Daily Usenet report: Oct 8 04:15:05

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	40152	60.4%	3.6 MB	60.9%
inn	18732	28.2%	1.5 MB	26.0%
innd	6474	9.7%	685.3 KB	11.4%
innfeed	1003	1.5%	94.2 KB	1.6%
nocem	123	0.2%	12.0 KB	0.2%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	66485	100.0%	5.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	17923	66.0%
Positive hits	4962	18.3%
Negative hits	4243	15.6%
Cache misses	17	0.1%
TOTAL: 4	27145	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.050	0.0%	169	0.000	0.296	1.500
article cleanup	00:00:00.137	0.0%	18198	0.000	0.008	0.042
article logging	00:00:00.421	0.0%	18572	0.000	0.023	0.075
article parse	00:00:00.257	0.0%	20458	0.000	0.013	0.063
article write	00:00:09.753	0.0%	16612	0.196	0.587	1.950
artlog/artcncl	00:00:00.003	0.0%	159	0.000	0.019	1.000
data move	00:00:00.037	0.0%	29057	0.000	0.001	0.011
hisgrep/artcncl	00:00:00.006	0.0%	141	0.000	0.043	0.500
hishave/artcncl	00:00:00.002	0.0%	169	0.000	0.012	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:05.270	0.0%	27010	0.020	0.195	1.206
history sync	00:00:00.017	0.0%	305	0.000	0.056	1.000
history write	00:00:06.523	0.0%	17905	0.087	0.364	1.336
hiswrite/artcncl	00:00:00.006	0.0%	28	0.000	0.214	1.000
idle	22:56:55.714	95.6%	30152	1444.890	2739.975	9404.540
nntp read	00:00:00.486	0.0%	28397	0.000	0.017	0.062
overview write	00:00:02.342	0.0%	16612	0.020	0.141	1.931
perl filter	01:02:58.796	4.4%	17905	99.952	211.047	379.958
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.308	0.0%	16725	0.000	0.018	0.073
TOTAL: 24:00:25.972	24:00:20.128	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	16609	0.000	0.002	0.021
article prepare	00:00:00.005	0.0%	47232	0.000	0.000	0.003
article read	00:00:00.500	0.0%	11803	0.000	0.042	2.118
backlog stats	00:00:00.027	0.0%	85944	0.000	0.000	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.321	0.0%	47473	0.000	0.007	0.025
data write	00:00:00.612	0.0%	30977	0.000	0.020	0.061
idle	23:58:40.566	100.0%	85944	568.168	1004.382	3776.145
status file	00:00:00.122	0.0%	293	0.000	0.416	1.000
TOTAL: 23:58:43.088	23:58:42.179	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	18:25:03.759	99.5%	62524	1.000	1060.453	109857.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.124	0.0%	209733	0.000	0.010	0.500
readart	00:00:28.895	0.0%	31171	0.053	0.927	38.000
TOTAL: 18:31:09.902	18:25:34.778	99.5%	-	-	-	-

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	12	16819	16165	63	591	96%	24:52:27
2	novabbs	985	4645	299	3486	860	6%	15:56:41
3	localhost	36	5	5	0	0	100%	00:00:11
TOTAL: 3		1033	21469	16469	3549	1451	76%	40:49:19

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	i2pn	44.0 MB	249.8 KB	1.8 MB	46.1 MB	95%	2.8 KB
2	novabbs	728.2 KB	506.1 KB	1.9 MB	3.1 MB	23%	2.7 KB
3	localhost	61.3 KB	0.0 KB	0.0 KB	61.3 KB	100%	12.3 KB
TOTAL: 3		44.8 MB	755.9 KB	3.7 MB	49.2 MB	91%	2.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 8 04:15:05 - 04:59:59	163	1.0%	0.06	457.8 KB	1.0%	0.17
Oct 8 05:00:00 - 05:59:59	332	2.0%	0.09	932.0 KB	2.0%	0.26
Oct 8 06:00:00 - 06:59:59	416	2.5%	0.12	1.1 MB	2.4%	0.31
Oct 8 07:00:00 - 07:59:59	666	4.0%	0.18	1.7 MB	3.7%	0.48
Oct 8 08:00:00 - 08:59:59	778	4.7%	0.22	2.0 MB	4.3%	0.56
Oct 8 09:00:00 - 09:59:59	977	5.9%	0.27	2.7 MB	6.0%	0.77
Oct 8 10:00:00 - 10:59:59	871	5.2%	0.24	2.2 MB	4.9%	0.63
Oct 8 11:00:00 - 11:59:59	769	4.6%	0.21	2.0 MB	4.5%	0.57
Oct 8 12:00:00 - 12:59:59	847	5.1%	0.24	2.1 MB	4.7%	0.60
Oct 8 13:00:00 - 13:59:59	867	5.2%	0.24	2.3 MB	5.1%	0.66
Oct 8 14:00:00 - 14:59:59	935	5.6%	0.26	2.4 MB	5.2%	0.67
Oct 8 15:00:00 - 15:59:59	955	5.7%	0.27	2.6 MB	5.7%	0.73
Oct 8 16:00:00 - 16:59:59	948	5.7%	0.26	2.5 MB	5.6%	0.71
Oct 8 17:00:00 - 17:59:59	892	5.4%	0.25	2.4 MB	5.4%	0.69
Oct 8 18:00:00 - 18:59:59	1009	6.1%	0.28	2.5 MB	5.6%	0.72
Oct 8 19:00:00 - 19:59:59	858	5.2%	0.24	2.4 MB	5.3%	0.68
Oct 8 20:00:00 - 20:59:59	824	5.0%	0.23	2.6 MB	5.8%	0.74
Oct 8 21:00:00 - 21:59:59	805	4.8%	0.22	2.2 MB	5.0%	0.64
Oct 8 22:00:00 - 22:59:59	615	3.7%	0.17	1.7 MB	3.8%	0.49
Oct 8 23:00:00 - 23:59:59	543	3.3%	0.15	1.6 MB	3.5%	0.44
Oct 9 00:00:00 - 00:59:59	435	2.6%	0.12	1.5 MB	3.2%	0.41
Oct 9 01:00:00 - 01:59:59	409	2.5%	0.11	1.3 MB	2.8%	0.36
Oct 9 02:00:00 - 02:59:59	362	2.2%	0.10	1007.5 KB	2.2%	0.28
Oct 9 03:00:00 - 03:59:59	293	1.8%	0.08	887.2 KB	1.9%	0.25
Oct 9 04:00:00 - 04:15:01	45	0.3%	0.05	148.0 KB	0.3%	0.16
TOTAL: 23:59:56	16614	100.0%	0.19	45.2 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	novabbs	993	0	209	784
2	i2pn	966	2	84	880
TOTAL: 2		1959	2	293	1664

Unwanted newsgroups [Top 20]:

Newsgroup	Count
24hoursupport.helpdesk	1
hk.politics	1
TOTAL: 2	2

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	735
Exceeds Spam Level	434
Poison newsgroup	76
EMP (phn nph)	32
EMP (phl)	8
HTML Image Tags	3
Binary Image: misplaced jpg	1
EMP (md5)	1
TOTAL: 8	1290

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	50	0	56	56
TOTAL: 1	50	66	56	56

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	i2pn	370
	novabbs	4
	TOTAL: 2	374
TOTAL: 1		374

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	novabbs	19684	11630	4456	174	3	59%	23:58:56
2	i2pn	360	6	350	0	0	1%	16:20:07
TOTAL: 2		20044	11636	4806	174	3	58%	40:19:03

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	novabbs	29.7 MB	346.7 KB	30.1 MB	0.4 KB/s	2.6 KB	23:58:56
2	i2pn	62.5 KB	0.0 KB	62.5 KB	0.0 KB/s	10.4 KB	16:20:07
TOTAL: 2		29.8 MB	346.7 KB	30.1 MB	0.2 KB/s	2.6 KB	40:19:03

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	novabbs	5873	28736	104.1 MB	304	5	8	18:27:48
2	i2pn2.org	54	5	7.2 KB	5	0	0	00:00:09
TOTAL: 2		5927	28741	104.1 MB	317	5	8	18:30:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	?	5873	28736	104.1 MB	304	5	8	18:27:48
2	*.org	54	5	7.2 KB	5	0	0	00:00:09
3	*.dip0.t-ipconnect.de	1	0	0.0 KB	0	0	0	00:00:10
4	*.static.tpgi.com.au	1	0	0.0 KB	0	0	0	00:00:34
5	*.static.otenet.gr	1	0	0.0 KB	0	0	0	00:00:32
6	*.sfj.corp.censys.io	2	0	0.0 KB	0	0	0	00:00:00
7	unresolved	3	0	0.0 KB	0	0	0	00:01:36
TOTAL: 7		5935	28741	104.1 MB	317	5	8	18:30:53

NNRP auth users [Top 20]:

User	Conn
retrobbs1	1037
def.i2p	39
Kerry	2
TOTAL: 3	1078

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
novabbs	280.620	40.304	2.396	18:27:48
60-242-78-216.static.tpgi.com.au	0.040	0.004	0.000	00:00:34
ohdjrw.static.otenet.gr	0.044	0.004	0.000	00:00:32
131.100.151.5	0.032	0.012	0.000	00:00:32
49.213.189.67	0.032	0.012	0.000	00:00:32
82.79.161.158	0.044	0.000	0.000	00:00:31
p54b90b05.dip0.t-ipconnect.de	0.040	0.004	0.000	00:00:10
i2pn2.org	2.684	0.308	0.121	00:00:09
worker-18.sfj.corp.censys.io	0.084	0.004	0.000	00:00:00
TOTAL: 9	283.620	40.652	2.517	18:30:53

Curious NNRP server explorers [Top 20]:

System	Conn
worker-18.sfj.corp.censys.io	2
131.100.151.5	1
49.213.189.67	1
ohdjrw.static.otenet.gr	1
p54b90b05.dip0.t-ipconnect.de	1
60-242-78-216.static.tpgi.com.au	1
82.79.161.158	1
TOTAL: 7	8

NNRP unrecognized commands (by host):

System	Conn
novabbs	26
49.213.189.67	10
131.100.151.5	10
82.79.161.158	10
60-242-78-216.static.tpgi.com.au	10
ohdjrw.static.otenet.gr	10
TOTAL: 6	76

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	8
Host: wwcqkwfo5yhe6uribv5tzylk25j5hkdk6g...	6
Accept-Encoding: identity	6
Connection: close	6
User-Agent: ApiTool	5
Accept: /	5
Authorization: Basic YWRtaW46ezEyMjEzQkQ...	5
Content-Type: text/xml	5
Accept-Language: en-us	5
Content-Length: 586	5
Cache-Control: max-age=0	5
Host: 157.230.63.40	3
User-Agent: MYOB/6.66 (AN/ON)	3
Host: news-i2pn.i2p	2
Accept-Encoding: gzip, deflate, bz	1
Host: 154.204.47.187	1
Host: 66.45.153.217	1
Accept-Encoding: gzip, deflate	1
Upgrade-Insecure-Requests: 1	1
DNT: 1	1
sentry-trace: 00-26367f6f8234459ca53ab2b...	1
TOTAL: 21	76

NNRP client timeouts [Top 20]:

System	Conn	Peer
worker-18.sfj.corp.censys.io	2	2
TOTAL: 1	2	2

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	24784	86.2%
2	alt	3762	13.1%
3	rec	168	0.6%
4	rocksolid	44	0.2%
5	news	1	0.0%
TOTAL: 5		28759	100.0%

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

Newsgroup		Count
1	comp.lang.python	12085
2	comp.lang.c	5405
3	comp.lang.c++	4891
4	alt.global-warming	1717
5	comp.lang.ada	1388
6	alt.test	1235
7	comp.lang.misc	968
8	alt.bbs.mystic	410
9	rec.food.cooking	81
10	alt.computer.security	81
11	alt.ascii-art	74
12	alt.censorship	74
13	alt.anonymous	42
14	alt.usage.english	30
15	comp.lang.asm.x86	25
16	rec.crafts.metalworking	22
17	alt.bbs.allsysop	22
18	comp.lang.lisp	18
19	rec.music.rock-pop-r+b.1950s	16
20	alt.bbs.lists	15
21	alt.bittorrent	14
22	rec.games.backgammon	14
23	rocksolid.shared.test	13
24	alt.free.newsservers	10
25	rec.audio.pro	10
26	alt.tv.survivor	10
27	rec.gambling.lottery	9
28	rocksolid.nodes	8
29	alt.activism	7
30	rocksolid.shared.helpdesk	7
31	rec.games.pinball	7
32	alt.apache.configuration	6
33	rocksolid.shared.hacking	6
34	alt.privacy.anon-server	6
35	rocksolid.shared.rocksolid	5
36	rec.arts.comics.strips	4
37	alt.obituaries	3
38	rocksolid.shared.entertainment	3
39	rec.aviation.soaring	2
40	alt.language.latin	2
41	comp.lang.forth	2
42	rocksolid.shared.news	1
43	comp.lang.postscript	1
44	alt.food.wine	1
45	rec.arts.books	1
46	rec.arts.animation	1
47	alt.anarchism	1
48	alt.food.fast-food	1
49	rec.games.bridge	1
50	rocksolid.shared.tor	1
51	comp.lang.apl	1
52	news.admin.net-abuse.email	1
53	alt.horror	1
TOTAL: 53		28759

Daily Usenet report

Oct 8 04:15:05 -- Oct 9 04:15:01