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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	45496	60.2%	8.4 MB	71.3%
innd	25554	33.8%	2.7 MB	23.0%
innfeed	3174	4.2%	532.7 KB	4.4%
nnrpd	1317	1.7%	143.9 KB	1.2%
nocem	80	0.1%	8.1 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	75622	100.0%	11.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	446215	56.3%
Negative hits	301400	38.0%
Do not exist	44149	5.6%
Cache misses	610	0.1%
TOTAL: 4	792374	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.436	0.0%	240	0.000	1.817	46.000
article cleanup	00:00:00.313	0.0%	44671	0.000	0.007	0.029
article logging	00:00:03.725	0.0%	45216	0.000	0.082	0.623
article parse	00:00:02.306	0.0%	148304	0.000	0.016	0.182
article write	00:02:46.138	0.2%	24034	0.203	6.913	27.299
artlog/artcncl	00:00:00.000	0.0%	205	0.000	0.000	0.000
artlog/artparse	00:00:00.001	0.0%	100	0.000	0.010	0.167
data move	00:00:00.381	0.0%	714920	0.000	0.001	0.008
hisgrep/artcncl	00:00:00.082	0.0%	239	0.000	0.343	31.000
hishave/artcncl	00:00:00.002	0.0%	240	0.000	0.008	0.500
hishave/artparse	00:00:00.000	0.0%	99	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:49.794	0.1%	792532	0.002	0.139	0.442
history sync	00:00:05.301	0.0%	364	0.000	14.563	143.500
history write	00:03:29.676	0.2%	43974	0.063	4.768	19.695
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.618	0.0%	97	0.000	6.371	86.000
idle	23:45:29.821	98.9%	698032	66.370	122.530	341.653
nntp read	00:00:03.441	0.0%	729159	0.002	0.005	0.013
overview write	00:04:01.904	0.3%	24034	0.923	10.065	164.918
perl filter	00:01:49.994	0.1%	43812	1.680	2.511	4.022
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.458	0.0%	48138	0.000	0.010	0.031
TOTAL: 24:01:01.331	23:59:44.391	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.070	0.0%	24009	0.000	0.003	0.027
article prepare	00:00:00.003	0.0%	40672	0.000	0.000	0.004
article read	00:00:01.232	0.0%	7559	0.046	0.163	2.294
backlog stats	00:00:00.262	0.0%	443078	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.261	0.0%	343705	0.002	0.007	0.013
data write	00:00:02.108	0.0%	326924	0.002	0.006	0.011
idle	23:52:46.737	100.0%	443078	100.398	194.022	444.748
status file	00:00:00.209	0.0%	270	0.000	0.774	12.000
TOTAL: 23:53:06.315	23:52:52.882	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.403	0.0%	293	0.000	1.375	21.000
idle	65:57:24.583	99.8%	1310	0.000	181255.407	900241.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.649	0.0%	3454	0.000	0.767	140.588
readart	00:00:04.609	0.0%	397	0.000	11.610	61.000
TOTAL: 66:06:27.250	65:57:32.244	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	141126	7969	121749	11408	5%	95:02:58
2	csiph-out.news.weretis.net	4	56090	4352	50946	792	7%	54:33:24
3	feeder.eternal-september.org	58	38716	3437	29499	5780	8%	36:33:55
4	news-out.aioe.org	3	23050	1983	21027	40	8%	24:09:54
5	newsfeed.neva.ru	146	59234	1428	54916	2890	2%	71:56:58
6	news-out.mixmin.net	3	26476	1178	24984	314	4%	24:08:43
7	newsfeed.fu-berlin.de	59	22340	1031	20635	674	4%	30:27:13
8	news.redatomik.org	1	31724	950	30769	5	2%	34:13:00
9	newsfeeds.xmission.com	2	24290	788	23492	10	3%	26:35:51
10	news.fcku.it	2	10435	580	9793	62	5%	23:59:48
11	xanadu-bbs.net	6	1739	182	1549	8	10%	35:06:31
12	news.freedyn.net	3	27068	125	26744	199	0%	24:09:50
13	nntp.pasdenom.info	3	23162	103	23030	29	0%	24:08:04
14	news.swapon.de	1	2633	89	2529	15	3%	23:17:05
15	news.bbs.geek.nz	2	17029	28	16998	3	0%	23:59:41
16	localhost	51	15	15	0	0	100%	00:00:11
TOTAL: 16		1496	505127	24238	458660	22229	4%	552:23:06

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	24.8 MB	2.2 MB	62.0 MB	89.0 MB	27%	4.7 KB
2	csiph-out.news.weretis.net	13.0 MB	21.7 KB	10.2 MB	23.3 MB	55%	4.6 KB
3	feeder.eternal-september.org	9.1 MB	5.5 MB	75.7 MB	90.2 MB	10%	10.0 KB
4	news-out.mixmin.net	5.6 MB	8.1 KB	1.3 MB	6.8 MB	81%	4.7 KB
5	news-out.aioe.org	4.9 MB	2.6 KB	105.6 KB	5.0 MB	97%	2.6 KB
6	newsfeed.neva.ru	3.4 MB	536.0 KB	25.0 MB	29.0 MB	11%	6.9 KB
7	news.redatomik.org	2.9 MB	7.8 KB	63.6 KB	3.0 MB	97%	3.2 KB
8	newsfeeds.xmission.com	2.2 MB	7.3 KB	361.6 KB	2.5 MB	85%	3.3 KB
9	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	1.9 MB	3.9 MB	52%	2.4 KB
10	news.fcku.it	1.2 MB	2.5 KB	360.0 KB	1.6 MB	77%	2.5 KB
11	xanadu-bbs.net	495.4 KB	0.0 KB	35.2 KB	530.6 KB	93%	2.8 KB
12	news.freedyn.net	444.0 KB	0.0 KB	2.0 MB	2.4 MB	17%	7.6 KB
13	nntp.pasdenom.info	250.5 KB	7.9 KB	69.5 KB	327.8 KB	76%	2.5 KB
14	news.swapon.de	246.8 KB	6.3 KB	37.6 KB	290.8 KB	84%	2.8 KB
15	news.bbs.geek.nz	66.4 KB	2.7 KB	7.7 KB	76.8 KB	86%	2.5 KB
16	localhost	19.2 KB	0.0 KB	0.0 KB	19.2 KB	100%	1.3 KB
TOTAL: 16		70.7 MB	8.3 MB	179.0 MB	258.0 MB	27%	5.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 13 04:15:00 - 04:59:59	375	1.6%	0.14	1.1 MB	1.5%	0.41
Feb 13 05:00:00 - 05:59:59	573	2.4%	0.16	2.2 MB	3.1%	0.61
Feb 13 06:00:00 - 06:59:59	605	2.5%	0.17	2.6 MB	3.7%	0.74
Feb 13 07:00:00 - 07:59:59	709	3.0%	0.20	2.5 MB	3.6%	0.71
Feb 13 08:00:00 - 08:59:59	936	3.9%	0.26	2.6 MB	3.7%	0.74
Feb 13 09:00:00 - 09:59:59	973	4.0%	0.27	2.7 MB	3.8%	0.76
Feb 13 10:00:00 - 10:59:59	1069	4.4%	0.30	2.7 MB	3.9%	0.77
Feb 13 11:00:00 - 11:59:59	1095	4.6%	0.30	3.1 MB	4.5%	0.89
Feb 13 12:00:00 - 12:59:59	1125	4.7%	0.31	3.0 MB	4.2%	0.84
Feb 13 13:00:00 - 13:59:59	1230	5.1%	0.34	3.2 MB	4.6%	0.91
Feb 13 14:00:00 - 14:59:59	1135	4.7%	0.32	3.1 MB	4.4%	0.87
Feb 13 15:00:00 - 15:59:59	1378	5.7%	0.38	4.0 MB	5.7%	1.14
Feb 13 16:00:00 - 16:59:59	1325	5.5%	0.37	3.9 MB	5.6%	1.12
Feb 13 17:00:00 - 17:59:59	1525	6.3%	0.42	4.6 MB	6.6%	1.32
Feb 13 18:00:00 - 18:59:59	1398	5.8%	0.39	3.9 MB	5.6%	1.11
Feb 13 19:00:00 - 19:59:59	1446	6.0%	0.40	3.9 MB	5.6%	1.10
Feb 13 20:00:00 - 20:59:59	1266	5.3%	0.35	3.4 MB	4.8%	0.96
Feb 13 21:00:00 - 21:59:59	1259	5.2%	0.35	3.6 MB	5.1%	1.02
Feb 13 22:00:00 - 22:59:59	1155	4.8%	0.32	3.2 MB	4.6%	0.91
Feb 13 23:00:00 - 23:59:59	817	3.4%	0.23	2.6 MB	3.7%	0.73
Feb 14 00:00:00 - 00:59:59	771	3.2%	0.21	2.4 MB	3.4%	0.68
Feb 14 01:00:00 - 01:59:59	617	2.6%	0.17	2.1 MB	3.0%	0.59
Feb 14 02:00:00 - 02:59:59	561	2.3%	0.16	1.6 MB	2.2%	0.44
Feb 14 03:00:00 - 03:59:59	570	2.4%	0.16	1.7 MB	2.5%	0.49
Feb 14 04:00:00 - 04:15:00	115	0.5%	0.13	383.5 KB	0.5%	0.43
TOTAL: 24:00:00	24028	100.0%	0.28	69.9 MB	100.0%	0.83

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	9815	430	196	1	9188
2	feeder.eternal-september.org	5919	24	436	0	5459
3	newsfeed.neva.ru	2955	173	47	0	2735
4	newsfeed.fu-berlin.de	1082	41	0	0	1041
5	csiph-out.news.weretis.net	720	197	5	0	518
6	news-out.mixmin.net	331	9	3	0	319
7	news.freedyn.net	201	17	0	0	184
8	news.fcku.it	67	4	1	0	62
9	news.swapon.de	59	0	1	0	58
10	news-out.aioe.org	48	34	1	0	13
11	nntp.pasdenom.info	30	12	2	0	16
12	newsfeeds.xmission.com	17	1	4	0	12
13	news.redatomik.org	11	0	2	0	9
14	xanadu-bbs.net	6	0	0	0	6
15	news.bbs.geek.nz	2	1	0	0	1
TOTAL: 15		21263	943	698	1	19621

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ut.test	114
it-alt.sport.calcio.juventus	56
lada.talk	50
lada.auto	46
it.annunci.immobiliari	42
it.annunci.commerciali	37
it.annunci.varie	36
mozilla.dev.security.policy	35
gmane.comp.gis.openstreetmap.tagging	33
spline.eisfair	32
gmane.linux.alsa.devel	23
mozilla.dev.platform	19
mpc.lists.freebsd.x11	18
lada.commerce	17
alt.survival	17
mozilla.support.firefox	17
mpc.lists.freebsd.gnome	16
alt.windows7.general	13
alt.pl.nieruchomosci.gielda	12
alt.computer.workshop	12
TOTAL: 151	943

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

Groups	Count
it.politica.m5s	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	16081
EMP (phn path)	1867
EMP (phl)	529
EMP (phn nph)	135
Too many newsgroups	60
Scoring filter (8)	40
HTML Multipart	18
User-issued cancel	17
Scoring filter (10)	15
Binary Payload	12
Scoring filter (20)	5
Too many newsgroups (meow)	5
Scoring filter (18)	5
Binary: misplaced par2	4
HTML post	3
Scoring filter (14)	3
Scoring filter (21)	2
Scoring filter (24)	2
Scoring filter (25)	2
User-issued spam cancel	2
TOTAL: 26	18815

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	161
	TOTAL: 1	161
Huge articles
	csiph-out.news.weretis.net	44
	feeder.eternal-september.org	18
	news.freedyn.net	14
	news-out.mixmin.net	12
	newsfeeds.xmission.com	6
	newsfeed.fu-berlin.de	2
	news.swapon.de	2
	news.fcku.it	1
	TOTAL: 8	99
Including strange strings
	newsfeed.fu-berlin.de	371
	csiph-out.feeder.erje.net	49
	feeder.eternal-september.org	31
	csiph-out.news.weretis.net	21
	news-out.mixmin.net	16
	newsfeed.neva.ru	13
	news.swapon.de	12
	news-out.aioe.org	11
	news.redatomik.org	8
	newsfeeds.xmission.com	6
	TOTAL: 13	545
TOTAL: 3		805

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.geek.nz	40035	6002	17235	86	2	0	14%	23:51:19
2	news.freedyn.net	24885	822	23067	5	0	0	3%	23:58:21
3	xanadu-bbs	26925	741	23140	0	0	0	2%	23:59:50
4	fu-berlin.de	22630	602	22018	0	0	15	2%	23:58:21
5	usenet.pasdenom.info	26943	193	22540	1192	0	13	0%	23:59:51
6	xmission	27580	175	22337	5	0	0	0%	23:59:51
7	erje	16100	116	15760	20	0	0	0%	23:50:04
8	news.redatomik.org	23770	40	22513	21	0	0	0%	23:54:46
9	weretis.net	18236	36	17356	0	0	0	0%	23:50:04
10	aioe	20893	30	19606	7	0	0	0%	23:50:04
11	eternal-september	21683	22	19622	0	0	0	0%	23:59:51
12	news.mixmin.net	22389	16	21253	0	0	0	0%	23:50:04
13	news.swapon.de	2219	13	2127	2	0	0	0%	23:45:06
14	neva.ru	23175	6	21615	18	0	0	0%	23:59:51
15	bwh	0	0	0	0	0	23327	0%	23:50:07
16	news.fcku.it	2252	0	2236	0	0	0	0%	22:39:19
17	au2pb	0	0	0	0	0	23347	0%	23:50:09
TOTAL: 17		319715	8814	272425	1356	2	46702	2%	405:06:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	15.5 MB	251.0 KB	15.8 MB	0.2 KB/s	2.7 KB	23:51:19
2	news.freedyn.net	5.6 MB	27.3 KB	5.7 MB	0.1 KB/s	7.0 KB	23:58:21
3	xanadu-bbs	5.3 MB	0.0 KB	5.3 MB	0.1 KB/s	7.4 KB	23:59:50
4	fu-berlin.de	5.0 MB	0.0 KB	5.0 MB	0.1 KB/s	8.5 KB	23:58:21
5	usenet.pasdenom.info	677.3 KB	6.0 MB	6.7 MB	0.1 KB/s	4.9 KB	23:59:51
6	erje	482.5 KB	174.5 KB	656.9 KB	0.0 KB/s	4.8 KB	23:50:04
7	xmission	404.8 KB	8.8 KB	413.6 KB	0.0 KB/s	2.3 KB	23:59:51
8	weretis.net	117.6 KB	0.0 KB	117.6 KB	0.0 KB/s	3.3 KB	23:50:04
9	news.redatomik.org	87.7 KB	77.0 KB	164.6 KB	0.0 KB/s	2.7 KB	23:54:46
10	aioe	59.1 KB	25.5 KB	84.6 KB	0.0 KB/s	2.3 KB	23:50:04
11	eternal-september	44.3 KB	0.0 KB	44.3 KB	0.0 KB/s	2.0 KB	23:59:51
12	news.mixmin.net	26.7 KB	0.0 KB	26.7 KB	0.0 KB/s	1.7 KB	23:50:04
13	news.swapon.de	16.6 KB	2.6 KB	19.2 KB	0.0 KB/s	1.3 KB	23:45:06
14	neva.ru	8.9 KB	31.2 KB	40.1 KB	0.0 KB/s	1.7 KB	23:59:51
15	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:07
16	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:39:19
17	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:09
TOTAL: 17		33.4 MB	6.6 MB	40.0 MB	0.0 KB/s	4.0 KB	405:06:58

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	tempe0.bbox.io	40	365	659.1 KB	19	5	4	08:37:54
2	68-185-181-64.dhcp.mdsn.wi.charter.com	30	17	23.7 KB	9	10	10	06:30:45
3	dhcp-089-099-203-254.chello.nl	14	9	12.8 KB	2	0	0	03:51:34
4	194-73-239-109.cust.centrio.cz	4	5	10.9 KB	2	0	0	01:01:40
5	1.126.48.227	1	1	3.8 KB	1	0	0	00:30:08
TOTAL: 5		89	397	710.3 KB	33	15	14	66:06:25

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.bbox.io	40	365	659.1 KB	19	5	4	08:37:54
2	*.dhcp.mdsn.wi.charter.com	30	17	23.7 KB	9	10	10	06:30:45
3	*.chello.nl	14	9	12.8 KB	2	0	0	03:51:34
4	*.cust.centrio.cz	4	5	10.9 KB	2	0	0	01:01:40
5	unresolved	98	1	3.8 KB	1	0	0	46:04:29
TOTAL: 5		186	397	710.3 KB	33	15	14	66:06:25

NNRP auth users [Top 20]:

User	Conn
ohlandl	10
kev009	4
ctomczyk	2
moussa	1
TOTAL: 4	17

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
216.239.174.218	7.088	1.545	0.000	45:33:41
tempe0.bbox.io	4.089	2.151	0.018	08:37:54
68-185-181-64.dhcp.mdsn.wi.charter.com	2.975	0.643	0.038	06:30:45
dhcp-089-099-203-254.chello.nl	1.090	0.195	0.000	03:51:34
194-73-239-109.cust.centrio.cz	0.400	0.080	0.006	01:01:40
1.126.48.227	0.082	0.038	0.004	00:30:08
5.51.176.30	0.188	0.049	0.000	00:00:39
TOTAL: 7	15.912	4.701	0.066	66:06:25

Curious NNRP server explorers [Top 20]:

System	Conn
216.239.174.218	95
5.51.176.30	2
TOTAL: 2	97

NNRP client timeouts [Top 20]:

System	Conn	Peer
216.239.174.218	87	0
tempe0.bbox.io	14	0
68-185-181-64.dhcp.mdsn.wi.charter.com	4	0
194-73-239-109.cust.centrio.cz	2	0
1.126.48.227	1	0
TOTAL: 5	108	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	389	98.0%
2	muc	5	1.3%
3	bit	3	0.8%
TOTAL: 3		397	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	382
2	comp.lang.javascript	7
3	bit.listserv.ibm-main	3
4	muc.lists.freebsd.fs	2
5	muc.lists.freebsd.stable	2
6	muc.lists.freebsd.hardware	1
TOTAL: 6		397

Daily Usenet report for csiph.com

Feb 13 04:15:00 -- Feb 14 04:15:00