Daily Usenet report: Jul 31 15:00:02

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 31 15:01:29 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Aug 1 00:04:02 colo-sc-1 pgpverify[4603]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	16087	68.0%	2.2 MB	68.3%
innd	4959	21.0%	665.3 KB	20.4%
innfeed	1408	6.0%	186.1 KB	5.7%
cnfsstat	1152	4.9%	173.9 KB	5.3%
nnrpd	25	0.1%	2.6 KB	0.1%
controlchan	22	0.1%	5.4 KB	0.2%
pgpverify	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.2 KB	0.0%
TOTAL: 8	23655	100.0%	3.2 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	37072	41.6%
Positive hits	36332	40.8%
Do not exist	15595	17.5%
Cache misses	84	0.1%
TOTAL: 4	89083	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.994	0.0%	73	0.000	13.616	183.000
article cleanup	00:00:00.111	0.0%	15766	0.000	0.007	0.044
article logging	00:00:00.440	0.0%	16057	0.000	0.027	0.080
article parse	00:00:00.287	0.0%	30403	0.000	0.009	0.033
article write	00:00:02.192	0.0%	12791	0.000	0.171	16.100
artlog/artcncl	00:00:00.003	0.0%	73	0.000	0.041	0.200
data move	00:00:00.057	0.0%	94520	0.000	0.001	0.006
hisgrep/artcncl	00:00:00.000	0.0%	73	0.000	0.000	0.000
hishave/artcncl	00:00:00.001	0.0%	73	0.000	0.014	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:01.479	0.0%	89970	0.000	0.016	1.008
history sync	00:00:00.019	0.0%	411	0.000	0.046	0.500
history write	00:00:00.493	0.0%	15766	0.000	0.031	0.151
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:00:27.517	100.0%	96880	484.282	892.109	2589.733
nntp read	00:00:00.631	0.0%	96346	0.000	0.007	0.018
overview write	00:00:00.040	0.0%	12791	0.000	0.003	0.032
perl filter	00:00:17.763	0.0%	15766	0.907	1.127	1.810
python filter	00:00:00.479	0.0%	15766	0.000	0.030	0.089
site send	00:00:01.965	0.0%	38375	0.020	0.051	0.083
TOTAL: 24:01:04.467	24:00:54.471	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	12753	0.000	0.002	0.028
article prepare	00:00:00.002	0.0%	11784	0.000	0.000	0.012
article read	00:00:00.123	0.0%	3009	0.000	0.041	0.222
backlog stats	00:00:00.067	0.0%	78983	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.331	0.0%	46593	0.000	0.007	0.038
data write	00:00:00.985	0.0%	34037	0.004	0.029	0.083
idle	23:57:21.695	100.0%	78983	608.044	1091.902	2715.611
status file	00:00:00.192	0.0%	264	0.000	0.727	61.000
TOTAL: 23:57:25.528	23:57:23.421	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.165	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	Other	Bad PGP	OK
bofh-control@killfile.org	1	0	1
us-control@lists.killfile.org	0	1	0
TOTAL	1	1	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	5	26141	8326	16904	911	31%	49:37:15
2	usenet.blueworldhosting.com	288	15204	3431	10129	1644	22%	23:40:17
3	news.nntp4.net	1	10866	1022	9497	347	9%	22:27:17
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		295	52211	12779	36530	2902	24%	95:44:49

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	28.2 MB	4.2 MB	32.5 MB	86%	3.6 KB
2	usenet.blueworldhosting.com	14.9 MB	6.4 MB	21.2 MB	70%	4.3 KB
3	news.nntp4.net	2.7 MB	1.2 MB	3.9 MB	69%	2.9 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		45.8 MB	11.8 MB	57.6 MB	79%	3.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 31 15:00:02 - 15:59:59	780	6.1%	0.22	2.9 MB	6.2%	0.81
Jul 31 16:00:00 - 16:59:59	736	5.8%	0.20	2.4 MB	5.3%	0.69
Jul 31 17:00:00 - 17:59:59	727	5.7%	0.20	2.3 MB	5.0%	0.65
Jul 31 18:00:00 - 18:59:59	637	5.0%	0.18	2.3 MB	5.1%	0.66
Jul 31 19:00:00 - 19:59:59	604	4.7%	0.17	2.0 MB	4.3%	0.56
Jul 31 20:00:00 - 20:59:59	645	5.1%	0.18	2.0 MB	4.3%	0.56
Jul 31 21:00:00 - 21:59:59	479	3.8%	0.13	1.6 MB	3.5%	0.45
Jul 31 22:00:00 - 22:59:59	611	4.8%	0.17	2.3 MB	5.0%	0.65
Jul 31 23:00:00 - 23:59:59	399	3.1%	0.11	1.4 MB	3.1%	0.40
Aug 1 00:00:00 - 00:59:59	454	3.6%	0.13	2.2 MB	4.8%	0.63
Aug 1 01:00:00 - 01:59:59	336	2.6%	0.09	1.7 MB	3.8%	0.49
Aug 1 02:00:00 - 02:59:59	277	2.2%	0.08	1008.0 KB	2.2%	0.28
Aug 1 03:00:00 - 03:59:59	249	2.0%	0.07	867.5 KB	1.9%	0.24
Aug 1 04:00:00 - 04:59:59	294	2.3%	0.08	1.1 MB	2.4%	0.31
Aug 1 05:00:00 - 05:59:59	377	3.0%	0.10	2.2 MB	4.9%	0.64
Aug 1 06:00:00 - 06:59:59	385	3.0%	0.11	1.6 MB	3.6%	0.46
Aug 1 07:00:00 - 07:59:59	406	3.2%	0.11	1.5 MB	3.2%	0.42
Aug 1 08:00:00 - 08:59:59	546	4.3%	0.15	1.8 MB	3.9%	0.51
Aug 1 09:00:00 - 09:59:59	591	4.6%	0.16	1.8 MB	3.8%	0.50
Aug 1 10:00:00 - 10:59:59	680	5.3%	0.19	2.4 MB	5.2%	0.67
Aug 1 11:00:00 - 11:59:59	590	4.6%	0.16	1.8 MB	3.8%	0.50
Aug 1 12:00:00 - 12:59:59	662	5.2%	0.18	2.3 MB	5.0%	0.65
Aug 1 13:00:00 - 13:59:59	646	5.1%	0.18	2.2 MB	4.8%	0.63
Aug 1 14:00:00 - 15:00:01	649	5.1%	0.18	2.3 MB	4.9%	0.64
TOTAL: 23:59:59	12760	100.0%	0.15	45.7 MB	100.0%	0.54

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
EIGHT	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
FIVE	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
FOUR	DEFAULT	1024.0 MB	483.6 MB	47.2%	22	0.21	58.14
ONE	DEFAULT	1024.0 MB	644.7 MB	63.0%	24	0.21	57.16
SEVEN	BIG	4.0 GB	2.9 GB	72.6%	1	0.00	0.00
SIX	BIG	4.0 GB	2.9 GB	72.8%	1	0.00	0.00
THREE	DEFAULT	1024.0 MB	494.5 MB	48.3%	22	0.21	57.94
TWO	DEFAULT	1024.0 MB	479.8 MB	46.9%	22	0.21	58.92
TOTAL: 8	-	20.0 GB	13.7 GB	68.4%	94	0.21	-

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	usenet.blueworldhosting.com	1654	723	6	925
2	hasname-out.news.weretis.net	1177	1	0	1176
3	news.nntp4.net	423	7	0	416
TOTAL: 3		3254	731	6	2517

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fido7.pushkin.local	164
fido7.pravda.news	59
fido7.ukrnews	53
kraft.competent	52
kraft.vehicles	46
linux.kernel.git	46
kraft.politics	32
kraft.talks	30
odessa.news	29
fido7.starper.limited	28
fido7.f715.techinfo	27
linux.redhat.rhsa.announce	20
perl.cpan	19
linux.kernel.netdev	16
kraft.hardware	15
fido7.fidonet.online	12
fido7.lorapvt.horo	12
local.general	8
alt.stupid	6
rocksolid.feeds.news	5
TOTAL: 49	731

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
alt.penthouse.sex.spanking	5
bit.listserv.catholic	1
TOTAL: 2	6

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1203
EMP (phn path)	943
Too many newsgroups	40
EMP (fsl)	28
Scoring filter	9
HTML Multipart	3
Too many newsgroups (meow)	2
HTML post	1
hierarchy violation - crosspost outside sdnet	1
TOTAL: 9	2230

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.news.weretis.net	273
	usenet.blueworldhosting.com	9
	news.nntp4.net	5
	TOTAL: 3	287
TOTAL: 1		287

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nntp4	12340	2668	8897	88	1	21%	23:59:55
2	bbsgslincom	275	275	0	0	0	100%	17:38:15
3	weretis	7603	98	4369	33	0	1%	23:59:56
4	blueworldhosting	10669	0	8958	0	20	0%	23:59:56
5	aioe	0	0	0	0	12673	0%	23:59:56
TOTAL: 5		30887	3041	22224	121	12694	9%	113:37:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nntp4	12.3 MB	254.1 KB	12.5 MB	0.1 KB/s	4.7 KB	23:59:55
2	bbsgslincom	1.0 MB	0.0 KB	1.0 MB	0.0 KB/s	3.7 KB	17:38:15
3	weretis	480.3 KB	83.9 KB	564.2 KB	0.0 KB/s	4.3 KB	23:59:56
4	blueworldhosting	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
5	aioe	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
TOTAL: 5		13.8 MB	338.0 KB	14.1 MB	0.0 KB/s	4.6 KB	113:37:58

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
107.170.240.13	0.001	0.001	00:00:00
71.6.134.232	0.000	0.006	00:00:00
152.89.198.113	0.000	0.002	00:00:00
TOTAL: 3	0.001	0.009	00:00:00

NNRP no permission clients:

System	Conn
71.6.134.232	3
107.170.240.13	1
152.89.198.113	1
TOTAL: 3	5

Daily Usenet report

Jul 31 15:00:02 -- Aug 1 15:00:01