View Issue Details

Jump to NotesJump to History
IDProjectCategoryView StatusDate SubmittedLast Update
0002367SOGoWeb Generalpublic2013-07-12 17:482013-09-25 20:14
Reportermjr Assigned To 
PrioritynormalSeveritymajorReproducibilityalways
Status closedResolutionno change required 
Product Version2.0.6 
Summary0002367: incorrect password hangs sogod until restarted
Description

If any user (we've tried a couple), gets their password wrong, sogod fails to bind to LDAP and then hangs until the watchdog kicks in - at which point, the new sogod child hangs and so on... until /etc/init.d/sogo restart or equivalent is run. The password doesn't contain any special characters (I searched for similar bugs and there were a couple of those). Any suggestions on how can I get to the bottom of the cause of this?

Additional Information

2013-07-12 11:38:49.746 sogod[15841] Problem posting notification: <NSException: 0x7f6705352c00> NAME:LDAPException REASON:operation bind failed: Invalid credentials (0x31) INFO:{login = "cn=userDNremoved"; }
Jul 12 11:39:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 1 minutes
Jul 12 11:40:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 2 minutes
Jul 12 11:41:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 3 minutes
Jul 12 11:42:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 4 minutes
Jul 12 11:43:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 5 minutes
Jul 12 11:44:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 6 minutes
Jul 12 11:45:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 7 minutes
Jul 12 11:46:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 8 minutes
Jul 12 11:47:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15841 has been hanging in the same request for 9 minutes
Jul 12 11:48:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> safety belt -- sending KILL signal to pid 15841
Jul 12 11:48:49 sogod [15835]: <0x0x7f670509fcc0[WOWatchDogChild]> child 15841 exited
Jul 12 11:48:49 sogod [15835]: <0x0x7f670509fcc0[WOWatchDogChild]> (terminated due to signal 9)
Jul 12 11:48:49 sogod [15835]: <0x0x7f6704dfccc0[WOWatchDog]> child spawned with pid 15894
Jul 12 11:48:49 sogod [15894]: <0x0x7f6705313a60[SOGoCache]> Cache cleanup interval set every 300.000000 seconds
Jul 12 11:48:49 sogod [15894]: <0x0x7f6705313a60[SOGoCache]> Using host(s) 'localhost' as server(s)
2013-07-12 11:48:49.827 sogod[15894] Note(SoObject): SoDebugKeyLookup is enabled!
2013-07-12 11:48:49.828 sogod[15894] Note(SoObject): SoDebugBaseURL is enabled!
2013-07-12 11:48:49.828 sogod[15894] Note(SoObject): relative base URLs are enabled.
2013-07-12 11:48:49.839 sogod[15894] ERROR(-[NGBundleManager bundleWithPath:]): could not create bundle for path: '/usr/share/GNUstep/Libraries/gnustep-base/Versions/1.20/Resources/SSL.bundle'
2013-07-12 11:48:49.855 sogod[15894] WOCompoundElement: pool embedding is on.
2013-07-12 11:48:49.855 sogod[15894] WOCompoundElement: id logging is on.
2013-07-12 11:48:49.863 sogod[15894] Problem posting notification: <NSException: 0x7f67053d4770> NAME:LDAPException REASON:operation bind failed: Invalid credentials (0x31) INFO:{login = "cn=userDNremoved"; }
Jul 12 11:49:49 sogod [15835]: [WARN] <0x0x7f670509fcc0[WOWatchDogChild]> pid 15894 has been hanging in the same request for 1 minutes

TagsNo tags attached.

Activities

ludovic

ludovic

2013-07-18 14:14

administrator   ~0005753

When you see "has been hanging in the same request for 5 minutes", attach to the pid using gdb and produce a stacktrace.
nephilim

nephilim

2013-07-26 12:53

reporter   ~0005768

I have the same problem

2013-07-26 12:53

 

strace.log (89,863 bytes)

2013-07-29 14:27

 

gdb.log (1,120 bytes)
nephilim

nephilim

2013-07-29 14:29

reporter   ~0005773

Last edited: 2013-07-29 14:34

And I see 100 percent load of CPU in this case
ludovic

ludovic

2013-07-29 18:14

administrator   ~0005775

I've just tried and it works well for me.

Provide a relevant stack trace, the one included in this ticket is useless.

http://www.sogo.nu/english/nc/support/faq/article/how-do-i-debug-sogo.html
mjr

mjr

2013-07-31 17:56

reporter   ~0005786

The linked FAQ is subtly wrong in at least two places (the first apt-get command results in "E: Unable to locate package libgnustep-base-dbg
E: Couldn't find any package by regex 'libgnustep-base-dbg'" and the sources.list line for backports should have http:// in front of the hostname) but I did install dbg packages and a backported gdb - unfortunately, it also resulted into an upgrade to 2.0.7 and the problem vanishing. I'm asking some friends if the hang has also gone away for them, but I suspect this may have been fixed in 2.0.7.
ludovic

ludovic

2013-09-25 20:14

administrator   ~0006041

Reopen if necessary.

Issue History

Date Modified Username Field Change
2013-07-12 17:48 mjr New Issue
2013-07-18 14:14 ludovic Note Added: 0005753
2013-07-26 12:53 nephilim Note Added: 0005768
2013-07-26 12:53 nephilim File Added: strace.log
2013-07-29 14:27 nephilim File Added: gdb.log
2013-07-29 14:29 nephilim Note Added: 0005773
2013-07-29 14:34 nephilim Note Edited: 0005773
2013-07-29 18:14 ludovic Note Added: 0005775
2013-07-31 17:56 mjr Note Added: 0005786
2013-09-25 20:14 ludovic Note Added: 0006041
2013-09-25 20:14 ludovic Status new => closed
2013-09-25 20:14 ludovic Resolution open => no change required