Daily Usenet Report

Jan 2 00:01:02 -- Jan 3 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 15857 65.0%4.0 MB 75.7%
innd 6112 25.1%884.6 KB 16.4%
innfeed 2349 9.6%419.1 KB 7.8%
nnrpd 63 0.3%5.1 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 24382 100.0%5.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 97052 54.6%
Negative hits 65064 36.6%
Do not exist 15566 8.8%
Cache misses 25 0.0%
TOTAL: 4 177707 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.055 0.0%46 0.000 1.196 6.000
article cleanup00:00:00.313 0.0%15587 0.000 0.020 0.083
article logging00:00:00.735 0.0%15835 0.000 0.046 0.136
article parse00:00:02.713 0.0%152477 0.000 0.018 0.111
article write00:00:13.447 0.0%11682 0.488 1.151 2.226
artlog/artcncl00:00:00.000 0.0%34 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.647 0.0%314440 0.000 0.002 0.012
hisgrep/artcncl00:00:00.010 0.0%45 0.000 0.222 2.000
hishave/artcncl00:00:00.002 0.0%46 0.000 0.043 0.200
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:08.202 0.0%178097 0.007 0.046 0.108
history sync00:00:00.054 0.0%383 0.000 0.141 1.000
history write00:00:09.054 0.0%15587 0.094 0.581 1.235
hiswrite/artcncl00:00:00.003 0.0%1 3.000 3.000 3.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:38.017 99.8%300920 24.511 286.648 2061.924
nntp read00:00:24.332 0.0%302752 0.020 0.080 0.149
overview write00:00:07.963 0.0%11682 0.270 0.682 3.623
perl filter00:00:45.127 0.1%15587 2.229 2.895 6.267
python filter00:00:02.574 0.0%15587 0.088 0.165 0.476
site send00:00:04.401 0.0%23364 0.012 0.188 0.583
TOTAL: 24:00:54.81023:59:37.649 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.158 0.0%12194 0.000 0.013 0.175
article prepare00:00:00.002 0.0%32160 0.000 0.000 0.008
article read00:00:01.364 0.0%5242 0.000 0.260 2.154
backlog stats00:00:00.486 0.0%245343 0.000 0.002 0.009
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.644 0.0%165041 0.020 0.034 0.074
data write00:00:20.593 0.0%154733 0.095 0.133 0.297
idle23:55:28.449100.0%245343 155.146 351.053 1135.336
status file00:00:00.225 0.0%203 0.000 1.108 9.000
TOTAL: 23:56:07.36723:55:56.921100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.069 95.9%3 25.000 3356.333 10019.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.250
TOTAL: 00:00:10.49600:00:10.070 95.9%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 4 28976 7295 21372 309 25%63:07:40
2usenet.blueworldhosting.com 4 12501 3388 8915 198 27%24:13:03
3outgoing.news.lysator.liu.se 1 12725 570 11728 427 4%23:59:58
4newsfeed.xs3.de 1 10808 488 10317 3 4%23:59:54
5news.samoylyk.net 3 10978 101 10874 3 0%23:59:32
6glockenspiel.complete.org 3 12489 99 12390 0 0%27:49:27
7news.furie.org.uk 7 6547 20 6527 0 0%24:41:28
8news.netfront.net 4 15571 9 12685 2877 0%24:50:52
9news.bbs.nz 4 12224 3 12221 0 0%27:09:08
10eotl-out.news.tnetconsulting.net 2 0 0 0 0 0%00:20:04
11localhost 25 0 0 0 0 0%00:00:00
12news.nk.ca 2 0 0 0 0 0%00:20:01
TOTAL: 12 60 122819 11973 107029 3817 9%264:31:07
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net27.3 MB0.0 KB603.4 KB27.9 MB 97%3.8 KB
2usenet.blueworldhosting.com18.2 MB0.0 KB1.2 MB19.4 MB 93%5.5 KB
3glockenspiel.complete.org4.6 MB0.0 KB0.0 KB4.6 MB100%47.4 KB
4newsfeed.xs3.de1.7 MB0.0 KB4.0 KB1.7 MB 99%3.6 KB
5outgoing.news.lysator.liu.se1.6 MB0.0 KB1.5 MB3.1 MB 51%3.2 KB
6news.samoylyk.net369.3 KB0.0 KB3.8 KB373.0 KB 98%3.6 KB
7news.netfront.net232.6 KB0.0 KB1.0 GB1.0 GB 0%365.0 KB
8news.furie.org.uk61.9 KB0.0 KB0.0 KB61.9 KB100%3.1 KB
9news.bbs.nz4.8 KB0.0 KB0.0 KB4.8 KB100%1.6 KB
10eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
11localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
12news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1254.0 MB0.0 KB1.0 GB1.1 GB 4%70.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jan 2 00:01:02 - 00:59:59 263 2.3% 0.071.1 MB 2.4% 0.33
Jan 2 01:00:00 - 01:59:59 343 2.9% 0.101.3 MB 2.7% 0.37
Jan 2 02:00:00 - 02:59:59 436 3.7% 0.122.3 MB 4.7% 0.64
Jan 2 03:00:00 - 03:59:59 547 4.7% 0.152.5 MB 5.3% 0.72
Jan 2 04:00:00 - 04:59:59 635 5.4% 0.182.0 MB 4.1% 0.56
Jan 2 05:00:00 - 05:59:59 585 5.0% 0.162.5 MB 5.2% 0.71
Jan 2 06:00:00 - 06:59:59 533 4.6% 0.151.7 MB 3.5% 0.48
Jan 2 07:00:00 - 07:59:59 558 4.8% 0.151.9 MB 3.9% 0.53
Jan 2 08:00:00 - 08:59:59 647 5.5% 0.182.2 MB 4.6% 0.63
Jan 2 09:00:00 - 09:59:59 827 7.1% 0.232.5 MB 5.2% 0.71
Jan 2 10:00:00 - 10:59:59 773 6.6% 0.213.9 MB 8.1% 1.11
Jan 2 11:00:00 - 11:59:59 657 5.6% 0.182.8 MB 5.9% 0.80
Jan 2 12:00:00 - 12:59:59 748 6.4% 0.212.3 MB 4.7% 0.64
Jan 2 13:00:00 - 13:59:59 695 6.0% 0.192.4 MB 4.9% 0.67
Jan 2 14:00:00 - 14:59:59 570 4.9% 0.162.1 MB 4.4% 0.60
Jan 2 15:00:00 - 15:59:59 473 4.1% 0.131.9 MB 4.0% 0.55
Jan 2 16:00:00 - 16:59:59 507 4.3% 0.143.0 MB 6.3% 0.87
Jan 2 17:00:00 - 17:59:59 415 3.6% 0.121.4 MB 2.9% 0.40
Jan 2 18:00:00 - 18:59:59 332 2.8% 0.091.9 MB 4.0% 0.54
Jan 2 19:00:00 - 19:59:59 293 2.5% 0.081.3 MB 2.8% 0.38
Jan 2 20:00:00 - 20:59:59 199 1.7% 0.061.3 MB 2.8% 0.38
Jan 2 21:00:00 - 21:59:59 198 1.7% 0.06971.4 KB 2.0% 0.27
Jan 2 22:00:00 - 22:59:59 198 1.7% 0.061.9 MB 4.0% 0.55
Jan 2 23:00:00 - 23:59:59 233 2.0% 0.06790.0 KB 1.6% 0.22
Jan 3 00:00:00 - 00:01:01 7 0.1% 0.1116.5 KB 0.0% 0.27
TOTAL: 23:59:59 11672 100.0% 0.1448.0 MB 100.0% 0.57
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 2874 0 0 0 0 0 0 0 2874
2endofthelinebbs-out.news.weretis.net 543 0 0 0 0 0 0 0 543
3outgoing.news.lysator.liu.se 419 0 0 0 0 0 0 0 419
4usenet.blueworldhosting.com 205 8 0 0 2 0 0 0 195
5glockenspiel.complete.org 99 0 0 0 0 0 0 0 99
6newsfeed.xs3.de 8 0 0 0 0 0 0 0 8
7news.samoylyk.net 3 0 0 0 0 0 0 0 3
TOTAL: 7 4151 8 0 0 2 0 0 0 4141

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 5
clari.local.georgia.briefs 1
gun.general 1
panix.chat 1
TOTAL: 4 8

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

GroupsCount
soc.religion.islam 1
rec.hunting 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 2084
Too many newsgroups (low_xpost) 612
EMP (phn path) 521
EMP (md5) 329
Too many newsgroups 139
EMP (phl) 108
EMP (phn nph) 63
Poison newsgroup 22
Too many newsgroups (meow) 8
Scoring filter 6
HTML Multipart 1
User-issued spam cancel 1
TOTAL: 12 3894

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 235
usenet.blueworldhosting.com 6
newsfeed.xs3.de 5
outgoing.news.lysator.liu.se 1
TOTAL: 4 247
TOTAL: 1 247

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 15518 5040 6619 3 0 15 32%23:59:21
2nyheter.lysator.liu.se 11616 2630 8459 15 0 0 22%23:59:33
3news.furie.org.uk 9821 49 6583 13 0 59 0%23:59:55
4news.nk.ca 15093 46 11519 41 0 39 0%23:59:55
5news.bbs.nz 22569 28 11564 73 0 295 0%23:59:55
6news.quux.org 12024 16 11530 92 0 16 0%23:59:55
7news.weretis.net 11697 2 11668 0 0 0 0%23:59:47
8usenet.blueworldhosting.com 8660 0 8250 0 0 0 0%23:59:44
9news.samoylyk.net 14475 0 11572 1 0 39 0%23:59:55
10news.tnetconsulting.net 12350 0 11658 0 0 31 0%23:59:55
11peer.alt119.net 0 0 0 0 0 11665 0%23:57:47
12newsfeed.xs3.de 14073 0 11172 1 0 40 0%23:59:55
TOTAL: 12 147896 7811 110594 239 0 12199 5%287:55:37
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net23.5 MB12.4 KB23.5 MB0.3 KB/s4.8 KB23:59:21
2nyheter.lysator.liu.se14.1 MB92.3 KB14.2 MB0.2 KB/s5.5 KB23:59:33
3news.furie.org.uk3.3 MB106.5 KB3.4 MB0.0 KB/s55.7 KB23:59:55
4news.nk.ca1.6 MB145.8 KB1.8 MB0.0 KB/s20.7 KB23:59:55
5news.quux.org481.0 KB1001.8 KB1.4 MB0.0 KB/s13.7 KB23:59:55
6news.bbs.nz226.9 KB2.3 MB2.5 MB0.0 KB/s25.2 KB23:59:55
7news.weretis.net3.3 KB0.0 KB3.3 KB0.0 KB/s1.7 KB23:59:47
8usenet.blueworldhosting.com0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:44
9news.samoylyk.net0.0 KB0.7 KB0.7 KB0.0 KB/s0.7 KB23:59:55
10news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
11peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
12newsfeed.xs3.de0.0 KB0.7 KB0.7 KB0.0 KB/s0.7 KB23:59:55
TOTAL: 1243.2 MB3.6 MB46.7 MB0.0 KB/s5.9 KB287:55:37
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
138.197.47.75 0.077 0.041 0.00000:00:10
198.199.92.56 0.091 0.064 0.00000:00:00
TOTAL: 2 0.168 0.105 0.00000:00:10

Curious NNRP server explorers [Top 20]:

SystemConn
198.199.92.56 1
138.197.47.75 1
TOTAL: 2 2

NNRP unrecognized commands (by host):

SystemConn
198.199.92.56 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
1comp 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1comp.sys.cbm 1
TOTAL: 1 1