2014-07-23T19:39:28+02:00 INFO: [31448] Horde_Core_ActiveSync_Driver::authenticate() attempt for stefan.buehler@mailcarrier.ch
2014-07-23T19:39:28+02:00 INFO: [31448] PING request received for user stefan.buehler@mailcarrier.ch
2014-07-23T19:39:28+02:00 INFO: [31448] Device entry exists for ANDROIDC1082106188, updating userAgent and version.
2014-07-23T19:39:28+02:00 INFO: [31448] Request being handled for device: ANDROIDC1082106188, Supporting protocol version: 14.1, Using Horde_ActiveSync v2.16.11
2014-07-23T19:39:28+02:00 INFO: [31448] GET VARIABLES: Array
(
[Cmd] => Ping
[User] => stefan.buehler@mailcarrier.ch
[DeviceId] => androidc1082106188
[DeviceType] => Android
)
2014-07-23T19:39:28+02:00 INFO: [31448] Handling PING command received at timestamp: 1406137168.
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I 480
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 INFO: [31448] Actual heartbeat value in use is 480.
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I F0eca702e
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I Email
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 INFO: [31448] Obtained synckey for collection F0eca702e from cache: {53cfe8cc-fd80-4296-bdac-2a2b3e8d2c65}5
2014-07-23T19:39:28+02:00 INFO: [31448] Collection added to collection handler: collection: Sent, synckey: {53cfe8cc-fd80-4296-bdac-2a2b3e8d2c65}5.
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I F02b039b0
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I Email
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 INFO: [31448] Obtained synckey for collection F02b039b0 from cache: {53cfe8c1-2420-41ec-add6-2a2b3e8d2c65}8
2014-07-23T19:39:28+02:00 INFO: [31448] Collection added to collection handler: collection: INBOX, synckey: {53cfe8c1-2420-41ec-add6-2a2b3e8d2c65}8.
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I C902931ee
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I Contacts
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 INFO: [31448] Obtained synckey for collection C902931ee from cache: {53cfe8d2-9b5c-4e69-b107-2a2b3e8d2c65}13
2014-07-23T19:39:28+02:00 INFO: [31448] Collection added to collection handler: collection: @Contacts@, synckey: {53cfe8d2-9b5c-4e69-b107-2a2b3e8d2c65}13.
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I A184d97b6
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I Calendar
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 INFO: [31448] Obtained synckey for collection A184d97b6 from cache: {53cfe8d1-4c38-461d-92cc-2a2b3e8d2c65}2
2014-07-23T19:39:28+02:00 INFO: [31448] Collection added to collection handler: collection: @Calendar@, synckey: {53cfe8d1-4c38-461d-92cc-2a2b3e8d2c65}2.
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 INFO: Setting collection INBOX (F02b039b0) PINGABLE.
2014-07-23T19:39:28+02:00 INFO: Setting collection Sent (F0eca702e) PINGABLE.
2014-07-23T19:39:28+02:00 INFO: Setting collection @Calendar@ (A184d97b6) PINGABLE.
2014-07-23T19:39:28+02:00 INFO: Setting collection @Contacts@ (C902931ee) PINGABLE.
2014-07-23T19:39:28+02:00 DEBUG: [31448] I
2014-07-23T19:39:28+02:00 INFO: Waiting for changes for 480 seconds
2014-07-23T19:39:28+02:00 INFO: [31448] Replacing SYNC_CACHE entry for user stefan.buehler@mailcarrier.ch and device ANDROIDC1082106188: a:11:{s:18:"confirmed_synckeys";a:1:{s:39:"{53cfe8d1-4c38-461d-92cc-2a2b3e8d2c65}2";b:1;}s:17:"lasthbsyncstarted";i:1406137168;s:17:"lastsyncendnormal";i:1406136867;s:9:"timestamp";s:10:"1406137168";s:4:"wait";b:0;s:10:"hbinterval";s:3:"480";s:7:"folders";a:14:{s:9:"T6e34e019";a:2:{s:5:"class";s:5:"Tasks";s:8:"serverid";s:7:"@Tasks@";}s:2:"RI";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:2:"RI";}s:9:"Nb977d1b4";a:2:{s:5:"class";s:5:"Notes";s:8:"serverid";s:7:"@Notes@";}s:9:"Ff1550486";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:14:"Infected Items";}s:9:"Fd2778da7";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:35:"Trash.Gelöschte Elemente [1].Trash";}s:9:"F6e065cf6";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:20:"INBOX.Infected Items";}s:9:"F6b366c25";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"Drafts";}s:9:"F47cc94cf";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"Trash";}s:9:"F0f549f7e";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:4:"Junk";}s:9:"F0eca702e";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:4:"Sent";}s:9:"F042926f9";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:29:"Trash.Gelöschte Elemente [1]";}s:9:"F02b039b0";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"INBOX";}s:9:"C902931ee";a:2:{s:5:"class";s:8:"Contacts";s:8:"serverid";s:10:"@Contacts@";}s:9:"A184d97b6";a:2:{s:5:"class";s:8:"Calendar";s:8:"serverid";s:10:"@Calendar@";}}s:9:"hierarchy";s:39:"{53cfe8bf-3fb4-480c-a45f-2a2b3e8d2c65}1";s:11:"collections";a:4:{s:9:"F02b039b0";a:12:{s:5:"class";s:5:"Email";s:10:"windowsize";s:2:"10";s:10:"truncation";i:0;s:11:"mimesupport";i:0;s:14:"mimetruncation";i:8;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:2;a:2:{s:4:"type";s:1:"2";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:5:"INBOX";s:11:"lastsynckey";s:39:"{53cfe8c1-2420-41ec-add6-2a2b3e8d2c65}8";s:14:"deletesasmoves";s:1:"1";s:10:"filtertype";s:1:"3";s:8:"pingable";b:1;}s:9:"F0eca702e";a:12:{s:5:"class";s:5:"Email";s:10:"windowsize";s:2:"10";s:10:"truncation";i:0;s:11:"mimesupport";i:0;s:14:"mimetruncation";i:8;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:2;a:2:{s:4:"type";s:1:"2";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:4:"Sent";s:11:"lastsynckey";s:39:"{53cfe8cc-fd80-4296-bdac-2a2b3e8d2c65}5";s:14:"deletesasmoves";s:1:"1";s:10:"filtertype";s:1:"3";s:8:"pingable";b:1;}s:9:"A184d97b6";a:12:{s:5:"class";s:8:"Calendar";s:10:"windowsize";s:2:"10";s:10:"truncation";i:0;s:11:"mimesupport";i:0;s:14:"mimetruncation";i:8;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:1;a:2:{s:4:"type";s:1:"1";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:10:"@Calendar@";s:11:"lastsynckey";s:39:"{53cfe8d1-4c38-461d-92cc-2a2b3e8d2c65}2";s:14:"deletesasmoves";b:1;s:10:"filtertype";s:1:"4";s:8:"pingable";b:1;}s:9:"C902931ee";a:12:{s:5:"class";s:8:"Contacts";s:10:"windowsize";s:2:"10";s:10:"truncation";i:0;s:11:"mimesupport";i:0;s:14:"mimetruncation";i:8;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:1;a:2:{s:4:"type";s:1:"1";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:10:"@Contacts@";s:11:"lastsynckey";s:40:"{53cfe8d2-9b5c-4e69-b107-2a2b3e8d2c65}13";s:14:"deletesasmoves";b:1;s:10:"filtertype";s:1:"0";s:8:"pingable";b:1;}}s:13:"pingheartbeat";b:0;s:14:"synckeycounter";a:0:{}}
2014-07-23T19:39:28+02:00 INFO: [31448] Initializing state for collection: Sent, synckey: {53cfe8cc-fd80-4296-bdac-2a2b3e8d2c65}5
2014-07-23T19:39:28+02:00 INFO: [31448] Loading state for synckey {53cfe8cc-fd80-4296-bdac-2a2b3e8d2c65}5
2014-07-23T19:39:28+02:00 INFO: [31448] Initializing message diff engine for F0eca702e (Sent)
2014-07-23T19:39:28+02:00 INFO: [31448] Horde_Core_ActiveSync_Driver::getSyncStamp(Sent, 1406134873);
2014-07-23T19:39:28+02:00 INFO: [31448] Using SYNCSTAMP 1406137168 for F0eca702e.
2014-07-23T19:39:28+02:00 INFO: [31448] Horde_Core_ActiveSync_Driver::getServerChanges(Sent, 1406134873, 1406137168, 1405532368, 1)
2014-07-23T19:39:28+02:00 INFO: [31448] Sent IMAP MODSEQ: 294
2014-07-23T19:39:28+02:00 INFO: [31448] Found 0 message changes in F0eca702e.
2014-07-23T19:39:28+02:00 INFO: [31448] Initializing state for collection: INBOX, synckey: {53cfe8c1-2420-41ec-add6-2a2b3e8d2c65}8
2014-07-23T19:39:28+02:00 INFO: [31448] Loading state for synckey {53cfe8c1-2420-41ec-add6-2a2b3e8d2c65}8
2014-07-23T19:39:28+02:00 INFO: [31448] Initializing message diff engine for F02b039b0 (INBOX)
2014-07-23T19:39:28+02:00 INFO: [31448] Horde_Core_ActiveSync_Driver::getSyncStamp(INBOX, 1406135267);
2014-07-23T19:39:28+02:00 INFO: [31448] Using SYNCSTAMP 1406137168 for F02b039b0.
2014-07-23T19:39:28+02:00 INFO: [31448] Horde_Core_ActiveSync_Driver::getServerChanges(INBOX, 1406135267, 1406137168, 1405532368, 1)
2014-07-23T19:39:28+02:00 INFO: [31448] INBOX IMAP MODSEQ: 75074
2014-07-23T19:39:28+02:00 INFO: [31448] Found 0 message changes in F02b039b0.
2014-07-23T19:39:28+02:00 INFO: [31448] Initializing state for collection: @Contacts@, synckey: {53cfe8d2-9b5c-4e69-b107-2a2b3e8d2c65}13
2014-07-23T19:39:28+02:00 INFO: [31448] Loading state for synckey {53cfe8d2-9b5c-4e69-b107-2a2b3e8d2c65}13
2014-07-23T19:39:28+02:00 INFO: [31448] Initializing message diff engine for C902931ee (@Contacts@)
2014-07-23T19:39:28+02:00 INFO: [31448] Horde_Core_ActiveSync_Driver::getSyncStamp(@Contacts@, 6748);
2014-07-23T19:39:28+02:00 INFO: [31448] Using SYNCSTAMP 6748 for C902931ee.
2014-07-23T19:39:28+02:00 INFO: [31448] Horde_Core_ActiveSync_Driver::getServerChanges(@Contacts@, 6748, 6748, 0, 1)
2014-07-23T19:39:28+02:00 INFO: [31448] Fetching changes for contacts using MODSEQ.
2014-07-23T19:39:28+02:00 INFO: [31448] Found 0 message changes in C902931ee.
2014-07-23T19:39:28+02:00 INFO: [31448] Initializing state for collection: @Calendar@, synckey: {53cfe8d1-4c38-461d-92cc-2a2b3e8d2c65}2
2014-07-23T19:39:28+02:00 INFO: [31448] Loading state for synckey {53cfe8d1-4c38-461d-92cc-2a2b3e8d2c65}2
2014-07-23T19:39:28+02:00 INFO: [31448] Found 64 changes remaining from previous SYNC.
2014-07-23T19:39:28+02:00 INFO: [31448] Initializing message diff engine for A184d97b6 (@Calendar@)
2014-07-23T19:39:28+02:00 INFO: [31448] Returning previously found changes.
2014-07-23T19:39:28+02:00 INFO: [31448] Found changes!
2014-07-23T19:39:28+02:00 INFO: [31448] Looping Sync complete: DataAvailable: 1, DataImported:
2014-07-23T19:39:28+02:00 INFO: [31448] Replacing SYNC_CACHE entry for user stefan.buehler@mailcarrier.ch and device ANDROIDC1082106188: a:11:{s:18:"confirmed_synckeys";a:1:{s:39:"{53cfe8d1-4c38-461d-92cc-2a2b3e8d2c65}2";b:1;}s:17:"lasthbsyncstarted";i:1406137168;s:17:"lastsyncendnormal";i:1406136867;s:9:"timestamp";s:10:"1406137168";s:4:"wait";b:0;s:10:"hbinterval";s:3:"480";s:7:"folders";a:14:{s:9:"T6e34e019";a:2:{s:5:"class";s:5:"Tasks";s:8:"serverid";s:7:"@Tasks@";}s:2:"RI";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:2:"RI";}s:9:"Nb977d1b4";a:2:{s:5:"class";s:5:"Notes";s:8:"serverid";s:7:"@Notes@";}s:9:"Ff1550486";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:14:"Infected Items";}s:9:"Fd2778da7";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:35:"Trash.Gelöschte Elemente [1].Trash";}s:9:"F6e065cf6";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:20:"INBOX.Infected Items";}s:9:"F6b366c25";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:6:"Drafts";}s:9:"F47cc94cf";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"Trash";}s:9:"F0f549f7e";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:4:"Junk";}s:9:"F0eca702e";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:4:"Sent";}s:9:"F042926f9";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:29:"Trash.Gelöschte Elemente [1]";}s:9:"F02b039b0";a:2:{s:5:"class";s:5:"Email";s:8:"serverid";s:5:"INBOX";}s:9:"C902931ee";a:2:{s:5:"class";s:8:"Contacts";s:8:"serverid";s:10:"@Contacts@";}s:9:"A184d97b6";a:2:{s:5:"class";s:8:"Calendar";s:8:"serverid";s:10:"@Calendar@";}}s:9:"hierarchy";s:39:"{53cfe8bf-3fb4-480c-a45f-2a2b3e8d2c65}1";s:11:"collections";a:4:{s:9:"F02b039b0";a:12:{s:5:"class";s:5:"Email";s:10:"windowsize";s:2:"10";s:10:"truncation";i:0;s:11:"mimesupport";i:0;s:14:"mimetruncation";i:8;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:2;a:2:{s:4:"type";s:1:"2";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:5:"INBOX";s:11:"lastsynckey";s:39:"{53cfe8c1-2420-41ec-add6-2a2b3e8d2c65}8";s:14:"deletesasmoves";s:1:"1";s:10:"filtertype";s:1:"3";s:8:"pingable";b:1;}s:9:"F0eca702e";a:12:{s:5:"class";s:5:"Email";s:10:"windowsize";s:2:"10";s:10:"truncation";i:0;s:11:"mimesupport";i:0;s:14:"mimetruncation";i:8;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:2;a:2:{s:4:"type";s:1:"2";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:4:"Sent";s:11:"lastsynckey";s:39:"{53cfe8cc-fd80-4296-bdac-2a2b3e8d2c65}5";s:14:"deletesasmoves";s:1:"1";s:10:"filtertype";s:1:"3";s:8:"pingable";b:1;}s:9:"A184d97b6";a:13:{s:5:"class";s:8:"Calendar";s:10:"windowsize";s:2:"10";s:10:"truncation";i:0;s:11:"mimesupport";i:0;s:14:"mimetruncation";i:8;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:1;a:2:{s:4:"type";s:1:"1";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:10:"@Calendar@";s:11:"lastsynckey";s:39:"{53cfe8d1-4c38-461d-92cc-2a2b3e8d2c65}2";s:14:"deletesasmoves";b:1;s:10:"filtertype";s:1:"4";s:8:"pingable";b:1;s:10:"pingchange";b:1;}s:9:"C902931ee";a:12:{s:5:"class";s:8:"Contacts";s:10:"windowsize";s:2:"10";s:10:"truncation";i:0;s:11:"mimesupport";i:0;s:14:"mimetruncation";i:8;s:8:"conflict";i:1;s:9:"bodyprefs";a:1:{i:1;a:2:{s:4:"type";s:1:"1";s:14:"truncationsize";s:6:"200000";}}s:8:"serverid";s:10:"@Contacts@";s:11:"lastsynckey";s:40:"{53cfe8d2-9b5c-4e69-b107-2a2b3e8d2c65}13";s:14:"deletesasmoves";b:1;s:10:"filtertype";s:1:"0";s:8:"pingable";b:1;}}s:13:"pingheartbeat";b:0;s:14:"synckeycounter";a:0:{}}
2014-07-23T19:39:28+02:00 DEBUG: [31448] O
2014-07-23T19:39:28+02:00 DEBUG: [31448] O
2014-07-23T19:39:28+02:00 DEBUG: [31448] O 2
2014-07-23T19:39:28+02:00 DEBUG: [31448] O
2014-07-23T19:39:28+02:00 DEBUG: [31448] O
2014-07-23T19:39:28+02:00 DEBUG: [31448] O
2014-07-23T19:39:28+02:00 DEBUG: [31448] O A184d97b6
2014-07-23T19:39:28+02:00 DEBUG: [31448] O
2014-07-23T19:39:28+02:00 DEBUG: [31448] O
2014-07-23T19:39:28+02:00 DEBUG: [31448] O
2014-07-23T19:39:28+02:00 INFO: [31448] Maximum memory usage for ActiveSync request: 5487864 bytes.