Daily Usenet report

May 31 04:15:05 -- Jun 1 04:15:03

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

May 31 09:13:50 newsfeed nnrpd[1745]: SERVER perl filter not defined
May 31 09:14:27 newsfeed nnrpd[1896]: SERVER perl filter not defined
May 31 09:14:56 newsfeed nnrpd[1904]: SERVER perl filter not defined

Log entries by program:

Program nameLines%LinesSize%Size
inn2120965 97.9%240.7 MB 97.5%
innd 27394 1.3%4.1 MB 1.7%
nnrpd 9937 0.5%1.0 MB 0.4%
innfeed 7310 0.3%1.1 MB 0.4%
controlchan 4 0.0%0.6 KB 0.0%
TOTAL: 52165610 100.0%246.9 MB100.0%

History cache:

ReasonCount%Count
Do not exist 2111744 93.7%
Negative hits 98698 4.4%
Positive hits 43906 1.9%
Cache misses 296 0.0%
TOTAL: 4 2254644 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:11.839 0.0%411 0.000 28.805 598.000
article cleanup00:00:27.356 0.0%2120537 0.003 0.013 0.179
article logging00:01:14.554 0.1%2120737 0.007 0.035 1.157
article parse01:00:30.882 4.2%72837048 0.018 0.050 0.169
article write00:22:34.831 1.6%2100460 0.323 0.645 2.106
artlog/artcncl00:00:00.007 0.0%404 0.000 0.017 1.000
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:01:56.358 0.1%84663677 0.000 0.001 0.024
hisgrep/artcncl00:00:02.988 0.0%337 0.000 8.866 522.000
hishave/artcncl00:00:01.333 0.0%411 0.000 3.243 255.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup03:03:15.254 12.7%2256050 0.070 4.874 20.500
history sync00:00:00.015 0.0%293 0.000 0.051 8.000
history write04:30:17.484 18.8%2113319 0.128 7.674 35.907
hiswrite/artcncl00:00:00.499 0.0%74 0.000 6.743 98.333
idle08:46:49.136 36.6%45979343 0.190 0.687 10.699
nntp read00:36:58.981 2.6%71241619 0.015 0.031 0.087
overview write00:00:14.225 0.0%2100460 0.001 0.007 0.114
perl filter05:04:20.661 21.1%2113312 5.487 8.641 16.670
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:06:16.536 0.4%4245233 0.009 0.089 0.509
TOTAL: 23:59:50.93423:35:12.939 98.3%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.176 0.0%44320 0.000 0.004 0.205
article prepare00:00:00.001 0.0%29534 0.000 0.000 0.023
article read00:00:00.507 0.0%7042 0.000 0.072 9.333
backlog stats00:00:00.849 0.0%325271 0.000 0.003 3.426
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.885 0.0%194214 0.000 0.015 3.289
data write00:00:06.684 0.0%157924 0.000 0.042 269.000
idle23:59:33.916100.0%325271 0.000 265.544 18090.000
status file00:00:03.040 0.0%215 1.000 14.140 266.000
TOTAL: 23:59:59.08623:59:48.058100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
hisgrep00:00:10.013 0.0%1886 5.309 5.309 5.309
idle71:46:15.916100.0%75698 0.000 3413.246600038.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.142 0.0%153540 0.000 0.047 0.667
readart00:00:01.056 0.0%475 0.000 2.223 48.167
TOTAL: 71:47:19.69671:46:34.127100.0%----

Control commands to INND:

CommandNumber
L 1
flush 24
flushlogs 2
go 2
logmode 2
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 188

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@film.rlss.okayama-u.ac.jp001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1newsfeed.pionier.net.pl 528 21048332087215 753 16865 99%360:35:33
2news.nask.pl 3 19683 6442 11370 1871 32%23:22:34
3news.task.gda.pl 11 30044 6161 22618 1265 20%44:20:43
4news.icm.edu.pl 33 356 5 338 13 1%20:48:44
5localhost 4 3 3 0 0 100%00:00:01
TOTAL: 5 579 21549192099826 35079 20014 97%449:07:35
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1newsfeed.pionier.net.pl623.5 GB132.2 MB1.8 GB625.4 GB 99%311.7 KB
2news.nask.pl149.1 MB17.3 MB17.4 MB183.9 MB 81%22.7 KB
3news.task.gda.pl13.2 MB51.4 KB3.3 MB16.6 MB 79%2.3 KB
4news.icm.edu.pl97.1 KB30.5 KB300.3 KB427.9 KB 22%23.8 KB
5localhost5.3 KB0.0 KB0.0 KB5.3 KB100%1.8 KB
TOTAL: 5623.7 GB149.6 MB1.8 GB625.6 GB 99%309.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 31 04:15:05 - 04:59:59 58089 2.8% 21.5517.8 GB 2.8%6910.28
May 31 05:00:00 - 05:59:59 104717 5.0% 29.0933.6 GB 5.4%9796.77
May 31 06:00:00 - 06:59:59 98183 4.7% 27.2730.7 GB 4.9%8951.78
May 31 07:00:00 - 07:59:59 95131 4.5% 26.4330.0 GB 4.8%8743.59
May 31 08:00:00 - 08:59:59 100468 4.8% 27.9131.5 GB 5.1%9179.47
May 31 09:00:00 - 09:59:59 112394 5.4% 31.2234.9 GB 5.6%10169.52
May 31 10:00:00 - 10:59:59 118103 5.6% 32.8136.9 GB 5.9%10744.71
May 31 11:00:00 - 11:59:59 82561 3.9% 22.9324.4 GB 3.9%7118.40
May 31 12:00:00 - 12:59:59 91845 4.4% 25.5123.4 GB 3.7%6805.24
May 31 13:00:00 - 13:59:59 68496 3.3% 19.0319.9 GB 3.2%5786.96
May 31 14:00:00 - 14:59:59 91298 4.3% 25.3622.2 GB 3.6%6474.92
May 31 15:00:00 - 15:59:59 69494 3.3% 19.3019.2 GB 3.1%5584.52
May 31 16:00:00 - 16:59:59 64321 3.1% 17.8719.5 GB 3.1%5678.60
May 31 17:00:00 - 17:59:59 69093 3.3% 19.1920.1 GB 3.2%5861.81
May 31 18:00:00 - 18:59:59 66700 3.2% 18.5320.5 GB 3.3%5981.89
May 31 19:00:00 - 19:59:59 64788 3.1% 18.0019.3 GB 3.1%5614.58
May 31 20:00:00 - 20:59:59 72838 3.5% 20.2321.0 GB 3.4%6118.76
May 31 21:00:00 - 21:59:59 72570 3.5% 20.1619.7 GB 3.2%5727.25
May 31 22:00:00 - 22:59:59 71967 3.4% 19.9919.5 GB 3.1%5679.15
May 31 23:00:00 - 23:59:59 67725 3.2% 18.8118.1 GB 2.9%5268.11
Jun 1 00:00:00 - 00:59:59 110961 5.3% 30.8231.8 GB 5.1%9257.56
Jun 1 01:00:00 - 01:59:59 108992 5.2% 30.2833.6 GB 5.4%9785.22
Jun 1 02:00:00 - 02:59:59 125330 6.0% 34.8138.5 GB 6.2%11220.28
Jun 1 03:00:00 - 03:59:59 94964 4.5% 26.3831.1 GB 5.0%9069.45
Jun 1 04:00:00 - 04:15:03 19230 0.9% 21.306.2 GB 1.0%7189.49
TOTAL: 23:59:58 2100258 100.0% 24.31623.5 GB 100.0%7566.64
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.pionier.net.pl 17018 358 0 5306 0 0 0 011354
2news.nask.pl 1960 14 0 1880 0 0 0 0 66
3news.task.gda.pl 1312 1102 0 35 0 0 0 0 175
4news.icm.edu.pl 13 0 0 1 0 0 0 0 12
TOTAL: 4 20303 1474 0 7222 0 0 0 011607

Unwanted newsgroups [Top 20]:

NewsgroupCount
uk.railway 139
uk.rec.cycling.moderated 117
mailing.gcc.gcc-cvs 102
mailing.openbsd.source-changes 101
mailing.freebsd.svn-ports-all 86
mailing.freebsd.svn-ports-head 85
mailing.openbsd.ports-changes 65
mailing.postfix.users 46
mailing.freebsd.ports-bugs 41
gmane.linux.alsa.devel 37
mailing.unix.spamassassin-dev 35
mailing.freebsd.svn-src-all 35
fa.freebsd.cvs-all 35
mailing.unix.spamassassin-talk 27
mailing.freebsd.svn-src-head 26
alt.politics.scorched-earth 24
mozilla.dev.gaia 23
mozilla.dev.tree-management 21
mailing.unix.samba 20
mailing.unix.dovecot 20
TOTAL: 90 1474

INND Perl filter [Top 20]:

ReasonCount
Binary in non-binary group 11039
EMP (fsl) 153
HTML post 87
Attached HTML file 84
EMP (md5) 32
Scoring filter (9) 3
Scoring filter (10) 1
Scoring filter (8) 1
TOTAL: 8 11400

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1panorama 49673 2919 40783 759 0 0 5%24:03:51
2icm 65790 1269 36321 2231 3 1 1%24:03:14
3task 2054 166 1009 8 0 0 8%22:50:18
4poznan 13502 31 11638 23 0 0 0%23:51:46
5nask 22010 15 14665 1 0 0 0%24:04:09
6okapi 0 0 0 0 0 2759 0%24:00:01
TOTAL: 6 153029 4400 104416 3022 3 2760 2%142:53:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1icm52.0 MB230.6 MB282.6 MB3.3 KB/s82.7 KB24:03:14
2panorama13.9 MB3.5 MB17.4 MB0.2 KB/s4.8 KB24:03:51
3nask1.4 MB159.4 KB1.5 MB0.0 KB/s98.1 KB24:04:09
4task366.2 KB15.0 KB381.2 KB0.0 KB/s2.2 KB22:50:18
5poznan74.8 KB37.2 KB112.0 KB0.0 KB/s2.1 KB23:51:46
6okapi0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 667.7 MB234.3 MB302.0 MB0.6 KB/s41.7 KB142:53:19
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1vegas.cm.p.lodz.pl 288 304581.5 KB 288 0 000:00:10
2web.man.lodz.pl 288 150156.5 KB 67 0 000:00:19
3212.191.196.1 2 1889.5 KB 2 0 001:39:12
4ech78.neoplus.adsl.tpnet.pl 3 35.3 KB 2 0 000:03:28
5kujawiak.man.lodz.pl 3 00.0 KB 0 3 000:00:00
TOTAL: 5 584 475832.8 KB 359 3 071:47:18

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.cm.p.lodz.pl 288 304581.5 KB 288 0 000:00:10
2*.man.lodz.pl 675 150156.5 KB 67 3 000:00:27
3unresolved 288 1889.5 KB 2 0 049:25:34
4*.neoplus.adsl.tpnet.pl 3 35.3 KB 2 0 000:03:28
5*.207.15.62.static.jazztel.es 3 00.0 KB 0 0 022:17:20
6*.toya.net.pl 39 00.0 KB 0 0 000:00:17
TOTAL: 61296 475832.8 KB 359 3 071:47:18

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
212.191.78.190 1.032 9.688 0.00047:46:21
82.207.15.62.static.jazztel.es 7.628 12.753 0.00022:17:20
212.191.196.1 0.000 0.268 0.00001:39:12
ech78.neoplus.adsl.tpnet.pl 0.004 0.072 0.00000:03:28
web.man.lodz.pl 1.900 19.900 0.00000:00:19
staticline41435.toya.net.pl 0.200 1.472 0.00000:00:17
vegas.cm.p.lodz.pl 2.148 18.148 0.00000:00:10
f-oper-v100.man.lodz.pl 1.412 15.508 0.00000:00:05
david.man.lodz.pl 0.372 3.772 0.00000:00:01
kujawiak.man.lodz.pl 0.024 0.080 0.00000:00:00
TOTAL: 10 14.720 81.661 0.00071:47:18

Curious NNRP server explorers [Top 20]:

SystemConn
f-oper-v100.man.lodz.pl 288
212.191.78.190 286
david.man.lodz.pl 96
staticline41435.toya.net.pl 39
82.207.15.62.static.jazztel.es 3
TOTAL: 5 712

NNRP client timeouts [Top 20]:

SystemConnPeer
82.207.15.62.static.jazztel.es 3 0
212.191.196.1 2 0
TOTAL: 2 5 0

Newsgroup request counts (by category):

CategoryCountPct
1lodman 307 64.6%
2pl 168 35.4%
TOTAL: 2 475100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

NewsgroupCount
1lodman.info 307
2pl.comp.pecet 84
3pl.comp.os.ms-windows.winnt 60
4pl.regionalne.lodz 14
5pl.internet.polip 6
6pl.listserv.chomor-l 4
TOTAL: 6 475