2014-09-23 13:42:07 INFO: OfflineImap 6.5.5 starting... Python: 2.7.8 Platform: darwin Args: /usr/local/bin/offlineimap -1 -d imap -l logfile.txt 2014-09-23 13:42:07 INFO: Debug mode: Forcing to singlethreaded. 2014-09-23 13:42:07 DEBUG: Now debugging for imap: IMAP protocol debugging 2014-09-23 13:42:07 DEBUG: Now debugging for : Other offlineimap related sync messages 2014-09-23 13:42:07 DEBUG: [imap]: Using authentication mechanisms ['GSSAPI', 'CRAM-MD5', 'PLAIN', 'LOGIN'] 2014-09-23 13:42:07 DEBUG: [imap]: Using authentication mechanisms ['GSSAPI', 'CRAM-MD5', 'PLAIN', 'LOGIN'] 2014-09-23 13:42:07 INFO: *** Processing account iCloud 2014-09-23 13:42:07 INFO: Establishing connection to imap.mail.me.com:993 2014-09-23 13:42:07 DEBUG: [imap]: 42:07.17 Account sync iCloud imaplib2 version 2.36 2014-09-23 13:42:07 DEBUG: [imap]: 42:07.17 Account sync iCloud imaplib2 debug level 5, buffer level 3 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.24 imap.mail.me.com writer starting 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.24 imap.mail.me.com reader starting using select 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.24 Account sync iCloud _request_push(continuation, None, {}) = DLKO0 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.24 Account sync iCloud None:DLKO0.ready.wait 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.35 imap.mail.me.com handler starting 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com reader select => [8], [], [] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com reader rcvd 188 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com reader < * OK [CAPABILITY st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN] iSCREAM ready to rumble (14F:21376) st11p00mm-iscream020 [22:1895:11:42:08:4B]\r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com handler untagged_responses[OK] 0 += ["[CAPABILITY st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN] iSCREAM ready to rumble (14F:21376) st11p00mm-iscream020 [22:1895:11:42:08:4B]"] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com handler untagged_responses[CAPABILITY] 0 += ["st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN"] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com handler state_change_free.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com handler _request_pop(continuation, (False, '* OK [CAPABILITY st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN] iSCREAM ready to rumble (14F:21376) st11p00mm-iscream020 [22:1895:11:42:08:4B]')) = DLKO0 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com handler None:DLKO0.ready.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 Account sync iCloud _get_untagged_response(OK) => ['[CAPABILITY st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN] iSCREAM ready to rumble (14F:21376) st11p00mm-iscream020 [22:1895:11:42:08:4B]'] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 Account sync iCloud state => NONAUTH 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 Account sync iCloud [async] CAPABILITY () 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 Account sync iCloud state_change_pending.acquire 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 Account sync iCloud state_change_pending.release 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 Account sync iCloud _request_push(DLKO1, CAPABILITY, {}) = DLKO1 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 Account sync iCloud data=DLKO1 CAPABILITY 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 Account sync iCloud CAPABILITY:DLKO1.ready.wait 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.36 imap.mail.me.com writer > DLKO1 CAPABILITY\r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.48 imap.mail.me.com reader select => [8], [], [] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.48 imap.mail.me.com reader rcvd 105 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.48 imap.mail.me.com reader < * CAPABILITY st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN \r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.48 imap.mail.me.com handler untagged_responses[CAPABILITY] 1 += ["st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN "] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 imap.mail.me.com reader select => [8], [], [] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 imap.mail.me.com reader rcvd 13 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 imap.mail.me.com reader < DLKO1 OK !!\r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 imap.mail.me.com handler state_change_free.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 imap.mail.me.com handler _request_pop(DLKO1, ('OK', ['!!'])) = DLKO1 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 imap.mail.me.com handler CAPABILITY:DLKO1.ready.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud _get_untagged_response(CAPABILITY) => ['st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN', 'st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN '] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud _untagged_response(OK, ?, CAPABILITY) => ['st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN', 'st11p00mm-iscream020 14F XAPPLEPUSHSERVICE IMAP4 IMAP4rev1 SASL-IR AUTH=ATOKEN AUTH=PLAIN '] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud CAPABILITY: ('ST11P00MM-ISCREAM020', '14F', 'XAPPLEPUSHSERVICE', 'IMAP4', 'IMAP4REV1', 'SASL-IR', 'AUTH=ATOKEN', 'AUTH=PLAIN') 2014-09-23 13:42:08 DEBUG: [imap]: Attempting PLAIN authentication 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud [sync] AUTHENTICATE ('PLAIN',) 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud state_change_pending.acquire 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud _request_push(DLKO2, AUTHENTICATE, {}) = DLKO2 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud data=DLKO2 AUTHENTICATE PLAIN 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud _request_push(continuation, None, {}) = DLKO3 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 Account sync iCloud None:DLKO3.ready.wait 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.60 imap.mail.me.com writer > DLKO2 AUTHENTICATE PLAIN\r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 imap.mail.me.com reader select => [8], [], [] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 imap.mail.me.com reader rcvd 4 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 imap.mail.me.com reader < + \r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 imap.mail.me.com handler _request_pop(continuation, (True, '')) = DLKO3 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 imap.mail.me.com handler None:DLKO3.ready.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 Account sync iCloud continuation => True, 2014-09-23 13:42:08 DEBUG: [imap]: __plainhandler: returning XXXXXXXXXXYYYYYYYYYYY 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 Account sync iCloud _request_push(continuation, None, {}) = DLKO4 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 Account sync iCloud write literal size 52 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 Account sync iCloud None:DLKO4.ready.wait 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.73 imap.mail.me.com writer > AFJhaW5lci5mckBrcnVncy5kZQBtZm5hLWNzbWUtc3Vwdy14b2R2\r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com reader select => [8], [], [] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com reader rcvd 55 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com reader < DLKO2 NO [AUTHENTICATIONFAILED] Authentication failed\r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com handler _request_pop(DLKO2, ('NO', ['[AUTHENTICATIONFAILED] Authentication failed'])) = DLKO2 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com handler AUTHENTICATE:DLKO2.ready.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com handler untagged_responses[AUTHENTICATIONFAILED] 0 += [""] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com handler state_change_free.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com handler _request_pop(continuation, (False, 'DLKO2 NO [AUTHENTICATIONFAILED] Authentication failed')) = DLKO4 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com handler None:DLKO4.ready.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 Account sync iCloud continuation => False, DLKO2 NO [AUTHENTICATIONFAILED] Authentication failed 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 imap.mail.me.com handler NO response: [AUTHENTICATIONFAILED] Authentication failed 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 Account sync iCloud AUTHENTICATE:DLKO2.ready.wait 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 Account sync iCloud state_change_pending.release 2014-09-23 13:42:08 WARNING: PLAIN authentication failed: [AUTHENTICATIONFAILED] Authentication failed 2014-09-23 13:42:08 DEBUG: [imap]: Attempting LOGIN authentication 2014-09-23 13:42:08 DEBUG: [imap]: Attempting IMAP LOGIN authentication 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 Account sync iCloud [sync] LOGIN ('XXXXXXXXXX', '"YYYYYYYYYYY"') 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 Account sync iCloud state_change_pending.acquire 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 Account sync iCloud _request_push(DLKO5, LOGIN, {}) = DLKO5 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.85 Account sync iCloud data=DLKO5 LOGIN XXXXXXXX "YYYYYYYYY" 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.86 Account sync iCloud LOGIN:DLKO5.ready.wait 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.86 imap.mail.me.com writer > DLKO5 LOGIN XXXXXXXX "YYYYYYYYY"\r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 imap.mail.me.com reader select => [8], [], [] 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 imap.mail.me.com reader rcvd 55 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 imap.mail.me.com reader < DLKO5 NO [AUTHENTICATIONFAILED] Authentication failed\r\n 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 imap.mail.me.com handler state_change_free.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 imap.mail.me.com handler _request_pop(DLKO5, ('NO', ['[AUTHENTICATIONFAILED] Authentication failed'])) = DLKO5 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 imap.mail.me.com handler LOGIN:DLKO5.ready.set 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 Account sync iCloud state_change_pending.release 2014-09-23 13:42:08 WARNING: LOGIN authentication failed: [AUTHENTICATIONFAILED] Authentication failed 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 imap.mail.me.com handler untagged_responses[AUTHENTICATIONFAILED] 1 += [""] 2014-09-23 13:42:08 INFO: ERROR: All authentication types failed: PLAIN: [AUTHENTICATIONFAILED] Authentication failed LOGIN: [AUTHENTICATIONFAILED] Authentication failed 2014-09-23 13:42:08 DEBUG: [imap]: 42:08.98 imap.mail.me.com handler NO response: [AUTHENTICATIONFAILED] Authentication failed 2014-09-23 13:42:08 INFO: [' File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/accounts.py", line 241, in syncrunner\n self.__sync()\n', ' File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/accounts.py", line 303, in __sync\n remoterepos.getfolders()\n', ' File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/repository/IMAP.py", line 322, in getfolders\n imapobj = self.imapserver.acquireconnection()\n', ' File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/imapserver.py", line 418, in acquireconnection\n self.__authn_helper(imapobj)\n', ' File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/imapserver.py", line 339, in __authn_helper\n "failed:\\n\\t%s" % msg, OfflineImapError.ERROR.REPO)\n'] 2014-09-23 13:42:08 INFO: *** Finished account 'iCloud' in 0:01 2014-09-23 13:42:08 DEBUG: [imap]: keepalive thread started 2014-09-23 13:42:08 DEBUG: [imap]: keepalive thread started 2014-09-23 13:42:08 DEBUG: Next refresh in 2.0 minutes 2014-09-23 13:42:08 DEBUG: [imap]: keepalive: waiting for timeout 2014-09-23 13:42:08 DEBUG: [imap]: keepalive: waiting for timeout 2014-09-23 13:42:16 WARNING: Terminating NOW (this may take a few seconds)... 2014-09-23 13:42:16 WARNING: ERROR: Exceptions occurred during the run! 2014-09-23 13:42:16 WARNING: ERROR: All authentication types failed: PLAIN: [AUTHENTICATIONFAILED] Authentication failed LOGIN: [AUTHENTICATIONFAILED] Authentication failed 2014-09-23 13:42:16 WARNING: Traceback: File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/accounts.py", line 241, in syncrunner self.__sync() File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/accounts.py", line 303, in __sync remoterepos.getfolders() File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/repository/IMAP.py", line 322, in getfolders imapobj = self.imapserver.acquireconnection() File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/imapserver.py", line 418, in acquireconnection self.__authn_helper(imapobj) File "/usr/local/Cellar/offline-imap/6.5.6/libexec/offlineimap/imapserver.py", line 339, in __authn_helper "failed:\n\t%s" % msg, OfflineImapError.ERROR.REPO)