Daily Usenet report for news.niel.me

Sep 17 04:15:02 -- Sep 18 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 17 13:48:41 rpi-studio innd: filter: No Cancel-Key[sha1:Yd1N1RA/89SGCap/Y/lknRHZbK8= sha256:97KHMTAFMz/ebAiTErGowpVRwW37GkmfDv9pENc34jM=#015#012#011sha1:3+YQY9cqGS4lMbt8N8c+WxyuEXo= sha256:IJpJXVAs+7XFqJrxDuM5p9onkfU3/4Xnz2S5wyIyFj4=] matches Cancel-Lock[sha1:UqzXY/B/Eu/vAEMwTIKrkmxr0QM= sha256:aBwi8j6syz9mbM1+GEyHkRD039YnJTdXAd3y5UVaevU=] target=<vcbq7v$m9$1@rasp.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2367 28.7%447.3 KB 33.6%
innd 2116 25.6%369.8 KB 27.8%
nnrpd 1993 24.2%225.9 KB 17.0%
innfeed 1767 21.4%287.9 KB 21.6%
controlchan 6 0.1%1.0 KB 0.1%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8250 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 12828 60.3%
Negative hits 6104 28.7%
Do not exist 2326 10.9%
Cache misses 2 0.0%
TOTAL: 4 21260 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.012 0.0%13 0.857 0.923 1.000
article cancel00:00:00.003 0.0%14 0.000 0.214 1.000
article cleanup00:00:00.045 0.0%2345 0.000 0.019 0.200
article logging00:00:00.186 0.0%2345 0.000 0.079 0.474
article parse00:00:00.327 0.0%5101 0.000 0.064 0.333
article write00:00:01.159 0.0%2182 0.000 0.531 1.154
artlog/artcncl00:00:00.002 0.0%14 0.000 0.143 1.000
artlog/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.105 0.0%21937 0.000 0.005 0.037
hisgrep/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%14 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.347 0.0%21359 0.000 0.016 0.055
history sync00:00:00.055 0.0%396 0.000 0.139 1.000
history write00:00:00.388 0.0%2338 0.000 0.166 0.769
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:44.144100.0%24052 1351.820 3594.052 19365.871
nntp read00:00:00.611 0.0%23318 0.000 0.026 0.073
overview write00:00:00.733 0.0%2182 0.000 0.336 2.889
perl filter00:00:12.656 0.0%2338 1.346 5.413 21.000
python filter00:00:00.012 0.0%2338 0.000 0.005 0.125
site send00:00:00.803 0.0%4405 0.000 0.182 0.500
TOTAL: 24:01:10.63524:01:01.588100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.025 0.0%2272 0.000 0.011 0.143
article prepare00:00:00.001 0.0%620 0.000 0.002 0.250
article read00:00:00.037 0.0%150 0.000 0.247 8.000
backlog stats00:00:00.195 0.0%32113 0.000 0.006 0.027
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.411 0.0%17135 0.000 0.024 0.059
data write00:00:00.861 0.0%15286 0.000 0.056 0.127
idle23:50:19.962100.0%32113 1367.084 2672.437 7058.588
status file00:00:03.766 0.0%214 1.000 17.598 65.000
TOTAL: 23:50:29.63223:50:25.258100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle03:01:40.669 98.8%24558 3.500 443.874 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.098 0.0%94102 0.000 0.044 0.500
readart00:00:03.719 0.0%22294 0.143 0.167 0.818
TOTAL: 03:03:55.63703:01:48.486 98.8%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
usenet@novabbs.com001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1feed-out.gegeweb.org 6 2139 1101 1037 1 51%23:56:38
2gegeweb-out.news.tnetconsulting.net 2 1992 286 1664 42 14%24:00:15
3i2pn.org 2 2220 167 2053 0 7%23:58:39
4news.nntp4.net 1 1581 152 1371 58 9%17:34:21
5usenet.pasdenom.info 6 1091 111 978 2 10%23:21:03
6news.glou.org 2 1663 69 1590 4 4%23:58:28
7news.samoylyk.net 2 715 43 671 1 6%08:52:01
8nntp.terraraq.uk 2 1942 39 1901 2 2%24:00:02
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 48 13343 1968 11265 110 14%169:41:27
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.5 MB0.0 KB4.3 KB3.5 MB 99%3.3 KB
2gegeweb-out.news.tnetconsulting.net1.0 MB0.0 KB141.6 KB1.1 MB 87%3.6 KB
3news.nntp4.net870.6 KB0.0 KB134.8 KB1005.4 KB 86%4.8 KB
4news.samoylyk.net722.1 KB4.8 KB4.8 KB731.7 KB 98%16.6 KB
5i2pn.org461.6 KB0.0 KB0.0 KB461.6 KB100%2.8 KB
6nntp.terraraq.uk411.4 KB0.0 KB19.4 KB430.8 KB 95%10.5 KB
7usenet.pasdenom.info247.5 KB1.7 KB2.9 KB252.1 KB 98%2.2 KB
8news.glou.org224.2 KB0.0 KB8.2 KB232.4 KB 96%3.2 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.4 MB6.5 KB316.1 KB7.7 MB 95%3.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 17 04:15:02 - 04:59:59 46 2.1% 0.02181.0 KB 2.2% 0.07
Sep 17 05:00:00 - 05:59:59 77 3.5% 0.02538.9 KB 6.4% 0.15
Sep 17 06:00:00 - 06:59:59 53 2.4% 0.01161.3 KB 1.9% 0.04
Sep 17 07:00:00 - 07:59:59 72 3.3% 0.02244.1 KB 2.9% 0.07
Sep 17 08:00:00 - 08:59:59 92 4.2% 0.03300.9 KB 3.6% 0.08
Sep 17 09:00:00 - 09:59:59 63 2.9% 0.02250.9 KB 3.0% 0.07
Sep 17 10:00:00 - 10:59:59 88 4.0% 0.02259.4 KB 3.1% 0.07
Sep 17 11:00:00 - 11:59:59 150 6.9% 0.04727.4 KB 8.7% 0.20
Sep 17 12:00:00 - 12:59:59 98 4.5% 0.03810.5 KB 9.7% 0.23
Sep 17 13:00:00 - 13:59:59 80 3.7% 0.02445.5 KB 5.3% 0.12
Sep 17 14:00:00 - 14:59:59 132 6.1% 0.04481.1 KB 5.7% 0.13
Sep 17 15:00:00 - 15:59:59 85 3.9% 0.02257.1 KB 3.1% 0.07
Sep 17 16:00:00 - 16:59:59 93 4.3% 0.03256.9 KB 3.1% 0.07
Sep 17 17:00:00 - 17:59:59 113 5.2% 0.03373.8 KB 4.5% 0.10
Sep 17 18:00:00 - 18:59:59 83 3.8% 0.02241.7 KB 2.9% 0.07
Sep 17 19:00:00 - 19:59:59 108 5.0% 0.03346.9 KB 4.1% 0.10
Sep 17 20:00:00 - 20:59:59 143 6.6% 0.04492.9 KB 5.9% 0.14
Sep 17 21:00:00 - 21:59:59 112 5.1% 0.03373.9 KB 4.5% 0.10
Sep 17 22:00:00 - 22:59:59 118 5.4% 0.03412.9 KB 4.9% 0.11
Sep 17 23:00:00 - 23:59:59 131 6.0% 0.04515.8 KB 6.1% 0.14
Sep 18 00:00:00 - 00:59:59 74 3.4% 0.02228.4 KB 2.7% 0.06
Sep 18 01:00:00 - 01:59:59 69 3.2% 0.02229.0 KB 2.7% 0.06
Sep 18 02:00:00 - 02:59:59 54 2.5% 0.01156.7 KB 1.9% 0.04
Sep 18 03:00:00 - 03:59:59 33 1.5% 0.0183.5 KB 1.0% 0.02
Sep 18 04:00:00 - 04:15:02 9 0.4% 0.0126.9 KB 0.3% 0.03
TOTAL: 24:00:00 2176 100.0% 0.038.2 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 107 0 0 1 0 0 0 0 106
2gegeweb-out.news.tnetconsulting.net 45 0 0 0 0 0 0 0 45
3news.glou.org 4 0 0 0 0 0 0 0 4
4news.samoylyk.net 2 0 0 2 0 0 0 0 0
5nntp.terraraq.uk 2 0 0 2 0 0 0 0 0
6usenet.pasdenom.info 2 0 0 1 0 0 0 0 1
7feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
8i2pn.org 1 0 0 1 0 0 0 0 0
TOTAL: 8 164 0 0 7 0 0 0 0 157

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 104
Bad path (news.giganews.com.POSTED) 48
EMP (phn path) 1
Cancel of non-existing ID <lkudm6FbkdnU1@mid.individual.net> 1
Too many newsgroups (meow) 1
Cancel of <f9112fb35579ab1bb1e6b4ab13e814ab94559496@i2pn2.org> without Cancel-Key 1
Cancels abusifs 1
TOTAL: 7 157

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 3217 59 1935 4 0 50 1%23:59:57
2news.gegeweb.org 1136 57 1014 0 0 0 5%23:53:33
3news.samoylyk.net 2377 7 1937 17 0 30 0%23:59:57
4news.tnetconsulting.net 3550 4 2163 5 0 19 0%23:59:57
5news.pasdenom.info 1844 2 1679 0 0 0 0%23:59:21
6news.aioe.org 0 0 0 0 0 1703 0%24:00:00
7nntp.terraraq.uk 1322 0 1290 0 0 0 0%23:56:37
8news.nntp4.net 2103 0 1968 0 0 2 0%23:59:57
TOTAL: 8 15549 129 11986 26 0 1804 0%191:49:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.gegeweb.org207.7 KB0.0 KB207.7 KB0.0 KB/s3.6 KB23:53:33
2i2pn.org161.3 KB9.1 KB170.4 KB0.0 KB/s2.7 KB23:59:57
3news.samoylyk.net31.2 KB106.4 KB137.6 KB0.0 KB/s5.7 KB23:59:57
4news.tnetconsulting.net11.5 KB35.6 KB47.1 KB0.0 KB/s5.2 KB23:59:57
5news.pasdenom.info4.5 KB0.0 KB4.5 KB0.0 KB/s2.2 KB23:59:21
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:56:37
8news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
TOTAL: 8416.2 KB151.1 KB567.2 KB0.0 KB/s3.7 KB191:49:19
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 22 2229435.8 MB 37 0 003:00:45
TOTAL: 1 22 2229435.8 MB 37 0 003:03:55

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 31 2229435.8 MB 37 0 003:01:42
2*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
3*.monitoring.internet-measurement.com 4 00.0 KB 0 0 000:00:07
4*.gegeweb.eu 288 00.0 KB 0 0 000:01:48
5*.w80-13.abo.wanadoo.fr 1 00.0 KB 0 0 000:00:10
6*.149.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:02
7*.stretchoid.com 1 00.0 KB 0 0 000:00:00
TOTAL: 7 328 2229435.8 MB 37 0 003:03:55

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 4.399 10.267 0.00003:00:45
mail.gegeweb.eu 5.261 4.419 1.72800:01:48
194.165.16.72 0.036 0.026 0.00000:00:28
147.185.132.18 0.024 0.024 0.00000:00:10
lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr 0.027 0.024 0.00000:00:10
198.235.24.29 0.025 0.025 0.00000:00:10
199.45.154.112 0.104 0.096 0.00000:00:06
plentiful.monitoring.internet-measurement.com 0.075 0.020 0.00000:00:06
server-0-2.survey.inspici.com 0.028 0.024 0.00000:00:04
125.149.216.162.bc.googleusercontent.com 0.036 0.004 0.00000:00:01
101.149.216.162.bc.googleusercontent.com 0.031 0.009 0.00000:00:00
91.238.181.31 0.019 0.026 0.00000:00:00
azpdeg37.stretchoid.com 0.022 0.030 0.00000:00:00
198.235.24.97 0.038 0.013 0.00000:00:00
classical.monitoring.internet-measurement.com 0.032 0.024 0.00000:00:00
successful.monitoring.internet-measurement.com 0.034 0.030 0.00000:00:00
keen.monitoring.internet-measurement.com 0.012 0.016 0.00000:00:00
TOTAL: 17 10.203 15.077 1.72803:03:55

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
199.45.154.112 4
198.235.24.97 1
azpdeg37.stretchoid.com 1
91.238.181.31 1
194.165.16.72 1
lputeaux-658-1-30-140.w80-13.abo.wanadoo.fr 1
101.149.216.162.bc.googleusercontent.com 1
198.235.24.29 1
successful.monitoring.internet-measurement.com 1
125.149.216.162.bc.googleusercontent.com 1
classical.monitoring.internet-measurement.com 1
147.185.132.18 1
plentiful.monitoring.internet-measurement.com 1
server-0-2.survey.inspici.com 1
keen.monitoring.internet-measurement.com 1
TOTAL: 16 306

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
125.149.216.162.bc.googleusercontent.com 4
101.149.216.162.bc.googleusercontent.com 4
199.45.154.112 2
azpdeg37.stretchoid.com 1
91.238.181.31 1
TOTAL: 5 12

NNRP unrecognized commands (by command):

CommandCount
Accept-Encoding: gzip 2
GET / HTTP/1.1 2
User-Agent: Expanse, a Palo Alto Network... 2
Host: 45.13.105.36:563 2
#026#003#001 1
áIéÿ#034,|«Oú#032Ú#010ÏïåÓÌ#027É%#030Ô˜aè¶Ó#027 1
#003 1
MGLNDD_45.13.105.36_119 1
TOTAL: 8 12

NNRP client timeouts [Top 20]:

SystemConnPeer
69.10.48.174 1 1
199.45.154.112 1 3
91.238.181.31 1 1
TOTAL: 3 3 6

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 21100 94.6%
2local 1194 5.4%
TOTAL: 2 22294100.0%

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

NewsgroupCount
1grisbi.bugsreports 9191
2grisbi.test 6524
3grisbi.user.french 3226
4grisbi.devel 1849
5local.test 1070
6grisbi.cvs 202
7local.gegeweb.support 124
8grisbi.user 102
9grisbi.admin 6
TOTAL: 9 22294
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me