Daily Usenet report

Oct 20 00:01:02 -- Oct 21 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 20 00:45:19 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 103494 65.5%30.5 MB 82.2%
innd 50030 31.7%5.8 MB 15.6%
innfeed 4475 2.8%811.5 KB 2.1%
nnrpd 47 0.0%4.9 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 158047 100.0%37.1 MB100.0%

History cache:

ReasonCount%Count
Positive hits 737393 54.7%
Negative hits 503391 37.3%
Do not exist 101233 7.5%
Cache misses 6849 0.5%
TOTAL: 4 1348866 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.100 0.0%31 0.500 3.226 11.000
article cleanup00:00:01.695 0.0%103499 0.004 0.016 0.039
article logging00:00:04.599 0.0%103514 0.015 0.044 0.081
article parse00:00:39.581 0.0%1794772 0.005 0.022 0.035
article write00:01:01.584 0.1%56659 0.741 1.087 2.758
artlog/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:08.033 0.0%3097689 0.000 0.003 0.022
hisgrep/artcncl00:00:00.016 0.0%34 0.000 0.471 1.000
hishave/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
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:48.296 0.1%1353624 0.010 0.036 0.102
history sync00:00:00.059 0.0%306 0.000 0.193 5.500
history write00:00:54.185 0.1%101190 0.274 0.535 1.867
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:20:32.943 97.2%2713165 9.778 30.972 161.960
nntp read00:04:11.993 0.3%2881776 0.024 0.087 0.136
overview write00:02:42.008 0.2%56659 0.393 2.859 216.607
perl filter00:20:36.190 1.4%101189 4.034 12.217 24.500
python filter00:00:11.728 0.0%101189 0.076 0.116 0.210
site send00:00:28.456 0.0%113318 0.113 0.251 0.862
TOTAL: 24:00:18.06623:52:21.466 99.4%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.535 0.0%59344 0.000 0.009 0.061
article prepare00:00:00.093 0.0%544724 0.000 0.000 0.001
article read00:00:20.117 0.0%54406 0.207 0.370 0.628
backlog stats00:00:03.757 0.0%1678270 0.001 0.002 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:40.173 0.0%1306033 0.021 0.031 0.038
data write00:02:53.731 0.2%1258932 0.115 0.138 0.254
idle23:46:26.200 99.7%1678270 30.462 50.997 118.008
status file00:00:00.537 0.0%547 0.000 0.982 7.000
TOTAL: 23:51:25.04223:50:25.143 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:00.335 14.2%16 17.500 20.938 25.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.007 0.3%57 0.000 0.123 0.500
TOTAL: 00:00:02.36400:00:00.342 14.5%----

Control commands to INND:

CommandNumber
flush 4
flushlogs 2
go 2
logmode 2
lowmark 1
mode 142
name 2
pause 2
paused 2
reload 2
reserve 2
TOTAL: 11 163

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1usenet.network 4 55270 9911 44394 965 17%24:44:44
2endofthelinebbs-out.news.weretis.net 6 51081 9430 39792 1859 18%48:03:28
3usenet.blueworldhosting.com 288 35965 7906 19961 8098 21%23:40:47
4news.nntp4.net 7 54311 7030 46699 582 12%24:50:19
5newsfeed.xs3.de 4 56325 4847 51110 368 8%24:56:16
6nntp.comgw.net 2 74215 3917 67634 2664 5%24:18:44
7outgoing.news.lysator.liu.se 10 59352 3351 41208 14793 5%31:42:32
8paganini.bofh.team 3 75358 3279 70072 2007 4%24:17:09
9news.hispagatos.org 6 10875 2114 8698 63 19%24:25:56
10usenet.goja.nl.eu.org 12 74532 1559 72027 946 2%24:07:54
11glockenspiel.complete.org 5 55080 1107 53833 140 2%23:42:48
12endofthelinebbs.peers.news.panix.com 33 58215 699 57409 107 1%25:29:18
13news.netfront.net 27 39773 692 24998 14083 1%37:15:42
14endoftheline-out.news.chmurka.net 16 40210 542 39629 39 1%26:24:27
15194.87.241.33 33 373 260 68 45 69%16:02:40
16i2pn.org 2 13356 129 13225 2 0%23:59:50
17news.bbs.nz 2 59428 16 59411 1 0%24:08:44
18news.furie.org.uk 1 39329 3 39320 6 0%23:59:56
19news.nk.ca 2 0 0 0 0 0%00:20:00
20eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:03
21localhost 25 0 0 0 0 0%00:00:00
TOTAL: 21 489 853048 56792 749488 46768 6%476:41:17
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.network71.7 MB6.4 KB6.7 MB78.3 MB 91%7.4 KB
2endofthelinebbs-out.news.weretis.net62.0 MB9.6 KB3.5 MB65.5 MB 94%5.9 KB
3usenet.blueworldhosting.com46.1 MB1.4 KB31.6 MB77.8 MB 59%5.0 KB
4news.nntp4.net44.8 MB6.4 KB3.8 MB48.6 MB 92%6.5 KB
5newsfeed.xs3.de33.0 MB6.5 KB2.6 MB35.7 MB 92%7.0 KB
6nntp.comgw.net27.8 MB11.1 KB13.7 MB41.5 MB 66%6.4 KB
7outgoing.news.lysator.liu.se25.4 MB135.1 MB7.7 GB7.9 GB 0%456.5 KB
8paganini.bofh.team19.0 MB32.6 KB10.7 MB29.7 MB 64%5.8 KB
9news.hispagatos.org9.1 MB0.0 KB85.2 KB9.2 MB 99%4.3 KB
10glockenspiel.complete.org7.6 MB6.5 KB814.0 KB8.4 MB 90%6.9 KB
11usenet.goja.nl.eu.org7.0 MB19.6 KB3.2 MB10.2 MB 68%4.2 KB
12news.netfront.net4.9 MB1.3 GB7.1 GB8.4 GB 0%596.4 KB
13i2pn.org3.4 MB0.0 KB1.5 KB3.4 MB 99%26.7 KB
14endoftheline-out.news.chmurka.net3.0 MB6.5 KB198.1 KB3.2 MB 93%5.7 KB
15endofthelinebbs.peers.news.panix.com2.9 MB0.0 KB325.8 KB3.2 MB 89%4.0 KB
16194.87.241.33929.5 KB0.0 KB70.1 KB999.6 KB 92%3.3 KB
17news.bbs.nz58.5 KB6.4 KB0.0 KB65.0 KB 90%3.8 KB
18news.furie.org.uk13.3 KB6.5 KB49.9 KB69.7 KB 19%7.7 KB
19news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 21368.7 MB1.5 GB14.9 GB16.7 GB 2%169.2 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Oct 20 00:01:02 - 00:59:59 2041 3.6% 0.5815.0 MB 4.1% 4.34
Oct 20 01:00:00 - 01:59:59 3018 5.3% 0.8419.9 MB 5.4% 5.67
Oct 20 02:00:00 - 02:59:59 2959 5.2% 0.8221.4 MB 5.8% 6.10
Oct 20 03:00:00 - 03:59:59 2526 4.5% 0.7018.8 MB 5.1% 5.33
Oct 20 04:00:00 - 04:59:59 2710 4.8% 0.7520.5 MB 5.6% 5.82
Oct 20 05:00:00 - 05:59:59 3306 5.8% 0.9220.4 MB 5.6% 5.82
Oct 20 06:00:00 - 06:59:59 2654 4.7% 0.7417.7 MB 4.8% 5.04
Oct 20 07:00:00 - 07:59:59 2237 3.9% 0.6215.3 MB 4.2% 4.34
Oct 20 08:00:00 - 08:59:59 2740 4.8% 0.7616.6 MB 4.5% 4.72
Oct 20 09:00:00 - 09:59:59 3010 5.3% 0.8420.1 MB 5.5% 5.73
Oct 20 10:00:00 - 10:59:59 2513 4.4% 0.7016.0 MB 4.4% 4.54
Oct 20 11:00:00 - 11:59:59 2394 4.2% 0.6713.6 MB 3.7% 3.86
Oct 20 12:00:00 - 12:59:59 2113 3.7% 0.5913.3 MB 3.6% 3.77
Oct 20 13:00:00 - 13:59:59 1466 2.6% 0.418.1 MB 2.2% 2.30
Oct 20 14:00:00 - 14:59:59 2365 4.2% 0.6614.7 MB 4.0% 4.19
Oct 20 15:00:00 - 15:59:59 2587 4.6% 0.7214.8 MB 4.0% 4.22
Oct 20 16:00:00 - 16:59:59 2213 3.9% 0.6113.8 MB 3.8% 3.93
Oct 20 17:00:00 - 17:59:59 2147 3.8% 0.6011.7 MB 3.2% 3.32
Oct 20 18:00:00 - 18:59:59 1923 3.4% 0.5310.9 MB 3.0% 3.11
Oct 20 19:00:00 - 19:59:59 1723 3.0% 0.489.1 MB 2.5% 2.59
Oct 20 20:00:00 - 20:59:59 1411 2.5% 0.3910.0 MB 2.7% 2.85
Oct 20 21:00:00 - 21:59:59 1960 3.5% 0.5413.4 MB 3.6% 3.81
Oct 20 22:00:00 - 22:59:59 2437 4.3% 0.6816.2 MB 4.4% 4.59
Oct 20 23:00:00 - 23:59:59 2160 3.8% 0.6015.4 MB 4.2% 4.37
Oct 21 00:00:00 - 00:01:01 37 0.1% 0.61241.3 KB 0.1% 3.96
TOTAL: 23:59:59 56650 100.0% 0.66367.0 MB 100.0% 4.35
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1outgoing.news.lysator.liu.se 14821 0 0 246 0 0 0 014575
2news.netfront.net 14104 0 0 2048 0 0 0 012056
3usenet.blueworldhosting.com 8105 29 0 1 1 0 0 0 8074
4nntp.comgw.net 2680 0 0 2 0 0 0 0 2678
5paganini.bofh.team 2003 0 0 3 0 0 0 0 2000
6endofthelinebbs-out.news.weretis.net 1864 0 0 1 0 0 0 0 1863
7usenet.network 972 0 0 1 0 0 0 0 971
8usenet.goja.nl.eu.org 947 0 0 2 0 0 0 0 945
9news.nntp4.net 575 0 0 1 0 0 0 0 574
10newsfeed.xs3.de 357 0 0 1 0 0 0 0 356
11glockenspiel.complete.org 151 0 0 1 0 0 0 0 150
12endofthelinebbs.peers.news.panix.com 103 14 0 0 0 0 0 0 89
13news.hispagatos.org 64 0 0 0 0 0 0 0 64
14194.87.241.33 45 0 0 0 0 0 0 0 45
15endoftheline-out.news.chmurka.net 41 0 0 1 0 0 0 0 40
16news.furie.org.uk 6 0 0 1 0 0 0 0 5
17i2pn.org 2 0 0 0 0 0 0 0 2
18news.bbs.nz 1 0 0 1 0 0 0 0 0
TOTAL: 18 46841 43 0 2310 1 0 0 044487

Unwanted newsgroups [Top 20]:

NewsgroupCount
de.sci.announce 41
Newsgroups 1
alt.support.chronic.pain 1
TOTAL: 3 43

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

GroupsCount
uk.religion.christian 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 21256
EMP (md5) 10914
EMP (phn path) 3901
Too many newsgroups 2911
EMP (phr nph) 1705
EMP (phl) 580
EMP (phr path) 288
User-issued cancel 84
Subject (lSDguY) 66
Subject (LSDguY) 58
Subject (LSDguYDguKfguYfguJrguYHguJfguIfguJr) 33
Subject (lSDguKrguKXguY) 33
Subject (LSDguYHguJfguIfguJr) 32
Subject (Buy Xanax) 29
Subject (lSDguKo) 25
Subject (LSDguYDguKXguY) 23
Subject (lSDguYDguITguKPguJTguL) 23
Subject (LSDguYDguKfguY) 21
Subject (lSDguYDguKfguY) 20
Subject (lSDguJ3guLLguIHguJY) 20
TOTAL: 1232 44471

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 8
usenet.blueworldhosting.com 4
news.hispagatos.org 1
outgoing.news.lysator.liu.se 1
paganini.bofh.team 1
TOTAL: 5 15
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 16

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 61120 41470 14182 230 0 9 67%23:59:49
2nyheter.lysator.liu.se 54537 32581 19586 1052 0 49 59%23:59:50
3endofthelinebbs.peers.news.panix.com 57308 30285 26156 195 0 0 52%23:59:50
4news.furie.org.uk 43108 2516 35179 235 0 22 5%23:59:50
5usenet.network 54679 2099 44091 151 0 0 3%23:59:50
6news.nntp4.net 53404 1933 46133 322 0 1 3%23:59:49
7nntp.comgw.net 62540 1922 54129 599 0 0 3%23:59:49
8paganini.bofh.team 63947 1209 55428 1 0 16 1%23:59:49
9news.bbs.nz 106429 1121 54483 1025 0 606 1%23:59:49
10news.quux.org 58043 1073 53275 1107 0 0 1%23:59:49
11usenet.goja.nl.eu.org 62382 972 53581 404 0 59 1%23:59:50
12news.tnetconsulting.net 70377 928 55124 584 0 23 1%23:59:50
13news.chmurka.net 40814 736 35505 113 0 273 1%23:59:50
14news.hispagatos.org 62186 560 51589 2386 0 495 0%23:59:49
15newsfeed.xs3.de 59664 555 50453 525 0 21 0%23:59:47
16i2pn.org 68850 394 53669 2249 0 1045 0%23:59:46
17usenet.blueworldhosting.com 53633 319 47403 88 0 333 0%23:59:48
18ddt.demos.su 804 300 493 6 0 1 37%21:10:31
19news.nk.ca 77738 66 54037 2485 0 69 0%23:59:50
20news.weretis.net 58619 54 54318 2275 0 15 0%23:59:50
21alphanet.ch 0 0 0 0 0 56650 0%23:59:50
22news.samoylyk.net 0 0 0 0 0 56650 0%23:59:50
TOTAL: 221170182 121093 858814 16032 0 116337 10%525:06:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net254.1 MB2.8 MB256.9 MB3.0 KB/s6.3 KB23:59:49
2nyheter.lysator.liu.se210.9 MB6.4 MB217.3 MB2.6 KB/s6.6 KB23:59:50
3endofthelinebbs.peers.news.panix.com207.7 MB1.3 MB209.0 MB2.5 KB/s7.0 KB23:59:50
4news.furie.org.uk21.9 MB2.0 MB23.8 MB0.3 KB/s8.9 KB23:59:50
5nntp.comgw.net13.4 MB4.0 MB17.4 MB0.2 KB/s7.1 KB23:59:49
6usenet.network13.1 MB636.4 KB13.8 MB0.2 KB/s6.3 KB23:59:50
7news.nntp4.net10.9 MB816.7 KB11.7 MB0.1 KB/s5.3 KB23:59:49
8news.bbs.nz8.6 MB5.7 MB14.3 MB0.2 KB/s6.8 KB23:59:49
9news.quux.org8.6 MB5.4 MB13.9 MB0.2 KB/s6.5 KB23:59:49
10paganini.bofh.team6.6 MB4.4 KB6.6 MB0.1 KB/s5.6 KB23:59:49
11news.tnetconsulting.net5.9 MB2.3 MB8.2 MB0.1 KB/s5.6 KB23:59:50
12news.chmurka.net5.6 MB837.4 KB6.4 MB0.1 KB/s7.7 KB23:59:50
13usenet.goja.nl.eu.org5.6 MB1.5 MB7.1 MB0.1 KB/s5.3 KB23:59:50
14newsfeed.xs3.de5.0 MB2.6 MB7.6 MB0.1 KB/s7.2 KB23:59:47
15news.hispagatos.org4.5 MB16.4 MB20.8 MB0.2 KB/s7.2 KB23:59:49
16i2pn.org1.9 MB12.9 MB14.8 MB0.2 KB/s5.7 KB23:59:46
17news.weretis.net1.8 MB14.8 MB16.6 MB0.2 KB/s7.3 KB23:59:50
18news.nk.ca1.7 MB14.0 MB15.6 MB0.2 KB/s6.3 KB23:59:50
19ddt.demos.su985.2 KB31.0 KB1016.2 KB0.0 KB/s3.3 KB21:10:31
20usenet.blueworldhosting.com737.3 KB628.5 KB1.3 MB0.0 KB/s3.4 KB23:59:48
21alphanet.ch0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
22news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:50
TOTAL: 22789.2 MB94.9 MB884.2 MB0.5 KB/s6.6 KB525:06:45
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12607:ff10:c8:594::e 3 00.0 KB 0 0 000:00:01
2scanner-08.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3198.199.106.76 1 00.0 KB 0 0 000:00:00
471.6.134.235 3 00.0 KB 0 0 000:00:00
TOTAL: 4 8 00.0 KB 0 0 000:00:02

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2unresolved 4 00.0 KB 0 0 000:00:00
3? 3 00.0 KB 0 0 000:00:01
TOTAL: 3 8 00.0 KB 0 0 000:00:02

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2607:ff10:c8:594::e 0.281 0.206 0.00000:00:01
71.6.134.235 0.323 0.169 0.00000:00:00
scanner-08.ch1.censys-scanner.com 0.109 0.049 0.00000:00:00
198.199.106.76 0.057 0.073 0.00000:00:00
TOTAL: 4 0.770 0.497 0.00000:00:02

NNRP unrecognized commands (by host) [Top 20]:

SystemConn
71.6.134.235 7
2607:ff10:c8:594::e 7
198.199.106.76 1
scanner-08.ch1.censys-scanner.com 1
TOTAL: 4 16

NNRP unrecognized commands (by command) [Top 20]:

CommandCount
#023#003#023#001#023#002#001 2
GET / HTTP/1.1 2
Accept: */* 2
#026#003#001 2
User-Agent: Mozilla/5.0 (Windows NT 10.0... 2
Accept-Encoding: gzip 2
Host: [2604:880:52:292::1]:119 1
MGLNDD_192.138.210.162_119 1
Host: 192.138.210.162:119 1
EHLO www.censys.io 1
TOTAL: 10 16