James, thank you - but this Log does not help! We can see for example:
Apr-16-09 17:58:08 [Main_Thread] Info: Loop in Worker_1 was not active for 17051 seconds Apr-16-09 17:58:08 [Main_Thread] Info: Worker_1 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:13:57 1239851637.07158 - 12909 Apr-16-09 17:58:08 [Main_Thread] Info: Worker_1 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:14:02 1239851642.47042 - 12964 That meens: the Worker_1 was not out of his MainLoop for 17051 seconds. The last registration (off) and (on) to the signalhandler from DKIMpreCheckOK, is the last known good state! So what I need to know, is the last action(s) at 13:14:02 (some seconds before and maybe after - is there any log entry from Worker_1 after 13:14:02?) ! The Worker is doing most of his work, without signal-registration, so it is possible, that some more actions are done (and resulting in stuck) after the last signal-registation. The DKIMpreCheckOK was OK, the next possible action depends on your configuration! Thomas James Brown <[email protected]> 16.04.2009 13:18 Bitte antworten an ASSP development mailing list <[email protected]> An ASSP development mailing list <[email protected]> Kopie Thema Re: [Assp-test] Antwort: ASSP frozen? Loop not active On 16/04/2009, at 4:36 PM, Thomas Eckardt/eck wrote: > James, > > please go back in Log to the point where a worker has done his last > action. > >> Apr-16-09 06:14:38 [Main_Thread] Info: Loop in Worker_2 was not >> active > for 17978 seconds > >> 17978 seconds > > > I need to know, what is the next step of the worker after doing > DKIMpreCheckOK. This step must be finished (reading the Log). > > Thomas Hi Thomas. It happened again. Here is more of the log: Apr-16-09 17:55:56 [Main_Thread] Info: Worker_6 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 16:20:07 1239862807.42009 - 12909 Apr-16-09 17:55:56 [Main_Thread] Info: Worker_6 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 16:20:12 1239862812.94014 - 12964 Apr-16-09 17:55:56 [Main_Thread] Info: Loop in Worker_8 was not active for 1012 seconds Apr-16-09 17:55:56 [Main_Thread] Info: Worker_8 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 17:39:03 1239867543.53485 - 7080 Apr-16-09 17:55:56 [Main_Thread] Info: Worker_8 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 17:39:03 1239867543.53501 - 7082 Apr-16-09 17:55:56 [Main_Thread] Info: Loop in Worker_9 was not active for 958 seconds Apr-16-09 17:55:56 [Main_Thread] Info: Worker_9 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 17:39:57 1239867597.15394 - 12909 Apr-16-09 17:55:56 [Main_Thread] Info: Worker_9 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 17:39:57 1239867597.17008 - 12964 Apr-16-09 17:55:56 [Worker_7] Connected: 192.168.1.2:61670 -> 192.168.1.9:25 -> 127.0.0.1:10026 , 23-24 Apr-16-09 17:56:18 id-68574-00833 [Worker_7] [preDKIM] 192.168.1.2 <[email protected] > to: [email protected] [[scoring]] DKIM domain missmatch - bignotemusic.com found in DKIMCache, but no DKIM-Signature found in mail header (Cache) Apr-16-09 17:56:18 id-68574-00833 [Worker_7] 192.168.1.2 <[email protected] > to: [email protected] Message-Score: total for this message is 15, added 15 for DKIM domain missmatch - bignotemusic.com found in DKIMCache, but no DKIM-Signature found in mail header Apr-16-09 17:56:20 id-68574-00833 [Worker_7] 192.168.1.2 <[email protected] > to: [email protected] Message-Score: total for this message is 60, added 45 for virus detected: 'Sanesecurity.Junk.14443.UNOFFICIAL' Apr-16-09 17:56:20 id-68574-00833 [Worker_7] [VIRUS] 192.168.1.2 <[email protected] > to: [email protected] [spam found] (virus detected: 'Sanesecurity.Junk.14443.UNOFFICIAL') [Get 250 business cards plus a glossy finish backside printing all FREE]; Apr-16-09 17:56:20 [Worker_7] Disconnected: 192.168.1.2 Apr-16-09 17:58:08 [Main_Thread] Info: Loop in Worker_1 was not active for 17051 seconds Apr-16-09 17:58:08 [Main_Thread] Info: Worker_1 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:13:57 1239851637.07158 - 12909 Apr-16-09 17:58:08 [Main_Thread] Info: Worker_1 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:14:02 1239851642.47042 - 12964 Apr-16-09 17:58:08 [Main_Thread] Info: Loop in Worker_2 was not active for 10300 seconds Apr-16-09 17:58:08 [Main_Thread] Info: Worker_2 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 15:06:28 1239858388.4971 - 12909 Apr-16-09 17:58:08 [Main_Thread] Info: Worker_2 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 15:06:28 1239858388.5486 - 12964 Apr-16-09 17:58:08 [Main_Thread] Info: Loop in Worker_3 was not active for 16385 seconds Apr-16-09 17:58:08 [Main_Thread] Info: Worker_3 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 13:25:03 1239852303.06135 - 7080 Apr-16-09 17:58:08 [Main_Thread] Info: Worker_3 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 13:25:03 1239852303.06149 - 7082 Apr-16-09 17:58:08 [Main_Thread] Info: Loop in Worker_4 was not active for 16085 seconds Apr-16-09 17:58:08 [Main_Thread] Info: Worker_4 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:30:03 1239852603.17785 - 12909 Apr-16-09 17:58:08 [Main_Thread] Info: Worker_4 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:30:03 1239852603.19265 - 12964 Apr-16-09 17:58:08 [Main_Thread] Info: Loop in Worker_5 was not active for 1927 seconds Apr-16-09 17:58:08 [Main_Thread] Info: Worker_5 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 17:26:01 1239866761.36503 - 7080 Apr-16-09 17:58:08 [Main_Thread] Info: Worker_5 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 17:26:01 1239866761.36517 - 7082 Apr-16-09 17:58:09 [Main_Thread] Info: Loop in Worker_6 was not active for 5881 seconds Apr-16-09 17:58:09 [Main_Thread] Info: Worker_6 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 16:20:07 1239862807.42009 - 12909 Apr-16-09 17:58:09 [Main_Thread] Info: Worker_6 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 16:20:12 1239862812.94014 - 12964 Apr-16-09 17:58:09 [Main_Thread] Info: Loop in Worker_8 was not active for 1145 seconds Apr-16-09 17:58:09 [Main_Thread] Info: Worker_8 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 17:39:03 1239867543.53485 - 7080 Apr-16-09 17:58:09 [Main_Thread] Info: Worker_8 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 17:39:03 1239867543.53501 - 7082 Apr-16-09 17:58:09 [Main_Thread] Info: Loop in Worker_9 was not active for 1091 seconds Apr-16-09 17:58:09 [Main_Thread] Info: Worker_9 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 17:39:57 1239867597.15394 - 12909 Apr-16-09 17:58:09 [Main_Thread] Info: Worker_9 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 17:39:57 1239867597.17008 - 12964 Apr-16-09 17:58:09 [Worker_7] Connected: 192.168.1.30:52755 -> 192.168.1.9:2525 -> 192.168.1.9:10026 , 23-24 Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] whitelist addition: [email protected] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] [Local] 192.168.1.30 <[email protected] > to: [email protected] local (no bad attachments) [Re CEO INSTITUTE GROUP 17 Query re trademarks] -> nocollect:freq Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] info: queued first data in sendqueue Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] convert and send data from sendqueue Apr-16-09 17:58:17 id-68692-00253 [Worker_7] [MessageOK] 192.168.1.30 <[email protected] > to: [email protected] message ok [Re CEO INSTITUTE GROUP 17 Query re trademarks] Apr-16-09 17:58:17 id-68692-00253 [Worker_7] 192.168.1.30 <[email protected] > to: [email protected] info: no MIME/TNEF conversion done Apr-16-09 17:58:21 [Main_Thread] Info: Loop in Worker_1 was not active for 17064 seconds Apr-16-09 17:58:21 [Main_Thread] Info: Worker_1 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:13:57 1239851637.07158 - 12909 Apr-16-09 17:58:21 [Main_Thread] Info: Worker_1 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:14:02 1239851642.47042 - 12964 Apr-16-09 17:58:21 [Main_Thread] Info: Loop in Worker_2 was not active for 10313 seconds Apr-16-09 17:58:21 [Main_Thread] Info: Worker_2 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 15:06:28 1239858388.4971 - 12909 Apr-16-09 17:58:21 [Main_Thread] Info: Worker_2 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 15:06:28 1239858388.5486 - 12964 Apr-16-09 17:58:21 [Main_Thread] Info: Loop in Worker_3 was not active for 16398 seconds Apr-16-09 17:58:21 [Main_Thread] Info: Worker_3 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 13:25:03 1239852303.06135 - 7080 Apr-16-09 17:58:21 [Main_Thread] Info: Worker_3 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 13:25:03 1239852303.06149 - 7082 Apr-16-09 17:58:21 [Main_Thread] Info: Loop in Worker_4 was not active for 16098 seconds Apr-16-09 17:58:21 [Main_Thread] Info: Worker_4 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:30:03 1239852603.17785 - 12909 Apr-16-09 17:58:21 [Main_Thread] Info: Worker_4 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:30:03 1239852603.19265 - 12964 Apr-16-09 17:58:21 [Main_Thread] Info: Loop in Worker_5 was not active for 1940 seconds Apr-16-09 17:58:21 [Main_Thread] Info: Worker_5 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 17:26:01 1239866761.36503 - 7080 Apr-16-09 17:58:21 [Main_Thread] Info: Worker_5 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 17:26:01 1239866761.36517 - 7082 Apr-16-09 17:58:21 [Main_Thread] Info: Loop in Worker_6 was not active for 5894 seconds Apr-16-09 17:58:21 [Main_Thread] Info: Worker_6 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 16:20:07 1239862807.42009 - 12909 Apr-16-09 17:58:21 [Main_Thread] Info: Worker_6 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 16:20:12 1239862812.94014 - 12964 Apr-16-09 17:58:21 [Main_Thread] Info: Loop in Worker_8 was not active for 1158 seconds Apr-16-09 17:58:21 [Main_Thread] Info: Worker_8 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 17:39:03 1239867543.53485 - 7080 Apr-16-09 17:58:22 [Main_Thread] Info: Worker_8 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 17:39:03 1239867543.53501 - 7082 Apr-16-09 17:58:22 [Main_Thread] Info: Loop in Worker_9 was not active for 1104 seconds Apr-16-09 17:58:22 [Main_Thread] Info: Worker_9 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 17:39:57 1239867597.15394 - 12909 Apr-16-09 17:58:22 [Main_Thread] Info: Worker_9 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 17:39:57 1239867597.17008 - 12964 Apr-16-09 17:58:22 [Worker_10] Connected: 192.168.1.33:56564 -> 192.168.1.9:2525 -> 192.168.1.9:10026 , 29-30 Apr-16-09 17:58:23 [Main_Thread] Info: Loop in Worker_1 was not active for 17066 seconds Apr-16-09 17:58:23 [Main_Thread] Info: Worker_1 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:13:57 1239851637.07158 - 12909 Apr-16-09 17:58:23 [Main_Thread] Info: Worker_1 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:14:02 1239851642.47042 - 12964 Apr-16-09 17:58:23 [Main_Thread] Info: Loop in Worker_2 was not active for 10315 seconds Apr-16-09 17:58:23 [Main_Thread] Info: Worker_2 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 15:06:28 1239858388.4971 - 12909 Apr-16-09 17:58:23 [Main_Thread] Info: Worker_2 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 15:06:28 1239858388.5486 - 12964 Apr-16-09 17:58:23 [Main_Thread] Info: Loop in Worker_3 was not active for 16400 seconds Apr-16-09 17:58:23 [Main_Thread] Info: Worker_3 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 13:25:03 1239852303.06135 - 7080 Apr-16-09 17:58:23 [Main_Thread] Info: Worker_3 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 13:25:03 1239852303.06149 - 7082 Apr-16-09 17:58:23 [Main_Thread] Info: Loop in Worker_4 was not active for 16100 seconds Apr-16-09 17:58:23 [Main_Thread] Info: Worker_4 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:30:03 1239852603.17785 - 12909 Apr-16-09 17:58:23 [Main_Thread] Info: Worker_4 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 13:30:03 1239852603.19265 - 12964 Apr-16-09 17:58:23 [Main_Thread] Info: Loop in Worker_5 was not active for 1942 seconds Apr-16-09 17:58:23 [Main_Thread] Info: Worker_5 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 17:26:01 1239866761.36503 - 7080 Apr-16-09 17:58:23 [Main_Thread] Info: Worker_5 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 17:26:01 1239866761.36517 - 7082 Apr-16-09 17:58:23 [Main_Thread] Info: Loop in Worker_6 was not active for 5896 seconds Apr-16-09 17:58:23 [Main_Thread] Info: Worker_6 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 16:20:07 1239862807.42009 - 12909 Apr-16-09 17:58:23 [Main_Thread] Info: Worker_6 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 16:20:12 1239862812.94014 - 12964 Apr-16-09 17:58:23 [Main_Thread] Info: Loop in Worker_8 was not active for 1160 seconds Apr-16-09 17:58:23 [Main_Thread] Info: Worker_8 : last sigoff in main, /Applications/assp/assp.pl, 7080, main::sigoffTry, 1, , , at Apr-16-09 17:39:03 1239867543.53485 - 7080 Apr-16-09 17:58:23 [Main_Thread] Info: Worker_8 : last sigon in main, / Applications/assp/assp.pl, 7082, main::sigonTry, 1, , , at Apr-16-09 17:39:03 1239867543.53501 - 7082 Apr-16-09 17:58:23 [Main_Thread] Info: Loop in Worker_9 was not active for 1106 seconds Apr-16-09 17:58:23 [Main_Thread] Info: Worker_9 : last sigoff in main, /Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 17:39:57 1239867597.15394 - 12909 Apr-16-09 17:58:24 [Main_Thread] Info: Worker_9 : last sigon in main, / Applications/assp/assp.pl, 11047, main::DKIMpreCheckOK, 1, 0, , at Apr-16-09 17:39:57 1239867597.17008 - 12964 Apr-16-09 17:58:24 [Worker_10] Connected: 192.168.1.33:56566 -> 192.168.1.9:25 -> 127.0.0.1:10026 , 31-32 ------------------------------------------------------------------------------ Stay on top of everything new and different, both inside and around Java (TM) technology - register by April 22, and save $200 on the JavaOne (SM) conference, June 2-5, 2009, San Francisco. 300 plus technical and hands-on sessions. Register today. Use priority code J9JMT32. http://p.sf.net/sfu/p _______________________________________________ Assp-test mailing list [email protected] https://lists.sourceforge.net/lists/listinfo/assp-test DISCLAIMER: ******************************************************* This email and any files transmitted with it may be confidential, legally privileged and protected in law and are intended solely for the use of the individual to whom it is addressed. This email was multiple times scanned for viruses. There should be no known virus in this email! ******************************************************* ------------------------------------------------------------------------------ Stay on top of everything new and different, both inside and around Java (TM) technology - register by April 22, and save $200 on the JavaOne (SM) conference, June 2-5, 2009, San Francisco. 300 plus technical and hands-on sessions. Register today. Use priority code J9JMT32. http://p.sf.net/sfu/p _______________________________________________ Assp-test mailing list [email protected] https://lists.sourceforge.net/lists/listinfo/assp-test
