Hello Quentin

I am trying to find the root cause of that behaviour, as it works perfectly fine on my local debian workstation.

I added some debug information to UIxCallListingsActions.m:alarmsListAction and to the construtor. I found out that the constructor is called (see below) but alarmsListAction is not called. So i am wondering if you could help me to find what is going on. Can you share some information how the routing is done? You mentioned, that a method is not called. Can you elaborate a bit more about that?

This is how it looks like on my local workstation:

2026-01-24 20:29:45.189 sogod[526192:526192] [TRACE] initWithRequest: called with request: <WORequest[0x0x55987ac18f50]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282985 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:29:45.189 sogod[526192:526192] [TRACE] super initWithRequest succeeded 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] componentsData initialized: {}
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] startDate set to nil
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] endDate set to nil
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] now set to: 2026-01-24 20:29:45 +0100 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] request assigned: <WORequest[0x0x55987ac18f50]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282985 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] activeUser: <0x0x55987b093dc0[SOGoUser]: [email protected] roles=Authenticated,Anonymous> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] dateFormatter assigned: <SOGoDateFormatter: 0x55987aced9b0> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] userTimeZone assigned: Europe/Berlin 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] now timezone set to: Europe/Berlin
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] dayBasedView = 0
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] currentView set to nil
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] enabledWeekDays assigned: (SU, MO, TU, WE, TH, FR, SA) 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] initWithRequest finished, returning self: <UIxCalListingActions: 0x55987ae74720> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] initWithRequest: called with request: <WORequest[0x0x55987ac18f50]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282985 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] super initWithRequest succeeded 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] componentsData initialized: {}
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] startDate set to nil
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] endDate set to nil
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] now set to: 2026-01-24 20:29:45 +0100 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] request assigned: <WORequest[0x0x55987ac18f50]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282985 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] activeUser: <0x0x55987b093dc0[SOGoUser]: [email protected] roles=Authenticated,Anonymous> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] dateFormatter assigned: <SOGoDateFormatter: 0x55987acbcc60> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] userTimeZone assigned: Europe/Berlin 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] now timezone set to: Europe/Berlin
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] dayBasedView = 0
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] currentView set to nil
2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] enabledWeekDays assigned: (SU, MO, TU, WE, TH, FR, SA) 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] initWithRequest finished, returning self: <UIxCalListingActions: 0x55987a6ff7a0> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] alarmsListAction called! 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] request: <WORequest[0x0x55987ac18f50]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282985 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] context: <0x0x55987abcf7c0[WOContext]: 00969751da97abcf7c0 app=SOGo sn=none eid=(null) rqeid=(null)> 2026-01-24 20:29:45.190 sogod[526192:526192] [TRACE] clientObject: <0x55987a6cf910[SOGoAppointmentFolders]: name=Calendar container=0x55987acc4ec0/[email protected]>
2026-01-24 20:29:45.190 sogod[526192:526192] alarmsListAction START
2026-01-24 20:29:45.190 sogod[526192:526192] browserTime=1769282985, laterTime=1769455785 2026-01-24 20:29:45.190 sogod[526192:526192] clientObject loaded: <0x55987a6cf910[SOGoAppointmentFolders]: name=Calendar container=0x55987acc4ec0/[email protected]>
2026-01-24 20:29:45.190 sogod[526192:526192] Iterating folders...
2026-01-24 20:29:45.190 sogod[526192:526192] Checking folder: personal
2026-01-24 20:29:45.190 sogod[526192:526192] Folder is active and shows alarms 2026-01-24 20:29:45.191 sogod[526192:526192] Found 0 alarms in folder personal 2026-01-24 20:29:45.191 sogod[526192:526192] Prepared data dictionary: {alarms = (); fields = ("c_folder", "c_name", "c_nextalarm"); }
2026-01-24 20:29:45.191 sogod[526192:526192] alarmsListAction END
Jan 24 20:29:45 sogod [526192]: 127.0.0.1 "GET /SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282985 HTTP/1.1" 200 60/0 0.004 - - 616K - 14 Jan 24 20:29:45 sogod [526194]: 127.0.0.1 "POST /SOGo/so/[email protected]/Mail/0/folderINBOX/changes HTTP/1.1" 200 19/126 0.176 - - 7M - 12 2026-01-24 20:29:45.374 sogod[526192:526192] clientObject geladen: <0x55987adc95b0[SOGoMailAccount]: name=0 container=0x55987aeeb680/Mail> 2026-01-24 20:29:45.375 sogod[526192:526192] Alle Ordner: ({children = (); flags = (hasnochildren); name = INBOX; path = INBOX; siev.... (shortened) 2026-01-24 20:29:45.565 sogod[526192:526192] File NSRegularExpression.m: 275. In -[NSRegularExpression initWithPattern:options:error:] Warning: this implementation of NSRegularExpression uses -enumerateMatchesInString:options:range:callback:context: as a primitive method rather than the blocks-dependtent method used by Apple.  If you must subclass NSRegularExpression, you must bear that difference in mind Jan 24 20:29:45 sogod [526192]: 127.0.0.1 "POST /SOGo/so/[email protected]/Mail/0/folderINBOX/view HTTP/1.1" 200 600/48 0.186 - - 264K - 16 Jan 24 20:29:45 sogod [526194]: 127.0.0.1 "GET /SOGo/so/[email protected]/Mail/0/folderINBOX/labels HTTP/1.1" 200 2/0 0.177 - - 280K - 12 Jan 24 20:29:45 sogod [526192]: 127.0.0.1 "POST /SOGo/so/[email protected]/Mail/unseenCount HTTP/1.1" 200 19/31 0.183 - - 0 - 15

Thats how it looks on the server:

2026-01-24 20:23:40.722 sogod[163111:163111] [TRACE] initWithRequest: called with request: <WORequest[0x0x55a236eac030]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282620 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:23:40.722 sogod[163111:163111] [TRACE] super initWithRequest succeeded 2026-01-24 20:23:40.722 sogod[163111:163111] [TRACE] componentsData initialized: {}
2026-01-24 20:23:40.722 sogod[163111:163111] [TRACE] startDate set to nil
2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] endDate set to nil
2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] now set to: 2026-01-24 20:23:40 +0100 2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] request assigned: <WORequest[0x0x55a236eac030]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282620 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] activeUser: <0x0x55a2374fdd70[SOGoUser]: [email protected] roles=Authenticated,Anonymous> 2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] dateFormatter assigned: <SOGoDateFormatter: 0x55a2373fd890> 2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] userTimeZone assigned: Europe/Berlin 2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] now timezone set to: Europe/Berlin
2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] dayBasedView = 0
2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] currentView set to nil
2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] enabledWeekDays assigned: (SU, MO, TU, WE, TH, FR, SA) 2026-01-24 20:23:40.723 sogod[163111:163111] [TRACE] initWithRequest finished, returning self: <UIxCalListingActions: 0x55a237383e00> Jan 24 20:23:40 sogod [163111]: <[obj-mth-dispatch]>D client object set in ctx: <0x55a236eac2b0[SOGoAppointmentFolders]: name=Calendar container=0x55a236be4660/[email protected]> Jan 24 20:23:40 sogod [163111]: <[obj-mth-dispatch]>D traversed object is callable: <0x0x55a236d62c20[SoActionInvocation]: class=UIxCalListingActions action=alarmsList> 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] initWithRequest: called with request: <WORequest[0x0x55a236eac030]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282620 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] super initWithRequest succeeded 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] componentsData initialized: {}
2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] startDate set to nil
2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] endDate set to nil
2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] now set to: 2026-01-24 20:23:40 +0100 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] request assigned: <WORequest[0x0x55a236eac030]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282620 app=SOGo rqKey=so [email protected]/Calendar/alarmslist> 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] activeUser: <0x0x55a2374fdd70[SOGoUser]: [email protected] roles=Authenticated,Anonymous> 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] dateFormatter assigned: <SOGoDateFormatter: 0x55a2373cc660> 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] userTimeZone assigned: Europe/Berlin 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] now timezone set to: Europe/Berlin
2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] dayBasedView = 0
2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] currentView set to nil
2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] enabledWeekDays assigned: (SU, MO, TU, WE, TH, FR, SA) 2026-01-24 20:23:40.728 sogod[163111:163111] [TRACE] initWithRequest finished, returning self: <UIxCalListingActions: 0x55a23710c470> Jan 24 20:23:40 sogod [163111]: <[obj-mth-dispatch]>D call produced result: (null) Jan 24 20:23:40 sogod [163111]: |SOGo| request took 0.026760 seconds to execute Jan 24 20:23:40 sogod [163111]: xx.xxx.xxx.xx "GET /SOGo/so/[email protected]/Calendar/alarmslist?browserTime=1769282620 HTTP/1.1" 500 36/0 0.029 - - 3M - 13 Jan 24 20:23:40 sogod [163109]: <[obj-mth-dispatch]>D client object set in ctx: <0x55a23724eb80[SOGoMailFolder]: name=folderINBOX container=0x55a2370e3ca0/0> Jan 24 20:23:40 sogod [163109]: <[obj-mth-dispatch]>D traversed object is callable: <0x0x55a236dbbad0[SoActionInvocation]: class=UIxMailListActions action=getChanges> Jan 24 20:23:40 sogod [163109]: <[obj-mth-dispatch]>D call produced result: (null) Jan 24 20:23:40 sogod [163109]: |SOGo| request took 0.107119 seconds to execute Jan 24 20:23:40 sogod [163109]: xx.xxx.xxx.xx "POST /SOGo/so/[email protected]/Mail/0/folderINBOX/changes HTTP/1.1" 500 36/126 0.110 - - 8M - 12 Jan 24 20:23:40 sogod [163110]: <[obj-mth-dispatch]>D client object set in ctx: <0x55a2370deb10[SOGoMailAccount]: name=0 container=0x55a236ef31e0/Mail> Jan 24 20:23:40 sogod [163110]: <[obj-mth-dispatch]>D traversed object is callable: <0x0x55a236db98a0[SoActionInvocation]: class=UIxMailAccountActions action=listMailboxes> Jan 24 20:23:40 sogod [163110]: <[obj-mth-dispatch]>D call produced result: (null) Jan 24 20:23:40 sogod [163110]: |SOGo| request took 0.123346 seconds to execute Jan 24 20:23:40 sogod [163110]: xx.xxx.xxx.xx "GET /SOGo/so/[email protected]/Mail/0/view HTTP/1.1" 500 36/0 0.126 - - 8M - 12

I guess not but: Do you see anything in the fields that might cause that behaviour?

What i noticed: on both systems, the constructor is called with "request assigned: <WORequest[0x0x55987ac18f50]: method=GET uri=/SOGo/so/[email protected]/Calendar/alarmslist?browser", but only on the workstation this is actually executed. Do you have any clue where this routing is done?

Regards

Oli

Am 05.01.26 um 16:33 schrieb qhivert ([email protected]):

Most of them are directly found on the file you want to debug

E.G.: SoDebugObjectTraversal is found here -> https://github.com/Alinto/sope/blob/caf376c233dd0aeb965fd806ec427c5062056b31/sope-appserver/NGObjWeb/SoObjects/SoObject%2BTraversal.m#L49

So, you need to know what to find and where. I suppose that’s why they haven’t been documented.

Cheers,

--

Quentin Hivert || Alinto || R&D Lead Developer

19 Quai Perrache 69002 Lyon

www.alinto.com <http://www.alinto.com>

*From:*[email protected] <[email protected]> *On Behalf Of *Washington Odhiambo
*Sent:* lundi 5 janvier 2026 15:30
*To:* [email protected]
*Subject:* Re: [SOGo] Debian 13 / SOGo / 500 error

Hello Quentin,

Out of curiosity, where are these config parameters coming from?

Looking at https://www.sogo.nu/files/docs/SOGoInstallationGuide.html#_installation <https://www.sogo.nu/files/docs/SOGoInstallationGuide.html#_installation>, I did not find many of these params..

Are they secret? :-)

SoObjectRequestHandlerDebugEnabled = YES;
  SoSelectorInvocationDebugEnabled = YES;
  SoDebugRequestClassification = YES;
  SoDebugObjectTraversal = YES;
  SOGoDebugRequests = YES;
  ImapDebugEnabled = YES;
  ImapLogEnabled = YES;
  MySQL4DebugEnabled = YES;
  SOGoUIxDebugEnabled = YES;
  SoObjectMethodDispatcherDebugEnabled = YES;
  SoPageInvocationDebugEnabled = YES;
  SoRendererDebugEnabled = YES;
  WOLogComponents = YES;
  WODebugComponentLookup = YES;
  WODebugResourceLookup = YES;
  SoProductResourceManagerDebugEnabled = YES;
  WOResourceURLAssociationDebugEnabled = YES;
  WEResourceManagerDebugEnabled = YES;
  NGLogDefaultLogLevel = "ALL";

On Mon, Jan 5, 2026 at 4:41 PM qhivert <[email protected] <mailto:[email protected]>> wrote:

    Well, no errors in your log, I've tested your sogo.conf and it
    works well...

    Either there is something very obvious that I don't see, or you
    found a very peculiar bug.

    Put that in your sogo.conf and reproduce the problem.

      SoObjectRequestHandlerDebugEnabled = YES;
      SoSelectorInvocationDebugEnabled = YES;
      SoDebugRequestClassification = YES;
      SoDebugObjectTraversal = YES;
      SOGoDebugRequests = YES;
      ImapDebugEnabled = YES;
      ImapLogEnabled = YES;
      MySQL4DebugEnabled = YES;
      SOGoUIxDebugEnabled = YES;
      SoObjectMethodDispatcherDebugEnabled = YES;
      SoPageInvocationDebugEnabled = YES;
      SoRendererDebugEnabled = YES;
      WOLogComponents = YES;
      WODebugComponentLookup = YES;
      WODebugResourceLookup = YES;
      SoProductResourceManagerDebugEnabled = YES;
      WOResourceURLAssociationDebugEnabled = YES;
      WEResourceManagerDebugEnabled = YES;
      NGLogDefaultLogLevel = "ALL";

    Then send me the log directly (not here) in an attachment file please.

    Regards,
-- Quentin Hivert || Alinto || R&D Lead Developer
    19 Quai Perrache 69002 Lyon
    www.alinto.com <http://www.alinto.com>

    -----Original Message-----
    From: [email protected]
    <mailto:[email protected]><[email protected]
    <mailto:[email protected]>> On Behalf Of "Oli Z."
    Sent: lundi 5 janvier 2026 12:37
    To: [email protected] <mailto:[email protected]>
    Subject: Re: [SOGo] Debian 13 / SOGo / 500 error

    update: it added now that table (empty) after
    setting SOGoEnableEMailAlarms to YES, but still the same error.

    Am 05.01.26 um 12:17 schrieb "Oli Z." ([email protected]
    <mailto:[email protected]>):
    > Thanks, that sounds reasonable, but the documentation says this is
    > only required if SOGoEnableEMailAlarms is set. I did not set this
    > flag. I added now:
    > OCSEMailAlarmsFolderURL =
    > "mysql://xx:xxx@localhost/sogo/sogo_alarms_folder"; - and:
    > OCSAdminURL = "mysql://xx:xxx@localhost/sogo/sogo_admin";
    >
    > Because i also found an error because of missing OCSAdminURL.
    > Unfortunately, the error still exists. It added now the sogo_admin
    > table but not the sogo_alarms_folder
    >
    > Am 05.01.26 um 10:35 schrieb qhivert ([email protected]
    <mailto:[email protected]>):
    >> Hello,
    >> I think the table for alarm is missing in this case:
    >> OCSEMailAlarmsFolderURL
    >>


--

Best regards,
Odhiambo WASHINGTON,
Nairobi,KE
+254 7 3200 0004/+254 7 2274 3223

 In an Internet failure case, the #1 suspect is a constant: DNS.
"Oh, the cruft.", egrep -v '^$|^.*#' ¯\_(ツ)_/¯ :-)

[How to ask smart questions: http://www.catb.org/~esr/faqs/smart-questions.html <http://www.catb.org/~esr/faqs/smart-questions.html>]

Attachment: smime.p7s
Description: Kryptografische S/MIME-Signatur

Reply via email to