Daily Usenet report for news.niel.me

May 10 04:15:01 -- May 11 04:15:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 10 05:32:15 rpi-studio innd: filter: No Cancel-Key[sha1:YoV0Ci0+BX2tS7Umfuah3Vy2h8A= sha256:Gs5PaACRJGiWPeZMYyEIX+Pnn+FdsRO+NRTrPmLwx4Y=] matches Cancel-Lock[sha1:WAPa86iDa18mVv/bxfYAxgzrH5U= sha256:pcinei+PT5va0H9EJgSVLnZc/Ww70hlYXg+xL8bFPUA=] target=<10tou3s$2hrt$1@gwaiyur.mb-net.net>
May 10 23:20:32 rpi-studio innd: filter: No Cancel-Key[sha1:aNjSRD7N0u+mvm7gocI7XcSfFlw= sha256:Huu2QD76xQGTU6ltzdBxnyCfMui6+w++EHP3f3uolOY=] matches Cancel-Lock[sha1:Bvg9jRmVi0I+Bv3TlV/cST4DHUQ= sha256:yb+Axf9WmDEKP0GPgA1r8SLTvlXH227xfKQqh9TfFN8=] target=<10tqsh9$1kom$1@gwaiyur.mb-net.net>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2071 26.3%367.7 KB 30.3%
innfeed 1975 25.1%281.7 KB 23.2%
innd 1925 24.5%340.9 KB 28.1%
nnrpd 1896 24.1%221.9 KB 18.3%
controlchan 1 0.0%0.2 KB 0.0%
nocem 1 0.0%0.1 KB 0.0%
TOTAL: 6 7869 100.0%1.2 MB100.0%

History cache:

ReasonCount%Count
Positive hits 8118 52.8%
Negative hits 5217 33.9%
Do not exist 2051 13.3%
Cache misses 3 0.0%
TOTAL: 4 15389 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.004 0.0%4 1.000 1.000 1.000
article cancel00:00:00.002 0.0%6 0.000 0.333 1.000
article cleanup00:00:00.045 0.0%2053 0.000 0.022 0.200
article logging00:00:00.143 0.0%2053 0.000 0.070 0.500
article parse00:00:00.322 0.0%5415 0.000 0.059 0.375
article write00:00:00.860 0.0%1800 0.000 0.478 2.000
artlog/artcncl00:00:00.001 0.0%6 0.000 0.167 1.000
artlog/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
data move00:00:00.143 0.0%17523 0.000 0.008 0.037
hisgrep/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%6 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%6 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%4 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.240 0.0%15416 0.000 0.016 0.118
history sync00:00:00.051 0.0%394 0.000 0.129 1.000
history write00:00:00.380 0.0%2053 0.000 0.185 0.667
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:47.520100.0%19156 1310.480 4512.817 21444.857
nntp read00:00:00.502 0.0%18311 0.000 0.027 0.121
overview write00:00:00.561 0.0%1800 0.000 0.312 3.000
perl filter00:00:10.098 0.0%2053 1.429 4.919 17.000
python filter00:00:00.012 0.0%2053 0.000 0.006 0.500
site send00:00:00.665 0.0%3641 0.000 0.183 0.500
TOTAL: 24:01:07.96524:01:01.549100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.014 0.0%1864 0.000 0.008 0.167
article prepare00:00:00.002 0.0%348 0.000 0.006 0.025
article read00:00:00.018 0.0%84 0.000 0.214 7.000
backlog stats00:00:00.156 0.0%23091 0.000 0.007 0.050
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.282 0.0%11134 0.000 0.025 0.133
data write00:00:00.543 0.0%9481 0.000 0.057 0.148
idle23:56:22.174100.0%23091 1195.089 3732.284 9238.385
status file00:00:05.257 0.0%350 0.000 15.020 62.000
TOTAL: 23:56:35.85523:56:28.446100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:00:33.088 42.8%1464 9.000 22.601 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.119 0.2%3351 0.000 0.036 0.364
TOTAL: 00:01:17.25200:00:33.207 43.0%----

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
1feed-out.gegeweb.org 3 1812 781 1031 0 43%23:55:14
2news.nntp4.net 2 2202 653 1327 222 29%26:09:03
3news.samoylyk.net 2 2169 299 1869 1 13%28:22:35
4nntp.terraraq.uk 7 1190 42 1146 2 3%20:49:43
5usenet.pasdenom.info 12 791 33 756 2 4%23:25:59
6news.glou.org 5 204 25 166 13 12%07:38:39
7gegeweb-out.news.tnetconsulting.net 5 373 8 365 0 2%10:08:17
8localhost 25 0 0 0 0 0%00:00:00
TOTAL: 8 61 8741 1841 6660 240 21%140:29:30
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net3.1 MB0.0 KB1.8 MB4.9 MB 63%5.7 KB
2news.samoylyk.net2.8 MB0.0 KB10.4 KB2.8 MB 99%9.4 KB
3feed-out.gegeweb.org2.4 MB0.0 KB0.0 KB2.4 MB100%3.2 KB
4nntp.terraraq.uk113.1 KB0.0 KB2.3 KB115.4 KB 98%2.6 KB
5news.glou.org84.8 KB0.0 KB45.7 KB130.5 KB 64%3.4 KB
6usenet.pasdenom.info66.2 KB0.0 KB2.5 KB68.7 KB 96%2.0 KB
7gegeweb-out.news.tnetconsulting.net29.9 KB0.0 KB0.0 KB29.9 KB100%3.7 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 88.6 MB0.0 KB1.8 MB10.4 MB 82%5.1 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
May 10 04:15:01 - 04:59:59 20 1.1% 0.0179.8 KB 0.9% 0.03
May 10 05:00:00 - 05:59:59 30 1.7% 0.011.2 MB 14.9% 0.35
May 10 06:00:00 - 06:59:59 41 2.3% 0.01198.3 KB 2.3% 0.06
May 10 07:00:00 - 07:59:59 27 1.5% 0.01130.1 KB 1.5% 0.04
May 10 08:00:00 - 08:59:59 58 3.2% 0.02228.6 KB 2.7% 0.06
May 10 09:00:00 - 09:59:59 73 4.0% 0.02249.8 KB 2.9% 0.07
May 10 10:00:00 - 10:59:59 61 3.4% 0.02162.8 KB 1.9% 0.05
May 10 11:00:00 - 11:59:59 41 2.3% 0.01245.4 KB 2.9% 0.07
May 10 12:00:00 - 12:59:59 80 4.4% 0.02322.5 KB 3.8% 0.09
May 10 13:00:00 - 13:59:59 83 4.6% 0.02280.9 KB 3.3% 0.08
May 10 14:00:00 - 14:59:59 72 4.0% 0.02273.9 KB 3.2% 0.08
May 10 15:00:00 - 15:59:59 97 5.4% 0.03291.2 KB 3.4% 0.08
May 10 16:00:00 - 16:59:59 90 5.0% 0.03710.1 KB 8.4% 0.20
May 10 17:00:00 - 17:59:59 89 4.9% 0.02390.0 KB 4.6% 0.11
May 10 18:00:00 - 18:59:59 155 8.6% 0.04557.4 KB 6.6% 0.15
May 10 19:00:00 - 19:59:59 93 5.1% 0.03303.9 KB 3.6% 0.08
May 10 20:00:00 - 20:59:59 122 6.8% 0.03437.8 KB 5.2% 0.12
May 10 21:00:00 - 21:59:59 119 6.6% 0.03854.4 KB 10.1% 0.24
May 10 22:00:00 - 22:59:59 76 4.2% 0.02252.9 KB 3.0% 0.07
May 10 23:00:00 - 23:59:59 78 4.3% 0.02297.3 KB 3.5% 0.08
May 11 00:00:00 - 00:59:59 125 6.9% 0.03367.8 KB 4.3% 0.10
May 11 01:00:00 - 01:59:59 52 2.9% 0.01156.9 KB 1.8% 0.04
May 11 02:00:00 - 02:59:59 57 3.2% 0.02180.9 KB 2.1% 0.05
May 11 03:00:00 - 03:59:59 58 3.2% 0.02236.5 KB 2.8% 0.07
May 11 04:00:00 - 04:15:01 10 0.6% 0.0123.9 KB 0.3% 0.03
TOTAL: 24:00:00 1807 100.0% 0.028.3 MB 100.0% 0.10
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 218 173 0 0 0 0 0 0 45
2news.glou.org 31 0 0 0 0 0 0 0 31
3usenet.pasdenom.info 2 0 0 0 0 0 0 0 2
4nntp.terraraq.uk 2 0 0 0 0 0 0 0 2
5news.samoylyk.net 1 0 0 0 0 0 0 0 1
TOTAL: 5 254 173 0 0 0 0 0 0 81

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 138
linux.kernel.git 34
news.test 1
TOTAL: 3 173

INND Perl filter [Top 20]:

ReasonCount
Bad path (news.giganews.com.POSTED) 39
Too many newsgroups 33
EMP (md5) 6
Cancels abusifs 2
HTML Multipart 1
TOTAL: 5 81

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.samoylyk.net 1952 47 1494 10 0 11 2%23:59:57
2news.tnetconsulting.net 3239 5 1773 22 0 48 0%23:59:57
3news.gegeweb.org 1045 2 1015 0 0 0 0%23:45:43
4news.nntp4.net 1194 1 1165 0 0 0 0%23:46:01
5nntp.terraraq.uk 933 0 890 0 0 1 0%23:17:52
6news.pasdenom.info 1295 0 1215 0 0 0 0%23:48:14
7i2pn.org 0 0 0 0 0 1799 0%24:00:00
8news.aioe.org 0 0 0 0 0 1503 0%24:00:00
TOTAL: 8 9658 55 7552 32 0 3362 0%190:37:44
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.samoylyk.net278.0 KB22.9 KB300.9 KB0.0 KB/s5.3 KB23:59:57
2news.tnetconsulting.net10.4 KB194.6 KB205.1 KB0.0 KB/s7.6 KB23:59:57
3news.gegeweb.org9.0 KB0.0 KB9.0 KB0.0 KB/s4.5 KB23:45:43
4news.nntp4.net7.2 KB0.0 KB7.2 KB0.0 KB/s7.2 KB23:46:01
5nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:17:52
6news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:48:14
7i2pn.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
TOTAL: 8304.6 KB217.5 KB522.1 KB0.0 KB/s6.0 KB190:37:44
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
124.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
2mail.gegeweb.eu 288 00.0 KB 0 0 000:00:38
3192.172.132.66.censys-scanner.com 1 00.0 KB 0 0 000:00:04
469.5.169.32 1 00.0 KB 0 0 000:00:00
5193.124.20.251 1 00.0 KB 0 0 000:00:00
6147.185.132.85 1 00.0 KB 0 0 000:00:00
7o327.scanner.modat.io 4 00.0 KB 0 0 000:00:00
881.19.219.212 1 00.0 KB 0 0 000:00:00
969.5.169.34 1 00.0 KB 0 0 000:00:00
10194.165.16.162 1 00.0 KB 0 0 000:00:00
11107.155.45.199.censys-scanner.com 7 00.0 KB 0 0 000:00:17
129.211.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
13203.172.132.66.censys-scanner.com 3 00.0 KB 0 0 000:00:01
14azpdcsqcdq5m.stretchoid.com 2 00.0 KB 0 0 000:00:10
15o328.scanner.modat.io 1 00.0 KB 0 0 000:00:00
1666.61.98.95 2 00.0 KB 0 0 000:00:02
TOTAL: 16 316 00.0 KB 0 0 000:01:16

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.172.132.66.censys-scanner.com 4 00.0 KB 0 0 000:00:05
2unresolved 8 00.0 KB 0 0 000:00:04
3*.211.203.35.bc.googleusercontent.com 2 00.0 KB 0 0 000:00:01
4*.155.45.199.censys-scanner.com 7 00.0 KB 0 0 000:00:17
5*.stretchoid.com 2 00.0 KB 0 0 000:00:10
6*.scanner.modat.io 5 00.0 KB 0 0 000:00:00
7*.gegeweb.eu 288 00.0 KB 0 0 000:00:38
TOTAL: 7 316 00.0 KB 0 0 000:01:16

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
mail.gegeweb.eu 5.150 4.347 1.72500:00:38
107.155.45.199.censys-scanner.com 0.277 0.137 0.00000:00:17
azpdcsqcdq5m.stretchoid.com 0.026 0.018 0.00000:00:10
192.172.132.66.censys-scanner.com 0.038 0.014 0.00000:00:04
66.61.98.95 0.041 0.032 0.00000:00:02
203.172.132.66.censys-scanner.com 0.062 0.052 0.00000:00:01
24.211.203.35.bc.googleusercontent.com 0.076 0.020 0.00000:00:00
193.124.20.251 0.036 0.016 0.00000:00:00
147.185.132.85 0.013 0.009 0.00000:00:00
9.211.203.35.bc.googleusercontent.com 0.039 0.012 0.00000:00:00
69.5.169.34 0.024 0.028 0.00000:00:00
81.19.219.212 0.026 0.022 0.00000:00:00
69.5.169.32 0.016 0.008 0.00000:00:00
o327.scanner.modat.io 0.122 0.045 0.00000:00:00
194.165.16.162 0.040 0.016 0.00000:00:00
o328.scanner.modat.io 0.018 0.032 0.00000:00:00
TOTAL: 16 6.004 4.808 1.72500:01:16

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
24.211.203.35.bc.googleusercontent.com 4
9.211.203.35.bc.googleusercontent.com 4
192.172.132.66.censys-scanner.com 1
o327.scanner.modat.io 1
107.155.45.199.censys-scanner.com 1
azpdcsqcdq5m.stretchoid.com 1
TOTAL: 6 12

NNRP unrecognized commands (by command):

CommandCount
Accept-Encoding: gzip 2
EHLO www.censys.io 2
GET / HTTP/1.1 2
User-Agent: Hello from Palo Alto Network... 2
Host: 45.13.105.36:563 1
MGLNDD_45.13.105.36_119 1
Host: 45.13.105.36:119 1
HELO 1
TOTAL: 8 12

NNRP client timeouts [Top 20]:

SystemConnPeer
81.19.219.212 1 1
69.5.169.32 1 1
TOTAL: 2 2 5