continues thread_start problem

[Alexis Yushin <alexis@NL.net>]

Hi,

	Still the same problem and perhaps someone who has more
understanding of what that could be could fix it faster than me.
So...

This one goes pretty well:
TURNME: suske.NL.net
thread_start(thr=smtpq/0/suske.nl.net) (dt=-872152537, thr=0x36f98)

transport(vhead,chan=smtpq,host=suske.nl.net)
$ /usr/local/bin/ta/smtp -c smtpq -Ps -l /var/log/mail/suske.smtp
to 6/7 from 7/6
stashprocess(1906, 7, 7, smtpq, suske.nl.net)
scheduler: unlink(252685): No such file or directory
completed, unlink 252685
curitem 3d1f8 curitem->wakeup 872757297 now 872152537
read from 7 returns 8
1906 fd=7 processed: #hungry
pick_next_vertex(proc->tofd=7, thr=0x36f98, vtx=0x367d0, jobs=1 ok=1 justfree=0)
 ... NONE, current one has not been fed..
feed: tofd=7, fed=0, chan=smtpq, proc=0x3ff30, vtx=0x367d0, len=27 buf=Q/252684-
1635    suske.nl.net
pick_next_vertex(proc->tofd=7, thr=0x36f98, vtx=0x367d0, jobs=1 ok=1 justfree=0)
 ... overfed=1, no thread change.
read from 7 returns 8, errno=0
dirqueuescan(dir='.') wrksum=0 new=0
curitem 3d1f8 curitem->wakeup 872757297 now 872152547
dirqueuescan(dir='.') wrksum=0 new=0
idle_cleanup()
curitem 3d1f8 curitem->wakeup 872757297 now 872152557
dirqueuescan(dir='.') wrksum=0 new=0
curitem 3d1f8 curitem->wakeup 872757297 now 872152567
sig_chld() pid=1911, ok=0, stat=0x0
sig_chld() pid=1913, ok=0, stat=0x0
dirqueuescan(dir='.') wrksum=0 new=0
idle_cleanup()
curitem 3d1f8 curitem->wakeup 872757297 now 872152577
dirqueuescan(dir='.') wrksum=0 new=0
curitem 3d1f8 curitem->wakeup 872757297 now 872152587
sig_chld() pid=1915, ok=0, stat=0x0
dirqueuescan(dir='.') wrksum=0 new=0
idle_cleanup()
curitem 3d1f8 curitem->wakeup 872757297 now 872152597
dirqueuescan(dir='.') wrksum=0 new=0
curitem 3d1f8 curitem->wakeup 872757297 now 872152607
read from 7 returns 248
1906 fd=7 processed: 252684/126 eric@suske.NL.net^Afailed^A5.4.1 (TCP/IP-connect
ion failure)^Asmtp; 500 (connect to suske.nl.net [193.78.250.34]: Connection tim
ed out)^Adns; suske.nl.net      retryat +60 smtp; 500 (connect to suske.nl.net [
193.78.250.34]: Connection timed out)
diagnostic: 252684/126  eric@suske.NL.net^Afailed^A5.4.1 (TCP/IP-connection fail
ure)^Asmtp; 500 (connect to suske.nl.net [193.78.250.34]: Connection timed out)
^Adns; suske.nl.net     retryat
pick_next_vertex(proc->tofd=7, thr=0x36f98, vtx=0x367d0, jobs=1 ok=0 justfree=0)
 ... overfed=1, no thread change.
thread_reschedule() ch=smtpq ho=suske.nl.net jobs=1
read from 7 returns 248, errno=0
read from 7 returns 8
1906 fd=7 processed: #hungry
pick_next_vertex(proc->tofd=7, thr=0x36f98, vtx=0x367d0, jobs=1 ok=1 justfree=0)
 ... NONE, idle the process (of=0, f=1).
read from 7 returns 8, errno=0
read from 7 returns 8
1906 fd=7 processed: #hungry
pick_next_vertex(proc->tofd=7, thr=0x0, vtx=0x0, jobs=0 ok=1 justfree=0)
 ... NONE, we are idle.
read from 7 returns 8, errno=0
dirqueuescan(dir='.') wrksum=0 new=0

But any subsequent one would:
TURNME: suske.Nl.net
thread_start(thr=smtpq/0/suske.nl.net) (dt=-872152777, thr=0x36f98)

feed: tofd=7, fed=0, chan=smtpq, proc=0x3ff30, vtx=0x367d0, len=27 buf=Q/252684-
1635    suske.nl.net
pick_next_vertex(proc->tofd=7, thr=0x36f98, vtx=0x367d0, jobs=1 ok=1 justfree=0)
 ... overfed=1, no thread change.
scheduler: unlink(252685): No such file or directory
completed, unlink 252685
curitem 3d1f8 curitem->wakeup 872757297 now 872152777
sig_chld() pid=1937, ok=0, stat=0x0
sig_chld() pid=1939, ok=0, stat=0x0
dirqueuescan(dir='.') wrksum=0 new=0
curitem 3d1f8 curitem->wakeup 872757297 now 872152787
dirqueuescan(dir='.') wrksum=0 new=0
idle_cleanup()
curitem 3d1f8 curitem->wakeup 872757297 now 872152797
sig_chld() pid=1944, ok=0, stat=0x0
dirqueuescan(dir='.') wrksum=0 new=0
curitem 3d1f8 curitem->wakeup 872757297 now 872152807
dirqueuescan(dir='.') wrksum=0 new=0
idle_cleanup()
curitem 3d1f8 curitem->wakeup 872757297 now 872152817
dirqueuescan(dir='.') wrksum=0 new=0
curitem 3d1f8 curitem->wakeup 872757297 now 872152827
dirqueuescan(dir='.') wrksum=0 new=0
idle_cleanup()
curitem 3d1f8 curitem->wakeup 872757297 now 872152837
dirqueuescan(dir='.') wrksum=0 new=0
curitem 3d1f8 curitem->wakeup 872757297 now 872152847
sig_chld() pid=1946, ok=0, stat=0x0
read from 7 returns 248
1906 fd=7 processed: 252684/126 eric@suske.NL.net^Afailed^A5.4.1 (TCP/IP-connect
ion failure)^Asmtp; 500 (connect to suske.nl.net [193.78.250.34]: Connection tim
ed out)^Adns; suske.nl.net      retryat +60 smtp; 500 (connect to suske.nl.net [
193.78.250.34]: Connection timed out)
diagnostic: 252684/126  eric@suske.NL.net^Afailed^A5.4.1 (TCP/IP-connection fail
ure)^Asmtp; 500 (connect to suske.nl.net [193.78.250.34]: Connection timed out)
^Adns; suske.nl.net     retryat
pick_next_vertex(proc->tofd=7, thr=0x36f98, vtx=0x367d0, jobs=1 ok=0 justfree=0)
 ... overfed=1, no thread change.
thread_reschedule() ch=smtpq ho=suske.nl.net jobs=1
...prescheduled
read from 7 returns 248, errno=0
read from 7 returns 8
1906 fd=7 processed: #hungry
pick_next_vertex(proc->tofd=7, thr=0x36f98, vtx=0x367d0, jobs=1 ok=1 justfree=0)
 ... NONE, idle the process (of=0, f=1).
read from 7 returns 8, errno=0
read from 7 returns 8
1906 fd=7 processed: #hungry
pick_next_vertex(proc->tofd=7, thr=0x0, vtx=0x0, jobs=0 ok=1 justfree=0)
 ... NONE, we are idle.


	So it says we are already prescheduled, but how could that
be if TURNME flushed wakeup to zero? After that of course it goes
continuesly to thread_start if from do_agenda because the process
is idle and wakeup == 0 (I've checked) So the problem is that in
do_agenda wakeup turns out to be 0, while it would be rescheduled
for somewhat later. I am still fighting with this, but any input is
highly appreciable.
							alexis
-- 
	 	Don't question why she needs to be so free...