Daily Usenet report for paganini.linuxd.org

Jun 9 00:00:02 -- Jun 10 00:00:03

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Jun 9 08:38:32 paganini overchan[11186]: input line too long, skipping
Jun 9 08:42:27 paganini overchan[11186]: input line too long, skipping
Jun 9 08:52:27 paganini overchan[11186]: input line too long, skipping
Jun 9 11:33:58 paganini overchan[11186]: input line too long, skipping
Jun 9 13:12:34 paganini overchan[11186]: input line too long, skipping
Jun 9 13:19:02 paganini overchan[11186]: input line too long, skipping
Jun 9 16:40:53 paganini overchan[11186]: input line too long, skipping
Jun 9 19:38:36 paganini overchan[11186]: input line too long, skipping
Jun 9 23:42:58 paganini overchan[11186]: input line too long, skipping
Jun 10 00:00:02 paganini overchan[24145]: 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 101331 51.0%12.6 MB 44.3%
nnrpd 57068 28.7%6.6 MB 23.1%
inn 31013 15.6%7.8 MB 27.3%
innd 9330 4.7%1.5 MB 5.3%
nocem 121 0.1%20.5 KB 0.1%
overchan 11 0.0%1.8 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 198875 100.0%28.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 116171 58.2%
Negative hits 53264 26.7%
Do not exist 30150 15.1%
Cache misses 67 0.0%
TOTAL: 4 199652 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.681 0.0%202 0.000 3.371 88.000
article cleanup00:00:00.216 0.0%30273 0.000 0.007 0.030
article logging00:00:00.508 0.0%30781 0.000 0.017 0.822
article parse00:00:00.646 0.0%44813 0.000 0.014 0.038
article write00:00:50.414 0.1%22009 0.151 2.291 12.839
artlog/artcncl00:00:00.001 0.0%173 0.000 0.006 0.056
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.138 0.0%210205 0.000 0.001 0.006
hisgrep/artcncl00:00:00.060 0.0%201 0.000 0.299 2.478
hishave/artcncl00:00:00.004 0.0%202 0.000 0.020 0.500
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:10.136 0.0%200405 0.013 0.051 0.752
history sync00:00:00.012 0.0%307 0.000 0.039 0.500
history write00:00:34.183 0.0%30273 0.000 1.129 5.659
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:56:54.541 99.8%205269 243.947 420.008 1795.907
nntp read00:00:01.607 0.0%210970 0.000 0.008 0.018
overview write00:00:20.490 0.0%22009 0.014 0.931 3.841
perl filter00:00:54.961 0.1%30273 1.064 1.816 6.643
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.433 0.0%66283 0.005 0.022 0.052
TOTAL: 24:00:22.71323:59:50.031100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.089 0.0%36827 0.000 0.002 0.014
article prepare00:00:00.005 0.0%36052 0.000 0.000 0.005
article read00:00:03.349 0.0%7013 0.000 0.478 19.698
backlog stats00:00:00.204 0.0%344621 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.507 0.0%190459 0.002 0.008 0.019
data write00:00:02.568 0.0%168721 0.006 0.015 0.031
idle23:43:41.809 99.3%344621 159.170 247.872 496.915
status file00:09:05.048 0.6%42299 8.030 12.886 24.173
TOTAL: 23:53:17.56123:52:54.579100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:53:52.717 99.4%57800 37.750 55.929 104.133
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:01.057 0.0%117488 0.003 0.009 0.020
readart00:00:00.003 0.0%3 0.000 1.000 3.000
TOTAL: 00:54:12.61700:53:53.777 99.4%----

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 5 47649 19442 26694 1513 40%48:23:25
2newsfeed.neva.ru 147 70280 2271 61626 6383 3%71:58:16
3news.fcku.it 1 10056 393 9404 259 3%29:35:32
4nntp.pasdenom.info 2 21721 43 21675 3 0%23:58:56
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 180 149706 22149 119399 8158 14%173:56:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net65.6 MB0.0 KB5.5 MB71.0 MB 92%3.5 KB
2newsfeed.neva.ru6.4 MB0.0 KB22.8 MB29.2 MB 21%3.5 KB
3news.fcku.it1.5 MB0.0 KB4.7 MB6.2 MB 23%9.7 KB
4nntp.pasdenom.info112.4 KB0.0 KB6.7 KB119.1 KB 94%2.6 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 573.6 MB0.0 KB33.0 MB106.6 MB 69%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 9 00:00:02 - 00:59:59 818 3.7% 0.233.6 MB 4.9% 1.02
Jun 9 01:00:00 - 01:59:59 686 3.1% 0.192.7 MB 3.8% 0.78
Jun 9 02:00:00 - 02:59:59 642 2.9% 0.182.3 MB 3.2% 0.67
Jun 9 03:00:00 - 03:59:59 439 2.0% 0.121.4 MB 1.9% 0.40
Jun 9 04:00:00 - 04:59:59 465 2.1% 0.131.5 MB 2.0% 0.42
Jun 9 05:00:00 - 05:59:59 310 1.4% 0.091006.7 KB 1.4% 0.28
Jun 9 06:00:00 - 06:59:59 530 2.4% 0.153.1 MB 4.2% 0.87
Jun 9 07:00:00 - 07:59:59 625 2.8% 0.172.6 MB 3.6% 0.73
Jun 9 08:00:00 - 08:59:59 758 3.4% 0.212.3 MB 3.2% 0.66
Jun 9 09:00:00 - 09:59:59 1081 4.9% 0.303.0 MB 4.2% 0.86
Jun 9 10:00:00 - 10:59:59 1050 4.8% 0.293.0 MB 4.1% 0.84
Jun 9 11:00:00 - 11:59:59 1189 5.4% 0.333.6 MB 5.0% 1.03
Jun 9 12:00:00 - 12:59:59 1109 5.0% 0.313.0 MB 4.2% 0.86
Jun 9 13:00:00 - 13:59:59 1030 4.7% 0.293.8 MB 5.3% 1.08
Jun 9 14:00:00 - 14:59:59 1151 5.2% 0.323.3 MB 4.5% 0.94
Jun 9 15:00:00 - 15:59:59 1155 5.2% 0.323.9 MB 5.3% 1.10
Jun 9 16:00:00 - 16:59:59 1127 5.1% 0.313.5 MB 4.8% 0.99
Jun 9 17:00:00 - 17:59:59 1319 6.0% 0.373.7 MB 5.1% 1.05
Jun 9 18:00:00 - 18:59:59 1183 5.4% 0.333.2 MB 4.5% 0.92
Jun 9 19:00:00 - 19:59:59 1142 5.2% 0.323.2 MB 4.4% 0.91
Jun 9 20:00:00 - 20:59:59 1155 5.2% 0.325.2 MB 7.1% 1.47
Jun 9 21:00:00 - 21:59:59 1101 5.0% 0.312.9 MB 4.1% 0.84
Jun 9 22:00:00 - 22:59:59 1044 4.7% 0.293.4 MB 4.7% 0.97
Jun 9 23:00:00 - 23:59:59 883 4.0% 0.253.1 MB 4.3% 0.88
Jun 10 00:00:00 - 00:00:03 24 0.1% 8.0099.3 KB 0.1% 33.10
TOTAL: 24:00:01 22016 100.0% 0.2572.3 MB 100.0% 0.86
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 6584 420 0 0 0 0 0 0 6164
2linuxd-out.news.weretis.net 1995 544 0 0 0 0 0 0 1451
3news.fcku.it 215 14 0 0 0 0 0 0 201
4nntp.pasdenom.info 12 0 0 0 0 0 0 0 12
TOTAL: 4 8806 978 0 0 0 0 0 0 7828

Unwanted newsgroups [Top 20]:

NewsgroupCount
ut.test 177
lada.talk 130
gmane.linux.alsa.devel 74
lada.auto 53
it-alt.sport.calcio.juventus 44
alt.windows7.general 44
mozilla.support.seamonkey 35
it.comp.os.win.windows10 34
gmane.linux.kernel 33
mozilla.general 29
it.annunci.varie 28
it.annunci.commerciali 26
it.annunci.immobiliari 23
mozilla.dev.security.policy 18
uk.radio.amateur.moderated 17
mozilla.support.thunderbird 13
spline.eisfair 12
gmane.comp.gis.openstreetmap.tagging 12
mozilla.support.firefox 10
gmane.linux.kernel.renesas-soc 8
TOTAL: 94 978

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6099
EMP (phn path) 735
EMP (phn nph) 172
EMP (phl) 167
Too many newsgroups 60
User-issued cancel 28
Binary Payload 26
Binary Image: misplaced jpg 10
Binary: non-binary distribution 10
HTML post 4
Too many newsgroups (low_xpost) 3
User-issued spam cancel 3
Too many newsgroups (meow) 1
TOTAL: 13 7318

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 484
newsfeed.neva.ru 25
news.fcku.it 1
TOTAL: 3 510
TOTAL: 1 510

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 37484 3062 17796 1023 0 574 8%23:59:52
2news.fcku.it 28365 1979 17024 2847 0 172 6%24:07:38
3weretis.net 2828 55 2521 0 0 1 1%23:53:42
4eternal-september 24915 43 18743 0 0 42 0%23:59:29
5neva.ru 27209 12 19700 122 0 76 0%24:07:47
6vc89.vc.panix.com 2837 0 0 0 0 24807 0%23:58:06
7news.albasani.net 2861 0 0 0 0 23892 0%23:58:18
8news.killfile.org 2839 0 0 0 0 24808 0%23:58:06
9news.netfront.net 2755 0 0 0 0 24684 0%23:57:50
10news.mixmin.net 0 0 0 0 0 0 0%00:10:00
11etla.org 0 0 0 0 0 22123 0%24:07:38
12news.stack.nl 2854 0 0 0 0 24730 0%23:57:58
TOTAL: 12 134947 5151 75784 3992 0 145909 3%264:16:24
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info10.0 MB2.1 MB12.1 MB0.1 KB/s3.0 KB23:59:52
2news.fcku.it5.5 MB9.1 MB14.6 MB0.2 KB/s3.1 KB24:07:38
3eternal-september156.5 KB0.0 KB156.5 KB0.0 KB/s3.6 KB23:59:29
4weretis.net146.9 KB0.0 KB146.9 KB0.0 KB/s2.7 KB23:53:42
5neva.ru113.3 KB768.5 KB881.8 KB0.0 KB/s6.6 KB24:07:47
6vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:06
7news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:18
8news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:58:06
9news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:50
10news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
11etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:07:38
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:58
TOTAL: 1216.0 MB11.9 MB27.9 MB0.0 KB/s3.1 KB264:16:24
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 103 39.5 KB 3 0 000:54:12
TOTAL: 1 103 39.5 KB 3 0 000:54:12

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 103 39.5 KB 3 0 000:54:12
TOTAL: 1 103 39.5 KB 3 0 000:54:12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 11.096 2.764 0.00000:54:12
TOTAL: 1 11.096 2.764 0.00000:54:12

Newsgroup request counts (by category):

CategoryCountPct
1de 1 33.3%
2control 1 33.3%
3ch 1 33.3%
TOTAL: 3 3100.0%

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

NewsgroupCount
1control.cancel 1
2de.test 1
3ch.soc.politics 1
TOTAL: 3 3