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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	19746	47.9%	5.1 MB	63.3%
innd	17281	41.9%	2.3 MB	28.2%
innfeed	3582	8.7%	634.0 KB	7.7%
nnrpd	560	1.4%	63.1 KB	0.8%
nocem	29	0.1%	3.4 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	41199	100.0%	8.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	309323	57.5%
Negative hits	209384	38.9%
Do not exist	19163	3.6%
Cache misses	196	0.0%
TOTAL: 4	538066	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.126	0.0%	9	0.000	14.000	20.600
article cleanup	00:00:00.088	0.0%	18729	0.000	0.005	0.065
article logging	00:00:00.266	0.0%	19229	0.000	0.014	0.049
article parse	00:00:00.834	0.0%	59634	0.000	0.014	0.043
article write	00:00:06.941	0.0%	15719	0.130	0.442	7.900
artlog/artcncl	00:00:00.000	0.0%	9	0.000	0.000	0.000
artlog/artparse	00:00:00.006	0.0%	505	0.000	0.012	0.091
data move	00:00:00.189	0.0%	504578	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.001	0.0%	9	0.000	0.111	0.200
hishave/artcncl	00:00:00.003	0.0%	9	0.000	0.333	1.000
hishave/artparse	00:00:00.000	0.0%	499	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:04.029	0.0%	539498	0.001	0.007	0.253
history sync	00:00:00.762	0.0%	388	0.000	1.964	8.000
history write	00:00:09.262	0.0%	18734	0.026	0.494	4.290
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.261	0.0%	498	0.000	0.524	6.000
idle	23:59:19.721	99.9%	514123	93.146	167.975	675.445
nntp read	00:00:01.979	0.0%	513562	0.002	0.004	0.006
overview write	00:00:23.455	0.0%	15719	0.102	1.492	44.688
perl filter	00:00:24.415	0.0%	18728	1.020	1.304	2.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.214	0.0%	31467	0.000	0.007	0.029
TOTAL: 24:01:07.281	24:00:32.552	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.037	0.0%	16251	0.000	0.002	0.044
article prepare	00:00:00.003	0.0%	18588	0.000	0.000	0.013
article read	00:00:00.328	0.0%	1894	0.000	0.173	19.500
backlog stats	00:00:00.192	0.0%	355709	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.218	0.0%	278066	0.001	0.004	0.010
data write	00:00:01.543	0.0%	262564	0.000	0.006	0.013
idle	23:54:13.495	100.0%	355709	140.360	241.921	798.860
status file	00:00:00.225	0.0%	298	0.000	0.755	2.000
TOTAL: 23:54:24.088	23:54:17.041	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	20:17:47.535	100.0%	440	335.000	166062.580	600176.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.004	0.0%	1026	0.000	0.004	0.167
readart	00:00:00.320	0.0%	59	0.000	5.424	42.000
TOTAL: 20:18:00.601	20:17:47.859	100.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
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	newsfeeds.xmission.com	3	15091	3908	11152	31	25%	24:04:24
2	news-out.aioe.org	3	15387	3353	11933	101	21%	24:08:45
3	feeder.eternal-september.org	5	17482	2374	14766	342	13%	24:45:02
4	csiph-out.feeder.erje.net	1440	79454	1114	77798	542	1%	118:39:14
5	csiph-out.news.weretis.net	2	31187	1078	29916	193	3%	45:24:05
6	csiph-out.news.xs4all.nl	860	17451	971	15345	1135	5%	71:30:48
7	newsfeed.fu-berlin.de	9	17728	954	16610	164	5%	30:07:35
8	newsfeed.neva.ru	142	17112	876	15849	387	5%	71:48:39
9	news.freedyn.net	1	18452	510	17748	194	2%	23:59:56
10	news.fcku.it	11	2398	194	2198	6	8%	22:11:39
11	csiph-out.feed.uzoreto.com	864	24195	140	23730	325	0%	71:13:17
12	csiph-out.news.tnetconsulting.net	1	15342	137	15174	31	0%	23:59:58
13	nntp.pasdenom.info	2	11044	108	10916	20	0%	23:58:29
14	news-out.neodome.net	1	16531	75	16386	70	0%	23:59:55
15	news.swapon.de	8	1307	25	1281	1	1%	22:38:19
16	localhost	36	10	10	0	0	100%	00:00:04
17	news.samoylyk.net	1	15370	5	15362	3	0%	23:43:53
18	xanadu-bbs.net	33	342	0	342	0	0%	19:42:12
19	news.bbs.nz	1	14997	0	14997	0	0%	23:59:53
TOTAL: 19		3423	330880	15832	311503	3545	4%	689:56:07

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.0 MB	0.0 KB	1.5 MB	12.4 MB	88%	3.2 KB
2	news-out.aioe.org	7.9 MB	0.0 KB	309.7 KB	8.2 MB	96%	2.4 KB
3	csiph-out.feeder.erje.net	6.8 MB	0.0 KB	12.3 MB	19.1 MB	35%	11.8 KB
4	feeder.eternal-september.org	6.1 MB	0.0 KB	2.6 MB	8.7 MB	70%	3.3 KB
5	csiph-out.news.weretis.net	3.2 MB	2.7 KB	2.3 MB	5.5 MB	58%	4.4 KB
6	csiph-out.news.xs4all.nl	3.0 MB	0.0 KB	11.4 MB	14.3 MB	20%	7.0 KB
7	newsfeed.fu-berlin.de	2.3 MB	0.0 KB	414.4 KB	2.7 MB	84%	2.4 KB
8	newsfeed.neva.ru	2.1 MB	0.0 KB	1.0 MB	3.1 MB	66%	2.5 KB
9	news.freedyn.net	1.8 MB	0.0 KB	1.7 MB	3.5 MB	52%	5.1 KB
10	csiph-out.feed.uzoreto.com	638.0 KB	0.0 KB	7.2 MB	7.8 MB	7%	17.2 KB
11	csiph-out.news.tnetconsulting.net	411.4 KB	0.0 KB	244.5 KB	655.9 KB	62%	3.9 KB
12	news.fcku.it	317.1 KB	0.0 KB	75.1 KB	392.2 KB	80%	2.0 KB
13	news-out.neodome.net	296.7 KB	0.0 KB	1.8 MB	2.1 MB	13%	15.0 KB
14	nntp.pasdenom.info	230.5 KB	0.0 KB	28.7 KB	259.1 KB	88%	2.0 KB
15	news.swapon.de	56.4 KB	0.0 KB	362.8 KB	419.2 KB	13%	16.1 KB
16	news.samoylyk.net	18.7 KB	0.0 KB	160.8 KB	179.5 KB	10%	22.4 KB
17	localhost	11.5 KB	0.0 KB	0.0 KB	11.5 KB	100%	1.1 KB
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
19	news.bbs.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		46.0 MB	2.7 KB	43.2 MB	89.2 MB	51%	4.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 21 04:15:00 - 04:59:59	154	1.0%	0.06	528.6 KB	1.1%	0.20
Feb 21 05:00:00 - 05:59:59	307	2.0%	0.09	1.2 MB	2.5%	0.33
Feb 21 06:00:00 - 06:59:59	409	2.6%	0.11	1.3 MB	2.8%	0.37
Feb 21 07:00:00 - 07:59:59	599	3.8%	0.17	2.0 MB	4.5%	0.58
Feb 21 08:00:00 - 08:59:59	710	4.5%	0.20	1.9 MB	4.2%	0.55
Feb 21 09:00:00 - 09:59:59	732	4.7%	0.20	1.8 MB	3.9%	0.51
Feb 21 10:00:00 - 10:59:59	810	5.2%	0.23	2.1 MB	4.5%	0.59
Feb 21 11:00:00 - 11:59:59	743	4.7%	0.21	2.1 MB	4.7%	0.60
Feb 21 12:00:00 - 12:59:59	855	5.4%	0.24	2.3 MB	5.0%	0.65
Feb 21 13:00:00 - 13:59:59	837	5.3%	0.23	2.1 MB	4.7%	0.61
Feb 21 14:00:00 - 14:59:59	834	5.3%	0.23	2.3 MB	5.0%	0.65
Feb 21 15:00:00 - 15:59:59	993	6.3%	0.28	3.2 MB	7.1%	0.92
Feb 21 16:00:00 - 16:59:59	963	6.1%	0.27	2.6 MB	5.7%	0.74
Feb 21 17:00:00 - 17:59:59	837	5.3%	0.23	2.1 MB	4.5%	0.58
Feb 21 18:00:00 - 18:59:59	849	5.4%	0.24	2.1 MB	4.5%	0.58
Feb 21 19:00:00 - 19:59:59	819	5.2%	0.23	2.6 MB	5.8%	0.75
Feb 21 20:00:00 - 20:59:59	835	5.3%	0.23	2.3 MB	5.0%	0.65
Feb 21 21:00:00 - 21:59:59	761	4.8%	0.21	2.0 MB	4.4%	0.57
Feb 21 22:00:00 - 22:59:59	588	3.7%	0.16	1.7 MB	3.8%	0.49
Feb 21 23:00:00 - 23:59:59	528	3.4%	0.15	1.9 MB	4.1%	0.53
Feb 22 00:00:00 - 00:59:59	498	3.2%	0.14	1.8 MB	3.9%	0.51
Feb 22 01:00:00 - 01:59:59	412	2.6%	0.11	1.4 MB	3.0%	0.39
Feb 22 02:00:00 - 02:59:59	289	1.8%	0.08	1.0 MB	2.2%	0.29
Feb 22 03:00:00 - 03:59:59	307	2.0%	0.09	1.3 MB	2.8%	0.36
Feb 22 04:00:00 - 04:15:00	49	0.3%	0.05	125.5 KB	0.3%	0.14
TOTAL: 24:00:00	15718	100.0%	0.18	45.6 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1141	52	0	1089
2	csiph-out.feeder.erje.net	546	61	0	485
3	newsfeed.fu-berlin.de	491	49	0	442
4	newsfeed.neva.ru	387	55	0	332
5	feeder.eternal-september.org	348	25	0	323
6	csiph-out.feed.uzoreto.com	326	10	0	316
7	csiph-out.news.weretis.net	245	102	1	142
8	news-out.aioe.org	196	96	0	100
9	news.freedyn.net	175	2	0	173
10	news-out.neodome.net	69	0	0	69
11	newsfeeds.xmission.com	40	8	0	32
12	csiph-out.news.tnetconsulting.net	25	22	0	3
13	nntp.pasdenom.info	20	0	0	20
14	news.fcku.it	6	2	0	4
15	news.samoylyk.net	3	0	0	3
16	news.swapon.de	1	0	0	1
TOTAL: 16		4019	484	1	3534

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	111
alt.bbs.synchronet	49
lada.talk	45
spline.eisfair	24
alt.politics.usa	19
alt.windows7.general	17
mozilla.support.seamonkey	14
alt.survival	13
mozilla.general	12
mozilla.support.thunderbird	12
alt.binaries.pictures.purebeauty	10
oesterreich.tratsch	9
mozilla.accessibility	9
alt.politics	8
alt.philosophy	8
it-alt.sport.calcio.juventus	7
lada.auto	7
alt.binaries.ebooks	6
spline.eisfair.dev	6
ba.forsale	6
TOTAL: 75	484

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1847
EMP (phn path)	276
EMP (phl)	221
0	91
Binary Payload	20
Scoring filter	19
HTML Multipart	18
Too many newsgroups	15
EMP (phn nph)	11
Too many newsgroups (meow)	6
Too many newsgroups (low_xpost)	3
HTML post	1
TOTAL: 12	2528

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	55
	csiph-out.news.xs4all.nl	3
	csiph-out.feed.uzoreto.com	3
	TOTAL: 3	61
Huge articles
	csiph-out.feeder.erje.net	213
	csiph-out.news.xs4all.nl	110
	csiph-out.feed.uzoreto.com	63
	news-out.neodome.net	33
	csiph-out.news.weretis.net	27
	newsfeeds.xmission.com	23
	news.freedyn.net	14
	feeder.eternal-september.org	9
	csiph-out.news.tnetconsulting.net	3
	news.samoylyk.net	3
	TOTAL: 12	500
Including strange strings
	newsfeed.fu-berlin.de	363
	news-out.aioe.org	90
	csiph-out.news.weretis.net	24
	newsfeeds.xmission.com	9
	csiph-out.news.xs4all.nl	6
	news.freedyn.net	3
	csiph-out.feeder.erje.net	3
	feeder.eternal-september.org	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 9	500
No colon-space in header
	csiph-out.news.xs4all.nl	3
	csiph-out.feeder.erje.net	2
	csiph-out.feed.uzoreto.com	1
	TOTAL: 3	6
TOTAL: 4		1067

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19141	1557	14151	10	460	8%	23:59:55
2	news.samoylyk.net	16273	511	15197	5	0	3%	23:59:55
3	news.bbs.nz	29615	478	14706	21	0	1%	23:59:44
4	news.freedyn.net	15428	475	14522	59	0	3%	23:59:55
5	fu-berlin.de	14745	472	14273	0	0	3%	23:59:55
6	tnet	16811	221	14991	0	0	1%	23:59:55
7	usenet.pasdenom.info	15717	162	14899	39	12	1%	23:59:55
8	newsfeed.xs4all.nl	15183	60	14533	10	80	0%	23:59:54
9	aioe	11502	48	11046	2	0	0%	23:59:45
10	neva.ru	14289	23	13972	161	0	0%	23:59:35
11	xmission	13380	23	11314	1	0	0%	23:59:55
12	neodome.net	16116	17	15563	0	0	0%	23:59:53
13	news.uzoreto.com	15435	14	15046	16	0	0%	23:59:35
14	weretis.net	14265	13	14071	0	0	0%	23:59:44
15	news.swapon.de	1381	10	1352	0	0	0%	23:14:25
16	eternal-september	13224	10	12685	0	0	0%	23:59:55
17	erje	14553	7	14245	221	0	0%	23:59:55
18	news.mixmin.net	0	0	0	0	15207	0%	23:59:55
19	news.fcku.it	2019	0	2013	0	0	0%	21:44:47
TOTAL: 19		259077	4101	228579	545	15759	1%	452:56:32

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.7 MB	44.0 KB	7.8 MB	0.1 KB/s	5.1 KB	23:59:55
2	news.freedyn.net	5.0 MB	109.9 KB	5.2 MB	0.1 KB/s	9.9 KB	23:59:55
3	news.samoylyk.net	5.0 MB	30.9 KB	5.1 MB	0.1 KB/s	10.0 KB	23:59:55
4	fu-berlin.de	5.0 MB	0.0 KB	5.0 MB	0.1 KB/s	10.8 KB	23:59:55
5	news.bbs.nz	1.3 MB	114.4 KB	1.4 MB	0.0 KB/s	2.9 KB	23:59:44
6	tnet	577.1 KB	0.0 KB	577.1 KB	0.0 KB/s	2.6 KB	23:59:55
7	usenet.pasdenom.info	461.8 KB	95.7 KB	557.6 KB	0.0 KB/s	2.8 KB	23:59:55
8	newsfeed.xs4all.nl	172.6 KB	35.8 KB	208.4 KB	0.0 KB/s	3.0 KB	23:59:54
9	aioe	112.7 KB	2.6 KB	115.3 KB	0.0 KB/s	2.3 KB	23:59:45
10	xmission	53.7 KB	1.3 KB	55.0 KB	0.0 KB/s	2.3 KB	23:59:55
11	neva.ru	37.1 KB	367.5 KB	404.5 KB	0.0 KB/s	2.2 KB	23:59:35
12	news.uzoreto.com	22.8 KB	33.9 KB	56.7 KB	0.0 KB/s	1.9 KB	23:59:35
13	neodome.net	22.7 KB	0.0 KB	22.7 KB	0.0 KB/s	1.3 KB	23:59:53
14	weretis.net	20.6 KB	0.0 KB	20.6 KB	0.0 KB/s	1.6 KB	23:59:44
15	news.swapon.de	11.5 KB	0.0 KB	11.5 KB	0.0 KB/s	1.1 KB	23:14:25
16	eternal-september	11.5 KB	0.0 KB	11.5 KB	0.0 KB/s	1.1 KB	23:59:55
17	erje	8.0 KB	653.9 KB	661.9 KB	0.0 KB/s	2.9 KB	23:59:55
18	news.mixmin.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:44:47
TOTAL: 19		25.5 MB	1.5 MB	27.0 MB	0.0 KB/s	5.9 KB	452:56:32

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	38	31	45.1 KB	6	0	0	10:16:58
2	68-190-164-53.dhcp.eucl.wi.charter.com	42	28	40.5 KB	13	11	9	10:00:55
TOTAL: 2		80	59	85.6 KB	19	11	9	20:18:00

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	38	31	45.1 KB	6	0	0	10:16:58
2	*.dhcp.eucl.wi.charter.com	42	28	40.5 KB	13	11	9	10:00:55
3	unresolved	5	0	0.0 KB	0	0	0	00:00:06
TOTAL: 3		85	59	85.6 KB	19	11	9	20:18:00

NNRP auth users [Top 20]:

User	Conn
ohlandl	9
TOTAL: 1	9

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.733	0.473	0.000	10:16:58
68-190-164-53.dhcp.eucl.wi.charter.com	3.306	0.738	0.053	10:00:55
94.165.93.102	0.270	0.033	0.000	00:00:04
5.87.159.20	0.062	0.016	0.000	00:00:01
TOTAL: 4	6.371	1.260	0.053	20:18:00

Curious NNRP server explorers [Top 20]:

System	Conn
94.165.93.102	4
5.87.159.20	1
TOTAL: 2	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-190-164-53.dhcp.eucl.wi.charter.com	9	0
TOTAL: 1	9	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	47
TOTAL: 1		47

Daily Usenet report for csiph.com

Feb 21 04:15:00 -- Feb 22 04:15:00