Daily Usenet report for news.niel.me

Nov 18 04:15:01 -- Nov 19 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 18 09:50:13 rpi-studio innd: filter: No Cancel-Key[sha1:Ncxz/BlcB4ID+7eE/OIdrLeluBQ=] matches Cancel-Lock[sha1:rri6OAycaEPYMQRFqUYL66L9TOQ=] target=<673af72e$0$29744$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 3050 31.6%332.1 KB 21.9%
inn 2648 27.4%526.1 KB 34.7%
innd 2190 22.7%376.2 KB 24.8%
innfeed 1762 18.3%282.2 KB 18.6%
controlchan 1 0.0%0.1 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 9652 100.0%1.5 MB100.0%

History cache:

ReasonCount%Count
Positive hits 15265 54.7%
Negative hits 10026 35.9%
Do not exist 2625 9.4%
Cache misses 9 0.0%
TOTAL: 4 27925 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.001 0.0%3 0.000 0.333 1.000
article cancel00:00:00.000 0.0%3 0.000 0.000 0.000
article cleanup00:00:00.059 0.0%2644 0.000 0.022 0.400
article logging00:00:00.199 0.0%2650 0.000 0.075 0.278
article parse00:00:00.388 0.0%6151 0.000 0.063 0.400
article write00:00:01.218 0.0%2447 0.167 0.498 1.429
artlog/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
data move00:00:00.149 0.0%29469 0.000 0.005 0.034
hisgrep/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%4 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%3 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.433 0.0%28059 0.000 0.015 0.054
history sync00:00:00.039 0.0%351 0.000 0.111 1.000
history write00:00:00.407 0.0%2636 0.000 0.154 0.500
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:37.381100.0%31866 821.568 2712.527 12514.292
nntp read00:00:00.772 0.0%30691 0.000 0.025 0.075
overview write00:00:00.669 0.0%2447 0.000 0.273 1.727
perl filter00:00:08.864 0.0%2636 2.133 3.363 7.400
python filter00:00:00.016 0.0%2636 0.000 0.006 0.143
site send00:00:00.947 0.0%5166 0.000 0.183 0.577
TOTAL: 24:01:00.11124:00:51.542100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.017 0.0%2482 0.000 0.007 0.111
article prepare00:00:00.000 0.0%664 0.000 0.000 0.000
article read00:00:00.024 0.0%152 0.000 0.158 1.333
backlog stats00:00:00.198 0.0%33342 0.000 0.006 0.023
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.474 0.0%19276 0.000 0.025 0.118
data write00:00:00.911 0.0%16937 0.000 0.054 0.109
idle23:58:08.673100.0%33342 1020.811 2587.987 9538.333
status file00:00:00.387 0.0%207 0.000 1.870 7.000
TOTAL: 23:58:18.72823:58:10.684100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle02:08:39.808 95.5%23836 9.600 323.872600148.667
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:03.074 0.0%89756 0.000 0.034 1.667
readart00:00:02.887 0.0%20787 0.102 0.139 0.407
TOTAL: 02:14:42.49702:08:45.769 95.6%----

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
1gegeweb-out.news.tnetconsulting.net 2 1878 909 929 40 48%21:56:40
2feed-out.gegeweb.org 6 2387 446 1941 0 18%25:46:47
3news.nntp4.net 1 3629 270 3255 104 7%35:21:42
4i2pn.org 2 1467 222 1243 2 15%18:59:21
5news.samoylyk.net 2 599 62 537 0 10%09:02:10
6news.glou.org 3 2021 55 1884 82 2%29:10:47
7usenet.pasdenom.info 3 694 39 652 3 5%14:42:41
8nntp.terraraq.uk 2 969 10 959 0 1%15:12:20
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 46 13644 2013 11400 231 14%170:12:28
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1gegeweb-out.news.tnetconsulting.net2.9 MB7.0 KB155.0 KB3.1 MB 94%3.3 KB
2feed-out.gegeweb.org1.6 MB0.0 KB0.0 KB1.6 MB100%3.8 KB
3news.nntp4.net1.4 MB2.2 KB312.6 KB1.7 MB 81%4.6 KB
4i2pn.org649.6 KB5.4 KB5.4 KB660.5 KB 98%2.9 KB
5news.samoylyk.net278.2 KB0.0 KB0.0 KB278.2 KB100%4.5 KB
6news.glou.org168.8 KB0.0 KB232.4 KB401.2 KB 42%2.9 KB
7usenet.pasdenom.info101.7 KB0.0 KB5.4 KB107.1 KB 94%2.5 KB
8nntp.terraraq.uk21.2 KB0.0 KB0.0 KB21.2 KB100%2.1 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.1 MB14.6 KB710.9 KB7.8 MB 90%3.6 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 18 04:15:01 - 04:59:59 37 1.5% 0.01216.1 KB 2.0% 0.08
Nov 18 05:00:00 - 05:59:59 49 2.0% 0.01205.0 KB 1.9% 0.06
Nov 18 06:00:00 - 06:59:59 45 1.8% 0.01143.7 KB 1.3% 0.04
Nov 18 07:00:00 - 07:59:59 60 2.5% 0.02161.7 KB 1.5% 0.04
Nov 18 08:00:00 - 08:59:59 48 2.0% 0.01203.1 KB 1.9% 0.06
Nov 18 09:00:00 - 09:59:59 66 2.7% 0.02206.4 KB 1.9% 0.06
Nov 18 10:00:00 - 10:59:59 115 4.7% 0.03522.9 KB 4.9% 0.15
Nov 18 11:00:00 - 11:59:59 85 3.5% 0.02255.0 KB 2.4% 0.07
Nov 18 12:00:00 - 12:59:59 110 4.5% 0.03332.6 KB 3.1% 0.09
Nov 18 13:00:00 - 13:59:59 93 3.8% 0.03255.6 KB 2.4% 0.07
Nov 18 14:00:00 - 14:59:59 97 4.0% 0.03315.4 KB 3.0% 0.09
Nov 18 15:00:00 - 15:59:59 132 5.4% 0.04597.0 KB 5.6% 0.17
Nov 18 16:00:00 - 16:59:59 121 5.0% 0.03653.9 KB 6.1% 0.18
Nov 18 17:00:00 - 17:59:59 165 6.8% 0.051.2 MB 11.6% 0.35
Nov 18 18:00:00 - 18:59:59 157 6.4% 0.04874.5 KB 8.2% 0.24
Nov 18 19:00:00 - 19:59:59 171 7.0% 0.05572.7 KB 5.4% 0.16
Nov 18 20:00:00 - 20:59:59 169 6.9% 0.05896.1 KB 8.4% 0.25
Nov 18 21:00:00 - 21:59:59 134 5.5% 0.04518.4 KB 4.9% 0.14
Nov 18 22:00:00 - 22:59:59 124 5.1% 0.03616.9 KB 5.8% 0.17
Nov 18 23:00:00 - 23:59:59 109 4.5% 0.03563.7 KB 5.3% 0.16
Nov 19 00:00:00 - 00:59:59 125 5.1% 0.03487.1 KB 4.6% 0.14
Nov 19 01:00:00 - 01:59:59 76 3.1% 0.02280.1 KB 2.6% 0.08
Nov 19 02:00:00 - 02:59:59 72 3.0% 0.02246.6 KB 2.3% 0.07
Nov 19 03:00:00 - 03:59:59 75 3.1% 0.02288.3 KB 2.7% 0.08
Nov 19 04:00:00 - 04:15:02 4 0.2% 0.0015.4 KB 0.1% 0.02
TOTAL: 24:00:01 2439 100.0% 0.0310.4 MB 100.0% 0.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 71 0 0 1 0 0 0 0 70
2news.glou.org 66 0 0 0 0 0 0 0 66
3gegeweb-out.news.tnetconsulting.net 47 0 0 3 0 0 0 0 44
4usenet.pasdenom.info 6 0 0 0 0 0 0 0 6
5feed-out.gegeweb.org 4 0 0 0 0 0 0 0 4
6nntp.terraraq.uk 4 0 0 0 0 0 0 0 4
7i2pn.org 3 0 0 2 0 0 0 0 1
8news.samoylyk.net 2 0 0 2 0 0 0 0 0
TOTAL: 8 203 0 0 8 0 0 0 0 195

INND Perl filter [Top 20]:

ReasonCount
EMP (phn path) 93
Bad path (news.giganews.com.POSTED) 50
Too many newsgroups 39
EMP (md5) 3
HTML Multipart 2
No Cancel-Key matches Cancel-Lock. target=<673af72e$0$29744$426a74cc@news.free.fr> 1
Cancel for rejected article 1
TOTAL: 7 189

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
feed-out.gegeweb.org 4
news.nntp4.net 1
nntp.terraraq.uk 1
TOTAL: 3 6
TOTAL: 1 6

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2978 77 2063 15 0 19 2%23:57:19
2news.gegeweb.org 2153 37 1939 0 0 0 1%23:59:13
3news.tnetconsulting.net 3236 10 2413 10 0 13 0%23:59:58
4news.samoylyk.net 2634 4 2171 9 0 11 0%24:05:54
5nntp.terraraq.uk 1606 2 1514 0 0 0 0%23:55:43
6news.nntp4.net 2343 1 2173 1 0 0 0%23:57:57
7news.pasdenom.info 2118 0 1946 0 0 0 0%23:57:14
8news.aioe.org 0 0 0 0 0 2123 0%24:00:01
TOTAL: 8 17068 131 14219 35 0 2166 0%191:53:19
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org181.2 KB80.6 KB261.8 KB0.0 KB/s2.8 KB23:57:19
2news.gegeweb.org87.2 KB0.0 KB87.2 KB0.0 KB/s2.4 KB23:59:13
3news.tnetconsulting.net35.9 KB34.6 KB70.5 KB0.0 KB/s3.5 KB23:59:58
4news.samoylyk.net33.0 KB37.4 KB70.4 KB0.0 KB/s5.4 KB24:05:54
5nntp.terraraq.uk4.7 KB0.0 KB4.7 KB0.0 KB/s2.4 KB23:55:43
6news.nntp4.net2.5 KB9.5 KB12.0 KB0.0 KB/s6.0 KB23:57:57
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:57:14
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 8344.5 KB162.2 KB506.7 KB0.0 KB/s3.1 KB191:53:19
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1162.250.122.68 104 2078735.6 MB 331 0 001:08:14
TOTAL: 1 104 2078735.6 MB 331 0 002:14:41

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 120 2078735.6 MB 331 0 001:12:11
2*.census.shodan.io 1 00.0 KB 0 0 000:00:01
3*.stretchoid.com 1 00.0 KB 0 0 000:00:00
4*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5*.ip.linodeusercontent.com 95 00.0 KB 0 0 000:00:24
6*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
7*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:06
8*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
9*.rev.sfr.net 2 00.0 KB 0 0 001:00:03
10*.gegeweb.eu 283 00.0 KB 0 0 000:01:47
TOTAL: 10 510 2078735.6 MB 331 0 002:14:41

NNRP auth users [Top 20]:

UserConn
mailman 283
TOTAL: 1 283

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
162.250.122.68 5.540 8.868 0.00001:08:14
2a02-842a-00fb-c801-a7d0-7104-07b6-628a.rev.sfr.net 0.051 0.047 0.00001:00:03
mail.gegeweb.eu 4.258 3.593 1.48700:01:47
206.168.34.117 0.040 0.016 0.00000:00:31
206.168.34.220 0.040 0.016 0.00000:00:31
206.168.34.125 0.020 0.008 0.00000:00:31
206.168.34.113 0.033 0.022 0.00000:00:31
206.168.34.192 0.038 0.026 0.00000:00:30
206.168.34.126 0.042 0.021 0.00000:00:30
206.168.34.204 0.039 0.026 0.00000:00:30
172-105-246-139.ip.linodeusercontent.com 2.273 1.291 0.00000:00:24
88.214.25.65 0.015 0.008 0.00000:00:06
199.45.154.155 0.086 0.072 0.00000:00:06
server-0-3.survey.inspici.com 0.030 0.017 0.00000:00:04
198.235.24.150 0.023 0.026 0.00000:00:04
bubbly.monitoring.internet-measurement.com 0.038 0.034 0.00000:00:03
amazing.monitoring.internet-measurement.com 0.022 0.000 0.00000:00:01
dojo.census.shodan.io 0.014 0.009 0.00000:00:01
80.66.76.134 0.047 0.016 0.00000:00:01
206.168.34.193 0.036 0.028 0.00000:00:01
TOTAL: 28 13.013 14.293 1.48702:14:41

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 283
172-105-246-139.ip.linodeusercontent.com 95
199.45.154.155 3
2a02-842a-00fb-c801-a7d0-7104-07b6-628a.rev.sfr.net 2
206.168.34.44 1
azpdcgc52.stretchoid.com 1
trusting.monitoring.internet-measurement.com 1
bubbly.monitoring.internet-measurement.com 1
206.168.34.125 1
ingenious.monitoring.internet-measurement.com 1
206.168.34.192 1
206.168.34.193 1
88.214.25.65 1
206.168.34.220 1
80.66.76.134 1
91.150.216.162.bc.googleusercontent.com 1
241.149.216.162.bc.googleusercontent.com 1
206.168.34.117 1
lively.monitoring.internet-measurement.com 1
dojo.census.shodan.io 1
TOTAL: 27 406

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
241.149.216.162.bc.googleusercontent.com 4
91.150.216.162.bc.googleusercontent.com 4
88.214.25.65 1
206.168.34.193 1
azpdcgc52.stretchoid.com 1
206.168.34.44 1
199.45.154.155 1
TOTAL: 7 13

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

SystemConnPeer
162.250.122.68 2 2
2a02-842a-00fb-c801-a7d0-7104-07b6-628a.rev.sfr.net 2 0
88.214.25.65 1 1
199.45.154.155 1 2
TOTAL: 4 6 7

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 16262 78.2%
2local 4525 21.8%
TOTAL: 2 20787100.0%

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

NewsgroupCount
1grisbi.bugsreports 3761
2grisbi.test 3416
3local.test 3083
4grisbi.user.french 3024
5grisbi.devel 3005
6grisbi.cvs 1988
7local.gegeweb.support 1442
8grisbi.user 1016
9grisbi.admin 52
TOTAL: 9 20787
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me