Daily Usenet Report

Nov 15 00:01:02 -- Nov 16 00:01:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Nov 15 00:05:53 www innd: message repeated 2 times: [ ctlinnd command s]
Nov 15 10:00:08 www pgpverify[3546199]: pgpverify: verification failed

Log entries by program:

Program nameLines%LinesSize%Size
inn 13854 67.9%3.7 MB 78.3%
innd 4144 20.3%584.0 KB 12.2%
innfeed 2335 11.4%448.7 KB 9.4%
nnrpd 59 0.3%4.7 KB 0.1%
controlchan 23 0.1%5.0 KB 0.1%
pgpverify 1 0.0%0.4 KB 0.0%
TOTAL: 6 20416 100.0%4.7 MB100.0%

History cache:

ReasonCount%Count
Positive hits 109049 57.6%
Negative hits 66280 35.0%
Do not exist 13441 7.1%
Cache misses 464 0.2%
TOTAL: 4 189234 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.097 0.0%48 0.000 2.021 7.000
article cleanup00:00:00.258 0.0%13471 0.000 0.019 0.088
article logging00:00:00.713 0.0%13805 0.000 0.052 0.137
article parse00:00:00.545 0.0%26558 0.000 0.021 0.089
article write00:00:10.355 0.0%11670 0.447 0.887 2.764
artlog/artcncl00:00:00.000 0.0%47 0.000 0.000 0.000
data move00:00:00.229 0.0%196136 0.000 0.001 0.005
hisgrep/artcncl00:00:00.010 0.0%44 0.000 0.227 1.000
hishave/artcncl00:00:00.015 0.0%48 0.000 0.312 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:07.197 0.0%189723 0.006 0.038 0.093
history sync00:00:00.055 0.0%394 0.000 0.140 0.667
history write00:00:07.281 0.0%13470 0.082 0.541 0.931
hiswrite/artcncl00:00:00.001 0.0%4 0.000 0.250 0.500
idle23:58:12.690 99.8%192623 127.954 447.987 1862.292
nntp read00:00:10.416 0.0%194192 0.028 0.054 0.153
overview write00:00:07.531 0.0%11670 0.250 0.645 3.167
perl filter00:00:39.684 0.0%13470 2.099 2.946 6.700
python filter00:00:02.326 0.0%13470 0.067 0.173 0.556
site send00:00:04.907 0.0%23342 0.074 0.210 0.673
TOTAL: 24:01:04.86923:59:44.310 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.163 0.0%14355 0.000 0.011 0.108
article prepare00:00:00.006 0.0%43220 0.000 0.000 0.003
article read00:00:01.540 0.0%5887 0.053 0.262 1.760
backlog stats00:00:00.628 0.0%276013 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:08.340 0.0%188620 0.023 0.044 0.081
data write00:00:23.594 0.0%168336 0.107 0.140 0.302
idle23:56:33.915 99.9%276013 147.758 312.282 964.318
status file00:00:00.204 0.0%205 0.000 0.995 3.000
TOTAL: 23:57:19.93023:57:08.390100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:10.077 96.3%2 308.000 5038.500 9769.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.000 0.0%4 0.000 0.000 0.000
TOTAL: 00:00:10.45900:00:10.077 96.3%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
group-admin@isc.org002112
TOTAL002112

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 5 24992 6265 18336 391 25%56:02:10
2usenet.blueworldhosting.com 4 12593 3611 8540 442 28%23:41:05
3peer.alt119.net 8 12743 1163 11430 150 9%20:37:22
4newsfeed.xs3.de 1 10410 375 10031 4 3%23:59:54
5outgoing.news.lysator.liu.se 1 12847 215 12103 529 1%23:59:57
6news.samoylyk.net 2 10690 39 10648 3 0%23:59:27
7glockenspiel.complete.org 2 10724 17 10706 1 0%23:59:51
8news.bbs.nz 3 16455 12 16443 0 0%36:59:51
9news.furie.org.uk 9 6040 7 6032 1 0%24:46:08
10news.netfront.net 0 5751 1 5551 199 0%10:36:33
11localhost 25 0 0 0 0 0%00:00:00
12eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
13news.nk.ca 2 0 0 0 0 0%00:20:01
TOTAL: 13 63 123245 11705 109820 1720 9%269:12:22
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net21.7 MB0.0 KB684.8 KB22.4 MB 97%3.4 KB
2usenet.blueworldhosting.com19.3 MB0.0 KB1.5 MB20.8 MB 92%5.2 KB
3peer.alt119.net2.9 MB0.0 KB1.5 MB4.4 MB 66%3.5 KB
4newsfeed.xs3.de1.7 MB0.0 KB9.7 KB1.7 MB 99%4.6 KB
5outgoing.news.lysator.liu.se463.8 KB0.0 KB1.0 MB1.5 MB 30%2.0 KB
6glockenspiel.complete.org281.2 KB1.7 KB1.7 KB284.5 KB 98%15.8 KB
7news.samoylyk.net150.3 KB0.0 KB9.7 KB160.0 KB 93%3.8 KB
8news.bbs.nz55.2 KB0.0 KB0.0 KB55.2 KB100%4.6 KB
9news.furie.org.uk27.8 KB0.0 KB4.0 KB31.7 KB 87%4.0 KB
10news.netfront.net1.0 KB0.0 KB54.7 MB54.7 MB 0%280.1 KB
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
13news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 1346.5 MB1.7 KB59.4 MB106.0 MB 43%8.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 15 00:01:02 - 00:59:59 279 2.4% 0.081.7 MB 3.6% 0.49
Nov 15 01:00:00 - 01:59:59 314 2.7% 0.091.6 MB 3.3% 0.44
Nov 15 02:00:00 - 02:59:59 454 3.9% 0.131.4 MB 3.0% 0.40
Nov 15 03:00:00 - 03:59:59 513 4.4% 0.141.7 MB 3.6% 0.48
Nov 15 04:00:00 - 04:59:59 592 5.1% 0.161.9 MB 4.2% 0.55
Nov 15 05:00:00 - 05:59:59 621 5.3% 0.173.3 MB 7.0% 0.93
Nov 15 06:00:00 - 06:59:59 486 4.2% 0.141.4 MB 2.9% 0.39
Nov 15 07:00:00 - 07:59:59 556 4.8% 0.152.0 MB 4.4% 0.58
Nov 15 08:00:00 - 08:59:59 725 6.2% 0.202.1 MB 4.5% 0.59
Nov 15 09:00:00 - 09:59:59 693 5.9% 0.193.7 MB 8.0% 1.06
Nov 15 10:00:00 - 10:59:59 712 6.1% 0.202.8 MB 6.0% 0.79
Nov 15 11:00:00 - 11:59:59 749 6.4% 0.212.5 MB 5.3% 0.71
Nov 15 12:00:00 - 12:59:59 700 6.0% 0.192.3 MB 4.9% 0.64
Nov 15 13:00:00 - 13:59:59 663 5.7% 0.181.9 MB 4.0% 0.53
Nov 15 14:00:00 - 14:59:59 633 5.4% 0.182.2 MB 4.7% 0.62
Nov 15 15:00:00 - 15:59:59 617 5.3% 0.174.0 MB 8.6% 1.13
Nov 15 16:00:00 - 16:59:59 521 4.5% 0.142.3 MB 5.0% 0.66
Nov 15 17:00:00 - 17:59:59 397 3.4% 0.111.5 MB 3.2% 0.42
Nov 15 18:00:00 - 18:59:59 267 2.3% 0.07882.0 KB 1.9% 0.25
Nov 15 19:00:00 - 19:59:59 288 2.5% 0.081.0 MB 2.2% 0.29
Nov 15 20:00:00 - 20:59:59 220 1.9% 0.062.4 MB 5.1% 0.67
Nov 15 21:00:00 - 21:59:59 231 2.0% 0.06728.6 KB 1.5% 0.20
Nov 15 22:00:00 - 22:59:59 173 1.5% 0.05674.1 KB 1.4% 0.19
Nov 15 23:00:00 - 23:59:59 256 2.2% 0.07761.6 KB 1.6% 0.21
Nov 16 00:00:00 - 00:01:01 11 0.1% 0.1852.3 KB 0.1% 0.86
TOTAL: 23:59:59 11671 100.0% 0.1446.4 MB 100.0% 0.55
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1endofthelinebbs-out.news.weretis.net 685 0 0 0 0 0 0 0 685
2outgoing.news.lysator.liu.se 500 0 0 0 0 0 0 0 500
3usenet.blueworldhosting.com 460 5 0 0 2 0 0 0 453
4news.netfront.net 330 0 0 0 0 0 0 0 330
5peer.alt119.net 136 0 0 0 0 0 0 0 136
6newsfeed.xs3.de 18 0 0 0 0 0 0 0 18
7news.samoylyk.net 4 0 0 0 0 0 0 0 4
8news.furie.org.uk 2 0 0 0 0 0 0 0 2
9glockenspiel.complete.org 1 0 0 1 0 0 0 0 0
TOTAL: 9 2136 5 0 1 2 0 0 0 2128

Unwanted newsgroups [Top 20]:

NewsgroupCount
rocksolid.feeds.news 4
gun.general 1
TOTAL: 2 5

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
uk.religion.jewish 1
soc.culture.indian.goa 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 688
EMP (md5) 574
Binary: misplaced binary 164
EMP (phl) 162
Too many newsgroups 108
EMP (phn nph) 83
Scoring filter 12
HTML Multipart 2
Too many newsgroups (low_xpost) 1
TOTAL: 9 1794

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 296
newsfeed.xs3.de 14
usenet.blueworldhosting.com 14
peer.alt119.net 6
outgoing.news.lysator.liu.se 2
news.furie.org.uk 1
news.samoylyk.net 1
TOTAL: 7 334
TOTAL: 1 334

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 15557 5309 6309 0 0 18 34%23:50:01
2nyheter.lysator.liu.se 11815 3103 8286 20 0 0 26%23:49:00
3peer.alt119.net 11103 1816 8675 26 0 2463 16%23:59:56
4news.nk.ca 15444 111 11480 45 0 18 0%23:59:56
5news.furie.org.uk 8877 70 6073 5 0 196 0%23:57:22
6news.bbs.nz 22924 32 11560 69 0 116 0%23:59:55
7news.quux.org 11961 20 11494 128 0 0 0%23:58:49
8news.tnetconsulting.net 13331 17 11596 6 0 39 0%23:50:02
9usenet.blueworldhosting.com 8237 3 7904 0 0 0 0%23:50:02
10news.weretis.net 11706 0 11668 0 0 0 0%23:59:50
11news.samoylyk.net 14835 0 11581 0 0 0 0%23:50:02
12newsfeed.xs3.de 14380 0 11285 0 0 0 0%23:59:40
TOTAL: 12 160170 10481 117911 299 0 2850 6%287:04:35
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net22.6 MB0.0 KB22.6 MB0.3 KB/s4.4 KB23:50:01
2nyheter.lysator.liu.se15.9 MB122.5 KB16.0 MB0.2 KB/s5.3 KB23:49:00
3peer.alt119.net6.9 MB88.2 KB7.0 MB0.1 KB/s3.9 KB23:59:56
4news.furie.org.uk4.7 MB36.7 KB4.8 MB0.1 KB/s65.0 KB23:57:22
5news.nk.ca407.6 KB229.3 KB636.9 KB0.0 KB/s4.1 KB23:59:56
6news.bbs.nz152.2 KB358.1 KB510.3 KB0.0 KB/s5.1 KB23:59:55
7news.quux.org89.3 KB446.8 KB536.1 KB0.0 KB/s3.6 KB23:58:49
8news.tnetconsulting.net49.1 KB16.0 KB65.1 KB0.0 KB/s2.8 KB23:50:02
9usenet.blueworldhosting.com5.5 KB0.0 KB5.5 KB0.0 KB/s1.8 KB23:50:02
10news.weretis.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
11news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:02
12newsfeed.xs3.de0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:40
TOTAL: 1250.9 MB1.3 MB52.1 MB0.1 KB/s5.0 KB287:04:35
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.census.shodan.io 1 00.0 KB 0 0 000:00:00
2unresolved 1 00.0 KB 1 0 000:00:09
TOTAL: 2 2 00.0 KB 1 0 000:00:10

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
192.241.195.28 0.068 0.029 0.00000:00:09
sky.census.shodan.io 0.146 0.039 0.00000:00:00
TOTAL: 2 0.214 0.068 0.00000:00:10

Curious NNRP server explorers [Top 20]:

SystemConn
sky.census.shodan.io 1
192.241.195.28 1
TOTAL: 2 2

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