Daily Usenet report for paganini.linuxd.org

Jun 27 00:00:02 -- Jun 28 00:00:02

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Jun 27 03:10:57 paganini overchan[31234]: input line too long, skipping
Jun 27 11:27:07 paganini overchan[31234]: input line too long, skipping
Jun 27 11:33:53 paganini overchan[31234]: input line too long, skipping
Jun 27 11:50:58 paganini overchan[31234]: input line too long, skipping
Jun 27 11:59:33 paganini overchan[31234]: input line too long, skipping
Jun 27 12:08:46 paganini overchan[31234]: input line too long, skipping
Jun 27 14:41:05 paganini overchan[31234]: input line too long, skipping
Jun 28 00:00:02 paganini overchan[10879]: 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
innfeed 101453 48.1%12.5 MB 41.6%
nnrpd 65377 31.0%7.5 MB 25.0%
inn 33300 15.8%8.2 MB 27.2%
innd 10827 5.1%1.8 MB 6.1%
nocem 72 0.0%12.4 KB 0.0%
overchan 9 0.0%1.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 211039 100.0%30.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 119697 56.7%
Negative hits 58643 27.8%
Do not exist 32525 15.4%
Cache misses 58 0.0%
TOTAL: 4 210923 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.498 0.0%164 0.000 3.037 25.500
article cleanup00:00:00.200 0.0%32607 0.000 0.006 0.024
article logging00:00:00.327 0.0%33156 0.000 0.010 0.186
article parse00:00:00.630 0.0%46670 0.000 0.013 0.038
article write00:01:04.467 0.1%22902 0.130 2.815 34.551
artlog/artcncl00:00:00.001 0.0%160 0.000 0.006 0.062
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.093 0.0%218113 0.000 0.000 0.002
hisgrep/artcncl00:00:00.034 0.0%163 0.000 0.209 4.125
hishave/artcncl00:00:00.002 0.0%164 0.000 0.012 1.000
hissync/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.082 0.0%211435 0.017 0.052 0.633
history sync00:00:00.337 0.0%397 0.000 0.849 90.667
history write00:00:40.693 0.0%32603 0.018 1.248 7.325
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:57:19.119 99.7%215889 245.770 399.460 968.772
nntp read00:00:01.576 0.0%221094 0.001 0.007 0.015
overview write00:00:21.402 0.0%22902 0.011 0.935 6.008
perl filter00:00:59.739 0.1%32603 1.106 1.832 4.708
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.485 0.0%68889 0.005 0.022 0.054
TOTAL: 24:01:13.85524:00:41.685100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.100 0.0%37986 0.000 0.003 0.012
article prepare00:00:00.004 0.0%40810 0.000 0.000 0.006
article read00:00:05.190 0.0%7637 0.000 0.680 25.395
backlog stats00:00:00.259 0.0%360980 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.559 0.0%198257 0.003 0.008 0.015
data write00:00:03.041 0.0%175871 0.010 0.017 0.030
idle23:42:45.098 99.2%360980 158.928 236.482 433.961
status file00:10:22.185 0.7%42394 9.619 14.676 38.731
TOTAL: 23:53:31.72323:53:17.436100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:04:27.205 99.2%66070 37.322 58.532 120.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.201 0.0%134032 0.000 0.009 0.016
readart00:00:00.000 0.0%1 0.000 0.000 0.000
TOTAL: 01:04:56.79601:04:28.406 99.3%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 6 47841 20034 26536 1271 41%47:53:07
2newsfeed.neva.ru 144 74230 2377 63531 8322 3%72:08:26
3news.fcku.it 2 7577 224 7266 87 2%22:59:23
4nntp.pasdenom.info 3 23515 43 23464 8 0%26:32:42
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 180 153163 22678 120797 9688 14%169:33:38
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net72.3 MB0.0 KB4.9 MB77.2 MB 93%3.7 KB
2newsfeed.neva.ru6.6 MB10.5 KB34.4 MB41.1 MB 16%3.9 KB
3news.fcku.it667.3 KB0.0 KB426.4 KB1.1 MB 61%3.5 KB
4nntp.pasdenom.info121.2 KB0.0 KB81.2 KB202.4 KB 59%4.0 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 579.7 MB10.5 KB39.8 MB119.5 MB 66%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 27 00:00:02 - 00:59:59 943 4.1% 0.264.7 MB 5.8% 1.33
Jun 27 01:00:00 - 01:59:59 642 2.8% 0.182.9 MB 3.6% 0.82
Jun 27 02:00:00 - 02:59:59 637 2.8% 0.181.9 MB 2.3% 0.53
Jun 27 03:00:00 - 03:59:59 625 2.7% 0.172.5 MB 3.1% 0.71
Jun 27 04:00:00 - 04:59:59 569 2.5% 0.161.8 MB 2.2% 0.50
Jun 27 05:00:00 - 05:59:59 419 1.8% 0.122.7 MB 3.3% 0.76
Jun 27 06:00:00 - 06:59:59 656 2.9% 0.182.8 MB 3.5% 0.79
Jun 27 07:00:00 - 07:59:59 510 2.2% 0.141.7 MB 2.2% 0.49
Jun 27 08:00:00 - 08:59:59 579 2.5% 0.161.7 MB 2.2% 0.50
Jun 27 09:00:00 - 09:59:59 863 3.8% 0.242.6 MB 3.2% 0.73
Jun 27 10:00:00 - 10:59:59 896 3.9% 0.252.3 MB 2.9% 0.66
Jun 27 11:00:00 - 11:59:59 942 4.1% 0.262.7 MB 3.4% 0.78
Jun 27 12:00:00 - 12:59:59 1046 4.6% 0.293.2 MB 4.0% 0.91
Jun 27 13:00:00 - 13:59:59 1040 4.5% 0.293.5 MB 4.4% 1.01
Jun 27 14:00:00 - 14:59:59 977 4.3% 0.273.2 MB 4.0% 0.92
Jun 27 15:00:00 - 15:59:59 1270 5.5% 0.356.3 MB 7.8% 1.78
Jun 27 16:00:00 - 16:59:59 1292 5.6% 0.364.1 MB 5.1% 1.16
Jun 27 17:00:00 - 17:59:59 1415 6.2% 0.395.8 MB 7.2% 1.64
Jun 27 18:00:00 - 18:59:59 1343 5.9% 0.374.3 MB 5.3% 1.21
Jun 27 19:00:00 - 19:59:59 1264 5.5% 0.353.6 MB 4.4% 1.02
Jun 27 20:00:00 - 20:59:59 1254 5.5% 0.353.8 MB 4.8% 1.09
Jun 27 21:00:00 - 21:59:59 1314 5.7% 0.363.6 MB 4.5% 1.04
Jun 27 22:00:00 - 22:59:59 1253 5.5% 0.355.3 MB 6.6% 1.51
Jun 27 23:00:00 - 23:59:59 1115 4.9% 0.313.4 MB 4.2% 0.97
Jun 28 00:00:00 - 00:00:02 24 0.1% 12.0084.5 KB 0.1% 42.24
TOTAL: 24:00:00 22888 100.0% 0.2680.5 MB 100.0% 0.95
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 8328 336 0 4 0 0 0 0 7988
2linuxd-out.news.weretis.net 1810 547 0 0 0 0 0 0 1263
3news.fcku.it 109 8 0 0 0 0 0 0 101
4nntp.pasdenom.info 6 0 0 0 0 0 0 0 6
TOTAL: 4 10253 891 0 4 0 0 0 0 9358

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 158
ut.test 89
it.comp.os.win.windows10 49
it-alt.sport.calcio.juventus 47
it.annunci.immobiliari 42
it.annunci.commerciali 41
alt.windows7.general 41
lada.auto 39
it.annunci.varie 30
mozilla.support.firefox 25
mozilla.dev.security.policy 21
mozilla.support.thunderbird 20
gmane.linux.alsa.devel 17
cakewalk.audio 15
mozilla.support.seamonkey 14
spline.eisfair 13
lada.mobile 11
fido7.ru.android 11
alt.survival 8
mozilla.dev.platform 8
TOTAL: 93 891

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 7716
EMP (phn path) 715
EMP (phl) 200
EMP (phn nph) 80
Too many newsgroups 45
Binary Payload 20
User-issued cancel 12
Too many newsgroups (low_xpost) 5
Binary: non-binary distribution 5
Binary: misplaced par2 2
Binary: misplaced asc 1
Binary: misplaced 005 1
Binary: misplaced 629 1
Binary: misplaced obj 1
Binary: misplaced 558 1
HTML post 1
Too many newsgroups (meow) 1
Angle-bracket bot 1
Binary: misplaced 003 1
TOTAL: 19 8809

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 529
newsfeed.neva.ru 19
news.fcku.it 1
TOTAL: 3 549
TOTAL: 1 549

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 38427 3236 18407 1060 1 649 8%23:57:46
2news.fcku.it 30651 2215 17009 3456 0 303 7%23:59:53
3weretis.net 2860 101 2508 0 0 15 3%23:59:36
4eternal-september 25818 31 19754 2 0 34 0%23:59:53
5neva.ru 28910 18 20315 166 0 151 0%23:59:51
6news.mixmin.net 0 0 0 0 0 0 0%00:10:00
7vc89.vc.panix.com 2842 0 0 0 0 25729 0%23:59:53
8news.albasani.net 2866 0 0 0 0 24804 0%23:59:53
9news.killfile.org 2850 0 0 0 0 25737 0%23:59:53
10news.stack.nl 2860 0 0 0 0 25600 0%23:59:53
11news.netfront.net 2756 0 0 0 0 25612 0%23:59:52
12etla.org 0 0 0 0 0 22888 0%23:59:53
TOTAL: 12 140840 5601 77993 4684 1 151522 3%264:06:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info10.4 MB2.5 MB12.9 MB0.2 KB/s3.1 KB23:57:46
2news.fcku.it6.8 MB12.6 MB19.4 MB0.2 KB/s3.5 KB23:59:53
3eternal-september334.2 KB3.9 KB338.1 KB0.0 KB/s10.2 KB23:59:53
4weretis.net136.2 KB0.0 KB136.2 KB0.0 KB/s1.3 KB23:59:36
5neva.ru83.6 KB775.9 KB859.5 KB0.0 KB/s4.7 KB23:59:51
6news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
7vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
9news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
10news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
11news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:52
12etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:53
TOTAL: 1217.8 MB15.9 MB33.7 MB0.0 KB/s3.4 KB264:06:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 118 12.0 KB 1 0 001:04:56
TOTAL: 1 118 12.0 KB 1 0 001:04:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 118 12.0 KB 1 0 001:04:56
2unresolved 1 00.0 KB 0 0 000:00:00
TOTAL: 2 119 12.0 KB 1 0 001:04:56

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 12.872 3.016 0.00001:04:56
125.64.94.200 0.052 0.004 0.00000:00:00
TOTAL: 2 12.924 3.020 0.00001:04:56

Curious NNRP server explorers [Top 20]:

SystemConn
125.64.94.200 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1de 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1de.comm.software.mailreader 1
TOTAL: 1 1