Daily Usenet report: Oct 9 02:30:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	67341	65.1%	5.9 MB	59.8%
inn	34869	33.7%	3.8 MB	38.5%
innd	1064	1.0%	158.6 KB	1.6%
innfeed	158	0.2%	14.2 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	103433	100.0%	9.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	34382	97.5%
Negative hits	877	2.5%
Positive hits	10	0.0%
Cache misses	0	0.0%
TOTAL: 4	35269	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.133	0.0%	44	0.000	3.023	10.000
article cleanup	00:00:00.345	0.0%	35644	0.000	0.010	0.047
article logging	00:00:00.538	0.0%	36059	0.000	0.015	0.047
article parse	00:00:27.993	0.0%	2663373	0.000	0.011	0.097
article write	00:14:43.434	1.0%	35334	3.239	25.002	45.112
artlog/artcncl	00:00:00.000	0.0%	10	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	0	0.000	0.000	0.000
data move	00:00:03.275	0.0%	2890442	0.000	0.001	0.019
hisgrep/artcncl	00:00:00.027	0.0%	54	0.000	0.500	2.000
hishave/artcncl	00:00:00.000	0.0%	10	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:10.036	0.0%	36521	0.112	0.275	0.573
history sync	00:00:00.928	0.0%	312	1.000	2.974	6.750
history write	00:00:23.931	0.0%	35644	0.469	0.671	1.076
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:32:55.577	98.1%	2662053	1.566	31.846	11109.074
nntp read	00:00:59.617	0.1%	2661853	0.000	0.022	0.072
overview write	00:00:16.292	0.0%	35334	0.129	0.461	8.764
perl filter	00:00:04.318	0.0%	35595	0.000	0.121	0.216
python filter	00:10:13.439	0.7%	35644	0.691	17.210	32.218
site send	00:00:00.998	0.0%	35411	0.000	0.028	0.093
TOTAL: 24:00:36.967	24:00:20.881	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.000	0.0%	0	0.000	0.000	0.000
article prepare	00:00:00.000	0.0%	0	0.000	0.000	0.000
article read	00:00:00.000	0.0%	0	0.000	0.000	0.000
backlog stats	00:00:00.001	0.0%	3733	0.000	0.000	0.038
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.000	0.0%	3	0.000	0.000	0.000
data write	00:00:00.000	0.0%	3	0.000	0.000	0.000
idle	23:56:16.062	100.0%	3733	17656.206	23084.935	24078.080
status file	00:00:00.003	0.0%	6	0.500	0.500	0.500
TOTAL: 23:56:16.097	23:56:16.066	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.934	0.0%	4741	0.000	0.408	7.000
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:27:59.956	1.5%	13280904	0.000	0.126	181.981
readart	00:00:39.020	0.0%	4741	0.000	8.230	33.000
TOTAL: 30:46:39.303	00:28:40.910	1.6%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	1
logmode	2
mode	149
name	2
pause	1
paused	1
reload	2
renumber	1
TOTAL: 10	166

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	feed1.usenet.blueworldhosting.com	12	34430	34121	0	309	99%	24:41:45
TOTAL: 1		12	34430	34121	0	309	99%	24:41:45

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed1.usenet.blueworldhosting.com	11.7 GB	0.0 KB	1.2 MB	11.7 GB	99%	356.3 KB
TOTAL: 1		11.7 GB	0.0 KB	1.2 MB	11.7 GB	99%	356.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 9 02:30:00 - 02:59:59	4939	14.5%	2.74	2.9 GB	24.6%	1670.84
Oct 9 03:00:00 - 03:59:59	2892	8.5%	0.80	1.4 GB	12.3%	417.27
Oct 9 04:00:00 - 04:59:59	626	1.8%	0.17	2.2 MB	0.0%	0.62
Oct 9 05:00:00 - 05:59:59	543	1.6%	0.15	1.5 MB	0.0%	0.44
Oct 9 06:00:00 - 06:59:59	616	1.8%	0.17	2.1 MB	0.0%	0.60
Oct 9 07:00:00 - 07:59:59	574	1.7%	0.16	1.6 MB	0.0%	0.46
Oct 9 08:00:00 - 08:59:59	603	1.8%	0.17	1.8 MB	0.0%	0.52
Oct 9 09:00:00 - 09:59:59	640	1.9%	0.18	3.0 MB	0.0%	0.85
Oct 9 10:00:00 - 10:59:59	561	1.6%	0.16	2.0 MB	0.0%	0.58
Oct 9 11:00:00 - 11:59:59	816	2.4%	0.23	61.9 MB	0.5%	17.62
Oct 9 12:00:00 - 12:59:59	717	2.1%	0.20	1.9 MB	0.0%	0.55
Oct 9 13:00:00 - 13:59:59	635	1.9%	0.18	3.1 MB	0.0%	0.89
Oct 9 14:00:00 - 14:59:59	4759	13.9%	1.32	1.8 GB	15.3%	519.09
Oct 9 15:00:00 - 15:59:59	611	1.8%	0.17	2.1 MB	0.0%	0.61
Oct 9 16:00:00 - 16:59:59	775	2.3%	0.22	126.0 MB	1.1%	35.85
Oct 9 17:00:00 - 17:59:59	437	1.3%	0.12	5.3 MB	0.0%	1.52
Oct 9 18:00:00 - 18:59:59	320	0.9%	0.09	1.2 MB	0.0%	0.35
Oct 9 19:00:00 - 19:59:59	282	0.8%	0.08	934.3 KB	0.0%	0.26
Oct 9 20:00:00 - 20:59:59	258	0.8%	0.07	793.5 KB	0.0%	0.22
Oct 9 21:00:00 - 21:59:59	1947	5.7%	0.54	696.3 MB	5.8%	198.07
Oct 9 22:00:00 - 22:59:59	4460	13.1%	1.24	1.4 GB	12.3%	417.61
Oct 9 23:00:00 - 23:59:59	308	0.9%	0.09	936.9 KB	0.0%	0.26
Oct 10 00:00:00 - 00:59:59	4634	13.6%	1.29	2.9 GB	25.1%	851.82
Oct 10 01:00:00 - 01:59:59	927	2.7%	0.26	344.3 MB	2.9%	97.93
Oct 10 02:00:00 - 02:30:00	255	0.7%	0.14	655.2 KB	0.0%	0.36
TOTAL: 24:00:00	34135	100.0%	0.40	11.7 GB	100.0%	141.65

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other
1	feed1.usenet.blueworldhosting.com	724	258	0	0	1	0	0	0	465
TOTAL: 1		724	258	0	0	1	0	0	0	465

Unwanted newsgroups [Top 20]:

Newsgroup	Count
finet.binaries.keskustelu	62
wolfsburg.test	20
alt.binaries.nospam.female.bodyhair.pubes	17
alt.binaries.pictures.wallpaper	14
alt.binaries.sounds.karaoke	12
alt.binaries.sacd.iso	10
alt.binaries.movies.erotica	8
alt.binaries.test.yenc	8
alt.binaries.pictures.nude.celebrities.fake	8
alt.binaries.pictures.teen-starlets	7
alt.binaries.nospam.female.bodyhair	7
alt.binaries.pictures.scenic	6
alt.binaries.pictures.erotica.bondage	6
alt.binaries.3d.poser	5
alt.binaries.howard-stern	5
alt.binaries.sounds.lossless	4
alt.binaries.comics.dcp	4
alt.binaries.sounds.mp3.new-age	4
alt.binaries.drwho	3
alt.binaries.xxx	3
TOTAL: 52	258

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

Groups	Count
bit.listserv.catholic	1
TOTAL: 1	1

INND Python filter [Top 20]:

Reason	Count
EMP Body Reject	17
Bad Subject (Solution manual )	10
Bad Subject (Buy Xanax)	7
Bad From (PHARMA GRADE)	4
Bad Subject (Solution Manual )	4
Bad Subject (Buy Ketamine)	4
Bad From (FBInCIAnNSATerroristSlayer@yahoo.com)	1
Bad From (dr.jamesmoore202@gmail.com)	1
Bad Subject (Buy Adderall)	1
TOTAL: 9	49

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	feed1.usenet.blueworldhosting.com	416
	TOTAL: 1	416
TOTAL: 1		416

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	feed1.usenet.blueworldhosting.com	0	0	0	0	0	0	0%	00:10:00
TOTAL: 1		0	0	0	0	0	0	0%	00:10:00

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	feed1.usenet.blueworldhosting.com	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	00:10:00
TOTAL: 1		0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	00:10:00

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	69.167.45.108	171	7	12.9 KB	2	0	01:36:58
2	69.167.42.35	86	1	3.6 KB	0	0	00:49:09
3	69.166.204.91	96	0	0.0 KB	0	4733	03:07:20
TOTAL: 3		353	8	16.5 KB	2	4733	30:46:32

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	353	8	16.5 KB	2	4733	05:33:28
2	*.monitoring.internet-measurement.com	10	0	0.0 KB	0	0	00:00:06
3	*.res.spectrum.com	5	0	0.0 KB	0	0	02:24:38
4	*.stehlik.co.uk	899	0	0.0 KB	0	0	22:48:18
TOTAL: 4		1267	8	16.5 KB	2	4733	30:46:32

NNRP auth users [Top 20]:

User	Conn
jesse	358
TOTAL: 1	358

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
toma-03.stehlik.co.uk	178.898	60.155	0.000	22:48:18
69.166.204.91	120.249	99.558	0.450	03:07:20
023-084-030-207.res.spectrum.com	0.401	0.067	0.022	02:24:38
69.167.45.108	13.279	2.283	0.997	01:36:58
69.167.42.35	6.705	1.082	0.453	00:49:09
regal.monitoring.internet-measurement.com	0.067	0.013	0.000	00:00:06
cute.monitoring.internet-measurement.com	0.065	0.008	0.000	00:00:00
compassionate.monitoring.internet-measurement.com	0.075	0.000	0.000	00:00:00
TOTAL: 8	319.739	163.166	1.922	30:46:32

Curious NNRP server explorers [Top 20]:

System	Conn
toma-03.stehlik.co.uk	899
023-084-030-207.res.spectrum.com	5
compassionate.monitoring.internet-measurement.com	1
principled.monitoring.internet-measurement.com	1
regal.monitoring.internet-measurement.com	1
elite.monitoring.internet-measurement.com	1
stellar.monitoring.internet-measurement.com	1
heartfelt.monitoring.internet-measurement.com	1
adventuresome.monitoring.internet-measurement.com	1
passionate.monitoring.internet-measurement.com	1
cute.monitoring.internet-measurement.com	1
refreshing.monitoring.internet-measurement.com	1
TOTAL: 12	914

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
69.167.45.108	171	171
69.167.42.35	86	86
023-084-030-207.res.spectrum.com	5	1
TOTAL: 3	262	259

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	comp	5	83.3%
2	alt	1	16.7%
TOTAL: 2		6	100.0%

Newsgroup request counts (by newsgroup) [Top 100]:

Newsgroup		Count
1	comp.security.unix	5
2	alt.free.newsservers	1
TOTAL: 2		6

Daily Usenet report

Oct 9 02:30:00 -- Oct 10 02:30:00