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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	41236	59.4%	7.6 MB	70.4%
innd	24196	34.8%	2.6 MB	23.8%
innfeed	3228	4.6%	550.5 KB	5.0%
nnrpd	723	1.0%	81.3 KB	0.7%
nocem	66	0.1%	7.1 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	69450	100.0%	10.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	403747	56.6%
Negative hits	268499	37.7%
Do not exist	40236	5.6%
Cache misses	644	0.1%
TOTAL: 4	713126	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.608	0.0%	213	0.000	2.854	36.000
article cleanup	00:00:00.256	0.0%	40364	0.000	0.006	0.026
article logging	00:00:02.445	0.0%	40884	0.000	0.060	0.509
article parse	00:00:02.097	0.0%	134222	0.003	0.016	0.189
article write	00:01:59.651	0.1%	21622	0.195	5.534	19.935
artlog/artcncl	00:00:00.001	0.0%	193	0.000	0.005	0.091
artlog/artparse	00:00:00.037	0.0%	209	0.000	0.177	1.714
data move	00:00:00.328	0.0%	664034	0.000	0.000	0.010
hisgrep/artcncl	00:00:00.197	0.0%	211	0.000	0.934	20.000
hishave/artcncl	00:00:00.111	0.0%	213	0.000	0.521	7.571
hishave/artparse	00:00:00.002	0.0%	205	0.000	0.010	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:10.822	0.1%	717055	0.002	0.099	0.440
history sync	00:00:04.164	0.0%	357	0.000	11.664	154.333
history write	00:02:32.324	0.2%	40248	0.089	3.785	19.377
hiswrite/artcncl	00:00:00.002	0.0%	2	1.000	1.000	1.000
hiswrite/artparse	00:00:00.554	0.0%	205	0.000	2.702	23.500
idle	23:49:04.492	99.2%	657212	78.236	130.467	395.786
nntp read	00:00:03.043	0.0%	678316	0.002	0.004	0.009
overview write	00:02:59.030	0.2%	21622	0.831	8.280	68.158
perl filter	00:01:38.965	0.1%	40179	1.483	2.463	4.708
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.398	0.0%	43302	0.000	0.009	0.030
TOTAL: 24:00:48.079	23:59:39.527	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.067	0.0%	21619	0.000	0.003	0.034
article prepare	00:00:00.006	0.0%	40932	0.000	0.000	0.003
article read	00:00:01.678	0.0%	7407	0.029	0.227	12.207
backlog stats	00:00:00.259	0.0%	428587	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.204	0.0%	318443	0.002	0.007	0.013
data write	00:00:01.896	0.0%	300850	0.002	0.006	0.011
idle	23:54:32.941	100.0%	428587	113.079	200.830	553.353
status file	00:00:00.322	0.0%	298	0.000	1.081	19.200
TOTAL: 23:54:49.896	23:54:39.373	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	32:19:11.290	100.0%	521	1010.000	223323.013	600100.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.010	0.0%	1185	0.000	0.008	0.500
readart	00:00:00.683	0.0%	44	0.000	15.523	56.000
TOTAL: 32:19:57.896	32:19:11.983	100.0%	-	-	-	-

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	130622	9097	110222	11303	6%	94:58:38
2	feeder.eternal-september.org	3	36394	3499	28525	4370	9%	24:32:33
3	news-out.aioe.org	3	21256	2366	18836	54	11%	24:09:56
4	csiph-out.news.weretis.net	4	44248	2339	41315	594	5%	45:37:39
5	newsfeed.neva.ru	147	53273	1089	49056	3128	2%	71:40:37
6	newsfeed.fu-berlin.de	24	22912	1047	21196	669	4%	27:47:37
7	newsfeeds.xmission.com	3	23624	669	22952	3	2%	29:23:04
8	news.redatomik.org	1	19039	602	18431	6	3%	22:02:44
9	news-out.mixmin.net	2	24967	535	24106	326	2%	24:08:39
10	news.freedyn.net	3	25180	97	24916	167	0%	24:09:48
11	nntp.pasdenom.info	2	20408	93	20302	13	0%	23:58:32
12	news.fcku.it	2	8900	74	8790	36	0%	23:59:47
13	xanadu-bbs.net	16	782	36	743	3	4%	22:47:04
14	news.bbs.geek.nz	1	14502	15	14487	0	0%	23:59:35
15	localhost	42	8	8	0	0	100%	00:00:00
16	news.swapon.de	1	159	2	157	0	1%	03:51:13
TOTAL: 16		1406	446274	21568	404034	20672	4%	487:07:26

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	26.4 MB	1.1 MB	60.9 MB	88.5 MB	29%	4.4 KB
2	feeder.eternal-september.org	9.1 MB	55.8 KB	57.7 MB	66.9 MB	13%	8.7 KB
3	csiph-out.news.weretis.net	8.1 MB	0.0 KB	10.9 MB	19.0 MB	42%	6.6 KB
4	news-out.aioe.org	6.8 MB	0.0 KB	96.0 KB	6.9 MB	98%	2.9 KB
5	news-out.mixmin.net	3.1 MB	0.0 KB	1.1 MB	4.2 MB	74%	5.0 KB
6	newsfeed.neva.ru	2.7 MB	48.1 KB	25.6 MB	28.3 MB	9%	6.9 KB
7	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	1.7 MB	4.0 MB	56%	2.4 KB
8	newsfeeds.xmission.com	1.8 MB	0.0 KB	170.1 KB	2.0 MB	91%	3.1 KB
9	news.redatomik.org	1.6 MB	2.5 KB	11.4 KB	1.6 MB	99%	2.6 KB
10	news.freedyn.net	439.3 KB	0.0 KB	3.4 MB	3.8 MB	11%	14.9 KB
11	nntp.pasdenom.info	245.1 KB	0.0 KB	39.6 KB	284.7 KB	86%	2.7 KB
12	news.fcku.it	138.9 KB	0.0 KB	2.4 MB	2.6 MB	5%	23.8 KB
13	xanadu-bbs.net	124.0 KB	0.0 KB	16.4 KB	140.4 KB	88%	3.6 KB
14	news.bbs.geek.nz	26.6 KB	0.0 KB	0.0 KB	26.6 KB	100%	1.8 KB
15	localhost	9.6 KB	0.0 KB	0.0 KB	9.6 KB	100%	1.2 KB
16	news.swapon.de	5.4 KB	0.0 KB	0.0 KB	5.4 KB	100%	2.7 KB
TOTAL: 16		62.9 MB	1.2 MB	164.1 MB	228.2 MB	27%	5.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 19 04:15:00 - 04:59:59	343	1.6%	0.13	977.2 KB	1.5%	0.36
Feb 19 05:00:00 - 05:59:59	410	1.9%	0.11	1.4 MB	2.3%	0.40
Feb 19 06:00:00 - 06:59:59	474	2.2%	0.13	1.5 MB	2.3%	0.41
Feb 19 07:00:00 - 07:59:59	677	3.1%	0.19	2.3 MB	3.7%	0.66
Feb 19 08:00:00 - 08:59:59	783	3.6%	0.22	2.6 MB	4.1%	0.73
Feb 19 09:00:00 - 09:59:59	935	4.3%	0.26	2.9 MB	4.6%	0.83
Feb 19 10:00:00 - 10:59:59	910	4.2%	0.25	2.6 MB	4.2%	0.75
Feb 19 11:00:00 - 11:59:59	846	3.9%	0.23	2.1 MB	3.4%	0.61
Feb 19 12:00:00 - 12:59:59	964	4.5%	0.27	2.5 MB	4.0%	0.71
Feb 19 13:00:00 - 13:59:59	1041	4.8%	0.29	2.8 MB	4.5%	0.80
Feb 19 14:00:00 - 14:59:59	1068	4.9%	0.30	3.2 MB	5.0%	0.90
Feb 19 15:00:00 - 15:59:59	1109	5.1%	0.31	3.0 MB	4.8%	0.85
Feb 19 16:00:00 - 16:59:59	1242	5.7%	0.34	3.5 MB	5.6%	1.01
Feb 19 17:00:00 - 17:59:59	1189	5.5%	0.33	3.4 MB	5.5%	0.98
Feb 19 18:00:00 - 18:59:59	1293	6.0%	0.36	3.5 MB	5.6%	1.00
Feb 19 19:00:00 - 19:59:59	1418	6.6%	0.39	3.9 MB	6.3%	1.12
Feb 19 20:00:00 - 20:59:59	1241	5.7%	0.34	3.2 MB	5.1%	0.92
Feb 19 21:00:00 - 21:59:59	1266	5.9%	0.35	3.5 MB	5.5%	0.99
Feb 19 22:00:00 - 22:59:59	1165	5.4%	0.32	4.1 MB	6.5%	1.17
Feb 19 23:00:00 - 23:59:59	888	4.1%	0.25	2.7 MB	4.2%	0.75
Feb 20 00:00:00 - 00:59:59	698	3.2%	0.19	2.2 MB	3.5%	0.63
Feb 20 01:00:00 - 01:59:59	573	2.7%	0.16	1.6 MB	2.5%	0.45
Feb 20 02:00:00 - 02:59:59	517	2.4%	0.14	1.5 MB	2.4%	0.43
Feb 20 03:00:00 - 03:59:59	458	2.1%	0.13	1.5 MB	2.4%	0.44
Feb 20 04:00:00 - 04:15:00	100	0.5%	0.11	280.8 KB	0.4%	0.31
TOTAL: 24:00:00	21608	100.0%	0.25	62.9 MB	100.0%	0.75

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	9585	270	106	9209
2	feeder.eternal-september.org	4421	73	6	4342
3	newsfeed.neva.ru	3102	219	7	2876
4	newsfeed.fu-berlin.de	1026	26	0	1000
5	csiph-out.news.weretis.net	610	81	0	529
6	news-out.mixmin.net	330	3	0	327
7	news.freedyn.net	163	4	0	159
8	news-out.aioe.org	82	40	0	42
9	news.swapon.de	47	0	0	47
10	news.fcku.it	33	0	0	33
11	nntp.pasdenom.info	14	6	0	8
12	news.redatomik.org	11	0	1	10
13	newsfeeds.xmission.com	6	0	0	6
14	xanadu-bbs.net	3	0	0	3
15	news.bbs.geek.nz	2	0	0	2
TOTAL: 15		19435	722	120	18593

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ut.test	153
lada.talk	70
alt.windows7.general	68
it-alt.sport.calcio.juventus	68
alt.politics.scorched-earth	32
lada.auto	30
alt.survival	21
mpc.lists.freebsd.x11	13
gmane.linux.alsa.devel	12
lada.movies	12
eagle.userchat.eng	12
alt.binaries.kindle	10
gmane.comp.gis.openstreetmap.tagging	10
gmane.comp.gis.openstreetmap	10
lada.photo	10
lada.commerce	9
gmane.comp.gis.openstreetmap.josm.devel	8
lada.kitchen	7
mozilla.dev.l10n	7
mozilla.support.seamonkey	7
TOTAL: 103	722

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14771
EMP (phn path)	1812
EMP (phl)	696
EMP (phn nph)	325
Too many newsgroups	92
User-issued cancel	32
Binary Payload	20
Scoring filter (8)	8
Scoring filter (14)	7
Scoring filter (10)	6
Scoring filter (17)	4
Scoring filter (9)	4
Scoring filter (16)	4
HTML Multipart	3
Scoring filter (28)	3
HTML Image Tags	3
Scoring filter (12)	2
Scoring filter (13)	2
Binary Image: misplaced gif	1
Binary: misplaced gz	1
TOTAL: 23	17799

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	63
	TOTAL: 1	63
Huge articles
	feeder.eternal-september.org	86
	csiph-out.news.weretis.net	54
	news.freedyn.net	28
	news.fcku.it	28
	newsfeeds.xmission.com	4
	news-out.mixmin.net	3
	newsfeed.fu-berlin.de	3
	TOTAL: 7	206
Including strange strings
	newsfeed.fu-berlin.de	356
	csiph-out.feeder.erje.net	68
	news-out.aioe.org	28
	feeder.eternal-september.org	22
	csiph-out.news.weretis.net	12
	news.swapon.de	12
	newsfeed.neva.ru	7
	news.redatomik.org	5
	news-out.mixmin.net	5
	newsfeeds.xmission.com	2
	TOTAL: 12	519
No colon-space in header
	csiph-out.feeder.erje.net	4
	TOTAL: 1	4
TOTAL: 4		792

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	35565	5697	15125	68	0	16%	23:50:38
2	news.freedyn.net	22846	881	20598	19	0	3%	23:57:03
3	xanadu-bbs	24790	793	20776	2	23	3%	23:59:54
4	fu-berlin.de	20323	622	19701	0	0	3%	23:54:51
5	usenet.pasdenom.info	25241	257	19819	1435	11	1%	23:59:49
6	xmission	26238	133	20152	8	0	0%	23:59:52
7	news.redatomik.org	21697	51	20204	18	0	0%	23:50:04
8	aioe	19304	31	17545	13	0	0%	23:55:29
9	eternal-september	19410	22	17119	0	0	0%	23:59:50
10	weretis.net	17606	17	16821	4	0	0%	23:58:53
11	news.mixmin.net	20831	15	19241	0	0	0%	23:50:04
12	news.swapon.de	2305	11	2178	0	0	0%	23:53:40
13	neva.ru	21495	10	19549	21	1	0%	23:59:43
14	news.fcku.it	1983	3	1851	0	0	0%	22:51:06
15	erje	12402	1	12234	88	0	0%	23:50:04
16	au2pb	0	0	0	0	20911	0%	23:50:09
17	bwh	0	0	0	0	20906	0%	23:50:09
TOTAL: 17		292036	8544	242913	1676	41852	2%	405:31:18

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	14.7 MB	247.8 KB	15.0 MB	0.2 KB/s	2.7 KB	23:50:38
2	news.freedyn.net	5.4 MB	145.9 KB	5.6 MB	0.1 KB/s	6.4 KB	23:57:03
3	xanadu-bbs	5.3 MB	2.8 KB	5.3 MB	0.1 KB/s	6.8 KB	23:59:54
4	fu-berlin.de	4.9 MB	0.0 KB	4.9 MB	0.1 KB/s	8.1 KB	23:54:51
5	usenet.pasdenom.info	605.6 KB	6.2 MB	6.8 MB	0.1 KB/s	4.1 KB	23:59:49
6	xmission	293.3 KB	12.1 KB	305.4 KB	0.0 KB/s	2.2 KB	23:59:52
7	news.redatomik.org	140.0 KB	43.3 KB	183.3 KB	0.0 KB/s	2.7 KB	23:50:04
8	eternal-september	70.2 KB	0.0 KB	70.2 KB	0.0 KB/s	3.2 KB	23:59:50
9	aioe	56.2 KB	43.6 KB	99.8 KB	0.0 KB/s	2.3 KB	23:55:29
10	weretis.net	37.0 KB	6.9 KB	43.9 KB	0.0 KB/s	2.1 KB	23:58:53
11	news.mixmin.net	31.1 KB	0.0 KB	31.1 KB	0.0 KB/s	2.1 KB	23:50:04
12	news.swapon.de	14.2 KB	0.0 KB	14.2 KB	0.0 KB/s	1.3 KB	23:53:40
13	neva.ru	12.6 KB	45.1 KB	57.7 KB	0.0 KB/s	1.9 KB	23:59:43
14	news.fcku.it	5.0 KB	0.0 KB	5.0 KB	0.0 KB/s	1.7 KB	22:51:06
15	erje	0.9 KB	288.3 KB	289.2 KB	0.0 KB/s	3.2 KB	23:50:04
16	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:09
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:09
TOTAL: 17		31.6 MB	7.0 MB	38.6 MB	0.0 KB/s	3.9 KB	405:31:18

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	194-73-239-109.cust.centrio.cz	11	20	64.7 KB	6	0	0	03:36:35
2	dhcp-089-099-203-254.chello.nl	71	11	16.9 KB	7	0	0	21:17:39
3	68-185-181-64.dhcp.mdsn.wi.charter.com	20	11	16.9 KB	9	8	7	03:54:55
4	tempe0.bbox.io	10	2	2.7 KB	1	0	0	03:30:45
TOTAL: 4		112	44	101.3 KB	23	8	7	32:19:56

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cust.centrio.cz	11	20	64.7 KB	6	0	0	03:36:35
2	*.chello.nl	71	11	16.9 KB	7	0	0	21:17:39
3	*.dhcp.mdsn.wi.charter.com	20	11	16.9 KB	9	8	7	03:54:55
4	*.bbox.io	10	2	2.7 KB	1	0	0	03:30:45
TOTAL: 4		112	44	101.3 KB	23	8	7	32:19:56

NNRP auth users [Top 20]:

User	Conn
ctomczyk	7
ohlandl	7
TOTAL: 2	14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	5.884	1.278	0.000	21:17:39
68-185-181-64.dhcp.mdsn.wi.charter.com	2.024	0.373	0.025	03:54:55
194-73-239-109.cust.centrio.cz	0.981	0.281	0.028	03:36:35
tempe0.bbox.io	0.992	0.192	0.000	03:30:45
TOTAL: 4	9.881	2.124	0.053	32:19:56

NNRP client timeouts [Top 20]:

System	Conn	Peer
194-73-239-109.cust.centrio.cz	7	0
tempe0.bbox.io	7	0
68-185-181-64.dhcp.mdsn.wi.charter.com	4	0
TOTAL: 3	18	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	33	75.0%
2	pl	11	25.0%
TOTAL: 2		44	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	24
2	pl.comp.lang.javascript	10
3	comp.lang.javascript	9
4	pl.comp.www	1
TOTAL: 4		44

Daily Usenet report for csiph.com

Feb 19 04:15:00 -- Feb 20 04:15:00