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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	45357	51.5%	8.5 MB	64.3%
innd	24522	27.9%	2.6 MB	19.7%
nnrpd	14870	16.9%	1.6 MB	11.9%
innfeed	3218	3.7%	539.6 KB	4.0%
nocem	80	0.1%	8.5 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	88048	100.0%	13.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	464260	55.2%
Negative hits	331557	39.4%
Do not exist	44268	5.3%
Cache misses	677	0.1%
TOTAL: 4	840762	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.405	0.0%	225	0.000	1.800	30.000
article cleanup	00:00:00.254	0.0%	44308	0.000	0.006	0.035
article logging	00:00:03.999	0.0%	44958	0.000	0.089	0.509
article parse	00:00:02.962	0.0%	141656	0.003	0.021	0.170
article write	00:02:21.079	0.2%	24901	0.164	5.666	14.344
artlog/artcncl	00:00:00.005	0.0%	184	0.000	0.027	1.500
artlog/artparse	00:00:00.005	0.0%	252	0.000	0.020	0.250
data move	00:00:00.253	0.0%	756300	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.073	0.0%	222	0.000	0.329	23.000
hishave/artcncl	00:00:00.000	0.0%	225	0.000	0.000	0.000
hishave/artparse	00:00:00.000	0.0%	251	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:37.213	0.1%	842861	0.001	0.115	0.305
history sync	00:00:05.901	0.0%	355	0.000	16.623	90.000
history write	00:03:47.516	0.3%	44142	0.088	5.154	17.492
hiswrite/artcncl	00:00:00.014	0.0%	3	0.000	4.667	7.000
hiswrite/artparse	00:00:01.347	0.0%	251	0.000	5.367	59.000
idle	23:45:14.071	98.9%	745835	69.987	114.655	357.618
nntp read	00:00:03.459	0.0%	772095	0.002	0.004	0.007
overview write	00:04:47.996	0.3%	24901	1.844	11.566	256.573
perl filter	00:01:42.834	0.1%	44141	1.578	2.330	3.623
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.416	0.0%	49873	0.000	0.008	0.028
TOTAL: 24:01:08.697	23:59:49.802	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.062	0.0%	24844	0.000	0.002	0.028
article prepare	00:00:00.007	0.0%	38180	0.000	0.000	0.005
article read	00:00:03.690	0.0%	7243	0.021	0.509	5.000
backlog stats	00:00:00.247	0.0%	448339	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.240	0.0%	350474	0.003	0.006	0.011
data write	00:00:01.978	0.0%	334976	0.002	0.006	0.012
idle	23:53:06.963	100.0%	448339	117.506	191.790	551.446
status file	00:00:00.239	0.0%	298	0.000	0.802	11.000
TOTAL: 23:53:24.883	23:53:15.426	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.175	0.0%	94	0.000	1.862	41.000
idle	76:03:51.366	99.6%	188113	81.975	1455.675	1164487.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:15.370	0.0%	488077	0.000	0.031	16.753
readart	00:08:03.221	0.2%	207283	0.000	2.331	52.000
TOTAL: 76:21:33.636	76:12:10.132	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	138040	7654	119314	11072	5%	94:57:50
2	csiph-out.news.weretis.net	3	56438	5014	50396	1028	8%	50:09:32
3	feeder.eternal-september.org	1	40086	3677	32784	3625	9%	24:10:34
4	news-out.aioe.org	2	24350	1886	22430	34	7%	24:09:56
5	news-out.mixmin.net	3	26958	1570	24952	436	5%	24:08:58
6	newsfeed.neva.ru	148	56054	1473	51564	3017	2%	72:22:30
7	newsfeed.fu-berlin.de	73	25162	1335	23586	241	5%	36:29:05
8	news.redatomik.org	1	24783	870	23906	7	3%	25:21:08
9	newsfeeds.xmission.com	3	24657	654	23995	8	2%	25:17:01
10	news.freedyn.net	3	29097	234	28651	212	0%	24:09:49
11	news.fcku.it	2	10667	151	10491	25	1%	23:59:46
12	nntp.pasdenom.info	1	38934	60	38858	16	0%	23:59:55
13	xanadu-bbs.net	11	791	59	730	2	7%	22:48:11
14	news.bbs.geek.nz	2	17403	5	17398	0	0%	23:59:27
15	news.swapon.de	1	100	1	98	1	1%	03:30:32
16	localhost	35	0	0	0	0	0%	00:00:00
TOTAL: 16		1441	513520	24643	469153	19724	4%	499:34:14

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	24.3 MB	1.5 MB	67.5 MB	93.3 MB	26%	5.1 KB
2	csiph-out.news.weretis.net	14.7 MB	19.6 KB	12.1 MB	26.8 MB	54%	4.5 KB
3	feeder.eternal-september.org	9.6 MB	309.0 KB	53.4 MB	63.3 MB	15%	8.9 KB
4	news-out.mixmin.net	6.9 MB	8.7 KB	1.3 MB	8.2 MB	83%	4.2 KB
5	news-out.aioe.org	4.6 MB	13.0 KB	240.9 KB	4.9 MB	94%	2.6 KB
6	newsfeed.neva.ru	4.3 MB	36.9 KB	24.2 MB	28.6 MB	15%	6.5 KB
7	newsfeed.fu-berlin.de	3.0 MB	1.5 KB	795.6 KB	3.7 MB	79%	2.4 KB
8	news.redatomik.org	2.4 MB	0.0 KB	1.2 MB	3.6 MB	67%	4.2 KB
9	newsfeeds.xmission.com	2.0 MB	2.4 KB	312.7 KB	2.3 MB	86%	3.5 KB
10	news.freedyn.net	677.0 KB	4.2 KB	4.6 MB	5.3 MB	12%	12.1 KB
11	news.fcku.it	305.5 KB	0.0 KB	1.3 MB	1.6 MB	19%	9.0 KB
12	xanadu-bbs.net	125.7 KB	0.0 KB	15.2 KB	140.9 KB	89%	2.3 KB
13	nntp.pasdenom.info	110.4 KB	3.5 KB	46.4 KB	160.2 KB	68%	2.1 KB
14	news.bbs.geek.nz	11.7 KB	0.0 KB	0.0 KB	11.7 KB	100%	2.3 KB
15	news.swapon.de	1.0 KB	2.2 KB	2.2 KB	5.4 KB	17%	2.7 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		73.0 MB	1.9 MB	167.0 MB	241.9 MB	30%	5.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 9 04:15:00 - 04:59:59	330	1.3%	0.12	1.1 MB	1.4%	0.40
Jan 9 05:00:00 - 05:59:59	590	2.4%	0.16	2.1 MB	2.9%	0.61
Jan 9 06:00:00 - 06:59:59	575	2.3%	0.16	1.9 MB	2.5%	0.53
Jan 9 07:00:00 - 07:59:59	679	2.7%	0.19	2.2 MB	3.0%	0.63
Jan 9 08:00:00 - 08:59:59	1047	4.2%	0.29	3.3 MB	4.5%	0.95
Jan 9 09:00:00 - 09:59:59	1058	4.2%	0.29	2.8 MB	3.8%	0.80
Jan 9 10:00:00 - 10:59:59	1069	4.3%	0.30	3.1 MB	4.2%	0.88
Jan 9 11:00:00 - 11:59:59	1003	4.0%	0.28	2.9 MB	3.9%	0.81
Jan 9 12:00:00 - 12:59:59	1100	4.4%	0.31	3.1 MB	4.2%	0.88
Jan 9 13:00:00 - 13:59:59	1176	4.7%	0.33	3.1 MB	4.2%	0.88
Jan 9 14:00:00 - 14:59:59	1257	5.0%	0.35	3.1 MB	4.2%	0.89
Jan 9 15:00:00 - 15:59:59	1462	5.9%	0.41	4.4 MB	6.0%	1.25
Jan 9 16:00:00 - 16:59:59	1575	6.3%	0.44	5.4 MB	7.3%	1.54
Jan 9 17:00:00 - 17:59:59	1482	6.0%	0.41	4.0 MB	5.4%	1.15
Jan 9 18:00:00 - 18:59:59	1411	5.7%	0.39	3.9 MB	5.2%	1.10
Jan 9 19:00:00 - 19:59:59	1540	6.2%	0.43	4.8 MB	6.6%	1.38
Jan 9 20:00:00 - 20:59:59	1433	5.8%	0.40	3.9 MB	5.3%	1.12
Jan 9 21:00:00 - 21:59:59	1236	5.0%	0.34	3.5 MB	4.7%	0.99
Jan 9 22:00:00 - 22:59:59	1249	5.0%	0.35	3.6 MB	4.9%	1.04
Jan 9 23:00:00 - 23:59:59	995	4.0%	0.28	3.2 MB	4.4%	0.92
Jan 10 00:00:00 - 00:59:59	852	3.4%	0.24	2.6 MB	3.5%	0.73
Jan 10 01:00:00 - 01:59:59	675	2.7%	0.19	2.2 MB	3.0%	0.63
Jan 10 02:00:00 - 02:59:59	466	1.9%	0.13	1.4 MB	1.9%	0.39
Jan 10 03:00:00 - 03:59:59	500	2.0%	0.14	1.8 MB	2.4%	0.51
Jan 10 04:00:00 - 04:15:00	135	0.5%	0.15	457.3 KB	0.6%	0.51
TOTAL: 24:00:00	24895	100.0%	0.29	73.9 MB	100.0%	0.88

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	11092	416	131	10545
2	feeder.eternal-september.org	3603	60	20	3523
3	newsfeed.neva.ru	2978	494	5	2479
4	csiph-out.news.weretis.net	1092	273	0	819
5	newsfeed.fu-berlin.de	753	29	1	723
6	news-out.mixmin.net	451	0	3	448
7	news.freedyn.net	213	22	1	190
8	news-out.aioe.org	28	21	3	4
9	news.fcku.it	19	0	0	19
10	nntp.pasdenom.info	16	1	1	14
11	news.swapon.de	16	0	1	15
12	news.redatomik.org	8	0	0	8
13	newsfeeds.xmission.com	7	1	1	5
14	xanadu-bbs.net	2	0	0	2
TOTAL: 14		20278	1317	167	18794

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	337
lada.auto	83
ut.test	71
it.annunci.varie	58
it.annunci.commerciali	57
it.annunci.immobiliari	56
it-alt.sport.calcio.juventus	56
gmane.linux.alsa.devel	38
gmane.comp.gis.openstreetmap.tagging	33
alt.windows7.general	25
alt.2600	22
mpc.lists.nanog	21
lada.photo	19
eagle.userchat.eng	17
gmane.comp.bacula.user	16
alt.survival	15
mozilla.test	14
alt.politics.scorched-earth	14
mozilla.support.seamonkey	14
alt.pl.nieruchomosci.gielda	12
TOTAL: 148	1317

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	15212
EMP (phn path)	1690
EMP (phl)	544
EMP (phn nph)	174
Too many newsgroups	116
HTML Multipart	30
Scoring filter (12)	29
Scoring filter (8)	20
User-issued cancel	17
Scoring filter (10)	12
Binary Payload	12
Binary: misplaced rar	10
Scoring filter (14)	6
Binary: misplaced par2	4
Scoring filter (15)	3
Too many newsgroups (low_xpost)	3
Scoring filter (17)	2
Scoring filter (13)	2
HTML post	2
User-issued spam cancel	2
TOTAL: 24	17894

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	TOTAL: 1	4
Huge articles
	feeder.eternal-september.org	141
	csiph-out.news.weretis.net	46
	news.freedyn.net	43
	news.fcku.it	8
	news-out.mixmin.net	5
	newsfeeds.xmission.com	3
	newsfeed.fu-berlin.de	3
	news.swapon.de	1
	news.redatomik.org	1
	TOTAL: 9	251
Including strange strings
	newsfeed.fu-berlin.de	520
	csiph-out.feeder.erje.net	42
	csiph-out.news.weretis.net	27
	news-out.mixmin.net	18
	news.swapon.de	14
	feeder.eternal-september.org	9
	newsfeed.neva.ru	8
	news.redatomik.org	5
	news-out.aioe.org	4
	newsfeeds.xmission.com	1
	TOTAL: 11	649
TOTAL: 3		904

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	42185	5315	18756	133	0	12%	23:54:03
2	news.freedyn.net	25273	759	23804	6	0	3%	23:50:06
3	xanadu-bbs	28407	690	24139	3	13	2%	23:59:55
4	fu-berlin.de	23171	589	22582	0	0	2%	23:59:51
5	usenet.pasdenom.info	27464	99	22975	1761	0	0%	23:59:53
6	news.redatomik.org	23930	30	23184	5	0	0%	23:51:44
7	aioe	21984	29	20836	10	0	0%	23:50:06
8	eternal-september	22107	20	20222	0	0	0%	23:59:55
9	xmission	27062	12	23483	2	1	0%	23:59:40
10	weretis.net	18103	10	17864	0	0	0%	23:52:23
11	neva.ru	23410	2	22458	45	0	0%	23:59:55
12	erje	17227	2	17113	21	5	0%	23:55:03
13	news.mixmin.net	23013	1	22179	0	0	0%	23:59:49
14	news.fcku.it	2905	1	2847	0	0	0%	22:36:19
15	au2pb	0	0	0	0	24271	0%	23:58:42
16	news.swapon.de	2321	0	2299	0	0	0%	23:59:19
17	bwh	0	0	0	0	24172	0%	23:50:04
TOTAL: 17		328562	7559	284741	1986	48462	2%	405:36:47

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	14.2 MB	620.0 KB	14.8 MB	0.2 KB/s	2.8 KB	23:54:03
2	news.freedyn.net	6.1 MB	24.2 KB	6.1 MB	0.1 KB/s	8.1 KB	23:50:06
3	xanadu-bbs	5.8 MB	7.4 KB	5.8 MB	0.1 KB/s	8.6 KB	23:59:55
4	fu-berlin.de	5.5 MB	0.0 KB	5.5 MB	0.1 KB/s	9.6 KB	23:59:51
5	usenet.pasdenom.info	355.1 KB	7.6 MB	7.9 MB	0.1 KB/s	4.4 KB	23:59:53
6	aioe	93.9 KB	47.6 KB	141.4 KB	0.0 KB/s	3.6 KB	23:50:06
7	news.redatomik.org	82.8 KB	18.8 KB	101.6 KB	0.0 KB/s	2.9 KB	23:51:44
8	eternal-september	56.6 KB	0.0 KB	56.6 KB	0.0 KB/s	2.8 KB	23:59:55
9	xmission	34.3 KB	11.2 KB	45.4 KB	0.0 KB/s	3.2 KB	23:59:40
10	weretis.net	30.1 KB	0.0 KB	30.1 KB	0.0 KB/s	3.0 KB	23:52:23
11	erje	9.5 KB	122.9 KB	132.4 KB	0.0 KB/s	5.8 KB	23:55:03
12	neva.ru	5.7 KB	209.6 KB	215.3 KB	0.0 KB/s	4.6 KB	23:59:55
13	news.mixmin.net	2.0 KB	0.0 KB	2.0 KB	0.0 KB/s	2.0 KB	23:59:49
14	news.fcku.it	1.3 KB	0.0 KB	1.3 KB	0.0 KB/s	1.3 KB	22:36:19
15	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
16	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:19
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:04
TOTAL: 17		32.3 MB	8.6 MB	40.9 MB	0.0 KB/s	4.4 KB	405:36:47

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca	287	55483	164.0 MB	430	05:02:33
2	194-73-239-109.cust.centrio.cz	28	25	74.6 KB	8	02:41:32
3	tempe0.bbox.io	22	9	38.1 KB	3	04:50:13
4	109.239.73.194	2	2	6.8 KB	1	00:03:33
5	91.199.153.3	1	1	1.3 KB	1	00:01:14
6	dhcp-089-099-203-254.chello.nl	44	1	1.0 KB	1	14:21:43
TOTAL: 6		384	55521	164.1 MB	444	76:21:29

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	287	55483	164.0 MB	430	05:02:33
2	*.cust.centrio.cz	28	25	74.6 KB	8	02:41:32
3	*.bbox.io	22	9	38.1 KB	3	04:50:13
4	unresolved	94	3	8.1 KB	2	46:07:26
5	*.chello.nl	44	1	1.0 KB	1	14:21:43
6	*.251.91.75.dynamic.ip.windstream.net	1	0	0.0 KB	0	00:00:00
7	*.dhcp.mdsn.wi.charter.com	10	0	0.0 KB	0	03:17:58
TOTAL: 7		486	55521	164.1 MB	444	76:21:29

NNRP auth users [Top 20]:

User	Conn
ctomczyk	9
TOTAL: 1	9

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
216.239.174.218	6.778	1.424	0.000	46:02:39
dhcp-089-099-203-254.chello.nl	3.426	0.540	0.000	14:21:43
mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca	34.823	23.283	0.000	05:02:33
tempe0.bbox.io	1.835	0.425	0.000	04:50:13
68-185-181-64.dhcp.mdsn.wi.charter.com	0.778	0.168	0.000	03:17:58
194-73-239-109.cust.centrio.cz	2.093	0.482	0.030	02:41:32
109.239.73.194	0.198	0.041	0.003	00:03:33
91.199.153.3	4.460	3.450	0.000	00:01:14
TOTAL: 8	54.391	29.813	0.033	76:21:29

Curious NNRP server explorers [Top 20]:

System	Conn
216.239.174.218	91
68-185-181-64.dhcp.mdsn.wi.charter.com	10
h23.251.91.75.dynamic.ip.windstream.net	1
TOTAL: 3	102

NNRP client timeouts [Top 20]:

System	Conn	Peer
216.239.174.218	88	0
tempe0.bbox.io	8	0
194-73-239-109.cust.centrio.cz	4	0
68-185-181-64.dhcp.mdsn.wi.charter.com	4	0
mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca	2	0
TOTAL: 5	106	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	55371	99.7%
2	uk	50	0.1%
3	comp	37	0.1%
4	rec	22	0.0%
5	soc	12	0.0%
6	muc	8	0.0%
7	talk	4	0.0%
8	pl	4	0.0%
9	linux	3	0.0%
10	sci	3	0.0%
11	aus	3	0.0%
12	misc	2	0.0%
13	can	1	0.0%
14	fr	1	0.0%
TOTAL: 14		55521	100.0%

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

Newsgroup		Count
1	alt.arts.poetry.comments	55199
2	alt.politics.economics	39
3	alt.christnet.christianlife	36
4	alt.free.newsservers	28
5	comp.lang.javascript	23
6	alt.society.liberalism	17
7	alt.global-warming	14
8	comp.lang.python	12
9	rec.boats	10
10	uk.legal	10
11	rec.arts.tv	8
12	uk.games.video.misc	7
13	alt.home.repair	7
14	muc.lists.freebsd.stable	7
15	uk.radio.amateur	7
16	alt.atheism	6
17	soc.culture.usa	6
18	alt.russian.z1	5
19	alt.comp.freeware	5
20	uk.media.radio.archers	5
21	soc.retirement	4
22	alt.bible.prophecy	4
23	uk.d-i-y	4
24	talk.politics.misc	4
25	aus.politics	3
26	linux.kernel	3
27	alt.sports.basketball.nba.gs-warriors	3
28	uk.rec.drugs.cannabis	3
29	pl.comp.www	3
30	misc.survivalism	2
31	uk.politics.misc	2
32	comp.sys.ibm.ps2.hardware	2
33	uk.railway	2
34	soc.culture.polish	2
35	uk.rec.sheds	2
36	sci.math	2
37	uk.rec.cycling	2
38	rec.music.bluenote	2
39	uk.rec.motorcycles	2
40	alt.california	2
41	pl.comp.www.nowe-strony	1
42	alt.sex.phone	1
43	alt.sports.football.pro.dallas-cowboys	1
44	sci.physics	1
45	uk.sci.weather	1
46	muc.lists.freebsd.current	1
47	can.politics	1
48	alt.os.linux	1
49	rec.arts.tv.uk.coronation-st	1
50	alt.bbs.lists	1
51	uk.tech.digital-tv	1
52	alt.conspiracy	1
53	rec.arts.sf.written	1
54	uk.people.silversurfers	1
55	alt.astronomy	1
56	uk.media.tv.misc	1
57	fr.soc.politique	1
TOTAL: 57		55521

Daily Usenet report for csiph.com

Jan 9 04:15:00 -- Jan 10 04:15:00