Daily Usenet report for news.niel.me: Jan 26 04:15:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Jan 27 01:30:02 rpi-studio innd: filter: No Cancel-Key[sha1:IDiQMgzhGzgunU8UtkEoBkNzUJA=] matches Cancel-Lock[sha1:i7IU6tH85N3lXR665VCryWwYsqo=] target=<de-gruppen-finden-20.01.2024@dnqmail.priggish.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	25445	79.1%	5.2 MB	84.3%
innd	2931	9.1%	479.1 KB	7.6%
innfeed	1995	6.2%	325.6 KB	5.1%
nnrpd	1779	5.5%	191.5 KB	3.0%
controlchan	1	0.0%	0.2 KB	0.0%
nocem	1	0.0%	0.1 KB	0.0%
TOTAL: 6	32152	100.0%	6.2 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	31802	40.0%
Do not exist	25200	31.7%
Positive hits	22520	28.3%
Cache misses	33	0.0%
TOTAL: 4	79555	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
artcncl/perl	00:00:00.026	0.0%	27	0.000	0.963	2.000
article cancel	00:00:00.004	0.0%	28	0.000	0.143	3.000
article cleanup	00:00:00.519	0.0%	25467	0.000	0.020	0.050
article logging	00:00:01.936	0.0%	25467	0.036	0.076	0.148
article parse	00:00:08.197	0.0%	141761	0.019	0.058	0.094
article write	00:00:17.608	0.0%	24663	0.294	0.714	1.459
artlog/artcncl	00:00:00.000	0.0%	28	0.000	0.000	0.000
artlog/artcncl/perl	00:00:00.000	0.0%	27	0.000	0.000	0.000
data move	00:00:01.243	0.0%	224700	0.000	0.006	0.013
hisgrep/artcncl	00:00:00.001	0.0%	28	0.000	0.036	1.000
hisgrep/artcncl/perl	00:00:00.000	0.0%	27	0.000	0.000	0.000
hisgrep/perl	00:00:00.002	0.0%	29	0.000	0.069	1.000
hishave/artcncl	00:00:00.000	0.0%	28	0.000	0.000	0.000
hishave/artcncl/perl	00:00:00.000	0.0%	27	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:01.596	0.0%	80167	0.000	0.020	0.041
history sync	00:00:00.049	0.0%	410	0.000	0.120	0.667
history write	00:00:04.572	0.0%	25445	0.087	0.180	0.273
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:58:12.809	99.8%	192837	59.288	447.491	300230.000
nntp read	00:00:06.173	0.0%	192219	0.000	0.032	0.062
overview write	00:00:09.342	0.0%	24663	0.181	0.379	5.974
perl filter	00:01:21.044	0.1%	25445	2.050	3.185	6.111
python filter	00:00:00.100	0.0%	25445	0.000	0.004	0.037
site send	00:00:06.284	0.0%	50481	0.023	0.124	0.242
TOTAL: 24:01:03.341	24:00:31.505	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.213	0.0%	27632	0.000	0.008	0.032
article prepare	00:00:00.058	0.0%	15140	0.000	0.004	0.050
article read	00:00:00.515	0.0%	3563	0.000	0.145	0.929
backlog stats	00:00:01.590	0.0%	332781	0.000	0.005	0.027
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:05.483	0.0%	228203	0.011	0.024	0.051
data write	00:00:09.521	0.0%	185993	0.000	0.051	0.071
idle	23:53:37.401	100.0%	332781	66.446	258.481	13089.000
status file	00:00:00.683	0.0%	252	0.750	2.710	9.000
TOTAL: 23:54:12.298	23:53:55.464	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:46.967	35.1%	1407	19.500	33.381	1913.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.101	0.1%	3117	0.000	0.032	1.000
TOTAL: 00:02:13.681	00:00:47.068	35.2%	-	-	-	-

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news.nntp4.net	6	24751	20760	3389	602	83%	23:45:07
2	news.glou.org	2	3475	1477	1884	114	42%	21:10:18
3	feed-out.gegeweb.org	3	3212	1063	2145	4	33%	23:47:16
4	usenet.pasdenom.info	2	2275	377	1892	6	16%	21:03:47
5	nntp.terraraq.uk	2	4196	334	3854	8	7%	25:57:58
6	gegeweb-out.news.tnetconsulting.net	3	3290	322	2916	52	9%	25:45:22
7	i2pn.org	2	5002	104	4898	0	2%	31:14:11
8	news.samoylyk.net	2	2386	26	2359	1	1%	17:07:15
9	2a01:e0a:21:ea80:ba27:ebff:fe3b:af7a	5	8481	0	8481	0	0%	21:36:24
10	localhost	25	0	0	0	0	0%	00:00:00
TOTAL: 10		52	57068	24463	31818	787	42%	211:27:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news.nntp4.net	236.1 MB	72.2 KB	6.5 MB	242.6 MB	97%	11.6 KB
2	news.glou.org	8.5 MB	0.0 KB	340.5 KB	8.8 MB	96%	5.7 KB
3	feed-out.gegeweb.org	5.5 MB	57.6 KB	57.6 KB	5.6 MB	97%	5.3 KB
4	usenet.pasdenom.info	2.7 MB	0.0 KB	12.5 KB	2.7 MB	99%	7.3 KB
5	i2pn.org	1.5 MB	0.0 KB	0.0 KB	1.5 MB	100%	14.4 KB
6	nntp.terraraq.uk	1.1 MB	6.4 KB	25.4 KB	1.1 MB	97%	3.3 KB
7	gegeweb-out.news.tnetconsulting.net	1.0 MB	0.0 KB	192.5 KB	1.2 MB	84%	3.4 KB
8	news.samoylyk.net	482.1 KB	0.0 KB	0.8 KB	482.9 KB	99%	17.9 KB
9	2a01:e0a:21:ea80:ba27:ebff:fe3b:af7a	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		256.8 MB	136.2 KB	7.1 MB	264.0 MB	97%	10.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 26 04:15:02 - 04:59:59	808	3.3%	0.30	9.1 MB	3.5%	3.46
Jan 26 05:00:00 - 05:59:59	966	3.9%	0.27	10.0 MB	3.9%	2.84
Jan 26 06:00:00 - 06:59:59	944	3.8%	0.26	10.4 MB	4.0%	2.96
Jan 26 07:00:00 - 07:59:59	1118	4.5%	0.31	12.4 MB	4.8%	3.51
Jan 26 08:00:00 - 08:59:59	1138	4.6%	0.32	11.6 MB	4.5%	3.31
Jan 26 09:00:00 - 09:59:59	1167	4.7%	0.32	13.0 MB	5.0%	3.69
Jan 26 10:00:00 - 10:59:59	1036	4.2%	0.29	11.0 MB	4.3%	3.14
Jan 26 11:00:00 - 11:59:59	620	2.5%	0.17	6.7 MB	2.6%	1.90
Jan 26 12:00:00 - 12:59:59	1715	7.0%	0.48	18.7 MB	7.2%	5.31
Jan 26 13:00:00 - 13:59:59	1168	4.7%	0.32	13.3 MB	5.2%	3.77
Jan 26 14:00:00 - 14:59:59	1085	4.4%	0.30	11.7 MB	4.6%	3.33
Jan 26 15:00:00 - 15:59:59	1033	4.2%	0.29	11.4 MB	4.4%	3.25
Jan 26 16:00:00 - 16:59:59	1116	4.5%	0.31	11.6 MB	4.5%	3.30
Jan 26 17:00:00 - 17:59:59	1004	4.1%	0.28	9.4 MB	3.7%	2.69
Jan 26 18:00:00 - 18:59:59	1016	4.1%	0.28	9.8 MB	3.8%	2.78
Jan 26 19:00:00 - 19:59:59	995	4.0%	0.28	9.5 MB	3.7%	2.70
Jan 26 20:00:00 - 20:59:59	941	3.8%	0.26	9.0 MB	3.5%	2.57
Jan 26 21:00:00 - 21:59:59	921	3.7%	0.26	10.1 MB	3.9%	2.89
Jan 26 22:00:00 - 22:59:59	980	4.0%	0.27	10.1 MB	3.9%	2.88
Jan 26 23:00:00 - 23:59:59	943	3.8%	0.26	9.7 MB	3.8%	2.77
Jan 27 00:00:00 - 00:59:59	1032	4.2%	0.29	10.9 MB	4.2%	3.11
Jan 27 01:00:00 - 01:59:59	838	3.4%	0.23	8.3 MB	3.2%	2.37
Jan 27 02:00:00 - 02:59:59	900	3.7%	0.25	8.6 MB	3.3%	2.45
Jan 27 03:00:00 - 03:59:59	952	3.9%	0.26	9.6 MB	3.7%	2.72
Jan 27 04:00:00 - 04:15:01	165	0.7%	0.18	1.5 MB	0.6%	1.75
TOTAL: 23:59:59	24601	100.0%	0.28	257.6 MB	100.0%	3.05

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.nntp4.net	599	5	16	578
2	news.glou.org	139	0	0	139
3	gegeweb-out.news.tnetconsulting.net	33	0	0	33
4	nntp.terraraq.uk	7	0	2	5
5	usenet.pasdenom.info	6	0	0	6
6	feed-out.gegeweb.org	4	0	4	0
7	news.samoylyk.net	1	0	0	1
TOTAL: 7		789	5	22	762

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.lettres.langue.allemande	3
fr.misc.gestion	2
TOTAL: 2	5

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	448
Too many newsgroups	160
EMP (phn path)	82
Bad path (news.giganews.com.POSTED)	62
Too many newsgroups (meow)	4
Cancels abusifs	3
User-issued spam cancel	1
Cancel for rejected article	1
Cancel of non-existing ID <9f48e51a-3a63-424b-b55c-9e03a8dbbbb2n@googlegroups.com>	1
TOTAL: 9	762

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	i2pn.org	41236	167	20962	3139	1946	0%	23:59:52
2	news.nntp4.net	4288	85	3662	0	214	1%	23:59:56
3	nntp.terraraq.uk	24295	60	23422	71	160	0%	23:59:56
4	news.gegeweb.org	27647	20	23488	0	191	0%	23:59:56
5	news.pasdenom.info	25327	14	24172	15	191	0%	23:59:56
6	news.samoylyk.net	30200	10	24493	60	203	0%	23:59:56
7	news.tnetconsulting.net	35913	6	24439	154	202	0%	23:59:56
8	news.aioe.org	0	0	0	0	11913	0%	23:59:56
TOTAL: 8		188906	362	144638	3439	15020	0%	191:59:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.nntp4.net	1.0 MB	0.0 KB	1.0 MB	0.0 KB/s	12.2 KB	23:59:56
2	i2pn.org	787.0 KB	35.3 MB	36.1 MB	0.4 KB/s	11.2 KB	23:59:52
3	nntp.terraraq.uk	759.6 KB	689.9 KB	1.4 MB	0.0 KB/s	11.1 KB	23:59:56
4	news.gegeweb.org	282.6 KB	0.0 KB	282.6 KB	0.0 KB/s	14.1 KB	23:59:56
5	news.pasdenom.info	44.8 KB	152.4 KB	197.2 KB	0.0 KB/s	6.8 KB	23:59:56
6	news.samoylyk.net	23.5 KB	720.6 KB	744.2 KB	0.0 KB/s	10.6 KB	23:59:56
7	news.tnetconsulting.net	18.6 KB	1.4 MB	1.4 MB	0.0 KB/s	8.8 KB	23:59:56
8	news.aioe.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
TOTAL: 8		2.9 MB	38.2 MB	41.1 MB	0.1 KB/s	11.1 KB	191:59:24

NNRP readership statistics:

System		Conn	Elapsed
1	stellar.monitoring.internet-measurement.com	1	00:00:01
2	71.6.134.233	3	00:00:01
3	cheery.monitoring.internet-measurement.com	1	00:00:00
4	192.241.238.40	1	00:00:00
5	83.97.73.76	1	00:00:00
6	194.165.16.10	1	00:00:00
7	mail.gegeweb.eu	279	00:01:52
8	productive.monitoring.internet-measurement.com	1	00:00:06
9	cheerful.monitoring.internet-measurement.com	1	00:00:00
10	motivating.monitoring.internet-measurement.com	1	00:00:00
11	swift.monitoring.internet-measurement.com	1	00:00:00
12	112.102.196.2	1	00:00:00
13	80.66.88.204	1	00:00:00
14	erudite.monitoring.internet-measurement.com	1	00:00:00
15	steadfast.monitoring.internet-measurement.com	1	00:00:00
16	graceful.monitoring.internet-measurement.com	1	00:00:05
TOTAL: 16		296	00:02:13

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	unresolved	8	00:00:05
2	*.monitoring.internet-measurement.com	9	00:00:15
3	*.gegeweb.eu	279	00:01:52
TOTAL: 3		296	00:02:13

NNRP auth users [Top 20]:

User	Conn
mailman	279
TOTAL: 1	279

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mail.gegeweb.eu	4.209	4.120	1.516	00:01:52
productive.monitoring.internet-measurement.com	0.056	0.032	0.000	00:00:06
graceful.monitoring.internet-measurement.com	0.061	0.012	0.000	00:00:05
stellar.monitoring.internet-measurement.com	0.026	0.026	0.000	00:00:01
71.6.134.233	0.060	0.044	0.000	00:00:01
112.102.196.2	0.020	0.007	0.000	00:00:00
194.165.16.10	0.036	0.018	0.000	00:00:00
192.241.238.40	0.013	0.013	0.000	00:00:00
cheery.monitoring.internet-measurement.com	0.046	0.021	0.000	00:00:00
83.97.73.76	0.038	0.015	0.000	00:00:00
erudite.monitoring.internet-measurement.com	0.044	0.020	0.000	00:00:00
steadfast.monitoring.internet-measurement.com	0.024	0.004	0.000	00:00:00
80.66.88.204	0.030	0.034	0.000	00:00:00
cheerful.monitoring.internet-measurement.com	0.042	0.021	0.000	00:00:00
swift.monitoring.internet-measurement.com	0.030	0.026	0.000	00:00:00
motivating.monitoring.internet-measurement.com	0.047	0.016	0.000	00:00:00
TOTAL: 16	4.782	4.429	1.516	00:02:13

NNRP gethostbyaddr failures [Top 20]:

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

NNRP unrecognized commands (by host):

System	Conn
71.6.134.233	7
194.165.16.10	1
192.241.238.40	1
TOTAL: 3	9

NNRP unrecognized commands (by command):

Command	Count
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
Accept: /	1
Accept-Encoding: gzip	1
MGLNDD_45.13.105.36_119	1
#026#003#001	1
GET / HTTP/1.1	1
Host: 45.13.105.36:119	1
#003	1
#023#003#023#001#023#002#001	1
TOTAL: 9	9

NNRP client timeouts [Top 20]:

System	Conn	Peer
194.165.16.10	1	1
TOTAL: 1	1	1

Daily Usenet report for news.niel.me

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