Daily Usenet report: Jun 8 03:00:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
innd	34162	49.3%	3.9 MB	47.7%
inn	24321	35.1%	2.8 MB	34.4%
nnrpd	10513	15.2%	1.4 MB	17.4%
innfeed	331	0.5%	43.2 KB	0.5%
nocem	4	0.0%	0.4 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	69332	100.0%	8.2 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	24037	68.5%
Negative hits	11062	31.5%
Positive hits	12	0.0%
Cache misses	3	0.0%
TOTAL: 4	35114	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.247	0.0%	84	0.000	14.845	734.000
article cleanup	00:00:00.226	0.0%	24074	0.000	0.009	0.049
article logging	00:00:01.547	0.0%	24321	0.000	0.064	0.841
article parse	00:00:17.251	0.0%	979268	0.000	0.018	0.048
article write	00:04:30.866	0.3%	22034	1.081	12.293	41.871
artlog/artcncl	00:00:00.000	0.0%	15	0.000	0.000	0.000
data move	00:00:02.364	0.0%	1047166	0.000	0.002	0.016
hisgrep/artcncl	00:00:00.277	0.0%	97	0.000	2.856	16.300
hishave/artcncl	00:00:00.000	0.0%	15	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:14.918	0.1%	35136	0.038	2.132	16.745
history sync	00:00:02.463	0.0%	414	0.000	5.949	51.000
history write	00:01:56.933	0.1%	24074	0.339	4.857	13.670
idle	23:38:32.254	98.4%	918885	2.152	92.626	9373.516
nntp read	00:00:13.849	0.0%	990773	0.000	0.014	0.237
overview write	00:02:08.773	0.1%	22034	0.333	5.844	874.520
perl filter	00:00:03.121	0.0%	22440	0.000	0.139	0.278
python filter	00:11:59.481	0.8%	34300	1.000	20.976	34.917
site send	00:00:00.760	0.0%	32323	0.000	0.024	0.087
TOTAL: 24:01:27.471	24:01:06.330	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	9693	0.000	0.003	0.007
article prepare	00:00:00.019	0.0%	38612	0.000	0.000	0.001
article read	00:00:02.130	0.0%	9653	0.105	0.221	0.546
backlog stats	00:00:00.124	0.0%	479228	0.000	0.000	0.077
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.221	0.0%	19864	0.000	0.011	0.013
data write	00:01:10.968	0.1%	456258	0.000	0.156	1.000
idle	23:43:58.661	99.9%	479228	5.533	178.284	23337.074
status file	00:00:00.067	0.0%	103	0.000	0.650	4.000
TOTAL: 23:45:14.803	23:45:12.216	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:01.599	0.0%	31037	0.000	0.052	4.067
readart	00:00:00.690	0.0%	15	9.200	46.000	64.400
TOTAL: 06:02:55.116	00:00:02.289	0.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	6
flushlogs	2
go	2
logmode	2
lowmark	1
mode	147
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	170

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Reject	%Accpt	Elapsed
1	feed1.usenet.blueworldhosting.com	241	13822	11786	2036	85%	58:17:40
2	localhost	10229	10226	10226	0	100%	00:21:55
TOTAL: 2		10470	24048	22012	2036	91%	58:39:35

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	localhost	7.0 GB	0.0 KB	7.0 GB	100%	713.8 KB
2	feed1.usenet.blueworldhosting.com	42.4 MB	15.8 MB	58.2 MB	72%	4.3 KB
TOTAL: 2		7.0 GB	15.8 MB	7.0 GB	99%	306.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 8 03:00:00 - 03:59:59	555	2.5%	0.15	1.8 MB	0.0%	0.51
Jun 8 04:00:00 - 04:59:59	596	2.7%	0.17	1.9 MB	0.0%	0.53
Jun 8 05:00:00 - 05:59:59	639	2.9%	0.18	2.1 MB	0.0%	0.60
Jun 8 06:00:00 - 06:59:59	613	2.8%	0.17	2.1 MB	0.0%	0.59
Jun 8 07:00:00 - 07:59:59	694	3.2%	0.19	3.1 MB	0.0%	0.87
Jun 8 08:00:00 - 08:59:59	684	3.1%	0.19	2.1 MB	0.0%	0.61
Jun 8 09:00:00 - 09:59:59	639	2.9%	0.18	2.0 MB	0.0%	0.56
Jun 8 10:00:00 - 10:59:59	684	3.1%	0.19	2.3 MB	0.0%	0.65
Jun 8 11:00:00 - 11:59:59	635	2.9%	0.18	2.0 MB	0.0%	0.58
Jun 8 12:00:00 - 12:59:59	671	3.0%	0.19	2.3 MB	0.0%	0.64
Jun 8 13:00:00 - 13:59:59	585	2.7%	0.16	1.6 MB	0.0%	0.47
Jun 8 14:00:00 - 14:59:59	605	2.7%	0.17	2.5 MB	0.0%	0.72
Jun 8 15:00:00 - 15:59:59	535	2.4%	0.15	1.6 MB	0.0%	0.45
Jun 8 16:00:00 - 16:59:59	499	2.3%	0.14	2.0 MB	0.0%	0.56
Jun 8 17:00:00 - 17:59:59	419	1.9%	0.12	2.0 MB	0.0%	0.56
Jun 8 18:00:00 - 18:59:59	324	1.5%	0.09	1.2 MB	0.0%	0.33
Jun 8 19:00:00 - 19:59:59	270	1.2%	0.07	1.2 MB	0.0%	0.35
Jun 8 20:00:00 - 20:59:59	247	1.1%	0.07	2.5 MB	0.0%	0.70
Jun 8 21:00:00 - 21:59:59	241	1.1%	0.07	879.6 KB	0.0%	0.24
Jun 8 22:00:00 - 22:59:59	237	1.1%	0.07	757.4 KB	0.0%	0.21
Jun 8 23:00:00 - 23:59:59	2818	12.8%	0.78	1.7 GB	24.5%	499.11
Jun 9 00:00:00 - 00:59:59	308	1.4%	0.09	1.0 MB	0.0%	0.29
Jun 9 01:00:00 - 01:59:59	3015	13.7%	0.84	1.8 GB	25.7%	524.19
Jun 9 02:00:00 - 03:00:00	5513	25.0%	1.53	3.5 GB	49.3%	1005.31
TOTAL: 24:00:00	22026	100.0%	0.25	7.0 GB	100.0%	84.98

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other
1	feed1.usenet.blueworldhosting.com	2280	406	0	0	0	0	0	0	1874
TOTAL: 1		2280	406	0	0	0	0	0	0	1874

Unwanted newsgroups [Top 20]:

Newsgroup	Count
talk.ukrainian.tg	282
talk.english.tg	72
talk.generic.ua.ws	22
talk.english.tw	10
news.oriens-occasus.ru	3
talk.from.diary	2
alt.penthouse.sex.first-time	2
news.test	2
alt.suicide.finals	2
talk.from.war.diary	2
alt.drugs.anticholinergics	1
comp.os.linus.misc	1
alt.biz.misc	1
panix.user.movies	1
silas.fonseca13gmail.com	1
list.postfix.users	1
alt.penthouse.sex.femdom	1
TOTAL: 17	406

INND Python filter [Top 20]:

Reason	Count
EMP Body Reject	761
EMP PHL Reject	324
Bad From (Test User <test-user@nospam.example>)	288
EMP PHN Reject	214
EMP FSL Reject	21
Bad Subject (echolot ping - ignore)	11
Binary (yEnc)	4
AUK Bad Crosspost	2
Bad Subject (MA_=23FININVEST=21_=C3=89_NAZI=E5=8D=8DP)	2
Bad Subject (MEGA PC4 Interface Card [PC4, PC4A ?, PC4B, PC4B/50 and P)	1
Bad Subject (MINALISSIMA_=23FININVEST=21_=C3=89_NAZI=E5=8D=8DP)	1
TOTAL: 11	1629

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	feed1.usenet.blueworldhosting.com	10229	10226	0	0	0	40	99%	01:32:36
TOTAL: 1		10229	10226	0	0	0	40	99%	01:32:36

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	feed1.usenet.blueworldhosting.com	7.0 GB	0.0 KB	7.0 GB	1.3 MB/s	713.8 KB	01:32:36
TOTAL: 1		7.0 GB	0.0 KB	7.0 GB	1.3 MB/s	713.8 KB	01:32:36

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	023-084-030-207.res.spectrum.com	2	15	41.9 KB	18	0	00:40:46
2	192.168.1.146	26	0	0.0 KB	0	10226	05:21:31
TOTAL: 2		28	15	41.9 KB	18	10226	06:02:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.res.spectrum.com	2	15	41.9 KB	18	0	00:40:46
2	unresolved	29	0	0.0 KB	0	10226	05:22:08
TOTAL: 2		31	15	41.9 KB	18	10226	06:02:54

NNRP auth users [Top 20]:

User	Conn
jesse	28
TOTAL: 1	28

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
192.168.1.146	231.619	175.616	0.315	05:21:31
023-084-030-207.res.spectrum.com	0.219	0.055	0.016	00:40:46
50.83.128.198	0.116	0.017	0.000	00:00:33
46.17.96.40	0.170	0.007	0.000	00:00:03
TOTAL: 4	232.124	175.695	0.331	06:02:54

Curious NNRP server explorers [Top 20]:

System	Conn
46.17.96.40	2
50.83.128.198	1
TOTAL: 2	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
023-084-030-207.res.spectrum.com	2	1
TOTAL: 1	2	2

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	news	19	100.0%
TOTAL: 1		19	100.0%

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

Newsgroup		Count
1	news.software.readers	12
2	news.lists.filters	6
3	news.admin.net-abuse.usenet	1
TOTAL: 3		19

Daily Usenet report

Jun 8 03:00:00 -- Jun 9 03:00:00