Daily Usenet report for csiph.com: Dec 28 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	28773	55.9%	6.2 MB	70.2%
innd	13053	25.4%	1.5 MB	17.4%
nnrpd	6106	11.9%	527.1 KB	5.8%
innfeed	3459	6.7%	589.2 KB	6.5%
nocem	96	0.2%	10.4 KB	0.1%
controlchan	3	0.0%	0.3 KB	0.0%
TOTAL: 6	51490	100.0%	8.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	310383	54.7%
Negative hits	228747	40.3%
Do not exist	27677	4.9%
Cache misses	428	0.1%
TOTAL: 4	567235	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.697	0.0%	270	0.000	6.285	40.864
article cleanup	00:00:00.206	0.0%	27499	0.000	0.007	0.026
article logging	00:00:00.752	0.0%	28165	0.000	0.027	0.400
article parse	00:00:03.584	0.0%	73441	0.000	0.049	1.279
article write	00:01:34.234	0.1%	20394	0.233	4.621	36.245
artlog/artcncl	00:00:00.000	0.0%	197	0.000	0.000	0.000
artlog/artparse	00:00:00.019	0.0%	419	0.000	0.045	2.600
data move	00:00:00.166	0.0%	548069	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.278	0.0%	268	0.000	1.037	11.818
hishave/artcncl	00:00:00.189	0.0%	270	0.000	0.700	8.273
hishave/artparse	00:00:00.001	0.0%	419	0.000	0.002	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:15.838	0.1%	570207	0.004	0.133	0.796
history sync	00:00:01.073	0.0%	354	0.000	3.031	13.000
history write	00:01:32.777	0.1%	27497	0.283	3.374	21.762
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hiswrite/artparse	00:00:02.584	0.0%	419	0.000	6.167	56.318
idle	23:52:06.994	99.4%	547990	92.633	156.804	379.425
nntp read	00:00:02.687	0.0%	558631	0.002	0.005	0.009
overview write	00:02:38.062	0.2%	20394	0.309	7.750	727.400
perl filter	00:00:52.136	0.1%	27489	1.264	1.897	3.398
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.367	0.0%	40877	0.000	0.009	0.031
TOTAL: 24:00:55.093	24:00:13.644	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.044	0.0%	21334	0.000	0.002	0.019
article prepare	00:00:00.002	0.0%	17756	0.000	0.000	0.010
article read	00:00:01.243	0.0%	2481	0.000	0.501	8.667
backlog stats	00:00:00.262	0.0%	372964	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.915	0.0%	289633	0.001	0.007	0.012
data write	00:00:01.605	0.0%	272044	0.001	0.006	0.012
idle	23:53:15.713	100.0%	372964	125.498	230.574	588.137
status file	00:00:00.360	0.0%	315	0.000	1.143	28.000
TOTAL: 23:53:31.966	23:53:21.144	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	21:51:03.472	100.0%	6026	402.443	13054.011	600072.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.078	0.0%	12514	0.000	0.006	0.167
readart	00:00:00.999	0.0%	110	0.000	9.082	63.000
TOTAL: 21:51:32.235	21:51:04.549	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	136
pause	2
paused	2
reload	2
reserve	2
shutdown	6
TOTAL: 11	162

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	11	40519	5461	34643	415	13%	49:05:14
2	csiph-out.feeder.erje.net	1158	86601	4295	79678	2628	4%	94:31:14
3	feeder.eternal-september.org	11	23643	2395	20160	1088	10%	25:09:09
4	news-out.mixmin.net	4	20323	2316	17552	455	11%	24:06:32
5	news-out.aioe.org	3	19240	1688	17530	22	8%	24:04:56
6	newsfeed.fu-berlin.de	14	17915	1208	16627	80	6%	22:51:28
7	newsfeed.neva.ru	146	25573	987	22074	2512	3%	71:21:56
8	news.redatomik.org	3	19701	623	19075	3	3%	26:24:55
9	news.fcku.it	3	6269	497	5614	158	7%	18:07:30
10	newsfeeds.xmission.com	4	14110	486	13621	3	3%	17:57:00
11	news.freedyn.net	3	19262	151	19059	52	0%	22:21:19
12	nntp.pasdenom.info	4	17738	75	17657	6	0%	23:57:18
13	news.swapon.de	7	1549	49	1499	1	3%	22:01:12
14	localhost	38	5	5	0	0	100%	00:00:06
15	xanadu-bbs.net	25	523	4	518	1	0%	22:08:51
16	news.bbs.geek.nz	3	17530	1	17529	0	0%	23:57:46
TOTAL: 16		1437	330501	20241	302836	7424	6%	488:06:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	16.4 MB	0.0 KB	12.8 MB	29.2 MB	56%	5.1 KB
2	csiph-out.feeder.erje.net	16.2 MB	23.5 KB	19.5 MB	35.7 MB	45%	5.3 KB
3	news-out.mixmin.net	6.8 MB	0.0 KB	1.1 MB	7.9 MB	86%	2.9 KB
4	feeder.eternal-september.org	6.2 MB	0.0 KB	5.7 MB	11.9 MB	52%	3.5 KB
5	news-out.aioe.org	3.8 MB	0.0 KB	31.1 KB	3.9 MB	99%	2.3 KB
6	newsfeed.fu-berlin.de	2.6 MB	0.0 KB	178.0 KB	2.8 MB	93%	2.2 KB
7	newsfeed.neva.ru	2.4 MB	29.6 KB	10.4 MB	12.9 MB	18%	3.8 KB
8	news.redatomik.org	1.5 MB	0.0 KB	5.6 KB	1.5 MB	99%	2.5 KB
9	newsfeeds.xmission.com	1.4 MB	0.0 KB	99.0 KB	1.5 MB	93%	3.1 KB
10	news.fcku.it	1.0 MB	0.0 KB	1.4 MB	2.4 MB	42%	3.8 KB
11	news.freedyn.net	472.7 KB	0.0 KB	162.2 KB	634.8 KB	74%	3.1 KB
12	nntp.pasdenom.info	168.3 KB	0.0 KB	16.8 KB	185.1 KB	90%	2.3 KB
13	news.swapon.de	131.5 KB	0.0 KB	296.7 KB	428.2 KB	30%	8.6 KB
14	xanadu-bbs.net	13.0 KB	0.0 KB	1.6 KB	14.6 KB	89%	2.9 KB
15	localhost	8.2 KB	0.0 KB	0.0 KB	8.2 KB	100%	1.6 KB
16	news.bbs.geek.nz	1.5 KB	0.0 KB	0.0 KB	1.5 KB	100%	1.5 KB
TOTAL: 16		59.3 MB	53.1 KB	51.7 MB	111.0 MB	53%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 28 04:15:00 - 04:59:59	269	1.3%	0.10	792.9 KB	1.3%	0.29
Dec 28 05:00:00 - 05:59:59	431	2.1%	0.12	1.4 MB	2.4%	0.41
Dec 28 06:00:00 - 06:59:59	433	2.1%	0.12	1.4 MB	2.4%	0.40
Dec 28 07:00:00 - 07:59:59	561	2.7%	0.16	1.8 MB	3.0%	0.51
Dec 28 08:00:00 - 08:59:59	763	3.7%	0.21	2.1 MB	3.4%	0.59
Dec 28 09:00:00 - 09:59:59	866	4.2%	0.24	2.7 MB	4.6%	0.78
Dec 28 10:00:00 - 10:59:59	1023	5.0%	0.28	3.1 MB	5.1%	0.87
Dec 28 11:00:00 - 11:59:59	1004	4.9%	0.28	3.5 MB	5.9%	1.00
Dec 28 12:00:00 - 12:59:59	1000	4.9%	0.28	2.7 MB	4.5%	0.77
Dec 28 13:00:00 - 13:59:59	1036	5.1%	0.29	2.8 MB	4.7%	0.80
Dec 28 14:00:00 - 14:59:59	998	4.9%	0.28	2.8 MB	4.7%	0.79
Dec 28 15:00:00 - 15:59:59	1108	5.4%	0.31	3.4 MB	5.6%	0.96
Dec 28 16:00:00 - 16:59:59	1229	6.0%	0.34	3.3 MB	5.4%	0.93
Dec 28 17:00:00 - 17:59:59	1255	6.1%	0.35	3.2 MB	5.4%	0.91
Dec 28 18:00:00 - 18:59:59	1191	5.8%	0.33	3.2 MB	5.3%	0.90
Dec 28 19:00:00 - 19:59:59	1157	5.7%	0.32	3.3 MB	5.6%	0.95
Dec 28 20:00:00 - 20:59:59	1103	5.4%	0.31	2.9 MB	4.9%	0.83
Dec 28 21:00:00 - 21:59:59	1019	5.0%	0.28	3.0 MB	5.0%	0.85
Dec 28 22:00:00 - 22:59:59	887	4.3%	0.25	2.6 MB	4.3%	0.73
Dec 28 23:00:00 - 23:59:59	744	3.6%	0.21	2.5 MB	4.2%	0.72
Dec 29 00:00:00 - 00:59:59	769	3.8%	0.21	2.4 MB	4.1%	0.69
Dec 29 01:00:00 - 01:59:59	510	2.5%	0.14	1.5 MB	2.6%	0.44
Dec 29 02:00:00 - 02:59:59	430	2.1%	0.12	1.3 MB	2.1%	0.36
Dec 29 03:00:00 - 03:59:59	486	2.4%	0.14	1.7 MB	2.9%	0.49
Dec 29 04:00:00 - 04:15:00	168	0.8%	0.19	492.4 KB	0.8%	0.55
TOTAL: 24:00:00	20440	100.0%	0.24	59.8 MB	100.0%	0.71

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	2656	206	1	1	2448
2	newsfeed.neva.ru	2502	254	1	0	2247
3	feeder.eternal-september.org	1138	37	0	0	1101
4	newsfeed.fu-berlin.de	572	16	0	0	556
5	news-out.mixmin.net	500	4	0	0	496
6	csiph-out.news.weretis.net	466	222	0	0	244
7	news.fcku.it	171	0	0	0	171
8	news.freedyn.net	69	6	0	0	63
9	news-out.aioe.org	31	17	0	0	14
10	news.redatomik.org	18	0	0	0	18
11	nntp.pasdenom.info	6	5	0	0	1
12	newsfeeds.xmission.com	3	1	0	0	2
13	news.swapon.de	3	0	0	0	3
14	xanadu-bbs.net	1	0	0	0	1
TOTAL: 14		8136	768	2	1	7365

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	159
mpc.lists.freebsd.ports.bugs	80
mpc.lists.nanog	66
it.annunci.varie	33
it.annunci.commerciali	33
it.annunci.immobiliari	31
mozilla.support.firefox	18
mpc.lists.freebsd.x11	18
gmane.comp.gis.openstreetmap.tagging	15
mozilla.general	15
lada.auto	14
alt.windows7.general	14
alt.job	14
gmane.comp.gis.openstreetmap	13
alt.english.usage	10
it-alt.comp.software.mozilla	10
alt.philosophy	9
at.jobs	9
oesterreich.tratsch	8
att.jobs	8
TOTAL: 111	768

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

Groups	Count
free.shqip.kulture	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5958
Binary: misplaced rar	96
EMP (phn path)	76
Scoring filter (11)	22
HTML Multipart	22
Too many newsgroups	21
EMP (phn nph)	21
Scoring filter (10)	17
User-issued cancel	15
Scoring filter (8)	9
Scoring filter (12)	7
Binary Payload	6
Scoring filter (17)	4
Scoring filter (14)	4
Scoring filter (9)	3
Scoring filter (13)	2
Too many newsgroups (meow)	2
Too many newsgroups (low_xpost)	2
Binary: misplaced 005	1
Binary: misplaced 028	1
TOTAL: 24	6293

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	88	0	98	98
TOTAL: 1	88	1	98	98

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.feeder.erje.net	231
	csiph-out.news.weretis.net	134
	feeder.eternal-september.org	16
	news.fcku.it	8
	news-out.mixmin.net	5
	newsfeeds.xmission.com	2
	news.freedyn.net	1
	news.swapon.de	1
	TOTAL: 8	398
Including strange strings
	newsfeed.fu-berlin.de	493
	csiph-out.news.weretis.net	55
	csiph-out.feeder.erje.net	45
	news-out.mixmin.net	43
	news.redatomik.org	16
	news-out.aioe.org	9
	news.fcku.it	2
	news.swapon.de	2
	newsfeed.neva.ru	1
	TOTAL: 9	666
TOTAL: 2		1064

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.geek.nz	37263	1035	18637	140	1	4	2%	23:54:18
2	news.freedyn.net	21269	708	19474	5	1	1	3%	23:54:18
3	xanadu-bbs	22911	588	19831	0	0	0	2%	23:58:48
4	fu-berlin.de	18924	500	18423	0	0	1	2%	23:58:48
5	usenet.pasdenom.info	21188	102	19049	1206	0	7	0%	23:58:48
6	aioe	17554	39	16957	1	0	0	0%	23:54:17
7	erje	16398	25	15880	2	0	8	0%	23:54:18
8	news.redatomik.org	19900	10	19246	0	0	943	0%	23:54:23
9	eternal-september	17670	9	17224	0	0	1	0%	23:58:48
10	neva.ru	19016	9	18652	42	0	0	0%	23:58:48
11	xmission	21153	8	19216	0	0	1	0%	23:58:48
12	weretis.net	14974	8	14092	0	0	0	0%	23:54:18
13	news.mixmin.net	17656	7	17339	0	0	1	0%	23:58:48
14	news.swapon.de	1689	5	1665	0	0	0	0%	23:45:58
15	news.fcku.it	1634	0	1620	0	0	0	0%	22:21:08
16	bwh	0	0	0	0	0	19867	0%	23:57:01
17	au2pb	0	0	0	0	0	19873	0%	23:55:08
TOTAL: 17		269199	3053	237305	1396	2	40707	1%	405:16:43

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	6.1 MB	13.4 KB	6.1 MB	0.1 KB/s	8.8 KB	23:54:18
2	xanadu-bbs	5.7 MB	0.0 KB	5.7 MB	0.1 KB/s	9.9 KB	23:58:48
3	fu-berlin.de	5.5 MB	0.0 KB	5.5 MB	0.1 KB/s	11.3 KB	23:58:48
4	news.bbs.geek.nz	2.9 MB	405.0 KB	3.3 MB	0.0 KB/s	2.9 KB	23:54:18
5	usenet.pasdenom.info	321.7 KB	6.6 MB	6.9 MB	0.1 KB/s	5.4 KB	23:58:48
6	aioe	108.5 KB	0.6 KB	109.2 KB	0.0 KB/s	2.7 KB	23:54:17
7	erje	58.0 KB	3.0 KB	61.0 KB	0.0 KB/s	2.3 KB	23:54:18
8	neva.ru	23.9 KB	106.6 KB	130.5 KB	0.0 KB/s	2.6 KB	23:58:48
9	eternal-september	19.4 KB	0.0 KB	19.4 KB	0.0 KB/s	2.2 KB	23:58:48
10	news.redatomik.org	16.7 KB	0.0 KB	16.7 KB	0.0 KB/s	1.7 KB	23:54:23
11	xmission	15.5 KB	0.0 KB	15.5 KB	0.0 KB/s	1.9 KB	23:58:48
12	weretis.net	14.0 KB	0.0 KB	14.0 KB	0.0 KB/s	1.7 KB	23:54:18
13	news.mixmin.net	13.5 KB	0.0 KB	13.5 KB	0.0 KB/s	1.9 KB	23:58:48
14	news.swapon.de	8.2 KB	0.0 KB	8.2 KB	0.0 KB/s	1.6 KB	23:45:58
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:21:08
16	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:01
17	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:55:08
TOTAL: 17		20.8 MB	7.1 MB	27.9 MB	0.0 KB/s	6.4 KB	405:16:43

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	141.168.117.108	48	88	238.6 KB	62	0	0	00:42:35
2	tempe0.bbox.io	28	19	35.3 KB	7	5	5	10:22:19
3	a131033.upc-a.chello.nl	37	3	5.2 KB	3	0	0	10:16:29
TOTAL: 3		113	110	279.1 KB	72	5	5	21:51:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	48	88	238.6 KB	62	0	0	00:42:35
2	*.bbox.io	28	19	35.3 KB	7	5	5	10:22:19
3	*.upc-a.chello.nl	37	3	5.2 KB	3	0	0	10:16:29
4	*.nielsenmedia.com	1	0	0.0 KB	0	0	0	00:30:06
TOTAL: 4		114	110	279.1 KB	72	5	5	21:51:31

NNRP auth users [Top 20]:

User	Conn
moussa	48
kev009	5
TOTAL: 2	53

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
tempe0.bbox.io	2.331	0.405	0.017	10:22:19
a131033.upc-a.chello.nl	2.809	0.500	0.000	10:16:29
141.168.117.108	5.479	1.082	0.175	00:42:35
challenger.nielsenmedia.com	0.061	0.007	0.000	00:30:06
TOTAL: 4	10.680	1.994	0.192	21:51:31

Curious NNRP server explorers [Top 20]:

System	Conn
challenger.nielsenmedia.com	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	13	0
challenger.nielsenmedia.com	1	0
TOTAL: 2	14	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	66	60.0%
2	alt	44	40.0%
TOTAL: 2		110	100.0%

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

Newsgroup		Count
1	alt.comp.freeware	44
2	comp.os.vms	16
3	comp.arch	12
4	comp.sys.ibm.ps2.hardware	12
5	comp.unix.misc	11
6	comp.sys.ibm.as400.misc	7
7	comp.arch.embedded	4
8	comp.arch.fpga	1
9	comp.sys.ibm.pc.games.action	1
10	comp.unix.aix	1
11	comp.os.cpm	1
TOTAL: 11		110

Daily Usenet report for csiph.com

Dec 28 04:15:00 -- Dec 29 04:15:00