Daily Usenet Report

Oct 21 00:01:01 -- Oct 22 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 21 00:05:31 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 13579 68.8%3.5 MB 78.3%
innd 3841 19.5%584.1 KB 12.8%
innfeed 2303 11.7%407.5 KB 8.9%
nnrpd 11 0.1%1.3 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 19735 100.0%4.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 95473 56.0%
Negative hits 61948 36.3%
Do not exist 13185 7.7%
Cache misses 20 0.0%
TOTAL: 4 170626 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.062 0.0%55 0.000 1.127 6.000
article cleanup00:00:00.179 0.0%13240 0.000 0.014 0.069
article logging00:00:00.568 0.0%13555 0.000 0.042 0.111
article parse00:00:00.341 0.0%19481 0.000 0.018 0.056
article write00:00:11.187 0.0%11520 0.321 0.971 1.831
artlog/artcncl00:00:00.001 0.0%54 0.000 0.019 1.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.137 0.0%172094 0.000 0.001 0.004
hisgrep/artcncl00:00:00.010 0.0%51 0.000 0.196 1.000
hishave/artcncl00:00:00.001 0.0%55 0.000 0.018 0.100
hishave/artparse00: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:06.624 0.0%171360 0.005 0.039 0.068
history sync00:00:00.053 0.0%395 0.000 0.134 1.667
history write00:00:06.950 0.0%13239 0.056 0.525 0.975
hiswrite/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:42.751 99.8%169405 283.470 509.564 2275.742
nntp read00:00:09.311 0.0%170951 0.031 0.054 0.087
overview write00:00:06.813 0.0%11520 0.192 0.591 3.000
perl filter00:00:30.915 0.0%13239 1.647 2.335 4.723
python filter00:00:01.572 0.0%13239 0.000 0.119 0.312
site send00:00:03.401 0.0%23040 0.035 0.148 0.360
TOTAL: 24:01:04.44824:00:00.876 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.108 0.0%11735 0.000 0.009 0.276
article prepare00:00:00.005 0.0%16440 0.000 0.000 0.019
article read00:00:00.738 0.0%3046 0.000 0.242 2.407
backlog stats00:00:00.352 0.0%232563 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:07.373 0.0%156068 0.013 0.047 0.075
data write00:00:17.777 0.0%146854 0.082 0.121 0.179
idle23:56:29.486100.0%232563 222.165 370.607 1567.003
status file00:00:00.178 0.0%174 0.000 1.023 5.000
TOTAL: 23:57:04.71823:56:56.017100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:03.503 85.5%4 25.000 875.750 1736.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.006 0.1%8 0.000 0.750 3.000
TOTAL: 00:00:04.09800:00:03.509 85.6%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 147
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 168

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 5 22522 5229 16704 589 23%46:45:52
2usenet.blueworldhosting.com 7 12623 3516 8725 382 27%22:42:10
3peer.alt119.net 2 12790 2106 9945 739 16%21:54:10
4newsfeed.xs3.de 2 10940 370 10555 15 3%23:59:52
5glockenspiel.complete.org 1 11201 50 11149 2 0%23:59:55
6news.samoylyk.net 1 10905 48 10855 2 0%23:59:50
7news.furie.org.uk 1 5878 14 5864 0 0%23:59:50
8news.bbs.nz 2 9207 8 9199 0 0%21:28:31
9outgoing.news.lysator.liu.se 2 10991 8 10983 0 0%23:59:57
10news.nk.ca 2 0 0 0 0 0%00:20:01
11localhost 25 0 0 0 0 0%00:00:00
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
TOTAL: 12 51 107057 11349 93979 1729 10%233:20:12
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com18.1 MB2.5 KB1.2 MB19.3 MB 93%5.1 KB
2endofthelinebbs-out.news.weretis.net17.7 MB0.0 KB1.1 MB18.8 MB 94%3.3 KB
3peer.alt119.net4.7 MB0.0 KB1.6 MB6.4 MB 74%2.3 KB
4newsfeed.xs3.de1.5 MB0.0 KB24.2 KB1.5 MB 98%4.1 KB
5glockenspiel.complete.org168.5 KB0.0 KB6.0 KB174.5 KB 96%3.4 KB
6news.samoylyk.net155.5 KB0.0 KB2.5 KB158.0 KB 98%3.2 KB
7news.furie.org.uk45.6 KB0.0 KB0.0 KB45.6 KB100%3.3 KB
8outgoing.news.lysator.liu.se30.5 KB0.0 KB0.0 KB30.5 KB100%3.8 KB
9news.bbs.nz19.8 KB0.0 KB0.0 KB19.8 KB100%2.5 KB
10news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1242.5 MB2.5 KB4.0 MB46.5 MB 91%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 21 00:01:01 - 00:59:59 334 2.9% 0.093.4 MB 7.7% 0.99
Oct 21 01:00:00 - 01:59:59 324 2.8% 0.09787.4 KB 1.7% 0.22
Oct 21 02:00:00 - 02:59:59 440 3.8% 0.121.3 MB 2.9% 0.37
Oct 21 03:00:00 - 03:59:59 587 5.1% 0.161.5 MB 3.3% 0.42
Oct 21 04:00:00 - 04:59:59 633 5.5% 0.182.1 MB 4.7% 0.60
Oct 21 05:00:00 - 05:59:59 603 5.2% 0.172.1 MB 4.8% 0.61
Oct 21 06:00:00 - 06:59:59 574 5.0% 0.161.8 MB 4.0% 0.51
Oct 21 07:00:00 - 07:59:59 683 5.9% 0.191.9 MB 4.3% 0.55
Oct 21 08:00:00 - 08:59:59 598 5.2% 0.171.8 MB 4.0% 0.51
Oct 21 09:00:00 - 09:59:59 623 5.4% 0.172.6 MB 5.9% 0.75
Oct 21 10:00:00 - 10:59:59 683 5.9% 0.192.8 MB 6.3% 0.81
Oct 21 11:00:00 - 11:59:59 677 5.9% 0.192.8 MB 6.2% 0.79
Oct 21 12:00:00 - 12:59:59 551 4.8% 0.152.0 MB 4.4% 0.56
Oct 21 13:00:00 - 13:59:59 595 5.2% 0.172.9 MB 6.5% 0.83
Oct 21 14:00:00 - 14:59:59 617 5.4% 0.171.8 MB 4.1% 0.52
Oct 21 15:00:00 - 15:59:59 515 4.5% 0.141.7 MB 3.9% 0.49
Oct 21 16:00:00 - 16:59:59 541 4.7% 0.152.2 MB 4.8% 0.61
Oct 21 17:00:00 - 17:59:59 390 3.4% 0.111.5 MB 3.3% 0.42
Oct 21 18:00:00 - 18:59:59 295 2.6% 0.08978.2 KB 2.1% 0.27
Oct 21 19:00:00 - 19:59:59 310 2.7% 0.091.2 MB 2.8% 0.35
Oct 21 20:00:00 - 20:59:59 296 2.6% 0.08993.3 KB 2.2% 0.28
Oct 21 21:00:00 - 21:59:59 202 1.8% 0.061.3 MB 3.0% 0.38
Oct 21 22:00:00 - 22:59:59 209 1.8% 0.062.0 MB 4.4% 0.56
Oct 21 23:00:00 - 23:59:59 207 1.8% 0.061.2 MB 2.6% 0.33
Oct 22 00:00:00 - 00:01:01 3 0.0% 0.057.1 KB 0.0% 0.12
TOTAL: 24:00:00 11490 100.0% 0.1344.7 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 866 3 0 0 0 0 0 0 863
2peer.alt119.net 734 2 0 0 0 0 0 0 732
3usenet.blueworldhosting.com 402 44 0 1 0 0 0 0 357
4newsfeed.xs3.de 22 0 0 0 0 0 0 0 22
5news.samoylyk.net 8 0 0 0 0 0 0 0 8
6glockenspiel.complete.org 2 0 0 0 0 0 0 0 2
7news.furie.org.uk 1 0 0 0 0 0 0 0 1
TOTAL: 7 2035 49 0 1 0 0 0 0 1985

Unwanted newsgroups [Top 20]:

NewsgroupCount
at.jobs 10
att.jobs 9
aus.jobs 9
rocksolid.feeds.news 5
grisbi.bugsreports 2
al.christnet.bible 2
alt.va.personals 2
trollnet.cinema 2
grisbi.test 1
alt.0.0.0 1
bofh.transport.public 1
1.test 1
wwarvagmail.com 1
de.alt.rec.flugsimulation 1
gun.general 1
soc.culture.russia 1
TOTAL: 16 49

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 898
EMP (md5) 394
EMP (phl) 157
EMP (phn nph) 117
Too many newsgroups 83
HTML Multipart 13
Scoring filter 9
TOTAL: 7 1671

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 274
peer.alt119.net 13
usenet.blueworldhosting.com 11
newsfeed.xs3.de 9
news.samoylyk.net 6
news.furie.org.uk 1
TOTAL: 6 314
TOTAL: 1 314

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 14448 2246 8839 400 0 128 15%23:59:25
2peer.alt119.net 10506 1084 8241 13 0 0 10%23:59:56
3news.nk.ca 15212 68 11347 38 0 7 0%23:59:56
4news.bbs.nz 22544 43 11381 57 0 84 0%23:59:56
5news.furie.org.uk 8772 29 5945 2 0 1 0%23:59:51
6news.quux.org 11893 13 11337 101 0 0 0%23:59:56
7usenet.blueworldhosting.com 8337 8 7848 0 0 3 0%23:59:56
8news.tnetconsulting.net 12696 4 11471 0 0 22 0%23:59:56
9news.weretis.net 11620 3 11486 0 0 0 0%23:59:45
10newsfeed.xs3.de 14085 0 11119 0 0 0 0%23:59:56
11news.samoylyk.net 14593 0 11437 2 0 0 0%23:59:20
12theuse.net 0 0 0 0 0 11489 0%23:59:56
TOTAL: 12 144706 3498 110451 613 0 11734 2%287:57:49
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se10.4 MB1.7 MB12.1 MB0.1 KB/s4.7 KB23:59:25
2peer.alt119.net5.7 MB35.5 KB5.8 MB0.1 KB/s5.4 KB23:59:56
3news.furie.org.uk796.0 KB22.3 KB818.4 KB0.0 KB/s26.4 KB23:59:51
4news.nk.ca482.9 KB120.0 KB602.9 KB0.0 KB/s5.7 KB23:59:56
5news.bbs.nz306.5 KB487.7 KB794.2 KB0.0 KB/s7.9 KB23:59:56
6news.quux.org138.6 KB329.8 KB468.4 KB0.0 KB/s4.1 KB23:59:56
7usenet.blueworldhosting.com20.3 KB0.0 KB20.3 KB0.0 KB/s2.5 KB23:59:56
8news.tnetconsulting.net12.2 KB0.0 KB12.2 KB0.0 KB/s3.0 KB23:59:56
9news.weretis.net6.8 KB0.0 KB6.8 KB0.0 KB/s2.3 KB23:59:45
10newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
11news.samoylyk.net0.0 KB182.5 KB182.5 KB0.0 KB/s91.2 KB23:59:20
12theuse.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 1217.8 MB2.9 MB20.7 MB0.0 KB/s5.2 KB287:57:49
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1192.241.203.138 1 00.0 KB 0 0 000:00:00
2principled.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3lustrous.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 3 3 00.0 KB 0 0 000:00:04

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.monitoring.internet-measurement.com 2 00.0 KB 0 0 000:00:03
2unresolved 1 00.0 KB 0 0 000:00:00
TOTAL: 2 3 00.0 KB 0 0 000:00:04

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
principled.monitoring.internet-measurement.com 0.077 0.055 0.00000:00:01
lustrous.monitoring.internet-measurement.com 0.045 0.068 0.00000:00:01
192.241.203.138 0.077 0.012 0.00000:00:00
TOTAL: 3 0.199 0.135 0.00000:00:04

NNRP unrecognized commands (by host):

SystemConn
192.241.203.138 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_192.138.210.162_119 1
TOTAL: 1 1