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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	43128	39.2%	8.0 MB	53.8%
nnrpd	39590	35.9%	3.8 MB	25.7%
innd	24162	21.9%	2.5 MB	17.0%
innfeed	3156	2.9%	522.5 KB	3.4%
nocem	97	0.1%	10.2 KB	0.1%
TOTAL: 5	110133	100.0%	14.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	423217	56.0%
Negative hits	290254	38.4%
Do not exist	41503	5.5%
Cache misses	607	0.1%
TOTAL: 4	755581	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.262	0.0%	281	0.000	4.491	59.000
article cleanup	00:00:00.295	0.0%	42018	0.000	0.007	0.029
article logging	00:00:05.656	0.0%	42535	0.000	0.133	2.253
article parse	00:00:03.529	0.0%	137603	0.000	0.026	0.559
article write	00:03:10.768	0.2%	22991	0.337	8.298	32.583
artlog/artcncl	00:00:00.010	0.0%	165	0.000	0.061	8.000
artlog/artparse	00:00:00.055	0.0%	210	0.000	0.262	24.000
data move	00:00:00.298	0.0%	681442	0.000	0.000	0.005
hisgrep/artcncl	00:00:00.355	0.0%	278	0.000	1.277	29.000
hishave/artcncl	00:00:00.146	0.0%	281	0.000	0.520	10.000
hishave/artparse	00:00:00.000	0.0%	210	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:38.056	0.2%	755823	0.004	0.209	1.109
history sync	00:00:06.464	0.0%	365	0.333	17.710	130.000
history write	00:04:28.779	0.3%	41262	0.313	6.514	39.208
hiswrite/artcncl	00:00:00.009	0.0%	3	0.000	3.000	9.000
hiswrite/artparse	00:00:01.850	0.0%	209	0.000	8.852	49.000
idle	23:30:49.185	98.6%	657142	68.710	128.814	449.454
nntp read	00:00:03.255	0.0%	691920	0.002	0.005	0.021
overview write	00:06:00.472	0.4%	22991	1.076	15.679	113.031
perl filter	00:01:46.654	0.1%	41260	1.563	2.585	10.967
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.430	0.0%	46071	0.000	0.009	0.026
TOTAL: 23:51:02.153	23:49:17.528	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.067	0.0%	23035	0.000	0.003	0.031
article prepare	00:00:00.005	0.0%	24092	0.000	0.000	0.008
article read	00:00:01.467	0.0%	3704	0.000	0.396	39.333
backlog stats	00:00:00.266	0.0%	422436	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.338	0.0%	326428	0.002	0.007	0.014
data write	00:00:01.868	0.0%	309839	0.001	0.006	0.011
idle	23:53:04.825	100.0%	422436	123.400	203.545	560.172
status file	00:00:00.565	0.0%	280	0.000	2.018	47.500
TOTAL: 23:53:21.479	23:53:11.401	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	25:26:20.926	99.7%	103424	12.000	885.490	600175.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.421	0.0%	207827	0.000	0.007	17.400
readart	00:01:29.691	0.1%	8510	0.000	10.539	198.000
TOTAL: 25:31:03.148	25:27:52.038	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	132154	6565	114492	11097	4%	95:02:49
2	csiph-out.news.weretis.net	4	45961	5755	39221	985	12%	44:34:00
3	feeder.eternal-september.org	69	37829	2974	29182	5673	7%	40:17:14
4	news-out.mixmin.net	3	24485	1670	22162	653	6%	24:08:56
5	news-out.aioe.org	3	22787	1594	21163	30	6%	24:09:39
6	newsfeed.neva.ru	150	54320	1343	51078	1899	2%	71:54:12
7	newsfeed.fu-berlin.de	49	22701	1039	21339	323	4%	31:36:18
8	news.redatomik.org	1	21616	754	20859	3	3%	23:40:14
9	newsfeeds.xmission.com	3	20629	565	20031	33	2%	21:33:40
10	news.fcku.it	1	10032	209	9814	9	2%	23:59:57
11	xanadu-bbs.net	6	1976	184	1789	3	9%	38:53:33
12	nntp.pasdenom.info	2	21795	97	21679	19	0%	23:58:43
13	news.freedyn.net	2	26218	69	26049	100	0%	23:59:43
14	news.swapon.de	1	2211	62	2149	0	2%	21:02:20
15	news.bbs.geek.nz	1	20478	19	20459	0	0%	23:59:45
16	localhost	35	1	1	0	0	100%	00:00:01
TOTAL: 16		1482	465193	22900	421466	20827	4%	532:51:04

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	21.9 MB	1.7 MB	63.7 MB	87.3 MB	25%	5.1 KB
2	csiph-out.news.weretis.net	17.6 MB	0.0 KB	11.5 MB	29.1 MB	60%	4.4 KB
3	feeder.eternal-september.org	7.8 MB	7.1 MB	75.1 MB	90.0 MB	8%	10.7 KB
4	news-out.mixmin.net	6.6 MB	0.0 KB	1.7 MB	8.3 MB	79%	3.7 KB
5	news-out.aioe.org	4.1 MB	0.0 KB	38.1 KB	4.1 MB	99%	2.6 KB
6	newsfeed.neva.ru	3.2 MB	653.2 KB	17.3 MB	21.1 MB	15%	6.7 KB
7	news.redatomik.org	2.4 MB	4.3 KB	141.8 KB	2.6 MB	94%	3.5 KB
8	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	804.2 KB	3.1 MB	74%	2.4 KB
9	newsfeeds.xmission.com	1.8 MB	0.0 KB	259.7 KB	2.0 MB	87%	3.5 KB
10	xanadu-bbs.net	551.1 KB	0.0 KB	21.5 KB	572.6 KB	96%	3.1 KB
11	news.freedyn.net	323.1 KB	0.0 KB	1.2 MB	1.6 MB	20%	9.5 KB
12	news.fcku.it	290.2 KB	0.0 KB	291.2 KB	581.4 KB	49%	2.7 KB
13	nntp.pasdenom.info	274.6 KB	3.9 KB	61.3 KB	339.8 KB	80%	2.9 KB
14	news.swapon.de	162.0 KB	0.0 KB	0.0 KB	162.0 KB	100%	2.6 KB
15	news.bbs.geek.nz	33.6 KB	0.0 KB	0.0 KB	33.6 KB	100%	1.8 KB
16	localhost	0.9 KB	0.0 KB	0.0 KB	0.9 KB	100%	0.9 KB
TOTAL: 16		69.4 MB	9.4 MB	172.0 MB	250.8 MB	27%	5.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 12 04:15:00 - 04:59:59	434	1.9%	0.16	1.7 MB	2.4%	0.64
Apr 12 05:00:00 - 05:59:59	661	2.9%	0.18	2.6 MB	3.7%	0.74
Apr 12 06:00:00 - 06:59:59	734	3.2%	0.20	2.4 MB	3.4%	0.68
Apr 12 07:00:00 - 07:59:59	930	4.0%	0.26	2.6 MB	3.7%	0.74
Apr 12 08:00:00 - 08:59:59	1033	4.5%	0.29	2.8 MB	3.9%	0.79
Apr 12 09:00:00 - 09:59:59	1124	4.9%	0.31	3.0 MB	4.3%	0.85
Apr 12 10:00:00 - 10:59:59	1093	4.7%	0.30	3.0 MB	4.2%	0.84
Apr 12 11:00:00 - 11:59:59	1193	5.2%	0.33	3.3 MB	4.8%	0.95
Apr 12 12:00:00 - 12:59:59	1148	5.0%	0.32	3.2 MB	4.6%	0.91
Apr 12 13:00:00 - 13:59:59	1262	5.5%	0.35	3.4 MB	4.8%	0.96
Apr 12 14:00:00 - 14:59:59	1254	5.4%	0.35	3.8 MB	5.5%	1.09
Apr 12 15:00:00 - 15:59:59	1300	5.6%	0.36	4.1 MB	5.9%	1.17
Apr 12 16:00:00 - 16:59:59	1260	5.5%	0.35	3.7 MB	5.3%	1.06
Apr 12 17:00:00 - 17:59:59	1433	6.2%	0.40	4.8 MB	6.8%	1.36
Apr 12 18:00:00 - 18:59:59	1350	5.9%	0.38	4.4 MB	6.3%	1.26
Apr 12 19:00:00 - 19:59:59	1075	4.7%	0.30	3.0 MB	4.2%	0.84
Apr 12 20:00:00 - 20:59:59	1097	4.8%	0.30	3.2 MB	4.5%	0.90
Apr 12 21:00:00 - 21:59:59	965	4.2%	0.27	2.8 MB	4.0%	0.79
Apr 12 22:00:00 - 22:59:59	894	3.9%	0.25	2.8 MB	3.9%	0.79
Apr 12 23:00:00 - 23:59:59	775	3.4%	0.22	2.8 MB	3.9%	0.78
Apr 13 00:00:00 - 00:59:59	541	2.3%	0.15	1.9 MB	2.8%	0.55
Apr 13 01:00:00 - 01:59:59	532	2.3%	0.15	1.6 MB	2.3%	0.45
Apr 13 02:00:00 - 02:59:59	414	1.8%	0.12	1.5 MB	2.1%	0.43
Apr 13 03:00:00 - 03:59:59	430	1.9%	0.12	1.4 MB	2.1%	0.41
Apr 13 04:00:00 - 04:15:00	107	0.5%	0.12	361.7 KB	0.5%	0.40
TOTAL: 24:00:00	23039	100.0%	0.27	70.0 MB	100.0%	0.83

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	9539	360	139	6	9034
2	feeder.eternal-september.org	5732	46	563	0	5123
3	newsfeed.neva.ru	1915	304	51	0	1560
4	csiph-out.news.weretis.net	1098	262	0	0	836
5	news-out.mixmin.net	695	4	0	0	691
6	newsfeed.fu-berlin.de	694	30	0	0	664
7	news.freedyn.net	100	7	0	0	93
8	newsfeeds.xmission.com	60	5	0	0	55
9	news-out.aioe.org	35	29	1	0	5
10	nntp.pasdenom.info	19	12	1	0	6
11	news.fcku.it	11	2	0	0	9
12	news.redatomik.org	8	0	1	0	7
13	news.swapon.de	5	0	0	0	5
14	news.bbs.geek.nz	1	0	0	0	1
15	xanadu-bbs.net	1	0	0	0	1
TOTAL: 15		19913	1061	756	6	18090

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	212
ut.test	116
it-alt.sport.calcio.juventus	89
it.annunci.commerciali	59
it.annunci.varie	33
alt.windows7.general	32
it.annunci.immobiliari	31
mpc.lists.freebsd.gecko	30
mozilla.support.thunderbird	30
gmane.linux.alsa.devel	29
mozilla.dev.security.policy	27
alt.survival	24
lada.auto	24
mpc.lists.freebsd.ports.bugs	22
mpc.lists.freebsd.gnome	15
at.jobs	13
alt.politics	11
spline.eisfair	10
mozilla.general	8
eagle.support.ger	8
TOTAL: 119	1061

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
nz.politics.announce	5
it.scienza.astronomia	1
TOTAL: 2	6

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	15807
EMP (phn path)	1242
EMP (phn nph)	124
User-issued cancel	39
Too many newsgroups	36
Scoring filter (10)	20
HTML Multipart	17
Scoring filter (8)	14
Binary Payload	12
Scoring filter (12)	11
EMP (phl)	11
Scoring filter (11)	5
Scoring filter (16)	4
Scoring filter (14)	4
Scoring filter (13)	2
HTML post	2
Scoring filter (9)	2
User-issued spam cancel	2
Too many newsgroups (meow)	1
Binary: misplaced nfo	1
TOTAL: 23	17359

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	90	0	106	106
TOTAL: 1	90	0	106	106

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	8
	TOTAL: 1	8
Huge articles
	feeder.eternal-september.org	107
	csiph-out.news.weretis.net	71
	news-out.mixmin.net	15
	news.fcku.it	5
	news.freedyn.net	4
	newsfeed.fu-berlin.de	3
	newsfeeds.xmission.com	3
	news.redatomik.org	2
	TOTAL: 8	210
Including strange strings
	newsfeed.fu-berlin.de	381
	csiph-out.news.weretis.net	48
	csiph-out.feeder.erje.net	39
	news-out.mixmin.net	21
	feeder.eternal-september.org	6
	newsfeeds.xmission.com	6
	news-out.aioe.org	5
	news.swapon.de	5
	news.redatomik.org	5
	newsfeed.neva.ru	2
	TOTAL: 11	519
TOTAL: 3		737

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	41657	1482	20741	131	0	3%	23:50:04
2	news.freedyn.net	23713	778	22140	4	0	3%	23:51:50
3	xanadu-bbs	24867	747	22222	0	0	3%	23:59:54
4	fu-berlin.de	21693	584	21108	0	0	2%	23:50:04
5	erje	17101	221	16038	72	18	1%	23:55:31
6	usenet.pasdenom.info	24779	219	21160	1564	14	0%	23:59:54
7	xmission	24214	96	21613	7	0	0%	23:59:45
8	aioe	21106	34	19815	11	0	0%	23:51:08
9	news.redatomik.org	22199	32	21531	5	0	0%	23:53:03
10	weretis.net	15992	9	15537	0	0	0%	23:50:04
11	eternal-september	21012	6	19137	0	0	0%	23:59:54
12	news.fcku.it	2552	3	2468	0	0	0%	22:50:11
13	news.swapon.de	2443	1	2410	0	0	0%	23:53:32
14	news.mixmin.net	21355	1	20456	0	0	0%	23:59:12
15	au2pb	0	0	0	0	22384	0%	23:50:08
16	neva.ru	21370	0	20815	17	0	0%	23:59:52
17	bwh	0	0	0	0	22380	0%	23:50:07
TOTAL: 17		306053	4213	267191	1811	44796	1%	405:24:13

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	5.4 MB	33.5 KB	5.4 MB	0.1 KB/s	7.1 KB	23:51:50
2	xanadu-bbs	5.0 MB	0.0 KB	5.0 MB	0.1 KB/s	6.9 KB	23:59:54
3	fu-berlin.de	4.7 MB	0.0 KB	4.7 MB	0.1 KB/s	8.2 KB	23:50:04
4	news.bbs.geek.nz	4.0 MB	439.8 KB	4.5 MB	0.1 KB/s	2.8 KB	23:50:04
5	erje	1.1 MB	541.9 KB	1.7 MB	0.0 KB/s	5.8 KB	23:55:31
6	usenet.pasdenom.info	739.0 KB	6.3 MB	7.0 MB	0.1 KB/s	4.0 KB	23:59:54
7	xmission	237.5 KB	12.0 KB	249.5 KB	0.0 KB/s	2.4 KB	23:59:45
8	aioe	71.7 KB	55.0 KB	126.7 KB	0.0 KB/s	2.8 KB	23:51:08
9	news.redatomik.org	64.5 KB	26.9 KB	91.4 KB	0.0 KB/s	2.5 KB	23:53:03
10	weretis.net	23.3 KB	0.0 KB	23.3 KB	0.0 KB/s	2.6 KB	23:50:04
11	eternal-september	10.8 KB	0.0 KB	10.8 KB	0.0 KB/s	1.8 KB	23:59:54
12	news.fcku.it	5.3 KB	0.0 KB	5.3 KB	0.0 KB/s	1.8 KB	22:50:11
13	news.swapon.de	0.9 KB	0.0 KB	0.9 KB	0.0 KB/s	0.9 KB	23:53:32
14	news.mixmin.net	0.9 KB	0.0 KB	0.9 KB	0.0 KB/s	0.9 KB	23:59:12
15	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:08
16	neva.ru	0.0 KB	63.7 KB	63.7 KB	0.0 KB/s	3.7 KB	23:59:52
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:07
TOTAL: 17		21.3 MB	7.4 MB	28.8 MB	0.0 KB/s	4.9 KB	405:24:13

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp130-02-70-24-222-72.dsl.bell.ca	1739	136	485.8 KB	16	0	0	03:16:46
2	204-73-239-109.cust.centrio.cz	11	60	138.6 KB	8	0	0	01:52:35
3	144.138.90.254	185	38	97.3 KB	35	0	0	02:48:21
4	g235242.upc-g.chello.nl	3	4	4.8 KB	1	0	0	00:05:36
5	cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	1	1.6 KB	1	0	0	00:01:15
6	dhcp-089-099-203-254.chello.nl	40	1	0.9 KB	1	0	0	09:34:35
7	68-185-181-64.dhcp.mdsn.wi.charter.com	16	1	0.9 KB	1	1	1	04:09:46
TOTAL: 7		1995	241	730.1 KB	63	1	1	25:30:47

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	1739	136	485.8 KB	16	0	0	03:16:46
2	*.cust.centrio.cz	11	60	138.6 KB	8	0	0	01:52:35
3	unresolved	186	38	97.3 KB	35	0	0	02:48:21
4	*.upc-g.chello.nl	3	4	4.8 KB	1	0	0	00:05:36
5	*.dhcp.mdsn.wi.charter.com	16	1	0.9 KB	1	1	1	04:09:46
6	*.chello.nl	40	1	0.9 KB	1	0	0	09:34:35
7	*.19-1.cable.virginm.net	1	1	1.6 KB	1	0	0	00:01:15
8	*.bbox.io	7	0	0.0 KB	0	0	0	03:41:48
TOTAL: 8		2003	241	730.1 KB	63	1	1	25:30:47

NNRP auth users [Top 20]:

User	Conn
moussa	185
ctomczyk	5
ohlandl	1
TOTAL: 3	191

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	3.051	0.761	0.000	09:34:35
68-185-181-64.dhcp.mdsn.wi.charter.com	1.283	0.273	0.004	04:09:46
tempe0.bbox.io	0.624	0.152	0.000	03:41:48
mtrlpq2314w-lp130-02-70-24-222-72.dsl.bell.ca	136.862	32.135	0.000	03:16:46
144.138.90.254	15.481	4.039	0.663	02:48:21
204-73-239-109.cust.centrio.cz	1.053	0.239	0.017	01:52:35
g235242.upc-g.chello.nl	0.237	0.069	0.000	00:05:36
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.147	0.023	0.000	00:01:15
71.6.146.185	0.074	0.030	0.000	00:00:00
TOTAL: 9	158.812	37.721	0.684	25:30:47

Curious NNRP server explorers [Top 20]:

System	Conn
tempe0.bbox.io	7
71.6.146.185	1
TOTAL: 2	8

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	7	0
dhcp-089-099-203-254.chello.nl	5	0
68-185-181-64.dhcp.mdsn.wi.charter.com	5	0
204-73-239-109.cust.centrio.cz	3	0
144.138.90.254	1	0
TOTAL: 5	21	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	100	41.5%
2	alt	84	34.9%
3	uk	20	8.3%
4	fr	16	6.6%
5	linux	12	5.0%
6	pl	5	2.1%
7	sci	1	0.4%
8	aus	1	0.4%
9	rec	1	0.4%
10	talk	1	0.4%
TOTAL: 10		241	100.0%

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

Newsgroup		Count
1	alt.atheism	72
2	comp.lang.javascript	55
3	uk.rec.drugs.cannabis	18
4	fr.soc.politique	16
5	linux.kernel	12
6	comp.os.vms	10
7	comp.sys.ibm.ps2.hardware	10
8	comp.arch	9
9	alt.usage.english	7
10	comp.arch.fpga	6
11	comp.os.msdos.misc	4
12	alt.comp.freeware	4
13	comp.sys.ibm.pc.hardware.chips	4
14	pl.comp.lang.javascript	4
15	comp.os.linux.networking	2
16	uk.legal.moderated	2
17	talk.politics.guns	1
18	alt.activism.death-penalty	1
19	aus.politics	1
20	rec.arts.tv	1
21	pl.comp.www	1
22	sci.math	1
TOTAL: 22		241

Daily Usenet report for csiph.com

Apr 12 04:15:00 -- Apr 13 04:15:00