[2011-01-26 18:19:31,863] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [] [] [] Handling incoming request [2011-01-26 18:19:31,901] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [] [] [] Request URL: http://xx/funambol/ds [2011-01-26 18:19:31,901] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [] [] [] Requested sessionId: null [2011-01-26 18:19:32,819] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] user/IMEI:351940032285111 logged in. [2011-01-26 18:19:32,886] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG1_RECEIVING [2011-01-26 18:19:32,939] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Source URI: cal [2011-01-26 18:19:32,939] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Done! Internal item type: 2 (text/x-vevent) [2011-01-26 18:19:32,973] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG3_RECEIVING [2011-01-26 18:19:33,106] [funambol.engine.pipeline] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Output processing stopped by com.funambol.foundation.synclet.BeanShellSynclet@249fe45c[script=com/funambol/server/engine/pipeline/phones-support/bsh/NokiaS60out.bsh,header=user-agent,pattern=Nokia SyncML HTTP Client|S60 SyncML HTTP Client] (reason: NokiaS60out Synclet finished) [2011-01-26 18:19:33,135] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Request processed. [2011-01-26 18:19:33,887] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Handling incoming request [2011-01-26 18:19:33,888] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Request URL: http://xx/funambol/ds [2011-01-26 18:19:33,892] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Requested sessionId: BD4A455ABCC91A0073E30084F2116CAA [2011-01-26 18:19:35,255] [funambol.engine] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Starting synchronization ... [2011-01-26 18:19:35,261] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] In beginSync()... [2011-01-26 18:19:35,262] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Loading the JDBC driver for URL: jdbc:postgresql:///sogo [2011-01-26 18:19:35,575] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Context's user ID: user [2011-01-26 18:19:35,576] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Context sync mode: 200 [2011-01-26 18:19:35,576] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Context conflict resolution: 1 [2011-01-26 18:19:35,576] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Context query: null [2011-01-26 18:19:35,803] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Device's charset: UTF-8 [2011-01-26 18:19:35,804] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Device's timezone: null [2011-01-26 18:19:35,877] [funambol.engine.strategy] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Preparing fast synchronization since 2011-01-26 18:14:15.045 [2011-01-26 18:19:35,877] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] getNewItemKeys(2011-01-26 18:14:15.045(1296062055), 2011-01-26 18:19:32.569(1296062372)) [2011-01-26 18:19:36,043] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] getUpdatedSyncItemKeys(2011-01-26 18:14:15.045(1296062055), 2011-01-26 18:19:32.569(1296062372)) [2011-01-26 18:19:36,049] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] getDeletedItemKeys(2011-01-26 18:14:15.045(1296062055), 2011-01-26 18:19:32.569(1296062372)) [2011-01-26 18:19:36,215] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] in aAlarmCleanup(), s on input is:BEGIN:VCALENDAR VERSION:1.0 BEGIN:VEVENT UID:SF7x14Al4F0Sf50MR9CCb1 SUMMARY:Defaut alarme DESCRIPTION:Cf Thomas Olivier DTSTART:20110127T070000Z DTEND:20110127T080000Z X-EPOCAGENDAENTRYTYPE:APPOINTMENT CLASS:PUBLIC LOCATION;ENCODING=QUOTED-PRINTABLE;CHARSET=UTF-8:T=C3=A9l=C3=A9phone SEQUENCE:0 X-METHOD:NONE AALARM;TYPE=X-EPOCSOUND:20110127T064500Z;;; LAST-MODIFIED:20110126T171902Z PRIORITY:5 X-SYMBIAN-LUID:318 RRULE: ORGANIZER: END:VEVENT END:VCALENDAR [2011-01-26 18:19:36,215] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] found part[1]=20110127T064500Z [2011-01-26 18:19:36,394] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] found an alarmdate:20110127T064500Z [2011-01-26 18:19:36,394] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] after aAlarmCleanup(), ret value is:BEGIN:VCALENDAR VERSION:1.0 BEGIN:VEVENT UID:SF7x14Al4F0Sf50MR9CCb1 SUMMARY:Defaut alarme DESCRIPTION:Cf Thomas Olivier DTSTART:20110127T070000Z DTEND:20110127T080000Z X-EPOCAGENDAENTRYTYPE:APPOINTMENT CLASS:PUBLIC LOCATION;ENCODING=QUOTED-PRINTABLE;CHARSET=UTF-8:T=C3=A9l=C3=A9phone SEQUENCE:0 X-METHOD:NONE AALARM:20110127T064500Z LAST-MODIFIED:20110126T171902Z PRIORITY:5 X-SYMBIAN-LUID:318 RRULE: ORGANIZER: END:VEVENT END:VCALENDAR [2011-01-26 18:19:37,183] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] DATE 2: 1296111600 tz: sun.util.calendar.ZoneInfo[id="GMT",offset=0,dstSavings=0,useDaylight=false,transitions=0,lastRule=null] [2011-01-26 18:19:37,670] [funambol.engine.strategy] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Preparation completed (last message in the package) [2011-01-26 18:19:37,671] [funambol.engine.strategy] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Synchronizing... [2011-01-26 18:19:37,684] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] removeSyncItem( { keyValue: 317 } , 2011-01-26 18:19:32.569 , soft? false) [2011-01-26 18:19:37,684] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Tags: [ ] count: 1 [2011-01-26 18:19:37,700] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Target tag: location: sogouser0022d915832 i:0 [2011-01-26 18:19:37,708] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] addSyncItem(318) [2011-01-26 18:19:37,708] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] addSyncItem - type: text/x-vcalendar [2011-01-26 18:19:37,709] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] getSyncItemFromId( { keyValue: 318 } ) [2011-01-26 18:19:37,710] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] addSyncItem - content: BEGIN:VCALENDAR VERSION:1.0 BEGIN:VEVENT UID:SF7x14Al4F0Sf50MR9CCb1 SUMMARY:Defaut alarme DESCRIPTION:Cf Thomas Olivier DTSTART:20110127T070000Z DTEND:20110127T080000Z X-EPOCAGENDAENTRYTYPE:APPOINTMENT CLASS:PUBLIC LOCATION;ENCODING=QUOTED-PRINTABLE;CHARSET=UTF-8:T=C3=A9l=C3=A9phone SEQUENCE:0 X-METHOD:NONE AALARM;TYPE=X-EPOCSOUND:20110127T064500Z;;; LAST-MODIFIED:20110126T171902Z PRIORITY:5 X-SYMBIAN-LUID:318 RRULE: ORGANIZER: END:VEVENT END:VCALENDAR [2011-01-26 18:19:37,710] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Preferred item type: 1 [2011-01-26 18:19:37,713] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] in aAlarmCleanup(), s on input is:BEGIN:VCALENDAR VERSION:1.0 BEGIN:VEVENT UID:SF7x14Al4F0Sf50MR9CCb1 SUMMARY:Defaut alarme DESCRIPTION:Cf Thomas Olivier DTSTART:20110127T070000Z DTEND:20110127T080000Z X-EPOCAGENDAENTRYTYPE:APPOINTMENT CLASS:PUBLIC LOCATION;ENCODING=QUOTED-PRINTABLE;CHARSET=UTF-8:T=C3=A9l=C3=A9phone SEQUENCE:0 X-METHOD:NONE AALARM;TYPE=X-EPOCSOUND:20110127T064500Z;;; LAST-MODIFIED:20110126T171902Z PRIORITY:5 X-SYMBIAN-LUID:318 RRULE: ORGANIZER: END:VEVENT END:VCALENDAR [2011-01-26 18:19:37,713] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] found part[1]=20110127T064500Z [2011-01-26 18:19:37,713] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] found an alarmdate:20110127T064500Z [2011-01-26 18:19:37,713] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] after aAlarmCleanup(), ret value is:BEGIN:VCALENDAR VERSION:1.0 BEGIN:VEVENT UID:SF7x14Al4F0Sf50MR9CCb1 SUMMARY:Defaut alarme DESCRIPTION:Cf Thomas Olivier DTSTART:20110127T070000Z DTEND:20110127T080000Z X-EPOCAGENDAENTRYTYPE:APPOINTMENT CLASS:PUBLIC LOCATION;ENCODING=QUOTED-PRINTABLE;CHARSET=UTF-8:T=C3=A9l=C3=A9phone SEQUENCE:0 X-METHOD:NONE AALARM:20110127T064500Z LAST-MODIFIED:20110126T171902Z PRIORITY:5 X-SYMBIAN-LUID:318 RRULE: ORGANIZER: END:VEVENT END:VCALENDAR [2011-01-26 18:19:37,719] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Converting vCalendar to iCalendar [2011-01-26 18:19:37,772] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Adding work-around for VALARM [2011-01-26 18:19:37,781] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Removed REPEAT:0 from VALARM [2011-01-26 18:19:37,797] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] DATE 2: 1296111600 tz: sun.util.calendar.ZoneInfo[id="GMT",offset=0,dstSavings=0,useDaylight=false,transitions=0,lastRule=null] [2011-01-26 18:19:37,837] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] In commitSync()... [2011-01-26 18:19:37,947] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG3_RECEIVED [2011-01-26 18:19:38,111] [funambol.engine.pipeline] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Output processing stopped by com.funambol.foundation.synclet.BeanShellSynclet@249fe45c[script=com/funambol/server/engine/pipeline/phones-support/bsh/NokiaS60out.bsh,header=user-agent,pattern=Nokia SyncML HTTP Client|S60 SyncML HTTP Client] (reason: NokiaS60out Synclet finished) [2011-01-26 18:19:38,115] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Request processed. [2011-01-26 18:19:38,546] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Handling incoming request [2011-01-26 18:19:38,559] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Request URL: http://xx/funambol/ds [2011-01-26 18:19:38,559] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Requested sessionId: BD4A455ABCC91A0073E30084F2116CAA [2011-01-26 18:19:38,842] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG1_RECEIVING [2011-01-26 18:19:39,052] [funambol.engine.pipeline] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Output processing stopped by com.funambol.foundation.synclet.BeanShellSynclet@249fe45c[script=com/funambol/server/engine/pipeline/phones-support/bsh/NokiaS60out.bsh,header=user-agent,pattern=Nokia SyncML HTTP Client|S60 SyncML HTTP Client] (reason: NokiaS60out Synclet finished) [2011-01-26 18:19:39,055] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Request processed. [2011-01-26 18:19:39,618] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Handling incoming request [2011-01-26 18:19:39,623] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Request URL: http://xx/funambol/ds [2011-01-26 18:19:39,623] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Requested sessionId: BD4A455ABCC91A0073E30084F2116CAA [2011-01-26 18:19:39,814] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG3_RECEIVING [2011-01-26 18:19:39,815] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] moving to state: STATE_END [2011-01-26 18:19:39,820] [funambol.engine.source] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] cal: 0 new items added, 0 existing items updated, 0 items deleted. [2011-01-26 18:19:39,820] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] In endSync()... [2011-01-26 18:19:39,820] [funambol.sogo] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [cal] Closed the database connection. [2011-01-26 18:19:39,843] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] moving to state: STATE_ENDED [2011-01-26 18:19:39,843] [funambol.handler] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Synchronization completed [2011-01-26 18:19:40,831] [funambol.engine.pipeline] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Output processing stopped by com.funambol.foundation.synclet.BeanShellSynclet@249fe45c[script=com/funambol/server/engine/pipeline/phones-support/bsh/NokiaS60out.bsh,header=user-agent,pattern=Nokia SyncML HTTP Client|S60 SyncML HTTP Client] (reason: NokiaS60out Synclet finished) [2011-01-26 18:19:40,858] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Request processed. [2011-01-26 18:19:40,859] [funambol.transport.http] [INFO] [BD4A455ABCC91A0073E30084F2116CAA] [62.201.142.26] [IMEI:351940032285111] [user] [] Closing session BD4A455ABCC91A0073E30084F2116CAA