Daily Usenet report: Aug 7 02:30:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	567482	85.6%	50.5 MB	84.4%
nnrpd	62202	9.4%	5.7 MB	9.6%
innd	32944	5.0%	3.6 MB	6.0%
innfeed	158	0.0%	15.0 KB	0.0%
nocem	7	0.0%	0.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	662794	100.0%	59.8 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	566602	51.0%
Negative hits	543438	49.0%
Positive hits	9	0.0%
Cache misses	3	0.0%
TOTAL: 4	1110052	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.577	0.0%	260	0.000	6.065	108.000
article cleanup	00:00:03.634	0.0%	570633	0.000	0.006	0.051
article logging	00:00:06.927	0.0%	571411	0.000	0.012	0.062
article parse	00:00:27.640	0.0%	3178804	0.000	0.009	0.042
article write	00:11:05.302	0.8%	550976	0.200	1.207	21.468
artlog/artcncl	00:00:00.000	0.0%	8	0.000	0.000	0.000
artlog/artparse	00:00:00.000	0.0%	1	0.000	0.000	0.000
data move	00:00:02.736	0.0%	2245923	0.000	0.001	0.007
hisgrep/artcncl	00:00:00.035	0.0%	268	0.000	0.131	3.000
hishave/artcncl	00:00:00.000	0.0%	11	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:28.998	0.0%	1118075	0.016	0.026	0.135
history sync	00:00:02.906	0.0%	387	0.000	7.509	10.000
history write	00:09:25.438	0.7%	570632	0.650	0.991	1.257
idle	23:21:33.547	97.3%	3144881	1.481	26.740	9536.587
nntp read	00:00:51.607	0.1%	3183754	0.000	0.016	0.063
overview write	00:01:38.940	0.1%	550976	0.078	0.180	1.056
perl filter	00:00:19.538	0.0%	553743	0.000	0.035	0.122
python filter	00:13:11.765	0.9%	1115380	0.143	0.710	12.177
site send	00:00:15.710	0.0%	551020	0.000	0.029	0.062
TOTAL: 24:01:04.125	23:59:36.300	99.9%	-	-	-	-

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.005	0.0%	3731	0.000	0.001	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:54:27.178	100.0%	3731	17383.943	23068.126	24111.400
status file	00:00:00.000	0.0%	6	0.000	0.000	0.000
TOTAL: 23:54:27.221	23:54:27.183	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.007	0.0%	9	0.500	0.778	1.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:29:43.031	2.1%	13158689	0.000	0.136	1406.485
readart	00:00:08.856	0.0%	375	13.750	23.616	38.000
TOTAL: 24:07:52.177	00:29:51.894	2.1%	-	-	-	-

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	localhost	3407	540761	523774	1	16986	96%	06:19:59
2	feed1.usenet.blueworldhosting.com	12	25932	23261	0	2671	89%	24:55:34
TOTAL: 2		3419	566693	547035	1	19657	96%	31:15:33

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feed1.usenet.blueworldhosting.com	5.9 GB	1.4 GB	7.2 GB	80%	292.7 KB
2	localhost	1.1 GB	858.6 MB	2.0 GB	57%	3.8 KB
TOTAL: 2		7.0 GB	2.2 GB	9.2 GB	75%	17.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 7 02:30:00 - 02:59:59	15542	2.8%	8.63	56.1 MB	0.8%	31.93
Aug 7 03:00:00 - 03:59:59	28848	5.3%	8.01	106.8 MB	1.5%	30.39
Aug 7 04:00:00 - 04:59:59	20773	3.8%	5.77	293.6 MB	4.1%	83.50
Aug 7 05:00:00 - 05:59:59	20967	3.8%	5.82	182.1 MB	2.5%	51.80
Aug 7 06:00:00 - 06:59:59	31136	5.7%	8.65	573.2 MB	8.0%	163.04
Aug 7 07:00:00 - 07:59:59	32958	6.0%	9.15	544.1 MB	7.6%	154.76
Aug 7 08:00:00 - 08:59:59	33285	6.1%	9.25	108.9 MB	1.5%	30.98
Aug 7 09:00:00 - 09:59:59	27591	5.0%	7.66	220.3 MB	3.1%	62.67
Aug 7 10:00:00 - 10:59:59	34084	6.2%	9.47	198.8 MB	2.8%	56.55
Aug 7 11:00:00 - 11:59:59	35674	6.5%	9.91	1.1 GB	16.1%	328.41
Aug 7 12:00:00 - 12:59:59	36671	6.7%	10.19	2.7 GB	37.9%	772.14
Aug 7 13:00:00 - 13:59:59	33674	6.2%	9.35	72.5 MB	1.0%	20.62
Aug 7 14:00:00 - 14:59:59	33188	6.1%	9.22	72.4 MB	1.0%	20.58
Aug 7 15:00:00 - 15:59:59	23723	4.3%	6.59	59.8 MB	0.8%	17.02
Aug 7 16:00:00 - 16:59:59	20872	3.8%	5.80	53.6 MB	0.7%	15.25
Aug 7 17:00:00 - 17:59:59	19648	3.6%	5.46	133.6 MB	1.9%	38.01
Aug 7 18:00:00 - 18:59:59	15640	2.9%	4.34	58.4 MB	0.8%	16.60
Aug 7 19:00:00 - 19:59:59	16063	2.9%	4.46	130.7 MB	1.8%	37.17
Aug 7 20:00:00 - 20:59:59	20582	3.8%	5.72	54.0 MB	0.8%	15.36
Aug 7 21:00:00 - 21:59:59	21040	3.8%	5.84	46.8 MB	0.7%	13.32
Aug 7 22:00:00 - 22:59:59	20778	3.8%	5.77	47.2 MB	0.7%	13.42
Aug 7 23:00:00 - 23:59:59	3194	0.6%	0.89	226.0 MB	3.2%	64.28
Aug 8 00:00:00 - 00:59:59	231	0.0%	0.06	742.1 KB	0.0%	0.21
Aug 8 01:00:00 - 01:59:59	476	0.1%	0.13	20.0 MB	0.3%	5.69
Aug 8 02:00:00 - 02:30:00	401	0.1%	0.22	31.2 MB	0.4%	17.74
TOTAL: 24:00:00	547039	100.0%	6.33	7.0 GB	100.0%	84.86

Sites sending bad articles:

Server		Total	Group	Dist	Unapp	Other
1	localhost	17457	7	15	192	17243
2	feed1.usenet.blueworldhosting.com	2978	2549	0	1	428
TOTAL: 2		20435	2556	15	193	17671

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.binaries.mom	1887
al.binaries.test	252
alt.binaries.de	143
talk.english.tg	56
alt.binaries.pictures.teen-starlets	20
alt.binaries.pictures.nude.celebrities.fake	18
finet.binaries.keskustelu	17
alt.binaries.pictures.wallpaper	14
talk.generic.ua.ws	11
alt.binaries.test.yenc	11
alt.binaries.nospam.female.bodyhair	11
alt.binaries.pictures.scenic	9
alt.binaries.nospam.female.bodyhair.pubes	9
alt	7
alt.binaries.howard-stern	6
alt.binaries.pictures.rail	5
alt.binaries.alt5	4
alt.binaries.classic.tv.shows	4
alt.binaries.sounds.lossless	4
alt.binaries.sounds.mp3.1960s	4
TOTAL: 61	2556

Unwanted distributions [Top 20]:

Distribution	Count
local	15
TOTAL: 1	15

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

Groups	Count
comp.dcom.telecom	64
comp.compilers	52
perl.dbi.users	28
linux.debian.policy	21
comp.arch.hobbyist	7
soc.religion.asatru	6
rec.music.info	3
comp.compression.research	2
perl.jobs	2
bit.listserv.catholic	1
clari.news.issues.misc	1
hannet.ml.cad.proe-users	1
mpc.lists.freebsd.current	1
perl.ai	1
clari.world.military	1
linux.debian.beowulf	1
comp.doc.techreports	1
TOTAL: 17	193

INND Python filter [Top 20]:

Reason	Count
EMP Body Reject	12528
Binary (yEnc)	2995
Binary (base64)	560
Binary (uuEnc)	368
OS2 Crosspost	242
Crosspost Low Limit Exceeded	111
Bad From (hester holt)	11
Bad Subject (Buy Xanax)	8
Bad Subject (Solution Manual )	7
Bad Subject (Buy Diazepam)	7
Bad Subject (Solution manual )	7
Bad Subject (Buy Adderall)	6
Bad Subject (Buy Hydrocodone)	6
Bad From (FBInCIAnNSATerroristSlayer@yahoo.com)	4
OS2 Followup	3
Bad Subject (Buy Oxycodon)	3
Bad From (huhai102@gmail.com)	3
Bad From (Hester Holt)	1
Symbols (183)	1
Bad From (giannicipolla@protonmail.com)	1
TOTAL: 23	16875

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	3	0	3	3
TOTAL: 1	3	0	3	3

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	localhost	4
	TOTAL: 1	4
Bad Message-ID's offered
	localhost	346
	TOTAL: 1	346
Including strange strings
	localhost	471
	feed1.usenet.blueworldhosting.com	307
	TOTAL: 2	778
No colon-space in header field
	localhost	1
	TOTAL: 1	1
TOTAL: 4		1129

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	173.30.87.242	17	365	776.7 KB	20	0	00:10:54
2	023-084-030-207.res.spectrum.com	34	10	24.1 KB	3	1	00:21:39
TOTAL: 2		51	375	800.8 KB	23	1	24:07:46

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	17	365	776.7 KB	20	0	00:10:54
2	*.res.spectrum.com	34	10	24.1 KB	3	1	00:21:39
3	*.contegix.com	68	0	0.0 KB	0	0	00:39:11
4	*.stehlik.co.uk	897	0	0.0 KB	0	0	22:56:02
TOTAL: 4		1016	375	800.8 KB	23	1	24:07:46

NNRP auth users [Top 20]:

User	Conn
jesse	102
TOTAL: 1	102

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
toma-03.stehlik.co.uk	179.988	60.657	0.000	22:56:02
199-119-120-158.contegix.com	5.220	0.729	0.361	00:39:11
023-084-030-207.res.spectrum.com	2.775	0.502	0.159	00:21:39
173.30.87.242	1.862	0.346	0.000	00:10:54
TOTAL: 4	189.845	62.234	0.520	24:07:46

Curious NNRP server explorers [Top 20]:

System	Conn
toma-03.stehlik.co.uk	897
199-119-120-158.contegix.com	68
TOTAL: 2	965

NNRP client timeouts [Top 20]:

System	Conn	Peer
199-119-120-158.contegix.com	68	68
023-084-030-207.res.spectrum.com	34	34
toma-03.stehlik.co.uk	1	1
TOTAL: 3	103	103

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	rec	365	98.9%
2	news	3	0.8%
3	alt	1	0.3%
TOTAL: 3		369	100.0%

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

Newsgroup		Count
1	rec.food.cooking	365
2	news.software.nntp	3
3	alt.binaries.e-books	1
TOTAL: 3		369

Daily Usenet report

Aug 7 02:30:00 -- Aug 8 02:30:00