Daily Usenet Report

Sep 30 00:01:02 -- Oct 1 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 30 00:05:09 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 12759 68.8%3.3 MB 78.1%
innd 3351 18.1%485.3 KB 11.4%
innfeed 2314 12.5%437.9 KB 10.3%
nnrpd 121 0.7%9.6 KB 0.2%
controlchan 13 0.1%2.8 KB 0.1%
TOTAL: 5 18558 100.0%4.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 90324 55.3%
Negative hits 60589 37.1%
Do not exist 12452 7.6%
Cache misses 55 0.0%
TOTAL: 4 163420 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.153 0.0%71 0.000 2.155 11.500
article cleanup00:00:00.177 0.0%12516 0.000 0.014 0.085
article logging00:00:00.589 0.0%12699 0.000 0.046 0.146
article parse00:00:00.346 0.0%21621 0.000 0.016 0.068
article write00:00:12.774 0.0%11269 0.456 1.134 3.142
artlog/artcncl00:00:00.001 0.0%67 0.000 0.015 0.500
data move00:00:00.184 0.0%170876 0.000 0.001 0.005
hisgrep/artcncl00:00:00.034 0.0%69 0.000 0.493 2.500
hishave/artcncl00:00:00.016 0.0%71 0.000 0.225 4.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:06.955 0.0%164282 0.011 0.042 0.082
history sync00:00:00.062 0.0%396 0.000 0.157 0.667
history write00:00:06.707 0.0%12513 0.105 0.536 0.944
hiswrite/artcncl00:00:00.001 0.0%2 0.000 0.500 1.000
idle23:58:32.109 99.8%166693 245.789 517.791 2150.932
nntp read00:00:07.973 0.0%168468 0.030 0.047 0.067
overview write00:00:07.856 0.0%11269 0.282 0.697 5.429
perl filter00:00:34.408 0.0%12513 2.119 2.750 6.761
python filter00:00:01.890 0.0%12514 0.057 0.151 0.644
site send00:00:04.830 0.0%22539 0.061 0.214 0.500
TOTAL: 24:01:05.14923:59:57.065 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.121 0.0%11347 0.000 0.011 0.130
article prepare00:00:00.001 0.0%6486 0.000 0.000 0.010
article read00:00:00.396 0.0%1447 0.000 0.274 43.000
backlog stats00:00:00.413 0.0%192250 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.445 0.0%138136 0.019 0.039 0.066
data write00:00:17.602 0.0%128651 0.087 0.137 0.237
idle23:56:24.121100.0%192250 210.708 448.292 1457.114
status file00:00:00.196 0.0%178 0.000 1.101 15.000
TOTAL: 23:56:56.98923:56:48.295100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:30.997 98.7%5 5310.250 6199.400 9756.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%10 0.000 0.000 0.000
TOTAL: 00:00:31.40400:00:30.997 98.7%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org001011
TOTAL001011

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1peer.alt119.net 3 12570 4040 7902 628 32%24:09:05
2usenet.blueworldhosting.com 4 12115 2848 8789 478 23%23:32:15
3endofthelinebbs-out.news.weretis.net 4 19958 2277 17546 135 11%41:52:19
4newsfeed.xs3.de 3 10155 1783 8318 54 17%24:08:52
5glockenspiel.complete.org 2 10600 49 10547 4 0%23:59:48
6news.samoylyk.net 1 10308 25 10283 0 0%23:59:50
7news.bbs.nz 1 8990 16 8974 0 0%20:52:10
8news.furie.org.uk 1 5703 15 5688 0 0%23:59:51
9outgoing.news.lysator.liu.se 2 10462 7 10455 0 0%23:59:47
10localhost 26 1 1 0 0 100%00:00:00
11news.nk.ca 2 0 0 0 0 0%00:20:01
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
TOTAL: 12 50 100862 11061 88502 1299 10%231:04:02
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com25.4 MB0.0 KB1.2 MB26.6 MB 95%8.2 KB
2endofthelinebbs-out.news.weretis.net10.0 MB13.8 KB256.7 KB10.3 MB 97%4.4 KB
3peer.alt119.net9.6 MB0.0 KB3.1 MB12.7 MB 75%2.8 KB
4newsfeed.xs3.de4.8 MB13.9 KB91.0 KB4.9 MB 97%2.7 KB
5glockenspiel.complete.org222.8 KB0.0 KB11.7 KB234.5 KB 95%4.4 KB
6news.samoylyk.net139.7 KB0.0 KB0.0 KB139.7 KB100%5.6 KB
7news.bbs.nz43.2 KB0.0 KB0.0 KB43.2 KB100%2.7 KB
8news.furie.org.uk38.1 KB0.0 KB0.0 KB38.1 KB100%2.5 KB
9outgoing.news.lysator.liu.se20.5 KB0.0 KB0.0 KB20.5 KB100%2.9 KB
10localhost2.0 KB0.0 KB0.0 KB2.0 KB100%2.0 KB
11news.nk.ca0.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: 1250.3 MB27.7 KB4.7 MB55.0 MB 91%4.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 00:01:02 - 00:59:59 299 2.7% 0.083.0 MB 5.8% 0.86
Sep 30 01:00:00 - 01:59:59 386 3.4% 0.111.4 MB 2.7% 0.39
Sep 30 02:00:00 - 02:59:59 505 4.5% 0.142.7 MB 5.3% 0.77
Sep 30 03:00:00 - 03:59:59 557 4.9% 0.152.0 MB 3.9% 0.58
Sep 30 04:00:00 - 04:59:59 636 5.6% 0.182.1 MB 4.0% 0.59
Sep 30 05:00:00 - 05:59:59 607 5.4% 0.172.9 MB 5.5% 0.81
Sep 30 06:00:00 - 06:59:59 554 4.9% 0.152.1 MB 4.1% 0.60
Sep 30 07:00:00 - 07:59:59 635 5.6% 0.182.5 MB 4.8% 0.70
Sep 30 08:00:00 - 08:59:59 647 5.7% 0.182.2 MB 4.2% 0.62
Sep 30 09:00:00 - 09:59:59 556 4.9% 0.153.5 MB 6.8% 0.99
Sep 30 10:00:00 - 10:59:59 822 7.3% 0.233.6 MB 7.0% 1.03
Sep 30 11:00:00 - 11:59:59 662 5.9% 0.182.1 MB 4.0% 0.59
Sep 30 12:00:00 - 12:59:59 570 5.1% 0.162.4 MB 4.7% 0.69
Sep 30 13:00:00 - 13:59:59 524 4.7% 0.153.7 MB 7.2% 1.05
Sep 30 14:00:00 - 14:59:59 591 5.2% 0.162.1 MB 4.1% 0.60
Sep 30 15:00:00 - 15:59:59 494 4.4% 0.142.1 MB 4.1% 0.60
Sep 30 16:00:00 - 16:59:59 421 3.7% 0.121.2 MB 2.4% 0.35
Sep 30 17:00:00 - 17:59:59 327 2.9% 0.091.8 MB 3.6% 0.52
Sep 30 18:00:00 - 18:59:59 323 2.9% 0.091.3 MB 2.5% 0.37
Sep 30 19:00:00 - 19:59:59 247 2.2% 0.071.0 MB 2.0% 0.29
Sep 30 20:00:00 - 20:59:59 236 2.1% 0.07746.3 KB 1.4% 0.21
Sep 30 21:00:00 - 21:59:59 232 2.1% 0.062.5 MB 4.9% 0.72
Sep 30 22:00:00 - 22:59:59 209 1.9% 0.061.6 MB 3.2% 0.46
Sep 30 23:00:00 - 23:59:59 212 1.9% 0.06863.5 KB 1.6% 0.24
Oct 1 00:00:00 - 00:01:01 8 0.1% 0.1324.9 KB 0.0% 0.41
TOTAL: 23:59:59 11260 100.0% 0.1351.4 MB 100.0% 0.61
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1peer.alt119.net 646 9 0 0 0 0 0 0 637
2usenet.blueworldhosting.com 450 44 0 0 0 0 0 0 406
3endofthelinebbs-out.news.weretis.net 216 0 0 1 0 0 0 0 215
4newsfeed.xs3.de 116 0 0 1 0 0 0 0 115
5glockenspiel.complete.org 3 0 0 0 0 0 0 0 3
6news.bbs.nz 1 0 0 1 0 0 0 0 0
TOTAL: 6 1432 53 0 3 0 0 0 0 1376

Unwanted newsgroups [Top 20]:

NewsgroupCount
at.jobs 10
talk.generic.ua.ws 10
att.jobs 8
aus.jobs 6
rocksolid.feeds.news 5
test.post 5
alt.aviation 2
talk.from.diary 1
talk.from.war.diary 1
fr.petites-annonces.divers 1
panix.chat.politics 1
grisbi.test 1
soc.culture.turkey 1
alt.music.pink-floyd.publius 1
TOTAL: 14 53

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 428
EMP (phn path) 398
EMP (phl) 194
Too many newsgroups 132
EMP (phn nph) 37
HTML Multipart 4
TOTAL: 6 1193

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 67
newsfeed.xs3.de 62
peer.alt119.net 38
usenet.blueworldhosting.com 16
TOTAL: 4 183
TOTAL: 1 183

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 13543 978 9945 326 3 65 7%23:59:55
2peer.alt119.net 8819 112 7124 0 0 1 1%23:58:40
3news.nk.ca 12144 45 11156 18 0 4 0%23:59:55
4news.furie.org.uk 6731 24 5807 1 0 0 0%23:59:45
5usenet.blueworldhosting.com 8677 11 7952 0 0 0 0%23:59:55
6news.bbs.nz 22070 11 11190 42 0 31 0%23:59:55
7news.weretis.net 11333 8 11249 1 0 0 0%23:59:55
8news.tnetconsulting.net 12180 3 11254 0 0 0 0%23:59:55
9news.quux.org 11568 2 11207 38 0 6 0%23:59:33
10newsfeed.xs3.de 9697 1 9458 2 0 0 0%23:59:54
11news.samoylyk.net 11846 1 11230 0 0 0 0%23:59:28
12theuse.net 0 0 0 0 0 11258 0%23:59:55
TOTAL: 12 128608 1196 107572 428 3 11365 0%287:56:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se6.7 MB2.4 MB9.1 MB0.1 KB/s7.1 KB23:59:55
2peer.alt119.net861.5 KB0.0 KB861.5 KB0.0 KB/s7.7 KB23:58:40
3news.nk.ca435.4 KB49.0 KB484.4 KB0.0 KB/s7.7 KB23:59:55
4news.furie.org.uk249.5 KB16.4 KB265.9 KB0.0 KB/s10.6 KB23:59:45
5news.bbs.nz29.2 KB482.9 KB512.1 KB0.0 KB/s9.7 KB23:59:55
6usenet.blueworldhosting.com21.0 KB0.0 KB21.0 KB0.0 KB/s1.9 KB23:59:55
7news.weretis.net14.7 KB4.1 KB18.8 KB0.0 KB/s2.1 KB23:59:55
8news.tnetconsulting.net12.8 KB0.0 KB12.8 KB0.0 KB/s4.3 KB23:59:55
9news.quux.org5.6 KB256.5 KB262.1 KB0.0 KB/s6.6 KB23:59:33
10newsfeed.xs3.de2.0 KB5.4 KB7.5 KB0.0 KB/s2.5 KB23:59:54
11news.samoylyk.net2.0 KB0.0 KB2.0 KB0.0 KB/s2.0 KB23:59:28
12theuse.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:55
TOTAL: 128.2 MB3.2 MB11.5 MB0.0 KB/s7.2 KB287:56:45
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:00:31

NNRP readership statistics (by domain):

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

NNRP auth users [Top 20]:

UserConn
nelgin 2
TOTAL: 1 2

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
bbs.endofthelinebbs.com 0.080 0.079 0.00700:00:21
192.241.219.54 0.084 0.074 0.00000:00:09
TOTAL: 2 0.164 0.153 0.00700:00:31

Curious NNRP server explorers [Top 20]:

SystemConn
192.241.219.54 1
TOTAL: 1 1

NNRP no permission clients:

SystemConn
bbs.endofthelinebbs.com 1
TOTAL: 1 1

NNRP unrecognized commands (by host):

SystemConn
bbs.endofthelinebbs.com 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
auth pass 44ur 1
TOTAL: 1 1

Newsgroup request counts (by category):

CategoryCountPct
1alt 1 50.0%
2news 1 50.0%
TOTAL: 2 2100.0%

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

NewsgroupCount
1alt.music.lyrics 1
2news.software.nntp 1
TOTAL: 2 2