Daily Usenet report for news.niel.me

May 24 04:15:01 -- May 25 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 141799 95.4%17.5 MB 94.6%
innd 2873 1.9%505.5 KB 2.7%
innfeed 1971 1.3%301.9 KB 1.6%
nnrpd 1970 1.3%222.2 KB 1.2%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.0 KB 0.0%
TOTAL: 6 148615 100.0%18.6 MB100.0%

History cache:

ReasonCount%Count
Negative hits 144352 48.6%
Do not exist 140772 47.4%
Positive hits 11757 4.0%
Cache misses 112 0.0%
TOTAL: 4 296993 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.006 0.0%6 1.000 1.000 1.000
article cancel00:00:00.002 0.0%6 0.000 0.333 1.000
article cleanup00:00:03.067 0.0%140774 0.000 0.022 0.333
article logging00:00:10.690 0.0%140774 0.000 0.076 0.500
article parse00:00:16.355 0.0%206945 0.000 0.079 0.300
article write00:00:00.940 0.0%1900 0.000 0.495 1.600
artlog/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
data move00:00:01.852 0.0%355969 0.000 0.005 0.034
hisgrep/artcncl00:00:00.001 0.0%6 0.000 0.167 1.000
hisgrep/artcncl/perl00:00:00.001 0.0%6 0.000 0.167 1.000
hisgrep/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%6 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:05.780 0.0%297030 0.000 0.019 0.083
history sync00:00:00.045 0.0%380 0.000 0.118 1.000
history write00:00:32.680 0.0%140774 0.000 0.232 0.500
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle23:57:59.592 99.8%362031 41.022 238.321 27304.409
nntp read00:00:15.468 0.0%361382 0.000 0.043 0.136
overview write00:00:00.620 0.0%1900 0.000 0.326 3.500
perl filter00:00:11.775 0.0%2107 1.583 5.589 33.667
python filter00:00:00.003 0.0%2107 0.000 0.001 0.250
site send00:00:00.778 0.0%3865 0.000 0.201 0.500
TOTAL: 24:01:05.26823:59:39.655 99.9%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.016 0.0%1944 0.000 0.008 0.125
article prepare00:00:00.000 0.0%316 0.000 0.000 0.000
article read00:00:00.016 0.0%76 0.000 0.211 4.000
backlog stats00:00:00.155 0.0%27960 0.000 0.006 0.037
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.398 0.0%14610 0.000 0.027 0.115
data write00:00:00.691 0.0%12784 0.000 0.054 0.286
idle24:09:01.303100.0%27960 1340.183 3109.489 9161.379
status file00:00:07.409 0.0%332 0.500 22.316 78.000
TOTAL: 24:09:15.97424:09:09.988100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:06:02.879 44.0%2040 9.600 177.882 14870.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:02.387 0.3%4520 0.000 0.528 2.527
readart00:00:00.000 0.0%2 0.000 0.000 0.000
TOTAL: 00:13:44.07800:06:05.266 44.3%----

Control commands to INND:

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 6 141672 952 1003 139717 0%24:12:27
2i2pn.org 4 3488 378 3095 15 10%44:01:40
3feed-out.gegeweb.org 5 1860 314 1546 0 16%23:56:11
4news.samoylyk.net 4 2218 218 1997 3 9%27:15:01
5gegeweb-out.news.tnetconsulting.net 3 1387 98 1288 1 7%23:57:02
6nntp.terraraq.uk 8 2674 92 2581 1 3%43:39:49
7news.glou.org 5 119 1 114 4 0%03:58:41
8localhost 25 0 0 0 0 0%00:00:00
9usenet.pasdenom.info 7 545 0 545 0 0%08:17:32
TOTAL: 9 67 153963 2053 12169 139741 1%199:18:23
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net4.8 MB0.0 KB453.3 MB458.0 MB 1%3.3 KB
2news.samoylyk.net1.8 MB0.0 KB4.1 KB1.8 MB 99%8.4 KB
3feed-out.gegeweb.org1.1 MB0.0 KB0.0 KB1.1 MB100%3.5 KB
4i2pn.org882.8 KB0.0 KB40.8 KB923.6 KB 95%2.4 KB
5nntp.terraraq.uk376.1 KB0.0 KB2.6 KB378.7 KB 99%4.1 KB
6gegeweb-out.news.tnetconsulting.net322.5 KB0.0 KB1.3 KB323.8 KB 99%3.3 KB
7news.glou.org1.3 KB0.0 KB14.3 KB15.6 KB 8%3.1 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 99.2 MB0.0 KB453.3 MB462.5 MB 1%3.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 24 04:15:01 - 04:59:59 27 1.4% 0.0174.7 KB 0.8% 0.03
May 24 05:00:00 - 05:59:59 28 1.5% 0.01192.2 KB 2.1% 0.05
May 24 06:00:00 - 06:59:59 24 1.3% 0.01206.7 KB 2.2% 0.06
May 24 07:00:00 - 07:59:59 50 2.6% 0.01191.9 KB 2.1% 0.05
May 24 08:00:00 - 08:59:59 28 1.5% 0.0198.8 KB 1.1% 0.03
May 24 09:00:00 - 09:59:59 55 2.9% 0.02324.4 KB 3.5% 0.09
May 24 10:00:00 - 10:59:59 68 3.6% 0.02226.2 KB 2.4% 0.06
May 24 11:00:00 - 11:59:59 89 4.7% 0.02268.2 KB 2.9% 0.07
May 24 12:00:00 - 12:59:59 67 3.5% 0.02231.0 KB 2.5% 0.06
May 24 13:00:00 - 13:59:59 59 3.1% 0.02186.8 KB 2.0% 0.05
May 24 14:00:00 - 14:59:59 83 4.4% 0.02348.5 KB 3.8% 0.10
May 24 15:00:00 - 15:59:59 97 5.1% 0.03343.9 KB 3.7% 0.10
May 24 16:00:00 - 16:59:59 94 5.0% 0.03357.1 KB 3.8% 0.10
May 24 17:00:00 - 17:59:59 122 6.4% 0.03777.8 KB 8.4% 0.22
May 24 18:00:00 - 18:59:59 141 7.4% 0.041.1 MB 12.2% 0.31
May 24 19:00:00 - 19:59:59 95 5.0% 0.03664.8 KB 7.2% 0.18
May 24 20:00:00 - 20:59:59 124 6.5% 0.03514.7 KB 5.5% 0.14
May 24 21:00:00 - 21:59:59 112 5.9% 0.03397.8 KB 4.3% 0.11
May 24 22:00:00 - 22:59:59 126 6.6% 0.04512.3 KB 5.5% 0.14
May 24 23:00:00 - 23:59:59 115 6.1% 0.03725.4 KB 7.8% 0.20
May 25 00:00:00 - 00:59:59 89 4.7% 0.02483.8 KB 5.2% 0.13
May 25 01:00:00 - 01:59:59 83 4.4% 0.02354.1 KB 3.8% 0.10
May 25 02:00:00 - 02:59:59 45 2.4% 0.01218.8 KB 2.4% 0.06
May 25 03:00:00 - 03:59:59 68 3.6% 0.02403.8 KB 4.4% 0.11
May 25 04:00:00 - 04:15:01 9 0.5% 0.0142.2 KB 0.5% 0.05
TOTAL: 24:00:00 1898 100.0% 0.029.1 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net139858 59 0 0 0139678 0 0 121
2i2pn.org 19 0 0 0 0 0 0 0 19
3news.glou.org 10 0 0 0 0 0 0 0 10
4news.samoylyk.net 2 0 0 0 0 0 0 0 2
TOTAL: 4139889 59 0 0 0139678 0 0 152

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.git 31
linux.kernel.netdev 27
news.test 1
TOTAL: 3 59

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 90
Bad path (news.giganews.com.POSTED) 59
Too many newsgroups (low_xpost) 1
Cancel of <100spub$pk9h$1@dont-email.me> without Cancel-Key 1
Cancel of <100srkf$q2pc$1@dont-email.me> without Cancel-Key 1
TOTAL: 5 152

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2473 22 1649 4 0 22 0%23:56:14
2news.gegeweb.org 1734 15 1562 0 0 0 0%23:55:44
3news.tnetconsulting.net 2708 15 1869 9 0 19 0%23:56:34
4nntp.terraraq.uk 1240 0 1148 0 0 0 0%23:41:58
5news.nntp4.net 1008 0 924 0 0 0 0%23:13:11
6news.pasdenom.info 1576 0 1431 0 0 0 0%23:54:57
7news.samoylyk.net 2104 0 1665 14 0 0 0%23:55:39
8news.aioe.org 0 0 0 0 0 1560 0%24:00:00
TOTAL: 8 12843 52 10248 27 0 1601 0%190:34:17
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org146.2 KB133.1 KB279.3 KB0.0 KB/s10.7 KB23:56:14
2news.tnetconsulting.net66.9 KB175.2 KB242.1 KB0.0 KB/s10.1 KB23:56:34
3news.gegeweb.org38.4 KB0.0 KB38.4 KB0.0 KB/s2.6 KB23:55:44
4nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:41:58
5news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:13:11
6news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:57
7news.samoylyk.net0.0 KB155.6 KB155.6 KB0.0 KB/s11.1 KB23:55:39
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 8251.4 KB464.0 KB715.4 KB0.0 KB/s9.1 KB190:34:17
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 10 21.5 KB 1 0 000:04:42
TOTAL: 1 10 21.5 KB 1 0 000:13:43

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 10 21.5 KB 1 0 000:04:42
2*.eu.edgewatch.com 1 00.0 KB 0 0 000:00:10
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:53
4? 6 00.0 KB 0 0 000:00:10
5unresolved 15 00.0 KB 0 0 000:06:37
6*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:07
7*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 7 326 21.5 KB 1 0 000:13:43

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 0.540 0.548 0.00000:04:42
mail.gegeweb.eu 4.595 4.287 1.82500:01:53
206.168.34.82 0.026 0.028 0.00000:00:59
206.168.34.222 0.039 0.017 0.00000:00:53
206.168.34.220 0.047 0.018 0.00000:00:51
206.168.34.121 0.031 0.035 0.00000:00:49
206.168.34.125 0.022 0.007 0.00000:00:49
206.168.34.53 0.034 0.029 0.00000:00:48
45.142.193.185 0.019 0.027 0.00000:00:29
222.186.13.130 0.012 0.012 0.00000:00:24
206.168.34.85 0.025 0.033 0.00000:00:14
explorer11.eu.edgewatch.com 0.020 0.028 0.00000:00:10
147.185.133.79 0.046 0.028 0.00000:00:08
pretty.monitoring.internet-measurement.com 0.039 0.021 0.00000:00:04
2a06:4883:7000::88 0.061 0.013 0.00000:00:04
198.235.24.79 0.029 0.025 0.00000:00:03
2a06:4882:7000::84 0.038 0.022 0.00000:00:03
transcendent.monitoring.internet-measurement.com 0.055 0.020 0.00000:00:03
2a06:4882:d000::f1 0.020 0.032 0.00000:00:02
1.24.16.2 0.012 0.012 0.00000:00:02
TOTAL: 28 5.966 5.390 1.82500:13:43

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
194.165.16.163 2
198.235.24.97 1
2a06:4882:7000::84 1
222.186.13.130 1
206.168.34.85 1
206.168.34.222 1
explorer11.eu.edgewatch.com 1
147.185.133.79 1
1.24.16.2 1
206.168.34.220 1
2a06:4882:d000::f1 1
28.149.216.162.bc.googleusercontent.com 1
206.168.34.121 1
45.142.193.185 1
198.235.24.79 1
2a06:4883:7000::88 1
2a06:4883:b000::bd 1
transcendent.monitoring.internet-measurement.com 1
upbeat.monitoring.internet-measurement.com 1
TOTAL: 28 316

NNRP gethostbyaddr failures [Top 20]:

SystemConn
? (can't getpeername) 14
TOTAL: 1 14

NNRP unrecognized commands (by host):

SystemConn
147.185.133.79 4
45.142.193.185 4
28.149.216.162.bc.googleusercontent.com 4
194.165.16.163 1
206.168.34.85 1
TOTAL: 5 14

NNRP unrecognized commands (by command):

CommandCount
Accept-Encoding: gzip 2
Host: 45.13.105.36:563 2
GET / HTTP/1.1 2
User-Agent: Expanse, a Palo Alto Network... 2
User-Agent: Mozilla/5.0 (Windows NT 6.1;... 1
Host: 45.13.105.36:119 1
Accept: */* 1
Accept-Encoding: deflate, gzip 1
#003 1
EHLO www.censys.io 1
TOTAL: 10 14

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.163 1 1
TOTAL: 1 1 3

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1grisbi.test 2
TOTAL: 1 2