Daily Usenet report

Dec 26 00:01:01 -- Dec 27 00:01:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 26 00:51:01 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 143876 86.8%32.6 MB 91.6%
innd 16538 10.0%2.1 MB 5.9%
innfeed 4054 2.4%770.8 KB 2.1%
nnrpd 1249 0.8%132.8 KB 0.4%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 5 165718 100.0%35.6 MB100.0%

History cache:

ReasonCount%Count
Positive hits 543002 62.7%
Negative hits 270836 31.3%
Do not exist 50112 5.8%
Cache misses 2375 0.3%
TOTAL: 4 866325 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:38.281 0.0%101209 0.208 0.378 3.389
article cleanup00:00:00.884 0.0%50647 0.000 0.017 0.050
article logging00:00:02.483 0.0%50759 0.019 0.049 0.083
article parse00:00:03.722 0.0%204109 0.004 0.018 0.030
article write00:00:48.681 0.1%42542 0.833 1.144 2.371
artlog/artcncl00:00:01.322 0.0%92921 0.002 0.014 0.036
artlog/artparse00:00:00.000 0.0%1 0.000 0.000 0.000
data move00:00:02.043 0.0%1031089 0.001 0.002 0.007
hisgrep/artcncl00:00:07.309 0.0%101337 0.021 0.072 1.213
hishave/artcncl00:00:00.584 0.0%100940 0.000 0.006 0.059
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:30.208 0.0%776133 0.013 0.039 0.109
history sync00:00:00.084 0.0%340 0.000 0.247 1.000
history write00:00:29.773 0.0%50606 0.248 0.588 1.901
hiswrite/artcncl00:00:00.012 0.0%42 0.000 0.286 1.000
idle23:43:31.793 98.8%961831 32.031 88.801 131.990
nntp read00:00:38.691 0.0%977396 0.023 0.040 0.099
overview write00:01:02.187 0.1%42542 0.629 1.462 28.125
perl filter00:07:27.898 0.5%50605 4.507 8.851 28.271
python filter00:00:05.714 0.0%50605 0.073 0.113 0.191
site send00:00:16.982 0.0%86491 0.095 0.196 0.353
TOTAL: 24:00:34.38723:55:48.651 99.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.398 0.0%56993 0.000 0.007 0.051
article prepare00:00:00.095 0.0%547644 0.000 0.000 0.001
article read00:00:16.737 0.0%42336 0.230 0.395 1.930
backlog stats00:00:03.203 0.0%1471052 0.001 0.002 0.004
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:33.171 0.0%1093030 0.024 0.030 0.208
data write00:02:35.025 0.2%999677 0.127 0.155 0.259
idle23:47:19.776 99.7%1471052 41.322 58.217 83.850
status file00:00:00.394 0.0%387 0.000 1.018 5.000
TOTAL: 23:51:37.59023:50:48.799 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:11:33.989 89.7%1052 25.000 659.685272169.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.198 0.0%2193 0.000 0.090 1.000
TOTAL: 00:12:53.92200:11:34.187 89.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 11 67348 18227 47319 1802 27%48:54:53
2usenet.blueworldhosting.com 994 29803 6294 22267 1242 21%21:56:22
3newsfeed.xs3.de 2 36817 4473 32087 257 12%25:09:33
42001:41d0:a:280::1 0 29928 3312 26379 237 11%19:04:24
5nntp.comgw.net 4 38490 1977 35877 636 5%24:18:07
6endofthelinebbs.peers.news.panix.com 41 42130 1510 40588 32 3%26:09:45
7news.hispagatos.org 6 15521 1371 14148 2 8%24:26:08
8usenet.goja.nl.eu.org 13 37661 1314 36032 315 3%24:40:12
9usenet.network 2 35797 1255 34438 104 3%28:21:01
10paganini.bofh.team 2 48300 865 47250 185 1%25:07:12
11endoftheline-out.news.chmurka.net 2 15198 633 14384 181 4%23:59:50
12news.nntp4.net 0 6502 565 5902 35 8%03:35:53
13outgoing.news.lysator.liu.se 1 8450 351 8006 93 4%23:59:55
14glockenspiel.complete.org 4 48378 332 48015 31 0%32:21:21
15i2pn.org 1 8711 282 8414 15 3%23:59:53
16194.87.241.33 37 383 212 86 85 55%14:42:15
17news.samoylyk.net 2 7836 34 7798 4 0%23:59:29
18news.furie.org.uk 2 20138 15 20123 0 0%23:59:47
19news.netfront.net 39 2954 13 124 2817 0%17:58:52
20news.bbs.nz 1 10050 2 10048 0 0%15:51:34
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
22news.nk.ca 2 0 0 0 0 0%00:20:00
23localhost 26 0 0 0 0 0%00:00:00
TOTAL: 23 1193 510395 43037 459285 8073 8%473:06:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net149.2 MB15.2 KB3.0 MB152.2 MB 98%7.8 KB
22001:41d0:a:280::145.6 MB0.0 KB2.4 MB48.0 MB 94%13.9 KB
3newsfeed.xs3.de45.5 MB46.0 KB2.5 MB48.0 MB 94%10.4 KB
4usenet.blueworldhosting.com41.5 MB0.0 KB2.8 MB44.2 MB 93%6.0 KB
5paganini.bofh.team10.2 MB66.8 KB1.5 MB11.8 MB 86%11.5 KB
6endofthelinebbs.peers.news.panix.com10.0 MB9.3 KB181.5 KB10.2 MB 98%6.8 KB
7nntp.comgw.net9.6 MB1.4 KB2.5 MB12.1 MB 79%4.8 KB
8usenet.goja.nl.eu.org8.4 MB0.0 KB1.0 MB9.5 MB 88%6.0 KB
9usenet.network7.8 MB7.5 KB445.0 KB8.2 MB 94%6.2 KB
10news.nntp4.net6.2 MB0.0 KB305.5 KB6.5 MB 95%11.0 KB
11news.hispagatos.org4.6 MB0.0 KB1.5 KB4.6 MB 99%3.4 KB
12endoftheline-out.news.chmurka.net3.1 MB0.0 KB379.3 KB3.5 MB 89%4.4 KB
13i2pn.org3.0 MB0.0 KB23.4 KB3.0 MB 99%10.5 KB
14glockenspiel.complete.org2.3 MB0.0 KB127.4 KB2.4 MB 94%6.8 KB
15outgoing.news.lysator.liu.se790.9 KB0.0 KB129.3 KB920.2 KB 85%2.1 KB
16194.87.241.33648.0 KB39.1 KB90.3 KB777.4 KB 83%2.6 KB
17news.netfront.net532.1 KB0.0 KB935.6 MB936.1 MB 0%338.7 KB
18news.samoylyk.net106.4 KB0.0 KB8.9 KB115.3 KB 92%3.0 KB
19news.furie.org.uk105.5 KB0.0 KB0.0 KB105.5 KB100%7.0 KB
20news.bbs.nz2.3 KB0.0 KB0.0 KB2.3 KB100%1.2 KB
21eotl-out.news.tnetconsulting.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
22news.nk.ca0.0 KB0.0 KB0.0 KB0.0 KB 0%0
23localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 23349.1 MB185.4 KB953.0 MB1.3 GB 26%26.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 26 00:01:01 - 00:59:59 1911 4.5% 0.5416.0 MB 4.6% 4.62
Dec 26 01:00:00 - 01:59:59 1996 4.7% 0.5516.4 MB 4.7% 4.65
Dec 26 02:00:00 - 02:59:59 1939 4.6% 0.5415.3 MB 4.5% 4.36
Dec 26 03:00:00 - 03:59:59 1670 3.9% 0.4612.9 MB 3.7% 3.66
Dec 26 04:00:00 - 04:59:59 2096 4.9% 0.5814.9 MB 4.3% 4.24
Dec 26 05:00:00 - 05:59:59 1854 4.4% 0.5215.6 MB 4.5% 4.42
Dec 26 06:00:00 - 06:59:59 2437 5.7% 0.6818.1 MB 5.3% 5.15
Dec 26 07:00:00 - 07:59:59 2012 4.7% 0.5615.9 MB 4.6% 4.53
Dec 26 08:00:00 - 08:59:59 1770 4.2% 0.4914.4 MB 4.2% 4.10
Dec 26 09:00:00 - 09:59:59 2003 4.7% 0.5624.2 MB 7.0% 6.87
Dec 26 10:00:00 - 10:59:59 1748 4.1% 0.4913.1 MB 3.8% 3.71
Dec 26 11:00:00 - 11:59:59 1574 3.7% 0.4412.1 MB 3.5% 3.44
Dec 26 12:00:00 - 12:59:59 1612 3.8% 0.4512.1 MB 3.5% 3.45
Dec 26 13:00:00 - 13:59:59 1485 3.5% 0.419.7 MB 2.8% 2.77
Dec 26 14:00:00 - 14:59:59 1690 4.0% 0.4711.5 MB 3.3% 3.27
Dec 26 15:00:00 - 15:59:59 1693 4.0% 0.4712.7 MB 3.7% 3.61
Dec 26 16:00:00 - 16:59:59 1471 3.5% 0.4112.3 MB 3.6% 3.51
Dec 26 17:00:00 - 17:59:59 1457 3.4% 0.4012.1 MB 3.5% 3.45
Dec 26 18:00:00 - 18:59:59 1417 3.3% 0.3911.9 MB 3.5% 3.39
Dec 26 19:00:00 - 19:59:59 1366 3.2% 0.3810.0 MB 2.9% 2.84
Dec 26 20:00:00 - 20:59:59 1579 3.7% 0.4413.6 MB 3.9% 3.86
Dec 26 21:00:00 - 21:59:59 1640 3.9% 0.4614.6 MB 4.3% 4.17
Dec 26 22:00:00 - 22:59:59 1948 4.6% 0.5417.5 MB 5.1% 4.97
Dec 26 23:00:00 - 23:59:59 2133 5.0% 0.5917.3 MB 5.0% 4.92
Dec 27 00:00:00 - 00:01:01 37 0.1% 0.61349.3 KB 0.1% 5.73
TOTAL: 24:00:00 42538 100.0% 0.49344.5 MB 100.0% 4.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 2817 0 0 0 0 0 0 0 2817
2endofthelinebbs-out.news.weretis.net 1945 0 0 2 0 0 0 0 1943
3usenet.blueworldhosting.com 1200 6 0 0 1 0 0 0 1193
4nntp.comgw.net 690 0 0 1 0 0 0 0 689
5usenet.goja.nl.eu.org 340 0 0 0 0 0 0 0 340
6newsfeed.xs3.de 241 0 0 1 0 0 0 0 240
72001:41d0:a:280::1 235 0 0 0 0 0 0 0 235
8endoftheline-out.news.chmurka.net 197 0 0 0 0 0 0 0 197
9paganini.bofh.team 187 0 0 10 0 0 0 0 177
10outgoing.news.lysator.liu.se 94 0 0 0 0 0 0 0 94
11194.87.241.33 85 0 0 25 0 0 0 0 60
12usenet.network 80 0 0 1 0 0 0 0 79
13endofthelinebbs.peers.news.panix.com 68 1 0 2 0 0 0 0 65
14glockenspiel.complete.org 26 0 0 0 0 0 0 0 26
15news.nntp4.net 23 0 0 0 0 0 0 0 23
16i2pn.org 15 0 0 0 0 0 0 0 15
17news.samoylyk.net 4 0 0 0 0 0 0 0 4
18news.hispagatos.org 3 0 0 0 0 0 0 0 3
TOTAL: 18 8250 7 0 42 1 0 0 0 8200

Unwanted newsgroups [Top 20]:

NewsgroupCount
de.sci.announce 5
Newsgroups 1
soc.culture.russia 1
TOTAL: 3 7

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

GroupsCount
bit.listserv.apar-l 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 3067
Binary: misplaced binary 2815
EMP (md5) 657
Too many newsgroups 432
EMP (phr path) 343
Subject (Buy Tramadol) 24
Subject (LSDQvdCwINC60L7QuyE) 24
Subject (Buy Xanax) 10
EMP (phr nph) 9
Subject (LSDguJzguKXguJrguK3guKXguKr) 9
User-issued spam cancel 8
EMP (phl) 8
Subject (lSDguY) 7
Subject (lSDguJfguJTguKXguK3guIfguYDguKXguY) 7
Subject (lSDguYDguITguKPguJTguL) 7
Subject (LSDguYDguKfguY) 6
Subject (lSDguKvguKfguKIg4Lih4Lix4LmI4LiZ4LiE4LiH4LiX4Li) 6
Subject (lSDguYDguKfguYfguJr) 6
Subject (LSDguY) 5
Subject (lSDguJ3guLLguIHguJbguK3guJkgdHJ1ZSB3Y) 5
TOTAL: 515 8087

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.blueworldhosting.com 37
endofthelinebbs.peers.news.panix.com 36
endofthelinebbs-out.news.weretis.net 32
paganini.bofh.team 3
nntp.comgw.net 2
glockenspiel.complete.org 2
TOTAL: 6 112
TOTAL: 1 112

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 42527 42523 0 2 0 26 99%23:59:51
2nyheter.lysator.liu.se 42721 33209 7516 1462 0 49 77%23:59:52
3endofthelinebbs.peers.news.panix.com 43819 10074 32429 28 0 0 22%23:59:45
4usenet.network 50670 8600 31571 678 0 0 16%23:59:52
5news.furie.org.uk 23685 5904 13699 32 0 4 24%23:59:51
6news.quux.org 45554 3432 38016 797 0 0 7%23:59:48
7news.hispagatos.org 48692 2604 35692 2777 0 5 5%23:59:52
8news.nntp4.net 42669 1975 35403 535 0 13 4%23:59:52
9paganini.bofh.team 50766 987 41547 0 0 329 1%23:59:50
10news.bbs.nz 76759 916 38557 3067 0 301 1%23:59:52
11nntp.comgw.net 48901 740 41018 780 0 34 1%23:59:49
12ddt.demos.su 1027 442 582 0 0 0 43%21:05:47
13news.weretis.net 43525 405 40217 1915 0 19 0%23:59:52
14usenet.goja.nl.eu.org 53954 400 40159 653 14 10525 0%23:59:47
15usenet.blueworldhosting.com 36365 376 34139 0 0 3223 1%23:59:52
16news.chmurka.net 23197 314 19578 30 0 5 1%23:59:44
17news.nk.ca 55054 314 36875 5215 0 95 0%23:59:52
18newsfeed.xs3.de 43877 205 37062 786 0 1 0%23:59:52
19i2pn.org 54081 198 39649 2135 0 104 0%23:59:52
20news.tnetconsulting.net 48621 50 39914 2566 0 0 0%23:59:52
21news.samoylyk.net 55129 36 41721 747 0 79 0%23:59:52
TOTAL: 21 931593 113704 645344 24205 14 14812 12%501:02:36
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net344.1 MB2.9 KB344.1 MB4.1 KB/s8.3 KB23:59:51
2nyheter.lysator.liu.se308.5 MB7.6 MB316.1 MB3.7 KB/s9.3 KB23:59:52
3endofthelinebbs.peers.news.panix.com113.2 MB221.6 KB113.4 MB1.3 KB/s11.5 KB23:59:45
4usenet.network80.0 MB3.6 MB83.6 MB1.0 KB/s9.2 KB23:59:52
5news.furie.org.uk63.0 MB310.5 KB63.3 MB0.8 KB/s10.9 KB23:59:51
6news.quux.org35.8 MB3.6 MB39.3 MB0.5 KB/s9.5 KB23:59:48
7news.hispagatos.org29.3 MB18.1 MB47.4 MB0.6 KB/s9.0 KB23:59:52
8news.nntp4.net18.0 MB1.4 MB19.4 MB0.2 KB/s7.9 KB23:59:52
9nntp.comgw.net7.1 MB4.3 MB11.4 MB0.1 KB/s7.7 KB23:59:49
10news.bbs.nz6.2 MB20.4 MB26.6 MB0.3 KB/s6.8 KB23:59:52
11paganini.bofh.team5.6 MB0.0 KB5.6 MB0.1 KB/s5.8 KB23:59:50
12usenet.goja.nl.eu.org3.3 MB3.2 MB6.5 MB0.1 KB/s6.4 KB23:59:47
13news.weretis.net2.8 MB17.3 MB20.1 MB0.2 KB/s8.9 KB23:59:52
14news.chmurka.net2.2 MB887.4 KB3.1 MB0.0 KB/s9.1 KB23:59:44
15newsfeed.xs3.de2.1 MB3.9 MB6.0 MB0.1 KB/s6.2 KB23:59:52
16ddt.demos.su1.1 MB0.0 KB1.1 MB0.0 KB/s2.6 KB21:05:47
17news.nk.ca983.6 KB37.9 MB38.9 MB0.5 KB/s7.2 KB23:59:52
18news.samoylyk.net842.2 KB4.1 MB4.9 MB0.1 KB/s6.4 KB23:59:52
19i2pn.org796.9 KB14.7 MB15.4 MB0.2 KB/s6.8 KB23:59:52
20usenet.blueworldhosting.com752.4 KB0.0 KB752.4 KB0.0 KB/s2.0 KB23:59:52
21news.tnetconsulting.net156.1 KB21.4 MB21.5 MB0.3 KB/s8.4 KB23:59:52
TOTAL: 211.0 GB162.9 MB1.2 GB0.7 KB/s8.8 KB501:02:36
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.47.220 1 00.0 KB 1 0 000:00:00
TOTAL: 1 1 00.0 KB 1 0 000:12:51

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.nntp4.net 327 00.0 KB 0 0 000:12:07
2unresolved 2 00.0 KB 1 0 000:00:00
3*.ip.linodeusercontent.com 65 00.0 KB 0 0 000:00:43
4*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
TOTAL: 4 395 00.0 KB 1 0 000:12:51

NNRP auth users [Top 20]:

UserConn
nelgin 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
news.nntp4.net 34.228 17.028 0.00000:12:07
139-144-52-241.ip.linodeusercontent.com 6.737 1.958 0.00000:00:43
scanner-29.ch1.censys-scanner.com 0.121 0.097 0.00000:00:00
162.243.150.48 0.118 0.048 0.00000:00:00
TOTAL: 4 41.204 19.131 0.00000:12:51

Curious NNRP server explorers [Top 20]:

SystemConn
news.nntp4.net 327
139-144-52-241.ip.linodeusercontent.com 65
scanner-29.ch1.censys-scanner.com 1
162.243.150.48 1
TOTAL: 4 394

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

SystemConn
scanner-29.ch1.censys-scanner.com 1
162.243.150.48 1
TOTAL: 2 2

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

CommandCount
MGLNDD_192.138.210.162_119 1
EHLO www.censys.io 1
TOTAL: 2 2

NNRP client timeouts [Top 20]:

SystemConnPeer
139-144-52-241.ip.linodeusercontent.com 1 1
TOTAL: 1 1 1

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1dfw 1100.0%
TOTAL: 1 1100.0%

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

NewsgroupCount
1dfw.forsale 1
TOTAL: 1 1