Daily Usenet report for news.niel.me

Jun 3 04:15:01 -- Jun 4 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 3 11:02:09 rpi-studio innd: filter: No Cancel-Key[sha1:bifE1eLqS5MMYKzHyT1a/tbmdkE=] matches Cancel-Lock[sha1:S7t8+wMnbcZveheKYrIpSfxA6w8=] target=<665d83eb$0$2577$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2468 29.9%468.9 KB 35.0%
innd 2090 25.3%366.4 KB 27.4%
nnrpd 1977 23.9%209.9 KB 15.7%
innfeed 1728 20.9%293.4 KB 21.9%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8265 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 14011 59.9%
Negative hits 6908 29.5%
Do not exist 2454 10.5%
Cache misses 10 0.0%
TOTAL: 4 23383 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.005 0.0%5 1.000 1.000 1.000
article cancel00:00:00.001 0.0%5 0.000 0.200 0.500
article cleanup00:00:00.052 0.0%2458 0.000 0.021 0.200
article logging00:00:00.196 0.0%2459 0.000 0.080 0.300
article parse00:00:00.294 0.0%5840 0.000 0.050 0.300
article write00:00:01.088 0.0%2299 0.000 0.473 1.182
artlog/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%5 0.000 0.200 1.000
data move00:00:00.116 0.0%24554 0.000 0.005 0.025
hisgrep/artcncl00:00:00.001 0.0%5 0.000 0.200 0.500
hisgrep/artcncl/perl00:00:00.001 0.0%5 0.000 0.200 0.500
hisgrep/perl00:00:00.000 0.0%6 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%5 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%5 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.364 0.0%23424 0.000 0.016 0.049
history sync00:00:00.046 0.0%346 0.000 0.133 1.000
history write00:00:00.379 0.0%2458 0.000 0.154 0.500
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:39.175100.0%27087 1418.099 3191.168 37542.312
nntp read00:00:00.645 0.0%26357 0.000 0.024 0.200
overview write00:00:00.979 0.0%2299 0.000 0.426 4.333
perl filter00:00:10.164 0.0%2458 2.135 4.135 15.000
python filter00:00:00.014 0.0%2458 0.000 0.006 0.167
site send00:00:00.827 0.0%4603 0.000 0.180 0.607
TOTAL: 24:01:02.08424:00:54.348100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.024 0.0%2324 0.000 0.010 0.118
article prepare00:00:00.001 0.0%644 0.000 0.002 0.028
article read00:00:00.024 0.0%154 0.000 0.156 1.500
backlog stats00:00:00.188 0.0%34467 0.000 0.005 0.030
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.458 0.0%18564 0.000 0.025 0.118
data write00:00:00.911 0.0%16506 0.008 0.055 0.135
idle23:50:17.749100.0%34467 1130.067 2489.853 9004.657
status file00:00:00.364 0.0%210 0.000 1.733 4.000
TOTAL: 23:50:24.17323:50:19.719100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:59.435 38.5%1520 19.400 39.102 10001.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.086 0.1%3381 0.000 0.025 0.400
readart00:00:00.003 0.0%2 1.500 1.500 1.500
TOTAL: 00:02:34.41300:00:59.524 38.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 2287 1230 1057 0 53%23:58:00
2news.nntp4.net 3 2975 327 2600 48 10%29:54:09
3gegeweb-out.news.tnetconsulting.net 2 2232 256 1896 80 11%28:05:29
4news.glou.org 2 3891 255 3519 117 6%47:58:40
5i2pn.org 3 2288 196 2089 3 8%23:56:36
6news.samoylyk.net 1 2318 120 2198 0 5%23:59:48
7usenet.pasdenom.info 2 1372 114 1257 1 8%21:34:59
8nntp.terraraq.uk 1 317 17 300 0 5%05:46:37
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 42 17680 2515 14916 249 14%205:14:18
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org4.4 MB0.0 KB0.0 KB4.4 MB100%3.7 KB
2news.nntp4.net1.2 MB0.0 KB163.1 KB1.3 MB 88%3.7 KB
3news.glou.org943.5 KB0.0 KB238.6 KB1.2 MB 79%3.2 KB
4news.samoylyk.net862.6 KB0.0 KB0.0 KB862.6 KB100%7.2 KB
5gegeweb-out.news.tnetconsulting.net707.0 KB0.0 KB290.0 KB997.0 KB 70%3.0 KB
6i2pn.org558.3 KB0.0 KB4.1 KB562.5 KB 99%2.8 KB
7usenet.pasdenom.info270.6 KB0.0 KB1.2 KB271.8 KB 99%2.4 KB
8nntp.terraraq.uk54.9 KB0.0 KB0.0 KB54.9 KB100%3.2 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 98.9 MB0.0 KB697.1 KB9.6 MB 92%3.5 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 3 04:15:01 - 04:59:59 57 2.5% 0.02264.4 KB 3.2% 0.10
Jun 3 05:00:00 - 05:59:59 50 2.2% 0.01156.3 KB 1.9% 0.04
Jun 3 06:00:00 - 06:59:59 38 1.7% 0.01136.0 KB 1.6% 0.04
Jun 3 07:00:00 - 07:59:59 61 2.7% 0.02213.3 KB 2.6% 0.06
Jun 3 08:00:00 - 08:59:59 59 2.6% 0.02183.3 KB 2.2% 0.05
Jun 3 09:00:00 - 09:59:59 106 4.6% 0.03402.6 KB 4.9% 0.11
Jun 3 10:00:00 - 10:59:59 114 5.0% 0.03441.9 KB 5.3% 0.12
Jun 3 11:00:00 - 11:59:59 72 3.1% 0.02224.6 KB 2.7% 0.06
Jun 3 12:00:00 - 12:59:59 82 3.6% 0.02258.1 KB 3.1% 0.07
Jun 3 13:00:00 - 13:59:59 82 3.6% 0.02285.7 KB 3.4% 0.08
Jun 3 14:00:00 - 14:59:59 77 3.4% 0.02261.8 KB 3.2% 0.07
Jun 3 15:00:00 - 15:59:59 145 6.3% 0.04429.4 KB 5.2% 0.12
Jun 3 16:00:00 - 16:59:59 105 4.6% 0.03363.1 KB 4.4% 0.10
Jun 3 17:00:00 - 17:59:59 131 5.7% 0.04669.1 KB 8.1% 0.19
Jun 3 18:00:00 - 18:59:59 106 4.6% 0.03547.1 KB 6.6% 0.15
Jun 3 19:00:00 - 19:59:59 110 4.8% 0.03342.3 KB 4.1% 0.10
Jun 3 20:00:00 - 20:59:59 117 5.1% 0.03398.6 KB 4.8% 0.11
Jun 3 21:00:00 - 21:59:59 156 6.8% 0.04599.3 KB 7.2% 0.17
Jun 3 22:00:00 - 22:59:59 148 6.4% 0.04480.5 KB 5.8% 0.13
Jun 3 23:00:00 - 23:59:59 120 5.2% 0.03358.7 KB 4.3% 0.10
Jun 4 00:00:00 - 00:59:59 109 4.7% 0.03312.1 KB 3.8% 0.09
Jun 4 01:00:00 - 01:59:59 91 4.0% 0.03287.1 KB 3.5% 0.08
Jun 4 02:00:00 - 02:59:59 91 4.0% 0.03336.1 KB 4.1% 0.09
Jun 4 03:00:00 - 03:59:59 58 2.5% 0.02297.9 KB 3.6% 0.08
Jun 4 04:00:00 - 04:15:01 13 0.6% 0.0142.1 KB 0.5% 0.05
TOTAL: 24:00:00 2298 100.0% 0.038.1 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1gegeweb-out.news.tnetconsulting.net 57 0 0 0 0 0 0 0 57
2news.glou.org 48 0 0 0 0 0 0 0 48
3news.nntp4.net 44 0 0 0 0 0 0 0 44
4news.samoylyk.net 5 0 0 0 0 0 0 0 5
5usenet.pasdenom.info 3 0 0 0 0 0 0 0 3
6i2pn.org 3 0 0 0 0 0 0 0 3
TOTAL: 6 160 0 0 0 0 0 0 0 160

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 59
EMP (phn path) 57
Too many newsgroups 34
EMP (md5) 5
Cancels abusifs 2
hierarchy violation - crosspost outside sdnet 1
No Cancel-Key matches Cancel-Lock. target=<665d83eb$0$2577$426a74cc@news.free.fr> 1
TOTAL: 7 159

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
usenet.pasdenom.info 1
TOTAL: 1 1
TOTAL: 1 1

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3438 88 2022 11 0 19 2%23:59:38
2news.gegeweb.org 1134 41 1029 0 0 0 3%23:51:14
3news.tnetconsulting.net 3779 10 2279 8 0 15 0%23:59:57
4nntp.terraraq.uk 1540 1 1415 0 0 0 0%23:59:57
5news.samoylyk.net 2559 1 2204 0 0 3 0%23:54:05
6news.pasdenom.info 2082 1 1899 0 0 0 0%23:59:57
7news.aioe.org 0 0 0 0 0 1790 0%24:00:00
8news.nntp4.net 2130 0 2042 0 0 0 0%23:59:57
TOTAL: 8 16662 142 12890 19 0 1827 0%191:44:45
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org258.4 KB86.4 KB344.8 KB0.0 KB/s3.5 KB23:59:38
2news.gegeweb.org121.3 KB0.0 KB121.3 KB0.0 KB/s3.0 KB23:51:14
3news.tnetconsulting.net35.3 KB24.4 KB59.7 KB0.0 KB/s3.3 KB23:59:57
4news.samoylyk.net7.8 KB0.0 KB7.8 KB0.0 KB/s7.8 KB23:54:05
5nntp.terraraq.uk5.0 KB0.0 KB5.0 KB0.0 KB/s5.0 KB23:59:57
6news.pasdenom.info1.4 KB0.0 KB1.4 KB0.0 KB/s1.4 KB23:59:57
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 8429.2 KB110.7 KB539.9 KB0.0 KB/s3.4 KB191:44:45
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 30 22.1 KB 1 0 000:00:09
TOTAL: 1 30 22.1 KB 1 0 000:02:33

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 41 22.1 KB 1 0 000:00:26
2*.internet-census.org 1 00.0 KB 0 0 000:00:11
3*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:06
4*.w92-154.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
5*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
6*.gegeweb.eu 287 00.0 KB 0 0 000:01:39
TOTAL: 6 337 22.1 KB 1 0 000:02:33

NNRP auth users [Top 20]:

UserConn
mailman 287
TOTAL: 1 287

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 4.367 3.959 1.43300:01:39
sh-ams-nl-gp1-wk116a.internet-census.org 0.030 0.023 0.00000:00:11
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 0.033 0.021 0.00000:00:10
69.10.48.174 0.630 0.559 0.00000:00:09
prudent.monitoring.internet-measurement.com 0.051 0.021 0.00000:00:05
172.104.238.162 0.038 0.013 0.00000:00:02
206.168.34.63 0.040 0.028 0.00000:00:02
206.168.34.116 0.008 0.023 0.00000:00:02
206.168.34.44 0.033 0.029 0.00000:00:01
71.6.134.235 0.031 0.018 0.00000:00:01
162.243.138.62 0.013 0.013 0.00000:00:01
206.168.34.187 0.065 0.025 0.00000:00:01
233.150.216.162.bc.googleusercontent.com 0.051 0.027 0.00000:00:01
206.168.34.40 0.036 0.032 0.00000:00:01
206.168.34.182 0.043 0.019 0.00000:00:01
194.165.16.72 0.028 0.024 0.00000:00:00
lovely.monitoring.internet-measurement.com 0.046 0.019 0.00000:00:00
thriving.monitoring.internet-measurement.com 0.047 0.016 0.00000:00:00
proud.monitoring.internet-measurement.com 0.034 0.023 0.00000:00:00
TOTAL: 19 5.624 4.892 1.43300:02:33

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 287
206.168.34.187 2
172.104.238.162 1
thriving.monitoring.internet-measurement.com 1
cheery.monitoring.internet-measurement.com 1
71.6.134.235 1
lustrous.monitoring.internet-measurement.com 1
233.150.216.162.bc.googleusercontent.com 1
162.243.138.62 1
206.168.34.116 1
prudent.monitoring.internet-measurement.com 1
206.168.34.44 1
sh-ams-nl-gp1-wk116a.internet-census.org 1
lovely.monitoring.internet-measurement.com 1
206.168.34.63 1
206.168.34.182 1
proud.monitoring.internet-measurement.com 1
194.165.16.72 1
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 1
206.168.34.40 1
TOTAL: 20 307

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
233.150.216.162.bc.googleusercontent.com 3
206.168.34.187 2
206.168.34.116 1
162.243.138.62 1
206.168.34.40 1
194.165.16.72 1
206.168.34.182 1
206.168.34.63 1
206.168.34.44 1
TOTAL: 9 12

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 7
Host: 45.13.105.36:563 1
MGLNDD_45.13.105.36_119 1
#003 1
GET / HTTP/1.1 1
User-Agent: Expanse, a Palo Alto Network... 1
TOTAL: 6 12

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.72 1 1
TOTAL: 1 1 1

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 2100.0%
TOTAL: 1 2100.0%

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

NewsgroupCount
1grisbi.admin 2
TOTAL: 1 2
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me