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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18973	46.7%	4.8 MB	61.8%
innd	17842	43.9%	2.3 MB	29.9%
innfeed	3515	8.6%	621.2 KB	7.8%
nnrpd	302	0.7%	34.1 KB	0.4%
nocem	26	0.1%	3.0 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	40659	100.0%	7.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	305166	58.1%
Negative hits	201848	38.4%
Do not exist	18235	3.5%
Cache misses	240	0.0%
TOTAL: 4	525489	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.577	0.0%	35	0.000	16.486	34.900
article cleanup	00:00:00.093	0.0%	18071	0.000	0.005	0.025
article logging	00:00:00.232	0.0%	18688	0.000	0.012	0.093
article parse	00:00:00.666	0.0%	59184	0.000	0.011	0.034
article write	00:00:07.363	0.0%	14904	0.149	0.494	19.262
artlog/artcncl	00:00:00.000	0.0%	35	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	272	0.000	0.018	0.250
data move	00:00:00.158	0.0%	506350	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.010	0.0%	32	0.000	0.312	1.000
hishave/artcncl	00:00:00.004	0.0%	35	0.000	0.114	0.667
hishave/artparse	00:00:00.001	0.0%	269	0.000	0.004	0.033
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.890	0.0%	527336	0.001	0.009	0.435
history sync	00:00:00.760	0.0%	374	0.000	2.032	9.333
history write	00:00:09.765	0.0%	18055	0.058	0.541	10.836
hiswrite/artcncl	00:00:00.014	0.0%	3	4.667	4.667	4.667
hiswrite/artparse	00:00:00.117	0.0%	267	0.000	0.438	1.125
idle	23:59:16.830	99.9%	513509	94.420	168.170	556.273
nntp read	00:00:01.882	0.0%	514185	0.002	0.004	0.010
overview write	00:00:25.570	0.0%	14904	0.125	1.716	37.820
perl filter	00:00:23.837	0.0%	18052	0.982	1.320	2.229
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.224	0.0%	29833	0.000	0.008	0.032
TOTAL: 24:01:06.370	24:00:32.998	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.033	0.0%	15061	0.000	0.002	0.022
article prepare	00:00:00.001	0.0%	17908	0.000	0.000	0.007
article read	00:00:00.279	0.0%	1952	0.000	0.143	15.000
backlog stats	00:00:00.144	0.0%	348147	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.261	0.0%	272879	0.000	0.005	0.011
data write	00:00:01.508	0.0%	259709	0.000	0.006	0.012
idle	23:54:16.148	100.0%	348147	130.398	247.183	649.376
status file	00:00:00.187	0.0%	273	0.000	0.685	2.000
TOTAL: 23:54:26.743	23:54:19.561	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	12:34:26.086	100.0%	219	62.500	206694.457	600209.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.005	0.0%	459	0.000	0.011	0.167
readart	00:00:00.083	0.0%	11	0.000	7.545	42.000
TOTAL: 12:34:36.880	12:34:26.174	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	14057	3493	10531	33	24%	23:44:12
2	news-out.aioe.org	3	14850	3239	11395	216	21%	24:08:49
3	feeder.eternal-september.org	1	16954	1823	14642	489	10%	24:12:12
4	csiph-out.feeder.erje.net	1440	72433	1305	70879	249	1%	118:41:41
5	csiph-out.news.weretis.net	4	43787	1042	42503	242	2%	65:24:17
6	newsfeed.fu-berlin.de	5	17444	954	16364	126	5%	29:24:29
7	news-out.mixmin.net	2	16080	846	14733	501	5%	24:08:59
8	csiph-out.news.xs4all.nl	861	16917	771	15245	901	4%	71:24:28
9	newsfeed.neva.ru	150	15901	546	15026	329	3%	71:49:00
10	news.freedyn.net	0	15944	331	15460	153	2%	21:56:36
11	csiph-out.feed.uzoreto.com	864	23852	188	23442	222	0%	71:09:41
12	news.fcku.it	14	1304	153	1151	0	11%	21:47:36
13	news-out.neodome.net	2	15889	116	15755	18	0%	23:59:50
14	nntp.pasdenom.info	2	10019	88	9912	19	0%	23:58:13
15	csiph-out.news.tnetconsulting.net	1	16005	75	15910	20	0%	23:59:57
16	news.swapon.de	7	1542	18	1513	11	1%	23:25:55
17	news.samoylyk.net	1	14669	14	14651	4	0%	23:59:48
18	news.bbs.nz	2	15594	4	15590	0	0%	23:59:44
19	localhost	30	4	4	0	0	100%	00:00:01
20	xanadu-bbs.net	75	585	0	585	0	0%	77:07:44
TOTAL: 20		3467	343830	15010	325287	3533	4%	788:23:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.4 MB	3.0 KB	1.5 MB	11.9 MB	87%	3.5 KB
2	csiph-out.feeder.erje.net	8.4 MB	4.0 KB	490.2 KB	8.9 MB	94%	5.8 KB
3	news-out.aioe.org	8.0 MB	1.3 KB	444.4 KB	8.5 MB	94%	2.5 KB
4	feeder.eternal-september.org	4.9 MB	2.5 KB	2.5 MB	7.4 MB	65%	3.3 KB
5	csiph-out.news.weretis.net	3.2 MB	1.4 KB	2.6 MB	5.8 MB	54%	4.6 KB
6	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	338.2 KB	2.8 MB	88%	2.6 KB
7	news-out.mixmin.net	2.4 MB	1.3 KB	989.0 KB	3.4 MB	71%	2.6 KB
8	csiph-out.news.xs4all.nl	2.3 MB	1.4 KB	12.0 MB	14.3 MB	16%	8.8 KB
9	newsfeed.neva.ru	1.5 MB	4.0 KB	1.6 MB	3.1 MB	47%	3.7 KB
10	news.freedyn.net	968.5 KB	1.4 KB	990.6 KB	1.9 MB	49%	4.1 KB
11	csiph-out.feed.uzoreto.com	655.8 KB	1.3 KB	6.5 MB	7.2 MB	8%	17.9 KB
12	news-out.neodome.net	276.7 KB	1.4 KB	32.5 KB	310.6 KB	89%	2.3 KB
13	csiph-out.news.tnetconsulting.net	259.6 KB	0.0 KB	117.7 KB	377.3 KB	68%	4.0 KB
14	news.fcku.it	230.8 KB	0.0 KB	0.0 KB	230.8 KB	100%	1.5 KB
15	nntp.pasdenom.info	170.4 KB	0.0 KB	27.0 KB	197.4 KB	86%	1.8 KB
16	news.samoylyk.net	47.4 KB	1.4 KB	1.5 MB	1.6 MB	2%	90.3 KB
17	news.swapon.de	40.0 KB	2.4 KB	5.0 MB	5.1 MB	0%	178.9 KB
18	localhost	8.5 KB	0.0 KB	0.0 KB	8.5 KB	100%	2.1 KB
19	news.bbs.nz	8.4 KB	0.0 KB	0.0 KB	8.4 KB	100%	2.1 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		46.2 MB	26.9 KB	36.7 MB	82.9 MB	55%	4.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Feb 1 04:15:00 - 04:59:59	221	1.5%	0.08	973.9 KB	2.1%	0.36
Feb 1 05:00:00 - 05:59:59	262	1.8%	0.07	714.6 KB	1.5%	0.20
Feb 1 06:00:00 - 06:59:59	365	2.5%	0.10	1.5 MB	3.2%	0.42
Feb 1 07:00:00 - 07:59:59	441	3.0%	0.12	1.6 MB	3.6%	0.47
Feb 1 08:00:00 - 08:59:59	609	4.1%	0.17	2.4 MB	5.3%	0.69
Feb 1 09:00:00 - 09:59:59	685	4.6%	0.19	2.4 MB	5.3%	0.70
Feb 1 10:00:00 - 10:59:59	664	4.5%	0.18	1.9 MB	4.1%	0.54
Feb 1 11:00:00 - 11:59:59	667	4.5%	0.19	1.7 MB	3.6%	0.48
Feb 1 12:00:00 - 12:59:59	698	4.7%	0.19	1.9 MB	4.0%	0.53
Feb 1 13:00:00 - 13:59:59	653	4.4%	0.18	1.9 MB	4.1%	0.53
Feb 1 14:00:00 - 14:59:59	753	5.1%	0.21	2.1 MB	4.6%	0.60
Feb 1 15:00:00 - 15:59:59	751	5.0%	0.21	2.3 MB	5.1%	0.66
Feb 1 16:00:00 - 16:59:59	803	5.4%	0.22	2.1 MB	4.6%	0.61
Feb 1 17:00:00 - 17:59:59	902	6.1%	0.25	2.5 MB	5.5%	0.72
Feb 1 18:00:00 - 18:59:59	800	5.4%	0.22	2.2 MB	4.8%	0.63
Feb 1 19:00:00 - 19:59:59	978	6.6%	0.27	3.5 MB	7.7%	1.01
Feb 1 20:00:00 - 20:59:59	685	4.6%	0.19	1.8 MB	3.9%	0.50
Feb 1 21:00:00 - 21:59:59	674	4.5%	0.19	2.1 MB	4.5%	0.59
Feb 1 22:00:00 - 22:59:59	710	4.8%	0.20	1.9 MB	4.2%	0.55
Feb 1 23:00:00 - 23:59:59	614	4.1%	0.17	2.1 MB	4.5%	0.58
Feb 2 00:00:00 - 00:59:59	528	3.5%	0.15	1.6 MB	3.4%	0.44
Feb 2 01:00:00 - 01:59:59	438	2.9%	0.12	1.6 MB	3.5%	0.45
Feb 2 02:00:00 - 02:59:59	611	4.1%	0.17	1.9 MB	4.2%	0.54
Feb 2 03:00:00 - 03:59:59	309	2.1%	0.09	1022.5 KB	2.2%	0.28
Feb 2 04:00:00 - 04:15:00	71	0.5%	0.08	274.3 KB	0.6%	0.30
TOTAL: 24:00:00	14892	100.0%	0.17	46.0 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	898	42	1	855
2	newsfeed.fu-berlin.de	614	40	0	574
3	news-out.mixmin.net	498	7	1	490
4	feeder.eternal-september.org	464	29	2	433
5	newsfeed.neva.ru	338	74	3	261
6	news-out.aioe.org	293	81	1	211
7	csiph-out.feeder.erje.net	251	47	3	201
8	csiph-out.feed.uzoreto.com	223	6	1	216
9	csiph-out.news.weretis.net	201	87	1	113
10	news.freedyn.net	155	5	1	149
11	newsfeeds.xmission.com	36	5	2	29
12	csiph-out.news.tnetconsulting.net	22	22	0	0
13	nntp.pasdenom.info	19	0	0	19
14	news-out.neodome.net	17	0	1	16
15	news.swapon.de	12	0	1	11
16	news.samoylyk.net	4	0	1	3
17	news.fcku.it	1	0	0	1
TOTAL: 17		4046	445	19	3582

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	69
lada.talk	52
alt.bbs.synchronet	43
alt.windows7.general	38
spline.eisfair	25
it-alt.sport.calcio.juventus	15
alt.survival	13
alt.music.pink-floyd.publius	13
alt.politics.usa	12
mozilla.support.thunderbird	12
oesterreich.tratsch	11
mozilla.general	10
alt.binaries.pictures.purebeauty	8
lada.commerce	7
alt.tv.comedy-central.daily-show	6
mozilla.support.seamonkey	6
alt.politics	6
rocksolid.shared.i2p	4
alt.religion	4
lada.movies	4
TOTAL: 79	445

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2043
EMP (phn nph)	203
EMP (phn path)	197
EMP (phl)	107
0	60
Binary: misplaced binary	40
Too many newsgroups	24
HTML Multipart	13
Scoring filter	8
Binary Payload	6
Too many newsgroups (meow)	1
U2 violation - invalid distribution	1
HTML post	1
TOTAL: 13	2704

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	36
	TOTAL: 1	36
Huge articles
	csiph-out.news.xs4all.nl	119
	csiph-out.feed.uzoreto.com	62
	newsfeeds.xmission.com	28
	csiph-out.news.weretis.net	20
	feeder.eternal-september.org	11
	news.swapon.de	8
	news.freedyn.net	8
	news-out.mixmin.net	3
	news.samoylyk.net	2
	TOTAL: 9	261
Including strange strings
	newsfeed.fu-berlin.de	497
	news-out.aioe.org	80
	csiph-out.news.weretis.net	17
	news-out.mixmin.net	8
	news.freedyn.net	4
	feeder.eternal-september.org	2
	csiph-out.feed.uzoreto.com	2
	csiph-out.feeder.erje.net	2
	news.swapon.de	1
	news.fcku.it	1
	TOTAL: 11	615
No colon-space in header
	csiph-out.feeder.erje.net	2
	csiph-out.news.xs4all.nl	1
	TOTAL: 2	3
TOTAL: 4		915

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	18915	1576	13313	2	60	8%	23:59:55
2	news.samoylyk.net	15394	579	14297	2	0	3%	23:59:55
3	fu-berlin.de	13878	558	13320	0	0	4%	23:59:45
4	news.freedyn.net	13033	519	12176	23	1821	3%	23:59:55
5	news.bbs.nz	27810	382	13919	8	1	1%	23:59:20
6	usenet.pasdenom.info	14858	147	14042	37	17	0%	23:59:55
7	tnet	15336	134	14182	0	0	0%	23:59:55
8	aioe	10779	64	10335	0	0	0%	23:59:55
9	erje	14021	43	13451	30	0	0%	23:59:43
10	newsfeed.xs4all.nl	14427	42	13769	8	104	0%	23:59:20
11	neodome.net	15254	41	14650	0	0	0%	23:59:35
12	neva.ru	13710	18	13467	163	0	0%	23:59:23
13	news.uzoreto.com	14664	10	14291	72	0	0%	23:59:55
14	xmission	12635	6	10706	0	10	0%	23:59:55
15	news.mixmin.net	13727	6	13222	0	0	0%	23:59:52
16	eternal-september	12908	5	12375	0	0	0%	23:59:55
17	news.swapon.de	1855	5	1777	0	0	0%	23:57:46
18	weretis.net	13456	4	13256	0	0	0%	23:59:55
19	news.fcku.it	1019	0	1017	0	0	0%	20:50:41
TOTAL: 19		257679	4139	227565	345	2013	1%	452:44:35

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.8 MB	5.8 KB	8.8 MB	0.1 KB/s	5.7 KB	23:59:55
2	news.samoylyk.net	5.9 MB	2.0 KB	5.9 MB	0.1 KB/s	10.5 KB	23:59:55
3	fu-berlin.de	5.9 MB	0.0 KB	5.9 MB	0.1 KB/s	10.8 KB	23:59:45
4	news.freedyn.net	5.7 MB	36.3 KB	5.7 MB	0.1 KB/s	10.8 KB	23:59:55
5	news.bbs.nz	1.0 MB	18.3 KB	1.0 MB	0.0 KB/s	2.7 KB	23:59:20
6	usenet.pasdenom.info	575.7 KB	126.3 KB	701.9 KB	0.0 KB/s	3.8 KB	23:59:55
7	neodome.net	438.9 KB	0.0 KB	438.9 KB	0.0 KB/s	10.7 KB	23:59:35
8	tnet	382.9 KB	0.0 KB	382.9 KB	0.0 KB/s	2.9 KB	23:59:55
9	newsfeed.xs4all.nl	334.1 KB	75.6 KB	409.6 KB	0.0 KB/s	8.2 KB	23:59:20
10	aioe	238.8 KB	0.0 KB	238.8 KB	0.0 KB/s	3.7 KB	23:59:55
11	erje	97.6 KB	132.7 KB	230.2 KB	0.0 KB/s	3.2 KB	23:59:43
12	neva.ru	42.9 KB	463.6 KB	506.5 KB	0.0 KB/s	2.8 KB	23:59:23
13	news.uzoreto.com	19.5 KB	612.0 KB	631.5 KB	0.0 KB/s	7.7 KB	23:59:55
14	xmission	12.1 KB	0.0 KB	12.1 KB	0.0 KB/s	2.0 KB	23:59:55
15	eternal-september	11.6 KB	0.0 KB	11.6 KB	0.0 KB/s	2.3 KB	23:59:55
16	news.mixmin.net	11.2 KB	0.0 KB	11.2 KB	0.0 KB/s	1.9 KB	23:59:52
17	news.swapon.de	10.2 KB	0.0 KB	10.2 KB	0.0 KB/s	2.0 KB	23:57:46
18	weretis.net	8.5 KB	0.0 KB	8.5 KB	0.0 KB/s	2.1 KB	23:59:55
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	20:50:41
TOTAL: 19		29.4 MB	1.4 MB	30.9 MB	0.0 KB/s	7.0 KB	452:44:35

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	66-188-80-165.dhcp.mdsn.wi.charter.com	35	6	12.9 KB	6	5	4	10:30:35
2	a131033.upc-a.chello.nl	7	5	8.2 KB	2	0	0	01:43:44
TOTAL: 2		42	11	21.2 KB	8	5	4	12:34:36

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.mdsn.wi.charter.com	35	6	12.9 KB	6	5	4	10:30:35
2	*.upc-a.chello.nl	7	5	8.2 KB	2	0	0	01:43:44
3	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
4	unresolved	1	0	0.0 KB	0	0	0	00:00:09
5	*.nat.epc.tmcz.cz	1	0	0.0 KB	0	0	0	00:20:05
TOTAL: 5		45	11	21.2 KB	8	5	4	12:34:36

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
ctomczyk	1
TOTAL: 2	5

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
66-188-80-165.dhcp.mdsn.wi.charter.com	2.537	0.563	0.014	10:30:35
a131033.upc-a.chello.nl	0.533	0.072	0.000	01:43:44
37-48-35-2.nat.epc.tmcz.cz	0.070	0.008	0.003	00:20:05
162.243.130.88	0.074	0.000	0.000	00:00:09
scan-141.security.ipip.net	0.076	0.000	0.000	00:00:01
TOTAL: 5	3.290	0.643	0.017	12:34:36

Curious NNRP server explorers [Top 20]:

System	Conn
scan-141.security.ipip.net	1
37-48-35-2.nat.epc.tmcz.cz	1
162.243.130.88	1
TOTAL: 3	3

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
Host: 69.160.37.58:119	1
Connection: close	1
User-Agent: HTTP Banner Detection (https...	1
GET / HTTP/1.1	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
66-188-80-165.dhcp.mdsn.wi.charter.com	11	0
37-48-35-2.nat.epc.tmcz.cz	1	1
TOTAL: 2	12	1

Newsgroup request counts (by category):

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

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

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

Daily Usenet report for csiph.com

Feb 1 04:15:00 -- Feb 2 04:15:00