Daily Usenet report for paganini.linuxd.org

Jun 1 00:00:03 -- Jun 2 00:00:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Jun 1 02:01:52 paganini pgpverify[14699]: pgpverify: verification failed
Jun 1 07:10:21 paganini overchan[2350]: input line too long, skipping
Jun 1 07:46:26 paganini overchan[2350]: input line too long, skipping
Jun 1 19:05:24 paganini overchan[2350]: input line too long, skipping
Jun 2 00:00:01 paganini overchan[14279]: 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 101394 48.9%12.5 MB 42.3%
nnrpd 64288 31.0%7.4 MB 25.0%
inn 31976 15.4%8.1 MB 27.3%
innd 9465 4.6%1.6 MB 5.4%
nocem 108 0.1%19.6 KB 0.1%
controlchan 7 0.0%1.1 KB 0.0%
overchan 5 0.0%0.8 KB 0.0%
pgpverify 1 0.0%0.2 KB 0.0%
TOTAL: 8 207244 100.0%29.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 118283 57.5%
Negative hits 56279 27.3%
Do not exist 31190 15.2%
Cache misses 71 0.0%
TOTAL: 4 205823 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:01.822 0.0%206 0.000 8.845 89.692
article cleanup00:00:00.213 0.0%31279 0.000 0.007 0.027
article logging00:00:00.372 0.0%31643 0.000 0.012 0.384
article parse00:00:00.637 0.0%47407 0.000 0.013 0.036
article write00:00:53.971 0.1%22831 0.133 2.364 14.379
artlog/artcncl00:00:00.000 0.0%206 0.000 0.000 0.000
data move00:00:00.135 0.0%216127 0.000 0.001 0.003
hisgrep/artcncl00:00:00.024 0.0%205 0.000 0.117 2.750
hishave/artcncl00:00:00.003 0.0%206 0.000 0.015 0.100
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:12.567 0.0%206381 0.013 0.061 0.446
history sync00:00:00.026 0.0%388 0.000 0.067 1.000
history write00:00:37.305 0.0%31278 0.022 1.193 4.199
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:47:25.444 99.7%211223 256.924 405.474 843.612
nntp read00:00:01.623 0.0%217311 0.002 0.007 0.015
overview write00:00:19.539 0.0%22831 0.012 0.856 5.267
perl filter00:01:00.814 0.1%31277 1.160 1.944 6.944
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.471 0.0%68683 0.004 0.021 0.057
TOTAL: 23:51:09.35823:50:35.966100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.093 0.0%38311 0.000 0.002 0.019
article prepare00:00:00.003 0.0%36376 0.000 0.000 0.007
article read00:00:05.355 0.0%7096 0.000 0.755 21.585
backlog stats00:00:00.211 0.0%361413 0.000 0.001 0.002
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.588 0.0%199030 0.002 0.008 0.022
data write00:00:03.091 0.0%176475 0.009 0.018 0.033
idle23:43:15.807 99.3%361413 156.688 236.283 399.156
status file00:09:07.461 0.6%42349 7.040 12.927 41.078
TOTAL: 23:52:57.61023:52:33.609100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:59:21.637 99.3%65006 38.111 110.169450753.250
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:08.147 0.1%223298 0.000 0.036 0.099
readart00:00:00.000 0.0%11 0.000 0.000 0.000
TOTAL: 02:00:10.27901:59:29.784 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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
bofh-control@killfile.org001001
us-control@lists.killfile.org000100
TOTAL001101

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 6 48304 19691 27483 1130 40%48:19:06
2newsfeed.neva.ru 146 71218 2933 60979 7306 4%71:22:21
3news.fcku.it 1 3723 142 3495 86 3%10:56:28
4nntp.pasdenom.info 3 19117 45 19068 4 0%19:36:24
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 181 142362 22811 111025 8526 16%150:14:19
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net68.4 MB0.0 KB4.4 MB72.9 MB 93%3.6 KB
2newsfeed.neva.ru7.6 MB8.4 KB32.6 MB40.3 MB 18%4.0 KB
3news.fcku.it698.1 KB0.0 KB464.7 KB1.1 MB 60%5.1 KB
4nntp.pasdenom.info128.6 KB0.0 KB13.3 KB141.9 KB 90%2.9 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 576.9 MB8.4 KB37.5 MB114.4 MB 67%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 1 00:00:03 - 00:59:59 787 3.4% 0.223.0 MB 3.9% 0.87
Jun 1 01:00:00 - 01:59:59 693 3.0% 0.192.6 MB 3.3% 0.74
Jun 1 02:00:00 - 02:59:59 622 2.7% 0.172.1 MB 2.7% 0.59
Jun 1 03:00:00 - 03:59:59 538 2.3% 0.152.7 MB 3.4% 0.75
Jun 1 04:00:00 - 04:59:59 540 2.4% 0.152.1 MB 2.7% 0.61
Jun 1 05:00:00 - 05:59:59 642 2.8% 0.182.7 MB 3.5% 0.77
Jun 1 06:00:00 - 06:59:59 523 2.3% 0.151.9 MB 2.5% 0.55
Jun 1 07:00:00 - 07:59:59 595 2.6% 0.172.1 MB 2.7% 0.60
Jun 1 08:00:00 - 08:59:59 658 2.9% 0.182.3 MB 3.0% 0.67
Jun 1 09:00:00 - 09:59:59 947 4.1% 0.262.7 MB 3.5% 0.77
Jun 1 10:00:00 - 10:59:59 977 4.3% 0.272.7 MB 3.4% 0.76
Jun 1 11:00:00 - 11:59:59 1005 4.4% 0.282.8 MB 3.6% 0.79
Jun 1 12:00:00 - 12:59:59 1116 4.9% 0.313.2 MB 4.1% 0.91
Jun 1 13:00:00 - 13:59:59 1116 4.9% 0.314.1 MB 5.3% 1.18
Jun 1 14:00:00 - 14:59:59 1119 4.9% 0.313.2 MB 4.1% 0.90
Jun 1 15:00:00 - 15:59:59 1153 5.0% 0.324.3 MB 5.5% 1.21
Jun 1 16:00:00 - 16:59:59 1357 5.9% 0.385.0 MB 6.4% 1.42
Jun 1 17:00:00 - 17:59:59 1264 5.5% 0.353.8 MB 4.9% 1.08
Jun 1 18:00:00 - 18:59:59 1436 6.3% 0.404.5 MB 5.8% 1.28
Jun 1 19:00:00 - 19:59:59 1257 5.5% 0.353.6 MB 4.7% 1.03
Jun 1 20:00:00 - 20:59:59 1187 5.2% 0.334.0 MB 5.1% 1.13
Jun 1 21:00:00 - 21:59:59 1118 4.9% 0.313.5 MB 4.5% 0.99
Jun 1 22:00:00 - 22:59:59 1201 5.2% 0.334.1 MB 5.3% 1.18
Jun 1 23:00:00 - 23:59:59 1077 4.7% 0.304.8 MB 6.2% 1.37
Jun 2 00:00:00 - 00:00:02 11 0.0% 5.5024.1 KB 0.0% 12.03
TOTAL: 23:59:59 22939 100.0% 0.2777.9 MB 100.0% 0.92
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 7270 455 0 1 1 0 0 0 6813
2linuxd-out.news.weretis.net 1465 537 0 0 0 0 0 0 928
3news.fcku.it 73 3 0 0 0 0 0 0 70
4nntp.pasdenom.info 17 1 0 0 0 1 0 0 15
TOTAL: 4 8825 996 0 1 1 1 0 0 7826

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 186
ut.test 141
it-alt.sport.calcio.juventus 58
mpc.lists.nanog 38
alt.windows7.general 35
mpc.lists.freebsd.ports.bugs 35
it.comp.os.win.windows10 33
lada.auto 32
it.annunci.commerciali 30
it.annunci.immobiliari 30
it.annunci.varie 29
mozilla.support.thunderbird 22
mozilla.dev.security.policy 19
alt.survival 18
spline.eisfair 15
mozilla.support.seamonkey 15
gmane.linux.drivers.video-input-infrastructure 14
gmane.linux.usb.general 12
mozilla.dev.ui-alerts 11
cakewalk.audio 10
TOTAL: 109 996

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
uk.legal.moderated 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 6684
EMP (phn path) 519
EMP (phl) 132
User-issued cancel 43
Too many newsgroups 23
Binary Payload 23
Binary: non-binary distribution 14
HTML post 12
User-issued spam cancel 6
Too many newsgroups (meow) 2
Binary: misplaced BRK 1
TOTAL: 11 7459

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 340
newsfeed.neva.ru 26
news.fcku.it 1
TOTAL: 3 367
TOTAL: 1 367

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 38862 3163 18734 866 0 680 8%23:57:35
2news.fcku.it 32428 1971 17923 2906 0 418 6%23:59:42
3weretis.net 3458 77 3104 0 0 7 2%23:58:24
4eternal-september 25209 32 19579 0 0 31 0%23:59:42
5neva.ru 28636 14 19851 122 0 223 0%23:59:42
6news.albasani.net 2865 0 0 0 0 24885 0%23:59:42
7news.mixmin.net 0 0 0 0 0 0 0%00:10:00
8news.stack.nl 2859 0 0 0 0 25682 0%23:59:42
9etla.org 0 0 0 0 0 22939 0%23:59:42
10vc89.vc.panix.com 2843 0 0 0 0 25781 0%23:59:42
11news.netfront.net 2756 0 0 0 0 25630 0%23:59:41
12news.killfile.org 2843 0 0 0 0 25781 0%23:59:42
TOTAL: 12 142759 5257 79191 3894 0 152057 3%264:03:16
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info10.6 MB2.0 MB12.6 MB0.1 KB/s3.2 KB23:57:35
2news.fcku.it5.8 MB9.7 MB15.5 MB0.2 KB/s3.3 KB23:59:42
3eternal-september141.0 KB0.0 KB141.0 KB0.0 KB/s4.4 KB23:59:42
4weretis.net90.6 KB0.0 KB90.6 KB0.0 KB/s1.2 KB23:58:24
5neva.ru45.0 KB378.2 KB423.1 KB0.0 KB/s3.1 KB23:59:42
6news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
7news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
8news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
9etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
10vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
11news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:41
12news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:42
TOTAL: 1216.7 MB12.0 MB28.7 MB0.0 KB/s3.2 KB264:03:16
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1dslb-088-067-084-037.088.067.pools.vodafone-ip.de 115 1022.5 KB 3 0 000:59:02
288.67.84.37 1 11.6 KB 1 0 000:00:50
TOTAL: 2 116 1124.1 KB 4 0 002:00:09

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.088.067.pools.vodafone-ip.de 115 1022.5 KB 3 0 000:59:02
2unresolved 3 11.6 KB 1 0 000:01:02
3*.nielsenmedia.com 2 00.0 KB 0 0 001:00:04
TOTAL: 3 120 1124.1 KB 4 0 002:00:09

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.124 0.008 0.00001:00:04
dslb-088-067-084-037.088.067.pools.vodafone-ip.de 12.312 3.136 0.00000:59:02
88.67.84.37 0.104 0.032 0.00000:00:50
67.43.172.252 0.168 0.060 0.00000:00:11
TOTAL: 4 12.708 3.236 0.00002:00:09

Curious NNRP server explorers [Top 20]:

SystemConn
challenger.nielsenmedia.com 2
67.43.172.252 2
TOTAL: 2 4

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

CategoryCountPct
1de 11100.0%
TOTAL: 1 11100.0%

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

NewsgroupCount
1de.talk.tagesgeschehen 9
2de.sci.theologie 1
3de.soc.umwelt 1
TOTAL: 3 11