Daily Usenet report for paganini.linuxd.org

Mar 28 00:00:02 -- Mar 29 00:00:03

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Mar 28 00:00:02 paganini overchan[3592]: overchan is running while innd is creating overview data (you can ignore this message if you are running makehistory -F)
Mar 28 03:49:03 paganini overchan[3592]: input line too long, skipping
Mar 28 08:58:20 paganini overchan[3592]: input line too long, skipping
Mar 28 08:59:14 paganini overchan[3592]: input line too long, skipping
Mar 28 09:01:12 paganini overchan[3592]: input line too long, skipping
Mar 28 09:16:09 paganini overchan[3592]: input line too long, skipping
Mar 28 09:17:34 paganini overchan[3592]: input line too long, skipping
Mar 28 09:50:20 paganini overchan[3592]: input line too long, skipping
Mar 28 19:58:55 paganini overchan[3592]: input line too long, skipping
Mar 29 00:00:02 paganini overchan[14722]: 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 103868 63.7%12.8 MB 53.2%
inn 40857 25.1%8.8 MB 36.7%
innd 17874 11.0%2.3 MB 9.8%
nnrpd 349 0.2%49.6 KB 0.2%
nocem 79 0.0%14.2 KB 0.1%
overchan 12 0.0%2.0 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 163040 100.0%24.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 126109 51.5%
Negative hits 78777 32.1%
Do not exist 40096 16.4%
Cache misses 69 0.0%
TOTAL: 4 245051 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.338 0.0%160 0.000 2.112 48.000
article cleanup00:00:00.276 0.0%40217 0.000 0.007 0.027
article logging00:00:00.378 0.0%40700 0.000 0.009 0.042
article parse00:00:01.160 0.0%92242 0.000 0.013 0.036
article write00:01:00.250 0.1%23349 0.157 2.580 9.311
artlog/artcncl00:00:00.002 0.0%156 0.000 0.013 1.000
data move00:00:00.285 0.0%259507 0.000 0.001 0.059
hisgrep/artcncl00:00:00.034 0.0%156 0.000 0.218 5.500
hishave/artcncl00:00:00.003 0.0%160 0.000 0.019 0.077
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.799 0.0%245753 0.015 0.052 1.129
history sync00:00:00.025 0.0%399 0.000 0.063 0.667
history write00:00:36.126 0.0%40217 0.043 0.898 2.995
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
idle23:56:49.654 99.7%258467 193.141 333.542 956.509
nntp read00:00:01.871 0.0%268056 0.002 0.007 0.028
overview write00:00:23.509 0.0%23349 0.016 1.007 4.550
perl filter00:01:26.501 0.1%40215 1.178 2.151 4.347
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.166 0.0%70184 0.000 0.017 0.055
TOTAL: 24:01:06.99824:00:34.377100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.110 0.0%62028 0.000 0.002 0.012
article prepare00:00:00.010 0.0%39240 0.000 0.000 0.009
article read00:00:02.649 0.0%7838 0.000 0.338 8.982
backlog stats00:00:00.234 0.0%388162 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.663 0.0%211078 0.001 0.008 0.018
data write00:00:03.373 0.0%188349 0.008 0.018 0.032
idle23:42:53.778 99.2%388162 25.357 219.944 404.015
status file00:10:39.662 0.7%43444 9.490 14.724 26.852
TOTAL: 23:53:54.85023:53:41.479100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:01:02.120 99.9%324 27.333 33525.062600301.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.007 0.0%848 0.000 0.008 0.125
TOTAL: 03:01:11.26403:01:02.127 99.9%----

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 4 50538 20080 28628 1830 39%48:22:59
2newsfeed.neva.ru 141 85259 3125 67274 14860 3%71:23:00
3nntp.pasdenom.info 2 24079 101 23966 12 0%24:06:20
4news.fcku.it 1 2083 64 1985 34 3%07:22:50
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 173 161959 23370 121853 16736 14%151:15:09
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net63.1 MB0.0 KB12.8 MB75.9 MB 83%3.5 KB
2newsfeed.neva.ru7.8 MB0.0 KB134.1 MB141.9 MB 5%8.1 KB
3news.fcku.it473.8 KB0.0 KB277.5 KB751.3 KB 63%7.7 KB
4nntp.pasdenom.info253.5 KB0.0 KB204.1 KB457.5 KB 55%4.0 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 571.6 MB0.0 KB147.4 MB219.0 MB 32%5.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Mar 28 00:00:02 - 00:59:59 967 4.1% 0.272.7 MB 3.6% 0.76
Mar 28 01:00:00 - 01:59:59 828 3.5% 0.232.4 MB 3.3% 0.70
Mar 28 02:00:00 - 02:59:59 744 3.2% 0.212.8 MB 3.8% 0.79
Mar 28 03:00:00 - 03:59:59 548 2.3% 0.152.2 MB 3.0% 0.63
Mar 28 04:00:00 - 04:59:59 454 1.9% 0.131.4 MB 1.9% 0.39
Mar 28 05:00:00 - 05:59:59 451 1.9% 0.132.0 MB 2.7% 0.57
Mar 28 06:00:00 - 06:59:59 524 2.2% 0.152.0 MB 2.7% 0.56
Mar 28 07:00:00 - 07:59:59 526 2.3% 0.152.0 MB 2.7% 0.56
Mar 28 08:00:00 - 08:59:59 745 3.2% 0.212.5 MB 3.4% 0.71
Mar 28 09:00:00 - 09:59:59 819 3.5% 0.232.3 MB 3.1% 0.66
Mar 28 10:00:00 - 10:59:59 935 4.0% 0.262.4 MB 3.2% 0.68
Mar 28 11:00:00 - 11:59:59 1077 4.6% 0.302.9 MB 3.9% 0.81
Mar 28 12:00:00 - 12:59:59 1113 4.8% 0.312.9 MB 4.0% 0.83
Mar 28 13:00:00 - 13:59:59 944 4.0% 0.262.6 MB 3.6% 0.75
Mar 28 14:00:00 - 14:59:59 1248 5.3% 0.353.7 MB 5.0% 1.05
Mar 28 15:00:00 - 15:59:59 1292 5.5% 0.363.8 MB 5.2% 1.08
Mar 28 16:00:00 - 16:59:59 1371 5.9% 0.384.4 MB 6.0% 1.26
Mar 28 17:00:00 - 17:59:59 1287 5.5% 0.364.1 MB 5.6% 1.17
Mar 28 18:00:00 - 18:59:59 1253 5.4% 0.353.7 MB 5.0% 1.04
Mar 28 19:00:00 - 19:59:59 1269 5.4% 0.354.0 MB 5.4% 1.14
Mar 28 20:00:00 - 20:59:59 1292 5.5% 0.365.2 MB 7.0% 1.47
Mar 28 21:00:00 - 21:59:59 1395 6.0% 0.394.2 MB 5.7% 1.19
Mar 28 22:00:00 - 22:59:59 1215 5.2% 0.344.5 MB 6.2% 1.29
Mar 28 23:00:00 - 23:59:59 1054 4.5% 0.293.0 MB 4.1% 0.85
Mar 29 00:00:00 - 00:00:03 10 0.0% 3.3362.5 KB 0.1% 20.84
TOTAL: 24:00:01 23361 100.0% 0.2773.7 MB 100.0% 0.87
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 14982 461 0 0 0 0 0 014521
2linuxd-out.news.weretis.net 2276 527 0 0 0 0 0 0 1749
3news.fcku.it 71 0 0 0 0 0 0 0 71
4nntp.pasdenom.info 11 2 0 0 0 2 0 0 7
TOTAL: 4 17340 990 0 0 0 2 0 016348

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 148
ut.test 135
lada.auto 92
it.comp.os.win.windows10 46
alt.windows7.general 35
it-alt.sport.calcio.juventus 34
it.annunci.immobiliari 31
gmane.linux.alsa.devel 29
it.annunci.commerciali 26
it.annunci.varie 25
spline.eisfair 22
mozilla.dev.security.policy 21
alt.survival 20
alt.politics.scorched-earth 17
lada.commerce 16
mozilla.support.seamonkey 14
gmane.comp.gis.openstreetmap.tagging 11
mozilla.dev.platform 11
alt.computer.workshop 10
mpc.lists.nanog 10
TOTAL: 119 990

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 14146
EMP (phn path) 1409
EMP (phn nph) 133
User-issued cancel 50
Too many newsgroups 43
Binary Payload 40
Too many newsgroups (low_xpost) 24
Binary: non-binary distribution 11
HTML post 4
Cancel for rejected article 1
Binary: misplaced xlsx 1
U2 violation - invalid distribution 1
Binary: misplaced zip 1
Too many newsgroups (meow) 1
TOTAL: 14 15865

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 446
newsfeed.neva.ru 36
news.fcku.it 1
TOTAL: 3 483
TOTAL: 1 483

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 58527 2712 39926 755 0 3756 4%23:57:48
2news.fcku.it 31809 2427 16974 3752 0 450 7%23:59:53
3weretis.net 3633 62 3292 0 0 8 1%23:59:55
4eternal-september 26464 53 20061 2 0 103 0%23:59:40
5neva.ru 30720 48 20111 56 0 296 0%23:59:54
6news.netfront.net 2756 0 0 0 0 26001 0%23:59:54
7news.mixmin.net 0 0 0 0 0 0 0%00:10:00
8news.albasani.net 2867 0 0 0 0 25457 0%23:59:54
9etla.org 0 0 0 0 0 23361 0%23:59:55
10vc89.vc.panix.com 2839 0 0 0 0 26199 0%23:59:54
11news.stack.nl 2859 0 0 0 0 26188 0%23:59:54
12news.killfile.org 2848 0 0 0 0 26208 0%23:59:54
TOTAL: 12 165322 5302 100364 4565 0 158027 3%264:06:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info9.2 MB1.6 MB10.8 MB0.1 KB/s3.2 KB23:57:48
2news.fcku.it6.7 MB10.7 MB17.4 MB0.2 KB/s2.9 KB23:59:53
3neva.ru344.2 KB723.2 KB1.0 MB0.0 KB/s10.3 KB23:59:54
4eternal-september166.8 KB83.5 KB250.3 KB0.0 KB/s4.6 KB23:59:40
5weretis.net91.3 KB0.0 KB91.3 KB0.0 KB/s1.5 KB23:59:55
6news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
7news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
8news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
9etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
10vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
11news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:54
TOTAL: 1216.5 MB13.1 MB29.6 MB0.0 KB/s3.1 KB264:06:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-092-073-008-096.092.073.pools.vodafone-ip.de 100 00.0 KB 0 0 000:00:15
2challenger.nielsenmedia.com 10 00.0 KB 0 0 003:00:55
TOTAL: 2 110 00.0 KB 0 0 003:01:10

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 10 00.0 KB 0 0 003:00:55
2*.092.073.pools.vodafone-ip.de 100 00.0 KB 0 0 000:00:15
TOTAL: 2 110 00.0 KB 0 0 003:01:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.600 0.048 0.00003:00:55
dslb-092-073-008-096.092.073.pools.vodafone-ip.de 5.300 0.284 0.00000:00:15
TOTAL: 2 5.900 0.332 0.00003:01:10

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 6 0
TOTAL: 1 6 0