Daily Usenet report for news.niel.me

Nov 2 04:15:01 -- Nov 3 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Nov 2 11:50:08 rpi-studio innd: filter: No Cancel-Key[sha1:Ce/TwBHS4qPl3h8qTiQNj/uAuGU= sha256:fVqq3mGvV8H2CizSxSxgirrbp50lfO20A827t90mpW0=#015#012#011sha1:9ecgqPtMwYpJifz//iet/Y80HlU= sha256:qYnMD2FEum2bQf56UC0bVjY/KwiVdUNMf/dtsm/KMwE=] matches Cancel-Lock[sha1:m/g/0qdI2gSOUZaifbWXxDBO4m0= sha256:Ru392e60YdGEy+vEVf4hleSHTptJFnJZFzGGiVojBYk=] target=<vg5011$2id$1@rasp.pasdenom.info>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2532 29.6%502.1 KB 36.1%
nnrpd 2159 25.2%246.3 KB 17.7%
innd 2135 24.9%368.0 KB 26.5%
innfeed 1732 20.2%274.1 KB 19.7%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 8560 100.0%1.4 MB100.0%

History cache:

ReasonCount%Count
Positive hits 13844 55.8%
Negative hits 8479 34.2%
Do not exist 2484 10.0%
Cache misses 6 0.0%
TOTAL: 4 24813 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.028 0.0%21 0.000 1.333 3.000
article cancel00:00:00.005 0.0%22 0.000 0.227 1.000
article cleanup00:00:00.056 0.0%2486 0.000 0.023 0.143
article logging00:00:00.177 0.0%2486 0.000 0.071 0.333
article parse00:00:00.362 0.0%5797 0.000 0.062 0.300
article write00:00:01.190 0.0%2296 0.000 0.518 1.143
artlog/artcncl00:00:00.002 0.0%22 0.000 0.091 1.000
artlog/artcncl/perl00:00:00.002 0.0%21 0.000 0.095 1.000
data move00:00:00.131 0.0%26403 0.000 0.005 0.025
hisgrep/artcncl00:00:00.000 0.0%22 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%21 0.000 0.048 0.500
hisgrep/perl00:00:00.001 0.0%25 0.000 0.040 1.000
hishave/artcncl00:00:00.000 0.0%22 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.001 0.0%21 0.000 0.048 1.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.357 0.0%24801 0.000 0.014 0.063
history sync00:00:00.049 0.0%361 0.000 0.136 1.000
history write00:00:00.441 0.0%2486 0.000 0.177 0.643
idle24:00:40.758100.0%28402 928.921 3043.474 12517.250
nntp read00:00:00.678 0.0%27542 0.000 0.025 0.070
overview write00:00:00.641 0.0%2296 0.000 0.279 2.765
perl filter00:00:08.826 0.0%2486 1.500 3.550 9.125
python filter00:00:00.013 0.0%2486 0.000 0.005 0.091
site send00:00:01.005 0.0%4882 0.000 0.206 0.519
TOTAL: 24:01:02.24424:00:54.724100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.026 0.0%2496 0.000 0.010 0.250
article prepare00:00:00.004 0.0%980 0.000 0.004 0.062
article read00:00:00.048 0.0%240 0.000 0.200 8.000
backlog stats00:00:00.178 0.0%32771 0.000 0.005 0.032
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.482 0.0%18298 0.000 0.026 0.071
data write00:00:00.945 0.0%16394 0.000 0.058 0.136
idle23:57:48.204100.0%32771 929.138 2632.456 7086.000
status file00:00:00.424 0.0%206 0.000 2.058 7.000
TOTAL: 23:57:55.86023:57:50.311100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle08:39:15.202 98.8%53467 0.000 582.700 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:07.431 0.0%207674 0.000 0.036 1.000
readart00:00:06.657 0.0%50164 0.117 0.133 0.370
TOTAL: 08:45:23.49708:39:29.290 98.9%----

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 2126 1039 1039 48 48%24:38:07
2feed-out.gegeweb.org 2 2144 389 1755 0 18%23:59:55
3i2pn.org 3 2555 349 2206 0 13%27:04:24
4usenet.pasdenom.info 4 2857 233 2619 5 8%44:47:11
5news.nntp4.net 2 2870 219 2512 139 7%28:37:13
6news.glou.org 2 3641 171 3460 10 4%47:23:24
7news.samoylyk.net 3 2181 157 2024 0 7%22:48:20
8nntp.terraraq.uk 3 4060 59 4001 0 1%45:50:22
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 46 22434 2616 19616 202 11%265:08:56
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1gegeweb-out.news.tnetconsulting.net4.0 MB0.0 KB222.2 KB4.2 MB 94%4.0 KB
2feed-out.gegeweb.org1.8 MB0.0 KB0.0 KB1.8 MB100%4.9 KB
3news.nntp4.net1.6 MB0.0 KB413.2 KB2.0 MB 80%5.8 KB
4news.samoylyk.net1.1 MB0.0 KB0.0 KB1.1 MB100%7.4 KB
5i2pn.org1.0 MB0.0 KB0.0 KB1.0 MB100%3.0 KB
6news.glou.org723.2 KB0.0 KB60.9 KB784.1 KB 92%4.3 KB
7usenet.pasdenom.info582.7 KB0.0 KB6.0 KB588.7 KB 98%2.5 KB
8nntp.terraraq.uk289.2 KB0.0 KB0.0 KB289.2 KB100%4.9 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 911.2 MB0.0 KB702.3 KB11.9 MB 94%4.3 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 2 04:15:01 - 04:59:59 57 2.5% 0.02221.8 KB 2.1% 0.08
Nov 2 05:00:00 - 05:59:59 44 1.9% 0.01162.3 KB 1.6% 0.05
Nov 2 06:00:00 - 06:59:59 49 2.1% 0.01330.1 KB 3.2% 0.09
Nov 2 07:00:00 - 07:59:59 74 3.2% 0.02307.5 KB 3.0% 0.09
Nov 2 08:00:00 - 08:59:59 79 3.4% 0.02444.8 KB 4.3% 0.12
Nov 2 09:00:00 - 09:59:59 68 3.0% 0.02232.5 KB 2.2% 0.06
Nov 2 10:00:00 - 10:59:59 72 3.1% 0.02213.5 KB 2.0% 0.06
Nov 2 11:00:00 - 11:59:59 104 4.5% 0.03384.1 KB 3.7% 0.11
Nov 2 12:00:00 - 12:59:59 115 5.0% 0.03487.1 KB 4.7% 0.14
Nov 2 13:00:00 - 13:59:59 91 4.0% 0.03666.2 KB 6.4% 0.19
Nov 2 14:00:00 - 14:59:59 105 4.6% 0.03330.2 KB 3.2% 0.09
Nov 2 15:00:00 - 15:59:59 88 3.8% 0.02356.3 KB 3.4% 0.10
Nov 2 16:00:00 - 16:59:59 70 3.0% 0.02380.1 KB 3.6% 0.11
Nov 2 17:00:00 - 17:59:59 106 4.6% 0.03434.5 KB 4.2% 0.12
Nov 2 18:00:00 - 18:59:59 99 4.3% 0.03510.7 KB 4.9% 0.14
Nov 2 19:00:00 - 19:59:59 112 4.9% 0.03576.7 KB 5.5% 0.16
Nov 2 20:00:00 - 20:59:59 126 5.5% 0.04431.9 KB 4.1% 0.12
Nov 2 21:00:00 - 21:59:59 123 5.4% 0.03525.5 KB 5.0% 0.15
Nov 2 22:00:00 - 22:59:59 259 11.3% 0.07943.5 KB 9.1% 0.26
Nov 2 23:00:00 - 23:59:59 140 6.1% 0.04686.5 KB 6.6% 0.19
Nov 3 00:00:00 - 00:59:59 77 3.3% 0.02326.8 KB 3.1% 0.09
Nov 3 01:00:00 - 01:59:59 96 4.2% 0.03601.5 KB 5.8% 0.17
Nov 3 02:00:00 - 02:59:59 74 3.2% 0.02624.6 KB 6.0% 0.17
Nov 3 03:00:00 - 03:59:59 54 2.3% 0.01176.6 KB 1.7% 0.05
Nov 3 04:00:00 - 04:15:01 17 0.7% 0.0265.8 KB 0.6% 0.07
TOTAL: 24:00:00 2299 100.0% 0.0310.2 MB 100.0% 0.12
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 129 0 0 0 0 0 0 0 129
2gegeweb-out.news.tnetconsulting.net 46 0 0 0 0 0 0 0 46
3news.glou.org 10 0 0 0 0 0 0 0 10
4usenet.pasdenom.info 5 0 0 0 0 0 0 0 5
TOTAL: 4 190 0 0 0 0 0 0 0 190

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 127
Bad path (news.giganews.com.POSTED) 53
Cancels abusifs 5
Cancel of non-existing ID <lomsq0FngjsU1@mid.individual.net> 2
EMP (md5) 1
Cancel of non-existing ID <vg4qpn$3nsb5$1@dont-email.me> 1
Too many newsgroups (meow) 1
TOTAL: 7 190

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 2099 113 1800 0 0 0 5%23:59:57
2i2pn.org 2845 36 1928 12 0 79 1%23:59:11
3news.samoylyk.net 2885 30 2064 38 0 86 1%23:57:59
4news.tnetconsulting.net 3066 12 2280 4 0 34 0%23:59:31
5news.nntp4.net 2372 0 2099 0 0 0 0%23:59:57
6news.aioe.org 0 0 0 0 0 1854 0%24:00:00
7news.pasdenom.info 2006 0 1749 0 0 0 0%23:59:57
8nntp.terraraq.uk 1517 0 1364 0 0 0 0%23:59:56
TOTAL: 8 16790 191 13284 54 0 2053 1%191:56:28
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.samoylyk.net347.1 KB236.1 KB583.2 KB0.0 KB/s8.6 KB23:57:59
2news.gegeweb.org312.7 KB0.0 KB312.7 KB0.0 KB/s2.8 KB23:59:57
3i2pn.org123.5 KB48.8 KB172.3 KB0.0 KB/s3.6 KB23:59:11
4news.tnetconsulting.net33.2 KB10.6 KB43.8 KB0.0 KB/s2.7 KB23:59:31
5news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
6news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:57
8nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:59:56
TOTAL: 8816.5 KB295.5 KB1.1 MB0.0 KB/s4.5 KB191:56:28
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1162.250.122.68 24 5016478.7 MB 33 0 008:38:52
TOTAL: 1 24 5016478.7 MB 33 0 008:45:22

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 45 5016478.7 MB 33 0 008:43:31
2*.ip.linodeusercontent.com 10 00.0 KB 0 0 000:00:02
3*.monitoring.internet-measurement.com 6 00.0 KB 0 0 000:00:06
4*.gegeweb.eu 287 00.0 KB 0 0 000:01:34
5*.150.216.162.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:01
6*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
7*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
8*.stretchoid.com 1 00.0 KB 0 0 000:00:00
TOTAL: 8 353 5016478.7 MB 33 0 008:45:22

NNRP auth users [Top 20]:

UserConn
mailman 287
TOTAL: 1 287

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
162.250.122.68 7.673 19.453 0.00008:38:52
mail.gegeweb.eu 4.485 3.630 1.54800:01:34
206.168.34.63 0.041 0.011 0.00000:00:32
206.168.34.222 0.044 0.020 0.00000:00:31
206.168.34.33 0.012 0.016 0.00000:00:31
206.168.34.202 0.034 0.030 0.00000:00:31
206.168.34.55 0.014 0.018 0.00000:00:31
206.168.34.38 0.046 0.017 0.00000:00:30
206.168.34.49 0.042 0.024 0.00000:00:30
206.168.34.58 0.114 0.086 0.00000:00:28
205.210.31.102 0.013 0.009 0.00000:00:10
198.235.24.215 0.011 0.011 0.00000:00:10
199.45.154.148 0.082 0.049 0.00000:00:05
server-0-2.survey.inspici.com 0.018 0.004 0.00000:00:04
motivated.monitoring.internet-measurement.com 0.012 0.012 0.00000:00:03
gracious.monitoring.internet-measurement.com 0.055 0.029 0.00000:00:03
194-195-215-162.ip.linodeusercontent.com 0.206 0.109 0.00000:00:02
27.149.216.162.bc.googleusercontent.com 0.024 0.016 0.00000:00:01
91.238.181.23 0.045 0.016 0.00000:00:01
206.168.34.215 0.044 0.020 0.00000:00:01
TOTAL: 28 13.222 23.727 1.54808:45:22

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 287
194-195-215-162.ip.linodeusercontent.com 10
206.168.34.58 5
199.45.154.148 3
206.168.34.38 1
91.238.181.23 1
198.235.24.215 1
205.210.31.102 1
206.168.34.33 1
206.168.34.215 1
61.150.216.162.bc.googleusercontent.com 1
206.168.34.63 1
swift.monitoring.internet-measurement.com 1
excellent.monitoring.internet-measurement.com 1
gracious.monitoring.internet-measurement.com 1
206.168.34.49 1
azpdcg61.stretchoid.com 1
142.150.216.162.bc.googleusercontent.com 1
enthusiastic.monitoring.internet-measurement.com 1
server-0-2.survey.inspici.com 1
TOTAL: 28 329

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
206.168.34.58 6
142.150.216.162.bc.googleusercontent.com 4
61.150.216.162.bc.googleusercontent.com 4
27.149.216.162.bc.googleusercontent.com 4
199.45.154.148 1
azpdcg61.stretchoid.com 1
206.168.34.215 1
88.214.25.65 1
TOTAL: 8 22

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 3
User-Agent: Expanse, a Palo Alto Network... 3
Accept-Encoding: gzip 3
EHLO www.censys.io 3
Host: 45.13.105.36:563 2
Host: 45.13.105.36:119 1
#026#003#001 1
MGLNDD_45.13.105.36_119 1
#003 1
#023#003#023#001#023#002#001 1
Ì©Õƒí#002&dkÉ#031P†wg!x¸Y«#014ø‰ 1
¸æ—·/üT#027#024#017¸5®{› ¹D¿`õ34 1
‰#027÷#014¥þ¸œ† 1
TOTAL: 13 22

NNRP client timeouts [Top 20]:

SystemConnPeer
88.214.25.65 1 1
199.45.154.148 1 2
206.168.34.58 1 2
TOTAL: 3 3 5

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 48512 96.7%
2local 1652 3.3%
TOTAL: 2 50164100.0%

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

NewsgroupCount
1grisbi.bugsreports 21426
2grisbi.test 16309
3grisbi.user.french 6781
4grisbi.devel 3996
5local.test 1652
TOTAL: 5 50164
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me