Daily Usenet report for paganini.linuxd.org

Jul 15 00:00:02 -- Jul 16 00:00:03

Unknown entries from news log file:

First 4 / 4 lines (100.0%)

Jul 15 00:00:24 paganini nnrpd[20479]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
Jul 15 00:00:54 paganini nnrpd[20541]: 2001:ba8:1f1:f1ef::2 noperm ihave without permission
Jul 15 17:00:06 paganini pgpverify[31593]: pgpverify: verification failed
Jul 16 00:00:03 paganini overchan[7717]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)

Log entries by program:

Program nameLines%LinesSize%Size
inn 57443 54.5%11.7 MB 69.2%
innd 37621 35.7%4.0 MB 23.7%
nnrpd 7740 7.3%813.5 KB 4.7%
innfeed 2515 2.4%418.4 KB 2.4%
nocem 80 0.1%9.3 KB 0.1%
controlchan 4 0.0%0.6 KB 0.0%
overchan 2 0.0%0.3 KB 0.0%
pgpverify 1 0.0%0.1 KB 0.0%
TOTAL: 8 105406 100.0%16.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 353512 48.5%
Negative hits 190263 26.1%
Cache misses 128105 17.6%
Do not exist 56731 7.8%
TOTAL: 4 728611 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.022 0.0%258 0.000 3.961 327.000
article cleanup00:00:00.383 0.0%57020 0.000 0.007 0.021
article logging00:00:00.597 0.0%57146 0.000 0.010 0.159
article parse00:00:01.835 0.0%179273 0.002 0.010 0.028
article write00:00:58.580 0.1%28282 0.044 2.071 10.071
artlog/artcncl00:00:00.001 0.0%140 0.000 0.007 0.083
artlog/artparse00:00:00.000 0.0%2 0.000 0.000 0.000
data move00:00:00.354 0.0%696123 0.000 0.001 0.002
hisgrep/artcncl00:00:00.058 0.0%256 0.000 0.227 1.000
hishave/artcncl00:00:00.002 0.0%258 0.000 0.008 0.250
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:41.273 0.0%734285 0.017 0.056 0.378
history sync00:00:00.043 0.0%363 0.000 0.118 7.000
history write00:00:48.162 0.1%57011 0.038 0.845 3.687
hiswrite/artcncl00:00:00.000 0.0%2 0.000 0.000 0.000
idle23:54:28.113 99.6%688402 36.563 125.026 475.059
nntp read00:00:04.544 0.0%699833 0.003 0.006 0.011
overview write00:00:24.920 0.0%28282 0.033 0.881 3.968
perl filter00:02:10.705 0.2%57009 0.997 2.293 7.928
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.311 0.0%85112 0.000 0.015 0.053
TOTAL: 24:00:48.87223:59:41.903 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.068 0.0%31048 0.000 0.002 0.018
article prepare00:00:00.018 0.0%161704 0.000 0.000 0.002
article read00:00:13.584 0.0%23714 0.000 0.573 6.579
backlog stats00:00:00.339 0.0%695805 0.000 0.000 0.002
callbacks00:00:00.000 0.0%1 0.000 0.000 0.000
data read00:00:02.729 0.0%441177 0.003 0.006 0.012
data write00:00:04.559 0.0%417354 0.005 0.011 0.020
idle23:51:46.306 99.9%695805 73.277 123.463 320.864
status file00:00:06.540 0.0%215 1.000 30.419 254.000
TOTAL: 23:52:31.02823:52:14.143100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:35:58.276 96.4%18850 34.757 114.497 179.083
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.509 0.0%38044 0.000 0.013 0.773
readart00:00:29.453 1.3%9591 0.216 3.071 68.149
TOTAL: 00:37:17.86700:36:28.238 97.8%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org000100
TOTAL000100

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 24 64344 7756 52997 3591 12%47:38:55
2feeder.eternal-september.org 5 53041 5899 39888 7254 11%25:12:41
3vc89.vc.panix.com 0 8053 4289 2853 911 53%23:41:56
4newsfeed.neva.ru 123 210504 3214 192837 14453 1%58:54:56
5news.albasani.net 3 34595 2439 31033 1123 7%23:44:56
6news-out.mixmin.net 5 35448 2284 31788 1376 6%24:26:38
7news.fcku.it 1957 3503 1377 2124 2 39%22:14:28
8etla.org 6 50630 899 49731 0 1%24:16:49
9news.netfront.net 1 42033 47 41887 99 0%20:03:36
10nntp.pasdenom.info 3 46873 27 46838 8 0%38:19:12
11localhost 25 0 0 0 0 0%00:00:00
12news.stack.nl 1 0 0 0 0 0%00:10:00
TOTAL: 12 2153 549024 28231 491976 28817 5%308:44:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net31.2 MB15.3 KB35.3 MB66.5 MB 46%6.0 KB
2vc89.vc.panix.com23.8 MB8.5 KB5.3 MB29.2 MB 81%5.7 KB
3feeder.eternal-september.org16.9 MB30.0 KB78.9 MB95.8 MB 17%7.5 KB
4newsfeed.neva.ru9.3 MB43.6 KB128.5 MB137.9 MB 6%8.0 KB
5news.albasani.net7.9 MB0.0 KB4.9 MB12.8 MB 61%3.7 KB
6news-out.mixmin.net6.8 MB0.0 KB2.9 MB9.7 MB 70%2.7 KB
7etla.org2.8 MB0.0 KB0.0 KB2.8 MB100%3.2 KB
8news.fcku.it2.4 MB0.0 KB61.6 KB2.5 MB 97%1.9 KB
9news.netfront.net163.2 KB0.0 KB31.4 MB31.6 MB 0%221.3 KB
10nntp.pasdenom.info112.6 KB0.0 KB10.9 KB123.6 KB 91%3.5 KB
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 12101.4 MB97.4 KB287.3 MB388.8 MB 26%7.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 15 00:00:02 - 00:59:59 1099 3.9% 0.313.4 MB 3.4% 0.98
Jul 15 01:00:00 - 01:59:59 926 3.3% 0.263.1 MB 3.1% 0.89
Jul 15 02:00:00 - 02:59:59 671 2.4% 0.192.3 MB 2.2% 0.65
Jul 15 03:00:00 - 03:59:59 615 2.2% 0.171.9 MB 1.8% 0.53
Jul 15 04:00:00 - 04:59:59 481 1.7% 0.132.5 MB 2.4% 0.70
Jul 15 05:00:00 - 05:59:59 576 2.0% 0.163.1 MB 3.0% 0.88
Jul 15 06:00:00 - 06:59:59 608 2.2% 0.173.0 MB 2.9% 0.84
Jul 15 07:00:00 - 07:59:59 616 2.2% 0.172.1 MB 2.0% 0.59
Jul 15 08:00:00 - 08:59:59 951 3.4% 0.263.4 MB 3.4% 0.97
Jul 15 09:00:00 - 09:59:59 1153 4.1% 0.323.3 MB 3.3% 0.94
Jul 15 10:00:00 - 10:59:59 1172 4.1% 0.333.6 MB 3.6% 1.04
Jul 15 11:00:00 - 11:59:59 1531 5.4% 0.434.5 MB 4.5% 1.29
Jul 15 12:00:00 - 12:59:59 1342 4.8% 0.374.1 MB 4.0% 1.16
Jul 15 13:00:00 - 13:59:59 1453 5.1% 0.408.9 MB 8.8% 2.53
Jul 15 14:00:00 - 14:59:59 1545 5.5% 0.434.8 MB 4.8% 1.37
Jul 15 15:00:00 - 15:59:59 1495 5.3% 0.425.4 MB 5.4% 1.55
Jul 15 16:00:00 - 16:59:59 1608 5.7% 0.455.9 MB 5.8% 1.68
Jul 15 17:00:00 - 17:59:59 1683 6.0% 0.475.6 MB 5.5% 1.59
Jul 15 18:00:00 - 18:59:59 1601 5.7% 0.446.8 MB 6.7% 1.94
Jul 15 19:00:00 - 19:59:59 1626 5.8% 0.456.5 MB 6.4% 1.84
Jul 15 20:00:00 - 20:59:59 1469 5.2% 0.414.7 MB 4.7% 1.35
Jul 15 21:00:00 - 21:59:59 1420 5.0% 0.394.0 MB 3.9% 1.14
Jul 15 22:00:00 - 22:59:59 1348 4.8% 0.374.3 MB 4.2% 1.22
Jul 15 23:00:00 - 23:59:59 1249 4.4% 0.354.1 MB 4.1% 1.18
Jul 16 00:00:00 - 00:00:03 7 0.0% 2.3324.6 KB 0.0% 8.19
TOTAL: 24:00:01 28245 100.0% 0.33101.4 MB 100.0% 1.20
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 14638 2159 0 7 0 0 0 012472
2feeder.eternal-september.org 7274 430 0 1 0 0 0 0 6843
3linuxd-out.news.weretis.net 3614 1432 0 2 0 0 0 0 2180
4news-out.mixmin.net 1361 6 0 0 0 0 0 0 1355
5news.albasani.net 1177 112 0 0 0 0 0 0 1065
6vc89.vc.panix.com 946 4 0 1 0 0 0 0 941
7news.netfront.net 38 0 0 0 0 0 0 0 38
8news.fcku.it 11 0 0 0 0 0 0 0 11
9nntp.pasdenom.info 2 1 0 0 0 0 0 0 1
10etla.org 1 0 0 0 0 0 0 0 1
TOTAL: 10 29062 4144 0 11 0 0 0 024907

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 1027
mailing.freebsd.pkg-fallout 208
lada.talk 192
mailing.freebsd.svn-ports-all 142
ut.test 125
mailing.freebsd.svn-ports-head 124
lada.auto 101
pld.cvs.commit 93
gmane.linux.alsa.devel 84
mailing.openbsd.ports-changes 76
mailing.freebsd.ports-bugs 72
alt.politics 64
it-alt.sport.calcio.juventus 64
mailing.gcc.gcc-cvs 62
mailing.openbsd.source-changes 59
fa.openbsd.source-changes 59
mailing.openbsd.misc 56
alt.politics.scorched-earth 54
alt.windows7.general 50
alt.survival 49
TOTAL: 266 4144

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 18869
EMP (phn path) 4292
EMP (phl) 911
EMP (phn nph) 500
Too many newsgroups 86
User-issued cancel 37
Binary: non-binary distribution 32
Binary Image: misplaced jpg 27
Binary Payload 23
HTML post 2
Binary Image: misplaced jpeg 1
TOTAL: 11 24780

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 46
news.albasani.net 26
feeder.eternal-september.org 20
news-out.mixmin.net 13
news.fcku.it 9
vc89.vc.panix.com 7
newsfeed.neva.ru 2
etla.org 1
news.netfront.net 1
TOTAL: 9 125
TOTAL: 1 125

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 49340 3392 24737 47 1 535 6%23:59:46
2vc89.vc.panix.com 30836 2377 9493 16366 0 152 7%23:59:51
3weretis.net 22123 696 19628 1 0 11 3%23:59:51
4etla.org 34572 665 27534 38 0 575 1%23:59:49
5neva.ru 33038 654 23658 547 0 142 1%23:59:47
6news.albasani.net 31814 368 23274 2115 0 75 1%23:59:51
7nntp.pasdenom.info 38762 294 26873 949 0 94 0%23:59:51
8news.fcku.it 29626 232 16678 9907 0 6 0%23:59:49
9news.stack.nl 46160 105 27863 121 1 1026 0%23:59:51
10news.killfile.org 47544 78 26525 1634 0 378 0%23:59:50
11eternal-september 24385 31 22123 5 0 2 0%23:59:51
12news.mixmin.net 0 0 0 0 0 0 0%00:10:00
TOTAL: 12 388200 8892 248386 31730 2 2996 2%264:08:07
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1etla.org20.8 MB266.8 KB21.1 MB0.3 KB/s30.7 KB23:59:49
2news.netfront.net19.2 MB1.9 MB21.1 MB0.2 KB/s6.3 KB23:59:46
3vc89.vc.panix.com7.9 MB48.0 MB55.8 MB0.7 KB/s3.1 KB23:59:51
4neva.ru1.2 MB1.3 MB2.5 MB0.0 KB/s2.1 KB23:59:47
5weretis.net1.2 MB2.5 KB1.2 MB0.0 KB/s1.7 KB23:59:51
6nntp.pasdenom.info1.2 MB1.5 MB2.7 MB0.0 KB/s2.2 KB23:59:51
7news.fcku.it1.0 MB52.4 MB53.4 MB0.6 KB/s5.4 KB23:59:49
8news.albasani.net991.4 KB8.1 MB9.1 MB0.1 KB/s3.7 KB23:59:51
9news.stack.nl464.9 KB278.3 KB743.2 KB0.0 KB/s3.3 KB23:59:51
10news.killfile.org314.4 KB7.1 MB7.5 MB0.1 KB/s4.5 KB23:59:50
11eternal-september286.6 KB8.4 KB295.0 KB0.0 KB/s8.2 KB23:59:51
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
TOTAL: 1254.5 MB120.8 MB175.3 MB0.2 KB/s4.4 KB264:08:07
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1mtrlpq2314w-lp140-07-1178043451.dsl.bell.ca 155 75354.7 KB 44 0 000:31:23
2x5ce5408c.dyn.telefonica.de 41 48102.4 KB 36 0 000:00:59
3bas2-montrealak-1177634384.dsl.bell.ca 20 2146.8 KB 11 0 000:04:44
4x55b31aca.dyn.telefonica.de 7 26.6 KB 2 0 000:00:09
TOTAL: 4 223 146510.5 KB 93 0 000:37:17

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.dsl.bell.ca 175 96401.4 KB 55 0 000:36:07
2*.dyn.telefonica.de 48 50109.0 KB 38 0 000:01:08
3? 2 00.0 KB 0 0 000:00:00
TOTAL: 3 225 146510.5 KB 93 0 000:37:17

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mtrlpq2314w-lp140-07-1178043451.dsl.bell.ca 14.176 1.352 0.00000:31:23
bas2-montrealak-1177634384.dsl.bell.ca 1.800 0.244 0.00000:04:44
x5ce5408c.dyn.telefonica.de 2.964 0.240 0.00000:00:59
x55b31aca.dyn.telefonica.de 0.460 0.020 0.00000:00:09
2001:ba8:1f1:f1ef::2 0.124 0.012 0.00000:00:00
TOTAL: 5 19.524 1.868 0.00000:37:17

Curious NNRP server explorers [Top 20]:

SystemConn
2001:ba8:1f1:f1ef::2 2
TOTAL: 1 2

Newsgroup request counts (by category):

CategoryCountPct
1de 50 34.2%
2rec 19 13.0%
3aus 19 13.0%
4alt 18 12.3%
5sci 14 9.6%
6uk 10 6.8%
7talk 8 5.5%
8fr 7 4.8%
9soc 1 0.7%
TOTAL: 9 146100.0%

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

NewsgroupCount
1de.talk.jokes 16
2sci.physics.relativity 13
3rec.boats 12
4aus.tv 10
5de.comp.security.misc 9
6uk.rec.cycling 9
7de.etc.finanz.boerse 9
8aus.cars 8
9talk.origins 8
10de.comp.os.unix.networking.misc 7
11fr.soc.politique 7
12alt.comp.freeware 6
13alt.home.repair 5
14de.alt.rec.digitalfotografie 3
15rec.arts.tv 3
16alt.fan.rush-limbaugh 3
17de.comm.technik.dsl 3
18alt.usenet.kooks 2
19rec.games.pinball 2
20de.org.ccc 2
21rec.sport.soccer 2
22alt.baldspot 1
23sci.military.naval 1
24alt.astronomy 1
25soc.culture.quebec 1
26uk.railway 1
27aus.politics 1
28de.admin.news.announce 1
TOTAL: 28 146