Daily Usenet report for csiph.com: Jan 26 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18127	46.5%	4.7 MB	61.9%
innd	16962	43.5%	2.2 MB	29.6%
innfeed	3531	9.1%	607.2 KB	7.9%
nnrpd	362	0.9%	40.6 KB	0.5%
nocem	24	0.1%	2.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	39007	100.0%	7.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	291199	57.6%
Negative hits	193301	38.2%
Do not exist	17601	3.5%
Cache misses	3472	0.7%
TOTAL: 4	505573	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.248	0.0%	22	0.000	11.273	23.000
article cleanup	00:00:00.099	0.0%	17200	0.000	0.006	0.040
article logging	00:00:00.278	0.0%	17675	0.000	0.016	0.292
article parse	00:00:00.919	0.0%	52272	0.000	0.018	0.152
article write	00:00:10.944	0.0%	14343	0.135	0.763	29.300
artlog/artcncl	00:00:00.001	0.0%	22	0.000	0.045	1.000
artlog/artparse	00:00:00.005	0.0%	455	0.000	0.011	0.053
data move	00:00:00.150	0.0%	466124	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.005	0.0%	20	0.000	0.250	1.000
hishave/artcncl	00:00:00.004	0.0%	22	0.000	0.182	1.000
hishave/artparse	00:00:00.002	0.0%	452	0.000	0.004	0.053
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:08.130	0.0%	506237	0.002	0.016	0.108
history sync	00:00:00.731	0.0%	351	0.000	2.083	10.500
history write	00:00:11.825	0.0%	17185	0.341	0.688	3.034
hiswrite/artcncl	00:00:00.001	0.0%	2	0.000	0.500	1.000
hiswrite/artparse	00:00:00.407	0.0%	452	0.000	0.900	14.500
idle	23:56:59.110	99.7%	473426	108.488	182.117	664.908
nntp read	00:00:01.773	0.0%	474356	0.001	0.004	0.008
overview write	00:02:15.125	0.2%	14343	0.088	9.421	2739.027
perl filter	00:00:22.719	0.0%	17181	0.922	1.322	2.220
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.225	0.0%	28710	0.000	0.008	0.028
TOTAL: 24:00:46.046	24:00:12.701	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	16168	0.000	0.002	0.022
article prepare	00:00:00.000	0.0%	7804	0.000	0.000	0.000
article read	00:00:00.184	0.0%	963	0.000	0.191	22.500
backlog stats	00:00:00.148	0.0%	300881	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.050	0.0%	232972	0.000	0.005	0.011
data write	00:00:01.295	0.0%	220430	0.001	0.006	0.013
idle	23:54:23.159	100.0%	300881	166.312	286.037	811.362
status file	00:00:00.286	0.0%	320	0.000	0.894	3.367
TOTAL: 23:54:31.987	23:54:26.154	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	16:18:11.800	100.0%	264	61.500	222317.424	600095.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.626	0.0%	95143	0.000	0.007	0.167
readart	00:00:00.086	0.0%	19	0.000	4.526	42.000
TOTAL: 16:18:31.913	16:18:12.512	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	2	13896	3767	10094	35	27%	24:22:14
2	news-out.aioe.org	4	14100	3129	10883	88	22%	24:09:44
3	feeder.eternal-september.org	2	15167	1586	13283	298	10%	21:35:14
4	csiph-out.feeder.erje.net	1440	71932	1035	70393	504	1%	118:46:14
5	csiph-out.news.xs4all.nl	861	16359	865	14591	903	5%	71:26:47
6	news-out.mixmin.net	2	15223	782	13979	462	5%	23:59:53
7	csiph-out.news.weretis.net	4	28848	758	27936	154	2%	47:59:12
8	newsfeed.fu-berlin.de	7	11737	666	10992	79	5%	19:59:48
9	newsfeed.neva.ru	147	15534	559	14682	293	3%	71:31:45
10	news.freedyn.net	2	16868	300	16436	132	1%	23:59:28
11	news-out.neodome.net	2	15726	165	15514	47	1%	23:59:49
12	csiph-out.news.tnetconsulting.net	1	12659	147	12502	10	1%	21:58:03
13	csiph-out.feed.uzoreto.com	864	23507	144	23188	175	0%	71:11:52
14	news.fcku.it	14	1645	125	1520	0	7%	22:36:07
15	nntp.pasdenom.info	2	9741	105	9587	49	1%	23:58:26
16	news.swapon.de	9	1492	22	1470	0	1%	23:56:04
17	news.bbs.nz	2	13525	3	13522	0	0%	23:59:50
18	news.samoylyk.net	2	8848	0	8848	0	0%	05:13:21
19	localhost	26	0	0	0	0	0%	00:00:03
TOTAL: 19		3393	306807	14158	289420	3229	4%	664:43:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.1 MB	1.8 KB	1.1 MB	12.2 MB	91%	3.3 KB
2	news-out.aioe.org	7.6 MB	2.2 KB	316.5 KB	7.9 MB	96%	2.5 KB
3	csiph-out.feeder.erje.net	6.9 MB	4.4 KB	10.6 MB	17.5 MB	39%	11.6 KB
4	feeder.eternal-september.org	4.2 MB	3.9 KB	3.1 MB	7.4 MB	57%	4.0 KB
5	csiph-out.news.xs4all.nl	2.6 MB	0.0 KB	7.7 MB	10.3 MB	24%	6.0 KB
6	csiph-out.news.weretis.net	2.5 MB	2.2 KB	936.9 KB	3.4 MB	72%	3.8 KB
7	news-out.mixmin.net	2.2 MB	2.2 KB	794.4 KB	3.0 MB	73%	2.5 KB
8	newsfeed.fu-berlin.de	1.5 MB	0.0 KB	221.1 KB	1.7 MB	87%	2.4 KB
9	newsfeed.neva.ru	1.5 MB	6.7 KB	874.2 KB	2.4 MB	63%	2.8 KB
10	news.freedyn.net	965.1 KB	4.0 KB	568.6 KB	1.5 MB	62%	3.6 KB
11	news-out.neodome.net	531.1 KB	2.3 KB	75.0 KB	608.4 KB	87%	2.9 KB
12	csiph-out.news.tnetconsulting.net	512.8 KB	0.0 KB	22.9 KB	535.7 KB	95%	3.4 KB
13	csiph-out.feed.uzoreto.com	512.8 KB	6.7 KB	2.5 MB	3.0 MB	16%	9.8 KB
14	news.fcku.it	212.2 KB	0.0 KB	0.0 KB	212.2 KB	100%	1.7 KB
15	nntp.pasdenom.info	199.9 KB	0.0 KB	72.7 KB	272.6 KB	73%	1.8 KB
16	news.swapon.de	51.9 KB	0.0 KB	0.0 KB	51.9 KB	100%	2.4 KB
17	news.bbs.nz	4.3 KB	0.0 KB	0.0 KB	4.3 KB	100%	1.4 KB
18	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
19	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		43.0 MB	36.4 KB	28.8 MB	71.8 MB	59%	4.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 26 04:15:00 - 04:59:59	172	1.2%	0.06	540.5 KB	1.2%	0.20
Jan 26 05:00:00 - 05:59:59	285	2.0%	0.08	1.1 MB	2.5%	0.31
Jan 26 06:00:00 - 06:59:59	300	2.1%	0.08	808.1 KB	1.8%	0.22
Jan 26 07:00:00 - 07:59:59	406	2.8%	0.11	1.9 MB	4.3%	0.53
Jan 26 08:00:00 - 08:59:59	471	3.3%	0.13	1.2 MB	2.9%	0.35
Jan 26 09:00:00 - 09:59:59	597	4.2%	0.17	1.7 MB	3.8%	0.47
Jan 26 10:00:00 - 10:59:59	670	4.7%	0.19	2.4 MB	5.6%	0.69
Jan 26 11:00:00 - 11:59:59	709	5.0%	0.20	2.1 MB	4.9%	0.60
Jan 26 12:00:00 - 12:59:59	733	5.1%	0.20	1.8 MB	4.0%	0.50
Jan 26 13:00:00 - 13:59:59	746	5.2%	0.21	1.7 MB	4.0%	0.50
Jan 26 14:00:00 - 14:59:59	760	5.3%	0.21	2.1 MB	4.7%	0.58
Jan 26 15:00:00 - 15:59:59	803	5.6%	0.22	2.6 MB	6.0%	0.74
Jan 26 16:00:00 - 16:59:59	780	5.4%	0.22	2.7 MB	6.2%	0.76
Jan 26 17:00:00 - 17:59:59	858	6.0%	0.24	2.3 MB	5.4%	0.66
Jan 26 18:00:00 - 18:59:59	783	5.5%	0.22	2.0 MB	4.6%	0.57
Jan 26 19:00:00 - 19:59:59	799	5.6%	0.22	2.9 MB	6.7%	0.83
Jan 26 20:00:00 - 20:59:59	848	5.9%	0.24	2.5 MB	5.7%	0.70
Jan 26 21:00:00 - 21:59:59	778	5.4%	0.22	2.1 MB	4.9%	0.60
Jan 26 22:00:00 - 22:59:59	729	5.1%	0.20	2.1 MB	4.8%	0.60
Jan 26 23:00:00 - 23:59:59	638	4.5%	0.18	2.2 MB	5.0%	0.62
Jan 27 00:00:00 - 00:59:59	436	3.0%	0.12	1.3 MB	3.0%	0.37
Jan 27 01:00:00 - 01:59:59	326	2.3%	0.09	934.3 KB	2.1%	0.26
Jan 27 02:00:00 - 02:59:59	340	2.4%	0.09	981.2 KB	2.2%	0.27
Jan 27 03:00:00 - 03:59:59	284	2.0%	0.08	1.3 MB	3.0%	0.36
Jan 27 04:00:00 - 04:15:00	72	0.5%	0.08	217.3 KB	0.5%	0.24
TOTAL: 24:00:00	14323	100.0%	0.17	43.3 MB	100.0%	0.51

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	908	53	0	855
2	csiph-out.feeder.erje.net	508	73	2	433
3	news-out.mixmin.net	472	2	1	469
4	newsfeed.fu-berlin.de	445	59	0	386
5	feeder.eternal-september.org	311	19	2	290
6	newsfeed.neva.ru	291	51	3	237
7	csiph-out.news.weretis.net	193	96	1	96
8	news-out.aioe.org	185	70	1	114
9	csiph-out.feed.uzoreto.com	175	6	2	167
10	news.freedyn.net	138	4	2	132
11	nntp.pasdenom.info	49	0	0	49
12	news-out.neodome.net	42	1	1	40
13	newsfeeds.xmission.com	37	16	1	20
14	csiph-out.news.tnetconsulting.net	25	21	2	2
15	news.swapon.de	3	0	0	3
TOTAL: 15		3782	471	18	3293

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	159
spline.eisfair	38
it-alt.sport.calcio.juventus	33
mozilla.support.thunderbird	29
lada.talk	29
alt.politics	19
alt.survival	13
alt.binaries.ebooks	11
oesterreich.tratsch	11
alt.binaries.pictures.purebeauty	10
mozilla.general	10
alt.bbs.synchronet	8
alt.politics.usa	6
alt.music.pink-floyd.publius	6
mozilla.support.firefox	5
lada.kitchen	5
alt.paranormal.spells	4
mozilla.support.seamonkey	4
alt.english.usage	4
mozilla.dev.l10n	4
TOTAL: 69	471

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1757
0	156
EMP (phn nph)	151
EMP (phn path)	134
EMP (phl)	110
Too many newsgroups	24
HTML Multipart	17
Scoring filter	10
U2 violation - invalid distribution	2
Too many newsgroups (meow)	1
Binary: misplaced binary	1
Too many newsgroups (low_xpost)	1
TOTAL: 12	2364

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
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
	csiph-out.feeder.erje.net	190
	csiph-out.news.xs4all.nl	143
	csiph-out.feed.uzoreto.com	55
	feeder.eternal-september.org	23
	newsfeeds.xmission.com	17
	csiph-out.news.weretis.net	10
	news.freedyn.net	10
	news-out.mixmin.net	3
	csiph-out.news.tnetconsulting.net	1
	newsfeed.fu-berlin.de	1
	TOTAL: 10	453
Including strange strings
	newsfeed.fu-berlin.de	343
	news-out.aioe.org	96
	news-out.mixmin.net	8
	csiph-out.news.weretis.net	8
	csiph-out.feeder.erje.net	5
	csiph-out.news.xs4all.nl	4
	news.swapon.de	3
	news.freedyn.net	3
	newsfeeds.xmission.com	2
	newsfeed.neva.ru	1
	TOTAL: 10	473
No colon-space in header
	csiph-out.news.xs4all.nl	3
	TOTAL: 1	3
TOTAL: 4		981

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	14318	439	13561	16	0	3%	23:59:55
2	fu-berlin.de	13391	437	12954	0	0	3%	23:59:56
3	news.bbs.nz	27009	336	13516	21	0	1%	23:59:46
4	tnet	14901	106	13732	4	1750	0%	23:52:05
5	erje	16743	62	13022	115	0	0%	23:59:56
6	usenet.pasdenom.info	14386	60	13655	56	27	0%	23:59:56
7	newsfeed.xs4all.nl	13727	54	13230	10	95	0%	23:59:50
8	aioe	10407	26	10068	0	0	0%	23:59:44
9	neodome.net	14418	19	13951	0	0	0%	23:49:57
10	neva.ru	13249	11	13025	143	0	0%	23:58:37
11	xmission	11734	8	10110	0	0	0%	23:59:56
12	news.mixmin.net	13339	4	12899	0	0	0%	23:59:56
13	news.uzoreto.com	14092	4	13781	28	0	0%	23:59:41
14	weretis.net	13202	1	13021	1	0	0%	23:59:56
15	news.fcku.it	1346	0	1342	0	0	0%	22:26:30
16	xanadu-bbs	0	0	0	0	14323	0%	23:58:43
17	eternal-september	12553	0	12080	0	0	0%	23:59:56
18	news.samoylyk.net	0	0	0	0	14323	0%	23:58:41
19	news.swapon.de	1551	0	1543	0	0	0%	23:31:36
TOTAL: 19		220366	1567	195490	394	30518	0%	453:34:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	4.9 MB	21.7 KB	4.9 MB	0.1 KB/s	11.0 KB	23:59:55
2	fu-berlin.de	4.9 MB	0.0 KB	4.9 MB	0.1 KB/s	11.4 KB	23:59:56
3	news.bbs.nz	855.9 KB	103.1 KB	959.0 KB	0.0 KB/s	2.7 KB	23:59:46
4	newsfeed.xs4all.nl	223.7 KB	37.4 KB	261.2 KB	0.0 KB/s	4.1 KB	23:59:50
5	tnet	223.7 KB	4.4 KB	228.0 KB	0.0 KB/s	2.1 KB	23:52:05
6	erje	173.4 KB	503.0 KB	676.4 KB	0.0 KB/s	3.8 KB	23:59:56
7	usenet.pasdenom.info	157.4 KB	88.8 KB	246.1 KB	0.0 KB/s	2.1 KB	23:59:56
8	neodome.net	117.5 KB	0.0 KB	117.5 KB	0.0 KB/s	6.2 KB	23:49:57
9	aioe	61.3 KB	0.0 KB	61.3 KB	0.0 KB/s	2.4 KB	23:59:44
10	news.uzoreto.com	39.8 KB	153.9 KB	193.7 KB	0.0 KB/s	6.1 KB	23:59:41
11	neva.ru	21.0 KB	270.2 KB	291.2 KB	0.0 KB/s	1.9 KB	23:58:37
12	xmission	19.5 KB	0.0 KB	19.5 KB	0.0 KB/s	2.4 KB	23:59:56
13	news.mixmin.net	7.1 KB	0.0 KB	7.1 KB	0.0 KB/s	1.8 KB	23:59:56
14	weretis.net	1.5 KB	1.2 KB	2.7 KB	0.0 KB/s	1.3 KB	23:59:56
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:26:30
16	xanadu-bbs	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:43
17	eternal-september	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
18	news.samoylyk.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:41
19	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:31:36
TOTAL: 19		11.6 MB	1.2 MB	12.8 MB	0.0 KB/s	6.7 KB	453:34:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	69.160.37.57	1	8	11.2 KB	2	00:01:08
2	a131033.upc-a.chello.nl	37	8	12.0 KB	2	11:53:36
3	71-90-73-253.dhcp.ftbg.wi.charter.com	11	2	2.9 KB	2	03:01:40
4	208-71-239-109.cust.centrio.cz	3	1	2.2 KB	1	00:21:57
TOTAL: 4		52	19	28.3 KB	7	16:18:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	3	8	11.2 KB	2	00:01:10
2	*.upc-a.chello.nl	37	8	12.0 KB	2	11:53:36
3	*.dhcp.ftbg.wi.charter.com	11	2	2.9 KB	2	03:01:40
4	*.cust.centrio.cz	3	1	2.2 KB	1	00:21:57
5	*.security.ipip.net	1	0	0.0 KB	0	00:00:01
6	*.ph.ph.cox.net	2	0	0.0 KB	0	01:00:05
TOTAL: 6		57	19	28.3 KB	7	16:18:31

NNRP auth users [Top 20]:

User	Conn
ctomczyk	3
TOTAL: 1	3

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.411	0.520	0.000	11:53:36
71-90-73-253.dhcp.ftbg.wi.charter.com	0.828	0.157	0.000	03:01:40
ip72-222-200-117.ph.ph.cox.net	0.200	0.042	0.000	01:00:05
208-71-239-109.cust.centrio.cz	0.283	0.033	0.008	00:21:57
69.160.37.57	0.418	0.859	0.000	00:01:08
94.161.185.51	0.116	0.038	0.000	00:00:02
scan-141.security.ipip.net	0.062	0.016	0.000	00:00:01
TOTAL: 7	4.318	1.665	0.008	16:18:31

Curious NNRP server explorers [Top 20]:

System	Conn
94.161.185.51	2
ip72-222-200-117.ph.ph.cox.net	2
scan-141.security.ipip.net	1
TOTAL: 3	5

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-90-73-253.dhcp.ftbg.wi.charter.com	4	0
ip72-222-200-117.ph.ph.cox.net	2	0
TOTAL: 2	6	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	17
2	comp.unix.aix	1
3	comp.lang.javascript	1
TOTAL: 3		19

Daily Usenet report for csiph.com

Jan 26 04:15:00 -- Jan 27 04:15:00