Daily Usenet report: Feb 29 15:00:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Feb 29 15:01:48 colo-sc-1 innd: message repeated 2 times: [ ctlinnd command s]
Mar 1 00:04:02 colo-sc-1 pgpverify[29269]: pgpverify: verification failed
Mar 1 05:45:03 colo-sc-1 pgpverify[16978]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	12439	63.3%	1.7 MB	64.6%
innd	3893	19.8%	464.5 KB	17.4%
innfeed	2080	10.6%	286.0 KB	10.7%
cnfsstat	1152	5.9%	179.6 KB	6.7%
controlchan	57	0.3%	9.3 KB	0.3%
overchan	25	0.1%	4.2 KB	0.2%
nnrpd	15	0.1%	1.5 KB	0.1%
pgpverify	2	0.0%	0.1 KB	0.0%
TOTAL: 8	19663	100.0%	2.6 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	25084	42.0%
Positive hits	24116	40.4%
Do not exist	10320	17.3%
Cache misses	243	0.4%
TOTAL: 4	59763	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.623	0.0%	59	0.000	10.559	95.000
article cleanup	00:00:00.069	0.0%	10412	0.000	0.007	0.037
article logging	00:00:00.279	0.0%	10436	0.000	0.027	0.089
article parse	00:00:00.206	0.0%	19377	0.000	0.011	0.050
article write	00:00:21.767	0.0%	9184	0.000	2.370	131.135
artlog/artcncl	00:00:00.001	0.0%	59	0.000	0.017	0.200
artlog/artparse	00:00:00.000	0.0%	2	0.000	0.000	0.000
data move	00:00:00.034	0.0%	55152	0.000	0.001	0.007
hisgrep/artcncl	00:00:00.000	0.0%	45	0.000	0.000	0.000
hishave/artcncl	00:00:00.034	0.0%	59	0.000	0.576	11.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:55.289	0.1%	60338	0.000	0.916	14.679
history sync	00:00:00.009	0.0%	278	0.000	0.032	0.500
history write	00:00:08.253	0.0%	10414	0.000	0.792	40.093
hiswrite/artcncl	00:00:00.002	0.0%	14	0.000	0.143	1.000
idle	19:58:54.665	99.9%	59812	510.548	1202.679	5557.870
nntp read	00:00:00.374	0.0%	59545	0.000	0.006	0.026
overview write	00:00:00.028	0.0%	9184	0.000	0.003	0.050
perl filter	00:00:09.843	0.0%	10412	0.688	0.945	1.344
python filter	00:00:00.233	0.0%	10412	0.000	0.022	0.100
site send	00:00:01.498	0.0%	27555	0.008	0.054	0.116
TOTAL: 20:00:41.131	20:00:33.207	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.014	0.0%	9236	0.000	0.002	0.025
article prepare	00:00:00.001	0.0%	6289	0.000	0.000	0.009
article read	00:00:00.071	0.0%	2336	0.000	0.030	0.250
backlog stats	00:00:00.034	0.0%	56058	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.268	0.0%	33644	0.000	0.008	0.040
data write	00:00:00.648	0.0%	25089	0.000	0.026	0.072
idle	19:52:01.878	99.9%	56058	596.221	1275.855	3825.331
status file	00:00:11.610	0.0%	361	0.000	32.161	1924.000
TOTAL: 19:53:04.780	19:52:14.524	99.9%	-	-	-	-

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%	3	0.000	0.000	0.000
TOTAL: 00:00:00.045	00:00:00.000	0.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	170
name	2
pause	2
paused	2
reserve	2
shutdown	72
TOTAL: 11	262

Control Channel:

Sender	Other	Bad PGP	OK
bofh-control@killfile.org	1	0	1
moderator@dana.de	1	1	1
us-control@lists.killfile.org	0	1	0
TOTAL	2	2	2

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.news.weretis.net	57	19516	7806	11701	9	39%	47:54:27
2	usenet.blueworldhosting.com	308	11898	1743	8820	1335	14%	23:23:26
3	news.nntp4.net	25	9746	1090	8425	231	11%	23:47:51
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		391	41160	10639	28946	1575	25%	95:05:44

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.news.weretis.net	26.8 MB	72.0 KB	26.8 MB	99%	3.5 KB
2	usenet.blueworldhosting.com	5.2 MB	5.0 MB	10.1 MB	51%	3.4 KB
3	news.nntp4.net	3.0 MB	3.5 MB	6.5 MB	46%	5.0 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		35.0 MB	8.5 MB	43.5 MB	80%	3.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 29 15:00:01 - 15:59:59	554	5.1%	0.15	1.6 MB	4.4%	0.45
Feb 29 16:00:00 - 16:59:59	580	5.4%	0.16	1.8 MB	5.0%	0.50
Feb 29 17:00:00 - 17:59:59	568	5.3%	0.16	2.2 MB	6.4%	0.64
Feb 29 18:00:00 - 18:59:59	876	8.1%	0.24	3.2 MB	9.1%	0.91
Feb 29 19:00:00 - 19:59:59	649	6.0%	0.18	2.8 MB	8.0%	0.80
Feb 29 20:00:00 - 20:59:59	546	5.1%	0.15	1.7 MB	4.7%	0.47
Feb 29 21:00:00 - 21:59:59	482	4.5%	0.13	2.0 MB	5.6%	0.56
Feb 29 22:00:00 - 22:59:59	530	4.9%	0.15	1.9 MB	5.4%	0.54
Feb 29 23:00:00 - 23:59:59	397	3.7%	0.11	1.8 MB	5.0%	0.51
Mar 1 00:00:00 - 00:59:59	241	2.2%	0.07	859.2 KB	2.4%	0.24
Mar 1 01:00:00 - 01:59:59	153	1.4%	0.04	455.0 KB	1.3%	0.13
Mar 1 02:00:00 - 02:59:59	154	1.4%	0.04	443.4 KB	1.2%	0.12
Mar 1 03:00:00 - 03:59:59	158	1.5%	0.04	480.8 KB	1.3%	0.13
Mar 1 04:00:00 - 04:59:59	132	1.2%	0.04	372.9 KB	1.0%	0.10
Mar 1 05:00:00 - 05:59:59	213	2.0%	0.06	797.2 KB	2.2%	0.22
Mar 1 06:00:00 - 06:59:59	275	2.6%	0.08	1.1 MB	3.0%	0.30
Mar 1 07:00:00 - 07:59:59	388	3.6%	0.11	1.4 MB	3.9%	0.39
Mar 1 08:00:00 - 08:59:59	441	4.1%	0.12	1.4 MB	4.1%	0.41
Mar 1 09:00:00 - 09:59:59	534	5.0%	0.15	1.4 MB	4.0%	0.40
Mar 1 10:00:00 - 10:59:59	495	4.6%	0.14	1.2 MB	3.5%	0.35
Mar 1 11:00:00 - 11:59:59	689	6.4%	0.19	1.3 MB	3.7%	0.37
Mar 1 12:00:00 - 12:59:59	764	7.1%	0.21	2.6 MB	7.2%	0.73
Mar 1 13:00:00 - 13:59:59	460	4.3%	0.13	1.5 MB	4.4%	0.44
Mar 1 14:00:00 - 14:59:59	494	4.6%	0.14	1.1 MB	3.2%	0.32
Mar 1 15:00:00 - 15:00:01	1	0.0%	1.00	4.6 KB	0.0%	4.58
TOTAL: 24:00:00	10774	100.0%	0.12	35.3 MB	100.0%	0.42

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	960.4 MB	93.8%	27	0.17	69.99
ONE	DEFAULT	1024.0 MB	132.6 MB	13.0%	30	0.18	69.23
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	973.9 MB	95.1%	27	0.17	69.56
TWO	DEFAULT	1024.0 MB	969.9 MB	94.7%	27	0.18	68.39
TOTAL: 8	-	20.0 GB	14.6 GB	72.9%	115	0.18	-

Sites sending bad articles:

Server		Total	Group	Other
1	usenet.blueworldhosting.com	1337	1264	73
2	news.nntp4.net	234	0	234
3	hasname-out.news.weretis.net	30	0	30
TOTAL: 3		1601	1264	337

Unwanted newsgroups [Top 20]:

Newsgroup	Count
linux.kernel.netdev	255
fido7.pravda.news	234
de.sci.announce	199
de.sci.medizin	181
perl.cpan	163
linux.kernel.git	69
fido7.ukrnews	36
fido7.pushkin.local	33
odessa.news	23
fido7.lorapvt.horo	12
rocksolid.feeds.news	12
fido7.starper.limited	12
fido7.fidonet.online	7
fido7.altyn.local	7
fido7.f715.techinfo	7
linux.centos.announce	3
fido7.crimea.business	2
fido7.crimea.robots	2
alt.bbs.misc	1
hispagatos.comunicados	1
TOTAL: 25	1264

INND Perl filter [Top 20]:

Reason	Count
Too many newsgroups	112
Binary: misplaced binary	96
EMP (md5)	90
HTML Multipart	7
HTML post	3
TOTAL: 5	308

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	hasname-out.news.weretis.net	21
	usenet.blueworldhosting.com	6
	TOTAL: 2	27
No colon-space in header
	usenet.blueworldhosting.com	2
	TOTAL: 1	2
TOTAL: 2		29

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	1790	1788	0	1	1	99%	23:55:59
2	nntp4	10350	1204	8453	16	55	11%	23:56:03
3	weretis	4022	110	2478	111	15	2%	23:52:38
4	aioe	0	0	0	0	10697	0%	23:55:56
5	blueworldhosting	10275	0	8755	0	16	0%	23:56:08
TOTAL: 5		26437	3102	19686	128	10784	11%	119:36:44

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	bbsgslincom	6.1 MB	2.8 KB	6.1 MB	0.1 KB/s	3.5 KB	23:55:59
2	nntp4	3.5 MB	48.6 KB	3.5 MB	0.0 KB/s	2.9 KB	23:56:03
3	weretis	225.3 KB	266.7 KB	492.0 KB	0.0 KB/s	2.2 KB	23:52:38
4	aioe	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:55:56
5	blueworldhosting	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:56:08
TOTAL: 5		9.8 MB	318.0 KB	10.1 MB	0.0 KB/s	3.2 KB	119:36:44

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
207.90.244.12	0.002	0.001	00:00:00
45.135.232.19	0.000	0.002	00:00:00
TOTAL: 2	0.002	0.003	00:00:00

NNRP no permission clients:

System	Conn
207.90.244.12	2
45.135.232.19	1
TOTAL: 2	3

Daily Usenet report

Feb 29 15:00:01 -- Mar 1 15:00:01