Skip to content

Instantly share code, notes, and snippets.

@sideshowbob84
Created December 17, 2012 13:42
Show Gist options
  • Select an option

  • Save sideshowbob84/4318356 to your computer and use it in GitHub Desktop.

Select an option

Save sideshowbob84/4318356 to your computer and use it in GitHub Desktop.
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:34 [10257] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476654')
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:17:34 [10257] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:34 [10257] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:17:34 [10257] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:34 [10257] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:17:34 [10257] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:34 [10257] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526254
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:17:34 [10257] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '1' changes
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] SyncCollections->CheckForChanges(): Found changes polling
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] WBXMLEncoder->endTag() WBXML output completed
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->Logoff()
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] BackendIMAP->Logoff(): IMAP connection closed
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] FileStateMachine->SetState() written 395 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bs-1355732061'
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] OCCombined->Logoff() success
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] LoopDetection->ProcessLoopDetectionTerminate()
17/12/2012 09:17:34 [10257] [DEBUG] [testuser] -------- End
17/12/2012 09:17:34 [10257] [ WARN] [testuser] /volume1/web/owncloud/apps/user_ldap/lib/connection.php:67 ldap_unbind(): 220 is not a valid ldap link resource (2)
17/12/2012 09:17:35 [31443] [DEBUG] [testuser] -------- Start
17/12/2012 09:17:35 [31443] [ INFO] [testuser] Version='2.0.6-1616' method='POST' from='192.168.178.24' cmd='Sync' getUser='testuser' devId='PALM657dff87dbce94a26444091b718e' devType='Palm'
17/12/2012 09:17:35 [31443] [DEBUG] [testuser] Used timezone 'UTC'
17/12/2012 09:17:35 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occombined/occombined.php'
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/imap.php'
17/12/2012 09:17:36 [31443] [ INFO] [testuser] i => Array
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occontacts.php'
17/12/2012 09:17:36 [31443] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/files_odfviewer/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:17:36 [31443] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/tasks/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:17:36 [31443] [ INFO] [testuser] o => Array
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occalendar.php'
17/12/2012 09:17:36 [31443] [ INFO] [testuser] a => Array
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/dummy.php'
17/12/2012 09:17:36 [31443] [ INFO] [testuser] d => Array
17/12/2012 09:17:36 [31443] [ INFO] [testuser] OCCombined 4 backends loaded.
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] Request::ProcessHeaders() ASVersion: 2.5
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] ZPush::CommandNeedsProvisioning(0): true
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-devicedata'
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] ASDevice data loaded for user: 'testuser'
17/12/2012 09:17:36 [31443] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:17:36 [31443] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] ZPush::HierarchyCommand(0): false
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] DeviceManager->ProvisioningRequired('248170377') saved device key '248170377': false
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] ZPush::CommandNeedsAuthentication(0): true
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCombined->Logon('testuser', 'die-sievers.de',***))
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] BackendIMAP->Logon(): Excluding Folders ()
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] BackendIMAP->Logon(): User 'testuser' is authenticated on IMAP
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCContacts::Logon(testuser)
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCContacts::Logon : Logged
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCContacts::Logon : addressBook selected :Contacts
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCContacts::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCalendar::Logon(testuser)
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCalendar::Logon : Logged
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCalendar::Logon : Calendar selected :Default calendar
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCalendar::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:17:36 [31443] [ INFO] [testuser] OCCombined->Logon() success
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCombined->Setup('testuser', 'true', '')
17/12/2012 09:17:36 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] ZPush::CommandNeedsPlainInput(0): false
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] Sync folder: 'Calendar'
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] HandleSync(): Start Output
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] Sync->loadStates(): loading states for folder 'a/calendar'
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-1'
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/calendar'): 'false'
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:36 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526256
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:17:36 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] Folder type: Calendar
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/calendar' changed
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] FileStateMachine->SetState() written 646 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] WBXMLEncoder->endTag() WBXML output completed
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCombined->Logoff()
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] BackendIMAP->Logoff(): IMAP connection closed
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] OCCombined->Logoff() success
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] LoopDetection->ProcessLoopDetectionTerminate()
17/12/2012 09:17:36 [31443] [DEBUG] [testuser] -------- End
17/12/2012 09:17:36 [31443] [ WARN] [testuser] /volume1/web/owncloud/apps/user_ldap/lib/connection.php:67 ldap_unbind(): 227 is not a valid ldap link resource (2)
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] -------- Start
17/12/2012 09:17:38 [13604] [ INFO] [testuser] Version='2.0.6-1616' method='POST' from='192.168.178.24' cmd='Ping' getUser='testuser' devId='PALM657dff87dbce94a26444091b718e' devType='Palm'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] Used timezone 'UTC'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occombined/occombined.php'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/imap.php'
17/12/2012 09:17:38 [13604] [ INFO] [testuser] i => Array
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occontacts.php'
17/12/2012 09:17:38 [13604] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/files_odfviewer/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:17:38 [13604] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/tasks/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:17:38 [13604] [ INFO] [testuser] o => Array
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occalendar.php'
17/12/2012 09:17:38 [13604] [ INFO] [testuser] a => Array
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/dummy.php'
17/12/2012 09:17:38 [13604] [ INFO] [testuser] d => Array
17/12/2012 09:17:38 [13604] [ INFO] [testuser] OCCombined 4 backends loaded.
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] Request::ProcessHeaders() ASVersion: 2.5
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] ZPush::CommandNeedsProvisioning(18): false
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] ZPush::CommandNeedsAuthentication(18): true
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCombined->Logon('testuser', 'die-sievers.de',***))
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] BackendIMAP->Logon(): Excluding Folders ()
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] BackendIMAP->Logon(): User 'testuser' is authenticated on IMAP
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCContacts::Logon(testuser)
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCContacts::Logon : Logged
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCContacts::Logon : addressBook selected :Contacts
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCContacts::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCalendar::Logon(testuser)
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCalendar::Logon : Logged
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCalendar::Logon : Calendar selected :Default calendar
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCalendar::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:17:38 [13604] [ INFO] [testuser] OCCombined->Logon() success
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCombined->Setup('testuser', 'true', '')
17/12/2012 09:17:38 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-devicedata'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] ASDevice data loaded for user: 'testuser'
17/12/2012 09:17:38 [13604] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:17:38 [13604] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] ZPush::HierarchyCommand(18): false
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] ZPush::CommandNeedsPlainInput(18): false
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-95747b28-4660-4045-9235-d7e151848d9f-fd'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/4ba0ba86'): 'false'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:38 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{95747b28-4660-4045-9235-d7e151848d9f}1'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-95747b28-4660-4045-9235-d7e151848d9f-1'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-fd'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/38c86e73'): 'false'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:38 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{ed4fa03c-db40-4e19-a8db-dcfb3c918199}1'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-1'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-fcf40993-094a-4453-8182-70228cec8908-fd'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/046f917d'): 'false'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:38 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{fcf40993-094a-4453-8182-70228cec8908}1'
17/12/2012 09:17:38 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-fcf40993-094a-4453-8182-70228cec8908-1'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-fd'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('o/contacts'): 'false'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:39 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{bcf81179-3f45-4884-978e-50326c607dd2}2'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-2'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-fd'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/tasks'): 'false'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:39 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{63c796ee-9b67-42c4-8b61-69e2dfd21970}1'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-1'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/calendar'): 'false'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:39 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{72ee3508-67de-488a-9b1e-bf27f528820e}1'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-1'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] HandlePing(): reference PolicyKey for PING: 248170377
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] HandlePing(): initialization data received
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Calendar' id 'a/calendar'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Tasks' id 'a/tasks'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Email' id 'i/38c86e73'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Contacts' id 'o/contacts'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'i/38c86e73' changed
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->SetState() written 638 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-fd'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'o/contacts' changed
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->SetState() written 613 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-fd'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/tasks' changed
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->SetState() written 636 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-fd'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/calendar' changed
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->SetState() written 646 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:17:39 [13604] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:17:39 [13604] [ INFO] [testuser] SyncCollections->CheckForChanges(): Waiting for store changes... (lifetime 1680 seconds)
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:39 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476659')
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bs-1355732061'
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:17:39 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:39 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:17:39 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:39 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:17:39 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:17:39 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526259
17/12/2012 09:17:39 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:17:39 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:09 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476689')
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:18:09 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:09 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:18:09 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:09 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:18:09 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:09 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526289
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
)
17/12/2012 09:18:09 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '1' changes
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] SyncCollections->CheckForChanges(): Found changes polling
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] WBXMLEncoder->endTag() WBXML output completed
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->Logoff()
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] BackendIMAP->Logoff(): IMAP connection closed
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] FileStateMachine->SetState() written 395 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bs-1355732061'
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] OCCombined->Logoff() success
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] LoopDetection->ProcessLoopDetectionTerminate()
17/12/2012 09:18:09 [13604] [DEBUG] [testuser] -------- End
17/12/2012 09:18:09 [13604] [ WARN] [testuser] /volume1/web/owncloud/apps/user_ldap/lib/connection.php:67 ldap_unbind(): 220 is not a valid ldap link resource (2)
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] -------- Start
17/12/2012 09:18:10 [16776] [ INFO] [testuser] Version='2.0.6-1616' method='POST' from='192.168.178.24' cmd='Sync' getUser='testuser' devId='PALM657dff87dbce94a26444091b718e' devType='Palm'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Used timezone 'UTC'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occombined/occombined.php'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/imap.php'
17/12/2012 09:18:10 [16776] [ INFO] [testuser] i => Array
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occontacts.php'
17/12/2012 09:18:10 [16776] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/files_odfviewer/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:10 [16776] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/tasks/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:10 [16776] [ INFO] [testuser] o => Array
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occalendar.php'
17/12/2012 09:18:10 [16776] [ INFO] [testuser] a => Array
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/dummy.php'
17/12/2012 09:18:10 [16776] [ INFO] [testuser] d => Array
17/12/2012 09:18:10 [16776] [ INFO] [testuser] OCCombined 4 backends loaded.
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Request::ProcessHeaders() ASVersion: 2.5
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] ZPush::CommandNeedsProvisioning(0): true
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-devicedata'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] ASDevice data loaded for user: 'testuser'
17/12/2012 09:18:10 [16776] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:10 [16776] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] ZPush::HierarchyCommand(0): false
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] DeviceManager->ProvisioningRequired('248170377') saved device key '248170377': false
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] ZPush::CommandNeedsAuthentication(0): true
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCombined->Logon('testuser', 'die-sievers.de',***))
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] BackendIMAP->Logon(): Excluding Folders ()
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] BackendIMAP->Logon(): User 'testuser' is authenticated on IMAP
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCContacts::Logon(testuser)
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCContacts::Logon : Logged
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCContacts::Logon : addressBook selected :Contacts
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCContacts::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::Logon(testuser)
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::Logon : Logged
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::Logon : Calendar selected :Default calendar
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:10 [16776] [ INFO] [testuser] OCCombined->Logon() success
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCombined->Setup('testuser', 'true', '')
17/12/2012 09:18:10 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] ZPush::CommandNeedsPlainInput(0): false
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Sync folder: 'Calendar'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] HandleSync(): Start Output
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Sync->loadStates(): loading states for folder 'a/calendar'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-1'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/calendar'): 'false'
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:10 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526290
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
)
17/12/2012 09:18:10 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '1' changes
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] Folder type: Calendar
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::StatMessage(calendar, owncloud-883d0e88e65153bc9522057c26045909)
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::StatMessage(Array
(
[id] => 39
[calendarid] => 2
[objecttype] => VEVENT
[startdate] => 2012-12-19 07:00:00
[enddate] => 2012-12-19 08:00:00
[repeating] => 0
[summary] => fromoc
[calendardata] => BEGIN:VCALENDAR
VERSION:2.0
PRODID:ownCloud Calendar
BEGIN:VEVENT
DTSTART;VALUE=DATE-TIME;TZID=Europe/Berlin:20121219T090000
DTEND;VALUE=DATE-TIME;TZID=Europe/Berlin:20121219T100000
SUMMARY:fromoc
DTSTAMP;VALUE=DATE-TIME:20121217T091745Z
UID:a62c37d234
LAST-MODIFIED;VALUE=DATE-TIME:20121217T091745Z
CREATED;VALUE=DATE-TIME:20121217T091745Z
END:VEVENT
END:VCALENDAR
[uri] => owncloud-883d0e88e65153bc9522057c26045909.ics
[lastmodified] => 1355735865
)
17/12/2012 09:18:10 [16776] [DEBUG] [testuser] OCCalendar::GetMessage(calendar, owncloud-883d0e88e65153bc9522057c26045909, ..)
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] OCCalendar::converting vevent to outlook appointment
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] TimezoneUtil::GetFullTZ() for Europe/Berlin
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] OCCalendar::GetMessage: UTC $message = (SyncAppointment Object
(
[timezone] => ////xAAoAEcATQBUACsAMAAxADoAMAAwACkAIABBAG0AcwB0AGUAcgBkAGEAbQAsACAAQgBlAHIAbABpAG4ALAAgAEIAAAoABQAAAAMAAAAAAAAAAAAAAAAoAEcATQBUACsAMAAxADoAMAAwACkAIABBAG0AcwB0AGUAcgBkAGEAbQAsACAAQgBlAHIAbABpAG4ALAAgAEIAAAMABQAAAAIAAAAAAAAA////xA==
[dtstamp] => 1355732265
[starttime] => 1355904000
[subject] => fromoc
[uid] => 61363263333764323334
[organizername] =>
[organizeremail] =>
[location] =>
[endtime] => 1355907600
[recurrence] =>
[sensitivity] => 0
[busystatus] => 2
[alldayevent] => 0
[reminder] =>
[rtf] =>
[meetingstatus] => 0
[attendees] =>
[body] =>
[bodytruncated] =>
[exception] =>
[deleted] =>
[exceptionstarttime] =>
[categories] =>
[asbody] =>
[nativebodytype] =>
[disallownewtimeprop] =>
[responsetype] =>
[responserequested] =>
[unsetVars:protected] => Array
(
)
[mapping:protected] => Array
(
[POOMCAL:Timezone] => Array
(
[1] => timezone
)
[POOMCAL:DtStamp] => Array
(
[1] => dtstamp
[3] => 1
[6] => Array
(
[7] => setToValue0
)
)
[POOMCAL:StartTime] => Array
(
[1] => starttime
[3] => 1
[6] => Array
(
[7] => setToValue0
[13] => POOMCAL:EndTime
)
)
[POOMCAL:Subject] => Array
(
[1] => subject
[6] => Array
(
[7] => setToValueEmpty
)
)
[POOMCAL:UID] => Array
(
[1] => uid
)
[POOMCAL:OrganizerName] => Array
(
[1] => organizername
)
[POOMCAL:OrganizerEmail] => Array
(
[1] => organizeremail
)
[POOMCAL:Location] => Array
(
[1] => location
)
[POOMCAL:EndTime] => Array
(
[1] => endtime
[3] => 1
[6] => Array
(
[7] => setToValue1
[14] => POOMCAL:StartTime
)
)
[POOMCAL:Recurrence] => Array
(
[1] => recurrence
[3] => SyncRecurrence
)
[POOMCAL:Sensitivity] => Array
(
[1] => sensitivity
[6] => Array
(
[10] => Array
(
[0] => 0
[1] => 1
[2] => 2
[3] => 3
)
)
)
[POOMCAL:BusyStatus] => Array
(
[1] => busystatus
[6] => Array
(
[7] => setToValue2
[10] => Array
(
[0] => 0
[1] => 1
[2] => 2
[3] => 3
)
)
)
[POOMCAL:AllDayEvent] => Array
(
[1] => alldayevent
[6] => Array
(
[8] => setToValue0
)
)
[POOMCAL:Reminder] => Array
(
[1] => reminder
[6] => Array
(
[14] => -1
)
)
[POOMCAL:Rtf] => Array
(
[1] => rtf
)
[POOMCAL:MeetingStatus] => Array
(
[1] => meetingstatus
[6] => Array
(
[10] => Array
(
[0] => 0
[1] => 1
[2] => 3
[3] => 5
[4] => 7
[5] => 9
[6] => 11
[7] => 13
[8] => 15
)
)
)
[POOMCAL:Attendees] => Array
(
[1] => attendees
[3] => SyncAttendee
[2] => POOMCAL:Attendee
)
[POOMCAL:Body] => Array
(
[1] => body
)
[POOMCAL:BodyTruncated] => Array
(
[1] => bodytruncated
)
[POOMCAL:Exceptions] => Array
(
[1] => exceptions
[3] => SyncAppointmentException
[2] => POOMCAL:Exception
)
[POOMCAL:Categories] => Array
(
[1] => categories
[2] => POOMCAL:Category
)
)
[flags] =>
[content] =>
[exceptions] => Array
(
)
)
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] FileStateMachine->SetState() written 118 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-2'
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/calendar' changed
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] FileStateMachine->SetState() written 672 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] WBXMLEncoder->endTag() WBXML output completed
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] OCCombined->Logoff()
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] BackendIMAP->Logoff(): IMAP connection closed
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] OCCombined->Logoff() success
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] LoopDetection->ProcessLoopDetectionTerminate()
17/12/2012 09:18:11 [16776] [DEBUG] [testuser] -------- End
17/12/2012 09:18:11 [16776] [ WARN] [testuser] /volume1/web/owncloud/apps/user_ldap/lib/connection.php:67 ldap_unbind(): 227 is not a valid ldap link resource (2)
17/12/2012 09:18:11 [31443] [DEBUG] [testuser] -------- Start
17/12/2012 09:18:11 [31443] [ INFO] [testuser] Version='2.0.6-1616' method='POST' from='192.168.178.24' cmd='Ping' getUser='testuser' devId='PALM657dff87dbce94a26444091b718e' devType='Palm'
17/12/2012 09:18:11 [31443] [DEBUG] [testuser] Used timezone 'UTC'
17/12/2012 09:18:11 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occombined/occombined.php'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/imap.php'
17/12/2012 09:18:12 [31443] [ INFO] [testuser] i => Array
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occontacts.php'
17/12/2012 09:18:12 [31443] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/files_odfviewer/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:12 [31443] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/tasks/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:12 [31443] [ INFO] [testuser] o => Array
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occalendar.php'
17/12/2012 09:18:12 [31443] [ INFO] [testuser] a => Array
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/dummy.php'
17/12/2012 09:18:12 [31443] [ INFO] [testuser] d => Array
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined 4 backends loaded.
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] Request::ProcessHeaders() ASVersion: 2.5
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::CommandNeedsProvisioning(18): false
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::CommandNeedsAuthentication(18): true
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCombined->Logon('testuser', 'die-sievers.de',***))
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] BackendIMAP->Logon(): Excluding Folders ()
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] BackendIMAP->Logon(): User 'testuser' is authenticated on IMAP
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCContacts::Logon(testuser)
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCContacts::Logon : Logged
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCContacts::Logon : addressBook selected :Contacts
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCContacts::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCalendar::Logon(testuser)
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCalendar::Logon : Logged
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCalendar::Logon : Calendar selected :Default calendar
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCalendar::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined->Logon() success
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCombined->Setup('testuser', 'true', '')
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-devicedata'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ASDevice data loaded for user: 'testuser'
17/12/2012 09:18:12 [31443] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:12 [31443] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::HierarchyCommand(18): false
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::CommandNeedsPlainInput(18): false
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-95747b28-4660-4045-9235-d7e151848d9f-fd'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/4ba0ba86'): 'false'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{95747b28-4660-4045-9235-d7e151848d9f}1'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-95747b28-4660-4045-9235-d7e151848d9f-1'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-fd'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/38c86e73'): 'false'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{ed4fa03c-db40-4e19-a8db-dcfb3c918199}1'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-1'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-fcf40993-094a-4453-8182-70228cec8908-fd'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/046f917d'): 'false'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{fcf40993-094a-4453-8182-70228cec8908}1'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-fcf40993-094a-4453-8182-70228cec8908-1'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-fd'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('o/contacts'): 'false'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{bcf81179-3f45-4884-978e-50326c607dd2}2'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-2'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-fd'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/tasks'): 'false'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{63c796ee-9b67-42c4-8b61-69e2dfd21970}1'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-1'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/calendar'): 'false'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:12 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{72ee3508-67de-488a-9b1e-bf27f528820e}2'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-2'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] HandlePing(): reference PolicyKey for PING: 248170377
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] HandlePing(): initialization data received
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Calendar' id 'a/calendar'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Tasks' id 'a/tasks'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Email' id 'i/38c86e73'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Contacts' id 'o/contacts'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'i/38c86e73' changed
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->SetState() written 638 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-fd'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'o/contacts' changed
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] FileStateMachine->SetState() written 613 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-fd'
17/12/2012 09:18:12 [31443] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/tasks' changed
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] FileStateMachine->SetState() written 636 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-fd'
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/calendar' changed
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] FileStateMachine->SetState() written 646 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:13 [31443] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:13 [31443] [ INFO] [testuser] SyncCollections->CheckForChanges(): Waiting for store changes... (lifetime 1680 seconds)
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:13 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476693')
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bs-1355732061'
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:18:13 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:13 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:18:13 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:13 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:18:13 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:13 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526293
17/12/2012 09:18:13 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
)
17/12/2012 09:18:13 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] -------- Start
17/12/2012 09:18:27 [10257] [ INFO] [testuser] Version='2.0.6-1616' method='POST' from='192.168.178.24' cmd='Sync' getUser='testuser' devId='PALM657dff87dbce94a26444091b718e' devType='Palm'
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] Used timezone 'UTC'
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occombined/occombined.php'
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/imap.php'
17/12/2012 09:18:27 [10257] [ INFO] [testuser] i => Array
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occontacts.php'
17/12/2012 09:18:27 [10257] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/files_odfviewer/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:27 [10257] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/tasks/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:27 [10257] [ INFO] [testuser] o => Array
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occalendar.php'
17/12/2012 09:18:27 [10257] [ INFO] [testuser] a => Array
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/dummy.php'
17/12/2012 09:18:27 [10257] [ INFO] [testuser] d => Array
17/12/2012 09:18:27 [10257] [ INFO] [testuser] OCCombined 4 backends loaded.
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] Request::ProcessHeaders() ASVersion: 2.5
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] ZPush::CommandNeedsProvisioning(0): true
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-devicedata'
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] ASDevice data loaded for user: 'testuser'
17/12/2012 09:18:27 [10257] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:27 [10257] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] ZPush::HierarchyCommand(0): false
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] DeviceManager->ProvisioningRequired('248170377') saved device key '248170377': false
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] ZPush::CommandNeedsAuthentication(0): true
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCCombined->Logon('testuser', 'die-sievers.de',***))
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] BackendIMAP->Logon(): Excluding Folders ()
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] BackendIMAP->Logon(): User 'testuser' is authenticated on IMAP
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCContacts::Logon(testuser)
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCContacts::Logon : Logged
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCContacts::Logon : addressBook selected :Contacts
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCContacts::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCCalendar::Logon(testuser)
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCCalendar::Logon : Logged
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCCalendar::Logon : Calendar selected :Default calendar
17/12/2012 09:18:27 [10257] [DEBUG] [testuser] OCCalendar::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:27 [10257] [ INFO] [testuser] OCCombined->Logon() success
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCombined->Setup('testuser', 'true', '')
17/12/2012 09:18:28 [10257] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] ZPush::CommandNeedsPlainInput(0): false
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] Sync folder: 'Calendar'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] Sync->getImporter(): initialize importer
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] Sync->loadStates(): loading states for folder 'a/calendar'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-1'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fs-1'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/calendar'): 'false'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:28 [10257] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCombined->GetImporter() Content: ImportChangesCombined:('a/calendar')
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] ImportChangesCombined->Config(...)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] ImportChangesCombined->Config() success
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] LoopDetection->SetSyncStateUsage(): uuid: 72ee3508-67de-488a-9b1e-bf27f528820e counter: 1
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::ChangeMessage(calendar, , ..)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::ChangeMessage: $message = (SyncAppointment Object
(
[timezone] => xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAEAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAEAAIAAAAAAAAAxP///w==
[dtstamp] => 1355735782
[starttime] => 1355990400
[subject] => frommobile
[uid] => 1355735780000299446613
[organizername] =>
[organizeremail] =>
[location] =>
[endtime] => 1355994000
[recurrence] =>
[sensitivity] => 0
[busystatus] => 2
[alldayevent] => 0
[reminder] => 15
[rtf] =>
[meetingstatus] => 0
[attendees] =>
[body] =>
[bodytruncated] =>
[exception] =>
[deleted] =>
[exceptionstarttime] =>
[categories] =>
[asbody] =>
[nativebodytype] =>
[disallownewtimeprop] =>
[responsetype] =>
[responserequested] =>
[unsetVars:protected] => Array
(
)
[mapping:protected] => Array
(
[POOMCAL:Timezone] => Array
(
[1] => timezone
)
[POOMCAL:DtStamp] => Array
(
[1] => dtstamp
[3] => 1
[6] => Array
(
[7] => setToValue0
)
)
[POOMCAL:StartTime] => Array
(
[1] => starttime
[3] => 1
[6] => Array
(
[7] => setToValue0
[13] => POOMCAL:EndTime
)
)
[POOMCAL:Subject] => Array
(
[1] => subject
[6] => Array
(
[7] => setToValueEmpty
)
)
[POOMCAL:UID] => Array
(
[1] => uid
)
[POOMCAL:OrganizerName] => Array
(
[1] => organizername
)
[POOMCAL:OrganizerEmail] => Array
(
[1] => organizeremail
)
[POOMCAL:Location] => Array
(
[1] => location
)
[POOMCAL:EndTime] => Array
(
[1] => endtime
[3] => 1
[6] => Array
(
[7] => setToValue1
[14] => POOMCAL:StartTime
)
)
[POOMCAL:Recurrence] => Array
(
[1] => recurrence
[3] => SyncRecurrence
)
[POOMCAL:Sensitivity] => Array
(
[1] => sensitivity
[6] => Array
(
[10] => Array
(
[0] => 0
[1] => 1
[2] => 2
[3] => 3
)
)
)
[POOMCAL:BusyStatus] => Array
(
[1] => busystatus
[6] => Array
(
[7] => setToValue2
[10] => Array
(
[0] => 0
[1] => 1
[2] => 2
[3] => 3
)
)
)
[POOMCAL:AllDayEvent] => Array
(
[1] => alldayevent
[6] => Array
(
[8] => setToValue0
)
)
[POOMCAL:Reminder] => Array
(
[1] => reminder
[6] => Array
(
[14] => -1
)
)
[POOMCAL:Rtf] => Array
(
[1] => rtf
)
[POOMCAL:MeetingStatus] => Array
(
[1] => meetingstatus
[6] => Array
(
[10] => Array
(
[0] => 0
[1] => 1
[2] => 3
[3] => 5
[4] => 7
[5] => 9
[6] => 11
[7] => 13
[8] => 15
)
)
)
[POOMCAL:Attendees] => Array
(
[1] => attendees
[3] => SyncAttendee
[2] => POOMCAL:Attendee
)
[POOMCAL:Body] => Array
(
[1] => body
)
[POOMCAL:BodyTruncated] => Array
(
[1] => bodytruncated
)
[POOMCAL:Exceptions] => Array
(
[1] => exceptions
[3] => SyncAppointmentException
[2] => POOMCAL:Exception
)
[POOMCAL:Categories] => Array
(
[1] => categories
[2] => POOMCAL:Category
)
)
[flags] =>
[content] =>
)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] CalDAV::Found new message on device
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] CalDAV:: About to create new event.
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] CalDAV:: About to create mapping array.
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] CalDAV:: About to loop through calendar array.
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] CalDAV::Converted to iCal:
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] CalDAV::putting to 20121217T091828UTC-0897UWA99s
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::ChangeMessage, OC_Calendar_Object::addFromDAVData(2, BEGIN:VCALENDAR
VERSION:2.0
PRODID:-//192.168.178.20//NONSGML kigkonsult.se iCalcreator 2.16.1//
BEGIN:VEVENT
UID:20121217T091828UTC-0897UWA99s
DTSTAMP:20121217T091622Z
CLASS:PUBLIC
DTSTART:20121220T080000Z
DTEND:20121220T090000Z
LAST-MODIFIED:20121217T091828Z
STATUS:
SUMMARY:frommobile
TRANSP:OPAQUE
BEGIN:VALARM
ACTION:DISPLAY
DESCRIPTION:frommobile
TRIGGER:-PT0H15M0S
END:VALARM
END:VEVENT
END:VCALENDAR
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::StatMessage(calendar, 20121217T091828UTC-0897UWA99s)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::StatMessage(Array
(
[id] => 40
[calendarid] => 2
[objecttype] => VEVENT
[startdate] => 2012-12-20 08:00:00
[enddate] => 2012-12-20 09:00:00
[repeating] => 0
[summary] => frommobile
[calendardata] => BEGIN:VCALENDAR
VERSION:2.0
PRODID:-//192.168.178.20//NONSGML kigkonsult.se iCalcreator 2.16.1//
BEGIN:VEVENT
UID:20121217T091828UTC-0897UWA99s
DTSTAMP:20121217T091622Z
CLASS:PUBLIC
DTSTART:20121220T080000Z
DTEND:20121220T090000Z
LAST-MODIFIED:20121217T091828Z
STATUS:
SUMMARY:frommobile
TRANSP:OPAQUE
BEGIN:VALARM
ACTION:DISPLAY
DESCRIPTION:frommobile
TRIGGER:-PT0H15M0S
END:VALARM
END:VEVENT
END:VCALENDAR
[uri] => 20121217T091828UTC-0897UWA99s.ics
[lastmodified] => 1355735908
)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::ChangeMessage,StatMessage=Array
(
[id] => 20121217T091828UTC-0897UWA99s
[mod] => 1355735908
[flags] => 1
)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::StatMessage(calendar, 20121217T091828UTC-0897UWA99s)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::StatMessage(Array
(
[id] => 40
[calendarid] => 2
[objecttype] => VEVENT
[startdate] => 2012-12-20 08:00:00
[enddate] => 2012-12-20 09:00:00
[repeating] => 0
[summary] => frommobile
[calendardata] => BEGIN:VCALENDAR
VERSION:2.0
PRODID:-//192.168.178.20//NONSGML kigkonsult.se iCalcreator 2.16.1//
BEGIN:VEVENT
UID:20121217T091828UTC-0897UWA99s
DTSTAMP:20121217T091622Z
CLASS:PUBLIC
DTSTART:20121220T080000Z
DTEND:20121220T090000Z
LAST-MODIFIED:20121217T091828Z
STATUS:
SUMMARY:frommobile
TRANSP:OPAQUE
BEGIN:VALARM
ACTION:DISPLAY
DESCRIPTION:frommobile
TRIGGER:-PT0H15M0S
END:VALARM
END:VEVENT
END:VCALENDAR
[uri] => 20121217T091828UTC-0897UWA99s.ics
[lastmodified] => 1355735908
)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] Sync->importMessage(): message imported
17/12/2012 09:18:28 [10257] [ INFO] [testuser] Processed '1' incoming changes
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] FileStateMachine->SetState() written 361 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fs-1'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] HandleSync(): Start Output
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526308
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
[1] => Array
(
[id] => 20121217T091828UTC-0897UWA99s
[mod] => 1355735908
[flags] => 1
)
)
17/12/2012 09:18:28 [10257] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '1' changes
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] Folder type: Calendar
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::StatMessage(calendar, owncloud-883d0e88e65153bc9522057c26045909)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::StatMessage(Array
(
[id] => 39
[calendarid] => 2
[objecttype] => VEVENT
[startdate] => 2012-12-19 07:00:00
[enddate] => 2012-12-19 08:00:00
[repeating] => 0
[summary] => fromoc
[calendardata] => BEGIN:VCALENDAR
VERSION:2.0
PRODID:ownCloud Calendar
BEGIN:VEVENT
DTSTART;VALUE=DATE-TIME;TZID=Europe/Berlin:20121219T090000
DTEND;VALUE=DATE-TIME;TZID=Europe/Berlin:20121219T100000
SUMMARY:fromoc
DTSTAMP;VALUE=DATE-TIME:20121217T091745Z
UID:a62c37d234
LAST-MODIFIED;VALUE=DATE-TIME:20121217T091745Z
CREATED;VALUE=DATE-TIME:20121217T091745Z
END:VEVENT
END:VCALENDAR
[uri] => owncloud-883d0e88e65153bc9522057c26045909.ics
[lastmodified] => 1355735865
)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::GetMessage(calendar, owncloud-883d0e88e65153bc9522057c26045909, ..)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::converting vevent to outlook appointment
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1098 timezone_open() expects parameter 1 to be string, array given (2)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1108 date_create_from_format() expects parameter 3 to be DateTimeZone, boolean given (2)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1109 date_timestamp_get() expects parameter 1 to be DateTime, boolean given (2)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1098 timezone_open() expects parameter 1 to be string, array given (2)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1108 date_create_from_format() expects parameter 3 to be DateTimeZone, boolean given (2)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1109 date_timestamp_get() expects parameter 1 to be DateTime, boolean given (2)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1098 timezone_open() expects parameter 1 to be string, array given (2)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1108 date_create_from_format() expects parameter 3 to be DateTimeZone, boolean given (2)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/oczpush/backend/occalendar.php:1109 date_timestamp_get() expects parameter 1 to be DateTime, boolean given (2)
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] TimezoneUtil::GetFullTZ() for Europe/Berlin
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCalendar::GetMessage: UTC $message = (SyncAppointment Object
(
[timezone] => ////xAAoAEcATQBUACsAMAAxADoAMAAwACkAIABBAG0AcwB0AGUAcgBkAGEAbQAsACAAQgBlAHIAbABpAG4ALAAgAEIAAAoABQAAAAMAAAAAAAAAAAAAAAAoAEcATQBUACsAMAAxADoAMAAwACkAIABBAG0AcwB0AGUAcgBkAGEAbQAsACAAQgBlAHIAbABpAG4ALAAgAEIAAAMABQAAAAIAAAAAAAAA////xA==
[dtstamp] =>
[starttime] =>
[subject] => fromoc
[uid] => 61363263333764323334
[organizername] =>
[organizeremail] =>
[location] =>
[endtime] =>
[recurrence] =>
[sensitivity] => 0
[busystatus] => 2
[alldayevent] => 0
[reminder] =>
[rtf] =>
[meetingstatus] => 0
[attendees] =>
[body] =>
[bodytruncated] =>
[exception] =>
[deleted] =>
[exceptionstarttime] =>
[categories] =>
[asbody] =>
[nativebodytype] =>
[disallownewtimeprop] =>
[responsetype] =>
[responserequested] =>
[unsetVars:protected] => Array
(
)
[mapping:protected] => Array
(
[POOMCAL:Timezone] => Array
(
[1] => timezone
)
[POOMCAL:DtStamp] => Array
(
[1] => dtstamp
[3] => 1
[6] => Array
(
[7] => setToValue0
)
)
[POOMCAL:StartTime] => Array
(
[1] => starttime
[3] => 1
[6] => Array
(
[7] => setToValue0
[13] => POOMCAL:EndTime
)
)
[POOMCAL:Subject] => Array
(
[1] => subject
[6] => Array
(
[7] => setToValueEmpty
)
)
[POOMCAL:UID] => Array
(
[1] => uid
)
[POOMCAL:OrganizerName] => Array
(
[1] => organizername
)
[POOMCAL:OrganizerEmail] => Array
(
[1] => organizeremail
)
[POOMCAL:Location] => Array
(
[1] => location
)
[POOMCAL:EndTime] => Array
(
[1] => endtime
[3] => 1
[6] => Array
(
[7] => setToValue1
[14] => POOMCAL:StartTime
)
)
[POOMCAL:Recurrence] => Array
(
[1] => recurrence
[3] => SyncRecurrence
)
[POOMCAL:Sensitivity] => Array
(
[1] => sensitivity
[6] => Array
(
[10] => Array
(
[0] => 0
[1] => 1
[2] => 2
[3] => 3
)
)
)
[POOMCAL:BusyStatus] => Array
(
[1] => busystatus
[6] => Array
(
[7] => setToValue2
[10] => Array
(
[0] => 0
[1] => 1
[2] => 2
[3] => 3
)
)
)
[POOMCAL:AllDayEvent] => Array
(
[1] => alldayevent
[6] => Array
(
[8] => setToValue0
)
)
[POOMCAL:Reminder] => Array
(
[1] => reminder
[6] => Array
(
[14] => -1
)
)
[POOMCAL:Rtf] => Array
(
[1] => rtf
)
[POOMCAL:MeetingStatus] => Array
(
[1] => meetingstatus
[6] => Array
(
[10] => Array
(
[0] => 0
[1] => 1
[2] => 3
[3] => 5
[4] => 7
[5] => 9
[6] => 11
[7] => 13
[8] => 15
)
)
)
[POOMCAL:Attendees] => Array
(
[1] => attendees
[3] => SyncAttendee
[2] => POOMCAL:Attendee
)
[POOMCAL:Body] => Array
(
[1] => body
)
[POOMCAL:BodyTruncated] => Array
(
[1] => bodytruncated
)
[POOMCAL:Exceptions] => Array
(
[1] => exceptions
[3] => SyncAppointmentException
[2] => POOMCAL:Exception
)
[POOMCAL:Categories] => Array
(
[1] => categories
[2] => POOMCAL:Category
)
)
[flags] =>
[content] =>
[exceptions] => Array
(
)
)
17/12/2012 09:18:28 [10257] [ WARN] [testuser] SyncObject->Check(): Unmet condition in object from type SyncAppointment: parameter 'starttime' can not be compared, as the comparable is not set. Check failed!
17/12/2012 09:18:28 [10257] [ERROR] [testuser] trace error: /volume1/web/oczpush/lib/default/diffbackend/exportchangesdiff.php:199 Creating default object from empty value (2048) - backtrace: 3 steps
17/12/2012 09:18:28 [10257] [ERROR] [testuser] trace: 1:/volume1/web/oczpush/lib/request/sync.php:858 - ExportChangesDiff->Synchronize()
17/12/2012 09:18:28 [10257] [ERROR] [testuser] trace: 2:/volume1/web/oczpush/lib/request/requestprocessor.php:127 - Sync->Handle()
17/12/2012 09:18:28 [10257] [ERROR] [testuser] trace: 3:/volume1/web/oczpush/index.php:182 - RequestProcessor::HandleRequest()
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] FileStateMachine->SetState() written 106 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-2'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/calendar' changed
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] FileStateMachine->SetState() written 672 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] WBXMLEncoder->endTag() WBXML output completed
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCombined->Logoff()
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] BackendIMAP->Logoff(): IMAP connection closed
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] OCCombined->Logoff() success
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] LoopDetection->ProcessLoopDetectionTerminate()
17/12/2012 09:18:28 [10257] [DEBUG] [testuser] -------- End
17/12/2012 09:18:28 [10257] [ WARN] [testuser] /volume1/web/owncloud/apps/user_ldap/lib/connection.php:67 ldap_unbind(): 227 is not a valid ldap link resource (2)
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] -------- Start
17/12/2012 09:18:29 [29776] [ INFO] [testuser] Version='2.0.6-1616' method='POST' from='192.168.178.24' cmd='Ping' getUser='testuser' devId='PALM657dff87dbce94a26444091b718e' devType='Palm'
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] Used timezone 'UTC'
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occombined/occombined.php'
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/imap.php'
17/12/2012 09:18:29 [29776] [ INFO] [testuser] i => Array
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occontacts.php'
17/12/2012 09:18:29 [29776] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/files_odfviewer/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:29 [29776] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/tasks/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:29 [29776] [ INFO] [testuser] o => Array
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occalendar.php'
17/12/2012 09:18:29 [29776] [ INFO] [testuser] a => Array
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/dummy.php'
17/12/2012 09:18:29 [29776] [ INFO] [testuser] d => Array
17/12/2012 09:18:29 [29776] [ INFO] [testuser] OCCombined 4 backends loaded.
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] Request::ProcessHeaders() ASVersion: 2.5
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] ZPush::CommandNeedsProvisioning(18): false
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] ZPush::CommandNeedsAuthentication(18): true
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] OCCombined->Logon('testuser', 'die-sievers.de',***))
17/12/2012 09:18:29 [29776] [DEBUG] [testuser] BackendIMAP->Logon(): Excluding Folders ()
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] BackendIMAP->Logon(): User 'testuser' is authenticated on IMAP
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCContacts::Logon(testuser)
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCContacts::Logon : Logged
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCContacts::Logon : addressBook selected :Contacts
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCContacts::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::Logon(testuser)
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::Logon : Logged
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::Logon : Calendar selected :Default calendar
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Logon() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('testuser', 'true', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-devicedata'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ASDevice data loaded for user: 'testuser'
17/12/2012 09:18:30 [29776] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:30 [29776] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ZPush::HierarchyCommand(18): false
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ZPush::CommandNeedsPlainInput(18): false
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-95747b28-4660-4045-9235-d7e151848d9f-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/4ba0ba86'): 'false'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{95747b28-4660-4045-9235-d7e151848d9f}1'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-95747b28-4660-4045-9235-d7e151848d9f-1'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/38c86e73'): 'false'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{ed4fa03c-db40-4e19-a8db-dcfb3c918199}1'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-1'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-fcf40993-094a-4453-8182-70228cec8908-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/046f917d'): 'false'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{fcf40993-094a-4453-8182-70228cec8908}1'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-fcf40993-094a-4453-8182-70228cec8908-1'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('o/contacts'): 'false'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{bcf81179-3f45-4884-978e-50326c607dd2}2'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-2'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/tasks'): 'false'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{63c796ee-9b67-42c4-8b61-69e2dfd21970}1'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-1'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/calendar'): 'false'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{72ee3508-67de-488a-9b1e-bf27f528820e}2'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-2'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] HandlePing(): reference PolicyKey for PING: 248170377
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] HandlePing(): initialization data received
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Calendar' id 'a/calendar'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Tasks' id 'a/tasks'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Email' id 'i/38c86e73'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Contacts' id 'o/contacts'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'i/38c86e73' changed
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->SetState() written 638 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'o/contacts' changed
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->SetState() written 613 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/tasks' changed
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->SetState() written 636 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-fd'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/calendar' changed
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->SetState() written 646 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:30 [29776] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:30 [29776] [ INFO] [testuser] SyncCollections->CheckForChanges(): Waiting for store changes... (lifetime 1680 seconds)
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476710')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bs-1355732061'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:18:30 [29776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:18:30 [29776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:18:30 [29776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:30 [29776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526310
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
[1] => Array
(
[id] => 20121217T091828UTC-0897UWA99s
[mod] => 1355735908
[flags] => 1
)
)
17/12/2012 09:18:30 [29776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '1' changes
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] SyncCollections->CheckForChanges(): Found changes polling
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] WBXMLEncoder->endTag() WBXML output completed
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Logoff()
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] BackendIMAP->Logoff(): IMAP connection closed
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] FileStateMachine->SetState() written 395 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bs-1355732061'
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] OCCombined->Logoff() success
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] LoopDetection->ProcessLoopDetectionTerminate()
17/12/2012 09:18:30 [29776] [DEBUG] [testuser] -------- End
17/12/2012 09:18:30 [29776] [ WARN] [testuser] /volume1/web/owncloud/apps/user_ldap/lib/connection.php:67 ldap_unbind(): 220 is not a valid ldap link resource (2)
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] -------- Start
17/12/2012 09:18:31 [13604] [ INFO] [testuser] Version='2.0.6-1616' method='POST' from='192.168.178.24' cmd='Sync' getUser='testuser' devId='PALM657dff87dbce94a26444091b718e' devType='Palm'
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] Used timezone 'UTC'
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occombined/occombined.php'
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/imap.php'
17/12/2012 09:18:31 [13604] [ INFO] [testuser] i => Array
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occontacts.php'
17/12/2012 09:18:31 [13604] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/files_odfviewer/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:31 [13604] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/tasks/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:31 [13604] [ INFO] [testuser] o => Array
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occalendar.php'
17/12/2012 09:18:31 [13604] [ INFO] [testuser] a => Array
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/dummy.php'
17/12/2012 09:18:31 [13604] [ INFO] [testuser] d => Array
17/12/2012 09:18:31 [13604] [ INFO] [testuser] OCCombined 4 backends loaded.
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] Request::ProcessHeaders() ASVersion: 2.5
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] ZPush::CommandNeedsProvisioning(0): true
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-devicedata'
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] ASDevice data loaded for user: 'testuser'
17/12/2012 09:18:31 [13604] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:31 [13604] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] ZPush::HierarchyCommand(0): false
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] DeviceManager->ProvisioningRequired('248170377') saved device key '248170377': false
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] ZPush::CommandNeedsAuthentication(0): true
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] OCCombined->Logon('testuser', 'die-sievers.de',***))
17/12/2012 09:18:31 [13604] [DEBUG] [testuser] BackendIMAP->Logon(): Excluding Folders ()
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] BackendIMAP->Logon(): User 'testuser' is authenticated on IMAP
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCContacts::Logon(testuser)
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCContacts::Logon : Logged
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCContacts::Logon : addressBook selected :Contacts
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCContacts::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::Logon(testuser)
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::Logon : Logged
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::Logon : Calendar selected :Default calendar
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:32 [13604] [ INFO] [testuser] OCCombined->Logon() success
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCombined->Setup('testuser', 'true', '')
17/12/2012 09:18:32 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] ZPush::CommandNeedsPlainInput(0): false
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] Sync folder: 'Calendar'
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] HandleSync(): Start Output
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] Sync->loadStates(): loading states for folder 'a/calendar'
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] FileStateMachine->CleanStates(): Deleting file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-1'
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-2'
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/calendar'): 'false'
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:32 [13604] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526312
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
[1] => Array
(
[id] => 20121217T091828UTC-0897UWA99s
[mod] => 1355735908
[flags] => 1
)
)
17/12/2012 09:18:32 [13604] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '1' changes
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] Folder type: Calendar
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::StatMessage(calendar, owncloud-883d0e88e65153bc9522057c26045909)
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::StatMessage(Array
(
[id] => 39
[calendarid] => 2
[objecttype] => VEVENT
[startdate] => 2012-12-19 07:00:00
[enddate] => 2012-12-19 08:00:00
[repeating] => 0
[summary] => fromoc
[calendardata] => BEGIN:VCALENDAR
VERSION:2.0
PRODID:ownCloud Calendar
BEGIN:VEVENT
DTSTART;VALUE=DATE-TIME;TZID=Europe/Berlin:20121219T090000
DTEND;VALUE=DATE-TIME;TZID=Europe/Berlin:20121219T100000
SUMMARY:fromoc
DTSTAMP;VALUE=DATE-TIME:20121217T091745Z
UID:a62c37d234
LAST-MODIFIED;VALUE=DATE-TIME:20121217T091745Z
CREATED;VALUE=DATE-TIME:20121217T091745Z
END:VEVENT
END:VCALENDAR
[uri] => owncloud-883d0e88e65153bc9522057c26045909.ics
[lastmodified] => 1355735865
)
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::GetMessage(calendar, owncloud-883d0e88e65153bc9522057c26045909, ..)
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::converting vevent to outlook appointment
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] TimezoneUtil::GetFullTZ() for Europe/Berlin
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCalendar::GetMessage: UTC $message = (SyncAppointment Object
(
[timezone] => ////xAAoAEcATQBUACsAMAAxADoAMAAwACkAIABBAG0AcwB0AGUAcgBkAGEAbQAsACAAQgBlAHIAbABpAG4ALAAgAEIAAAoABQAAAAMAAAAAAAAAAAAAAAAoAEcATQBUACsAMAAxADoAMAAwACkAIABBAG0AcwB0AGUAcgBkAGEAbQAsACAAQgBlAHIAbABpAG4ALAAgAEIAAAMABQAAAAIAAAAAAAAA////xA==
[dtstamp] => 1355732265
[starttime] => 1355904000
[subject] => fromoc
[uid] => 61363263333764323334
[organizername] =>
[organizeremail] =>
[location] =>
[endtime] => 1355907600
[recurrence] =>
[sensitivity] => 0
[busystatus] => 2
[alldayevent] => 0
[reminder] =>
[rtf] =>
[meetingstatus] => 0
[attendees] =>
[body] =>
[bodytruncated] =>
[exception] =>
[deleted] =>
[exceptionstarttime] =>
[categories] =>
[asbody] =>
[nativebodytype] =>
[disallownewtimeprop] =>
[responsetype] =>
[responserequested] =>
[unsetVars:protected] => Array
(
)
[mapping:protected] => Array
(
[POOMCAL:Timezone] => Array
(
[1] => timezone
)
[POOMCAL:DtStamp] => Array
(
[1] => dtstamp
[3] => 1
[6] => Array
(
[7] => setToValue0
)
)
[POOMCAL:StartTime] => Array
(
[1] => starttime
[3] => 1
[6] => Array
(
[7] => setToValue0
[13] => POOMCAL:EndTime
)
)
[POOMCAL:Subject] => Array
(
[1] => subject
[6] => Array
(
[7] => setToValueEmpty
)
)
[POOMCAL:UID] => Array
(
[1] => uid
)
[POOMCAL:OrganizerName] => Array
(
[1] => organizername
)
[POOMCAL:OrganizerEmail] => Array
(
[1] => organizeremail
)
[POOMCAL:Location] => Array
(
[1] => location
)
[POOMCAL:EndTime] => Array
(
[1] => endtime
[3] => 1
[6] => Array
(
[7] => setToValue1
[14] => POOMCAL:StartTime
)
)
[POOMCAL:Recurrence] => Array
(
[1] => recurrence
[3] => SyncRecurrence
)
[POOMCAL:Sensitivity] => Array
(
[1] => sensitivity
[6] => Array
(
[10] => Array
(
[0] => 0
[1] => 1
[2] => 2
[3] => 3
)
)
)
[POOMCAL:BusyStatus] => Array
(
[1] => busystatus
[6] => Array
(
[7] => setToValue2
[10] => Array
(
[0] => 0
[1] => 1
[2] => 2
[3] => 3
)
)
)
[POOMCAL:AllDayEvent] => Array
(
[1] => alldayevent
[6] => Array
(
[8] => setToValue0
)
)
[POOMCAL:Reminder] => Array
(
[1] => reminder
[6] => Array
(
[14] => -1
)
)
[POOMCAL:Rtf] => Array
(
[1] => rtf
)
[POOMCAL:MeetingStatus] => Array
(
[1] => meetingstatus
[6] => Array
(
[10] => Array
(
[0] => 0
[1] => 1
[2] => 3
[3] => 5
[4] => 7
[5] => 9
[6] => 11
[7] => 13
[8] => 15
)
)
)
[POOMCAL:Attendees] => Array
(
[1] => attendees
[3] => SyncAttendee
[2] => POOMCAL:Attendee
)
[POOMCAL:Body] => Array
(
[1] => body
)
[POOMCAL:BodyTruncated] => Array
(
[1] => bodytruncated
)
[POOMCAL:Exceptions] => Array
(
[1] => exceptions
[3] => SyncAppointmentException
[2] => POOMCAL:Exception
)
[POOMCAL:Categories] => Array
(
[1] => categories
[2] => POOMCAL:Category
)
)
[flags] =>
[content] =>
[exceptions] => Array
(
)
)
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] FileStateMachine->SetState() written 218 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-3'
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/calendar' changed
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] FileStateMachine->SetState() written 672 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] WBXMLEncoder->endTag() WBXML output completed
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCombined->Logoff()
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] BackendIMAP->Logoff(): IMAP connection closed
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] OCCombined->Logoff() success
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] LoopDetection->ProcessLoopDetectionTerminate()
17/12/2012 09:18:32 [13604] [DEBUG] [testuser] -------- End
17/12/2012 09:18:32 [13604] [ WARN] [testuser] /volume1/web/owncloud/apps/user_ldap/lib/connection.php:67 ldap_unbind(): 227 is not a valid ldap link resource (2)
17/12/2012 09:18:33 [16776] [DEBUG] [testuser] -------- Start
17/12/2012 09:18:33 [16776] [ INFO] [testuser] Version='2.0.6-1616' method='POST' from='192.168.178.24' cmd='Ping' getUser='testuser' devId='PALM657dff87dbce94a26444091b718e' devType='Palm'
17/12/2012 09:18:33 [16776] [DEBUG] [testuser] Used timezone 'UTC'
17/12/2012 09:18:33 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occombined/occombined.php'
17/12/2012 09:18:33 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/imap.php'
17/12/2012 09:18:33 [16776] [ INFO] [testuser] i => Array
17/12/2012 09:18:33 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occontacts.php'
17/12/2012 09:18:33 [16776] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/files_odfviewer/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:33 [16776] [ WARN] [testuser] /volume1/web/owncloud/lib/app.php:393 file_get_contents(/volume1/web/owncloud/apps/tasks/appinfo/version): failed to open stream: No such file or directory (2)
17/12/2012 09:18:33 [16776] [ INFO] [testuser] o => Array
17/12/2012 09:18:33 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/occalendar.php'
17/12/2012 09:18:34 [16776] [ INFO] [testuser] a => Array
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] Including backend file: '/volume1/web/oczpush/backend/dummy.php'
17/12/2012 09:18:34 [16776] [ INFO] [testuser] d => Array
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined 4 backends loaded.
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] Request::ProcessHeaders() ASVersion: 2.5
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::CommandNeedsProvisioning(18): false
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::CommandNeedsAuthentication(18): true
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Logon('testuser', 'die-sievers.de',***))
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] BackendIMAP->Logon(): Excluding Folders ()
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] BackendIMAP->Logon(): User 'testuser' is authenticated on IMAP
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCContacts::Logon(testuser)
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCContacts::Logon : Logged
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCContacts::Logon : addressBook selected :Contacts
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCContacts::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::Logon(testuser)
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::Logon : Logged
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::Logon : Calendar selected :Default calendar
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::Logon : TZ Selected: Europe/Berlin
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Logon() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('testuser', 'true', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-devicedata'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ASDevice data loaded for user: 'testuser'
17/12/2012 09:18:34 [16776] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:34 [16776] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::HierarchyCommand(18): false
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::CommandNeedsPlainInput(18): false
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-95747b28-4660-4045-9235-d7e151848d9f-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/4ba0ba86'): 'false'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{95747b28-4660-4045-9235-d7e151848d9f}1'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-95747b28-4660-4045-9235-d7e151848d9f-1'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/38c86e73'): 'false'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{ed4fa03c-db40-4e19-a8db-dcfb3c918199}1'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-1'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-fcf40993-094a-4453-8182-70228cec8908-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('i/046f917d'): 'false'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{fcf40993-094a-4453-8182-70228cec8908}1'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-fcf40993-094a-4453-8182-70228cec8908-1'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('o/contacts'): 'false'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{bcf81179-3f45-4884-978e-50326c607dd2}2'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-2'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/tasks'): 'false'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{63c796ee-9b67-42c4-8b61-69e2dfd21970}1'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-1'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->UseCPO('DEFAULT')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ZPush::GetAdditionalSyncFolderStore('a/calendar'): 'false'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncParameters->GetLastestSyncKey(): '{72ee3508-67de-488a-9b1e-bf27f528820e}3'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-3'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] HandlePing(): reference PolicyKey for PING: 248170377
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] HandlePing(): initialization data received
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Calendar' id 'a/calendar'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Tasks' id 'a/tasks'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Email' id 'i/38c86e73'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] HandlePing(): using saved sync state for 'Contacts' id 'o/contacts'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'i/38c86e73' changed
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->SetState() written 638 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-ed4fa03c-db40-4e19-a8db-dcfb3c918199-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'o/contacts' changed
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->SetState() written 613 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bcf81179-3f45-4884-978e-50326c607dd2-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/tasks' changed
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->SetState() written 636 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-63c796ee-9b67-42c4-8b61-69e2dfd21970-fd'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] SyncCollections->SaveCollection(): Data of folder 'a/calendar' changed
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->SetState() written 646 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-72ee3508-67de-488a-9b1e-bf27f528820e-fd'
17/12/2012 09:18:34 [16776] [ INFO] [testuser] InterProcessData::InitSharedMem(): PHP libraries for the use shared memory are not available. Functionalities like z-push-top or loop detection are not available. Check your php packages.
17/12/2012 09:18:34 [16776] [ INFO] [testuser] SyncCollections->CheckForChanges(): Waiting for store changes... (lifetime 1680 seconds)
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476714')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] FileStateMachine->GetState() on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bs-1355732061'
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:18:34 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:18:34 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:18:34 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '2' messages in state
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526314
17/12/2012 09:18:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
[1] => Array
(
[id] => 20121217T091828UTC-0897UWA99s
[mod] => 1355735908
[flags] => 1
)
)
17/12/2012 09:18:34 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:43 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476723')
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:18:43 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:43 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:18:43 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:43 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:18:43 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:18:43 [31443] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526323
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
[1] => Array
(
[id] => 20121217T091828UTC-0897UWA99s
[mod] => 1355735908
[flags] => 1
)
)
17/12/2012 09:18:43 [31443] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '1' changes
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] SyncCollections->CheckForChanges(): Found changes polling
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] WBXMLEncoder->startWBXML() type: vnd.ms-sync.wbxml
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] WBXMLEncoder->endTag() WBXML output completed
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->Logoff()
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] BackendIMAP->Logoff(): IMAP connection closed
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] FileStateMachine->SetState() written 395 bytes on file: '/volume1/web/oczpush/state/e/8/PALM657dff87dbce94a26444091b718e-bs-1355732061'
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] OCCombined->Logoff() success
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] LoopDetection->ProcessLoopDetectionTerminate()
17/12/2012 09:18:43 [31443] [DEBUG] [testuser] -------- End
17/12/2012 09:18:43 [31443] [ WARN] [testuser] /volume1/web/owncloud/apps/user_ldap/lib/connection.php:67 ldap_unbind(): 220 is not a valid ldap link resource (2)
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:19:04 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476744')
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:19:04 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:19:04 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:19:04 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:19:04 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:19:04 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:19:04 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '2' messages in state
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526344
17/12/2012 09:19:04 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
[1] => Array
(
[id] => 20121217T091828UTC-0897UWA99s
[mod] => 1355735908
[flags] => 1
)
)
17/12/2012 09:19:04 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:19:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCombined->GetExporter('i/38c86e73')
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] BackendIMAP->GetMessageList('38c86e73','1355476774')
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] BackendIMAP->getImapIdFromFolderId('38c86e73') = INBOX
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] BackendIMAP->GetMessageList(): searching with sequence '1:*'
17/12/2012 09:19:34 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:19:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCombined->GetExporter('o/contacts')
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '1' messages in state
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCContacts::GetMessageList(contacts)
17/12/2012 09:19:34 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:19:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCombined->GetExporter('a/tasks')
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '0' messages in state
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList(tasks)
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
)
17/12/2012 09:19:34 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCombined->Setup('', 'false', '')
17/12/2012 09:19:34 [16776] [ INFO] [testuser] OCCombined->Setup() success
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCombined->GetExporter('a/calendar')
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] ExportChangesDiff->InitializeExporter(): Initializing message diff engine. '2' messages in state
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList(calendar)
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList cutoffdate1350290173 < 1354526374
17/12/2012 09:19:34 [16776] [DEBUG] [testuser] OCCalendar::GetMessageList: $messages = (Array
(
[0] => Array
(
[id] => owncloud-883d0e88e65153bc9522057c26045909
[mod] => 1355735865
[flags] => 1
)
[1] => Array
(
[id] => 20121217T091828UTC-0897UWA99s
[mod] => 1355735908
[flags] => 1
)
)
17/12/2012 09:19:34 [16776] [ INFO] [testuser] ExportChangesDiff->InitializeExporter(): Found '0' changes
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment