Daily Usenet report: Apr 15 15:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 15 15:00:58 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Apr 16 05:56:44 colo-sc-1 pgpverify[11840]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17634	82.1%	1.9 MB	78.8%
innd	2160	10.1%	291.5 KB	11.8%
innfeed	1067	5.0%	141.1 KB	5.7%
cnfsstat	576	2.7%	88.7 KB	3.6%
nnrpd	16	0.1%	1.7 KB	0.1%
controlchan	12	0.1%	2.7 KB	0.1%
overchan	2	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.0 KB	0.0%
TOTAL: 8	21468	100.0%	2.4 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	22435	42.5%
Do not exist	16851	31.9%
Positive hits	13521	25.6%
Cache misses	16	0.0%
TOTAL: 4	52823	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.392	0.0%	52	0.000	7.538	31.500
article cleanup	00:00:00.090	0.0%	17227	0.000	0.005	0.029
article logging	00:00:00.503	0.0%	17602	0.000	0.029	0.073
article parse	00:00:00.285	0.0%	38730	0.000	0.007	0.028
article write	00:00:04.512	0.0%	16330	0.000	0.276	15.977
artlog/artcncl	00:00:00.001	0.0%	51	0.000	0.020	0.125
data move	00:00:00.034	0.0%	73489	0.000	0.000	0.010
hisgrep/artcncl	00:00:00.001	0.0%	45	0.000	0.022	0.125
hishave/artcncl	00:00:00.003	0.0%	52	0.000	0.058	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.925	0.0%	53086	0.000	0.262	4.534
history sync	00:00:00.017	0.0%	417	0.000	0.041	1.000
history write	00:00:02.285	0.0%	16958	0.000	0.135	4.210
hiswrite/artcncl	00:00:00.001	0.0%	7	0.000	0.143	0.250
idle	24:00:13.510	99.9%	72854	436.747	1186.119	3776.119
nntp read	00:00:00.646	0.0%	72585	0.000	0.009	0.027
overview write	00:00:00.053	0.0%	16330	0.000	0.003	0.025
perl filter	00:00:17.794	0.0%	16958	0.708	1.049	3.617
python filter	00:00:00.494	0.0%	16958	0.000	0.029	0.085
site send	00:00:02.529	0.0%	48846	0.020	0.052	0.093
TOTAL: 24:01:12.954	24:00:57.075	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.025	0.0%	16184	0.000	0.002	0.018
article prepare	00:00:00.000	0.0%	517	0.000	0.000	0.000
article read	00:00:00.081	0.0%	493	0.000	0.164	15.250
backlog stats	00:00:00.038	0.0%	55516	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.287	0.0%	33404	0.000	0.009	0.030
data write	00:00:00.550	0.0%	17315	0.000	0.032	0.103
idle	23:59:53.662	100.0%	55516	874.169	1556.194	4432.227
status file	00:00:00.068	0.0%	231	0.000	0.294	1.000
TOTAL: 23:59:56.210	23:59:54.711	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%	4	0.000	0.000	0.000
TOTAL: 00:00:01.286	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
control@usenet-fr.news.eu.org	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	7	13884	12571	1222	91	90%	24:42:57
2	news.nntp4.net	3	17286	4046	12402	838	23%	24:52:25
3	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 3		11	31170	16617	13624	929	53%	49:35:22

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	33.9 MB	166.7 KB	278.2 KB	34.4 MB	98%	2.8 KB
2	news.nntp4.net	10.9 MB	624.0 KB	6.9 MB	18.3 MB	59%	3.8 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		44.8 MB	790.7 KB	7.1 MB	52.7 MB	84%	3.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 15 15:00:02 - 15:59:59	1051	6.4%	0.29	3.0 MB	6.7%	0.84
Apr 15 16:00:00 - 16:59:59	920	5.6%	0.26	2.1 MB	4.8%	0.60
Apr 15 17:00:00 - 17:59:59	1018	6.2%	0.28	2.7 MB	6.0%	0.76
Apr 15 18:00:00 - 18:59:59	918	5.6%	0.26	2.5 MB	5.6%	0.71
Apr 15 19:00:00 - 19:59:59	839	5.1%	0.23	2.3 MB	5.2%	0.65
Apr 15 20:00:00 - 20:59:59	788	4.8%	0.22	2.6 MB	5.8%	0.73
Apr 15 21:00:00 - 21:59:59	701	4.3%	0.19	1.9 MB	4.4%	0.55
Apr 15 22:00:00 - 22:59:59	592	3.6%	0.16	1.8 MB	4.2%	0.52
Apr 15 23:00:00 - 23:59:59	437	2.7%	0.12	1.3 MB	3.0%	0.38
Apr 16 00:00:00 - 00:59:59	419	2.6%	0.12	1.2 MB	2.8%	0.36
Apr 16 01:00:00 - 01:59:59	331	2.0%	0.09	1.1 MB	2.5%	0.31
Apr 16 02:00:00 - 02:59:59	336	2.1%	0.09	1.2 MB	2.7%	0.34
Apr 16 03:00:00 - 03:59:59	349	2.1%	0.10	1.2 MB	2.7%	0.34
Apr 16 04:00:00 - 04:59:59	400	2.5%	0.11	1.3 MB	3.0%	0.37
Apr 16 05:00:00 - 05:59:59	348	2.1%	0.10	943.4 KB	2.1%	0.26
Apr 16 06:00:00 - 06:59:59	478	2.9%	0.13	1.1 MB	2.5%	0.31
Apr 16 07:00:00 - 07:59:59	696	4.3%	0.19	1.6 MB	3.5%	0.44
Apr 16 08:00:00 - 08:59:59	856	5.2%	0.24	2.1 MB	4.8%	0.60
Apr 16 09:00:00 - 09:59:59	819	5.0%	0.23	2.0 MB	4.5%	0.57
Apr 16 10:00:00 - 10:59:59	734	4.5%	0.20	2.0 MB	4.5%	0.56
Apr 16 11:00:00 - 11:59:59	762	4.7%	0.21	1.8 MB	4.1%	0.51
Apr 16 12:00:00 - 12:59:59	777	4.8%	0.22	2.1 MB	4.8%	0.60
Apr 16 13:00:00 - 13:59:59	844	5.2%	0.23	2.0 MB	4.6%	0.58
Apr 16 14:00:00 - 14:59:59	898	5.5%	0.25	2.2 MB	5.0%	0.63
Apr 16 15:00:00 - 15:00:05	2	0.0%	0.40	4.3 KB	0.0%	0.86
TOTAL: 24:00:03	16313	100.0%	0.19	44.1 MB	100.0%	0.52

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
FOUR	DEFAULT	1024.0 MB	367.0 MB	35.8%	0	0.23	52.53
ONE	DEFAULT	1024.0 MB	525.5 MB	51.3%	2	0.23	52.34
THREE	DEFAULT	1024.0 MB	368.6 MB	36.0%	0	0.24	51.62
TWO	DEFAULT	1024.0 MB	370.0 MB	36.1%	0	0.23	51.86
TOTAL: 4	-	4.0 GB	1.6 GB	39.8%	2	0.23	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.nntp4.net	845	17	208	1	619
2	news-out.aioe.org	425	0	61	0	364
TOTAL: 2		1270	17	269	1	983

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.hardware	6
panix.chat	6
alt.penthouse.sex.femdom	1
soc.culture.thailand	1
alt.fetish.feet	1
panix.questions	1
alt.pcnews	1
TOTAL: 7	17

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 (md5)	421
EMP (phl)	101
Too many newsgroups	26
EMP (phn path)	24
Binary: misplaced binary	10
Scoring filter	10
EMP (phn nph)	10
HTML Multipart	4
Too many newsgroups (meow)	3
TOTAL: 9	609

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	news-out.aioe.org	334
	news.nntp4.net	40
	TOTAL: 2	374
TOTAL: 1		374

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Spool	%Took	Elapsed
1	bbsgslincom	485	485	0	0	100%	21:16:58
2	aioe	3844	8	3752	19	0%	24:00:00
3	nntp4	12442	0	12404	0	0%	24:00:00
TOTAL: 3		16771	493	16156	19	2%	69:16:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	2.0 MB	2.0 MB	4.1 KB	21:16:58
2	aioe	22.7 KB	22.7 KB	2.8 KB	24:00:00
3	nntp4	0.0 KB	0.0 KB	0	24:00:00
TOTAL: 3		2.0 MB	2.0 MB	4.1 KB	69:16:58

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
news.nntp4.net	0.004	0.004	00:00:01
cloud.census.shodan.io	0.000	0.005	00:00:00
TOTAL: 2	0.004	0.009	00:00:01

NNRP no permission clients:

System	Conn
news.nntp4.net	2
cloud.census.shodan.io	2
TOTAL: 2	4

Daily Usenet report

Apr 15 15:00:02 -- Apr 16 15:00:05