Daily Usenet report for news.niel.me

May 18 04:15:02 -- May 19 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

May 18 19:35:50 rpi-studio innd: filter: No Cancel-Key[sha1:bQDwvNEH41stu7NdGVo+ksir6jA= sha256:JcOt/4tyQ4IVXBps41rUC2naTVo6UX0gWUSGxAq4Szc=] matches Cancel-Lock[sha1:tQMNeheFv4+ZEhN4k8Kr5Et1FJg= sha256:wsnu0vf9mFBYm3Vqa4Y2c6W76N1xATy1/vyOLDZ5VDY=] target=<100cipk$55n$1@rasp.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
innd 2119 27.2%372.6 KB 30.6%
nnrpd 1912 24.5%218.3 KB 17.9%
inn 1890 24.2%337.9 KB 27.7%
innfeed 1880 24.1%290.1 KB 23.8%
nocem 1 0.0%0.2 KB 0.0%
controlchan 1 0.0%0.1 KB 0.0%
TOTAL: 6 7803 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 9653 58.3%
Negative hits 5060 30.5%
Do not exist 1849 11.2%
Cache misses 3 0.0%
TOTAL: 4 16565 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.016 0.0%16 1.000 1.000 1.000
article cancel00:00:00.004 0.0%17 0.000 0.235 1.000
article cleanup00:00:00.049 0.0%1867 0.000 0.026 0.167
article logging00:00:00.154 0.0%1868 0.000 0.082 0.500
article parse00:00:00.265 0.0%4750 0.000 0.056 0.207
article write00:00:00.795 0.0%1659 0.000 0.479 1.111
artlog/artcncl00:00:00.001 0.0%17 0.000 0.059 1.000
artlog/artcncl/perl00:00:00.001 0.0%16 0.000 0.062 1.000
data move00:00:00.107 0.0%18644 0.000 0.006 0.052
hisgrep/artcncl00:00:00.000 0.0%17 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%16 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%18 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%17 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%16 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.295 0.0%16624 0.000 0.018 0.066
history sync00:00:00.060 0.0%399 0.000 0.150 1.000
history write00:00:00.289 0.0%1867 0.000 0.155 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:56.038100.0%19988 916.992 4325.397 28597.810
nntp read00:00:00.564 0.0%19251 0.000 0.029 0.103
overview write00:00:00.567 0.0%1659 0.000 0.342 4.333
perl filter00:00:11.348 0.0%1867 2.048 6.078 23.000
python filter00:00:00.014 0.0%1867 0.000 0.007 0.143
site send00:00:00.556 0.0%3388 0.000 0.164 0.485
TOTAL: 24:01:21.09324:01:11.123100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.020 0.0%1676 0.000 0.012 0.333
article prepare00:00:00.001 0.0%236 0.000 0.004 0.019
article read00:00:00.012 0.0%56 0.000 0.214 3.000
backlog stats00:00:00.126 0.0%24890 0.000 0.005 0.028
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.344 0.0%12504 0.000 0.028 0.154
data write00:00:00.569 0.0%10921 0.000 0.052 0.190
idle23:51:38.611100.0%24890 1119.739 3451.129 8994.414
status file00:00:11.054 0.0%304 1.000 36.362 88.000
TOTAL: 23:51:55.44023:51:50.737100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle01:17:10.172 97.1%16490 9.600 280.787 2754.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:04.914 0.1%63105 0.000 0.078 1.000
readart00:00:02.582 0.1%14870 0.163 0.174 0.183
TOTAL: 01:19:28.14201:17:17.668 97.3%----

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

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news.nntp4.net 2 1799 727 897 175 40%23:58:32
2feed-out.gegeweb.org 3 1628 339 1289 0 20%23:58:46
3news.samoylyk.net 2 1304 190 1114 0 14%17:51:43
4i2pn.org 1 1518 174 1336 8 11%22:32:27
5news.glou.org 4 1244 81 1146 17 6%23:53:01
6gegeweb-out.news.tnetconsulting.net 2 2383 79 2303 1 3%39:05:03
7usenet.pasdenom.info 12 849 21 828 0 2%24:27:01
8nntp.terraraq.uk 5 2062 10 2052 0 0%36:23:53
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 56 12787 1621 10965 201 12%212:10:26
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net3.5 MB0.0 KB847.7 KB4.3 MB 80%4.9 KB
2news.samoylyk.net2.0 MB0.0 KB0.0 KB2.0 MB100%10.9 KB
3feed-out.gegeweb.org1.1 MB0.0 KB0.0 KB1.1 MB100%3.2 KB
4i2pn.org395.3 KB0.0 KB13.4 KB408.7 KB 96%2.2 KB
5gegeweb-out.news.tnetconsulting.net310.9 KB0.0 KB127.6 KB438.5 KB 70%5.5 KB
6news.glou.org250.6 KB0.0 KB49.8 KB300.4 KB 83%3.1 KB
7usenet.pasdenom.info50.1 KB0.0 KB0.0 KB50.1 KB100%2.4 KB
8nntp.terraraq.uk16.5 KB0.0 KB0.0 KB16.5 KB100%1.7 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.5 MB0.0 KB1.0 MB8.6 MB 88%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 18 04:15:02 - 04:59:59 42 2.5% 0.02180.3 KB 2.2% 0.07
May 18 05:00:00 - 05:59:59 52 3.1% 0.01147.6 KB 1.8% 0.04
May 18 06:00:00 - 06:59:59 26 1.6% 0.0169.3 KB 0.8% 0.02
May 18 07:00:00 - 07:59:59 45 2.7% 0.01313.0 KB 3.8% 0.09
May 18 08:00:00 - 08:59:59 41 2.5% 0.01346.6 KB 4.2% 0.10
May 18 09:00:00 - 09:59:59 30 1.8% 0.01142.2 KB 1.7% 0.04
May 18 10:00:00 - 10:59:59 71 4.3% 0.02470.4 KB 5.8% 0.13
May 18 11:00:00 - 11:59:59 75 4.5% 0.02672.3 KB 8.2% 0.19
May 18 12:00:00 - 12:59:59 66 4.0% 0.02249.9 KB 3.1% 0.07
May 18 13:00:00 - 13:59:59 91 5.5% 0.03501.2 KB 6.1% 0.14
May 18 14:00:00 - 14:59:59 69 4.2% 0.02251.0 KB 3.1% 0.07
May 18 15:00:00 - 15:59:59 78 4.7% 0.02284.9 KB 3.5% 0.08
May 18 16:00:00 - 16:59:59 74 4.5% 0.02254.4 KB 3.1% 0.07
May 18 17:00:00 - 17:59:59 72 4.3% 0.02246.0 KB 3.0% 0.07
May 18 18:00:00 - 18:59:59 95 5.7% 0.03300.1 KB 3.7% 0.08
May 18 19:00:00 - 19:59:59 132 8.0% 0.041.2 MB 15.3% 0.35
May 18 20:00:00 - 20:59:59 79 4.8% 0.02233.0 KB 2.8% 0.06
May 18 21:00:00 - 21:59:59 120 7.2% 0.03627.9 KB 7.7% 0.17
May 18 22:00:00 - 22:59:59 113 6.8% 0.03486.2 KB 5.9% 0.14
May 18 23:00:00 - 23:59:59 69 4.2% 0.02203.6 KB 2.5% 0.06
May 19 00:00:00 - 00:59:59 43 2.6% 0.01170.6 KB 2.1% 0.05
May 19 01:00:00 - 01:59:59 44 2.7% 0.01412.7 KB 5.0% 0.11
May 19 02:00:00 - 02:59:59 49 3.0% 0.01128.9 KB 1.6% 0.04
May 19 03:00:00 - 03:59:59 58 3.5% 0.02150.7 KB 1.8% 0.04
May 19 04:00:00 - 04:15:02 22 1.3% 0.0285.3 KB 1.0% 0.09
TOTAL: 24:00:00 1656 100.0% 0.028.0 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 175 57 0 0 0 0 0 0 118
2news.glou.org 17 0 0 0 0 0 0 0 17
3i2pn.org 8 0 0 0 0 0 0 0 8
4feed-out.gegeweb.org 1 0 0 0 0 0 0 0 1
TOTAL: 4 201 57 0 0 0 0 0 0 144

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.git 29
linux.kernel.netdev 27
news.test 1
TOTAL: 3 57

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 87
Bad path (news.giganews.com.POSTED) 52
Cancels abusifs 2
HTML Multipart 1
Cancel of non-existing ID <1008eja$3vuc5$1@dont-email.me> 1
TOTAL: 5 143

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 1430 12 1305 0 0 0 0%23:52:09
2news.tnetconsulting.net 2453 12 1626 9 0 20 0%23:59:13
3i2pn.org 2253 9 1453 14 0 10 0%23:59:17
4news.pasdenom.info 1264 3 1172 0 0 0 0%23:53:59
5news.samoylyk.net 1617 0 1373 0 0 0 0%23:44:24
6news.aioe.org 0 0 0 0 0 1315 0%24:00:00
7news.nntp4.net 987 0 919 0 0 0 0%23:12:49
8nntp.terraraq.uk 1091 0 992 0 0 0 0%23:53:06
TOTAL: 8 11095 36 8840 23 0 1345 0%190:34:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org104.8 KB146.4 KB251.2 KB0.0 KB/s10.9 KB23:59:17
2news.gegeweb.org61.1 KB0.0 KB61.1 KB0.0 KB/s5.1 KB23:52:09
3news.tnetconsulting.net60.3 KB65.3 KB125.6 KB0.0 KB/s6.0 KB23:59:13
4news.pasdenom.info7.3 KB0.0 KB7.3 KB0.0 KB/s2.4 KB23:53:59
5news.samoylyk.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:44:24
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:12:49
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:53:06
TOTAL: 8233.4 KB211.7 KB445.1 KB0.0 KB/s7.5 KB190:34:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1syn-066-061-096-239.res.spectrum.com 8 1487039.4 MB 12 0 001:16:56
TOTAL: 1 8 1487039.4 MB 12 0 001:19:31

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.res.spectrum.com 8 1487039.4 MB 12 0 001:16:56
2unresolved 4 00.0 KB 0 0 000:00:08
3*.stretchoid.com 1 00.0 KB 0 0 000:00:01
4*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:07
5*.probe.onyphe.net 2 00.0 KB 0 0 000:00:05
6*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
7? 6 00.0 KB 0 0 000:00:14
8*.gegeweb.eu 288 00.0 KB 0 0 000:01:56
9*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
TOTAL: 9 316 1487039.4 MB 12 0 001:19:31

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
syn-066-061-096-239.res.spectrum.com 3.102 7.272 0.00001:16:56
mail.gegeweb.eu 4.874 4.453 1.91900:01:56
2a06:4882:3000::35 0.050 0.028 0.00000:00:08
fostering.monitoring.internet-measurement.com 0.053 0.019 0.00000:00:04
198.235.24.90 0.029 0.021 0.00000:00:03
perceptive.monitoring.internet-measurement.com 0.042 0.017 0.00000:00:03
theodor.probe.onyphe.net 0.033 0.016 0.00000:00:03
2a06:4882:3000::3b 0.044 0.012 0.00000:00:03
2a06:4883:b000::c3 0.021 0.030 0.00000:00:02
205.210.31.93 0.012 0.012 0.00000:00:02
wheatley.probe.onyphe.net 0.025 0.029 0.00000:00:02
azpdcg6r8yih.stretchoid.com 0.027 0.022 0.00000:00:01
187.149.216.162.bc.googleusercontent.com 0.052 0.024 0.00000:00:01
71.6.134.232 0.024 0.020 0.00000:00:01
194.165.16.167 0.011 0.011 0.00000:00:00
104.150.216.162.bc.googleusercontent.com 0.060 0.028 0.00000:00:00
rewarding.monitoring.internet-measurement.com 0.028 0.016 0.00000:00:00
2a06:4883:d000::f3 0.036 0.020 0.00000:00:00
TOTAL: 18 8.523 12.050 1.91901:19:31

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
2a06:4883:d000::f3 1
187.149.216.162.bc.googleusercontent.com 1
2a06:4882:3000::35 1
realized.monitoring.internet-measurement.com 1
2a06:4883:d000::ec 1
198.235.24.90 1
2a06:4882:d000::e7 1
205.210.31.93 1
2a06:4882:3000::3b 1
rewarding.monitoring.internet-measurement.com 1
2a06:4883:b000::c3 1
azpdcg6r8yih.stretchoid.com 1
104.150.216.162.bc.googleusercontent.com 1
194.165.16.167 1
theodor.probe.onyphe.net 1
fostering.monitoring.internet-measurement.com 1
71.6.134.232 1
unwavering.monitoring.internet-measurement.com 1
perceptive.monitoring.internet-measurement.com 1
TOTAL: 21 308

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
187.149.216.162.bc.googleusercontent.com 4
104.150.216.162.bc.googleusercontent.com 4
wheatley.probe.onyphe.net 2
azpdcg6r8yih.stretchoid.com 1
194.165.16.167 1
TOTAL: 5 12

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 2
Accept-Encoding: gzip 2
User-Agent: Expanse, a Palo Alto Network... 2
Host: 45.13.105.36:563 2
#003 1
MGLNDD_45.13.105.36_119 1
#026#003#003#001¥#001 1
À$À­À¯À,ÀrÀsÌ©#023#002#023#001Ì#024À#007À#022À#023À'À/À#024À(À0À`Àa... 1
TOTAL: 8 12

NNRP client timeouts [Top 20]:

SystemConnPeer
194.165.16.167 1 1
TOTAL: 1 1 3

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 14870100.0%
TOTAL: 1 14870100.0%

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

NewsgroupCount
1grisbi.bugsreports 6746
2grisbi.test 5999
3grisbi.user.french 2007
4grisbi.devel 118
TOTAL: 4 14870
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me