Daily Usenet report: Nov 2 15:00:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Nov 2 15:00:55 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Nov 2 21:15:02 colo-sc-1 pgpverify[22242]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	12115	73.5%	1.5 MB	71.0%
innd	2493	15.1%	350.9 KB	16.5%
innfeed	1234	7.5%	173.1 KB	8.1%
cnfsstat	576	3.5%	85.8 KB	4.0%
nnrpd	55	0.3%	5.4 KB	0.3%
controlchan	12	0.1%	2.5 KB	0.1%
pgpverify	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.2 KB	0.0%
TOTAL: 8	16487	100.0%	2.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	30959	44.3%
Negative hits	27123	38.9%
Do not exist	11693	16.8%
Cache misses	33	0.0%
TOTAL: 4	69808	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.775	0.0%	66	0.000	11.742	62.444
article cleanup	00:00:00.091	0.0%	11786	0.000	0.008	0.040
article logging	00:00:00.443	0.0%	12050	0.000	0.037	1.204
article parse	00:00:00.193	0.0%	19879	0.000	0.010	0.039
article write	00:00:01.539	0.0%	10855	0.000	0.142	11.432
artlog/artcncl	00:00:00.000	0.0%	65	0.000	0.000	0.000
data move	00:00:00.035	0.0%	77446	0.000	0.000	0.005
hisgrep/artcncl	00:00:00.001	0.0%	61	0.000	0.016	0.125
hishave/artcncl	00:00:00.033	0.0%	66	0.000	0.500	2.600
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:08.288	0.0%	70329	0.000	0.118	1.171
history sync	00:00:00.015	0.0%	410	0.000	0.037	0.500
history write	00:00:00.493	0.0%	11786	0.000	0.042	4.875
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
idle	24:00:41.836	100.0%	77015	574.713	1122.403	4260.957
nntp read	00:00:00.560	0.0%	76813	0.000	0.007	0.023
overview write	00:00:00.035	0.0%	10855	0.000	0.003	0.033
perl filter	00:00:12.887	0.0%	11786	0.823	1.093	1.862
python filter	00:00:00.362	0.0%	11786	0.000	0.031	0.090
site send	00:00:01.936	0.0%	32566	0.021	0.059	0.098
TOTAL: 24:01:16.859	24:01:09.522	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.019	0.0%	10854	0.000	0.002	0.025
article prepare	00:00:00.000	0.0%	771	0.000	0.000	0.000
article read	00:00:00.647	0.0%	485	0.000	1.334	126.200
backlog stats	00:00:00.039	0.0%	63542	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.262	0.0%	38440	0.000	0.007	0.034
data write	00:00:00.710	0.0%	27633	0.000	0.026	0.070
idle	23:58:54.330	100.0%	63542	787.000	1358.697	4168.724
status file	00:00:00.066	0.0%	242	0.000	0.273	1.000
TOTAL: 23:58:57.544	23:58:56.073	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%	11	0.000	0.000	0.000
TOTAL: 00:00:00.240	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	hasname-out.news.weretis.net	5	20798	7714	12812	272	37%	48:24:14
2	news-out.aioe.org	2	11292	2793	8489	10	24%	24:56:14
3	news.nntp4.net	1	11591	506	10445	640	4%	23:55:01
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		9	43681	11013	31746	922	25%	97:15:29

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	24.8 MB	617.4 KB	25.4 MB	97%	3.3 KB
2	news-out.aioe.org	6.7 MB	15.3 KB	6.7 MB	99%	2.4 KB
3	news.nntp4.net	1.6 MB	2.2 MB	3.7 MB	41%	3.3 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		33.0 MB	2.8 MB	35.8 MB	92%	3.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 2 15:00:01 - 15:59:59	600	5.5%	0.17	1.7 MB	5.3%	0.49
Nov 2 16:00:00 - 16:59:59	712	6.6%	0.20	2.0 MB	6.2%	0.58
Nov 2 17:00:00 - 17:59:59	656	6.0%	0.18	2.2 MB	6.6%	0.62
Nov 2 18:00:00 - 18:59:59	609	5.6%	0.17	1.7 MB	5.0%	0.47
Nov 2 19:00:00 - 19:59:59	524	4.8%	0.15	1.6 MB	4.8%	0.45
Nov 2 20:00:00 - 20:59:59	464	4.3%	0.13	1.5 MB	4.6%	0.43
Nov 2 21:00:00 - 21:59:59	528	4.9%	0.15	1.6 MB	4.8%	0.45
Nov 2 22:00:00 - 22:59:59	455	4.2%	0.13	1.4 MB	4.2%	0.40
Nov 2 23:00:00 - 23:59:59	413	3.8%	0.11	1.4 MB	4.2%	0.39
Nov 3 00:00:00 - 00:59:59	272	2.5%	0.08	851.4 KB	2.5%	0.24
Nov 3 01:00:00 - 01:59:59	253	2.3%	0.07	1.1 MB	3.3%	0.31
Nov 3 02:00:00 - 02:59:59	178	1.6%	0.05	762.3 KB	2.3%	0.21
Nov 3 03:00:00 - 03:59:59	174	1.6%	0.05	840.2 KB	2.5%	0.23
Nov 3 04:00:00 - 04:59:59	176	1.6%	0.05	578.4 KB	1.7%	0.16
Nov 3 05:00:00 - 05:59:59	206	1.9%	0.06	741.1 KB	2.2%	0.21
Nov 3 06:00:00 - 06:59:59	280	2.6%	0.08	745.6 KB	2.2%	0.21
Nov 3 07:00:00 - 07:59:59	370	3.4%	0.10	1.2 MB	3.5%	0.33
Nov 3 08:00:00 - 08:59:59	570	5.2%	0.16	1.5 MB	4.5%	0.42
Nov 3 09:00:00 - 09:59:59	560	5.2%	0.16	1.5 MB	4.5%	0.42
Nov 3 10:00:00 - 10:59:59	562	5.2%	0.16	1.5 MB	4.4%	0.42
Nov 3 11:00:00 - 11:59:59	606	5.6%	0.17	1.7 MB	5.3%	0.49
Nov 3 12:00:00 - 12:59:59	539	5.0%	0.15	1.6 MB	4.9%	0.46
Nov 3 13:00:00 - 13:59:59	564	5.2%	0.16	1.7 MB	5.2%	0.48
Nov 3 14:00:00 - 15:00:01	588	5.4%	0.16	1.7 MB	5.1%	0.47
TOTAL: 24:00:00	10859	100.0%	0.13	32.8 MB	100.0%	0.39

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
FOUR	DEFAULT	1024.0 MB	390.4 MB	38.1%	9	0.17	73.28
ONE	DEFAULT	1024.0 MB	569.4 MB	55.6%	11	0.17	73.53
THREE	DEFAULT	1024.0 MB	403.0 MB	39.4%	9	0.16	73.80
TWO	DEFAULT	1024.0 MB	396.3 MB	38.7%	9	0.16	74.12
TOTAL: 4	-	4.0 GB	1.7 GB	42.9%	38	0.16	-

Sites sending bad articles:

Server		Total	Group	Other
1	news.nntp4.net	649	1	648
2	hasname-out.news.weretis.net	498	20	478
3	news-out.aioe.org	44	8	36
TOTAL: 3		1191	29	1162

Unwanted newsgroups [Top 20]:

Newsgroup	Count
sybase.public.powerdesigner.general	16
comp.infosystems.gemini	8
biz.marketplace	1
alt.2600.programz	1
alt.business.ads	1
fa.hylafax	1
wolfsburg.test	1
TOTAL: 7	29

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	432
EMP (md5)	304
EMP (phl)	139
EMP (phn nph)	18
Too many newsgroups (meow)	5
Scoring filter	1
TOTAL: 6	899

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.news.weretis.net	228
	news-out.aioe.org	34
	news.nntp4.net	1
	TOTAL: 3	263
TOTAL: 1		263

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	395	395	0	0	0	100%	20:30:49
2	aioe	9770	76	7918	3	1	0%	23:59:57
3	nntp4	12665	1	10337	0	0	0%	23:59:42
4	weretis	4267	0	3123	14	0	0%	23:58:26
TOTAL: 4		27097	472	21378	17	1	1%	92:28:54

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.4 MB	0.0 KB	1.4 MB	3.6 KB	20:30:49
2	aioe	316.5 KB	22.1 KB	338.6 KB	4.3 KB	23:59:57
3	nntp4	1.7 KB	0.0 KB	1.7 KB	1.7 KB	23:59:42
4	weretis	0.0 KB	40.8 KB	40.8 KB	2.9 KB	23:58:26
TOTAL: 4		1.7 MB	62.9 KB	1.7 MB	3.7 KB	92:28:54

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
147.182.247.10	0.001	0.003	00:00:00
165.22.244.120	0.006	0.010	00:00:00
192.241.197.122	0.000	0.002	00:00:00
TOTAL: 3	0.007	0.015	00:00:00

NNRP no permission clients:

System	Conn
165.22.244.120	8
147.182.247.10	2
192.241.197.122	1
TOTAL: 3	11

Daily Usenet report

Nov 2 15:00:01 -- Nov 3 15:00:01