Daily Usenet report for csiph.com: Aug 25 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	22219	39.2%	2.3 MB	27.0%
inn	20664	36.4%	4.5 MB	51.5%
innd	10882	19.2%	1.4 MB	15.8%
innfeed	2914	5.1%	499.2 KB	5.6%
nocem	31	0.1%	3.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	56711	100.0%	8.7 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	268326	58.4%
Negative hits	170700	37.2%
Do not exist	19994	4.4%
Cache misses	176	0.0%
TOTAL: 4	459196	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.274	0.0%	58	0.000	4.724	21.000
article cleanup	00:00:00.124	0.0%	19708	0.000	0.006	0.063
article logging	00:00:00.331	0.0%	20257	0.000	0.016	0.066
article parse	00:00:00.798	0.0%	52710	0.000	0.015	0.053
article write	00:00:05.172	0.0%	16176	0.123	0.320	4.472
artlog/artcncl	00:00:00.000	0.0%	57	0.000	0.000	0.000
artlog/artparse	00:00:00.002	0.0%	375	0.000	0.005	0.500
data move	00:00:00.170	0.0%	448148	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.004	0.0%	57	0.000	0.070	0.667
hishave/artcncl	00:00:00.003	0.0%	58	0.000	0.052	0.300
hishave/artparse	00:00:00.000	0.0%	375	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:02.934	0.0%	460536	0.001	0.006	0.019
history sync	00:00:00.487	0.0%	384	0.000	1.268	3.667
history write	00:00:06.650	0.0%	19700	0.048	0.338	0.586
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.144	0.0%	375	0.000	0.384	4.000
idle	23:59:23.438	99.9%	456647	111.450	189.125	499.276
nntp read	00:00:02.313	0.0%	454741	0.001	0.005	0.021
overview write	00:00:05.406	0.0%	16176	0.079	0.334	5.911
perl filter	00:00:36.740	0.0%	19699	1.281	1.865	10.517
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.289	0.0%	32380	0.000	0.009	0.026
TOTAL: 24:01:07.622	24:00:25.279	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.049	0.0%	16262	0.000	0.003	0.037
article prepare	00:00:00.001	0.0%	17188	0.000	0.000	0.019
article read	00:00:00.439	0.0%	2095	0.000	0.210	5.400
backlog stats	00:00:00.197	0.0%	335599	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.638	0.0%	243466	0.001	0.007	0.014
data write	00:00:01.580	0.0%	228884	0.001	0.007	0.018
idle	23:54:21.437	100.0%	335599	136.516	256.441	622.508
status file	00:00:00.185	0.0%	263	0.000	0.703	2.000
TOTAL: 23:54:35.704	23:54:25.526	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:01.808	0.0%	43915	0.000	0.041	0.047
idle	18:01:32.062	99.7%	102829	85.510	631.068	600208.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.231	0.0%	206377	0.000	0.006	0.192
readart	00:00:53.873	0.1%	6186	0.000	8.709	71.000
TOTAL: 18:05:00.613	18:02:28.974	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	84424	3950	79165	1309	4%	118:42:09
2	csiph-out.news.weretis.net	5	32720	3426	29043	251	10%	48:01:20
3	feeder.eternal-september.org	5	18045	2114	15470	461	11%	24:37:40
4	news-out.aioe.org	2	15674	1674	13941	59	10%	24:09:57
5	newsfeeds.xmission.com	1	15045	1000	14027	18	6%	22:55:25
6	news.redatomik.org	3	15507	994	14448	65	6%	24:02:43
7	news-out.mixmin.net	1	17035	922	15358	755	5%	23:59:33
8	newsfeed.fu-berlin.de	7	15336	904	14246	186	5%	24:16:47
9	newsfeed.neva.ru	145	18655	689	17461	505	3%	72:14:13
10	news.fcku.it	1	7034	258	6499	277	3%	23:59:57
11	nntp.pasdenom.info	3	14584	110	14467	7	0%	23:58:40
12	news.swapon.de	10	1385	40	1345	0	2%	23:03:55
13	localhost	35	6	6	0	0	100%	00:00:06
14	news.freedyn.net	2	22454	3	22444	7	0%	32:25:03
15	news.bbs.nz	2	17475	1	17474	0	0%	23:59:42
16	xanadu-bbs.net	31	381	0	381	0	0%	20:39:27
TOTAL: 16		1693	295760	16091	275769	3900	5%	531:06:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	13.5 MB	10.1 KB	10.5 MB	24.0 MB	56%	4.7 KB
2	csiph-out.news.weretis.net	10.9 MB	0.0 KB	5.2 MB	16.0 MB	67%	4.5 KB
3	feeder.eternal-september.org	5.7 MB	0.0 KB	4.6 MB	10.3 MB	54%	4.1 KB
4	news-out.aioe.org	4.0 MB	0.0 KB	233.7 KB	4.2 MB	94%	2.5 KB
5	newsfeeds.xmission.com	2.6 MB	1.9 KB	842.4 KB	3.5 MB	76%	3.5 KB
6	news-out.mixmin.net	2.6 MB	2.0 KB	1.5 MB	4.1 MB	63%	2.5 KB
7	news.redatomik.org	2.5 MB	0.0 KB	783.0 KB	3.3 MB	76%	3.2 KB
8	newsfeed.fu-berlin.de	2.0 MB	0.0 KB	440.1 KB	2.4 MB	82%	2.3 KB
9	newsfeed.neva.ru	1.9 MB	0.0 KB	2.7 MB	4.6 MB	41%	4.0 KB
10	news.fcku.it	851.5 KB	0.0 KB	3.3 MB	4.2 MB	19%	8.0 KB
11	nntp.pasdenom.info	237.9 KB	0.0 KB	12.7 KB	250.6 KB	94%	2.1 KB
12	news.swapon.de	99.6 KB	0.0 KB	0.0 KB	99.6 KB	100%	2.5 KB
13	localhost	13.0 KB	0.0 KB	0.0 KB	13.0 KB	100%	2.2 KB
14	news.freedyn.net	3.3 KB	0.0 KB	75.2 KB	78.5 KB	4%	7.9 KB
15	news.bbs.nz	2.4 KB	0.0 KB	0.0 KB	2.4 KB	100%	2.4 KB
16	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		46.9 MB	14.1 KB	30.1 MB	77.0 MB	60%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Aug 25 04:15:00 - 04:59:59	252	1.6%	0.09	783.5 KB	1.6%	0.29
Aug 25 05:00:00 - 05:59:59	369	2.3%	0.10	997.8 KB	2.1%	0.28
Aug 25 06:00:00 - 06:59:59	484	3.0%	0.13	1.6 MB	3.4%	0.46
Aug 25 07:00:00 - 07:59:59	639	4.0%	0.18	2.2 MB	4.6%	0.62
Aug 25 08:00:00 - 08:59:59	692	4.3%	0.19	1.8 MB	3.9%	0.52
Aug 25 09:00:00 - 09:59:59	839	5.2%	0.23	3.3 MB	7.1%	0.95
Aug 25 10:00:00 - 10:59:59	691	4.3%	0.19	1.9 MB	3.9%	0.53
Aug 25 11:00:00 - 11:59:59	799	4.9%	0.22	2.1 MB	4.5%	0.60
Aug 25 12:00:00 - 12:59:59	783	4.8%	0.22	1.9 MB	4.0%	0.54
Aug 25 13:00:00 - 13:59:59	781	4.8%	0.22	2.0 MB	4.3%	0.58
Aug 25 14:00:00 - 14:59:59	817	5.1%	0.23	3.2 MB	6.9%	0.92
Aug 25 15:00:00 - 15:59:59	1026	6.3%	0.28	2.7 MB	5.8%	0.77
Aug 25 16:00:00 - 16:59:59	1010	6.2%	0.28	2.7 MB	5.8%	0.77
Aug 25 17:00:00 - 17:59:59	959	5.9%	0.27	2.6 MB	5.5%	0.74
Aug 25 18:00:00 - 18:59:59	826	5.1%	0.23	2.5 MB	5.3%	0.71
Aug 25 19:00:00 - 19:59:59	829	5.1%	0.23	2.2 MB	4.7%	0.62
Aug 25 20:00:00 - 20:59:59	870	5.4%	0.24	2.3 MB	4.9%	0.65
Aug 25 21:00:00 - 21:59:59	793	4.9%	0.22	2.1 MB	4.4%	0.59
Aug 25 22:00:00 - 22:59:59	565	3.5%	0.16	1.8 MB	3.8%	0.51
Aug 25 23:00:00 - 23:59:59	502	3.1%	0.14	1.3 MB	2.8%	0.37
Aug 26 00:00:00 - 00:59:59	422	2.6%	0.12	1.2 MB	2.5%	0.33
Aug 26 01:00:00 - 01:59:59	403	2.5%	0.11	1.1 MB	2.4%	0.32
Aug 26 02:00:00 - 02:59:59	365	2.3%	0.10	1.3 MB	2.7%	0.36
Aug 26 03:00:00 - 03:59:59	369	2.3%	0.10	1.3 MB	2.8%	0.37
Aug 26 04:00:00 - 04:15:00	85	0.5%	0.09	242.7 KB	0.5%	0.27
TOTAL: 24:00:00	16170	100.0%	0.19	47.1 MB	100.0%	0.56

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1325	82	1	1242
2	news-out.mixmin.net	765	4	1	760
3	newsfeed.fu-berlin.de	649	10	0	639
4	newsfeed.neva.ru	509	60	0	449
5	feeder.eternal-september.org	457	40	0	417
6	news.fcku.it	268	3	0	265
7	csiph-out.news.weretis.net	259	86	0	173
8	news.redatomik.org	96	0	0	96
9	news-out.aioe.org	65	58	0	7
10	newsfeeds.xmission.com	17	4	1	12
11	news.swapon.de	13	0	0	13
12	news.freedyn.net	8	0	0	8
13	nntp.pasdenom.info	7	4	0	3
TOTAL: 13		4438	351	3	4084

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.sport.calcio.juventus	48
lada.talk	40
alt.politics	23
gmane.comp.gis.openstreetmap.tagging	18
alt.windows7.general	16
alt.politics.usa	12
mozilla.support.thunderbird	11
lada.auto	11
trollnet.cinema	10
alt.english.usage	10
at.jobs	9
alt.survival	8
oesterreich.tratsch	7
spline.eisfair	6
alt.binaries.ctb	5
mozilla.support.seamonkey	5
alt.politics.republican	5
alt.christnet.eucharist	4
mozilla.test	4
lada.commerce	4
TOTAL: 81	351

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2565
EMP (phn path)	374
EMP (phl)	77
Too many newsgroups	57
User-issued cancel	24
HTML Multipart	18
Binary: misplaced rar	9
Binary Payload	7
Scoring filter (13)	6
Binary: misplaced par2	6
Scoring filter (14)	5
Scoring filter (9)	5
Scoring filter (10)	5
Too many newsgroups (low_xpost)	3
User-issued spam cancel	2
Binary Image: misplaced jpg	2
Binary: misplaced 090	1
Binary: misplaced 002	1
Binary: misplaced 103	1
Binary: misplaced 293	1
TOTAL: 24	3173

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	7	0	8	8
TOTAL: 1	7	21	8	8

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
Bad Message-ID's offered
	csiph-out.feeder.erje.net	60
	TOTAL: 1	60
Huge articles
	csiph-out.feeder.erje.net	150
	csiph-out.news.weretis.net	67
	feeder.eternal-september.org	58
	news.fcku.it	56
	newsfeeds.xmission.com	11
	news.redatomik.org	10
	news-out.mixmin.net	5
	news.freedyn.net	1
	TOTAL: 8	358
Including strange strings
	newsfeed.fu-berlin.de	462
	news.redatomik.org	30
	csiph-out.feeder.erje.net	16
	news.swapon.de	13
	news-out.mixmin.net	7
	feeder.eternal-september.org	6
	news-out.aioe.org	6
	csiph-out.news.weretis.net	6
	newsfeed.neva.ru	1
	TOTAL: 9	547
TOTAL: 4		966

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	17548	746	15420	1	0	4%	23:59:52
2	xanadu-bbs	18861	696	15461	12	118	3%	23:59:52
3	fu-berlin.de	15099	501	14597	0	0	3%	23:59:46
4	erje	17446	370	11788	1	0	2%	23:59:52
5	usenet.pasdenom.info	18821	207	14607	1244	3	1%	23:59:51
6	news.bbs.nz	30583	194	15390	9	2	0%	23:59:52
7	weretis.net	12698	25	11553	7	0	0%	23:59:49
8	aioe	14331	25	13278	0	0	0%	23:59:44
9	xmission	17338	19	14567	2	0	0%	23:59:50
10	news.mixmin.net	15022	17	14337	1	0	0%	23:59:52
11	eternal-september	14548	14	13369	1	0	0%	23:59:52
12	news.redatomik.org	15669	8	14585	1	6	0%	23:59:52
13	neva.ru	14994	7	14572	199	0	0%	23:59:52
14	news.swapon.de	1457	6	1414	0	0	0%	23:15:18
15	news.fcku.it	1411	0	1377	0	0	0%	22:10:19
TOTAL: 15		225826	2835	186315	1478	129	1%	357:23:33

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	5.2 MB	9.7 KB	5.2 MB	0.1 KB/s	7.2 KB	23:59:52
2	xanadu-bbs	5.1 MB	19.5 KB	5.1 MB	0.1 KB/s	7.4 KB	23:59:52
3	fu-berlin.de	4.7 MB	0.0 KB	4.7 MB	0.1 KB/s	9.5 KB	23:59:46
4	erje	1.2 MB	2.8 KB	1.2 MB	0.0 KB/s	3.2 KB	23:59:52
5	usenet.pasdenom.info	461.0 KB	5.8 MB	6.3 MB	0.1 KB/s	4.4 KB	23:59:51
6	news.bbs.nz	450.9 KB	27.4 KB	478.3 KB	0.0 KB/s	2.4 KB	23:59:52
7	weretis.net	63.3 KB	36.9 KB	100.2 KB	0.0 KB/s	3.1 KB	23:59:49
8	aioe	48.9 KB	0.0 KB	48.9 KB	0.0 KB/s	2.0 KB	23:59:44
9	xmission	39.9 KB	3.9 KB	43.8 KB	0.0 KB/s	2.1 KB	23:59:50
10	news.mixmin.net	35.8 KB	2.1 KB	37.9 KB	0.0 KB/s	2.1 KB	23:59:52
11	eternal-september	32.4 KB	2.4 KB	34.9 KB	0.0 KB/s	2.3 KB	23:59:52
12	neva.ru	20.7 KB	389.9 KB	410.6 KB	0.0 KB/s	2.0 KB	23:59:52
13	news.redatomik.org	19.5 KB	6.0 KB	25.5 KB	0.0 KB/s	2.8 KB	23:59:52
14	news.swapon.de	13.0 KB	0.0 KB	13.0 KB	0.0 KB/s	2.2 KB	23:15:18
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:10:19
TOTAL: 15		17.3 MB	6.3 MB	23.6 MB	0.0 KB/s	5.6 KB	357:23:33

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	141.168.117.108	44	171	501.2 KB	81	0	0	00:38:29
2	mtrlpq2314w-lp130-05-70-55-68-33.dsl.bell.ca	1600	43	112.3 KB	34	0	0	03:42:34
3	47.41.144.29	21	10	21.6 KB	7	5	5	05:50:02
4	ip72-222-200-117.ph.ph.cox.net	13	2	9.3 KB	2	1	1	03:47:27
5	208-71-239-109.cust.centrio.cz	4	1	3.3 KB	1	0	0	02:00:37
TOTAL: 5		1682	227	647.6 KB	125	6	6	18:04:42

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	65	181	522.7 KB	88	5	5	06:28:31
2	*.dsl.bell.ca	1600	43	112.3 KB	34	0	0	03:42:34
3	*.ph.ph.cox.net	13	2	9.3 KB	2	1	1	03:47:27
4	*.cust.centrio.cz	4	1	3.3 KB	1	0	0	02:00:37
5	*.dhcp.chtrptr.net	13	0	0.0 KB	0	0	0	01:35:25
6	*.nielsenmedia.com	1	0	0.0 KB	0	0	0	00:30:05
TOTAL: 6		1696	227	647.6 KB	125	6	6	18:04:42

NNRP auth users [Top 20]:

User	Conn
moussa	44
ohlandl	5
ctomczyk	4
kev009	1
TOTAL: 4	54

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
47.41.144.29	1.782	0.358	0.014	05:50:02
ip72-222-200-117.ph.ph.cox.net	1.231	0.173	0.004	03:47:27
mtrlpq2314w-lp130-05-70-55-68-33.dsl.bell.ca	140.825	19.109	0.000	03:42:34
208-71-239-109.cust.centrio.cz	0.468	0.047	0.014	02:00:37
172-221-041-102.dhcp.chtrptr.net	1.797	3.038	0.000	01:35:25
141.168.117.108	5.180	0.933	0.137	00:38:29
challenger.nielsenmedia.com	0.084	0.034	0.000	00:30:05
TOTAL: 7	151.367	23.692	0.169	18:04:42

Curious NNRP server explorers [Top 20]:

System	Conn
172-221-041-102.dhcp.chtrptr.net	13
challenger.nielsenmedia.com	1
TOTAL: 2	14

NNRP client timeouts [Top 20]:

System	Conn	Peer
47.41.144.29	5	0
208-71-239-109.cust.centrio.cz	4	0
ip72-222-200-117.ph.ph.cox.net	3	0
challenger.nielsenmedia.com	1	0
TOTAL: 4	13	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	113	49.8%
2	comp	99	43.6%
3	perl	7	3.1%
4	uk	5	2.2%
5	fr	3	1.3%
TOTAL: 5		227	100.0%

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

Newsgroup		Count
1	alt.comp.freeware	94
2	comp.sys.ibm.ps2.hardware	21
3	comp.os.vms	21
4	comp.ai.philosophy	16
5	comp.os.cpm	12
6	comp.arch	9
7	alt.os.linux.ubuntu	8
8	perl.cpan.uploads	7
9	comp.mobile.android	5
10	comp.sys.ibm.pc.games.action	4
11	alt.os.linux.mint	4
12	alt.comp.os.windows-10	4
13	uk.legal.moderated	4
14	fr.sci.zetetique	3
15	comp.mobile.ipad	3
16	comp.os.linux.networking	2
17	alt.os.linux.mageia	2
18	comp.os.os2.advocacy	1
19	comp.archives.ms-windows.discuss	1
20	comp.lang.javascript	1
21	comp.sys.raspberry-pi	1
22	comp.sys.ibm.pc.hardware.storage	1
23	uk.radio.amateur.moderated	1
24	alt.guitar.amps	1
25	comp.os.os2.misc	1
TOTAL: 25		227

Daily Usenet report for csiph.com

Aug 25 04:15:00 -- Aug 26 04:15:00