DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:11:50. Packet logged in /tmp/sync/client_10.xml
DEBUG:  New session created: 6vd9p6ig9cfipbtltkd93fv6n7
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Previous sync found for database task; client timestamp: 1341495956
INFO:   Client requested sync with anchor timestamp 1341594535 but server has recorded timestamp 1341495956. Enforcing SlowSync
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 201
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-06 19:11:50. Packet logged in /tmp/sync/server_10.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:11:51. Packet logged in /tmp/sync/client_11.xml
DEBUG:  New session created: hd1o12hmo207hq2q082utsfbk1
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-06 19:11:51. Packet logged in /tmp/sync/server_11.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:13:19. Packet logged in /tmp/sync/client_20.xml
DEBUG:  New session created: or43lvbd8gk3921kclrdk5lmg3
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Previous sync found for database task; client timestamp: 1341495956
INFO:   Client requested sync with anchor timestamp 1341594535 but server has recorded timestamp 1341495956. Enforcing SlowSync
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 201
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-06 19:13:19. Packet logged in /tmp/sync/server_20.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:13:19. Packet logged in /tmp/sync/client_21.xml
DEBUG:  New session created: jk0t40d89c09r5hrt2dvar7084
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-06 19:13:20. Packet logged in /tmp/sync/server_21.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:20:43. Packet logged in /tmp/sync/client_30.xml
DEBUG:  Current Session ID: 1341595244
DEBUG:  New session created: b605p37lmb52s0r5b9gfb7h8e5
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Previous sync found for database task; client timestamp: 1341495956
INFO:   Client requested sync with anchor timestamp 1341594535 but server has recorded timestamp 1341495956. Enforcing SlowSync
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 201
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-06 19:20:43. Packet logged in /tmp/sync/server_30.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:20:44. Packet logged in /tmp/sync/client_31.xml
DEBUG:  Current Session ID: 1341595244
DEBUG:  New session created: 2js85vml0q881vv5jmgr96n483
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-06 19:20:44. Packet logged in /tmp/sync/server_31.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:25:20. Packet logged in /tmp/sync/client_40.xml
DEBUG:  Current Session ID: 1341595520
DEBUG:  New session created: fqmr5gcss30hqjd440ron6fjq0
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Previous sync found for database task; client timestamp: 1341495956
INFO:   Client requested sync with anchor timestamp 1341594535 but server has recorded timestamp 1341495956. Enforcing SlowSync
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 201
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-06 19:25:20. Packet logged in /tmp/sync/server_40.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:25:20. Packet logged in /tmp/sync/client_41.xml
DEBUG:  Current Session ID: 1341595520
DEBUG:  New session created: l01cq1hs7luboig547nsp54q62
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-06 19:25:20. Packet logged in /tmp/sync/server_41.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:34:33. Packet logged in /tmp/sync/client_50.xml
DEBUG:  Current Session ID: 1341596073
DEBUG:  New session created: i32sun1l15d8eidbs9rvrtkmj4
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Previous sync found for database task; client timestamp: 1341495956
INFO:   Client requested sync with anchor timestamp 1341594535 but server has recorded timestamp 1341495956. Enforcing SlowSync
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 201
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-06 19:34:33. Packet logged in /tmp/sync/server_50.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:34:34. Packet logged in /tmp/sync/client_51.xml
DEBUG:  Current Session ID: 1341596073
DEBUG:  New session created: 5b68olb7gh2c0k607mrc5fvt26
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-06 19:34:34. Packet logged in /tmp/sync/server_51.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:36:34. Packet logged in /tmp/sync/client_60.xml
DEBUG:  Current Session ID: 1341596195
DEBUG:  New session created: k8183nsk41539kg7qjhnl258v6
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Previous sync found for database task; client timestamp: 1341495956
INFO:   Client requested sync with anchor timestamp 1341594535 but server has recorded timestamp 1341495956. Enforcing SlowSync
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 201
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-06 19:36:34. Packet logged in /tmp/sync/server_60.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-06 19:36:35. Packet logged in /tmp/sync/client_61.xml
DEBUG:  Current Session ID: 1341596195
DEBUG:  New session created: o7ej115doonn5pnlvn1na8loa4
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-06 19:36:35. Packet logged in /tmp/sync/server_61.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-07 00:42:55. Packet logged in /tmp/sync/client_70.xml
DEBUG:  New session created: m5uerjoj4sd38h1n55a3qp49d0
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 203
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-07 00:42:55. Packet logged in /tmp/sync/server_70.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-07 00:42:56. Packet logged in /tmp/sync/client_71.xml
DEBUG:  New session created: s4ogkos6t94ddb0mr5vbjbbs33
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-07 00:42:56. Packet logged in /tmp/sync/server_71.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-07 00:43:57. Packet logged in /tmp/sync/client_80.xml
DEBUG:  New session created: 5nk8hktr73j5k1rf106qjdir35
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 203
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-07 00:43:57. Packet logged in /tmp/sync/server_80.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-07 00:43:58. Packet logged in /tmp/sync/client_81.xml
DEBUG:  New session created: rqdk1teimdmq48dv8sjjs8ed87
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-07 00:43:58. Packet logged in /tmp/sync/server_81.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-07 00:46:58. Packet logged in /tmp/sync/client_90.xml
DEBUG:  New session created: 72s8m6u6ckuhm6qvcajd9hkp23
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  No info about previous syncs found for device fol-Sk9OSU1PQklMOmpvbml3 and database task
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 201
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-07 00:46:58. Packet logged in /tmp/sync/server_90.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-07 00:46:59. Packet logged in /tmp/sync/client_91.xml
DEBUG:  New session created: hok0palpsn1fe7a1oi2k01krq1
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-07 00:46:59. Packet logged in /tmp/sync/server_91.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-07 00:51:09. Packet logged in /tmp/sync/client_100.xml
DEBUG:  New session created: 2s2q8vqdn3mp6su2ird225rls1
DEBUG:  Checking authentication for user joniw
DEBUG:  Authenticated: yes; version: 1.2; message ID: 1; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: joniw; charset: UTF-8; wbxml: no
DEBUG:  Previous sync found for database task; client timestamp: 1341495956
INFO:   Client requested sync with anchor timestamp 1341594535 but server has recorded timestamp 1341495956. Enforcing SlowSync
DEBUG:  Creating Horde_SyncMl_Sync object for database task; sync type 201
DEBUG:  Received <Final> from client.
DEBUG:  Handle <Final> for state Init
DEBUG:  Sending <Final> to client
DEBUG:  Return message completed
DEBUG:  Finished at 2012-07-07 00:51:09. Packet logged in /tmp/sync/server_100.xml

DEBUG:  Backend of class Horde_SyncMl_Backend_Horde created
DEBUG:  Started at 2012-07-07 00:51:09. Packet logged in /tmp/sync/client_101.xml
DEBUG:  New session created: 3lgmc44ha368lr0h87tfgttft7
DEBUG:  Invalid authentication
DEBUG:  Authenticated: no; version: 1.2; message ID: 2; source URI: fol-Sk9OSU1PQklMOmpvbml3; target URI: http://test.test/rpc.php; user: ; charset: UTF-8; wbxml: no
DEBUG:  Received <Final> from client.
DEBUG:  Sending <Final> to client
DEBUG:  Session completed and closed
DEBUG:  Finished at 2012-07-07 00:51:09. Packet logged in /tmp/sync/server_101.xml