Daily Usenet report for csiph.com: Jun 8 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	25733	47.4%	5.5 MB	62.3%
nnrpd	14692	27.1%	1.5 MB	16.6%
innd	10905	20.1%	1.3 MB	15.2%
innfeed	2820	5.2%	513.7 KB	5.7%
nocem	113	0.2%	12.6 KB	0.1%
TOTAL: 5	54263	100.0%	8.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	303130	55.0%
Negative hits	222862	40.4%
Do not exist	24698	4.5%
Cache misses	329	0.1%
TOTAL: 4	551019	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.468	0.0%	231	0.000	10.684	865.000
article cleanup	00:00:00.169	0.0%	24439	0.000	0.007	0.027
article logging	00:00:05.627	0.0%	25067	0.000	0.224	7.822
article parse	00:00:02.125	0.0%	69980	0.002	0.030	0.625
article write	00:02:35.372	0.2%	19564	0.509	7.942	56.009
artlog/artcncl	00:00:00.002	0.0%	179	0.000	0.011	0.500
artlog/artparse	00:00:00.012	0.0%	492	0.000	0.024	0.333
data move	00:00:00.177	0.0%	535007	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.034	0.0%	224	0.000	0.152	2.000
hishave/artcncl	00:00:00.016	0.0%	231	0.000	0.069	1.000
hishave/artparse	00:00:00.002	0.0%	491	0.000	0.004	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:37.189	0.0%	555401	0.003	0.067	0.531
history sync	00:00:02.456	0.0%	379	0.000	6.480	159.000
history write	00:01:13.286	0.1%	24424	0.403	3.001	41.953
hiswrite/artcncl	00:00:00.010	0.0%	7	0.000	1.429	3.000
hiswrite/artparse	00:00:01.196	0.0%	490	0.000	2.441	36.889
idle	23:36:31.365	98.3%	527608	84.408	161.088	503.892
nntp read	00:00:02.843	0.0%	541193	0.001	0.005	0.009
overview write	00:17:53.350	1.2%	19564	0.769	54.864	3457.894
perl filter	00:00:47.075	0.1%	24416	1.185	1.928	3.274
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.387	0.0%	39230	0.000	0.010	0.033
TOTAL: 24:01:14.318	23:59:55.161	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.044	0.0%	19555	0.000	0.002	0.017
article prepare	00:00:00.001	0.0%	16460	0.000	0.000	0.002
article read	00:00:04.523	0.0%	1898	0.000	2.383	105.333
backlog stats	00:00:00.227	0.0%	371369	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.064	0.0%	281813	0.002	0.007	0.014
data write	00:00:01.577	0.0%	266125	0.002	0.006	0.017
idle	23:54:24.509	100.0%	371369	131.715	231.749	642.174
status file	00:00:00.465	0.0%	246	0.000	1.890	55.000
TOTAL: 23:54:45.511	23:54:33.410	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	22:06:49.614	99.8%	24599	81.158	3236.295	600116.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.308	0.0%	49620	0.000	0.006	0.194
readart	00:01:28.365	0.1%	3669	0.000	24.084	511.000
TOTAL: 22:09:47.696	22:08:18.287	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	40076	4850	34659	567	12%	47:59:41
2	csiph-out.feeder.erje.net	1152	82247	3682	76739	1826	4%	94:57:15
3	feeder.eternal-september.org	6	21040	2565	17787	688	12%	22:58:55
4	news-out.aioe.org	2	19142	1761	17323	58	9%	23:59:52
5	news.redatomik.org	1	18459	1641	16797	21	8%	24:26:58
6	news-out.mixmin.net	3	20796	1307	18964	525	6%	24:08:13
7	newsfeed.fu-berlin.de	18	17897	1222	16637	38	6%	26:03:23
8	newsfeed.neva.ru	146	21754	951	19442	1361	4%	71:54:21
9	newsfeeds.xmission.com	3	17629	740	16878	11	4%	21:25:40
10	news.fcku.it	2	8890	531	8160	199	5%	23:59:45
11	news.swapon.de	5	1685	63	1622	0	3%	26:07:44
12	nntp.pasdenom.info	2	18468	50	18405	13	0%	23:59:00
13	news.freedyn.net	9	22239	22	22203	14	0%	24:50:52
14	news.bbs.nz	2	21612	6	21606	0	0%	23:59:42
15	localhost	39	1	1	0	0	100%	00:00:00
16	xanadu-bbs.net	14	761	1	759	1	0%	29:17:01
TOTAL: 16		1408	332696	19393	307981	5322	5%	510:08:22

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	16.9 MB	43.5 KB	13.6 MB	30.6 MB	55%	5.7 KB
2	csiph-out.news.weretis.net	15.0 MB	41.8 KB	17.0 MB	32.1 MB	46%	6.1 KB
3	feeder.eternal-september.org	6.7 MB	0.0 KB	4.4 MB	11.1 MB	60%	3.5 KB
4	news-out.mixmin.net	5.5 MB	1.3 KB	1.4 MB	6.9 MB	79%	3.8 KB
5	news-out.aioe.org	4.4 MB	1.2 KB	401.4 KB	4.8 MB	91%	2.7 KB
6	news.redatomik.org	3.9 MB	1.2 KB	299.4 KB	4.2 MB	93%	2.6 KB
7	newsfeed.fu-berlin.de	2.9 MB	0.0 KB	138.6 KB	3.0 MB	95%	2.4 KB
8	newsfeed.neva.ru	2.4 MB	72.1 KB	8.4 MB	10.9 MB	22%	4.8 KB
9	newsfeeds.xmission.com	2.3 MB	0.0 KB	671.9 KB	2.9 MB	77%	4.0 KB
10	news.fcku.it	1.4 MB	0.0 KB	5.4 MB	6.8 MB	20%	9.5 KB
11	news.swapon.de	153.6 KB	0.0 KB	0.0 KB	153.6 KB	100%	2.4 KB
12	nntp.pasdenom.info	124.7 KB	0.0 KB	32.7 KB	157.4 KB	79%	2.5 KB
13	news.freedyn.net	64.8 KB	0.0 KB	42.0 KB	106.8 KB	60%	3.0 KB
14	news.bbs.nz	15.9 KB	0.0 KB	0.0 KB	15.9 KB	100%	2.7 KB
15	xanadu-bbs.net	4.1 KB	0.0 KB	17.1 KB	21.2 KB	19%	10.6 KB
16	localhost	1.1 KB	0.0 KB	0.0 KB	1.1 KB	100%	1.1 KB
TOTAL: 16		61.8 MB	160.9 KB	51.7 MB	113.7 MB	54%	4.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 8 04:15:00 - 04:59:59	345	1.8%	0.13	1.6 MB	2.5%	0.60
Jun 8 05:00:00 - 05:59:59	523	2.7%	0.15	2.4 MB	3.8%	0.68
Jun 8 06:00:00 - 06:59:59	653	3.3%	0.18	2.6 MB	4.1%	0.73
Jun 8 07:00:00 - 07:59:59	747	3.8%	0.21	1.9 MB	3.1%	0.55
Jun 8 08:00:00 - 08:59:59	797	4.1%	0.22	2.2 MB	3.5%	0.61
Jun 8 09:00:00 - 09:59:59	1006	5.1%	0.28	3.0 MB	4.8%	0.85
Jun 8 10:00:00 - 10:59:59	1391	7.1%	0.39	5.5 MB	8.9%	1.58
Jun 8 11:00:00 - 11:59:59	1207	6.2%	0.34	4.3 MB	7.0%	1.23
Jun 8 12:00:00 - 12:59:59	949	4.9%	0.26	2.4 MB	3.9%	0.69
Jun 8 13:00:00 - 13:59:59	974	5.0%	0.27	2.5 MB	4.0%	0.71
Jun 8 14:00:00 - 14:59:59	1102	5.6%	0.31	2.9 MB	4.7%	0.82
Jun 8 15:00:00 - 15:59:59	1086	5.6%	0.30	3.7 MB	6.0%	1.06
Jun 8 16:00:00 - 16:59:59	1076	5.5%	0.30	3.6 MB	5.7%	1.01
Jun 8 17:00:00 - 17:59:59	1148	5.9%	0.32	3.7 MB	6.0%	1.06
Jun 8 18:00:00 - 18:59:59	993	5.1%	0.28	3.1 MB	5.0%	0.89
Jun 8 19:00:00 - 19:59:59	990	5.1%	0.28	2.8 MB	4.5%	0.79
Jun 8 20:00:00 - 20:59:59	945	4.8%	0.26	2.9 MB	4.7%	0.84
Jun 8 21:00:00 - 21:59:59	814	4.2%	0.23	2.4 MB	3.8%	0.68
Jun 8 22:00:00 - 22:59:59	662	3.4%	0.18	2.1 MB	3.4%	0.61
Jun 8 23:00:00 - 23:59:59	458	2.3%	0.13	1.5 MB	2.3%	0.41
Jun 9 00:00:00 - 00:59:59	453	2.3%	0.13	1.3 MB	2.0%	0.36
Jun 9 01:00:00 - 01:59:59	402	2.1%	0.11	1.1 MB	1.8%	0.33
Jun 9 02:00:00 - 02:59:59	400	2.0%	0.11	1.4 MB	2.2%	0.40
Jun 9 03:00:00 - 03:59:59	335	1.7%	0.09	993.8 KB	1.6%	0.28
Jun 9 04:00:00 - 04:15:00	106	0.5%	0.12	339.5 KB	0.5%	0.38
TOTAL: 24:00:00	19562	100.0%	0.23	62.3 MB	100.0%	0.74

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1833	139	8	1686
2	newsfeed.neva.ru	1361	182	3	1176
3	feeder.eternal-september.org	721	29	0	692
4	csiph-out.news.weretis.net	583	163	2	418
5	newsfeed.fu-berlin.de	563	24	0	539
6	news-out.mixmin.net	538	0	1	537
7	news.fcku.it	222	5	0	217
8	news-out.aioe.org	68	54	1	13
9	news.redatomik.org	52	0	1	51
10	news.freedyn.net	14	2	0	12
11	news.swapon.de	13	0	0	13
12	newsfeeds.xmission.com	12	0	0	12
13	nntp.pasdenom.info	11	5	0	6
14	xanadu-bbs.net	1	0	0	1
TOTAL: 14		5992	603	16	5373

Unwanted newsgroups [Top 20]:

Newsgroup	Count
gmane.comp.gis.openstreetmap.tagging	71
lada.talk	71
lada.auto	51
mozilla.support.firefox	43
mpc.lists.freebsd.ports.bugs	43
mozilla.support.thunderbird	33
it-alt.sport.calcio.juventus	33
lada.commerce	18
alt.politics.usa	14
spline.eisfair	13
mpc.lists.nanog	12
alt.english.usage	11
oesterreich.tratsch	9
alt.windows7.general	9
mozilla.support.seamonkey	9
lada.mobile	9
free.it.religioni.scientology	8
alt.politics	7
mozilla.test	6
alt.politics.republican	6
TOTAL: 85	603

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3405
EMP (phn path)	405
Binary: misplaced rar	130
EMP (phl)	85
Too many newsgroups	68
EMP (phn nph)	46
HTML Multipart	18
User-issued cancel	16
Binary: misplaced par2	13
Scoring filter (10)	12
Binary Payload	10
Scoring filter (8)	8
User-issued spam cancel	7
Scoring filter (9)	5
Scoring filter (12)	4
Binary: misplaced PAR2	4
Scoring filter (11)	4
Angle-bracket bot	1
Binary: misplaced 009	1
Binary: misplaced 123	1
TOTAL: 25	4248

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	68	0	71	71
TOTAL: 1	68	34	71	71

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	7
	TOTAL: 1	7
Huge articles
	csiph-out.news.weretis.net	189
	csiph-out.feeder.erje.net	166
	news.fcku.it	81
	feeder.eternal-september.org	35
	newsfeeds.xmission.com	11
	news.redatomik.org	4
	news-out.mixmin.net	3
	TOTAL: 7	489
Including strange strings
	newsfeed.fu-berlin.de	523
	news.redatomik.org	31
	csiph-out.news.weretis.net	30
	news.swapon.de	13
	csiph-out.feeder.erje.net	10
	news-out.aioe.org	10
	news-out.mixmin.net	9
	feeder.eternal-september.org	1
	newsfeed.neva.ru	1
	TOTAL: 9	628
TOTAL: 3		1124

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	20867	879	18667	2	1	4%	23:59:52
2	xanadu-bbs	21768	680	18879	0	22	3%	23:59:52
3	fu-berlin.de	18076	625	17451	0	0	3%	23:59:52
4	erje	19440	294	15447	17	1	1%	23:59:53
5	usenet.pasdenom.info	20707	225	18188	1097	2	1%	23:59:48
6	news.bbs.nz	35670	150	18749	2	3	0%	23:59:43
7	weretis.net	14121	11	13614	8	1	0%	23:59:46
8	neva.ru	18007	6	17613	105	0	0%	23:59:39
9	xmission	20864	6	18046	0	3	0%	23:59:53
10	aioe	17004	5	16177	0	1	0%	23:59:52
11	eternal-september	16991	4	15983	0	0	0%	23:59:52
12	news.redatomik.org	18080	3	17266	0	0	0%	23:59:52
13	news.mixmin.net	17864	2	17300	0	1	0%	23:59:36
14	news.swapon.de	1650	1	1609	0	0	0%	23:48:27
15	news.fcku.it	2131	0	2108	0	0	0%	22:18:18
TOTAL: 15		263240	2891	227097	1231	35	1%	358:04:15

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	8.6 MB	7.1 KB	8.6 MB	0.1 KB/s	10.0 KB	23:59:52
2	xanadu-bbs	7.9 MB	0.0 KB	7.9 MB	0.1 KB/s	11.9 KB	23:59:52
3	fu-berlin.de	7.8 MB	0.0 KB	7.8 MB	0.1 KB/s	12.8 KB	23:59:52
4	erje	1.2 MB	97.6 KB	1.3 MB	0.0 KB/s	4.2 KB	23:59:53
5	usenet.pasdenom.info	630.4 KB	8.5 MB	9.2 MB	0.1 KB/s	7.1 KB	23:59:48
6	news.bbs.nz	417.5 KB	8.9 KB	426.4 KB	0.0 KB/s	2.8 KB	23:59:43
7	weretis.net	25.3 KB	24.2 KB	49.4 KB	0.0 KB/s	2.6 KB	23:59:46
8	aioe	19.1 KB	0.0 KB	19.1 KB	0.0 KB/s	3.8 KB	23:59:52
9	xmission	18.7 KB	0.0 KB	18.7 KB	0.0 KB/s	3.1 KB	23:59:53
10	eternal-september	14.2 KB	0.0 KB	14.2 KB	0.0 KB/s	3.6 KB	23:59:52
11	neva.ru	11.3 KB	252.2 KB	263.5 KB	0.0 KB/s	2.4 KB	23:59:39
12	news.redatomik.org	11.0 KB	0.0 KB	11.0 KB	0.0 KB/s	3.7 KB	23:59:52
13	news.mixmin.net	8.2 KB	0.0 KB	8.2 KB	0.0 KB/s	4.1 KB	23:59:36
14	news.swapon.de	1.1 KB	0.0 KB	1.1 KB	0.0 KB/s	1.1 KB	23:48:27
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:18:18
TOTAL: 15		26.6 MB	8.9 MB	35.5 MB	0.0 KB/s	8.8 KB	358:04:15

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-01-70-49-71-241.dsl.bell.ca	650	45	116.9 KB	39	0	0	00:56:12
2	challenger.nielsenmedia.com	1	2	4.7 KB	1	0	0	00:32:31
3	141.168.117.108	48	1	1.1 KB	1	0	0	00:39:31
4	a131033.upc-a.chello.nl	41	1	1.1 KB	1	0	0	09:54:02
5	68-185-188-186.dhcp.mdsn.wi.charter.com	4	1	1.1 KB	1	1	1	01:05:42
6	ip72-222-200-117.ph.ph.cox.net	25	1	1.1 KB	1	0	0	08:50:31
TOTAL: 6		769	51	125.9 KB	44	1	1	22:09:41

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	650	45	116.9 KB	39	0	0	00:56:12
2	*.nielsenmedia.com	1	2	4.7 KB	1	0	0	00:32:31
3	*.upc-a.chello.nl	41	1	1.1 KB	1	0	0	09:54:02
4	*.ph.ph.cox.net	25	1	1.1 KB	1	0	0	08:50:31
5	unresolved	48	1	1.1 KB	1	0	0	00:39:31
6	*.dhcp.mdsn.wi.charter.com	4	1	1.1 KB	1	1	1	01:05:42
7	*.dhcp.chtrptr.net	4	0	0.0 KB	0	0	0	00:11:09
TOTAL: 7		773	51	125.9 KB	44	1	1	22:09:41

NNRP auth users [Top 20]:

User	Conn
ohlandl	1
TOTAL: 1	1

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.881	0.474	0.000	09:54:02
ip72-222-200-117.ph.ph.cox.net	2.140	0.383	0.000	08:50:31
68-185-188-186.dhcp.mdsn.wi.charter.com	0.385	0.055	0.006	01:05:42
mtrlpq2314w-lp130-01-70-49-71-241.dsl.bell.ca	62.574	8.934	0.000	00:56:12
141.168.117.108	5.161	1.018	0.000	00:39:31
challenger.nielsenmedia.com	0.154	0.008	0.000	00:32:31
172-220-042-114.dhcp.chtrptr.net	0.307	0.092	0.000	00:11:09
TOTAL: 7	73.602	10.964	0.006	22:09:41

Curious NNRP server explorers [Top 20]:

System	Conn
172-220-042-114.dhcp.chtrptr.net	4
TOTAL: 1	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	12	0
68-185-188-186.dhcp.mdsn.wi.charter.com	2	0
challenger.nielsenmedia.com	1	0
a131033.upc-a.chello.nl	1	0
TOTAL: 4	16	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	13	25.5%
2	uk	12	23.5%
3	comp	11	21.6%
4	perl	6	11.8%
5	fr	6	11.8%
6	soc	2	3.9%
7	aus	1	2.0%
TOTAL: 7		51	100.0%

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

Newsgroup		Count
1	fr.comp.os.ms-windows	5
2	alt.comp.os.windows-10	5
3	alt.home.repair	5
4	perl.cpan.uploads	5
5	comp.sys.ibm.ps2.hardware	4
6	alt.os.linux.mageia	3
7	uk.legal.moderated	3
8	uk.legal	3
9	comp.lang.awk	2
10	uk.media.radio.archers	2
11	soc.culture.polish	2
12	comp.lang.python	2
13	uk.politics.misc	1
14	comp.lang.xharbour	1
15	comp.os.linux.advocacy	1
16	comp.unix.shell	1
17	aus.cars	1
18	fr.soc.environnement	1
19	uk.d-i-y	1
20	perl.daily-build.reports	1
21	uk.media.tv.misc	1
22	uk.rec.cycling	1
TOTAL: 22		51

Daily Usenet report for csiph.com

Jun 8 04:15:00 -- Jun 9 04:15:00