Daily Usenet report for news.niel.me: Sep 30 04:15:01

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 1 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:L9S41jOtmXLJvhIkl1pl01Sitdk=] matches Cancel-Lock[sha1:V99cfUACbgbwjjo2V4IOsI/8voM=] target=<de-gruppen-finden-24.09.2022@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	3743	39.6%	712.5 KB	44.9%
innd	2434	25.8%	418.4 KB	26.4%
innfeed	1750	18.5%	303.8 KB	19.1%
nnrpd	1512	16.0%	151.4 KB	9.5%
controlchan	6	0.1%	1.3 KB	0.1%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	9446	100.0%	1.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	24646	66.7%
Negative hits	8624	23.3%
Do not exist	3701	10.0%
Cache misses	2	0.0%
TOTAL: 4	36973	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.011	0.0%	10	1.000	1.100	2.000
article cancel	00:00:00.002	0.0%	11	0.000	0.182	2.000
article cleanup	00:00:00.070	0.0%	3712	0.000	0.019	0.129
article logging	00:00:00.237	0.0%	3722	0.000	0.064	0.333
article parse	00:00:00.671	0.0%	7851	0.000	0.085	0.235
article write	00:00:02.153	0.0%	3334	0.111	0.646	4.643
artlog/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.002	0.0%	10	0.000	0.200	1.000
data move	00:00:00.116	0.0%	40900	0.000	0.003	0.025
hisgrep/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hisgrep/artcncl/perl	00:00:00.001	0.0%	10	0.000	0.100	0.500
hisgrep/perl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	11	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	10	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.487	0.0%	37056	0.000	0.013	0.042
history sync	00:00:00.054	0.0%	399	0.000	0.135	1.333
history write	00:00:00.850	0.0%	3712	0.000	0.229	0.600
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:32.111	100.0%	41273	718.796	2094.156	9374.281
nntp read	00:00:01.322	0.0%	40762	0.000	0.032	0.063
overview write	00:00:02.765	0.0%	3334	0.000	0.829	16.895
perl filter	00:00:16.202	0.0%	3712	2.944	4.365	10.600
python filter	00:00:00.008	0.0%	3712	0.000	0.002	0.062
site send	00:00:01.153	0.0%	6711	0.000	0.172	0.476
TOTAL: 24:01:10.266	24:00:58.215	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	3335	0.000	0.012	0.095
article prepare	00:00:00.002	0.0%	732	0.000	0.003	0.083
article read	00:00:00.028	0.0%	137	0.000	0.204	7.000
backlog stats	00:00:00.120	0.0%	53964	0.000	0.002	0.011
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.746	0.0%	31493	0.000	0.024	0.075
data write	00:00:01.852	0.0%	28259	0.024	0.066	0.110
idle	23:49:55.554	100.0%	53964	620.881	1589.866	4445.541
status file	00:00:00.598	0.0%	198	1.000	3.020	11.800
TOTAL: 23:50:01.718	23:49:58.939	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:01.181	50.7%	1457	11.200	41.991	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.110	0.1%	3210	0.000	0.034	0.364
TOTAL: 00:02:00.756	00:01:01.291	50.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	170

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
us-control@lists.killfile.org	0	0	1	0	0	1
TOTAL	0	0	1	0	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	2	3456	1522	1891	43	44%	25:10:53
2	i2pn.org	1	3393	756	2440	197	22%	24:05:57
3	news.glou.org	2	2900	516	2308	76	17%	21:58:22
4	feed-out.gegeweb.org	3	2277	253	2023	1	11%	23:59:11
5	gegeweb-out.news.tnetconsulting.net	1	3375	50	3317	8	1%	23:59:56
6	news.samoylyk.net	2	6742	29	6711	2	0%	45:51:21
7	news.nntp4.net	2	7361	13	7279	69	0%	46:54:02
8	nntp.terraraq.uk	1	183	6	177	0	3%	02:05:00
9	usenet.pasdenom.info	1	198	1	196	1	0%	03:27:54
10	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 10		40	29885	3146	26342	397	10%	217:32:36

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	5.4 MB	110.8 KB	5.5 MB	98%	3.6 KB
2	news.glou.org	4.4 MB	196.9 KB	4.6 MB	95%	7.9 KB
3	i2pn.org	2.9 MB	470.7 KB	3.3 MB	86%	3.6 KB
4	news.samoylyk.net	1.2 MB	5.4 KB	1.2 MB	99%	41.1 KB
5	feed-out.gegeweb.org	682.7 KB	1.5 KB	684.3 KB	99%	2.7 KB
6	news.nntp4.net	419.8 KB	458.2 KB	878.0 KB	47%	10.7 KB
7	gegeweb-out.news.tnetconsulting.net	404.3 KB	122.3 KB	526.6 KB	76%	9.1 KB
8	nntp.terraraq.uk	13.2 KB	0.0 KB	13.2 KB	100%	2.2 KB
9	usenet.pasdenom.info	2.2 KB	1.8 KB	4.0 KB	54%	2.0 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		15.5 MB	1.3 MB	16.8 MB	92%	4.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 30 04:15:01 - 04:59:59	44	1.3%	0.02	121.8 KB	0.8%	0.05
Sep 30 05:00:00 - 05:59:59	82	2.5%	0.02	291.0 KB	1.9%	0.08
Sep 30 06:00:00 - 06:59:59	69	2.1%	0.02	625.0 KB	4.0%	0.17
Sep 30 07:00:00 - 07:59:59	89	2.7%	0.02	668.9 KB	4.3%	0.19
Sep 30 08:00:00 - 08:59:59	105	3.1%	0.03	369.9 KB	2.4%	0.10
Sep 30 09:00:00 - 09:59:59	75	2.2%	0.02	428.9 KB	2.8%	0.12
Sep 30 10:00:00 - 10:59:59	109	3.3%	0.03	509.6 KB	3.3%	0.14
Sep 30 11:00:00 - 11:59:59	137	4.1%	0.04	517.1 KB	3.3%	0.14
Sep 30 12:00:00 - 12:59:59	117	3.5%	0.03	621.0 KB	4.0%	0.17
Sep 30 13:00:00 - 13:59:59	145	4.3%	0.04	448.8 KB	2.9%	0.12
Sep 30 14:00:00 - 14:59:59	173	5.2%	0.05	873.7 KB	5.6%	0.24
Sep 30 15:00:00 - 15:59:59	175	5.2%	0.05	855.8 KB	5.5%	0.24
Sep 30 16:00:00 - 16:59:59	162	4.9%	0.04	1.3 MB	8.3%	0.36
Sep 30 17:00:00 - 17:59:59	303	9.1%	0.08	1.7 MB	11.1%	0.48
Sep 30 18:00:00 - 18:59:59	194	5.8%	0.05	844.3 KB	5.4%	0.23
Sep 30 19:00:00 - 19:59:59	160	4.8%	0.04	704.6 KB	4.5%	0.20
Sep 30 20:00:00 - 20:59:59	177	5.3%	0.05	666.2 KB	4.3%	0.19
Sep 30 21:00:00 - 21:59:59	210	6.3%	0.06	867.6 KB	5.6%	0.24
Sep 30 22:00:00 - 22:59:59	170	5.1%	0.05	626.4 KB	4.0%	0.17
Sep 30 23:00:00 - 23:59:59	151	4.5%	0.04	589.0 KB	3.8%	0.16
Oct 1 00:00:00 - 00:59:59	126	3.8%	0.04	581.0 KB	3.7%	0.16
Oct 1 01:00:00 - 01:59:59	129	3.9%	0.04	521.1 KB	3.3%	0.14
Oct 1 02:00:00 - 02:59:59	117	3.5%	0.03	450.2 KB	2.9%	0.13
Oct 1 03:00:00 - 03:59:59	90	2.7%	0.03	296.7 KB	1.9%	0.08
Oct 1 04:00:00 - 04:15:01	25	0.7%	0.03	85.2 KB	0.5%	0.09
TOTAL: 24:00:00	3334	100.0%	0.04	15.2 MB	100.0%	0.18

Sites sending bad articles:

Server		Total	Group	Other
1	i2pn.org	198	0	198
2	news.glou.org	81	0	81
3	news-out.aioe.org	50	2	48
4	news.nntp4.net	27	0	27
5	usenet.pasdenom.info	19	0	19
6	nntp.terraraq.uk	7	0	7
7	news.samoylyk.net	3	0	3
8	gegeweb-out.news.tnetconsulting.net	2	1	1
9	feed-out.gegeweb.org	1	0	1
TOTAL: 9		388	3	385

Unwanted newsgroups [Top 20]:

Newsgroup	Count
soc.culture.turkey	1
fr.petites-annonces.divers	1
news.test	1
TOTAL: 3	3

INND Perl filter [Top 20]:

Reason	Count
EMP (phl)	138
Bad path (news.giganews.com.POSTED)	90
EMP (phn path)	74
Too many newsgroups	40
EMP (phn nph)	29
EMP (md5)	3
HTML Multipart	1
TOTAL: 7	375

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	7
	news.samoylyk.net	2
	i2pn.org	1
	TOTAL: 3	10
TOTAL: 1		10

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	4396	65	2464	4	10	1%	23:59:30
2	news.nntp4.net	4112	29	3296	0	0	0%	23:59:28
3	news.tnetconsulting.net	5240	29	3296	5	9	0%	23:59:52
4	nntp.terraraq.uk	2771	20	2239	13	0	0%	23:59:15
5	news.gegeweb.org	3141	9	3069	2	0	0%	23:59:09
6	news.aioe.org	1522	4	1274	0	0	0%	23:48:21
7	news.samoylyk.net	4014	0	3312	3	0	0%	23:57:37
8	news.pasdenom.info	3321	0	2890	0	0	0%	23:59:57
TOTAL: 8		28517	156	21840	27	19	0%	191:43:09

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	news.nntp4.net	768.1 KB	0.0 KB	768.1 KB	26.5 KB	23:59:28
2	nntp.terraraq.uk	711.0 KB	931.7 KB	1.6 MB	49.8 KB	23:59:15
3	i2pn.org	266.5 KB	64.7 KB	331.2 KB	4.8 KB	23:59:30
4	news.tnetconsulting.net	176.2 KB	66.1 KB	242.3 KB	7.1 KB	23:59:52
5	news.gegeweb.org	22.0 KB	5.2 KB	27.2 KB	2.5 KB	23:59:09
6	news.aioe.org	10.9 KB	0.0 KB	10.9 KB	2.7 KB	23:48:21
7	news.samoylyk.net	0.0 KB	63.4 KB	63.4 KB	21.1 KB	23:57:37
8	news.pasdenom.info	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 8		1.9 MB	1.1 MB	3.0 MB	16.9 KB	191:43:09

NNRP readership statistics:

System		Conn	Elapsed
1	192.241.220.237	1	00:00:09
2	104.152.52.240	1	00:00:10
3	192.241.197.78	1	00:00:00
4	185.70.186.188	10	00:00:20
5	mail.gegeweb.eu	288	00:01:18
TOTAL: 5		301	00:02:00

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.gegeweb.eu	288	00:01:18
2	unresolved	13	00:00:41
TOTAL: 2		301	00:02:00

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	8.043	8.153	2.395	00:01:18
185.70.186.188	0.206	0.220	0.000	00:00:20
104.152.52.240	0.019	0.029	0.000	00:00:10
192.241.220.237	0.038	0.010	0.000	00:00:09
192.241.197.78	0.033	0.022	0.000	00:00:00
TOTAL: 5	8.339	8.434	2.395	00:02:00

NNRP unrecognized commands (by host):

System	Conn
185.70.186.188	3
192.241.197.78	1
TOTAL: 2	4

NNRP unrecognized commands (by command):

Command	Count
«dÀR³&·ï«#011‚‰Wï;Â'#023‡‚×ÿÿ`P#002å ¾×àA	1
À#024	1
MGLNDD_45.13.105.36_119	1
#026#003#001#002	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
185.70.186.188	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

Sep 30 04:15:01 -- Oct 1 04:15:01