Daily Usenet report for news.niel.me

Jun 27 04:15:01 -- Jun 28 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jun 27 19:23:28 rpi-studio innd: filter: No Cancel-Key[sha1:244HxcE8z9zw5s708rrlYs8XiKA=] matches Cancel-Lock[sha1:3YrFwusgjmpcUBZHsGPn+gp+xMQ=] target=<685ed1a3$0$11427$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
inn 2499 29.2%433.1 KB 32.6%
innd 2314 27.0%403.7 KB 30.4%
nnrpd 1949 22.8%218.3 KB 16.4%
innfeed 1791 20.9%273.2 KB 20.6%
nocem 1 0.0%0.1 KB 0.0%
controlchan 1 0.0%0.2 KB 0.0%
TOTAL: 6 8555 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 10786 56.2%
Negative hits 5936 30.9%
Do not exist 2476 12.9%
Cache misses 2 0.0%
TOTAL: 4 19200 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.003 0.0%8 0.000 0.375 1.000
article cancel00:00:00.001 0.0%8 0.000 0.125 1.000
article cleanup00:00:00.059 0.0%2487 0.000 0.024 0.154
article logging00:00:00.167 0.0%2487 0.000 0.067 0.333
article parse00:00:00.416 0.0%5930 0.000 0.070 0.333
article write00:00:00.913 0.0%1841 0.000 0.496 1.500
artlog/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
data move00:00:00.102 0.0%21950 0.000 0.005 0.030
hisgrep/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
hisgrep/perl00:00:00.000 0.0%9 0.000 0.000 0.000
hishave/artcncl00:00:00.000 0.0%8 0.000 0.000 0.000
hishave/artcncl/perl00:00:00.000 0.0%8 0.000 0.000 0.000
history grep00:00:00.000 0.0%0 0.000 0.000 0.000
history lookup00:00:00.339 0.0%19231 0.000 0.018 0.077
history sync00:00:00.057 0.0%404 0.000 0.141 1.000
history write00:00:00.439 0.0%2487 0.000 0.177 1.000
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:47.549100.0%23402 1516.558 3694.024 18195.727
nntp read00:00:00.664 0.0%22611 0.000 0.029 0.078
overview write00:00:00.592 0.0%1841 0.000 0.322 2.500
perl filter00:00:13.361 0.0%2487 2.389 5.372 17.000
python filter00:00:00.019 0.0%2487 0.000 0.008 0.143
site send00:00:00.637 0.0%3780 0.000 0.169 0.750
TOTAL: 24:01:14.99024:01:05.318100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.027 0.0%1989 0.000 0.014 0.182
article prepare00:00:00.006 0.0%1396 0.000 0.004 0.050
article read00:00:00.046 0.0%278 0.000 0.165 2.667
backlog stats00:00:00.155 0.0%28932 0.000 0.005 0.022
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.402 0.0%14830 0.000 0.027 0.092
data write00:00:00.815 0.0%13276 0.000 0.061 0.158
idle23:59:16.790100.0%28932 1247.409 2984.819 8222.644
status file00:00:08.016 0.0%221 1.000 36.271 97.000
TOTAL: 23:59:29.72023:59:26.257100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:03:44.619 58.8%1466 3.000 153.219 95528.500
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.133 0.0%3356 0.000 0.040 0.500
TOTAL: 00:06:22.09800:03:44.752 58.8%----

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
1news.nntp4.net 1 2520 864 1072 584 34%25:17:39
2feed-out.gegeweb.org 2 1744 455 1287 2 26%23:59:58
3nntp.terraraq.uk 3 2270 282 1969 19 12%39:39:32
4news.glou.org 3 1896 181 1656 59 9%30:00:19
5gegeweb-out.news.tnetconsulting.net 3 2230 150 2072 8 6%36:13:10
6i2pn.org 2 3246 141 3103 2 4%45:44:25
7news.samoylyk.net 2 1973 69 1904 0 3%27:21:49
8localhost 25 0 0 0 0 0%00:00:00
9usenet.pasdenom.info 6 902 0 902 0 0%23:53:29
TOTAL: 9 47 16781 2142 13965 674 12%252:10:21
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1news.nntp4.net3.9 MB0.0 KB5.1 MB9.0 MB 43%6.4 KB
2feed-out.gegeweb.org1.4 MB0.0 KB3.2 KB1.4 MB 99%3.2 KB
3gegeweb-out.news.tnetconsulting.net639.3 KB0.0 KB29.6 KB668.9 KB 95%4.2 KB
4news.glou.org608.6 KB0.0 KB163.6 KB772.2 KB 78%3.2 KB
5nntp.terraraq.uk602.3 KB0.0 KB42.5 KB644.8 KB 93%2.1 KB
6news.samoylyk.net311.1 KB0.0 KB0.0 KB311.1 KB100%4.5 KB
7i2pn.org310.3 KB0.0 KB4.3 KB314.6 KB 98%2.2 KB
8localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
9usenet.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 97.8 MB0.0 KB5.3 MB13.1 MB 59%4.8 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Jun 27 04:15:01 - 04:59:59 52 2.8% 0.02141.4 KB 2.0% 0.05
Jun 27 05:00:00 - 05:59:59 32 1.7% 0.0199.4 KB 1.4% 0.03
Jun 27 06:00:00 - 06:59:59 43 2.3% 0.01160.9 KB 2.3% 0.04
Jun 27 07:00:00 - 07:59:59 48 2.6% 0.01201.1 KB 2.8% 0.06
Jun 27 08:00:00 - 08:59:59 47 2.6% 0.01159.6 KB 2.3% 0.04
Jun 27 09:00:00 - 09:59:59 82 4.5% 0.02423.6 KB 6.0% 0.12
Jun 27 10:00:00 - 10:59:59 83 4.5% 0.02275.4 KB 3.9% 0.08
Jun 27 11:00:00 - 11:59:59 73 4.0% 0.02193.8 KB 2.7% 0.05
Jun 27 12:00:00 - 12:59:59 76 4.1% 0.02190.0 KB 2.7% 0.05
Jun 27 13:00:00 - 13:59:59 88 4.8% 0.02442.8 KB 6.3% 0.12
Jun 27 14:00:00 - 14:59:59 54 2.9% 0.01187.2 KB 2.6% 0.05
Jun 27 15:00:00 - 15:59:59 80 4.3% 0.02276.5 KB 3.9% 0.08
Jun 27 16:00:00 - 16:59:59 117 6.4% 0.03367.4 KB 5.2% 0.10
Jun 27 17:00:00 - 17:59:59 125 6.8% 0.03425.7 KB 6.0% 0.12
Jun 27 18:00:00 - 18:59:59 116 6.3% 0.03832.3 KB 11.8% 0.23
Jun 27 19:00:00 - 19:59:59 71 3.9% 0.02233.4 KB 3.3% 0.06
Jun 27 20:00:00 - 20:59:59 77 4.2% 0.02227.9 KB 3.2% 0.06
Jun 27 21:00:00 - 21:59:59 79 4.3% 0.02338.1 KB 4.8% 0.09
Jun 27 22:00:00 - 22:59:59 75 4.1% 0.02283.2 KB 4.0% 0.08
Jun 27 23:00:00 - 23:59:59 95 5.2% 0.03363.9 KB 5.1% 0.10
Jun 28 00:00:00 - 00:59:59 76 4.1% 0.02307.7 KB 4.3% 0.09
Jun 28 01:00:00 - 01:59:59 62 3.4% 0.02254.9 KB 3.6% 0.07
Jun 28 02:00:00 - 02:59:59 116 6.3% 0.03460.0 KB 6.5% 0.13
Jun 28 03:00:00 - 03:59:59 67 3.6% 0.02218.9 KB 3.1% 0.06
Jun 28 04:00:00 - 04:15:01 6 0.3% 0.0113.9 KB 0.2% 0.02
TOTAL: 24:00:00 1840 100.0% 0.026.9 MB 100.0% 0.08
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 552 280 0 0 0 0 0 0 272
2news.glou.org 62 0 0 0 1 0 0 0 61
3nntp.terraraq.uk 18 0 0 0 0 0 0 0 18
4gegeweb-out.news.tnetconsulting.net 7 0 0 0 0 0 0 0 7
5feed-out.gegeweb.org 2 0 0 0 0 0 0 0 2
6news.samoylyk.net 1 0 0 0 0 0 0 0 1
7i2pn.org 1 0 0 0 0 0 0 0 1
TOTAL: 7 643 280 0 0 1 0 0 0 362

Unwanted newsgroups [Top 20]:

NewsgroupCount
linux.kernel.netdev 238
linux.kernel.git 38
alt.france 2
news.test 1
soc.culture.russia 1
TOTAL: 5 280

Supposedly-moderated groups with unmoderated postings [Top 20]:

GroupsCount
soc.feminism 1
TOTAL: 1 1

INND Perl filter [Top 20]:

ReasonCount
EMP (md5) 123
Bad path (news.giganews.com.POSTED) 84
Too many newsgroups 82
EMP (phn path) 36
Binary: misplaced binary 31
Cancels abusifs 2
No Cancel-Key matches Cancel-Lock. target=<685ed1a3$0$11427$426a74cc@news.free.fr> 1
Too many newsgroups (low_xpost) 1
Angle-bracket bot 1
HTML Multipart 1
TOTAL: 10 362

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1news.samoylyk.net 2760 113 1596 109 0 134 4%23:59:57
2i2pn.org 2530 21 1711 16 0 10 0%23:59:57
3news.tnetconsulting.net 2702 14 1802 22 0 5 0%23:59:57
4news.nntp4.net 1069 14 967 0 0 0 1%23:56:34
5news.gegeweb.org 1489 9 1379 0 0 0 0%23:55:30
6nntp.terraraq.uk 1237 0 1138 13 0 0 0%23:57:58
7news.aioe.org 0 0 0 0 0 1525 0%24:00:00
8news.pasdenom.info 1559 0 1477 18 0 0 0%23:58:53
TOTAL: 8 13346 171 10070 178 0 1674 1%191:48:46
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1news.samoylyk.net402.7 KB508.2 KB910.8 KB0.0 KB/s4.1 KB23:59:57
2i2pn.org127.9 KB42.4 KB170.3 KB0.0 KB/s4.6 KB23:59:57
3news.tnetconsulting.net58.3 KB76.1 KB134.4 KB0.0 KB/s3.7 KB23:59:57
4news.gegeweb.org32.6 KB0.0 KB32.6 KB0.0 KB/s3.6 KB23:55:30
5news.nntp4.net18.1 KB0.0 KB18.1 KB0.0 KB/s1.3 KB23:56:34
6nntp.terraraq.uk0.0 KB16.9 KB16.9 KB0.0 KB/s1.3 KB23:57:58
7news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:00
8news.pasdenom.info0.0 KB22.6 KB22.6 KB0.0 KB/s1.3 KB23:58:53
TOTAL: 8639.5 KB666.1 KB1.3 MB0.0 KB/s3.7 KB191:48:46
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
1235.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
2198.235.24.144 1 00.0 KB 0 0 000:00:02
3205.210.31.7 3 00.0 KB 0 0 000:03:12
410.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
5194.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
6203.55.131.3 1 00.0 KB 0 0 000:00:00
7147.185.132.118 1 00.0 KB 0 0 000:00:00
8riga.scan.bufferover.run 2 00.0 KB 0 0 000:00:01
9198.235.24.157 3 00.0 KB 0 0 000:00:14
10147.185.133.184 2 00.0 KB 0 0 000:00:32
11mail.gegeweb.eu 288 00.0 KB 0 0 000:01:47
12206.168.34.215 1 00.0 KB 0 0 000:00:10
1345.227.254.156 1 00.0 KB 0 0 000:00:00
1491.238.181.96 1 00.0 KB 0 0 000:00:01
15147.185.132.132 1 00.0 KB 0 0 000:00:01
16147.185.132.95 2 00.0 KB 0 0 000:00:03
17206.168.34.77 8 00.0 KB 0 0 000:00:19
18147.185.133.148 1 00.0 KB 0 0 000:00:08
TOTAL: 18 319 00.0 KB 0 0 000:06:39

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1*.gegeweb.eu 288 00.0 KB 0 0 000:01:47
2*.150.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
3*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
4unresolved 26 00.0 KB 0 0 000:04:47
5*.scan.bufferover.run 2 00.0 KB 0 0 000:00:01
6*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:00
TOTAL: 6 319 00.0 KB 0 0 000:06:39

NNRP auth users [Top 20]:

UserConn
mailman 288
TOTAL: 1 288

NNRP total resource statistics [Top 20]:

SystemUser(ms)System(ms)Idle(ms)Elapsed
205.210.31.7 0.048 0.048 0.00000:03:12
mail.gegeweb.eu 4.913 4.561 1.90600:01:47
147.185.133.184 0.118 0.050 0.00000:00:32
206.168.34.77 0.265 0.133 0.00000:00:19
198.235.24.157 0.064 0.060 0.00000:00:14
206.168.34.215 0.037 0.029 0.00000:00:10
147.185.133.148 0.055 0.035 0.00000:00:08
147.185.132.95 0.182 0.074 0.00000:00:03
198.235.24.144 0.023 0.030 0.00000:00:02
147.185.132.132 0.017 0.034 0.00000:00:01
194.210.203.35.bc.googleusercontent.com 0.032 0.020 0.00000:00:01
91.238.181.96 0.004 0.019 0.00000:00:01
riga.scan.bufferover.run 0.045 0.026 0.00000:00:01
235.150.216.162.bc.googleusercontent.com 0.051 0.028 0.00000:00:00
10.149.216.162.bc.googleusercontent.com 0.056 0.016 0.00000:00:00
45.227.254.156 0.049 0.016 0.00000:00:00
203.55.131.3 0.015 0.008 0.00000:00:00
147.185.132.118 0.019 0.004 0.00000:00:00
TOTAL: 18 5.993 5.191 1.90600:06:39

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
riga.scan.bufferover.run 7
194.210.203.35.bc.googleusercontent.com 4
10.149.216.162.bc.googleusercontent.com 4
235.150.216.162.bc.googleusercontent.com 4
147.185.133.148 4
147.185.132.95 4
147.185.133.184 4
198.235.24.157 1
205.210.31.7 1
91.238.181.96 1
206.168.34.215 1
TOTAL: 11 35

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 7
Accept-Encoding: gzip 5
Host: 45.13.105.36:563 5
User-Agent: Expanse, a Palo Alto Network... 4
Accept: */* 3
#026#003 2
User-Agent: curl/7.68.0 2
Host: 45.13.105.36:119 2
EHLO www.censys.io 1
#026#003#001 1
#001 1
User-Agent: Mozilla/5.0 (Macintosh; Inte... 1
#003 1
TOTAL: 13 35

NNRP client timeouts [Top 20]:

SystemConnPeer
205.210.31.7 2 3
198.235.24.157 2 3
147.185.133.184 1 2
91.238.181.96 1 1
147.185.132.95 1 2
TOTAL: 5 7 14