Daily Usenet report: Jan 1 15:00:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jan 1 15:01:09 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Jan 2 11:22:41 colo-sc-1 pgpverify[11518]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	15182	74.2%	1.8 MB	71.7%
innd	3425	16.7%	473.3 KB	18.1%
innfeed	1259	6.2%	174.2 KB	6.7%
cnfsstat	576	2.8%	87.9 KB	3.4%
controlchan	12	0.1%	2.5 KB	0.1%
nnrpd	9	0.0%	0.9 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 8	20465	100.0%	2.6 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	40022	43.3%
Positive hits	37444	40.6%
Do not exist	14537	15.7%
Cache misses	327	0.4%
TOTAL: 4	92330	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.976	0.0%	355	0.000	5.566	328.000
article cleanup	00:00:00.066	0.0%	14639	0.000	0.005	0.033
article logging	00:00:00.428	0.0%	14837	0.000	0.029	0.140
article parse	00:00:00.256	0.0%	27126	0.000	0.009	0.045
article write	00:00:01.131	0.0%	12626	0.000	0.090	3.417
artlog/artcncl	00:00:00.001	0.0%	355	0.000	0.003	0.004
data move	00:00:00.046	0.0%	103091	0.000	0.000	0.007
hisgrep/artcncl	00:00:00.005	0.0%	350	0.000	0.014	0.100
hishave/artcncl	00:00:00.290	0.0%	355	0.000	0.817	65.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:55.133	0.1%	92679	0.000	1.242	48.376
history sync	00:00:00.014	0.0%	355	0.000	0.039	0.500
history write	00:00:03.250	0.0%	14639	0.000	0.222	17.920
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
idle	23:58:17.035	99.8%	102605	288.479	841.061	2554.306
nntp read	00:00:00.758	0.0%	102788	0.000	0.007	0.018
overview write	00:00:00.043	0.0%	12626	0.000	0.003	0.029
perl filter	00:00:16.930	0.0%	14639	0.716	1.156	16.926
python filter	00:00:00.420	0.0%	14639	0.000	0.029	0.087
site send	00:00:02.323	0.0%	37878	0.027	0.061	0.129
TOTAL: 24:00:53.223	24:00:40.105	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.029	0.0%	13090	0.000	0.002	0.022
article prepare	00:00:00.001	0.0%	870	0.000	0.001	0.091
article read	00:00:00.027	0.0%	519	0.000	0.052	1.000
backlog stats	00:00:00.043	0.0%	71740	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.316	0.0%	43403	0.000	0.007	0.025
data write	00:00:00.863	0.0%	30992	0.000	0.028	0.077
idle	23:57:54.377	100.0%	71740	424.947	1202.598	2492.413
status file	00:00:00.098	0.0%	251	0.000	0.390	2.000
TOTAL: 23:57:57.438	23:57:55.754	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%	2	0.000	0.000	0.000
TOTAL: 00:00:00.044	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
hun-mnt@news.sztaki.hu	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	hasname-out.news.weretis.net	5	25217	6892	17292	1033	27%	48:08:15
2	news-out.aioe.org	2	12439	5436	6983	20	43%	24:07:20
3	news.nntp4.net	1	13554	247	12414	893	1%	22:37:37
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		9	51210	12575	36689	1946	24%	94:53:12

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	23.9 MB	1.8 MB	25.7 MB	92%	3.3 KB
2	news-out.aioe.org	14.4 MB	24.8 KB	14.5 MB	99%	2.7 KB
3	news.nntp4.net	807.8 KB	2.0 MB	2.8 MB	28%	2.5 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		39.1 MB	3.8 MB	42.9 MB	91%	3.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 1 15:00:01 - 15:59:59	607	4.8%	0.17	1.6 MB	4.0%	0.45
Jan 1 16:00:00 - 16:59:59	637	5.0%	0.18	1.6 MB	4.2%	0.47
Jan 1 17:00:00 - 17:59:59	626	5.0%	0.17	1.9 MB	4.9%	0.55
Jan 1 18:00:00 - 18:59:59	618	4.9%	0.17	1.8 MB	4.5%	0.50
Jan 1 19:00:00 - 19:59:59	634	5.0%	0.18	2.4 MB	6.0%	0.68
Jan 1 20:00:00 - 20:59:59	653	5.2%	0.18	2.4 MB	6.1%	0.68
Jan 1 21:00:00 - 21:59:59	588	4.7%	0.16	2.1 MB	5.4%	0.61
Jan 1 22:00:00 - 22:59:59	569	4.5%	0.16	1.7 MB	4.4%	0.49
Jan 1 23:00:00 - 23:59:59	549	4.4%	0.15	1.6 MB	3.9%	0.44
Jan 2 00:00:00 - 00:59:59	385	3.1%	0.11	1.2 MB	3.1%	0.35
Jan 2 01:00:00 - 01:59:59	448	3.6%	0.12	1.6 MB	4.1%	0.46
Jan 2 02:00:00 - 02:59:59	502	4.0%	0.14	1.8 MB	4.5%	0.51
Jan 2 03:00:00 - 03:59:59	274	2.2%	0.08	1.2 MB	2.9%	0.33
Jan 2 04:00:00 - 04:59:59	253	2.0%	0.07	934.8 KB	2.3%	0.26
Jan 2 05:00:00 - 05:59:59	288	2.3%	0.08	939.9 KB	2.3%	0.26
Jan 2 06:00:00 - 06:59:59	551	4.4%	0.15	2.6 MB	6.5%	0.73
Jan 2 07:00:00 - 07:59:59	345	2.7%	0.10	1.1 MB	2.8%	0.31
Jan 2 08:00:00 - 08:59:59	630	5.0%	0.17	1.6 MB	4.0%	0.45
Jan 2 09:00:00 - 09:59:59	603	4.8%	0.17	1.7 MB	4.3%	0.48
Jan 2 10:00:00 - 10:59:59	527	4.2%	0.15	1.4 MB	3.6%	0.41
Jan 2 11:00:00 - 11:59:59	570	4.5%	0.16	1.5 MB	3.8%	0.43
Jan 2 12:00:00 - 12:59:59	591	4.7%	0.16	1.5 MB	3.8%	0.43
Jan 2 13:00:00 - 13:59:59	539	4.3%	0.15	1.3 MB	3.3%	0.37
Jan 2 14:00:00 - 14:59:59	630	5.0%	0.17	2.0 MB	5.0%	0.56
Jan 2 15:00:00 - 15:00:02	1	0.0%	0.50	2.3 KB	0.0%	1.17
TOTAL: 24:00:01	12618	100.0%	0.15	39.5 MB	100.0%	0.47

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
FOUR	DEFAULT	1024.0 MB	789.5 MB	77.1%	4	0.19	63.80
ONE	DEFAULT	1024.0 MB	955.1 MB	93.3%	6	0.19	64.40
THREE	DEFAULT	1024.0 MB	798.5 MB	78.0%	4	0.19	62.27
TWO	DEFAULT	1024.0 MB	790.5 MB	77.2%	4	0.20	61.89
TOTAL: 4	-	4.0 GB	3.3 GB	81.4%	18	0.19	-

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	hasname-out.news.weretis.net	1140	2	0	1138
2	news.nntp4.net	969	3	1	965
3	news-out.aioe.org	99	1	0	98
TOTAL: 3		2208	6	1	2201

Unwanted newsgroups [Top 20]:

Newsgroup	Count
oecher.wohnungsmarkt	1
alt.fetish.feet	1
biz.marketplace	1
alt.penthouse.sex.femdom	1
comp.infosystems.gemini	1
braunschweig.test	1
TOTAL: 6	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)	1610
EMP (phn nph)	171
EMP (md5)	157
EMP (phl)	32
User-issued spam cancel	18
HTML Multipart	7
Scoring filter	5
HTML post	1
TOTAL: 8	2001

INND no permission servers:

System	Conn
89.248.168.176	1
80.66.88.19	1
TOTAL: 2	2

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.news.weretis.net	121
	news-out.aioe.org	79
	TOTAL: 2	200
TOTAL: 1		200

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	406	406	0	0	0	100%	20:14:05
2	aioe	9418	41	6973	9	100	0%	23:59:52
3	nntp4	14996	30	12318	9	390	0%	23:59:53
4	weretis	6079	0	5701	27	0	0%	23:59:41
TOTAL: 4		30899	477	24992	45	490	1%	92:13:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.9 MB	0.0 KB	1.9 MB	4.8 KB	20:14:05
2	aioe	165.9 KB	79.8 KB	245.8 KB	4.9 KB	23:59:52
3	nntp4	95.1 KB	40.4 KB	135.5 KB	3.5 KB	23:59:53
4	weretis	0.0 KB	64.6 KB	64.6 KB	2.4 KB	23:59:41
TOTAL: 4		2.1 MB	184.9 KB	2.3 MB	4.6 KB	92:13:31

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
scanner-09.ch1.censys-scanner.com	0.002	0.001	00:00:00
80.66.88.19	0.001	0.001	00:00:00
TOTAL: 2	0.003	0.002	00:00:00

NNRP no permission clients:

System	Conn
scanner-09.ch1.censys-scanner.com	1
80.66.88.19	1
TOTAL: 2	2

Daily Usenet report

Jan 1 15:00:01 -- Jan 2 15:00:02