Daily Usenet report for news.niel.me: Oct 11 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 12 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:IGbMmaLhUKwOYuI9NYDWcoBNeoE=] matches Cancel-Lock[sha1:mmY7GaIzi36XZ/R33yU0BPnpy2M=] target=<de-gruppen-finden-05.10.2024@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	2457	29.5%	453.4 KB	33.9%
innd	2249	27.0%	376.2 KB	28.1%
nnrpd	1865	22.4%	224.2 KB	16.7%
innfeed	1767	21.2%	285.3 KB	21.3%
controlchan	1	0.0%	0.0 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	8340	100.0%	1.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	13094	59.1%
Negative hits	6636	29.9%
Do not exist	2434	11.0%
Cache misses	2	0.0%
TOTAL: 4	22166	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.003	0.0%	4	0.000	0.750	1.000
article cancel	00:00:00.002	0.0%	5	0.000	0.400	1.000
article cleanup	00:00:00.047	0.0%	2440	0.000	0.019	0.167
article logging	00:00:00.199	0.0%	2440	0.000	0.082	0.286
article parse	00:00:00.350	0.0%	5136	0.000	0.068	0.333
article write	00:00:01.197	0.0%	2135	0.000	0.561	2.000
artlog/artcncl	00:00:00.001	0.0%	5	0.000	0.200	1.000
artlog/artcncl/perl	00:00:00.000	0.0%	4	0.000	0.000	0.000
artlog/artwrite	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.133	0.0%	22595	0.000	0.006	0.053
hisgrep/artcncl	00:00:00.001	0.0%	5	0.000	0.200	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	4	0.000	0.000	0.000
hisgrep/perl	00:00:00.004	0.0%	29	0.000	0.138	1.000
hishave/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	4	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:00.378	0.0%	22166	0.000	0.017	0.077
history sync	00:00:00.060	0.0%	393	0.000	0.153	1.000
history write	00:00:00.452	0.0%	2435	0.000	0.186	0.700
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:50:53.146	100.0%	24987	1175.029	3435.913	30001.800
nntp read	00:00:00.665	0.0%	24198	0.000	0.027	0.100
overview write	00:00:00.739	0.0%	2135	0.000	0.346	3.600
perl filter	00:00:09.836	0.0%	2435	2.020	4.039	10.000
python filter	00:00:00.013	0.0%	2435	0.000	0.005	0.250
site send	00:00:00.887	0.0%	4311	0.000	0.206	1.000
TOTAL: 23:51:16.518	23:51:08.113	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.021	0.0%	2253	0.000	0.009	0.167
article prepare	00:00:00.003	0.0%	328	0.000	0.009	0.250
article read	00:00:00.012	0.0%	79	0.000	0.152	3.000
backlog stats	00:00:00.197	0.0%	31683	0.000	0.006	0.044
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.436	0.0%	16859	0.000	0.026	0.133
data write	00:00:00.851	0.0%	14982	0.000	0.057	0.200
idle	23:58:40.301	100.0%	31683	1038.148	2724.499	9695.242
status file	00:00:00.441	0.0%	230	0.500	1.917	7.000
TOTAL: 23:58:47.855	23:58:42.262	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:00.300	34.1%	1466	5.500	41.132	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.123	0.1%	3316	0.000	0.037	1.000
TOTAL: 00:02:57.056	00:01:00.423	34.1%	-	-	-	-

Control commands to INND:

Command	Number
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):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feed-out.gegeweb.org	3	2107	888	1219	0	42%	23:58:48
2	gegeweb-out.news.tnetconsulting.net	2	2878	338	2473	67	11%	36:13:42
3	news.samoylyk.net	3	2583	311	2271	1	12%	28:21:48
4	news.nntp4.net	2	2246	286	1814	146	12%	22:54:13
5	i2pn.org	2	1832	145	1685	2	7%	22:24:51
6	usenet.pasdenom.info	7	1242	102	1112	28	8%	23:05:27
7	news.glou.org	3	1780	87	1620	73	4%	23:56:33
8	nntp.terraraq.uk	3	1523	65	1457	1	4%	21:02:53
9	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 9		50	16191	2222	13651	318	13%	201:58:15

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed-out.gegeweb.org	3.0 MB	0.0 KB	0.0 KB	3.0 MB	100%	3.5 KB
2	news.samoylyk.net	1.5 MB	4.3 KB	4.3 KB	1.6 MB	99%	5.1 KB
3	gegeweb-out.news.tnetconsulting.net	1.3 MB	1.4 KB	218.9 KB	1.5 MB	85%	3.9 KB
4	news.nntp4.net	1003.3 KB	0.0 KB	438.4 KB	1.4 MB	69%	3.3 KB
5	news.glou.org	430.1 KB	0.0 KB	196.3 KB	626.3 KB	68%	3.9 KB
6	i2pn.org	402.4 KB	0.0 KB	2.9 KB	405.4 KB	99%	2.8 KB
7	nntp.terraraq.uk	396.1 KB	0.0 KB	2.5 KB	398.6 KB	99%	6.0 KB
8	usenet.pasdenom.info	236.4 KB	0.0 KB	37.4 KB	273.9 KB	86%	2.1 KB
9	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 9		8.3 MB	5.6 KB	900.6 KB	9.2 MB	90%	3.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 11 04:15:01 - 04:59:59	30	1.4%	0.01	156.1 KB	1.9%	0.06
Oct 11 05:00:00 - 05:59:59	35	1.6%	0.01	180.1 KB	2.2%	0.05
Oct 11 06:00:00 - 06:59:59	35	1.6%	0.01	105.8 KB	1.3%	0.03
Oct 11 07:00:00 - 07:59:59	29	1.4%	0.01	156.8 KB	2.0%	0.04
Oct 11 08:00:00 - 08:59:59	65	3.0%	0.02	228.3 KB	2.8%	0.06
Oct 11 09:00:00 - 09:59:59	53	2.5%	0.01	164.9 KB	2.1%	0.05
Oct 11 10:00:00 - 10:59:59	100	4.7%	0.03	282.1 KB	3.5%	0.08
Oct 11 11:00:00 - 11:59:59	105	4.9%	0.03	372.6 KB	4.6%	0.10
Oct 11 12:00:00 - 12:59:59	77	3.6%	0.02	366.9 KB	4.6%	0.10
Oct 11 13:00:00 - 13:59:59	122	5.7%	0.03	436.0 KB	5.4%	0.12
Oct 11 14:00:00 - 14:59:59	73	3.4%	0.02	257.8 KB	3.2%	0.07
Oct 11 15:00:00 - 15:59:59	62	2.9%	0.02	217.3 KB	2.7%	0.06
Oct 11 16:00:00 - 16:59:59	114	5.3%	0.03	411.4 KB	5.1%	0.11
Oct 11 17:00:00 - 17:59:59	188	8.8%	0.05	692.0 KB	8.6%	0.19
Oct 11 18:00:00 - 18:59:59	148	6.9%	0.04	581.3 KB	7.2%	0.16
Oct 11 19:00:00 - 19:59:59	103	4.8%	0.03	426.4 KB	5.3%	0.12
Oct 11 20:00:00 - 20:59:59	137	6.4%	0.04	475.0 KB	5.9%	0.13
Oct 11 21:00:00 - 21:59:59	91	4.2%	0.03	344.6 KB	4.3%	0.10
Oct 11 22:00:00 - 22:59:59	126	5.9%	0.04	491.8 KB	6.1%	0.14
Oct 11 23:00:00 - 23:59:59	126	5.9%	0.04	540.6 KB	6.7%	0.15
Oct 12 00:00:00 - 00:59:59	124	5.8%	0.03	458.2 KB	5.7%	0.13
Oct 12 01:00:00 - 01:59:59	84	3.9%	0.02	249.0 KB	3.1%	0.07
Oct 12 02:00:00 - 02:59:59	55	2.6%	0.02	145.6 KB	1.8%	0.04
Oct 12 03:00:00 - 03:59:59	45	2.1%	0.01	126.8 KB	1.6%	0.04
Oct 12 04:00:00 - 04:15:01	16	0.7%	0.02	153.2 KB	1.9%	0.17
TOTAL: 24:00:00	2143	100.0%	0.02	7.8 MB	100.0%	0.09

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	149	0	1	148
2	news.glou.org	73	1	0	72
3	gegeweb-out.news.tnetconsulting.net	51	0	2	49
4	usenet.pasdenom.info	28	0	0	28
5	i2pn.org	2	0	0	2
6	news.samoylyk.net	1	0	1	0
7	nntp.terraraq.uk	1	0	1	0
TOTAL: 7		305	1	5	299

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.lang.go	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	125
EMP (phn path)	90
Bad path (news.giganews.com.POSTED)	56
Too many newsgroups (meow)	4
Cancel of <4c9d982b429b72348e6a3a262d65cf8a829d8a08@i2pn2.org> without Cancel-Key	1
Cancel of <0cdd25c502fca49de56c2777fa380291b41fdcb3@i2pn2.org> without Cancel-Key	1
Cancel of <95fde65fe20824c9a9208be8018d16edf3ab3a52@i2pn2.org> without Cancel-Key	1
Cancel of <75c703c6a56df2cbf85cd4ce38ab3a8250baacf8@i2pn2.org> without Cancel-Key	1
Cancel of <46abd0424d4bdea4dd99d30aeedefbbe0c2f6a53@i2pn2.org> without Cancel-Key	1
Cancel of <c29fa5f8fe7b4b504f11a3cb77b8af972726f880@i2pn2.org> without Cancel-Key	1
Cancel of <5a12e609af96f98de2941e9f84c013699d006c2c@i2pn2.org> without Cancel-Key	1
Cancel of <a3bbf3504cfb0f9f9586812c40bdfb432bdf2ac3@i2pn2.org> without Cancel-Key	1
Cancel of <e4283609457dbb76865d28e11a9c22d02aca1b34@i2pn2.org> without Cancel-Key	1
Cancel of <fcb305060fbd1df23d4fa9f1e5302231338de2da@i2pn2.org> without Cancel-Key	1
Cancel of <bb518d6bbf8d6ec4aa2ab62a1b1ca9478964b11c@i2pn2.org> without Cancel-Key	1
Cancel of <0c58088102596f8ae6058726526f357ab7932825@i2pn2.org> without Cancel-Key	1
Cancel of <f2d5f622abcfc609d3f442496797f11c61fb8774@i2pn2.org> without Cancel-Key	1
Cancel of <81d010514abd4abfd4e54edb1c3524386c60c10a@i2pn2.org> without Cancel-Key	1
Cancel of <3a085da49c8f37f41449a2fec5d1686afdd5456b@i2pn2.org> without Cancel-Key	1
Cancel of <2007b67eb8e6a1bf9370922df734d2602e398027@i2pn2.org> without Cancel-Key	1
TOTAL: 28	299

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	3083	36	1909	7	56	1%	23:58:58
2	news.gegeweb.org	1346	34	1216	0	0	2%	23:43:44
3	news.tnetconsulting.net	3520	2	2139	0	59	0%	23:58:58
4	nntp.terraraq.uk	1339	1	1249	0	0	0%	23:51:21
5	news.nntp4.net	1932	1	1844	0	0	0%	23:58:54
6	news.samoylyk.net	2152	1	1864	0	0	0%	23:58:54
7	news.pasdenom.info	1913	0	1658	0	0	0%	23:58:55
8	news.aioe.org	0	0	0	0	1795	0%	24:00:00
TOTAL: 8		15285	75	11879	7	1910	0%	191:29:44

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.gegeweb.org	106.6 KB	0.0 KB	106.6 KB	3.1 KB	23:43:44
2	i2pn.org	84.8 KB	26.9 KB	111.7 KB	2.6 KB	23:58:58
3	news.nntp4.net	11.3 KB	0.0 KB	11.3 KB	11.3 KB	23:58:54
4	news.tnetconsulting.net	7.7 KB	0.0 KB	7.7 KB	3.8 KB	23:58:58
5	nntp.terraraq.uk	3.4 KB	0.0 KB	3.4 KB	3.4 KB	23:51:21
6	news.samoylyk.net	2.0 KB	0.0 KB	2.0 KB	2.0 KB	23:58:54
7	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:58:55
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0	24:00:00
TOTAL: 8		215.7 KB	26.9 KB	242.6 KB	3.0 KB	191:29:44

NNRP readership statistics:

System		Conn	Elapsed
1	terrific.monitoring.internet-measurement.com	1	00:00:01
2	jovial.monitoring.internet-measurement.com	1	00:00:00
3	198.235.24.245	1	00:00:10
4	principled.monitoring.internet-measurement.com	1	00:00:00
5	75.210.203.35.bc.googleusercontent.com	1	00:00:00
6	ns31410046.ip-145-239-154.eu	2	00:00:00
7	azpdwgb27.stretchoid.com	1	00:00:00
8	2607:ff10:c8:594::e	1	00:00:02
9	139.210.203.35.bc.googleusercontent.com	1	00:00:00
10	server-0-3.survey.inspici.com	1	00:00:04
11	147.45.112.177	1	00:00:01
12	69.10.48.174	2	00:00:00
13	147.185.133.51	1	00:00:12
14	patient.monitoring.internet-measurement.com	1	00:00:02
15	206.168.34.125	3	00:00:06
16	198.235.24.159	1	00:00:10
17	147.45.112.222	1	00:00:00
18	attentive.monitoring.internet-measurement.com	1	00:00:06
19	exquisite.monitoring.internet-measurement.com	1	00:00:02
20	mail.gegeweb.eu	288	00:01:49
21	45.227.254.8	1	00:00:00
22	upright.monitoring.internet-measurement.com	1	00:00:00
TOTAL: 22		313	00:02:56

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.ip-145-239-154.eu	2	00:00:00
2	*.gegeweb.eu	288	00:01:49
3	*.stretchoid.com	1	00:00:00
4	unresolved	11	00:00:43
5	*.monitoring.internet-measurement.com	7	00:00:14
6	*.survey.inspici.com	1	00:00:04
7	?	1	00:00:02
8	*.210.203.35.bc.googleusercontent.com	2	00:00:01
TOTAL: 8		313	00:02:56

NNRP auth users [Top 20]:

User	Conn
mailman	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mail.gegeweb.eu	5.072	4.519	1.753	00:01:49
147.185.133.51	0.027	0.013	0.000	00:00:12
198.235.24.159	0.021	0.026	0.000	00:00:10
198.235.24.245	0.026	0.026	0.000	00:00:10
206.168.34.125	0.085	0.082	0.000	00:00:06
attentive.monitoring.internet-measurement.com	0.044	0.018	0.000	00:00:06
server-0-3.survey.inspici.com	0.028	0.020	0.000	00:00:04
exquisite.monitoring.internet-measurement.com	0.027	0.027	0.000	00:00:02
patient.monitoring.internet-measurement.com	0.038	0.025	0.000	00:00:02
2607:ff10:c8:594::e	0.025	0.021	0.000	00:00:02
terrific.monitoring.internet-measurement.com	0.036	0.016	0.000	00:00:01
147.45.112.177	0.011	0.011	0.000	00:00:01
75.210.203.35.bc.googleusercontent.com	0.062	0.012	0.000	00:00:00
69.10.48.174	0.034	0.017	0.000	00:00:00
ns31410046.ip-145-239-154.eu	0.038	0.025	0.000	00:00:00
azpdwgb27.stretchoid.com	0.027	0.020	0.000	00:00:00
147.45.112.222	0.037	0.029	0.000	00:00:00
139.210.203.35.bc.googleusercontent.com	0.033	0.016	0.000	00:00:00
jovial.monitoring.internet-measurement.com	0.038	0.008	0.000	00:00:00
45.227.254.8	0.035	0.016	0.000	00:00:00
TOTAL: 21	5.784	4.971	1.753	00:02:56

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	6
TOTAL: 1	6

NNRP unrecognized commands (by host):

System	Conn
139.210.203.35.bc.googleusercontent.com	4
147.185.133.51	4
75.210.203.35.bc.googleusercontent.com	4
45.227.254.8	1
azpdwgb27.stretchoid.com	1
147.45.112.177	1
206.168.34.125	1
ns31410046.ip-145-239-154.eu	1
TOTAL: 8	17

NNRP unrecognized commands (by command):

Command	Count
Accept-Encoding: gzip	3
User-Agent: Expanse, a Palo Alto Network...	3
GET / HTTP/1.1	3
Host: 45.13.105.36:563	2
#003	2
EHLO www.censys.io	1
Host: 45.13.105.36:119	1
MGLNDD_45.13.105.36_119	1
#026#003	1
TOTAL: 9	17

NNRP client timeouts [Top 20]:

System	Conn	Peer
45.227.254.8	1	1
147.45.112.177	1	1
206.168.34.125	1	2
TOTAL: 3	3	4

Daily Usenet report for news.niel.me

Oct 11 04:15:01 -- Oct 12 04:15:01