View Issue Details

IDProjectCategoryView StatusLast Update
0002589SOGoActiveSyncpublic2014-03-06 21:28
ReporterLudovic Hutin Assigned Toludovic  
PrioritynormalSeverityminorReproducibilityalways
Status closedResolutionfixed 
Product Version2.1.1b 
Fixed in Version2.2.1 
Summary0002589: Crash when using ActiveSync with Outlook 2013
Description

Hi,

Here is the BT

When i configure ActiveSync for my Outlook 2013, i got this entry in the log 

Jan 27 14:22:32 sogod [13317]: <0x0x555555fa3b50[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-01-27 14:22:33.486 sogod[13317] Note: using 'UCS-2LE' on Linux.
Jan 27 14:22:35 sogod [13317]: [WARN] <0x0x55555f0c3ae0[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jan 27 14:22:35 sogod [13317]: [WARN] <0x0x55555f0c3ae0[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jan 27 14:22:35 sogod [13317]: [WARN] <0x0x55555f0c3ae0[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
EXCEPTION: <NSException: 0x55555f30b9e0> NAME:NSRangeException REASON:Index 0 is out of range 0 (in 'objectAtIndex:') INFO:{Array = (); Count = 0; Index = 0; }

Here is the full GDB Log

sogo@sogo-be-test:~$ gdb --args /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Ubuntu/Linaro 7.4-2012.04-0ubuntu2.1) 7.4-2012.04
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
For bug reporting instructions, please see:
<http://bugs.launchpad.net/gdb-linaro/>...
Reading symbols from /usr/local/sbin/sogod...done.
(gdb) run
Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
^C
Program received signal SIGINT, Interrupt.
0x00007ffff7dee966 in ?? () from /lib64/ld-linux-x86-64.so.2
(gdb) b [NSException raise]
Function "[NSException raise]" not defined.
Make breakpoint pending on future shared library load? (y or [n]) y
Breakpoint 1 ([NSException raise]) pending.
(gdb) b abort
Breakpoint 2 at 0x7ffff435fa10
(gdb) c
Continuing.
Jan 27 14:22:30 sogod [13317]: version 2.1.2 (build root@sogo-be-test.u-strasbg.fr 201401250249) -- starting
Jan 27 14:22:30 sogod [13317]: vmem size check enabled: shutting down app when vmem > 512 MB
Jan 27 14:22:30 sogod [13317]: <0x0x555555a580f0[SOGoProductLoader]> SOGo products loaded from '/usr/local/lib/GNUstep/SOGo':
Jan 27 14:22:30 sogod [13317]: <0x0x555555a580f0[SOGoProductLoader]> ContactsUI.SOGo, PreferencesUI.SOGo, SchedulerUI.SOGo, Mailer.SOGo, CommonUI.SOGo, Contacts.SOGo, MailPartViewers.SOGo, MainUI.SOGo, Appointments.SOGo, MailerUI.SOGo, ActiveSync.SOGo, AdministrationUI.SOGo
Jan 27 14:22:31 sogod [13317]: |SOGo| WOHttpAdaptor listening on address *:20000
Jan 27 14:22:32 sogod [13317]: <0x0x555555d807a0[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Jan 27 14:22:32 sogod [13317]: <0x0x555555d807a0[SOGoCache]> Using host(s) 'localhost' as server(s)
Jan 27 14:22:32 sogod [13317]: <0x0x555555dc7e60[LDAPSource]> WARNING: using old bindFields format - please update it
2014-01-27 14:22:32.466 sogod[13317] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-01-27 14:22:32.467 sogod[13317] Note(SoObject): SoDebugKeyLookup is enabled!
2014-01-27 14:22:32.467 sogod[13317] Note(SoObject): SoDebugBaseURL is enabled!
2014-01-27 14:22:32.467 sogod[13317] Note(SoObject): relative base URLs are enabled.
2014-01-27 14:22:32.570 sogod[13317] Note: Using UTF-8 as URL encoding in NGExtensions.
2014-01-27 14:22:32.666 sogod[13317] Note(NGImap4Connection): using '/' as the IMAP4 folder separator.
Jan 27 14:22:32 sogod [13317]: <0x0x555555fa3b50[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-01-27 14:22:33.486 sogod[13317] Note: using 'UCS-2LE' on Linux.
Jan 27 14:22:35 sogod [13317]: [WARN] <0x0x55555f0c3ae0[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jan 27 14:22:35 sogod [13317]: [WARN] <0x0x55555f0c3ae0[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jan 27 14:22:35 sogod [13317]: [WARN] <0x0x55555f0c3ae0[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
EXCEPTION: <NSException: 0x55555f30b9e0> NAME:NSRangeException REASON:Index 0 is out of range 0 (in 'objectAtIndex:') INFO:{Array = (); Count = 0; Index = 0; }

Breakpoint 2, 0x00007ffff435fa10 in abort () from /lib/x86_64-linux-gnu/libc.so.6

(gdb) bt
#0 0x00007ffff435fa10 in abort () from /lib/x86_64-linux-gnu/libc.so.6
0000001 0x000055555555b4ec in -[SOGo handleException:inContext:] (self=0x555555ba0f50, _cmd=0x7ffff6db7790, _exc=0x55555f30b9e0, _ctx=0x555555dad9b0) at SOGo.m:400
0000002 0x00007ffff6a98a1f in -[WORequestHandler handleRequest:] (self=0x555555b042e0, _cmd=0x7ffff6d81d80, _request=0x555555d91a80) at WORequestHandler.m:264
0000003 0x00007ffff6a595e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555ba0f50, _cmd=0x7ffff6d81dd0, _request=0x555555d91a80, handler=0x555555b042e0) at WOCoreApplication.m:712
0000004 0x00007ffff6a598fe in -[WOCoreApplication dispatchRequest:] (self=0x555555ba0f50, _cmd=0x555555762da0, _request=0x555555d91a80) at WOCoreApplication.m:752
0000005 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555ba0f50, _cmd=0x7ffff6e19530, _request=0x555555d91a80) at SOGo.m:453
0000006 0x00007ffff6af6368 in -[WOHttpTransaction _run] (self=0x555555d736c0, _cmd=0x7ffff6e19560) at WOHttpTransaction.m:596
0000007 0x00007ffff6af66de in -[WOHttpTransaction run] (self=0x555555d736c0, _cmd=0x7ffff6e171b0) at WOHttpTransaction.m:649
0000008 0x00007ffff6af2277 in -[WOHttpAdaptor runConnection:] (self=0x555555d610f0, _cmd=0x7ffff6e17250, _socket=0x555555d6fd30) at WOHttpAdaptor.m:367
0000009 0x00007ffff6af2483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d610f0, _cmd=0x7ffff6e17260, _connection=0x555555d6fd30) at WOHttpAdaptor.m:401
0000010 0x00007ffff6af2884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d610f0, _cmd=0x7ffff6e17310, connection=0x555555d6fd30) at WOHttpAdaptor.m:460
0000011 0x00007ffff6af2cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d610f0, _cmd=0x7ffff6e17170, _notification=0x555555d6f0e0) at WOHttpAdaptor.m:521
0000012 0x00007ffff527448d in ?? () from /usr/lib/libgnustep-base.so.1.22
0000013 0x00007ffff5ecc953 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d69f50, _cmd=0x7ffff5796700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572e390) at NSRunLoop+FileObjects.m:58
0000014 0x00007ffff536ef62 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000015 0x00007ffff52bd170 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000016 0x00007ffff52bc250 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000017 0x00007ffff6a58e31 in -[WOCoreApplication run] (self=0x555555ba0f50, _cmd=0x555555762bc0) at WOCoreApplication.m:584
0000018 0x000055555555ae71 in -[SOGo run] (self=0x555555ba0f50, _cmd=0x7ffff6da3780) at SOGo.m:277
0000019 0x00007ffff6a8302a in WOApplicationMain (_appClassName=0x555555761120, argc=13, argv=0x7fffffffe5a8) at WOApplicationMain.m:42
0000020 0x00007ffff6aa3e95 in WOWatchDogApplicationMain (appName=0x555555761120, argc=13, argv=0x7fffffffe5a8) at WOWatchDogApplicationMain.m:1048
0000021 0x000055555555a145 in main (argc=13, argv=0x7fffffffe5a8, env=0x7fffffffe618) at sogod.m:53

(gdb) bt full
#0 0x00007ffff435fa10 in abort () from /lib/x86_64-linux-gnu/libc.so.6
No symbol table info available.
0000001 0x000055555555b4ec in -[SOGo handleException:inContext:] (self=0x555555ba0f50, _cmd=0x7ffff6db7790, _exc=0x55555f30b9e0, _ctx=0x555555dad9b0) at SOGo.m:400
No locals.
0000002 0x00007ffff6a98a1f in -[WORequestHandler handleRequest:] (self=0x555555b042e0, _cmd=0x7ffff6d81d80, _request=0x555555d91a80) at WORequestHandler.m:264
localException = 0x55555f30b9e0
startHandling = 0
app = 0x555555ba0f50
response = 0x0
context = 0x555555dad9b0
thread = 0x555555867d10
sessionId = 0x0
session = 0x0
uri = 0x555555d80c80
0000003 0x00007ffff6a595e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555ba0f50, _cmd=0x7ffff6d81dd0, _request=0x555555d91a80, handler=0x555555b042e0) at WOCoreApplication.m:712
startDispatch = 0
response = 0x0
startDispatch = 0
0000004 0x00007ffff6a598fe in -[WOCoreApplication dispatchRequest:] (self=0x555555ba0f50, _cmd=0x555555762da0, _request=0x555555d91a80) at WOCoreApplication.m:752
handler = 0x555555b042e0
0000005 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555ba0f50, _cmd=0x7ffff6e19530, _request=0x555555d91a80) at SOGo.m:453
runLoopModes = 0x0
debugOn = 0 '\000'
resp = 0x7fffffffd890
startDate = 0x555555d74c60
timeDelta = 6.9533480862213144e-310
objc_super = {self = 0x555555ba0f50, super_class = 0x7ffff6e297e0}
0000006 0x00007ffff6af6368 in -[WOHttpTransaction _run] (self=0x555555d736c0, _cmd=0x7ffff6e19560) at WOHttpTransaction.m:596
No locals.
0000007 0x00007ffff6af66de in -[WOHttpTransaction run] (self=0x555555d736c0, _cmd=0x7ffff6e171b0) at WOHttpTransaction.m:649
ok = 1 '\001'
0000008 0x00007ffff6af2277 in -[WOHttpAdaptor runConnection:] (self=0x555555d610f0, _cmd=0x7ffff6e17250, _socket=0x555555d6fd30) at WOHttpAdaptor.m:367
tx = 0x555555d736c0
0000009 0x00007ffff6af2483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d610f0, _cmd=0x7ffff6e17260, _connection=0x555555d6fd30) at WOHttpAdaptor.m:401
t = 4.6355709553818051e-310
0000010 0x00007ffff6af2884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d610f0, _cmd=0x7ffff6e17310, connection=0x555555d6fd30) at WOHttpAdaptor.m:460
No locals.
0000011 0x00007ffff6af2cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d610f0, _cmd=0x7ffff6e17170, _notification=0x555555d6f0e0) at WOHttpAdaptor.m:521
No locals.
0000012 0x00007ffff527448d in ?? () from /usr/lib/libgnustep-base.so.1.22
No symbol table info available.
0000013 0x00007ffff5ecc953 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d69f50, _cmd=0x7ffff5796700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572e390) at NSRunLoop+FileObjects.m:58
nc = 0x55555586b1e0
0000014 0x00007ffff536ef62 in ?? () from /usr/lib/libgnustep-base.so.1.22
No symbol table info available.
0000015 0x00007ffff52bd170 in ?? () from /usr/lib/libgnustep-base.so.1.22
No symbol table info available.
0000016 0x00007ffff52bc250 in ?? () from /usr/lib/libgnustep-base.so.1.22

I hope this will help.

Best regards,
Ludovic.

TagsNo tags attached.

Relationships

related to 0002609 closedludovic Exception when using ActiveSync with Android 4.4.2 (Email) 

Activities

ludovic

ludovic

2014-01-27 13:49

administrator   ~0006426

See http://www.sogo.nu/nc/support/faq/article/how-do-i-debug-sogo.html to generate a relevant trace.

Ludovic Hutin

Ludovic Hutin

2014-01-27 14:08

reporter   ~0006427

I follow this article...

I don't know what i can add ?

ludovic

ludovic

2014-01-27 14:33

administrator   ~0006428

You have to run with 1 child and set a breakpoint on raise.

Ludovic Hutin

Ludovic Hutin

2014-01-27 14:37

reporter   ~0006429

It's what i have done.

Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid

Make breakpoint pending on future shared library load? (y or [n]) y
Breakpoint 1 ([NSException raise]) pending.
(gdb) b abort
Breakpoint 2 at 0x7ffff435fa10
(gdb) c

ludovic

ludovic

2014-01-27 14:42

administrator   ~0006430

Ok, so now, get the exception!

Ludovic Hutin

Ludovic Hutin

2014-01-27 14:48

reporter   ~0006431

Have you seen the description of this ticket, it's what i have done...

first block is sogo.log

and after it's the GDB backtrace

with resultat of bt command and bt full

ludovic

ludovic

2014-01-27 15:43

administrator   ~0006432

The exception got trapped by the normal exception handler, which is "useless" in this case. We need the exception trace when it's raised.

Do:

gdb ...
r
CONTROL-C
b raise
c

Then get the exception + trace. Setting breakpoints for 'future use' in gdb is troublesome.

Ludovic Hutin

Ludovic Hutin

2014-01-27 15:50

reporter   ~0006433

sogo@sogo-be-test:~$ gdb --args /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Ubuntu/Linaro 7.4-2012.04-0ubuntu2.1) 7.4-2012.04
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
For bug reporting instructions, please see:
<http://bugs.launchpad.net/gdb-linaro/>...
Reading symbols from /usr/local/sbin/sogod...done.
(gdb) run
Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
^CStopped due to shared library event
Quit
(gdb) b raise
Breakpoint 1 at 0x7ffff4e2ab50 (2 locations)
(gdb) c
Continuing.
Jan 27 16:48:44 sogod [21338]: version 2.1.2 (build root@sogo-be-test.u-strasbg.fr 201401250249) -- starting
Jan 27 16:48:44 sogod [21338]: vmem size check enabled: shutting down app when vmem > 512 MB
Jan 27 16:48:44 sogod [21338]: <0x0x555555a57f90[SOGoProductLoader]> SOGo products loaded from '/usr/local/lib/GNUstep/SOGo':
Jan 27 16:48:44 sogod [21338]: <0x0x555555a57f90[SOGoProductLoader]> ContactsUI.SOGo, PreferencesUI.SOGo, SchedulerUI.SOGo, Mailer.SOGo, CommonUI.SOGo, Contacts.SOGo, MailPartViewers.SOGo, MainUI.SOGo, Appointments.SOGo, MailerUI.SOGo, ActiveSync.SOGo, AdministrationUI.SOGo
Jan 27 16:48:45 sogod [21338]: |SOGo| WOHttpAdaptor listening on address *:20000
Jan 27 16:48:45 sogod [21338]: <0x0x555555d7f070[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Jan 27 16:48:45 sogod [21338]: <0x0x555555d7f070[SOGoCache]> Using host(s) 'localhost' as server(s)
Jan 27 16:48:45 sogod [21338]: <0x0x555555dc6160[LDAPSource]> WARNING: using old bindFields format - please update it
2014-01-27 16:48:45.961 sogod[21338] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-01-27 16:48:45.962 sogod[21338] Note(SoObject): SoDebugKeyLookup is enabled!
2014-01-27 16:48:45.962 sogod[21338] Note(SoObject): SoDebugBaseURL is enabled!
2014-01-27 16:48:45.962 sogod[21338] Note(SoObject): relative base URLs are enabled.
::ffff:130.79.203.84 - - [27/Jan/2014:16:48:46 GMT] "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=Ping&User=ludovic.hutin&DeviceId=67CDCA842C634CE888551474F04DB222&DeviceType=WindowsOutlook15 HTTP/1.0" 200 13/4213 0.047 - - 1M
2014-01-27 16:48:46.043 sogod[21338] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-01-27 16:48:46.063 sogod[21338] Note: Using UTF-8 as URL encoding in NGExtensions.
2014-01-27 16:48:46.156 sogod[21338] Note(NGImap4Connection): using '/' as the IMAP4 folder separator.
Jan 27 16:48:46 sogod [21338]: <0x0x555555ee3920[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-01-27 16:48:46.657 sogod[21338] Note: using 'UCS-2LE' on Linux.
Jan 27 16:48:47 sogod [21338]: [WARN] <0x0x5555560b7510[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jan 27 16:48:47 sogod [21338]: [WARN] <0x0x5555560b7510[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jan 27 16:48:47 sogod [21338]: [WARN] <0x0x5555560b7510[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
EXCEPTION: <NSException: 0x555556596630> NAME:NSRangeException REASON:Index 0 is out of range 0 (in 'objectAtIndex:') INFO:{Array = (); Count = 0; Index = 0; }

Breakpoint 1, 0x00007ffff435c3f0 in raise () from /lib/x86_64-linux-gnu/libc.so.6
(gdb) bt
#0 0x00007ffff435c3f0 in raise () from /lib/x86_64-linux-gnu/libc.so.6
0000001 0x00007ffff435fb8b in abort () from /lib/x86_64-linux-gnu/libc.so.6
0000002 0x000055555555b4ec in -[SOGo handleException:inContext:] (self=0x555555ba0e40, _cmd=0x7ffff6db7790, _exc=0x555556596630, _ctx=0x555555d97810) at SOGo.m:400
0000003 0x00007ffff6a98a1f in -[WORequestHandler handleRequest:] (self=0x555555b31ba0, _cmd=0x7ffff6d81d80, _request=0x555555de9ed0) at WORequestHandler.m:264
0000004 0x00007ffff6a595e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555ba0e40, _cmd=0x7ffff6d81dd0, _request=0x555555de9ed0, handler=0x555555b31ba0) at WOCoreApplication.m:712
0000005 0x00007ffff6a598fe in -[WOCoreApplication dispatchRequest:] (self=0x555555ba0e40, _cmd=0x555555762da0, _request=0x555555de9ed0) at WOCoreApplication.m:752
0000006 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555ba0e40, _cmd=0x7ffff6e19530, _request=0x555555de9ed0) at SOGo.m:453
0000007 0x00007ffff6af6368 in -[WOHttpTransaction _run] (self=0x555555d9f3d0, _cmd=0x7ffff6e19560) at WOHttpTransaction.m:596
0000008 0x00007ffff6af66de in -[WOHttpTransaction run] (self=0x555555d9f3d0, _cmd=0x7ffff6e171b0) at WOHttpTransaction.m:649
0000009 0x00007ffff6af2277 in -[WOHttpAdaptor runConnection:] (self=0x555555d60f80, _cmd=0x7ffff6e17250, _socket=0x555555d74af0) at WOHttpAdaptor.m:367
0000010 0x00007ffff6af2483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d60f80, _cmd=0x7ffff6e17260, _connection=0x555555d74af0) at WOHttpAdaptor.m:401
0000011 0x00007ffff6af2884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d60f80, _cmd=0x7ffff6e17310, connection=0x555555d74af0) at WOHttpAdaptor.m:460
0000012 0x00007ffff6af2cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d60f80, _cmd=0x7ffff6e17170, _notification=0x555555d91c40) at WOHttpAdaptor.m:521
0000013 0x00007ffff527448d in ?? () from /usr/lib/libgnustep-base.so.1.22
0000014 0x00007ffff5ecc953 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d69de0, _cmd=0x7ffff5796700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572e390) at NSRunLoop+FileObjects.m:58
0000015 0x00007ffff536ef62 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000016 0x00007ffff52bd170 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000017 0x00007ffff52bc250 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000018 0x00007ffff6a58e31 in -[WOCoreApplication run] (self=0x555555ba0e40, _cmd=0x555555762bc0) at WOCoreApplication.m:584
0000019 0x000055555555ae71 in -[SOGo run] (self=0x555555ba0e40, _cmd=0x7ffff6da3780) at SOGo.m:277
0000020 0x00007ffff6a8302a in WOApplicationMain (_appClassName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOApplicationMain.m:42
0000021 0x00007ffff6aa3e95 in WOWatchDogApplicationMain (appName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOWatchDogApplicationMain.m:1048
0000022 0x000055555555a145 in main (argc=13, argv=0x7fffffffe5c8, env=0x7fffffffe638) at sogod.m:53

ludovic

ludovic

2014-01-27 16:32

administrator   ~0006434

Should be fixed with that commit:

https://github.com/inverse-inc/sogo/commit/3b7a3c94d429d74e6a027b93dadf19664191f811

Ludovic Hutin

Ludovic Hutin

2014-01-28 07:46

reporter   ~0006441

We just upgrade and the error still there.
Nothing change :-(

Ludovic Hutin

Ludovic Hutin

2014-01-28 07:48

reporter   ~0006442

sogo@sogo-be-test:/root$ gdb --args /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Ubuntu/Linaro 7.4-2012.04-0ubuntu2.1) 7.4-2012.04
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
For bug reporting instructions, please see:
<http://bugs.launchpad.net/gdb-linaro/>...
Reading symbols from /usr/local/sbin/sogod...done.
(gdb) run
Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
^C
Program received signal SIGINT, Interrupt.
0x00007ffff4c05e9c in __objc_resolve_class_links () from /usr/lib/x86_64-linux-gnu/libobjc.so.3
(gdb) b raise
Breakpoint 1 at 0x7ffff4e2ab50 (2 locations)
(gdb) c
Continuing.
Jan 28 08:44:51 sogod [6451]: version 2.1.2 (build root@sogo-be-test.u-strasbg.fr 201401271803) -- starting
Jan 28 08:44:51 sogod [6451]: vmem size check enabled: shutting down app when vmem > 512 MB
Jan 28 08:44:51 sogod [6451]: <0x0x555555a57f90[SOGoProductLoader]> SOGo products loaded from '/usr/local/lib/GNUstep/SOGo':
Jan 28 08:44:51 sogod [6451]: <0x0x555555a57f90[SOGoProductLoader]> ContactsUI.SOGo, PreferencesUI.SOGo, SchedulerUI.SOGo, Mailer.SOGo, CommonUI.SOGo, Contacts.SOGo, MailPartViewers.SOGo, MainUI.SOGo, Appointments.SOGo, MailerUI.SOGo, ActiveSync.SGo, AdministrationUI.SOGo
Jan 28 08:44:52 sogod [6451]: |SOGo| WOHttpAdaptor listening on address *:20000
Jan 28 08:45:02 sogod [6451]: <0x0x555555d7f080[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Jan 28 08:45:02 sogod [6451]: <0x0x555555d7f080[SOGoCache]> Using host(s) 'localhost' as server(s)
Jan 28 08:45:02 sogod [6451]: <0x0x555555dc2f90[LDAPSource]> WARNING: using old bindFields format - please update it
2014-01-28 08:45:02.761 sogod[6451] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-01-28 08:45:02.762 sogod[6451] Note(SoObject): SoDebugKeyLookup is enabled!
2014-01-28 08:45:02.762 sogod[6451] Note(SoObject): SoDebugBaseURL is enabled!
2014-01-28 08:45:02.762 sogod[6451] Note(SoObject): relative base URLs are enabled.
::ffff:130.79.203.84 - - [28/Jan/2014:08:45:02 GMT] "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.0" 200 0/0 0.059 - - 708K
2014-01-28 08:45:03.005 sogod[6451] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [28/Jan/2014:08:45:03 GMT] "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=ludovic.hutin&DeviceId=67CDCA842C634CE888551474F04DB222&DeviceType=WindowsOutlook15 HTTP/1.0" 200 19/13 0.017 - - 792K
2014-01-28 08:45:03.127 sogod[6451] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-01-28 08:45:03.152 sogod[6451] Note: Using UTF-8 as URL encoding in NGExtensions.
2014-01-28 08:45:03.272 sogod[6451] Note(NGImap4Connection): using '/' as the IMAP4 folder separator.
Jan 28 08:45:03 sogod [6451]: <0x0x555555ef7f40[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-01-28 08:45:03.804 sogod[6451] Note: using 'UCS-2LE' on Linux.
Jan 28 08:45:10 sogod [6451]: [WARN] <0x0x555556b8a630[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jan 28 08:45:10 sogod [6451]: [WARN] <0x0x555556b8a630[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jan 28 08:45:10 sogod [6451]: [WARN] <0x0x555556b8a630[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
EXCEPTION: <NSException: 0x555556f4ef50> NAME:NSRangeException REASON:Index 0 is out of range 0 (in 'objectAtIndex:') INFO:{Array = (); Count = 0; Index = 0; }

Breakpoint 1, 0x00007ffff435c3f0 in raise () from /lib/x86_64-linux-gnu/libc.so.6
(gdb) bt
#0 0x00007ffff435c3f0 in raise () from /lib/x86_64-linux-gnu/libc.so.6
0000001 0x00007ffff435fb8b in abort () from /lib/x86_64-linux-gnu/libc.so.6
0000002 0x000055555555b4ec in -[SOGo handleException:inContext:] (self=0x555555ba0e50, _cmd=0x7ffff6db7790, _exc=0x555556f4ef50, _ctx=0x555555da02d0) at SOGo.m:400
0000003 0x00007ffff6a98a1f in -[WORequestHandler handleRequest:] (self=0x555555b31ba0, _cmd=0x7ffff6d81d80, _request=0x555555dd9880) at WORequestHandler.m:264
0000004 0x00007ffff6a595e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555ba0e50, _cmd=0x7ffff6d81dd0, _request=0x555555dd9880, handler=0x555555b31ba0) at WOCoreApplication.m:712
0000005 0x00007ffff6a598fe in -[WOCoreApplication dispatchRequest:] (self=0x555555ba0e50, _cmd=0x555555762da0, _request=0x555555dd9880) at WOCoreApplication.m:752
0000006 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555ba0e50, _cmd=0x7ffff6e19530, _request=0x555555dd9880) at SOGo.m:453
0000007 0x00007ffff6af6368 in -[WOHttpTransaction _run] (self=0x555555dc3390, _cmd=0x7ffff6e19560) at WOHttpTransaction.m:596
0000008 0x00007ffff6af66de in -[WOHttpTransaction run] (self=0x555555dc3390, _cmd=0x7ffff6e171b0) at WOHttpTransaction.m:649
0000009 0x00007ffff6af2277 in -[WOHttpAdaptor runConnection:] (self=0x555555d60f90, _cmd=0x7ffff6e17250, _socket=0x555555decb40) at WOHttpAdaptor.m:367
0000010 0x00007ffff6af2483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d60f90, _cmd=0x7ffff6e17260, _connection=0x555555decb40) at WOHttpAdaptor.m:401
0000011 0x00007ffff6af2884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d60f90, _cmd=0x7ffff6e17310, connection=0x555555decb40) at WOHttpAdaptor.m:460
0000012 0x00007ffff6af2cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d60f90, _cmd=0x7ffff6e17170, _notification=0x555555d86d50) at WOHttpAdaptor.m:521
0000013 0x00007ffff527448d in ?? () from /usr/lib/libgnustep-base.so.1.22
0000014 0x00007ffff5ecc953 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d69df0, _cmd=0x7ffff5796700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572e390) at NSRunLoop+FileObjects.m:58
0000015 0x00007ffff536ef62 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000016 0x00007ffff52bd170 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000017 0x00007ffff52bc250 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000018 0x00007ffff6a58e31 in -[WOCoreApplication run] (self=0x555555ba0e50, _cmd=0x555555762bc0) at WOCoreApplication.m:584
0000019 0x000055555555ae71 in -[SOGo run] (self=0x555555ba0e50, _cmd=0x7ffff6da3780) at SOGo.m:277
0000020 0x00007ffff6a8302a in WOApplicationMain (_appClassName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOApplicationMain.m:42
0000021 0x00007ffff6aa3e95 in WOWatchDogApplicationMain (appName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOWatchDogApplicationMain.m:1048
0000022 0x000055555555a145 in main (argc=13, argv=0x7fffffffe5c8, env=0x7fffffffe638) at sogod.m:53

Ludovic Hutin

Ludovic Hutin

2014-01-28 12:49

reporter   ~0006445

With a step by step GDB

748 if (!first_sync)
(gdb)
753 s = [NSMutableString string];
(gdb)
754 processed = NO;
(gdb)
760 processed: &processed];
(gdb)
762 if (processed)
(gdb)
765 [theBuffer appendString: s];
(gdb)
768 [theBuffer appendString: @"</Collection>"];
(gdb)
769 }
(gdb)
-[SOGoActiveSyncDispatcher(Sync) processSync:inResponse:] (self=0x555555da20a0, _cmd=0x555555bc7b90, theDocumentElement=0x555555e01760, theResponse=0x555555ab0360) at SOGoActiveSyncDispatcher+Sync.m:885
885 for (i = 0; i < [allCollections count]; i++)
(gdb)
887 aCollection = [allCollections objectAtIndex: i];
(gdb)
889 [self processSyncCollection: aCollection inBuffer: s];
(gdb)
Jan 28 13:46:32 sogod [15045]: [WARN] <0x0x5555560e0730[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jan 28 13:46:32 sogod [15045]: [WARN] <0x0x5555560e0730[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jan 28 13:46:32 sogod [15045]: [WARN] <0x0x5555560e0730[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
885 for (i = 0; i < [allCollections count]; i++)
(gdb)
887 aCollection = [allCollections objectAtIndex: i];
(gdb)
889 [self processSyncCollection: aCollection inBuffer: s];
(gdb)
EXCEPTION: <NSException: 0x55555663a8f0> NAME:NSRangeException REASON:Index 0 is out of range 0 (in 'objectAtIndex:') INFO:{Array = (); Count = 0; Index = 0; }

Program received signal SIGABRT, Aborted.
0x00007ffff435c425 in raise () from /lib/x86_64-linux-gnu/libc.so.6
(gdb)
Single stepping until exit from function raise,
which has no line number information.

Program terminated with signal SIGABRT, Aborted.
The program no longer exists.
(gdb)
The program is not being run.
(gdb)
The program is not being run.
(gdb)
The program is not being run.
(gdb)
The program is not being run.
(gdb)

Ligne 889 in the sogo/ActiveSync//SOGoActiveSyncDispatcher+Sync.m

I think it's better for debugging :-)

ludovic

ludovic

2014-01-28 13:27

administrator   ~0006448

It's not at line 889 that it crashes, but in the function itself (or an other callee).

As I said before, RUN sogo BEFORE setting the breakpoint.

You launch the app and you hit Control-C immediately. Run the app for a few seconds (like hit a webpage or two from the SOGo web GUI) before setting it.

Ludovic Hutin

Ludovic Hutin

2014-01-29 08:08

reporter   ~0006451

With le nightbuild the problem disppear.
But other one appear

sogo@sogo-be-test:~$ gdb --args /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Ubuntu/Linaro 7.4-2012.04-0ubuntu2.1) 7.4-2012.04
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
For bug reporting instructions, please see:
<http://bugs.launchpad.net/gdb-linaro/>...
Reading symbols from /usr/local/sbin/sogod...done.
(gdb) run
Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Jan 29 09:03:41 sogod [4989]: version 2.1.2 (build root@sogo-be-test.u-strasbg.fr 201401282239) -- starting
Jan 29 09:03:41 sogod [4989]: vmem size check enabled: shutting down app when vmem > 512 MB
Jan 29 09:03:41 sogod [4989]: <0x0x555555a58140[SOGoProductLoader]> SOGo products loaded from '/usr/local/lib/GNUstep/SOGo':
Jan 29 09:03:41 sogod [4989]: <0x0x555555a58140[SOGoProductLoader]> ContactsUI.SOGo, PreferencesUI.SOGo, SchedulerUI.SOGo, Mailer.SOGo, CommonUI.SOGo, Contacts.SOGo, MailPartViewers.SOGo, MainUI.SOGo, Appointments.SOGo, MailerUI.SOGo, ActiveSync.SOGo, AdministrationUI.SOGo
Jan 29 09:03:41 sogod [4989]: |SOGo| WOHttpAdaptor listening on address *:20000
Jan 29 09:03:45 sogod [4989]: <0x0x555555d9b780[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Jan 29 09:03:45 sogod [4989]: <0x0x555555d9b780[SOGoCache]> Using host(s) 'localhost' as server(s)
2014-01-29 09:03:45.057 sogod[4989] Note(SoObject): SoDebugKeyLookup is enabled!
2014-01-29 09:03:45.057 sogod[4989] Note(SoObject): SoDebugBaseURL is enabled!
2014-01-29 09:03:45.057 sogod[4989] Note(SoObject): relative base URLs are enabled.
2014-01-29 09:03:45.079 sogod[4989] ERROR(-[NGBundleManager bundleWithPath:]): could not create bundle for path: '/usr/share/GNUstep/Libraries/gnustep-base/Versions/1.22/Resources/SSL.bundle'
2014-01-29 09:03:45.116 sogod[4989] WOxElemBuilder: could not locate builders: WOxExtElemBuilder,WOxExtElemBuilder
2014-01-29 09:03:45.117 sogod[4989] WOCompoundElement: pool embedding is on.
2014-01-29 09:03:45.117 sogod[4989] WOCompoundElement: id logging is on.
2001:660:2402:12:fe:: - - [29/Jan/2014:09:03:45 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.067 - - 1M
2001:660:2402:12:fd:: - - [29/Jan/2014:09:03:50 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 12K
2014-01-29 09:03:53.297 sogod[4989] Note: Using UTF-8 as URL encoding in NGExtensions.
Jan 29 09:03:53 sogod [4989]: <0x0x555555dd7970[LDAPSource]> WARNING: using old bindFields format - please update it
2014-01-29 09:03:53.320 sogod[4989] WARNING(-[NSNull(misc) count]): called NSNull -count (returns 0) !!!
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:03:53 GMT] "GET /SOGo/ HTTP/1.0" 200 4579/0 0.044 12754 64% 1M
^C
Program received signal SIGINT, Interrupt.
0x00007ffff440da08 in poll () from /lib/x86_64-linux-gnu/libc.so.6
(gdb) b raise
Breakpoint 1 at 0x7ffff4e29b50 (2 locations)
(gdb) c
Continuing.
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:04:15 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.002 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:04:20 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:04:15 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.002 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:04:20 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:04:45 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:04:50 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:05:15 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:05:20 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:05:45 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.002 - - 0
XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:05:50 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.002 - - 0

Then i start outlook 2013

2014-01-29 09:06:11.336 sogod[4989] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:06:11 GMT] "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.0" 200 0/0 0.100 - - 324K
2014-01-29 09:06:11.378 sogod[4989] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:XXXXXXXXXXXXXXXXX - - [29/Jan/2014:09:06:11 GMT] "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=usertest&DeviceId=58CF61ED8E6E4E5C8D85DF73287F752F&DeviceType=WindowsOutlook15 HTTP/1.0" 200 19/13 0.022 - - 0
2014-01-29 09:06:11.496 sogod[4989] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-01-29 09:06:12.602 sogod[4989] Note(NGImap4Connection): using '/' as the IMAP4 folder separator.
Jan 29 09:06:12 sogod [4989]: <0x0x555555e1bb10[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-01-29 09:06:13.343 sogod[4989] Note: using 'UCS-2LE' on Linux.
Jan 29 09:06:14 sogod [4989]: [WARN] <0x0x5555560a0d90[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Jan 29 09:06:14 sogod [4989]: [WARN] <0x0x5555560a0d90[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Jan 29 09:06:14 sogod [4989]: [WARN] <0x0x5555560a0d90[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table

Program received signal SIGSEGV, Segmentation fault.
0x00007fffea19a1e7 in -[iCalRecurrenceRule(ActiveSync) activeSyncRepresentation] (self=0x555556be2800, _cmd=0x7fffea3ae1b0) at iCalRecurrenceRule+ActiveSync.m:82
82 if (occurrences[i])

(gdb) bt
#0 0x00007fffea19a1e7 in -[iCalRecurrenceRule(ActiveSync) activeSyncRepresentation] (self=0x555556be2800, _cmd=0x7fffea3ae1b0) at iCalRecurrenceRule+ActiveSync.m:82
0000001 0x00007fffea199515 in -[iCalEvent(ActiveSync) activeSyncRepresentation] (self=0x555556bdb740, _cmd=0x7fffea3b6ba0) at iCalEvent+ActiveSync.m:180
0000002 0x00007fffea1a5d47 in -[SOGoActiveSyncDispatcher(Sync) processSyncGetChanges:inCollection:withSyncKey:withFolderType:withFilterType:inBuffer:] (self=0x555555fa2400, _cmd=0x7fffea3b6d30, theDocumentElement=0x555555ef9f00,
theCollection=0x5555560eabe0, theSyncKey=0x5555560a4960, theFolderType=ActiveSyncEventFolder, theFilterType=0x0, theBuffer=0x555556098ee0) at SOGoActiveSyncDispatcher+Sync.m:531
0000003 0x00007fffea1a6b80 in -[SOGoActiveSyncDispatcher(Sync) processSyncCollection:inBuffer:] (self=0x555555fa2400, _cmd=0x7fffea3b6d50, theDocumentElement=0x555555ef9f00, theBuffer=0x555555f1d660) at SOGoActiveSyncDispatcher+Sync.m:731
0000004 0x00007fffea1a7061 in -[SOGoActiveSyncDispatcher(Sync) processSync:inResponse:] (self=0x555555fa2400, _cmd=0x55555600c8e0, theDocumentElement=0x555555dd3980, theResponse=0x555555fc6370) at SOGoActiveSyncDispatcher+Sync.m:902
0000005 0x00007fffea1a4648 in -[SOGoActiveSyncDispatcher dispatchRequest:inResponse:context:] (self=0x555555fa2400, _cmd=0x7fffeb06b2a0, theRequest=0x555555e0c110, theResponse=0x555555fc6370, theContext=0x555555f2d920)
at SOGoActiveSyncDispatcher.m:1349
0000006 0x00007fffeae652e7 in -[SOGoMicrosoftActiveSyncActions microsoftServerActiveSyncAction] (self=0x555555e8fa40, _cmd=0x55555600c900) at SOGoMicrosoftActiveSyncActions.m:55
0000007 0x00007ffff6a85c64 in -[WODirectAction performActionNamed:] (self=0x555555e8fa40, _cmd=0x7ffff6e31b00, _actionName=0x555555ef1b70) at WODirectAction.m:97
0000008 0x00007ffff6b07959 in -[SoActionInvocation callOnObject:withPositionalParametersWhenNotNil:inContext:] (self=0x555555f590a0, _cmd=<optimized out>, _client=0x555555ba0fc0, _positionalArgs=0x0, _ctx=0x555555f2d920)
at SoActionInvocation.m:300
0000009 0x00007ffff6b02f00 in -[SoObjectMethodDispatcher dispatchInContext:] (self=0x555555ee9510, _cmd=<optimized out>, _ctx=0x555555f2d920) at SoObjectMethodDispatcher.m:191
0000010 0x00007ffff6b053f8 in -[SoObjectRequestHandler handleRequest:inContext:session:application:] (self=0x555555a79940, _cmd=<optimized out>, _rq=<optimized out>, _ctx=0x555555f2d920, _sn=<optimized out>, app=<optimized out>)
at SoObjectRequestHandler.m:584
0000011 0x00007ffff6a974fa in -[WORequestHandler handleRequest:] (self=0x555555a79940, _cmd=0x7ffff6d80d80, _request=0x555555e0c110) at WORequestHandler.m:237
0000012 0x00007ffff6a585e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555ba0fc0, _cmd=0x7ffff6d80dd0, _request=0x555555e0c110, handler=0x555555a79940) at WOCoreApplication.m:712
0000013 0x00007ffff6a588fe in -[WOCoreApplication dispatchRequest:] (self=0x555555ba0fc0, _cmd=0x555555762da0, _request=0x555555e0c110) at WOCoreApplication.m:752
0000014 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555ba0fc0, _cmd=0x7ffff6e18530, _request=0x555555e0c110) at SOGo.m:453
0000015 0x00007ffff6af5368 in -[WOHttpTransaction _run] (self=0x555555f86d80, _cmd=0x7ffff6e18560) at WOHttpTransaction.m:596
0000016 0x00007ffff6af56de in -[WOHttpTransaction run] (self=0x555555f86d80, _cmd=0x7ffff6e161b0) at WOHttpTransaction.m:649
0000017 0x00007ffff6af1277 in -[WOHttpAdaptor runConnection:] (self=0x555555d60ce0, _cmd=0x7ffff6e16250, _socket=0x555555f39f50) at WOHttpAdaptor.m:367
0000018 0x00007ffff6af1483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d60ce0, _cmd=0x7ffff6e16260, _connection=0x555555f39f50) at WOHttpAdaptor.m:401
0000019 0x00007ffff6af1884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d60ce0, _cmd=0x7ffff6e16310, connection=0x555555f39f50) at WOHttpAdaptor.m:460
0000020 0x00007ffff6af1cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d60ce0, _cmd=0x7ffff6e16170, _notification=0x555555f390f0) at WOHttpAdaptor.m:521
0000021 0x00007ffff527348d in ?? () from /usr/lib/libgnustep-base.so.1.22
0000022 0x00007ffff5ecb953 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d69b40, _cmd=0x7ffff5795700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572d390) at NSRunLoop+FileObjects.m:58
0000023 0x00007ffff536df62 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000024 0x00007ffff52bc170 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000025 0x00007ffff52bb250 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000026 0x00007ffff6a57e31 in -[WOCoreApplication run] (self=0x555555ba0fc0, _cmd=0x555555762bc0) at WOCoreApplication.m:584
0000027 0x000055555555ae71 in -[SOGo run] (self=0x555555ba0fc0, _cmd=0x7ffff6da2780) at SOGo.m:277
0000028 0x00007ffff6a8202a in WOApplicationMain (_appClassName=0x555555761120, argc=13, argv=0x7fffffffe598) at WOApplicationMain.m:42
0000029 0x00007ffff6aa2e95 in WOWatchDogApplicationMain (appName=0x555555761120, argc=13, argv=0x7fffffffe598) at WOWatchDogApplicationMain.m:1048
0000030 0x000055555555a145 in main (argc=13, argv=0x7fffffffe598, env=0x7fffffffe608) at sogod.m:53

ludovic

ludovic

2014-01-29 14:50

administrator   ~0006453

I've pushed a fix: https://github.com/inverse-inc/sogo/commit/f2d5a7691115390c5f0ead5b8276c248504fb7e8

ludovic

ludovic

2014-02-04 00:02

administrator   ~0006475

Any updates?

Ludovic Hutin

Ludovic Hutin

2014-02-04 07:39

reporter   ~0006478

sogo@sogo-be-test:~$ gdb --args /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Ubuntu/Linaro 7.4-2012.04-0ubuntu2.1) 7.4-2012.04
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
For bug reporting instructions, please see:
<http://bugs.launchpad.net/gdb-linaro/>...
Reading symbols from /usr/local/sbin/sogod...done.
(gdb) run
Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Feb 04 08:36:01 sogod [869]: version 2.1.2 (build root@sogo-be-test.u-strasbg.fr 201402040830) -- starting
Feb 04 08:36:01 sogod [869]: vmem size check enabled: shutting down app when vmem > 512 MB
Feb 04 08:36:01 sogod [869]: <0x0x555555a58140[SOGoProductLoader]> SOGo products loaded from '/usr/local/lib/GNUstep/SOGo':
Feb 04 08:36:01 sogod [869]: <0x0x555555a58140[SOGoProductLoader]> ContactsUI.SOGo, PreferencesUI.SOGo, SchedulerUI.SOGo, Mailer.SOGo, CommonUI.SOGo, Contacts.SOGo, MailPartViewers.SOGo, MainUI.SOGo, Appointments.SOGo, MailerUI.SOGo, ActiveSync.SOGo, AdministrationUI.SOGo
Feb 04 08:36:02 sogod [869]: |SOGo| WOHttpAdaptor listening on address *:20000
^C
Program received signal SIGINT, Interrupt.
0x00007ffff440da08 in poll () from /lib/x86_64-linux-gnu/libc.so.6
(gdb) b raise
Breakpoint 1 at 0x7ffff4e29b50 (2 locations)
(gdb) c
Continuing.
Feb 04 08:36:13 sogod [869]: <0x0x555555d9be10[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Feb 04 08:36:13 sogod [869]: <0x0x555555d9be10[SOGoCache]> Using host(s) 'localhost' as server(s)
2014-02-04 08:36:13.040 sogod[869] Note(SoObject): SoDebugKeyLookup is enabled!
2014-02-04 08:36:13.040 sogod[869] Note(SoObject): SoDebugBaseURL is enabled!
2014-02-04 08:36:13.040 sogod[869] Note(SoObject): relative base URLs are enabled.
2014-02-04 08:36:13.089 sogod[869] ERROR(-[NGBundleManager bundleWithPath:]): could not create bundle for path: '/usr/share/GNUstep/Libraries/gnustep-base/Versions/1.22/Resources/SSL.bundle'
2014-02-04 08:36:13.210 sogod[869] WOxElemBuilder: could not locate builders: WOxExtElemBuilder,WOxExtElemBuilder
2014-02-04 08:36:13.211 sogod[869] WOCompoundElement: pool embedding is on.
2014-02-04 08:36:13.211 sogod[869] WOCompoundElement: id logging is on.
2001:660:2402:12:fe:: - - [04/Feb/2014:08:36:13 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.176 - - 1M
2014-02-04 08:36:13.215 sogod[869] Note: Using UTF-8 as URL encoding in NGExtensions.
Feb 04 08:36:13 sogod [869]: <0x0x555555dd4fe0[LDAPSource]> WARNING: using old bindFields format - please update it
2014-02-04 08:36:13.237 sogod[869] WARNING(-[NSNull(misc) count]): called NSNull -count (returns 0) !!!
::ffff:130.79.203.84 - - [04/Feb/2014:08:36:13 GMT] "GET /SOGo/ HTTP/1.0" 200 4565/0 0.042 12754 64% 1M
2001:660:2402:12:fd:: - - [04/Feb/2014:08:36:13 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
2001:660:2402:12:fe:: - - [04/Feb/2014:08:36:43 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
2001:660:2402:12:fd:: - - [04/Feb/2014:08:36:43 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
2001:660:2402:12:fe:: - - [04/Feb/2014:08:37:13 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.002 - - 0
2001:660:2402:12:fd:: - - [04/Feb/2014:08:37:13 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.002 - - 0
2001:660:2402:12:fe:: - - [04/Feb/2014:08:37:43 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
2001:660:2402:12:fd:: - - [04/Feb/2014:08:37:43 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
2014-02-04 08:38:07.568 sogod[869] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [04/Feb/2014:08:38:07 GMT] "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.0" 200 0/0 0.089 - - 324K
2014-02-04 08:38:07.650 sogod[869] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [04/Feb/2014:08:38:07 GMT] "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=ludovic.hutin&DeviceId=21011EE7BA624DC09F708A8020B4877A&DeviceType=WindowsOutlook15 HTTP/1.0" 200 19/13 0.018 - - 0
2014-02-04 08:38:08.531 sogod[869] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-02-04 08:38:08.635 sogod[869] Note(NGImap4Connection): using '/' as the IMAP4 folder separator.
Feb 04 08:38:08 sogod [869]: <0x0x555555e91430[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-02-04 08:38:09.426 sogod[869] Note: using 'UCS-2LE' on Linux.
2014-02-04 08:38:10.774 sogod[869] parseTimeZone: cannot parse time notation 'GMT'
Feb 04 08:38:11 sogod [869]: [WARN] <0x0x555556391010[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Feb 04 08:38:11 sogod [869]: [WARN] <0x0x555556391010[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Feb 04 08:38:11 sogod [869]: [WARN] <0x0x555556391010[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
Feb 04 08:38:14 sogod [869]: <0x0x555555e91430[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-02-04 08:38:22.446 sogod[869] parseTimeZone: cannot parse time notation 'GMT'
2014-02-04 08:38:27.565 sogod[869] parseTimeZone: cannot parse time notation 'GMT'
EXCEPTION: <SaxParseException: 0x55556be1e090> NAME:SaxIOException REASON:Could not convert input to string! INFO:(null)

Breakpoint 1, 0x00007ffff435b3f0 in raise () from /lib/x86_64-linux-gnu/libc.so.6

(gdb) bt
#0 0x00007ffff435b3f0 in raise () from /lib/x86_64-linux-gnu/libc.so.6
0000001 0x00007ffff435eb8b in abort () from /lib/x86_64-linux-gnu/libc.so.6
0000002 0x000055555555b4ec in -[SOGo handleException:inContext:] (self=0x555555ba0fc0, _cmd=0x7ffff6db6790, _exc=0x55556be1e090, _ctx=0x555555f90b10) at SOGo.m:400
0000003 0x00007ffff6a97a1f in -[WORequestHandler handleRequest:] (self=0x555555c5e250, _cmd=0x7ffff6d80d80, _request=0x555555f39a00) at WORequestHandler.m:264
0000004 0x00007ffff6a585e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555ba0fc0, _cmd=0x7ffff6d80dd0, _request=0x555555f39a00, handler=0x555555c5e250) at WOCoreApplication.m:712
0000005 0x00007ffff6a588fe in -[WOCoreApplication dispatchRequest:] (self=0x555555ba0fc0, _cmd=0x555555762da0, _request=0x555555f39a00) at WOCoreApplication.m:752
0000006 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555ba0fc0, _cmd=0x7ffff6e18530, _request=0x555555f39a00) at SOGo.m:453
0000007 0x00007ffff6af5368 in -[WOHttpTransaction _run] (self=0x555555f87cd0, _cmd=0x7ffff6e18560) at WOHttpTransaction.m:596
0000008 0x00007ffff6af56de in -[WOHttpTransaction run] (self=0x555555f87cd0, _cmd=0x7ffff6e161b0) at WOHttpTransaction.m:649
0000009 0x00007ffff6af1277 in -[WOHttpAdaptor runConnection:] (self=0x555555d61370, _cmd=0x7ffff6e16250, _socket=0x555555fbec40) at WOHttpAdaptor.m:367
0000010 0x00007ffff6af1483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d61370, _cmd=0x7ffff6e16260, _connection=0x555555fbec40) at WOHttpAdaptor.m:401
0000011 0x00007ffff6af1884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d61370, _cmd=0x7ffff6e16310, connection=0x555555fbec40) at WOHttpAdaptor.m:460
0000012 0x00007ffff6af1cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d61370, _cmd=0x7ffff6e16170, _notification=0x555555f87e90) at WOHttpAdaptor.m:521
0000013 0x00007ffff527348d in ?? () from /usr/lib/libgnustep-base.so.1.22
0000014 0x00007ffff5ecb953 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d6a1d0, _cmd=0x7ffff5795700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572d390)
at NSRunLoop+FileObjects.m:58
0000015 0x00007ffff536df62 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000016 0x00007ffff52bc170 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000017 0x00007ffff52bb250 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000018 0x00007ffff6a57e31 in -[WOCoreApplication run] (self=0x555555ba0fc0, _cmd=0x555555762bc0) at WOCoreApplication.m:584
0000019 0x000055555555ae71 in -[SOGo run] (self=0x555555ba0fc0, _cmd=0x7ffff6da2780) at SOGo.m:277
0000020 0x00007ffff6a8202a in WOApplicationMain (_appClassName=0x555555761120, argc=13, argv=0x7fffffffe598) at WOApplicationMain.m:42
0000021 0x00007ffff6aa2e95 in WOWatchDogApplicationMain (appName=0x555555761120, argc=13, argv=0x7fffffffe598) at WOWatchDogApplicationMain.m:1048
0000022 0x000055555555a145 in main (argc=13, argv=0x7fffffffe598, env=0x7fffffffe608) at sogod.m:53

ludovic

ludovic

2014-02-06 12:39

administrator   ~0006507

Have you tried the latest nightly builds?

Ludovic Hutin

Ludovic Hutin

2014-02-06 12:49

reporter   ~0006509

Yes, i just compile them and same error.

ludovic

ludovic

2014-02-06 12:52

administrator   ~0006510

Try to produce a new stack trace. The one above is of no use.

Ludovic Hutin

Ludovic Hutin

2014-02-06 13:00

reporter   ~0006511

I install libc6-dbg too in order to get more information.

sogo@sogo-be-test:/root$ gdb --args /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Ubuntu/Linaro 7.4-2012.04-0ubuntu2.1) 7.4-2012.04
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
For bug reporting instructions, please see:
<http://bugs.launchpad.net/gdb-linaro/>...
Reading symbols from /usr/local/sbin/sogod...done.
(gdb) run
Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Feb 06 13:59:09 sogod [21482]: version 2.1.2 (build root@sogo-be-test.u-strasbg.fr 201402060840) -- starting
Feb 06 13:59:09 sogod [21482]: vmem size check enabled: shutting down app when vmem > 512 MB
Feb 06 13:59:09 sogod [21482]: <0x0x555555a581e0[SOGoProductLoader]> SOGo products loaded from '/usr/local/lib/GNUstep/SOGo':
Feb 06 13:59:09 sogod [21482]: <0x0x555555a581e0[SOGoProductLoader]> ContactsUI.SOGo, PreferencesUI.SOGo, SchedulerUI.SOGo, Mailer.SOGo, CommonUI.SOGo, Contacts.SOGo, MailPartViewers.SOGo, MainUI.SOGo, Appointments.SOGo, MailerUI.SOGo, ActiveSync.SOGo, AdministrationUI.SOGo
Feb 06 13:59:10 sogod [21482]: |SOGo| WOHttpAdaptor listening on address *:20000
2014-02-06 13:59:20.754 sogod[21482] Note: Using UTF-8 as URL encoding in NGExtensions.
Feb 06 13:59:20 sogod [21482]: <0x0x555555d947c0[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Feb 06 13:59:20 sogod [21482]: <0x0x555555d947c0[SOGoCache]> Using host(s) 'localhost' as server(s)
2014-02-06 13:59:20.756 sogod[21482] Note(SoObject): SoDebugKeyLookup is enabled!
2014-02-06 13:59:20.756 sogod[21482] Note(SoObject): SoDebugBaseURL is enabled!
2014-02-06 13:59:20.756 sogod[21482] Note(SoObject): relative base URLs are enabled.
2014-02-06 13:59:20.779 sogod[21482] ERROR(-[NGBundleManager bundleWithPath:]): could not create bundle for path: '/usr/share/GNUstep/Libraries/gnustep-base/Versions/1.22/Resources/SSL.bundle'
2014-02-06 13:59:20.836 sogod[21482] WOxElemBuilder: could not locate builders: WOxExtElemBuilder,WOxExtElemBuilder
2014-02-06 13:59:20.837 sogod[21482] WOCompoundElement: pool embedding is on.
2014-02-06 13:59:20.837 sogod[21482] WOCompoundElement: id logging is on.
Feb 06 13:59:20 sogod [21482]: <0x0x555555de8de0[LDAPSource]> WARNING: using old bindFields format - please update it
::ffff:130.79.203.84 - - [06/Feb/2014:13:59:20 GMT] "GET /SOGo/ HTTP/1.0" 200 4558/0 0.130 12754 64% 3M
2001:660:2402:12:fd:: - - [06/Feb/2014:13:59:25 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.002 - - 0
2001:660:2402:12:fe:: - - [06/Feb/2014:13:59:26 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
^C
Program received signal SIGINT, Interrupt.
0x00007ffff440da08 in __GI___poll (fds=0x555555d6e870, nfds=2, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:83
83 ../sysdeps/unix/sysv/linux/poll.c: Permission denied.
(gdb) b raise
Breakpoint 1 at 0x7ffff4e29b50: raise. (2 locations)
(gdb) c
Continuing.
2014-02-06 13:59:39.069 sogod[21482] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [06/Feb/2014:13:59:39 GMT] "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.0" 200 0/0 0.110 - - 332K
2014-02-06 13:59:39.098 sogod[21482] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [06/Feb/2014:13:59:39 GMT] "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=ludovic.hutin&DeviceId=77BBD2AD0F3B48D48DA8D33BB7470655&DeviceType=WindowsOutlook15 HTTP/1.0" 200 19/13 0.032 - - 0
2014-02-06 13:59:39.657 sogod[21482] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-02-06 13:59:39.784 sogod[21482] Note(NGImap4Connection): using '/' as the IMAP4 folder separator.
Feb 06 13:59:39 sogod [21482]: <0x0x555556004370[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-02-06 13:59:40.393 sogod[21482] Note: using 'UCS-2LE' on Linux.
Feb 06 13:59:41 sogod [21482]: [WARN] <0x0x5555563c96f0[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Feb 06 13:59:41 sogod [21482]: [WARN] <0x0x5555563c96f0[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Feb 06 13:59:41 sogod [21482]: [WARN] <0x0x5555563c96f0[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
Feb 06 13:59:45 sogod [21482]: <0x0x555556004370[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
EXCEPTION: <SaxParseException: 0x55556b57cd90> NAME:SaxIOException REASON:Could not convert input to string! INFO:(null)

Breakpoint 1, GI_raise (sig=6) at ../nptl/sysdeps/unix/sysv/linux/raise.c:34
34 ../nptl/sysdeps/unix/sysv/linux/raise.c: Permission denied.
(gdb) bt
#0 __GI_raise (sig=6) at ../nptl/sysdeps/unix/sysv/linux/raise.c:34
0000001 0x00007ffff435eb8b in
GI_abort () at abort.c:91
0000002 0x000055555555b4ec in -[SOGo handleException:inContext:] (self=0x555555ba2c80, _cmd=0x7ffff6db6790, _exc=0x55556b57cd90, _ctx=0x555555f979a0) at SOGo.m:400
0000003 0x00007ffff6a97a1f in -[WORequestHandler handleRequest:] (self=0x555555a68820, _cmd=0x7ffff6d80d80, _request=0x555555dd56c0) at WORequestHandler.m:264
0000004 0x00007ffff6a585e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555ba2c80, _cmd=0x7ffff6d80dd0, _request=0x555555dd56c0, handler=0x555555a68820) at WOCoreApplication.m:712
0000005 0x00007ffff6a588fe in -[WOCoreApplication dispatchRequest:] (self=0x555555ba2c80, _cmd=0x555555762da0, _request=0x555555dd56c0) at WOCoreApplication.m:752
0000006 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555ba2c80, _cmd=0x7ffff6e18530, _request=0x555555dd56c0) at SOGo.m:453
0000007 0x00007ffff6af5368 in -[WOHttpTransaction _run] (self=0x555555f043d0, _cmd=0x7ffff6e18560) at WOHttpTransaction.m:596
0000008 0x00007ffff6af56de in -[WOHttpTransaction run] (self=0x555555f043d0, _cmd=0x7ffff6e161b0) at WOHttpTransaction.m:649
0000009 0x00007ffff6af1277 in -[WOHttpAdaptor runConnection:] (self=0x555555d61df0, _cmd=0x7ffff6e16250, _socket=0x555555f3ac10) at WOHttpAdaptor.m:367
0000010 0x00007ffff6af1483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d61df0, _cmd=0x7ffff6e16260, _connection=0x555555f3ac10) at WOHttpAdaptor.m:401
0000011 0x00007ffff6af1884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d61df0, _cmd=0x7ffff6e16310, connection=0x555555f3ac10) at WOHttpAdaptor.m:460
0000012 0x00007ffff6af1cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d61df0, _cmd=0x7ffff6e16170, _notification=0x555555f3a120) at WOHttpAdaptor.m:521
0000013 0x00007ffff527348d in ?? () from /usr/lib/libgnustep-base.so.1.22
0000014 0x00007ffff5ecb743 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d6ac50, _cmd=0x7ffff5795700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572d390)
at NSRunLoop+FileObjects.m:58
0000015 0x00007ffff536df62 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000016 0x00007ffff52bc170 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000017 0x00007ffff52bb250 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000018 0x00007ffff6a57e31 in -[WOCoreApplication run] (self=0x555555ba2c80, _cmd=0x555555762bc0) at WOCoreApplication.m:584
0000019 0x000055555555ae71 in -[SOGo run] (self=0x555555ba2c80, _cmd=0x7ffff6da2780) at SOGo.m:277
0000020 0x00007ffff6a8202a in WOApplicationMain (_appClassName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOApplicationMain.m:42
0000021 0x00007ffff6aa2e95 in WOWatchDogApplicationMain (appName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOWatchDogApplicationMain.m:1048
0000022 0x000055555555a145 in main (argc=13, argv=0x7fffffffe5c8, env=0x7fffffffe638) at sogod.m:53

ludovic

ludovic

2014-02-06 13:16

administrator   ~0006512

Instead of "b raise" try to do:

b [NSException raise]

The traces are again, not useful.

Ludovic Hutin

Ludovic Hutin

2014-02-06 13:21

reporter   ~0006513

sogo@sogo-be-test:/root$ gdb --args /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Ubuntu/Linaro 7.4-2012.04-0ubuntu2.1) 7.4-2012.04
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
For bug reporting instructions, please see:
<http://bugs.launchpad.net/gdb-linaro/>...
Reading symbols from /usr/local/sbin/sogod...done.
(gdb) run
Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Feb 06 14:18:03 sogod [21688]: version 2.1.2 (build root@sogo-be-test.u-strasbg.fr 201402060840) -- starting
Feb 06 14:18:03 sogod [21688]: vmem size check enabled: shutting down app when vmem > 512 MB
Feb 06 14:18:03 sogod [21688]: <0x0x555555a581e0[SOGoProductLoader]> SOGo products loaded from '/usr/local/lib/GNUstep/SOGo':
Feb 06 14:18:03 sogod [21688]: <0x0x555555a581e0[SOGoProductLoader]> ContactsUI.SOGo, PreferencesUI.SOGo, SchedulerUI.SOGo, Mailer.SOGo, CommonUI.SOGo, Contacts.SOGo, MailPartViewers.SOGo, MainUI.SOGo, Appointments.SOGo, MailerUI.SOGo, ActiveSync.SOGo, AdministrationUI.SOGo
Feb 06 14:18:03 sogod [21688]: |SOGo| WOHttpAdaptor listening on address *:20000
2014-02-06 14:18:10.849 sogod[21688] Note: Using UTF-8 as URL encoding in NGExtensions.
Feb 06 14:18:10 sogod [21688]: <0x0x555555d947c0[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Feb 06 14:18:10 sogod [21688]: <0x0x555555d947c0[SOGoCache]> Using host(s) 'localhost' as server(s)
2014-02-06 14:18:10.851 sogod[21688] Note(SoObject): SoDebugKeyLookup is enabled!
2014-02-06 14:18:10.851 sogod[21688] Note(SoObject): SoDebugBaseURL is enabled!
2014-02-06 14:18:10.851 sogod[21688] Note(SoObject): relative base URLs are enabled.
2014-02-06 14:18:10.875 sogod[21688] ERROR(-[NGBundleManager bundleWithPath:]): could not create bundle for path: '/usr/share/GNUstep/Libraries/gnustep-base/Versions/1.22/Resources/SSL.bundle'
2014-02-06 14:18:10.933 sogod[21688] WOxElemBuilder: could not locate builders: WOxExtElemBuilder,WOxExtElemBuilder
2014-02-06 14:18:10.934 sogod[21688] WOCompoundElement: pool embedding is on.
2014-02-06 14:18:10.934 sogod[21688] WOCompoundElement: id logging is on.
Feb 06 14:18:10 sogod [21688]: <0x0x555555de8de0[LDAPSource]> WARNING: using old bindFields format - please update it
::ffff:130.79.203.84 - - [06/Feb/2014:14:18:10 GMT] "GET /SOGo/ HTTP/1.0" 200 4558/0 0.130 12754 64% 3M
^C
Program received signal SIGINT, Interrupt.
0x00007ffff440da08 in __GI___poll (fds=0x555555d6e870, nfds=2, timeout=<optimized out>) at ../sysdeps/unix/sysv/linux/poll.c:83
83 ../sysdeps/unix/sysv/linux/poll.c: Permission denied.
(gdb) b [NSException raise]
Function "[NSException raise]" not defined.
Make breakpoint pending on future shared library load? (y or [n]) y
Breakpoint 1 ([NSException raise]) pending.
(gdb) c
Continuing.
2001:660:2402:12:fd:: - - [06/Feb/2014:14:18:31 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.003 - - 0
2001:660:2402:12:fe:: - - [06/Feb/2014:14:18:31 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
2014-02-06 14:18:39.211 sogod[21688] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [06/Feb/2014:14:18:39 GMT] "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.0" 200 0/0 0.105 - - 332K
2014-02-06 14:18:39.244 sogod[21688] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [06/Feb/2014:14:18:39 GMT] "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=ludovic.hutin&DeviceId=77BBD2AD0F3B48D48DA8D33BB7470655&DeviceType=WindowsOutlook15 HTTP/1.0" 200 19/13 0.024 - - 0
2014-02-06 14:18:39.495 sogod[21688] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-02-06 14:18:39.614 sogod[21688] Note(NGImap4Connection): using '/' as the IMAP4 folder separator.
Feb 06 14:18:39 sogod [21688]: <0x0x555555f5ef20[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-02-06 14:18:40.267 sogod[21688] Note: using 'UCS-2LE' on Linux.
Feb 06 14:18:41 sogod [21688]: [WARN] <0x0x5555563c7650[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Feb 06 14:18:41 sogod [21688]: [WARN] <0x0x5555563c7650[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Feb 06 14:18:41 sogod [21688]: [WARN] <0x0x5555563c7650[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
Feb 06 14:18:44 sogod [21688]: <0x0x555555f5ef20[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
EXCEPTION: <SaxParseException: 0x55556b586d90> NAME:SaxIOException REASON:Could not convert input to string! INFO:(null)

Program received signal SIGABRT, Aborted.
0x00007ffff435b425 in __GI_raise (sig=<optimized out>) at ../nptl/sysdeps/unix/sysv/linux/raise.c:64
64 ../nptl/sysdeps/unix/sysv/linux/raise.c: Permission denied.
(gdb) bt

#0 0x00007ffff435b425 in __GI_raise (sig=<optimized out>) at ../nptl/sysdeps/unix/sysv/linux/raise.c:64
0000001 0x00007ffff435eb8b in __GI_abort () at abort.c:91
0000002 0x000055555555b4ec in -[SOGo handleException:inContext:] (self=0x555555ba2c80, _cmd=0x7ffff6db6790, _exc=0x55556b586d90, _ctx=0x555555f979a0) at SOGo.m:400
0000003 0x00007ffff6a97a1f in -[WORequestHandler handleRequest:] (self=0x555555a68820, _cmd=0x7ffff6d80d80, _request=0x555555dd56c0) at WORequestHandler.m:264
0000004 0x00007ffff6a585e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555ba2c80, _cmd=0x7ffff6d80dd0, _request=0x555555dd56c0, handler=0x555555a68820) at WOCoreApplication.m:712
0000005 0x00007ffff6a588fe in -[WOCoreApplication dispatchRequest:] (self=0x555555ba2c80, _cmd=0x555555762da0, _request=0x555555dd56c0) at WOCoreApplication.m:752
0000006 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555ba2c80, _cmd=0x7ffff6e18530, _request=0x555555dd56c0) at SOGo.m:453
0000007 0x00007ffff6af5368 in -[WOHttpTransaction _run] (self=0x555555f043d0, _cmd=0x7ffff6e18560) at WOHttpTransaction.m:596
0000008 0x00007ffff6af56de in -[WOHttpTransaction run] (self=0x555555f043d0, _cmd=0x7ffff6e161b0) at WOHttpTransaction.m:649
0000009 0x00007ffff6af1277 in -[WOHttpAdaptor runConnection:] (self=0x555555d61df0, _cmd=0x7ffff6e16250, _socket=0x555555f3ac10) at WOHttpAdaptor.m:367
0000010 0x00007ffff6af1483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d61df0, _cmd=0x7ffff6e16260, _connection=0x555555f3ac10) at WOHttpAdaptor.m:401
0000011 0x00007ffff6af1884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d61df0, _cmd=0x7ffff6e16310, connection=0x555555f3ac10) at WOHttpAdaptor.m:460
0000012 0x00007ffff6af1cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d61df0, _cmd=0x7ffff6e16170, _notification=0x555555f3a120) at WOHttpAdaptor.m:521
0000013 0x00007ffff527348d in ?? () from /usr/lib/libgnustep-base.so.1.22
0000014 0x00007ffff5ecb743 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d6ac50, _cmd=0x7ffff5795700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572d390)
at NSRunLoop+FileObjects.m:58
0000015 0x00007ffff536df62 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000016 0x00007ffff52bc170 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000017 0x00007ffff52bb250 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000018 0x00007ffff6a57e31 in -[WOCoreApplication run] (self=0x555555ba2c80, _cmd=0x555555762bc0) at WOCoreApplication.m:584
0000019 0x000055555555ae71 in -[SOGo run] (self=0x555555ba2c80, _cmd=0x7ffff6da2780) at SOGo.m:277
0000020 0x00007ffff6a8202a in WOApplicationMain (_appClassName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOApplicationMain.m:42
0000021 0x00007ffff6aa2e95 in WOWatchDogApplicationMain (appName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOWatchDogApplicationMain.m:1048
0000022 0x000055555555a145 in main (argc=13, argv=0x7fffffffe5c8, env=0x7fffffffe638) at sogod.m:53
(gdb)

Well i can perceive what you will say.. The trace is again, not useful...

ludovic

ludovic

2014-02-06 14:01

administrator   ~0006514

Is that on a test server? Can I have access to it and test it directly?

Ludovic Hutin

Ludovic Hutin

2014-02-18 08:59

reporter   ~0006549

sogo@sogo-be-test:/root$ gdb --args /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
GNU gdb (Ubuntu/Linaro 7.4-2012.04-0ubuntu2.1) 7.4-2012.04
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law. Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
For bug reporting instructions, please see:
<http://bugs.launchpad.net/gdb-linaro/>...
Reading symbols from /usr/local/sbin/sogod...done.
(gdb) run
Starting program: /usr/local/sbin/sogod -WOUseWatchDog NO -WONoDetach YES -WOPort 20000 -WOWorkersCount 1 -WOLogFile - -WOPidFile /tmp/sogo.pid
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Feb 18 09:53:16 sogod [835]: version 2.1.2 (build root@sogo-be-test.u-strasbg.fr 201402180902) -- starting
Feb 18 09:53:16 sogod [835]: vmem size check enabled: shutting down app when vmem > 512 MB
Feb 18 09:53:16 sogod [835]: <0x0x555555a582c0[SOGoProductLoader]> SOGo products loaded from '/usr/local/lib/GNUstep/SOGo':
Feb 18 09:53:16 sogod [835]: <0x0x555555a582c0[SOGoProductLoader]> ContactsUI.SOGo, PreferencesUI.SOGo, SchedulerUI.SOGo, Mailer.SOGo, CommonUI.SOGo, Contacts.SOGo, MailPartViewers.SOGo, MainUI.SOGo, Appointments.SOGo, MailerUI.SOGo, ActiveSync.SOGo, AdministrationUI.SOGo
Feb 18 09:53:17 sogod [835]: |SOGo| WOHttpAdaptor listening on address *:20000
^C
Program received signal SIGINT, Interrupt.
0x00007ffff440da08 in poll () from /lib/x86_64-linux-gnu/libc.so.6
(gdb) b [NSException raise]
Function "[NSException raise]" not defined.
Make breakpoint pending on future shared library load? (y or [n]) y
Breakpoint 1 ([NSException raise]) pending.
(gdb) b [NSInvalidArgumentException raise]
Function "[NSInvalidArgumentException raise]" not defined.
Make breakpoint pending on future shared library load? (y or [n]) y
Breakpoint 2 ([NSInvalidArgumentException raise]) pending.
(gdb) c

Continuing.
Feb 18 09:53:45 sogod [835]: <0x0x555555d9c980[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Feb 18 09:53:45 sogod [835]: <0x0x555555d9c980[SOGoCache]> Using host(s) 'localhost' as server(s)
2014-02-18 09:53:45.910 sogod[835] Note(SoObject): SoDebugKeyLookup is enabled!
2014-02-18 09:53:45.910 sogod[835] Note(SoObject): SoDebugBaseURL is enabled!
2014-02-18 09:53:45.910 sogod[835] Note(SoObject): relative base URLs are enabled.
2014-02-18 09:53:45.980 sogod[835] ERROR(-[NGBundleManager bundleWithPath:]): could not create bundle for path: '/usr/share/GNUstep/Libraries/gnustep-base/Versions/1.22/Resources/SSL.bundle'
2014-02-18 09:53:46.287 sogod[835] WOxElemBuilder: could not locate builders: WOxExtElemBuilder,WOxExtElemBuilder
2014-02-18 09:53:46.288 sogod[835] WOCompoundElement: pool embedding is on.
2014-02-18 09:53:46.288 sogod[835] WOCompoundElement: id logging is on.
<0x0x555555d744b0[WOHttpTransaction]> client disconnected during delivery of response for <WORequest[0x0x555555d8fbb0]: method=HEAD uri=/SOGo/index app=SOGo rqKey=index rqPath=(null)> (len=0): the socket was shutdown
2001:660:2402:12:fd:: - - [18/Feb/2014:09:53:46 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.390 - - 2M
<0x0x555555eab8b0[WOHttpTransaction]> client disconnected during delivery of response for <WORequest[0x0x555555e130c0]: method=HEAD uri=/SOGo/index app=SOGo rqKey=index rqPath=(null)> (len=0): the socket was shutdown
2001:660:2402:12:fe:: - - [18/Feb/2014:09:53:46 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 12K
2001:660:2402:12:fd:: - - [18/Feb/2014:09:53:50 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
2001:660:2402:12:fe:: - - [18/Feb/2014:09:53:52 GMT] "HEAD /SOGo/index HTTP/1.0" 302 0/0 0.001 - - 0
Feb 18 09:53:54 sogod [835]: <0x0x555555d931f0[LDAPSource]> WARNING: using old bindFields format - please update it
2014-02-18 09:53:54.233 sogod[835] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [18/Feb/2014:09:53:54 GMT] "OPTIONS /SOGo/Microsoft-Server-ActiveSync HTTP/1.0" 200 0/0 0.005 - - 56K
2014-02-18 09:53:54.318 sogod[835] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
::ffff:130.79.203.84 - - [18/Feb/2014:09:53:54 GMT] "POST /SOGo/Microsoft-Server-ActiveSync?Cmd=FolderSync&User=ludovic.hutin&DeviceId=77BBD2AD0F3B48D48DA8D33BB7470655&DeviceType=WindowsOutlook15 HTTP/1.0" 200 19/13 0.014 - - 260K
2014-02-18 09:53:54.425 sogod[835] -[WEClientCapabilities initWithRequest:]: Unknown WebClient: user-agent='Outlook/15.0 (15.0.4551.1507; MSI; x64)'
2014-02-18 09:53:54.446 sogod[835] Note: Using UTF-8 as URL encoding in NGExtensions.
2014-02-18 09:53:54.540 sogod[835] Note(NGImap4Connection): using '/' as the IMAP4 folder separator.
Feb 18 09:53:54 sogod [835]: <0x0x555555f9dd70[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-02-18 09:53:55.048 sogod[835] Note: using 'UCS-2LE' on Linux.
Feb 18 09:53:55 sogod [835]: [WARN] <0x0x555555f4b910[SOGoWebDAVAclManager]> entry '{DAV:}write' already exists in DAV permissions table
Feb 18 09:53:55 sogod [835]: [WARN] <0x0x555555f4b910[SOGoWebDAVAclManager]> entry '{DAV:}write-properties' already exists in DAV permissions table
Feb 18 09:53:55 sogod [835]: [WARN] <0x0x555555f4b910[SOGoWebDAVAclManager]> entry '{DAV:}write-content' already exists in DAV permissions table
Feb 18 09:53:59 sogod [835]: <0x0x555555f9dd70[NGImap4Client]> Note: no key found for sorting, using 'DATE': (null)
2014-02-18 09:54:06.990 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
2014-02-18 09:54:21.565 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
2014-02-18 09:54:32.500 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
2014-02-18 09:54:35.290 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
2014-02-18 09:55:03.773 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
2014-02-18 09:55:03.977 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
2014-02-18 09:55:29.137 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
2014-02-18 09:55:29.402 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
2014-02-18 09:55:44.541 sogod[835] parseTimeZone: cannot parse time notation 'GMT'
EXCEPTION: <NSException: 0x55556c453a40> NAME:NSInvalidArgumentException REASON:-[NGImap4Client fetchModseqForUid:]: unrecognized selector sent to instance 0x555555f9dd70 INFO:(null)

Program received signal SIGABRT, Aborted.
0x00007ffff435b425 in raise () from /lib/x86_64-linux-gnu/libc.so.6
(gdb) bt
#0 0x00007ffff435b425 in raise () from /lib/x86_64-linux-gnu/libc.so.6
0000001 0x00007ffff435eb8b in abort () from /lib/x86_64-linux-gnu/libc.so.6
0000002 0x000055555555b4ec in -[SOGo handleException:inContext:] (self=0x555555c2e1d0, _cmd=0x7ffff6db6790, _exc=0x55556c453a40, _ctx=0x555555de03d0) at SOGo.m:400
0000003 0x00007ffff6a97a1f in -[WORequestHandler handleRequest:] (self=0x555555a68900, _cmd=0x7ffff6d80d80, _request=0x555555d8ec90) at WORequestHandler.m:264
0000004 0x00007ffff6a585e9 in -[WOCoreApplication dispatchRequest:usingHandler:] (self=0x555555c2e1d0, _cmd=0x7ffff6d80dd0, _request=0x555555d8ec90, handler=0x555555a68900) at WOCoreApplication.m:712
0000005 0x00007ffff6a588fe in -[WOCoreApplication dispatchRequest:] (self=0x555555c2e1d0, _cmd=0x555555762da0, _request=0x555555d8ec90) at WOCoreApplication.m:752
0000006 0x000055555555b751 in -[SOGo dispatchRequest:] (self=0x555555c2e1d0, _cmd=0x7ffff6e18530, _request=0x555555d8ec90) at SOGo.m:453
0000007 0x00007ffff6af5368 in -[WOHttpTransaction _run] (self=0x555555e97180, _cmd=0x7ffff6e18560) at WOHttpTransaction.m:596
0000008 0x00007ffff6af56de in -[WOHttpTransaction run] (self=0x555555e97180, _cmd=0x7ffff6e161b0) at WOHttpTransaction.m:649
0000009 0x00007ffff6af1277 in -[WOHttpAdaptor runConnection:] (self=0x555555d61ee0, _cmd=0x7ffff6e16250, _socket=0x555555eac090) at WOHttpAdaptor.m:367
0000010 0x00007ffff6af1483 in -[WOHttpAdaptor _handleAcceptedConnection:] (self=0x555555d61ee0, _cmd=0x7ffff6e16260, _connection=0x555555eac090) at WOHttpAdaptor.m:401
0000011 0x00007ffff6af1884 in -[WOHttpAdaptor _handleConnection:] (self=0x555555d61ee0, _cmd=0x7ffff6e16310, connection=0x555555eac090) at WOHttpAdaptor.m:460
0000012 0x00007ffff6af1cff in -[WOHttpAdaptor acceptConnection:] (self=0x555555d61ee0, _cmd=0x7ffff6e16170, _notification=0x555555e0bda0) at WOHttpAdaptor.m:521
0000013 0x00007ffff527348d in ?? () from /usr/lib/libgnustep-base.so.1.22
0000014 0x00007ffff5ecb743 in -[NSObject(FileObjectWatcher) receivedEvent:type:extra:forMode:] (self=0x555555d6ad40, _cmd=0x7ffff5795700, _fdData=0x6, _type=ET_RDESC, _extra=0x6, _mode=0x7ffff572d390) at NSRunLoop+FileObjects.m:58
0000015 0x00007ffff536df62 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000016 0x00007ffff52bc170 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000017 0x00007ffff52bb250 in ?? () from /usr/lib/libgnustep-base.so.1.22
0000018 0x00007ffff6a57e31 in -[WOCoreApplication run] (self=0x555555c2e1d0, _cmd=0x555555762bc0) at WOCoreApplication.m:584
0000019 0x000055555555ae71 in -[SOGo run] (self=0x555555c2e1d0, _cmd=0x7ffff6da2780) at SOGo.m:277
0000020 0x00007ffff6a8202a in WOApplicationMain (_appClassName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOApplicationMain.m:42
0000021 0x00007ffff6aa2e95 in WOWatchDogApplicationMain (appName=0x555555761120, argc=13, argv=0x7fffffffe5c8) at WOWatchDogApplicationMain.m:1048
0000022 0x000055555555a145 in main (argc=13, argv=0x7fffffffe5c8, env=0x7fffffffe638) at sogod.m:53
(gdb)

Ludovic Hutin

Ludovic Hutin

2014-02-28 08:47

reporter   ~0006583

The problem has been fix with le lastest SOPE release.
You can close.

Issue History

Date Modified Username Field Change
2014-01-27 13:27 Ludovic Hutin New Issue
2014-01-27 13:49 ludovic Note Added: 0006426
2014-01-27 14:08 Ludovic Hutin Note Added: 0006427
2014-01-27 14:33 ludovic Note Added: 0006428
2014-01-27 14:37 Ludovic Hutin Note Added: 0006429
2014-01-27 14:42 ludovic Note Added: 0006430
2014-01-27 14:48 Ludovic Hutin Note Added: 0006431
2014-01-27 15:43 ludovic Note Added: 0006432
2014-01-27 15:50 Ludovic Hutin Note Added: 0006433
2014-01-27 16:32 ludovic Note Added: 0006434
2014-01-27 16:32 ludovic Status new => closed
2014-01-27 16:32 ludovic Assigned To => ludovic
2014-01-27 16:32 ludovic Resolution open => fixed
2014-01-28 07:46 Ludovic Hutin Note Added: 0006441
2014-01-28 07:46 Ludovic Hutin Status closed => feedback
2014-01-28 07:46 Ludovic Hutin Resolution fixed => reopened
2014-01-28 07:48 Ludovic Hutin Note Added: 0006442
2014-01-28 07:48 Ludovic Hutin Status feedback => assigned
2014-01-28 12:49 Ludovic Hutin Note Added: 0006445
2014-01-28 13:27 ludovic Note Added: 0006448
2014-01-29 08:08 Ludovic Hutin Note Added: 0006451
2014-01-29 14:50 ludovic Note Added: 0006453
2014-02-04 00:02 ludovic Note Added: 0006475
2014-02-04 07:39 Ludovic Hutin Note Added: 0006478
2014-02-06 12:39 ludovic Note Added: 0006507
2014-02-06 12:49 Ludovic Hutin Note Added: 0006509
2014-02-06 12:52 ludovic Note Added: 0006510
2014-02-06 13:00 Ludovic Hutin Note Added: 0006511
2014-02-06 13:16 ludovic Note Added: 0006512
2014-02-06 13:21 Ludovic Hutin Note Added: 0006513
2014-02-06 14:01 ludovic Note Added: 0006514
2014-02-18 08:59 Ludovic Hutin Note Added: 0006549
2014-02-25 15:01 Christian Mack Relationship added related to 0002609
2014-02-28 08:47 Ludovic Hutin Note Added: 0006583
2014-03-06 21:28 ludovic Status assigned => closed
2014-03-06 21:28 ludovic Resolution reopened => fixed
2014-03-06 21:28 ludovic Fixed in Version => 2.2.1