Daily Usenet report for news.niel.me

Nov 30 04:15:02 -- Dec 1 04:15:01

Unknown entries from news log file:

First 9 / 9 lines (100.0%)

Nov 30 04:15:35 rpi-studio innfeed[29888]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 30 04:16:35 rpi-studio innfeed[29888]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 30 04:22:36 rpi-studio innfeed[29888]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 30 04:30:36 rpi-studio innfeed[29888]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 30 05:18:37 rpi-studio innfeed[29888]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 30 06:18:37 rpi-studio innfeed[29888]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 30 08:18:38 rpi-studio innfeed[29888]: news.tnetconsulting.net:0 connect: Network is unreachable
Nov 30 09:18:38 rpi-studio innfeed[29888]: news.tnetconsulting.net:0 connect: Network is unreachable
Dec 1 01:30:03 rpi-studio innd: filter: No Cancel-Key[sha1:NX4V1GskYuhK7MFx5AJkQ/b5ukU=] matches Cancel-Lock[sha1:n4AbYE41yo8WwdmBUG4rJ3El9NU=] target=<de-gruppen-finden-24.11.2021@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
inn 4656 39.9%800.0 KB 44.4%
innd 3471 29.7%517.2 KB 28.7%
nnrpd 1950 16.7%212.3 KB 11.8%
innfeed 1589 13.6%269.8 KB 15.0%
controlchan 6 0.1%1.1 KB 0.1%
nocem 6 0.1%0.5 KB 0.0%
TOTAL: 6 11678 100.0%1.8 MB100.0%

History cache:

ReasonCount%Count
Positive hits 21883 66.0%
Negative hits 6665 20.1%
Do not exist 4616 13.9%
Cache misses 3 0.0%
TOTAL: 4 33167 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.009 0.0%7 1.000 1.286 3.000
article cancel00:00:00.002 0.0%12 0.000 0.167 2.000
article cleanup00:00:00.099 0.0%4616 0.000 0.021 0.125
article logging00:00:00.335 0.0%4637 0.000 0.072 0.231
article parse00:00:00.796 0.0%8006 0.000 0.099 0.308
article write00:00:04.917 0.0%4088 0.077 1.203 62.351
artlog/artcncl00:00:00.000 0.0%11 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
data move00:00:00.090 0.0%36856 0.000 0.002 0.028
hisgrep/artcncl00:00:00.000 0.0%9 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/perl00:00:00.001 0.0%9 0.000 0.111 1.000
hishave/artcncl00:00:00.000 0.0%12 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.476 0.0%33167 0.000 0.014 0.043
history sync00:00:00.049 0.0%409 0.000 0.120 0.667
history write00:00:01.040 0.0%4616 0.000 0.225 0.635
hiswrite/artcncl00:00:00.000 0.0%3 0.000 0.000 0.000
idle24:00:24.333 99.9%37422 946.994 2309.453 10922.473
nntp read00:00:01.220 0.0%36707 0.000 0.033 0.078
overview write00:00:02.965 0.0%4088 0.000 0.725 7.919
perl filter00:00:21.616 0.0%4616 2.441 4.683 11.368
python filter00:00:00.012 0.0%4616 0.000 0.003 0.059
site send00:00:01.113 0.0%8185 0.000 0.136 0.444
TOTAL: 24:01:12.39924:00:59.073100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.055 0.0%7573 0.000 0.007 0.143
article prepare00:00:00.001 0.0%712 0.000 0.001 0.050
article read00:00:00.022 0.0%160 0.000 0.138 4.500
backlog stats00:00:00.107 0.0%62410 0.000 0.002 0.018
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.823 0.0%35101 0.000 0.023 0.062
data write00:00:02.091 0.0%30912 0.000 0.068 0.145
idle23:51:25.065100.0%62410 389.572 1376.143 4886.512
status file00:00:00.533 0.0%195 1.000 2.733 8.000
TOTAL: 23:51:32.03323:51:28.697100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:16.336 54.5%1216 21.500 161.461 3901.400
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.083 0.0%2988 0.000 0.028 0.222
readart00:00:00.003 0.0%11 0.273 0.273 0.273
TOTAL: 00:06:00.31200:03:16.422 54.5%----

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

Control Channel:

SendernewgrouprmgroupOtherBad PGPDoItOK
us-control@lists.killfile.org001001
TOTAL001001

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 2 4118 2597 1430 91 63%24:01:19
2i2pn.org 1 2716 500 2181 35 18%17:35:55
3feed-out.gegeweb.org 290 2910 417 2485 8 14%23:56:10
4nntp.terraraq.uk 1 4946 257 4362 327 5%28:46:02
5news.nntp4.net 2 3426 185 3152 89 5%18:46:16
6gegeweb-out.news.tnetconsulting.net 1 4172 7 4163 2 0%12:54:19
7localhost 27 0 0 0 0 0%00:00:00
8usenet.pasdenom.info 1 0 0 0 0 0%00:00:00
TOTAL: 8 325 22288 3963 17773 552 17%126:00:01
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org9.4 MB0.0 KB320.3 KB9.8 MB 96%3.7 KB
2nntp.terraraq.uk3.0 MB0.0 KB1.3 MB4.3 MB 69%7.6 KB
3i2pn.org2.0 MB0.0 KB131.7 KB2.2 MB 94%4.1 KB
4news.nntp4.net1.4 MB0.0 KB241.4 KB1.7 MB 85%6.3 KB
5feed-out.gegeweb.org1.2 MB0.0 KB8.7 KB1.3 MB 99%3.0 KB
6gegeweb-out.news.tnetconsulting.net108.1 KB0.0 KB13.5 KB121.6 KB 88%13.5 KB
7localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
8usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 817.3 MB0.0 KB2.0 MB19.3 MB 89%4.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Nov 30 04:15:02 - 04:59:59 105 2.6% 0.04334.5 KB 1.9% 0.12
Nov 30 05:00:00 - 05:59:59 134 3.3% 0.04441.6 KB 2.5% 0.12
Nov 30 06:00:00 - 06:59:59 108 2.6% 0.03400.5 KB 2.2% 0.11
Nov 30 07:00:00 - 07:59:59 76 1.9% 0.02262.0 KB 1.5% 0.07
Nov 30 08:00:00 - 08:59:59 90 2.2% 0.03299.5 KB 1.7% 0.08
Nov 30 09:00:00 - 09:59:59 132 3.2% 0.04998.8 KB 5.5% 0.28
Nov 30 10:00:00 - 10:59:59 167 4.1% 0.05664.5 KB 3.7% 0.18
Nov 30 11:00:00 - 11:59:59 151 3.7% 0.04452.0 KB 2.5% 0.13
Nov 30 12:00:00 - 12:59:59 179 4.4% 0.05546.6 KB 3.0% 0.15
Nov 30 13:00:00 - 13:59:59 164 4.0% 0.05491.3 KB 2.7% 0.14
Nov 30 14:00:00 - 14:59:59 183 4.5% 0.05578.4 KB 3.2% 0.16
Nov 30 15:00:00 - 15:59:59 204 5.0% 0.06756.5 KB 4.2% 0.21
Nov 30 16:00:00 - 16:59:59 221 5.4% 0.061.8 MB 10.4% 0.52
Nov 30 17:00:00 - 17:59:59 193 4.7% 0.051.4 MB 7.9% 0.40
Nov 30 18:00:00 - 18:59:59 266 6.5% 0.071.2 MB 6.9% 0.35
Nov 30 19:00:00 - 19:59:59 250 6.1% 0.07811.3 KB 4.5% 0.23
Nov 30 20:00:00 - 20:59:59 243 5.9% 0.071.0 MB 5.8% 0.29
Nov 30 21:00:00 - 21:59:59 232 5.7% 0.06927.5 KB 5.1% 0.26
Nov 30 22:00:00 - 22:59:59 192 4.7% 0.05971.6 KB 5.4% 0.27
Nov 30 23:00:00 - 23:59:59 188 4.6% 0.05934.3 KB 5.2% 0.26
Dec 1 00:00:00 - 00:59:59 199 4.9% 0.06760.0 KB 4.2% 0.21
Dec 1 01:00:00 - 01:59:59 152 3.7% 0.04613.2 KB 3.4% 0.17
Dec 1 02:00:00 - 02:59:59 131 3.2% 0.04576.5 KB 3.2% 0.16
Dec 1 03:00:00 - 03:59:59 105 2.6% 0.03504.0 KB 2.8% 0.14
Dec 1 04:00:00 - 04:15:01 24 0.6% 0.0382.3 KB 0.5% 0.09
TOTAL: 23:59:59 4089 100.0% 0.0517.6 MB 100.0% 0.21
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1nntp.terraraq.uk 247 0 0 0 0 0 0 0 247
2news.nntp4.net 151 0 0 0 0 0 0 0 151
3news-out.aioe.org 118 2 0 0 0 0 0 0 116
4i2pn.org 23 0 0 0 0 0 0 0 23
5feed-out.gegeweb.org 8 0 0 0 0 0 0 0 8
6usenet.pasdenom.info 1 0 0 0 0 0 0 0 1
7gegeweb-out.news.tnetconsulting.net 1 0 0 0 0 0 0 0 1
TOTAL: 7 549 2 0 0 0 0 0 0 547

Unwanted newsgroups [Top 20]:

NewsgroupCount
news.test 1
soc.culture.india 1
TOTAL: 2 2

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 220
EMP (phn nph) 141
Bad path (news.giganews.com.POSTED) 85
User-issued spam cancel 46
EMP (md5) 32
Cancel of non-existing ID <j0mnvqF54tjU1@mid.individual.net> 1
Cancels abusifs 1
TOTAL: 7 526

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com4044
TOTAL: 14044

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 21
TOTAL: 1 21
TOTAL: 1 21

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 6952 33 3518 27 0 47 0%23:59:56
2news.gegeweb.org 3658 20 3542 56 0 0 0%23:59:12
3news.tnetconsulting.net 6997 18 4068 2 0 729 0%23:59:56
4news.pasdenom.info 4679 8 3379 6 0 0 0%23:59:56
5news.aioe.org 1445 4 1206 0 0 0 0%23:20:51
6news.nntp4.net 4503 3 3851 0 0 0 0%23:59:38
7nntp.terraraq.uk 5251 1 5188 0 0 0 0%23:58:52
TOTAL: 7 33485 87 24752 91 0 776 0%167:18:21
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org74.7 KB53.9 KB128.7 KB0.0 KB/s2.1 KB23:59:56
2news.gegeweb.org72.8 KB211.4 KB284.3 KB0.0 KB/s3.7 KB23:59:12
3news.tnetconsulting.net41.7 KB9.9 KB51.6 KB0.0 KB/s2.6 KB23:59:56
4news.pasdenom.info36.5 KB118.3 KB154.8 KB0.0 KB/s11.1 KB23:59:56
5news.nntp4.net11.1 KB0.0 KB11.1 KB0.0 KB/s3.7 KB23:59:38
6news.aioe.org9.7 KB0.0 KB9.7 KB0.0 KB/s2.4 KB23:20:51
7nntp.terraraq.uk2.2 KB0.0 KB2.2 KB0.0 KB/s2.2 KB23:58:52
TOTAL: 7248.7 KB393.6 KB642.3 KB0.0 KB/s3.6 KB167:18:21
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1108b-gniel 2 1018.2 KB 5 0 000:02:47
TOTAL: 1 2 1018.2 KB 5 0 000:05:59

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 2 1018.2 KB 5 0 000:02:47
2*.gegeweb.eu 288 00.0 KB 0 0 000:02:14
3unresolved 12 00.0 KB 0 0 000:00:56
4*.ip-51-81-155.us 1 00.0 KB 0 0 000:00:00
5*.ch1.censys-scanner.com 2 00.0 KB 0 0 000:00:00
TOTAL: 5 305 1018.2 KB 5 0 000:05:59

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
108b-gniel 0.062 0.077 0.00000:02:47
sys.gegeweb.eu 8.067 9.023 2.83500:02:14
159.203.77.164 0.199 0.199 0.00000:00:51
43.131.94.145 0.033 0.022 0.00000:00:02
88.165.5.23 0.069 0.114 0.00000:00:01
106.75.22.49 0.036 0.024 0.00000:00:01
ns1005107.ip-51-81-155.us 0.039 0.039 0.00000:00:00
scanner-07.ch1.censys-scanner.com 0.046 0.046 0.00000:00:00
TOTAL: 8 8.551 9.544 2.83500:05:59

Curious NNRP server explorers [Top 20]:

SystemConn
sys.gegeweb.eu 288
159.203.77.164 7
88.165.5.23 3
scanner-07.ch1.censys-scanner.com 2
43.131.94.145 1
ns1005107.ip-51-81-155.us 1
106.75.22.49 1
TOTAL: 7 303

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
159.203.77.164 3
43.131.94.145 3
scanner-07.ch1.censys-scanner.com 1
TOTAL: 3 7

NNRP unrecognized commands (by command):

CommandCount
EHLO www.censys.io 1
À#024 1
Host: 185.73.232.189:563 1
#026#003#001 1
GET / HTTP/1.1 1
#023#001#023#002#023#003#001 1
Cookie: rememberMe=1 1
TOTAL: 7 7

NNRP client timeouts [Top 20]:

SystemConnPeer
43.131.94.145 1 1
TOTAL: 1 1 2

Newsgroup request counts (by category):

CategoryCountPct
1fr 5 50.0%
2comp 4 40.0%
3grisbi 1 10.0%
TOTAL: 3 10100.0%

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

NewsgroupCount
1fr.comp.usenet.serveurs 4
2comp.infosystems.gemini 4
3grisbi.test 1
4fr.usenet.forums.evolution 1
TOTAL: 4 10
innreport from INN 2.6.4 based on work (c) 1996-1999 by Fabien Tassin <fta@sofaraway.org>
Local contact: usenet@niel.me