Daily Usenet report for news.niel.me

Sep 30 04:15:01 -- Oct 1 04:15:01

Log entries by program:

Program nameLines%LinesSize%Size
inn 2281 27.8%431.3 KB 32.7%
innd 2115 25.8%389.2 KB 29.5%
nnrpd 1969 24.0%224.2 KB 17.0%
innfeed 1819 22.2%273.4 KB 20.7%
controlchan 6 0.1%1.1 KB 0.1%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8191 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12726 61.1%
Negative hits 5856 28.1%
Do not exist 2257 10.8%
Cache misses 1 0.0%
TOTAL: 4 20840 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.011 0.0%11 0.000 1.000 2.000
article cancel00:00:00.003 0.0%11 0.000 0.273 1.000
article cleanup00:00:00.049 0.0%2263 0.000 0.022 0.200
article logging00:00:00.202 0.0%2263 0.000 0.089 0.500
article parse00:00:00.324 0.0%4846 0.000 0.067 0.263
article write00:00:01.068 0.0%2074 0.000 0.515 1.125
artlog/artcncl00:00:00.001 0.0%11 0.000 0.091 0.500
artlog/artcncl/perl00:00:00.001 0.0%11 0.000 0.091 1.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.132 0.0%22032 0.000 0.006 0.033
hisgrep/artcncl00:00:00.001 0.0%11 0.000 0.091 0.500
hisgrep/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%19 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%11 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.327 0.0%20875 0.000 0.016 0.143
history sync00:00:00.065 0.0%396 0.000 0.164 1.000
history write00:00:00.380 0.0%2263 0.000 0.168 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:45.755100.0%24003 1486.644 3601.456 18771.906
nntp read00:00:00.658 0.0%23209 0.000 0.028 0.061
overview write00:00:00.765 0.0%2074 0.000 0.369 2.357
perl filter00:00:09.156 0.0%2263 2.208 4.046 9.900
python filter00:00:00.012 0.0%2263 0.000 0.005 0.167
site send00:00:00.885 0.0%4194 0.000 0.211 0.548
TOTAL: 24:01:06.95724:00:59.795100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%2081 0.000 0.012 0.200
article prepare00:00:00.000 0.0%476 0.000 0.000 0.000
article read00:00:00.032 0.0%114 0.000 0.281 8.000
backlog stats00:00:00.167 0.0%32184 0.000 0.005 0.022
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.400 0.0%16953 0.000 0.024 0.091
data write00:00:00.920 0.0%15074 0.014 0.061 0.125
idle23:58:27.273100.0%32184 1170.103 2681.683 8448.915
status file00:00:00.492 0.0%234 0.000 2.103 5.000
TOTAL: 23:58:33.43523:58:29.308100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:07:05.825 76.9%3250 3.500 131.023 10051.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.313 0.1%10393 0.000 0.030 1.000
readart00:00:00.237 0.0%1711 0.120 0.139 0.156
TOTAL: 00:09:14.03600:07:06.375 77.0%----

Control commands to INND:

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 2 2040 1062 973 5 52%23:59:25
2gegeweb-out.news.tnetconsulting.net 2 3076 350 2645 81 11%38:50:04
3news.nntp4.net 2 1861 170 1629 62 9%21:07:32
4usenet.pasdenom.info 5 1294 90 1180 24 6%26:23:20
5news.glou.org 2 208 12 187 9 5%04:06:48
6i2pn.org 2 122 10 112 0 8%02:14:59
7news.samoylyk.net 2 129 6 123 0 4%02:23:42
8nntp.terraraq.uk 3 303 4 299 0 1%05:57:36
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 45 9033 1704 7148 181 18%125:03:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.7 MB0.0 KB17.4 KB3.7 MB 99%3.5 KB
2gegeweb-out.news.tnetconsulting.net1.2 MB103.4 KB617.5 KB1.9 MB 62%4.5 KB
3news.nntp4.net647.9 KB0.0 KB173.5 KB821.4 KB 78%3.5 KB
4news.samoylyk.net476.4 KB0.0 KB0.0 KB476.4 KB100%79.4 KB
5usenet.pasdenom.info190.4 KB0.0 KB31.4 KB221.8 KB 85%1.9 KB
6news.glou.org42.2 KB0.0 KB35.2 KB77.4 KB 54%3.7 KB
7nntp.terraraq.uk41.0 KB0.0 KB0.0 KB41.0 KB100%10.2 KB
8i2pn.org18.5 KB0.0 KB0.0 KB18.5 KB100%1.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 96.2 MB103.4 KB875.0 KB7.2 MB 86%3.9 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 30 04:15:01 - 04:59:59 45 2.2% 0.02212.5 KB 2.7% 0.08
Sep 30 05:00:00 - 05:59:59 59 2.8% 0.02277.8 KB 3.5% 0.08
Sep 30 06:00:00 - 06:59:59 44 2.1% 0.01641.3 KB 8.1% 0.18
Sep 30 07:00:00 - 07:59:59 81 3.9% 0.02348.8 KB 4.4% 0.10
Sep 30 08:00:00 - 08:59:59 56 2.7% 0.02203.1 KB 2.6% 0.06
Sep 30 09:00:00 - 09:59:59 76 3.7% 0.02192.3 KB 2.4% 0.05
Sep 30 10:00:00 - 10:59:59 54 2.6% 0.01232.6 KB 3.0% 0.06
Sep 30 11:00:00 - 11:59:59 55 2.7% 0.02228.6 KB 2.9% 0.06
Sep 30 12:00:00 - 12:59:59 72 3.5% 0.02236.4 KB 3.0% 0.07
Sep 30 13:00:00 - 13:59:59 97 4.7% 0.03372.6 KB 4.7% 0.10
Sep 30 14:00:00 - 14:59:59 99 4.8% 0.03268.8 KB 3.4% 0.07
Sep 30 15:00:00 - 15:59:59 91 4.4% 0.03332.2 KB 4.2% 0.09
Sep 30 16:00:00 - 16:59:59 118 5.7% 0.03436.6 KB 5.5% 0.12
Sep 30 17:00:00 - 17:59:59 126 6.1% 0.04394.5 KB 5.0% 0.11
Sep 30 18:00:00 - 18:59:59 108 5.2% 0.03365.4 KB 4.6% 0.10
Sep 30 19:00:00 - 19:59:59 105 5.1% 0.03324.4 KB 4.1% 0.09
Sep 30 20:00:00 - 20:59:59 125 6.0% 0.03387.0 KB 4.9% 0.11
Sep 30 21:00:00 - 21:59:59 151 7.3% 0.04431.4 KB 5.5% 0.12
Sep 30 22:00:00 - 22:59:59 101 4.9% 0.03284.2 KB 3.6% 0.08
Sep 30 23:00:00 - 23:59:59 110 5.3% 0.03384.3 KB 4.9% 0.11
Oct 1 00:00:00 - 00:59:59 91 4.4% 0.03513.9 KB 6.5% 0.14
Oct 1 01:00:00 - 01:59:59 93 4.5% 0.03336.1 KB 4.3% 0.09
Oct 1 02:00:00 - 02:59:59 56 2.7% 0.02167.2 KB 2.1% 0.05
Oct 1 03:00:00 - 03:59:59 48 2.3% 0.01150.1 KB 1.9% 0.04
Oct 1 04:00:00 - 04:15:01 10 0.5% 0.01158.0 KB 2.0% 0.18
TOTAL: 24:00:00 2071 100.0% 0.027.7 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 76 0 0 0 0 0 0 0 76
2gegeweb-out.news.tnetconsulting.net 48 0 0 0 0 0 0 0 48
3news.glou.org 36 0 0 0 0 0 0 0 36
4usenet.pasdenom.info 18 0 0 0 0 0 0 0 18
5feed-out.gegeweb.org 5 0 0 0 0 0 0 0 5
6news.samoylyk.net 3 0 0 0 0 0 0 0 3
7nntp.terraraq.uk 1 0 0 0 0 0 0 0 1
8i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 8 188 0 0 0 0 0 0 0 188

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 68
Bad path (news.giganews.com.POSTED) 53
EMP (phn path) 53
Cancels abusifs 4
Cancel of <ac439bdd2eb5ae9de13853732ae9f4f8bb791a06@i2pn2.org> without Cancel-Key 1
Cancel of <0b62df719e6e874b1dbdb6522573baa6ee2fe21b@i2pn2.org> without Cancel-Key 1
Cancel of non-existing ID <lm01efFeue4U1@mid.individual.net> 1
Too many newsgroups (meow) 1
Cancel of <74c0262547139ad86d969aff39913963495b0261@i2pn2.org> without Cancel-Key 1
Cancel of <792d69cc19b6970cd36b532b8155e1a0264d0bde@i2pn2.org> without Cancel-Key 1
Cancel of <cd796b4355a34b79c7ac2d230745f74a1b0ffaaf@i2pn2.org> without Cancel-Key 1
Cancel of <e42b6dc0edde9eda78dc82624de1ddeb805f0896@i2pn2.org> without Cancel-Key 1
Too many newsgroups (low_xpost) 1
Cancel of <c5f77e3f7334a72cfb06d957d79a9b8d2d84a718@i2pn2.org> without Cancel-Key 1
TOTAL: 14 188

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1079 41 973 0 0 0 3%23:47:24
2i2pn.org 2989 34 1821 5 0 5 1%23:58:48
3news.samoylyk.net 2326 8 1887 21 0 0 0%23:50:55
4news.nntp4.net 2055 1 1860 3 0 0 0%23:58:10
5news.tnetconsulting.net 3450 1 2065 3 0 2 0%23:59:31
6nntp.terraraq.uk 1338 1 1306 0 0 0 0%23:47:28
7news.aioe.org 0 0 0 0 0 1547 0%24:00:00
8news.pasdenom.info 1913 0 1709 1 0 0 0%23:50:55
TOTAL: 8 15150 86 11621 33 0 1554 0%191:13:11
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org110.2 KB0.0 KB110.2 KB0.0 KB/s2.7 KB23:47:24
2i2pn.org76.4 KB29.6 KB106.0 KB0.0 KB/s2.7 KB23:58:48
3news.samoylyk.net36.0 KB69.8 KB105.7 KB0.0 KB/s3.6 KB23:50:55
4news.nntp4.net6.5 KB25.6 KB32.1 KB0.0 KB/s8.0 KB23:58:10
5nntp.terraraq.uk2.9 KB0.0 KB2.9 KB0.0 KB/s2.9 KB23:47:28
6news.tnetconsulting.net2.7 KB4.8 KB7.5 KB0.0 KB/s1.9 KB23:59:31
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.pasdenom.info0.0 KB1.7 KB1.7 KB0.0 KB/s1.7 KB23:50:55
TOTAL: 8234.7 KB131.3 KB366.1 KB0.0 KB/s3.1 KB191:13:11
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 6 17113.0 MB 20 0 000:06:02
TOTAL: 1 6 17113.0 MB 20 0 000:09:13

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 24 17113.0 MB 20 0 000:06:51
2*.stretchoid.com 1 00.0 KB 0 0 000:00:00
3*.gegeweb.eu 288 00.0 KB 0 0 000:01:55
4*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
6*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
7*.us-east-2.compute.amazonaws.com 4 00.0 KB 0 0 000:00:01
8*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:06
9*.internet-census.org 1 00.0 KB 0 0 000:00:10
10*.census.shodan.io 1 00.0 KB 0 0 000:00:00
TOTAL: 10 327 17113.0 MB 20 0 000:09:13

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 0.333 0.705 0.00000:06:02
mail.gegeweb.eu 5.161 4.391 1.70300:01:55
206.168.34.206 0.309 0.121 0.00000:00:15
206.168.34.218 0.308 0.101 0.00000:00:10
sh-ams-nl-gp1-wk111a.internet-census.org 0.012 0.012 0.00000:00:10
198.235.24.237 0.021 0.025 0.00000:00:10
205.210.31.194 0.023 0.019 0.00000:00:10
patient.monitoring.internet-measurement.com 0.048 0.012 0.00000:00:05
server-0-3.survey.inspici.com 0.025 0.021 0.00000:00:04
ec2-13-58-97-162.us-east-2.compute.amazonaws.com 0.097 0.089 0.00000:00:01
198.211.203.35.bc.googleusercontent.com 0.029 0.011 0.00000:00:01
virtuous.monitoring.internet-measurement.com 0.031 0.031 0.00000:00:00
155.150.216.162.bc.googleusercontent.com 0.057 0.032 0.00000:00:00
91.238.181.23 0.017 0.004 0.00000:00:00
azpdcgc23.stretchoid.com 0.015 0.008 0.00000:00:00
wine.census.shodan.io 0.033 0.021 0.00000:00:00
80.66.76.134 0.041 0.023 0.00000:00:00
staunch.monitoring.internet-measurement.com 0.032 0.032 0.00000:00:00
wonderful.monitoring.internet-measurement.com 0.043 0.012 0.00000:00:00
TOTAL: 19 6.635 5.670 1.70300:09:13

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
206.168.34.218 7
206.168.34.206 7
ec2-13-58-97-162.us-east-2.compute.amazonaws.com 4
sh-ams-nl-gp1-wk111a.internet-census.org 1
staunch.monitoring.internet-measurement.com 1
virtuous.monitoring.internet-measurement.com 1
azpdcgc23.stretchoid.com 1
155.150.216.162.bc.googleusercontent.com 1
patient.monitoring.internet-measurement.com 1
wine.census.shodan.io 1
198.211.203.35.bc.googleusercontent.com 1
80.66.76.134 1
198.235.24.237 1
91.238.181.23 1
server-0-3.survey.inspici.com 1
205.210.31.194 1
wonderful.monitoring.internet-measurement.com 1
alluring.monitoring.internet-measurement.com 1
TOTAL: 19 321

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
155.150.216.162.bc.googleusercontent.com 4
198.211.203.35.bc.googleusercontent.com 4
ec2-13-58-97-162.us-east-2.compute.amazonaws.com 3
91.238.181.23 1
206.168.34.218 1
206.168.34.206 1
azpdcgc23.stretchoid.com 1
TOTAL: 7 15

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
91.238.181.23 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 1349 78.8%
2local 362 21.2%
TOTAL: 2 1711100.0%

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

NewsgroupCount
1local.test 300
2grisbi.bugsreports 300
3grisbi.devel 300
4grisbi.user.french 300
5grisbi.test 300
6grisbi.cvs 96
7local.gegeweb.support 62
8grisbi.user 51
9grisbi.admin 2
TOTAL: 9 1711
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me