Daily Usenet report

Dec 27 00:01:01 -- Dec 28 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 27 00:52:38 www innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program nameLines%LinesSize%Size
inn 165265 85.0%37.7 MB 90.8%
innd 19632 10.1%2.5 MB 6.0%
innfeed 8334 4.3%1.2 MB 2.9%
nnrpd 1088 0.6%115.9 KB 0.3%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 5 194320 100.0%41.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 589527 61.0%
Negative hits 309258 32.0%
Do not exist 62184 6.4%
Cache misses 5302 0.5%
TOTAL: 4 966271 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:41.393 0.0%112364 0.221 0.368 2.581
article cleanup00:00:01.159 0.0%62701 0.000 0.018 0.048
article logging00:00:02.944 0.0%62728 0.025 0.047 0.095
article parse00:00:06.273 0.0%331726 0.005 0.019 0.029
article write00:00:52.896 0.1%50489 0.574 1.048 3.571
artlog/artcncl00:00:01.519 0.0%102574 0.006 0.015 0.032
artlog/artparse00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:02.751 0.0%1260219 0.000 0.002 0.007
hisgrep/artcncl00:00:09.053 0.0%112347 0.020 0.081 1.255
hishave/artcncl00:00:00.606 0.0%112045 0.000 0.005 0.082
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:34.770 0.0%864864 0.010 0.040 0.132
history sync00:00:00.070 0.0%325 0.000 0.215 1.000
history write00:00:35.610 0.0%62700 0.271 0.568 2.069
hiswrite/artcncl00:00:00.016 0.0%31 0.000 0.516 1.000
idle23:38:21.205 98.5%1157234 25.946 73.538 146.626
nntp read00:00:56.419 0.1%1182259 0.023 0.048 0.105
overview write00:01:54.620 0.1%50489 0.322 2.270 150.678
perl filter00:10:33.603 0.7%62700 2.916 10.105 16.028
python filter00:00:07.378 0.0%62703 0.053 0.118 0.210
site send00:00:19.846 0.0%102393 0.050 0.194 0.434
TOTAL: 24:00:33.61323:55:22.131 99.6%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.490 0.0%79579 0.000 0.006 0.069
article prepare00:00:00.100 0.0%582190 0.000 0.000 0.001
article read00:00:18.636 0.0%49631 0.121 0.375 0.632
backlog stats00:00:03.427 0.0%1578893 0.001 0.002 0.004
callbacks00:00:00.001 0.0%232 0.000 0.004 0.005
data read00:00:37.247 0.0%1209540 0.024 0.031 0.044
data write00:02:41.927 0.2%1136907 0.035 0.142 0.235
idle23:47:07.395 99.7%1578893 12.789 54.233 162.183
status file00:00:02.023 0.0%2235 0.000 0.905 4.000
TOTAL: 23:51:43.57623:50:51.246 99.9%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle22:10:04.653 99.9%2449 25.500 32586.628 51012.876
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.744 0.0%4988 0.000 0.149 2.000
readart00:00:00.036 0.0%113 0.319 0.319 0.319
TOTAL: 22:10:59.33022:10:05.433 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 65745 15187 48383 2175 23%48:27:36
2news.nntp4.net 6 47120 8690 37821 609 18%21:16:48
3usenet.blueworldhosting.com 720 27960 7892 18386 1682 28%23:46:30
4newsfeed.xs3.de 4 38437 7111 30895 431 18%24:04:12
5nntp.comgw.net 3 43937 2700 40561 676 6%24:11:57
6news.hispagatos.org 7 17567 2093 15471 3 11%24:35:07
7paganini.bofh.team 4 47203 1422 45565 216 3%22:49:21
8endofthelinebbs.peers.news.panix.com 32 45366 1315 44026 25 2%24:53:16
9usenet.goja.nl.eu.org 12 46919 1179 45287 453 2%25:44:34
10endoftheline-out.news.chmurka.net 2 15883 692 15054 137 4%23:59:56
11usenet.network 3 30109 584 29512 13 1%19:57:03
12glockenspiel.complete.org 4 36813 358 36430 25 0%20:15:36
13outgoing.news.lysator.liu.se 1 11160 307 10735 118 2%23:59:57
14i2pn.org 2 9897 288 9602 7 2%23:58:46
15194.87.241.33 42 210 141 69 0 67%13:03:52
16news.samoylyk.net 1 10945 30 10906 9 0%23:59:48
17news.netfront.net 38 6052 21 222 5809 0%19:44:20
18news.furie.org.uk 2 23384 8 23376 0 0%23:59:57
19localhost 29 3 3 0 0 100%00:00:00
20news.nk.ca 3 0 0 0 0 0%00:30:01
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
22news.bbs.nz 2 18057 0 18057 0 0%23:59:34
TOTAL: 22 926 542767 50021 480358 12388 9%457:28:15
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net132.5 MB0.0 KB3.6 MB136.0 MB 97%8.0 KB
2news.nntp4.net92.0 MB0.0 KB5.0 MB97.0 MB 94%10.7 KB
3newsfeed.xs3.de79.9 MB0.0 KB4.5 MB84.3 MB 94%11.5 KB
4usenet.blueworldhosting.com51.2 MB0.0 KB4.1 MB55.3 MB 92%5.9 KB
5nntp.comgw.net17.5 MB0.0 KB3.0 MB20.5 MB 85%6.2 KB
6paganini.bofh.team14.0 MB0.0 KB1.5 MB15.4 MB 90%9.6 KB
7endofthelinebbs.peers.news.panix.com8.4 MB0.0 KB92.8 KB8.5 MB 98%6.5 KB
8usenet.goja.nl.eu.org8.2 MB0.0 KB1.3 MB9.5 MB 86%6.0 KB
9news.hispagatos.org6.4 MB0.0 KB2.5 KB6.4 MB 99%3.1 KB
10endoftheline-out.news.chmurka.net3.4 MB0.0 KB271.3 KB3.7 MB 92%4.6 KB
11usenet.network3.2 MB0.0 KB123.3 KB3.3 MB 96%5.7 KB
12i2pn.org3.1 MB0.0 KB12.5 KB3.1 MB 99%10.7 KB
13glockenspiel.complete.org2.7 MB0.0 KB132.3 KB2.8 MB 95%7.5 KB
14194.87.241.33702.3 KB0.0 KB0.0 KB702.3 KB100%5.0 KB
15news.netfront.net696.6 KB0.0 KB1.9 GB1.9 GB 0%338.9 KB
16outgoing.news.lysator.liu.se630.2 KB0.0 KB173.3 KB803.5 KB 78%1.9 KB
17news.samoylyk.net87.6 KB2.9 KB13.6 KB104.2 KB 84%2.7 KB
18news.furie.org.uk38.4 KB0.0 KB0.0 KB38.4 KB100%4.8 KB
19localhost6.6 KB0.0 KB0.0 KB6.6 KB100%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
22news.bbs.nz0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 22424.5 MB2.9 KB1.9 GB2.3 GB 17%39.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 27 00:01:01 - 00:59:59 1971 3.9% 0.5617.1 MB 4.0% 4.93
Dec 27 01:00:00 - 01:59:59 2084 4.1% 0.5818.9 MB 4.4% 5.36
Dec 27 02:00:00 - 02:59:59 7174 14.2% 1.9969.0 MB 16.0% 19.62
Dec 27 03:00:00 - 03:59:59 2132 4.2% 0.5917.9 MB 4.2% 5.08
Dec 27 04:00:00 - 04:59:59 2273 4.5% 0.6318.3 MB 4.3% 5.20
Dec 27 05:00:00 - 05:59:59 2094 4.1% 0.5816.5 MB 3.8% 4.68
Dec 27 06:00:00 - 06:59:59 2201 4.4% 0.6118.9 MB 4.4% 5.37
Dec 27 07:00:00 - 07:59:59 2532 5.0% 0.7022.7 MB 5.3% 6.46
Dec 27 08:00:00 - 08:59:59 2025 4.0% 0.5616.6 MB 3.9% 4.72
Dec 27 09:00:00 - 09:59:59 2075 4.1% 0.5817.6 MB 4.1% 4.99
Dec 27 10:00:00 - 10:59:59 1915 3.8% 0.5314.1 MB 3.3% 4.01
Dec 27 11:00:00 - 11:59:59 1428 2.8% 0.408.5 MB 2.0% 2.42
Dec 27 12:00:00 - 12:59:59 2193 4.3% 0.6117.7 MB 4.1% 5.04
Dec 27 13:00:00 - 13:59:59 1821 3.6% 0.5115.9 MB 3.7% 4.53
Dec 27 14:00:00 - 14:59:59 1663 3.3% 0.4612.6 MB 2.9% 3.60
Dec 27 15:00:00 - 15:59:59 2008 4.0% 0.5618.4 MB 4.3% 5.25
Dec 27 16:00:00 - 16:59:59 1327 2.6% 0.379.4 MB 2.2% 2.67
Dec 27 17:00:00 - 17:59:59 1201 2.4% 0.338.4 MB 2.0% 2.39
Dec 27 18:00:00 - 18:59:59 1708 3.4% 0.4713.1 MB 3.1% 3.74
Dec 27 19:00:00 - 19:59:59 1574 3.1% 0.4413.0 MB 3.0% 3.69
Dec 27 20:00:00 - 20:59:59 1673 3.3% 0.4614.9 MB 3.5% 4.23
Dec 27 21:00:00 - 21:59:59 1635 3.2% 0.4514.4 MB 3.3% 4.08
Dec 27 22:00:00 - 22:59:59 1687 3.3% 0.4716.5 MB 3.8% 4.68
Dec 27 23:00:00 - 23:59:59 2032 4.0% 0.5619.5 MB 4.5% 5.53
Dec 28 00:00:00 - 00:01:02 38 0.1% 0.61316.5 KB 0.1% 5.10
TOTAL: 24:00:01 50464 100.0% 0.58429.9 MB 100.0% 5.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 5809 0 0 0 0 0 0 0 5809
2endofthelinebbs-out.news.weretis.net 2079 0 0 0 0 0 0 0 2079
3usenet.blueworldhosting.com 1690 1 0 0 0 0 0 0 1689
4nntp.comgw.net 637 0 0 0 0 0 0 0 637
5news.nntp4.net 614 0 0 0 0 0 0 0 614
6newsfeed.xs3.de 437 0 0 0 0 0 0 0 437
7usenet.goja.nl.eu.org 404 0 0 0 0 0 0 0 404
8paganini.bofh.team 217 0 0 0 0 0 0 0 217
9endoftheline-out.news.chmurka.net 117 0 0 0 0 0 0 0 117
10outgoing.news.lysator.liu.se 117 0 0 0 0 0 0 0 117
11endofthelinebbs.peers.news.panix.com 23 0 0 0 0 0 0 0 23
12glockenspiel.complete.org 23 0 0 0 0 0 0 0 23
13usenet.network 20 0 0 0 0 0 0 0 20
14news.samoylyk.net 9 0 0 1 0 0 0 0 8
15i2pn.org 7 0 0 0 0 0 0 0 7
16news.hispagatos.org 4 0 0 0 0 0 0 0 4
TOTAL: 16 12207 1 0 1 0 0 0 012205

Unwanted newsgroups [Top 20]:

NewsgroupCount
a.b.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 5798
EMP (phn path) 3215
EMP (md5) 818
Too many newsgroups 764
EMP (phr path) 389
Subject (Buy Xanax) 22
Subject (LSDguY) 21
User-issued cancel 20
Subject (lSDguYDguITguKPguJTguL) 19
Subject (LSDguJzguKXguJrguK3guKXguKr) 18
Subject (Buy Tramadol) 16
Subject (LSDguYDguKfguY) 15
Subject (LSDguYDguKfguYfguJo) 10
EMP (phr nph) 10
Subject (lSDguJfguJTguKXguK3guIfguYDguKXguY) 9
Subject (lSDguKvguKfguKIg4Lih4Lix4LmI4LiZ4LiE4LiH4LiX4Li) 9
Subject (LSDguYD) 9
HTML Multipart 8
Subject (lSDguY) 8
Subject (lSDguYDguKfguY) 7
TOTAL: 735 12178

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
endofthelinebbs-out.news.weretis.net 15
usenet.blueworldhosting.com 7
news.hispagatos.org 2
nntp.comgw.net 2
usenet.goja.nl.eu.org 1
TOTAL: 5 27
TOTAL: 1 27

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 50445 45380 5046 17 0 27 89%23:59:56
2nyheter.lysator.liu.se 50657 36226 12790 1142 0 42 71%23:59:56
3endofthelinebbs.peers.news.panix.com 51726 14399 36024 40 0 0 27%23:59:56
4usenet.network 60131 7449 41468 370 0 0 12%23:59:54
5news.quux.org 53990 4419 45044 595 0 0 8%23:59:56
6news.furie.org.uk 29395 2110 22721 22 0 6 7%23:59:56
7news.hispagatos.org 57072 1811 44573 2015 0 0 3%23:59:55
8news.nk.ca 63004 1472 36997 8717 3183 10224 2%23:59:56
9news.bbs.nz 77237 957 46734 2760 0 16843 1%23:59:55
10news.nntp4.net 46432 904 39151 407 0 10 1%23:59:56
11nntp.comgw.net 57974 890 49040 535 0 44 1%23:59:55
12paganini.bofh.team 58623 676 49780 3 3 491 1%23:59:56
13usenet.goja.nl.eu.org 55979 505 48307 507 1 272 0%23:59:44
14news.weretis.net 51519 383 47864 2216 0 2 0%23:59:56
15i2pn.org 62428 381 47121 2497 0 173 0%23:59:56
16news.chmurka.net 29258 309 25017 71 0 37 1%23:59:56
17usenet.blueworldhosting.com 42186 300 40654 1 0 0 0%23:59:55
18ddt.demos.su 633 293 333 0 0 0 46%21:04:43
19newsfeed.xs3.de 49699 213 42033 593 0 83 0%23:59:55
20news.tnetconsulting.net 56156 68 47672 2721 0 48 0%23:59:45
21news.samoylyk.net 63556 29 49924 483 0 1046 0%23:59:55
TOTAL: 211068100 119174 778293 25712 3187 29348 11%501:02:52
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net380.7 MB122.4 KB380.9 MB4.5 KB/s8.6 KB23:59:56
2nyheter.lysator.liu.se348.3 MB5.6 MB353.9 MB4.2 KB/s9.7 KB23:59:56
3endofthelinebbs.peers.news.panix.com157.9 MB350.4 KB158.2 MB1.9 KB/s11.2 KB23:59:56
4usenet.network73.6 MB1.9 MB75.5 MB0.9 KB/s9.9 KB23:59:54
5news.quux.org43.3 MB2.4 MB45.7 MB0.5 KB/s9.3 KB23:59:56
6news.hispagatos.org21.0 MB15.9 MB36.9 MB0.4 KB/s9.9 KB23:59:55
7news.furie.org.uk21.0 MB161.8 KB21.1 MB0.3 KB/s10.1 KB23:59:56
8news.nntp4.net9.1 MB904.5 KB10.0 MB0.1 KB/s7.8 KB23:59:56
9nntp.comgw.net9.0 MB2.7 MB11.8 MB0.1 KB/s8.4 KB23:59:55
10news.bbs.nz6.8 MB18.0 MB24.8 MB0.3 KB/s6.8 KB23:59:55
11usenet.goja.nl.eu.org5.0 MB2.3 MB7.4 MB0.1 KB/s7.5 KB23:59:44
12paganini.bofh.team4.3 MB23.6 KB4.3 MB0.1 KB/s6.5 KB23:59:56
13news.nk.ca4.2 MB68.2 MB72.4 MB0.9 KB/s7.3 KB23:59:56
14news.weretis.net2.6 MB19.8 MB22.4 MB0.3 KB/s8.8 KB23:59:56
15newsfeed.xs3.de2.3 MB3.2 MB5.5 MB0.1 KB/s7.0 KB23:59:55
16news.chmurka.net2.0 MB1.3 MB3.3 MB0.0 KB/s8.9 KB23:59:56
17i2pn.org1.4 MB18.6 MB20.0 MB0.2 KB/s7.1 KB23:59:56
18usenet.blueworldhosting.com602.3 KB2.4 KB604.7 KB0.0 KB/s2.0 KB23:59:55
19ddt.demos.su587.4 KB0.0 KB587.4 KB0.0 KB/s2.0 KB21:04:43
20news.tnetconsulting.net208.5 KB23.4 MB23.6 MB0.3 KB/s8.7 KB23:59:45
21news.samoylyk.net80.4 KB2.5 MB2.6 MB0.0 KB/s5.2 KB23:59:55
TOTAL: 211.1 GB187.6 MB1.3 GB0.7 KB/s9.1 KB501:02:52
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.47.220 1 814.6 KB 5 1 022:08:03
TOTAL: 1 1 814.6 KB 5 1 022:10:56

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 3 814.6 KB 5 1 022:08:14
2*.ch1.censys-scanner.com 1 00.0 KB 0 0 000:00:00
3*.nntp4.net 293 00.0 KB 0 0 000:02:39
4*.dynamic.chello.pl 1 00.0 KB 0 0 000:00:00
5*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 5 299 814.6 KB 5 1 022:10:56

NNRP auth users [Top 20]:

UserConn
nelgin 1
TOTAL: 1 1

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
47.186.47.220 0.739 0.990 0.00722:08:03
news.nntp4.net 30.452 15.160 0.00000:02:39
104.152.52.243 0.096 0.047 0.00000:00:10
adroit.monitoring.internet-measurement.com 0.097 0.045 0.00000:00:01
89-64-85-20.dynamic.chello.pl 0.104 0.069 0.00000:00:00
198.199.112.21 0.148 0.076 0.00000:00:00
scanner-05.ch1.censys-scanner.com 0.108 0.069 0.00000:00:00
TOTAL: 7 31.744 16.456 0.00722:10:56

Curious NNRP server explorers [Top 20]:

SystemConn
news.nntp4.net 293
adroit.monitoring.internet-measurement.com 1
198.199.112.21 1
scanner-05.ch1.censys-scanner.com 1
89-64-85-20.dynamic.chello.pl 1
104.152.52.243 1
TOTAL: 6 298

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

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

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

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

NNRP client timeouts [Top 20]:

SystemConnPeer
47.186.47.220 1 0
TOTAL: 1 1 0

Newsgroup request counts (by hierarchy):

HierarchyCountPct
1news 8 72.7%
2comp 2 18.2%
3soc 1 9.1%
TOTAL: 3 11100.0%

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

NewsgroupCount
1news.software.nntp 5
2news.admin.net-abuse.usenet 3
3comp.sys.acorn.hardware 1
4soc.genealogy.misc 1
5comp.sys.acorn.misc 1
TOTAL: 5 11