Daily Usenet report for csiph.com: Feb 11 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23557	54.4%	5.1 MB	66.5%
innd	11794	27.2%	1.5 MB	19.1%
nnrpd	5079	11.7%	612.7 KB	7.8%
innfeed	2815	6.5%	512.8 KB	6.6%
nocem	43	0.1%	4.4 KB	0.1%
TOTAL: 5	43288	100.0%	7.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	312612	56.3%
Negative hits	219821	39.6%
Do not exist	22786	4.1%
Cache misses	374	0.1%
TOTAL: 4	555593	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.923	0.0%	110	0.000	8.391	83.000
article cleanup	00:00:00.142	0.0%	22591	0.000	0.006	0.072
article logging	00:00:00.456	0.0%	23160	0.000	0.020	0.269
article parse	00:00:01.156	0.0%	66946	0.000	0.017	0.222
article write	00:00:31.081	0.0%	18196	0.182	1.708	59.500
artlog/artcncl	00:00:00.013	0.0%	80	0.000	0.163	4.333
artlog/artparse	00:00:00.014	0.0%	316	0.000	0.044	6.000
data move	00:00:00.132	0.0%	525792	0.000	0.000	0.007
hisgrep/artcncl	00:00:00.198	0.0%	102	0.000	1.941	20.143
hishave/artcncl	00:00:00.003	0.0%	110	0.000	0.027	1.000
hishave/artparse	00:00:00.001	0.0%	316	0.000	0.003	0.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:08.502	0.0%	557891	0.002	0.015	0.489
history sync	00:00:01.019	0.0%	373	0.000	2.732	33.333
history write	00:00:48.287	0.1%	22580	0.381	2.138	16.388
hiswrite/artcncl	00:00:00.010	0.0%	8	0.000	1.250	4.000
hiswrite/artparse	00:00:00.599	0.0%	315	0.000	1.902	14.000
idle	23:56:46.100	99.7%	529453	88.799	162.821	582.528
nntp read	00:00:02.350	0.0%	532431	0.002	0.004	0.030
overview write	00:01:23.782	0.1%	18196	0.125	4.604	501.192
perl filter	00:00:38.367	0.0%	22555	1.339	1.701	3.832
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.310	0.0%	36430	0.000	0.009	0.038
TOTAL: 24:01:02.529	24:00:23.445	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.049	0.0%	18166	0.000	0.003	0.023
article prepare	00:00:00.001	0.0%	15368	0.000	0.000	0.004
article read	00:00:00.337	0.0%	1689	0.000	0.200	48.000
backlog stats	00:00:00.144	0.0%	342990	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.266	0.0%	262162	0.000	0.005	0.011
data write	00:00:01.583	0.0%	247419	0.001	0.006	0.016
idle	23:53:54.907	100.0%	342990	140.184	250.838	735.211
status file	00:00:00.378	0.0%	244	0.000	1.549	128.000
TOTAL: 23:54:05.081	23:53:58.665	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:42.616	0.0%	280328	0.000	0.152	0.526
idle	85:51:49.309	99.7%	968393	153.282	319.198	526458.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:12.682	0.0%	2594725	0.000	0.005	0.167
readart	00:12:47.554	0.2%	681166	0.000	1.127	106.000
TOTAL: 86:07:25.768	86:05:32.161	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	5	39276	3851	34927	498	9%	52:30:27
2	csiph-out.feeder.erje.net	1508	107694	3761	102414	1519	3%	139:19:40
3	feeder.eternal-september.org	1	20533	2173	18137	223	10%	24:32:47
4	news-out.mixmin.net	3	19334	2083	16418	833	10%	24:08:30
5	news-out.aioe.org	2	17762	1646	16056	60	9%	24:09:01
6	news.redatomik.org	3	17481	1172	16259	50	6%	24:08:52
7	newsfeed.fu-berlin.de	9	17416	1072	16252	92	6%	24:31:44
8	newsfeed.neva.ru	152	21451	962	19386	1103	4%	70:54:43
9	newsfeeds.xmission.com	3	19478	687	18756	35	3%	27:10:06
10	news.freedyn.net	3	19466	569	18630	267	2%	24:10:04
11	news.fcku.it	10	2324	260	2057	7	11%	22:32:41
12	nntp.pasdenom.info	2	15963	24	15929	10	0%	23:59:33
13	localhost	40	8	8	0	0	100%	00:00:04
14	news.bbs.nz	1	16109	5	16104	0	0%	23:59:51
15	news.swapon.de	2	70	0	70	0	0%	03:11:14
16	xanadu-bbs.net	13	544	0	544	0	0%	19:54:07
TOTAL: 16		1757	334909	18273	311939	4697	5%	529:13:24

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	16.2 MB	65.2 KB	12.2 MB	28.5 MB	56%	5.5 KB
2	csiph-out.news.weretis.net	12.4 MB	17.2 KB	8.4 MB	20.8 MB	59%	4.9 KB
3	feeder.eternal-september.org	6.0 MB	9.5 KB	1.4 MB	7.4 MB	80%	3.2 KB
4	news-out.mixmin.net	5.9 MB	13.3 KB	2.0 MB	7.9 MB	74%	2.8 KB
5	news-out.aioe.org	4.2 MB	9.3 KB	212.5 KB	4.4 MB	95%	2.7 KB
6	news.redatomik.org	3.7 MB	38.9 KB	1.5 MB	5.3 MB	70%	4.5 KB
7	newsfeed.fu-berlin.de	2.6 MB	0.0 KB	256.5 KB	2.8 MB	91%	2.5 KB
8	newsfeed.neva.ru	2.4 MB	48.0 KB	3.9 MB	6.3 MB	37%	3.1 KB
9	newsfeeds.xmission.com	2.2 MB	0.0 KB	2.6 MB	4.8 MB	45%	6.8 KB
10	news.freedyn.net	1.7 MB	0.0 KB	1.3 MB	3.0 MB	56%	3.7 KB
11	news.fcku.it	507.7 KB	0.0 KB	42.9 KB	550.6 KB	92%	2.1 KB
12	nntp.pasdenom.info	52.8 KB	0.0 KB	19.2 KB	72.1 KB	73%	2.1 KB
13	news.bbs.nz	16.5 KB	0.0 KB	0.0 KB	16.5 KB	100%	3.3 KB
14	localhost	11.9 KB	0.0 KB	0.0 KB	11.9 KB	100%	1.5 KB
15	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
16	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		57.9 MB	201.5 KB	33.9 MB	92.0 MB	62%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 11 04:15:00 - 04:59:59	278	1.5%	0.10	1.1 MB	1.9%	0.41
Feb 11 05:00:00 - 05:59:59	384	2.1%	0.11	1.5 MB	2.7%	0.44
Feb 11 06:00:00 - 06:59:59	509	2.8%	0.14	2.3 MB	4.1%	0.66
Feb 11 07:00:00 - 07:59:59	536	2.9%	0.15	1.8 MB	3.1%	0.51
Feb 11 08:00:00 - 08:59:59	746	4.1%	0.21	2.2 MB	3.8%	0.62
Feb 11 09:00:00 - 09:59:59	692	3.8%	0.19	2.2 MB	3.9%	0.63
Feb 11 10:00:00 - 10:59:59	821	4.5%	0.23	2.3 MB	4.1%	0.67
Feb 11 11:00:00 - 11:59:59	749	4.1%	0.21	2.4 MB	4.2%	0.69
Feb 11 12:00:00 - 12:59:59	1035	5.7%	0.29	2.9 MB	5.1%	0.83
Feb 11 13:00:00 - 13:59:59	961	5.3%	0.27	2.5 MB	4.3%	0.71
Feb 11 14:00:00 - 14:59:59	918	5.0%	0.26	2.5 MB	4.3%	0.71
Feb 11 15:00:00 - 15:59:59	1116	6.1%	0.31	3.8 MB	6.5%	1.07
Feb 11 16:00:00 - 16:59:59	1029	5.7%	0.29	3.7 MB	6.4%	1.04
Feb 11 17:00:00 - 17:59:59	1006	5.5%	0.28	2.8 MB	4.9%	0.80
Feb 11 18:00:00 - 18:59:59	1001	5.5%	0.28	2.8 MB	4.8%	0.79
Feb 11 19:00:00 - 19:59:59	1090	6.0%	0.30	3.9 MB	6.8%	1.11
Feb 11 20:00:00 - 20:59:59	911	5.0%	0.25	2.7 MB	4.8%	0.78
Feb 11 21:00:00 - 21:59:59	866	4.8%	0.24	2.4 MB	4.2%	0.68
Feb 11 22:00:00 - 22:59:59	840	4.6%	0.23	2.4 MB	4.2%	0.69
Feb 11 23:00:00 - 23:59:59	782	4.3%	0.22	2.8 MB	4.9%	0.80
Feb 12 00:00:00 - 00:59:59	554	3.0%	0.15	1.8 MB	3.2%	0.52
Feb 12 01:00:00 - 01:59:59	502	2.8%	0.14	1.6 MB	2.7%	0.45
Feb 12 02:00:00 - 02:59:59	428	2.4%	0.12	1.3 MB	2.3%	0.38
Feb 12 03:00:00 - 03:59:59	352	1.9%	0.10	1.4 MB	2.4%	0.39
Feb 12 04:00:00 - 04:15:00	89	0.5%	0.10	309.2 KB	0.5%	0.34
TOTAL: 24:00:00	18195	100.0%	0.21	57.6 MB	100.0%	0.68

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1571	114	5	1452
2	newsfeed.neva.ru	1110	67	3	1040
3	news-out.mixmin.net	841	3	1	837
4	newsfeed.fu-berlin.de	594	21	0	573
5	csiph-out.news.weretis.net	496	228	1	267
6	news.freedyn.net	265	9	0	256
7	feeder.eternal-september.org	220	16	0	204
8	news-out.aioe.org	68	59	0	9
9	news.redatomik.org	61	0	1	60
10	newsfeeds.xmission.com	29	0	0	29
11	news.swapon.de	10	0	0	10
12	nntp.pasdenom.info	10	0	0	10
13	news.fcku.it	7	5	0	2
TOTAL: 13		5282	522	11	4749

Unwanted newsgroups [Top 20]:

Newsgroup	Count
rocksolid.feeds.indymedia.lille	38
it-alt.sport.calcio.juventus	32
lada.talk	26
gmane.linux.alsa.devel	19
alt.music.pink-floyd.publius	19
gmane.linux.kernel	18
gmane.comp.gis.openstreetmap.tagging	17
mozilla.support.firefox	15
mozilla.support.thunderbird	14
alt.bbs.synchronet	14
gmane.comp.gis.openstreetmap	13
alt.windows7.general	13
alt.hack.nl	12
alt.pl.nieruchomosci.gielda	12
alt.politics.scorched-earth	11
rocksolid.feeds.indymedia.argentina	11
mozilla.support.seamonkey	11
it-alt.comp.software.mozilla	11
spline.eisfair	9
oesterreich.tratsch	9
TOTAL: 113	522

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3350
EMP (phn path)	185
EMP (phn nph)	90
HTML Multipart	69
Too many newsgroups	53
User-issued cancel	31
Binary Payload	15
Scoring filter (10)	10
User-issued spam cancel	8
Binary: misplaced rar	7
Scoring filter (14)	6
Scoring filter (11)	4
Scoring filter (9)	4
Scoring filter (12)	4
Scoring filter (8)	2
Scoring filter (13)	1
TOTAL: 16	3839

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	2
	TOTAL: 1	2
Bad Message-ID's offered
	csiph-out.feeder.erje.net	54
	TOTAL: 1	54
Huge articles
	csiph-out.feeder.erje.net	153
	csiph-out.news.weretis.net	78
	newsfeeds.xmission.com	29
	feeder.eternal-september.org	20
	news.redatomik.org	17
	news-out.mixmin.net	9
	news.freedyn.net	8
	newsfeed.fu-berlin.de	1
	news.swapon.de	1
	TOTAL: 9	316
Including strange strings
	newsfeed.fu-berlin.de	497
	news-out.mixmin.net	21
	csiph-out.feeder.erje.net	13
	csiph-out.news.weretis.net	11
	news.swapon.de	9
	news.redatomik.org	9
	news-out.aioe.org	8
	feeder.eternal-september.org	1
	TOTAL: 8	569
TOTAL: 4		941

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	17954	699	16927	2	0	3%	23:59:55
2	xanadu-bbs	20994	632	17561	1	0	3%	23:59:54
3	fu-berlin.de	16926	517	16408	0	0	3%	23:59:55
4	news.bbs.nz	34465	335	17328	14	0	0%	23:59:55
5	usenet.pasdenom.info	19225	103	16924	1143	0	0%	23:59:55
6	aioe	15799	67	14988	0	0	0%	23:59:55
7	news.redatomik.org	17183	12	16458	1	5	0%	23:59:55
8	news.mixmin.net	15948	12	15406	0	0	0%	23:59:55
9	neva.ru	16515	10	16272	173	0	0%	23:59:55
10	weretis.net	14757	10	13637	0	0	0%	23:59:20
11	news.swapon.de	1644	8	1589	0	0	0%	23:48:54
12	xmission	20484	8	16997	0	0	0%	23:59:21
13	eternal-september	16109	8	15426	0	0	0%	23:59:51
14	erje	14456	6	14201	84	0	0%	23:59:24
15	news.fcku.it	1909	0	1891	0	0	0%	21:34:40
TOTAL: 15		244368	2427	212013	1418	5	0%	357:20:44

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	7.4 MB	6.7 KB	7.4 MB	0.1 KB/s	10.9 KB	23:59:55
2	xanadu-bbs	7.2 MB	6.2 KB	7.2 MB	0.1 KB/s	11.7 KB	23:59:54
3	fu-berlin.de	6.9 MB	0.0 KB	6.9 MB	0.1 KB/s	13.7 KB	23:59:55
4	news.bbs.nz	855.8 KB	59.6 KB	915.4 KB	0.0 KB/s	2.6 KB	23:59:55
5	usenet.pasdenom.info	252.2 KB	7.9 MB	8.1 MB	0.1 KB/s	6.7 KB	23:59:55
6	aioe	162.6 KB	0.0 KB	162.6 KB	0.0 KB/s	2.4 KB	23:59:55
7	news.redatomik.org	23.1 KB	1.3 KB	24.4 KB	0.0 KB/s	1.9 KB	23:59:55
8	news.mixmin.net	20.1 KB	0.0 KB	20.1 KB	0.0 KB/s	1.7 KB	23:59:55
9	neva.ru	16.6 KB	431.1 KB	447.7 KB	0.0 KB/s	2.4 KB	23:59:55
10	weretis.net	15.6 KB	0.0 KB	15.6 KB	0.0 KB/s	1.6 KB	23:59:20
11	news.swapon.de	11.9 KB	0.0 KB	11.9 KB	0.0 KB/s	1.5 KB	23:48:54
12	xmission	11.9 KB	0.0 KB	11.9 KB	0.0 KB/s	1.5 KB	23:59:21
13	eternal-september	11.9 KB	0.0 KB	11.9 KB	0.0 KB/s	1.5 KB	23:59:51
14	erje	11.2 KB	260.4 KB	271.5 KB	0.0 KB/s	3.0 KB	23:59:24
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:34:40
TOTAL: 15		22.9 MB	8.7 MB	31.6 MB	0.0 KB/s	8.4 KB	357:20:44

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2320w-lp130-01-184-146-238-112.dsl.bell.ca	605	77396	200.5 MB	974	0	0	09:34:48
2	ip72-222-200-117.ph.ph.cox.net	4	50	179.9 KB	2	0	0	03:12:54
3	a131033.upc-a.chello.nl	75	26	42.9 KB	9	0	0	20:37:04
4	172-220-042-146.dhcp.chtrptr.net	26	20	35.9 KB	13	7	5	07:01:13
5	208-71-239-109.cust.centrio.cz	2	13	23.0 KB	2	0	0	00:06:59
6	68-114-222-192.dhcp.mdsn.wi.charter.com	3	2	3.2 KB	2	1	1	00:35:05
TOTAL: 6		715	328283	894.6 MB	1012	8	6	86:07:17

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	605	328172	894.3 MB	984	0	0	35:53:15
2	*.ph.ph.cox.net	4	50	179.9 KB	2	0	0	03:12:54
3	*.upc-a.chello.nl	75	26	42.9 KB	9	0	0	20:37:04
4	*.dhcp.chtrptr.net	68	20	35.9 KB	13	7	5	25:41:58
5	*.cust.centrio.cz	2	13	23.0 KB	2	0	0	00:06:59
6	*.dhcp.mdsn.wi.charter.com	3	2	3.2 KB	2	1	1	00:35:05
TOTAL: 6		757	328283	894.6 MB	1012	8	6	86:07:17

NNRP auth users [Top 20]:

User	Conn
ohlandl	6
ctomczyk	2
TOTAL: 2	8

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
bras-vprn-mtrlpq2320w-lp140-01-70-27-192-142.dsl.bell.ca	27.353	38.731	0.000	26:18:27
a131033.upc-a.chello.nl	5.803	0.974	0.000	20:37:04
172-221-041-102.dhcp.chtrptr.net	11.009	27.154	0.000	18:40:45
mtrlpq2320w-lp130-01-184-146-238-112.dsl.bell.ca	54.715	20.429	0.000	09:34:48
172-220-042-146.dhcp.chtrptr.net	2.272	0.377	0.011	07:01:13
ip72-222-200-117.ph.ph.cox.net	0.708	0.082	0.000	03:12:54
68-114-222-192.dhcp.mdsn.wi.charter.com	0.392	0.063	0.003	00:35:05
208-71-239-109.cust.centrio.cz	0.224	0.033	0.004	00:06:59
TOTAL: 8	102.476	87.843	0.018	86:07:17

Curious NNRP server explorers [Top 20]:

System	Conn
172-221-041-102.dhcp.chtrptr.net	42
TOTAL: 1	42

NNRP client timeouts [Top 20]:

System	Conn	Peer
mtrlpq2320w-lp130-01-184-146-238-112.dsl.bell.ca	14	0
bras-vprn-mtrlpq2320w-lp140-01-70-27-192-142.dsl.bell.ca	10	0
172-220-042-146.dhcp.chtrptr.net	8	1
ip72-222-200-117.ph.ph.cox.net	6	0
TOTAL: 4	38	1

Newsgroup request counts (by category):

Category		Count	Pct
1	soc	77703	99.7%
2	comp	116	0.1%
3	uk	29	0.0%
4	alt	28	0.0%
5	fr	26	0.0%
6	aus	15	0.0%
7	rec	14	0.0%
8	talk	3	0.0%
9	perl	2	0.0%
10	misc	2	0.0%
11	sci	2	0.0%
TOTAL: 11		77940	100.0%

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

Newsgroup		Count
1	soc.retirement	77695
2	comp.arch	53
3	comp.sys.ibm.ps2.hardware	48
4	aus.cars	15
5	alt.usage.english	15
6	comp.lang.javascript	13
7	rec.arts.drwho	12
8	fr.soc.politique	11
9	fr.sci.zetetique	11
10	uk.d-i-y	10
11	soc.culture.polish	7
12	uk.rec.motorcycles	7
13	uk.railway	5
14	uk.radio.amateur	5
15	fr.soc.environnement	3
16	alt.comp.os.windows-10	3
17	talk.politics.misc	3
18	alt.slack	2
19	rec.aviation.soaring	2
20	sci.logic	2
21	uk.tech.digital-tv	2
22	perl.modules	2
23	comp.lang.tcl	2
24	alt.life.sucks	2
25	misc.survivalism	2
26	alt.appalachian	2
27	alt.fan.art-bell	1
28	alt.russian.z1	1
29	alt.os.linux	1
30	alt.sports.football.pro.phila-eagles	1
31	soc.culture.netherlands	1
32	fr.misc.finance	1
TOTAL: 32		77940

Daily Usenet report for csiph.com

Feb 11 04:15:00 -- Feb 12 04:15:00