Daily Usenet report

Nov 16 00:01:02 -- Nov 17 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 16 00:51:33 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 229419 86.5%47.6 MB 91.3%
innd 29223 11.0%3.5 MB 6.7%
innfeed 6493 2.4%1.0 MB 1.9%
nnrpd 73 0.0%6.1 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 265209 100.0%52.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 799765 62.4%
Negative hits 399918 31.2%
Do not exist 77588 6.1%
Cache misses 3638 0.3%
TOTAL: 4 1280909 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:48.256 0.1%176952 0.158 0.273 1.010
article cleanup00:00:01.387 0.0%77586 0.003 0.018 0.036
article logging00:00:03.747 0.0%77614 0.027 0.048 0.097
article parse00:00:17.874 0.0%740381 0.010 0.024 0.032
article write00:01:07.537 0.1%54215 0.859 1.246 2.272
artlog/artcncl00:00:02.102 0.0%151692 0.007 0.014 0.025
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:05.221 0.0%1987484 0.001 0.003 0.027
hisgrep/artcncl00:00:12.230 0.0%176958 0.020 0.069 0.409
hishave/artcncl00:00:00.797 0.0%176884 0.000 0.005 0.095
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:46.298 0.1%1110166 0.014 0.042 0.111
history sync00:00:00.063 0.0%314 0.000 0.201 1.500
history write00:00:47.326 0.1%77585 0.287 0.610 1.928
hiswrite/artcncl00:00:00.002 0.0%3 0.667 0.667 0.667
idle23:38:06.565 98.5%1799581 12.759 47.281 128.885
nntp read00:02:04.719 0.1%1868514 0.024 0.067 0.127
overview write00:00:53.353 0.1%54215 0.515 0.984 4.582
perl filter00:07:43.853 0.5%77585 2.549 5.979 13.273
python filter00:00:10.146 0.0%77585 0.096 0.131 0.221
site send00:00:25.254 0.0%109814 0.100 0.230 0.500
TOTAL: 24:00:25.34923:53:36.730 99.5%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.478 0.0%95721 0.000 0.005 0.019
article prepare00:00:00.090 0.0%565776 0.000 0.000 0.001
article read00:00:19.550 0.0%54192 0.213 0.361 0.496
backlog stats00:00:03.867 0.0%1771875 0.001 0.002 0.004
callbacks00:00:00.000 0.0%12 0.000 0.000 0.000
data read00:00:40.258 0.0%1336167 0.021 0.030 0.038
data write00:03:11.303 0.2%1215318 0.128 0.157 0.228
idle23:46:21.419 99.6%1771875 27.611 48.300 88.113
status file00:00:01.918 0.0%1829 0.615 1.049 1.917
TOTAL: 23:51:39.81723:50:38.883 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle20:12:08.032100.0%1342 40.500 54193.765 54307.649
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.558 0.0%2743 0.200 0.203 0.500
readart00:00:01.510 0.0%4721 0.320 0.320 0.320
TOTAL: 20:12:13.50920:12:10.100100.0%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 11 88054 16258 69799 1997 18%51:37:49
2usenet.blueworldhosting.com 288 35058 10910 18684 5464 31%23:44:56
3usenet.goja.nl.eu.org 12 63538 6194 56233 1111 9%24:09:52
4usenet.network 2 47328 3834 43088 406 8%24:26:57
5newsfeed.xs3.de 3 48767 3819 44726 222 7%23:56:46
6paganini.bofh.team 5 67685 3612 61435 2638 5%24:53:49
7news.nntp4.net 4 48770 3321 45119 330 6%24:09:15
8news.hispagatos.org 7 20783 2376 18396 11 11%24:38:14
9endofthelinebbs.peers.news.panix.com 37 57610 1216 56003 391 2%25:44:14
10news.netfront.net 22 22155 803 13089 8263 3%33:35:07
11endoftheline-out.news.chmurka.net 1 15577 745 14814 18 4%23:59:57
12nntp.comgw.net 4 63399 494 60991 1914 0%24:24:47
13194.87.241.33 32 529 247 109 173 46%20:43:03
14i2pn.org 2 11144 226 10917 1 2%23:59:31
15glockenspiel.complete.org 4 35513 140 35338 35 0%16:20:19
16news.bbs.nz 5 47014 114 46694 206 0%24:50:35
17news.samoylyk.net 1 8787 7 8780 0 0%23:59:42
18news.furie.org.uk 2 4850 6 4844 0 0%23:59:53
19outgoing.news.lysator.liu.se 1 8048 3 8044 1 0%23:59:58
20news.nk.ca 2 0 0 0 0 0%00:20:02
21localhost 26 0 0 0 0 0%00:00:01
22eotl-out.news.tnetconsulting.net 19 0 0 0 0 0%01:07:47
TOTAL: 22 490 694609 54325 617103 23181 7%488:42:34
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net139.9 MB0.0 KB12.4 MB152.4 MB 91%8.5 KB
2usenet.blueworldhosting.com77.7 MB0.0 KB25.4 MB103.0 MB 75%6.4 KB
3usenet.goja.nl.eu.org53.0 MB0.0 KB4.5 MB57.5 MB 92%8.1 KB
4usenet.network40.4 MB0.0 KB4.0 MB44.5 MB 90%10.7 KB
5newsfeed.xs3.de33.7 MB0.0 KB2.0 MB35.7 MB 94%9.0 KB
6news.nntp4.net33.0 MB0.0 KB3.3 MB36.4 MB 90%10.2 KB
7paganini.bofh.team30.5 MB0.0 KB22.9 MB53.4 MB 57%8.7 KB
8news.hispagatos.org9.2 MB0.0 KB12.4 KB9.3 MB 99%4.0 KB
9news.netfront.net8.6 MB0.0 KB5.1 GB5.1 GB 0%587.2 KB
10nntp.comgw.net8.2 MB0.0 KB518.4 MB526.6 MB 1%223.9 KB
11endofthelinebbs.peers.news.panix.com7.5 MB0.0 KB950.7 KB8.4 MB 88%5.3 KB
12endoftheline-out.news.chmurka.net4.9 MB0.0 KB44.3 KB5.0 MB 99%6.6 KB
13i2pn.org3.1 MB0.0 KB29.4 KB3.1 MB 99%14.2 KB
14glockenspiel.complete.org1.0 MB0.0 KB130.9 KB1.2 MB 88%6.8 KB
15194.87.241.33883.4 KB1.4 KB262.8 KB1.1 MB 76%2.7 KB
16news.bbs.nz662.8 KB0.0 KB2.2 MB2.8 MB 22%9.0 KB
17news.furie.org.uk22.9 KB0.0 KB0.0 KB22.9 KB100%3.8 KB
18news.samoylyk.net15.5 KB0.0 KB0.0 KB15.5 KB100%2.2 KB
19outgoing.news.lysator.liu.se7.8 KB0.0 KB2.1 KB9.9 KB 78%2.5 KB
20news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
21localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 22452.4 MB1.4 KB5.7 GB6.1 GB 7%82.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 16 00:01:02 - 00:59:59 2805 5.2% 0.7930.1 MB 6.7% 8.72
Nov 16 01:00:00 - 01:59:59 2828 5.2% 0.7928.8 MB 6.4% 8.18
Nov 16 02:00:00 - 02:59:59 3003 5.5% 0.8329.1 MB 6.5% 8.29
Nov 16 03:00:00 - 03:59:59 2786 5.1% 0.7727.7 MB 6.2% 7.87
Nov 16 04:00:00 - 04:59:59 2968 5.5% 0.8226.1 MB 5.8% 7.43
Nov 16 05:00:00 - 05:59:59 2595 4.8% 0.7220.7 MB 4.6% 5.89
Nov 16 06:00:00 - 06:59:59 2910 5.4% 0.8124.5 MB 5.5% 6.98
Nov 16 07:00:00 - 07:59:59 2796 5.2% 0.7823.3 MB 5.2% 6.62
Nov 16 08:00:00 - 08:59:59 2745 5.1% 0.7623.0 MB 5.1% 6.53
Nov 16 09:00:00 - 09:59:59 2650 4.9% 0.7421.6 MB 4.8% 6.16
Nov 16 10:00:00 - 10:59:59 2330 4.3% 0.6516.6 MB 3.7% 4.72
Nov 16 11:00:00 - 11:59:59 1906 3.5% 0.5314.1 MB 3.1% 4.01
Nov 16 12:00:00 - 12:59:59 2140 3.9% 0.5913.8 MB 3.1% 3.92
Nov 16 13:00:00 - 13:59:59 1811 3.3% 0.5012.1 MB 2.7% 3.44
Nov 16 14:00:00 - 14:59:59 1651 3.0% 0.469.8 MB 2.2% 2.80
Nov 16 15:00:00 - 15:59:59 1600 3.0% 0.449.1 MB 2.0% 2.59
Nov 16 16:00:00 - 16:59:59 1700 3.1% 0.479.9 MB 2.2% 2.83
Nov 16 17:00:00 - 17:59:59 1436 2.7% 0.409.9 MB 2.2% 2.80
Nov 16 18:00:00 - 18:59:59 1482 2.7% 0.4112.9 MB 2.9% 3.68
Nov 16 19:00:00 - 19:59:59 1614 3.0% 0.4513.8 MB 3.1% 3.92
Nov 16 20:00:00 - 20:59:59 1780 3.3% 0.4913.5 MB 3.0% 3.83
Nov 16 21:00:00 - 21:59:59 2063 3.8% 0.5715.3 MB 3.4% 4.36
Nov 16 22:00:00 - 22:59:59 2319 4.3% 0.6421.2 MB 4.7% 6.04
Nov 16 23:00:00 - 23:59:59 2219 4.1% 0.6221.9 MB 4.9% 6.22
Nov 17 00:00:00 - 00:01:02 43 0.1% 0.69620.1 KB 0.1% 10.00
TOTAL: 24:00:00 54180 100.0% 0.63449.4 MB 100.0% 5.33
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 8565 0 0 0 0 0 0 0 8565
2usenet.blueworldhosting.com 5474 2 0 0 0 0 0 0 5472
3paganini.bofh.team 2582 0 0 0 0 0 0 0 2582
4endofthelinebbs-out.news.weretis.net 2001 0 0 0 0 0 0 0 2001
5nntp.comgw.net 1957 0 0 0 0 0 0 0 1957
6usenet.goja.nl.eu.org 1107 0 0 0 0 0 0 0 1107
7usenet.network 403 0 0 0 0 0 0 0 403
8endofthelinebbs.peers.news.panix.com 394 0 0 0 0 0 0 0 394
9news.nntp4.net 331 0 0 0 0 0 0 0 331
10newsfeed.xs3.de 217 0 0 0 0 0 0 0 217
11news.bbs.nz 206 0 0 0 0 0 0 0 206
12194.87.241.33 173 0 0 1 0 0 0 0 172
13glockenspiel.complete.org 42 0 0 0 0 0 0 0 42
14endoftheline-out.news.chmurka.net 16 0 0 0 0 0 0 0 16
15news.hispagatos.org 13 0 0 0 0 0 0 0 13
16outgoing.news.lysator.liu.se 1 0 0 0 0 0 0 0 1
17i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 17 23483 2 0 1 0 0 0 023480

Unwanted newsgroups [Top 20]:

NewsgroupCount
Newsgroups 2
TOTAL: 1 2

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 7704
EMP (md5) 7270
EMP (phn path) 3965
Too many newsgroups 1761
EMP (phl) 570
EMP (phr path) 341
Subject (lSDguJ3guLLguIE) 88
Subject (Buy Xanax) 87
Subject (lSDguJ3guLI) 77
Subject (lSDguYDguITguKPguJTguL) 63
Subject (lSDguYDguI) 51
User-issued cancel 47
EMP (phn nph) 46
Subject (lSDguKrguKHguLLguIrguL) 42
Subject (lSDwn) 38
Subject (lSDguYDguJXguLTguKEgd) 33
Subject (Buy Tramadol) 32
Subject (lSDguJ/guKPguLUgN) 26
Subject (lSDguJfguLjguJkg4LiZ4L) 26
Subject (lSDguY) 25
TOTAL: 626 23452

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 11
usenet.blueworldhosting.com 11
usenet.network 3
usenet.goja.nl.eu.org 2
news.hispagatos.org 1
TOTAL: 5 28
TOTAL: 1 28

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1nyheter.lysator.liu.se 54903 46158 6640 1378 0 1 84%23:59:54
2news.netfront.net 57851 44679 8457 285 0 104 77%23:59:53
3endofthelinebbs.peers.news.panix.com 56197 11305 42802 64 5 58 20%23:59:55
4usenet.network 60624 5035 44560 121 0 1 8%23:59:54
5news.nntp4.net 57887 2777 46630 363 0 1 4%23:59:54
6news.hispagatos.org 63302 2560 46856 2403 0 0 4%23:59:54
7nntp.comgw.net 63907 1895 51633 652 0 22 2%23:59:51
8usenet.goja.nl.eu.org 59135 1138 46300 444 0 1 1%23:59:54
9paganini.bofh.team 65233 688 53489 0 0 3 1%23:59:55
10news.quux.org 58905 576 51726 1645 0 1 0%23:59:51
11news.chmurka.net 34397 520 26145 106 0 1 1%23:59:55
12news.nk.ca 69683 322 45787 8025 0 107 0%23:59:55
13ddt.demos.su 887 322 560 1 0 0 36%23:13:30
14usenet.blueworldhosting.com 45113 320 41811 10 0 0 0%23:59:55
15news.tnetconsulting.net 68059 216 53183 780 0 0 0%23:59:55
16news.weretis.net 55608 185 52486 1508 0 6 0%23:59:54
17i2pn.org 67322 174 52037 1285 0 261 0%23:59:55
18newsfeed.xs3.de 62995 164 49594 535 0 3 0%23:59:55
19news.furie.org.uk 36182 163 26046 2207 0 112 0%23:59:55
20news.samoylyk.net 70676 15 53570 586 0 33 0%23:59:55
21news.bbs.nz 45487 0 36062 8 137 59246 0%23:59:55
TOTAL: 211154353 119212 836374 22406 142 59961 10%503:11:34
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1nyheter.lysator.liu.se413.5 MB8.1 MB421.6 MB5.0 KB/s9.1 KB23:59:54
2news.netfront.net350.7 MB3.0 MB353.8 MB4.2 KB/s8.1 KB23:59:53
3endofthelinebbs.peers.news.panix.com118.1 MB879.7 KB118.9 MB1.4 KB/s10.7 KB23:59:55
4usenet.network43.3 MB1.2 MB44.4 MB0.5 KB/s8.8 KB23:59:54
5news.hispagatos.org28.7 MB18.6 MB47.3 MB0.6 KB/s9.8 KB23:59:54
6news.nntp4.net27.2 MB2.7 MB29.9 MB0.4 KB/s9.7 KB23:59:54
7nntp.comgw.net20.1 MB3.9 MB23.9 MB0.3 KB/s9.6 KB23:59:51
8usenet.goja.nl.eu.org7.3 MB1.7 MB9.0 MB0.1 KB/s5.9 KB23:59:54
9news.chmurka.net6.7 MB991.7 KB7.6 MB0.1 KB/s12.5 KB23:59:55
10news.quux.org5.6 MB9.0 MB14.6 MB0.2 KB/s6.7 KB23:59:51
11paganini.bofh.team4.2 MB0.0 KB4.2 MB0.0 KB/s6.3 KB23:59:55
12newsfeed.xs3.de2.1 MB2.4 MB4.5 MB0.1 KB/s6.6 KB23:59:55
13news.tnetconsulting.net2.0 MB4.2 MB6.2 MB0.1 KB/s6.4 KB23:59:55
14news.weretis.net1.9 MB11.7 MB13.6 MB0.2 KB/s8.2 KB23:59:54
15news.nk.ca1.0 MB59.2 MB60.2 MB0.7 KB/s7.4 KB23:59:55
16i2pn.org937.3 KB7.8 MB8.7 MB0.1 KB/s6.1 KB23:59:55
17news.furie.org.uk858.2 KB18.0 MB18.8 MB0.2 KB/s8.1 KB23:59:55
18ddt.demos.su569.5 KB2.8 KB572.3 KB0.0 KB/s1.8 KB23:13:30
19usenet.blueworldhosting.com557.2 KB41.1 KB598.4 KB0.0 KB/s1.8 KB23:59:55
20news.samoylyk.net74.2 KB3.6 MB3.7 MB0.0 KB/s6.3 KB23:59:55
21news.bbs.nz0.0 KB8.6 KB8.6 KB0.0 KB/s1.1 KB23:59:55
TOTAL: 211.0 GB157.0 MB1.2 GB0.7 KB/s8.6 KB503:11:34
Outgoing feeds (innfeed) by Volume

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
2*.midsouth.biz.rr.com 1 00.0 KB 0 0 000:00:10
TOTAL: 2 2 831.4 KB 2 0 020:12:12

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.186.47.220 0.784 1.842 0.01120:12:01
rrcs-98-101-117-58.midsouth.biz.rr.com 0.105 0.060 0.00000:00:10
scanner-05.ch1.censys-scanner.com 0.155 0.075 0.00000:00:00
TOTAL: 3 1.044 1.977 0.01120:12:12

Curious NNRP server explorers [Top 20]:

SystemConn
scanner-05.ch1.censys-scanner.com 1
rrcs-98-101-117-58.midsouth.biz.rr.com 1
TOTAL: 2 2

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

SystemConn
scanner-05.ch1.censys-scanner.com 1
TOTAL: 1 1

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

CommandCount
EHLO www.censys.io 1
TOTAL: 1 1

NNRP client timeouts [Top 20]:

SystemConnPeer
47.186.47.220 1 0
TOTAL: 1 1 0

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 1 50.0%
2alt 1 50.0%
TOTAL: 2 2100.0%

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

NewsgroupCount
1news.answers 1
2alt.music.lyrics 1
TOTAL: 2 2