Daily Usenet report

Aug 12 00:01:01 -- Aug 13 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Aug 12 00:39:19 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 16507 51.3%5.1 MB 69.1%
innd 11816 36.7%1.5 MB 21.0%
innfeed 3798 11.8%737.4 KB 9.8%
nnrpd 58 0.2%6.0 KB 0.1%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 32180 100.0%7.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 163099 56.3%
Negative hits 110252 38.1%
Do not exist 16335 5.6%
Cache misses 13 0.0%
TOTAL: 4 289699 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:00.138 0.0%47 0.000 2.936 9.000
article cleanup00:00:00.309 0.0%16375 0.000 0.019 0.083
article logging00:00:00.711 0.0%16530 0.000 0.043 0.131
article parse00:00:02.357 0.0%126676 0.000 0.019 0.097
article write00:00:15.405 0.0%11160 0.828 1.380 4.739
artlog/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:00.549 0.0%392056 0.000 0.001 0.005
hisgrep/artcncl00:00:00.040 0.0%52 0.000 0.769 3.333
hishave/artcncl00:00:00.000 0.0%5 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:10.300 0.0%290575 0.012 0.035 0.117
history sync00:00:00.105 0.0%396 0.000 0.265 1.000
history write00:00:10.747 0.0%16376 0.394 0.656 3.571
hiswrite/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:56:58.619 99.7%376259 68.043 229.147 866.727
nntp read00:00:22.538 0.0%382812 0.016 0.059 0.188
overview write00:00:19.687 0.0%11160 0.679 1.764 10.052
perl filter00:00:29.311 0.0%16375 1.199 1.790 5.586
python filter00:00:02.331 0.0%16375 0.068 0.142 0.500
site send00:00:05.159 0.0%22320 0.093 0.231 0.671
TOTAL: 24:00:55.80423:58:58.306 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.130 0.0%11301 0.000 0.012 0.108
article prepare00:00:00.014 0.0%68624 0.000 0.000 0.011
article read00:00:03.543 0.0%11064 0.089 0.320 2.690
backlog stats00:00:00.698 0.0%346139 0.000 0.002 0.007
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:07.179 0.0%261606 0.015 0.027 0.040
data write00:00:32.158 0.0%236494 0.098 0.136 0.294
idle23:56:18.031 99.9%346139 123.855 248.969 575.220
status file00:00:00.313 0.0%334 0.000 0.937 4.000
TOTAL: 23:57:21.77023:57:02.066100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle23:11:25.593100.0%1460 25.500 57181.913 57806.889
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.646 0.0%2980 0.000 0.217 2.750
readart00:00:00.008 0.0%33 0.242 0.242 0.242
TOTAL: 23:11:32.49823:11:26.247100.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 3 22597 3986 17882 729 17%48:30:12
2usenet.blueworldhosting.com 720 13349 2554 10186 609 19%23:46:18
3outgoing.news.lysator.liu.se 3 10912 2113 8509 290 19%24:08:36
4usenet.goja.nl.eu.org 11 12932 727 12146 59 5%23:45:56
5usenet.network 1 9803 297 8974 532 3%23:59:57
6i2pn.org 1 11733 241 11479 13 2%23:59:54
7endofthelinebbs.peers.news.panix.com 23 11094 232 10846 16 2%23:57:31
8paganini.bofh.team 2 13079 207 12836 36 1%23:58:54
9endoftheline-out.news.chmurka.net 2 4610 189 4419 2 4%23:59:53
10194.87.241.33 29 523 173 111 239 33%20:23:38
11newsfeed.xs3.de 2 9786 158 9628 0 1%23:59:48
12glockenspiel.complete.org 2 10365 152 10207 6 1%23:59:38
13nntp.alphanet.ch 26 8857 110 8730 17 1%24:10:03
14news.nntp4.net 1 10273 13 10260 0 0%23:59:55
15news.samoylyk.net 6 10718 7 10711 0 0%23:54:28
16news.bbs.nz 2 11035 3 11032 0 0%23:59:33
17news.furie.org.uk 2 5455 3 5452 0 0%23:59:53
18news.netfront.net 22 4587 0 1818 2769 0%22:57:08
19localhost 25 0 0 0 0 0%00:00:00
20news.nk.ca 2 0 0 0 0 0%00:20:01
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
TOTAL: 21 886 181708 11165 165226 5317 6%452:01:20
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1usenet.blueworldhosting.com22.5 MB0.0 KB2.7 MB25.2 MB 89%8.2 KB
2endofthelinebbs-out.news.weretis.net17.1 MB0.0 KB1.3 MB18.3 MB 93%4.0 KB
3outgoing.news.lysator.liu.se5.5 MB0.0 KB1.1 MB6.6 MB 83%2.8 KB
4usenet.goja.nl.eu.org3.0 MB0.0 KB94.5 KB3.1 MB 96%4.0 KB
5usenet.network2.6 MB0.0 KB1.2 MB3.8 MB 69%4.7 KB
6nntp.alphanet.ch1.7 MB0.0 KB84.3 KB1.8 MB 95%14.6 KB
7i2pn.org1.2 MB0.0 KB72.0 KB1.3 MB 94%5.1 KB
8glockenspiel.complete.org1.1 MB0.0 KB47.4 KB1.2 MB 96%7.7 KB
9endofthelinebbs.peers.news.panix.com1.1 MB0.0 KB29.5 KB1.1 MB 97%4.7 KB
10endoftheline-out.news.chmurka.net623.3 KB0.0 KB1.5 KB624.8 KB 99%3.3 KB
11newsfeed.xs3.de578.9 KB0.0 KB0.0 KB578.9 KB100%3.7 KB
12paganini.bofh.team572.8 KB0.0 KB181.7 KB754.4 KB 75%3.1 KB
13194.87.241.33473.2 KB0.0 KB667.6 KB1.1 MB 41%2.8 KB
14news.nntp4.net38.4 KB0.0 KB0.0 KB38.4 KB100%3.0 KB
15news.furie.org.uk17.3 KB0.0 KB0.0 KB17.3 KB100%5.8 KB
16news.samoylyk.net15.0 KB0.0 KB0.0 KB15.0 KB100%2.1 KB
17news.bbs.nz5.5 KB0.0 KB0.0 KB5.5 KB100%1.8 KB
18news.netfront.net0.0 KB0.0 KB918.2 MB918.2 MB 0%339.6 KB
19localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
20news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 2158.2 MB0.0 KB925.6 MB983.7 MB 5%61.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 12 00:01:01 - 00:59:59 271 2.4% 0.081.1 MB 1.9% 0.31
Aug 12 01:00:00 - 01:59:59 387 3.5% 0.111.7 MB 2.9% 0.48
Aug 12 02:00:00 - 02:59:59 511 4.6% 0.142.1 MB 3.6% 0.59
Aug 12 03:00:00 - 03:59:59 600 5.4% 0.173.1 MB 5.3% 0.87
Aug 12 04:00:00 - 04:59:59 567 5.1% 0.163.5 MB 6.0% 0.99
Aug 12 05:00:00 - 05:59:59 484 4.3% 0.131.9 MB 3.4% 0.55
Aug 12 06:00:00 - 06:59:59 523 4.7% 0.152.7 MB 4.6% 0.76
Aug 12 07:00:00 - 07:59:59 570 5.1% 0.163.0 MB 5.1% 0.85
Aug 12 08:00:00 - 08:59:59 531 4.8% 0.152.3 MB 3.9% 0.64
Aug 12 09:00:00 - 09:59:59 650 5.8% 0.182.4 MB 4.1% 0.68
Aug 12 10:00:00 - 10:59:59 631 5.7% 0.184.0 MB 6.8% 1.13
Aug 12 11:00:00 - 11:59:59 592 5.3% 0.162.9 MB 5.0% 0.82
Aug 12 12:00:00 - 12:59:59 629 5.6% 0.172.4 MB 4.2% 0.69
Aug 12 13:00:00 - 13:59:59 472 4.2% 0.132.2 MB 3.8% 0.62
Aug 12 14:00:00 - 14:59:59 480 4.3% 0.133.3 MB 5.7% 0.94
Aug 12 15:00:00 - 15:59:59 503 4.5% 0.141.7 MB 3.0% 0.49
Aug 12 16:00:00 - 16:59:59 460 4.1% 0.132.5 MB 4.3% 0.72
Aug 12 17:00:00 - 17:59:59 523 4.7% 0.152.6 MB 4.5% 0.74
Aug 12 18:00:00 - 18:59:59 322 2.9% 0.093.1 MB 5.3% 0.88
Aug 12 19:00:00 - 19:59:59 350 3.1% 0.102.6 MB 4.4% 0.73
Aug 12 20:00:00 - 20:59:59 287 2.6% 0.081.2 MB 2.1% 0.34
Aug 12 21:00:00 - 21:59:59 288 2.6% 0.081.5 MB 2.6% 0.44
Aug 12 22:00:00 - 22:59:59 217 1.9% 0.062.5 MB 4.3% 0.71
Aug 12 23:00:00 - 23:59:59 295 2.6% 0.081.8 MB 3.1% 0.52
Aug 13 00:00:00 - 00:01:01 13 0.1% 0.2172.0 KB 0.1% 1.18
TOTAL: 24:00:00 11156 100.0% 0.1358.1 MB 100.0% 0.69
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 2725 0 0 0 0 0 0 0 2725
2endofthelinebbs-out.news.weretis.net 788 0 0 0 0 0 0 0 788
3usenet.blueworldhosting.com 624 5 0 0 0 0 0 0 619
4usenet.network 528 36 0 0 0 0 0 0 492
5outgoing.news.lysator.liu.se 287 0 0 0 0 0 0 0 287
6194.87.241.33 239 98 0 0 0 0 0 0 141
7usenet.goja.nl.eu.org 66 0 0 0 0 0 0 0 66
8paganini.bofh.team 36 0 0 0 0 0 0 0 36
9nntp.alphanet.ch 16 0 0 0 0 0 0 0 16
10endofthelinebbs.peers.news.panix.com 14 5 0 0 0 0 0 0 9
11i2pn.org 12 0 0 0 0 0 0 0 12
12glockenspiel.complete.org 10 0 0 0 0 0 0 0 10
13endoftheline-out.news.chmurka.net 1 0 0 0 0 0 0 0 1
TOTAL: 13 5346 144 0 0 0 0 0 0 5202

Unwanted newsgroups [Top 20]:

NewsgroupCount
fido7.pushkin.local 40
fido7.ukrnews 29
odessa.news 18
perl.cpan 18
fido7.lorapvt.horo 12
fido7.fidonet.online 7
fido7.f715.techinfo 5
fido7.crimea.robots 3
fido7.downgrade.talks 3
fido7.altyn.local 2
fido7.nodex.tech 1
alt.test.foo 1
fido7.starper.limited 1
fido7.crimea.business 1
fido7.f4441.robots 1
cxrnxvxl.phonkgmail.com 1
alt.entertainment 1
TOTAL: 17 144

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 2717
EMP (phn path) 1062
EMP (md5) 632
EMP (phr path) 322
Too many newsgroups 168
EMP (phn nph) 105
User-issued cancel 26
EMP (phl) 10
HTML Multipart 4
TOTAL: 9 5046

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 130
usenet.blueworldhosting.com 15
usenet.goja.nl.eu.org 3
usenet.network 3
outgoing.news.lysator.liu.se 2
endoftheline-out.news.chmurka.net 1
i2pn.org 1
TOTAL: 7 155
No colon-space in header field
usenet.blueworldhosting.com 1
TOTAL: 1 1
TOTAL: 2 156

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 11268 11058 90 29 0 3 98%24:03:12
2nyheter.lysator.liu.se 9581 2129 6267 643 0 0 22%24:03:17
3endofthelinebbs.peers.news.panix.com 11393 371 10745 35 0 0 3%23:59:51
4paganini.bofh.team 12973 288 10836 0 0 1 2%23:54:29
5news.nk.ca 17004 251 10624 261 0 9 1%23:59:52
6news.chmurka.net 5435 93 4161 3 0 0 1%23:57:52
7usenet.blueworldhosting.com 7965 90 7585 1 0 0 1%23:59:52
8ddt.demos.su 407 85 305 14 0 2 20%19:02:14
9news.bbs.nz 21884 85 10911 158 0 85 0%23:59:52
10news.furie.org.uk 7353 81 5187 51 0 0 1%24:08:38
11news.tnetconsulting.net 11698 73 10952 147 0 0 0%24:03:06
12usenet.network 13130 62 10350 3 0 0 0%24:05:38
13news.quux.org 11507 46 10870 163 0 0 0%23:59:50
14i2pn.org 11090 43 10659 94 0 0 0%24:07:24
15news.weretis.net 11319 29 10993 133 0 0 0%23:59:52
16news.nntp4.net 13160 27 10982 106 0 0 0%24:01:11
17usenet.goja.nl.eu.org 12549 20 10205 127 0 63 0%24:00:00
18alphanet.ch 13950 19 10910 133 0 0 0%24:03:22
19newsfeed.xs3.de 13294 7 10839 148 0 0 0%23:59:37
20news.samoylyk.net 13604 2 11055 92 0 0 0%23:59:52
TOTAL: 20 230564 14859 174526 2341 0 163 6%475:29:01
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net56.9 MB624.3 KB57.5 MB0.7 KB/s5.3 KB24:03:12
2nyheter.lysator.liu.se19.1 MB5.2 MB24.3 MB0.3 KB/s9.0 KB24:03:17
3paganini.bofh.team3.8 MB0.0 KB3.8 MB0.0 KB/s13.5 KB23:54:29
4news.chmurka.net2.5 MB9.1 KB2.5 MB0.0 KB/s26.3 KB23:57:52
5endofthelinebbs.peers.news.panix.com1.4 MB73.3 KB1.5 MB0.0 KB/s3.7 KB23:59:51
6news.nk.ca1.1 MB2.5 MB3.6 MB0.0 KB/s7.2 KB23:59:52
7news.furie.org.uk1.1 MB722.3 KB1.8 MB0.0 KB/s13.7 KB24:08:38
8news.nntp4.net813.1 KB1.5 MB2.3 MB0.0 KB/s17.6 KB24:01:11
9news.bbs.nz625.0 KB825.0 KB1.4 MB0.0 KB/s6.0 KB23:59:52
10news.tnetconsulting.net458.0 KB640.8 KB1.1 MB0.0 KB/s5.0 KB24:03:06
11usenet.network394.7 KB62.3 KB457.0 KB0.0 KB/s7.0 KB24:05:38
12news.quux.org317.8 KB772.7 KB1.1 MB0.0 KB/s5.2 KB23:59:50
13i2pn.org237.2 KB212.7 KB450.0 KB0.0 KB/s3.3 KB24:07:24
14news.weretis.net197.7 KB1.2 MB1.4 MB0.0 KB/s8.9 KB23:59:52
15usenet.blueworldhosting.com175.0 KB5.6 KB180.6 KB0.0 KB/s2.0 KB23:59:52
16ddt.demos.su169.8 KB95.2 KB265.0 KB0.0 KB/s2.7 KB19:02:14
17usenet.goja.nl.eu.org123.3 KB498.5 KB621.8 KB0.0 KB/s4.2 KB24:00:00
18alphanet.ch88.1 KB473.2 KB561.3 KB0.0 KB/s3.7 KB24:03:22
19newsfeed.xs3.de52.1 KB803.5 KB855.5 KB0.0 KB/s5.5 KB23:59:37
20news.samoylyk.net9.9 KB188.4 KB198.3 KB0.0 KB/s2.1 KB23:59:52
TOTAL: 2089.4 MB16.2 MB105.7 MB0.1 KB/s6.3 KB475:29:01
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 6 613.6 KB 1 0 023:11:27
2*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
3*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:02
TOTAL: 4 9 613.6 KB 1 0 023:11:31

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.186.47.220 0.657 0.924 0.00823:11:14
128.14.224.165 0.246 0.121 0.00000:00:11
auspicious.monitoring.internet-measurement.com 0.125 0.031 0.00000:00:02
49.211.203.35.bc.googleusercontent.com 0.061 0.074 0.00000:00:01
92.118.39.242 0.168 0.089 0.00000:00:00
107.170.255.21 0.085 0.040 0.00000:00:00
scanner-08.ch1.censys-scanner.com 0.104 0.055 0.00000:00:00
TOTAL: 7 1.446 1.334 0.00823:11:31

Curious NNRP server explorers [Top 20]:

SystemConn
128.14.224.165 3
92.118.39.242 2
107.170.255.21 1
auspicious.monitoring.internet-measurement.com 1
scanner-08.ch1.censys-scanner.com 1
49.211.203.35.bc.googleusercontent.com 1
TOTAL: 6 9

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

SystemConn
92.118.39.242 10
49.211.203.35.bc.googleusercontent.com 3
128.14.224.165 2
107.170.255.21 1
scanner-08.ch1.censys-scanner.com 1
TOTAL: 5 17

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

CommandCount
Host: 192.138.210.162:119 3
Accept-Encoding: gzip 2
User-Agent: Mozilla/5.0 zgrab/0.x 2
GET / HTTP/1.1 2
Accept: */* 2
#026#003#001#001#011#001 1
MGLNDD_192.138.210.162_119 1
#023#003#023#001#023#002#001 1
GET /doc/xml/version.xml HTTP/1.1 1
User-Agent: Expanse, a Palo Alto Network... 1
EHLO www.censys.io 1
TOTAL: 11 17

NNRP client timeouts [Top 20]:

SystemConnPeer
47.186.47.220 1 0
TOTAL: 1 1 0

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1news.software.nntp 2
TOTAL: 1 2