Daily Usenet Report

Nov 28 00:01:01 -- Nov 29 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 28 00:06:00 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 19920 68.6%4.4 MB 77.3%
innd 5768 19.9%797.7 KB 13.8%
innfeed 2350 8.1%418.0 KB 7.2%
nnrpd 982 3.4%96.7 KB 1.7%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 29021 100.0%5.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 94638 51.8%
Negative hits 62901 34.5%
Do not exist 19591 10.7%
Cache misses 5401 3.0%
TOTAL: 4 182531 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.046 0.0%39 0.000 1.179 2.000
article cleanup00:00:00.365 0.0%19617 0.000 0.019 0.125
article logging00:00:01.088 0.0%19880 0.000 0.055 0.128
article parse00:00:10.991 0.0%1353165 0.000 0.008 0.103
article write00:00:08.898 0.0%11067 0.381 0.804 2.467
artlog/artcncl00:00:00.000 0.0%36 0.000 0.000 0.000
data move00:00:03.138 0.0%1535388 0.000 0.002 0.010
hisgrep/artcncl00:00:00.006 0.0%38 0.000 0.158 1.000
hishave/artcncl00:00:00.002 0.0%39 0.000 0.051 0.286
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:09.147 0.0%183204 0.003 0.050 0.159
history sync00:00:00.064 0.0%377 0.000 0.170 1.000
history write00:00:10.835 0.0%19606 0.075 0.553 0.957
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:53:54.581 99.5%1373922 2.746 62.620 1786.527
nntp read00:02:37.349 0.2%1491724 0.029 0.105 0.145
overview write00:00:06.772 0.0%11067 0.214 0.612 5.111
perl filter00:01:30.630 0.1%19606 1.780 4.623 8.938
python filter00:00:02.945 0.0%19606 0.049 0.150 0.487
site send00:00:05.165 0.0%22134 0.083 0.233 0.643
TOTAL: 24:00:59.92123:59:02.022 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.127 0.0%11530 0.000 0.011 0.109
article prepare00:00:00.009 0.0%31208 0.000 0.000 0.009
article read00:00:01.302 0.0%5150 0.028 0.253 2.929
backlog stats00:00:00.553 0.0%233845 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.797 0.0%156472 0.015 0.043 0.073
data write00:00:20.649 0.0%146408 0.068 0.141 0.231
idle23:56:04.044100.0%233845 183.308 368.466 998.176
status file00:00:00.237 0.0%213 0.000 1.113 5.000
TOTAL: 23:56:44.96523:56:33.718100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:04:54.984 81.4%855 24.500 345.011 10032.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.197 0.1%1710 0.000 0.115 1.667
TOTAL: 00:06:02.24300:04:55.181 81.5%----

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 21918 7006 14449 463 31%51:02:16
2usenet.blueworldhosting.com 7 17350 2751 9254 5345 15%25:34:10
3outgoing.news.lysator.liu.se 2 12540 680 11115 745 5%23:59:47
4newsfeed.xs3.de 2 9704 424 9275 5 4%23:59:39
5news.samoylyk.net 2 9968 79 9888 1 0%23:59:42
6glockenspiel.complete.org 1 9833 17 9816 0 0%23:59:54
7news.netfront.net 3 13176 16 11793 1367 0%22:50:54
8news.bbs.nz 3 14567 11 14556 0 0%33:27:11
9news.furie.org.uk 8 14333 3 13841 489 0%19:18:56
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 2 0 0 0 0 0%00:20:03
TOTAL: 12 62 123389 10987 103987 8415 8%248:52:33
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net23.5 MB3.6 KB1.0 MB24.5 MB 95%3.4 KB
2usenet.blueworldhosting.com13.2 MB774.2 KB3.6 GB3.7 GB 0%474.0 KB
3newsfeed.xs3.de1.9 MB0.0 KB13.5 KB1.9 MB 99%4.5 KB
4outgoing.news.lysator.liu.se1.3 MB0.0 KB2.9 MB4.1 MB 30%3.0 KB
5news.samoylyk.net479.2 KB0.0 KB1.9 KB481.0 KB 99%6.0 KB
6glockenspiel.complete.org236.5 KB0.0 KB0.0 KB236.5 KB100%13.9 KB
7news.netfront.net44.6 KB0.0 KB472.8 MB472.9 MB 0%350.1 KB
8news.bbs.nz34.1 KB0.0 KB0.0 KB34.1 KB100%3.1 KB
9news.furie.org.uk13.4 KB6.8 MB365.7 MB372.6 MB 0%775.4 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: 1240.6 MB7.6 MB4.5 GB4.5 GB 0%244.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 28 00:01:01 - 00:59:59 246 2.2% 0.07665.4 KB 1.6% 0.19
Nov 28 01:00:00 - 01:59:59 340 3.1% 0.091.3 MB 3.1% 0.36
Nov 28 02:00:00 - 02:59:59 480 4.3% 0.132.4 MB 5.9% 0.69
Nov 28 03:00:00 - 03:59:59 580 5.2% 0.162.1 MB 5.2% 0.61
Nov 28 04:00:00 - 04:59:59 625 5.6% 0.172.1 MB 5.2% 0.61
Nov 28 05:00:00 - 05:59:59 701 6.3% 0.192.1 MB 5.1% 0.60
Nov 28 06:00:00 - 06:59:59 588 5.3% 0.161.9 MB 4.6% 0.53
Nov 28 07:00:00 - 07:59:59 573 5.2% 0.161.9 MB 4.6% 0.53
Nov 28 08:00:00 - 08:59:59 632 5.7% 0.181.9 MB 4.8% 0.55
Nov 28 09:00:00 - 09:59:59 702 6.3% 0.202.3 MB 5.6% 0.66
Nov 28 10:00:00 - 10:59:59 637 5.8% 0.182.1 MB 5.0% 0.58
Nov 28 11:00:00 - 11:59:59 647 5.8% 0.182.0 MB 5.0% 0.58
Nov 28 12:00:00 - 12:59:59 566 5.1% 0.161.9 MB 4.7% 0.55
Nov 28 13:00:00 - 13:59:59 503 4.5% 0.141.9 MB 4.6% 0.54
Nov 28 14:00:00 - 14:59:59 524 4.7% 0.152.0 MB 5.0% 0.58
Nov 28 15:00:00 - 15:59:59 577 5.2% 0.162.3 MB 5.7% 0.66
Nov 28 16:00:00 - 16:59:59 440 4.0% 0.121.5 MB 3.6% 0.42
Nov 28 17:00:00 - 17:59:59 307 2.8% 0.09983.3 KB 2.3% 0.27
Nov 28 18:00:00 - 18:59:59 289 2.6% 0.08872.5 KB 2.1% 0.24
Nov 28 19:00:00 - 19:59:59 255 2.3% 0.073.3 MB 8.1% 0.95
Nov 28 20:00:00 - 20:59:59 206 1.9% 0.06816.8 KB 1.9% 0.23
Nov 28 21:00:00 - 21:59:59 205 1.9% 0.06879.6 KB 2.1% 0.24
Nov 28 22:00:00 - 22:59:59 189 1.7% 0.05696.1 KB 1.7% 0.19
Nov 28 23:00:00 - 23:59:59 245 2.2% 0.07987.0 KB 2.4% 0.27
Nov 29 00:00:00 - 00:01:01 9 0.1% 0.1531.4 KB 0.1% 0.51
TOTAL: 24:00:00 11066 100.0% 0.1340.9 MB 100.0% 0.48
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 5388 4548 0 1 0 0 0 0 839
2news.netfront.net 1481 0 0 0 0 0 0 0 1481
3outgoing.news.lysator.liu.se 742 0 0 0 0 0 0 0 742
4endofthelinebbs-out.news.weretis.net 699 0 0 1 0 0 0 0 698
5news.furie.org.uk 489 453 0 9 0 0 0 0 27
6newsfeed.xs3.de 15 0 0 0 0 0 0 0 15
7news.samoylyk.net 3 0 0 0 0 0 0 0 3
8glockenspiel.complete.org 1 0 0 0 0 0 0 0 1
TOTAL: 8 8818 5001 0 11 0 0 0 0 3806

Unwanted newsgroups [Top 20]:

NewsgroupCount
alt.bin 4977
panix.chat 8
rocksolid.feeds.news 5
gun.general 4
tw.bbs.computer.forsale 1
alt.entrepreneurs 1
alt.french 1
soc.culutre.china 1
soc.culture.germany 1
aol.neighborhood.ca.fresno.marketplace 1
alt.soc.germans 1
TOTAL: 11 5001

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 904
EMP (phn path) 861
EMP (md5) 558
EMP (fsl) 484
Too many newsgroups (low_xpost) 394
EMP (phl) 190
Too many newsgroups 67
Poison newsgroup 59
EMP (phn nph) 16
Scoring filter 4
HTML Multipart 1
TOTAL: 11 3538

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 232
usenet.blueworldhosting.com 21
newsfeed.xs3.de 10
news.samoylyk.net 2
outgoing.news.lysator.liu.se 2
glockenspiel.complete.org 1
TOTAL: 6 268
TOTAL: 1 268

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 15007 4750 6296 3 0 0 31%23:59:53
2nyheter.lysator.liu.se 10814 2359 8038 13 0 0 21%23:59:54
3news.nk.ca 14617 235 10726 61 0 22 1%23:59:55
4news.furie.org.uk 7506 82 5609 8 0 373 1%23:59:55
5news.bbs.nz 21636 48 10955 49 0 70 0%23:59:55
6news.quux.org 11564 40 10874 115 0 0 0%23:59:51
7news.tnetconsulting.net 12260 33 11018 14 0 1 0%23:59:55
8usenet.blueworldhosting.com 8954 4 8008 0 0 1 0%23:59:55
9news.weretis.net 11092 1 11063 0 0 0 0%23:59:55
10newsfeed.xs3.de 12907 0 10641 1 0 9 0%23:59:37
11news.samoylyk.net 13412 0 10990 0 0 7 0%23:59:38
12peer.alt119.net 0 0 0 0 0 11058 0%23:57:46
TOTAL: 12 139769 7552 104218 264 0 11541 5%287:56:09
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net20.2 MB29.0 KB20.2 MB0.2 KB/s4.4 KB23:59:53
2nyheter.lysator.liu.se11.7 MB99.5 KB11.8 MB0.1 KB/s5.1 KB23:59:54
3news.furie.org.uk4.7 MB200.9 KB4.9 MB0.1 KB/s56.0 KB23:59:55
4news.bbs.nz1.0 MB240.1 KB1.3 MB0.0 KB/s13.3 KB23:59:55
5news.nk.ca674.5 KB1.1 MB1.8 MB0.0 KB/s6.2 KB23:59:55
6news.quux.org122.1 KB1.4 MB1.5 MB0.0 KB/s9.8 KB23:59:51
7news.tnetconsulting.net72.7 KB40.2 KB112.9 KB0.0 KB/s2.4 KB23:59:55
8usenet.blueworldhosting.com5.1 KB0.0 KB5.1 KB0.0 KB/s1.3 KB23:59:55
9news.weretis.net1.2 KB0.0 KB1.2 KB0.0 KB/s1.2 KB23:59:55
10newsfeed.xs3.de0.0 KB4.0 KB4.0 KB0.0 KB/s4.0 KB23:59:37
11news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:38
12peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:46
TOTAL: 1238.5 MB3.1 MB41.6 MB0.0 KB/s5.5 KB287:56:09
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.43.57 1 00.0 KB 2 0 000:00:00
TOTAL: 1 1 00.0 KB 2 0 000:06:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 5 00.0 KB 2 0 000:00:12
2*.furie.org.uk 283 00.0 KB 0 0 000:05:46
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 3 289 00.0 KB 2 0 000:06:00

NNRP auth users [Top 20]:

UserConn
nelgin 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
freeq.furie.org.uk 24.674 9.604 0.00000:05:46
68.183.203.69 0.096 0.041 0.00000:00:10
prepared.monitoring.internet-measurement.com 0.086 0.025 0.00000:00:01
50.31.21.5 0.171 0.058 0.00000:00:01
192.241.209.124 0.124 0.048 0.00000:00:00
TOTAL: 5 25.151 9.776 0.00000:06:00

Curious NNRP server explorers [Top 20]:

SystemConn
freeq.furie.org.uk 283
50.31.21.5 2
192.241.209.124 1
68.183.203.69 1
prepared.monitoring.internet-measurement.com 1
TOTAL: 5 288

NNRP unrecognized commands (by host):

SystemConn
192.241.209.124 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
1alt 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1alt.music.lyrics 1
2alt.bbs.doors 1
TOTAL: 2 2