[2011-01-26 18:28:15,815] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [] [] [] Handling incoming request [2011-01-26 18:28:15,929] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [] [] [] Request URL: http://xx/funambol/ds [2011-01-26 18:28:15,929] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [] [] [] Requested sessionId: null [2011-01-26 18:28:18,333] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] user/IMEI:351940032285111 logged in. [2011-01-26 18:28:18,449] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG1_RECEIVING [2011-01-26 18:28:18,834] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Source URI: cal [2011-01-26 18:28:18,835] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Done! Internal item type: 2 (text/x-vevent) [2011-01-26 18:28:18,901] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG3_RECEIVING [2011-01-26 18:28:19,402] [funambol.engine.pipeline] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [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:28:19,495] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Request processed. [2011-01-26 18:28:20,295] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Handling incoming request [2011-01-26 18:28:20,317] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Request URL: http://xx/funambol/ds [2011-01-26 18:28:20,317] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Requested sessionId: 45254CE6720D81E0740AA851CED89B08 [2011-01-26 18:28:21,784] [funambol.engine] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Starting synchronization ... [2011-01-26 18:28:21,787] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] In beginSync()... [2011-01-26 18:28:21,797] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Loading the JDBC driver for URL: jdbc:postgresql:///sogo [2011-01-26 18:28:22,035] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Context's user ID: user [2011-01-26 18:28:22,052] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Context sync mode: 200 [2011-01-26 18:28:22,052] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Context conflict resolution: 1 [2011-01-26 18:28:22,053] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Context query: null [2011-01-26 18:28:22,178] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Device's charset: UTF-8 [2011-01-26 18:28:22,178] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Device's timezone: null [2011-01-26 18:28:22,178] [funambol.engine.strategy] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Preparing fast synchronization since 2011-01-26 18:19:32.569 [2011-01-26 18:28:22,186] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] getNewItemKeys(2011-01-26 18:19:32.569(1296062372), 2011-01-26 18:28:17.563(1296062897)) [2011-01-26 18:28:22,205] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] getNewSyncItemKeys(): { keyValue: 5C6C-4D405900-117-64710480.ics } (sogouser0022d915832) [2011-01-26 18:28:22,206] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] getUpdatedSyncItemKeys(2011-01-26 18:19:32.569(1296062372), 2011-01-26 18:28:17.563(1296062897)) [2011-01-26 18:28:22,221] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] getDeletedItemKeys(2011-01-26 18:19:32.569(1296062372), 2011-01-26 18:28:17.563(1296062897)) [2011-01-26 18:28:22,224] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] getDeletedSyncItemKeys(): { keyValue: 317 } (sogouser0022d915832) [2011-01-26 18:28:22,226] [funambol.engine.strategy] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Preparation completed (last message in the package) [2011-01-26 18:28:22,226] [funambol.engine.strategy] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Synchronizing... [2011-01-26 18:28:22,233] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] In commitSync()... [2011-01-26 18:28:22,320] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG3_RECEIVED [2011-01-26 18:28:22,471] [funambol.engine.pipeline] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [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:28:22,478] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Request processed. [2011-01-26 18:28:22,868] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Handling incoming request [2011-01-26 18:28:22,869] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Request URL: http://xx/funambol/ds [2011-01-26 18:28:22,869] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Requested sessionId: 45254CE6720D81E0740AA851CED89B08 [2011-01-26 18:28:23,022] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] getSyncItemFromId( { keyValue: 5C6C-4D405900-117-64710480.ics } ) [2011-01-26 18:28:23,037] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Preferred item type: 1 [2011-01-26 18:28:23,038] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] must secure? false [2011-01-26 18:28:23,038] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] About to convert vCalendar (from v2 to v1): BEGIN:VCALENDAR VERSION:2.0 PRODID:-//Inverse inc./SOGo 1.0//EN BEGIN:VEVENT UID:5C6C-4D405900-117-64710480 SUMMARY:Sogo défaut alarme LOCATION:Mon bureau DESCRIPTION:test de non transfert de l'alarme de Sogo vers Téléphone CREATED:20110126T172522Z DTSTAMP:20110126T172522Z LAST-MODIFIED:20110126T172522Z BEGIN:VALARM TRIGGER;VALUE=DURATION:-PT15M ACTION:DISPLAY END:VALARM DTSTART;TZID=/inverse.ca/20101018_1/Europe/Paris:20110127T090000 DTEND;TZID=/inverse.ca/20101018_1/Europe/Paris:20110127T100000 TRANSP:OPAQUE END:VEVENT BEGIN:VTIMEZONE TZID:/inverse.ca/20101018_1/Europe/Paris X-LIC-LOCATION:Europe/Paris BEGIN:DAYLIGHT TZOFFSETFROM:+0100 TZOFFSETTO:+0200 TZNAME:CEST DTSTART:19700329T020000 RRULE:FREQ=YEARLY;BYMONTH=3;BYDAY=-1SU END:DAYLIGHT BEGIN:STANDARD TZOFFSETFROM:+0200 TZOFFSETTO:+0100 TZNAME:CET DTSTART:19701025T030000 RRULE:FREQ=YEARLY;BYMONTH=10;BYDAY=-1SU END:STANDARD END:VTIMEZONE END:VCALENDAR [2011-01-26 18:28:23,051] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] in aAlarmCleanup(), s on input is:BEGIN:VCALENDAR VERSION:2.0 PRODID:-//Inverse inc./SOGo 1.0//EN BEGIN:VEVENT UID:5C6C-4D405900-117-64710480 SUMMARY:Sogo défaut alarme LOCATION:Mon bureau DESCRIPTION:test de non transfert de l'alarme de Sogo vers Téléphone CREATED:20110126T172522Z DTSTAMP:20110126T172522Z LAST-MODIFIED:20110126T172522Z BEGIN:VALARM TRIGGER;VALUE=DURATION:-PT15M ACTION:DISPLAY END:VALARM DTSTART;TZID=/inverse.ca/20101018_1/Europe/Paris:20110127T090000 DTEND;TZID=/inverse.ca/20101018_1/Europe/Paris:20110127T100000 TRANSP:0 END:VEVENT BEGIN:VTIMEZONE TZID:/inverse.ca/20101018_1/Europe/Paris X-LIC-LOCATION:Europe/Paris BEGIN:DAYLIGHT TZOFFSETFROM:+0100 TZOFFSETTO:+0200 TZNAME:CEST DTSTART:19700329T020000 RRULE:FREQ=YEARLY;BYMONTH=3;BYDAY=-1SU END:DAYLIGHT BEGIN:STANDARD TZOFFSETFROM:+0200 TZOFFSETTO:+0100 TZNAME:CET DTSTART:19701025T030000 RRULE:FREQ=YEARLY;BYMONTH=10;BYDAY=-1SU END:STANDARD END:VTIMEZONE END:VCALENDAR [2011-01-26 18:28:23,072] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] after aAlarmCleanup(), ret value is:BEGIN:VCALENDAR VERSION:2.0 PRODID:-//Inverse inc./SOGo 1.0//EN BEGIN:VEVENT UID:5C6C-4D405900-117-64710480 SUMMARY:Sogo défaut alarme LOCATION:Mon bureau DESCRIPTION:test de non transfert de l'alarme de Sogo vers Téléphone CREATED:20110126T172522Z DTSTAMP:20110126T172522Z LAST-MODIFIED:20110126T172522Z BEGIN:VALARM TRIGGER;VALUE=DURATION:-PT15M ACTION:DISPLAY END:VALARM DTSTART;TZID=/inverse.ca/20101018_1/Europe/Paris:20110127T090000 DTEND;TZID=/inverse.ca/20101018_1/Europe/Paris:20110127T100000 TRANSP:0 END:VEVENT BEGIN:VTIMEZONE TZID:/inverse.ca/20101018_1/Europe/Paris X-LIC-LOCATION:Europe/Paris BEGIN:DAYLIGHT TZOFFSETFROM:+0100 TZOFFSETTO:+0200 TZNAME:CEST DTSTART:19700329T020000 RRULE:FREQ=YEARLY;BYMONTH=3;BYDAY=-1SU END:DAYLIGHT BEGIN:STANDARD TZOFFSETFROM:+0200 TZOFFSETTO:+0100 TZNAME:CET DTSTART:19701025T030000 RRULE:FREQ=YEARLY;BYMONTH=10;BYDAY=-1SU END:STANDARD END:VTIMEZONE END:VCALENDAR [2011-01-26 18:28:23,581] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] VALARM is: TRIGGER;VALUE=DURATION:-PT15M ACTION:DISPLAY [2011-01-26 18:28:23,590] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] BEGIN:VCALENDAR PRODID:-//Inverse inc./SOGo 1.0//EN VERSION:1.0 TZ:+0100 DAYLIGHT:TRUE;+0200;20100328T020000;20101031T030000;Europe/Paris;Europe/Paris DAYLIGHT:TRUE;+0200;20110327T020000;20111030T030000;Europe/Paris;Europe/Paris DAYLIGHT:TRUE;+0200;20120325T020000;20121028T030000;Europe/Paris;Europe/Paris DAYLIGHT:TRUE;+0200;20130331T020000;20131027T030000;Europe/Paris;Europe/Paris BEGIN:VEVENT UID:5C6C-4D405900-117-64710480 SUMMARY;ENCODING=QUOTED-PRINTABLE;CHARSET=UTF-8:Sogo d=C3=A9faut alarme DESCRIPTION;ENCODING=QUOTED-PRINTABLE;CHARSET=UTF-8:test de non transfert de l'alarme de Sogo vers T=C3=A9l=C3=A9phone LOCATION:Mon bureau CLASS:PUBLIC DTSTART:20110127T080000Z DTEND:20110127T090000Z TRANSP:0 LAST-MODIFIED:20110126T172522Z X-FUNAMBOL-ALLDAY:0 AALARM:-PT15M END:VEVENT END:VCALENDAR [2011-01-26 18:28:23,641] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG1_RECEIVING [2011-01-26 18:28:23,748] [funambol.engine.pipeline] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [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:28:23,750] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Request processed. [2011-01-26 18:28:24,405] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Handling incoming request [2011-01-26 18:28:24,406] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Request URL: http://xx/funambol/ds [2011-01-26 18:28:24,406] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Requested sessionId: 45254CE6720D81E0740AA851CED89B08 [2011-01-26 18:28:24,506] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Received status code '201' for a 'Add' for this items (1): - 5C6C-4D405900-117-64710480.ics [2011-01-26 18:28:24,532] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] moving to state: STATE_PKG3_RECEIVING [2011-01-26 18:28:24,532] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] moving to state: STATE_END [2011-01-26 18:28:24,532] [funambol.engine.source] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] cal: 0 new items added, 0 existing items updated, 0 items deleted. [2011-01-26 18:28:24,532] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] In endSync()... [2011-01-26 18:28:24,532] [funambol.sogo] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [cal] Closed the database connection. [2011-01-26 18:28:24,556] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] moving to state: STATE_ENDED [2011-01-26 18:28:24,558] [funambol.handler] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Synchronization completed [2011-01-26 18:28:24,663] [funambol.engine.pipeline] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [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:28:24,665] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Request processed. [2011-01-26 18:28:24,666] [funambol.transport.http] [INFO] [45254CE6720D81E0740AA851CED89B08] [62.201.142.25] [IMEI:351940032285111] [user] [] Closing session 45254CE6720D81E0740AA851CED89B08