CURRENT branch and older OSes

Julien ÉLIE julien at trigofacile.com
Sun Nov 23 17:15:10 UTC 2008


Hi The Doctor,

> As your were asking:

Thanks!

I see trn gets the information for 4 or 5 groups per second.  Was it faster before?



> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 200 news.nk.ca InterNetNews NNRP server INN 2.5.0 (20081122 
> snapshot) ready (posting ok)
> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < MODE READER
> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 200 news.nk.ca InterNetNews NNRP server INN 2.5.0 (20081122 
> snapshot) ready (posting ok)
> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < LIST active control
> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 215 Newsgroups in form "group high low flags"
> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < XOVER
> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 412 Not in a newsgroup

It is very weird that trn sends XOVER at that point.
Is it checking whether the answer is 412 or 500?  (that is to say whether XOVER is available)



> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < LIST active alt.binaries.drwho
> Nov 23 09:21:48 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 215 Newsgroups in form "group high low flags"
[...]
> Nov 23 09:22:45 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < LIST active comp.sys.apple2.programmer
> Nov 23 09:22:45 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 215 Newsgroups in form "group high low flags"
> Nov 23 09:22:52 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < LIST active alt.drwho.creative
> Nov 23 09:22:52 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 215 Newsgroups in form "group high low flags"

It takes time!  More than a minute at initial connection?
Is there a hang of 7 seconds of trn at the end (09:22:45 -- 09:22:52) or was the output cut?
If you cut it, please add "[...]" or anything else to properly say it.



> Nov 23 09:22:57 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < LIST active alt.drwho.creative
> Nov 23 09:22:57 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 215 Newsgroups in form "group high low flags"
[...]
> Nov 23 09:23:08 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < LIST active can.politics
> Nov 23 09:23:08 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 215 Newsgroups in form "group high low flags"

11 seconds when you went backwards?
But why are there less groups scanned than at initial connection?  How does trn chooses
what it refreshes?



> Nov 23 09:25:41 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < LIST active can.taxes
> Nov 23 09:25:41 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 215 Newsgroups in form "group high low flags"
> Nov 23 09:26:03 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca < LIST active can.talk.smoking
> Nov 23 09:26:03 gallifrey doctor[3]: nnrpd[1205]: doctor.nl2k.ab.ca > 215 Newsgroups in form "group high low flags"

Note that there is a hang of 22 seconds.  What does trn do during that time?


Did you compare the "same" logs with INN 2.4.x to see where it goes faster?

-- 
Julien ÉLIE

« Donner un sens plus pur aux mots de la tribu. » (Stéphane Mallarmé)




More information about the inn-workers mailing list