[Pan-users] Re: freeze, high CPU getting new headers

[walt]

On Wed, 06 Aug 2008 23:30:56 +0000, Duncan wrote:

> ...
> Two things would be nice.  1) Timestamps on either/both the strace and
> the gdb, do either of them support that?  Then we could see how long
> it's spending on the poll before returning, for instance.

The -r flag to strace allegedly does that, but I've not tried it yet.

>  2)  Is there
> a way to query the system for the path of a fd from another process...

Try this:
#pidof pan
13522
#ls -l /proc/13522/fd
total 0
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 0 -> /dev/pts/3
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 1 -> /dev/pts/3
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 10 -> socket:[317753]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 11 -> socket:[317765]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 12 -> socket:[317767]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 13 -> socket:[317777]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 14 -> socket:[317782]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 15 -> socket:[317785]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 16 -> socket:[317792]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 17 -> socket:[317794]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 18 -> socket:[317795]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 2 -> /dev/pts/3
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 3 -> socket:[313872]
lr-x------ 1 wa1ter users 64 2008-08-06 17:34 4 -> pipe:[313874]
l-wx------ 1 wa1ter users 64 2008-08-06 17:34 5 -> pipe:[313874]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 6 -> socket:[313920]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 7 -> socket:[317855]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 8 -> socket:[317756]
lrwx------ 1 wa1ter users 64 2008-08-06 17:34 9 -> socket:[317764]

I'm downloading bazillions of headers right now and all pan is talking to 
is sockets, no files.  (BTW, fd 3 is reading mouse input.)

BTW, here is my event log during the header download:
Wed Aug  6 17:34:42 2008 - Loaded 53397 articles for     <======= NOTE 
"alt.binaries.cd.image" in 11.3 seconds (4733 per second)
Wed Aug  6 17:34:46 2008 - Added 1 articles to alt.binaries.cd.image.
Wed Aug  6 17:34:56 2008 - Added 10 articles to alt.binaries.cd.image.
Wed Aug  6 17:35:06 2008 - Added 63 articles to alt.binaries.cd.image.
Wed Aug  6 17:35:16 2008 - Added 73 articles to alt.binaries.cd.image.
Wed Aug  6 17:35:26 2008 - Added 56 articles to alt.binaries.cd.image.
<many more similar events snipped>

These events are all exactly 10 seconds apart, and the number of articles
to be threaded is less than 80 in every case -- a trivial job for a modern
machine.  I don't know what the 53397 articles in 11.3 seconds is about,
but grepping thru pan's source code should tell us that -- tomorrow ;o)