Daily Usenet report: Oct 1 06:01:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Oct 1 06:01:49 kennel innd: message repeated 2 times: [ ctlinnd command s]
Oct 1 16:30:03 kennel pgpverify[2821104]: pgpverify: verification failed
Oct 2 02:12:13 kennel thermald[889]: 32 CPUID levels; family:model:stepping 0x6:be:0 (6:190:0)
Oct 2 02:12:13 kennel thermald[889]: 32 CPUID levels; family:model:stepping 0x6:be:0 (6:190:0)
Oct 2 02:12:13 kennel thermald[889]: sensor id 5 : No temp sysfs for reading raw temp
Oct 2 02:12:13 kennel thermald[889]: message repeated 2 times: [ sensor id 5 : No temp sysfs for reading raw temp]
Oct 2 02:12:13 kennel thermald[889]: Config file /etc/thermald/thermal-conf.xml does not exist
Oct 2 02:12:13 kennel thermald[889]: Config file /etc/thermald/thermal-conf.xml does not exist
Oct 2 02:12:13 kennel thermald[889]: Config file /etc/thermald/thermal-conf.xml does not exist
Oct 2 02:12:13 kennel thermald[889]: Polling mode is enabled: 4

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	459072	98.5%	62.5 MB	98.3%
innd	5252	1.1%	855.9 KB	1.3%
innfeed	1403	0.3%	213.7 KB	0.3%
cnfsstat	144	0.0%	23.1 KB	0.0%
nnrpd	87	0.0%	9.9 KB	0.0%
controlchan	13	0.0%	2.6 KB	0.0%
thermald	8	0.0%	0.9 KB	0.0%
overchan	1	0.0%	0.0 KB	0.0%
pgpverify	1	0.0%	0.0 KB	0.0%
TOTAL: 9	465981	100.0%	63.6 MB	100.0%

History cache:

Reason	Count	%Count
Negative hits	472549	49.3%
Do not exist	456992	47.7%
Positive hits	25876	2.7%
Cache misses	2762	0.3%
TOTAL: 4	958179	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.002	0.0%	69	0.000	0.029	0.143
article cleanup	00:00:05.224	0.0%	457292	0.005	0.011	0.020
article logging	00:00:18.626	0.0%	457307	0.015	0.041	0.055
article parse	00:00:24.914	0.0%	1268338	0.008	0.020	0.028
article write	00:00:20.729	0.0%	250795	0.038	0.083	0.128
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:05.087	0.0%	1260368	0.000	0.004	0.014
hisgrep/artcncl	00:00:00.001	0.0%	69	0.000	0.014	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:30.864	0.0%	959737	0.002	0.032	0.462
history sync	00:00:00.029	0.0%	305	0.000	0.095	1.000
history write	00:00:29.554	0.0%	457290	0.031	0.065	0.083
idle	23:43:02.699	99.5%	949791	33.208	89.896	173.896
nntp read	00:00:40.037	0.0%	950135	0.012	0.042	0.065
overview write	00:00:01.359	0.0%	250795	0.001	0.005	0.012
perl filter	00:00:21.995	0.0%	457131	0.013	0.048	0.076
python filter	00:00:23.505	0.0%	457131	0.019	0.051	0.079
site send	00:00:13.038	0.0%	752385	0.010	0.017	0.111
TOTAL: 23:50:24.754	23:46:57.663	99.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.801	0.0%	249478	0.000	0.003	0.011
article prepare	00:00:00.000	0.0%	468	0.000	0.000	0.000
article read	00:00:00.040	0.0%	387	0.000	0.103	1.000
backlog stats	00:00:00.695	0.0%	721443	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:12.242	0.0%	463730	0.015	0.026	0.046
data write	00:00:10.614	0.0%	263637	0.016	0.040	0.069
idle	23:41:08.199	99.9%	721443	35.764	118.191	391.254
status file	00:00:00.301	0.0%	258	0.000	1.167	34.750
TOTAL: 23:41:53.434	23:41:32.892	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%	20	0.000	0.150	1.000
TOTAL: 00:00:06.939	00:00:00.003	0.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	146
name	2
pause	2
paused	2
reload	46
reserve	2
TOTAL: 11	212

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	289	460627	244879	9566	206182	53%	25:44:11
2	usenet.blueworldhosting.com	145	7753	2443	4807	503	31%	23:36:33
3	hasname-out.news.weretis.net	5	10194	2207	7917	70	21%	43:01:42
4	news.nntp4.net	3	7743	1946	5343	454	25%	25:56:30
5	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 5		443	486317	251475	27633	207209	51%	118:18:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	hasname-out.feeder.erje.net	2.0 GB	0.0 KB	1.8 GB	3.8 GB	53%	8.9 KB
2	hasname-out.news.weretis.net	7.5 MB	12.1 KB	145.2 KB	7.6 MB	97%	3.4 KB
3	news.nntp4.net	6.1 MB	0.0 KB	4.3 MB	10.4 MB	58%	4.4 KB
4	usenet.blueworldhosting.com	5.9 MB	0.0 KB	2.1 MB	8.0 MB	73%	2.8 KB
5	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 5		2.1 GB	12.1 KB	1.8 GB	3.8 GB	53%	8.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 1 06:01:01 - 06:59:59	8278	3.3%	2.34	57.5 MB	2.7%	16.64
Oct 1 07:00:00 - 07:59:59	9011	3.6%	2.50	75.3 MB	3.6%	21.42
Oct 1 08:00:00 - 08:59:59	7234	2.9%	2.01	61.8 MB	2.9%	17.57
Oct 1 09:00:00 - 09:59:59	9416	3.7%	2.62	75.5 MB	3.6%	21.47
Oct 1 10:00:00 - 10:59:59	7891	3.1%	2.19	69.8 MB	3.3%	19.85
Oct 1 11:00:00 - 11:59:59	13608	5.4%	3.78	109.9 MB	5.2%	31.26
Oct 1 12:00:00 - 12:59:59	14649	5.8%	4.07	104.2 MB	4.9%	29.63
Oct 1 13:00:00 - 13:59:59	11153	4.4%	3.10	89.3 MB	4.2%	25.39
Oct 1 14:00:00 - 14:59:59	10785	4.3%	3.00	91.1 MB	4.3%	25.91
Oct 1 15:00:00 - 15:59:59	9180	3.6%	2.55	81.8 MB	3.9%	23.28
Oct 1 16:00:00 - 16:59:59	7312	2.9%	2.03	85.0 MB	4.0%	24.19
Oct 1 17:00:00 - 17:59:59	8452	3.4%	2.35	78.3 MB	3.7%	22.27
Oct 1 18:00:00 - 18:59:59	7068	2.8%	1.96	59.4 MB	2.8%	16.90
Oct 1 19:00:00 - 19:59:59	7148	2.8%	1.99	68.1 MB	3.2%	19.37
Oct 1 20:00:00 - 20:59:59	9564	3.8%	2.66	70.3 MB	3.3%	19.98
Oct 1 21:00:00 - 21:59:59	11658	4.6%	3.24	95.3 MB	4.5%	27.10
Oct 1 22:00:00 - 22:59:59	9704	3.9%	2.70	76.3 MB	3.6%	21.70
Oct 1 23:00:00 - 23:59:59	13911	5.5%	3.86	109.0 MB	5.1%	31.01
Oct 2 00:00:00 - 00:59:59	22349	8.9%	6.21	100.7 MB	4.7%	28.63
Oct 2 01:00:00 - 01:59:59	9052	3.6%	2.51	78.6 MB	3.7%	22.37
Oct 2 02:00:00 - 02:59:59	11626	4.6%	3.23	110.7 MB	5.2%	31.47
Oct 2 03:00:00 - 03:59:59	10411	4.1%	2.89	123.1 MB	5.8%	35.00
Oct 2 04:00:00 - 04:59:59	14141	5.6%	3.93	189.2 MB	8.9%	53.81
Oct 2 05:00:00 - 05:59:59	7988	3.2%	2.22	59.9 MB	2.8%	17.05
Oct 2 06:00:00 - 06:01:01	145	0.1%	2.38	918.2 KB	0.0%	15.05
TOTAL: 24:00:00	251734	100.0%	2.91	2.1 GB	100.0%	25.14

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days
C1	DEFAULT	10.0 GB	2.7 GB	27.1%	181	31.41	3.86
TOTAL: 1	-	10.0 GB	2.7 GB	27.1%	181	31.41	-

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	TooOld	Other
1	hasname-out.feeder.erje.net	206304	206135	0	0	156	13
2	usenet.blueworldhosting.com	506	502	0	3	0	1
3	news.nntp4.net	443	442	0	1	0	0
4	hasname-out.news.weretis.net	85	70	3	0	0	12
TOTAL: 4		207338	207149	3	4	156	26

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.friends	72628
alt.binaries.wtfnzb.lima	5685
alt.binaries.wtfnzb.golf	5568
alt.binaries.wtfnzb.mike	5544
alt.binaries.wtfnzb.novemeber	5513
alt.binaries.wtfnzb.bravo	5483
alt.binaries.wtfnzb.juliet	5483
alt.binaries.wtfnzb.india	5481
alt.binaries.wtfnzb.foxtrot	5474
alt.binaries.wtfnzb.alpha	5450
alt.binaries.wtfnzb.kilo	5450
alt.binaries.wtfnzb.beta	5435
alt.binaries.wtfnzb.hotel	5424
alt.binaries.wtfnzb.echo	5416
alt.binaries.wtfnzb.delta	5394
alt.binaries.wtfnzb.charlie	5391
alt.binaries.amazing	4522
alt.binaries.u-4all	4315
alt.binaries.encrypted	3532
alt.binaries.flowed	2894
TOTAL: 199	207149

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
soc.culture.hawaii	3
uk.religion.christian	1
TOTAL: 2	4

INND no permission servers:

System	Conn
103.193.138.76	30
147.185.133.122	2
185.242.226.60	1
185.247.137.4	1
195.96.139.6	1
66.132.195.124	1
TOTAL: 6	36

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	hasname-out.feeder.erje.net	9
	TOTAL: 1	9
Including strange strings
	hasname-out.news.weretis.net	12
	hasname-out.feeder.erje.net	3
	TOTAL: 2	15
No colon-space in header field
	usenet.blueworldhosting.com	1
	TOTAL: 1	1
TOTAL: 3		25

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	bbsgslincom	361	361	0	0	0	100%	21:46:41
2	blueworldhosting	248979	0	247327	20	0	0%	23:48:14
3	erje	6208	0	6206	0	31	0%	23:47:06
4	nntp4	4952	0	4942	0	0	0%	23:48:13
5	weretis	4450	0	4437	7	0	0%	23:48:13
TOTAL: 5		264950	361	262912	27	31	0%	116:58:27

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	bbsgslincom	1.4 MB	0.0 KB	1.4 MB	3.9 KB	21:46:41
2	blueworldhosting	0.0 KB	153.4 KB	153.4 KB	7.7 KB	23:48:14
3	erje	0.0 KB	0.0 KB	0.0 KB	0	23:47:06
4	nntp4	0.0 KB	0.0 KB	0.0 KB	0	23:48:13
5	weretis	0.0 KB	16.7 KB	16.7 KB	2.4 KB	23:48:13
TOTAL: 5		1.4 MB	170.1 KB	1.5 MB	4.0 KB	116:58:27

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
71.6.238.189	0.005	0.008	00:00:02
94.26.88.142	0.003	0.002	00:00:01
r3-175-af.monitoring.internet-measurement.com	0.001	0.004	00:00:00
vilnius.scan.bufferover.run	0.002	0.007	00:00:00
20.84.144.204	0.001	0.006	00:00:00
5-226-140-36.infrawat.ch	0.002	0.003	00:00:00
31-14-254-40.infrawat.ch	0.001	0.004	00:00:00
193-176-29-16.infrawat.ch	0.000	0.005	00:00:00
lisbon.scan.bufferover.run	0.003	0.005	00:00:00
69-164-217-245.ip.linodeusercontent.com	0.001	0.003	00:00:00
194-195-210-47.ip.linodeusercontent.com	0.000	0.005	00:00:00
45-79-207-110.ip.linodeusercontent.com	0.001	0.003	00:00:00
32.195.132.66.censys-scanner.com	0.001	0.003	00:00:00
198.235.24.158	0.001	0.002	00:00:00
89-21-67-133.infrawat.ch	0.000	0.004	00:00:00
TOTAL: 15	0.022	0.064	00:00:06

NNRP no permission clients [Top 20]:

System	Conn
71.6.238.189	3
20.84.144.204	2
lisbon.scan.bufferover.run	2
vilnius.scan.bufferover.run	2
193-176-29-16.infrawat.ch	1
194-195-210-47.ip.linodeusercontent.com	1
198.235.24.158	1
31-14-254-40.infrawat.ch	1
32.195.132.66.censys-scanner.com	1
45-79-207-110.ip.linodeusercontent.com	1
5-226-140-36.infrawat.ch	1
69-164-217-245.ip.linodeusercontent.com	1
89-21-67-133.infrawat.ch	1
94.26.88.142	1
r3-175-af.monitoring.internet-measurement.com	1
TOTAL: 15	20

Daily Usenet report

Oct 1 06:01:01 -- Oct 2 06:01:01