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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	48473	44.9%	9.2 MB	61.6%
nnrpd	32047	29.7%	2.7 MB	18.0%
innd	23941	22.2%	2.5 MB	16.9%
innfeed	3384	3.1%	533.5 KB	3.5%
nocem	36	0.0%	3.5 KB	0.0%
TOTAL: 5	107881	100.0%	15.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	615525	59.1%
Negative hits	372170	35.7%
Do not exist	46850	4.5%
Cache misses	7439	0.7%
TOTAL: 4	1041984	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.496	0.0%	166	0.000	2.988	19.400
article cleanup	00:00:00.268	0.0%	46391	0.000	0.006	0.021
article logging	00:00:00.603	0.0%	46845	0.000	0.013	0.057
article parse	00:00:01.739	0.0%	182620	0.003	0.010	0.025
article write	00:01:11.258	0.1%	26174	0.414	2.722	15.714
artlog/artcncl	00:00:00.002	0.0%	154	0.000	0.013	0.500
artlog/artparse	00:00:00.011	0.0%	764	0.000	0.014	1.000
data move	00:00:00.301	0.0%	926200	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.063	0.0%	165	0.000	0.382	13.000
hishave/artcncl	00:00:00.000	0.0%	166	0.000	0.000	0.000
hishave/artparse	00:00:00.000	0.0%	196	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:07.274	0.0%	1044187	0.002	0.007	0.107
history sync	00:00:01.776	0.0%	328	0.000	5.415	65.500
history write	00:00:51.693	0.1%	46714	0.078	1.107	25.615
hiswrite/artcncl	00:00:00.004	0.0%	1	4.000	4.000	4.000
hiswrite/artparse	00:00:00.076	0.0%	193	0.000	0.394	11.000
idle	23:54:11.376	99.6%	961712	28.328	89.477	377.660
nntp read	00:00:03.169	0.0%	972295	0.001	0.003	0.006
overview write	00:01:09.621	0.1%	26174	0.268	2.660	29.000
perl filter	00:01:59.758	0.1%	46094	1.589	2.598	4.681
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.442	0.0%	52377	0.000	0.008	0.025
TOTAL: 24:00:39.837	23:59:39.930	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.069	0.0%	29542	0.000	0.002	0.019
article prepare	00:00:00.006	0.0%	35332	0.000	0.000	0.008
article read	00:00:01.493	0.0%	4032	0.000	0.370	3.455
backlog stats	00:00:00.285	0.0%	557890	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.076	0.0%	406159	0.001	0.005	0.009
data write	00:00:02.669	0.0%	397253	0.003	0.007	0.017
idle	23:53:02.464	100.0%	557890	30.373	154.121	496.147
status file	00:00:00.260	0.0%	372	0.000	0.699	1.000
TOTAL: 23:53:21.357	23:53:09.322	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.222	0.0%	6923	0.000	0.032	0.042
idle	38:54:47.537	99.9%	38463	207.857	3642.138	600123.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.451	0.0%	77974	0.000	0.019	12.195
readart	00:00:06.558	0.0%	10631	0.000	0.617	48.000
TOTAL: 38:56:20.069	38:54:55.768	99.9%	-	-	-	-

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	usenet.blueworldhosting.com	289	35503	8185	22022	5296	23%	23:48:03
2	csiph-out.feeder.erje.net	1152	183661	4795	170773	8093	2%	94:58:05
3	news-out.aioe.org	3	23116	2059	21048	9	8%	24:59:41
4	feeder.eternal-september.org	8	22962	1949	20828	185	8%	08:14:57
5	newsfeed.neva.ru	140	71365	1762	65220	4383	2%	70:55:13
6	news-out.mixmin.net	2	29163	1708	26371	1084	5%	24:07:51
7	au2pb.net	1	27499	1563	25799	137	5%	24:24:16
8	newsfeed.fu-berlin.de	61	28550	1249	27120	181	4%	33:25:06
9	csiph-out.news.weretis.net	4	52419	1144	50968	307	2%	44:26:38
10	news.redatomik.org	20	22538	505	21877	156	2%	20:23:08
11	news.fcku.it	1	9312	486	8826	0	5%	26:59:19
12	newsfeeds.xmission.com	2	24394	406	23971	17	1%	22:40:07
13	news.freedyn.net	6	28730	165	28546	19	0%	23:59:53
14	xanadu-bbs.net	1	64348	102	63049	1197	0%	32:59:11
15	news.swapon.de	4	1896	80	1807	9	4%	23:31:04
16	nntp.pasdenom.info	3	24746	30	24696	20	0%	24:08:35
17	localhost	36	2	2	0	0	100%	00:00:00
18	news.bbs.geek.nz	5	48921	2	48918	1	0%	37:47:03
TOTAL: 18		1738	699125	26192	651839	21094	3%	561:48:10

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	21.3 MB	719.8 KB	45.7 MB	67.7 MB	31%	5.4 KB
2	usenet.blueworldhosting.com	21.1 MB	17.0 KB	53.0 MB	74.1 MB	28%	5.6 KB
3	news-out.mixmin.net	6.3 MB	29.6 KB	2.6 MB	8.9 MB	70%	3.3 KB
4	news-out.aioe.org	5.4 MB	2.9 KB	17.0 KB	5.4 MB	99%	2.7 KB
5	feeder.eternal-september.org	4.8 MB	131.5 KB	1.7 MB	6.7 MB	71%	3.2 KB
6	newsfeed.neva.ru	4.6 MB	113.5 KB	30.4 MB	35.2 MB	13%	5.9 KB
7	csiph-out.news.weretis.net	3.9 MB	17.4 KB	6.9 MB	10.8 MB	35%	7.6 KB
8	au2pb.net	3.3 MB	16.0 KB	447.3 KB	3.8 MB	88%	2.3 KB
9	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	514.3 KB	3.3 MB	84%	2.3 KB
10	news.redatomik.org	1.4 MB	0.0 KB	3.3 MB	4.6 MB	29%	7.1 KB
11	newsfeeds.xmission.com	1.2 MB	0.0 KB	279.7 KB	1.5 MB	81%	3.6 KB
12	news.fcku.it	848.2 KB	0.0 KB	0.0 KB	848.2 KB	100%	1.7 KB
13	news.freedyn.net	658.4 KB	0.0 KB	262.7 KB	921.1 KB	71%	5.0 KB
14	xanadu-bbs.net	339.4 KB	19.1 KB	17.9 MB	18.3 MB	1%	14.4 KB
15	news.swapon.de	204.2 KB	0.0 KB	2.6 MB	2.8 MB	7%	32.4 KB
16	nntp.pasdenom.info	54.0 KB	0.0 KB	151.8 KB	205.8 KB	26%	4.1 KB
17	news.bbs.geek.nz	5.0 KB	0.0 KB	1.7 KB	6.7 KB	74%	2.2 KB
18	localhost	3.7 KB	0.0 KB	0.0 KB	3.7 KB	100%	1.9 KB
TOTAL: 18		78.0 MB	1.0 MB	165.9 MB	244.9 MB	31%	5.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 8 04:15:00 - 04:59:59	618	2.3%	0.23	1.8 MB	2.2%	0.67
Jan 8 05:00:00 - 05:59:59	792	3.0%	0.22	3.1 MB	3.9%	0.88
Jan 8 06:00:00 - 06:59:59	694	2.6%	0.19	3.1 MB	3.9%	0.89
Jan 8 07:00:00 - 07:59:59	809	3.0%	0.22	2.2 MB	2.8%	0.64
Jan 8 08:00:00 - 08:59:59	1104	4.1%	0.31	3.4 MB	4.3%	0.96
Jan 8 09:00:00 - 09:59:59	1323	4.9%	0.37	3.5 MB	4.4%	1.00
Jan 8 10:00:00 - 10:59:59	1374	5.1%	0.38	3.8 MB	4.8%	1.07
Jan 8 11:00:00 - 11:59:59	1141	4.3%	0.32	3.4 MB	4.3%	0.96
Jan 8 12:00:00 - 12:59:59	1183	4.4%	0.33	3.2 MB	4.0%	0.90
Jan 8 13:00:00 - 13:59:59	1117	4.2%	0.31	2.9 MB	3.7%	0.84
Jan 8 14:00:00 - 14:59:59	1312	4.9%	0.36	4.2 MB	5.3%	1.20
Jan 8 15:00:00 - 15:59:59	1254	4.7%	0.35	3.9 MB	5.0%	1.12
Jan 8 16:00:00 - 16:59:59	1414	5.3%	0.39	4.5 MB	5.7%	1.28
Jan 8 17:00:00 - 17:59:59	1395	5.2%	0.39	4.0 MB	5.0%	1.13
Jan 8 18:00:00 - 18:59:59	1594	6.0%	0.44	5.2 MB	6.6%	1.49
Jan 8 19:00:00 - 19:59:59	1277	4.8%	0.35	3.7 MB	4.7%	1.05
Jan 8 20:00:00 - 20:59:59	1161	4.3%	0.32	3.5 MB	4.4%	1.00
Jan 8 21:00:00 - 21:59:59	1404	5.2%	0.39	3.8 MB	4.7%	1.07
Jan 8 22:00:00 - 22:59:59	1078	4.0%	0.30	3.2 MB	4.0%	0.90
Jan 8 23:00:00 - 23:59:59	772	2.9%	0.21	2.2 MB	2.7%	0.62
Jan 9 00:00:00 - 00:59:59	634	2.4%	0.18	1.8 MB	2.3%	0.51
Jan 9 01:00:00 - 01:59:59	516	1.9%	0.14	1.6 MB	2.0%	0.46
Jan 9 02:00:00 - 02:59:59	429	1.6%	0.12	1.1 MB	1.4%	0.32
Jan 9 03:00:00 - 03:59:59	675	2.5%	0.19	2.1 MB	2.6%	0.59
Jan 9 04:00:00 - 04:15:00	1675	6.3%	1.86	4.1 MB	5.2%	4.65
TOTAL: 24:00:00	26745	100.0%	0.31	79.2 MB	100.0%	0.94

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	8119	700	189	0	7230
2	usenet.blueworldhosting.com	5308	1048	7	1	4252
3	newsfeed.neva.ru	4421	1509	24	0	2888
4	xanadu-bbs.net	1168	26	1	0	1141
5	news-out.mixmin.net	1091	2	15	0	1074
6	newsfeed.fu-berlin.de	557	39	0	0	518
7	csiph-out.news.weretis.net	308	224	3	0	81
8	feeder.eternal-september.org	217	62	70	0	85
9	au2pb.net	136	102	1	0	33
10	news.redatomik.org	124	0	0	0	124
11	news.swapon.de	34	0	2	0	32
12	news-out.aioe.org	23	11	0	0	12
13	newsfeeds.xmission.com	23	16	0	0	7
14	nntp.pasdenom.info	20	19	0	0	1
15	news.freedyn.net	20	0	0	0	20
16	news.bbs.geek.nz	2	2	0	0	0
17	news.fcku.it	2	0	0	0	2
TOTAL: 17		21573	3760	312	1	17500

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	980
ut.test	181
lada.talk	128
lada.auto	124
mailing.freebsd.ports-bugs	110
pld.cvs.commit	108
mozilla.general	102
mailing.freebsd.svn-ports-all	96
mailing.freebsd.svn-ports-head	89
mailing.database.pgsql-general	78
mailing.freebsd.pkg-fallout	61
mailing.openbsd.source-changes	57
mailing.freebsd.svn-src-all	55
alt.survival	52
fa.freebsd.cvs-all	52
gmane.comp.gis.openstreetmap.tagging	50
mailing.openbsd.ports-changes	50
alt.binaries.multimedia.tatu	48
mailing.freebsd.svn-src-head	47
fa.openbsd.source-changes	41
TOTAL: 265	3760

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

Groups	Count
uk.radio.amateur.moderated	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11825
EMP (phn path)	2361
EMP (phl)	976
Binary: misplaced rar	189
EMP (phn nph)	186
Too many newsgroups	117
User-issued cancel	99
PFM bot misc	73
Scoring filter (21)	46
HTML Multipart	35
Scoring filter (18)	33
Scoring filter (16)	24
Scoring filter (19)	21
Binary: misplaced rev	20
Scoring filter (15)	19
Scoring filter (20)	19
Scoring filter (29)	18
Binary Payload	14
Scoring filter (8)	12
Scoring filter (22)	12
TOTAL: 45	16230

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	50
	usenet.blueworldhosting.com	2
	TOTAL: 2	52
Huge articles
	usenet.blueworldhosting.com	81
	csiph-out.news.weretis.net	39
	xanadu-bbs.net	28
	feeder.eternal-september.org	15
	news-out.mixmin.net	11
	news.swapon.de	7
	newsfeeds.xmission.com	7
	news.redatomik.org	5
	news.freedyn.net	2
	au2pb.net	1
	TOTAL: 10	196
Including strange strings
	newsfeed.fu-berlin.de	376
	news.swapon.de	22
	csiph-out.feeder.erje.net	13
	news-out.aioe.org	10
	feeder.eternal-september.org	9
	csiph-out.news.weretis.net	9
	usenet.blueworldhosting.com	5
	news-out.mixmin.net	3
	newsfeed.neva.ru	2
	news.fcku.it	2
	TOTAL: 12	454
No colon-space in header
	csiph-out.feeder.erje.net	567
	TOTAL: 1	567
TOTAL: 4		1269

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	29974	1518	25022	7	1	5%	23:59:52
2	xanadu-bbs	27841	1250	25338	79	17	4%	23:59:53
3	news.bbs.geek.nz	47765	1101	24440	18	244	2%	23:59:52
4	fu-berlin.de	25166	996	24133	37	0	3%	23:59:52
5	aioe	24929	482	21369	9	1	1%	23:59:52
6	usenet.pasdenom.info	34318	372	24416	1926	11	1%	23:59:52
7	erje	22415	302	17608	103	1	1%	23:59:10
8	news.redatomik.org	30122	189	24750	46	1340	0%	23:59:52
9	eternal-september	7910	99	6915	28	17066	1%	23:59:53
10	au2pb	24375	71	23822	69	0	0%	23:59:52
11	xmission	30672	29	25202	1	0	0%	23:59:53
12	news.fcku.it	3362	18	2835	0	0	0%	23:10:42
13	news.mixmin.net	26828	13	23009	0	2	0%	23:59:15
14	neva.ru	27564	12	23421	117	1	0%	23:59:48
15	weretis.net	22944	9	22422	5	0	0%	23:59:32
16	bwh	17665	2	17277	0	231	0%	23:59:31
17	news.swapon.de	2001	1	1905	5	0	0%	23:54:48
TOTAL: 17		405851	6464	333884	2450	18915	1%	407:01:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	11.1 MB	56.4 KB	11.2 MB	0.1 KB/s	7.5 KB	23:59:52
2	xanadu-bbs	10.5 MB	189.2 KB	10.7 MB	0.1 KB/s	8.3 KB	23:59:53
3	fu-berlin.de	9.7 MB	48.0 KB	9.8 MB	0.1 KB/s	9.7 KB	23:59:52
4	news.bbs.geek.nz	3.3 MB	58.0 KB	3.3 MB	0.0 KB/s	3.1 KB	23:59:52
5	usenet.pasdenom.info	1.5 MB	11.3 MB	12.7 MB	0.2 KB/s	5.7 KB	23:59:52
6	aioe	1.3 MB	40.7 KB	1.4 MB	0.0 KB/s	2.9 KB	23:59:52
7	erje	1.1 MB	551.8 KB	1.6 MB	0.0 KB/s	4.0 KB	23:59:10
8	news.redatomik.org	690.4 KB	156.6 KB	847.0 KB	0.0 KB/s	3.6 KB	23:59:52
9	au2pb	445.9 KB	179.4 KB	625.3 KB	0.0 KB/s	4.5 KB	23:59:52
10	eternal-september	358.1 KB	102.1 KB	460.2 KB	0.0 KB/s	3.6 KB	23:59:53
11	xmission	113.7 KB	2.0 KB	115.6 KB	0.0 KB/s	3.9 KB	23:59:53
12	news.mixmin.net	70.1 KB	0.0 KB	70.1 KB	0.0 KB/s	5.4 KB	23:59:15
13	neva.ru	45.8 KB	614.4 KB	660.1 KB	0.0 KB/s	5.1 KB	23:59:48
14	news.fcku.it	37.0 KB	0.0 KB	37.0 KB	0.0 KB/s	2.1 KB	23:10:42
15	weretis.net	23.3 KB	12.0 KB	35.3 KB	0.0 KB/s	2.5 KB	23:59:32
16	bwh	3.7 KB	0.0 KB	3.7 KB	0.0 KB/s	1.9 KB	23:59:31
17	news.swapon.de	1.9 KB	9.8 KB	11.7 KB	0.0 KB/s	2.0 KB	23:54:48
TOTAL: 17		40.3 MB	13.2 MB	53.5 MB	0.0 KB/s	6.1 KB	407:01:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	89	315.2 KB	82	0	0	04:00:52
2	tempe0.bbox.io	59	8	13.9 KB	7	2	2	07:45:05
3	188.244.132.171	2	2	3.2 KB	2	0	0	00:00:10
4	dhcp-089-099-203-254.chello.nl	4	2	3.0 KB	2	0	0	01:16:47
TOTAL: 4		353	101	335.2 KB	93	2	2	38:56:16

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	300	91	318.4 KB	84	0	0	28:07:46
2	*.bbox.io	59	8	13.9 KB	7	2	2	07:45:05
3	*.chello.nl	4	2	3.0 KB	2	0	0	01:16:47
4	*.dyn.optonline.net	1	0	0.0 KB	0	0	0	00:00:02
5	*.ip-188-165-239.eu	1	0	0.0 KB	0	0	0	00:00:03
6	*.143.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	0	0	00:00:00
7	*.nielsenmedia.com	4	0	0.0 KB	0	0	0	01:16:29
8	*.tampfl.dsl-w.verizon.net	1	0	0.0 KB	0	0	0	00:30:01
TOTAL: 8		371	101	335.2 KB	93	2	2	38:56:16

NNRP auth users [Top 20]:

User	Conn
moussa	288
kev009	2
TOTAL: 2	290

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.221	1.351	0.579	0.000	24:06:42
tempe0.bbox.io	5.244	1.121	0.005	07:45:05
202.89.176.220	29.861	6.445	0.774	04:00:52
dhcp-089-099-203-254.chello.nl	0.474	0.078	0.000	01:16:47
challenger.nielsenmedia.com	0.379	0.046	0.000	01:16:29
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.080	0.032	0.000	00:30:01
188.244.132.171	0.629	0.406	0.000	00:00:10
ns342002.ip-188-165-239.eu	0.083	0.030	0.000	00:00:03
ool-2f14e00c.dyn.optonline.net	0.063	0.014	0.000	00:00:02
TOTAL: 9	38.164	8.751	0.779	38:56:16

Curious NNRP server explorers [Top 20]:

System	Conn
162.212.88.221	10
challenger.nielsenmedia.com	4
h55.143.22.98.dynamic.ip.windstream.net	1
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1
ool-2f14e00c.dyn.optonline.net	1
ns342002.ip-188-165-239.eu	1
TOTAL: 6	18

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	13	0
challenger.nielsenmedia.com	2	0
dhcp-089-099-203-254.chello.nl	2	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	1	0
188.244.132.171	1	1
TOTAL: 5	19	1

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	90	89.1%
2	news	7	6.9%
3	alt	2	2.0%
4	bit	2	2.0%
TOTAL: 4		101	100.0%

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

Newsgroup		Count
1	comp.os.vms	22
2	comp.ai.philosophy	15
3	comp.arch	15
4	comp.arch.embedded	14
5	comp.os.os2.misc	9
6	comp.sys.ibm.ps2.hardware	8
7	news.admin.peering	7
8	comp.arch.fpga	5
9	bit.listserv.ibm-main	2
10	alt.free.newsservers	2
11	comp.os.linux.networking	1
12	comp.benchmarks	1
TOTAL: 12		101

Daily Usenet report for csiph.com

Jan 8 04:15:00 -- Jan 9 04:15:00