Daily Usenet Report

Sep 28 00:01:02 -- Sep 29 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 13588 68.7%3.4 MB 78.0%
innd 3780 19.1%534.6 KB 12.1%
innfeed 2338 11.8%435.9 KB 9.8%
nnrpd 77 0.4%6.2 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 19784 100.0%4.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 93380 55.4%
Negative hits 61953 36.8%
Do not exist 13169 7.8%
Cache misses 77 0.0%
TOTAL: 4 168579 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.186 0.0%106 0.000 1.755 6.000
article cleanup00:00:00.221 0.0%13188 0.000 0.017 0.069
article logging00:00:00.597 0.0%13422 0.000 0.044 0.107
article parse00:00:00.328 0.0%20156 0.000 0.016 0.078
article write00:00:09.102 0.0%11527 0.365 0.790 2.113
artlog/artcncl00:00:00.005 0.0%105 0.000 0.048 0.500
data move00:00:00.184 0.0%171204 0.000 0.001 0.018
hisgrep/artcncl00:00:00.028 0.0%105 0.000 0.267 1.000
hishave/artcncl00:00:00.018 0.0%106 0.000 0.170 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.167 0.0%168763 0.004 0.042 0.085
history sync00:00:00.049 0.0%336 0.000 0.146 1.000
history write00:00:07.318 0.0%13186 0.099 0.555 1.000
hiswrite/artcncl00:00:00.000 0.0%1 0.000 0.000 0.000
idle23:48:14.524 99.8%167714 256.005 510.956 1910.121
nntp read00:00:08.464 0.0%169728 0.025 0.050 0.595
overview write00:00:07.849 0.0%11527 0.219 0.681 5.216
perl filter00:00:34.476 0.0%13186 1.899 2.615 5.220
python filter00:00:01.922 0.0%13187 0.059 0.146 0.366
site send00:00:04.422 0.0%23054 0.059 0.192 0.600
TOTAL: 23:50:46.57923:49:36.860 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.116 0.0%11741 0.000 0.010 0.109
article prepare00:00:00.003 0.0%6992 0.000 0.000 0.013
article read00:00:00.424 0.0%1505 0.000 0.282 23.500
backlog stats00:00:00.387 0.0%197734 0.000 0.002 0.008
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.450 0.0%141568 0.023 0.038 0.064
data write00:00:17.592 0.0%131965 0.090 0.133 0.295
idle23:55:32.444100.0%197734 237.039 435.598 1372.050
status file00:00:00.185 0.0%189 0.000 0.979 9.000
TOTAL: 23:56:05.39623:55:56.601100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.099 17.6%5 15.333 19.800 26.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.2%12 0.000 0.083 0.125
TOTAL: 00:00:00.56400:00:00.100 17.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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1peer.alt119.net 2 13084 4837 7490 757 36%24:31:59
2usenet.blueworldhosting.com 6 12551 2973 9073 505 23%24:03:57
3endofthelinebbs-out.news.weretis.net 5 22540 2038 20144 358 9%48:06:28
4newsfeed.xs3.de 3 10398 1614 8704 80 15%24:08:43
5glockenspiel.complete.org 1 10613 54 10556 3 0%23:59:52
6news.samoylyk.net 1 10722 41 10680 1 0%23:59:50
7news.furie.org.uk 1 5641 14 5627 0 0%23:59:58
8outgoing.news.lysator.liu.se 1 10890 7 10882 1 0%23:59:57
9news.bbs.nz 3 9828 2 9826 0 0%21:26:46
10localhost 26 1 1 0 0 100%00:00:00
11news.nk.ca 2 0 0 0 0 0%00:20:00
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
TOTAL: 12 52 106268 11581 92982 1705 10%238:47:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com19.9 MB8.3 KB1.5 MB21.3 MB 93%6.3 KB
2peer.alt119.net11.6 MB0.0 KB3.3 MB14.9 MB 78%2.7 KB
3endofthelinebbs-out.news.weretis.net7.7 MB0.0 KB698.5 KB8.4 MB 91%3.6 KB
4newsfeed.xs3.de4.4 MB0.0 KB179.6 KB4.5 MB 96%2.7 KB
5glockenspiel.complete.org326.8 KB350.5 KB353.7 KB1.0 MB 31%18.1 KB
6news.samoylyk.net229.3 KB0.0 KB7.4 KB236.7 KB 96%5.6 KB
7news.furie.org.uk48.4 KB0.0 KB0.0 KB48.4 KB100%3.5 KB
8outgoing.news.lysator.liu.se16.3 KB0.0 KB1.8 KB18.1 KB 90%2.3 KB
9news.bbs.nz6.2 KB0.0 KB0.0 KB6.2 KB100%3.1 KB
10localhost1.1 KB0.0 KB0.0 KB1.1 KB100%1.1 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: 1244.2 MB358.7 KB5.9 MB50.5 MB 87%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 28 00:01:02 - 00:59:59 323 2.8% 0.091.0 MB 2.3% 0.30
Sep 28 01:00:00 - 01:59:59 354 3.1% 0.101.2 MB 2.6% 0.33
Sep 28 02:00:00 - 02:59:59 475 4.1% 0.131.6 MB 3.6% 0.46
Sep 28 03:00:00 - 03:59:59 527 4.6% 0.151.3 MB 2.9% 0.36
Sep 28 04:00:00 - 04:59:59 574 5.0% 0.161.6 MB 3.7% 0.46
Sep 28 05:00:00 - 05:59:59 542 4.7% 0.152.0 MB 4.4% 0.56
Sep 28 06:00:00 - 06:59:59 565 4.9% 0.161.8 MB 4.0% 0.51
Sep 28 07:00:00 - 07:59:59 699 6.0% 0.194.7 MB 10.6% 1.35
Sep 28 08:00:00 - 08:59:59 664 5.7% 0.181.9 MB 4.2% 0.53
Sep 28 09:00:00 - 09:59:59 812 7.0% 0.232.5 MB 5.7% 0.72
Sep 28 10:00:00 - 10:59:59 715 6.2% 0.202.4 MB 5.4% 0.69
Sep 28 11:00:00 - 11:59:59 610 5.3% 0.172.0 MB 4.4% 0.56
Sep 28 12:00:00 - 12:59:59 701 6.1% 0.193.7 MB 8.3% 1.05
Sep 28 13:00:00 - 13:59:59 655 5.7% 0.181.9 MB 4.3% 0.54
Sep 28 14:00:00 - 14:59:59 584 5.1% 0.161.7 MB 3.9% 0.49
Sep 28 15:00:00 - 15:59:59 550 4.8% 0.151.6 MB 3.7% 0.47
Sep 28 16:00:00 - 16:59:59 450 3.9% 0.121.6 MB 3.6% 0.45
Sep 28 17:00:00 - 17:59:59 394 3.4% 0.112.7 MB 6.2% 0.78
Sep 28 18:00:00 - 18:59:59 302 2.6% 0.081.1 MB 2.6% 0.33
Sep 28 19:00:00 - 19:59:59 200 1.7% 0.06926.8 KB 2.0% 0.26
Sep 28 20:00:00 - 20:59:59 231 2.0% 0.06964.8 KB 2.1% 0.27
Sep 28 21:00:00 - 21:59:59 186 1.6% 0.051.1 MB 2.5% 0.32
Sep 28 22:00:00 - 22:59:59 213 1.8% 0.061.4 MB 3.1% 0.39
Sep 28 23:00:00 - 23:59:59 226 2.0% 0.061.8 MB 4.0% 0.50
Sep 29 00:00:00 - 00:01:02 5 0.0% 0.0811.6 KB 0.0% 0.19
TOTAL: 24:00:00 11557 100.0% 0.1344.5 MB 100.0% 0.53
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1peer.alt119.net 823 10 0 0 0 0 0 0 813
2usenet.blueworldhosting.com 499 70 0 1 0 0 0 0 428
3endofthelinebbs-out.news.weretis.net 434 0 0 0 0 0 0 0 434
4newsfeed.xs3.de 167 0 0 0 0 0 0 0 167
5news.samoylyk.net 1 0 0 0 0 0 0 0 1
6outgoing.news.lysator.liu.se 1 0 0 0 0 0 0 0 1
7glockenspiel.complete.org 1 0 0 1 0 0 0 0 0
TOTAL: 7 1926 80 0 2 0 0 0 0 1844

Unwanted newsgroups [Top 20]:

NewsgroupCount
at.jobs 19
talk.generic.ua.ws 15
aus.jobs 8
panix.chat 7
att.jobs 5
rocksolid.feeds.news 3
al.christnet.bible 3
rocksolid.feeds.tech 2
panix.questions 2
alt.entrepreneurs 2
ee.arvutid 2
alt.french 1
talk.from.diary 1
soc.culture.germany 1
soc.culutre.china 1
1.test 1
alt.soc.germans 1
soc.culture.france 1
altprivacy.anon-server 1
grisbi.test 1
TOTAL: 23 80

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 660
EMP (md5) 526
Too many newsgroups 176
EMP (phl) 172
EMP (phn nph) 59
Scoring filter 7
HTML Multipart 7
Too many newsgroups (low_xpost) 1
Binary: misplaced binary 1
TOTAL: 9 1609

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
newsfeed.xs3.de 87
endofthelinebbs-out.news.weretis.net 84
peer.alt119.net 56
usenet.blueworldhosting.com 8
TOTAL: 4 235
TOTAL: 1 235

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 14163 984 10193 374 0 109 6%23:59:41
2peer.alt119.net 8527 194 6552 1 0 0 2%23:59:52
3news.furie.org.uk 6675 19 5787 6 0 3 0%23:59:56
4news.nk.ca 12961 16 11472 17 0 11 0%23:59:57
5news.bbs.nz 22518 14 11491 46 0 72 0%23:59:50
6news.quux.org 12092 6 11461 54 0 0 0%23:57:53
7usenet.blueworldhosting.com 8735 4 8296 0 0 0 0%23:59:20
8news.weretis.net 11630 4 11549 3 0 0 0%23:59:52
9news.tnetconsulting.net 12419 2 11553 1 0 1 0%23:59:45
10news.samoylyk.net 12145 1 11514 0 0 1 0%23:59:54
11newsfeed.xs3.de 10197 1 10000 2 0 0 0%23:59:56
12theuse.net 0 0 0 0 0 11556 0%23:59:57
TOTAL: 12 132062 1245 109868 504 0 11753 0%287:55:53
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se7.0 MB1.9 MB8.9 MB0.1 KB/s6.7 KB23:59:41
2peer.alt119.net1.3 MB1.5 KB1.3 MB0.0 KB/s6.9 KB23:59:52
3news.furie.org.uk213.1 KB53.3 KB266.4 KB0.0 KB/s10.7 KB23:59:56
4news.nk.ca55.4 KB50.5 KB105.9 KB0.0 KB/s3.2 KB23:59:57
5news.bbs.nz41.3 KB211.7 KB253.0 KB0.0 KB/s4.2 KB23:59:50
6news.quux.org28.8 KB182.0 KB210.8 KB0.0 KB/s3.5 KB23:57:53
7news.tnetconsulting.net16.4 KB1.2 KB17.6 KB0.0 KB/s5.9 KB23:59:45
8usenet.blueworldhosting.com14.5 KB0.0 KB14.5 KB0.0 KB/s3.6 KB23:59:20
9news.weretis.net7.0 KB10.1 KB17.1 KB0.0 KB/s2.4 KB23:59:52
10news.samoylyk.net1.1 KB0.0 KB1.1 KB0.0 KB/s1.1 KB23:59:54
11newsfeed.xs3.de1.1 KB8.2 KB9.3 KB0.0 KB/s3.1 KB23:59:56
12theuse.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 128.7 MB2.4 MB11.1 MB0.0 KB/s6.5 KB287:55:53
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.43.57 1 00.0 KB 3 0 000:00:00
TOTAL: 1 1 00.0 KB 3 0 000:00:00

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 3 00.0 KB 3 0 000:00:00
TOTAL: 1 3 00.0 KB 3 0 000:00: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
192.241.205.245 0.078 0.077 0.00000:00:00
69.57.160.94 0.064 0.042 0.00000:00:00
TOTAL: 2 0.142 0.119 0.00000:00:00

Curious NNRP server explorers [Top 20]:

SystemConn
192.241.205.245 1
69.57.160.94 1
TOTAL: 2 2

NNRP unrecognized commands (by host):

SystemConn
69.57.160.94 2
192.241.205.245 1
TOTAL: 2 3

NNRP unrecognized commands (by command):

CommandCount
À#024 1
#026#003#001#002 1
MGLNDD_192.138.210.162_119 1
TOTAL: 3 3

NNRP client timeouts [Top 20]:

SystemConnPeer
69.57.160.94 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1alt 2 66.7%
2news 1 33.3%
TOTAL: 2 3100.0%

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

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