Daily Usenet report: Sep 15 04:15:09

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	15388	51.8%	1.3 MB	49.4%
nnrpd	10472	35.2%	865.4 KB	32.9%
innd	2953	9.9%	375.7 KB	14.3%
innfeed	872	2.9%	86.2 KB	3.3%
nocem	45	0.2%	5.1 KB	0.2%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	29731	100.0%	2.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	14676	68.5%
Positive hits	4053	18.9%
Negative hits	2658	12.4%
Cache misses	36	0.2%
TOTAL: 4	21423	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.098	0.0%	108	0.000	0.907	4.000
article cleanup	00:00:00.119	0.0%	14909	0.000	0.008	0.043
article logging	00:00:00.407	0.0%	15295	0.000	0.027	0.104
article parse	00:00:00.238	0.0%	17322	0.000	0.014	0.075
article write	00:00:08.025	0.0%	14045	0.254	0.571	2.398
artlog/artcncl	00:00:00.003	0.0%	107	0.000	0.028	0.200
data move	00:00:00.042	0.0%	24588	0.000	0.002	0.016
hisgrep/artcncl	00:00:00.016	0.0%	93	0.000	0.172	2.000
hishave/artcncl	00:00:00.012	0.0%	108	0.000	0.111	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.761	0.0%	21408	0.019	0.222	0.848
history sync	00:00:00.027	0.0%	403	0.000	0.067	0.667
history write	00:00:04.459	0.0%	14712	0.062	0.303	0.933
hiswrite/artcncl	00:00:00.004	0.0%	15	0.000	0.267	1.000
idle	23:00:14.742	95.8%	23399	1765.292	3539.243	12606.234
nntp read	00:00:00.417	0.0%	22969	0.000	0.018	0.057
overview write	00:00:02.399	0.0%	14045	0.022	0.171	1.674
perl filter	01:00:38.486	4.2%	14712	125.367	247.314	527.673
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.314	0.0%	14083	0.000	0.022	0.074
TOTAL: 24:01:19.108	24:01:14.569	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.024	0.0%	14031	0.000	0.002	0.021
article prepare	00:00:00.005	0.0%	37912	0.000	0.000	0.004
article read	00:00:00.474	0.0%	9477	0.000	0.050	1.429
backlog stats	00:00:00.015	0.0%	73054	0.000	0.000	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.283	0.0%	39869	0.000	0.007	0.028
data write	00:00:00.521	0.0%	25986	0.000	0.020	0.060
idle	23:58:27.953	100.0%	73054	582.487	1181.427	2886.163
status file	00:00:00.107	0.0%	225	0.000	0.476	9.000
TOTAL: 23:58:30.191	23:58:29.382	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:16:06.974	86.2%	16192	0.750	59.719	52225.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:01:41.849	9.1%	97100	0.000	1.049	2.314
readart	00:00:02.070	0.2%	557	2.500	3.716	33.000
TOTAL: 00:18:42.155	00:17:50.893	95.4%	-	-	-	-

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	4	13829	13370	26	433	96%	24:34:54
2	novabbs	279	4178	592	3187	399	14%	18:16:59
3	localhost	32	1	1	0	0	100%	00:00:12
TOTAL: 3		315	18008	13963	3213	832	77%	42:52:05

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn	39.4 MB	237.2 KB	1.4 MB	41.0 MB	96%	3.0 KB
2	novabbs	1.1 MB	399.1 KB	984.9 KB	2.5 MB	45%	2.5 KB
3	localhost	1.4 KB	0.0 KB	0.0 KB	1.4 KB	100%	1.4 KB
TOTAL: 3		40.5 MB	636.2 KB	2.3 MB	43.5 MB	93%	3.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 15 04:15:09 - 04:59:59	192	1.4%	0.07	633.3 KB	1.5%	0.24
Sep 15 05:00:00 - 05:59:59	296	2.1%	0.08	987.4 KB	2.4%	0.27
Sep 15 06:00:00 - 06:59:59	478	3.4%	0.13	1.4 MB	3.4%	0.39
Sep 15 07:00:00 - 07:59:59	528	3.8%	0.15	1.4 MB	3.5%	0.41
Sep 15 08:00:00 - 08:59:59	568	4.0%	0.16	1.3 MB	3.1%	0.36
Sep 15 09:00:00 - 09:59:59	693	4.9%	0.19	2.0 MB	4.9%	0.56
Sep 15 10:00:00 - 10:59:59	663	4.7%	0.18	1.7 MB	4.1%	0.48
Sep 15 11:00:00 - 11:59:59	704	5.0%	0.20	1.7 MB	4.1%	0.48
Sep 15 12:00:00 - 12:59:59	635	4.5%	0.18	1.8 MB	4.5%	0.52
Sep 15 13:00:00 - 13:59:59	705	5.0%	0.20	1.9 MB	4.7%	0.55
Sep 15 14:00:00 - 14:59:59	713	5.1%	0.20	2.0 MB	4.9%	0.56
Sep 15 15:00:00 - 15:59:59	866	6.2%	0.24	2.4 MB	5.8%	0.67
Sep 15 16:00:00 - 16:59:59	738	5.3%	0.20	2.4 MB	6.0%	0.70
Sep 15 17:00:00 - 17:59:59	727	5.2%	0.20	2.1 MB	5.1%	0.59
Sep 15 18:00:00 - 18:59:59	791	5.6%	0.22	2.1 MB	5.1%	0.59
Sep 15 19:00:00 - 19:59:59	859	6.1%	0.24	2.5 MB	6.1%	0.70
Sep 15 20:00:00 - 20:59:59	834	5.9%	0.23	2.7 MB	6.6%	0.77
Sep 15 21:00:00 - 21:59:59	733	5.2%	0.20	2.2 MB	5.5%	0.63
Sep 15 22:00:00 - 22:59:59	503	3.6%	0.14	1.6 MB	3.9%	0.45
Sep 15 23:00:00 - 23:59:59	411	2.9%	0.11	1.7 MB	4.2%	0.48
Sep 16 00:00:00 - 00:59:59	375	2.7%	0.10	1.2 MB	3.0%	0.35
Sep 16 01:00:00 - 01:59:59	371	2.6%	0.10	1.2 MB	3.0%	0.34
Sep 16 02:00:00 - 02:59:59	313	2.2%	0.09	948.8 KB	2.3%	0.26
Sep 16 03:00:00 - 03:59:59	258	1.8%	0.07	702.8 KB	1.7%	0.20
Sep 16 04:00:00 - 04:15:01	76	0.5%	0.08	326.9 KB	0.8%	0.36
TOTAL: 23:59:52	14030	100.0%	0.16	40.8 MB	100.0%	0.48

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	i2pn	764	15	63	686
2	novabbs	488	0	134	354
TOTAL: 2		1252	15	197	1040

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.pl.nieruchomosci.gielda	11
spline.test	1
it-alt.fan.bud-e-terence	1
hk.politics	1
alt.rec.guns	1
TOTAL: 5	15

INND Perl filter [Top 20]:

Reason	Count
Exceeds Spam Level	337
EMP (phn path)	294
Poison newsgroup	23
HTML Image Tags	1
TOTAL: 4	655

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn	326
	novabbs	59
	TOTAL: 2	385
TOTAL: 1		385

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	novabbs	16322	9412	3924	68	8	57%	23:59:50
2	i2pn	631	1	625	0	0	0%	19:13:20
TOTAL: 2		16953	9413	4549	68	8	55%	43:13:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	24.7 MB	206.1 KB	24.9 MB	0.3 KB/s	2.7 KB	23:59:50
2	i2pn	1.4 KB	0.0 KB	1.4 KB	0.0 KB/s	1.4 KB	19:13:20
TOTAL: 2		24.7 MB	206.1 KB	24.9 MB	0.2 KB/s	2.7 KB	43:13:10

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	novabbs	286	557	1.6 MB	523	0	0	00:18:24
TOTAL: 1		286	557	1.6 MB	534	0	0	00:18:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	?	286	557	1.6 MB	523	00:18:24
2	unresolved	1	0	0.0 KB	0	00:00:09
3	*.org	7	0	0.0 KB	0	00:00:06
TOTAL: 3		294	557	1.6 MB	534	00:18:40

NNRP auth users [Top 20]:

User	Conn
retrobbs1	285
TOTAL: 1	285

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
novabbs	41.884	6.544	0.676	00:18:24
159.203.201.214	0.036	0.008	0.000	00:00:09
i2pn2.org	0.700	0.140	0.015	00:00:06
TOTAL: 3	42.620	6.692	0.691	00:18:40

Curious NNRP server explorers [Top 20]:

System	Conn
i2pn2.org	7
159.203.201.214	1
TOTAL: 2	8

NNRP unrecognized commands (by host):

System	Conn
novabbs	18
TOTAL: 1	18

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	6
Host: wwcqkwfo5yhe6uribv5tzylk25j5hkdk6g...	4
User-Agent: MYOB/6.66 (AN/ON)	2
Host: news-i2pn.i2p	2
Accept-Encoding: identity	1
sentry-trace: 00-009cf145f8ae4307a6f2643...	1
Accept-Encoding: gzip, deflate	1
Connection: close	1
TOTAL: 8	18

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	522	88.9%
2	rocksolid	39	6.6%
3	alt	24	4.1%
4	news	2	0.3%
TOTAL: 4		587	100.0%

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

Newsgroup		Count
1	comp.lang.c	522
2	rocksolid.nodes	36
3	alt.arts.poetry.comments	20
4	alt.checkmate	3
5	rocksolid.nodes.announce	3
6	news.admin.net-abuse.misc	1
7	news.admin.hierarchies	1
8	alt.test	1
TOTAL: 8		587

Daily Usenet report

Sep 15 04:15:09 -- Sep 16 04:15:01