• Domino 7 error after restart

    By Karl Wolny 2 decades ago

    Hello,



    we are using kSpam 1.6b2 with Domino 7.0.2 on SLES 10 (SuSE Linux Enterprise Server). The Domino server is shut down every day at 00:15 for backup and after that started again by a shell script.

    The server crashes very often (at intervals of 1-2 days) when it receives the first mails by SMTP after it was started again. Domino log says:







    13.02.2007 07:00:35,49 [08377:00007–1311556704] SMTP CIServ Listen> Connection Accepted on Port 125 for Session 0C420004

    13.02.2007 07:00:35,52 [08377:00010–1606939744] SMTP CITask StateMachine> Sent 115 bytes to 127.0.0.1

    13.02.2007 07:00:35,52 [08377:00010–1606939744] SMTP CITask StateMachine> Received 14 bytes from 127.0.0.1

    13.02.2007 07:00:35,53 [08377:00010–1606939744] SMTP CITask StateMachine> Sent 118 bytes to 127.0.0.1

    13.02.2007 07:00:35,53 [08377:00010–1606939744] SMTP CITask StateMachine> Received 30 bytes from 127.0.0.1

    13.02.2007 07:00:35,54 [08377:00010–1606939744] SMTP CITask StateMachine> Sent 37 bytes to 127.0.0.1

    13.02.2007 07:00:35,54 [08377:00010–1606939744] SMTP CITask StateMachine> Received 40 bytes from 127.0.0.1

    13.02.2007 07:00:35,54 [08377:00010–1606939744] SMTP CITask StateMachine> Sent 52 bytes to 127.0.0.1

    13.02.2007 07:00:35,54 [08377:00010–1606939744] SMTP CITask StateMachine> Received 4 bytes from 127.0.0.1

    13.02.2007 07:00:35,55 [08377:00010–1606939744] SMTP CITask StateMachine> Sent 53 bytes to 127.0.0.1

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] State change from Greeting to Greeting

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] Processing in Greeting state

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] State change from Greeting to Connected

    13.02.2007 07:00:35,60 [08377:00010–1606939744] SMTP CITask StateMachine> ITASK_STATE_RECV_TEXT: Received total line 30, 1 bytes from 127.0.0.1

    13.02.2007 07:00:35 SMTP Server: 127.0.0.1 connected

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] EHLO command received

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] MAIL command received

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] RCPT command received

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] DATA command received

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00010–1606939744] DATA command (cont.)

    13.02.2007 07:00:35,71 [08377:00007–1311556704] SMTP CIServ Listen> Connection Accepted on Port 125 for Session 0C510003

    13.02.2007 07:00:35,71 [08377:00012–1607205984] SMTP CITask StateMachine> Sent 115 bytes to 127.0.0.1

    13.02.2007 07:00:35,71 [08377:00012–1607205984] SMTP CITask StateMachine> Received 14 bytes from 127.0.0.1

    13.02.2007 07:00:35,72 [08377:00012–1607205984] SMTP CITask StateMachine> Sent 118 bytes to 127.0.0.1

    13.02.2007 07:00:35,72 [08377:00012–1607205984] SMTP CITask StateMachine> Received 34 bytes from 127.0.0.1

    13.02.2007 07:00:35,72 [08377:00012–1607205984] SMTP CITask StateMachine> Sent 41 bytes to 127.0.0.1

    13.02.2007 07:00:35,72 [08377:00012–1607205984] SMTP CITask StateMachine> Received 40 bytes from 127.0.0.1

    13.02.2007 07:00:35,72 [08377:00012–1607205984] SMTP CITask StateMachine> Sent 52 bytes to 127.0.0.1

    13.02.2007 07:00:35,73 [08377:00012–1607205984] SMTP CITask StateMachine> Received 4 bytes from 127.0.0.1

    13.02.2007 07:00:35,73 [08377:00012–1607205984] SMTP CITask StateMachine> Sent 53 bytes to 127.0.0.1

    13.02.2007 07:00:35,77 [08377:00012–1607205984] SMTP CITask StateMachine> ITASK_STATE_RECV_TEXT: Received total line 17, 1 bytes from 127.0.0.1

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] State change from Greeting to Greeting

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] Processing in Greeting state

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] State change from Greeting to Connected

    13.02.2007 07:00:35 SMTP Server: 127.0.0.1 connected

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] EHLO command received

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] MAIL command received

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] RCPT command received

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] DATA command received

    13.02.2007 07:00:35 kSpam: BetaVersion Blacklist doc_Conf & Reload

    13.02.2007 07:00:35 kSpam.extmgr: Loading rules

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] Processing in Connected state

    13.02.2007 07:00:35 SMTP Server [08377:00012–1607205984] DATA command (cont.)

    Stack base = 0xa033f54c, Stack size = 23452 bytes

    Fatal Error signal = 0x0000000b PID/TID = 8377/-1607205984

    13/2/2007 7:00:36 Running NSD

    NSD is in progress ……………..

    Please attach the following files to your bug report along with the server log:

    Log file :



    /Daten01/IBM_TECHNICAL_SUPPORT/nsd_Linux_DOM1_2007_02_13@07_00_45.log

    13/2/2007 7:02:15 Termination is in progress

    13/2/2007 7:02:15 Terminating tasks

    13/2/2007 7:02:17 Freeing resources





    After that Domino works mostly well. Besides it crashes sometimes (not very often) during the shutdown process.

    When kSpam (both, ExtMgr addin and server task) is disabled the server works without any problems. We have tested that for a week.

    Does anybody have an idea or a hint what can we do? We would appreciate any help.

    Thanks in advance.

    • Configuration

      By Tom Lyne 2 decades ago

      Does this occur when bload is not running and the Bayesian filter is turned off?



      How many rules do you have in the configuration database?



      Rgds,

      Tom

      • Log's with loglevel=3

        By Hans-Georg Franke 2 decades ago

        Log's with loglevel=3

        • Where to set it?

          By Karl Wolny 2 decades ago

          Hello,



          can you tell me, where should we set the loglevel to 3?



          Thank you.

          Best regards

          • in notes.ini

            By Hans-Georg Franke 2 decades ago

            please set:

            KS_DEBUG=3

            KS_BL_DEBUG=3

            then you will find:

            bload.txt for kspam-servertask and kspam.log for kspam-extensionmanager.

            Check your settings in KSpamConf.nsf (look out for debug….)

            Hans-Georg

      • Configuration and conjecture

        By Karl Wolny 2 decades ago

        Hello,



        when it occurs bload has mostly already finished it's work but is still loaded. We have not tried it without bload. The Bayesian is enabled and there are 17 rules.

        After looking into 'ks_log.txt' for the entries which were made at a time of crash, we have noticed that 2 mails came at once and their entries are nested. One of the

        entries contains 'Read pointer size to'. Here is an excerpt from 'ks_log.txt' (the crash was at 13.02.2007 07:00:36):





        13.02.2007 00:00:26 - Form: Memo

        *SUBJECT:do eleven*<br/>
        *FROM:charge is &lt;cgcbass@veng.com&gt;*<br/>
        *MAIL_FROM:cgcbass@veng.com*<br/>
        *BODY LENGTH: 7251* <br/>
        *ATTACHMENT: alliance.gif*<br/>
        *Scanning message*<br/>
        *P:0,0018*<br/>
        



        Number of rules: 17

        Reloading configuration…

        freeing rule list

        freed rule list

        loading rule list…

        Number of rules: 17

        13.02.2007 07:00:36 - Form: Memo

        *SUBJECT:Citibank Deutschland:  Mon, 12 Feb. 2007 12:07:01*<br/>
        *FROM:&quot;Citibank Deutschland&quot; &lt;sicherheit@citibank.de&gt;*<br/>
        *MAIL_FROM:info@awilson.co.uk*<br/>
        

        13.02.2007 07:00:36 - Form: Memo

        *SUBJECT:Citibank Deutschland:  Mon, 12 Feb. 2007 12:07:01*<br/>
        *FROM:Citibank Deutschland &lt;sicherheit@citibank.de&gt;*<br/>
        *MAIL_FROM:sicherheit@citibank.de*<br/>
        *BODY LENGTH: 5174* <br/>
        *Scanning message*<br/>
        

        Read pointer size to BODY LENGTH: 5103

        *Scanning message*<br/>
        

        Number of rules: 17

        13.02.2007 09:40:58 - Form: Memo

        *SUBJECT:it explanation be vocalic*<br/>
        *FROM:&quot;Kathleen Short&quot; &lt;zdpproud@everymail.net&gt;*<br/>
        *MAIL_FROM:zdpproud@everymail.net*<br/>
        *BODY LENGTH: 7844* <br/>
        *ATTACHMENT: malleable.gif*<br/>
        *Scanning message*<br/>
        

        Read pointer size to P:1,0000

        *Copying to goodmail*<br/>
        *ALLOW*<br/>
        



        13.02.2007 09:41:05 - Form: Memo

        *SUBJECT:Or casket be sally*<br/>
        *FROM:&quot;Desiree Mcclure&quot; &lt;rvdevilish@chenbiao.com&gt;*<br/>
        *MAIL_FROM:rvdevilish@chenbiao.com*<br/>
        *BODY LENGTH: 7809* <br/>
        *ATTACHMENT: catv.gif*<br/>
        *Scanning message*<br/>
        *P:1,0000*<br/>
        *Copying to goodmail*<br/>
        *ALLOW*<br/>
        





        There are nested entries at a time where no crash happened, but these do not contain 'Read pointer size to'. So, we assume it could be involved in the problem. Maybe, the problem occurs in 'ks_load_bayesian_data()'?



        Best regards

      • Source code

        By Karl Wolny 2 decades ago

        Hello,



        we have the source code of 1.6b2. Does there exist a newer version of source code for Linux?

        As we need a solution, we would like to try to find the problem and fix it. Or is somebody already on it? Thank you in advance.



        Best regards

        • By Nico Vis 2 decades ago

          Hi

          Karl, sorry for being late.

          The problem with reloading of rules is an old one. We fixed it with the last two versions.

          Reloading of rules has to be done without the scanning of any messages.

          Please write to me nvisATlinkgroupDOTit as I can explain better and we can find a stable solution.



          Regards



          Nico