Daily Usenet report for paganini.linuxd.org

Jan 13 00:00:03 -- Jan 14 00:00:03

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jan 13 09:37:24 paganini overchan[8699]: input line too long, skipping
Jan 13 21:26:59 paganini overchan[8699]: input line too long, skipping
Jan 14 00:00:03 paganini overchan[30100]: 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 101317 63.6%12.5 MB 52.7%
inn 40367 25.3%8.9 MB 37.4%
innd 16921 10.6%2.3 MB 9.5%
nnrpd 594 0.4%83.6 KB 0.3%
nocem 40 0.0%6.8 KB 0.0%
overchan 5 0.0%0.7 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 7 159245 100.0%23.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 140998 54.4%
Negative hits 78405 30.3%
Do not exist 39507 15.3%
Cache misses 90 0.0%
TOTAL: 4 259000 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.780 0.0%199 0.000 3.920 282.000
article cleanup00:00:00.264 0.0%39650 0.000 0.007 0.033
article logging00:00:00.457 0.0%40262 0.000 0.011 0.129
article parse00:00:00.952 0.0%82782 0.000 0.012 0.034
article write00:00:54.588 0.1%23634 0.148 2.310 15.202
artlog/artcncl00:00:00.000 0.0%163 0.000 0.000 0.000
data move00:00:00.179 0.0%268845 0.000 0.001 0.003
hisgrep/artcncl00:00:00.037 0.0%199 0.000 0.186 2.583
hishave/artcncl00:00:00.003 0.0%199 0.000 0.015 0.056
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:14.966 0.0%260109 0.016 0.058 0.525
history sync00:00:00.021 0.0%302 0.000 0.070 1.000
history write00:00:33.427 0.0%39650 0.044 0.843 2.556
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:09.516 99.7%265649 206.847 324.374 1057.485
nntp read00:00:02.090 0.0%276084 0.003 0.008 0.017
overview write00:00:23.949 0.0%23634 0.019 1.013 3.208
perl filter00:01:23.899 0.1%39650 1.061 2.116 5.523
python filter00:00:00.000 0.0%0 0.000 0.000 0.000
site send00:00:01.455 0.0%71076 0.004 0.020 0.053
TOTAL: 24:00:22.77423:59:46.583100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.092 0.0%38681 0.000 0.002 0.018
article prepare00:00:00.009 0.0%28020 0.000 0.000 0.008
article read00:00:02.337 0.0%6142 0.000 0.380 25.571
backlog stats00:00:00.253 0.0%372859 0.000 0.001 0.003
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:01.631 0.0%204130 0.002 0.008 0.017
data write00:00:03.161 0.0%180680 0.006 0.017 0.034
idle23:42:43.439 99.3%372859 147.709 228.943 444.799
status file00:10:07.584 0.7%42317 6.630 14.358 25.993
TOTAL: 23:53:17.23023:52:58.506100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle05:12:25.031 99.7%532 29.000 35235.021600123.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:11.301 0.1%1611 0.000 7.015 41.330
readart00:00:04.300 0.0%10477 0.333 0.410 0.410
TOTAL: 05:13:13.84205:12:40.632 99.8%----

Control commands to INND:

CommandNumber
L 1
flush 7
flushlogs 2
go 2
logmode 2
mode 149
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 173

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1linuxd-out.news.weretis.net 4 52403 20577 29418 2408 39%48:10:12
2newsfeed.neva.ru 146 84610 2863 68892 12855 3%71:45:29
3news.fcku.it 2 9464 213 9103 148 2%26:34:13
4nntp.pasdenom.info 2 22838 10 22284 544 0%16:25:22
5localhost 25 0 0 0 0 0%00:00:00
TOTAL: 5 179 169315 23663 129697 15955 13%162:55:16
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1linuxd-out.news.weretis.net61.9 MB0.0 KB15.2 MB77.0 MB 80%3.4 KB
2newsfeed.neva.ru7.4 MB0.0 KB108.0 MB115.4 MB 6%7.5 KB
3news.fcku.it1.2 MB0.0 KB596.5 KB1.7 MB 66%4.9 KB
4nntp.pasdenom.info25.8 KB0.0 KB1.9 MB2.0 MB 1%3.6 KB
5localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 570.4 MB0.0 KB125.7 MB196.1 MB 35%5.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 13 00:00:03 - 00:59:59 942 4.0% 0.264.0 MB 5.7% 1.15
Jan 13 01:00:00 - 01:59:59 744 3.2% 0.212.4 MB 3.4% 0.68
Jan 13 02:00:00 - 02:59:59 552 2.3% 0.151.6 MB 2.3% 0.45
Jan 13 03:00:00 - 03:59:59 456 1.9% 0.131.4 MB 2.0% 0.40
Jan 13 04:00:00 - 04:59:59 486 2.1% 0.141.5 MB 2.2% 0.44
Jan 13 05:00:00 - 05:59:59 509 2.2% 0.142.0 MB 2.8% 0.57
Jan 13 06:00:00 - 06:59:59 539 2.3% 0.152.1 MB 3.0% 0.60
Jan 13 07:00:00 - 07:59:59 528 2.2% 0.151.6 MB 2.3% 0.47
Jan 13 08:00:00 - 08:59:59 704 3.0% 0.201.9 MB 2.7% 0.54
Jan 13 09:00:00 - 09:59:59 960 4.1% 0.272.6 MB 3.7% 0.74
Jan 13 10:00:00 - 10:59:59 1112 4.7% 0.313.0 MB 4.3% 0.85
Jan 13 11:00:00 - 11:59:59 1169 5.0% 0.323.0 MB 4.2% 0.84
Jan 13 12:00:00 - 12:59:59 1035 4.4% 0.292.9 MB 4.1% 0.81
Jan 13 13:00:00 - 13:59:59 1179 5.0% 0.333.1 MB 4.3% 0.87
Jan 13 14:00:00 - 14:59:59 1266 5.4% 0.353.4 MB 4.8% 0.96
Jan 13 15:00:00 - 15:59:59 1201 5.1% 0.333.1 MB 4.4% 0.87
Jan 13 16:00:00 - 16:59:59 1400 5.9% 0.394.0 MB 5.7% 1.14
Jan 13 17:00:00 - 17:59:59 1366 5.8% 0.384.4 MB 6.2% 1.25
Jan 13 18:00:00 - 18:59:59 1336 5.7% 0.373.7 MB 5.3% 1.07
Jan 13 19:00:00 - 19:59:59 1365 5.8% 0.384.1 MB 5.9% 1.17
Jan 13 20:00:00 - 20:59:59 1275 5.4% 0.353.9 MB 5.6% 1.12
Jan 13 21:00:00 - 21:59:59 1155 4.9% 0.323.1 MB 4.4% 0.88
Jan 13 22:00:00 - 22:59:59 1240 5.3% 0.343.7 MB 5.3% 1.07
Jan 13 23:00:00 - 23:59:59 1052 4.5% 0.293.7 MB 5.2% 1.05
Jan 14 00:00:00 - 00:00:03 12 0.1% 4.0063.9 KB 0.1% 21.30
TOTAL: 24:00:00 23583 100.0% 0.2770.3 MB 100.0% 0.83
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1newsfeed.neva.ru 12968 720 0 0 0 0 0 012248
2linuxd-out.news.weretis.net 2981 425 0 0 0 0 0 0 2556
3nntp.pasdenom.info 563 0 0 0 0 0 0 0 563
4news.fcku.it 127 0 0 0 0 0 0 0 127
TOTAL: 4 16639 1145 0 0 0 0 0 015494

Unwanted newsgroups [Top 20]:

NewsgroupCount
lada.talk 348
ut.test 178
lada.auto 87
it-alt.sport.calcio.juventus 60
mpc.lists.nanog 24
mpc.lists.freebsd.x11 23
alt.computer.workshop 23
alt.survival 21
lada.kitchen 19
it.comp.os.win.windows10 16
mpc.lists.freebsd.gecko 16
gmane.linux.alsa.devel 15
mozilla.dev.l10n 15
alt.windows7.general 13
mozilla.support.thunderbird 11
lada.commerce 9
lada.soft 9
spline.eisfair.dev 9
mozilla.test 9
alt.slack.goathead 9
TOTAL: 116 1145

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 12155
EMP (phn path) 1203
EMP (phr path) 712
EMP (phl) 520
EMP (phn nph) 144
Too many newsgroups 69
User-issued cancel 30
User-issued spam cancel 14
Binary Payload 13
Binary: non-binary distribution 8
HTML post 8
Binary Image: misplaced jpg 6
TOTAL: 12 14882

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
linuxd-out.news.weretis.net 586
newsfeed.neva.ru 23
news.fcku.it 3
TOTAL: 3 612
TOTAL: 1 612

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.fcku.it 33050 2030 18986 2455 0 229 6%24:04:10
2nntp.pasdenom.info 43255 1166 21260 1234 0 770 2%24:04:54
3weretis.net 3212 48 3037 0 0 6 1%24:01:03
4neva.ru 30369 34 20785 67 0 116 0%24:09:39
5eternal-september 25522 28 20259 1 0 11 0%24:00:24
6news.killfile.org 2848 0 0 0 0 26469 0%24:00:15
7etla.org 0 0 0 0 0 23779 0%24:09:39
8vc89.vc.panix.com 2832 0 0 0 0 26449 0%24:00:00
9news.netfront.net 2747 0 0 0 0 26277 0%24:00:13
10news.albasani.net 2864 0 0 0 0 25548 0%24:00:07
11news.mixmin.net 0 0 0 0 0 0 0%00:10:00
12news.stack.nl 2860 0 0 0 0 26441 0%24:00:07
TOTAL: 12 149559 3306 84327 3757 0 156095 2%264:40:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.fcku.it6.1 MB7.5 MB13.6 MB0.2 KB/s3.1 KB24:04:10
2nntp.pasdenom.info4.4 MB2.0 MB6.4 MB0.1 KB/s2.7 KB24:04:54
3eternal-september150.9 KB1.3 KB152.1 KB0.0 KB/s5.2 KB24:00:24
4neva.ru125.2 KB427.1 KB552.4 KB0.0 KB/s5.5 KB24:09:39
5weretis.net68.3 KB0.0 KB68.3 KB0.0 KB/s1.4 KB24:01:03
6news.killfile.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:15
7etla.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:09:39
8vc89.vc.panix.com0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
9news.netfront.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:13
10news.albasani.net0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:07
11news.mixmin.net0.0 KB0.0 KB0.0 KB0.0 KB/s000:10:00
12news.stack.nl0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:07
TOTAL: 1210.8 MB9.9 MB20.7 MB0.0 KB/s3.0 KB264:40:31
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1challenger.nielsenmedia.com 15 614.2 KB 2 0 002:45:28
TOTAL: 1 15 614.2 KB 2 0 005:13:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nielsenmedia.com 15 614.2 KB 2 0 002:45:28
2*.094.216.pools.vodafone-ip.de 144 00.0 KB 0 0 000:00:35
3*.drr02.clwr.fl.frontiernet.net 19 00.0 KB 0 0 002:26:37
4unresolved 1 00.0 KB 0 0 000:00:31
TOTAL: 4 179 614.2 KB 2 0 005:13:13

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
challenger.nielsenmedia.com 0.972 0.080 0.00002:45:28
47-192-187-101.drr02.clwr.fl.frontiernet.net 1.232 0.092 0.00002:26:37
dslb-094-216-025-116.094.216.pools.vodafone-ip.de 7.664 0.476 0.00000:00:35
196.52.20.224 0.280 0.232 0.00000:00:31
TOTAL: 4 10.148 0.880 0.00005:13:13

Curious NNRP server explorers [Top 20]:

SystemConn
dslb-094-216-025-116.094.216.pools.vodafone-ip.de 144
47-192-187-101.drr02.clwr.fl.frontiernet.net 19
196.52.20.224 1
TOTAL: 3 164

NNRP client timeouts [Top 20]:

SystemConnPeer
challenger.nielsenmedia.com 5 1
47-192-187-101.drr02.clwr.fl.frontiernet.net 1 1
TOTAL: 2 6 2

Newsgroup request counts (by category):

CategoryCountPct
1comp 6100.0%
TOTAL: 1 6100.0%

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

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