Daily Usenet report for paganini.linuxd.org

Jan 29 00:00:01 -- Jan 30 00:00:01

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Jan 29 00:00:03 paganini nnrpd[30320]: feeder.eternal-september.org noperm ihave without permission
Jan 29 00:00:05 paganini nnrpd[30058]: feeder.eternal-september.org noperm ihave without permission
Jan 29 00:00:08 paganini nnrpd[30478]: feeder.eternal-september.org noperm ihave without permission
Jan 29 00:00:26 paganini nnrpd[30486]: feeder.eternal-september.org noperm ihave without permission
Jan 29 00:00:33 paganini nnrpd[30487]: feeder.eternal-september.org noperm ihave without permission
Jan 29 00:00:36 paganini nnrpd[30488]: feeder.eternal-september.org noperm ihave without permission
Jan 29 00:00:38 paganini nnrpd[30492]: feeder.eternal-september.org noperm ihave without permission
Jan 29 00:00:56 paganini nnrpd[30557]: feeder.eternal-september.org noperm ihave without permission

Log entries by program:

Program nameLines%LinesSize%Size
inn 50780 73.3%10.5 MB 83.0%
innd 16468 23.8%1.9 MB 14.9%
innfeed 1870 2.7%260.0 KB 2.0%
nocem 107 0.2%13.2 KB 0.1%
nnrpd 68 0.1%7.1 KB 0.1%
TOTAL: 5 69293 100.0%12.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 301599 54.1%
Negative hits 206072 36.9%
Do not exist 50123 9.0%
Cache misses 196 0.0%
TOTAL: 4 557990 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.301 0.0%267 0.000 1.127 19.000
article cleanup00:00:00.285 0.0%50428 0.000 0.006 0.032
article logging00:00:01.021 0.0%50572 0.000 0.020 0.977
article parse00:00:01.129 0.0%121935 0.001 0.009 0.024
article write00:01:16.595 0.1%32127 0.122 2.384 11.700
artlog/artcncl00:00:00.001 0.0%239 0.000 0.004 0.050
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.210 0.0%591103 0.000 0.000 0.002
hisgrep/artcncl00:00:00.058 0.0%256 0.000 0.227 5.500
hishave/artcncl00:00:00.005 0.0%267 0.000 0.019 0.143
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:29.820 0.0%598770 0.015 0.050 0.316
history sync00:00:00.128 0.0%347 0.000 0.369 19.000
history write00:01:47.124 0.1%50416 0.044 2.125 10.229
hiswrite/artcncl00:00:00.001 0.0%11 0.000 0.091 0.500
idle23:52:50.305 99.4%578375 78.870 148.641 393.341
nntp read00:00:03.122 0.0%592918 0.002 0.005 0.010
overview write00:00:51.112 0.1%32127 0.036 1.591 4.688
perl filter00:02:16.730 0.2%50416 0.991 2.712 10.982
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:07.286 0.0%128715 0.011 0.057 0.098
TOTAL: 24:00:51.06423:59:45.233 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.078 0.0%35865 0.000 0.002 0.014
article prepare00:00:00.013 0.0%97392 0.000 0.000 0.002
article read00:00:19.256 0.0%23590 0.000 0.816 20.297
backlog stats00:00:00.199 0.0%524573 0.000 0.000 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:02.604 0.0%345386 0.003 0.008 0.016
data write00:00:04.074 0.0%317746 0.007 0.013 0.023
idle24:02:35.837 99.9%524573 97.821 165.002 502.344
status file00:00:07.557 0.0%195 0.000 38.754 497.000
TOTAL: 24:03:20.97524:03:09.618100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:10:13.734 97.9%184 39.667 3335.511 3826.275
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.347 0.2%486 0.000 2.772 3.073
readart00:00:00.001 0.0%49 0.020 0.020 0.020
TOTAL: 00:10:26.71200:10:15.082 98.1%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 1 74291 12336 58214 3741 16%47:52:09
2feeder.eternal-september.org 6 84672 5441 76442 2789 6%24:49:28
3vc89.vc.panix.com 1 8492 4217 3928 347 49%24:35:10
4etla.org 2 31045 3698 27347 0 11%24:05:08
5newsfeed.neva.ru 142 105030 3493 91450 10087 3%72:07:03
6news-out.mixmin.net 5 39075 3007 34738 1330 7%24:12:17
7news.netfront.net 2 43394 86 43206 102 0%21:46:40
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 184 385999 32278 335325 18396 8%239:27:55
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net46.7 MB3.6 KB16.1 MB62.8 MB 74%4.0 KB
2feeder.eternal-september.org17.0 MB11.7 KB29.7 MB46.7 MB 36%5.8 KB
3vc89.vc.panix.com14.6 MB218.3 KB1.8 MB16.6 MB 87%3.7 KB
4etla.org12.1 MB0.0 KB0.0 KB12.1 MB100%3.4 KB
5newsfeed.neva.ru8.4 MB0.0 KB64.8 MB73.2 MB 11%5.5 KB
6news-out.mixmin.net8.2 MB1.8 KB2.3 MB10.5 MB 78%2.5 KB
7news.netfront.net2.3 MB1.7 KB6.3 MB8.6 MB 26%47.0 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 8109.4 MB237.0 KB121.0 MB230.6 MB 47%4.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 29 00:00:01 - 00:59:59 1137 3.5% 0.326.1 MB 5.7% 1.74
Jan 29 01:00:00 - 01:59:59 699 2.2% 0.192.1 MB 2.0% 0.60
Jan 29 02:00:00 - 02:59:59 837 2.6% 0.233.5 MB 3.3% 1.00
Jan 29 03:00:00 - 03:59:59 724 2.3% 0.202.7 MB 2.5% 0.77
Jan 29 04:00:00 - 04:59:59 732 2.3% 0.202.6 MB 2.4% 0.73
Jan 29 05:00:00 - 05:59:59 490 1.5% 0.142.6 MB 2.4% 0.74
Jan 29 06:00:00 - 06:59:59 694 2.2% 0.192.5 MB 2.3% 0.70
Jan 29 07:00:00 - 07:59:59 837 2.6% 0.232.3 MB 2.2% 0.67
Jan 29 08:00:00 - 08:59:59 1058 3.3% 0.293.8 MB 3.5% 1.08
Jan 29 09:00:00 - 09:59:59 1211 3.8% 0.344.7 MB 4.4% 1.33
Jan 29 10:00:00 - 10:59:59 1618 5.0% 0.454.2 MB 3.9% 1.19
Jan 29 11:00:00 - 11:59:59 1739 5.4% 0.484.6 MB 4.3% 1.32
Jan 29 12:00:00 - 12:59:59 1763 5.5% 0.495.5 MB 5.2% 1.58
Jan 29 13:00:00 - 13:59:59 1640 5.1% 0.465.5 MB 5.1% 1.55
Jan 29 14:00:00 - 14:59:59 1782 5.5% 0.494.8 MB 4.5% 1.36
Jan 29 15:00:00 - 15:59:59 1738 5.4% 0.484.8 MB 4.5% 1.37
Jan 29 16:00:00 - 16:59:59 1737 5.4% 0.486.6 MB 6.2% 1.88
Jan 29 17:00:00 - 17:59:59 1823 5.7% 0.515.2 MB 4.8% 1.47
Jan 29 18:00:00 - 18:59:59 1834 5.7% 0.517.9 MB 7.4% 2.25
Jan 29 19:00:00 - 19:59:59 1755 5.5% 0.495.8 MB 5.4% 1.66
Jan 29 20:00:00 - 20:59:59 1686 5.3% 0.475.1 MB 4.7% 1.44
Jan 29 21:00:00 - 21:59:59 1494 4.7% 0.415.6 MB 5.2% 1.58
Jan 29 22:00:00 - 22:59:59 1558 4.9% 0.434.4 MB 4.1% 1.24
Jan 29 23:00:00 - 00:00:01 1523 4.7% 0.424.4 MB 4.1% 1.25
TOTAL: 24:00:00 32109 100.0% 0.37107.2 MB 100.0% 1.27
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 10003 2399 0 0 0 0 0 0 7604
2linuxd-out.news.weretis.net 3856 1651 0 2 0 0 0 0 2203
3feeder.eternal-september.org 2814 252 0 1 0 0 0 0 2561
4news-out.mixmin.net 1353 23 0 1 0 0 0 0 1329
5vc89.vc.panix.com 344 3 0 7 0 0 0 0 334
6news.netfront.net 48 4 0 1 0 0 0 0 43
7etla.org 13 0 0 0 0 0 0 0 13
TOTAL: 7 18431 4332 0 12 0 0 0 014087

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 1313
lada.talk 244
mailing.freebsd.pkg-fallout 126
alt.politics 114
lada.auto 97
ut.test 89
it-alt.sport.calcio.juventus 75
alt.politics.scorched-earth 69
mailing.freebsd.net 54
tin.it.sport.calcio 52
mailing.unix.samba-technical 51
mailing.unix.samba 48
mailing.freebsd.ports-bugs 48
mpc.lists.freebsd.ports.bugs 48
mozilla.general 47
mailing.gcc.gcc-cvs 44
mpc.lists.nanog 44
mailing.freebsd.svn-src-all 43
fa.freebsd.cvs-all 43
mailing.openbsd.misc 41
TOTAL: 290 4332

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 9288
EMP (phn path) 2764
EMP (phl) 1567
Too many newsgroups 140
User-issued cancel 81
EMP (phn nph) 55
Binary Payload 22
Binary: non-binary distribution 15
HTML post 6
Too many newsgroups (low_xpost) 2
Binary Image: misplaced jpg 2
Binary: misplaced com 1
TOTAL: 12 13943

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1vc89.vc.panix.com 40015 888 14545 16689 2 496 2%24:00:08
2etla.org 38062 447 31631 5 0 633 1%23:58:51
3news.netfront.net 56038 299 31610 62 0 1643 0%23:44:01
4news.killfile.org 51674 189 26258 5639 0 455 0%23:58:35
5news.stack.nl 34273 22 31947 27 0 189 0%24:05:29
6neva.ru 32242 15 28256 29 0 274 0%23:56:47
7weretis.net 20445 4 19735 0 0 5 0%24:02:18
8eternal-september 27837 2 26586 3 0 2 0%24:01:11
TOTAL: 8 300586 1866 210568 22454 2 3697 0%191:47:20
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org19.4 MB19.3 KB19.4 MB0.2 KB/s44.0 KB23:58:51
2news.netfront.net10.8 MB4.6 MB15.4 MB0.2 KB/s43.7 KB23:44:01
3vc89.vc.panix.com3.0 MB52.3 MB55.3 MB0.7 KB/s3.2 KB24:00:08
4news.killfile.org622.2 KB20.3 MB20.9 MB0.2 KB/s3.7 KB23:58:35
5neva.ru194.3 KB237.6 KB431.9 KB0.0 KB/s9.8 KB23:56:47
6news.stack.nl85.1 KB52.7 KB137.8 KB0.0 KB/s2.8 KB24:05:29
7weretis.net9.4 KB0.0 KB9.4 KB0.0 KB/s2.3 KB24:02:18
8eternal-september8.2 KB5.4 KB13.6 KB0.0 KB/s2.7 KB24:01:11
TOTAL: 834.2 MB77.5 MB111.7 MB0.2 KB/s4.7 KB191:47:20
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.168.200.4 1 49101.2 KB 5 0 000:10:13
TOTAL: 1 1 49101.2 KB 5 0 000:10:26

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 1 49101.2 KB 5 0 000:10:13
2*.eternal-september.org 8 00.0 KB 0 0 000:00:12
TOTAL: 2 9 49101.2 KB 5 0 000:10:26

NNRP auth users [Top 20]:

UserConn
ivo@paganini.linuxd.org 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.168.200.4 0.116 0.008 0.01900:10:13
feeder.eternal-september.org 0.548 0.048 0.00000:00:12
TOTAL: 2 0.664 0.056 0.01900:10:26

Curious NNRP server explorers [Top 20]:

SystemConn
feeder.eternal-september.org 8
TOTAL: 1 8

Newsgroup request counts (by category):

CategoryCountPct
1it 49100.0%
TOTAL: 1 49100.0%

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

NewsgroupCount
1it.comp.os.linux.sys 33
2it.comp.os.win.windows7 7
3it.comp.os.linux.ubuntu 5
4it.news.net-abuse 3
5it.news.gcn 1
TOTAL: 5 49