Daily Usenet report: May 28 15:00:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

May 28 15:01:13 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
May 29 07:30:03 colo-sc-1 pgpverify[16939]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	11870	74.0%	1.4 MB	71.1%
innd	2318	14.5%	335.9 KB	16.2%
innfeed	1193	7.4%	167.6 KB	8.1%
cnfsstat	576	3.6%	86.2 KB	4.2%
nnrpd	71	0.4%	7.7 KB	0.4%
controlchan	2	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.2 KB	0.0%
overchan	1	0.0%	0.2 KB	0.0%
TOTAL: 8	16032	100.0%	2.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	31232	42.6%
Negative hits	30413	41.5%
Do not exist	11593	15.8%
Cache misses	37	0.1%
TOTAL: 4	73275	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.043	0.0%	37	0.000	1.162	6.000
article cleanup	00:00:00.067	0.0%	11701	0.000	0.006	0.055
article logging	00:00:00.345	0.0%	11841	0.000	0.029	0.125
article parse	00:00:00.176	0.0%	21385	0.000	0.008	0.030
article write	00:00:00.766	0.0%	10863	0.000	0.071	2.735
artlog/artcncl	00:00:00.000	0.0%	37	0.000	0.000	0.000
data move	00:00:00.052	0.0%	80464	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.000	0.0%	31	0.000	0.000	0.000
hishave/artcncl	00:00:00.000	0.0%	37	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.117	0.0%	73996	0.000	0.015	0.600
history sync	00:00:00.009	0.0%	369	0.000	0.024	0.500
history write	00:00:01.055	0.0%	11701	0.000	0.090	4.418
hiswrite/artcncl	00:00:00.001	0.0%	6	0.000	0.167	1.000
idle	24:00:27.090	100.0%	81016	613.401	1066.790	2857.295
nntp read	00:00:00.537	0.0%	80821	0.000	0.007	0.018
overview write	00:00:00.031	0.0%	10863	0.000	0.003	0.034
perl filter	00:00:12.095	0.0%	11701	0.754	1.034	4.745
python filter	00:00:00.351	0.0%	11701	0.000	0.030	0.094
site send	00:00:01.957	0.0%	32588	0.023	0.060	0.119
TOTAL: 24:00:54.197	24:00:45.692	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.027	0.0%	10860	0.000	0.002	0.025
article prepare	00:00:00.000	0.0%	833	0.000	0.000	0.000
article read	00:00:00.029	0.0%	524	0.000	0.055	0.500
backlog stats	00:00:00.052	0.0%	64272	0.000	0.001	0.006
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.316	0.0%	37710	0.000	0.008	0.024
data write	00:00:00.726	0.0%	27188	0.000	0.027	0.072
idle	23:58:03.745	100.0%	64272	731.951	1342.478	2943.922
status file	00:00:01.192	0.0%	224	0.000	5.321	284.250
TOTAL: 23:58:12.047	23:58:06.087	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.001	0.2%	17	0.000	0.059	1.000
TOTAL: 00:00:00.643	00:00:00.001	0.2%	-	-	-	-

Control commands to INND:

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

Control Channel:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	7	20795	7038	13489	268	33%	47:53:51
2	news-out.aioe.org	5	11019	3754	7264	1	34%	24:43:00
3	news.nntp4.net	1	12769	149	11969	651	1%	25:50:33
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		14	44583	10941	32722	920	24%	98:27:24

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	22.5 MB	431.0 KB	22.9 MB	98%	3.2 KB
2	news-out.aioe.org	10.2 MB	1.5 KB	10.2 MB	99%	2.8 KB
3	news.nntp4.net	697.9 KB	1.8 MB	2.5 MB	27%	3.2 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		33.3 MB	2.2 MB	35.6 MB	93%	3.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 28 15:00:01 - 15:59:59	610	5.6%	0.17	1.8 MB	5.6%	0.52
May 28 16:00:00 - 16:59:59	686	6.3%	0.19	2.3 MB	7.1%	0.66
May 28 17:00:00 - 17:59:59	647	6.0%	0.18	2.0 MB	6.2%	0.58
May 28 18:00:00 - 18:59:59	565	5.2%	0.16	1.8 MB	5.4%	0.51
May 28 19:00:00 - 19:59:59	603	5.6%	0.17	1.8 MB	5.4%	0.51
May 28 20:00:00 - 20:59:59	539	5.0%	0.15	1.8 MB	5.5%	0.52
May 28 21:00:00 - 21:59:59	497	4.6%	0.14	1.6 MB	4.9%	0.46
May 28 22:00:00 - 22:59:59	427	3.9%	0.12	1.2 MB	3.8%	0.35
May 28 23:00:00 - 23:59:59	272	2.5%	0.08	865.2 KB	2.6%	0.24
May 29 00:00:00 - 00:59:59	333	3.1%	0.09	1.3 MB	3.9%	0.36
May 29 01:00:00 - 01:59:59	315	2.9%	0.09	1.3 MB	4.0%	0.38
May 29 02:00:00 - 02:59:59	250	2.3%	0.07	795.4 KB	2.4%	0.22
May 29 03:00:00 - 03:59:59	200	1.8%	0.06	696.9 KB	2.1%	0.19
May 29 04:00:00 - 04:59:59	284	2.6%	0.08	1023.8 KB	3.0%	0.28
May 29 05:00:00 - 05:59:59	268	2.5%	0.07	857.9 KB	2.5%	0.24
May 29 06:00:00 - 06:59:59	319	2.9%	0.09	902.0 KB	2.7%	0.25
May 29 07:00:00 - 07:59:59	410	3.8%	0.11	1.3 MB	3.9%	0.36
May 29 08:00:00 - 08:59:59	498	4.6%	0.14	1.3 MB	4.1%	0.38
May 29 09:00:00 - 09:59:59	553	5.1%	0.15	1.6 MB	4.7%	0.44
May 29 10:00:00 - 10:59:59	544	5.0%	0.15	1.3 MB	4.1%	0.38
May 29 11:00:00 - 11:59:59	458	4.2%	0.13	1.2 MB	3.7%	0.34
May 29 12:00:00 - 12:59:59	525	4.8%	0.15	1.3 MB	4.0%	0.37
May 29 13:00:00 - 13:59:59	525	4.8%	0.15	1.4 MB	4.2%	0.39
May 29 14:00:00 - 14:59:59	527	4.9%	0.15	1.4 MB	4.3%	0.40
May 29 15:00:00 - 15:00:02	3	0.0%	1.50	12.7 KB	0.0%	6.35
TOTAL: 24:00:01	10858	100.0%	0.13	32.9 MB	100.0%	0.39

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
FOUR	DEFAULT	1024.0 MB	151.6 MB	14.8%	7	0.16	74.39
ONE	DEFAULT	1024.0 MB	326.2 MB	31.9%	9	0.16	75.16
THREE	DEFAULT	1024.0 MB	162.1 MB	15.8%	7	0.16	75.38
TWO	DEFAULT	1024.0 MB	152.7 MB	14.9%	7	0.16	74.34
TOTAL: 4	-	4.0 GB	792.6 MB	19.4%	30	0.16	-

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	news.nntp4.net	562	2	1	559
2	hasname-out.news.weretis.net	371	4	0	367
3	news-out.aioe.org	43	0	0	43
TOTAL: 3		976	6	1	969

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.buttered.scones	2
fr.misc.domotique	1
panix.test	1
alt.ham-radio	1
alt.alt.alt	1
TOTAL: 5	6

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)	488
EMP (phn nph)	162
EMP (md5)	135
EMP (phl)	35
EMP (fsl)	4
HTML Multipart	2
Scoring filter	2
TOTAL: 7	828

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.news.weretis.net	99
	news-out.aioe.org	42
	TOTAL: 2	141
TOTAL: 1		141

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	422	422	0	0	0	100%	20:41:20
2	aioe	9064	81	6739	15	0	0%	23:59:54
3	weretis	4044	1	3809	6	0	0%	23:59:54
4	nntp4	13198	0	10722	0	26	0%	23:59:54
TOTAL: 4		26728	504	21270	21	26	1%	92:41:02

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	2.3 MB	0.0 KB	2.3 MB	5.6 KB	20:41:20
2	aioe	216.5 KB	37.8 KB	254.3 KB	2.6 KB	23:59:54
3	weretis	11.8 KB	104.1 KB	115.9 KB	16.6 KB	23:59:54
4	nntp4	0.0 KB	0.0 KB	0.0 KB	0	23:59:54
TOTAL: 4		2.5 MB	141.9 KB	2.7 MB	5.2 KB	92:41:02

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
178-79-148-229.ip.linodeusercontent.com	0.012	0.018	00:00:00
139.59.94.193	0.002	0.001	00:00:00
scanner-06.ch1.censys-scanner.com	0.001	0.004	00:00:00
192.241.213.224	0.001	0.001	00:00:00
192.241.220.113	0.001	0.002	00:00:00
TOTAL: 5	0.017	0.026	00:00:00

NNRP no permission clients:

System	Conn
178-79-148-229.ip.linodeusercontent.com	12
scanner-06.ch1.censys-scanner.com	2
192.241.213.224	1
139.59.94.193	1
192.241.220.113	1
TOTAL: 5	17

Daily Usenet report

May 28 15:00:01 -- May 29 15:00:02