Jan 29 19:18:30 sogod [1966]: version 2.3.5 (build root@shiva.inverse 201601051534) -- starting Jan 29 19:18:30 sogod [1966]: vmem size check enabled: shutting down app when vmem > 384 MB Jan 29 19:18:31 sogod [1966]: <0x0x2384c0c[SOGoProductLoader]> SOGo products loaded from '/usr/lib/GNUstep/SOGo': Jan 29 19:18:31 sogod [1966]: <0x0x2384c0c[SOGoProductLoader]> CommonUI.SOGo, Appointments.SOGo, ActiveSync.SOGo, MainUI.SOGo, MailerUI.SOGo, AdministrationUI.SOGo, PreferencesUI.SOGo, Mailer.SOGo, Contacts.SOGo, SchedulerUI.SOGo, MailPartViewers.SOGo, ContactsUI.SOGo Jan 29 19:18:32 sogod [1966]: <0x0x24529cc[WOWatchDog]> listening on 127.0.0.1:20000 Jan 29 19:18:32 sogod [1966]: <0x0x24529cc[WOWatchDog]> watchdog process pid: 1966 Jan 29 19:18:32 sogod [1966]: <0x0x96a8c0[WOWatchDogChild]> watchdog request timeout set to 10 minutes Jan 29 19:18:32 sogod [1966]: <0x0x24529cc[WOWatchDog]> preparing 5 children Jan 29 19:18:32 sogod [1966]: <0x0x24529cc[WOWatchDog]> child spawned with pid 1991 Jan 29 19:18:32 sogod [1966]: <0x0x24529cc[WOWatchDog]> child spawned with pid 1992 Jan 29 19:18:33 sogod [1966]: <0x0x24529cc[WOWatchDog]> child spawned with pid 1994 Jan 29 19:18:33 sogod [1966]: <0x0x24529cc[WOWatchDog]> child spawned with pid 1996 Jan 29 19:18:33 sogod [1966]: <0x0x24529cc[WOWatchDog]> child spawned with pid 1999 Jan 29 19:20:53 sogod [1999]: <0x0x23a34bc[SOGoCache]> Cache cleanup interval set every 1800.000000 seconds Jan 29 19:20:53 sogod [1999]: <0x0x23a34bc[SOGoCache]> Using host(s) '127.0.0.1' as server(s) Jan 29 19:20:54 sogod [1999]: 192.168.10.181 "GET /SOGo HTTP/1.1" 302 0/0 0.308 - - 2M Jan 29 19:20:54 sogod [1999]: 192.168.10.181 "GET /SOGo/ HTTP/1.1" 200 4629/0 0.139 13451 65% 1M Jan 29 19:21:01 sogod [1999]: SOGoRootPage successful login from '192.168.10.181' for user 'testuser' - expire = -1 grace = -1 Jan 29 19:21:01 sogod [1999]: [WARN] <0x0xb64ee6cc[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table Jan 29 19:21:01 sogod [1999]: [WARN] <0x0xb64ee6cc[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table Jan 29 19:21:01 sogod [1999]: [WARN] <0x0xb64ee6cc[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table Jan 29 19:21:01 sogod [1999]: 192.168.10.181 "POST /SOGo/connect HTTP/1.1" 200 27/43 0.432 - - 636K Jan 29 19:21:01 sogod [1999]: 192.168.10.181 "GET /SOGo/testuser HTTP/1.1" 302 0/0 0.014 - - 12K Jan 29 19:21:01 sogod [1999]: 192.168.10.181 "GET /SOGo/testuser/view HTTP/1.1" 302 0/0 0.030 - - 8K Jan 29 19:21:01 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Mail HTTP/1.1" 302 0/0 0.003 - - 20K Jan 29 19:21:02 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/view HTTP/1.1" 200 11282/0 0.939 39621 71% 1M Jan 29 19:21:02 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091663 HTTP/1.1" 200 2/0 0.043 - - 108K Jan 29 19:21:03 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/mailboxes HTTP/1.1" 200 341/0 0.226 - - 8K Jan 29 19:21:03 sogod [1996]: <0x0x22f478c[SOGoCache]> Cache cleanup interval set every 1800.000000 seconds Jan 29 19:21:03 sogod [1996]: <0x0x22f478c[SOGoCache]> Using host(s) '127.0.0.1' as server(s) Jan 29 19:21:03 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/foldersState HTTP/1.1" 200 0/0 0.155 - - 2M Jan 29 19:21:03 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/unseenCount HTTP/1.1" 200 13/0 0.316 - - 8K Jan 29 19:21:08 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/0/folderINBOX/expunge HTTP/1.1" 200 2/0 0.234 - - 4K Jan 29 19:21:08 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar HTTP/1.1" 302 0/0 0.006 - - 0 Jan 29 19:21:08 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/view HTTP/1.1" 200 14363/0 0.161 54103 73% 176K Jan 29 19:21:09 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/canAccessContent HTTP/1.1" 204 0/0 0.005 - - 16KJan 29 19:21:09 sogod [1996]: [WARN] <0x0xb64cc574[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table Jan 29 19:21:09 sogod [1996]: [WARN] <0x0xb64cc574[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table Jan 29 19:21:09 sogod [1996]: [WARN] <0x0xb64cc574[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table Jan 29 19:21:09 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=&filterpopup=view_next7 HTTP/1.1" 200 614/0 0.064 - - 28K Jan 29 19:21:09 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091669 HTTP/1.1" 200 2/0 0.087 - - 240K Jan 29 19:21:09 sogod [1992]: <0x0x22f473c[SOGoCache]> Cache cleanup interval set every 1800.000000 seconds Jan 29 19:21:09 sogod [1992]: <0x0x22f473c[SOGoCache]> Using host(s) '127.0.0.1' as server(s) Jan 29 19:21:09 sogod [1991]: <0x0x22f473c[SOGoCache]> Cache cleanup interval set every 1800.000000 seconds Jan 29 19:21:09 sogod [1991]: <0x0x22f473c[SOGoCache]> Using host(s) '127.0.0.1' as server(s) Jan 29 19:21:09 sogod [1994]: <0x0x22f47bc[SOGoCache]> Cache cleanup interval set every 1800.000000 seconds Jan 29 19:21:09 sogod [1994]: <0x0x22f47bc[SOGoCache]> Using host(s) '127.0.0.1' as server(s) Jan 29 19:21:09 sogod [1992]: [WARN] <0x0xb647262c[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table Jan 29 19:21:09 sogod [1992]: [WARN] <0x0xb647262c[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table Jan 29 19:21:09 sogod [1992]: [WARN] <0x0xb647262c[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table Jan 29 19:21:09 sogod [1991]: [WARN] <0x0xb647262c[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table Jan 29 19:21:09 sogod [1991]: [WARN] <0x0xb647262c[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table Jan 29 19:21:09 sogod [1991]: [WARN] <0x0xb647262c[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table Jan 29 19:21:09 sogod [1994]: [WARN] <0x0xb64731d4[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table Jan 29 19:21:09 sogod [1994]: [WARN] <0x0xb64731d4[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table Jan 29 19:21:09 sogod [1994]: [WARN] <0x0xb64731d4[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table Jan 29 19:21:09 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.212 - - 1M Jan 29 19:21:09 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.223 - - 1M Jan 29 19:21:09 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview HTTP/1.1" 200 2273/0 0.289 54908 95% 3M Jan 29 19:21:09 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 694/0 0.016 - - 164K Jan 29 19:21:19 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/dateselector?day=20160129 HTTP/1.1" 200 765/0 0.013 9375 91% 64K Jan 29 19:21:24 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/batchDelete?ids=4561732055696420546167205B265E25242340215D39653466366633372D653339642D333530372D393133392D383332656136623163383566.ics HTTP/1.1" 204 0/0 0.109 - - 684K Jan 29 19:21:25 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.005 - - 12K Jan 29 19:21:25 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.004 - - 4K Jan 29 19:21:25 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091685 HTTP/1.1" 200 2/0 0.008 - - 0 Jan 29 19:21:28 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.004 - - 28K Jan 29 19:21:28 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091689 HTTP/1.1" 200 2/0 0.019 - - 0 Jan 29 19:21:28 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.020 - - 76K Jan 29 19:21:29 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/batchDelete?ids=1007-56AB3580-F-5DD63480.ics HTTP/1.1" 204 0/0 0.109 - - 2M Jan 29 19:21:33 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091693 HTTP/1.1" 200 2/0 0.006 - - 0 Jan 29 19:21:33 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=20160129&filterpopup=view_all HTTP/1.1" 200 2/0 0.004 - - 4K Jan 29 19:21:35 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.018 - - 0 Jan 29 19:21:35 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091695 HTTP/1.1" 200 2/0 0.026 - - 0 Jan 29 19:21:35 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=20160129&filterpopup=view_all HTTP/1.1" 200 2/0 0.034 - - 4K Jan 29 19:21:35 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.029 - - 0 Jan 29 19:21:35 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview?day=20160129 HTTP/1.1" 200 2273/0 0.039 54908 95% 628K Jan 29 19:21:35 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 64/0 0.005 - - 40K Jan 29 19:21:39 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/saveSelectedList HTTP/1.1" 204 0/24 0.016 - - 76K Jan 29 19:21:40 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/saveSelectedList HTTP/1.1" 204 0/25 0.006 - - 0 Jan 29 19:21:45 sogod [1996]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts HTTP/1.1" 302 0/0 0.003 - - 20K Jan 29 19:21:45 sogod [1996]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts/view HTTP/1.1" 200 8123/0 0.211 26710 69% 864K Jan 29 19:21:45 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091706 HTTP/1.1" 200 2/0 0.005 - - 0 Jan 29 19:21:45 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/groups/canAccessContent HTTP/1.1" 204 0/0 0.013 - - 56K Jan 29 19:21:45 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/canAccessContent HTTP/1.1" 204 0/0 0.004 - - 16K Jan 29 19:21:45 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/users/canAccessContent HTTP/1.1" 204 0/0 0.016 - - 52K Jan 29 19:21:48 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/7C1-56AB3E00-1-1B4A7920.vcf/view?noframe=1 HTTP/1.1" 200 395/0 0.015 - - 104K Jan 29 19:21:52 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/batchDelete HTTP/1.1" 204 0/39 0.010 - - 0 Jan 29 19:21:52 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/7C4-56AB3E00-3-7B2EC380.vcf/view?noframe=1 HTTP/1.1" 200 544/0 0.007 - - 4K Jan 29 19:21:57 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/batchDelete HTTP/1.1" 204 0/39 0.009 - - 0 Jan 29 19:21:57 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/E95-56AB3000-1-16AE9120.vcf/view?noframe=1 HTTP/1.1" 200 723/0 0.007 - - 0 Jan 29 19:21:58 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/7C4-56AB3D80-1-7B2EC380.vcf/view?noframe=1 HTTP/1.1" 200 393/0 0.007 - - 0 Jan 29 19:22:02 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/batchDelete HTTP/1.1" 204 0/39 0.007 - - 0 Jan 29 19:22:04 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 237/0 0.008 - - 20K Jan 29 19:22:07 sogod [1994]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar HTTP/1.1" 302 0/0 0.003 - - 8K Jan 29 19:22:08 sogod [1994]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/view HTTP/1.1" 200 14363/0 0.133 54103 73% 1M Jan 29 19:22:08 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/canAccessContent HTTP/1.1" 204 0/0 0.004 - - 0 Jan 29 19:22:08 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.005 - - 12K Jan 29 19:22:08 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.003 - - 0 Jan 29 19:22:08 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091728 HTTP/1.1" 200 2/0 0.008 - - 0 Jan 29 19:22:08 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=&filterpopup=view_next7 HTTP/1.1" 200 2/0 0.028 - - 8K Jan 29 19:22:08 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview HTTP/1.1" 200 2273/0 0.041 54908 95% 24K Jan 29 19:22:08 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 64/0 0.006 - - 0 Jan 29 19:22:11 sogod [1996]: 192.168.10.181 "GET /SOGo/so/testuser/Mail HTTP/1.1" 302 0/0 0.003 - - 0 Jan 29 19:22:12 sogod [1996]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/view HTTP/1.1" 200 11282/0 0.410 39621 71% 1M Jan 29 19:22:12 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091733 HTTP/1.1" 200 2/0 0.005 - - 0 Jan 29 19:22:12 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/mailboxes HTTP/1.1" 200 341/0 0.227 - - 8K Jan 29 19:22:13 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/foldersState HTTP/1.1" 200 0/0 0.037 - - 32K Jan 29 19:22:13 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/unseenCount HTTP/1.1" 200 13/0 0.291 - - 8K Jan 29 19:22:15 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/1/markMessageUnread HTTP/1.1" 204 0/0 0.313 - - 24K Jan 29 19:22:15 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/headers HTTP/1.1" 200 629/12 0.284 - - 0 Jan 29 19:22:17 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderSent/uids HTTP/1.1" 200 412/37 0.427 1124 63% 4K Jan 29 19:22:17 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderSent/unseenCount HTTP/1.1" 200 13/0 0.466 - - 196K Jan 29 19:22:22 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderSent/2/markMessageUnread HTTP/1.1" 204 0/0 0.299 - - 28K Jan 29 19:22:22 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderSent/headers HTTP/1.1" 200 622/12 0.283 - - 80K Jan 29 19:22:22 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderSent/1/markMessageUnread HTTP/1.1" 204 0/0 0.275 - - 0 Jan 29 19:22:23 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderSent/headers HTTP/1.1" 200 622/12 0.276 - - 0 Jan 29 19:22:26 sogod [1994]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/0/expunge HTTP/1.1" 404 208/0 0.187 - - 0 Jan 29 19:22:26 sogod [1994]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar HTTP/1.1" 302 0/0 0.004 - - 0 Jan 29 19:22:26 sogod [1994]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/view HTTP/1.1" 200 14363/0 0.039 54103 73% 28K Jan 29 19:22:26 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/canAccessContent HTTP/1.1" 204 0/0 0.005 - - 0 Jan 29 19:22:26 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.006 - - 0 Jan 29 19:22:26 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454091747 HTTP/1.1" 200 2/0 0.022 - - 0 Jan 29 19:22:26 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=&filterpopup=view_next7 HTTP/1.1" 200 2/0 0.024 - - 0Jan 29 19:22:26 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.023 - - 0 Jan 29 19:22:26 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview HTTP/1.1" 200 2273/0 0.039 54908 95% 16K Jan 29 19:22:26 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 64/0 0.009 - - 12K Jan 29 19:24:08 sogod [1999]: 37.209.102.40 "OPTIONS /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail HTTP/1.1" 401 0/0 0.018 - - 32K Jan 29 19:24:08 sogod [1999]: 37.209.102.40 "OPTIONS /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail HTTP/1.1" 200 0/0 0.003 - - 20K Jan 29 19:24:09 sogod [1999]: <0x0xb655cb24[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: NokiaE700 IMEI357909041390858 Nokia/Mail For Exchange 25.007 Jan 29 19:24:09 sogod [1999]: <0x0xb655cb24[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 Jan 29 19:24:09 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Settings HTTP/1.1" 200 19/85 0.031 - - 240K Jan 29 19:24:09 sogod [1999]: <0x0xb655cb24[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 0 Jan 29 19:24:09 sogod [1999]: <0x0xb655cb24[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 6 mail%2F5036bb35162fab56c80e0000b79f221a 0 INBOX 2 mail%2F981b3a01552fab56d60e0000b79f221a 0 Sent 5 mail%2Fceb247272731ab562f0f0000b79f221a 0 junkmail 12 vevent%2Fpersonal 0 Persönlicher Kalender 8 vtodo%2Fpersonal 0 Persönlicher Kalender 7 vcard%2Fpersonal 0 Persönliches Adressbuch 9 Jan 29 19:24:09 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 429/13 0.369 - - 200K Jan 29 19:24:10 sogod [1999]: <0x0xb63739b4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 0 mail%2F5036bb35162fab56c80e0000b79f221a Jan 29 19:24:11 sogod [1999]: <0x0xb63739b4[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:11 sogod [1999]: <0x0xb63739b4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Email -1 mail%2F5036bb35162fab56c80e0000b79f221a 1 Jan 29 19:24:11 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 73/58 0.368 - - 24K Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: -1 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 Jan 29 19:24:11 sogod [1999]: <0x0xb62ad95c[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> EAS - sortedBySequence (0) - lastObject: (null) Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> EAS - allCacheObjects (1) - lastObject: 1-4 Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> EAS - found in cache: 0 k = 0 Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> EAS - Dealing with cacheObject: 1-4 Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> EAS - ADD! Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> EAS - first uid added 1 Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:11 sogod [1999]: <0x0xb63a082c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Email 1-4 mail%2F5036bb35162fab56c80e0000b79f221a 1 1 "testuser@XXX.local" <testuser@XXX.local> "admin@XXX.local" <admin@XXX.local> test test 2016-01-29T10:08:05.000Z testuser 1 0 IPM.Note urn:content-classes:message 65001 1 0 test 22 0 1 Jan 29 19:24:11 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 357/97 0.790 - - 112K Jan 29 19:24:13 sogod [1999]: <0x0xb64c025c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 0 vevent%2Fpersonal Jan 29 19:24:13 sogod [1999]: <0x0xb64c025c[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:13 sogod [1999]: <0x0xb64c025c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Calendar -1 vevent%2Fpersonal 1 Jan 29 19:24:13 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 54/36 0.009 - - 0 Jan 29 19:24:15 sogod [1999]: <0x0xb626d924[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: -1 vevent%2Fpersonal 5 4 1 2048 1 Jan 29 19:24:15 sogod [1999]: <0x0xb626d924[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:15 sogod [1999]: <0x0xb626d924[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Calendar 1454091689 vevent%2Fpersonal 1 Jan 29 19:24:15 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 62/75 0.030 - - 16K Jan 29 19:24:17 sogod [1999]: <0x0xb6538db4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 0 vcard%2Fpersonal Jan 29 19:24:17 sogod [1999]: <0x0xb6538db4[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:17 sogod [1999]: <0x0xb6538db4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Contacts -1 vcard%2Fpersonal 1 Jan 29 19:24:17 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 53/35 0.009 - - 0 Jan 29 19:24:17 sogod [1999]: <0x0xb64fa70c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: -1 vcard%2Fpersonal 5 0 1 1024 1 Jan 29 19:24:17 sogod [1999]: <0x0xb64fa70c[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:17 sogod [1999]: <0x0xb64fa70c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Contacts 1454091722 vcard%2Fpersonal 1 E95-56AB3000-1-16AE9120.vcf Doe John john.doe@email.com 1970-02-01T11:00:00.000Z 1 0 Jan 29 19:24:17 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 188/74 0.025 - - 120K Jan 29 19:24:26 sogod [1999]: <0x0xb64cd7a4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:24:26 sogod [1999]: <0x0xb64cd7a4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:24:26 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.337 - - 4K Jan 29 19:24:27 sogod [1999]: <0x0xb639017c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1-4 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 Jan 29 19:24:28 sogod [1999]: <0x0xb643bcb4[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:24:28 sogod [1999]: <0x0xb639017c[SOGoActiveSyncDispatcher]> EAS - sortedBySequence (1) - lastObject: 1-4 Jan 29 19:24:28 sogod [1999]: <0x0xb639017c[SOGoActiveSyncDispatcher]> EAS - allCacheObjects (1) - lastObject: 1-4 Jan 29 19:24:28 sogod [1999]: <0x0xb639017c[SOGoActiveSyncDispatcher]> EAS - found in cache: 0 k = 0 Jan 29 19:24:28 sogod [1999]: <0x0xb639017c[SOGoActiveSyncDispatcher]> EAS - Dealing with cacheObject: 1-4 Jan 29 19:24:28 sogod [1999]: <0x0xb639017c[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:28 sogod [1999]: <0x0xb639017c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Email 2-4 mail%2F5036bb35162fab56c80e0000b79f221a 1 Jan 29 19:24:28 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 74/98 0.652 - - 4K Jan 29 19:24:30 sogod [1999]: <0x0xb64d3cb4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454091689 vevent%2Fpersonal 5 4 1 2048 1 Jan 29 19:24:30 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/83 0.011 - - 0 Jan 29 19:24:30 sogod [1999]: <0x0xb639b5f4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454091722 vcard%2Fpersonal 5 0 1 1024 1 Jan 29 19:24:30 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/82 0.012 - - 0 Jan 29 19:24:43 sogod [1999]: <0x0xb650a164[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:24:44 sogod [1999]: <0x0xb650a164[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:24:44 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.349 - - 0 Jan 29 19:24:44 sogod [1999]: <0x0xb65126bc[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 0 mail%2F981b3a01552fab56d60e0000b79f221a Jan 29 19:24:44 sogod [1999]: <0x0xb65126bc[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:44 sogod [1999]: <0x0xb65126bc[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Email -1 mail%2F981b3a01552fab56d60e0000b79f221a 1 Jan 29 19:24:44 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 73/58 0.382 - - 0 Jan 29 19:24:44 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: -1 mail%2F981b3a01552fab56d60e0000b79f221a 5 3 2 2048 1 Jan 29 19:24:45 sogod [1999]: <0x0xb6552aac[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - sortedBySequence (0) - lastObject: (null) Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - allCacheObjects (2) - lastObject: 1-4 Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - found in cache: 0 k = 0 Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - Dealing with cacheObject: 2-3 Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - ADD! Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - first uid added 2 Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - Dealing with cacheObject: 1-4 Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - ADD! Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:24:45 sogod [1999]: <0x0xb64a9814[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Email 2-4 mail%2F981b3a01552fab56d60e0000b79f221a 1 2 "admin@XXX.dyndns.org" <admin@XXX.dyndns.org> "ein testuser" <testuser@XXX.local> Test Test 2016-01-29T09:34:48.000Z testuser 1 0 IPM.Note urn:content-classes:message 65001 1 0 Test 4 0 1 1 "SME Server administrator" <admin@XXX.local> "ein testuser" <testuser@XXX.local> test test 2016-01-29T09:22:28.000Z testuser 1 0 IPM.Note urn:content-classes:message 65001 1 0 test 10 0 1 Jan 29 19:24:45 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 624/97 0.918 - - 28K Jan 29 19:29:36 sogod [1999]: <0x0xb64e302c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: Mailbox mail%2F5036bb35162fab56c80e0000b79f221a 1 2 204800 Jan 29 19:29:37 sogod [1999]: <0x0xb64e302c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 1 mail%2F5036bb35162fab56c80e0000b79f221a 1 "testuser@XXX.local" <testuser@XXX.local> "admin@XXX.local" <admin@XXX.local> test test 2016-01-29T10:08:05.000Z testuser 1 0 IPM.Note urn:content-classes:message 65001 1 0 test 22 0 1 Jan 29 19:29:37 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=ItemOperations HTTP/1.1" 200 348/94 0.502 - - 12K Jan 29 19:30:04 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts HTTP/1.1" 302 0/0 0.002 - - 0 Jan 29 19:30:04 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts/view HTTP/1.1" 200 8010/0 0.049 25883 69% 132K Jan 29 19:30:04 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092205 HTTP/1.1" 200 2/0 0.006 - - 0 Jan 29 19:30:04 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/groups/canAccessContent HTTP/1.1" 204 0/0 0.003 - - 0 Jan 29 19:30:04 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/users/canAccessContent HTTP/1.1" 204 0/0 0.010 - - 0 Jan 29 19:30:04 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/canAccessContent HTTP/1.1" 204 0/0 0.014 - - 16K Jan 29 19:30:23 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 237/0 0.007 - - 16K Jan 29 19:30:27 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 237/0 0.007 - - 0 Jan 29 19:30:42 sogod [1991]: <0x0xb6481034[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: Mailbox mail%2F981b3a01552fab56d60e0000b79f221a 1 2 204800 Jan 29 19:30:42 sogod [1991]: <0x0xb6481034[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 1 mail%2F981b3a01552fab56d60e0000b79f221a 1 "SME Server administrator" <admin@XXX.local> "ein testuser" <testuser@XXX.local> test test 2016-01-29T09:22:28.000Z testuser 1 0 IPM.Note urn:content-classes:message 65001 1 0 test 10 0 1 Jan 29 19:30:42 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=ItemOperations HTTP/1.1" 200 339/94 0.535 - - 1M Jan 29 19:31:34 sogod [1991]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar HTTP/1.1" 302 0/0 0.004 - - 8K Jan 29 19:31:34 sogod [1991]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/view HTTP/1.1" 200 14363/0 0.167 54103 73% 2M Jan 29 19:31:34 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/canAccessContent HTTP/1.1" 204 0/0 0.005 - - 4K Jan 29 19:31:34 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092295 HTTP/1.1" 200 2/0 0.003 - - 0 Jan 29 19:31:34 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.020 - - 4K Jan 29 19:31:34 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=&filterpopup=view_next7 HTTP/1.1" 200 2/0 0.027 - - 0 Jan 29 19:31:34 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.027 - - 0 Jan 29 19:31:35 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview HTTP/1.1" 200 2273/0 0.040 54908 95% 204K Jan 29 19:31:35 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 64/0 0.005 - - 0 Jan 29 19:31:36 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts HTTP/1.1" 302 0/0 0.004 - - 20K Jan 29 19:31:36 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts/view HTTP/1.1" 200 8010/0 0.072 25883 69% 716K Jan 29 19:31:37 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092297 HTTP/1.1" 200 2/0 0.005 - - 0 Jan 29 19:31:37 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/users/canAccessContent HTTP/1.1" 204 0/0 0.003 - - 0 Jan 29 19:31:37 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/groups/canAccessContent HTTP/1.1" 204 0/0 0.008 - - 0 Jan 29 19:31:37 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/canAccessContent HTTP/1.1" 204 0/0 0.014 - - 4K Jan 29 19:31:38 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Mail HTTP/1.1" 302 0/0 0.004 - - 12K Jan 29 19:31:39 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/view HTTP/1.1" 200 11289/0 0.415 39638 71% 1M Jan 29 19:31:39 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092299 HTTP/1.1" 200 2/0 0.005 - - 0 Jan 29 19:31:39 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/mailboxes HTTP/1.1" 200 341/0 0.223 - - 8K Jan 29 19:31:39 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/foldersState HTTP/1.1" 200 0/0 0.003 - - 0 Jan 29 19:31:40 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/unseenCount HTTP/1.1" 200 13/0 0.280 - - 8K Jan 29 19:31:45 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/unseenCount HTTP/1.1" 200 13/0 0.350 - - 0 Jan 29 19:31:45 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/uids HTTP/1.1" 200 28/53 0.451 - - 0 Jan 29 19:31:51 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/0/folderINBOX/expunge HTTP/1.1" 200 2/0 0.236 - - 4K Jan 29 19:31:51 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts HTTP/1.1" 302 0/0 0.005 - - 0 Jan 29 19:31:51 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts/view HTTP/1.1" 200 8010/0 0.023 25883 69% 4K Jan 29 19:31:51 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092311 HTTP/1.1" 200 2/0 0.006 - - 0 Jan 29 19:31:51 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/users/canAccessContent HTTP/1.1" 204 0/0 0.004 - - 0 Jan 29 19:31:51 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/groups/canAccessContent HTTP/1.1" 204 0/0 0.010 - - 0 Jan 29 19:31:51 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/canAccessContent HTTP/1.1" 204 0/0 0.014 - - 0 Jan 29 19:31:54 sogod [1992]: SOGoUserHomePage user 'testuser' logged off Jan 29 19:31:54 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/logoff HTTP/1.1" 302 0/0 0.007 - - 104K Jan 29 19:31:54 sogod [1992]: 192.168.10.181 "GET /SOGo/so/ HTTP/1.1" 200 4631/0 0.037 13454 65% 40K Jan 29 19:32:02 sogod [1992]: SOGoRootPage successful login from '192.168.10.181' for user 'testuser' - expire = -1 grace = -1 Jan 29 19:32:02 sogod [1992]: 192.168.10.181 "POST /SOGo/connect HTTP/1.1" 200 27/43 0.016 - - 244K Jan 29 19:32:02 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser HTTP/1.1" 302 0/0 0.002 - - 0 Jan 29 19:32:02 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/view HTTP/1.1" 302 0/0 0.002 - - 4K Jan 29 19:32:02 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Mail HTTP/1.1" 302 0/0 0.002 - - 0 Jan 29 19:32:03 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/view HTTP/1.1" 200 11289/0 0.347 39638 71% 20K Jan 29 19:32:03 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092324 HTTP/1.1" 200 2/0 0.005 - - 0 Jan 29 19:32:04 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/mailboxes HTTP/1.1" 200 341/0 0.227 - - 0 Jan 29 19:32:04 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/foldersState HTTP/1.1" 200 0/0 0.003 - - 0 Jan 29 19:32:04 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/unseenCount HTTP/1.1" 200 13/0 0.283 - - 0 Jan 29 19:32:06 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/0/folderINBOX/expunge HTTP/1.1" 200 2/0 0.237 - - 0 Jan 29 19:32:06 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts HTTP/1.1" 302 0/0 0.007 - - 0 Jan 29 19:32:06 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts/view HTTP/1.1" 200 8010/0 0.021 25883 69% 0 Jan 29 19:32:07 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092327 HTTP/1.1" 200 2/0 0.006 - - 0 Jan 29 19:32:07 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/users/canAccessContent HTTP/1.1" 204 0/0 0.003 - - 0 Jan 29 19:32:07 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/canAccessContent HTTP/1.1" 204 0/0 0.011 - - 0 Jan 29 19:32:07 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/groups/canAccessContent HTTP/1.1" 204 0/0 0.011 - - 0 Jan 29 19:32:10 sogod [1994]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar HTTP/1.1" 302 0/0 0.004 - - 0 Jan 29 19:32:10 sogod [1994]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/view HTTP/1.1" 200 14363/0 0.034 54103 73% 4K Jan 29 19:32:11 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/canAccessContent HTTP/1.1" 204 0/0 0.005 - - 0 Jan 29 19:32:11 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.014 - - 0 Jan 29 19:32:11 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.021 - - 0 Jan 29 19:32:11 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092331 HTTP/1.1" 200 2/0 0.029 - - 0 Jan 29 19:32:11 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=&filterpopup=view_next7 HTTP/1.1" 200 2/0 0.029 - - 0 Jan 29 19:32:11 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview HTTP/1.1" 200 2273/0 0.040 54908 95% 20K Jan 29 19:32:11 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 64/0 0.008 - - 8K Jan 29 19:32:16 sogod [1991]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts HTTP/1.1" 302 0/0 0.003 - - 0 Jan 29 19:32:16 sogod [1991]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts/view HTTP/1.1" 200 8010/0 0.049 25883 69% 24K Jan 29 19:32:16 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092337 HTTP/1.1" 200 2/0 0.006 - - 0 Jan 29 19:32:16 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/groups/canAccessContent HTTP/1.1" 204 0/0 0.007 - - 0 Jan 29 19:32:16 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/users/canAccessContent HTTP/1.1" 204 0/0 0.003 - - 0 Jan 29 19:32:16 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/canAccessContent HTTP/1.1" 204 0/0 0.012 - - 0 Jan 29 19:32:19 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/groups/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 426/0 0.025 - - 304K Jan 29 19:32:21 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/users/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 962/0 0.016 - - 0 Jan 29 19:32:25 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 237/0 0.007 - - 0 Jan 29 19:33:12 sogod [1991]: <0x0xb63f9454[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:33:13 sogod [1991]: <0x0xb63f9454[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:33:13 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.347 - - 72K Jan 29 19:33:13 sogod [1991]: <0x0xb63e807c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mail%2F5036bb35162fab56c80e0000b79f221a 3 2-4 vevent%2Fpersonal 4 1454091689 vcard%2Fpersonal 0 1454091722 mail%2F981b3a01552fab56d60e0000b79f221a 3 2-4 Jan 29 19:33:13 sogod [1991]: <0x0xb63e4b34[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:33:13 sogod [1991]: <0x0xb63e4b34[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:33:13 sogod [1991]: <0x0xb63e807c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 Email mail%2F5036bb35162fab56c80e0000b79f221a 1 1 Calendar vevent%2Fpersonal 0 1 Contacts vcard%2Fpersonal 1 1 Email mail%2F981b3a01552fab56d60e0000b79f221a 1 Jan 29 19:33:13 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=GetItemEstimate HTTP/1.1" 200 233/221 0.697 - - 48K Jan 29 19:33:14 sogod [1991]: <0x0xb6427e14[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 2-4 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 1 1 Jan 29 19:33:14 sogod [1991]: <0x0xb6387bfc[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:33:15 sogod [1991]: <0x0xb6427e14[SOGoActiveSyncDispatcher]> EAS - sortedBySequence (1) - lastObject: 1-5 Jan 29 19:33:15 sogod [1991]: <0x0xb6427e14[SOGoActiveSyncDispatcher]> EAS - allCacheObjects (1) - lastObject: 1-5 Jan 29 19:33:15 sogod [1991]: <0x0xb6427e14[SOGoActiveSyncDispatcher]> EAS - found in cache: 0 k = 0 Jan 29 19:33:15 sogod [1991]: <0x0xb6427e14[SOGoActiveSyncDispatcher]> EAS - Dealing with cacheObject: 1-5 Jan 29 19:33:15 sogod [1991]: <0x0xb6427e14[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:33:15 sogod [1991]: <0x0xb6427e14[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Email 2-5 mail%2F5036bb35162fab56c80e0000b79f221a 1 1 1 Jan 29 19:33:15 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 88/117 0.865 - - 40K Jan 29 19:33:16 sogod [1991]: <0x0xb6279234[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454091722 vcard%2Fpersonal 5 0 1 1024 1 1 Bar, Foo Foo Bar +1362474895 foo.bar@email.com 1 Jan 29 19:33:16 sogod [1991]: <0x0xb6279234[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:33:16 sogod [1991]: <0x0xb6279234[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Contacts 1454092396 vcard%2Fpersonal 1 1 7C7-56ABB080-1-3E0D80C0.vcf 1 Jan 29 19:33:16 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 106/172 0.022 - - 116K Jan 29 19:33:18 sogod [1991]: <0x0xb651796c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 2-4 mail%2F981b3a01552fab56d60e0000b79f221a 5 3 2 2048 1 1 1 2 1 Jan 29 19:33:19 sogod [1991]: <0x0xb642292c[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:33:19 sogod [1991]: <0x0xb651796c[SOGoActiveSyncDispatcher]> EAS - sortedBySequence (2) - lastObject: 2-6 Jan 29 19:33:19 sogod [1991]: <0x0xb651796c[SOGoActiveSyncDispatcher]> EAS - allCacheObjects (2) - lastObject: 2-6 Jan 29 19:33:19 sogod [1991]: <0x0xb651796c[SOGoActiveSyncDispatcher]> EAS - found in cache: 0 k = 0 Jan 29 19:33:19 sogod [1991]: <0x0xb651796c[SOGoActiveSyncDispatcher]> EAS - Dealing with cacheObject: 1-5 Jan 29 19:33:19 sogod [1991]: <0x0xb651796c[SOGoActiveSyncDispatcher]> EAS - Dealing with cacheObject: 2-6 Jan 29 19:33:19 sogod [1991]: <0x0xb651796c[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:33:19 sogod [1991]: <0x0xb651796c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Email 3-6 mail%2F981b3a01552fab56d60e0000b79f221a 1 1 1 2 1 Jan 29 19:33:19 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 100/136 0.973 - - 4K Jan 29 19:33:34 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 470/0 0.008 - - 0 Jan 29 19:36:26 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/7C7-56ABB080-1-3E0D80C0.vcf/view?noframe=1 HTTP/1.1" 200 727/0 0.013 - - 56K Jan 29 19:36:31 sogod [1991]: 192.168.10.181 "GET /SOGo/so/testuser/Contacts/personal/7C7-56ABB080-1-3E0D80C0.vcf/edit HTTP/1.1" 200 5656/0 0.056 21651 73% 84K Jan 29 19:37:27 sogod [1991]: <0x0xb6281104[WOTextField]> -[WOInput takeValuesFromRequest:inContext:]: form value is not settable: <0x0xb6281604[WOValueAssociation]: value=""> Jan 29 19:37:27 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/7C7-56ABB080-1-3E0D80C0.vcf/saveAsContact HTTP/1.1" 200 658/745 0.014 - - 4K Jan 29 19:37:27 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 481/0 0.009 - - 0 Jan 29 19:37:27 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/7C7-56ABB080-1-3E0D80C0.vcf/view?noframe=1 HTTP/1.1" 200 447/0 0.006 1175 61% 0 Jan 29 19:37:30 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 481/0 0.006 - - 0 Jan 29 19:38:21 sogod [1991]: <0x0xb6426fc4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:38:22 sogod [1991]: <0x0xb6426fc4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:38:22 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.341 - - 0 Jan 29 19:38:22 sogod [1991]: <0x0xb62778d4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mail%2F5036bb35162fab56c80e0000b79f221a 3 2-5 vevent%2Fpersonal 4 1454091689 vcard%2Fpersonal 0 1454092396 mail%2F981b3a01552fab56d60e0000b79f221a 3 3-6 Jan 29 19:38:22 sogod [1991]: <0x0xb628cd04[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:38:22 sogod [1991]: <0x0xb628cd04[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:38:22 sogod [1991]: <0x0xb62778d4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 Email mail%2F5036bb35162fab56c80e0000b79f221a 1 1 Calendar vevent%2Fpersonal 0 1 Contacts vcard%2Fpersonal 2 1 Email mail%2F981b3a01552fab56d60e0000b79f221a 1 Jan 29 19:38:22 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=GetItemEstimate HTTP/1.1" 200 233/221 0.696 - - 0 Jan 29 19:38:23 sogod [1991]: <0x0xb642c9d4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 2-5 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 Jan 29 19:38:23 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.408 - - 0 Jan 29 19:38:23 sogod [1991]: <0x0xb64e4634[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454092396 vcard%2Fpersonal 5 0 1 1024 1 Jan 29 19:38:23 sogod [1991]: <0x0xb64e4634[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:38:23 sogod [1991]: <0x0xb64e4634[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Contacts 1454092647 vcard%2Fpersonal 1 7C7-56ABB080-1-3E0D80C0.vcf Bar Foo foo.bar@email.com +1894339024 +1362474895 street city germany 1970-11-30T11:00:00.000Z 1 0 Jan 29 19:38:23 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 247/82 0.020 - - 4K Jan 29 19:38:24 sogod [1991]: <0x0xb64291bc[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 3-6 mail%2F981b3a01552fab56d60e0000b79f221a 5 3 2 2048 1 Jan 29 19:38:24 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.406 - - 0 Jan 29 19:41:00 sogod [1991]: <0x0xb63fc464[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:41:00 sogod [1991]: <0x0xb63fc464[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:41:00 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.341 - - 0 Jan 29 19:41:00 sogod [1991]: <0x0xb637105c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mail%2F5036bb35162fab56c80e0000b79f221a 3 2-5 vevent%2Fpersonal 4 1454091689 vcard%2Fpersonal 0 1454092647 mail%2F981b3a01552fab56d60e0000b79f221a 3 3-6 Jan 29 19:41:01 sogod [1991]: <0x0xb63f2e64[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:41:01 sogod [1991]: <0x0xb63f2e64[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:41:01 sogod [1991]: <0x0xb637105c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 Email mail%2F5036bb35162fab56c80e0000b79f221a 1 1 Calendar vevent%2Fpersonal 0 1 Contacts vcard%2Fpersonal 2 1 Email mail%2F981b3a01552fab56d60e0000b79f221a 1 Jan 29 19:41:01 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=GetItemEstimate HTTP/1.1" 200 233/221 0.703 - - 0 Jan 29 19:41:01 sogod [1991]: <0x0xb63ab9bc[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 2-5 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 Jan 29 19:41:02 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.475 - - 0 Jan 29 19:41:02 sogod [1991]: <0x0xb63fc464[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454092647 vcard%2Fpersonal 5 0 1 1024 1 E95-56AB3000-1-16AE9120.vcf Doe, John John Doe +5647857839 john.doe@email.com Company 1970-01-31T23:00:00.000Z 1 Jan 29 19:41:02 sogod [1991]: <0x0xb63fc464[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:41:02 sogod [1991]: <0x0xb63fc464[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Contacts 1454092862 vcard%2Fpersonal 1 E95-56AB3000-1-16AE9120.vcf 1 Jan 29 19:41:02 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 101/248 0.021 - - 0 Jan 29 19:41:02 sogod [1991]: <0x0xb64b6fcc[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 3-6 mail%2F981b3a01552fab56d60e0000b79f221a 5 3 2 2048 1 Jan 29 19:41:03 sogod [1991]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.411 - - 0 Jan 29 19:41:15 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/view?noframe=1&search=name_or_address&value=.&sort=c_cn&asc=true HTTP/1.1" 200 487/0 0.007 - - 0 Jan 29 19:41:17 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Contacts/personal/E95-56AB3000-1-16AE9120.vcf/view?noframe=1 HTTP/1.1" 200 417/0 0.008 1065 60% 0 Jan 29 19:42:43 sogod [1991]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar HTTP/1.1" 302 0/0 0.003 - - 0 Jan 29 19:42:43 sogod [1991]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/view HTTP/1.1" 200 14363/0 0.046 54103 73% 316K Jan 29 19:42:44 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/canAccessContent HTTP/1.1" 204 0/0 0.004 - - 0 Jan 29 19:42:44 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454092964 HTTP/1.1" 200 2/0 0.005 - - 0 Jan 29 19:42:44 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.017 - - 0 Jan 29 19:42:44 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.015 - - 0 Jan 29 19:42:44 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=&filterpopup=view_next7 HTTP/1.1" 200 2/0 0.022 - - 0 Jan 29 19:42:44 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview HTTP/1.1" 200 2273/0 0.030 54908 95% 0 Jan 29 19:42:44 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 64/0 0.007 - - 0 Jan 29 19:43:33 sogod [1992]: <0x0xb637bc84[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:43:33 sogod [1992]: <0x0xb637bc84[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:43:33 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.347 - - 300K Jan 29 19:43:34 sogod [1992]: <0x0xb63ea2f4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mail%2F5036bb35162fab56c80e0000b79f221a 3 2-5 vevent%2Fpersonal 4 1454091689 vcard%2Fpersonal 0 1454092862 mail%2F981b3a01552fab56d60e0000b79f221a 3 3-6 Jan 29 19:43:34 sogod [1992]: <0x0xb63b0e4c[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:43:34 sogod [1992]: <0x0xb63b0e4c[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:43:34 sogod [1992]: <0x0xb63ea2f4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 Email mail%2F5036bb35162fab56c80e0000b79f221a 1 1 Calendar vevent%2Fpersonal 0 1 Contacts vcard%2Fpersonal 2 1 Email mail%2F981b3a01552fab56d60e0000b79f221a 1 Jan 29 19:43:34 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=GetItemEstimate HTTP/1.1" 200 233/221 0.701 - - 16K Jan 29 19:43:35 sogod [1992]: <0x0xb652051c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 2-5 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 Jan 29 19:43:35 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.407 - - 28K Jan 29 19:43:35 sogod [1992]: <0x0xb65310b4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454091689 vevent%2Fpersonal 5 4 1 2048 1 1 xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAEAAAAAAAAAxP///w== 20160129T184334Z 20160130T070000Z Test event 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 20160130T080000Z 1 0 2 15 Jan 29 19:43:35 sogod [1992]: <0x0xb65310b4[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:43:35 sogod [1992]: <0x0xb65310b4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Calendar 1454093015 vevent%2Fpersonal 1 1 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 1 Jan 29 19:43:35 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 194/552 0.081 - - 96K Jan 29 19:43:35 sogod [1992]: <0x0x2566b1c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454092862 vcard%2Fpersonal 5 0 1 1024 1 Jan 29 19:43:35 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/82 0.017 - - 0 Jan 29 19:43:36 sogod [1992]: <0x0xb63dc32c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 3-6 mail%2F981b3a01552fab56d60e0000b79f221a 5 3 2 2048 1 Jan 29 19:43:36 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.398 - - 0 Jan 29 19:43:58 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454093038 HTTP/1.1" 200 148/0 0.024 - - 0 Jan 29 19:43:58 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.025 - - 0 Jan 29 19:43:58 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.016 - - 0 Jan 29 19:43:58 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=20160129&filterpopup=view_next7 HTTP/1.1" 200 361/0 0.039 - - 0 Jan 29 19:43:58 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview?day=20160129 HTTP/1.1" 200 2273/0 0.042 54908 95% 16K Jan 29 19:43:58 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 432/0 0.008 - - 8K Jan 29 19:45:02 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/dateselector?day=20160130 HTTP/1.1" 200 766/0 0.016 9375 91% 64K Jan 29 19:45:02 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235.ics/view HTTP/1.1" 200 282/0 0.040 - - 24K Jan 29 19:45:03 sogod [1994]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/personal/4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235.ics/edit HTTP/1.1" 200 10515/0 0.077 33196 68% 372K Jan 29 19:45:15 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235.ics/saveAsAppointment HTTP/1.1" 200 21/808 0.032 - - 136K Jan 29 19:45:15 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=20160130&filterpopup=view_next7 HTTP/1.1" 200 361/0 0.012 - - 0 Jan 29 19:45:15 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454093115 HTTP/1.1" 200 148/0 0.017 - - 0 Jan 29 19:45:15 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview?day=20160130 HTTP/1.1" 200 2273/0 0.024 54908 95% 8K Jan 29 19:45:15 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 432/0 0.007 - - 0 Jan 29 19:45:36 sogod [1999]: <0x0xb64e3bd4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:45:36 sogod [1999]: <0x0xb64e3bd4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:45:36 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.338 - - 0 Jan 29 19:45:37 sogod [1999]: <0x0xb631969c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mail%2F5036bb35162fab56c80e0000b79f221a 3 2-5 vevent%2Fpersonal 4 1454091689 vcard%2Fpersonal 0 1454092862 mail%2F981b3a01552fab56d60e0000b79f221a 3 3-6 Jan 29 19:45:37 sogod [1999]: <0x0xb6273aa4[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:45:37 sogod [1999]: <0x0xb6273aa4[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:45:37 sogod [1999]: <0x0xb631969c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 Email mail%2F5036bb35162fab56c80e0000b79f221a 1 1 Calendar vevent%2Fpersonal 1 1 Contacts vcard%2Fpersonal 2 1 Email mail%2F981b3a01552fab56d60e0000b79f221a 1 Jan 29 19:45:37 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=GetItemEstimate HTTP/1.1" 200 233/221 0.709 - - 0 Jan 29 19:45:38 sogod [1999]: <0x0xb6457724[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 2-5 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 Jan 29 19:45:38 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.409 - - 0 Jan 29 19:45:38 sogod [1999]: <0x0xb63181cc[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454091689 vevent%2Fpersonal 5 4 1 2048 1 Jan 29 19:45:38 sogod [1999]: <0x0xb63181cc[SOGoActiveSyncDispatcher]> Cache cleanup needed for device IMEI357909041390858 - user: testuser syncKey: 1454091689 cache: 1454093015 Jan 29 19:45:38 sogod [1999]: <0x0xb63181cc[SOGoActiveSyncDispatcher]> EAS - Cache cleanup: ADD 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 Jan 29 19:45:38 sogod [1999]: <0x0xb63181cc[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:45:38 sogod [1999]: <0x0xb63181cc[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Calendar 1454093115 vevent%2Fpersonal 1 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 0 20160130T090000Z 20160130T100000Z xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAIAAAAAAAAAxP///w== 0 Test event 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 0 15 1 Jan 29 19:45:38 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 624/83 0.031 - - 144K Jan 29 19:45:39 sogod [1999]: <0x0xb646e16c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454092862 vcard%2Fpersonal 5 0 1 1024 1 Jan 29 19:45:39 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/82 0.028 - - 0 Jan 29 19:45:40 sogod [1999]: <0x0xb65490bc[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 3-6 mail%2F981b3a01552fab56d60e0000b79f221a 5 3 2 2048 1 Jan 29 19:45:40 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.404 - - 0 Jan 29 19:48:53 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.014 - - 0 Jan 29 19:48:53 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=20160130&filterpopup=view_next7 HTTP/1.1" 200 361/0 0.012 - - 0 Jan 29 19:48:53 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454093334 HTTP/1.1" 200 148/0 0.006 - - 0 Jan 29 19:48:53 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.010 - - 0 Jan 29 19:48:53 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview?day=20160130 HTTP/1.1" 200 2273/0 0.017 54908 95% 40K Jan 29 19:48:53 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 432/0 0.009 - - 0 Jan 29 19:49:08 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454093349 HTTP/1.1" 200 148/0 0.007 - - 0 Jan 29 19:49:08 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=20160129&filterpopup=view_all HTTP/1.1" 200 361/0 0.007 - - 0 Jan 29 19:49:10 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/saveSelectedList HTTP/1.1" 204 0/24 0.005 - - 0 Jan 29 19:49:10 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/saveSelectedList HTTP/1.1" 204 0/25 0.005 - - 0 Jan 29 19:49:45 sogod [1999]: <0x0xb64ce8b4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:49:46 sogod [1999]: <0x0xb64ce8b4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:49:46 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.334 - - 0 Jan 29 19:49:46 sogod [1999]: <0x0xb63a171c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mail%2F5036bb35162fab56c80e0000b79f221a 3 2-5 vevent%2Fpersonal 4 1454091689 vcard%2Fpersonal 0 1454092862 mail%2F981b3a01552fab56d60e0000b79f221a 3 3-6 Jan 29 19:49:46 sogod [1999]: <0x0xb6539064[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:49:46 sogod [1999]: <0x0xb6539064[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:49:47 sogod [1999]: <0x0xb63a171c[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 Email mail%2F5036bb35162fab56c80e0000b79f221a 1 1 Calendar vevent%2Fpersonal 1 1 Contacts vcard%2Fpersonal 2 1 Email mail%2F981b3a01552fab56d60e0000b79f221a 1 Jan 29 19:49:47 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=GetItemEstimate HTTP/1.1" 200 233/221 0.693 - - 0 Jan 29 19:49:47 sogod [1999]: <0x0xb6527e1c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 2-5 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 Jan 29 19:49:47 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.443 - - 0 Jan 29 19:49:47 sogod [1999]: <0x0xb62a0fdc[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454091689 vevent%2Fpersonal 5 4 1 2048 1 1 xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAEAAAAAAAAAxP///w== 20160129T184946Z 20160130T090000Z Test event 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 20160130T100000Z 1 0 2 15 2 xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAEAAAAAAAAAxP///w== 20160129T184946Z 20160130T070000Z Second test event 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 20160130T080000Z 1 0 2 15 Jan 29 19:49:48 sogod [1999]: <0x0xb62a0fdc[SOGoActiveSyncDispatcher]> Cache cleanup needed for device IMEI357909041390858 - user: testuser syncKey: 1454091689 cache: 1454093115 Jan 29 19:49:48 sogod [1999]: <0x0xb62a0fdc[SOGoActiveSyncDispatcher]> EAS - Cache cleanup: ADD 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 Jan 29 19:49:48 sogod [1999]: <0x0xb62a0fdc[SOGoActiveSyncDispatcher]> EAS - Cache cleanup: ADD 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 Jan 29 19:49:48 sogod [1999]: <0x0xb62a0fdc[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:49:48 sogod [1999]: <0x0xb62a0fdc[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Calendar 1454093388 vevent%2Fpersonal 1 1 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 1 2 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 1 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 0 20160130T090000Z 20160130T100000Z xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAIAAAAAAAAAxP///w== 0 Test event 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 0 15 1 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 0 20160130T070000Z 20160130T080000Z xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAIAAAAAAAAAxP///w== 0 Second test event 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 0 15 1 Jan 29 19:49:48 sogod [1999]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 1455/1028 0.098 - - 1M Jan 29 19:49:54 sogod [1999]: SOGoUserHomePage user 'testuser' logged off Jan 29 19:49:54 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/logoff HTTP/1.1" 302 0/0 0.004 - - 8K Jan 29 19:49:54 sogod [1999]: 192.168.10.181 "GET /SOGo/so/ HTTP/1.1" 200 4631/0 0.015 13454 65% 0 Jan 29 19:50:01 sogod [1999]: SOGoRootPage successful login from '192.168.10.181' for user 'testuser' - expire = -1 grace = -1 Jan 29 19:50:01 sogod [1999]: 192.168.10.181 "POST /SOGo/connect HTTP/1.1" 200 27/43 0.012 - - 0 Jan 29 19:50:01 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser HTTP/1.1" 302 0/0 0.002 - - 0 Jan 29 19:50:01 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/view HTTP/1.1" 302 0/0 0.004 - - 0 Jan 29 19:50:01 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Mail HTTP/1.1" 302 0/0 0.003 - - 0 Jan 29 19:50:02 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/view HTTP/1.1" 200 11282/0 0.351 39621 71% 0 Jan 29 19:50:02 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454093402 HTTP/1.1" 200 296/0 0.007 - - 0 Jan 29 19:50:02 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/mailboxes HTTP/1.1" 200 341/0 0.219 - - 0 Jan 29 19:50:02 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/foldersState HTTP/1.1" 200 0/0 0.007 - - 0 Jan 29 19:50:03 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Mail/0/folderINBOX/unseenCount HTTP/1.1" 200 13/0 0.283 - - 0 Jan 29 19:50:05 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Mail/0/folderINBOX/expunge HTTP/1.1" 200 2/0 0.238 - - 0 Jan 29 19:50:05 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar HTTP/1.1" 302 0/0 0.006 - - 0 Jan 29 19:50:05 sogod [1999]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/view HTTP/1.1" 200 14363/0 0.037 54103 73% 16K Jan 29 19:50:06 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/canAccessContent HTTP/1.1" 204 0/0 0.004 - - 0 Jan 29 19:50:06 sogod [1999]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454093406 HTTP/1.1" 200 296/0 0.024 - - 0 Jan 29 19:50:06 sogod [1996]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/taskslist?show-completed=0&asc=true&sort=end&filterpopup=view_today HTTP/1.1" 200 2/0 0.024 - - 0 Jan 29 19:50:06 sogod [1994]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=&filterpopup=view_next7 HTTP/1.1" 200 729/0 0.037 - - 0Jan 29 19:50:06 sogod [1991]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/activeTasks HTTP/1.1" 200 15/0 0.031 - - 0 Jan 29 19:50:06 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview HTTP/1.1" 200 2273/0 0.033 54908 95% 0 Jan 29 19:50:06 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 811/0 0.012 - - 4K Jan 29 19:52:58 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/dateselector?day=20160131 HTTP/1.1" 200 770/0 0.010 9375 91% 0 Jan 29 19:52:58 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/personal/newevent?day=20160131&hm=1200 HTTP/1.1" 302 0/0 0.012 - - 20K Jan 29 19:52:58 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/Calendar/personal//7C8-56ABB500-7-21186A40.ics/editAsAppointment?day=20160131&hm=1200 HTTP/1.1" 200 10433/0 0.114 33009 68% 1M Jan 29 19:53:16 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/personal/7C8-56ABB500-7-21186A40.ics/saveAsAppointment HTTP/1.1" 200 21/810 0.018 - - 20K Jan 29 19:53:16 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/alarmslist?browserTime=1454093597 HTTP/1.1" 200 353/0 0.005 - - 0 Jan 29 19:53:17 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventslist?asc=true&sort=start&day=20160131&filterpopup=view_next7 HTTP/1.1" 200 1008/0 0.011 - - 0 Jan 29 19:53:17 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/weekview?day=20160131 HTTP/1.1" 200 2273/0 0.013 54908 95% 12K Jan 29 19:53:17 sogod [1992]: 192.168.10.181 "POST /SOGo/so/testuser/Calendar/eventsblocks?sd=20160125&ed=20160131&view=weekview HTTP/1.1" 200 407/0 0.009 1099 62% 0 Jan 29 19:55:08 sogod [1992]: <0x0xb62f19b4[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mond_XXX_local_7cf_1c5be5c9_0 Jan 29 19:55:08 sogod [1992]: <0x0xb62f19b4[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 mond_XXX_local_7cf_1c5be5c9_0 0 Jan 29 19:55:08 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=FolderSync HTTP/1.1" 200 57/45 0.343 - - 0 Jan 29 19:55:08 sogod [1992]: <0x0xb6178354[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: mail%2F5036bb35162fab56c80e0000b79f221a 3 2-5 vevent%2Fpersonal 4 1454091689 vcard%2Fpersonal 0 1454092862 mail%2F981b3a01552fab56d60e0000b79f221a 3 3-6 Jan 29 19:55:09 sogod [1992]: <0x0xb641f514[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:55:09 sogod [1992]: <0x0xb641f514[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null) Jan 29 19:55:09 sogod [1992]: <0x0xb6178354[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: 1 Email mail%2F5036bb35162fab56c80e0000b79f221a 1 1 Calendar vevent%2Fpersonal 3 1 Contacts vcard%2Fpersonal 2 1 Email mail%2F981b3a01552fab56d60e0000b79f221a 1 Jan 29 19:55:09 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=GetItemEstimate HTTP/1.1" 200 233/221 0.720 - - 0 Jan 29 19:55:09 sogod [1992]: <0x0xb631a96c[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 2-5 mail%2F5036bb35162fab56c80e0000b79f221a 5 3 2 2048 1 Jan 29 19:55:10 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 0/98 0.415 - - 0 Jan 29 19:55:10 sogod [1992]: <0x0xb63271ac[SOGoActiveSyncDispatcher]> EAS - request for device IMEI357909041390858: 1454091689 vevent%2Fpersonal 5 4 1 2048 1 1 xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAEAAAAAAAAAxP///w== 20160129T185508Z 20160130T090000Z Test event 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 20160130T100000Z 1 0 2 15 2 xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAEAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAEAAAAAAAAAxP///w== 20160129T185508Z 20160130T070000Z Second test event 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 20160130T080000Z 1 0 2 15 Jan 29 19:55:10 sogod [1992]: <0x0xb63271ac[SOGoActiveSyncDispatcher]> Cache cleanup needed for device IMEI357909041390858 - user: testuser syncKey: 1454091689 cache: 1454093388 Jan 29 19:55:10 sogod [1992]: <0x0xb63271ac[SOGoActiveSyncDispatcher]> EAS - Cache cleanup: CHANGE 7C8-56ABB500-7-21186A40 Jan 29 19:55:10 sogod [1992]: <0x0xb63271ac[SOGoActiveSyncDispatcher]> EAS - Cache cleanup: ADD 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 Jan 29 19:55:10 sogod [1992]: <0x0xb63271ac[SOGoActiveSyncDispatcher]> EAS - Cache cleanup: ADD 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 Jan 29 19:55:10 sogod [1992]: <0x0xb63271ac[SOGoActiveSyncDispatcher]> Change detected during Sync, we push the content. Jan 29 19:55:10 sogod [1992]: <0x0xb63271ac[SOGoActiveSyncDispatcher]> EAS - response for device IMEI357909041390858: Calendar 1454093710 vevent%2Fpersonal 1 1 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 1 2 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 1 7C8-56ABB500-7-21186A40 0 20160129T185316Z 20160131T110000Z 20160131T120000Z xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAIAAAAAAAAAxP///w== 0 third event anywhere 7C8-56ABB500-7-21186A40 0 15 1 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 0 20160130T090000Z 20160130T100000Z xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAIAAAAAAAAAxP///w== 0 Test event 4561732055696420546167205B265E25242340215D34623237303339662D353937662D336162392D393336622D303161333432633661653235 0 15 1 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 0 20160130T070000Z 20160130T080000Z xP///wAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAoAAAAFAAMAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAMAAAAFAAIAAAAAAAAAxP///w== 0 Second test event 4561732055696420546167205B265E25242340215D61636262373035642D636231622D336638352D623736332D373865653762393332353764 0 15 1 Jan 29 19:55:10 sogod [1992]: 37.209.102.40 "POST /SOGo/Microsoft-Server-ActiveSync?User=testuser&DeviceId=IMEI357909041390858&DeviceType=NokiaEmail&Cmd=Sync HTTP/1.1" 200 1868/1028 0.099 - - 716K Jan 29 19:56:20 sogod [1992]: SOGoUserHomePage user 'testuser' logged off Jan 29 19:56:20 sogod [1992]: 192.168.10.181 "GET /SOGo/so/testuser/logoff HTTP/1.1" 302 0/0 0.005 - - 0 Jan 29 19:56:20 sogod [1992]: 192.168.10.181 "GET /SOGo/so/ HTTP/1.1" 200 4631/0 0.010 13454 65% 0