Daily Usenet report: Oct 5 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	43623	65.9%	3.9 MB	65.9%
inn	15416	23.3%	1.3 MB	21.5%
innd	6107	9.2%	647.3 KB	10.7%
innfeed	989	1.5%	110.8 KB	1.8%
nocem	51	0.1%	4.4 KB	0.1%
controlchan	12	0.0%	2.2 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 7	66199	100.0%	5.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	14787	64.4%
Positive hits	4186	18.2%
Negative hits	3969	17.3%
Cache misses	15	0.1%
TOTAL: 4	22957	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.055	0.0%	80	0.000	0.688	2.500
article cleanup	00:00:00.099	0.0%	15025	0.000	0.007	0.050
article logging	00:00:00.382	0.0%	15347	0.000	0.025	0.078
article parse	00:00:00.209	0.0%	17006	0.000	0.012	0.051
article write	00:00:07.943	0.0%	13793	0.227	0.576	2.273
artlog/artcncl	00:00:00.001	0.0%	79	0.000	0.013	0.250
data move	00:00:00.022	0.0%	24596	0.000	0.001	0.019
hisgrep/artcncl	00:00:00.003	0.0%	47	0.000	0.064	1.000
hishave/artcncl	00:00:00.011	0.0%	80	0.000	0.138	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.388	0.0%	22959	0.010	0.191	1.588
history sync	00:00:00.027	0.0%	410	0.000	0.066	0.667
history write	00:00:04.303	0.0%	14785	0.050	0.291	0.895
hiswrite/artcncl	00:00:00.005	0.0%	33	0.000	0.152	1.000
idle	23:05:43.213	96.1%	25893	1514.433	3211.031	8475.929
nntp read	00:00:00.365	0.0%	24102	0.000	0.015	0.036
overview write	00:00:02.255	0.0%	13793	0.036	0.163	1.717
perl filter	00:55:08.520	3.8%	14785	79.078	223.775	565.372
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.252	0.0%	13839	0.000	0.018	0.091
TOTAL: 24:01:17.057	24:01:12.053	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.021	0.0%	13778	0.000	0.002	0.029
article prepare	00:00:00.002	0.0%	38984	0.000	0.000	0.004
article read	00:00:00.441	0.0%	9746	0.000	0.045	2.136
backlog stats	00:00:00.025	0.0%	71180	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.273	0.0%	38865	0.000	0.007	0.031
data write	00:00:00.442	0.0%	25205	0.000	0.018	0.068
idle	23:58:56.854	100.0%	71180	644.977	1212.937	4416.199
status file	00:00:00.132	0.0%	296	0.000	0.446	2.000
TOTAL: 23:58:58.938	23:58:58.190	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	06:13:59.662	98.4%	36456	1.000	615.527	57078.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.065	0.0%	100383	0.000	0.011	1.000
readart	00:00:02.408	0.0%	415	2.400	5.802	32.000
TOTAL: 06:20:06.581	06:14:03.135	98.4%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
moderator@dana.de	0	0	1	1	0	1
TOTAL	0	0	1	1	0	1

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	i2pn	14	14102	13449	92	561	95%	25:46:32
2	novabbs	979	5881	352	4755	774	5%	31:39:46
3	localhost	29	0	0	0	0	0%	00:00:10
TOTAL: 3		1022	19983	13801	4847	1335	69%	57:26:28

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn	37.4 MB	325.1 KB	2.3 MB	40.0 MB	93%	2.9 KB
2	novabbs	926.7 KB	523.3 KB	1.9 MB	3.3 MB	27%	3.0 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		38.3 MB	848.4 KB	4.2 MB	43.3 MB	88%	2.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 5 04:15:01 - 04:59:59	181	1.3%	0.07	704.2 KB	1.8%	0.26
Oct 5 05:00:00 - 05:59:59	296	2.1%	0.08	836.7 KB	2.1%	0.23
Oct 5 06:00:00 - 06:59:59	359	2.6%	0.10	1.0 MB	2.7%	0.30
Oct 5 07:00:00 - 07:59:59	534	3.9%	0.15	1.3 MB	3.4%	0.37
Oct 5 08:00:00 - 08:59:59	545	4.0%	0.15	1.5 MB	3.9%	0.43
Oct 5 09:00:00 - 09:59:59	672	4.9%	0.19	1.9 MB	4.8%	0.53
Oct 5 10:00:00 - 10:59:59	716	5.2%	0.20	1.9 MB	4.8%	0.53
Oct 5 11:00:00 - 11:59:59	701	5.1%	0.19	1.7 MB	4.5%	0.49
Oct 5 12:00:00 - 12:59:59	673	4.9%	0.19	1.8 MB	4.7%	0.51
Oct 5 13:00:00 - 13:59:59	674	4.9%	0.19	1.9 MB	4.9%	0.54
Oct 5 14:00:00 - 14:59:59	757	5.5%	0.21	2.0 MB	5.2%	0.56
Oct 5 15:00:00 - 15:59:59	732	5.3%	0.20	1.9 MB	5.0%	0.55
Oct 5 16:00:00 - 16:59:59	789	5.7%	0.22	2.1 MB	5.6%	0.61
Oct 5 17:00:00 - 17:59:59	763	5.5%	0.21	2.0 MB	5.1%	0.56
Oct 5 18:00:00 - 18:59:59	817	5.9%	0.23	2.2 MB	5.8%	0.63
Oct 5 19:00:00 - 19:59:59	927	6.7%	0.26	2.5 MB	6.5%	0.71
Oct 5 20:00:00 - 20:59:59	696	5.0%	0.19	2.1 MB	5.6%	0.61
Oct 5 21:00:00 - 21:59:59	646	4.7%	0.18	1.8 MB	4.7%	0.52
Oct 5 22:00:00 - 22:59:59	480	3.5%	0.13	1.3 MB	3.3%	0.36
Oct 5 23:00:00 - 23:59:59	421	3.1%	0.12	1.3 MB	3.5%	0.38
Oct 6 00:00:00 - 00:59:59	371	2.7%	0.10	1.2 MB	3.1%	0.34
Oct 6 01:00:00 - 01:59:59	501	3.6%	0.14	1.5 MB	3.9%	0.42
Oct 6 02:00:00 - 02:59:59	265	1.9%	0.07	972.3 KB	2.5%	0.27
Oct 6 03:00:00 - 03:59:59	200	1.5%	0.06	662.9 KB	1.7%	0.18
Oct 6 04:00:00 - 04:15:01	67	0.5%	0.07	339.9 KB	0.9%	0.38
TOTAL: 24:00:00	13783	100.0%	0.16	38.4 MB	100.0%	0.45

Sites sending bad articles:

Server		Total	Duplic	Other
1	i2pn	878	94	784
2	novabbs	677	147	530
TOTAL: 2		1555	241	1314

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	448
Exceeds Spam Level	426
EMP (phn nph)	79
Poison newsgroup	39
TOTAL: 4	992

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn	318
	novabbs	4
	TOTAL: 2	322
TOTAL: 1		322

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	novabbs	16299	9624	3726	123	59%	23:59:58
2	i2pn	313	0	308	0	0%	14:47:04
TOTAL: 2		16612	9624	4034	123	57%	38:47:02

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	24.1 MB	332.4 KB	24.4 MB	0.3 KB/s	2.6 KB	23:59:58
2	i2pn	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	14:47:04
TOTAL: 2		24.1 MB	332.4 KB	24.4 MB	0.2 KB/s	2.6 KB	38:47:02

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	novabbs	6622	415	1.1 MB	415	0	0	06:19:39
TOTAL: 1		6622	415	1.1 MB	420	0	0	06:19:48

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	?	6622	415	1.1 MB	415	06:19:39
2	*.security.ipip.net	1	0	0.0 KB	0	00:00:00
3	*.org	28	0	0.0 KB	0	00:00:08
TOTAL: 3		6651	415	1.1 MB	420	06:19:48

NNRP auth users [Top 20]:

User	Conn
retrobbs1	1005
TOTAL: 1	1005

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
novabbs	305.104	37.124	2.467	06:19:39
i2pn2.org	1.456	0.200	0.062	00:00:08
scan-141.security.ipip.net	0.036	0.008	0.000	00:00:00
TOTAL: 3	306.596	37.332	2.529	06:19:48

Curious NNRP server explorers [Top 20]:

System	Conn
i2pn2.org	28
scan-141.security.ipip.net	1
TOTAL: 2	29

NNRP unrecognized commands (by host):

System	Conn
novabbs	22
scan-141.security.ipip.net	4
TOTAL: 2	26

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	9
Host: wwcqkwfo5yhe6uribv5tzylk25j5hkdk6g...	7
User-Agent: MYOB/6.66 (AN/ON)	2
Connection: close	2
Accept-Encoding: gzip, deflate	1
sentry-trace: 00-99ce77f18fc14c8da74a575...	1
User-Agent: HTTP Banner Detection (https...	1
Host: news-i2pn.i2p	1
Accept-Encoding: identity	1
Host: 157.230.63.40:119	1
TOTAL: 10	26

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	379	89.8%
2	rec	33	7.8%
3	news	5	1.2%
4	rocksolid	3	0.7%
5	comp	2	0.5%
TOTAL: 5		422	100.0%

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

Newsgroup		Count
1	alt.arts.poetry.comments	123
2	alt.dreams.castaneda	93
3	alt.lang.asm	76
4	alt.bbs.mystic	69
5	rec.food.cooking	17
6	rec.music.rock-pop-r+b.1950s	9
7	alt.astronomy	8
8	rec.games.backgammon	6
9	alt.usage.english	6
10	news.software.readers	3
11	alt.humor.puns	2
12	comp.lang.forth	2
13	rocksolid.shared.offtopic	2
14	rec.bicycles.tech	1
15	news.software.nntp	1
16	rocksolid.shared.general	1
17	alt.english.usage	1
18	news.admin.hierarchies	1
19	alt.language.latin	1
TOTAL: 19		422

Daily Usenet report

Oct 5 04:15:01 -- Oct 6 04:15:01