Daily Usenet report for news.niel.me

Aug 27 04:15:01 -- Aug 28 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Aug 27 17:02:51 rpi-studio innd: filter: No Cancel-Key[sha1:hx5ncVApeh7eeihliCNNHzNo4vE=] matches Cancel-Lock[sha1:ClOsVDAKDh3jva4+v2gIS5KNIJ0=] target=<66cde9d5$0$3595$426a34cc@news.free.fr>
Aug 27 19:34:48 rpi-studio innd: filter: No Cancel-Key[sha1:miJPag/9ZqxowT8MO4givkshO7g=] matches Cancel-Lock[sha1:WUziTPkYVnBzFPcWiB20DdxSeho=] target=<66ce0de5$0$3578$426a74cc@news.free.fr>
Aug 28 01:00:02 rpi-studio controlchan[2208]: Unknown "tag" control by robomod@news.nic.it

Log entries by program:

Program nameLines%LinesSize%Size
inn 2775 32.2%524.2 KB 37.4%
innd 2185 25.4%385.7 KB 27.5%
nnrpd 1888 21.9%207.9 KB 14.8%
innfeed 1764 20.5%285.2 KB 20.3%
controlchan 2 0.0%0.3 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8615 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 15083 59.6%
Negative hits 7478 29.5%
Do not exist 2756 10.9%
Cache misses 2 0.0%
TOTAL: 4 25319 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.006 0.0%4 1.000 1.500 2.000
article cancel00:00:00.000 0.0%4 0.000 0.000 0.000
article cleanup00:00:00.063 0.0%2762 0.000 0.023 0.333
article logging00:00:00.211 0.0%2764 0.000 0.076 0.286
article parse00:00:00.371 0.0%6398 0.000 0.058 0.273
article write00:00:01.284 0.0%2511 0.000 0.511 1.036
artlog/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.001 0.0%4 0.000 0.250 1.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.160 0.0%26667 0.000 0.006 0.029
hisgrep/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%4 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.430 0.0%25386 0.000 0.017 0.054
history sync00:00:00.055 0.0%405 0.000 0.136 0.667
history write00:00:00.504 0.0%2762 0.000 0.182 0.800
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:47.237100.0%28847 1053.807 2996.750 15408.846
nntp read00:00:00.762 0.0%28207 0.000 0.027 0.076
overview write00:00:00.858 0.0%2511 0.000 0.342 3.250
perl filter00:00:12.409 0.0%2762 2.405 4.493 9.714
python filter00:00:00.018 0.0%2762 0.000 0.007 0.100
site send00:00:00.950 0.0%5060 0.000 0.188 0.500
TOTAL: 24:01:14.69424:01:05.319100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.033 0.0%2635 0.000 0.013 0.333
article prepare00:00:00.008 0.0%1328 0.000 0.006 0.125
article read00:00:00.061 0.0%311 0.000 0.196 7.000
backlog stats00:00:00.202 0.0%36382 0.000 0.006 0.038
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.510 0.0%19928 0.000 0.026 0.094
data write00:00:01.081 0.0%18001 0.000 0.060 0.136
idle23:58:21.109100.0%36382 1027.337 2372.083 7613.937
status file00:00:02.647 0.0%215 1.000 12.312 59.000
TOTAL: 23:58:31.07823:58:25.651100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:01:24.970 98.5%1607 3.000 4533.273600422.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.126 0.0%3770 0.000 0.033 0.364
readart00:00:00.022 0.0%117 0.183 0.188 0.193
TOTAL: 02:03:12.35402:01:25.118 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 2462 1132 1330 0 45%23:59:14
2gegeweb-out.news.tnetconsulting.net 2 2590 559 1970 61 21%28:16:44
3news.nntp4.net 2 3695 426 3153 116 11%32:25:14
4i2pn.org 2 2262 180 2080 2 7%23:58:18
5usenet.pasdenom.info 3 1366 126 1211 29 9%27:31:24
6news.glou.org 2 2124 85 1953 86 4%25:11:31
7nntp.terraraq.uk 1 2147 38 2106 3 1%23:59:57
8news.samoylyk.net 2 339 26 313 0 7%06:13:05
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 42 16985 2572 14116 297 15%191:35:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.9 MB0.0 KB0.0 KB3.9 MB100%3.5 KB
2gegeweb-out.news.tnetconsulting.net2.2 MB0.0 KB230.5 KB2.4 MB 90%4.0 KB
3news.nntp4.net1.8 MB0.0 KB585.6 KB2.4 MB 76%4.5 KB
4i2pn.org600.3 KB0.0 KB4.2 KB604.5 KB 99%3.3 KB
5news.glou.org303.0 KB0.0 KB219.4 KB522.4 KB 57%3.1 KB
6usenet.pasdenom.info290.0 KB0.0 KB44.5 KB334.4 KB 86%2.2 KB
7nntp.terraraq.uk210.0 KB0.0 KB7.0 KB217.0 KB 96%5.3 KB
8news.samoylyk.net100.5 KB0.0 KB0.0 KB100.5 KB100%3.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 99.4 MB0.0 KB1.1 MB10.4 MB 89%3.7 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Aug 27 04:15:01 - 04:59:59 40 1.6% 0.01111.4 KB 1.1% 0.04
Aug 27 05:00:00 - 05:59:59 58 2.3% 0.02208.5 KB 2.1% 0.06
Aug 27 06:00:00 - 06:59:59 45 1.8% 0.01166.1 KB 1.7% 0.05
Aug 27 07:00:00 - 07:59:59 68 2.7% 0.02211.3 KB 2.1% 0.06
Aug 27 08:00:00 - 08:59:59 43 1.7% 0.01153.3 KB 1.6% 0.04
Aug 27 09:00:00 - 09:59:59 88 3.5% 0.02453.8 KB 4.6% 0.13
Aug 27 10:00:00 - 10:59:59 105 4.2% 0.03373.2 KB 3.8% 0.10
Aug 27 11:00:00 - 11:59:59 78 3.1% 0.02257.0 KB 2.6% 0.07
Aug 27 12:00:00 - 12:59:59 86 3.4% 0.02330.7 KB 3.4% 0.09
Aug 27 13:00:00 - 13:59:59 127 5.1% 0.04438.3 KB 4.5% 0.12
Aug 27 14:00:00 - 14:59:59 89 3.5% 0.02314.8 KB 3.2% 0.09
Aug 27 15:00:00 - 15:59:59 160 6.4% 0.04550.6 KB 5.6% 0.15
Aug 27 16:00:00 - 16:59:59 112 4.5% 0.03391.7 KB 4.0% 0.11
Aug 27 17:00:00 - 17:59:59 245 9.7% 0.071.3 MB 13.7% 0.38
Aug 27 18:00:00 - 18:59:59 123 4.9% 0.03540.4 KB 5.5% 0.15
Aug 27 19:00:00 - 19:59:59 172 6.8% 0.05632.3 KB 6.4% 0.18
Aug 27 20:00:00 - 20:59:59 109 4.3% 0.03403.3 KB 4.1% 0.11
Aug 27 21:00:00 - 21:59:59 143 5.7% 0.04493.5 KB 5.0% 0.14
Aug 27 22:00:00 - 22:59:59 145 5.8% 0.04554.6 KB 5.6% 0.15
Aug 27 23:00:00 - 23:59:59 119 4.7% 0.03531.1 KB 5.4% 0.15
Aug 28 00:00:00 - 00:59:59 82 3.3% 0.02320.6 KB 3.3% 0.09
Aug 28 01:00:00 - 01:59:59 106 4.2% 0.03315.5 KB 3.2% 0.09
Aug 28 02:00:00 - 02:59:59 86 3.4% 0.02413.0 KB 4.2% 0.11
Aug 28 03:00:00 - 03:59:59 64 2.5% 0.02261.4 KB 2.7% 0.07
Aug 28 04:00:00 - 04:15:02 21 0.8% 0.0262.5 KB 0.6% 0.07
TOTAL: 24:00:01 2514 100.0% 0.039.6 MB 100.0% 0.11
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.glou.org 86 0 0 0 0 0 0 0 86
2news.nntp4.net 84 1 0 0 0 0 0 0 83
3gegeweb-out.news.tnetconsulting.net 51 0 0 0 0 0 0 0 51
4usenet.pasdenom.info 28 0 0 0 0 0 0 0 28
5feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
6i2pn.org 2 0 0 0 0 0 0 0 2
TOTAL: 6 253 1 0 0 0 0 0 0 252

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 135
Bad path (news.giganews.com.POSTED) 54
Too many newsgroups 54
Cancel for rejected article 2
Cancel of <020b7340fc57ac100e234a9afc61a16ced35012d@i2pn2.org> without Cancel-Key 1
No Cancel-Key matches Cancel-Lock. target=<66ce0de5$0$3578$426a74cc@news.free.fr> 1
No Cancel-Key matches Cancel-Lock. target=<66cde9d5$0$3595$426a34cc@news.free.fr> 1
Cancel of <7455bb66087a8e50c92253949d60471de16cb377@i2pn2.org> without Cancel-Key 1
Cancels abusifs 1
TOTAL: 9 250

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 2
TOTAL: 1 2
TOTAL: 1 2

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1437 64 1320 0 0 0 4%23:44:36
2i2pn.org 3700 61 2269 4 0 43 1%23:58:20
3news.samoylyk.net 3445 57 2197 125 0 53 1%23:59:58
4news.tnetconsulting.net 3967 9 2497 6 0 24 0%23:59:58
5news.pasdenom.info 2021 5 1864 0 0 0 0%23:54:01
6news.nntp4.net 2274 1 2151 0 0 2 0%23:57:41
7nntp.terraraq.uk 1588 0 1529 0 0 0 0%23:53:56
8news.aioe.org 0 0 0 0 0 1959 0%24:00:01
TOTAL: 8 18432 197 13827 135 0 2081 1%191:28:31
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org244.8 KB0.0 KB244.8 KB0.0 KB/s3.8 KB23:44:36
2news.samoylyk.net194.2 KB546.4 KB740.5 KB0.0 KB/s4.1 KB23:59:58
3i2pn.org170.2 KB63.9 KB234.1 KB0.0 KB/s3.6 KB23:58:20
4news.pasdenom.info35.5 KB0.0 KB35.5 KB0.0 KB/s7.1 KB23:54:01
5news.tnetconsulting.net31.7 KB74.5 KB106.3 KB0.0 KB/s7.1 KB23:59:58
6news.nntp4.net4.0 KB0.0 KB4.0 KB0.0 KB/s4.0 KB23:57:41
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:56
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 8680.4 KB684.8 KB1.3 MB0.0 KB/s4.1 KB191:28:31
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 2 117241.8 KB 17 0 000:00:27
TOTAL: 1 2 117241.8 KB 17 0 002:03:11

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 9 117241.8 KB 17 0 000:00:51
2*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
3*.w92-154.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:12
4*.stretchoid.com 2 00.0 KB 0 0 000:00:10
5*.rev.sfr.net 4 00.0 KB 0 0 001:59:52
6*.gegeweb.eu 288 00.0 KB 0 0 000:01:51
7*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:09
8*.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
TOTAL: 8 312 117241.8 KB 17 0 002:03:11

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
2a02-8428-0e98-6001-56b3-548e-bea9-05ec.rev.sfr.net 0.067 0.068 0.00001:59:52
mail.gegeweb.eu 5.229 4.312 1.72000:01:51
69.10.48.174 0.083 0.086 0.00000:00:27
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 0.016 0.008 0.00000:00:12
205.210.31.19 0.026 0.018 0.00000:00:10
198.235.24.196 0.013 0.009 0.00000:00:10
azpdcsc4.stretchoid.com 0.033 0.015 0.00000:00:09
vivid.monitoring.internet-measurement.com 0.047 0.014 0.00000:00:06
calm.monitoring.internet-measurement.com 0.033 0.017 0.00000:00:02
208.211.203.35.bc.googleusercontent.com 0.054 0.025 0.00000:00:01
9.149.216.162.bc.googleusercontent.com 0.056 0.022 0.00000:00:01
azpdcgb90.stretchoid.com 0.013 0.009 0.00000:00:01
91.238.181.31 0.020 0.024 0.00000:00:01
88.214.25.63 0.004 0.018 0.00000:00:00
92.255.85.102 0.033 0.013 0.00000:00:00
194.165.16.10 0.048 0.012 0.00000:00:00
198.235.24.149 0.038 0.013 0.00000:00:00
upstanding.monitoring.internet-measurement.com 0.032 0.032 0.00000:00:00
cute.monitoring.internet-measurement.com 0.035 0.028 0.00000:00:00
patient.monitoring.internet-measurement.com 0.041 0.021 0.00000:00:00
TOTAL: 20 5.921 4.764 1.72002:03:11

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
2a02-8428-0e98-6001-56b3-548e-bea9-05ec.rev.sfr.net 4
9.149.216.162.bc.googleusercontent.com 1
azpdcsc4.stretchoid.com 1
208.211.203.35.bc.googleusercontent.com 1
upstanding.monitoring.internet-measurement.com 1
205.210.31.19 1
vivid.monitoring.internet-measurement.com 1
91.238.181.31 1
patient.monitoring.internet-measurement.com 1
cute.monitoring.internet-measurement.com 1
198.235.24.196 1
88.214.25.63 1
pretty.monitoring.internet-measurement.com 1
92.255.85.102 1
calm.monitoring.internet-measurement.com 1
azpdcgb90.stretchoid.com 1
lstlambert-656-1-48-236.w92-154.abo.wanadoo.fr 1
198.235.24.149 1
194.165.16.10 1
TOTAL: 20 310

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
9.149.216.162.bc.googleusercontent.com 4
208.211.203.35.bc.googleusercontent.com 4
88.214.25.63 1
92.255.85.102 1
azpdcgb90.stretchoid.com 1
91.238.181.31 1
TOTAL: 6 12

NNRP unrecognized commands (by command):

CommandCount
#003 3
GET / HTTP/1.1 2
Host: 45.13.105.36:563 2
User-Agent: Expanse, a Palo Alto Network... 2
Accept-Encoding: gzip 2
MGLNDD_45.13.105.36_119 1
TOTAL: 6 12

NNRP client timeouts [Top 20]:

SystemConnPeer
2a02-8428-0e98-6001-56b3-548e-bea9-05ec.rev.sfr.net 2 0
91.238.181.31 1 1
88.214.25.63 1 1
92.255.85.102 1 1
TOTAL: 4 5 4

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 90 76.9%
2local 27 23.1%
TOTAL: 2 117100.0%

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

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