Daily Usenet Report

Feb 16 00:01:01 -- Feb 17 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Feb 16 00:06:36 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16505 62.2%3.9 MB 72.9%
innd 7597 28.6%1.0 MB 19.2%
innfeed 2356 8.9%428.2 KB 7.8%
nnrpd 65 0.2%5.2 KB 0.1%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 26524 100.0%5.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 90224 55.6%
Negative hits 56081 34.5%
Do not exist 16048 9.9%
Cache misses 57 0.0%
TOTAL: 4 162410 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.138 0.0%89 0.000 1.551 4.083
article cleanup00:00:00.350 0.0%16177 0.000 0.022 0.100
article logging00:00:00.730 0.0%16425 0.000 0.044 0.103
article parse00:00:03.514 0.0%198355 0.000 0.018 0.097
article write00:00:11.819 0.0%10764 0.330 1.098 2.833
artlog/artcncl00:00:00.001 0.0%89 0.000 0.011 0.500
data move00:00:00.772 0.0%349269 0.000 0.002 0.008
hisgrep/artcncl00:00:00.022 0.0%89 0.000 0.247 1.000
hishave/artcncl00:00:00.019 0.0%89 0.000 0.213 1.083
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:08.066 0.0%162868 0.006 0.050 0.119
history sync00:00:00.064 0.0%340 0.000 0.188 2.500
history write00:00:09.831 0.0%16177 0.000 0.608 1.039
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:21.415 99.8%331861 24.852 259.872 2598.251
nntp read00:00:30.407 0.0%333876 0.022 0.091 0.151
overview write00:00:06.867 0.0%10764 0.223 0.638 4.500
perl filter00:00:41.844 0.0%16177 1.440 2.587 4.517
python filter00:00:02.849 0.0%16177 0.076 0.176 0.395
site send00:00:04.005 0.0%21528 0.029 0.186 0.550
TOTAL: 24:00:44.08323:59:22.713 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.173 0.0%11201 0.000 0.015 0.107
article prepare00:00:00.009 0.0%35976 0.000 0.000 0.010
article read00:00:01.550 0.0%5396 0.043 0.287 1.815
backlog stats00:00:00.650 0.0%235157 0.000 0.003 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:05.064 0.0%154766 0.019 0.033 0.052
data write00:00:20.913 0.0%144619 0.101 0.145 0.212
idle23:55:56.604100.0%235157 201.170 366.379 1049.879
status file00:00:00.222 0.0%212 0.000 1.047 4.000
TOTAL: 23:56:36.22523:56:25.185100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle13:05:33.776100.0%986 30.000 47803.018 47900.118
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.462 0.0%2074 0.223 0.223 0.250
readart00:00:00.108 0.0%323 0.334 0.334 0.334
TOTAL: 13:05:36.60513:05:34.346100.0%----

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 19424 5837 13192 395 30%45:42:03
2usenet.blueworldhosting.com 5 11953 3746 7528 679 31%23:04:15
3outgoing.news.lysator.liu.se 2 12092 626 11146 320 5%23:59:47
4newsfeed.xs3.de 2 9930 321 9606 3 3%23:59:53
5news.samoylyk.net 2 9971 57 9913 1 0%23:58:49
6glockenspiel.complete.org 1 10520 36 10407 77 0%23:59:52
7news.bbs.nz 2 4764 13 4751 0 0%13:33:38
8news.furie.org.uk 2 5778 1 5777 0 0%24:56:48
9news.netfront.net 6 16144 1 12169 3974 0%25:21:30
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:21:10
TOTAL: 12 55 100576 10638 84489 5449 10%229:07:50
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com24.4 MB0.0 KB2.7 MB27.1 MB 90%6.3 KB
2endofthelinebbs-out.news.weretis.net19.1 MB0.0 KB774.3 KB19.9 MB 96%3.3 KB
3newsfeed.xs3.de2.0 MB0.0 KB4.5 KB2.0 MB 99%6.4 KB
4outgoing.news.lysator.liu.se1.2 MB0.0 KB713.7 KB1.9 MB 63%2.1 KB
5glockenspiel.complete.org327.5 KB1.7 KB162.6 KB491.7 KB 66%4.4 KB
6news.samoylyk.net213.2 KB0.0 KB1.3 KB214.5 KB 99%3.7 KB
7news.bbs.nz35.3 KB0.0 KB0.0 KB35.3 KB100%2.7 KB
8news.netfront.net4.8 KB0.0 KB1.4 GB1.4 GB 0%358.7 KB
9news.furie.org.uk2.8 KB0.0 KB0.0 KB2.8 KB100%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.3 MB1.7 KB1.4 GB1.4 GB 3%91.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Feb 16 00:01:01 - 00:59:59 197 1.8% 0.06933.7 KB 1.9% 0.26
Feb 16 01:00:00 - 01:59:59 416 3.9% 0.121.1 MB 2.4% 0.33
Feb 16 02:00:00 - 02:59:59 488 4.5% 0.141.6 MB 3.3% 0.44
Feb 16 03:00:00 - 03:59:59 589 5.5% 0.162.0 MB 4.2% 0.57
Feb 16 04:00:00 - 04:59:59 642 6.0% 0.181.9 MB 4.0% 0.54
Feb 16 05:00:00 - 05:59:59 508 4.7% 0.144.0 MB 8.4% 1.13
Feb 16 06:00:00 - 06:59:59 618 5.7% 0.172.0 MB 4.2% 0.56
Feb 16 07:00:00 - 07:59:59 478 4.4% 0.131.7 MB 3.5% 0.48
Feb 16 08:00:00 - 08:59:59 605 5.6% 0.172.3 MB 4.9% 0.67
Feb 16 09:00:00 - 09:59:59 591 5.5% 0.163.4 MB 7.1% 0.96
Feb 16 10:00:00 - 10:59:59 511 4.7% 0.141.8 MB 3.8% 0.51
Feb 16 11:00:00 - 11:59:59 540 5.0% 0.151.8 MB 3.8% 0.51
Feb 16 12:00:00 - 12:59:59 563 5.2% 0.162.5 MB 5.2% 0.71
Feb 16 13:00:00 - 13:59:59 612 5.7% 0.172.8 MB 5.8% 0.78
Feb 16 14:00:00 - 14:59:59 537 5.0% 0.153.3 MB 7.1% 0.95
Feb 16 15:00:00 - 15:59:59 516 4.8% 0.143.2 MB 6.7% 0.90
Feb 16 16:00:00 - 16:59:59 437 4.1% 0.121.6 MB 3.4% 0.46
Feb 16 17:00:00 - 17:59:59 411 3.8% 0.112.0 MB 4.1% 0.56
Feb 16 18:00:00 - 18:59:59 296 2.8% 0.081.2 MB 2.6% 0.35
Feb 16 19:00:00 - 19:59:59 277 2.6% 0.081.8 MB 3.8% 0.51
Feb 16 20:00:00 - 20:59:59 254 2.4% 0.071.5 MB 3.1% 0.42
Feb 16 21:00:00 - 21:59:59 234 2.2% 0.071.2 MB 2.5% 0.33
Feb 16 22:00:00 - 22:59:59 203 1.9% 0.06879.8 KB 1.8% 0.24
Feb 16 23:00:00 - 23:59:59 233 2.2% 0.061.2 MB 2.4% 0.33
Feb 17 00:00:00 - 00:01:02 5 0.0% 0.0812.4 KB 0.0% 0.20
TOTAL: 24:00:01 10761 100.0% 0.1247.4 MB 100.0% 0.56
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 3963 0 0 0 0 0 0 0 3963
2usenet.blueworldhosting.com 706 12 0 0 0 0 0 0 694
3endofthelinebbs-out.news.weretis.net 618 0 0 0 0 0 0 0 618
4outgoing.news.lysator.liu.se 289 0 0 0 0 0 0 0 289
5glockenspiel.complete.org 62 0 0 0 0 0 0 0 62
6newsfeed.xs3.de 13 0 0 0 0 0 0 0 13
7news.samoylyk.net 4 0 0 0 0 0 0 0 4
TOTAL: 7 5655 12 0 0 0 0 0 0 5643

Unwanted newsgroups [Top 20]:

NewsgroupCount
free.it.test.testo.testa.testi.teste 5
rocksolid.feeds.news 4
gozankayagmail.com 1
de.rec.tv.lindenstrasse 1
alt.penthouse.sex.first-time 1
TOTAL: 5 12

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary fx02.ams4.POSTED 741
EMP (phn path) 633
EMP (md5) 598
Binary: misplaced binary fx12.ams4.POSTED 355
Binary: misplaced binary fx10.ams4.POSTED 292
Binary: misplaced binary fx17.iad.POSTED 282
Binary: misplaced binary fx15.ams4.POSTED 240
Binary: misplaced binary fx11.iad.POSTED 234
Binary: misplaced binary fx16.iad.POSTED 232
Binary: misplaced binary fx06.ams4.POSTED 219
Binary: misplaced binary fx09.iad.POSTED 219
Binary: misplaced binary fx05.ams4.POSTED 144
Binary: misplaced binary fx18.iad.POSTED 117
Binary: misplaced binary fx10.iad.POSTED 116
EMP (phn nph) 115
Binary: misplaced binary fx12.iad.POSTED 110
Binary: misplaced binary fx04.ams4.POSTED 105
Binary: misplaced binary fx01.ams4.POSTED 101
Binary: misplaced binary fx15.iad.POSTED 92
Binary: misplaced binary fx14.ams4.POSTED 84
TOTAL: 35 5395

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 224
usenet.blueworldhosting.com 11
newsfeed.xs3.de 10
news.samoylyk.net 3
TOTAL: 4 248
TOTAL: 1 248

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 14646 5118 5628 14 0 5 34%23:59:54
2nyheter.lysator.liu.se 10357 3457 6654 4 0 0 33%23:59:31
3news.nk.ca 12117 46 10660 41 0 297 0%23:59:57
4news.bbs.nz 20907 17 10639 85 0 120 0%23:59:56
5news.quux.org 11070 14 10564 159 0 0 0%23:59:29
6usenet.blueworldhosting.com 7881 13 6889 0 0 7 0%23:59:57
7news.furie.org.uk 9281 13 5879 16 0 25 0%23:59:56
8news.samoylyk.net 14147 3 10696 0 0 0 0%23:59:54
9news.weretis.net 10848 1 10756 2 0 0 0%23:59:32
10peer.alt119.net 0 0 0 0 0 10757 0%23:57:47
11news.tnetconsulting.net 11342 0 10756 0 0 0 0%23:59:57
12newsfeed.xs3.de 13809 0 10429 2 0 0 0%23:59:35
TOTAL: 12 136405 8682 99550 323 0 11211 6%287:55:25
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net25.7 MB63.8 KB25.8 MB0.3 KB/s5.1 KB23:59:54
2nyheter.lysator.liu.se20.4 MB5.1 KB20.4 MB0.2 KB/s6.0 KB23:59:31
3news.nk.ca282.4 KB460.8 KB743.3 KB0.0 KB/s8.5 KB23:59:57
4news.bbs.nz217.1 KB560.1 KB777.1 KB0.0 KB/s7.6 KB23:59:56
5news.quux.org159.1 KB1.0 MB1.2 MB0.0 KB/s6.9 KB23:59:29
6news.furie.org.uk152.9 KB79.7 KB232.6 KB0.0 KB/s8.0 KB23:59:56
7usenet.blueworldhosting.com24.2 KB0.0 KB24.2 KB0.0 KB/s1.9 KB23:59:57
8news.samoylyk.net8.7 KB0.0 KB8.7 KB0.0 KB/s2.9 KB23:59:54
9news.weretis.net1.6 KB570.7 KB572.3 KB0.0 KB/s190.8 KB23:59:32
10peer.alt119.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:47
11news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
12newsfeed.xs3.de0.0 KB5.6 KB5.6 KB0.0 KB/s2.8 KB23:59:35
TOTAL: 1246.9 MB2.7 MB49.6 MB0.0 KB/s5.6 KB287:55:25
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 1 2093.8 KB 1 1 013:05:36
TOTAL: 1 1 2093.8 KB 1 1 013:05:36

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.186.32.124 0.395 0.656 1.62613:05:36
107.170.231.12 0.078 0.035 0.00000:00:00
TOTAL: 2 0.473 0.691 1.62613:05:36

Curious NNRP server explorers [Top 20]:

SystemConn
107.170.231.12 1
TOTAL: 1 1

NNRP unrecognized commands (by host):

SystemConn
107.170.231.12 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
1soc 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1soc.genealogy.britain 1
TOTAL: 1 1