Daily Usenet report for news.niel.me

Sep 26 04:15:01 -- Sep 27 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Sep 26 09:30:31 rpi-studio innd: filter: No Cancel-Key[sha1:AOlDX4gnEKp2Xre5mCTXjBsXlKM=] matches Cancel-Lock[sha1:pz8P/2/iwoFmH6frT0vrpbuEqb4=] target=<66f50616$0$1289$426a74cc@news.free.fr>

Log entries by program:

Program nameLines%LinesSize%Size
innd 2166 26.9%384.9 KB 30.1%
inn 2103 26.1%392.0 KB 30.6%
nnrpd 1908 23.7%225.6 KB 17.6%
innfeed 1875 23.3%278.1 KB 21.7%
controlchan 1 0.0%0.0 KB 0.0%
nocem 1 0.0%0.2 KB 0.0%
TOTAL: 6 8054 100.0%1.3 MB100.0%

History cache:

ReasonCount%Count
Positive hits 11066 60.0%
Negative hits 5308 28.8%
Do not exist 2082 11.3%
Cache misses 2 0.0%
TOTAL: 4 18458 100.0%

INND timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
artcncl/perl00:00:00.011 0.0%7 1.000 1.571 2.000
article cancel00:00:00.001 0.0%7 0.000 0.143 1.000
article cleanup00:00:00.058 0.0%2090 0.000 0.028 0.286
article logging00:00:00.158 0.0%2092 0.000 0.076 0.400
article parse00:00:00.355 0.0%4658 0.000 0.076 0.667
article write00:00:01.084 0.0%1840 0.000 0.589 1.273
artlog/artcncl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
artlog/artwrite00:00:00.000 0.0%0 0.000 0.000 0.000
data move00:00:00.103 0.0%19672 0.000 0.005 0.032
hisgrep/artcncl00:00:00.001 0.0%7 0.000 0.143 1.000
hisgrep/artcncl/perl00:00:00.000 0.0%7 0.000 0.000 0.000
hisgrep/perl00:00:00.005 0.0%19 0.000 0.263 1.000
hishave/artcncl00:00:00.000 0.0%7 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.281 0.0%18501 0.000 0.015 0.080
history sync00:00:00.048 0.0%395 0.000 0.122 1.000
history write00:00:00.353 0.0%2090 0.000 0.169 0.571
hiswrite/artcncl00:00:00.000 0.0%0 0.000 0.000 0.000
idle24:00:49.074100.0%21701 1546.711 3983.645 40012.267
nntp read00:00:00.572 0.0%20893 0.000 0.027 0.143
overview write00:00:00.668 0.0%1840 0.000 0.363 3.000
perl filter00:00:08.785 0.0%2090 2.429 4.203 9.000
python filter00:00:00.012 0.0%2090 0.000 0.006 0.143
site send00:00:00.730 0.0%3706 0.000 0.197 0.500
TOTAL: 24:01:09.29324:01:02.299100.0%----

INNfeed timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
article new00:00:00.019 0.0%1840 0.000 0.010 0.250
article prepare00:00:00.001 0.0%364 0.000 0.003 0.062
article read00:00:00.023 0.0%87 0.000 0.264 8.000
backlog stats00:00:00.156 0.0%29219 0.000 0.005 0.025
callbacks00:00:00.000 0.0%0 0.000 0.000 0.000
data read00:00:00.361 0.0%14988 0.000 0.024 0.129
data write00:00:00.805 0.0%13260 0.000 0.061 0.133
idle23:58:23.442100.0%29219 1293.810 2953.675 8835.882
status file00:00:00.655 0.0%293 0.000 2.235 8.000
TOTAL: 23:58:29.97023:58:25.462100.0%----

nnrpd timer:

Code regionTimePctInvokedMin(ms)Avg(ms)Max(ms)
idle00:01:28.320 36.2%1508 0.000 58.568 10050.000
newnews00:00:00.000 0.0%0 0.000 0.000 0.000
nntpwrite00:00:00.123 0.1%3371 0.000 0.036 0.500
readart00:00:00.017 0.0%10 1.125 1.700 4.000
TOTAL: 00:04:04.27300:01:28.460 36.2%----

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 1807 1046 761 0 57%23:54:15
2gegeweb-out.news.tnetconsulting.net 2 1990 287 1635 68 14%28:52:11
3news.nntp4.net 3 1836 115 1632 89 6%21:31:15
4usenet.pasdenom.info 7 1131 96 1013 22 8%23:57:47
5news.glou.org 4 1591 60 1460 71 3%23:51:31
6news.samoylyk.net 2 224 27 197 0 12%04:58:02
7nntp.terraraq.uk 2 217 4 213 0 1%05:54:11
8i2pn.org 3 13 3 10 0 23%00:20:01
9localhost 25 0 0 0 0 0%00:00:00
TOTAL: 9 51 8809 1638 6921 250 18%133:19:13
Articles received by server

Incoming Volume (INN):

ServerAcceptVolDupVolRejVolTotalVol%AccVol/Art
1feed-out.gegeweb.org3.5 MB0.0 KB0.0 KB3.5 MB100%3.4 KB
2gegeweb-out.news.tnetconsulting.net986.2 KB0.0 KB309.6 KB1.3 MB 76%3.7 KB
3news.nntp4.net357.4 KB0.0 KB267.7 KB625.1 KB 57%3.1 KB
4usenet.pasdenom.info240.2 KB0.0 KB27.7 KB267.9 KB 89%2.3 KB
5news.glou.org230.2 KB0.0 KB306.8 KB536.9 KB 42%4.1 KB
6news.samoylyk.net153.0 KB0.0 KB0.0 KB153.0 KB100%5.7 KB
7i2pn.org13.7 KB0.0 KB0.0 KB13.7 KB100%4.6 KB
8nntp.terraraq.uk5.9 KB0.0 KB0.0 KB5.9 KB100%1.5 KB
9localhost0.0 KB0.0 KB0.0 KB0.0 KB 0%0
TOTAL: 95.4 MB0.0 KB911.7 KB6.3 MB 85%3.4 KB
Incoming Volume received by server

Incoming articles:

DateArticles%ArtsArt/secSize%SizeKB/sec
Sep 26 04:15:01 - 04:59:59 30 1.6% 0.0194.8 KB 1.3% 0.04
Sep 26 05:00:00 - 05:59:59 40 2.2% 0.01178.1 KB 2.4% 0.05
Sep 26 06:00:00 - 06:59:59 26 1.4% 0.0177.9 KB 1.1% 0.02
Sep 26 07:00:00 - 07:59:59 37 2.0% 0.01103.8 KB 1.4% 0.03
Sep 26 08:00:00 - 08:59:59 54 2.9% 0.01245.9 KB 3.3% 0.07
Sep 26 09:00:00 - 09:59:59 63 3.4% 0.02205.2 KB 2.8% 0.06
Sep 26 10:00:00 - 10:59:59 102 5.6% 0.03346.9 KB 4.7% 0.10
Sep 26 11:00:00 - 11:59:59 69 3.8% 0.02220.4 KB 3.0% 0.06
Sep 26 12:00:00 - 12:59:59 40 2.2% 0.01150.8 KB 2.0% 0.04
Sep 26 13:00:00 - 13:59:59 91 5.0% 0.03293.1 KB 4.0% 0.08
Sep 26 14:00:00 - 14:59:59 77 4.2% 0.02259.5 KB 3.5% 0.07
Sep 26 15:00:00 - 15:59:59 84 4.6% 0.02296.4 KB 4.0% 0.08
Sep 26 16:00:00 - 16:59:59 63 3.4% 0.02261.2 KB 3.5% 0.07
Sep 26 17:00:00 - 17:59:59 116 6.3% 0.03473.9 KB 6.4% 0.13
Sep 26 18:00:00 - 18:59:59 115 6.3% 0.03370.1 KB 5.0% 0.10
Sep 26 19:00:00 - 19:59:59 106 5.8% 0.03431.1 KB 5.8% 0.12
Sep 26 20:00:00 - 20:59:59 110 6.0% 0.03371.8 KB 5.0% 0.10
Sep 26 21:00:00 - 21:59:59 121 6.6% 0.03540.4 KB 7.3% 0.15
Sep 26 22:00:00 - 22:59:59 140 7.6% 0.041.0 MB 14.0% 0.29
Sep 26 23:00:00 - 23:59:59 106 5.8% 0.03371.7 KB 5.0% 0.10
Sep 27 00:00:00 - 00:59:59 67 3.6% 0.02476.2 KB 6.4% 0.13
Sep 27 01:00:00 - 01:59:59 53 2.9% 0.01184.2 KB 2.5% 0.05
Sep 27 02:00:00 - 02:59:59 56 3.0% 0.02194.7 KB 2.6% 0.05
Sep 27 03:00:00 - 03:59:59 59 3.2% 0.02177.0 KB 2.4% 0.05
Sep 27 04:00:00 - 04:15:02 12 0.7% 0.0130.5 KB 0.4% 0.03
TOTAL: 24:00:01 1837 100.0% 0.027.2 MB 100.0% 0.09
Incoming articles
Incoming articles (size)

Sites sending bad articles:

ServerTotalGroupDistDuplicUnappTooOldSiteLineOther
1news.nntp4.net 99 0 0 0 0 0 0 0 99
2news.glou.org 71 0 0 0 0 0 0 0 71
3gegeweb-out.news.tnetconsulting.net 60 3 0 0 0 0 0 0 57
4usenet.pasdenom.info 22 0 0 0 0 0 0 0 22
TOTAL: 4 252 3 0 0 0 0 0 0 249

Unwanted newsgroups [Top 20]:

NewsgroupCount
soc.culture.iran 3
TOTAL: 1 3

INND Perl filter [Top 20]:

ReasonCount
Too many newsgroups 87
EMP (phn path) 80
Bad path (news.giganews.com.POSTED) 61
Too many newsgroups (meow) 4
No Cancel-Key matches Cancel-Lock. target=<66f50616$0$1289$426a74cc@news.free.fr> 1
Cancels abusifs 1
Cancel of <67b83210c49a9cc4023e8745b6c53b2500168a2d@i2pn2.org> without Cancel-Key 1
Cancel of <9b0d40c8fcc4cfcb128a9093abb07f1175f83ce7@i2pn2.org> without Cancel-Key 1
Cancel of <b11c9f98c0809cf7d4c67cff9a389b610262a457@i2pn2.org> without Cancel-Key 1
Cancel of <16382acdee569e15a7172da3aa5c2b9a6f73a5c0@i2pn2.org> without Cancel-Key 1
Cancel of <cf3e323ee5084069d46d8f53223b9a82dc2464d8@i2pn2.org> without Cancel-Key 1
Cancel of <c0d9784de01dcae81c5d1c2b5fbeee5e28e5d057@i2pn2.org> without Cancel-Key 1
Cancel of <de667dafd9bff2af6bec3221d9fc672c97d91c7b@i2pn2.org> without Cancel-Key 1
Cancel of <46f88fe1ce30f22af0d33e4881e64de364c745a5@i2pn2.org> without Cancel-Key 1
Cancel of non-existing ID <vd489c$at48$1@dont-email.me> 1
HTML Multipart 1
Cancel of <1cc433e2492a324df4e799fec8d181e8edc8a4ac@i2pn2.org> without Cancel-Key 1
Cancel for rejected article 1
Cancel of <56c0e823b11371eceffdf9fb1bbafa44cda7f932@i2pn2.org> without Cancel-Key 1
TOTAL: 19 247

Miscellaneous innd statistics [Top 10]:

EventServerNumber
Including strange strings
gegeweb-out.news.tnetconsulting.net 2
TOTAL: 1 2
TOTAL: 1 2

Outgoing Feeds (innfeed) by Articles:

ServerOfferedTakenRefusedRejectMissSpool%TookElapsed
1i2pn.org 2852 37 1687 6 0 2 1%23:54:40
2news.gegeweb.org 828 23 769 0 0 0 2%23:16:23
3news.samoylyk.net 1911 10 1633 12 0 1 0%23:53:00
4news.tnetconsulting.net 3085 2 1830 1 0 0 0%23:54:41
5news.nntp4.net 1800 0 1706 0 0 0 0%23:54:36
6nntp.terraraq.uk 1154 0 1132 0 0 0 0%23:39:39
7news.pasdenom.info 1612 0 1504 0 0 0 0%23:52:06
8news.aioe.org 0 0 0 0 0 1465 0%24:00:01
TOTAL: 8 13242 72 10261 19 0 1468 0%190:25:06
Outgoing feeds (innfeed) by Articles

Outgoing Feeds (innfeed) by Volume:

ServerAcceptVolRejectVolTotalVolVolume/secVol/ArtElapsed
1i2pn.org107.4 KB26.3 KB133.7 KB0.0 KB/s3.1 KB23:54:40
2news.gegeweb.org64.9 KB0.0 KB64.9 KB0.0 KB/s2.8 KB23:16:23
3news.samoylyk.net34.5 KB41.9 KB76.4 KB0.0 KB/s3.5 KB23:53:00
4news.tnetconsulting.net5.6 KB3.8 KB9.5 KB0.0 KB/s3.2 KB23:54:41
5news.nntp4.net0.0 KB0.0 KB0.0 KB0.0 KB/s023:54:36
6nntp.terraraq.uk0.0 KB0.0 KB0.0 KB0.0 KB/s023:39:39
7news.pasdenom.info0.0 KB0.0 KB0.0 KB0.0 KB/s023:52:06
8news.aioe.org0.0 KB0.0 KB0.0 KB0.0 KB/s024:00:01
TOTAL: 8212.4 KB72.0 KB284.5 KB0.0 KB/s3.1 KB190:25:06
Outgoing feeds (innfeed) by Volume

NNRP readership statistics:

SystemConnArtsSizeGroupsPostRejElapsed
169.10.48.174 6 1017.6 KB 3 0 000:00:14
TOTAL: 1 6 1017.6 KB 3 0 000:04:03

NNRP readership statistics (by domain):

SystemConnArtsSizeGroupsPostRejElapsed
1unresolved 16 1017.6 KB 3 0 000:01:36
2*.us-east-2.compute.amazonaws.com 4 00.0 KB 0 0 000:00:01
3*.stretchoid.com 2 00.0 KB 0 0 000:00:10
4*.subs.proxad.net 2 00.0 KB 0 0 000:00:11
5*.monitoring.internet-measurement.com 5 00.0 KB 0 0 000:00:07
6*.210.203.35.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
7*.survey.inspici.com 1 00.0 KB 0 0 000:00:04
8*.gegeweb.eu 288 00.0 KB 0 0 000:01:51
9*.149.216.162.bc.googleusercontent.com 1 00.0 KB 0 0 000:00:01
TOTAL: 9 320 1017.6 KB 3 0 000:04:03

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.257 4.257 1.73600:01:51
91.238.181.71 0.034 0.025 0.00000:00:28
194.165.16.76 0.021 0.004 0.00000:00:15
69.10.48.174 0.127 0.119 0.00000:00:14
88-165-5-23.subs.proxad.net 0.070 0.037 0.00000:00:11
147.185.132.94 0.024 0.028 0.00000:00:10
205.210.31.79 0.028 0.022 0.00000:00:10
104.152.52.241 0.022 0.029 0.00000:00:10
azpdwsb96.stretchoid.com 0.030 0.020 0.00000:00:09
generous.monitoring.internet-measurement.com 0.064 0.011 0.00000:00:06
server-0-3.survey.inspici.com 0.017 0.034 0.00000:00:04
71.6.134.235 0.020 0.005 0.00000:00:01
152.32.225.11 0.028 0.024 0.00000:00:01
206.168.34.123 0.020 0.008 0.00000:00:01
ec2-3-23-132-121.us-east-2.compute.amazonaws.com 0.107 0.094 0.00000:00:01
186.149.216.162.bc.googleusercontent.com 0.063 0.026 0.00000:00:01
48.210.203.35.bc.googleusercontent.com 0.050 0.027 0.00000:00:01
185.242.226.41 0.015 0.007 0.00000:00:01
azpdsgb83.stretchoid.com 0.025 0.025 0.00000:00:00
resounding.monitoring.internet-measurement.com 0.043 0.020 0.00000:00:00
TOTAL: 23 6.131 4.888 1.73600:04:03

Curious NNRP server explorers [Top 20]:

SystemConn
mail.gegeweb.eu 288
ec2-3-23-132-121.us-east-2.compute.amazonaws.com 4
88-165-5-23.subs.proxad.net 2
71.6.134.235 1
azpdsgb83.stretchoid.com 1
147.185.132.94 1
glowing.monitoring.internet-measurement.com 1
91.238.181.71 1
104.152.52.241 1
186.149.216.162.bc.googleusercontent.com 1
48.210.203.35.bc.googleusercontent.com 1
resounding.monitoring.internet-measurement.com 1
generous.monitoring.internet-measurement.com 1
152.32.225.11 1
server-0-3.survey.inspici.com 1
205.210.31.79 1
104.152.52.133 1
prudent.monitoring.internet-measurement.com 1
instinctive.monitoring.internet-measurement.com 1
206.168.34.123 1
TOTAL: 23 314

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

SystemConn
185.242.226.41 5
186.149.216.162.bc.googleusercontent.com 4
48.210.203.35.bc.googleusercontent.com 4
ec2-3-23-132-121.us-east-2.compute.amazonaws.com 4
azpdsgb83.stretchoid.com 1
194.165.16.76 1
206.168.34.123 1
TOTAL: 7 20

NNRP unrecognized commands (by command):

CommandCount
GET / HTTP/1.1 3
Accept-Encoding: gzip 3
#026#003#001 2
Host: 45.13.105.36:563 2
#001 2
User-Agent: Expanse, a Palo Alto Network... 2
EHLO www.censys.io 1
User-Agent: Mozilla/5.0 (Windows NT 10.0... 1
Accept: */* 1
#003 1
Host: 45.13.105.36:119 1
MGLNDD_45.13.105.36_119 1
TOTAL: 12 20

Newsgroup request counts (by category):

CategoryCountPct
1grisbi 10100.0%
TOTAL: 1 10100.0%

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

NewsgroupCount
1grisbi.bugsreports 5
2grisbi.test 5
TOTAL: 2 10