Daily Usenet Report

Oct 25 00:01:01 -- Oct 26 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 25 00:05:36 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 13675 68.3%3.5 MB 78.2%
innd 4005 20.0%577.1 KB 12.4%
innfeed 2317 11.6%432.6 KB 9.3%
nnrpd 21 0.1%2.4 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 20019 100.0%4.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 95236 54.5%
Negative hits 66092 37.8%
Do not exist 13247 7.6%
Cache misses 45 0.0%
TOTAL: 4 174620 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.134 0.0%77 0.000 1.740 4.500
article cleanup00:00:00.199 0.0%13325 0.000 0.015 0.085
article logging00:00:00.578 0.0%13602 0.000 0.042 0.160
article parse00:00:00.318 0.0%20290 0.000 0.016 0.058
article write00:00:11.988 0.0%11414 0.267 1.050 2.041
artlog/artcncl00:00:00.003 0.0%77 0.000 0.039 0.333
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.179 0.0%178111 0.000 0.001 0.006
hisgrep/artcncl00:00:00.021 0.0%76 0.000 0.276 2.000
hishave/artcncl00:00:00.006 0.0%77 0.000 0.078 0.500
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:05.688 0.0%175115 0.003 0.032 0.080
history sync00:00:00.046 0.0%386 0.000 0.119 1.000
history write00:00:05.897 0.0%13295 0.052 0.444 0.812
hiswrite/artcncl00:00:00.001 0.0%1 1.000 1.000 1.000
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:58:43.907 99.8%175527 277.506 491.798 1366.674
nntp read00:00:08.502 0.0%176802 0.023 0.048 0.077
overview write00:00:06.548 0.0%11414 0.232 0.574 2.881
perl filter00:00:33.276 0.0%13295 1.748 2.503 5.472
python filter00:00:01.744 0.0%13295 0.054 0.131 0.345
site send00:00:03.711 0.0%22828 0.026 0.163 0.362
TOTAL: 24:01:11.50724:00:02.746 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.077 0.0%11511 0.000 0.007 0.158
article prepare00:00:00.006 0.0%15000 0.000 0.000 0.018
article read00:00:00.717 0.0%2857 0.000 0.251 5.625
backlog stats00:00:00.402 0.0%221773 0.000 0.002 0.006
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:06.151 0.0%152951 0.016 0.040 0.073
data write00:00:17.682 0.0%143454 0.069 0.123 0.195
idle23:57:23.978100.0%221773 229.217 388.884 827.823
status file00:00:00.185 0.0%181 0.000 1.022 8.000
TOTAL: 23:57:57.95823:57:49.198100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:25.086 97.2%6 25.500 4181.000 10041.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.002 0.0%12 0.000 0.167 0.500
TOTAL: 00:00:25.80300:00:25.088 97.2%----

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 3 23380 6446 16199 735 27%51:30:26
2usenet.blueworldhosting.com 5 13308 2673 10270 365 20%25:39:29
3peer.alt119.net 2 13187 1814 10531 842 13%24:08:54
4newsfeed.xs3.de 1 10891 415 10457 19 3%23:59:54
5news.samoylyk.net 2 10874 102 10767 5 0%23:59:32
6glockenspiel.complete.org 1 11031 48 10968 15 0%23:59:54
7news.furie.org.uk 1 5937 30 5906 1 0%23:59:52
8outgoing.news.lysator.liu.se 1 10556 24 10530 2 0%23:59:57
9news.bbs.nz 2 14793 3 14789 1 0%32:31:18
10eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:05
11localhost 25 0 0 0 0 0%00:00:00
12news.nk.ca 2 0 0 0 0 0%00:20:01
TOTAL: 12 46 113957 11555 100417 1985 10%254:19:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net24.6 MB57.6 KB1.6 MB26.2 MB 93%3.7 KB
2usenet.blueworldhosting.com15.5 MB4.9 KB886.4 KB16.3 MB 94%5.5 KB
3peer.alt119.net4.3 MB7.7 KB2.6 MB6.9 MB 62%2.7 KB
4newsfeed.xs3.de2.0 MB3.6 KB31.9 KB2.0 MB 98%4.7 KB
5news.samoylyk.net639.5 KB2.7 KB6.5 KB648.7 KB 98%6.1 KB
6glockenspiel.complete.org294.0 KB8.5 KB40.3 KB342.8 KB 85%5.4 KB
7news.furie.org.uk116.2 KB0.0 KB4.0 KB120.1 KB 96%3.9 KB
8outgoing.news.lysator.liu.se91.2 KB0.0 KB2.1 KB93.3 KB 97%3.6 KB
9news.bbs.nz5.0 KB3.2 KB3.2 KB11.4 KB 43%2.8 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: 1247.4 MB88.2 KB5.1 MB52.6 MB 90%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 25 00:01:01 - 00:59:59 298 2.6% 0.081.3 MB 2.8% 0.38
Oct 25 01:00:00 - 01:59:59 342 3.0% 0.101.6 MB 3.5% 0.47
Oct 25 02:00:00 - 02:59:59 481 4.2% 0.132.2 MB 4.7% 0.63
Oct 25 03:00:00 - 03:59:59 511 4.5% 0.141.3 MB 2.7% 0.36
Oct 25 04:00:00 - 04:59:59 559 4.9% 0.162.7 MB 5.7% 0.76
Oct 25 05:00:00 - 05:59:59 478 4.2% 0.131.7 MB 3.7% 0.49
Oct 25 06:00:00 - 06:59:59 549 4.8% 0.151.7 MB 3.6% 0.48
Oct 25 07:00:00 - 07:59:59 571 5.0% 0.161.6 MB 3.4% 0.46
Oct 25 08:00:00 - 08:59:59 540 4.7% 0.151.7 MB 3.6% 0.48
Oct 25 09:00:00 - 09:59:59 650 5.7% 0.183.3 MB 6.9% 0.93
Oct 25 10:00:00 - 10:59:59 633 5.5% 0.182.9 MB 6.2% 0.83
Oct 25 11:00:00 - 11:59:59 668 5.9% 0.192.2 MB 4.8% 0.64
Oct 25 12:00:00 - 12:59:59 642 5.6% 0.182.3 MB 4.9% 0.66
Oct 25 13:00:00 - 13:59:59 640 5.6% 0.181.8 MB 3.8% 0.51
Oct 25 14:00:00 - 14:59:59 624 5.5% 0.172.2 MB 4.7% 0.63
Oct 25 15:00:00 - 15:59:59 551 4.8% 0.151.8 MB 3.8% 0.51
Oct 25 16:00:00 - 16:59:59 582 5.1% 0.163.6 MB 7.5% 1.01
Oct 25 17:00:00 - 17:59:59 418 3.7% 0.121.6 MB 3.4% 0.45
Oct 25 18:00:00 - 18:59:59 363 3.2% 0.101.9 MB 4.1% 0.54
Oct 25 19:00:00 - 19:59:59 294 2.6% 0.081.7 MB 3.6% 0.48
Oct 25 20:00:00 - 20:59:59 245 2.1% 0.07898.1 KB 1.9% 0.25
Oct 25 21:00:00 - 21:59:59 291 2.6% 0.081018.3 KB 2.1% 0.28
Oct 25 22:00:00 - 22:59:59 253 2.2% 0.073.3 MB 6.9% 0.93
Oct 25 23:00:00 - 23:59:59 221 1.9% 0.06857.1 KB 1.8% 0.24
Oct 26 00:00:00 - 00:01:01 4 0.0% 0.079.9 KB 0.0% 0.16
TOTAL: 24:00:00 11408 100.0% 0.1347.1 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 962 0 0 17 0 0 0 0 945
2peer.alt119.net 830 4 0 5 0 0 0 0 821
3usenet.blueworldhosting.com 356 27 0 1 0 0 0 0 328
4newsfeed.xs3.de 23 0 0 3 0 0 0 0 20
5news.samoylyk.net 13 0 0 2 0 0 0 0 11
6glockenspiel.complete.org 4 1 0 2 0 0 0 0 1
7outgoing.news.lysator.liu.se 1 0 0 0 0 0 0 0 1
8news.furie.org.uk 1 0 0 0 0 0 0 0 1
TOTAL: 8 2190 32 0 30 0 0 0 0 2128

Unwanted newsgroups [Top 20]:

NewsgroupCount
att.jobs 8
at.jobs 7
aus.jobs 6
rocksolid.feeds.news 4
fr.petites-annonces.informatique.materiel 2
panix.user.macintosh 1
alt.exploding.barney 1
panix.chat 1
de.markt.wohnen 1
grisbi.test 1
TOTAL: 10 32

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 855
EMP (md5) 459
EMP (phn nph) 214
EMP (phl) 199
Too many newsgroups 103
Scoring filter 19
HTML Multipart 2
TOTAL: 7 1851

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 235
peer.alt119.net 19
news.samoylyk.net 8
usenet.blueworldhosting.com 8
newsfeed.xs3.de 5
glockenspiel.complete.org 1
outgoing.news.lysator.liu.se 1
TOTAL: 7 277
TOTAL: 1 277

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 13472 2100 8928 355 0 47 15%23:59:56
2peer.alt119.net 10346 736 8831 21 0 0 7%23:59:56
3news.bbs.nz 21887 106 11220 72 0 36 0%23:59:56
4usenet.blueworldhosting.com 12089 94 8648 14 0 19 0%23:59:37
5news.furie.org.uk 7726 54 6122 26 0 2 0%23:59:56
6news.quux.org 11879 35 11271 66 0 0 0%23:59:27
7news.nk.ca 14483 31 11335 27 0 9 0%23:59:56
8news.tnetconsulting.net 12630 3 11398 1 0 0 0%23:59:56
9news.weretis.net 11578 2 11394 11 0 0 0%23:59:52
10theuse.net 0 0 0 0 0 11407 0%23:59:56
11news.samoylyk.net 12733 0 11302 0 0 1 0%23:59:48
12newsfeed.xs3.de 12267 0 10992 0 0 1 0%23:59:56
TOTAL: 12 141090 3161 111441 593 0 11522 2%287:58:12
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se11.3 MB1.7 MB13.0 MB0.2 KB/s5.4 KB23:59:56
2peer.alt119.net3.8 MB64.5 KB3.8 MB0.0 KB/s5.2 KB23:59:56
3news.furie.org.uk1.8 MB840.3 KB2.7 MB0.0 KB/s34.1 KB23:59:56
4news.bbs.nz404.4 KB355.9 KB760.3 KB0.0 KB/s4.3 KB23:59:56
5usenet.blueworldhosting.com259.3 KB40.4 KB299.7 KB0.0 KB/s2.8 KB23:59:37
6news.nk.ca160.2 KB123.3 KB283.5 KB0.0 KB/s4.9 KB23:59:56
7news.quux.org112.0 KB278.5 KB390.4 KB0.0 KB/s3.9 KB23:59:27
8news.tnetconsulting.net74.5 KB1.3 KB75.7 KB0.0 KB/s18.9 KB23:59:56
9news.weretis.net3.2 KB314.7 KB317.9 KB0.0 KB/s24.5 KB23:59:52
10theuse.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
11news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:48
12newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 1217.9 MB3.7 MB21.6 MB0.0 KB/s5.9 KB287:58:12
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1104.152.52.133 1 00.0 KB 0 0 000:00:00
2192.241.212.187 1 00.0 KB 0 0 000:00:09
3104.152.52.119 1 00.0 KB 0 0 000:00:10
4sh-ams-nl-gp1-wk114.internet-census.org 1 00.0 KB 0 0 000:00:05
5192.241.218.248 1 00.0 KB 0 0 000:00:00
TOTAL: 5 5 00.0 KB 0 0 000:00:25

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 4 00.0 KB 0 0 000:00:20
2*.internet-census.org 1 00.0 KB 0 0 000:00:05
TOTAL: 2 5 00.0 KB 0 0 000:00:25

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
104.152.52.119 0.091 0.033 0.00000:00:10
192.241.212.187 0.084 0.035 0.00000:00:09
sh-ams-nl-gp1-wk114.internet-census.org 0.070 0.033 0.00000:00:05
192.241.218.248 0.069 0.032 0.00000:00:00
104.152.52.133 0.074 0.025 0.00000:00:00
TOTAL: 5 0.388 0.158 0.00000:00:25

NNRP unrecognized commands (by host):

SystemConn
192.241.218.248 1
TOTAL: 1 1

NNRP unrecognized commands (by command):

CommandCount
MGLNDD_192.138.210.162_119 1
TOTAL: 1 1