Daily Usenet report for csiph.com: Apr 24 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	25472	51.9%	5.6 MB	66.9%
nnrpd	10893	22.2%	1.1 MB	12.5%
innd	9568	19.5%	1.2 MB	14.3%
innfeed	2965	6.0%	532.1 KB	6.2%
nocem	148	0.3%	16.0 KB	0.2%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	49047	100.0%	8.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	315876	58.9%
Negative hits	195858	36.5%
Do not exist	24249	4.5%
Cache misses	416	0.1%
TOTAL: 4	536399	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.679	0.0%	310	0.000	11.868	189.000
article cleanup	00:00:00.163	0.0%	24183	0.000	0.007	0.031
article logging	00:00:02.787	0.0%	24894	0.000	0.112	2.692
article parse	00:00:01.319	0.0%	60121	0.000	0.022	0.601
article write	00:02:50.947	0.2%	19912	1.753	8.585	46.587
artlog/artcncl	00:00:00.003	0.0%	275	0.000	0.011	0.500
artlog/artparse	00:00:00.006	0.0%	223	0.000	0.027	1.000
data move	00:00:00.153	0.0%	512502	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.015	0.0%	306	0.000	0.049	2.000
hishave/artcncl	00:00:00.003	0.0%	310	0.000	0.010	0.214
hishave/artparse	00:00:00.002	0.0%	223	0.000	0.009	0.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:19.447	0.0%	539105	0.005	0.036	0.237
history sync	00:00:01.595	0.0%	366	0.000	4.358	80.333
history write	00:01:09.736	0.1%	24178	0.327	2.884	53.481
hiswrite/artcncl	00:00:00.001	0.0%	4	0.000	0.250	0.333
hiswrite/artparse	00:00:00.561	0.0%	223	0.000	2.516	332.000
idle	23:34:31.934	98.8%	505064	108.875	168.042	442.657
nntp read	00:00:02.581	0.0%	518532	0.002	0.005	0.010
overview write	00:10:12.885	0.7%	19912	1.026	30.780	1420.019
perl filter	00:00:48.946	0.1%	24178	1.336	2.024	3.432
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.370	0.0%	39968	0.000	0.009	0.031
TOTAL: 23:51:00.621	23:50:07.133	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.066	0.0%	20178	0.000	0.003	0.039
article prepare	00:00:00.002	0.0%	17198	0.000	0.000	0.013
article read	00:00:07.143	0.0%	2392	0.000	2.986	29.417
backlog stats	00:00:00.249	0.0%	392614	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.168	0.0%	291472	0.003	0.007	0.014
data write	00:00:01.745	0.0%	275675	0.002	0.006	0.012
idle	23:43:59.598	100.0%	392614	132.229	217.617	571.072
status file	00:00:01.613	0.0%	278	0.000	5.802	498.000
TOTAL: 23:44:34.493	23:44:12.584	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	17:46:50.439	99.7%	27535	87.056	2324.694	600113.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.518	0.0%	56042	0.000	0.009	0.664
readart	00:02:12.947	0.2%	10493	0.000	12.670	127.000
TOTAL: 17:50:17.047	17:49:03.904	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	3
logmode	2
mode	37
pause	3
paused	3
reload	4
reserve	2
TOTAL: 10	62

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	3	41122	6409	34080	633	15%	47:36:09
2	csiph-out.feeder.erje.net	1152	83392	3053	79007	1332	3%	95:38:23
3	feeder.eternal-september.org	11	21695	2384	18917	394	10%	24:50:55
4	news-out.aioe.org	2	20132	2082	17934	116	10%	24:09:56
5	news.redatomik.org	1	20489	1387	19076	26	6%	26:22:25
6	newsfeed.fu-berlin.de	21	17105	1238	15785	82	7%	22:30:48
7	newsfeeds.xmission.com	2	25060	1233	23823	4	4%	32:29:43
8	newsfeed.neva.ru	140	28095	1139	25662	1294	4%	71:57:33
9	news.fcku.it	1	9373	556	8649	168	5%	23:59:57
10	news-out.mixmin.net	1	19630	447	18801	382	2%	21:59:49
11	news.swapon.de	3	1660	78	1582	0	4%	21:39:46
12	nntp.pasdenom.info	2	18815	33	18774	8	0%	23:59:09
13	news.freedyn.net	1	20736	12	20706	18	0%	22:50:38
14	xanadu-bbs.net	16	605	1	603	1	0%	22:02:15
15	localhost	33	1	1	0	0	100%	00:00:00
16	news.bbs.geek.nz	2	19407	0	19407	0	0%	23:59:47
TOTAL: 16		1391	347317	20053	322806	4458	5%	506:07:13

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	19.5 MB	0.0 KB	7.8 MB	27.3 MB	71%	4.0 KB
2	csiph-out.feeder.erje.net	13.1 MB	45.5 KB	8.6 MB	21.7 MB	60%	5.1 KB
3	feeder.eternal-september.org	5.9 MB	0.0 KB	1.9 MB	7.9 MB	75%	2.9 KB
4	news-out.aioe.org	4.6 MB	0.0 KB	603.4 KB	5.2 MB	88%	2.4 KB
5	newsfeeds.xmission.com	3.7 MB	0.0 KB	235.3 KB	3.9 MB	94%	3.3 KB
6	news.redatomik.org	3.2 MB	0.0 KB	741.7 KB	4.0 MB	81%	2.9 KB
7	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	199.9 KB	2.9 MB	93%	2.3 KB
8	newsfeed.neva.ru	2.5 MB	0.0 KB	3.8 MB	6.3 MB	39%	2.6 KB
9	news-out.mixmin.net	1.6 MB	9.1 KB	807.3 KB	2.4 MB	66%	2.9 KB
10	news.fcku.it	1.1 MB	0.0 KB	2.2 MB	3.3 MB	32%	4.6 KB
11	news.swapon.de	192.8 KB	0.0 KB	0.0 KB	192.8 KB	100%	2.5 KB
12	nntp.pasdenom.info	82.4 KB	0.0 KB	20.0 KB	102.5 KB	80%	2.5 KB
13	news.freedyn.net	30.4 KB	0.0 KB	49.1 KB	79.5 KB	38%	2.7 KB
14	xanadu-bbs.net	2.3 KB	0.0 KB	1.5 KB	3.9 KB	60%	1.9 KB
15	localhost	1.8 KB	0.0 KB	0.0 KB	1.8 KB	100%	1.8 KB
16	news.bbs.geek.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		58.1 MB	54.6 KB	26.9 MB	85.1 MB	68%	3.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 24 04:15:00 - 04:59:59	302	1.5%	0.11	1.4 MB	2.4%	0.53
Apr 24 05:00:00 - 05:59:59	763	3.8%	0.21	3.1 MB	5.4%	0.89
Apr 24 06:00:00 - 06:59:59	691	3.5%	0.19	2.1 MB	3.6%	0.59
Apr 24 07:00:00 - 07:59:59	817	4.1%	0.23	2.1 MB	3.7%	0.61
Apr 24 08:00:00 - 08:59:59	885	4.4%	0.25	2.3 MB	4.0%	0.65
Apr 24 09:00:00 - 09:59:59	982	4.9%	0.27	2.5 MB	4.3%	0.71
Apr 24 10:00:00 - 10:59:59	1009	5.0%	0.28	2.6 MB	4.4%	0.73
Apr 24 11:00:00 - 11:59:59	967	4.8%	0.27	2.8 MB	4.8%	0.79
Apr 24 12:00:00 - 12:59:59	1107	5.5%	0.31	3.1 MB	5.4%	0.88
Apr 24 13:00:00 - 13:59:59	1044	5.2%	0.29	2.5 MB	4.3%	0.71
Apr 24 14:00:00 - 14:59:59	1034	5.2%	0.29	3.3 MB	5.7%	0.94
Apr 24 15:00:00 - 15:59:59	1200	6.0%	0.33	3.9 MB	6.8%	1.12
Apr 24 16:00:00 - 16:59:59	1019	5.1%	0.28	2.9 MB	5.1%	0.83
Apr 24 17:00:00 - 17:59:59	1181	5.9%	0.33	3.6 MB	6.2%	1.02
Apr 24 18:00:00 - 18:59:59	1030	5.2%	0.29	2.7 MB	4.6%	0.76
Apr 24 19:00:00 - 19:59:59	1036	5.2%	0.29	2.6 MB	4.5%	0.75
Apr 24 20:00:00 - 20:59:59	989	4.9%	0.27	2.7 MB	4.7%	0.77
Apr 24 21:00:00 - 21:59:59	879	4.4%	0.24	2.5 MB	4.3%	0.71
Apr 24 22:00:00 - 22:59:59	699	3.5%	0.19	1.9 MB	3.3%	0.55
Apr 24 23:00:00 - 23:59:59	561	2.8%	0.16	1.7 MB	2.9%	0.48
Apr 25 00:00:00 - 00:59:59	446	2.2%	0.12	1.3 MB	2.2%	0.37
Apr 25 01:00:00 - 01:59:59	431	2.2%	0.12	1.2 MB	2.1%	0.35
Apr 25 02:00:00 - 02:59:59	411	2.1%	0.11	1.4 MB	2.3%	0.39
Apr 25 03:00:00 - 03:59:59	365	1.8%	0.10	1.1 MB	1.8%	0.30
Apr 25 04:00:00 - 04:15:00	134	0.7%	0.15	453.1 KB	0.8%	0.50
TOTAL: 24:00:00	19982	100.0%	0.23	57.7 MB	100.0%	0.68

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1359	181	4	1174
2	newsfeed.neva.ru	1298	195	0	1103
3	csiph-out.news.weretis.net	681	406	0	275
4	newsfeed.fu-berlin.de	617	34	0	583
5	feeder.eternal-september.org	410	29	0	381
6	news-out.mixmin.net	392	0	1	391
7	news.fcku.it	163	5	0	158
8	news-out.aioe.org	126	110	0	16
9	news.redatomik.org	96	0	0	96
10	news.swapon.de	30	0	0	30
11	news.freedyn.net	22	2	0	20
12	nntp.pasdenom.info	8	7	0	1
13	newsfeeds.xmission.com	3	0	0	3
14	xanadu-bbs.net	1	0	0	1
TOTAL: 14		5206	969	5	4232

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	114
gmane.linux.alsa.devel	83
it-alt.sport.calcio.juventus	77
it.annunci.varie	55
it.annunci.commerciali	55
it.annunci.immobiliari	54
alt.survival	51
mpc.lists.freebsd.ports.bugs	35
alt.bbs.synchronet	26
mozilla.support.thunderbird	26
mpc.lists.nanog	25
gmane.linux.kernel	21
gmane.comp.gis.openstreetmap	20
spline.eisfair	18
free.it.religioni.scientology	17
lada.auto	15
alt.windows7.general	15
mozilla.general	15
mozilla.dev.security.policy	13
mozilla.test	12
TOTAL: 100	969

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2926
EMP (phn path)	99
Too many newsgroups	42
User-issued cancel	37
Scoring filter (8)	31
HTML Multipart	30
EMP (phl)	29
Scoring filter (12)	23
EMP (phn nph)	22
Scoring filter (10)	14
Binary Payload	10
Scoring filter (9)	10
Scoring filter (11)	8
Binary: misplaced par2	5
HTML post	4
Binary Image: misplaced jpg	3
Too many newsgroups (low_xpost)	2
User-issued spam cancel	1
Binary: misplaced 008	1
Scoring filter (14)	1
TOTAL: 21	3299

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	89	0	92	92
TOTAL: 1	89	54	92	92

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.feeder.erje.net	108
	csiph-out.news.weretis.net	87
	feeder.eternal-september.org	12
	news.redatomik.org	6
	news.fcku.it	4
	newsfeeds.xmission.com	3
	news-out.mixmin.net	2
	news.freedyn.net	1
	TOTAL: 8	223
Including strange strings
	newsfeed.fu-berlin.de	525
	news.redatomik.org	69
	csiph-out.news.weretis.net	35
	news.swapon.de	30
	csiph-out.feeder.erje.net	27
	news-out.aioe.org	11
	news-out.mixmin.net	7
	newsfeed.neva.ru	4
	feeder.eternal-september.org	2
	TOTAL: 9	710
TOTAL: 2		933

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.geek.nz	36612	823	18595	22	1	1	2%	23:59:46
2	news.freedyn.net	21288	656	19303	1	0	0	3%	23:59:46
3	xanadu-bbs	21869	597	19368	11	0	0	2%	23:59:46
4	fu-berlin.de	18441	522	17901	0	0	24	2%	23:59:46
5	erje	23996	285	16543	24	0	0	1%	23:59:40
6	usenet.pasdenom.info	21624	141	18744	1064	0	14	0%	23:59:46
7	aioe	17142	28	16447	0	0	144	0%	23:59:36
8	weretis.net	13398	18	12497	6	0	0	0%	23:59:46
9	neva.ru	18611	11	17875	116	0	0	0%	23:59:45
10	xmission	21861	5	18318	0	0	0	0%	23:59:46
11	eternal-september	17572	3	16824	0	0	153	0%	23:59:46
12	news.mixmin.net	19142	2	18654	0	0	0	0%	23:59:46
13	news.swapon.de	1687	1	1654	0	0	0	0%	23:47:51
14	news.redatomik.org	18790	1	18133	3	0	0	0%	23:59:46
15	news.fcku.it	2255	0	2239	0	0	0	0%	21:37:24
TOTAL: 15		274288	3093	233095	1247	1	336	1%	357:21:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	6.8 MB	12.7 KB	6.8 MB	0.1 KB/s	10.6 KB	23:59:46
2	xanadu-bbs	6.5 MB	27.6 KB	6.6 MB	0.1 KB/s	11.1 KB	23:59:46
3	fu-berlin.de	6.3 MB	0.0 KB	6.3 MB	0.1 KB/s	12.4 KB	23:59:46
4	news.bbs.geek.nz	2.3 MB	113.3 KB	2.5 MB	0.0 KB/s	3.0 KB	23:59:46
5	erje	838.7 KB	107.2 KB	946.0 KB	0.0 KB/s	3.1 KB	23:59:40
6	usenet.pasdenom.info	392.5 KB	7.3 MB	7.7 MB	0.1 KB/s	6.5 KB	23:59:46
7	aioe	65.2 KB	0.0 KB	65.2 KB	0.0 KB/s	2.3 KB	23:59:36
8	weretis.net	48.5 KB	12.1 KB	60.7 KB	0.0 KB/s	2.5 KB	23:59:46
9	neva.ru	19.1 KB	235.8 KB	254.9 KB	0.0 KB/s	2.0 KB	23:59:45
10	xmission	10.9 KB	0.0 KB	10.9 KB	0.0 KB/s	2.2 KB	23:59:46
11	eternal-september	5.5 KB	0.0 KB	5.5 KB	0.0 KB/s	1.8 KB	23:59:46
12	news.mixmin.net	3.9 KB	0.0 KB	3.9 KB	0.0 KB/s	2.0 KB	23:59:46
13	news.swapon.de	1.8 KB	0.0 KB	1.8 KB	0.0 KB/s	1.8 KB	23:47:51
14	news.redatomik.org	1.8 KB	74.9 KB	76.7 KB	0.0 KB/s	19.2 KB	23:59:46
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:37:24
TOTAL: 15		23.4 MB	7.9 MB	31.3 MB	0.0 KB/s	7.4 KB	357:21:56

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp140-03-70-24-218-108.dsl.bell.ca	300	337	1.1 MB	37	0	0	00:55:13
2	194-73-239-109.cust.centrio.cz	7	9	26.5 KB	6	0	0	00:31:53
3	ip72-222-200-117.ph.ph.cox.net	17	2	3.3 KB	2	1	1	06:16:06
TOTAL: 3		324	348	1.1 MB	45	1	1	17:50:13

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	300	337	1.1 MB	37	0	0	00:55:13
2	*.cust.centrio.cz	7	9	26.5 KB	6	0	0	00:31:53
3	*.ph.ph.cox.net	17	2	3.3 KB	2	1	1	06:16:06
4	*.upc-a.chello.nl	45	0	0.0 KB	0	0	0	07:18:38
5	*.nielsenmedia.com	1	0	0.0 KB	0	0	0	00:30:12
6	unresolved	47	0	0.0 KB	0	0	0	00:40:30
7	*.dhcp.mdsn.wi.charter.com	6	0	0.0 KB	0	0	0	01:37:37
TOTAL: 7		423	348	1.1 MB	45	1	1	17:50:13

NNRP auth users [Top 20]:

User	Conn
ctomczyk	7
kev009	1
TOTAL: 2	8

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	3.169	0.704	0.000	07:18:38
ip72-222-200-117.ph.ph.cox.net	1.241	0.300	0.006	06:16:06
96-42-18-226.dhcp.mdsn.wi.charter.com	0.439	0.083	0.000	01:37:37
mtrlpq2314w-lp140-03-70-24-218-108.dsl.bell.ca	27.702	5.188	0.000	00:55:13
141.168.117.108	4.938	1.055	0.000	00:40:28
194-73-239-109.cust.centrio.cz	0.727	0.104	0.177	00:31:53
challenger.nielsenmedia.com	0.055	0.008	0.000	00:30:12
94.162.201.30	0.087	0.016	0.000	00:00:02
TOTAL: 8	38.358	7.458	0.183	17:50:13

Curious NNRP server explorers [Top 20]:

System	Conn
141.168.117.108	46
a131033.upc-a.chello.nl	45
96-42-18-226.dhcp.mdsn.wi.charter.com	6
94.162.201.30	1
challenger.nielsenmedia.com	1
TOTAL: 5	99

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	9	0
96-42-18-226.dhcp.mdsn.wi.charter.com	3	0
challenger.nielsenmedia.com	1	0
TOTAL: 3	13	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	290	83.3%
2	rec	31	8.9%
3	comp	14	4.0%
4	soc	8	2.3%
5	aus	4	1.1%
6	perl	1	0.3%
TOTAL: 6		348	100.0%

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

Newsgroup		Count
1	alt.atheism	211
2	alt.comp.freeware	20
3	rec.food.cooking	16
4	rec.drugs.cannabis	14
5	alt.home.repair	11
6	alt.society.liberalism	10
7	comp.lang.javascript	9
8	alt.support.chronic-pain	7
9	alt.bible.prophecy	6
10	alt.arts.poetry.comments	5
11	soc.history	5
12	aus.cars	4
13	comp.lang.python	3
14	soc.history.medieval	3
15	alt.usage.english	3
16	alt.christnet.christianlife	2
17	alt.conspiracy	2
18	comp.unix.aix	2
19	alt.global-warming	2
20	alt.religion.christian	2
21	alt.politics.economics	2
22	perl.perl5.porters	1
23	rec.humor	1
24	alt.assassination.jfk	1
25	alt.christnet.theology	1
26	alt.slack	1
27	alt.politics.trump	1
28	alt.gossip.celebrities	1
29	alt.comp.os.windows-10	1
30	alt.life.sucks	1
TOTAL: 30		348

Daily Usenet report for csiph.com

Apr 24 04:15:00 -- Apr 25 04:15:00