Daily Usenet report: Sep 11 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	17626	42.2%	1.4 MB	39.7%
nnrpd	17208	41.2%	1.5 MB	40.1%
innd	5967	14.3%	659.1 KB	17.7%
innfeed	853	2.0%	82.2 KB	2.2%
nocem	89	0.2%	10.3 KB	0.3%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41744	100.0%	3.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	16726	65.1%
Positive hits	5764	22.4%
Negative hits	3150	12.3%
Cache misses	37	0.1%
TOTAL: 4	25677	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.231	0.0%	170	0.000	1.359	32.000
article cleanup	00:00:00.127	0.0%	17050	0.000	0.007	0.039
article logging	00:00:00.518	0.0%	17410	0.000	0.030	0.116
article parse	00:00:00.309	0.0%	20214	0.000	0.015	0.056
article write	00:00:09.636	0.0%	16372	0.191	0.589	1.933
artlog/artcncl	00:00:00.005	0.0%	162	0.000	0.031	0.500
data move	00:00:00.042	0.0%	28934	0.000	0.001	0.014
hisgrep/artcncl	00:00:00.012	0.0%	107	0.000	0.112	1.000
hishave/artcncl	00:00:00.111	0.0%	170	0.000	0.653	16.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.185	0.0%	25626	0.013	0.202	0.956
history sync	00:00:00.022	0.0%	410	0.000	0.054	0.667
history write	00:00:06.382	0.0%	16712	0.052	0.382	1.523
hiswrite/artcncl	00:00:00.073	0.0%	63	0.000	1.159	15.500
idle	22:37:58.137	94.9%	29644	1084.897	2748.554	9734.738
nntp read	00:00:00.549	0.0%	27828	0.000	0.020	0.056
overview write	00:00:02.573	0.0%	16372	0.036	0.157	1.963
perl filter	01:12:54.261	5.1%	16712	113.259	261.744	803.323
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.375	0.0%	16454	0.000	0.023	0.055
TOTAL: 23:51:24.933	23:51:18.548	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	16427	0.000	0.002	0.019
article prepare	00:00:00.006	0.0%	38898	0.000	0.000	0.006
article read	00:00:00.565	0.0%	9726	0.000	0.058	1.760
backlog stats	00:00:00.022	0.0%	84727	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.365	0.0%	46262	0.000	0.008	0.027
data write	00:00:00.685	0.0%	30150	0.000	0.023	0.155
idle	23:58:07.225	100.0%	84727	560.735	1018.415	2468.188
status file	00:00:00.095	0.0%	210	0.000	0.452	2.000
TOTAL: 23:58:09.977	23:58:08.995	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	148:59:50.809	99.9%	48142	0.400	11141.847	360020.600
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.875	0.0%	125299	0.000	0.015	1.652
readart	00:00:14.174	0.0%	4927	0.093	2.877	107.000
TOTAL: 149:12:13.933	149:00:06.858	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
cancel	17
flush	3
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	4
reserve	2
TOTAL: 12	188

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	i2pn	16	15808	15348	30	430	97%	25:50:35
2	novabbs	1086	6806	1080	5470	256	15%	25:12:35
3	localhost	32	0	0	0	0	0%	00:00:02
TOTAL: 3		1134	22614	16428	5500	686	72%	51:03:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn	47.7 MB	425.0 KB	1.6 MB	49.6 MB	96%	3.2 KB
2	novabbs	2.6 MB	766.2 KB	798.3 KB	4.1 MB	62%	3.2 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		50.3 MB	1.2 MB	2.3 MB	53.8 MB	93%	3.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 11 04:15:01 - 04:59:59	277	1.7%	0.10	845.5 KB	1.6%	0.31
Sep 11 05:00:00 - 05:59:59	413	2.5%	0.11	1.4 MB	2.8%	0.41
Sep 11 06:00:00 - 06:59:59	485	3.0%	0.13	1.9 MB	3.8%	0.54
Sep 11 07:00:00 - 07:59:59	633	3.9%	0.18	1.8 MB	3.6%	0.51
Sep 11 08:00:00 - 08:59:59	706	4.3%	0.20	1.8 MB	3.6%	0.51
Sep 11 09:00:00 - 09:59:59	741	4.5%	0.21	2.0 MB	3.9%	0.56
Sep 11 10:00:00 - 10:59:59	829	5.1%	0.23	2.7 MB	5.3%	0.76
Sep 11 11:00:00 - 11:59:59	795	4.8%	0.22	2.4 MB	4.9%	0.70
Sep 11 12:00:00 - 12:59:59	892	5.4%	0.25	2.8 MB	5.6%	0.80
Sep 11 13:00:00 - 13:59:59	852	5.2%	0.24	2.8 MB	5.7%	0.81
Sep 11 14:00:00 - 14:59:59	908	5.5%	0.25	2.3 MB	4.6%	0.66
Sep 11 15:00:00 - 15:59:59	962	5.9%	0.27	3.2 MB	6.4%	0.91
Sep 11 16:00:00 - 16:59:59	966	5.9%	0.27	2.7 MB	5.3%	0.76
Sep 11 17:00:00 - 17:59:59	978	6.0%	0.27	2.5 MB	5.0%	0.72
Sep 11 18:00:00 - 18:59:59	860	5.2%	0.24	2.7 MB	5.3%	0.76
Sep 11 19:00:00 - 19:59:59	828	5.0%	0.23	2.3 MB	4.6%	0.66
Sep 11 20:00:00 - 20:59:59	811	4.9%	0.23	2.7 MB	5.4%	0.77
Sep 11 21:00:00 - 21:59:59	807	4.9%	0.22	2.4 MB	4.7%	0.68
Sep 11 22:00:00 - 22:59:59	626	3.8%	0.17	2.1 MB	4.1%	0.58
Sep 11 23:00:00 - 23:59:59	480	2.9%	0.13	2.0 MB	4.1%	0.58
Sep 12 00:00:00 - 00:59:59	430	2.6%	0.12	1.2 MB	2.5%	0.35
Sep 12 01:00:00 - 01:59:59	369	2.2%	0.10	1.1 MB	2.3%	0.32
Sep 12 02:00:00 - 02:59:59	356	2.2%	0.10	1.2 MB	2.3%	0.33
Sep 12 03:00:00 - 03:59:59	328	2.0%	0.09	942.8 KB	1.8%	0.26
Sep 12 04:00:00 - 04:15:07	81	0.5%	0.09	454.0 KB	0.9%	0.50
TOTAL: 24:00:06	16413	100.0%	0.19	50.2 MB	100.0%	0.60

Sites sending bad articles:

Server		Total	Duplic	Other
1	i2pn	766	92	674
2	novabbs	275	246	29
TOTAL: 2		1041	338	703

INND Perl filter [Top 20]:

Reason	Count
Exceeds Spam Level	297
Poison newsgroup	41
Scoring filter (8)	5
HTML Image Tags	1
TOTAL: 4	344

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	72	0	87	87
TOTAL: 1	72	10	87	87

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn	336
	novabbs	23
	TOTAL: 2	359
TOTAL: 1		359

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	novabbs	19571	9674	5619	51	3	24	49%	24:00:02
2	i2pn	1065	0	1065	0	0	0	0%	23:10:47
TOTAL: 2		20636	9674	6684	51	3	24	46%	47:10:49

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	25.2 MB	108.8 KB	25.3 MB	0.3 KB/s	2.7 KB	24:00:02
2	i2pn	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:10:47
TOTAL: 2		25.2 MB	108.8 KB	25.3 MB	0.2 KB/s	2.7 KB	47:10:49

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	novabbs	1091	1232	3.4 MB	1232	0	08:36:41
2	ip68-2-45-86.ph.ph.cox.net	3	230	588.2 KB	40	2	140:35:17
TOTAL: 2		1094	1462	4.0 MB	1272	2	149:12:08

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	?	1091	1232	3.4 MB	1232	0	08:36:41
2	*.ph.ph.cox.net	3	230	588.2 KB	40	2	140:35:17
3	*.org	9	0	0.0 KB	0	0	00:00:10
TOTAL: 3		1103	1462	4.0 MB	1272	2	149:12:08

NNRP auth users [Top 20]:

User	Conn
retrobbs1	1093
TOTAL: 1	1093

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
ip68-2-45-86.ph.ph.cox.net	2.232	2.640	0.006	140:35:17
novabbs	97.236	12.188	3.563	08:36:41
i2pn2.org	1.140	0.164	0.024	00:00:10
TOTAL: 3	100.608	14.992	3.593	149:12:08

Curious NNRP server explorers [Top 20]:

System	Conn
i2pn2.org	9
TOTAL: 1	9

NNRP unrecognized commands (by host):

System	Conn
novabbs	20
TOTAL: 1	20

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	9
Host: wwcqkwfo5yhe6uribv5tzylk25j5hkdk6g...	8
Accept-Encoding: identity	1
Host: news-i2pn.i2p	1
User-Agent: MYOB/6.66 (AN/ON)	1
TOTAL: 5	20

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

Category		Count	Pct
1	rec	859	66.3%
2	comp	265	20.4%
3	alt	137	10.6%
4	rocksolid	33	2.5%
5	news	2	0.2%
TOTAL: 5		1296	100.0%

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

Newsgroup		Count
1	rec.music.classical.recordings	598
2	rec.music.dylan	247
3	comp.lang.c	133
4	alt.humor.puns	48
5	comp.lang.forth	39
6	rocksolid.shared.rocksolid	30
7	alt.astronomy	30
8	alt.checkmate	19
9	comp.lang.javascript	17
10	comp.lang.python	16
11	comp.lang.c++	14
12	alt.obituaries	11
13	comp.lang.lisp	11
14	comp.lang.clipper.visual-objects	11
15	rec.music.classical	10
16	alt.fan.jai-maharaj	9
17	alt.dreams.castaneda	9
18	comp.lang.prolog	6
19	alt.food.fast-food	5
20	comp.lang.fortran	4
21	comp.lang.tcl	4
22	rec.music.rock-pop-r+b.1960s	4
23	comp.lang.ada	3
24	comp.lang.mumps	2
25	alt.military.retired	2
26	rocksolid.nodes	2
27	comp.protocols.dicom	2
28	news.admin.net-abuse.email	2
29	alt.law-enforcement	2
30	comp.lang.clipper	1
31	comp.lang.java.programmer	1
32	alt.lang.asm	1
33	alt.privacy.anon-server	1
34	rocksolid.shared.news	1
35	comp.databases.ms-access	1
TOTAL: 35		1296

Daily Usenet report

Sep 11 04:15:01 -- Sep 12 04:15:07