Scalix 11.0.3 imap crash

[jethro.carr]

hi all,

Had a problem with a Scalix 11.0.3 server this morning, where imap and the mime browser start spitting out errors.

Result was that users could login, and see that they had email, but were unable to open any in webmail.

Below is a capture of the log. The first non-normal message was the connection rate exceeded, then there were a number of errors with different browser processes, finally the IMAP service errors. The imap errors continued to repeat until I finally killed off the scalix processes, and brought the server back online.

This server is running 11.0.3, so it's possible it may be fixed in 11.3, although I couldn't see anything in the release notes that sounded related. I am actually scheduled to upgrade this server to 11.3 in the next couple of weeks, but decided it's worth posting this here, incase it's an unknown issue.

-----

WARNING IMAP Server Da(IMAP Server Pr) 02.19.08 06:09:02
[OM.DMON 2108] Maximum IMAP connection rate exceeded, sleeping.


WARNING IMAP Server Da(IMAP Server Pr) 02.19.08 06:49:02
[OM.DMON 2108] Maximum IMAP connection rate exceeded, sleeping.


WARNING Remote Client (U/I Access ) 02.19.08 07:37:50
[OM.UI 582] Cannot resolve DirectRef - folder is not visible to client
User Name: Bob Jones / myserver, myorg/CN=Bob Jones
Last Msg Subject: RE: Quotation for Online Client and e-Vend
Last Msg Sender: Jones/Bob///myserver/myorg//////////////////%Bob Jones%
Last Msg Id: 21788890.38991203287788033.JavaMail.root(a)myserver.adril
Last Folder: UserFolder - Filing Cab
Last Ct RecNo: 3445
-> ual_GetAckId
<- ual_GetAckId
-> mapi_SyncRelFlags
<- mapi_SyncRelFlags
-> mapi_SyncCompFlags
<- mapi_SyncCompFlags
<- ual_BuildListEntry
-> ct_ReadNextContentRec
<- ct_ReadNextContentRec
-> ct_GetCtnerLastCRec
<- ct_GetCtnerLastCRec
<- ual_UpdateAnyList
<- ual_ContentNumForDI
<- /build/11.0.3/src/lib/ual/ual_dref.c:209[101,582]
<- /build/11.0.3/src/lib/ual/ual_dref.c:241[101,582]
<- /build/11.0.3/src/lib/ual/ual_delete.c:673[101,582]



SERIOUS ERROR Mime Browser C(Mime Browser C) 02.19.08 08:19:17
[OM 10270] Process about to terminate due to error.
Signal (Segmentation Violation) trapped by process 27181
Procedure trace follows:
<- beingBrowsed
-> getFreeBrowser
-> startBrowser
<- startBrowser
<- getFreeBrowser
-> browseRequest
<- browseRequest
-> addConnection
<- addConnection
-> inCache
<- inCache
-> beingBrowsed
<- beingBrowsed
-> getFreeBrowser
<- getFreeBrowser
-> browseRequest


SERIOUS ERROR Mime Browser C(Mime Browser C) 02.19.08 08:19:17
[OM 10272] BACKTRACE:
/opt/scalix/lib/libom_er.so(er_add_backtrace+0xc6)[0xa87ee6]
/opt/scalix/lib/libom_er.so[0xa881e6]
/opt/scalix/lib/libom_er.so(er_DumpProcAndExit+0x1f)[0xa8838f]
/lib/tls/libpthread.so.0[0x3189c8]
mime.control[0x8049f01]
mime.control[0x804a857]
mime.control[0x804c514]
/lib/tls/libc.so.6(__libc_start_main+0xd3)[0x176de3]
mime.control[0x8049831]


SERIOUS ERROR Browser (Service 14 ) 02.19.08 08:19:17
[OM 10270] Process about to terminate due to error.
Signal (Segmentation Violation) trapped by process 32458
Procedure trace follows:
-> msl_transform_
<- msl_transform_
-> msl_transform_
<- msl_transform_
<- msl_readContainerOpenedParent
-> ct_CloseCtner 3001
-> sfl_CloseItem
<- sfl_CloseItem
<- ct_CloseCtner 3001
<- msl_readContainer
-> msl_outputIndex
-> msl:outputMime
<- msl:outputMime
<- msl_outputIndex
<- browseMessage
-> decodeParams
Last Msg Id: A1F0C7458F2C9948B8D66A1FDE66C2B2072D0C2F(a)somemailserverurl.com
Last Msg DirectRef: 00182ae921f2ff62


SERIOUS ERROR Browser (Service 14 ) 02.19.08 08:19:17
[OM 10272] BACKTRACE:
/opt/scalix/lib/libom_er.so(er_add_backtrace+0xc6)[0x2e5ee6]
/opt/scalix/lib/libom_er.so[0x2e61e6]
/opt/scalix/lib/libom_er.so(er_DumpProcAndExit+0x1f)[0x2e638f]
/lib/tls/libpthread.so.0[0x3189c8]
/opt/scalix/bin/index.browse[0x8049f38]
/lib/tls/libc.so.6(__libc_start_main+0xd3)[0x1a7de3]
/opt/scalix/bin/index.browse[0x80492c1]
Last Msg Id: A1F0C7458F2C9948B8D66A1FDE66C2B2072D0C2F(a)somemailserverurl.com
Last Msg DirectRef: 00182ae921f2ff62


SERIOUS ERROR IMAP Server Da(IMAP Server Pr) 02.19.08 08:19:33
[OM 10270] Process about to terminate due to error.
Signal (Segmentation Violation) trapped by process 710
Procedure trace follows:
<- imapFetch
-> checkCoreNotifications
<- checkCoreNotifications
-> imaplex_nextRequest
<- imaplex_nextRequest
-> imapFetch
-> prepareFetch
<- prepareFetch
-> imapMimeUpdateCRecNums


ERIOUS ERROR Mime Browser C(Mime Browser C) 02.19.08 08:19:17
[OM 10270] Process about to terminate due to error.
Signal (Segmentation Violation) trapped by process 27181
Procedure trace follows:
<- beingBrowsed
-> getFreeBrowser
-> startBrowser
<- startBrowser
<- getFreeBrowser
-> browseRequest
<- browseRequest
-> addConnection
<- addConnection
-> inCache
<- inCache
-> beingBrowsed
<- beingBrowsed
-> getFreeBrowser
<- getFreeBrowser
-> browseRequest


SERIOUS ERROR Mime Browser C(Mime Browser C) 02.19.08 08:19:17
[OM 10272] BACKTRACE:
/opt/scalix/lib/libom_er.so(er_add_backtrace+0xc6)[0xa87ee6]
/opt/scalix/lib/libom_er.so[0xa881e6]
/opt/scalix/lib/libom_er.so(er_DumpProcAndExit+0x1f)[0xa8838f]
/lib/tls/libpthread.so.0[0x3189c8]
mime.control[0x8049f01]
mime.control[0x804a857]
mime.control[0x804c514]
/lib/tls/libc.so.6(__libc_start_main+0xd3)[0x176de3]
mime.control[0x8049831]

<- ct_ReadNextContentRec
<- imapMimeUpdateCRecNums
-> getMessageInfo
<- getMessageInfo
-> sendMessageInfo
-> imapMimeBrowseMessagePath
User Name: James Jones / myserver, myorg/CN=James Jones


SERIOUS ERROR IMAP Server Da(IMAP Server Pr) 02.19.08 08:19:33
[OM 10272] BACKTRACE:
/opt/scalix/lib/libom_er.so(er_add_backtrace+0xc6)[0xdebee6]
/opt/scalix/lib/libom_er.so[0xdec1e6]
/opt/scalix/lib/libom_er.so(er_DumpProcAndExit+0x1f)[0xdec38f]
/lib/tls/libpthread.so.0[0x3189c8]
in.imap41d[0x805ec77]
in.imap41d[0x805f4b1]
in.imap41d[0x8063b89]
in.imap41d[0x80650bb]
in.imap41d[0x8065a84]
/lib/tls/libc.so.6(__libc_start_main+0xd3)[0x399de3]
in.imap41d[0x804e021]
User Name: James Jones / myserver, myorg/CN=James Jones


SERIOUS ERROR IMAP Server Da(IMAP Server Pr) 02.19.08 08:19:49
[OM 10270] Process about to terminate due to error.
Signal (Segmentation Violation) trapped by process 751
Procedure trace follows:
<- imapnotif_removeUnseenUid
<- imapnotif_notificationUpdate
<- checkCoreNotifications
-> imaplex_nextRequest
<- imaplex_nextRequest
-> imapFetch
-> prepareFetch
<- prepareFetch
-> imapMimeUpdateCRecNums
-> ct_ReadNextContentRec
<- ct_ReadNextContentRec
<- imapMimeUpdateCRecNums
-> getMessageInfo
<- getMessageInfo
-> sendMessageInfo
-> imapMimeBrowseMessagePath
User Name: James Jones / myserver, myorg/CN=James Jones
---

[mikevl]

Hi Jethro

Two things com to mind

First check the number of IMAP processes running
ps aux |grep IMAP

If this seems excessive kill them all. Hey IMAP clients will try to log in again so thats OK

Second. You may need to flush / recreate the IMAP cache. There are plenty of posts in this forum about that.

Thry that for starters.

Mike

[jethro.carr]

Thanks Mike,

I resolved the problem by killing all the scalix and imap processes when it occured, and brought the system back online without a problem.

I'm not looking for a fix to get me up and running again, I'm looking to see if anyone else has seen a bug like this, or at the least, bring it to the attention of Scalix.

[les]

Thanks Mike,

I resolved the problem by killing all the scalix and imap processes when it occured, and brought the system back online without a problem. :-)

I'm not looking for a fix to get me up and running again, I'm looking to see if anyone else has seen a bug like this, or at the least, bring it to the attention of Scalix.

there were bugs fixed since 11.0.3 which related to better handling of defunct imap processes and also improvements in imap in general.

11.3 is significantly faster in imap access.

I had similar issues with other clients on older 11 series releases. The problems disappeared after upgrading.

[FJE_84]

Hallo Everybody,

i have the same Problems by a new Server not Updated Installation ist Version 11.3.0.11339 Comunity Edition.

Code: Select all

ERIOUS ERROR                  IMAP Server Da(IMAP Server Pr) 03.21.08 21:41:59
[OM 10270] Process about to terminate due to error.
Signal (Segmentation Violation) trapped by process 28326
Procedure trace follows:
  -> imaplex_deleteContext
  <- imaplex_deleteContext
  -> imapual_hideSession
  -> usr_SetSessionFlags
  <- usr_SetSessionFlags
  <- imapual_hideSession
  <- imapCloseSatConn
  <- imapSatelliteCommand
  -> checkNotifications
  <- checkNotifications
  -> imapCheckCompactFldItems
  <- imapCheckCompactFldItems
  -> getNextTimeout
  -> imapGetCompactionTOD
  <- imapGetCompactionTOD
  <- getNextTimeout
User Name: Erwin Haberson / mailnode/CN=Vorname, Nachname


SERIOUS ERROR                  IMAP Server Da(IMAP Server Pr) 03.21.08 21:41:59
[OM 10272] BACKTRACE:
/opt/scalix/lib/libom_er.so(er_add_backtrace+0xb3)[0xf7e7bd43]
/opt/scalix/lib/libom_er.so[0xf7e7c033]
/opt/scalix/lib/libom_er.so(er_DumpProcAndExit+0x1f)[0xf7e7c1bf]
[0xffffe500]
in.imap41d[0x80597eb]
in.imap41d[0x806c78b]
in.imap41d[0x806d6d1]
in.imap41d[0x8064c89]
in.imap41d[0x8066b4c]
in.imap41d[0x8067609]
/lib/libc.so.6(__libc_start_main+0xdc)[0xf7aa987c]
in.imap41d[0x804e541]
User Name: Erwin Haberson / mailnode/CN=Vorname, Nachname

Have a nice Day