Daily Usenet report: Apr 3 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	16522	52.2%	4.0 MB	65.1%
innd	12152	38.4%	1.6 MB	26.8%
innfeed	2932	9.3%	498.1 KB	8.0%
nocem	25	0.1%	2.5 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	31632	100.0%	6.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	148763	56.3%
Negative hits	99350	37.6%
Do not exist	15977	6.0%
Cache misses	59	0.0%
TOTAL: 4	264149	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.011	0.0%	64	0.000	0.172	1.000
article cleanup	00:00:00.068	0.0%	15985	0.000	0.004	0.033
article logging	00:00:00.477	0.0%	16404	0.000	0.029	0.087
article parse	00:00:00.236	0.0%	28644	0.000	0.008	0.067
article write	00:00:08.981	0.0%	15175	0.079	0.592	16.214
artlog/artcncl	00:00:00.001	0.0%	63	0.000	0.016	0.500
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:00.094	0.0%	269623	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.001	0.0%	62	0.000	0.016	1.000
hishave/artcncl	00:00:00.000	0.0%	64	0.000	0.000	0.000
hishave/artparse	00:00:00.000	0.0%	0	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.866	0.0%	264284	0.000	0.003	0.008
history sync	00:00:00.014	0.0%	386	0.000	0.036	0.500
history write	00:00:02.337	0.0%	15986	0.000	0.146	4.037
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hiswrite/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:49:53.463	99.9%	273235	172.197	313.991	931.391
nntp read	00:00:01.814	0.0%	271863	0.002	0.007	0.014
overview write	00:00:06.178	0.0%	15175	0.021	0.407	17.347
perl filter	00:00:16.600	0.0%	15984	0.690	1.039	2.688
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.601	0.0%	30374	0.000	0.020	0.062
TOTAL: 23:50:58.906	23:50:31.742	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.018	0.0%	17087	0.000	0.001	0.022
article prepare	00:00:00.007	0.0%	116130	0.000	0.000	0.003
article read	00:00:00.675	0.0%	14795	0.000	0.046	1.571
backlog stats	00:00:00.358	0.0%	342852	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.448	0.0%	234043	0.000	0.006	0.010
data write	00:00:02.018	0.0%	219888	0.003	0.009	0.020
idle	23:54:47.888	100.0%	342852	134.401	251.093	734.129
status file	00:00:00.208	0.0%	286	0.000	0.727	7.667
TOTAL: 23:54:58.494	23:54:52.620	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
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	i2pn-out.news.weretis.net	4	28577	5949	22579	49	20%	52:39:46
2	news-out.aioe.org	2	12807	2841	9934	32	22%	24:09:03
3	feeder.eternal-september.org	57	5473	2517	2747	209	45%	36:14:17
4	paganini.bofh.team	3	16961	1379	15348	234	8%	27:27:39
5	usenet.goja.nl.eu.org	12	15273	975	14181	117	6%	24:26:12
6	news-out.neodome.net	2	14407	560	13819	28	3%	23:59:55
7	news.swapon.de	11	1248	356	892	0	28%	23:18:13
8	news.niel.me	2	3685	259	3373	53	7%	24:46:36
9	news.nntp4.net	1	15322	222	15039	61	1%	23:59:57
10	i2pn-out.feed.uzoreto.com	2257	23350	181	23121	48	0%	70:28:34
11	i2pn2.org	35	616	85	531	0	13%	20:06:18
12	novabbs.org	2	4067	5	4062	0	0%	23:15:32
13	news.bbs.nz	1	10812	1	10811	0	0%	20:22:10
14	localhost	27	0	0	0	0	0%	00:00:00
15	kf5zxw.com	1	10111	0	10111	0	0%	18:44:07
TOTAL: 15		2417	162709	15330	146548	831	9%	413:58:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn-out.news.weretis.net	26.0 MB	0.0 KB	126.1 KB	26.1 MB	99%	4.5 KB
2	news-out.aioe.org	7.4 MB	0.0 KB	94.0 KB	7.5 MB	98%	2.7 KB
3	feeder.eternal-september.org	6.8 MB	0.0 KB	1.8 MB	8.6 MB	78%	3.2 KB
4	paganini.bofh.team	4.2 MB	0.0 KB	6.5 MB	10.7 MB	39%	6.8 KB
5	usenet.goja.nl.eu.org	2.6 MB	0.0 KB	237.4 KB	2.9 MB	91%	2.7 KB
6	news-out.neodome.net	1.5 MB	17.0 KB	109.6 KB	1.6 MB	92%	2.8 KB
7	news.swapon.de	916.2 KB	0.0 KB	0.0 KB	916.2 KB	100%	2.6 KB
8	news.nntp4.net	706.2 KB	0.0 KB	3.4 MB	4.1 MB	16%	14.7 KB
9	i2pn-out.feed.uzoreto.com	672.4 KB	0.0 KB	143.3 KB	815.6 KB	82%	3.6 KB
10	news.niel.me	665.7 KB	0.0 KB	99.0 KB	764.8 KB	87%	2.5 KB
11	i2pn2.org	179.8 KB	0.0 KB	0.0 KB	179.8 KB	100%	2.1 KB
12	news.bbs.nz	17.9 KB	0.0 KB	0.0 KB	17.9 KB	100%	17.9 KB
13	novabbs.org	11.8 KB	0.0 KB	0.0 KB	11.8 KB	100%	2.4 KB
14	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
15	kf5zxw.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 15		51.6 MB	17.0 KB	12.5 MB	64.1 MB	80%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 3 04:15:02 - 04:59:59	208	1.4%	0.08	850.1 KB	1.6%	0.32
Apr 3 05:00:00 - 05:59:59	353	2.3%	0.10	1.1 MB	2.1%	0.31
Apr 3 06:00:00 - 06:59:59	468	3.1%	0.13	1.8 MB	3.5%	0.50
Apr 3 07:00:00 - 07:59:59	561	3.7%	0.16	1.7 MB	3.4%	0.49
Apr 3 08:00:00 - 08:59:59	672	4.4%	0.19	2.1 MB	4.1%	0.59
Apr 3 09:00:00 - 09:59:59	717	4.7%	0.20	1.8 MB	3.6%	0.52
Apr 3 10:00:00 - 10:59:59	824	5.4%	0.23	3.2 MB	6.3%	0.92
Apr 3 11:00:00 - 11:59:59	832	5.5%	0.23	2.5 MB	4.9%	0.71
Apr 3 12:00:00 - 12:59:59	842	5.5%	0.23	2.7 MB	5.3%	0.76
Apr 3 13:00:00 - 13:59:59	961	6.3%	0.27	2.7 MB	5.4%	0.78
Apr 3 14:00:00 - 14:59:59	789	5.2%	0.22	2.1 MB	4.1%	0.59
Apr 3 15:00:00 - 15:59:59	879	5.8%	0.24	2.5 MB	5.0%	0.72
Apr 3 16:00:00 - 16:59:59	930	6.1%	0.26	2.9 MB	5.7%	0.82
Apr 3 17:00:00 - 17:59:59	812	5.3%	0.23	2.6 MB	5.2%	0.74
Apr 3 18:00:00 - 18:59:59	706	4.6%	0.20	2.2 MB	4.4%	0.64
Apr 3 19:00:00 - 19:59:59	876	5.8%	0.24	2.4 MB	4.7%	0.68
Apr 3 20:00:00 - 20:59:59	645	4.2%	0.18	2.7 MB	5.4%	0.78
Apr 3 21:00:00 - 21:59:59	559	3.7%	0.16	2.5 MB	5.0%	0.73
Apr 3 22:00:00 - 22:59:59	634	4.2%	0.18	2.3 MB	4.5%	0.64
Apr 3 23:00:00 - 23:59:59	479	3.1%	0.13	2.4 MB	4.7%	0.67
Apr 4 00:00:00 - 00:59:59	359	2.4%	0.10	1.2 MB	2.4%	0.35
Apr 4 01:00:00 - 01:59:59	467	3.1%	0.13	1.5 MB	2.9%	0.42
Apr 4 02:00:00 - 02:59:59	311	2.0%	0.09	1.7 MB	3.4%	0.49
Apr 4 03:00:00 - 03:59:59	263	1.7%	0.07	983.3 KB	1.9%	0.27
Apr 4 04:00:00 - 04:15:01	70	0.5%	0.08	250.6 KB	0.5%	0.28
TOTAL: 23:59:59	15217	100.0%	0.18	50.8 MB	100.0%	0.60

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	paganini.bofh.team	228	20	0	208
2	feeder.eternal-september.org	210	19	0	191
3	i2pn-out.news.weretis.net	209	26	0	183
4	news.swapon.de	163	0	0	163
5	usenet.goja.nl.eu.org	132	0	0	132
6	news-out.aioe.org	81	18	0	63
7	news.nntp4.net	57	7	0	50
8	news.niel.me	54	45	0	9
9	i2pn-out.feed.uzoreto.com	53	29	0	24
10	news-out.neodome.net	44	0	1	43
11	kf5zxw.com	2	0	0	2
TOTAL: 11		1233	164	1	1068

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.misc.actualite.covid19	70
alt.news.misc	24
att.jobs	14
fr.comp.sys.raspberry-pi	8
aus.jobs	6
it.eventi.covid19	6
alt.tv.comedy-central.daily-show	5
sk.politics	5
alt.finance	3
alt.connecticut	3
alt.math	3
alt.testing	2
sourceforge.firebird-devel	2
alt.ads	1
trollnet.cinema	1
alt.college.camp-all-stars	1
sdf.music	1
alt.science	1
alt.business.biz.newsgroup	1
alt.business.ads	1
TOTAL: 26	164

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	542
Poison newsgroup	51
User-issued cancel	19
Too many newsgroups	17
HTML Multipart	12
Binary: misplaced rar	3
Scoring filter (8)	1
Scoring filter (9)	1
HTML Image Tags	1
TOTAL: 9	647

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	19	0	19	19
TOTAL: 1	19	5	19	19

INND no permission servers:

System	Conn
167.248.133.37	1
TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn-out.news.weretis.net	164
	news.swapon.de	163
	news-out.aioe.org	50
	usenet.goja.nl.eu.org	15
	feeder.eternal-september.org	11
	paganini.bofh.team	9
	i2pn-out.feed.uzoreto.com	5
	news.nntp4.net	1
	news.niel.me	1
	TOTAL: 9	419
No colon-space in header
	i2pn-out.feed.uzoreto.com	2
	TOTAL: 1	2
TOTAL: 2		421

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	i2pn2	14418	13929	63	361	1	137	96%	23:59:56
2	novabbs	18462	10079	4058	399	1	149	54%	23:59:48
3	kf5zxw.com	27257	1831	13379	6	0	325	6%	23:59:54
4	news.bbs.nz	29608	186	14941	86	1	447	0%	23:59:55
5	weretis.net	15164	131	7894	1216	0	1	0%	23:59:56
6	paganini.bofh.team	14363	121	13783	0	0	143	0%	23:59:44
7	news.nntp4.net	15302	113	14865	0	0	136	0%	23:59:56
8	news.niel.me	4013	109	3798	32	0	36	2%	23:59:56
9	aioe	11753	96	11272	7	0	163	0%	23:59:38
10	neodome	14965	91	14452	1	0	85	0%	23:59:48
11	eternal-september	13106	72	12494	10	0	125	0%	23:59:21
12	news.uzoreto.com	13114	68	12698	21	0	81	0%	23:59:19
13	usenet.goja.nl.eu.org	14327	40	14019	56	0	74	0%	23:59:55
14	swapon.de	959	0	947	0	0	0	0%	23:02:43
15	news.samoylyk.net	0	0	0	0	0	15114	0%	23:57:46
TOTAL: 15		206811	26866	138663	2195	3	17016	12%	358:57:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	i2pn2	37.7 MB	1.6 MB	39.3 MB	0.5 KB/s	2.8 KB	23:59:56
2	novabbs	32.5 MB	2.8 MB	35.4 MB	0.4 KB/s	3.5 KB	23:59:48
3	kf5zxw.com	9.9 MB	12.9 KB	9.9 MB	0.1 KB/s	5.5 KB	23:59:54
4	news.bbs.nz	644.6 KB	198.2 KB	842.8 KB	0.0 KB/s	3.1 KB	23:59:55
5	weretis.net	323.5 KB	2.4 MB	2.7 MB	0.0 KB/s	2.1 KB	23:59:56
6	paganini.bofh.team	282.2 KB	0.0 KB	282.2 KB	0.0 KB/s	2.3 KB	23:59:44
7	news.nntp4.net	264.9 KB	0.0 KB	264.9 KB	0.0 KB/s	2.3 KB	23:59:56
8	news.niel.me	243.4 KB	133.7 KB	377.1 KB	0.0 KB/s	2.7 KB	23:59:56
9	aioe	208.9 KB	13.9 KB	222.8 KB	0.0 KB/s	2.2 KB	23:59:38
10	neodome	199.7 KB	5.5 KB	205.1 KB	0.0 KB/s	2.2 KB	23:59:48
11	news.uzoreto.com	165.5 KB	39.0 KB	204.5 KB	0.0 KB/s	2.3 KB	23:59:19
12	eternal-september	159.2 KB	22.5 KB	181.6 KB	0.0 KB/s	2.2 KB	23:59:21
13	usenet.goja.nl.eu.org	127.6 KB	91.1 KB	218.7 KB	0.0 KB/s	2.3 KB	23:59:55
14	swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:02:43
15	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
TOTAL: 15		82.6 MB	7.4 MB	90.0 MB	0.1 KB/s	3.2 KB	358:57:35

Daily Usenet report

Apr 3 04:15:02 -- Apr 4 04:15:01