0001974: Activesync with Nokia N900 not working

About | Get Support

View Issue Details [ Jump to Notes ]

[ Issue History ] [ Print ]

Project

Category

View Status

Date Submitted

Last Update

0001974

Tine 2.0

ActiveSync

public

2009-12-16 09:30

2010-04-09 11:47

Reporter

naich

Assigned To

lkneschke

Priority

normal

Severity

minor

Reproducibility

always

Status

resolved

Resolution

fixed

Platform

OS Version

Product Version

August (2009-11-1)

Target Version

Mialena (2010-03) Beta 1

Fixed in Version

Mialena (2010-03) Beta 1

Summary

0001974: Activesync with Nokia N900 not working

Description

hi,

in recent SVN version (rev 12008) activesync is not working with a Nokia N900 and Mail for Exchange client software.

the device says the sync is fine but not transfer is ever transferred in any direction. i tested calender and tasks.

i attached a debug-level log of the sync below.

what makes me wonder are the lines:
2009-12-15T18:45:18+00:00 NOTICE (5): Tinebase_Core::errorHandler::278 Undefined index: User in /www/tine20/ActiveSync/Server/Http.php::88 (
8)
2009-12-15T18:45:18+00:00 NOTICE (5): Tinebase_Core::errorHandler::278 Undefined index: HTTP_X_MS_POLICYKEY in /www/tine20/ActiveSync/Fronte
nd/Http.php::86 (8)

br

Additional Information

2009-12-15T18:45:17+00:00 INFO (6): index.php (63) TIME: 0.292315006256 seconds 17.5 MBytes
2009-12-15T18:45:18+00:00 INFO (6): Tinebase_Core::setupLogger::374 logger initialized
2009-12-15T18:45:18+00:00 INFO (6): Tinebase_Core::setupCache::414 cache disabled
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_Preference_Abstract::getValue::129 get user preference "timezone" for account id 0
2009-12-15T18:45:18+00:00 INFO (6): Tinebase_Core::setupUserLocale::580 given localeString 'auto'
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_Translation::getLocale::177 given localeString 'auto'
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_Translation::getLocale::189 'en' is not supported, checking fallback
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_Translation::getLocale::212 selected locale: 'en'
2009-12-15T18:45:18+00:00 DEBUG (7): ActiveSync_Server_Http::handle::40 is ActiveSync request.
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_Auth::__construct::129 authentication backend: Sql
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_Auth_Sql::authenticate::29 Trying to authenticate max
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_Auth_Sql::authenticate::53 Authentication of max succeeded
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_User::getInstance::118 accounts backend: Sql
2009-12-15T18:45:18+00:00 DEBUG (7): Tinebase_Group::getInstance::56 groups backend: Sql
2009-12-15T18:45:18+00:00 NOTICE (5): Tinebase_Core::errorHandler::278 Undefined index: User in /www/tine20/ActiveSync/Server/Http.php::88 (
8)
2009-12-15T18:45:18+00:00 NOTICE (5): Tinebase_Core::errorHandler::278 Undefined index: HTTP_X_MS_POLICYKEY in /www/tine20/ActiveSync/Fronte
nd/Http.php::86 (8)
2009-12-15T18:45:18+00:00 DEBUG (7): ActiveSync_Frontend_Http::handlePost::87 Agent: UQExchange/1.0 PolicyKey: 0 ASVersion: 2.5 Command: Syn
c
2009-12-15T18:45:18+00:00 DEBUG (7): ActiveSync_Frontend_Http::handlePost::99 class name: ActiveSync_Command_Sync
2009-12-15T18:45:18+00:00 DEBUG (7): ActiveSync_Command_Wbxml::__construct::95 decoded wbxml content: <?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" "http://www.microsoft.com/"> [^]
<Sync xmlns="uri:AirSync" xmlns:AirSyncBase="uri:AirSyncBase"><Collections><Collection><SyncKey>1</SyncKey><CollectionId>calendar-root</Colle
ctionId><GetChanges/><Options><FilterType>4</FilterType><Conflict>1</Conflict><MIMESupport>0</MIMESupport><AirSyncBase:BodyPreference><AirSyn
cBase:Type>1</AirSyncBase:Type></AirSyncBase:BodyPreference></Options></Collection></Collections></Sync>

2009-12-15T18:45:18+00:00 DEBUG (7): ActiveSync_Command_Wbxml::__construct::101 sync timestamp: 2009-12-15 18:45:18
2009-12-15T18:45:18+00:00 INFO (6): ActiveSync_Command_Sync::handle::130 SyncKey is 1 Class: CollectionId: calendar-root
2009-12-15T18:45:20+00:00 INFO (6): Tinebase_Core::setupLogger::374 logger initialized
2009-12-15T18:45:20+00:00 INFO (6): Tinebase_Core::setupCache::414 cache disabled
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Preference_Abstract::getValue::129 get user preference "timezone" for account id 0
2009-12-15T18:45:20+00:00 INFO (6): Tinebase_Core::setupUserLocale::580 given localeString 'auto'
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Translation::getLocale::177 given localeString 'auto'
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Translation::getLocale::189 'en' is not supported, checking fallback
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Translation::getLocale::212 selected locale: 'en'
2009-12-15T18:45:20+00:00 DEBUG (7): ActiveSync_Server_Http::handle::40 is ActiveSync request.
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Auth::__construct::129 authentication backend: Sql
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Auth_Sql::authenticate::29 Trying to authenticate max
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Auth_Sql::authenticate::53 Authentication of max succeeded
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_User::getInstance::118 accounts backend: Sql
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Group::getInstance::56 groups backend: Sql
2009-12-15T18:45:20+00:00 NOTICE (5): Tinebase_Core::errorHandler::278 Undefined index: User in /www/tine20/ActiveSync/Server/Http.php::88 (
8)
2009-12-15T18:45:20+00:00 NOTICE (5): Tinebase_Core::errorHandler::278 Undefined index: HTTP_X_MS_POLICYKEY in /www/tine20/ActiveSync/Fronte
nd/Http.php::86 (8)
2009-12-15T18:45:20+00:00 DEBUG (7): ActiveSync_Frontend_Http::handlePost::87 Agent: UQExchange/1.0 PolicyKey: 0 ASVersion: 2.5 Command: Pin
g
2009-12-15T18:45:20+00:00 DEBUG (7): ActiveSync_Frontend_Http::handlePost::99 class name: ActiveSync_Command_Ping
2009-12-15T18:45:20+00:00 DEBUG (7): ActiveSync_Command_Wbxml::__construct::95 decoded wbxml content: <?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" "http://www.microsoft.com/"> [^]
<Ping xmlns="uri:Ping"><HeartBeatInterval>1800</HeartBeatInterval><Folders><Folder><Id>calendar-root</Id><Class>Calendar</Class></Folder><Fol
der><Id>tasks-root</Id><Class>Tasks</Class></Folder></Folders></Ping>

2009-12-15T18:45:20+00:00 DEBUG (7): ActiveSync_Command_Wbxml::__construct::101 sync timestamp: 2009-12-15 18:45:20
2009-12-15T18:45:20+00:00 DEBUG (7): ActiveSync_Command_Ping::handle::111 Folders to monitor(1800 / 1260902720 / 1260904520 / 1): Array
(
    [0] => Array
        (
            [serverEntryId] => calendar-root
            [folderType] => Calendar
        )

    [1] => Array
        (
            [serverEntryId] => tasks-root
            [folderType] => Tasks
        )

)

2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Container::getContainerByACL::262 app: Calendar / account: ad55303bae255b8ac4b813a115696e559ff17a99
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Container::getContainerByACL::262 app: Calendar / account: ad55303bae255b8ac4b813a115696e559ff17a99
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Container::getContainerByACL::262 app: Calendar / account: ad55303bae255b8ac4b813a115696e559ff17a99
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Container::getContainerByACL::262 app: Calendar / account: ad55303bae255b8ac4b813a115696e559ff17a99
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Container::getContainerByACL::262 app: Tasks / account: ad55303bae255b8ac4b813a115696e559ff17a99
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Container::getContainerByACL::262 app: Tasks / account: ad55303bae255b8ac4b813a115696e559ff17a99
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Container::getContainerByACL::262 app: Tasks / account: ad55303bae255b8ac4b813a115696e559ff17a99
2009-12-15T18:45:20+00:00 DEBUG (7): Tinebase_Container::getContainerByACL::262 app: Tasks / account: ad55303bae255b8ac4b813a115696e559ff17a99
2009-12-15T18:45:20+00:00 NOTICE (5): Tinebase_Core::errorHandler::278 Undefined variable: secondsLeft in /www/tine20/ActiveSync/Command/Ping.php::159 (8)
2009-12-15T18:45:20+00:00 INFO (6): ActiveSync_Command_Ping::handle::159 DeviceId: 356938030392519 Lifetime: 1800 SecondsLeft: Status: 2)
2009-12-15T18:45:20+00:00 INFO (6): ActiveSync_Command_Ping::handle::168 DeviceId: 356938030392519 changes in folder: calendar-root
2009-12-15T18:45:20+00:00 DEBUG (7): ActiveSync_Command_Wbxml::getResponse::129 <?xml version="1.0" encoding="utf-8"?>
<!DOCTYPE AirSync PUBLIC "-//AIRSYNC//DTD AirSync//EN" "http://www.microsoft.com/"> [^]
<Ping xmlns="uri:Ping"><Status>2</Status><Folders><Folder>calendar-root</Folder></Folders></Ping>

2009-12-15T18:45:20+00:00 INFO (6): index.php (63) TIME: 0.306075811386 seconds 17.5 MBytes

Issue History
Date Modified	Username	Field	Change
2009-12-16 09:30	naich	New Issue
2009-12-16 09:30	naich	Status	new => assigned
2009-12-16 09:30	naich	Assigned To	=> lkneschke
2009-12-16 10:02	naich	Issue Monitored: naich
2009-12-16 19:05	pschuele	Target Version	=> 2010-03 Milestone 1
2010-01-04 11:17	naich	Issue End Monitor: naich
2010-01-15 17:17	pschuele	Target Version	2010-03 Milestone 1 => 2010-03 Milestone 2
2010-03-17 12:33	pschuele	Target Version	Mialena (2010-03) Milestone 2 => 2010-07
2010-04-09 11:12	lkneschke	Note Added: 0002022
2010-04-09 11:12	lkneschke	Status	assigned => resolved
2010-04-09 11:12	lkneschke	Fixed in Version	=> Mialena (2010-03) Beta 1
2010-04-09 11:12	lkneschke	Resolution	open => fixed
2010-04-09 11:47	lkneschke	Target Version	2010-07 => Mialena (2010-03) Beta 1

Notes
(0002022) lkneschke (manager) 2010-04-09 11:12	Tested with Nokia E66 and Mail for Exchange 3.0. Works now.

Relationships