Daily Usenet report for news.niel.me

Sep 11 04:15:01 -- Sep 12 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 2487 28.9%468.1 KB 34.2%
nnrpd 2169 25.2%235.7 KB 17.2%
innd 2126 24.7%375.8 KB 27.5%
innfeed 1815 21.1%288.9 KB 21.1%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8599 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 13305 59.1%
Negative hits 6724 29.9%
Do not exist 2464 11.0%
Cache misses 9 0.0%
TOTAL: 4 22502 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.012 0.0%9 1.000 1.333 2.000
article cancel00:00:00.001 0.0%9 0.000 0.111 1.000
article cleanup00:00:00.065 0.0%2476 0.000 0.026 0.286
article logging00:00:00.165 0.0%2476 0.000 0.067 0.250
article parse00:00:00.334 0.0%5122 0.000 0.065 0.308
article write00:00:01.206 0.0%2298 0.167 0.525 1.333
artlog/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.004 0.0%9 0.000 0.444 1.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.136 0.0%23209 0.000 0.006 0.143
hisgrep/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%9 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%10 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%9 0.000 0.111 0.500
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.385 0.0%22628 0.000 0.017 0.061
history sync00:00:00.077 0.0%405 0.000 0.190 1.000
history write00:00:00.441 0.0%2476 0.000 0.178 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:59.337100.0%25333 854.192 3412.913 28576.762
nntp read00:00:00.674 0.0%24573 0.000 0.027 0.082
overview write00:00:00.750 0.0%2298 0.000 0.326 3.000
perl filter00:00:10.833 0.0%2476 1.750 4.375 9.667
python filter00:00:00.016 0.0%2476 0.000 0.006 0.143
site send00:00:01.006 0.0%4622 0.000 0.218 0.667
TOTAL: 24:01:23.07124:01:15.443100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%2340 0.000 0.012 0.200
article prepare00:00:00.005 0.0%536 0.000 0.009 0.250
article read00:00:00.031 0.0%132 0.000 0.235 7.000
backlog stats00:00:00.211 0.0%33263 0.000 0.006 0.036
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.436 0.0%17994 0.000 0.024 0.118
data write00:00:00.912 0.0%16012 0.000 0.057 0.250
idle23:59:23.156100.0%33263 712.996 2596.373 8978.701
status file00:00:01.635 0.0%265 1.000 6.170 32.000
TOTAL: 23:59:30.84623:59:26.413100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:46:14.106 98.4%21935 11.500 290.591 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.380 0.1%83671 0.000 0.040 0.273
readart00:00:03.103 0.0%19679 0.146 0.158 4.000
TOTAL: 01:47:59.10501:46:20.589 98.5%----

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
1feed-out.gegeweb.org 3 2247 1047 1199 1 46%23:59:06
2gegeweb-out.news.tnetconsulting.net 2 2111 292 1819 0 13%26:07:20
3news.nntp4.net 2 1867 276 1452 139 14%20:07:32
4news.samoylyk.net 2 1704 218 1486 0 12%19:20:57
5usenet.pasdenom.info 8 1307 99 1205 3 7%26:02:53
6i2pn.org 2 287 23 264 0 8%04:55:23
7nntp.terraraq.uk 2 232 9 223 0 3%04:52:38
8news.glou.org 3 47 3 43 1 6%01:18:03
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 49 9802 1967 7691 144 20%126:43:52
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.4 MB0.0 KB11.1 KB3.4 MB 99%3.3 KB
2news.samoylyk.net1.4 MB0.0 KB0.0 KB1.4 MB100%6.4 KB
3gegeweb-out.news.tnetconsulting.net1.0 MB0.0 KB0.0 KB1.0 MB100%3.7 KB
4news.nntp4.net959.6 KB0.0 KB402.9 KB1.3 MB 70%3.3 KB
5usenet.pasdenom.info233.7 KB0.0 KB3.3 KB237.0 KB 98%2.3 KB
6i2pn.org64.2 KB0.0 KB0.0 KB64.2 KB100%2.8 KB
7news.glou.org21.7 KB0.0 KB3.1 KB24.8 KB 87%6.2 KB
8nntp.terraraq.uk16.9 KB0.0 KB0.0 KB16.9 KB100%1.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.1 MB0.0 KB420.3 KB7.5 MB 94%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 11 04:15:01 - 04:59:59 31 1.4% 0.01125.2 KB 1.5% 0.05
Sep 11 05:00:00 - 05:59:59 48 2.1% 0.01180.6 KB 2.2% 0.05
Sep 11 06:00:00 - 06:59:59 48 2.1% 0.01122.0 KB 1.5% 0.03
Sep 11 07:00:00 - 07:59:59 42 1.8% 0.01139.6 KB 1.7% 0.04
Sep 11 08:00:00 - 08:59:59 34 1.5% 0.01172.3 KB 2.1% 0.05
Sep 11 09:00:00 - 09:59:59 57 2.5% 0.02201.7 KB 2.4% 0.06
Sep 11 10:00:00 - 10:59:59 134 5.8% 0.04506.8 KB 6.1% 0.14
Sep 11 11:00:00 - 11:59:59 123 5.4% 0.03366.8 KB 4.4% 0.10
Sep 11 12:00:00 - 12:59:59 61 2.7% 0.02210.5 KB 2.5% 0.06
Sep 11 13:00:00 - 13:59:59 90 3.9% 0.03318.5 KB 3.8% 0.09
Sep 11 14:00:00 - 14:59:59 128 5.6% 0.04391.1 KB 4.7% 0.11
Sep 11 15:00:00 - 15:59:59 112 4.9% 0.03402.8 KB 4.8% 0.11
Sep 11 16:00:00 - 16:59:59 93 4.1% 0.03327.6 KB 3.9% 0.09
Sep 11 17:00:00 - 17:59:59 169 7.4% 0.05601.1 KB 7.2% 0.17
Sep 11 18:00:00 - 18:59:59 135 5.9% 0.04512.9 KB 6.1% 0.14
Sep 11 19:00:00 - 19:59:59 126 5.5% 0.04634.0 KB 7.6% 0.18
Sep 11 20:00:00 - 20:59:59 144 6.3% 0.04619.6 KB 7.4% 0.17
Sep 11 21:00:00 - 21:59:59 117 5.1% 0.03345.9 KB 4.1% 0.10
Sep 11 22:00:00 - 22:59:59 116 5.1% 0.03419.2 KB 5.0% 0.12
Sep 11 23:00:00 - 23:59:59 162 7.1% 0.04579.8 KB 7.0% 0.16
Sep 12 00:00:00 - 00:59:59 100 4.4% 0.03423.6 KB 5.1% 0.12
Sep 12 01:00:00 - 01:59:59 89 3.9% 0.02334.5 KB 4.0% 0.09
Sep 12 02:00:00 - 02:59:59 54 2.4% 0.01168.5 KB 2.0% 0.05
Sep 12 03:00:00 - 03:59:59 61 2.7% 0.02186.0 KB 2.2% 0.05
Sep 12 04:00:00 - 04:15:01 17 0.7% 0.0251.6 KB 0.6% 0.06
TOTAL: 24:00:00 2291 100.0% 0.038.1 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 169 0 0 0 0 0 0 0 169
2news.glou.org 5 0 0 0 0 0 0 0 5
3usenet.pasdenom.info 3 0 0 0 0 0 0 0 3
4feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 4 178 0 0 0 0 0 0 0 178

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 169
EMP (phn path) 6
Cancel of non-existing ID <vbt6l1$1sa9$1@cabale.usenet-fr.net> 1
Cancels abusifs 1
EMP (md5) 1
TOTAL: 5 178

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3439 63 2062 9 0 37 1%23:58:21
2news.gegeweb.org 1296 48 1197 0 0 0 3%23:34:08
3news.tnetconsulting.net 3788 5 2284 1 0 12 0%23:59:47
4news.nntp4.net 2027 1 1935 1 0 0 0%23:57:16
5nntp.terraraq.uk 1426 0 1409 0 0 0 0%23:50:34
6news.aioe.org 0 0 0 0 0 1897 0%24:00:00
7news.pasdenom.info 1908 0 1758 0 0 0 0%23:54:03
8news.samoylyk.net 2350 0 2017 6 0 0 0%23:59:39
TOTAL: 8 16234 117 12662 17 0 1946 0%191:13:48
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org270.1 KB33.9 KB304.0 KB0.0 KB/s4.2 KB23:58:21
2news.gegeweb.org161.6 KB0.0 KB161.6 KB0.0 KB/s3.4 KB23:34:08
3news.tnetconsulting.net16.7 KB2.0 KB18.7 KB0.0 KB/s3.1 KB23:59:47
4news.nntp4.net2.3 KB10.7 KB13.0 KB0.0 KB/s6.5 KB23:57:16
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:50:34
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:03
8news.samoylyk.net0.0 KB43.4 KB43.4 KB0.0 KB/s7.2 KB23:59:39
TOTAL: 8450.6 KB90.1 KB540.7 KB0.0 KB/s4.0 KB191:13:48
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 29 1967930.7 MB 88 0 001:45:18
TOTAL: 1 29 1967930.7 MB 88 0 001:47:58

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 46 1967930.7 MB 88 0 001:46:04
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:49
3*.monitoring.internet-measurement.com 1 00.0 KB 0 0 000:00:01
4*.stretchoid.com 1 00.0 KB 0 0 000:00:00
5*.210.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:01
TOTAL: 5 338 1967930.7 MB 88 0 001:47:58

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
69.10.48.174 3.920 8.555 0.00001:45:18
mail.gegeweb.eu 5.162 4.249 1.69700:01:49
205.210.31.84 0.027 0.023 0.00000:00:11
152.32.150.29 0.072 0.072 0.00000:00:11
205.210.31.176 0.028 0.024 0.00000:00:10
199.45.154.140 0.077 0.052 0.00000:00:06
206.168.34.37 0.303 0.103 0.00000:00:05
harmonious.monitoring.internet-measurement.com 0.028 0.020 0.00000:00:01
247.210.203.35.bc.googleusercontent.com 0.052 0.024 0.00000:00:01
109.210.203.35.bc.googleusercontent.com 0.061 0.025 0.00000:00:00
80.66.76.130 0.027 0.019 0.00000:00:00
91.238.181.32 0.037 0.025 0.00000:00:00
azpdegb11.stretchoid.com 0.031 0.020 0.00000:00:00
TOTAL: 13 9.825 13.211 1.69701:47:58

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
206.168.34.37 7
152.32.150.29 3
199.45.154.140 3
harmonious.monitoring.internet-measurement.com 1
80.66.76.130 1
91.238.181.32 1
247.210.203.35.bc.googleusercontent.com 1
205.210.31.176 1
109.210.203.35.bc.googleusercontent.com 1
azpdegb11.stretchoid.com 1
205.210.31.84 1
TOTAL: 12 309

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
109.210.203.35.bc.googleusercontent.com 4
247.210.203.35.bc.googleusercontent.com 4
152.32.150.29 2
206.168.34.37 1
80.66.76.130 1
199.45.154.140 1
azpdegb11.stretchoid.com 1
TOTAL: 7 14

NNRP unrecognized commands (by command):

CommandCount
User-Agent: Expanse, a Palo Alto Network... 2
GET / HTTP/1.1 2
Host: 45.13.105.36:563 2
Accept-Encoding: gzip 2
EHLO www.censys.io 2
À#024 1
MGLNDD_45.13.105.36_119 1
#026#003#001#001#027#001 1
#003 1
TOTAL: 9 14

NNRP client timeouts [Top 20]:

SystemConnPeer
80.66.76.130 1 1
69.10.48.174 1 1
199.45.154.140 1 2
TOTAL: 3 3 4

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 18485 93.9%
2local 1194 6.1%
TOTAL: 2 19679100.0%

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

NewsgroupCount
1grisbi.test 6633
2grisbi.bugsreports 6593
3grisbi.user.french 3227
4grisbi.devel 1830
5local.test 1070
6local.gegeweb.support 124
7grisbi.user 102
8grisbi.cvs 96
9grisbi.admin 4
TOTAL: 9 19679