Daily Usenet report for csiph.com: Oct 2 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	100438	71.2%	10.8 MB	59.3%
inn	25365	18.0%	5.4 MB	29.6%
innd	12304	8.7%	1.5 MB	8.3%
innfeed	2901	2.1%	518.1 KB	2.8%
nocem	36	0.0%	4.4 KB	0.0%
TOTAL: 5	141044	100.0%	18.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	314828	56.8%
Negative hits	214462	38.7%
Do not exist	24477	4.4%
Cache misses	473	0.1%
TOTAL: 4	554240	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:15.943	0.0%	352	0.000	45.293	183.000
article cleanup	00:00:00.200	0.0%	24678	0.000	0.008	0.038
article logging	00:00:00.455	0.0%	25324	0.000	0.018	0.054
article parse	00:00:01.246	0.0%	65964	0.000	0.019	0.153
article write	00:00:36.416	0.0%	19471	0.281	1.870	32.803
artlog/artcncl	00:00:00.002	0.0%	352	0.000	0.006	0.007
artlog/artparse	00:00:00.008	0.0%	375	0.000	0.021	1.000
data move	00:00:00.209	0.0%	531687	0.000	0.000	0.001
hisgrep/artcncl	00:00:01.708	0.0%	352	0.000	4.852	5.580
hishave/artcncl	00:00:01.958	0.0%	352	0.000	5.562	6.420
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:15.967	0.0%	565451	0.003	0.028	0.758
history sync	00:00:00.580	0.0%	368	0.000	1.576	22.500
history write	00:00:20.819	0.0%	24607	0.148	0.846	7.421
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.416	0.0%	375	0.000	1.109	23.429
idle	23:56:58.497	99.7%	539281	83.090	159.877	492.367
nntp read	00:00:04.484	0.0%	539597	0.003	0.008	0.116
overview write	00:00:29.588	0.0%	19471	0.188	1.520	39.018
perl filter	00:00:46.620	0.1%	24600	1.358	1.895	3.928
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.344	0.0%	38977	0.000	0.009	0.095
TOTAL: 24:00:55.762	23:59:55.460	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.075	0.0%	19613	0.000	0.004	0.024
article prepare	00:00:00.007	0.0%	21076	0.000	0.000	0.014
article read	00:00:02.479	0.0%	2778	0.000	0.892	12.359
backlog stats	00:00:00.248	0.0%	374701	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.067	0.0%	280027	0.002	0.007	0.014
data write	00:00:01.682	0.0%	264173	0.001	0.006	0.012
idle	23:54:41.647	100.0%	374701	107.588	229.734	944.918
status file	00:00:00.442	0.0%	265	0.000	1.668	7.361
TOTAL: 23:54:59.495	23:54:48.647	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	42:25:41.560	99.8%	115399	111.565	1323.595	600098.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.430	0.0%	231831	0.000	0.006	3.919
readart	00:01:32.739	0.1%	14043	0.000	6.604	200.500
TOTAL: 42:31:22.277	42:27:15.729	99.8%	-	-	-	-

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.feeder.erje.net	1440	99025	4376	93437	1212	4%	118:56:46
2	csiph-out.news.weretis.net	5	39834	3806	35592	436	9%	47:38:58
3	feeder.eternal-september.org	5	21512	2500	18395	617	11%	23:19:55
4	news-out.aioe.org	3	19467	1800	17578	89	9%	24:08:59
5	newsfeeds.xmission.com	2	18871	1556	17307	8	8%	25:05:15
6	news-out.mixmin.net	3	20728	1397	18312	1019	6%	24:11:43
7	newsfeed.neva.ru	150	23239	1238	20259	1742	5%	71:21:26
8	newsfeed.fu-berlin.de	10	16292	1014	15098	180	6%	20:39:08
9	news.redatomik.org	3	19108	738	18323	47	3%	24:08:47
10	news.fcku.it	4	3517	377	3110	30	10%	25:39:10
11	news.freedyn.net	3	21517	120	21306	91	0%	24:28:14
12	news.swapon.de	5	1586	76	1509	1	4%	23:53:03
13	nntp.pasdenom.info	3	17620	57	17539	24	0%	23:58:21
14	localhost	49	23	23	0	0	100%	00:00:10
15	news.bbs.nz	2	19172	4	19168	0	0%	22:51:27
16	xanadu-bbs.net	15	876	1	874	1	0%	26:55:22
TOTAL: 16		1702	342387	19083	317807	5497	5%	527:16:44

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	16.7 MB	0.0 KB	12.4 MB	29.2 MB	57%	5.3 KB
2	csiph-out.news.weretis.net	11.7 MB	0.0 KB	11.4 MB	23.2 MB	50%	5.6 KB
3	feeder.eternal-september.org	6.6 MB	0.0 KB	3.6 MB	10.2 MB	64%	3.4 KB
4	news-out.aioe.org	4.6 MB	10.9 KB	501.3 KB	5.1 MB	90%	2.8 KB
5	news-out.mixmin.net	4.5 MB	52.4 KB	2.2 MB	6.7 MB	66%	2.8 KB
6	newsfeeds.xmission.com	4.4 MB	0.0 KB	741.4 KB	5.1 MB	85%	3.4 KB
7	newsfeed.neva.ru	3.1 MB	36.8 KB	6.3 MB	9.4 MB	32%	3.2 KB
8	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	543.2 KB	2.8 MB	80%	2.4 KB
9	news.redatomik.org	2.0 MB	4.2 KB	713.8 KB	2.7 MB	74%	3.6 KB
10	news.fcku.it	630.0 KB	0.0 KB	53.2 KB	683.2 KB	92%	1.7 KB
11	news.freedyn.net	289.6 KB	0.0 KB	156.0 KB	445.6 KB	64%	2.1 KB
12	news.swapon.de	197.6 KB	0.0 KB	2.3 KB	199.9 KB	98%	2.6 KB
13	nntp.pasdenom.info	135.2 KB	4.3 KB	45.1 KB	184.6 KB	73%	2.3 KB
14	localhost	29.1 KB	0.0 KB	0.0 KB	29.1 KB	100%	1.3 KB
15	news.bbs.nz	9.8 KB	0.0 KB	0.0 KB	9.8 KB	100%	2.4 KB
16	xanadu-bbs.net	5.0 KB	0.0 KB	95.7 KB	100.7 KB	4%	50.3 KB
TOTAL: 16		57.2 MB	108.6 KB	38.7 MB	96.0 MB	59%	4.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 2 04:15:00 - 04:59:59	502	2.6%	0.19	2.6 MB	4.5%	0.97
Oct 2 05:00:00 - 05:59:59	516	2.7%	0.14	2.1 MB	3.6%	0.59
Oct 2 06:00:00 - 06:59:59	568	3.0%	0.16	1.7 MB	3.1%	0.50
Oct 2 07:00:00 - 07:59:59	719	3.7%	0.20	1.9 MB	3.2%	0.53
Oct 2 08:00:00 - 08:59:59	908	4.7%	0.25	2.4 MB	4.2%	0.68
Oct 2 09:00:00 - 09:59:59	927	4.8%	0.26	2.6 MB	4.6%	0.74
Oct 2 10:00:00 - 10:59:59	814	4.2%	0.23	2.3 MB	4.0%	0.65
Oct 2 11:00:00 - 11:59:59	821	4.3%	0.23	2.1 MB	3.7%	0.60
Oct 2 12:00:00 - 12:59:59	862	4.5%	0.24	2.0 MB	3.6%	0.58
Oct 2 13:00:00 - 13:59:59	1033	5.4%	0.29	2.9 MB	5.0%	0.81
Oct 2 14:00:00 - 14:59:59	1019	5.3%	0.28	2.7 MB	4.7%	0.76
Oct 2 15:00:00 - 15:59:59	1358	7.1%	0.38	5.1 MB	9.0%	1.45
Oct 2 16:00:00 - 16:59:59	1154	6.0%	0.32	3.3 MB	5.8%	0.95
Oct 2 17:00:00 - 17:59:59	984	5.1%	0.27	2.7 MB	4.7%	0.77
Oct 2 18:00:00 - 18:59:59	1134	5.9%	0.32	3.2 MB	5.7%	0.92
Oct 2 19:00:00 - 19:59:59	1077	5.6%	0.30	2.9 MB	5.0%	0.82
Oct 2 20:00:00 - 20:59:59	962	5.0%	0.27	3.2 MB	5.6%	0.91
Oct 2 21:00:00 - 21:59:59	830	4.3%	0.23	2.3 MB	4.1%	0.66
Oct 2 22:00:00 - 22:59:59	743	3.9%	0.21	2.3 MB	4.1%	0.67
Oct 2 23:00:00 - 23:59:59	456	2.4%	0.13	1.3 MB	2.4%	0.38
Oct 3 00:00:00 - 00:59:59	441	2.3%	0.12	1.2 MB	2.2%	0.36
Oct 3 01:00:00 - 01:59:59	436	2.3%	0.12	1.2 MB	2.1%	0.34
Oct 3 02:00:00 - 02:59:59	452	2.4%	0.13	1.5 MB	2.6%	0.42
Oct 3 03:00:00 - 03:59:59	338	1.8%	0.09	1.0 MB	1.8%	0.29
Oct 3 04:00:00 - 04:15:00	122	0.6%	0.14	472.6 KB	0.8%	0.53
TOTAL: 24:00:00	19176	100.0%	0.22	57.1 MB	100.0%	0.68

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	1733	136	1	1596
2	csiph-out.feeder.erje.net	1242	120	0	1122
3	news-out.mixmin.net	972	0	1	971
4	newsfeed.fu-berlin.de	753	24	0	729
5	feeder.eternal-september.org	638	45	0	593
6	csiph-out.news.weretis.net	462	110	0	352
7	news.freedyn.net	91	0	0	91
8	news-out.aioe.org	89	79	2	8
9	news.redatomik.org	59	0	1	58
10	news.swapon.de	30	0	0	30
11	news.fcku.it	30	29	0	1
12	nntp.pasdenom.info	23	5	1	17
13	newsfeeds.xmission.com	9	0	0	9
14	xanadu-bbs.net	2	0	0	2
TOTAL: 14		6133	548	6	5579

Unwanted newsgroups [Top 20]:

Newsgroup	Count
it-alt.sport.calcio.juventus	84
gmane.comp.gis.openstreetmap.tagging	54
lada.talk	45
lada.auto	34
gmane.linux.alsa.devel	32
lada.commerce	24
alt.windows7.general	21
alt.survival	20
at.jobs	14
alt.politics.usa	13
mozilla.dev.platform	12
alt.english.usage	11
mozilla.support.seamonkey	10
spline.fli4l	9
mozilla.support.firefox	9
alt.rec.guns	8
oesterreich.tratsch	6
gmane.linux.kernel	6
mozilla.dev.security.policy	6
alt.philosophy	5
TOTAL: 91	548

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3663
EMP (phn path)	631
EMP (phl)	80
Too many newsgroups	56
HTML Multipart	35
User-issued spam cancel	19
User-issued cancel	14
Binary Payload	13
EMP (phn nph)	9
Scoring filter (10)	9
Scoring filter (9)	8
Scoring filter (12)	6
Scoring filter (11)	6
Binary: misplaced rar	6
HTML post	2
Too many newsgroups (meow)	1
Scoring filter (8)	1
Binary: misplaced 076	1
Scoring filter (13)	1
TOTAL: 19	4561

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	7
	TOTAL: 1	7
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	TOTAL: 1	50
Huge articles
	csiph-out.feeder.erje.net	184
	csiph-out.news.weretis.net	138
	feeder.eternal-september.org	30
	newsfeeds.xmission.com	7
	news.redatomik.org	6
	news-out.mixmin.net	4
	xanadu-bbs.net	1
	TOTAL: 7	370
Including strange strings
	newsfeed.fu-berlin.de	551
	csiph-out.feeder.erje.net	30
	news.swapon.de	29
	news.redatomik.org	9
	csiph-out.news.weretis.net	8
	news-out.mixmin.net	7
	news-out.aioe.org	3
	newsfeeds.xmission.com	2
	xanadu-bbs.net	1
	newsfeed.neva.ru	1
	TOTAL: 10	641
TOTAL: 4		1068

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	21216	917	18250	0	0	4%	23:59:48
2	news.freedyn.net	19951	774	18280	2	0	3%	23:59:52
3	fu-berlin.de	17850	667	17183	0	0	3%	23:59:53
4	erje	19681	339	13914	517	1	1%	23:59:53
5	news.bbs.nz	36190	194	18287	10	1	0%	23:59:42
6	usenet.pasdenom.info	29842	183	17920	1350	142	0%	23:59:53
7	xmission	19604	30	16899	2	0	0%	23:59:53
8	weretis.net	13658	29	13460	0	0	0%	23:59:53
9	aioe	16616	27	15906	0	0	0%	23:59:38
10	news.mixmin.net	17401	24	16917	0	0	0%	23:59:47
11	news.redatomik.org	18539	23	17739	0	6	0%	23:59:53
12	news.swapon.de	1743	22	1649	0	0	1%	23:46:32
13	eternal-september	16457	22	15734	0	0	0%	23:59:53
14	neva.ru	17147	19	16845	164	14	0%	23:59:53
15	news.fcku.it	1999	0	1988	0	0	0%	22:31:26
TOTAL: 15		267894	3270	220971	2045	164	1%	358:15:49

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.6 MB	0.0 KB	7.6 MB	0.1 KB/s	8.4 KB	23:59:48
2	news.freedyn.net	7.3 MB	9.4 KB	7.3 MB	0.1 KB/s	9.6 KB	23:59:52
3	fu-berlin.de	7.0 MB	0.0 KB	7.0 MB	0.1 KB/s	10.7 KB	23:59:53
4	erje	835.6 KB	1.8 MB	2.6 MB	0.0 KB/s	3.1 KB	23:59:53
5	usenet.pasdenom.info	638.5 KB	8.2 MB	8.8 MB	0.1 KB/s	5.9 KB	23:59:53
6	news.bbs.nz	495.2 KB	56.9 KB	552.1 KB	0.0 KB/s	2.7 KB	23:59:42
7	weretis.net	44.5 KB	0.0 KB	44.5 KB	0.0 KB/s	1.5 KB	23:59:53
8	xmission	42.0 KB	5.0 KB	47.0 KB	0.0 KB/s	1.5 KB	23:59:53
9	aioe	36.8 KB	0.0 KB	36.8 KB	0.0 KB/s	1.4 KB	23:59:38
10	news.mixmin.net	32.2 KB	0.0 KB	32.2 KB	0.0 KB/s	1.3 KB	23:59:47
11	news.redatomik.org	29.2 KB	0.0 KB	29.2 KB	0.0 KB/s	1.3 KB	23:59:53
12	eternal-september	28.3 KB	0.0 KB	28.3 KB	0.0 KB/s	1.3 KB	23:59:53
13	news.swapon.de	28.1 KB	0.0 KB	28.1 KB	0.0 KB/s	1.3 KB	23:46:32
14	neva.ru	24.1 KB	350.4 KB	374.5 KB	0.0 KB/s	2.0 KB	23:59:53
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:31:26
TOTAL: 15		24.0 MB	10.3 MB	34.3 MB	0.0 KB/s	6.6 KB	358:15:49

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-01-70-49-68-37.dsl.bell.ca	2600	193	744.3 KB	109	0	0	07:26:36
2	167-179-154-5.a7b39a.mel.nbn.aussiebb.net	46	125	332.3 KB	61	0	0	00:41:08
3	71-82-167-111.dhcp.mdsn.wi.charter.com	53	23	29.2 KB	19	23	16	10:39:43
4	a131033.upc-a.chello.nl	79	19	24.5 KB	8	0	0	16:59:33
5	challenger.nielsenmedia.com	2	6	16.6 KB	1	0	0	00:40:36
TOTAL: 5		2780	366	1.1 MB	198	23	16	42:30:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	2600	193	744.3 KB	109	0	0	07:26:36
2	*.a7b39a.mel.nbn.aussiebb.net	46	125	332.3 KB	61	0	0	00:41:08
3	*.dhcp.mdsn.wi.charter.com	53	23	29.2 KB	19	23	16	10:39:43
4	*.upc-a.chello.nl	79	19	24.5 KB	8	0	0	16:59:33
5	*.nielsenmedia.com	2	6	16.6 KB	1	0	0	00:40:36
6	*.ph.ph.cox.net	12	0	0.0 KB	0	0	0	05:33:02
7	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:00
8	unresolved	2	0	0.0 KB	0	0	0	00:00:11
TOTAL: 8		2795	366	1.1 MB	198	23	16	42:30:53

NNRP auth users [Top 20]:

User	Conn
moussa	46
ohlandl	16
TOTAL: 2	62

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	6.474	0.993	0.000	16:59:33
71-82-167-111.dhcp.mdsn.wi.charter.com	5.283	0.852	0.057	10:39:43
mtrlpq2314w-lp130-01-70-49-68-37.dsl.bell.ca	229.378	36.864	0.000	07:26:36
ip72-222-200-117.ph.ph.cox.net	1.135	0.168	0.000	05:33:02
167-179-154-5.a7b39a.mel.nbn.aussiebb.net	5.028	1.059	0.159	00:41:08
challenger.nielsenmedia.com	0.193	0.049	0.000	00:40:36
c-67-160-62-214.hsd1.wa.comcast.net	0.054	0.008	0.000	00:30:00
162.243.146.47	0.098	0.000	0.000	00:00:09
94.164.109.167	0.062	0.007	0.000	00:00:01
TOTAL: 9	247.705	40.000	0.216	42:30:53

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	12
94.164.109.167	1
c-67-160-62-214.hsd1.wa.comcast.net	1
162.243.146.47	1
TOTAL: 4	15

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	10	0
71-82-167-111.dhcp.mdsn.wi.charter.com	6	0
c-67-160-62-214.hsd1.wa.comcast.net	1	0
167-179-154-5.a7b39a.mel.nbn.aussiebb.net	1	1
challenger.nielsenmedia.com	1	0
TOTAL: 5	19	1

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	142	38.8%
2	alt	88	24.0%
3	linux	70	19.1%
4	perl	25	6.8%
5	uk	21	5.7%
6	fr	8	2.2%
7	misc	6	1.6%
8	free	5	1.4%
9	soc	1	0.3%
TOTAL: 9		366	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	65
2	linux.debian.bugs.dist	49
3	alt.comp.freeware	42
4	comp.os.vms	34
5	alt.comp.os.windows-10	20
6	perl.cpan.uploads	17
7	uk.legal.moderated	16
8	linux.debian.bugs.rc	14
9	comp.mobile.android	10
10	comp.arch	10
11	alt.os.linux.mageia	8
12	fr.rec.loisirs-creatifs	8
13	alt.os.linux.ubuntu	8
14	comp.os.cpm	7
15	alt.privacy.anon-server.stats	7
16	comp.lang.awk	6
17	misc.phone.mobile.iphone	6
18	free.virginmedia.discussion.general	5
19	linux.debian.kernel	4
20	perl.daily-build.reports	4
21	uk.net.news.moderation	4
22	perl.perl5.porters	4
23	comp.sys.ibm.as400.misc	3
24	comp.ai.philosophy	3
25	comp.sys.ibm.pc.games.action	2
26	linux.gentoo.user	2
27	alt.sports.baseball.wash-nationals	2
28	soc.culture.lebanon	1
29	linux.gentoo.dev	1
30	comp.sys.raspberry-pi	1
31	uk.d-i-y	1
32	comp.lang.xharbour	1
33	alt.tv.big-brother	1
TOTAL: 33		366

Daily Usenet report for csiph.com

Oct 2 04:15:00 -- Oct 3 04:15:00