Daily Usenet report: May 2 15:00:05

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 2 15:02:19 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
May 2 20:45:04 colo-sc-1 pgpverify[23163]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	16099	80.6%	1.7 MB	76.8%
innd	2200	11.0%	312.4 KB	13.5%
innfeed	1058	5.3%	142.9 KB	6.2%
cnfsstat	576	2.9%	76.2 KB	3.3%
nnrpd	20	0.1%	2.0 KB	0.1%
controlchan	12	0.1%	2.4 KB	0.1%
pgpverify	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 8	19967	100.0%	2.3 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	27289	49.1%
Do not exist	15558	28.0%
Positive hits	12659	22.8%
Cache misses	20	0.0%
TOTAL: 4	55526	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.549	0.0%	52	0.000	49.019	337.000
article cleanup	00:00:00.097	0.0%	15713	0.000	0.006	0.044
article logging	00:00:00.542	0.0%	16051	0.000	0.034	0.080
article parse	00:00:00.295	0.0%	33786	0.000	0.009	0.039
article write	00:00:03.479	0.0%	14757	0.000	0.236	10.328
artlog/artcncl	00:00:00.001	0.0%	51	0.000	0.020	0.167
data move	00:00:00.042	0.0%	73585	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.000	0.0%	50	0.000	0.000	0.000
hishave/artcncl	00:00:00.235	0.0%	52	0.000	4.519	206.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:20.167	0.0%	56035	0.000	0.360	6.661
history sync	00:00:00.022	0.0%	350	0.000	0.063	0.500
history write	00:00:09.538	0.0%	15711	0.000	0.607	18.970
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
idle	23:59:22.510	99.9%	72957	622.925	1183.745	4840.460
nntp read	00:00:00.670	0.0%	72748	0.000	0.009	0.026
overview write	00:00:00.060	0.0%	14757	0.000	0.004	0.033
perl filter	00:00:19.176	0.0%	15711	0.800	1.221	7.109
python filter	00:00:00.445	0.0%	15711	0.000	0.028	0.089
site send	00:00:02.434	0.0%	44075	0.016	0.055	0.107
TOTAL: 24:00:44.919	24:00:22.262	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.021	0.0%	14549	0.000	0.001	0.028
article prepare	00:00:00.001	0.0%	344	0.000	0.003	0.100
article read	00:00:00.543	0.0%	341	0.000	1.592	132.750
backlog stats	00:00:00.031	0.0%	50192	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.218	0.0%	29931	0.000	0.007	0.061
data write	00:00:00.479	0.0%	15403	0.000	0.031	0.111
idle	23:59:41.638	100.0%	50192	990.041	1721.024	5467.727
status file	00:00:00.631	0.0%	238	0.000	2.651	251.000
TOTAL: 23:59:44.895	23:59:43.562	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%	5	0.000	0.000	0.000
TOTAL: 00:00:00.917	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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
moderator@dana.de	0	0	1	1	0	1
TOTAL	0	0	1	1	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	4	13032	10805	2096	131	82%	24:24:44
2	news.nntp4.net	3	15787	4133	10852	802	26%	24:30:07
3	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 3		8	28819	14938	12948	933	51%	48:54:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	28.7 MB	0.0 KB	182.4 KB	28.9 MB	99%	2.7 KB
2	news.nntp4.net	13.7 MB	4.1 KB	2.2 MB	15.9 MB	86%	3.3 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		42.4 MB	4.1 KB	2.3 MB	44.8 MB	94%	2.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 2 15:00:05 - 15:59:59	811	5.5%	0.23	2.9 MB	6.9%	0.83
May 2 16:00:00 - 16:59:59	853	5.8%	0.24	2.4 MB	5.6%	0.67
May 2 17:00:00 - 17:59:59	905	6.1%	0.25	2.8 MB	6.8%	0.81
May 2 18:00:00 - 18:59:59	829	5.6%	0.23	2.2 MB	5.1%	0.61
May 2 19:00:00 - 19:59:59	710	4.8%	0.20	1.9 MB	4.6%	0.55
May 2 20:00:00 - 20:59:59	646	4.4%	0.18	1.9 MB	4.5%	0.54
May 2 21:00:00 - 21:59:59	503	3.4%	0.14	1.7 MB	4.1%	0.49
May 2 22:00:00 - 22:59:59	539	3.7%	0.15	1.4 MB	3.3%	0.40
May 2 23:00:00 - 23:59:59	404	2.7%	0.11	1.1 MB	2.7%	0.32
May 3 00:00:00 - 00:59:59	309	2.1%	0.09	1.3 MB	3.0%	0.36
May 3 01:00:00 - 01:59:59	313	2.1%	0.09	912.1 KB	2.1%	0.25
May 3 02:00:00 - 02:59:59	241	1.6%	0.07	849.6 KB	2.0%	0.24
May 3 03:00:00 - 03:59:59	236	1.6%	0.07	717.4 KB	1.7%	0.20
May 3 04:00:00 - 04:59:59	285	1.9%	0.08	1.0 MB	2.5%	0.30
May 3 05:00:00 - 05:59:59	319	2.2%	0.09	1.1 MB	2.5%	0.30
May 3 06:00:00 - 06:59:59	489	3.3%	0.14	1.4 MB	3.2%	0.38
May 3 07:00:00 - 07:59:59	685	4.6%	0.19	1.7 MB	4.1%	0.49
May 3 08:00:00 - 08:59:59	749	5.1%	0.21	1.9 MB	4.5%	0.54
May 3 09:00:00 - 09:59:59	815	5.5%	0.23	1.9 MB	4.6%	0.55
May 3 10:00:00 - 10:59:59	845	5.7%	0.23	2.1 MB	5.1%	0.61
May 3 11:00:00 - 11:59:59	765	5.2%	0.21	2.0 MB	4.7%	0.57
May 3 12:00:00 - 12:59:59	739	5.0%	0.21	1.8 MB	4.3%	0.51
May 3 13:00:00 - 13:59:59	836	5.7%	0.23	2.6 MB	6.2%	0.74
May 3 14:00:00 - 14:59:59	922	6.2%	0.26	2.4 MB	5.6%	0.67
May 3 15:00:00 - 15:00:06	5	0.0%	0.83	10.7 KB	0.0%	1.78
TOTAL: 24:00:01	14753	100.0%	0.17	41.9 MB	100.0%	0.50

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
FOUR	DEFAULT	1024.0 MB	693.5 MB	67.7%	0	0.22	55.18
ONE	DEFAULT	1024.0 MB	852.4 MB	83.2%	2	0.22	55.98
THREE	DEFAULT	1024.0 MB	696.0 MB	68.0%	0	0.21	56.86
TWO	DEFAULT	1024.0 MB	696.7 MB	68.0%	0	0.22	55.58
TOTAL: 4	-	4.0 GB	2.9 GB	71.7%	2	0.22	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nntp4.net	868	24	2	1	841
2	news-out.aioe.org	426	0	0	0	426
TOTAL: 2		1294	24	2	1	1267

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.blah	13
alt.computer.hardware	4
alt.ebook	1
lada.music	1
alt.alien	1
revue.test	1
mozilla.dev.ports.os2	1
alt.finals.suicide	1
vic.general	1
TOTAL: 9	24

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)	319
EMP (md5)	285
EMP (phn nph)	215
EMP (phl)	99
User-issued spam cancel	6
HTML Multipart	3
Too many newsgroups	2
Scoring filter	1
TOTAL: 8	930

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	292
	news.nntp4.net	45
	TOTAL: 2	337
TOTAL: 1		337

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	%Took	Elapsed
1	bbsgslincom	332	332	0	100%	18:16:42
2	aioe	3891	1	3810	0%	23:50:00
3	nntp4	10691	0	10687	0%	23:59:14
TOTAL: 3		14914	333	14497	2%	66:05:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.5 MB	1.5 MB	4.5 KB	18:16:42
2	aioe	5.2 KB	5.2 KB	5.2 KB	23:50:00
3	nntp4	0.0 KB	0.0 KB	0	23:59:14
TOTAL: 3		1.5 MB	1.5 MB	4.5 KB	66:05:56

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
news.nntp4.net	0.001	0.005	00:00:00
hat.census.shodan.io	0.000	0.004	00:00:00
scanner-06.ch1.censys-scanner.com	0.000	0.003	00:00:00
TOTAL: 3	0.001	0.012	00:00:00

NNRP no permission clients:

System	Conn
hat.census.shodan.io	2
news.nntp4.net	2
scanner-06.ch1.censys-scanner.com	1
TOTAL: 3	5

Daily Usenet report

May 2 15:00:05 -- May 3 15:00:06