Daily Usenet report for csiph.com: Jan 1 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	16651	45.4%	4.4 MB	60.9%
innd	16243	44.3%	2.1 MB	29.4%
innfeed	3475	9.5%	678.6 KB	9.2%
nnrpd	306	0.8%	32.1 KB	0.4%
nocem	15	0.0%	1.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	36691	100.0%	7.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	277473	57.8%
Negative hits	186757	38.9%
Do not exist	15921	3.3%
Cache misses	174	0.0%
TOTAL: 4	480325	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.664	0.0%	56	0.000	11.857	32.600
article cleanup	00:00:00.083	0.0%	15735	0.000	0.005	0.041
article logging	00:00:00.249	0.0%	16331	0.000	0.015	0.154
article parse	00:00:00.506	0.0%	47095	0.000	0.011	0.030
article write	00:00:08.815	0.0%	13683	0.172	0.644	32.256
artlog/artcncl	00:00:00.000	0.0%	56	0.000	0.000	0.000
artlog/artparse	00:00:00.004	0.0%	228	0.000	0.018	1.000
data move	00:00:00.136	0.0%	450142	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.019	0.0%	51	0.000	0.373	1.000
hishave/artcncl	00:00:00.005	0.0%	56	0.000	0.089	0.333
hishave/artparse	00:00:00.000	0.0%	222	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:03.487	0.0%	480788	0.002	0.007	0.031
history sync	00:00:00.833	0.0%	368	0.000	2.264	56.750
history write	00:00:08.019	0.0%	15717	0.206	0.510	1.863
hiswrite/artcncl	00:00:00.008	0.0%	5	0.500	1.600	2.333
hiswrite/artparse	00:00:00.104	0.0%	222	0.000	0.468	4.000
idle	23:49:11.365	99.9%	458144	106.093	187.171	640.979
nntp read	00:00:01.676	0.0%	458409	0.001	0.004	0.008
overview write	00:00:29.701	0.0%	13683	0.086	2.171	63.980
perl filter	00:00:21.249	0.0%	15708	1.093	1.353	1.976
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.214	0.0%	27380	0.000	0.008	0.028
TOTAL: 23:50:58.545	23:50:27.137	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.026	0.0%	13752	0.000	0.002	0.023
article prepare	00:00:00.000	0.0%	12284	0.000	0.000	0.000
article read	00:00:00.218	0.0%	1229	0.000	0.177	46.000
backlog stats	00:00:00.169	0.0%	338224	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.150	0.0%	258682	0.000	0.004	0.008
data write	00:00:01.491	0.0%	246878	0.001	0.006	0.012
idle	23:54:47.623	100.0%	338224	145.630	254.528	742.957
status file	00:00:00.182	0.0%	260	0.000	0.700	2.000
TOTAL: 23:54:57.044	23:54:50.859	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	09:54:24.041	99.6%	330	0.000	108072.852	415129.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:02:13.786	0.4%	212507	0.000	0.630	5.300
readart	00:00:00.893	0.0%	88	0.000	10.148	42.000
TOTAL: 09:56:54.321	09:56:38.720	100.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	138
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	158

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	3	13170	3011	10126	33	22%	24:08:49
2	csiph-out.feeder.erje.net	1440	67617	2431	64827	359	3%	118:46:42
3	newsfeeds.xmission.com	3	12321	2026	10268	27	16%	22:08:04
4	feeder.eternal-september.org	2	14843	1817	12607	419	12%	24:04:22
5	newsfeed.fu-berlin.de	6	14054	986	12989	79	7%	27:08:35
6	news-out.mixmin.net	2	14173	743	13228	202	5%	23:59:39
7	csiph-out.news.weretis.net	3	18419	610	17659	150	3%	36:06:07
8	csiph-out.news.xs4all.nl	861	14592	562	13562	468	3%	71:26:02
9	newsfeed.neva.ru	142	14684	469	14029	186	3%	71:35:30
10	news.freedyn.net	2	15168	336	14743	89	2%	23:59:50
11	csiph-out.feed.uzoreto.com	864	21017	138	20675	204	0%	71:17:07
12	news-out.neodome.net	1	14139	105	14001	33	0%	23:59:56
13	nntp.pasdenom.info	2	8783	90	8682	11	1%	23:59:31
14	news.fcku.it	14	1033	53	977	3	5%	22:14:20
15	csiph-out.news.tnetconsulting.net	2	2985	36	2948	1	1%	08:36:26
16	news.swapon.de	7	1473	24	1448	1	1%	24:56:02
17	news.samoylyk.net	2	13207	5	13201	1	0%	23:59:51
18	news.bbs.nz	2	13446	3	13443	0	0%	23:59:45
19	localhost	28	2	2	0	0	100%	00:00:05
20	xanadu-bbs.net	27	391	0	391	0	0%	22:36:40
TOTAL: 20		3413	275517	13447	259804	2266	4%	689:03:23

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	9.9 MB	43.6 KB	8.7 MB	18.6 MB	52%	6.8 KB
2	news-out.aioe.org	7.8 MB	5.3 KB	87.8 KB	7.9 MB	98%	2.7 KB
3	newsfeeds.xmission.com	6.2 MB	0.0 KB	1.4 MB	7.6 MB	81%	3.8 KB
4	feeder.eternal-september.org	5.3 MB	8.2 KB	1.8 MB	7.1 MB	74%	3.2 KB
5	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	520.4 KB	2.9 MB	82%	2.8 KB
6	news-out.mixmin.net	2.1 MB	5.4 KB	349.5 KB	2.4 MB	85%	2.6 KB
7	csiph-out.news.weretis.net	1.8 MB	5.4 KB	1.0 MB	2.8 MB	64%	3.8 KB
8	csiph-out.news.xs4all.nl	1.5 MB	5.4 KB	6.1 MB	7.6 MB	19%	7.6 KB
9	newsfeed.neva.ru	1.3 MB	5.4 KB	949.8 KB	2.2 MB	58%	3.5 KB
10	news.freedyn.net	1.3 MB	6.7 KB	557.8 KB	1.8 MB	69%	4.3 KB
11	csiph-out.feed.uzoreto.com	717.7 KB	16.0 KB	3.5 MB	4.2 MB	16%	12.6 KB
12	news-out.neodome.net	209.1 KB	3.4 KB	168.0 KB	380.5 KB	54%	2.8 KB
13	nntp.pasdenom.info	179.3 KB	0.0 KB	15.0 KB	194.3 KB	92%	1.9 KB
14	news.fcku.it	113.8 KB	0.0 KB	4.2 KB	118.0 KB	96%	2.1 KB
15	csiph-out.news.tnetconsulting.net	82.5 KB	3.5 KB	3.5 KB	89.4 KB	92%	2.4 KB
16	news.swapon.de	54.3 KB	5.4 KB	5.4 KB	65.0 KB	83%	2.6 KB
17	news.samoylyk.net	16.0 KB	5.4 KB	5.4 KB	26.7 KB	59%	4.5 KB
18	news.bbs.nz	7.3 KB	0.0 KB	0.0 KB	7.3 KB	100%	2.4 KB
19	localhost	2.4 KB	0.0 KB	0.0 KB	2.4 KB	100%	1.2 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		40.9 MB	119.0 KB	25.0 MB	66.1 MB	61%	4.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 1 04:15:00 - 04:59:59	204	1.5%	0.08	634.3 KB	1.5%	0.23
Jan 1 05:00:00 - 05:59:59	285	2.1%	0.08	807.3 KB	1.9%	0.22
Jan 1 06:00:00 - 06:59:59	297	2.2%	0.08	1.0 MB	2.4%	0.29
Jan 1 07:00:00 - 07:59:59	289	2.1%	0.08	1.4 MB	3.4%	0.40
Jan 1 08:00:00 - 08:59:59	430	3.1%	0.12	1.1 MB	2.7%	0.32
Jan 1 09:00:00 - 09:59:59	583	4.3%	0.16	1.9 MB	4.5%	0.54
Jan 1 10:00:00 - 10:59:59	607	4.4%	0.17	1.9 MB	4.5%	0.54
Jan 1 11:00:00 - 11:59:59	542	4.0%	0.15	1.6 MB	3.9%	0.47
Jan 1 12:00:00 - 12:59:59	590	4.3%	0.16	1.6 MB	3.9%	0.47
Jan 1 13:00:00 - 13:59:59	654	4.8%	0.18	1.6 MB	3.8%	0.46
Jan 1 14:00:00 - 14:59:59	689	5.0%	0.19	1.9 MB	4.4%	0.53
Jan 1 15:00:00 - 15:59:59	688	5.0%	0.19	2.3 MB	5.4%	0.65
Jan 1 16:00:00 - 16:59:59	907	6.6%	0.25	2.8 MB	6.6%	0.79
Jan 1 17:00:00 - 17:59:59	804	5.9%	0.22	2.2 MB	5.2%	0.62
Jan 1 18:00:00 - 18:59:59	820	6.0%	0.23	2.6 MB	6.1%	0.73
Jan 1 19:00:00 - 19:59:59	827	6.0%	0.23	2.5 MB	5.9%	0.71
Jan 1 20:00:00 - 20:59:59	770	5.6%	0.21	2.2 MB	5.3%	0.63
Jan 1 21:00:00 - 21:59:59	737	5.4%	0.20	2.4 MB	5.7%	0.68
Jan 1 22:00:00 - 22:59:59	718	5.2%	0.20	2.0 MB	4.7%	0.56
Jan 1 23:00:00 - 23:59:59	652	4.8%	0.18	2.3 MB	5.5%	0.66
Jan 2 00:00:00 - 00:59:59	472	3.4%	0.13	1.5 MB	3.5%	0.41
Jan 2 01:00:00 - 01:59:59	425	3.1%	0.12	1.3 MB	3.1%	0.37
Jan 2 02:00:00 - 02:59:59	324	2.4%	0.09	1.1 MB	2.5%	0.30
Jan 2 03:00:00 - 03:59:59	348	2.5%	0.10	1.4 MB	3.3%	0.39
Jan 2 04:00:00 - 04:15:00	54	0.4%	0.06	168.0 KB	0.4%	0.19
TOTAL: 24:00:00	13716	100.0%	0.16	42.0 MB	100.0%	0.50

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.fu-berlin.de	564	34	0	530
2	csiph-out.news.xs4all.nl	468	7	1	460
3	feeder.eternal-september.org	419	25	3	391
4	csiph-out.feeder.erje.net	361	57	8	296
5	news-out.mixmin.net	211	0	1	210
6	csiph-out.feed.uzoreto.com	205	4	3	198
7	csiph-out.news.weretis.net	195	25	1	169
8	newsfeed.neva.ru	185	41	1	143
9	news-out.aioe.org	111	23	1	87
10	news.freedyn.net	90	0	2	88
11	newsfeeds.xmission.com	28	2	0	26
12	news-out.neodome.net	16	0	1	15
13	nntp.pasdenom.info	12	0	0	12
14	csiph-out.news.tnetconsulting.net	7	2	0	5
15	news.swapon.de	3	0	1	2
16	news.fcku.it	3	0	0	3
17	news.samoylyk.net	1	0	1	0
TOTAL: 17		2879	220	24	2635

Unwanted newsgroups [Top 20]:

Newsgroup	Count
spline.eisfair	24
alt.computer.workshop	22
lada.auto	14
lada.photo	13
alt.binaries.pictures.purebeauty	12
alt.survival	11
alt.binaries.ebooks	10
oesterreich.tratsch	9
alt.politics	9
lada.talk	7
alt.binaries.moovee	6
alt.music.pink-floyd.publius	5
spline.fli4l	4
alt.windows7.general	3
mozilla.support.thunderbird	3
alt.linux	3
mozilla.support.calendar	3
alt.philosophy	3
alt.binaries.e-books.flood	2
alt.poetry	2
TOTAL: 66	220

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1137
EMP (phn path)	280
EMP (phn nph)	200
EMP (phl)	67
0	63
Too many newsgroups	22
Binary: misplaced binary	15
Scoring filter	13
HTML Multipart	8
Too many newsgroups (low_xpost)	2
U2 violation - invalid distribution	1
TOTAL: 11	1808

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.feed.uzoreto.com	9
	csiph-out.news.xs4all.nl	8
	TOTAL: 3	67
Huge articles
	csiph-out.feeder.erje.net	153
	newsfeeds.xmission.com	26
	csiph-out.news.xs4all.nl	18
	csiph-out.news.weretis.net	9
	csiph-out.feed.uzoreto.com	7
	newsfeed.fu-berlin.de	4
	feeder.eternal-september.org	4
	news.freedyn.net	1
	TOTAL: 8	222
Including strange strings
	newsfeed.fu-berlin.de	488
	news-out.aioe.org	79
	csiph-out.news.weretis.net	12
	news-out.mixmin.net	10
	news.swapon.de	2
	csiph-out.feeder.erje.net	2
	news.freedyn.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 8	596
No colon-space in header
	csiph-out.news.xs4all.nl	3
	csiph-out.feeder.erje.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	6
TOTAL: 4		891

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17751	785	12927	0	0	4%	23:59:55
2	news.freedyn.net	13640	549	12775	31	0	4%	23:59:55
3	news.samoylyk.net	14237	491	13216	3	0	3%	23:59:55
4	fu-berlin.de	12637	463	12174	0	0	3%	23:59:55
5	news.bbs.nz	25731	275	12932	7	0	1%	23:59:55
6	usenet.pasdenom.info	13700	90	13019	17	0	0%	23:59:55
7	newsfeed.xs4all.nl	13551	29	13010	5	57	0%	23:59:55
8	erje	14623	29	11142	44	0	0%	23:59:55
9	neva.ru	12750	28	12509	122	0	0%	23:59:51
10	neodome.net	14026	27	13549	0	0	0%	23:59:55
11	news.uzoreto.com	13688	19	13354	15	0	0%	23:59:31
12	aioe	9898	16	9488	0	0	0%	23:59:55
13	tnet	15457	13	13205	0	0	0%	23:59:55
14	xmission	13039	7	11052	0	0	0%	23:59:55
15	news.mixmin.net	12773	6	12305	0	0	0%	23:59:55
16	eternal-september	11756	5	11322	0	0	0%	23:59:10
17	news.swapon.de	1491	2	1468	0	0	0%	23:40:41
18	weretis.net	12816	2	12435	0	0	0%	23:59:55
19	news.fcku.it	852	0	844	0	0	0%	21:42:58
TOTAL: 19		244416	2836	212726	244	57	1%	453:21:01

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.1 MB	0.0 KB	5.1 MB	0.1 KB/s	6.7 KB	23:59:55
2	news.freedyn.net	4.5 MB	44.8 KB	4.5 MB	0.1 KB/s	8.0 KB	23:59:55
3	news.samoylyk.net	4.3 MB	3.7 KB	4.3 MB	0.1 KB/s	8.8 KB	23:59:55
4	fu-berlin.de	4.2 MB	0.0 KB	4.2 MB	0.1 KB/s	9.4 KB	23:59:55
5	news.bbs.nz	717.2 KB	44.8 KB	761.9 KB	0.0 KB/s	2.7 KB	23:59:55
6	usenet.pasdenom.info	380.6 KB	43.3 KB	423.9 KB	0.0 KB/s	4.0 KB	23:59:55
7	neva.ru	105.1 KB	301.4 KB	406.5 KB	0.0 KB/s	2.7 KB	23:59:51
8	newsfeed.xs4all.nl	83.7 KB	10.3 KB	94.0 KB	0.0 KB/s	2.8 KB	23:59:55
9	erje	60.8 KB	260.1 KB	320.9 KB	0.0 KB/s	4.4 KB	23:59:55
10	neodome.net	52.0 KB	0.0 KB	52.0 KB	0.0 KB/s	1.9 KB	23:59:55
11	aioe	41.3 KB	0.0 KB	41.3 KB	0.0 KB/s	2.6 KB	23:59:55
12	news.uzoreto.com	35.3 KB	44.6 KB	79.9 KB	0.0 KB/s	2.3 KB	23:59:31
13	tnet	24.0 KB	0.0 KB	24.0 KB	0.0 KB/s	1.8 KB	23:59:55
14	xmission	24.0 KB	0.0 KB	24.0 KB	0.0 KB/s	3.4 KB	23:59:55
15	news.mixmin.net	18.5 KB	0.0 KB	18.5 KB	0.0 KB/s	3.1 KB	23:59:55
16	eternal-september	15.4 KB	0.0 KB	15.4 KB	0.0 KB/s	3.1 KB	23:59:10
17	news.swapon.de	2.4 KB	0.0 KB	2.4 KB	0.0 KB/s	1.2 KB	23:40:41
18	weretis.net	2.4 KB	0.0 KB	2.4 KB	0.0 KB/s	1.2 KB	23:59:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:42:58
TOTAL: 19		19.6 MB	753.0 KB	20.4 MB	0.0 KB/s	6.8 KB	453:21:01

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mail.nappey.org	3	68	138.1 KB	5	0	0	01:46:41
2	a131033.upc-a.chello.nl	20	10	15.1 KB	3	0	0	04:58:46
3	71-90-73-253.dhcp.ftbg.wi.charter.com	4	8	12.5 KB	2	2	2	01:11:01
4	p3ee23925.dip0.t-ipconnect.de	1	2	2.4 KB	1	0	0	00:00:07
TOTAL: 4		28	88	168.1 KB	11	2	2	09:56:54

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.nappey.org	3	68	138.1 KB	5	0	0	01:46:41
2	*.upc-a.chello.nl	20	10	15.1 KB	3	0	0	04:58:46
3	*.dhcp.ftbg.wi.charter.com	4	8	12.5 KB	2	2	2	01:11:01
4	*.dip0.t-ipconnect.de	1	2	2.4 KB	1	0	0	00:00:07
5	*.us-west-1.compute.amazonaws.com	1	0	0.0 KB	0	0	0	00:00:00
6	unresolved	2	0	0.0 KB	0	0	0	00:00:02
7	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	02:00:13
8	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 8		36	88	168.1 KB	11	2	2	09:56:54

NNRP auth users [Top 20]:

User	Conn
ohlandl	2
TOTAL: 1	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	1.462	0.252	0.000	04:58:46
ip72-222-200-117.ph.ph.cox.net	0.398	0.086	0.000	02:00:13
mail.nappey.org	0.952	2.576	0.000	01:46:41
71-90-73-253.dhcp.ftbg.wi.charter.com	0.308	0.094	0.005	01:11:01
p3ee23925.dip0.t-ipconnect.de	0.090	0.037	0.000	00:00:07
scan-141.security.ipip.net	0.060	0.015	0.000	00:00:01
94.160.16.208	0.053	0.023	0.000	00:00:01
94.163.119.187	0.068	0.009	0.000	00:00:01
ec2-13-57-252-243.us-west-1.compute.amazonaws.com	0.058	0.016	0.000	00:00:00
TOTAL: 9	3.449	3.108	0.005	09:56:54

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	4
scan-141.security.ipip.net	1
94.160.16.208	1
94.163.119.187	1
ec2-13-57-252-243.us-west-1.compute.amazonaws.com	1
TOTAL: 5	8

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.1	1
Connection: close	1
User-Agent: HTTP Banner Detection (https...	1
Host: 69.160.37.58:119	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	4	0
mail.nappey.org	2	0
71-90-73-253.dhcp.ftbg.wi.charter.com	2	0
TOTAL: 3	8	0

Newsgroup request counts (by category):

Category		Count	Pct
1	fr	58	65.9%
2	comp	28	31.8%
3	alt	2	2.3%
TOTAL: 3		88	100.0%

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

Newsgroup		Count
1	fr.comp.text.tex	29
2	fr.rec.arts.musique.classique	19
3	comp.sys.ibm.ps2.hardware	18
4	fr.comp.os.bsd	10
5	comp.text.tex	10
6	alt.free.newsservers	2
TOTAL: 6		88

Daily Usenet report for csiph.com

Jan 1 04:15:00 -- Jan 2 04:15:00