Daily Usenet report for csiph.com: Jul 24 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19972	48.1%	5.1 MB	64.3%
innd	17822	42.9%	2.2 MB	28.3%
innfeed	3306	8.0%	553.6 KB	6.8%
nnrpd	368	0.9%	39.1 KB	0.5%
nocem	59	0.1%	7.0 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	41528	100.0%	7.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	289122	57.5%
Negative hits	193840	38.6%
Do not exist	19215	3.8%
Cache misses	235	0.0%
TOTAL: 4	502412	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.361	0.0%	118	0.000	3.059	25.000
article cleanup	00:00:00.095	0.0%	18327	0.000	0.005	0.048
article logging	00:00:00.324	0.0%	18838	0.000	0.017	0.264
article parse	00:00:03.734	0.0%	84566	0.000	0.044	0.432
article write	00:00:07.573	0.0%	15420	0.153	0.491	15.860
artlog/artcncl	00:00:00.001	0.0%	104	0.000	0.010	1.000
artlog/artparse	00:00:00.006	0.0%	1015	0.000	0.006	0.125
data move	00:00:00.162	0.0%	503440	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.081	0.0%	113	0.000	0.717	9.000
hishave/artcncl	00:00:00.029	0.0%	118	0.000	0.246	4.667
hishave/artparse	00:00:00.003	0.0%	1015	0.000	0.003	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:19.956	0.0%	503875	0.002	0.040	0.576
history sync	00:00:00.801	0.0%	390	0.000	2.054	17.333
history write	00:00:31.227	0.0%	18323	0.068	1.704	11.202
hiswrite/artcncl	00:00:00.001	0.0%	5	0.000	0.200	0.500
hiswrite/artparse	00:00:02.945	0.0%	1014	0.000	2.904	31.000
idle	23:58:32.677	99.8%	506071	84.930	170.554	561.041
nntp read	00:00:02.106	0.0%	507668	0.001	0.004	0.010
overview write	00:00:34.414	0.0%	15420	0.109	2.232	246.643
perl filter	00:00:29.746	0.0%	18307	1.151	1.625	2.664
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.210	0.0%	30892	0.000	0.007	0.021
TOTAL: 24:01:15.389	24:00:46.452	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.036	0.0%	15649	0.000	0.002	0.023
article prepare	00:00:00.002	0.0%	13692	0.000	0.000	0.005
article read	00:00:00.225	0.0%	1402	0.000	0.160	1.688
backlog stats	00:00:00.148	0.0%	332801	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.273	0.0%	257029	0.001	0.005	0.010
data write	00:00:01.573	0.0%	242714	0.001	0.006	0.016
idle	23:54:05.824	100.0%	332801	113.875	258.550	728.170
status file	00:00:00.187	0.0%	269	0.000	0.695	2.000
TOTAL: 23:54:17.564	23:54:09.268	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	10:33:09.898	100.0%	338	163.424	112396.148	600060.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.004	0.0%	868	0.000	0.005	0.167
readart	00:00:00.760	0.0%	69	0.000	11.014	46.000
TOTAL: 10:33:23.340	10:33:10.662	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	3	30407	3096	27117	194	10%	45:28:50
2	newsfeeds.xmission.com	3	15144	1958	13181	5	12%	25:03:01
3	feeder.eternal-september.org	5	16634	1891	14627	116	11%	23:32:45
4	csiph-out.feeder.erje.net	1439	76408	1489	74672	247	1%	118:13:08
5	news-out.aioe.org	3	15071	1432	13608	31	9%	24:09:41
6	news.freedyn.net	3	18478	1240	15952	1286	6%	24:08:56
7	news-out.mixmin.net	3	15808	1079	14538	191	6%	24:05:48
8	newsfeed.fu-berlin.de	7	14165	947	13000	218	6%	22:48:07
9	csiph-out.news.xs4all.nl	864	17577	920	16107	550	5%	71:11:55
10	newsfeed.neva.ru	146	17875	539	16736	600	3%	71:16:32
11	news.fcku.it	15	2016	238	1768	10	11%	22:22:39
12	csiph-out.feed.uzoreto.com	864	24796	212	24214	370	0%	71:11:35
13	nntp.pasdenom.info	4	9765	50	9686	29	0%	20:18:07
14	news.swapon.de	3	1506	32	1474	0	2%	23:22:36
15	news.samoylyk.net	3	15037	10	15027	0	0%	25:47:40
16	news.bbs.nz	2	14801	2	14799	0	0%	23:59:30
17	xanadu-bbs.net	22	534	0	534	0	0%	23:09:25
18	localhost	33	0	0	0	0	0%	00:00:01
TOTAL: 18		3422	306022	15135	287040	3847	4%	660:10:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	9.9 MB	0.0 KB	5.1 MB	15.1 MB	65%	4.7 KB
2	csiph-out.feeder.erje.net	7.0 MB	31.9 KB	3.8 MB	10.9 MB	64%	6.4 KB
3	newsfeeds.xmission.com	5.5 MB	0.0 KB	355.5 KB	5.9 MB	94%	3.1 KB
4	feeder.eternal-september.org	4.9 MB	0.0 KB	520.9 KB	5.4 MB	90%	2.8 KB
5	news.freedyn.net	3.4 MB	0.0 KB	89.1 MB	92.5 MB	3%	37.5 KB
6	news-out.aioe.org	3.3 MB	0.0 KB	48.3 KB	3.4 MB	98%	2.4 KB
7	news-out.mixmin.net	3.1 MB	0.0 KB	415.2 KB	3.5 MB	88%	2.9 KB
8	csiph-out.news.xs4all.nl	2.3 MB	0.0 KB	6.3 MB	8.6 MB	27%	6.0 KB
9	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	533.4 KB	2.7 MB	80%	2.4 KB
10	newsfeed.neva.ru	1.7 MB	33.2 KB	2.0 MB	3.7 MB	44%	3.4 KB
11	csiph-out.feed.uzoreto.com	746.2 KB	31.9 KB	9.5 MB	10.3 MB	7%	18.1 KB
12	news.fcku.it	419.0 KB	0.0 KB	11.5 KB	430.6 KB	97%	1.7 KB
13	nntp.pasdenom.info	98.3 KB	0.0 KB	63.6 KB	161.9 KB	60%	2.0 KB
14	news.swapon.de	76.5 KB	0.0 KB	0.0 KB	76.5 KB	100%	2.4 KB
15	news.samoylyk.net	43.8 KB	0.0 KB	0.0 KB	43.8 KB	100%	4.4 KB
16	news.bbs.nz	6.8 KB	0.0 KB	0.0 KB	6.8 KB	100%	3.4 KB
17	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
18	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		44.8 MB	97.1 KB	117.8 MB	162.7 MB	27%	8.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 24 04:15:00 - 04:59:59	257	1.7%	0.10	1.3 MB	2.8%	0.49
Jul 24 05:00:00 - 05:59:59	425	2.8%	0.12	2.1 MB	4.7%	0.61
Jul 24 06:00:00 - 06:59:59	587	3.8%	0.16	1.7 MB	3.6%	0.47
Jul 24 07:00:00 - 07:59:59	483	3.1%	0.13	1.2 MB	2.6%	0.33
Jul 24 08:00:00 - 08:59:59	670	4.3%	0.19	1.8 MB	3.9%	0.51
Jul 24 09:00:00 - 09:59:59	630	4.1%	0.17	1.5 MB	3.3%	0.43
Jul 24 10:00:00 - 10:59:59	611	4.0%	0.17	1.8 MB	3.9%	0.51
Jul 24 11:00:00 - 11:59:59	740	4.8%	0.21	2.2 MB	4.9%	0.63
Jul 24 12:00:00 - 12:59:59	693	4.5%	0.19	1.9 MB	4.2%	0.54
Jul 24 13:00:00 - 13:59:59	922	6.0%	0.26	2.4 MB	5.3%	0.69
Jul 24 14:00:00 - 14:59:59	781	5.1%	0.22	2.3 MB	5.0%	0.65
Jul 24 15:00:00 - 15:59:59	838	5.4%	0.23	2.3 MB	5.0%	0.64
Jul 24 16:00:00 - 16:59:59	987	6.4%	0.27	2.9 MB	6.3%	0.82
Jul 24 17:00:00 - 17:59:59	896	5.8%	0.25	3.0 MB	6.6%	0.85
Jul 24 18:00:00 - 18:59:59	888	5.8%	0.25	2.4 MB	5.3%	0.69
Jul 24 19:00:00 - 19:59:59	740	4.8%	0.21	1.9 MB	4.2%	0.55
Jul 24 20:00:00 - 20:59:59	852	5.5%	0.24	2.6 MB	5.7%	0.74
Jul 24 21:00:00 - 21:59:59	693	4.5%	0.19	2.0 MB	4.3%	0.56
Jul 24 22:00:00 - 22:59:59	603	3.9%	0.17	1.8 MB	3.9%	0.51
Jul 24 23:00:00 - 23:59:59	509	3.3%	0.14	1.6 MB	3.5%	0.45
Jul 25 00:00:00 - 00:59:59	446	2.9%	0.12	1.4 MB	3.0%	0.39
Jul 25 01:00:00 - 01:59:59	368	2.4%	0.10	1.0 MB	2.2%	0.29
Jul 25 02:00:00 - 02:59:59	391	2.5%	0.11	1.2 MB	2.7%	0.35
Jul 25 03:00:00 - 03:59:59	308	2.0%	0.09	950.5 KB	2.0%	0.26
Jul 25 04:00:00 - 04:15:00	99	0.6%	0.11	510.4 KB	1.1%	0.57
TOTAL: 24:00:00	15417	100.0%	0.18	45.7 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.freedyn.net	1306	31	0	1275
2	newsfeed.fu-berlin.de	669	48	0	621
3	newsfeed.neva.ru	619	71	1	547
4	csiph-out.news.xs4all.nl	561	27	0	534
5	csiph-out.feed.uzoreto.com	374	6	1	367
6	csiph-out.feeder.erje.net	251	46	1	204
7	csiph-out.news.weretis.net	244	91	0	153
8	news-out.mixmin.net	202	3	0	199
9	feeder.eternal-september.org	132	43	0	89
10	news-out.aioe.org	41	32	0	9
11	nntp.pasdenom.info	32	0	0	32
12	news.fcku.it	10	10	0	0
13	news.swapon.de	7	0	0	7
14	newsfeeds.xmission.com	5	0	0	5
TOTAL: 14		4453	408	3	4042

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.bbs.synchronet	51
alt.computer.workshop	41
it-alt.sport.calcio.juventus	36
lada.talk	30
spline.eisfair	27
alt.windows7.general	23
lada.auto	19
alt.slack.goathead	17
oesterreich.tratsch	12
lada.photo	11
mozilla.general	11
alt.survival	11
alt.binaries.ebook	10
spline.fli4l	9
mozilla.support.seamonkey	7
mozilla.dev.security.policy	5
alt.fr.os.windows.7	4
mozilla.dev.platform	3
alt.paranormal.spells	3
alt.binaries.audiobooks	3
TOTAL: 75	408

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2017
EMP (phn path)	190
EMP (phn nph)	92
Too many newsgroups	60
EMP (phl)	42
User-issued spam cancel	29
Binary: misplaced rar	19
User-issued cancel	15
HTML Multipart	14
Binary: misplaced par2	5
Scoring filter (10)	5
Binary Payload	4
Binary: misplaced nfo	2
Scoring filter (9)	2
Scoring filter (16)	1
Scoring filter (11)	1
Too many newsgroups (meow)	1
HTML Image Tags	1
Binary: misplaced nzb	1
TOTAL: 19	2501

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	34	0	35	35
TOTAL: 1	34	18	35	35

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	6
	csiph-out.news.xs4all.nl	2
	TOTAL: 2	8
Bad Message-ID's offered
	csiph-out.feeder.erje.net	50
	csiph-out.news.xs4all.nl	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	52
Huge articles
	news.freedyn.net	649
	csiph-out.feed.uzoreto.com	118
	csiph-out.news.weretis.net	106
	csiph-out.news.xs4all.nl	67
	csiph-out.feeder.erje.net	62
	newsfeeds.xmission.com	5
	feeder.eternal-september.org	3
	news-out.mixmin.net	2
	newsfeed.fu-berlin.de	1
	TOTAL: 9	1013
Including strange strings
	newsfeed.fu-berlin.de	448
	csiph-out.news.weretis.net	19
	newsfeed.neva.ru	11
	news-out.mixmin.net	8
	news-out.aioe.org	8
	news.swapon.de	7
	csiph-out.news.xs4all.nl	4
	feeder.eternal-september.org	3
	csiph-out.feeder.erje.net	3
	csiph-out.feed.uzoreto.com	1
	TOTAL: 10	512
TOTAL: 4		1585

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17742	463	14954	0	0	2%	23:59:52
2	news.samoylyk.net	16149	429	14955	2	102	2%	23:57:07
3	news.freedyn.net	14475	420	13690	26	0	2%	23:59:53
4	fu-berlin.de	14249	413	13836	0	0	2%	23:59:33
5	news.bbs.nz	29155	261	14654	6	0	0%	23:50:04
6	usenet.pasdenom.info	15885	83	14292	991	46	0%	23:59:53
7	erje	15074	36	13719	62	70	0%	23:59:53
8	aioe	13407	18	12907	0	0	0%	23:50:04
9	newsfeed.xs4all.nl	15155	13	14337	12	60	0%	23:56:41
10	neva.ru	14379	6	14132	189	0	0%	23:59:47
11	news.mixmin.net	14219	3	13743	0	0	0%	23:59:38
12	eternal-september	13435	3	12915	1	0	0%	23:59:52
13	xmission	16732	1	13005	1	0	0%	23:59:53
14	weretis.net	11776	1	11558	0	0	0%	23:54:34
15	news.fcku.it	1676	0	1671	0	0	0%	21:32:55
16	news.uzoreto.com	14954	0	14652	43	0	0%	23:52:10
17	news.swapon.de	1693	0	1665	0	0	0%	23:58:29
18	news.redatomik.org	0	0	0	0	14922	0%	23:50:04
TOTAL: 18		240155	2150	210685	1333	15200	0%	428:40:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	4.0 MB	0.0 KB	4.0 MB	0.0 KB/s	8.8 KB	23:59:52
2	news.freedyn.net	3.9 MB	42.9 KB	3.9 MB	0.0 KB/s	9.0 KB	23:59:53
3	fu-berlin.de	3.9 MB	0.0 KB	3.9 MB	0.0 KB/s	9.6 KB	23:59:33
4	news.samoylyk.net	3.8 MB	2.6 KB	3.8 MB	0.0 KB/s	9.1 KB	23:57:07
5	news.bbs.nz	621.2 KB	11.0 KB	632.2 KB	0.0 KB/s	2.4 KB	23:50:04
6	usenet.pasdenom.info	179.2 KB	5.0 MB	5.1 MB	0.1 KB/s	4.9 KB	23:59:53
7	erje	96.5 KB	298.4 KB	395.0 KB	0.0 KB/s	4.0 KB	23:59:53
8	aioe	37.9 KB	0.0 KB	37.9 KB	0.0 KB/s	2.1 KB	23:50:04
9	newsfeed.xs4all.nl	30.8 KB	43.8 KB	74.6 KB	0.0 KB/s	3.0 KB	23:56:41
10	neva.ru	17.0 KB	429.3 KB	446.2 KB	0.0 KB/s	2.3 KB	23:59:47
11	eternal-september	5.8 KB	9.0 KB	14.9 KB	0.0 KB/s	3.7 KB	23:59:52
12	news.mixmin.net	4.2 KB	0.0 KB	4.2 KB	0.0 KB/s	1.4 KB	23:59:38
13	xmission	2.1 KB	1.4 KB	3.6 KB	0.0 KB/s	1.8 KB	23:59:53
14	weretis.net	2.1 KB	0.0 KB	2.1 KB	0.0 KB/s	2.1 KB	23:54:34
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:32:55
16	news.uzoreto.com	0.0 KB	152.0 KB	152.0 KB	0.0 KB/s	3.5 KB	23:52:10
17	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:29
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:04
TOTAL: 18		16.6 MB	5.9 MB	22.5 MB	0.0 KB/s	6.6 KB	428:40:22

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	176.235.169.138	13	34	112.5 KB	10	01:18:41
2	challenger.nielsenmedia.com	3	33	41.5 KB	2	00:45:47
3	a131033.upc-a.chello.nl	13	2	4.1 KB	2	02:47:44
TOTAL: 3		29	69	158.1 KB	14	10:33:22

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	13	34	112.5 KB	10	01:18:41
2	*.nielsenmedia.com	3	33	41.5 KB	2	00:45:47
3	*.upc-a.chello.nl	13	2	4.1 KB	2	02:47:44
4	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	00:30:00
5	*.ph.ph.cox.net	11	0	0.0 KB	0	04:46:06
6	*.dhcp.mdsn.wi.charter.com	2	0	0.0 KB	0	00:25:02
TOTAL: 6		43	69	158.1 KB	14	10:33:22

NNRP auth users [Top 20]:

User	Conn
ctomczyk	11
TOTAL: 1	11

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
ip72-222-200-117.ph.ph.cox.net	0.953	0.144	0.000	04:46:06
a131033.upc-a.chello.nl	0.956	0.153	0.000	02:47:44
176.235.169.138	1.305	0.193	0.024	01:18:41
challenger.nielsenmedia.com	0.330	0.046	0.000	00:45:47
c-67-160-62-214.hsd1.wa.comcast.net	0.049	0.028	0.000	00:30:00
68-114-223-148.dhcp.mdsn.wi.charter.com	0.131	0.029	0.000	00:25:02
TOTAL: 6	3.724	0.593	0.024	10:33:22

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	11
68-114-223-148.dhcp.mdsn.wi.charter.com	2
c-67-160-62-214.hsd1.wa.comcast.net	1
TOTAL: 3	14

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	8	0
challenger.nielsenmedia.com	1	0
c-67-160-62-214.hsd1.wa.comcast.net	1	0
TOTAL: 3	10	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	69	100.0%
TOTAL: 1		69	100.0%

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

Newsgroup		Count
1	comp.lang.javascript	34
2	comp.lang.awk	33
3	comp.sys.ibm.ps2.hardware	2
TOTAL: 3		69

Daily Usenet report for csiph.com

Jul 24 04:15:00 -- Jul 25 04:15:00