Daily Usenet report for csiph.com: Nov 20 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	37634	56.0%	7.8 MB	69.5%
innd	14558	21.7%	1.7 MB	15.4%
nnrpd	11713	17.4%	1.1 MB	10.2%
innfeed	3256	4.8%	548.9 KB	4.8%
nocem	71	0.1%	7.6 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	67233	100.0%	11.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	368709	54.1%
Negative hits	275228	40.4%
Do not exist	36536	5.4%
Cache misses	505	0.1%
TOTAL: 4	680978	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.176	0.0%	233	0.000	9.339	127.500
article cleanup	00:00:00.240	0.0%	36364	0.000	0.007	0.041
article logging	00:00:00.652	0.0%	37058	0.000	0.018	0.044
article parse	00:00:01.580	0.0%	97266	0.000	0.016	0.065
article write	00:09:44.567	0.7%	27193	0.260	21.497	107.571
artlog/artcncl	00:00:00.005	0.0%	207	0.000	0.024	0.333
artlog/artparse	00:00:00.006	0.0%	367	0.000	0.016	0.500
data move	00:00:00.205	0.0%	654422	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.019	0.0%	223	0.000	0.085	1.000
hishave/artcncl	00:00:00.003	0.0%	233	0.000	0.013	0.214
hishave/artparse	00:00:00.001	0.0%	366	0.000	0.003	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.108	0.0%	684391	0.004	0.009	0.017
history sync	00:00:01.466	0.0%	332	0.000	4.416	12.000
history write	00:00:44.560	0.1%	36338	0.244	1.226	23.723
hiswrite/artcncl	00:00:00.005	0.0%	10	0.000	0.500	1.000
hiswrite/artparse	00:00:00.378	0.0%	366	0.000	1.033	14.000
idle	23:44:37.044	98.9%	648969	45.719	131.712	404.747
nntp read	00:00:03.185	0.0%	666242	0.002	0.005	0.009
overview write	00:03:18.950	0.2%	27193	0.319	7.316	526.456
perl filter	00:01:03.455	0.1%	36319	1.191	1.747	2.894
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.471	0.0%	54450	0.000	0.009	0.028
TOTAL: 24:00:39.765	23:59:45.076	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.079	0.0%	27140	0.000	0.003	0.024
article prepare	00:00:00.014	0.0%	104414	0.000	0.000	0.011
article read	00:00:30.097	0.0%	8017	0.000	3.754	57.000
backlog stats	00:00:00.266	0.0%	481154	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.467	0.0%	360320	0.002	0.007	0.012
data write	00:00:02.270	0.0%	338635	0.000	0.007	0.011
idle	23:53:07.823	99.9%	481154	26.994	178.712	514.967
status file	00:00:01.154	0.0%	293	0.000	3.939	244.000
TOTAL: 23:53:59.444	23:53:44.170	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	16:26:13.697	99.7%	25777	73.192	2295.601	600142.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.463	0.0%	52635	0.000	0.009	0.465
readart	00:01:13.495	0.1%	10832	0.000	6.785	261.000
TOTAL: 16:29:06.818	16:27:27.655	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	118788	10549	104909	3330	8%	94:57:29
2	csiph-out.news.weretis.net	6	43635	4650	38349	636	10%	46:04:00
3	newsfeeds.xmission.com	2	22039	2543	19488	8	11%	26:13:35
4	news-out.aioe.org	5	22368	2113	20156	99	9%	24:12:05
5	feeder.eternal-september.org	4	25386	2057	22510	819	8%	22:43:32
6	newsfeed.neva.ru	144	28112	1326	23604	3182	4%	71:35:29
7	newsfeed.fu-berlin.de	21	21319	1100	19938	281	5%	24:46:37
8	news.redatomik.org	2	19314	1016	18286	12	5%	21:41:17
9	news.fcku.it	1	10467	967	9256	244	9%	28:09:47
10	news-out.mixmin.net	1	24099	826	22214	1059	3%	23:59:52
11	news.swapon.de	4	1878	67	1809	2	3%	24:40:11
12	nntp.pasdenom.info	3	20789	56	20728	5	0%	24:08:24
13	news.bbs.geek.nz	1	7576	13	7563	0	0%	12:16:40
14	news.freedyn.net	1	13396	6	13386	4	0%	14:26:11
15	xanadu-bbs.net	19	650	2	642	6	0%	23:27:39
16	localhost	34	0	0	0	0	0%	00:00:06
TOTAL: 16		1400	379816	27291	342838	9687	7%	483:22:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	29.1 MB	60.8 KB	16.3 MB	45.5 MB	64%	3.4 KB
2	csiph-out.news.weretis.net	13.3 MB	9.3 KB	14.7 MB	28.0 MB	47%	5.4 KB
3	newsfeeds.xmission.com	7.1 MB	1.7 KB	279.2 KB	7.3 MB	96%	2.9 KB
4	feeder.eternal-september.org	5.0 MB	4.2 KB	4.6 MB	9.5 MB	52%	3.4 KB
5	news-out.aioe.org	4.7 MB	0.0 KB	170.1 KB	4.8 MB	96%	2.2 KB
6	newsfeed.neva.ru	3.4 MB	179.5 KB	24.3 MB	27.9 MB	12%	6.3 KB
7	news-out.mixmin.net	3.3 MB	2.2 KB	3.1 MB	6.4 MB	50%	3.5 KB
8	news.fcku.it	2.6 MB	2.0 KB	2.9 MB	5.6 MB	47%	4.7 KB
9	news.redatomik.org	2.6 MB	0.0 KB	604.5 KB	3.2 MB	81%	3.2 KB
10	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	648.3 KB	3.0 MB	79%	2.3 KB
11	news.swapon.de	158.0 KB	0.0 KB	27.2 KB	185.2 KB	85%	2.7 KB
12	nntp.pasdenom.info	127.7 KB	0.0 KB	6.0 KB	133.7 KB	95%	2.2 KB
13	news.bbs.geek.nz	53.6 KB	0.0 KB	0.0 KB	53.6 KB	100%	4.1 KB
14	news.freedyn.net	17.5 KB	1.7 KB	203.0 KB	222.3 KB	7%	22.2 KB
15	xanadu-bbs.net	3.4 KB	0.0 KB	20.4 KB	23.8 KB	14%	3.0 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		73.8 MB	261.5 KB	67.9 MB	141.9 MB	51%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 20 04:15:00 - 04:59:59	377	1.4%	0.14	1.1 MB	1.5%	0.41
Nov 20 05:00:00 - 05:59:59	504	1.9%	0.14	2.2 MB	3.0%	0.62
Nov 20 06:00:00 - 06:59:59	609	2.2%	0.17	2.7 MB	3.6%	0.76
Nov 20 07:00:00 - 07:59:59	612	2.3%	0.17	1.9 MB	2.6%	0.54
Nov 20 08:00:00 - 08:59:59	690	2.5%	0.19	1.7 MB	2.3%	0.48
Nov 20 09:00:00 - 09:59:59	944	3.5%	0.26	2.5 MB	3.5%	0.72
Nov 20 10:00:00 - 10:59:59	965	3.6%	0.27	2.2 MB	3.0%	0.63
Nov 20 11:00:00 - 11:59:59	935	3.4%	0.26	2.4 MB	3.3%	0.69
Nov 20 12:00:00 - 12:59:59	880	3.2%	0.24	2.2 MB	3.0%	0.63
Nov 20 13:00:00 - 13:59:59	6084	22.4%	1.69	9.6 MB	13.0%	2.72
Nov 20 14:00:00 - 14:59:59	1249	4.6%	0.35	3.5 MB	4.7%	0.98
Nov 20 15:00:00 - 15:59:59	1343	4.9%	0.37	4.1 MB	5.6%	1.17
Nov 20 16:00:00 - 16:59:59	1286	4.7%	0.36	3.9 MB	5.2%	1.10
Nov 20 17:00:00 - 17:59:59	1514	5.6%	0.42	5.0 MB	6.8%	1.43
Nov 20 18:00:00 - 18:59:59	1362	5.0%	0.38	4.0 MB	5.4%	1.14
Nov 20 19:00:00 - 19:59:59	1542	5.7%	0.43	5.1 MB	7.0%	1.46
Nov 20 20:00:00 - 20:59:59	1123	4.1%	0.31	3.1 MB	4.2%	0.88
Nov 20 21:00:00 - 21:59:59	1154	4.2%	0.32	3.8 MB	5.2%	1.08
Nov 20 22:00:00 - 22:59:59	1017	3.7%	0.28	3.1 MB	4.2%	0.87
Nov 20 23:00:00 - 23:59:59	852	3.1%	0.24	2.7 MB	3.6%	0.76
Nov 21 00:00:00 - 00:59:59	573	2.1%	0.16	1.7 MB	2.3%	0.49
Nov 21 01:00:00 - 01:59:59	514	1.9%	0.14	1.6 MB	2.2%	0.45
Nov 21 02:00:00 - 02:59:59	478	1.8%	0.13	1.3 MB	1.8%	0.38
Nov 21 03:00:00 - 03:59:59	462	1.7%	0.13	1.8 MB	2.4%	0.51
Nov 21 04:00:00 - 04:15:00	106	0.4%	0.12	350.1 KB	0.5%	0.39
TOTAL: 24:00:00	27175	100.0%	0.31	73.4 MB	100.0%	0.87

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	3378	320	12	3046
2	newsfeed.neva.ru	3122	266	9	2847
3	news-out.mixmin.net	1061	3	1	1057
4	feeder.eternal-september.org	818	52	2	764
5	newsfeed.fu-berlin.de	783	29	0	754
6	csiph-out.news.weretis.net	679	332	1	346
7	news.fcku.it	222	7	0	215
8	news-out.aioe.org	105	42	0	63
9	news.redatomik.org	44	0	0	44
10	news.swapon.de	15	0	0	15
11	newsfeeds.xmission.com	10	4	1	5
12	news.freedyn.net	10	0	1	9
13	nntp.pasdenom.info	5	0	0	5
14	xanadu-bbs.net	2	0	0	2
TOTAL: 14		10254	1055	27	9172

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	111
ut.test	99
it-alt.sport.calcio.juventus	69
lada.auto	65
mozilla.support.firefox	62
it.annunci.immobiliari	51
it.annunci.commerciali	50
it.annunci.varie	49
alt.survival	49
mpc.lists.freebsd.ports.bugs	44
gmane.linux.alsa.devel	29
gmane.linux.kernel	25
mozilla.dev.platform	18
alt.politics.usa	15
mpc.lists.nanog	15
alt.politics	14
gmane.comp.gis.openstreetmap.tagging	14
gmane.comp.gis.openstreetmap	14
it-alt.comp.software.mozilla	14
alt.windows7.general	14
TOTAL: 111	1055

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	6587
Binary: misplaced rar	512
EMP (phn path)	459
EMP (phn nph)	249
Too many newsgroups	48
Scoring filter (10)	48
Too many newsgroups (meow)	26
EMP (phl)	23
Scoring filter (8)	22
User-issued cancel	15
Scoring filter (13)	15
HTML Multipart	13
Binary Payload	12
Scoring filter (9)	10
Binary: misplaced par2	9
HTML Image Tags	7
Scoring filter (11)	6
HTML post	6
Scoring filter (14)	5
User-issued spam cancel	4
TOTAL: 26	8091

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	63	0	87	87
TOTAL: 1	63	0	87	87

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.feeder.erje.net	176
	csiph-out.news.weretis.net	125
	feeder.eternal-september.org	30
	news.fcku.it	18
	news-out.mixmin.net	9
	newsfeeds.xmission.com	3
	news.redatomik.org	2
	news.freedyn.net	2
	newsfeed.fu-berlin.de	2
	TOTAL: 9	367
Including strange strings
	newsfeed.fu-berlin.de	502
	csiph-out.news.weretis.net	73
	csiph-out.feeder.erje.net	48
	news.redatomik.org	34
	news.swapon.de	13
	news-out.mixmin.net	10
	news-out.aioe.org	6
	news.fcku.it	4
	feeder.eternal-september.org	2
	newsfeeds.xmission.com	2
	TOTAL: 11	695
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 3		1063

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.freedyn.net	28421	5975	21077	113	0	0	21%	23:59:51
2	xanadu-bbs	31787	5967	21131	75	0	0	18%	23:59:52
3	fu-berlin.de	25733	5762	19869	91	0	0	22%	23:59:34
4	news.bbs.geek.nz	39489	1031	20304	35	0	0	2%	23:59:51
5	usenet.pasdenom.info	27907	155	20305	6659	0	4	0%	23:59:52
6	aioe	19327	48	18291	6	0	0	0%	23:59:52
7	news.redatomik.org	21321	34	20296	5	0	0	0%	23:59:52
8	erje	17817	17	16459	0	0	0	0%	23:59:52
9	neva.ru	20216	11	19676	103	0	0	0%	23:59:52
10	eternal-september	20165	10	18749	0	1	0	0%	23:59:42
11	news.swapon.de	1819	3	1807	0	0	0	0%	23:49:47
12	xmission	20261	2	18785	0	0	0	0%	23:59:52
13	weretis.net	18477	2	16543	0	0	0	0%	23:59:42
14	news.mixmin.net	20499	1	20120	0	0	0	0%	23:59:52
15	news.fcku.it	2267	1	2257	0	0	0	0%	21:47:24
16	au2pb	0	0	0	0	0	21380	0%	23:58:42
17	bwh	0	0	0	0	0	21363	0%	23:58:41
TOTAL: 17		315506	19019	255669	7087	1	42747	6%	405:32:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	16.5 MB	238.2 KB	16.7 MB	0.2 KB/s	2.8 KB	23:59:51
2	xanadu-bbs	16.3 MB	173.9 KB	16.5 MB	0.2 KB/s	2.8 KB	23:59:52
3	fu-berlin.de	15.7 MB	184.4 KB	15.9 MB	0.2 KB/s	2.8 KB	23:59:34
4	news.bbs.geek.nz	2.7 MB	101.0 KB	2.8 MB	0.0 KB/s	2.7 KB	23:59:51
5	usenet.pasdenom.info	461.4 KB	17.3 MB	17.7 MB	0.2 KB/s	2.7 KB	23:59:52
6	aioe	106.9 KB	18.9 KB	125.9 KB	0.0 KB/s	2.3 KB	23:59:52
7	news.redatomik.org	76.3 KB	15.2 KB	91.5 KB	0.0 KB/s	2.3 KB	23:59:52
8	erje	38.5 KB	0.0 KB	38.5 KB	0.0 KB/s	2.3 KB	23:59:52
9	neva.ru	32.9 KB	264.4 KB	297.2 KB	0.0 KB/s	2.6 KB	23:59:52
10	eternal-september	26.4 KB	0.0 KB	26.4 KB	0.0 KB/s	2.6 KB	23:59:42
11	news.swapon.de	5.7 KB	0.0 KB	5.7 KB	0.0 KB/s	1.9 KB	23:49:47
12	weretis.net	4.4 KB	0.0 KB	4.4 KB	0.0 KB/s	2.2 KB	23:59:42
13	xmission	3.7 KB	0.0 KB	3.7 KB	0.0 KB/s	1.9 KB	23:59:52
14	news.mixmin.net	3.0 KB	0.0 KB	3.0 KB	0.0 KB/s	3.0 KB	23:59:52
15	news.fcku.it	2.0 KB	0.0 KB	2.0 KB	0.0 KB/s	2.0 KB	21:47:24
16	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:41
TOTAL: 17		51.9 MB	18.2 MB	70.2 MB	0.0 KB/s	2.8 KB	405:32:10

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp140-05-70-55-59-144.dsl.bell.ca	442	346	980.2 KB	55	00:51:28
2	141.168.117.108	47	62	166.7 KB	39	00:40:43
3	tempe0.bbox.io	6	9	35.9 KB	1	03:32:40
4	194-73-239-109.cust.centrio.cz	3	3	9.9 KB	2	00:53:42
TOTAL: 4		498	420	1.2 MB	97	16:29:02

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	442	346	980.2 KB	55	00:51:28
2	unresolved	49	62	166.7 KB	39	00:40:45
3	*.bbox.io	6	9	35.9 KB	1	03:32:40
4	*.cust.centrio.cz	3	3	9.9 KB	2	00:53:42
5	*.nielsenmedia.com	3	0	0.0 KB	0	00:02:27
6	*.upc-a.chello.nl	46	0	0.0 KB	0	07:23:07
7	*.dhcp.stpt.wi.charter.com	13	0	0.0 KB	0	03:04:49
TOTAL: 7		562	420	1.2 MB	97	16:29:02

NNRP auth users [Top 20]:

User	Conn
moussa	47
ctomczyk	3
TOTAL: 2	50

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	3.336	0.774	0.000	07:23:07
tempe0.bbox.io	0.806	0.163	0.000	03:32:40
71-82-225-13.dhcp.stpt.wi.charter.com	0.981	0.242	0.000	03:04:49
194-73-239-109.cust.centrio.cz	0.280	0.048	0.009	00:53:42
mtrlpq2314w-lp140-05-70-55-59-144.dsl.bell.ca	36.160	7.098	0.000	00:51:28
141.168.117.108	4.931	0.980	0.417	00:40:43
challenger.nielsenmedia.com	0.256	0.041	0.000	00:02:27
185.100.87.191	0.144	0.024	0.000	00:00:02
TOTAL: 8	46.894	9.370	0.426	16:29:02

Curious NNRP server explorers [Top 20]:

System	Conn
a131033.upc-a.chello.nl	46
71-82-225-13.dhcp.stpt.wi.charter.com	13
challenger.nielsenmedia.com	3
185.100.87.191	2
TOTAL: 4	64

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	6	0
71-82-225-13.dhcp.stpt.wi.charter.com	4	0
194-73-239-109.cust.centrio.cz	1	0
TOTAL: 3	11	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	281	66.9%
2	comp	83	19.8%
3	fr	18	4.3%
4	uk	16	3.8%
5	muc	9	2.1%
6	rec	7	1.7%
7	sci	4	1.0%
8	soc	2	0.5%
TOTAL: 8		420	100.0%

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

Newsgroup		Count
1	alt.atheism	192
2	comp.os.vms	40
3	alt.comp.freeware	23
4	alt.bible.prophecy	20
5	fr.soc.politique	18
6	alt.home.repair	10
7	alt.usage.english	9
8	muc.lists.freebsd.security	9
9	comp.lang.c	7
10	comp.lang.python	7
11	comp.arch	6
12	alt.society.liberalism	6
13	comp.sys.ibm.pc.games.action	5
14	uk.d-i-y	5
15	alt.politics.trump	5
16	rec.arts.drwho	4
17	comp.arch.fpga	4
18	alt.politics.economics	3
19	comp.lang.javascript	3
20	uk.rec.sheds	3
21	comp.ai.philosophy	3
22	uk.games.video.misc	2
23	comp.os.os2.announce	2
24	alt.christnet.christianlife	2
25	alt.arts.poetry.comments	2
26	rec.sport.tennis	2
27	alt.obituaries	2
28	sci.physics.relativity	2
29	uk.media.radio.archers	2
30	soc.culture.israel	2
31	uk.radio.amateur	2
32	comp.soft-sys.matlab	1
33	rec.arts.tv.uk.coronation-st	1
34	comp.lang.lisp	1
35	comp.arch.embedded	1
36	sci.electronics.repair	1
37	comp.ai.alife	1
38	alt.sports.football.pro.sd-chargers	1
39	alt.religion.christian	1
40	alt.rush-limbaugh	1
41	comp.os.os2.misc	1
42	uk.tech.digital-tv	1
43	alt.russian.z1	1
44	alt.os.linux	1
45	uk.sci.weather	1
46	alt.assassination.jfk	1
47	alt.stupidity	1
48	comp.lang.ada	1
49	sci.military.naval	1
TOTAL: 49		420

Daily Usenet report for csiph.com

Nov 20 04:15:00 -- Nov 21 04:15:00