Daily Usenet report: Jul 2 06:01:02

Unknown entries from news log file:

First 3 / 3 lines (100.0%)

Jul 2 06:01:47 kennel innd: message repeated 2 times: [ ctlinnd command s]
Jul 3 05:15:02 kennel pgpverify[2571819]: pgpverify: verification failed
Jul 3 05:25:00 kennel innd: message repeated 2 times: [ 24.182.239.66 rejected 502]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	425718	98.0%	56.2 MB	97.8%
innd	6801	1.6%	1.0 MB	1.8%
innfeed	1449	0.3%	215.3 KB	0.4%
cnfsstat	144	0.0%	18.4 KB	0.0%
nnrpd	76	0.0%	8.3 KB	0.0%
controlchan	12	0.0%	2.5 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 8	434202	100.0%	57.4 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	706333	45.4%
Positive hits	429876	27.6%
Do not exist	412890	26.6%
Cache misses	5817	0.4%
TOTAL: 4	1554916	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.001	0.0%	27	0.000	0.037	0.125
article cleanup	00:00:04.342	0.0%	424125	0.004	0.010	0.017
article logging	00:00:16.702	0.0%	424127	0.016	0.039	0.054
article parse	00:00:22.938	0.0%	1075244	0.007	0.021	0.029
article write	00:00:16.496	0.0%	190706	0.041	0.086	0.123
artlog/artparse	00:00:00.067	0.0%	1494	0.000	0.045	1.000
data move	00:00:05.867	0.0%	1075365	0.001	0.005	0.011
hisgrep/artcncl	00:00:00.000	0.0%	27	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.457	0.0%	1561388	0.001	0.003	0.006
history sync	00:00:00.038	0.0%	323	0.000	0.118	1.000
history write	00:00:24.867	0.0%	413939	0.034	0.060	0.086
idle	23:52:27.729	99.4%	893628	55.371	96.178	182.451
nntp read	00:00:37.701	0.0%	894161	0.018	0.042	0.061
overview write	00:00:01.077	0.0%	190706	0.000	0.006	0.012
perl filter	00:00:19.239	0.0%	411152	0.020	0.047	0.070
python filter	00:00:19.299	0.0%	411152	0.016	0.047	0.063
site send	00:00:08.089	0.0%	487838	0.010	0.017	0.127
TOTAL: 24:00:32.034	23:55:29.909	99.7%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.365	0.0%	106902	0.000	0.003	0.022
article prepare	00:00:00.000	0.0%	972	0.000	0.000	0.000
article read	00:00:00.042	0.0%	378	0.000	0.111	1.000
backlog stats	00:00:00.318	0.0%	324321	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:05.347	0.0%	210321	0.009	0.025	0.045
data write	00:00:05.411	0.0%	116175	0.017	0.047	0.133
idle	23:52:07.753	100.0%	324321	128.809	264.947	745.834
status file	00:00:00.173	0.0%	283	0.000	0.611	1.000
TOTAL: 23:52:28.182	23:52:19.409	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.001	0.0%	18	0.000	0.056	1.000
TOTAL: 00:00:07.661	00:00:00.001	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	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
moderator@dana.de	0	0	1	1	0	1
TOTAL	0	0	1	1	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	hasname-out.feeder.erje.net	577	828610	186199	408351	234060	22%	47:40:08
2	hasname-out.news.weretis.net	8	8527	2095	6397	35	24%	38:36:55
3	news.nntp4.net	1	7044	1920	4834	290	27%	27:35:54
4	usenet.blueworldhosting.com	274	6467	1095	5029	343	16%	22:34:02
5	24.182.239.66	0	13	5	8	0	38%	01:04:26
6	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 6		861	850661	191314	424619	234728	22%	137:31:25

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	1.6 GB	103.5 MB	1.9 GB	3.6 GB	43%	9.0 KB
2	news.nntp4.net	6.3 MB	28.3 KB	2.6 MB	8.8 MB	70%	4.1 KB
3	hasname-out.news.weretis.net	5.7 MB	9.5 KB	58.9 KB	5.7 MB	98%	2.8 KB
4	usenet.blueworldhosting.com	2.4 MB	0.0 KB	616.9 KB	3.0 MB	80%	2.2 KB
5	24.182.239.66	13.6 KB	0.0 KB	0.0 KB	13.6 KB	100%	2.7 KB
6	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 6		1.6 GB	103.5 MB	1.9 GB	3.6 GB	43%	8.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 2 06:01:02 - 06:59:59	4085	2.1%	1.15	47.3 MB	2.9%	13.69
Jul 2 07:00:00 - 07:59:59	5877	3.1%	1.63	57.0 MB	3.5%	16.23
Jul 2 08:00:00 - 08:59:59	7288	3.8%	2.02	55.2 MB	3.4%	15.70
Jul 2 09:00:00 - 09:59:59	6460	3.4%	1.79	64.1 MB	4.0%	18.22
Jul 2 10:00:00 - 10:59:59	7282	3.8%	2.02	69.0 MB	4.3%	19.63
Jul 2 11:00:00 - 11:59:59	6411	3.4%	1.78	50.3 MB	3.1%	14.30
Jul 2 12:00:00 - 12:59:59	10501	5.5%	2.92	85.0 MB	5.3%	24.18
Jul 2 13:00:00 - 13:59:59	10288	5.4%	2.86	68.9 MB	4.3%	19.61
Jul 2 14:00:00 - 14:59:59	9736	5.1%	2.70	82.2 MB	5.1%	23.39
Jul 2 15:00:00 - 15:59:59	10941	5.7%	3.04	93.0 MB	5.8%	26.44
Jul 2 16:00:00 - 16:59:59	11192	5.9%	3.11	100.0 MB	6.2%	28.45
Jul 2 17:00:00 - 17:59:59	10148	5.3%	2.82	93.1 MB	5.8%	26.48
Jul 2 18:00:00 - 18:59:59	10202	5.3%	2.83	82.7 MB	5.1%	23.53
Jul 2 19:00:00 - 19:59:59	13865	7.3%	3.85	95.2 MB	5.9%	27.08
Jul 2 20:00:00 - 20:59:59	12805	6.7%	3.56	96.6 MB	6.0%	27.47
Jul 2 21:00:00 - 21:59:59	8131	4.3%	2.26	67.7 MB	4.2%	19.25
Jul 2 22:00:00 - 22:59:59	6228	3.3%	1.73	58.3 MB	3.6%	16.57
Jul 2 23:00:00 - 23:59:59	7055	3.7%	1.96	52.1 MB	3.2%	14.81
Jul 3 00:00:00 - 00:59:59	6202	3.2%	1.72	50.9 MB	3.2%	14.49
Jul 3 01:00:00 - 01:59:59	4691	2.5%	1.30	41.4 MB	2.6%	11.77
Jul 3 02:00:00 - 02:59:59	4573	2.4%	1.27	42.2 MB	2.6%	12.01
Jul 3 03:00:00 - 03:59:59	5731	3.0%	1.59	53.2 MB	3.3%	15.13
Jul 3 04:00:00 - 04:59:59	5338	2.8%	1.48	58.2 MB	3.6%	16.54
Jul 3 05:00:00 - 05:59:59	6080	3.2%	1.69	51.6 MB	3.2%	14.68
Jul 3 06:00:00 - 06:01:01	90	0.0%	1.48	631.0 KB	0.0%	10.34
TOTAL: 23:59:59	191200	100.0%	2.21	1.6 GB	100.0%	19.15

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	5.8 GB	57.9%	153	23.79	5.10
TOTAL: 1	-	10.0 GB	5.8 GB	57.9%	153	23.79	-

Sites sending bad articles:

Server		Total	Group	Duplic	TooOld	Other
1	hasname-out.feeder.erje.net	233865	219375	11624	1334	1532
2	usenet.blueworldhosting.com	343	343	0	0	0
3	news.nntp4.net	275	269	6	0	0
4	hasname-out.news.weretis.net	35	30	4	0	1
TOTAL: 4		234518	220017	11634	1334	1533

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	114723
alt.binaries.encrypted	17512
alt.binaries.pwp	4703
alt.binaries.mp3.abooks	4110
alt.binaries.wtfnzb.alpha	2639
alt.binaries.wtfnzb.bravo	2626
alt.binaries.font	2581
alt.binaries.wtfnzb.india	2581
alt.binaries.wtfnzb.charlie	2580
alt.binaries.wtfnzb.foxtrot	2569
alt.binaries.wtfnzb.echo	2565
alt.binaries.wtfnzb.mike	2558
alt.binaries.wtfnzb.kilo	2548
alt.binaries.wtfnzb.golf	2545
alt.binaries.wtfnzb.beta	2543
alt.binaries.wtfnzb.novemeber	2541
alt.binaries.wtfnzb.hotel	2525
alt.binaries.wtfnzb.juliet	2522
alt.binaries.wtfnzb.lima	2483
alt.binaries.wtfnzb.delta	2472
TOTAL: 2389	220017

INND no permission servers:

System	Conn
103.193.138.76	30
24.182.239.66	17
35.203.210.169	3
66.132.195.39	2
194.165.16.162	1
45.134.174.219	1
66.132.186.191	1
85.217.149.18	1
TOTAL: 8	56

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	hasname-out.feeder.erje.net	156
	TOTAL: 1	156
Including strange strings
	hasname-out.news.weretis.net	1
	hasname-out.feeder.erje.net	1
	TOTAL: 2	2
No colon-space in header field
	hasname-out.feeder.erje.net	1531
	TOTAL: 1	1531
TOTAL: 3		1689

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	241	241	0	0	0	100%	17:58:04
2	blueworldhosting	103400	73	99463	0	6944	0%	23:59:55
3	nntp4	4283	45	4236	0	0	1%	23:59:42
4	weretis	3714	1	3630	64	0	0%	23:59:55
5	erje	4689	0	4688	0	0	0%	23:59:55
TOTAL: 5		116327	360	112017	64	6944	0%	113:57:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.1 MB	0.0 KB	1.1 MB	4.7 KB	17:58:04
2	blueworldhosting	416.6 KB	0.0 KB	416.6 KB	5.7 KB	23:59:55
3	nntp4	56.7 KB	0.0 KB	56.7 KB	1.3 KB	23:59:42
4	weretis	5.5 KB	91.2 KB	96.7 KB	1.5 KB	23:59:55
5	erje	0.0 KB	0.0 KB	0.0 KB	0	23:59:55
TOTAL: 5		1.6 MB	91.2 KB	1.7 MB	4.0 KB	113:57:31

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
79.124.62.114	0.002	0.002	00:00:04
blanchard.probe.onyphe.net	0.002	0.002	00:00:00
maisie.probe.onyphe.net	0.000	0.004	00:00:00
azpdwss8jbmn.stretchoid.com	0.003	0.005	00:00:00
venice.scan.bufferover.run	0.001	0.008	00:00:00
r3-252-fc.monitoring.internet-measurement.com	0.001	0.003	00:00:00
79.224.132.66.censys-scanner.com	0.004	0.005	00:00:00
45-33-14-197.ip.linodeusercontent.com	0.002	0.003	00:00:00
47.84.83.246	0.002	0.010	00:00:00
45-79-207-110.ip.linodeusercontent.com	0.003	0.002	00:00:00
45-79-115-59.ip.linodeusercontent.com	0.001	0.002	00:00:00
o056.scanner.modat.io	0.002	0.002	00:00:00
TOTAL: 12	0.023	0.048	00:00:07

NNRP no permission clients [Top 20]:

System	Conn
47.84.83.246	3
79.224.132.66.censys-scanner.com	3
azpdwss8jbmn.stretchoid.com	2
venice.scan.bufferover.run	2
45-33-14-197.ip.linodeusercontent.com	1
45-79-115-59.ip.linodeusercontent.com	1
45-79-207-110.ip.linodeusercontent.com	1
79.124.62.114	1
blanchard.probe.onyphe.net	1
maisie.probe.onyphe.net	1
o056.scanner.modat.io	1
r3-252-fc.monitoring.internet-measurement.com	1
TOTAL: 12	18

Daily Usenet report

Jul 2 06:01:02 -- Jul 3 06:01:01