Daily Usenet report

Nov 19 00:01:01 -- Nov 20 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 19 00:52:40 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 210302 88.0%43.9 MB 92.2%
innd 21918 9.2%2.7 MB 5.7%
innfeed 6496 2.7%1.0 MB 2.1%
nnrpd 195 0.1%22.0 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 238912 100.0%47.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 730937 62.0%
Negative hits 379449 32.2%
Do not exist 65531 5.6%
Cache misses 2693 0.2%
TOTAL: 4 1178610 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:43.661 0.1%164496 0.156 0.265 1.050
article cleanup00:00:01.246 0.0%65363 0.003 0.019 0.051
article logging00:00:03.296 0.0%65380 0.021 0.050 0.118
article parse00:00:09.603 0.0%389738 0.003 0.025 0.032
article write00:00:52.265 0.1%49169 0.735 1.063 2.619
artlog/artcncl00:00:02.080 0.0%145141 0.006 0.014 0.031
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:06.490 0.0%1532235 0.001 0.004 0.051
hisgrep/artcncl00:00:10.605 0.0%164502 0.022 0.064 0.542
hishave/artcncl00:00:00.663 0.0%164467 0.000 0.004 0.047
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:41.887 0.0%1018538 0.011 0.041 0.118
history sync00:00:00.076 0.0%309 0.000 0.246 4.500
history write00:00:41.911 0.0%65356 0.243 0.641 2.209
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:40:57.350 98.7%1404457 21.345 60.705 175.591
nntp read00:01:09.968 0.1%1442036 0.025 0.049 0.108
overview write00:01:12.482 0.1%49169 0.475 1.474 39.210
perl filter00:06:42.788 0.5%65356 2.630 6.163 13.006
python filter00:00:09.268 0.0%65356 0.094 0.142 0.262
site send00:00:23.520 0.0%99722 0.115 0.236 0.505
TOTAL: 24:00:22.67523:54:09.159 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.450 0.0%107537 0.000 0.004 0.035
article prepare00:00:00.090 0.0%515958 0.000 0.000 0.002
article read00:00:17.865 0.0%49929 0.216 0.358 0.551
backlog stats00:00:03.697 0.0%1605039 0.001 0.002 0.004
callbacks00:00:00.000 0.0%5 0.000 0.000 0.000
data read00:00:37.432 0.0%1216908 0.020 0.031 0.043
data write00:02:57.372 0.2%1106719 0.133 0.160 0.241
idle23:56:20.883 99.7%1605039 31.210 53.694 113.729
status file00:00:02.059 0.0%1868 0.556 1.102 2.000
TOTAL: 24:01:20.09924:00:19.848 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:35.445 60.6%65 14.500 545.308 5365.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.021 0.0%223 0.000 0.094 2.667
TOTAL: 00:00:58.46200:00:35.466 60.7%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 17 82699 21128 59470 2101 25%50:20:03
2usenet.blueworldhosting.com 288 32191 9844 17209 5138 30%23:44:50
3paganini.bofh.team 3 59327 4170 52312 2845 7%24:00:56
4usenet.network 4 41314 2725 38343 246 6%24:46:25
5usenet.goja.nl.eu.org 16 62419 2650 59088 681 4%26:44:37
6news.nntp4.net 3 43467 2170 41143 154 4%24:01:48
7news.hispagatos.org 5 22232 2132 20095 5 9%24:26:22
8newsfeed.xs3.de 3 40965 1646 39262 57 4%22:53:10
9endofthelinebbs.peers.news.panix.com 35 48454 925 47473 56 1%25:46:02
10endoftheline-out.news.chmurka.net 2 13402 493 12897 12 3%23:59:54
11i2pn.org 2 10598 308 10289 1 2%23:59:29
12nntp.comgw.net 4 56779 290 56129 360 0%24:12:00
13glockenspiel.complete.org 4 36684 223 36406 55 0%17:50:17
14194.87.241.33 40 398 204 81 113 51%20:28:43
15news.netfront.net 39 7897 92 3448 4357 1%95:15:31
16news.bbs.nz 3 46223 21 46201 1 0%24:08:32
17news.furie.org.uk 2 4606 8 4598 0 0%23:59:55
18news.samoylyk.net 2 8521 6 8515 0 0%23:57:41
19outgoing.news.lysator.liu.se 1 7350 5 7343 2 0%23:59:57
20eotl-out.news.tnetconsulting.net 2 0 0 0 0 0%00:29:48
21news.nk.ca 2 0 0 0 0 0%00:20:00
22localhost 26 0 0 0 0 0%00:00:00
TOTAL: 22 503 625526 49040 560302 16184 7%549:26:00
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net216.0 MB0.0 KB4.8 MB220.8 MB 97%9.7 KB
2usenet.blueworldhosting.com64.5 MB0.0 KB24.5 MB89.0 MB 72%6.1 KB
3paganini.bofh.team32.4 MB0.0 KB23.2 MB55.5 MB 58%8.1 KB
4usenet.network27.6 MB97.1 KB2.5 MB30.2 MB 91%10.4 KB
5news.nntp4.net23.9 MB0.0 KB2.3 MB26.1 MB 91%11.5 KB
6usenet.goja.nl.eu.org22.2 MB2.2 KB3.6 MB25.7 MB 86%7.9 KB
7newsfeed.xs3.de15.6 MB0.0 KB813.6 KB16.4 MB 95%9.8 KB
8news.hispagatos.org9.3 MB0.0 KB10.7 KB9.3 MB 99%4.5 KB
9endofthelinebbs.peers.news.panix.com5.6 MB0.0 KB244.0 KB5.9 MB 95%6.1 KB
10nntp.comgw.net5.5 MB0.0 KB4.5 MB10.0 MB 55%15.8 KB
11i2pn.org3.8 MB0.0 KB2.2 KB3.8 MB 99%12.4 KB
12endoftheline-out.news.chmurka.net3.5 MB0.0 KB16.1 KB3.5 MB 99%7.1 KB
13glockenspiel.complete.org2.2 MB0.0 KB262.3 KB2.4 MB 89%9.0 KB
14news.netfront.net1.1 MB0.0 KB2.9 GB2.9 GB 0%691.4 KB
15194.87.241.33874.7 KB0.0 KB158.8 KB1.0 MB 84%3.3 KB
16news.bbs.nz866.1 KB0.0 KB93.2 KB959.3 KB 90%43.6 KB
17news.furie.org.uk28.4 KB0.0 KB0.0 KB28.4 KB100%3.6 KB
18news.samoylyk.net13.2 KB0.0 KB0.0 KB13.2 KB100%2.2 KB
19outgoing.news.lysator.liu.se11.3 KB0.0 KB2.4 KB13.7 KB 82%2.0 KB
20eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 22434.9 MB99.3 KB3.0 GB3.4 GB 12%55.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 19 00:01:01 - 00:59:59 2250 4.6% 0.6426.7 MB 6.1% 7.71
Nov 19 01:00:00 - 01:59:59 2553 5.2% 0.7129.5 MB 6.8% 8.38
Nov 19 02:00:00 - 02:59:59 2902 5.9% 0.8127.3 MB 6.3% 7.75
Nov 19 03:00:00 - 03:59:59 3198 6.5% 0.8927.9 MB 6.4% 7.93
Nov 19 04:00:00 - 04:59:59 2700 5.5% 0.7523.9 MB 5.5% 6.79
Nov 19 05:00:00 - 05:59:59 2976 6.1% 0.8328.1 MB 6.5% 8.00
Nov 19 06:00:00 - 06:59:59 2845 5.8% 0.7928.9 MB 6.6% 8.22
Nov 19 07:00:00 - 07:59:59 2449 5.0% 0.6821.8 MB 5.0% 6.19
Nov 19 08:00:00 - 08:59:59 2584 5.3% 0.7224.9 MB 5.7% 7.08
Nov 19 09:00:00 - 09:59:59 1465 3.0% 0.4110.2 MB 2.4% 2.92
Nov 19 10:00:00 - 10:59:59 1699 3.5% 0.4711.8 MB 2.7% 3.35
Nov 19 11:00:00 - 11:59:59 1801 3.7% 0.5011.6 MB 2.7% 3.30
Nov 19 12:00:00 - 12:59:59 1639 3.3% 0.4610.0 MB 2.3% 2.86
Nov 19 13:00:00 - 13:59:59 1425 2.9% 0.409.7 MB 2.2% 2.75
Nov 19 14:00:00 - 14:59:59 1412 2.9% 0.398.2 MB 1.9% 2.33
Nov 19 15:00:00 - 15:59:59 1244 2.5% 0.356.8 MB 1.6% 1.92
Nov 19 16:00:00 - 16:59:59 1486 3.0% 0.419.2 MB 2.1% 2.61
Nov 19 17:00:00 - 17:59:59 1262 2.6% 0.358.3 MB 1.9% 2.35
Nov 19 18:00:00 - 18:59:59 1158 2.4% 0.328.5 MB 2.0% 2.43
Nov 19 19:00:00 - 19:59:59 1193 2.4% 0.3310.8 MB 2.5% 3.07
Nov 19 20:00:00 - 20:59:59 1617 3.3% 0.4514.1 MB 3.2% 4.00
Nov 19 21:00:00 - 21:59:59 1919 3.9% 0.5319.5 MB 4.5% 5.55
Nov 19 22:00:00 - 22:59:59 2591 5.3% 0.7227.9 MB 6.4% 7.93
Nov 19 23:00:00 - 23:59:59 2735 5.6% 0.7629.0 MB 6.7% 8.26
Nov 20 00:00:00 - 00:01:02 56 0.1% 0.90614.4 KB 0.1% 9.91
TOTAL: 24:00:01 49159 100.0% 0.57434.9 MB 100.0% 5.15
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1usenet.blueworldhosting.com 5149 20 0 0 0 0 0 0 5129
2news.netfront.net 4379 0 0 0 0 0 0 0 4379
3paganini.bofh.team 2873 0 0 0 0 0 0 0 2873
4endofthelinebbs-out.news.weretis.net 2105 0 0 0 0 0 0 0 2105
5usenet.goja.nl.eu.org 657 0 0 2 0 0 0 0 655
6nntp.comgw.net 336 0 0 0 0 0 0 0 336
7usenet.network 250 0 0 5 0 0 0 0 245
8news.nntp4.net 156 0 0 0 0 0 0 0 156
9194.87.241.33 112 0 0 0 0 0 0 0 112
10newsfeed.xs3.de 59 0 0 0 0 0 0 0 59
11glockenspiel.complete.org 59 0 0 0 0 0 0 0 59
12endofthelinebbs.peers.news.panix.com 57 12 0 0 0 0 0 0 45
13endoftheline-out.news.chmurka.net 11 0 0 0 0 0 0 0 11
14news.hispagatos.org 7 0 0 0 0 0 0 0 7
15outgoing.news.lysator.liu.se 2 0 0 0 0 0 0 0 2
16news.samoylyk.net 1 0 0 0 0 0 0 0 1
17i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 17 16214 32 0 7 0 0 0 016175

Unwanted newsgroups [Top 20]:

NewsgroupCount
de.sci.announce 32
TOTAL: 1 32

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 5553
Binary: misplaced binary 4393
EMP (phn path) 3626
EMP (phl) 741
EMP (phr path) 345
Too many newsgroups 296
Subject (Buy Xanax) 91
EMP (phn nph) 69
Subject (lSDguKrguKHguLLguIrguL) 41
Subject (Buy Tramadol) 36
Subject (lSDguK3guK3guJnguY) 33
Subject (lSDguY) 25
Subject (lSDguYDguJXguLTguKEgd) 25
hierarchy violation - crosspost outside sdnet 24
Subject (lSDguJfguLjguJkg4LiZ4L) 23
Subject (lSDguJfguJTguKXguK3guIfguYDguKXguYjguJn) 17
Body (https://dmtcartsofficial.com) 17
User-issued cancel 17
Subject (lSDguJ7guKXguLnguJ7guLLguKPguKfguKIg4LiX4Li14L) 16
Subject (lSDguYDguITguKPguJTguL) 12
TOTAL: 456 16158

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 10
news.hispagatos.org 2
endofthelinebbs-out.news.weretis.net 2
endofthelinebbs.peers.news.panix.com 1
usenet.goja.nl.eu.org 1
usenet.network 1
TOTAL: 6 17
TOTAL: 1 17

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 49798 47256 1299 490 0 0 94%23:59:51
2nyheter.lysator.liu.se 49846 41918 6192 1044 0 113 84%23:59:51
3endofthelinebbs.peers.news.panix.com 51397 7476 41623 49 0 0 14%23:59:51
4usenet.network 56723 4884 40977 108 0 0 8%23:59:51
5news.nntp4.net 52981 2654 43167 173 0 1 5%23:59:50
6news.hispagatos.org 57348 1693 43745 1542 0 0 2%23:59:50
7usenet.goja.nl.eu.org 55647 1000 45207 221 0 6 1%23:59:51
8nntp.comgw.net 58479 990 47897 272 0 25 1%23:59:51
9news.quux.org 53154 650 46886 1348 0 0 1%23:59:49
10paganini.bofh.team 59131 424 48732 0 0 0 0%23:59:51
11news.chmurka.net 29622 408 22588 97 0 0 1%23:59:40
12news.nk.ca 66469 338 41927 6831 0 54 0%23:59:51
13news.tnetconsulting.net 64004 166 48415 564 0 19 0%23:59:51
14news.weretis.net 50141 155 47886 1117 0 5 0%23:59:51
15usenet.blueworldhosting.com 41452 141 38214 1 0 1 0%23:59:51
16ddt.demos.su 630 135 494 0 0 1 21%21:47:59
17newsfeed.xs3.de 57208 125 46990 310 0 0 0%23:59:51
18news.furie.org.uk 31039 116 22595 1790 0 0 0%23:59:51
19i2pn.org 62707 116 47333 1180 0 247 0%23:59:51
20news.samoylyk.net 63026 25 48739 389 0 102 0%23:59:51
21news.bbs.nz 63259 0 52996 1 58 54062 0%23:59:51
TOTAL: 211074061 110670 783902 17527 58 54636 10%501:44:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net415.2 MB5.5 MB420.7 MB5.0 KB/s9.0 KB23:59:51
2nyheter.lysator.liu.se401.3 MB7.3 MB408.5 MB4.8 KB/s9.7 KB23:59:51
3endofthelinebbs.peers.news.panix.com83.0 MB472.5 KB83.5 MB1.0 KB/s11.4 KB23:59:51
4usenet.network48.3 MB889.1 KB49.1 MB0.6 KB/s10.1 KB23:59:51
5news.nntp4.net23.6 MB1.7 MB25.2 MB0.3 KB/s9.1 KB23:59:50
6news.hispagatos.org23.3 MB13.4 MB36.7 MB0.4 KB/s11.6 KB23:59:50
7nntp.comgw.net8.4 MB1.5 MB9.9 MB0.1 KB/s8.0 KB23:59:51
8news.quux.org6.1 MB5.6 MB11.7 MB0.1 KB/s6.0 KB23:59:49
9news.chmurka.net5.8 MB981.4 KB6.7 MB0.1 KB/s13.7 KB23:59:40
10usenet.goja.nl.eu.org4.7 MB719.5 KB5.4 MB0.1 KB/s4.5 KB23:59:51
11paganini.bofh.team2.3 MB0.0 KB2.3 MB0.0 KB/s5.5 KB23:59:51
12newsfeed.xs3.de1.0 MB1.3 MB2.4 MB0.0 KB/s5.5 KB23:59:51
13news.weretis.net1005.1 KB8.1 MB9.1 MB0.1 KB/s7.3 KB23:59:51
14news.nk.ca960.1 KB45.8 MB46.8 MB0.6 KB/s6.7 KB23:59:51
15news.tnetconsulting.net867.7 KB3.3 MB4.1 MB0.0 KB/s5.8 KB23:59:51
16news.furie.org.uk731.0 KB19.4 MB20.2 MB0.2 KB/s10.8 KB23:59:51
17i2pn.org433.8 KB8.4 MB8.8 MB0.1 KB/s6.9 KB23:59:51
18ddt.demos.su330.0 KB0.0 KB330.0 KB0.0 KB/s2.4 KB21:47:59
19usenet.blueworldhosting.com265.1 KB5.8 KB270.9 KB0.0 KB/s1.9 KB23:59:51
20news.samoylyk.net129.6 KB1.7 MB1.8 MB0.0 KB/s4.5 KB23:59:51
21news.bbs.nz0.0 KB1.3 KB1.3 KB0.0 KB/s1.3 KB23:59:51
TOTAL: 211.0 GB125.9 MB1.1 GB0.7 KB/s9.2 KB501:44:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1172-104-4-17.ip.linodeusercontent.com 53 00.0 KB 0 0 000:00:54
2147.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3buoyant.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
4198.20.101.106 3 00.0 KB 0 0 000:00:00
TOTAL: 4 58 00.0 KB 0 0 000:00:57

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ip.linodeusercontent.com 53 00.0 KB 0 0 000:00:54
2unresolved 3 00.0 KB 0 0 000:00:00
3*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
4*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 4 58 00.0 KB 0 0 000:00:57

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
172-104-4-17.ip.linodeusercontent.com 6.518 2.501 0.00000:00:54
buoyant.monitoring.internet-measurement.com 0.090 0.080 0.00000:00:01
198.20.101.106 0.403 0.173 0.00000:00:00
147.149.216.162.bc.googleusercontent.com 0.094 0.043 0.00000:00:00
TOTAL: 4 7.105 2.797 0.00000:00:57

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

SystemConn
198.20.101.106 8
147.149.216.162.bc.googleusercontent.com 3
TOTAL: 2 11

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

CommandCount
GET / HTTP/1.1 2
Host: 192.138.210.162:119 2
User-Agent: Expanse, a Palo Alto Network... 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Accept-Encoding: gzip 1
–1&¶€û7 1
#023#003#023#001#023#002#001 1
Accept: */* 1
#026#003#001 1
TOTAL: 9 11

NNRP client timeouts [Top 20]:

SystemConnPeer
172-104-4-17.ip.linodeusercontent.com 1 3
TOTAL: 1 1 3