Daily Usenet report for paganini.linuxd.org

Apr 1 00:00:01 -- Apr 2 00:00:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Apr 1 01:06:24 paganini pgpverify[14830]: pgpverify: verification failed
Apr 1 01:35:09 paganini overchan[839]: input line too long, skipping
Apr 1 07:04:04 paganini pgpverify[32070]: pgpverify: verification failed
Apr 1 07:20:19 paganini overchan[839]: input line too long, skipping
Apr 1 20:24:06 paganini overchan[839]: input line too long, skipping

Log entries by program:

Program nameLines%LinesSize%Size
inn 52541 70.5%11.0 MB 81.3%
innd 19073 25.6%2.2 MB 16.1%
innfeed 1988 2.7%260.9 KB 1.9%
nnrpd 771 1.0%88.6 KB 0.6%
nocem 104 0.1%12.3 KB 0.1%
controlchan 8 0.0%1.3 KB 0.0%
overchan 3 0.0%0.3 KB 0.0%
pgpverify 2 0.0%0.5 KB 0.0%
TOTAL: 8 74490 100.0%13.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 336137 55.5%
Negative hits 217120 35.9%
Do not exist 51744 8.5%
Cache misses 275 0.0%
TOTAL: 4 605276 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:02.011 0.0%388 0.000 5.183 88.500
article cleanup00:00:00.348 0.0%51948 0.000 0.007 0.022
article logging00:00:01.174 0.0%52185 0.000 0.022 0.746
article parse00:00:01.479 0.0%158628 0.002 0.009 0.019
article write00:01:20.323 0.1%30666 0.082 2.619 15.695
artlog/artcncl00:00:00.001 0.0%382 0.000 0.003 0.030
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.256 0.0%662893 0.000 0.000 0.002
hisgrep/artcncl00:00:00.306 0.0%376 0.000 0.814 8.643
hishave/artcncl00:00:00.006 0.0%388 0.000 0.015 0.125
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:34.786 0.0%607351 0.015 0.057 0.394
history sync00:00:00.131 0.0%292 0.000 0.449 48.500
history write00:01:44.285 0.1%51935 0.254 2.008 5.922
hiswrite/artcncl00:00:00.029 0.0%12 0.000 2.417 5.800
idle23:51:21.748 99.4%647899 26.576 132.554 362.365
nntp read00:00:03.770 0.0%662768 0.003 0.006 0.011
overview write00:00:48.327 0.1%30666 0.047 1.576 5.292
perl filter00:02:56.094 0.2%51935 1.315 3.391 39.871
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:09.980 0.0%125000 0.039 0.080 0.147
TOTAL: 24:00:19.38623:59:05.054 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.095 0.0%32356 0.000 0.003 0.021
article prepare00:00:00.014 0.0%95078 0.000 0.000 0.004
article read00:00:22.949 0.0%21257 0.000 1.080 15.229
backlog stats00:00:00.261 0.0%549825 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.767 0.0%367560 0.002 0.008 0.013
data write00:00:04.059 0.0%340959 0.005 0.012 0.021
idle24:02:19.336 99.9%549825 85.390 157.394 377.334
status file00:00:07.033 0.0%179 0.000 39.291 562.000
TOTAL: 24:03:10.89824:02:56.514100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:10:09.018 93.0%676 202.000 900.914 3162.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:11.006 1.7%92858 0.000 0.119 0.136
TOTAL: 00:10:55.14100:10:20.024 94.6%----

Control commands to INND:

CommandNumber
L 1
flush 1
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 167

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
control@usenet.org.uk000100
us-control@lists.killfile.org000100
TOTAL001201

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 2 69170 7424 58464 3282 10%46:39:07
2feeder.eternal-september.org 4 47564 6256 37872 3436 13%24:37:53
3vc89.vc.panix.com 1 9468 4947 3991 530 52%23:49:36
4news.albasani.net 3 37278 3891 31212 2175 10%24:02:18
5newsfeed.neva.ru 140 106814 3557 92648 10609 3%71:54:39
6news-out.mixmin.net 6 36733 2803 32686 1244 7%24:35:36
7etla.org 1 30949 1538 29411 0 4%24:27:03
8news.netfront.net 1 49020 59 48944 17 0%22:35:19
9localhost 25 0 0 0 0 0%00:00:00
10news.stack.nl 1 0 0 0 0 0%00:10:00
TOTAL: 10 184 386996 30475 335228 21293 7%262:51:31
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net21.1 MB83.1 KB27.3 MB48.5 MB 43%4.6 KB
2vc89.vc.panix.com16.8 MB58.5 KB4.2 MB21.0 MB 79%3.9 KB
3feeder.eternal-september.org16.6 MB45.9 KB44.6 MB61.3 MB 27%6.5 KB
4news.albasani.net15.1 MB5.5 KB108.0 MB123.0 MB 12%20.8 KB
5newsfeed.neva.ru9.2 MB27.5 KB93.8 MB103.1 MB 8%7.5 KB
6news-out.mixmin.net7.3 MB4.7 KB2.8 MB10.1 MB 72%2.5 KB
7etla.org4.8 MB0.0 KB0.0 KB4.8 MB100%3.2 KB
8news.netfront.net206.2 KB0.0 KB907.6 KB1.1 MB 18%14.7 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1091.1 MB225.3 KB281.6 MB372.9 MB 24%7.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Apr 1 00:00:01 - 00:59:59 1119 3.7% 0.313.6 MB 4.0% 1.03
Apr 1 01:00:00 - 01:59:59 899 2.9% 0.252.7 MB 2.9% 0.76
Apr 1 02:00:00 - 02:59:59 850 2.8% 0.243.0 MB 3.3% 0.86
Apr 1 03:00:00 - 03:59:59 675 2.2% 0.192.4 MB 2.7% 0.69
Apr 1 04:00:00 - 04:59:59 619 2.0% 0.171.6 MB 1.8% 0.46
Apr 1 05:00:00 - 05:59:59 699 2.3% 0.192.4 MB 2.6% 0.68
Apr 1 06:00:00 - 06:59:59 735 2.4% 0.202.5 MB 2.8% 0.72
Apr 1 07:00:00 - 07:59:59 760 2.5% 0.212.8 MB 3.0% 0.79
Apr 1 08:00:00 - 08:59:59 1061 3.5% 0.293.6 MB 4.0% 1.04
Apr 1 09:00:00 - 09:59:59 1320 4.3% 0.373.3 MB 3.6% 0.93
Apr 1 10:00:00 - 10:59:59 1352 4.4% 0.382.9 MB 3.2% 0.83
Apr 1 11:00:00 - 11:59:59 1456 4.7% 0.403.6 MB 4.0% 1.03
Apr 1 12:00:00 - 12:59:59 1328 4.3% 0.373.4 MB 3.7% 0.96
Apr 1 13:00:00 - 13:59:59 1357 4.4% 0.387.8 MB 8.6% 2.22
Apr 1 14:00:00 - 14:59:59 1683 5.5% 0.474.9 MB 5.3% 1.38
Apr 1 15:00:00 - 15:59:59 1503 4.9% 0.423.8 MB 4.1% 1.07
Apr 1 16:00:00 - 16:59:59 1719 5.6% 0.485.5 MB 6.0% 1.56
Apr 1 17:00:00 - 17:59:59 1708 5.6% 0.474.1 MB 4.5% 1.17
Apr 1 18:00:00 - 18:59:59 1983 6.5% 0.555.7 MB 6.2% 1.61
Apr 1 19:00:00 - 19:59:59 1775 5.8% 0.494.5 MB 4.9% 1.28
Apr 1 20:00:00 - 20:59:59 1679 5.5% 0.474.9 MB 5.4% 1.40
Apr 1 21:00:00 - 21:59:59 1530 5.0% 0.424.5 MB 5.0% 1.29
Apr 1 22:00:00 - 22:59:59 1473 4.8% 0.414.0 MB 4.3% 1.13
Apr 1 23:00:00 - 23:59:59 1371 4.5% 0.383.7 MB 4.0% 1.04
Apr 2 00:00:00 - 00:00:02 1 0.0% 0.501.1 KB 0.0% 0.54
TOTAL: 24:00:01 30655 100.0% 0.3591.2 MB 100.0% 1.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 10617 2165 0 3 0 0 0 0 8449
2linuxd-out.news.weretis.net 3491 2050 0 3 0 0 0 0 1438
3feeder.eternal-september.org 3467 408 0 3 0 0 0 0 3056
4news.albasani.net 2082 185 0 2 0 0 0 0 1895
5news-out.mixmin.net 1264 19 0 1 0 0 0 0 1244
6vc89.vc.panix.com 552 14 0 1 0 0 0 0 537
7news.netfront.net 31 6 0 0 0 0 0 0 25
TOTAL: 7 21504 4847 0 13 0 0 0 016644

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 769
mailing.freebsd.pkg-fallout 420
alt.politics.scorched-earth 186
ut.test 177
alt.politics 144
lada.auto 136
lada.talk 100
mailing.freebsd.svn-ports-all 94
mozilla.dev.tree-alerts 94
mailing.freebsd.svn-ports-head 89
alt.windows7.general 81
mailing.freebsd.svn-src-all 77
fa.freebsd.cvs-all 75
mailing.freebsd.svn-src-head 71
mailing.freebsd.ports-bugs 62
pld.cvs.commit 62
it-alt.sport.calcio.juventus 53
mailing.database.pgsql-general 51
mozilla.support.firefox 47
mozilla.general 46
TOTAL: 392 4847

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 12270
EMP (phn path) 2713
EMP (phl) 874
EMP (phn nph) 222
Too many newsgroups 98
User-issued cancel 84
Binary Image: misplaced jpg 58
Binary: non-binary distribution 43
Binary Payload 18
Binary: misplaced PAR2 11
HTML post 8
Too many newsgroups (meow) 4
Binary: misplaced par2 2
HTML file attachment 1
Binary: misplaced rar 1
TOTAL: 15 16407

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 35319 2340 13234 15171 5 123 6%24:04:22
2news.netfront.net 56066 896 29643 59 1 486 1%24:01:03
3etla.org 37282 356 30424 6 0 471 0%24:07:14
4news.killfile.org 49393 228 27438 3017 1 104 0%24:01:43
5neva.ru 30282 28 26673 67 0 19 0%23:52:35
6news.stack.nl 36402 22 30562 30 0 348 0%23:59:55
7news.albasani.net 30070 13 25129 1528 0 66 0%23:59:38
8eternal-september 25250 3 24265 3 0 3 0%24:02:04
9weretis.net 23188 1 22221 0 0 8 0%23:59:37
TOTAL: 9 323252 3887 229589 19881 7 1628 1%216:08:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org10.4 MB32.3 KB10.4 MB0.1 KB/s29.5 KB24:07:14
2news.netfront.net9.0 MB1.7 MB10.7 MB0.1 KB/s11.5 KB24:01:03
3vc89.vc.panix.com6.6 MB43.7 MB50.3 MB0.6 KB/s2.9 KB24:04:22
4news.killfile.org561.6 KB10.9 MB11.5 MB0.1 KB/s3.6 KB24:01:43
5news.stack.nl92.5 KB39.6 KB132.0 KB0.0 KB/s2.5 KB23:59:55
6news.albasani.net51.1 KB7.6 MB7.6 MB0.1 KB/s5.1 KB23:59:38
7neva.ru39.8 KB268.2 KB308.1 KB0.0 KB/s3.2 KB23:52:35
8eternal-september17.6 KB3.7 KB21.3 KB0.0 KB/s3.5 KB24:02:04
9weretis.net5.9 KB0.0 KB5.9 KB0.0 KB/s5.9 KB23:59:37
TOTAL: 926.8 MB64.2 MB91.0 MB0.1 KB/s3.9 KB216:08:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12607:f350:1:1225::1:4 2 00.0 KB 0 0 000:00:34
274.205.216.224 168 00.0 KB 0 0 000:10:20
TOTAL: 2 170 00.0 KB 0 0 000:10:54

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 2 00.0 KB 0 0 000:00:34
2unresolved 168 00.0 KB 0 0 000:10:20
TOTAL: 2 170 00.0 KB 0 0 000:10:54

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
74.205.216.224 8.232 0.696 0.00000:10:20
2607:f350:1:1225::1:4 0.132 0.080 0.00000:00:34
TOTAL: 2 8.364 0.776 0.00000:10:54