Daily Usenet report: Sep 30 06:01:01

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Sep 30 06:02:00 kennel innd: message repeated 2 times: [ ctlinnd command s]
Oct 1 00:04:03 kennel pgpverify[1997008]: pgpverify: verification failed
Oct 1 05:15:02 kennel pgpverify[2120868]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	290120	97.4%	38.2 MB	97.1%
innd	6019	2.0%	931.6 KB	2.3%
innfeed	1387	0.5%	187.3 KB	0.5%
cnfsstat	144	0.0%	32.5 KB	0.1%
nnrpd	78	0.0%	8.0 KB	0.0%
controlchan	33	0.0%	7.7 KB	0.0%
pgpverify	2	0.0%	0.3 KB	0.0%
TOTAL: 7	297783	100.0%	39.3 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	463463	43.6%
Positive hits	311130	29.3%
Do not exist	283956	26.7%
Cache misses	3970	0.4%
TOTAL: 4	1062519	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.008	0.0%	166	0.000	0.048	1.000
article cleanup	00:00:03.170	0.0%	285955	0.006	0.011	0.018
article logging	00:00:12.048	0.0%	286321	0.029	0.042	0.057
article parse	00:00:18.443	0.0%	832834	0.008	0.022	0.033
article write	00:00:20.519	0.0%	202351	0.064	0.101	0.166
artlog/artparse	00:00:00.192	0.0%	3864	0.000	0.050	1.000
data move	00:00:03.057	0.0%	854768	0.001	0.004	0.008
hisgrep/artcncl	00:00:00.002	0.0%	166	0.000	0.012	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:21.769	0.0%	1067061	0.002	0.020	1.071
history sync	00:00:00.018	0.0%	367	0.000	0.049	0.667
history write	00:00:17.282	0.0%	284684	0.044	0.061	0.077
idle	23:53:04.757	99.5%	699615	68.500	122.903	237.441
nntp read	00:00:28.937	0.0%	700207	0.016	0.041	0.057
overview write	00:00:01.174	0.0%	202351	0.001	0.006	0.013
perl filter	00:00:14.591	0.0%	280885	0.035	0.052	0.070
python filter	00:00:14.574	0.0%	280885	0.030	0.052	0.077
site send	00:00:09.560	0.0%	607056	0.010	0.016	0.109
TOTAL: 24:00:44.847	23:55:50.101	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.630	0.0%	203337	0.000	0.003	0.010
article prepare	00:00:00.000	0.0%	1176	0.000	0.000	0.000
article read	00:00:00.055	0.0%	576	0.000	0.095	1.000
backlog stats	00:00:00.529	0.0%	568177	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:09.465	0.0%	357847	0.012	0.026	0.044
data write	00:00:06.146	0.0%	221402	0.012	0.028	0.050
idle	23:52:30.017	100.0%	568177	85.562	151.273	283.177
status file	00:00:00.164	0.0%	250	0.000	0.656	2.000
TOTAL: 23:53:03.100	23:52:47.006	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.003	0.0%	17	0.000	0.176	1.000
TOTAL: 00:00:07.367	00:00:00.003	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
reload	48
reserve	2
TOTAL: 11	215

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.feeder.erje.net	576	564642	194618	282935	87089	34%	47:37:33
2	hasname-out.news.weretis.net	8	18914	5603	13266	45	29%	51:02:22
3	usenet.blueworldhosting.com	288	10433	1420	8795	218	13%	23:43:28
4	news.nntp4.net	3	7756	922	6742	92	11%	21:51:26
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		876	601745	202563	311738	87444	33%	144:14:49

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	2.0 GB	52.5 MB	771.0 MB	2.8 GB	71%	10.5 KB
2	hasname-out.news.weretis.net	13.6 MB	53.8 KB	43.5 KB	13.7 MB	99%	2.5 KB
3	news.nntp4.net	11.9 MB	1.9 KB	680.9 KB	12.6 MB	94%	12.7 KB
4	usenet.blueworldhosting.com	3.6 MB	65.3 KB	871.1 KB	4.6 MB	79%	2.8 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		2.1 GB	52.7 MB	772.5 MB	2.9 GB	71%	10.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 30 06:01:01 - 06:59:59	6368	3.1%	1.80	65.5 MB	3.1%	18.95
Sep 30 07:00:00 - 07:59:59	6934	3.4%	1.93	67.7 MB	3.2%	19.25
Sep 30 08:00:00 - 08:59:59	9293	4.6%	2.58	89.6 MB	4.3%	25.47
Sep 30 09:00:00 - 09:59:59	10642	5.3%	2.96	115.3 MB	5.5%	32.79
Sep 30 10:00:00 - 10:59:59	8218	4.1%	2.28	87.2 MB	4.1%	24.81
Sep 30 11:00:00 - 11:59:59	7868	3.9%	2.19	80.0 MB	3.8%	22.75
Sep 30 12:00:00 - 12:59:59	8708	4.3%	2.42	92.8 MB	4.4%	26.38
Sep 30 13:00:00 - 13:59:59	9531	4.7%	2.65	109.3 MB	5.2%	31.10
Sep 30 14:00:00 - 14:59:59	12149	6.0%	3.37	129.1 MB	6.1%	36.73
Sep 30 15:00:00 - 15:59:59	9710	4.8%	2.70	105.4 MB	5.0%	29.99
Sep 30 16:00:00 - 16:59:59	7515	3.7%	2.09	78.1 MB	3.7%	22.22
Sep 30 17:00:00 - 17:59:59	7176	3.5%	1.99	83.6 MB	4.0%	23.79
Sep 30 18:00:00 - 18:59:59	7653	3.8%	2.13	90.9 MB	4.3%	25.85
Sep 30 19:00:00 - 19:59:59	6748	3.3%	1.87	64.2 MB	3.0%	18.26
Sep 30 20:00:00 - 20:59:59	8396	4.1%	2.33	80.6 MB	3.8%	22.93
Sep 30 21:00:00 - 21:59:59	9025	4.5%	2.51	80.4 MB	3.8%	22.87
Sep 30 22:00:00 - 22:59:59	7979	3.9%	2.22	86.1 MB	4.1%	24.49
Sep 30 23:00:00 - 23:59:59	7536	3.7%	2.09	81.4 MB	3.9%	23.14
Oct 1 00:00:00 - 00:59:59	11614	5.7%	3.23	104.2 MB	4.9%	29.65
Oct 1 01:00:00 - 01:59:59	7210	3.6%	2.00	72.1 MB	3.4%	20.52
Oct 1 02:00:00 - 02:59:59	8615	4.3%	2.39	87.4 MB	4.1%	24.87
Oct 1 03:00:00 - 03:59:59	9177	4.5%	2.55	88.1 MB	4.2%	25.05
Oct 1 04:00:00 - 04:59:59	6544	3.2%	1.82	74.0 MB	3.5%	21.05
Oct 1 05:00:00 - 05:59:59	7671	3.8%	2.13	92.3 MB	4.4%	26.27
Oct 1 06:00:00 - 06:01:02	108	0.1%	1.74	1.5 MB	0.1%	25.38
TOTAL: 24:00:01	202388	100.0%	2.34	2.1 GB	100.0%	24.97

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	2.9 GB	28.8%	85	29.90	4.06
TOTAL: 1	-	10.0 GB	2.9 GB	28.8%	85	29.90	-

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	hasname-out.feeder.erje.net	87138	78153	5030	0	3955
2	news.nntp4.net	312	90	2	6	214
3	usenet.blueworldhosting.com	236	211	7	0	18
4	hasname-out.news.weretis.net	46	22	22	0	2
TOTAL: 4		87732	78476	5061	6	4189

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	26089
alt.binaries.encrypted	2139
alt.binaries.pwp	2138
alt.binaries.ath	1781
alt.binaries.wtfnzb.echo	1451
alt.binaries.wtfnzb.alpha	1400
alt.binaries.wtfnzb.india	1393
alt.binaries.wtfnzb.mike	1386
alt.binaries.wtfnzb.kilo	1379
alt.binaries.amazing	1378
alt.binaries.wtfnzb.charlie	1375
alt.binaries.wtfnzb.lima	1373
alt.binaries.wtfnzb.hotel	1371
alt.binaries.wtfnzb.golf	1368
alt.binaries.wtfnzb.delta	1364
alt.binaries.wtfnzb.juliet	1352
alt.binaries.wtfnzb.novemeber	1344
alt.binaries.wtfnzb.beta	1336
alt.binaries.wtfnzb.foxtrot	1318
alt.binaries.wtfnzb.bravo	1283
TOTAL: 225	78476

INND no permission servers:

System	Conn
103.193.138.76	30
147.185.133.136	2
199.45.155.76	2
35.203.210.103	2
35.203.210.6	2
162.142.125.36	1
TOTAL: 6	39

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	hasname-out.feeder.erje.net	8
	TOTAL: 1	8
Including strange strings
	news.nntp4.net	214
	hasname-out.feeder.erje.net	137
	usenet.blueworldhosting.com	18
	hasname-out.news.weretis.net	2
	TOTAL: 4	371
No colon-space in header field
	hasname-out.feeder.erje.net	1461
	TOTAL: 1	1461
TOTAL: 3		1840

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	378	378	0	0	0	100%	21:29:46
2	weretis	3659	1	3483	167	0	0%	23:59:54
3	blueworldhosting	201953	0	200703	32	21	0%	23:59:54
4	nntp4	9383	0	9378	0	1508	0%	23:57:38
5	erje	7370	0	7367	0	2	0%	23:59:52
TOTAL: 5		222743	379	220931	199	1531	0%	117:27:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	bbsgslincom	1.2 MB	0.0 KB	1.2 MB	0.0 KB/s	3.2 KB	21:29:46
2	weretis	7.4 KB	6.9 MB	6.9 MB	0.1 KB/s	42.3 KB	23:59:54
3	blueworldhosting	0.0 KB	127.1 KB	127.1 KB	0.0 KB/s	4.0 KB	23:59:54
4	erje	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:52
5	nntp4	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:38
TOTAL: 5		1.2 MB	7.1 MB	8.3 MB	0.0 KB/s	14.6 KB	117:27:04

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
165.154.253.241	0.001	0.005	00:00:01
91.238.181.94	0.000	0.004	00:00:01
165.154.237.241	0.002	0.003	00:00:01
talley.probe.onyphe.net	0.001	0.003	00:00:01
79.124.49.202	0.005	0.007	00:00:00
webber.probe.onyphe.net	0.001	0.003	00:00:00
o68.scanner.modat.io	0.003	0.001	00:00:00
106.75.133.232	0.002	0.002	00:00:00
azpdssw7f4ws.stretchoid.com	0.001	0.007	00:00:00
azpdsg1j90qs.stretchoid.com	0.002	0.004	00:00:00
162.142.125.121	0.001	0.002	00:00:00
198.235.24.17	0.000	0.004	00:00:00
198.235.24.66	0.003	0.001	00:00:00
TOTAL: 13	0.022	0.046	00:00:07

NNRP no permission clients [Top 20]:

System	Conn
79.124.49.202	3
azpdsg1j90qs.stretchoid.com	2
azpdssw7f4ws.stretchoid.com	2
106.75.133.232	1
162.142.125.121	1
165.154.237.241	1
165.154.253.241	1
198.235.24.17	1
198.235.24.66	1
91.238.181.94	1
o68.scanner.modat.io	1
talley.probe.onyphe.net	1
webber.probe.onyphe.net	1
TOTAL: 13	17

Daily Usenet report

Sep 30 06:01:01 -- Oct 1 06:01:02