Daily Usenet report for paganini.linuxd.org

Oct 3 00:00:02 -- Oct 4 00:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Oct 3 00:38:05 paganini overchan[28904]: input line too long, skipping
Oct 4 00:00:02 paganini overchan[16520]: 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 101168 63.7%12.5 MB 52.7%
inn 40515 25.5%8.8 MB 37.4%
innd 16502 10.4%2.3 MB 9.6%
nnrpd 487 0.3%67.4 KB 0.3%
nocem 47 0.0%7.3 KB 0.0%
overchan 3 0.0%0.3 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 158723 100.0%23.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 106350 47.3%
Negative hits 78784 35.0%
Do not exist 39661 17.6%
Cache misses 73 0.0%
TOTAL: 4 224868 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.090 0.0%138 0.000 0.652 14.000
article cleanup00:00:00.273 0.0%39815 0.000 0.007 0.029
article logging00:00:00.350 0.0%40329 0.000 0.009 0.042
article parse00:00:01.055 0.0%84241 0.000 0.013 0.036
article write00:00:53.156 0.1%23516 0.058 2.260 29.608
artlog/artcncl00:00:00.000 0.0%134 0.000 0.000 0.000
data move00:00:00.147 0.0%246897 0.000 0.001 0.003
hisgrep/artcncl00:00:00.003 0.0%138 0.000 0.022 1.000
hishave/artcncl00:00:00.004 0.0%138 0.000 0.029 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:11.395 0.0%225682 0.012 0.050 0.406
history sync00:00:00.203 0.0%397 0.000 0.511 16.000
history write00:00:35.300 0.0%39815 0.027 0.887 4.588
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:57.934 99.7%245903 195.655 350.618 1027.837
nntp read00:00:01.962 0.0%250905 0.004 0.008 0.015
overview write00:00:22.761 0.0%23516 0.000 0.968 2.671
perl filter00:01:28.768 0.1%39815 1.035 2.230 4.470
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.512 0.0%70689 0.005 0.021 0.053
TOTAL: 24:01:13.07624:00:34.913100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.097 0.0%38415 0.000 0.003 0.013
article prepare00:00:00.001 0.0%26092 0.000 0.000 0.004
article read00:00:01.126 0.0%4275 0.000 0.263 5.500
backlog stats00:00:00.214 0.0%377236 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.575 0.0%204728 0.002 0.008 0.015
data write00:00:03.125 0.0%181326 0.008 0.017 0.028
idle23:42:45.031 99.3%377236 145.658 226.291 468.321
status file00:10:11.524 0.7%42287 8.883 14.461 33.642
TOTAL: 23:53:23.82323:53:02.693100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle04:49:24.239 99.9%419 28.667 41442.098600183.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.010 0.0%1113 0.000 0.009 0.250
readart00:00:00.115 0.0%14 0.000 8.214 45.000
TOTAL: 04:49:40.24604:49:24.364 99.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 3 52417 18175 32271 1971 34%48:18:25
2news.fcku.it 3 10081 2757 7082 242 27%24:06:40
3newsfeed.neva.ru 145 84658 2676 67901 14081 3%72:12:37
4localhost 25 0 0 0 0 0%00:00:00
5nntp.pasdenom.info 2 0 0 0 0 0%00:20:00
TOTAL: 5 178 147156 23608 107254 16294 16%144:57:42
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net64.9 MB0.0 KB11.6 MB76.5 MB 84%3.9 KB
2newsfeed.neva.ru7.5 MB0.0 KB111.3 MB118.8 MB 6%7.3 KB
3news.fcku.it7.3 MB0.0 KB1.0 MB8.4 MB 87%2.9 KB
4localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
5nntp.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 579.7 MB0.0 KB124.0 MB203.7 MB 39%5.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 3 00:00:02 - 00:59:59 801 3.4% 0.222.2 MB 2.8% 0.63
Oct 3 01:00:00 - 01:59:59 843 3.6% 0.234.1 MB 5.2% 1.17
Oct 3 02:00:00 - 02:59:59 578 2.5% 0.161.7 MB 2.1% 0.48
Oct 3 03:00:00 - 03:59:59 537 2.3% 0.151.7 MB 2.2% 0.49
Oct 3 04:00:00 - 04:59:59 528 2.2% 0.152.3 MB 2.8% 0.64
Oct 3 05:00:00 - 05:59:59 392 1.7% 0.111.3 MB 1.7% 0.38
Oct 3 06:00:00 - 06:59:59 456 1.9% 0.131.3 MB 1.7% 0.38
Oct 3 07:00:00 - 07:59:59 466 2.0% 0.131.8 MB 2.2% 0.51
Oct 3 08:00:00 - 08:59:59 602 2.6% 0.171.8 MB 2.3% 0.52
Oct 3 09:00:00 - 09:59:59 930 4.0% 0.262.6 MB 3.3% 0.75
Oct 3 10:00:00 - 10:59:59 1095 4.7% 0.303.3 MB 4.1% 0.93
Oct 3 11:00:00 - 11:59:59 1167 5.0% 0.323.1 MB 3.9% 0.87
Oct 3 12:00:00 - 12:59:59 1116 4.8% 0.313.6 MB 4.5% 1.02
Oct 3 13:00:00 - 13:59:59 1043 4.4% 0.292.6 MB 3.3% 0.74
Oct 3 14:00:00 - 14:59:59 1103 4.7% 0.313.0 MB 3.7% 0.84
Oct 3 15:00:00 - 15:59:59 1216 5.2% 0.343.3 MB 4.1% 0.93
Oct 3 16:00:00 - 16:59:59 1359 5.8% 0.383.4 MB 4.3% 0.96
Oct 3 17:00:00 - 17:59:59 1369 5.8% 0.383.6 MB 4.5% 1.02
Oct 3 18:00:00 - 18:59:59 1470 6.3% 0.414.2 MB 5.3% 1.20
Oct 3 19:00:00 - 19:59:59 1487 6.3% 0.417.9 MB 9.9% 2.24
Oct 3 20:00:00 - 20:59:59 1429 6.1% 0.405.8 MB 7.4% 1.66
Oct 3 21:00:00 - 21:59:59 1321 5.6% 0.376.5 MB 8.3% 1.86
Oct 3 22:00:00 - 22:59:59 1195 5.1% 0.335.1 MB 6.4% 1.44
Oct 3 23:00:00 - 23:59:59 965 4.1% 0.273.0 MB 3.8% 0.86
Oct 4 00:00:00 - 00:00:02 7 0.0% 3.5040.9 KB 0.1% 20.46
TOTAL: 24:00:00 23475 100.0% 0.2779.3 MB 100.0% 0.94
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 14209 1041 0 0 0 0 0 013168
2linuxd-out.news.weretis.net 2450 742 0 0 0 0 0 0 1708
3news.fcku.it 247 4 0 0 0 0 0 0 243
TOTAL: 3 16906 1787 0 0 0 0 0 015119

Unwanted newsgroups [Top 20]:

NewsgroupCount
fa.linux.kernel 461
lada.talk 130
ut.test 127
alt.survival 93
fa.freebsd.cvs-all 76
it-alt.sport.calcio.juventus 66
lada.auto 55
fa.openbsd.source-changes 47
lada.photo 47
mozilla.support.seamonkey 39
mozilla.support.thunderbird 31
gmane.linux.alsa.devel 30
it.comp.os.win.windows10 27
fa.philos-l 26
alt.politics.scorched-earth 25
mpc.lists.nanog 24
lada.commerce 20
alt.windows7.general 20
fa.netbsd.bugs 18
fa.openbsd.tech 16
TOTAL: 147 1787

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 11659
EMP (phn path) 2047
EMP (phl) 702
EMP (phn nph) 65
User-issued cancel 48
Too many newsgroups 38
Binary Payload 15
User-issued spam cancel 11
Too many newsgroups (meow) 10
Binary: non-binary distribution 7
HTML post 2
Too many newsgroups (low_xpost) 1
Binary Image: misplaced jpg 1
TOTAL: 13 14606

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 473
newsfeed.neva.ru 37
news.fcku.it 3
TOTAL: 3 513
TOTAL: 1 513

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nntp.pasdenom.info 42113 1655 21596 180 0 866 3%23:57:39
2weretis.net 5745 977 4403 0 0 3 17%23:58:47
3news.fcku.it 27788 975 18010 1660 0 15 3%23:50:01
4neva.ru 32531 392 19723 680 0 70 1%23:59:46
5eternal-september 26902 10 19784 0 0 11 0%23:59:45
6news.albasani.net 2860 0 0 0 0 25249 0%23:59:46
7news.netfront.net 2759 0 0 0 0 26170 0%23:59:45
8news.killfile.org 2849 0 0 0 0 26323 0%23:59:46
9news.stack.nl 2820 0 0 0 0 26096 0%23:59:46
10etla.org 0 0 0 0 0 23475 0%23:59:46
11vc89.vc.panix.com 2839 0 0 0 0 26313 0%23:59:46
12news.mixmin.net 0 0 0 0 0 0 0%00:10:01
TOTAL: 12 149206 4009 83516 2520 0 154591 2%263:54:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nntp.pasdenom.info7.7 MB572.8 KB8.3 MB0.1 KB/s4.6 KB23:57:39
2news.fcku.it6.9 MB8.3 MB15.2 MB0.2 KB/s5.9 KB23:50:01
3weretis.net2.7 MB0.0 KB2.7 MB0.0 KB/s2.8 KB23:58:47
4neva.ru1.6 MB2.2 MB3.8 MB0.0 KB/s3.6 KB23:59:46
5eternal-september22.1 KB0.0 KB22.1 KB0.0 KB/s2.2 KB23:59:45
6news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
7news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:45
8news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
9news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
10etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
11vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:46
12news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:01
TOTAL: 1218.8 MB11.0 MB29.9 MB0.0 KB/s4.7 KB263:54:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 15 1142.9 KB 6 0 002:32:30
247.192.187.101 11 39.0 KB 3 0 002:16:45
TOTAL: 2 26 1451.9 KB 9 0 004:49:39

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 15 1142.9 KB 6 0 002:32:30
2unresolved 11 39.0 KB 3 0 002:16:45
3*.188.110.pools.vodafone-ip.de 114 00.0 KB 0 0 000:00:23
TOTAL: 3 140 1451.9 KB 9 0 004:49:39

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.872 0.072 0.00002:32:30
47.192.187.101 0.804 0.064 0.00002:16:45
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 5.960 0.360 0.00000:00:23
TOTAL: 3 7.636 0.496 0.00004:49:39

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-188-110-188-212.188.110.pools.vodafone-ip.de 114
TOTAL: 1 114

NNRP client timeouts [Top 20]:

SystemConnPeer
47.192.187.101 4 0
challenger.nielsenmedia.com 4 0
TOTAL: 2 8 0

Newsgroup request counts (by category):

CategoryCountPct
1comp 14100.0%
TOTAL: 1 14100.0%

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

NewsgroupCount
1comp.lang.awk 14
TOTAL: 1 14