Daily Usenet report: Oct 6 15:00:02

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Oct 6 15:01:12 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	45812	72.0%	6.5 MB	73.7%
innd	15349	24.1%	2.0 MB	22.7%
innfeed	1263	2.0%	155.0 KB	1.7%
cnfsstat	1152	1.8%	175.6 KB	1.9%
nnrpd	5	0.0%	0.6 KB	0.0%
overchan	2	0.0%	0.3 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 7	63584	100.0%	8.9 MB	100.0%

History cache:

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.762	0.0%	52	0.000	14.654	276.000
article cleanup	00:00:00.276	0.0%	45731	0.000	0.006	0.016
article logging	00:00:01.222	0.0%	45747	0.005	0.027	0.067
article parse	00:00:01.091	0.0%	137981	0.002	0.008	0.019
article write	00:00:02.145	0.0%	33566	0.018	0.064	0.827
artlog/artcncl	00:00:00.001	0.0%	50	0.000	0.020	0.500
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:00.251	0.0%	364677	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.001	0.0%	51	0.000	0.020	0.333
hishave/artcncl	00:00:00.331	0.0%	52	0.000	6.365	164.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:02.990	0.0%	240419	0.002	0.012	0.467
history sync	00:00:00.014	0.0%	336	0.000	0.042	0.667
history write	00:00:03.649	0.0%	45731	0.010	0.080	3.180
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
idle	23:58:56.541	99.9%	318141	173.981	271.378	558.870
nntp read	00:00:02.294	0.0%	317394	0.002	0.007	0.014
overview write	00:00:00.130	0.0%	33566	0.000	0.004	0.021
perl filter	00:00:57.338	0.1%	45731	0.758	1.254	1.521
python filter	00:00:01.212	0.0%	45731	0.000	0.027	0.063
site send	00:00:05.572	0.0%	100698	0.034	0.055	0.078
TOTAL: 24:00:40.251	24:00:15.820	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.092	0.0%	33416	0.000	0.003	0.018
article prepare	00:00:00.001	0.0%	15136	0.000	0.000	0.007
article read	00:00:00.367	0.0%	3522	0.000	0.104	6.351
backlog stats	00:00:00.121	0.0%	176967	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.763	0.0%	113388	0.000	0.007	0.043
data write	00:00:02.189	0.0%	80219	0.008	0.027	0.104
idle	23:53:39.764	100.0%	176967	334.494	486.078	907.099
status file	00:00:00.494	0.0%	190	0.000	2.600	26.706
TOTAL: 23:53:48.024	23:53:43.791	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%	1	0.000	0.000	0.000
TOTAL: 00:00:00.048	00:00:00.000	0.0%	-	-	-	-

Control commands to INND:

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	12	76006	25939	43380	6687	34%	48:48:23
2	usenet.blueworldhosting.com	720	24023	3863	15539	4621	16%	23:44:58
3	news.nntp4.net	3	38445	3677	33940	828	9%	24:08:10
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		736	138474	33479	92859	12136	24%	96:41:31

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	198.4 MB	50.7 MB	249.1 MB	79%	7.8 KB
2	news.nntp4.net	28.6 MB	5.1 MB	33.7 MB	84%	7.7 KB
3	usenet.blueworldhosting.com	23.9 MB	25.0 MB	49.0 MB	48%	5.9 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		250.9 MB	80.9 MB	331.8 MB	75%	7.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 6 15:00:02 - 15:59:59	1313	3.9%	0.36	11.7 MB	4.7%	3.34
Oct 6 16:00:00 - 16:59:59	1533	4.6%	0.43	11.9 MB	4.7%	3.39
Oct 6 17:00:00 - 17:59:59	1440	4.3%	0.40	12.5 MB	5.0%	3.55
Oct 6 18:00:00 - 18:59:59	1359	4.0%	0.38	10.3 MB	4.1%	2.93
Oct 6 19:00:00 - 19:59:59	1670	5.0%	0.46	12.2 MB	4.8%	3.46
Oct 6 20:00:00 - 20:59:59	1692	5.0%	0.47	13.2 MB	5.3%	3.76
Oct 6 21:00:00 - 21:59:59	1593	4.7%	0.44	12.3 MB	4.9%	3.51
Oct 6 22:00:00 - 22:59:59	1276	3.8%	0.35	10.5 MB	4.2%	2.98
Oct 6 23:00:00 - 23:59:59	1211	3.6%	0.34	9.7 MB	3.9%	2.77
Oct 7 00:00:00 - 00:59:59	1084	3.2%	0.30	8.5 MB	3.4%	2.42
Oct 7 01:00:00 - 01:59:59	1107	3.3%	0.31	8.3 MB	3.3%	2.35
Oct 7 02:00:00 - 02:59:59	1062	3.2%	0.29	8.3 MB	3.3%	2.37
Oct 7 03:00:00 - 03:59:59	1273	3.8%	0.35	10.7 MB	4.3%	3.04
Oct 7 04:00:00 - 04:59:59	1246	3.7%	0.35	10.1 MB	4.0%	2.87
Oct 7 05:00:00 - 05:59:59	1242	3.7%	0.34	9.3 MB	3.7%	2.64
Oct 7 06:00:00 - 06:59:59	1471	4.4%	0.41	9.0 MB	3.6%	2.55
Oct 7 07:00:00 - 07:59:59	1565	4.7%	0.43	12.3 MB	4.9%	3.49
Oct 7 08:00:00 - 08:59:59	1594	4.7%	0.44	10.9 MB	4.4%	3.11
Oct 7 09:00:00 - 09:59:59	1461	4.4%	0.41	10.0 MB	4.0%	2.84
Oct 7 10:00:00 - 10:59:59	1573	4.7%	0.44	11.4 MB	4.5%	3.25
Oct 7 11:00:00 - 11:59:59	1560	4.6%	0.43	10.7 MB	4.3%	3.04
Oct 7 12:00:00 - 12:59:59	1662	5.0%	0.46	11.3 MB	4.5%	3.20
Oct 7 13:00:00 - 13:59:59	1385	4.1%	0.38	9.5 MB	3.8%	2.71
Oct 7 14:00:00 - 15:00:01	1199	3.6%	0.33	6.6 MB	2.6%	1.88
TOTAL: 23:59:59	33571	100.0%	0.39	251.2 MB	100.0%	2.98

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	35.0 MB	3.4%	24	0.94	12.97
ONE	DEFAULT	1024.0 MB	198.5 MB	19.4%	26	0.93	13.00
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	41.9 MB	4.1%	24	0.94	12.85
TWO	DEFAULT	1024.0 MB	30.7 MB	3.0%	24	0.94	12.87
TOTAL: 8	-	20.0 GB	11.9 GB	59.6%	102	0.94	-

Sites sending bad articles:

Server		Total	Group	Unapp	Other
1	hasname-out.news.weretis.net	6710	14	0	6696
2	usenet.blueworldhosting.com	4630	1182	0	3448
3	news.nntp4.net	851	8	1	842
TOTAL: 3		12191	1204	1	10986

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	429
de.sci.medizin	214
fido7.pushkin.local	97
kraft.politics	94
fido7.ukrnews	58
kraft.talks	55
kraft.competent	32
kraft.vehicles	31
linux.kernel.git	29
fido7.fidonet.online	17
odessa.news	16
perl.cpan	13
adobe.illustrator.macintosh	12
fido7.lorapvt.horo	12
eternal-september.moderated	11
kraft.blacklog	9
local.general	9
alt.stupid	8
fido7.f715.techinfo	6
panix.chat.politics	5
TOTAL: 41	1204

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)	3488
Reject Google Groups posting to sci.crypt	2783
Reject Google Groups posting to comp.lang.c	2485
EMP (md5)	1780
Too many newsgroups	302
Scoring filter	62
EMP (phl)	46
hierarchy violation - crosspost outside sdnet	13
HTML Multipart	9
Too many newsgroups (meow)	2
TOTAL: 10	10970

INND no permission servers:

System	Conn
45.227.254.49	1
TOTAL: 1	1

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	usenet.blueworldhosting.com	11
	hasname-out.news.weretis.net	5
	TOTAL: 2	16
TOTAL: 1		16

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	nntp4	34141	2598	27175	89	0	7%	23:59:56
2	weretis	10461	325	6138	783	28	3%	23:59:57
3	bbsgslincom	0	0	0	0	9503	0%	23:59:57
4	aioe	0	0	0	0	33365	0%	23:59:57
5	blueworldhosting	32361	0	28916	0	3	0%	23:59:57
TOTAL: 5		76963	2923	62229	872	42899	3%	119:59:44

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	nntp4	17.2 MB	269.1 KB	17.4 MB	0.2 KB/s	6.6 KB	23:59:56
2	weretis	1.7 MB	6.3 MB	8.0 MB	0.1 KB/s	7.4 KB	23:59:57
3	bbsgslincom	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:57
4	aioe	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:57
5	blueworldhosting	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:57
TOTAL: 5		18.9 MB	6.5 MB	25.4 MB	0.1 KB/s	6.9 KB	119:59:44

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
198.199.100.51	0.002	0.002	0.000	00:00:00
TOTAL: 1	0.002	0.002	0.000	00:00:00

NNRP no permission clients:

System	Conn
198.199.100.51	1
TOTAL: 1	1

Daily Usenet report