Daily Usenet report

Dec 28 00:01:02 -- Dec 29 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 28 00:54:53 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 164808 86.5%36.2 MB 91.4%
innd 21815 11.4%2.7 MB 6.7%
innfeed 3884 2.0%762.3 KB 1.9%
nnrpd 33 0.0%3.6 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 190541 100.0%39.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 593292 61.2%
Negative hits 314374 32.4%
Do not exist 59975 6.2%
Cache misses 2383 0.2%
TOTAL: 4 970024 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:41.045 0.0%115937 0.217 0.354 1.867
article cleanup00:00:01.147 0.0%60130 0.003 0.019 0.056
article logging00:00:02.977 0.0%60165 0.022 0.049 0.099
article parse00:00:08.046 0.0%398092 0.008 0.020 0.029
article write00:00:50.005 0.1%45746 0.823 1.093 2.496
artlog/artcncl00:00:01.647 0.0%104769 0.004 0.016 0.038
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:03.111 0.0%1336107 0.001 0.002 0.006
hisgrep/artcncl00:00:08.508 0.0%115961 0.016 0.073 0.817
hishave/artcncl00:00:00.685 0.0%115732 0.000 0.006 0.083
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:35.466 0.0%858862 0.013 0.041 0.136
history sync00:00:00.091 0.0%327 0.000 0.278 1.500
history write00:00:36.647 0.0%60121 0.302 0.610 2.255
hiswrite/artcncl00:00:00.011 0.0%32 0.000 0.344 1.000
idle23:39:33.922 98.5%1230633 23.354 69.211 124.368
nntp read00:01:06.061 0.1%1256788 0.022 0.053 0.111
overview write00:01:11.381 0.1%45746 0.671 1.560 56.170
perl filter00:09:48.888 0.7%60121 3.243 9.795 16.839
python filter00:00:07.178 0.0%60121 0.076 0.119 0.178
site send00:00:20.795 0.0%92916 0.128 0.224 0.516
TOTAL: 24:00:31.48223:55:17.611 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.367 0.0%51565 0.000 0.007 0.050
article prepare00:00:00.102 0.0%589446 0.000 0.000 0.001
article read00:00:18.446 0.0%45510 0.242 0.405 0.711
backlog stats00:00:03.560 0.0%1572957 0.001 0.002 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:35.818 0.0%1181901 0.023 0.030 0.103
data write00:02:46.262 0.2%1081763 0.127 0.154 0.238
idle23:46:44.852 99.7%1572957 38.975 54.423 83.329
status file00:00:00.313 0.0%320 0.000 0.978 4.000
TOTAL: 23:51:21.52823:50:29.720 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:30:01.997 99.9%11 19.500163817.909900049.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.001 0.0%35 0.000 0.029 0.077
TOTAL: 00:30:03.59000:30:01.998 99.9%----

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 8 64083 13362 48904 1817 20%47:47:36
2usenet.blueworldhosting.com 720 27970 7388 18318 2264 26%23:46:31
3newsfeed.xs3.de 2 39526 7295 31763 468 18%24:22:30
4news.nntp4.net 4 44251 4736 39230 285 10%24:32:42
5paganini.bofh.team 4 50196 2263 47553 380 4%24:00:23
6nntp.comgw.net 5 42525 2194 39851 480 5%24:17:53
7news.hispagatos.org 12 16979 1853 15119 7 10%24:55:17
8usenet.goja.nl.eu.org 12 40403 1744 38198 461 4%22:05:42
9endofthelinebbs.peers.news.panix.com 30 46036 1661 44333 42 3%24:44:48
10usenet.network 2 40554 1221 39297 36 3%27:11:10
11endoftheline-out.news.chmurka.net 4 13105 699 12324 82 5%24:02:45
12i2pn.org 2 9468 312 9149 7 3%23:59:35
13194.87.241.33 34 457 302 128 27 66%18:26:29
14outgoing.news.lysator.liu.se 1 8798 144 8574 80 1%23:59:54
15glockenspiel.complete.org 4 23721 128 23585 8 0%13:29:00
16news.netfront.net 35 8241 24 295 7922 0%22:25:48
17news.furie.org.uk 2 23866 14 23850 2 0%23:59:50
18news.bbs.nz 2 18089 10 18079 0 0%23:59:40
19news.samoylyk.net 1 8839 7 8829 3 0%23:59:47
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
22localhost 26 0 0 0 0 0%00:00:00
TOTAL: 22 913 527107 45357 467379 14371 8%466:37:25
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net122.7 MB7.6 KB3.2 MB125.8 MB 97%8.5 KB
2newsfeed.xs3.de84.3 MB13.0 KB4.6 MB88.9 MB 94%11.7 KB
3news.nntp4.net59.3 MB39.6 KB2.9 MB62.3 MB 95%12.7 KB
4usenet.blueworldhosting.com49.4 MB0.0 KB5.1 MB54.5 MB 90%5.8 KB
5paganini.bofh.team16.7 MB43.8 KB1.9 MB18.6 MB 89%7.2 KB
6nntp.comgw.net14.5 MB0.0 KB1.8 MB16.2 MB 89%6.2 KB
7endofthelinebbs.peers.news.panix.com12.2 MB0.0 KB217.8 KB12.4 MB 98%7.5 KB
8usenet.goja.nl.eu.org10.4 MB7.6 KB906.7 KB11.3 MB 92%5.3 KB
9usenet.network9.4 MB0.0 KB352.0 KB9.7 MB 96%7.9 KB
10news.hispagatos.org6.0 MB7.6 KB13.0 KB6.1 MB 99%3.3 KB
11endoftheline-out.news.chmurka.net3.7 MB0.0 KB125.7 KB3.8 MB 96%5.0 KB
12i2pn.org3.4 MB0.0 KB10.1 KB3.4 MB 99%11.0 KB
13news.netfront.net1.1 MB39.6 KB2.6 GB2.6 GB 0%339.5 KB
14glockenspiel.complete.org1.1 MB0.0 KB61.3 KB1.1 MB 94%8.4 KB
15194.87.241.33905.6 KB0.0 KB45.7 KB951.3 KB 95%2.9 KB
16outgoing.news.lysator.liu.se345.0 KB0.0 KB124.7 KB469.6 KB 73%2.1 KB
17news.furie.org.uk88.5 KB10.1 KB11.8 KB110.4 KB 80%6.9 KB
18news.bbs.nz20.5 KB0.0 KB0.0 KB20.5 KB100%2.1 KB
19news.samoylyk.net14.4 KB0.0 KB7.8 KB22.2 KB 64%2.2 KB
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
22localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 22395.4 MB168.8 KB2.6 GB3.0 GB 12%52.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 28 00:01:02 - 00:59:59 2154 4.7% 0.6121.2 MB 5.3% 6.15
Dec 28 01:00:00 - 01:59:59 2336 5.1% 0.6523.2 MB 5.8% 6.61
Dec 28 02:00:00 - 02:59:59 2181 4.8% 0.6119.2 MB 4.8% 5.46
Dec 28 03:00:00 - 03:59:59 2048 4.5% 0.5717.5 MB 4.4% 4.99
Dec 28 04:00:00 - 04:59:59 2222 4.9% 0.6215.9 MB 4.0% 4.52
Dec 28 05:00:00 - 05:59:59 2243 4.9% 0.6220.7 MB 5.2% 5.88
Dec 28 06:00:00 - 06:59:59 2248 4.9% 0.6220.7 MB 5.2% 5.89
Dec 28 07:00:00 - 07:59:59 2135 4.7% 0.5918.9 MB 4.8% 5.39
Dec 28 08:00:00 - 08:59:59 2094 4.6% 0.5818.3 MB 4.6% 5.19
Dec 28 09:00:00 - 09:59:59 1893 4.1% 0.5315.5 MB 3.9% 4.40
Dec 28 10:00:00 - 10:59:59 1952 4.3% 0.5416.5 MB 4.1% 4.70
Dec 28 11:00:00 - 11:59:59 1850 4.0% 0.5115.0 MB 3.8% 4.27
Dec 28 12:00:00 - 12:59:59 1892 4.1% 0.5314.6 MB 3.7% 4.15
Dec 28 13:00:00 - 13:59:59 1585 3.5% 0.4412.7 MB 3.2% 3.61
Dec 28 14:00:00 - 14:59:59 1654 3.6% 0.4612.6 MB 3.2% 3.59
Dec 28 15:00:00 - 15:59:59 1713 3.7% 0.4814.7 MB 3.7% 4.18
Dec 28 16:00:00 - 16:59:59 1672 3.7% 0.4612.8 MB 3.2% 3.65
Dec 28 17:00:00 - 17:59:59 1788 3.9% 0.5016.4 MB 4.1% 4.68
Dec 28 18:00:00 - 18:59:59 1670 3.7% 0.4614.6 MB 3.7% 4.16
Dec 28 19:00:00 - 19:59:59 1759 3.8% 0.4916.1 MB 4.0% 4.57
Dec 28 20:00:00 - 20:59:59 1450 3.2% 0.4010.9 MB 2.7% 3.11
Dec 28 21:00:00 - 21:59:59 1627 3.6% 0.4514.0 MB 3.5% 3.98
Dec 28 22:00:00 - 22:59:59 1666 3.6% 0.4618.8 MB 4.7% 5.36
Dec 28 23:00:00 - 23:59:59 1852 4.1% 0.5117.7 MB 4.4% 5.03
Dec 29 00:00:00 - 00:01:01 31 0.1% 0.51261.7 KB 0.1% 4.29
TOTAL: 23:59:59 45715 100.0% 0.53398.9 MB 100.0% 4.73
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 7922 0 0 1 0 0 0 0 7921
2usenet.blueworldhosting.com 2276 12 0 0 0 0 0 0 2264
3endofthelinebbs-out.news.weretis.net 1837 0 0 1 0 0 0 0 1836
4nntp.comgw.net 473 0 0 0 0 0 0 0 473
5usenet.goja.nl.eu.org 469 0 0 1 0 0 0 0 468
6newsfeed.xs3.de 463 0 0 1 0 0 0 0 462
7paganini.bofh.team 385 0 0 1 0 0 0 0 384
8news.nntp4.net 285 0 0 1 0 0 0 0 284
9outgoing.news.lysator.liu.se 81 0 0 0 0 0 0 0 81
10endoftheline-out.news.chmurka.net 79 0 0 0 0 0 0 0 79
11endofthelinebbs.peers.news.panix.com 45 3 0 0 0 0 0 0 42
12194.87.241.33 37 0 0 0 0 0 0 0 37
13usenet.network 32 0 0 0 0 0 0 0 32
14glockenspiel.complete.org 18 0 0 0 0 0 0 0 18
15news.hispagatos.org 11 0 0 1 0 0 0 0 10
16i2pn.org 8 0 0 0 0 0 0 0 8
17news.samoylyk.net 3 0 0 0 0 0 0 0 3
18news.furie.org.uk 2 0 0 1 0 0 0 0 1
19news.bbs.nz 1 0 0 1 0 0 0 0 0
TOTAL: 19 14427 15 0 9 0 0 0 014403

Unwanted newsgroups [Top 20]:

NewsgroupCount
de.sci.announce 13
norwaygmail.com 1
ee.arvutid 1
TOTAL: 3 15

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 7909
EMP (phn path) 3885
EMP (md5) 644
Too many newsgroups 529
EMP (phr path) 316
User-issued cancel 27
Subject (LSDguJzguKXguJrguK3guKXguKr) 24
Subject (lSDguKvguKfguKIg4Lih4Lix4LmI4LiZ4LiE4LiH4LiX4Li) 24
Subject (LSDguY) 19
Subject (LSDguYDguKfguYfguJo) 16
Subject (Buy Xanax) 15
Subject (Buy Tramadol) 13
Subject (lSDguY) 11
Subject (LSDguYD) 11
Subject (lSDguYDguITguKPguJTguL) 10
EMP (fsl) 8
Subject (lSDguYDguKfguY) 7
Subject (lSDguJrguLLguITguLLguKPguYjguLIg4Lij4Li54LmA4Lil4L) 7
Subject (LSDguYDguKfguY) 7
Subject (lSDguYD) 6
TOTAL: 659 14368

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 13
endofthelinebbs-out.news.weretis.net 8
endofthelinebbs.peers.news.panix.com 4
usenet.network 3
paganini.bofh.team 2
newsfeed.xs3.de 1
news.hispagatos.org 1
nntp.comgw.net 1
usenet.goja.nl.eu.org 1
i2pn.org 1
TOTAL: 10 35
TOTAL: 1 35

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 45690 45682 0 6 0 9 99%23:59:54
2nyheter.lysator.liu.se 46520 36642 7524 1401 0 5 78%23:59:54
3endofthelinebbs.peers.news.panix.com 47172 15172 30505 27 0 1 32%23:59:50
4usenet.network 54436 7203 36566 351 0 2 13%23:59:54
5news.quux.org 49418 4528 40089 868 0 0 9%23:59:54
6news.hispagatos.org 58623 2121 39708 1976 1 5404 3%23:59:54
7nntp.comgw.net 53244 2070 42856 780 8 167 3%23:59:54
8news.furie.org.uk 26393 1737 20758 7 0 1 6%23:59:54
9news.bbs.nz 80680 1286 40716 3711 0 174 1%23:59:53
10paganini.bofh.team 52779 845 44852 13 0 139 1%23:59:49
11news.nk.ca 59074 822 36368 8454 0 35 1%23:59:54
12news.nntp4.net 46189 817 38986 476 0 1 1%23:59:54
13usenet.goja.nl.eu.org 50136 531 42517 734 0 5 1%23:59:54
14news.weretis.net 46822 409 43181 2124 0 3 0%23:59:52
15usenet.blueworldhosting.com 38389 377 36597 0 0 0 0%23:59:52
16ddt.demos.su 938 373 565 0 0 0 39%23:53:58
17news.chmurka.net 26669 256 22651 35 0 1 0%23:59:54
18i2pn.org 57695 203 43291 1715 0 61 0%23:59:54
19newsfeed.xs3.de 44962 202 37093 692 0 1 0%23:59:52
20news.samoylyk.net 59051 51 45003 651 0 115 0%23:59:54
21news.tnetconsulting.net 51793 48 42780 2876 0 1 0%23:59:54
TOTAL: 21 996673 121375 692606 26897 9 6125 12%503:51:42
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net397.9 MB65.9 KB398.0 MB4.7 KB/s8.9 KB23:59:54
2nyheter.lysator.liu.se365.2 MB6.1 MB371.4 MB4.4 KB/s10.0 KB23:59:54
3endofthelinebbs.peers.news.panix.com172.5 MB285.2 KB172.8 MB2.0 KB/s11.6 KB23:59:50
4usenet.network73.7 MB1.7 MB75.4 MB0.9 KB/s10.2 KB23:59:54
5news.quux.org48.2 MB2.9 MB51.2 MB0.6 KB/s9.7 KB23:59:54
6news.hispagatos.org24.7 MB16.8 MB41.6 MB0.5 KB/s10.4 KB23:59:54
7nntp.comgw.net23.9 MB5.8 MB29.7 MB0.4 KB/s10.7 KB23:59:54
8news.furie.org.uk21.1 MB48.0 KB21.1 MB0.3 KB/s12.4 KB23:59:54
9news.nntp4.net11.4 MB1.3 MB12.7 MB0.2 KB/s10.1 KB23:59:54
10news.bbs.nz8.4 MB27.0 MB35.4 MB0.4 KB/s7.3 KB23:59:53
11paganini.bofh.team6.6 MB161.5 KB6.8 MB0.1 KB/s8.1 KB23:59:49
12usenet.goja.nl.eu.org6.6 MB3.8 MB10.4 MB0.1 KB/s8.4 KB23:59:54
13news.weretis.net2.7 MB20.5 MB23.2 MB0.3 KB/s9.4 KB23:59:52
14newsfeed.xs3.de2.5 MB5.3 MB7.9 MB0.1 KB/s9.0 KB23:59:52
15news.chmurka.net2.3 MB1.3 MB3.6 MB0.0 KB/s12.6 KB23:59:54
16news.samoylyk.net2.0 MB3.9 MB5.9 MB0.1 KB/s8.7 KB23:59:54
17news.nk.ca1.9 MB71.7 MB73.6 MB0.9 KB/s8.1 KB23:59:54
18ddt.demos.su893.3 KB0.0 KB893.3 KB0.0 KB/s2.4 KB23:53:58
19usenet.blueworldhosting.com789.6 KB0.0 KB789.6 KB0.0 KB/s2.1 KB23:59:52
20i2pn.org663.7 KB11.3 MB11.9 MB0.1 KB/s6.4 KB23:59:54
21news.tnetconsulting.net150.2 KB25.0 MB25.1 MB0.3 KB/s8.8 KB23:59:54
TOTAL: 211.1 GB205.0 MB1.3 GB0.8 KB/s9.5 KB503:51:42
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12607:ff10:c8:594::6 3 00.0 KB 0 0 000:00:01
2distinguished.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
3138.68.208.47 1 00.0 KB 0 0 000:00:00
4183.134.104.173 1 00.0 KB 0 0 000:30:00
TOTAL: 4 6 00.0 KB 0 0 000:30:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 3 00.0 KB 0 0 000:00:01
2unresolved 2 00.0 KB 0 0 000:30:00
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 3 6 00.0 KB 0 0 000:30:03

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
183.134.104.173 0.085 0.069 0.00000:30:00
distinguished.monitoring.internet-measurement.com 0.104 0.033 0.00000:00:01
2607:ff10:c8:594::6 0.330 0.166 0.00000:00:01
138.68.208.47 0.102 0.048 0.00000:00:00
TOTAL: 4 0.621 0.316 0.00000:30:03

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

SystemConn
2607:ff10:c8:594::6 7
183.134.104.173 1
138.68.208.47 1
TOTAL: 3 9

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

CommandCount
Accept: */* 1
#023#003#023#001#023#002#001 1
MGLNDD_192.138.210.162_119 1
Accept-Encoding: gzip 1
Host: [2604:880:52:292::1]:119 1
GET / HTTP/1.0 1
GET / HTTP/1.1 1
#026#003#001 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
TOTAL: 9 9

NNRP client timeouts [Top 20]:

SystemConnPeer
183.134.104.173 1 0
TOTAL: 1 1 0