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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	46242	39.9%	9.0 MB	57.1%
nnrpd	43866	37.9%	3.9 MB	24.3%
innd	22408	19.4%	2.4 MB	15.0%
innfeed	3157	2.7%	580.1 KB	3.6%
nocem	94	0.1%	9.3 KB	0.1%
TOTAL: 5	115767	100.0%	15.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	551865	56.8%
Negative hits	373738	38.5%
Do not exist	45280	4.7%
Cache misses	679	0.1%
TOTAL: 4	971562	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.518	0.0%	286	0.000	1.811	46.000
article cleanup	00:00:00.284	0.0%	44563	0.000	0.006	0.022
article logging	00:00:00.610	0.0%	45165	0.000	0.014	0.091
article parse	00:00:01.761	0.0%	156656	0.000	0.011	0.119
article write	00:00:56.171	0.1%	26605	0.175	2.111	31.827
artlog/artcncl	00:00:00.002	0.0%	224	0.000	0.009	0.100
artlog/artparse	00:00:00.014	0.0%	892	0.000	0.016	0.111
data move	00:00:00.330	0.0%	916987	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.051	0.0%	279	0.000	0.183	14.000
hishave/artcncl	00:00:00.001	0.0%	286	0.000	0.003	0.100
hishave/artparse	00:00:00.002	0.0%	307	0.000	0.007	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.405	0.0%	974806	0.001	0.005	0.045
history sync	00:00:01.168	0.0%	358	0.000	3.263	32.333
history write	00:00:22.902	0.0%	45131	0.083	0.507	5.340
hiswrite/artcncl	00:00:00.001	0.0%	7	0.000	0.143	0.250
hiswrite/artparse	00:00:00.282	0.0%	307	0.000	0.919	45.500
idle	23:55:12.135	99.6%	941438	54.079	91.469	288.739
nntp read	00:00:03.077	0.0%	947825	0.002	0.003	0.008
overview write	00:01:08.821	0.1%	26605	0.315	2.587	53.169
perl filter	00:01:42.514	0.1%	44494	1.417	2.304	4.014
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.469	0.0%	53298	0.000	0.009	0.031
TOTAL: 24:00:50.984	23:59:35.518	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.077	0.0%	26654	0.000	0.003	0.030
article prepare	00:00:00.007	0.0%	27058	0.000	0.000	0.009
article read	00:00:00.560	0.0%	3231	0.000	0.173	5.909
backlog stats	00:00:00.266	0.0%	605573	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.329	0.0%	448905	0.002	0.005	0.009
data write	00:00:02.985	0.0%	431874	0.002	0.007	0.012
idle	23:53:13.534	100.0%	605573	75.253	142.004	379.892
status file	00:00:00.191	0.0%	269	0.000	0.710	14.000
TOTAL: 23:53:28.997	23:53:19.949	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.490	0.0%	3848	0.011	0.127	0.301
idle	48:13:43.595	98.9%	61997	79.971	2800.516	600083.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.702	0.0%	124922	0.000	0.006	0.167
readart	00:00:10.275	0.0%	12156	0.000	0.845	58.000
TOTAL: 48:45:12.168	48:13:55.062	98.9%	-	-	-	-

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	usenet.blueworldhosting.com	288	31436	5654	24223	1559	17%	23:44:50
2	csiph-out.feeder.erje.net	1152	145787	4114	131646	10027	2%	95:07:56
3	feeder.eternal-september.org	3	38577	3887	33549	1141	10%	24:26:03
4	csiph-out.news.weretis.net	3	58011	3582	53647	782	6%	41:47:38
5	newsfeed.neva.ru	152	59057	2304	52899	3854	3%	71:47:26
6	news-out.mixmin.net	2	30260	2117	27543	600	6%	24:08:56
7	news-out.aioe.org	3	25755	1554	24157	44	6%	24:09:39
8	newsfeed.fu-berlin.de	65	31223	1252	29309	662	4%	37:48:07
9	newsfeeds.xmission.com	1	27974	678	27278	18	2%	25:41:05
10	news.freedyn.net	4	29501	607	28812	82	2%	24:09:36
11	news.fcku.it	1	6141	252	5874	15	4%	12:49:28
12	news.redatomik.org	1	23170	123	23043	4	0%	22:26:07
13	news.swapon.de	2	1951	90	1861	0	4%	22:45:13
14	nntp.pasdenom.info	3	27996	40	27953	3	0%	24:08:24
15	xanadu-bbs.net	12	732	33	688	11	4%	22:47:39
16	au2pb.net	1	6788	31	6735	22	0%	09:10:59
17	news.bbs.geek.nz	2	27408	9	27399	0	0%	23:59:51
18	localhost	37	3	3	0	0	100%	00:00:00
TOTAL: 18		1732	571770	26330	526616	18824	4%	530:58:57

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	16.5 MB	0.0 KB	18.0 MB	34.6 MB	47%	4.9 KB
2	csiph-out.feeder.erje.net	16.4 MB	64.8 KB	44.1 MB	60.5 MB	27%	4.4 KB
3	csiph-out.news.weretis.net	10.3 MB	2.0 KB	9.2 MB	19.5 MB	52%	4.6 KB
4	feeder.eternal-september.org	9.8 MB	2.0 KB	18.0 MB	27.8 MB	35%	5.7 KB
5	news-out.mixmin.net	8.5 MB	2.0 KB	1.9 MB	10.4 MB	82%	3.9 KB
6	newsfeed.neva.ru	6.2 MB	92.1 KB	26.3 MB	32.6 MB	19%	5.4 KB
7	news-out.aioe.org	3.5 MB	0.0 KB	63.6 KB	3.6 MB	98%	2.3 KB
8	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	1.3 MB	4.0 MB	67%	2.1 KB
9	news.freedyn.net	1.9 MB	3.6 KB	361.0 KB	2.3 MB	84%	3.4 KB
10	newsfeeds.xmission.com	1.9 MB	0.0 KB	749.2 KB	2.7 MB	72%	3.9 KB
11	news.fcku.it	489.7 KB	0.0 KB	133.3 KB	623.0 KB	78%	2.3 KB
12	news.redatomik.org	270.1 KB	0.0 KB	299.4 KB	569.5 KB	47%	4.5 KB
13	news.swapon.de	213.5 KB	0.0 KB	0.0 KB	213.5 KB	100%	2.4 KB
14	au2pb.net	97.9 KB	0.0 KB	49.6 KB	147.5 KB	66%	2.8 KB
15	nntp.pasdenom.info	71.5 KB	0.0 KB	10.5 KB	82.0 KB	87%	1.9 KB
16	xanadu-bbs.net	63.9 KB	0.0 KB	37.9 KB	101.8 KB	62%	2.3 KB
17	news.bbs.geek.nz	13.8 KB	0.0 KB	0.0 KB	13.8 KB	100%	1.5 KB
18	localhost	3.0 KB	0.0 KB	0.0 KB	3.0 KB	100%	1.0 KB
TOTAL: 18		79.0 MB	166.6 KB	120.5 MB	199.6 MB	39%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 28 04:15:00 - 04:59:59	437	1.6%	0.16	1.5 MB	1.9%	0.58
Jun 28 05:00:00 - 05:59:59	633	2.4%	0.18	2.7 MB	3.4%	0.77
Jun 28 06:00:00 - 06:59:59	818	3.1%	0.23	2.1 MB	2.7%	0.60
Jun 28 07:00:00 - 07:59:59	1111	4.2%	0.31	3.1 MB	3.8%	0.87
Jun 28 08:00:00 - 08:59:59	1123	4.2%	0.31	3.4 MB	4.3%	0.97
Jun 28 09:00:00 - 09:59:59	1313	4.9%	0.36	3.8 MB	4.7%	1.08
Jun 28 10:00:00 - 10:59:59	1288	4.8%	0.36	3.4 MB	4.3%	0.98
Jun 28 11:00:00 - 11:59:59	1158	4.4%	0.32	3.1 MB	3.9%	0.89
Jun 28 12:00:00 - 12:59:59	1372	5.2%	0.38	3.5 MB	4.3%	0.99
Jun 28 13:00:00 - 13:59:59	1518	5.7%	0.42	4.8 MB	6.0%	1.36
Jun 28 14:00:00 - 14:59:59	1381	5.2%	0.38	4.0 MB	5.0%	1.15
Jun 28 15:00:00 - 15:59:59	1524	5.7%	0.42	4.6 MB	5.7%	1.29
Jun 28 16:00:00 - 16:59:59	1499	5.6%	0.42	4.6 MB	5.8%	1.31
Jun 28 17:00:00 - 17:59:59	1618	6.1%	0.45	5.1 MB	6.3%	1.44
Jun 28 18:00:00 - 18:59:59	1557	5.9%	0.43	4.2 MB	5.3%	1.20
Jun 28 19:00:00 - 19:59:59	1617	6.1%	0.45	5.8 MB	7.2%	1.64
Jun 28 20:00:00 - 20:59:59	1492	5.6%	0.41	5.0 MB	6.3%	1.43
Jun 28 21:00:00 - 21:59:59	1228	4.6%	0.34	3.6 MB	4.5%	1.03
Jun 28 22:00:00 - 22:59:59	957	3.6%	0.27	2.8 MB	3.5%	0.80
Jun 28 23:00:00 - 23:59:59	710	2.7%	0.20	2.0 MB	2.5%	0.58
Jun 29 00:00:00 - 00:59:59	602	2.3%	0.17	1.8 MB	2.2%	0.50
Jun 29 01:00:00 - 01:59:59	510	1.9%	0.14	1.6 MB	2.0%	0.45
Jun 29 02:00:00 - 02:59:59	502	1.9%	0.14	1.6 MB	1.9%	0.44
Jun 29 03:00:00 - 03:59:59	498	1.9%	0.14	1.5 MB	1.9%	0.42
Jun 29 04:00:00 - 04:15:00	130	0.5%	0.14	498.3 KB	0.6%	0.55
TOTAL: 24:00:00	26596	100.0%	0.31	80.0 MB	100.0%	0.95

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	10066	1166	6	8894
2	newsfeed.neva.ru	3841	1218	5	2618
3	usenet.blueworldhosting.com	1559	424	0	1135
4	feeder.eternal-september.org	1172	127	0	1045
5	newsfeed.fu-berlin.de	1063	16	0	1047
6	csiph-out.news.weretis.net	878	269	0	609
7	news-out.mixmin.net	615	1	0	614
8	news.freedyn.net	81	0	1	80
9	news-out.aioe.org	48	33	0	15
10	news.fcku.it	24	0	0	24
11	newsfeeds.xmission.com	21	8	0	13
12	au2pb.net	20	15	0	5
13	news.swapon.de	20	0	0	20
14	xanadu-bbs.net	11	0	0	11
15	nntp.pasdenom.info	4	1	0	3
16	news.redatomik.org	2	0	0	2
TOTAL: 16		19425	3278	12	16135

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	993
mailing.freebsd.pkg-fallout	236
lada.talk	194
it-alt.sport.calcio.juventus	140
ut.test	128
mailing.freebsd.ports-bugs	87
lada.auto	84
mailing.freebsd.svn-ports-all	69
mailing.freebsd.svn-ports-head	67
mailing.openbsd.ports-changes	45
mailing.openbsd.source-changes	33
mailing.openssl.cvs	33
mailing.freebsd.ports	32
cakewalk.audio	31
fa.openbsd.source-changes	29
mailing.unix.dovecot	27
mailing.unix.spamassassin-talk	27
alt.politics.scorched-earth	27
mailing.openssl.dev	26
mozilla.general	26
TOTAL: 231	3278

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	9980
EMP (phn path)	2420
EMP (phl)	822
PFM bot misc	760
EMP (phn nph)	205
Binary Payload	80
Too many newsgroups	62
HTML Multipart	31
Scoring filter (18)	23
Scoring filter (16)	18
Scoring filter (13)	14
Scoring filter (12)	14
Scoring filter (14)	14
Scoring filter (9)	13
Scoring filter (11)	12
User-issued cancel	11
Scoring filter (19)	10
Scoring filter (8)	9
HTML post	8
HTML Image Tags	8
TOTAL: 45	14588

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	51
	usenet.blueworldhosting.com	1
	TOTAL: 2	52
Bad Message-ID's offered
	csiph-out.feeder.erje.net	3
	usenet.blueworldhosting.com	1
	TOTAL: 2	4
Huge articles
	feeder.eternal-september.org	119
	usenet.blueworldhosting.com	86
	csiph-out.news.weretis.net	67
	news-out.mixmin.net	18
	newsfeeds.xmission.com	7
	news.fcku.it	4
	news.freedyn.net	3
	news.redatomik.org	1
	au2pb.net	1
	TOTAL: 9	306
Including strange strings
	newsfeed.fu-berlin.de	442
	csiph-out.news.weretis.net	40
	csiph-out.feeder.erje.net	37
	feeder.eternal-september.org	27
	news.swapon.de	20
	news-out.mixmin.net	18
	newsfeed.neva.ru	7
	news-out.aioe.org	4
	news.fcku.it	1
	news.freedyn.net	1
	TOTAL: 12	599
No colon-space in header
	csiph-out.feeder.erje.net	584
	usenet.blueworldhosting.com	1
	TOTAL: 2	585
TOTAL: 5		1546

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.geek.nz	49432	1650	24065	54	1	0	3%	23:59:50
2	news.freedyn.net	30479	1118	24856	20	0	0	3%	23:59:54
3	xanadu-bbs	29613	1012	25527	0	0	0	3%	23:59:48
4	fu-berlin.de	25108	800	24308	0	0	0	3%	23:59:54
5	usenet.pasdenom.info	34065	182	25203	1167	0	6	0%	23:59:54
6	aioe	24418	173	22372	4	0	0	0%	23:50:03
7	weretis.net	22658	113	21161	33	0	0	0%	23:50:03
8	au2pb	27433	88	25586	8	0	0	0%	23:59:46
9	news.redatomik.org	27129	67	25400	8	0	0	0%	23:59:55
10	xmission	30823	57	25038	3	0	0	0%	23:59:55
11	news.mixmin.net	25015	19	23332	0	0	0	0%	23:59:48
12	eternal-september	24251	11	21472	0	0	0	0%	23:59:42
13	erje	24203	10	22307	77	0	0	0%	23:59:55
14	neva.ru	27206	7	22871	87	0	0	0%	23:59:48
15	bwh	22045	5	19935	0	0	120	0%	23:59:55
16	news.fcku.it	3789	3	3192	0	0	0	0%	22:52:35
17	news.swapon.de	2036	1	1953	10	0	0	0%	23:54:01
TOTAL: 17		429703	5316	358578	1471	1	126	1%	406:24:46

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	9.3 MB	131.6 KB	9.4 MB	0.1 KB/s	8.4 KB	23:59:54
2	xanadu-bbs	8.9 MB	0.0 KB	8.9 MB	0.1 KB/s	9.0 KB	23:59:48
3	fu-berlin.de	8.3 MB	0.0 KB	8.3 MB	0.1 KB/s	10.7 KB	23:59:54
4	news.bbs.geek.nz	4.1 MB	181.6 KB	4.3 MB	0.1 KB/s	2.6 KB	23:59:50
5	usenet.pasdenom.info	541.1 KB	9.3 MB	9.8 MB	0.1 KB/s	7.5 KB	23:59:54
6	aioe	388.1 KB	11.7 KB	399.8 KB	0.0 KB/s	2.3 KB	23:50:03
7	weretis.net	295.5 KB	82.7 KB	378.3 KB	0.0 KB/s	2.6 KB	23:50:03
8	news.redatomik.org	220.7 KB	27.2 KB	247.9 KB	0.0 KB/s	3.3 KB	23:59:55
9	au2pb	202.8 KB	72.5 KB	275.2 KB	0.0 KB/s	2.9 KB	23:59:46
10	xmission	142.2 KB	5.1 KB	147.4 KB	0.0 KB/s	2.5 KB	23:59:55
11	news.mixmin.net	67.1 KB	0.0 KB	67.1 KB	0.0 KB/s	3.5 KB	23:59:48
12	eternal-september	18.3 KB	0.0 KB	18.3 KB	0.0 KB/s	1.7 KB	23:59:42
13	erje	15.2 KB	368.9 KB	384.1 KB	0.0 KB/s	4.4 KB	23:59:55
14	neva.ru	13.8 KB	451.8 KB	465.6 KB	0.0 KB/s	5.0 KB	23:59:48
15	bwh	8.5 KB	0.0 KB	8.5 KB	0.0 KB/s	1.7 KB	23:59:55
16	news.fcku.it	7.0 KB	0.0 KB	7.0 KB	0.0 KB/s	2.3 KB	22:52:35
17	news.swapon.de	2.2 KB	17.1 KB	19.3 KB	0.0 KB/s	1.8 KB	23:54:01
TOTAL: 17		32.4 MB	10.6 MB	43.1 MB	0.0 KB/s	6.5 KB	406:24:46

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	36	79.6 KB	35	0	0	05:00:17
2	dhcp-089-099-203-254.chello.nl	79	11	13.9 KB	5	0	0	23:56:32
3	tempe0.bbox.io	8	10	12.8 KB	2	0	0	02:31:47
4	68-185-181-64.dhcp.mdsn.wi.charter.com	9	9	11.8 KB	4	3	2	02:13:01
5	mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	120	6	9.4 KB	6	0	0	00:39:20
TOTAL: 5		504	72	127.5 KB	52	3	2	48:45:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	300	36	79.6 KB	35	0	0	18:04:39
2	*.chello.nl	79	11	13.9 KB	5	0	0	23:56:32
3	*.bbox.io	8	10	12.8 KB	2	0	0	02:31:47
4	*.dhcp.mdsn.wi.charter.com	9	9	11.8 KB	4	3	2	02:13:01
5	*.dsl.bell.ca	120	6	9.4 KB	6	0	0	00:39:20
6	*.aomori.ocn.ne.jp	1	0	0.0 KB	0	0	0	00:00:01
7	*.57.194.77.rev.sfr.net	3	0	0.0 KB	0	0	0	00:00:48
8	*.nielsenmedia.com	4	0	0.0 KB	0	0	0	01:18:56
TOTAL: 8		524	72	127.5 KB	52	3	2	48:45:07

NNRP auth users [Top 20]:

User	Conn
moussa	287
ohlandl	2
TOTAL: 2	289

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	6.438	1.788	0.000	23:56:32
216.246.166.30	0.566	0.444	0.000	11:33:39
202.89.176.220	28.316	8.070	0.773	05:00:17
tempe0.bbox.io	0.829	0.140	0.000	02:31:47
68-185-181-64.dhcp.mdsn.wi.charter.com	1.082	0.166	0.005	02:13:01
71.98.160.36	0.216	0.063	0.000	01:30:39
challenger.nielsenmedia.com	0.326	0.087	0.000	01:18:56
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	15.534	3.918	0.000	00:39:20
140.57.194.77.rev.sfr.net	0.221	0.069	0.000	00:00:48
p4077-ipbf205okidate.aomori.ocn.ne.jp	0.091	0.023	0.000	00:00:01
94.167.247.105	0.098	0.015	0.000	00:00:01
TOTAL: 11	53.717	14.783	0.778	48:45:07

Curious NNRP server explorers [Top 20]:

System	Conn
216.246.166.30	8
challenger.nielsenmedia.com	4
71.98.160.36	3
140.57.194.77.rev.sfr.net	3
94.167.247.105	1
p4077-ipbf205okidate.aomori.ocn.ne.jp	1
TOTAL: 6	20

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	5	0
71.98.160.36	3	0
68-185-181-64.dhcp.mdsn.wi.charter.com	2	0
challenger.nielsenmedia.com	2	0
TOTAL: 4	12	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	67	93.1%
2	alt	4	5.6%
3	rec	1	1.4%
TOTAL: 3		72	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	36
2	comp.os.vms	16
3	comp.arch.embedded	7
4	comp.sys.ibm.as400.misc	2
5	alt.home.repair	2
6	comp.sys.ibm.pc.games.action	2
7	rec.food.cooking	1
8	alt.comp.os.windows-10	1
9	comp.os.os2.programmer.misc	1
10	comp.os.linux.misc	1
11	alt.happy.valley	1
12	comp.os.os2.apps	1
13	comp.ai.philosophy	1
TOTAL: 13		72

Daily Usenet report for csiph.com

Jun 28 04:15:00 -- Jun 29 04:15:00