Daily Usenet Report

Jan 8 00:01:01 -- Jan 9 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 8 00:06:41 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12862 68.4%3.5 MB 78.7%
innd 3537 18.8%545.0 KB 12.1%
innfeed 2335 12.4%411.4 KB 9.1%
nnrpd 69 0.4%5.6 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 18804 100.0%4.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 91797 56.5%
Negative hits 58259 35.9%
Do not exist 12330 7.6%
Cache misses 20 0.0%
TOTAL: 4 162406 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.095 0.0%75 0.000 1.267 9.000
article cleanup00:00:00.250 0.0%12392 0.000 0.020 0.100
article logging00:00:00.570 0.0%12793 0.000 0.045 0.179
article parse00:00:00.493 0.0%22647 0.000 0.022 0.128
article write00:00:08.854 0.0%11006 0.388 0.804 2.929
artlog/artcncl00:00:00.007 0.0%73 0.000 0.096 1.500
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.230 0.0%168371 0.000 0.001 0.008
hisgrep/artcncl00:00:00.011 0.0%73 0.000 0.151 3.000
hishave/artcncl00:00:00.004 0.0%75 0.000 0.053 0.333
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.717 0.0%163190 0.002 0.041 0.126
history sync00:00:00.055 0.0%396 0.000 0.139 1.000
history write00:00:07.411 0.0%12391 0.024 0.598 1.030
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:28.622 99.8%165782 177.484 520.615 1600.109
nntp read00:00:06.885 0.0%166419 0.023 0.041 0.109
overview write00:00:07.071 0.0%11006 0.256 0.642 4.023
perl filter00:00:36.613 0.0%12391 2.023 2.955 5.679
python filter00:00:02.127 0.0%12391 0.061 0.172 0.373
site send00:00:04.768 0.0%22012 0.052 0.217 0.553
TOTAL: 24:01:03.45723:59:50.784 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.106 0.0%11154 0.000 0.010 0.117
article prepare00:00:00.008 0.0%31472 0.000 0.000 0.015
article read00:00:01.159 0.0%4935 0.000 0.235 2.333
backlog stats00:00:00.480 0.0%231387 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.143 0.0%154688 0.015 0.033 0.065
data write00:00:19.897 0.0%145398 0.101 0.137 0.210
idle23:56:21.256100.0%231387 183.089 372.455 1049.061
status file00:00:00.177 0.0%195 0.000 0.908 4.000
TOTAL: 23:56:57.97923:56:48.226100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.099 95.6%3 24.500 3366.333 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%6 0.000 0.167 0.500
TOTAL: 00:00:10.56400:00:10.100 95.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 4 19169 6621 12169 379 34%43:45:45
2usenet.blueworldhosting.com 4 11771 3070 8494 207 26%23:58:01
3outgoing.news.lysator.liu.se 1 11890 543 10822 525 4%23:59:57
4newsfeed.xs3.de 2 10057 499 9555 3 4%23:59:47
5news.samoylyk.net 2 10179 61 10117 1 0%23:59:42
6glockenspiel.complete.org 1 10225 53 10172 0 0%23:59:54
7news.bbs.nz 3 16999 20 16979 0 0%39:08:42
8news.furie.org.uk 2 5846 5 5841 0 0%23:59:37
9news.netfront.net 1 12686 2 12423 261 0%25:55:58
10localhost 25 0 0 0 0 0%00:00:00
11eotl-out.news.tnetconsulting.net 2 0 0 0 0 0%00:20:05
12news.nk.ca 2 0 0 0 0 0%00:20:01
TOTAL: 12 49 108822 10874 96572 1376 9%253:27:29
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net22.0 MB0.0 KB836.7 KB22.9 MB 96%3.3 KB
2usenet.blueworldhosting.com17.4 MB0.0 KB1.6 MB19.0 MB 91%5.9 KB
3newsfeed.xs3.de2.3 MB0.0 KB5.1 KB2.3 MB 99%4.7 KB
4outgoing.news.lysator.liu.se1.0 MB7.5 KB1.8 MB2.9 MB 36%2.7 KB
5news.samoylyk.net793.1 KB0.0 KB1.8 KB794.9 KB 99%12.8 KB
6glockenspiel.complete.org256.4 KB0.0 KB0.0 KB256.4 KB100%4.8 KB
7news.bbs.nz46.3 KB0.0 KB0.0 KB46.3 KB100%2.3 KB
8news.furie.org.uk13.8 KB0.0 KB0.0 KB13.8 KB100%2.8 KB
9news.netfront.net3.3 KB0.0 KB35.5 MB35.5 MB 0%138.2 KB
10localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1243.9 MB7.5 KB39.7 MB83.6 MB 52%7.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 8 00:01:01 - 00:59:59 263 2.4% 0.071.0 MB 2.3% 0.30
Jan 8 01:00:00 - 01:59:59 301 2.7% 0.081.5 MB 3.4% 0.43
Jan 8 02:00:00 - 02:59:59 399 3.6% 0.111.1 MB 2.5% 0.31
Jan 8 03:00:00 - 03:59:59 545 5.0% 0.152.4 MB 5.4% 0.68
Jan 8 04:00:00 - 04:59:59 574 5.2% 0.162.4 MB 5.5% 0.69
Jan 8 05:00:00 - 05:59:59 483 4.4% 0.131.8 MB 4.1% 0.52
Jan 8 06:00:00 - 06:59:59 545 5.0% 0.152.2 MB 5.1% 0.63
Jan 8 07:00:00 - 07:59:59 493 4.5% 0.141.9 MB 4.3% 0.54
Jan 8 08:00:00 - 08:59:59 449 4.1% 0.121.5 MB 3.3% 0.42
Jan 8 09:00:00 - 09:59:59 556 5.1% 0.152.0 MB 4.5% 0.56
Jan 8 10:00:00 - 10:59:59 556 5.1% 0.153.2 MB 7.3% 0.91
Jan 8 11:00:00 - 11:59:59 739 6.7% 0.212.7 MB 6.1% 0.77
Jan 8 12:00:00 - 12:59:59 688 6.3% 0.192.2 MB 5.1% 0.64
Jan 8 13:00:00 - 13:59:59 623 5.7% 0.171.9 MB 4.2% 0.53
Jan 8 14:00:00 - 14:59:59 564 5.1% 0.161.6 MB 3.7% 0.46
Jan 8 15:00:00 - 15:59:59 605 5.5% 0.171.9 MB 4.4% 0.55
Jan 8 16:00:00 - 16:59:59 464 4.2% 0.131.7 MB 4.0% 0.50
Jan 8 17:00:00 - 17:59:59 418 3.8% 0.122.7 MB 6.1% 0.76
Jan 8 18:00:00 - 18:59:59 400 3.6% 0.111.7 MB 3.9% 0.49
Jan 8 19:00:00 - 19:59:59 280 2.5% 0.08939.6 KB 2.1% 0.26
Jan 8 20:00:00 - 20:59:59 283 2.6% 0.081.4 MB 3.3% 0.41
Jan 8 21:00:00 - 21:59:59 241 2.2% 0.071.0 MB 2.3% 0.29
Jan 8 22:00:00 - 22:59:59 255 2.3% 0.072.1 MB 4.9% 0.61
Jan 8 23:00:00 - 23:59:59 268 2.4% 0.071011.6 KB 2.2% 0.28
Jan 9 00:00:00 - 00:01:02 4 0.0% 0.0610.6 KB 0.0% 0.17
TOTAL: 24:00:01 10996 100.0% 0.1344.1 MB 100.0% 0.52
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 714 0 0 0 0 0 0 0 714
2outgoing.news.lysator.liu.se 596 0 0 1 0 0 0 0 595
3news.netfront.net 238 0 0 0 0 0 0 0 238
4usenet.blueworldhosting.com 214 19 0 0 0 0 0 0 195
5newsfeed.xs3.de 23 0 0 0 0 0 0 0 23
6news.samoylyk.net 8 0 0 0 0 0 0 0 8
TOTAL: 6 1793 19 0 1 0 0 0 0 1773

Unwanted newsgroups [Top 20]:

NewsgroupCount
sk.politics 10
rocksolid.feeds.news 5
de.soc.dateschutz 2
alt.rock-n-roll.psychedelic 1
alt.computer.software.financial.quicken 1
TOTAL: 5 19

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 682
EMP (phn path) 468
Binary: misplaced binary 86
Too many newsgroups 49
EMP (phl) 39
EMP (phn nph) 36
Scoring filter 6
HTML Multipart 4
U2 violation - invalid distribution 2
TOTAL: 9 1372

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 360
newsfeed.xs3.de 20
outgoing.news.lysator.liu.se 7
usenet.blueworldhosting.com 7
news.samoylyk.net 7
TOTAL: 5 401
TOTAL: 1 401

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 14283 4800 6193 1 0 12 33%23:59:56
2nyheter.lysator.liu.se 10780 2695 7740 11 0 0 25%23:59:44
3news.furie.org.uk 8847 48 6055 7 0 17 0%23:59:57
4news.nk.ca 13998 44 10847 32 0 2 0%23:59:57
5news.quux.org 11283 23 10839 112 0 0 0%23:59:52
6news.bbs.nz 21319 21 10893 66 0 110 0%23:59:46
7usenet.blueworldhosting.com 8381 14 7848 0 0 21 0%23:59:31
8news.weretis.net 11027 2 10990 1 0 0 0%23:59:57
9news.tnetconsulting.net 11520 1 10987 0 0 5 0%23:59:57
10newsfeed.xs3.de 13163 0 10491 1 0 0 0%23:59:57
11news.samoylyk.net 13753 0 10939 0 0 0 0%23:59:57
12peer.alt119.net 0 0 0 0 0 10970 0%23:57:48
TOTAL: 12 138354 7648 103822 231 0 11137 5%287:56:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net23.7 MB2.3 KB23.7 MB0.3 KB/s5.1 KB23:59:56
2nyheter.lysator.liu.se15.1 MB214.3 KB15.3 MB0.2 KB/s5.8 KB23:59:44
3news.furie.org.uk3.3 MB40.1 KB3.4 MB0.0 KB/s62.6 KB23:59:57
4news.quux.org1.3 MB935.6 KB2.3 MB0.0 KB/s17.1 KB23:59:52
5news.nk.ca1.1 MB889.4 KB1.9 MB0.0 KB/s26.0 KB23:59:57
6news.bbs.nz774.2 KB1.2 MB2.0 MB0.0 KB/s23.3 KB23:59:46
7usenet.blueworldhosting.com33.9 KB0.0 KB33.9 KB0.0 KB/s2.4 KB23:59:31
8news.weretis.net5.1 KB591.9 KB596.9 KB0.0 KB/s199.0 KB23:59:57
9news.tnetconsulting.net1.8 KB0.0 KB1.8 KB0.0 KB/s1.8 KB23:59:57
10newsfeed.xs3.de0.0 KB1.6 KB1.6 KB0.0 KB/s1.6 KB23:59:57
11news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
12peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:48
TOTAL: 1245.4 MB3.8 MB49.2 MB0.0 KB/s6.4 KB287:56:19
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 00.0 KB 1 0 000:00:10
TOTAL: 1 2 00.0 KB 1 0 000:00:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
146.190.125.99 0.113 0.039 0.00000:00:10
198.199.92.225 0.107 0.030 0.00000:00:00
TOTAL: 2 0.220 0.069 0.00000:00:10

Curious NNRP server explorers [Top 20]:

SystemConn
146.190.125.99 1
198.199.92.225 1
TOTAL: 2 2

NNRP unrecognized commands (by host):

SystemConn
198.199.92.225 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_192.138.210.162_119 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1news 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1news.software.nntp 1
TOTAL: 1 1