Daily Usenet report: Jan 30 15:00:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jan 30 15:01:15 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Jan 31 06:45:02 colo-sc-1 pgpverify[27036]: pgpverify: verification failed
Jan 31 06:45:02 colo-sc-1 controlchan[15834]: skipping newgroup m moderator@dana.de (pgpverify failed) in <newgroup-de.admin.net-abuse.announce-2022-01-31@dana.de>

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	16374	74.1%	1.9 MB	71.9%
innd	3941	17.8%	536.4 KB	19.3%
innfeed	1187	5.4%	159.0 KB	5.7%
cnfsstat	576	2.6%	84.9 KB	3.1%
nnrpd	4	0.0%	0.4 KB	0.0%
controlchan	2	0.0%	0.2 KB	0.0%
overchan	1	0.0%	0.2 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 8	22086	100.0%	2.7 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	42515	43.4%
Positive hits	39663	40.5%
Do not exist	15819	16.1%
Cache misses	24	0.0%
TOTAL: 4	98021	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.305	0.0%	47	0.000	6.489	28.600
article cleanup	00:00:00.084	0.0%	15902	0.000	0.005	0.053
article logging	00:00:00.473	0.0%	16337	0.000	0.029	0.096
article parse	00:00:00.243	0.0%	32925	0.000	0.007	0.029
article write	00:00:00.958	0.0%	13562	0.000	0.071	2.643
artlog/artcncl	00:00:00.000	0.0%	46	0.000	0.000	0.000
data move	00:00:00.040	0.0%	112875	0.000	0.000	0.005
hisgrep/artcncl	00:00:00.000	0.0%	47	0.000	0.000	0.000
hishave/artcncl	00:00:00.011	0.0%	47	0.000	0.234	2.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:43.488	0.2%	98491	0.000	1.660	63.525
history sync	00:00:00.015	0.0%	397	0.000	0.038	0.667
history write	00:00:02.450	0.0%	15902	0.000	0.154	7.194
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:57:36.942	99.8%	112858	302.147	764.296	3124.839
nntp read	00:00:00.751	0.0%	113214	0.000	0.007	0.017
overview write	00:00:00.058	0.0%	13562	0.000	0.004	0.048
perl filter	00:00:20.099	0.0%	15902	0.784	1.264	8.396
python filter	00:00:00.485	0.0%	15902	0.000	0.030	0.104
site send	00:00:02.339	0.0%	40687	0.024	0.057	0.103
TOTAL: 24:01:03.212	24:00:48.741	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	13537	0.000	0.002	0.021
article prepare	00:00:00.000	0.0%	753	0.000	0.000	0.000
article read	00:00:00.026	0.0%	532	0.000	0.049	0.500
backlog stats	00:00:00.053	0.0%	75609	0.000	0.001	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.340	0.0%	46238	0.000	0.007	0.024
data write	00:00:00.866	0.0%	32851	0.000	0.026	0.060
idle	23:59:06.466	100.0%	75609	632.112	1142.013	3337.878
status file	00:00:00.885	0.0%	229	0.000	3.865	165.000
TOTAL: 23:59:12.625	23:59:08.662	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:00.000	0.0%	0	0.000	0.000	0.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	1	0.000	0.000	0.000
TOTAL: 00:00:00.025	00:00:00.000	0.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	147
name	2
pause	2
paused	2
reserve	2
TOTAL: 10	167

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	7	26285	6890	18467	928	26%	47:54:37
2	news-out.aioe.org	5	13305	6409	6888	8	48%	24:47:29
3	news.nntp4.net	2	15840	390	14025	1425	2%	23:59:01
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		15	55430	13689	39380	2361	24%	96:41:07

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	22.2 MB	1.6 MB	23.8 MB	93%	3.1 KB
2	news-out.aioe.org	16.8 MB	18.0 KB	16.8 MB	99%	2.7 KB
3	news.nntp4.net	1.1 MB	9.5 MB	10.7 MB	10%	6.0 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		40.1 MB	11.2 MB	51.3 MB	78%	3.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 30 15:00:01 - 15:59:59	756	5.6%	0.21	1.9 MB	4.9%	0.55
Jan 30 16:00:00 - 16:59:59	712	5.3%	0.20	2.1 MB	5.2%	0.58
Jan 30 17:00:00 - 17:59:59	769	5.7%	0.21	2.1 MB	5.3%	0.60
Jan 30 18:00:00 - 18:59:59	854	6.3%	0.24	2.2 MB	5.6%	0.64
Jan 30 19:00:00 - 19:59:59	697	5.1%	0.19	2.1 MB	5.2%	0.59
Jan 30 20:00:00 - 20:59:59	606	4.5%	0.17	1.7 MB	4.3%	0.49
Jan 30 21:00:00 - 21:59:59	716	5.3%	0.20	2.5 MB	6.4%	0.72
Jan 30 22:00:00 - 22:59:59	574	4.2%	0.16	1.9 MB	4.8%	0.55
Jan 30 23:00:00 - 23:59:59	433	3.2%	0.12	1.4 MB	3.5%	0.39
Jan 31 00:00:00 - 00:59:59	556	4.1%	0.15	2.0 MB	5.1%	0.58
Jan 31 01:00:00 - 01:59:59	334	2.5%	0.09	971.1 KB	2.4%	0.27
Jan 31 02:00:00 - 02:59:59	324	2.4%	0.09	1.0 MB	2.5%	0.29
Jan 31 03:00:00 - 03:59:59	226	1.7%	0.06	864.3 KB	2.1%	0.24
Jan 31 04:00:00 - 04:59:59	213	1.6%	0.06	785.2 KB	1.9%	0.22
Jan 31 05:00:00 - 05:59:59	296	2.2%	0.08	1.0 MB	2.6%	0.29
Jan 31 06:00:00 - 06:59:59	264	1.9%	0.07	890.9 KB	2.2%	0.25
Jan 31 07:00:00 - 07:59:59	394	2.9%	0.11	1.2 MB	2.9%	0.33
Jan 31 08:00:00 - 08:59:59	632	4.7%	0.18	2.1 MB	5.2%	0.59
Jan 31 09:00:00 - 09:59:59	617	4.6%	0.17	1.6 MB	3.9%	0.44
Jan 31 10:00:00 - 10:59:59	692	5.1%	0.19	1.9 MB	4.8%	0.54
Jan 31 11:00:00 - 11:59:59	623	4.6%	0.17	1.7 MB	4.2%	0.47
Jan 31 12:00:00 - 12:59:59	644	4.8%	0.18	1.7 MB	4.2%	0.47
Jan 31 13:00:00 - 13:59:59	715	5.3%	0.20	1.9 MB	4.8%	0.54
Jan 31 14:00:00 - 14:59:59	900	6.6%	0.25	2.4 MB	5.9%	0.67
Jan 31 15:00:00 - 15:00:03	4	0.0%	1.33	29.7 KB	0.1%	9.90
TOTAL: 24:00:02	13551	100.0%	0.16	39.8 MB	100.0%	0.47

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
FOUR	DEFAULT	1024.0 MB	272.9 MB	26.7%	5	0.20	60.39
ONE	DEFAULT	1024.0 MB	438.9 MB	42.9%	7	0.20	61.00
THREE	DEFAULT	1024.0 MB	281.5 MB	27.5%	5	0.20	61.78
TWO	DEFAULT	1024.0 MB	272.8 MB	26.6%	5	0.20	62.20
TOTAL: 4	-	4.0 GB	1.2 GB	30.9%	22	0.20	-

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	news.nntp4.net	1439	4	1	1434
2	hasname-out.news.weretis.net	1215	5	0	1210
3	news-out.aioe.org	123	6	0	117
TOTAL: 3		2777	15	1	2761

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.infosystems.gemini	7
alt.games.video.sony-playstation	1
ulm.test	1
wolfsburg.test	1
alt.sex.telephone.alt	1
uky.test	1
list.postfix.users	1
borland.public.test	1
alt.soupdragons	1
TOTAL: 9	15

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	1627
EMP (md5)	571
EMP (phn nph)	58
EMP (phl)	30
User-issued spam cancel	24
HTML Multipart	12
Too many newsgroups	3
Scoring filter	2
TOTAL: 8	2327

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.news.weretis.net	317
	news-out.aioe.org	116
	news.nntp4.net	1
	TOTAL: 3	434
TOTAL: 1		434

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	461	461	0	0	0	100%	19:55:51
2	aioe	9450	44	7113	1	1	0%	23:59:57
3	nntp4	15522	11	13149	0	1	0%	23:59:56
4	weretis	6871	0	6570	17	0	0%	23:56:44
TOTAL: 4		32304	516	26832	18	2	1%	91:52:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.5 MB	0.0 KB	1.5 MB	3.3 KB	19:55:51
2	aioe	194.6 KB	11.8 KB	206.5 KB	4.6 KB	23:59:57
3	nntp4	44.1 KB	0.0 KB	44.1 KB	4.0 KB	23:59:56
4	weretis	0.0 KB	87.3 KB	87.3 KB	5.1 KB	23:56:44
TOTAL: 4		1.7 MB	99.2 KB	1.8 MB	3.5 KB	91:52:28

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
scanner-07.ch1.censys-scanner.com	0.000	0.003	0.000	00:00:00
TOTAL: 1	0.000	0.003	0.000	00:00:00

NNRP no permission clients:

System	Conn
scanner-07.ch1.censys-scanner.com	1
TOTAL: 1	1

Daily Usenet report

Jan 30 15:00:01 -- Jan 31 15:00:03