Daily Usenet report: Jul 7 15:00:01

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Jul 7 15:00:54 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Jul 8 04:49:14 colo-sc-1 innd: message repeated 4 times: [ 87.121.221.43 rejected 502]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	14341	59.9%	1.9 MB	60.1%
innd	7006	29.3%	921.6 KB	28.3%
innfeed	1406	5.9%	201.1 KB	6.2%
cnfsstat	1152	4.8%	172.5 KB	5.3%
nnrpd	29	0.1%	3.0 KB	0.1%
overchan	1	0.0%	0.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	23936	100.0%	3.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	32994	43.0%
Negative hits	29912	39.0%
Do not exist	13851	18.0%
Cache misses	22	0.0%
TOTAL: 4	76779	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.106	0.0%	31	0.000	3.419	79.000
article cleanup	00:00:00.081	0.0%	13978	0.000	0.006	0.035
article logging	00:00:00.364	0.0%	14332	0.000	0.025	0.083
article parse	00:00:00.219	0.0%	26017	0.000	0.008	0.036
article write	00:00:00.483	0.0%	10573	0.000	0.046	0.116
artlog/artcncl	00:00:00.001	0.0%	28	0.000	0.036	0.143
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.036	0.0%	82709	0.000	0.000	0.005
hisgrep/artcncl	00:00:00.002	0.0%	30	0.000	0.067	1.000
hishave/artcncl	00:00:00.002	0.0%	31	0.000	0.065	2.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:02.373	0.0%	77464	0.000	0.031	1.086
history sync	00:00:00.009	0.0%	363	0.000	0.025	0.500
history write	00:00:00.497	0.0%	13978	0.000	0.036	0.592
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	24:00:27.732	100.0%	85835	589.654	1006.905	3372.713
nntp read	00:00:00.568	0.0%	84880	0.000	0.007	0.020
overview write	00:00:00.028	0.0%	10573	0.000	0.003	0.038
perl filter	00:00:13.640	0.0%	13978	0.558	0.976	1.737
python filter	00:00:00.411	0.0%	13978	0.000	0.029	0.079
site send	00:00:01.692	0.0%	31719	0.016	0.053	0.127
TOTAL: 24:00:55.341	24:00:48.244	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.024	0.0%	10556	0.000	0.002	0.032
article prepare	00:00:00.001	0.0%	2981	0.000	0.000	0.020
article read	00:00:00.038	0.0%	791	0.000	0.048	0.500
backlog stats	00:00:00.043	0.0%	67596	0.000	0.001	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.274	0.0%	38302	0.000	0.007	0.026
data write	00:00:00.735	0.0%	27868	0.000	0.026	0.093
idle	23:59:19.489	100.0%	67596	698.138	1277.583	4139.186
status file	00:00:00.068	0.0%	263	0.000	0.259	1.000
TOTAL: 23:59:22.921	23:59:20.672	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%	6	0.000	0.000	0.000
TOTAL: 00:00:00.186	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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	4	19769	6419	12325	1025	32%	45:54:05
2	usenet.blueworldhosting.com	720	13770	2838	9068	1864	20%	23:47:27
3	news.nntp4.net	2	12625	1173	10926	526	9%	24:07:46
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		727	46164	10430	32319	3415	22%	93:49:18

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	21.8 MB	3.4 MB	25.2 MB	86%	3.5 KB
2	usenet.blueworldhosting.com	13.3 MB	10.8 MB	24.1 MB	55%	5.2 KB
3	news.nntp4.net	2.8 MB	1.2 MB	4.1 MB	69%	2.5 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		37.9 MB	15.4 MB	53.4 MB	71%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 7 15:00:01 - 15:59:59	715	6.8%	0.20	2.3 MB	6.1%	0.66
Jul 7 16:00:00 - 16:59:59	614	5.8%	0.17	1.9 MB	5.0%	0.54
Jul 7 17:00:00 - 17:59:59	712	6.7%	0.20	2.4 MB	6.4%	0.69
Jul 7 18:00:00 - 18:59:59	619	5.9%	0.17	2.3 MB	6.0%	0.65
Jul 7 19:00:00 - 19:59:59	614	5.8%	0.17	1.9 MB	5.0%	0.55
Jul 7 20:00:00 - 20:59:59	484	4.6%	0.13	1.7 MB	4.3%	0.47
Jul 7 21:00:00 - 21:59:59	521	4.9%	0.14	1.9 MB	4.9%	0.54
Jul 7 22:00:00 - 22:59:59	426	4.0%	0.12	1.7 MB	4.5%	0.49
Jul 7 23:00:00 - 23:59:59	345	3.3%	0.10	1.3 MB	3.4%	0.37
Jul 8 00:00:00 - 00:59:59	314	3.0%	0.09	1.0 MB	2.7%	0.29
Jul 8 01:00:00 - 01:59:59	237	2.2%	0.07	1.2 MB	3.2%	0.35
Jul 8 02:00:00 - 02:59:59	202	1.9%	0.06	915.2 KB	2.3%	0.25
Jul 8 03:00:00 - 03:59:59	183	1.7%	0.05	636.0 KB	1.6%	0.18
Jul 8 04:00:00 - 04:59:59	290	2.7%	0.08	1.1 MB	2.9%	0.31
Jul 8 05:00:00 - 05:59:59	285	2.7%	0.08	1.4 MB	3.7%	0.41
Jul 8 06:00:00 - 06:59:59	345	3.3%	0.10	1.2 MB	3.2%	0.35
Jul 8 07:00:00 - 07:59:59	383	3.6%	0.11	1.2 MB	3.0%	0.33
Jul 8 08:00:00 - 08:59:59	558	5.3%	0.15	1.9 MB	5.0%	0.54
Jul 8 09:00:00 - 09:59:59	470	4.5%	0.13	1.5 MB	3.9%	0.43
Jul 8 10:00:00 - 10:59:59	443	4.2%	0.12	1.8 MB	4.6%	0.51
Jul 8 11:00:00 - 11:59:59	454	4.3%	0.13	2.0 MB	5.3%	0.58
Jul 8 12:00:00 - 12:59:59	432	4.1%	0.12	2.2 MB	5.8%	0.63
Jul 8 13:00:00 - 13:59:59	407	3.9%	0.11	1.3 MB	3.3%	0.36
Jul 8 14:00:00 - 15:00:02	504	4.8%	0.14	1.5 MB	3.8%	0.42
TOTAL: 24:00:01	10557	100.0%	0.12	38.4 MB	100.0%	0.45

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	95.7 MB	9.3%	22	0.18	67.75
ONE	DEFAULT	1024.0 MB	255.7 MB	25.0%	24	0.18	69.13
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	106.6 MB	10.4%	22	0.17	70.23
TWO	DEFAULT	1024.0 MB	91.7 MB	9.0%	22	0.18	68.16
TOTAL: 8	-	20.0 GB	12.2 GB	60.8%	94	0.18	-

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	usenet.blueworldhosting.com	1903	711	1	1191
2	hasname-out.news.weretis.net	1330	1	0	1329
3	news.nntp4.net	523	2	0	521
TOTAL: 3		3756	714	1	3041

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	610
linux.kernel.git	53
alfanet.nocem	20
kraft.talks	6
rocksolid.feeds.news	5
kraft.blacklog	4
alt.stupid	3
harvard.forsale	2
local.general	2
mailing.database.sql-general	1
comp.infosystems.gemini	1
fido.ru.android	1
chico.forsale	1
alt.sex.bondage.particle	1
alt.politics.liberal	1
vic.forsale	1
aol.neighborhood.ca.fresno.marketplace	1
alt.russia	1
TOTAL: 18	714

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)	1203
EMP (md5)	1171
Too many newsgroups	123
EMP (phl)	109
EMP (phn nph)	74
Scoring filter	7
HTML Multipart	3
TOTAL: 7	2690

INND no permission servers:

System	Conn
87.121.221.43	3
162.142.125.217	1
TOTAL: 2	4

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.news.weretis.net	311
	usenet.blueworldhosting.com	36
	news.nntp4.net	4
	TOTAL: 3	351
TOTAL: 1		351

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	321	321	0	0	0	100%	17:14:58
2	nntp4	12096	307	9073	4	0	2%	23:59:48
3	weretis	6223	294	3612	60	0	4%	23:59:57
4	blueworldhosting	8117	0	7030	0	0	0%	23:59:43
5	aioe	0	0	0	0	10426	0%	23:59:57
TOTAL: 5		26757	922	19715	64	10426	3%	113:14:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	2.2 MB	0.0 KB	2.2 MB	7.0 KB	17:14:58
2	weretis	1.3 MB	182.0 KB	1.5 MB	4.4 KB	23:59:57
3	nntp4	1.3 MB	6.7 KB	1.3 MB	4.3 KB	23:59:48
4	blueworldhosting	0.0 KB	0.0 KB	0.0 KB	0	23:59:43
5	aioe	0.0 KB	0.0 KB	0.0 KB	0	23:59:57
TOTAL: 5		4.8 MB	188.6 KB	5.0 MB	5.2 KB	113:14:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
spirited.monitoring.internet-measurement.com	0.001	0.002	00:00:00
192.241.218.47	0.001	0.002	00:00:00
71.6.134.232	0.003	0.004	00:00:00
193.233.21.25	0.000	0.003	00:00:00
TOTAL: 4	0.005	0.011	00:00:00

NNRP no permission clients:

System	Conn
71.6.134.232	3
192.241.218.47	1
193.233.21.25	1
spirited.monitoring.internet-measurement.com	1
TOTAL: 4	6

Daily Usenet report

Jul 7 15:00:01 -- Jul 8 15:00:02