Daily Usenet report: Sep 14 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	15057	54.6%	1.2 MB	51.8%
nnrpd	9313	33.8%	778.0 KB	31.9%
innd	2294	8.3%	309.2 KB	12.7%
innfeed	855	3.1%	85.1 KB	3.5%
nocem	38	0.1%	4.8 KB	0.2%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	27558	100.0%	2.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	14359	69.1%
Positive hits	4232	20.4%
Negative hits	2175	10.5%
Cache misses	18	0.1%
TOTAL: 4	20784	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.058	0.0%	75	0.000	0.773	3.000
article cleanup	00:00:00.114	0.0%	14598	0.000	0.008	0.043
article logging	00:00:00.378	0.0%	14980	0.000	0.025	0.093
article parse	00:00:00.226	0.0%	16928	0.000	0.013	0.041
article write	00:00:07.497	0.0%	13953	0.236	0.537	3.000
artlog/artcncl	00:00:00.001	0.0%	75	0.000	0.013	0.250
data move	00:00:00.035	0.0%	23300	0.000	0.002	0.014
hisgrep/artcncl	00:00:00.009	0.0%	54	0.000	0.167	1.000
hishave/artcncl	00:00:00.010	0.0%	75	0.000	0.133	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.369	0.0%	20802	0.012	0.210	0.833
history sync	00:00:00.028	0.0%	411	0.000	0.068	0.667
history write	00:00:04.429	0.0%	14372	0.075	0.308	0.960
hiswrite/artcncl	00:00:00.011	0.0%	21	0.000	0.524	1.000
idle	23:07:23.590	96.3%	21987	2072.379	3786.037	9932.051
nntp read	00:00:00.386	0.0%	21749	0.000	0.018	0.050
overview write	00:00:02.319	0.0%	13953	0.000	0.166	2.710
perl filter	00:53:28.930	3.7%	14372	99.165	223.277	561.067
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.259	0.0%	13988	0.000	0.019	0.059
TOTAL: 24:01:16.769	24:01:12.649	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.028	0.0%	13956	0.000	0.002	0.034
article prepare	00:00:00.005	0.0%	36514	0.000	0.000	0.007
article read	00:00:00.443	0.0%	9128	0.000	0.049	1.750
backlog stats	00:00:00.027	0.0%	73274	0.000	0.000	0.008
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.288	0.0%	39813	0.000	0.007	0.026
data write	00:00:00.526	0.0%	26075	0.000	0.020	0.063
idle	23:57:41.546	100.0%	73274	604.373	1177.246	3155.691
status file	00:00:00.093	0.0%	212	0.000	0.439	2.000
TOTAL: 23:57:43.780	23:57:42.956	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	43:57:04.310	98.1%	23169	0.333	6829.139	57962.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:27.253	0.0%	66820	0.000	0.408	271.963
readart	00:00:00.258	0.0%	2155	0.051	0.120	4.167
TOTAL: 44:46:52.506	43:57:31.821	98.2%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	3
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	169

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	i2pn	16	13616	13254	29	333	97%	25:38:48
2	novabbs	174	6069	811	4870	388	13%	31:31:03
3	localhost	29	1	1	0	0	100%	00:00:10
TOTAL: 3		219	19686	14066	4899	721	71%	57:10:01

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn	39.1 MB	196.6 KB	1007.5 KB	40.3 MB	97%	3.0 KB
2	novabbs	1.7 MB	577.2 KB	958.7 KB	3.2 MB	53%	2.8 KB
3	localhost	1.3 KB	0.0 KB	0.0 KB	1.3 KB	100%	1.3 KB
TOTAL: 3		40.8 MB	773.9 KB	1.9 MB	43.5 MB	93%	3.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 14 04:15:01 - 04:59:59	199	1.4%	0.07	595.1 KB	1.4%	0.22
Sep 14 05:00:00 - 05:59:59	275	2.0%	0.08	779.7 KB	1.9%	0.22
Sep 14 06:00:00 - 06:59:59	429	3.1%	0.12	1.2 MB	3.0%	0.35
Sep 14 07:00:00 - 07:59:59	577	4.1%	0.16	1.4 MB	3.5%	0.40
Sep 14 08:00:00 - 08:59:59	646	4.6%	0.18	1.7 MB	4.2%	0.48
Sep 14 09:00:00 - 09:59:59	785	5.6%	0.22	2.1 MB	5.2%	0.60
Sep 14 10:00:00 - 10:59:59	697	5.0%	0.19	1.8 MB	4.5%	0.52
Sep 14 11:00:00 - 11:59:59	753	5.4%	0.21	2.2 MB	5.4%	0.63
Sep 14 12:00:00 - 12:59:59	654	4.7%	0.18	2.1 MB	5.1%	0.59
Sep 14 13:00:00 - 13:59:59	666	4.8%	0.18	1.9 MB	4.7%	0.54
Sep 14 14:00:00 - 14:59:59	778	5.6%	0.22	2.2 MB	5.4%	0.63
Sep 14 15:00:00 - 15:59:59	789	5.7%	0.22	2.3 MB	5.6%	0.65
Sep 14 16:00:00 - 16:59:59	836	6.0%	0.23	2.3 MB	5.8%	0.66
Sep 14 17:00:00 - 17:59:59	797	5.7%	0.22	2.1 MB	5.2%	0.60
Sep 14 18:00:00 - 18:59:59	785	5.6%	0.22	2.3 MB	5.8%	0.66
Sep 14 19:00:00 - 19:59:59	763	5.5%	0.21	2.1 MB	5.2%	0.60
Sep 14 20:00:00 - 20:59:59	691	5.0%	0.19	2.1 MB	5.3%	0.61
Sep 14 21:00:00 - 21:59:59	582	4.2%	0.16	1.7 MB	4.1%	0.47
Sep 14 22:00:00 - 22:59:59	550	3.9%	0.15	1.4 MB	3.5%	0.40
Sep 14 23:00:00 - 23:59:59	382	2.7%	0.11	1.1 MB	2.6%	0.30
Sep 15 00:00:00 - 00:59:59	335	2.4%	0.09	1.0 MB	2.6%	0.29
Sep 15 01:00:00 - 01:59:59	343	2.5%	0.10	1.4 MB	3.5%	0.41
Sep 15 02:00:00 - 02:59:59	300	2.1%	0.08	1.3 MB	3.1%	0.36
Sep 15 03:00:00 - 03:59:59	260	1.9%	0.07	886.2 KB	2.1%	0.25
Sep 15 04:00:00 - 04:15:09	83	0.6%	0.09	437.6 KB	1.1%	0.48
TOTAL: 24:00:08	13955	100.0%	0.16	40.5 MB	100.0%	0.48

Sites sending bad articles:

Server		Total	Duplic	Other
1	i2pn	671	57	614
2	novabbs	357	169	188
TOTAL: 2		1028	226	802

INND Perl filter [Top 20]:

Reason	Count
Exceeds Spam Level	254
EMP (phn path)	125
Poison newsgroup	22
EMP (phn nph)	16
Scoring filter (8)	2
TOTAL: 5	419

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	27	0	29	29
TOTAL: 1	27	8	29	29

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn	338
	novabbs	45
	TOTAL: 2	383
TOTAL: 1		383

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	novabbs	16380	9089	4107	49	1	13	55%	24:00:05
2	i2pn	714	1	709	0	0	0	0%	20:16:45
TOTAL: 2		17094	9090	4816	49	1	13	53%	44:16:50

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	24.1 MB	128.6 KB	24.3 MB	0.3 KB/s	2.7 KB	24:00:05
2	i2pn	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	20:16:45
TOTAL: 2		24.1 MB	128.6 KB	24.3 MB	0.2 KB/s	2.7 KB	44:16:50

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip68-2-45-86.ph.ph.cox.net	6	373	903.6 KB	46	5	1	44:32:16
TOTAL: 1		6	373	903.6 KB	46	5	1	44:46:51

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	6	373	903.6 KB	46	5	1	44:32:16
2	?	183	0	0.0 KB	0	0	0	00:14:29
3	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
4	*.org	21	0	0.0 KB	0	0	0	00:00:04
TOTAL: 4		211	373	903.6 KB	46	5	1	44:46:51

NNRP auth users [Top 20]:

User	Conn
retrobbs1	195
Retro Guy	1
TOTAL: 2	196

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
ip68-2-45-86.ph.ph.cox.net	1.576	2.260	0.096	44:32:16
novabbs	33.692	6.048	0.400	00:14:29
i2pn2.org	1.068	0.164	0.052	00:00:04
scan-141.security.ipip.net	0.032	0.012	0.000	00:00:00
TOTAL: 4	36.368	8.484	0.548	44:46:51

Curious NNRP server explorers [Top 20]:

System	Conn
novabbs	183
i2pn2.org	21
scan-141.security.ipip.net	1
TOTAL: 3	205

NNRP unrecognized commands (by host):

System	Conn
novabbs	41
scan-141.security.ipip.net	4
TOTAL: 2	45

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	11
Host: wwcqkwfo5yhe6uribv5tzylk25j5hkdk6g...	9
User-Agent: MYOB/6.66 (AN/ON)	3
Connection: close	3
Accept-Encoding: gzip,deflate	2
Referer: http://isitup.i2p/workingsites....	2
Accept-Language: en	2
X-Accept-Encoding: x-i2p-gzip;q=1.0, ide...	2
Accept: text/html,application/xhtml+xml,...	2
GET /?_escaped_fragment_=sig%3D32JwUI8P6...	1
Host: 157.230.63.40:119	1
Accept-Encoding: identity	1
User-Agent: Mozilla/5.0 (Windows NT 6.1;...	1
Host: news-i2pn.i2p	1
Accept: /	1
Host: asq5mo52aghemn2i.onion:119	1
User-Agent: HTTP Banner Detection (https...	1
Accept-Encoding: deflate, gzip	1
TOTAL: 18	45

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip68-2-45-86.ph.ph.cox.net	2	0
TOTAL: 1	2	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	313	90.2%
2	comp	29	8.4%
3	rocksolid	5	1.4%
TOTAL: 3		347	100.0%

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

Newsgroup		Count
1	alt.arts.poetry.comments	310
2	comp.os.linux.advocacy	29
3	rocksolid.shared.test	4
4	alt.checkmate	3
5	rocksolid.nodes	1
TOTAL: 5		347

Daily Usenet report

Sep 14 04:15:01 -- Sep 15 04:15:09