Daily Usenet report for csiph.com: May 6 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	70376	58.7%	6.9 MB	44.9%
inn	29385	24.5%	6.0 MB	39.1%
innd	16847	14.0%	1.9 MB	12.6%
innfeed	3245	2.7%	530.6 KB	3.4%
nocem	58	0.0%	6.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	119912	100.0%	15.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	324829	55.7%
Negative hits	229114	39.3%
Do not exist	28689	4.9%
Cache misses	328	0.1%
TOTAL: 4	582960	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.127	0.0%	190	0.000	5.932	53.400
article cleanup	00:00:00.224	0.0%	28115	0.000	0.008	0.038
article logging	00:00:05.972	0.0%	28533	0.000	0.209	3.320
article parse	00:00:09.072	0.0%	88894	0.000	0.102	1.444
article write	00:03:28.178	0.2%	18690	0.173	11.138	74.336
artlog/artcncl	00:00:00.034	0.0%	142	0.000	0.239	8.500
artlog/artparse	00:00:00.613	0.0%	755	0.000	0.812	16.273
data move	00:00:00.292	0.0%	565159	0.000	0.001	0.031
hisgrep/artcncl	00:00:00.321	0.0%	190	0.000	1.689	31.000
hishave/artcncl	00:00:00.141	0.0%	190	0.000	0.742	13.700
hishave/artparse	00:00:00.004	0.0%	755	0.000	0.005	0.125
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:59.340	0.2%	586038	0.001	0.306	1.915
history sync	00:00:04.929	0.0%	358	0.000	13.768	134.000
history write	00:04:39.192	0.3%	28113	0.517	9.931	72.233
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:07.220	0.0%	755	0.000	9.563	119.000
idle	23:38:10.369	98.4%	550500	89.631	154.569	471.112
nntp read	00:00:02.784	0.0%	576845	0.002	0.005	0.014
overview write	00:08:18.785	0.6%	18690	0.585	26.687	273.452
perl filter	00:01:01.190	0.1%	28113	1.529	2.177	3.956
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.365	0.0%	37428	0.000	0.010	0.034
TOTAL: 24:00:58.073	23:59:10.152	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.053	0.0%	18650	0.000	0.003	0.019
article prepare	00:00:00.004	0.0%	24184	0.000	0.000	0.009
article read	00:00:02.329	0.0%	3723	0.000	0.626	42.000
backlog stats	00:00:00.194	0.0%	333574	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.781	0.0%	260267	0.001	0.007	0.014
data write	00:00:01.531	0.0%	245535	0.002	0.006	0.012
idle	23:55:19.180	100.0%	333574	142.824	258.171	714.358
status file	00:00:00.553	0.0%	287	0.000	1.927	62.000
TOTAL: 23:55:34.008	23:55:25.625	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.455	0.0%	1328	1.096	1.096	1.096
idle	22:32:57.999	99.5%	78390	79.214	1035.566	600147.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.880	0.0%	157677	0.000	0.006	0.143
readart	00:02:30.782	0.2%	8788	0.000	17.158	321.000
TOTAL: 22:40:09.442	22:35:31.116	99.7%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	139
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	159

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	3	37072	5657	30697	718	15%	47:00:55
2	csiph-out.feeder.erje.net	1440	112892	3763	103341	5788	3%	118:49:34
3	feeder.eternal-september.org	6	24162	2372	20698	1092	9%	25:03:49
4	news-out.aioe.org	2	17278	1583	15586	109	9%	24:09:56
5	news-out.mixmin.net	2	20273	1535	18297	441	7%	24:08:55
6	newsfeed.neva.ru	142	25935	880	23742	1313	3%	71:45:38
7	newsfeed.fu-berlin.de	18	19151	867	17955	329	4%	27:13:11
8	newsfeeds.xmission.com	2	17562	837	16722	3	4%	24:14:46
9	news.redatomik.org	1	24771	527	24244	0	2%	30:52:30
10	news.freedyn.net	3	20808	399	20067	342	1%	24:08:55
11	news.fcku.it	2	7258	154	7054	50	2%	23:59:35
12	xanadu-bbs.net	18	658	142	514	2	21%	22:55:53
13	nntp.pasdenom.info	2	17424	110	17312	2	0%	23:58:53
14	news.swapon.de	3	1652	24	1628	0	1%	24:49:39
15	localhost	40	4	4	0	0	100%	00:00:12
16	news.bbs.geek.nz	2	18657	0	18657	0	0%	23:59:32
TOTAL: 16		1686	365557	18854	336514	10189	5%	537:11:53

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	16.4 MB	1.0 KB	49.7 MB	66.1 MB	24%	7.1 KB
2	csiph-out.news.weretis.net	16.4 MB	0.0 KB	10.0 MB	26.4 MB	62%	4.2 KB
3	feeder.eternal-september.org	6.6 MB	0.0 KB	10.5 MB	17.1 MB	38%	5.1 KB
4	news-out.mixmin.net	5.9 MB	0.0 KB	1.4 MB	7.3 MB	80%	3.8 KB
5	news-out.aioe.org	3.9 MB	0.0 KB	216.7 KB	4.1 MB	94%	2.5 KB
6	newsfeeds.xmission.com	2.6 MB	0.0 KB	126.4 KB	2.7 MB	95%	3.3 KB
7	newsfeed.neva.ru	1.9 MB	1.7 KB	5.4 MB	7.3 MB	26%	3.4 KB
8	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	1.0 MB	3.0 MB	64%	2.5 KB
9	news.freedyn.net	1.5 MB	0.0 KB	11.7 MB	13.2 MB	11%	18.2 KB
10	news.redatomik.org	1.4 MB	0.0 KB	0.0 KB	1.4 MB	100%	2.7 KB
11	xanadu-bbs.net	575.0 KB	0.0 KB	12.1 KB	587.1 KB	97%	4.1 KB
12	news.fcku.it	299.3 KB	0.0 KB	1016.3 KB	1.3 MB	22%	6.4 KB
13	nntp.pasdenom.info	243.8 KB	0.0 KB	5.1 KB	248.9 KB	97%	2.2 KB
14	news.swapon.de	67.3 KB	0.0 KB	0.0 KB	67.3 KB	100%	2.8 KB
15	localhost	15.6 KB	0.0 KB	0.0 KB	15.6 KB	100%	3.9 KB
16	news.bbs.geek.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		59.7 MB	2.7 KB	91.0 MB	150.7 MB	39%	5.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 6 04:15:00 - 04:59:59	301	1.6%	0.11	890.9 KB	1.5%	0.33
May 6 05:00:00 - 05:59:59	463	2.5%	0.13	1.8 MB	3.1%	0.52
May 6 06:00:00 - 06:59:59	501	2.7%	0.14	1.5 MB	2.6%	0.44
May 6 07:00:00 - 07:59:59	895	4.8%	0.25	3.5 MB	5.8%	0.98
May 6 08:00:00 - 08:59:59	915	4.9%	0.25	2.8 MB	4.8%	0.80
May 6 09:00:00 - 09:59:59	731	3.9%	0.20	2.5 MB	4.3%	0.72
May 6 10:00:00 - 10:59:59	791	4.2%	0.22	2.4 MB	4.1%	0.69
May 6 11:00:00 - 11:59:59	805	4.3%	0.22	1.9 MB	3.2%	0.54
May 6 12:00:00 - 12:59:59	855	4.6%	0.24	2.7 MB	4.5%	0.76
May 6 13:00:00 - 13:59:59	1063	5.7%	0.30	3.7 MB	6.2%	1.05
May 6 14:00:00 - 14:59:59	1005	5.4%	0.28	3.7 MB	6.3%	1.06
May 6 15:00:00 - 15:59:59	1182	6.3%	0.33	3.6 MB	6.0%	1.01
May 6 16:00:00 - 16:59:59	1003	5.4%	0.28	3.9 MB	6.6%	1.12
May 6 17:00:00 - 17:59:59	1077	5.8%	0.30	2.8 MB	4.8%	0.81
May 6 18:00:00 - 18:59:59	1104	5.9%	0.31	3.4 MB	5.8%	0.97
May 6 19:00:00 - 19:59:59	1042	5.6%	0.29	3.2 MB	5.3%	0.90
May 6 20:00:00 - 20:59:59	885	4.7%	0.25	2.5 MB	4.2%	0.70
May 6 21:00:00 - 21:59:59	839	4.5%	0.23	2.4 MB	4.0%	0.68
May 6 22:00:00 - 22:59:59	698	3.7%	0.19	2.2 MB	3.8%	0.63
May 6 23:00:00 - 23:59:59	543	2.9%	0.15	1.6 MB	2.6%	0.44
May 7 00:00:00 - 00:59:59	473	2.5%	0.13	1.4 MB	2.3%	0.39
May 7 01:00:00 - 01:59:59	622	3.3%	0.17	1.8 MB	3.1%	0.52
May 7 02:00:00 - 02:59:59	396	2.1%	0.11	1.4 MB	2.3%	0.39
May 7 03:00:00 - 03:59:59	369	2.0%	0.10	1.3 MB	2.2%	0.37
May 7 04:00:00 - 04:15:00	113	0.6%	0.13	343.4 KB	0.6%	0.38
TOTAL: 24:00:00	18671	100.0%	0.22	59.2 MB	100.0%	0.70

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	5839	122	1	5716
2	newsfeed.neva.ru	1320	209	1	1110
3	feeder.eternal-september.org	1075	51	0	1024
4	csiph-out.news.weretis.net	771	176	0	595
5	newsfeed.fu-berlin.de	584	30	0	554
6	news-out.mixmin.net	479	0	0	479
7	news.freedyn.net	341	17	0	324
8	news-out.aioe.org	107	41	0	66
9	news.fcku.it	53	0	0	53
10	nntp.pasdenom.info	2	1	0	1
11	newsfeeds.xmission.com	2	0	0	2
12	xanadu-bbs.net	2	0	0	2
13	news.swapon.de	1	0	0	1
14	news.redatomik.org	1	0	0	1
TOTAL: 14		10577	647	2	9928

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.sport.calcio.juventus	85
ut.test	82
lada.talk	68
alt.survival	40
lada.commerce	38
mpc.lists.freebsd.ports.bugs	36
lada.auto	26
lada.mobile	15
mozilla.support.thunderbird	15
cakewalk.audio	14
alt.personals.ad	14
alt.windows7.general	12
alt.politics	11
mozilla.support.seamonkey	11
lada.photo	11
spline.eisfair	10
mozilla.support.firefox	9
mozilla.dev.l10n	7
gmane.comp.gis.openstreetmap.tagging	6
mpc.lists.freebsd.gnome	6
TOTAL: 91	647

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	7720
EMP (phn path)	721
EMP (phl)	88
EMP (phn nph)	55
Too many newsgroups	46
User-issued cancel	38
Binary Payload	22
Scoring filter (10)	15
Scoring filter (8)	15
Scoring filter (9)	14
HTML Multipart	13
HTML post	9
Scoring filter (14)	2
Scoring filter (15)	2
Scoring filter (13)	2
Too many newsgroups (low_xpost)	1
Angle-bracket bot	1
Scoring filter (11)	1
Scoring filter (12)	1
HTML Image Tags	1
TOTAL: 20	8767

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	48	0	49	49
TOTAL: 1	48	0	49	49

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.feeder.erje.net	549
	news.freedyn.net	86
	csiph-out.news.weretis.net	81
	feeder.eternal-september.org	14
	news-out.mixmin.net	8
	newsfeed.fu-berlin.de	6
	newsfeeds.xmission.com	1
	TOTAL: 7	745
Including strange strings
	newsfeed.fu-berlin.de	276
	csiph-out.feeder.erje.net	52
	csiph-out.news.weretis.net	42
	news-out.mixmin.net	31
	newsfeed.neva.ru	7
	feeder.eternal-september.org	3
	news-out.aioe.org	2
	news.fcku.it	1
	news.swapon.de	1
	news.redatomik.org	1
	TOTAL: 10	416
TOTAL: 2		1161

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	32583	1916	16014	42	0	5%	23:59:46
2	news.freedyn.net	18817	783	17479	10	0	4%	23:59:55
3	xanadu-bbs	19216	736	17791	1	0	3%	23:59:55
4	fu-berlin.de	17643	585	17057	0	0	3%	23:59:55
5	usenet.pasdenom.info	20162	153	16716	1688	13	0%	23:59:52
6	news.redatomik.org	17982	26	17542	1	0	0%	23:59:55
7	erje	14932	20	14785	20	0	0%	23:59:55
8	aioe	16474	15	15737	3	0	0%	23:59:47
9	xmission	18144	10	17133	0	0	0%	23:59:54
10	news.mixmin.net	16735	10	16273	0	0	0%	23:59:55
11	weretis.net	11970	6	11897	0	0	0%	23:59:43
12	news.swapon.de	1705	6	1675	0	0	0%	23:50:02
13	eternal-september	16178	6	15373	0	0	0%	23:59:55
14	neva.ru	17314	3	16901	7	0	0%	23:59:55
15	news.fcku.it	1371	0	1354	0	0	0%	21:40:05
16	au2pb	0	0	0	0	17972	0%	23:58:42
17	bwh	0	0	0	0	17957	0%	23:58:42
TOTAL: 17		241226	4275	213727	1772	35942	1%	405:25:53

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	7.5 MB	25.8 KB	7.5 MB	0.1 KB/s	9.7 KB	23:59:55
2	xanadu-bbs	7.3 MB	5.8 KB	7.3 MB	0.1 KB/s	10.2 KB	23:59:55
3	fu-berlin.de	7.0 MB	0.0 KB	7.0 MB	0.1 KB/s	12.2 KB	23:59:55
4	news.bbs.geek.nz	5.3 MB	200.3 KB	5.5 MB	0.1 KB/s	2.9 KB	23:59:46
5	usenet.pasdenom.info	603.5 KB	8.9 MB	9.5 MB	0.1 KB/s	5.3 KB	23:59:52
6	news.redatomik.org	84.9 KB	1.0 KB	85.8 KB	0.0 KB/s	3.2 KB	23:59:55
7	erje	61.7 KB	81.8 KB	143.5 KB	0.0 KB/s	3.6 KB	23:59:55
8	aioe	44.5 KB	8.1 KB	52.6 KB	0.0 KB/s	2.9 KB	23:59:47
9	news.mixmin.net	35.3 KB	0.0 KB	35.3 KB	0.0 KB/s	3.5 KB	23:59:55
10	xmission	35.2 KB	0.0 KB	35.2 KB	0.0 KB/s	3.5 KB	23:59:54
11	weretis.net	20.3 KB	0.0 KB	20.3 KB	0.0 KB/s	3.4 KB	23:59:43
12	news.swapon.de	19.6 KB	0.0 KB	19.6 KB	0.0 KB/s	3.3 KB	23:50:02
13	eternal-september	18.8 KB	0.0 KB	18.8 KB	0.0 KB/s	3.1 KB	23:59:55
14	neva.ru	10.9 KB	25.9 KB	36.8 KB	0.0 KB/s	3.7 KB	23:59:55
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:40:05
16	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
TOTAL: 17		28.0 MB	9.3 MB	37.2 MB	0.0 KB/s	6.3 KB	405:25:53

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	204-73-239-109.cust.centrio.cz	43	62	172.7 KB	21	4	08:24:30
2	144.138.90.254	288	57	137.2 KB	52	0	03:44:35
3	mtrlpq2314w-lp130-04-70-54-156-183.dsl.bell.ca	2936	1	1.1 KB	1	0	03:59:54
4	dhcp-089-099-203-254.chello.nl	10	1	1.3 KB	1	0	01:30:39
TOTAL: 4		3277	121	312.2 KB	75	4	22:39:43

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.cust.centrio.cz	43	62	172.7 KB	21	4	08:24:30
2	unresolved	288	57	137.2 KB	52	0	03:44:35
3	*.chello.nl	10	1	1.3 KB	1	0	01:30:39
4	*.dsl.bell.ca	2936	1	1.1 KB	1	0	03:59:54
5	*.dhcp.mdsn.wi.charter.com	11	0	0.0 KB	0	0	03:16:22
6	*.census.shodan.io	1	0	0.0 KB	0	0	00:00:10
7	*.103.20.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	0	01:43:31
TOTAL: 7		3290	121	312.2 KB	75	4	22:39:43

NNRP auth users [Top 20]:

User	Conn
moussa	288
ctomczyk	31
TOTAL: 2	319

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
204-73-239-109.cust.centrio.cz	4.017	0.863	0.110	08:24:30
mtrlpq2314w-lp130-04-70-54-156-183.dsl.bell.ca	235.564	44.814	0.000	03:59:54
144.138.90.254	24.434	6.568	1.031	03:44:35
68-185-181-64.dhcp.mdsn.wi.charter.com	0.842	0.133	0.000	03:16:22
h59.103.20.98.dynamic.ip.windstream.net	0.112	0.102	0.000	01:43:31
dhcp-089-099-203-254.chello.nl	0.891	0.172	0.000	01:30:39
sky.census.shodan.io	0.086	0.016	0.000	00:00:10
TOTAL: 7	265.946	52.668	1.141	22:39:43

Curious NNRP server explorers [Top 20]:

System	Conn
68-185-181-64.dhcp.mdsn.wi.charter.com	11
sky.census.shodan.io	1
h59.103.20.98.dynamic.ip.windstream.net	1
TOTAL: 3	13

NNRP client timeouts [Top 20]:

System	Conn	Peer
204-73-239-109.cust.centrio.cz	7	0
68-185-181-64.dhcp.mdsn.wi.charter.com	4	0
h59.103.20.98.dynamic.ip.windstream.net	1	0
TOTAL: 3	12	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	119	98.3%
2	pl	1	0.8%
3	uk	1	0.8%
TOTAL: 3		121	100.0%

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

Newsgroup		Count
1	comp.lang.javascript	61
2	comp.arch	28
3	comp.os.vms	9
4	comp.arch.fpga	6
5	comp.sys.ibm.pc.games.action	4
6	comp.arch.embedded	2
7	comp.sys.ibm.as400.misc	2
8	comp.sys.ibm.ps2.hardware	1
9	comp.windows.x	1
10	comp.sys.ibm.pc.hardware.chips	1
11	comp.sys.ibm.pc.games.adventure	1
12	comp.os.msdos.djgpp	1
13	pl.comp.www	1
14	comp.arch.storage	1
15	comp.ai.philosophy	1
16	uk.rec.drugs.cannabis	1
TOTAL: 16		121

Daily Usenet report for csiph.com

May 6 04:15:00 -- May 7 04:15:00