Daily Usenet report

Dec 24 00:01:01 -- Dec 25 00:01:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

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

Log entries by program:

Program nameLines%LinesSize%Size
inn 85111 76.2%20.8 MB 85.5%
innd 22167 19.9%2.7 MB 11.2%
innfeed 4256 3.8%801.9 KB 3.2%
nnrpd 134 0.1%10.7 KB 0.0%
controlchan 2 0.0%0.1 KB 0.0%
TOTAL: 5 111670 100.0%24.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 392933 60.1%
Negative hits 216827 33.2%
Do not exist 42112 6.4%
Cache misses 1552 0.2%
TOTAL: 4 653424 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article cancel00:00:27.206 0.0%47334 0.267 0.575 2.622
article cleanup00:00:00.849 0.0%42546 0.004 0.020 0.065
article logging00:00:02.244 0.0%42597 0.016 0.053 0.118
article parse00:00:05.483 0.0%256601 0.003 0.021 0.032
article write00:00:36.602 0.0%30950 0.825 1.183 2.818
artlog/artcncl00:00:00.637 0.0%42535 0.000 0.015 0.052
data move00:00:01.931 0.0%890976 0.000 0.002 0.005
hisgrep/artcncl00:00:05.871 0.0%47313 0.020 0.124 1.038
hishave/artcncl00:00:00.525 0.0%47154 0.000 0.011 0.152
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:26.895 0.0%615200 0.010 0.044 0.120
history sync00:00:00.102 0.0%341 0.000 0.299 1.667
history write00:00:27.619 0.0%42545 0.257 0.649 2.304
hiswrite/artcncl00:00:00.010 0.0%36 0.000 0.278 1.000
idle23:44:57.158 98.9%827647 24.552 103.301 283.982
nntp read00:00:45.227 0.1%842385 0.024 0.054 0.129
overview write00:03:00.261 0.2%30950 0.671 5.824 660.192
perl filter00:05:21.541 0.4%42545 2.678 7.558 14.421
python filter00:00:05.389 0.0%42546 0.056 0.127 0.247
site send00:00:14.750 0.0%62974 0.116 0.234 0.450
TOTAL: 24:00:41.99823:56:40.300 99.7%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.381 0.0%31746 0.000 0.012 0.069
article prepare00:00:00.075 0.0%364650 0.000 0.000 0.001
article read00:00:12.410 0.0%30827 0.219 0.403 0.665
backlog stats00:00:02.495 0.0%1057914 0.001 0.002 0.005
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:23.255 0.0%794567 0.020 0.029 0.040
data write00:01:57.975 0.1%720959 0.129 0.164 0.223
idle23:49:16.194 99.8%1057914 52.315 81.062 189.812
status file00:00:00.475 0.0%462 0.000 1.028 4.000
TOTAL: 23:52:34.66523:51:53.260100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle22:28:01.687100.0%1642 26.500 49258.031 49347.233
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.721 0.0%3382 0.000 0.213 0.250
readart00:00:00.024 0.0%102 0.235 0.235 0.235
TOTAL: 22:28:04.58622:28:02.432100.0%----

Control commands to INND:

CommandNumber
checkfile 1
flush 5
flushlogs 2
go 2
logmode 2
lowmark 1
mode 142
name 2
pause 2
paused 2
reload 4
reserve 2
TOTAL: 12 167

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1endofthelinebbs-out.news.weretis.net 12 51121 13563 35822 1736 26%47:58:52
2usenet.blueworldhosting.com 1440 21656 3573 16202 1881 16%23:47:03
3newsfeed.xs3.de 4 26953 3458 23293 202 12%24:24:30
4news.nntp4.net 4 32170 2939 29051 180 9%24:16:49
5news.hispagatos.org 6 12644 1721 10918 5 13%24:26:18
6endofthelinebbs.peers.news.panix.com 31 30708 1327 29322 59 4%24:44:43
7nntp.comgw.net 3 31936 1121 30109 706 3%24:09:01
8usenet.goja.nl.eu.org 13 31710 951 30100 659 2%23:58:31
9paganini.bofh.team 64 35796 619 34951 226 1%24:13:07
10endoftheline-out.news.chmurka.net 9 7647 433 7211 3 5%23:59:25
11usenet.network 1 22315 339 21891 85 1%23:59:58
12outgoing.news.lysator.liu.se 2 8126 306 7672 148 3%23:59:29
13194.87.241.33 37 331 149 63 119 45%19:49:05
14i2pn.org 2 8584 96 8472 16 1%23:59:58
15glockenspiel.complete.org 4 29262 77 29164 21 0%23:10:05
16news.samoylyk.net 1 7254 39 7215 0 0%23:59:49
17news.netfront.net 40 5542 11 87 5444 0%17:47:56
18news.furie.org.uk 2 14498 9 14489 0 0%23:59:48
19news.bbs.nz 2 16023 8 16015 0 0%23:59:34
20localhost 28 1 1 0 0 100%00:00:00
21eotl-out.news.tnetconsulting.net 1 0 0 0 0 0%00:10:04
22news.nk.ca 3 0 0 0 0 0%00:30:00
TOTAL: 22 1709 394277 30740 352047 11490 7%471:24:05
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1endofthelinebbs-out.news.weretis.net114.5 MB0.0 KB2.7 MB117.2 MB 97%7.8 KB
2newsfeed.xs3.de33.3 MB0.0 KB1.9 MB35.1 MB 94%9.8 KB
3news.nntp4.net32.6 MB0.0 KB1.4 MB34.0 MB 95%11.2 KB
4usenet.blueworldhosting.com23.5 MB0.0 KB4.5 MB28.0 MB 83%5.3 KB
5endofthelinebbs.peers.news.panix.com8.8 MB0.0 KB258.6 KB9.0 MB 97%6.7 KB
6nntp.comgw.net5.2 MB0.0 KB4.3 MB9.5 MB 54%5.3 KB
7news.hispagatos.org5.1 MB0.0 KB6.8 KB5.1 MB 99%3.0 KB
8usenet.goja.nl.eu.org4.9 MB0.0 KB1.7 MB6.6 MB 74%4.2 KB
9paganini.bofh.team4.2 MB0.0 KB1.3 MB5.5 MB 76%6.7 KB
10usenet.network2.7 MB0.0 KB288.5 KB3.0 MB 90%7.3 KB
11endoftheline-out.news.chmurka.net2.1 MB0.0 KB4.4 KB2.1 MB 99%5.0 KB
12glockenspiel.complete.org868.8 KB0.0 KB50.2 KB919.0 KB 94%9.4 KB
13outgoing.news.lysator.liu.se584.9 KB0.0 KB216.1 KB801.1 KB 73%1.8 KB
14194.87.241.33371.1 KB323.2 KB168.2 KB862.5 KB 43%3.2 KB
15i2pn.org303.0 KB0.0 KB30.3 KB333.3 KB 90%3.0 KB
16news.netfront.net215.0 KB0.0 KB1.8 GB1.8 GB 0%347.1 KB
17news.samoylyk.net107.5 KB0.0 KB0.0 KB107.5 KB100%2.8 KB
18news.furie.org.uk47.0 KB0.0 KB0.0 KB47.0 KB100%5.2 KB
19news.bbs.nz21.6 KB0.0 KB0.0 KB21.6 KB100%2.7 KB
20localhost1.6 KB0.0 KB0.0 KB1.6 KB100%1.6 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
TOTAL: 22239.3 MB323.2 KB1.8 GB2.1 GB 11%51.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Dec 24 00:01:01 - 00:59:59 1275 4.1% 0.3610.1 MB 4.2% 2.92
Dec 24 01:00:00 - 01:59:59 1608 5.2% 0.4513.8 MB 5.7% 3.93
Dec 24 02:00:00 - 02:59:59 1343 4.3% 0.3711.0 MB 4.6% 3.13
Dec 24 03:00:00 - 03:59:59 1450 4.7% 0.4010.4 MB 4.3% 2.95
Dec 24 04:00:00 - 04:59:59 1553 5.0% 0.4311.6 MB 4.8% 3.31
Dec 24 05:00:00 - 05:59:59 1669 5.4% 0.4611.8 MB 4.9% 3.34
Dec 24 06:00:00 - 06:59:59 1574 5.1% 0.4412.5 MB 5.2% 3.56
Dec 24 07:00:00 - 07:59:59 1467 4.7% 0.4111.6 MB 4.8% 3.29
Dec 24 08:00:00 - 08:59:59 1216 3.9% 0.348.3 MB 3.5% 2.37
Dec 24 09:00:00 - 09:59:59 1502 4.9% 0.4211.5 MB 4.8% 3.27
Dec 24 10:00:00 - 10:59:59 1287 4.2% 0.368.9 MB 3.7% 2.54
Dec 24 11:00:00 - 11:59:59 921 3.0% 0.265.3 MB 2.2% 1.52
Dec 24 12:00:00 - 12:59:59 1115 3.6% 0.317.9 MB 3.3% 2.26
Dec 24 13:00:00 - 13:59:59 1232 4.0% 0.347.7 MB 3.2% 2.20
Dec 24 14:00:00 - 14:59:59 1015 3.3% 0.287.5 MB 3.1% 2.13
Dec 24 15:00:00 - 15:59:59 1167 3.8% 0.3210.1 MB 4.2% 2.87
Dec 24 16:00:00 - 16:59:59 1064 3.4% 0.308.5 MB 3.5% 2.42
Dec 24 17:00:00 - 17:59:59 1128 3.6% 0.318.8 MB 3.7% 2.50
Dec 24 18:00:00 - 18:59:59 881 2.8% 0.246.4 MB 2.7% 1.83
Dec 24 19:00:00 - 19:59:59 747 2.4% 0.215.1 MB 2.1% 1.44
Dec 24 20:00:00 - 20:59:59 1376 4.4% 0.3811.3 MB 4.7% 3.23
Dec 24 21:00:00 - 21:59:59 1432 4.6% 0.4013.0 MB 5.4% 3.70
Dec 24 22:00:00 - 22:59:59 1401 4.5% 0.3913.0 MB 5.4% 3.70
Dec 24 23:00:00 - 23:59:59 1505 4.9% 0.4213.7 MB 5.7% 3.90
Dec 25 00:00:00 - 00:01:02 21 0.1% 0.34159.9 KB 0.1% 2.58
TOTAL: 24:00:01 30949 100.0% 0.36240.1 MB 100.0% 2.85
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.netfront.net 5444 0 0 0 0 0 0 0 5444
2usenet.blueworldhosting.com 1888 19 0 0 1 0 0 0 1868
3endofthelinebbs-out.news.weretis.net 1799 0 0 0 0 0 0 0 1799
4nntp.comgw.net 737 0 0 0 0 0 0 0 737
5usenet.goja.nl.eu.org 682 0 0 0 0 0 0 0 682
6paganini.bofh.team 225 0 0 0 0 0 0 0 225
7newsfeed.xs3.de 200 0 0 0 0 0 0 0 200
8news.nntp4.net 180 0 0 0 0 0 0 0 180
9outgoing.news.lysator.liu.se 148 0 0 0 0 0 0 0 148
10194.87.241.33 119 0 0 1 0 0 0 0 118
11usenet.network 89 0 0 0 0 0 0 0 89
12endofthelinebbs.peers.news.panix.com 66 14 0 0 0 0 0 0 52
13glockenspiel.complete.org 49 0 0 0 0 0 0 0 49
14i2pn.org 17 0 0 0 0 0 0 0 17
15news.hispagatos.org 10 0 0 0 0 0 0 0 10
16endoftheline-out.news.chmurka.net 3 0 0 0 0 0 0 0 3
TOTAL: 16 11656 33 0 1 1 0 0 011621

Unwanted newsgroups [Top 20]:

NewsgroupCount
de.sci.announce 29
soc.culture.africa 3
rec.autos.makers.mazda 1
TOTAL: 3 33

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

GroupsCount
uk.religion.christian 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
Binary: misplaced binary 4615
EMP (phn path) 3571
Too many newsgroups 1390
EMP (md5) 1164
EMP (phr path) 337
HTML Multipart 11
Subject (lSDguKvguKfguKIg4Lih4Lix4LmI4LiZ4LiE4LiH4LiX4Li) 9
Subject (LSDguYDguKfguYfguJo) 8
Subject (LSDguJzguKXguJrguK3guKXguKr) 8
Subject (LSDguY) 7
Subject (lSDguYDguITguKPguJTguL) 7
User-issued cancel 7
Subject (lSDguY) 7
User-issued spam cancel 7
Subject (LSDguYD) 6
Subject (LSDguYDguKfguY) 5
Subject (lSDguKLguLTguI) 4
Subject (lSDguYLguK3guJnguYTguKfguIjguYjguLLguKLguYDguKPguYfguKcg4LiE) 3
Subject (lSDguJ7guKPguYnguK3guKHguYLguJvguKPguYI) 3
Subject (Buy Xanax) 3
TOTAL: 366 11569

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Bad command received
paganini.bofh.team 38
TOTAL: 1 38
Including strange strings
endofthelinebbs-out.news.weretis.net 28
nntp.comgw.net 8
usenet.blueworldhosting.com 6
news.hispagatos.org 4
endofthelinebbs.peers.news.panix.com 4
i2pn.org 1
glockenspiel.complete.org 1
TOTAL: 7 52
TOTAL: 2 90

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.netfront.net 30940 30934 0 4 0 0 99%23:59:46
2nyheter.lysator.liu.se 30955 23571 6484 588 0 0 76%23:59:46
3usenet.network 36885 7683 22224 357 0 1 20%23:59:46
4endofthelinebbs.peers.news.panix.com 31583 7123 23800 21 0 0 22%23:59:47
5news.hispagatos.org 34129 3147 23949 1997 0 2 9%23:52:31
6news.furie.org.uk 16260 2209 11736 24 0 1 13%23:59:46
7news.quux.org 31958 1954 28510 316 0 0 6%23:59:47
8news.nntp4.net 31883 492 27097 129 0 11 1%23:59:46
9news.bbs.nz 56983 479 28839 1628 0 78 0%23:59:46
10nntp.comgw.net 35238 389 30290 270 0 24 1%23:59:47
11paganini.bofh.team 37017 344 30602 0 0 1 0%23:59:46
12news.nk.ca 39157 253 28672 1950 0 47 0%23:59:47
13usenet.goja.nl.eu.org 34707 202 29574 202 0 11 0%23:59:46
14news.weretis.net 31454 156 29671 1121 0 0 0%23:59:47
15news.chmurka.net 15908 142 13488 11 0 3 0%23:59:46
16usenet.blueworldhosting.com 26868 122 25779 1 0 0 0%23:59:47
17ddt.demos.su 446 119 322 0 0 0 26%20:24:36
18i2pn.org 37093 100 29282 1342 1 705 0%23:59:44
19newsfeed.xs3.de 31424 90 26965 294 0 0 0%23:59:46
20news.tnetconsulting.net 34857 34 29399 1510 0 7 0%23:59:48
21news.samoylyk.net 41133 30 30631 250 0 52 0%23:59:46
TOTAL: 21 666878 79573 477314 12015 1 943 11%500:12:47
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.netfront.net240.0 MB38.1 KB240.0 MB2.8 KB/s7.9 KB23:59:46
2nyheter.lysator.liu.se215.5 MB3.3 MB218.8 MB2.6 KB/s9.3 KB23:59:46
3endofthelinebbs.peers.news.panix.com71.8 MB146.5 KB71.9 MB0.9 KB/s10.3 KB23:59:47
4usenet.network69.9 MB1.9 MB71.8 MB0.9 KB/s9.1 KB23:59:46
5news.hispagatos.org35.9 MB13.3 MB49.2 MB0.6 KB/s9.8 KB23:52:31
6news.quux.org21.7 MB1.1 MB22.9 MB0.3 KB/s10.3 KB23:59:47
7news.furie.org.uk14.0 MB74.9 KB14.1 MB0.2 KB/s6.5 KB23:59:46
8news.nntp4.net4.5 MB294.9 KB4.8 MB0.1 KB/s7.8 KB23:59:46
9news.bbs.nz3.2 MB11.6 MB14.8 MB0.2 KB/s7.2 KB23:59:46
10nntp.comgw.net3.1 MB1.7 MB4.8 MB0.1 KB/s7.5 KB23:59:47
11paganini.bofh.team2.3 MB0.0 KB2.3 MB0.0 KB/s6.9 KB23:59:46
12usenet.goja.nl.eu.org1.4 MB863.9 KB2.3 MB0.0 KB/s5.8 KB23:59:46
13news.chmurka.net1.4 MB325.4 KB1.7 MB0.0 KB/s11.3 KB23:59:46
14newsfeed.xs3.de1.1 MB1.8 MB2.8 MB0.0 KB/s7.6 KB23:59:46
15news.weretis.net996.0 KB11.0 MB12.0 MB0.1 KB/s9.6 KB23:59:47
16news.nk.ca679.9 KB13.5 MB14.2 MB0.2 KB/s6.6 KB23:59:47
17news.samoylyk.net552.4 KB1.4 MB1.9 MB0.0 KB/s7.0 KB23:59:46
18i2pn.org276.8 KB10.3 MB10.5 MB0.1 KB/s7.5 KB23:59:44
19usenet.blueworldhosting.com237.0 KB1.2 KB238.2 KB0.0 KB/s1.9 KB23:59:47
20ddt.demos.su233.0 KB0.0 KB233.0 KB0.0 KB/s2.0 KB20:24:36
21news.tnetconsulting.net65.9 KB13.6 MB13.7 MB0.2 KB/s9.1 KB23:59:48
TOTAL: 21688.6 MB86.3 MB774.9 MB0.4 KB/s8.7 KB500:12:47
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
147.186.47.220 1 933.0 KB 2 2 022:28:01
TOTAL: 1 1 933.0 KB 2 2 022:28:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 2 933.0 KB 2 2 022:28:02
2*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
TOTAL: 2 3 933.0 KB 2 2 022:28:03

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.752 1.120 0.00722:28:01
special.monitoring.internet-measurement.com 0.124 0.084 0.00000:00:01
192.241.224.15 0.112 0.057 0.00000:00:00
TOTAL: 3 0.988 1.261 0.00722:28:03

Curious NNRP server explorers [Top 20]:

SystemConn
192.241.224.15 1
special.monitoring.internet-measurement.com 1
TOTAL: 2 2

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

SystemConn
192.241.224.15 1
TOTAL: 1 1

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

CommandCount
MGLNDD_192.138.210.162_119 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 14100.0%
TOTAL: 1 14100.0%

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

NewsgroupCount
1news.admin.peering 13
2news.admin.net-abuse.usenet 1
TOTAL: 2 14