Cannot see new folder added on IMAP server

[shaiay]

Hi,

I've been using k-9 for a few months now and I'm very satisfied. It's
great that an open source email application of this quality exists.

Recently I added a new imap subfolder to my account. I cannot see this
new subfolder when I try to move/copy on k-9, no matter how many times
I hit the refresh folders button.

Under Account Settings -> Folders -> Move/copy destinations folders I
have "all"

This problem occurs with 3.604 & 3.801, on a samasung galaxy s running
stock froyo firmware

Any help would be appreciated

Shai

[cketti]

Please enable debug logging and record a log
(https://github.com/k9mail/k-9/wiki/LoggingErrors) while refreshing the
folder list.

There are two cases when folders on the server are ignored:
a) The folder name is "OUTBOX" (case-sensitive)
b) The folder name is not correctly encoded with the modified UTF-7
variant RFC3501 describes

-cketti

[shaiay]

I don't think I have any of these problems - the new folder is called
"IT.Spam Check". It seems to me that when I press "Refresh folders" in
the menu of the folder list presented while trying to move a message,
nothing happens. I am no expert in reading the logs, but I think the
log will show it also. I pressed "Refresh folders" somewhere between
4:43 to 4:55 in the attached log. I'm sorry I just pasted in here
since I found mo way to attach a file.

05-28 22:52:00.584 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 22:55:00.612 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 22:58:00.639 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:01:00.667 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:04:00.698 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:07:00.729 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:10:00.756 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:13:00.784 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:16:00.815 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:19:00.846 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:20:33.674 I/k9 (14040): Committing preference changes
05-28 23:20:34.635 I/k9 (14040): Preferences commit took 961ms
05-28 23:20:36.420 I/k9 (14040): Committing preference changes
05-28 23:20:41.213 I/k9 (14040): Preferences commit took 4793ms
05-28 23:22:00.956 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:25:01.100 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:28:01.241 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:31:01.366 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:34:01.506 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:37:01.690 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:40:01.854 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:43:02.002 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:46:02.135 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:49:02.284 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:52:02.420 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:55:02.565 I/k9 (14040): AutoSync help is available,
autoSync = true
05-28 23:58:02.713 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:01:02.850 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:04:02.995 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:07:03.221 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:10:03.366 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:13:03.495 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:16:03.631 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:19:03.706 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:22:03.823 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:25:03.963 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:28:04.108 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:31:04.245 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:34:04.385 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:37:04.530 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:40:04.667 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:43:04.803 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:46:04.940 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:49:05.088 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:52:05.256 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:55:05.393 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 00:58:05.584 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:01:05.752 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:04:05.909 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:07:06.030 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:10:06.170 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:13:06.323 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:16:06.518 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:19:06.682 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:22:06.873 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:25:07.088 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:28:07.299 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:31:07.420 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:34:07.553 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:37:07.702 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:40:07.893 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:43:08.053 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:46:08.202 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:49:08.307 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:52:08.459 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:55:08.600 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 01:58:08.745 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:01:08.901 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:04:09.038 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:07:09.167 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:10:09.307 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:13:09.463 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:16:09.604 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:19:09.745 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:22:09.885 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:25:10.022 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:28:10.167 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:31:10.307 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:34:10.452 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:37:10.639 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:40:10.803 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:43:11.002 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:46:11.151 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:49:11.307 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:52:11.502 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:55:11.670 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 02:58:11.823 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:01:11.963 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:04:12.104 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:07:12.245 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:10:12.428 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:13:12.651 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:16:12.819 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:19:12.959 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:22:13.104 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:25:13.252 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:28:13.393 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:31:13.561 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:34:13.647 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:37:13.788 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:40:13.948 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:43:14.092 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:46:14.233 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:49:14.420 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:52:14.631 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:55:14.795 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 03:58:14.944 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:01:15.151 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:02:26.995 I/k9 (14040): Committing preference changes
05-29 04:02:29.569 I/k9 (14040): Preferences commit took 2577ms
05-29 04:04:15.315 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:07:15.448 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:10:15.592 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:13:15.741 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:16:15.885 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:19:16.022 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:22:16.159 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:25:16.288 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:28:16.432 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:31:16.584 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:34:16.729 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:37:16.874 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:40:17.053 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:43:10.045 I/k9 (14040): MessageList sending message
MessageReference{accountUuid='6680b8d5-2f66-46a1-8d41-dca880be1d9c',
folderName='INBOX', uid='72563', flag=null}
05-29 04:43:17.252 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:43:20.569 I/k9 (14040): Got FETCH #null# [82, FETCH,
[FLAGS, [\Seen]]]
05-29 04:46:17.374 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:49:17.526 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:50:03.971 I/k9 (14040): Committing preference changes
05-29 04:50:04.788 I/k9 (14040): Preferences commit took 812ms
05-29 04:50:04.952 I/k9 (14040): Running Foreground command
'getFolderUnread:BioControl:INBOX', seq = 248
05-29 04:50:05.108 I/k9 (14040): Foreground Command
'getFolderUnread:BioControl:INBOX' completed
05-29 04:50:05.151 V/k9 (14040): Got ack that callbackRunner
finished
05-29 04:50:31.729 I/k9 (14040): Running Foreground command
'getFolderUnread:BioControl:INBOX', seq = 249
05-29 04:50:31.772 I/k9 (14040): Foreground Command
'getFolderUnread:BioControl:INBOX' completed
05-29 04:50:31.862 V/k9 (14040): Got ack that callbackRunner
finished
05-29 04:51:17.749 V/k9 (14040): conn1204245504<<<#null# [OK,
Still, here]
05-29 04:51:17.749 V/k9 (14040): Got async response: #null# [OK,
Still, here]
05-29 04:51:17.784 V/k9 (14040): conn1204231864<<<#null# [OK,
Still, here]
05-29 04:51:17.792 V/k9 (14040): Got async response: #null# [OK,
Still, here]
05-29 04:51:40.659 I/k9 (14040): Running Foreground command
'getFolderUnread:BioControl:INBOX', seq = 250
05-29 04:51:40.659 I/k9 (14040): Foreground Command
'getFolderUnread:BioControl:INBOX' completed
05-29 04:51:40.686 V/k9 (14040): Got ack that callbackRunner
finished
05-29 04:52:17.647 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1327: Create
05-29 04:52:17.666 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1327 for 60000 ms: acquired
05-29 04:52:17.666 V/k9 (14040): CoreReceiver Created wakeLock
653
05-29 04:52:17.682 I/k9 (14040): CoreReceiver.onReceiveIntent
{ act=com.fsck.k9.service.BroadcastReceiver.fireIntent dat=action://
com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS flg=0x4
cmp=com.fsck.k9/.service.BootReceiver (has extras) }
05-29 04:52:17.682 I/k9 (14040): BootReceiver.onReceiveIntent
{ act=com.fsck.k9.service.BroadcastReceiver.fireIntent dat=action://
com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS flg=0x4
cmp=com.fsck.k9/.service.BootReceiver (has extras) }
05-29 04:52:17.686 I/k9 (14040): BootReceiver Got alarm to fire
alarmedIntent com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
05-29 04:52:17.713 I/k9 (14040): CoreService:
com.fsck.k9.service.MailService.onCreate()
05-29 04:52:17.713 V/k9 (14040): ***** MailService *****:
onCreate
05-29 04:52:17.713 V/k9 (14040): TracingWakeLock for tag
CoreService onStart / id 1328: Create
05-29 04:52:17.725 V/k9 (14040): TracingWakeLock for tag
CoreService onStart / id 1328 for 30000 ms: acquired
05-29 04:52:17.729 I/k9 (14040): CoreService:
com.fsck.k9.service.MailService.onStart(Intent
{ act=com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
cmp=com.fsck.k9/.service.MailService (has extras) }, 1
05-29 04:52:17.733 V/k9 (14040): CoreReceiver Got request to
release wakeLock 653
05-29 04:52:17.764 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:52:17.764 I/k9 (14040): MailService.onStart(Intent
{ act=com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
cmp=com.fsck.k9/.service.MailService (has extras) }, 1),
hasConnectivity = true, doBackground = true
05-29 04:52:17.768 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1329: Create
05-29 04:52:17.768 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1329 for 30000 ms: acquired
05-29 04:52:17.768 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) queueing Runnable 1203901304 with
startId null
05-29 04:52:17.780 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1330: Create
05-29 04:52:17.780 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1330 for 30000 ms: acquired
05-29 04:52:17.780 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) queueing Runnable 1205299408 with
startId 1
05-29 04:52:17.780 I/k9 (14040): MailService.onStart took 30ms
05-29 04:52:17.784 V/k9 (14040): TracingWakeLock for tag
CoreService onStart / id 1328: releasing after 56 ms, timeout = 30000
ms
05-29 04:52:17.784 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1331: Create
05-29 04:52:17.788 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1331 for 60000 ms: acquired
05-29 04:52:17.788 V/k9 (14040): CoreReceiver Created wakeLock
654
05-29 04:52:17.788 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) running Runnable 1203901304 with
startId null
05-29 04:52:17.788 I/k9 (14040): CoreReceiver.onReceiveIntent
{ act=com.fsck.k9.service.CoreReceiver.wakeLockRelease
cmp=com.fsck.k9/.service.CoreReceiver (has extras) }
05-29 04:52:17.788 I/k9 (14040): Refreshing pushers
05-29 04:52:17.791 V/k9 (14040): CoreReceiver Release wakeLock
653
05-29 04:52:17.791 D/k9 (14040): PUSHREFRESH: refreshing
lastRefresh = 1306633757542, interval = 180000, nowTime =
1306633937791, sinceLast = 180249
05-29 04:52:17.791 V/k9 (14040): CoreReceiver Releasing wakeLock
653
05-29 04:52:17.795 V/k9 (14040): TracingWakeLock for tag
ImapFolderPusher BioControl:INBOX / id 79 for 60000 ms: acquired
05-29 04:52:17.795 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1327: releasing after 127 ms, timeout =
60000 ms
05-29 04:52:17.795 V/k9 (14040): CoreReceiver Releasing wakeLock
654
05-29 04:52:17.799 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1331: releasing after 11 ms, timeout =
60000 ms
05-29 04:52:17.807 V/k9 (14040): conn1204245504>>> DONE
05-29 04:52:17.819 V/k9 (14040): TracingWakeLock for tag
ImapFolderPusher BioControl:Drafts / id 78 for 60000 ms: acquired
05-29 04:52:17.846 V/k9 (14040): conn1204245504<<<#516# [OK,
Idle, completed.]
05-29 04:52:17.862 V/k9 (14040): Got async response: #516# [OK,
Idle, completed.]
05-29 04:52:17.905 I/k9 (14040): Got oldUidNext 72565 for
BioControl:INBOX/Thread-28/conn1204245504
05-29 04:52:17.952 V/k9 (14040): conn1204245504>>> 517 NOOP
05-29 04:52:18.018 V/k9 (14040): conn1204231864<<<#404# [OK,
Idle, completed.]
05-29 04:52:18.034 V/k9 (14040): Got async response: #404# [OK,
Idle, completed.]
05-29 04:52:18.069 I/k9 (14040): Got oldUidNext 3346 for
BioControl:Drafts/Thread-27/conn1204231864
05-29 04:52:18.100 V/k9 (14040): conn1204231864>>> DONE
05-29 04:52:18.112 V/k9 (14040): conn1204231864>>> 405 NOOP
05-29 04:52:18.120 V/k9 (14040): conn1204245504<<<#517# [OK,
NOOP, completed.]
05-29 04:52:18.124 D/k9 (14040): PUSHREFRESH: trying to send
mail in all folders!
05-29 04:52:18.127 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) completed Runnable 1203901304 with
startId null
05-29 04:52:18.135 I/k9 (14040): Running Background command
'sendPendingMessages', seq = 251
05-29 04:52:18.147 V/k9 (14040): conn1204231864<<<#405# [OK,
NOOP, completed.]
05-29 04:52:18.170 V/k9 (14040): Connection conn1204231864 has 14
capabilities
05-29 04:52:18.174 I/k9 (14040): About to IDLE for
BioControl:Drafts/Thread-27/conn1204231864
05-29 04:52:18.194 V/k9 (14040): Connection conn1204245504 has 14
capabilities
05-29 04:52:18.202 V/k9 (14040): conn1204231864>>> 406 IDLE
05-29 04:52:18.206 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1329: releasing after 436 ms, timeout = 30000
ms
05-29 04:52:18.209 V/k9 (14040): conn1204231864<<<#+# [idling]
05-29 04:52:18.245 I/k9 (14040): Background Command
'sendPendingMessages' completed
05-29 04:52:18.323 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) running Runnable 1205299408 with
startId 1
05-29 04:52:18.334 I/k9 (14040): About to IDLE for
BioControl:INBOX/Thread-28/conn1204245504
05-29 04:52:18.338 V/k9 (14040): Got async response: #+# [idling]
05-29 04:52:18.358 V/k9 (14040): Pusher refresh interval = 180000
05-29 04:52:18.370 D/k9 (14040): Idling BioControl:Drafts/
Thread-27/conn1204231864
05-29 04:52:18.374 V/k9 (14040): TracingWakeLock for tag
ImapFolderPusher BioControl:Drafts / id 78: releasing after 539 ms,
timeout = 60000 ms
05-29 04:52:18.409 V/k9 (14040): conn1204245504>>> 518 IDLE
05-29 04:52:18.416 D/k9 (14040): Next pusher refresh scheduled
for Sun May 29 04:55:18 GMT+03:00 2011
05-29 04:52:18.428 V/k9 (14040): conn1204245504<<<#+# [idling]
05-29 04:52:18.448 I/k9 (14040): BootReceiver Got request to
schedule alarmedIntent
com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
05-29 04:52:18.463 V/k9 (14040): Got async response: #+# [idling]
05-29 04:52:18.471 D/k9 (14040): Idling BioControl:INBOX/
Thread-28/conn1204245504
05-29 04:52:18.487 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) completed Runnable 1205299408 with
startId 1
05-29 04:52:18.487 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1330: releasing after 706 ms, timeout = 30000
ms
05-29 04:52:18.487 V/k9 (14040): TracingWakeLock for tag
ImapFolderPusher BioControl:INBOX / id 79: releasing after 692 ms,
timeout = 60000 ms
05-29 04:52:18.487 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1332: Create
05-29 04:52:18.491 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1332 for 60000 ms: acquired
05-29 04:52:18.491 V/k9 (14040): CoreReceiver Created wakeLock
655
05-29 04:52:18.491 I/k9 (14040): CoreReceiver.onReceiveIntent
{ act=com.fsck.k9.service.BroadcastReceiver.scheduleIntent
cmp=com.fsck.k9/.service.BootReceiver (has extras) }
05-29 04:52:18.491 I/k9 (14040): BootReceiver.onReceiveIntent
{ act=com.fsck.k9.service.BroadcastReceiver.scheduleIntent
cmp=com.fsck.k9/.service.BootReceiver (has extras) }
05-29 04:52:18.491 I/k9 (14040): BootReceiver Scheduling intent
Intent { act=com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
cmp=com.fsck.k9/.service.MailService } for Sun May 29 04:55:18 GMT
+03:00 2011
05-29 04:52:18.495 V/k9 (14040): CoreReceiver Releasing wakeLock
655
05-29 04:52:18.495 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1332: releasing after 4 ms, timeout =
60000 ms
05-29 04:52:18.499 V/k9 (14040): ***** MailService *****:
onDestroy()
05-29 04:52:18.499 I/k9 (14040): CoreService:
com.fsck.k9.service.MailService.onDestroy()
05-29 04:54:18.217 V/k9 (14040): conn1204231864<<<#null# [OK,
Still, here]
05-29 04:54:18.221 V/k9 (14040): Got async response: #null# [OK,
Still, here]
05-29 04:54:18.401 V/k9 (14040): conn1204245504<<<#null# [OK,
Still, here]
05-29 04:54:18.420 V/k9 (14040): Got async response: #null# [OK,
Still, here]
05-29 04:55:06.479 V/k9 (14040): LockableDatabase: Transaction
ended, took 7960ms / com.fsck.k9.mail.store.LocalStore
$LocalFolder.appendMessages(LocalStore.java:2036)
05-29 04:55:09.698 V/k9 (14040): LockableDatabase: Transaction
ended, took 2988ms / com.fsck.k9.mail.store.LocalStore
$LocalMessage.setFlag(LocalStore.java:3113)
05-29 04:55:09.702 I/k9 (14040): Running Background command
'sendPendingMessages', seq = 252
05-29 04:55:10.088 I/k9 (14040): Scanning folder 'OUTBOX' (200)
for messages to send
05-29 04:55:10.092 I/k9 (14040): Send count for message K9LOCAL:
321cb7da-7178-412f-9d6c-efd1deeb9b99 is 0
05-29 04:55:13.468 V/k9 (14040): LockableDatabase: Transaction
ended, took 3197ms / com.fsck.k9.mail.store.LocalStore
$LocalMessage.setFlag(LocalStore.java:3113)
05-29 04:55:13.468 I/k9 (14040): Sending message with UID K9LOCAL:
321cb7da-7178-412f-9d6c-efd1deeb9b99
05-29 04:55:13.651 D/k9 (14040): SMTP >>> QUIT
05-29 04:55:13.751 D/k9 (14040): SMTP <<< 220
mail.biocontrol.co.il ESMTP Postfix
05-29 04:55:13.752 D/k9 (14040): SMTP >>> EHLO localhost
05-29 04:55:13.792 D/k9 (14040): SMTP <<< 250-
mail.biocontrol.co.il
05-29 04:55:13.815 D/k9 (14040): SMTP <<< 250-PIPELINING
05-29 04:55:13.815 D/k9 (14040): SMTP <<< 250-SIZE 50000000
05-29 04:55:13.823 D/k9 (14040): SMTP <<< 250-ETRN
05-29 04:55:13.827 D/k9 (14040): SMTP <<< 250-ENHANCEDSTATUSCODES
05-29 04:55:13.831 D/k9 (14040): SMTP <<< 250-8BITMIME
05-29 04:55:13.842 D/k9 (14040): SMTP <<< 250 DSN
05-29 04:55:13.936 D/k9 (14040): SMTP >>> MAIL FROM:<XXX@YYY>
05-29 04:55:13.991 D/k9 (14040): SMTP <<< 250 2.1.0 Ok
05-29 04:55:13.995 D/k9 (14040): SMTP >>> RCPT TO:<XXX@YYY>
05-29 04:55:14.034 D/k9 (14040): SMTP <<< 250 2.1.5 Ok
05-29 04:55:14.034 D/k9 (14040): SMTP >>> DATA
05-29 04:55:14.073 D/k9 (14040): SMTP <<< 354 End data with
<CR><LF>.<CR><LF>
05-29 04:55:14.213 D/k9 (14040): SMTP >>>
05-29 04:55:14.213 D/k9 (14040): .
05-29 04:55:14.409 D/k9 (14040): SMTP <<< 250 2.0.0 Ok: queued as
7F12730F3CB
05-29 04:55:14.409 D/k9 (14040): SMTP >>> QUIT
05-29 04:55:14.463 D/k9 (14040): SMTP <<< 221 2.0.0 Bye
05-29 04:55:17.702 V/k9 (14040): LockableDatabase: Transaction
ended, took 3174ms / com.fsck.k9.mail.store.LocalStore
$LocalMessage.setFlag(LocalStore.java:3113)
05-29 04:55:18.405 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1333: Create
05-29 04:55:18.409 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1333 for 60000 ms: acquired
05-29 04:55:18.413 V/k9 (14040): CoreReceiver Created wakeLock
656
05-29 04:55:18.416 I/k9 (14040): CoreReceiver.onReceiveIntent
{ act=com.fsck.k9.service.BroadcastReceiver.fireIntent dat=action://
com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS flg=0x4
cmp=com.fsck.k9/.service.BootReceiver (has extras) }
05-29 04:55:18.420 I/k9 (14040): BootReceiver.onReceiveIntent
{ act=com.fsck.k9.service.BroadcastReceiver.fireIntent dat=action://
com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS flg=0x4
cmp=com.fsck.k9/.service.BootReceiver (has extras) }
05-29 04:55:18.424 I/k9 (14040): BootReceiver Got alarm to fire
alarmedIntent com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
05-29 04:55:18.452 I/k9 (14040): CoreService:
com.fsck.k9.service.MailService.onCreate()
05-29 04:55:18.452 V/k9 (14040): ***** MailService *****:
onCreate
05-29 04:55:18.460 V/k9 (14040): TracingWakeLock for tag
CoreService onStart / id 1334: Create
05-29 04:55:18.463 V/k9 (14040): TracingWakeLock for tag
CoreService onStart / id 1334 for 30000 ms: acquired
05-29 04:55:18.467 I/k9 (14040): CoreService:
com.fsck.k9.service.MailService.onStart(Intent
{ act=com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
cmp=com.fsck.k9/.service.MailService (has extras) }, 1
05-29 04:55:18.467 V/k9 (14040): CoreReceiver Got request to
release wakeLock 656
05-29 04:55:18.487 I/k9 (14040): AutoSync help is available,
autoSync = true
05-29 04:55:18.487 I/k9 (14040): MailService.onStart(Intent
{ act=com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
cmp=com.fsck.k9/.service.MailService (has extras) }, 1),
hasConnectivity = true, doBackground = true
05-29 04:55:18.491 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1335: Create
05-29 04:55:18.491 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1335 for 30000 ms: acquired
05-29 04:55:18.491 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) queueing Runnable 1205278552 with
startId null
05-29 04:55:18.499 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1336: Create
05-29 04:55:18.499 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1336 for 30000 ms: acquired
05-29 04:55:18.499 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) queueing Runnable 1206842896 with
startId 1
05-29 04:55:18.502 I/k9 (14040): MailService.onStart took 18ms
05-29 04:55:18.502 V/k9 (14040): TracingWakeLock for tag
CoreService onStart / id 1334: releasing after 35 ms, timeout = 30000
ms
05-29 04:55:18.502 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1337: Create
05-29 04:55:18.506 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1337 for 60000 ms: acquired
05-29 04:55:18.506 V/k9 (14040): CoreReceiver Created wakeLock
657
05-29 04:55:18.506 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) running Runnable 1205278552 with
startId null
05-29 04:55:18.514 I/k9 (14040): Refreshing pushers
05-29 04:55:18.514 I/k9 (14040): CoreReceiver.onReceiveIntent
{ act=com.fsck.k9.service.CoreReceiver.wakeLockRelease
cmp=com.fsck.k9/.service.CoreReceiver (has extras) }
05-29 04:55:18.514 V/k9 (14040): CoreReceiver Release wakeLock
656
05-29 04:55:18.514 D/k9 (14040): PUSHREFRESH: refreshing
lastRefresh = 1306633937791, interval = 180000, nowTime =
1306634118514, sinceLast = 180723
05-29 04:55:18.514 V/k9 (14040): CoreReceiver Releasing wakeLock
656
05-29 04:55:18.518 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1333: releasing after 103 ms, timeout =
60000 ms
05-29 04:55:18.518 V/k9 (14040): CoreReceiver Releasing wakeLock
657
05-29 04:55:18.522 V/k9 (14040): TracingWakeLock for tag
ImapFolderPusher BioControl:INBOX / id 79 for 60000 ms: acquired
05-29 04:55:18.522 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1337: releasing after 13 ms, timeout =
60000 ms
05-29 04:55:18.530 V/k9 (14040): conn1204245504>>> DONE
05-29 04:55:18.545 V/k9 (14040): TracingWakeLock for tag
ImapFolderPusher BioControl:Drafts / id 78 for 60000 ms: acquired
05-29 04:55:18.557 V/k9 (14040): conn1204245504<<<#518# [OK,
Idle, completed.]
05-29 04:55:18.588 V/k9 (14040): Got async response: #518# [OK,
Idle, completed.]
05-29 04:55:18.666 V/k9 (14040): conn1204231864>>> DONE
05-29 04:55:18.745 V/k9 (14040): conn1204231864<<<#406# [OK,
Idle, completed.]
05-29 04:55:18.780 V/k9 (14040): Got async response: #406# [OK,
Idle, completed.]
05-29 04:55:18.807 D/k9 (14040): PUSHREFRESH: trying to send
mail in all folders!
05-29 04:55:18.807 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) completed Runnable 1205278552 with
startId null
05-29 04:55:18.815 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1335: releasing after 317 ms, timeout = 30000
ms
05-29 04:55:18.827 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) running Runnable 1206842896 with
startId 1
05-29 04:55:18.831 V/k9 (14040): Pusher refresh interval = 180000
05-29 04:55:18.834 D/k9 (14040): Next pusher refresh scheduled
for Sun May 29 04:58:18 GMT+03:00 2011
05-29 04:55:18.846 I/k9 (14040): BootReceiver Got request to
schedule alarmedIntent
com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
05-29 04:55:18.854 D/k9 (14040): CoreService
(com.fsck.k9.service.MailService) completed Runnable 1206842896 with
startId 1
05-29 04:55:18.854 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1338: Create
05-29 04:55:18.854 V/k9 (14040): TracingWakeLock for tag
CoreService execute / id 1336: releasing after 353 ms, timeout = 30000
ms
05-29 04:55:18.854 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1338 for 60000 ms: acquired
05-29 04:55:18.854 V/k9 (14040): CoreReceiver Created wakeLock
658
05-29 04:55:18.854 I/k9 (14040): CoreReceiver.onReceiveIntent
{ act=com.fsck.k9.service.BroadcastReceiver.scheduleIntent
cmp=com.fsck.k9/.service.BootReceiver (has extras) }
05-29 04:55:18.854 I/k9 (14040): BootReceiver.onReceiveIntent
{ act=com.fsck.k9.service.BroadcastReceiver.scheduleIntent
cmp=com.fsck.k9/.service.BootReceiver (has extras) }
05-29 04:55:18.858 I/k9 (14040): BootReceiver Scheduling intent
Intent { act=com.fsck.k9.intent.action.MAIL_SERVICE_REFRESH_PUSHERS
cmp=com.fsck.k9/.service.MailService } for Sun May 29 04:58:18 GMT
+03:00 2011
05-29 04:55:18.862 V/k9 (14040): CoreReceiver Releasing wakeLock
658
05-29 04:55:18.862 V/k9 (14040): TracingWakeLock for tag
CoreReceiver getWakeLock / id 1338: releasing after 6 ms, timeout =
60000 ms
05-29 04:55:18.862 V/k9 (14040): ***** MailService *****:
onDestroy()
05-29 04:55:18.862 I/k9 (14040): CoreService:
com.fsck.k9.service.MailService.onDestroy()
05-29 04:55:21.186 V/k9 (14040): LockableDatabase: Transaction
ended, took 3288ms / com.fsck.k9.mail.store.LocalStore
$LocalMessage.setFlag(LocalStore.java:3113)
05-29 04:55:21.420 I/k9 (14040): Got oldUidNext 3346 for
BioControl:Drafts/Thread-27/conn1204231864
05-29 04:55:21.467 I/k9 (14040): Got oldUidNext 72565 for
BioControl:INBOX/Thread-28/conn1204245504
05-29 04:55:21.471 V/k9 (14040): conn1204231864>>> 407 NOOP
05-29 04:55:21.483 V/k9 (14040): conn1204231864<<<#407# [OK,
NOOP, completed.]
05-29 04:55:21.514 V/k9 (14040): Connection conn1204231864 has 14
capabilities
05-29 04:55:21.526 I/k9 (14040): About to IDLE for
BioControl:Drafts/Thread-27/conn1204231864
05-29 04:55:21.530 V/k9 (14040): conn1204245504>>> 519 NOOP
05-29 04:55:21.565 V/k9 (14040): conn1204245504<<<#519# [OK,
NOOP, completed.]
05-29 04:55:21.569 V/k9 (14040): conn1204231864>>> 408 IDLE
05-29 04:55:21.581 V/k9 (14040): Connection conn1204245504 has 14
capabilities
05-29 04:55:21.584 I/k9 (14040): About to IDLE for
BioControl:INBOX/Thread-28/conn1204245504
05-29 04:55:21.620 V/k9 (14040): conn1204231864<<<#+# [idling]
05-29 04:55:21.635 V/k9 (14040): Got async response: #+# [idling]
05-29 04:55:21.639 V/k9 (14040): conn1204245504>>> 520 IDLE
05-29 04:55:21.655 D/k9 (14040): Idling BioControl:Drafts/
Thread-27/conn1204231864
05-29 04:55:21.655 V/k9 (14040): TracingWakeLock for tag
ImapFolderPusher BioControl:Drafts / id 78: releasing after 3027 ms,
timeout = 60000 ms
05-29 04:55:21.674 V/k9 (14040): conn1204245504<<<#+# [idling]
05-29 04:55:21.678 V/k9 (14040): Got async response: #+# [idling]
05-29 04:55:21.682 D/k9 (14040): Idling BioControl:INBOX/
Thread-28/conn1204245504
05-29 04:55:21.686 V/k9 (14040): TracingWakeLock for tag
ImapFolderPusher BioControl:INBOX / id 79: releasing after 3163 ms,
timeout = 60000 ms
05-29 04:55:21.698 I/k9 (14040): Sent folder set to -NONE-,
deleting sent message
05-29 04:55:27.147 V/k9 (14040): LockableDatabase: Transaction
ended, took 5285ms / com.fsck.k9.mail.store.LocalStore
$LocalMessage.setFlag(LocalStore.java:3113)
05-29 04:55:27.248 I/k9 (14040): Background Command
'sendPendingMessages' completed
05-29 04:55:27.260 I/k9 (14040): Running Background command
'sendPendingMessages', seq = 253
05-29 04:55:27.514 I/k9 (14040): Scanning folder 'OUTBOX' (200)
for messages to send
05-29 04:55:34.186 V/k9 (14040): LockableDatabase: Transaction
ended, took 6583ms / com.fsck.k9.mail.store.LocalStore
$LocalMessage.destroy(LocalStore.java:3193)
05-29 04:55:34.291 I/k9 (14040): Background Command
'sendPendingMessages' completed

[cketti]

Go to the folder list with the colored bars/checkboxes at the left,
press the menu button, select "Folders", then "Refresh folders".
You can't use the folder list that is presented to select a target
folder for a copy or move operation to refresh the folder list from the
server.

-cketti

[shaiay]

Yes, this did the trick. Thank you!
Maybe the refresh folders option should be removed from the folder

list that is presented to select a target folder for a copy or move

operation if it does nothing ...

Once again, thanks for k-9 mail. As a contributor to several (other)
open source projects I know and appreciate the amount of time that
goes into these things ...

Shai

[mhb...@gmail.com]

Hi cketti (or anyone else ?),

Is there a solution to synchronize the sent folder when its name is
"OUTBOX" on the server ? Or is it impossible ?

I think it was possible in march when I installed K-9 mail. Perhaps it
changed with one of the last versions ?
I am now in 3.802 version (in french), and "OUTBOX" folder does not
appear in the list of folder indeed, and thus I can't choose if for
the "sent" folder of K-9 mail.

Thanks in advance
Bertrand

On 28 mai, 23:54, cketti <cke...@googlemail.com> wrote:

>
> Please enable debug logging and record a log
> (https://github.com/k9mail/k-9/wiki/LoggingErrors) while refreshing thefolderlist.
>
> There are two cases when folders on the server are ignored:
> a) Thefoldername is "OUTBOX" (case-sensitive)

> b) Thefoldername is not correctly encoded with the modified UTF-7
> variant RFC3501 describes
>
> -cketti

[cketti]

On Fri, 2011-06-10 at 23:32, mhb...@gmail.com wrote:
> Hi cketti (or anyone else ?),
>
> Is there a solution to synchronize the sent folder when its name is
> "OUTBOX" on the server ? Or is it impossible ?

As stated before: the folder "OUTBOX" on the server is ignored. That is
because the local folder K-9 Mail uses to store messages that need to be
sent is named like that internally. It is displayed as "Outbox" or the
localized version of that in the folder list.
You probably shouldn't name the Sent folder "OUTBOX" as this name
implies it contains something that has yet to be sent.

In the future we will probably rename the internal outbox to something
that is more unlikely to clash with existing folders on the server
(maybe something along the lines of K9MAIL_INTERNAL_OUTBOX).

> I think it was possible in march when I installed K-9 mail. Perhaps it
> changed with one of the last versions ?

It did.

> I am now in 3.802 version (in french), and "OUTBOX" folder does not
> appear in the list of folder indeed, and thus I can't choose if for
> the "sent" folder of K-9 mail.
>
> Thanks in advance
> Bertrand
>
>
> On 28 mai, 23:54, cketti <cke...@googlemail.com> wrote:
>
>>
>> Please enable debug logging and record a log
>> (https://github.com/k9mail/k-9/wiki/LoggingErrors) while refreshing thefolderlist.
>>
>> There are two cases when folders on the server are ignored:
>> a) Thefoldername is "OUTBOX" (case-sensitive)
>> b) Thefoldername is not correctly encoded with the modified UTF-7
>> variant RFC3501 describes
>>
>> -cketti
>

-cketti

[mhb...@gmail.com]

Thank you for your quick answer.
I hope this future is near... because I can not change the name on my
provider's server
However K-9 mail is very good, so I keep it on my tablet, and I thank
all the developpers.

Bertrand