[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