Daily Usenet report for csiph.com: Dec 13 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	29954	42.2%	6.4 MB	57.6%
nnrpd	24455	34.5%	2.6 MB	23.5%
innd	13200	18.6%	1.6 MB	14.1%
innfeed	3247	4.6%	540.2 KB	4.7%
nocem	124	0.2%	13.8 KB	0.1%
TOTAL: 5	70980	100.0%	11.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	326602	53.7%
Negative hits	251903	41.4%
Do not exist	28911	4.8%
Cache misses	336	0.1%
TOTAL: 4	607752	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:05.227	0.0%	387	0.000	13.506	544.000
article cleanup	00:00:00.210	0.0%	28833	0.000	0.007	0.026
article logging	00:00:09.602	0.0%	29393	0.000	0.327	3.759
article parse	00:00:04.385	0.0%	75122	0.000	0.058	1.046
article write	00:04:48.530	0.3%	21145	0.959	13.645	58.647
artlog/artcncl	00:00:00.078	0.0%	310	0.000	0.252	3.700
artlog/artparse	00:00:00.269	0.0%	306	0.000	0.879	122.500
data move	00:00:00.170	0.0%	580580	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.131	0.0%	382	0.000	0.343	5.769
hishave/artcncl	00:00:00.060	0.0%	387	0.000	0.155	3.923
hishave/artparse	00:00:00.000	0.0%	305	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:03:07.332	0.2%	611776	0.003	0.306	2.185
history sync	00:00:07.374	0.0%	365	0.000	20.203	308.000
history write	00:04:08.794	0.3%	28824	0.379	8.631	47.183
hiswrite/artcncl	00:00:00.001	0.0%	5	0.000	0.200	1.000
hiswrite/artparse	00:00:03.163	0.0%	305	0.000	10.370	165.333
idle	23:29:48.466	97.8%	551210	79.757	153.460	463.625
nntp read	00:00:02.831	0.0%	589119	0.002	0.005	0.008
overview write	00:15:37.287	1.1%	21145	0.370	44.327	870.930
perl filter	00:00:55.740	0.1%	28813	1.212	1.935	4.502
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.373	0.0%	42410	0.000	0.009	0.028
TOTAL: 24:01:13.780	23:59:00.023	99.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.268	0.0%	279148	0.000	0.001	0.033
article prepare	00:00:00.004	0.0%	21020	0.000	0.000	0.011
article read	00:00:03.211	0.0%	2332	0.000	1.377	23.500
backlog stats	00:00:00.374	0.0%	662480	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.943	0.0%	470815	0.003	0.006	0.015
data write	00:00:02.316	0.0%	441707	0.002	0.005	0.013
idle	23:53:29.086	100.0%	662480	41.212	129.829	574.660
status file	00:00:00.817	0.0%	329	0.000	2.483	114.000
TOTAL: 23:53:56.402	23:53:39.019	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	16:20:59.292	99.3%	32964	69.900	1785.563	600157.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.337	0.0%	66468	0.000	0.005	0.222
readart	00:04:06.728	0.4%	8969	0.000	27.509	484.000
TOTAL: 16:27:53.416	16:25:06.357	99.7%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	92168	4608	84344	3216	4%	95:02:40
2	newsfeeds.xmission.com	3	20605	3224	17373	8	15%	25:16:43
3	csiph-out.news.weretis.net	8	41839	2865	38579	395	6%	45:38:36
4	feeder.eternal-september.org	1	24920	2729	21040	1151	10%	23:50:56
5	news-out.aioe.org	4	20743	2463	18200	80	11%	24:11:43
6	news-out.mixmin.net	3	22155	1204	20487	464	5%	24:08:49
7	newsfeed.neva.ru	138	22798	1108	19728	1962	4%	71:46:59
8	newsfeed.fu-berlin.de	16	19800	1097	18375	328	5%	24:34:50
9	news.redatomik.org	1	21733	1028	20701	4	4%	27:49:20
10	news.fcku.it	2	9896	768	8760	368	7%	26:39:20
11	news.swapon.de	5	1676	63	1613	0	3%	23:10:32
12	news.bbs.geek.nz	2	20079	48	20031	0	0%	23:59:45
13	nntp.pasdenom.info	7	19747	45	19692	10	0%	23:56:22
14	news.freedyn.net	3	21606	21	21569	16	0%	21:42:47
15	xanadu-bbs.net	18	592	12	580	0	2%	22:20:22
16	localhost	34	0	0	0	0	0%	00:00:08
TOTAL: 16		1397	360357	21283	331072	8002	5%	504:09:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	18.9 MB	58.7 KB	16.0 MB	34.9 MB	54%	4.6 KB
2	csiph-out.news.weretis.net	10.6 MB	0.0 KB	6.5 MB	17.1 MB	61%	5.4 KB
3	newsfeeds.xmission.com	8.8 MB	0.0 KB	269.8 KB	9.1 MB	97%	2.9 KB
4	feeder.eternal-september.org	7.2 MB	0.0 KB	4.2 MB	11.5 MB	62%	3.0 KB
5	news-out.aioe.org	5.6 MB	0.0 KB	165.0 KB	5.7 MB	97%	2.3 KB
6	news-out.mixmin.net	4.2 MB	0.0 KB	1.7 MB	5.9 MB	70%	3.6 KB
7	newsfeed.neva.ru	3.1 MB	36.9 KB	11.8 MB	14.9 MB	20%	5.0 KB
8	news.redatomik.org	2.7 MB	0.0 KB	19.6 KB	2.7 MB	99%	2.7 KB
9	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	617.1 KB	3.1 MB	80%	2.2 KB
10	news.fcku.it	1.7 MB	0.0 KB	2.0 MB	3.6 MB	46%	3.3 KB
11	news.swapon.de	153.3 KB	0.0 KB	0.0 KB	153.3 KB	100%	2.4 KB
12	nntp.pasdenom.info	112.9 KB	0.0 KB	11.6 KB	124.5 KB	90%	2.3 KB
13	news.bbs.geek.nz	84.7 KB	0.0 KB	0.0 KB	84.7 KB	100%	1.8 KB
14	news.freedyn.net	56.2 KB	0.0 KB	122.5 KB	178.6 KB	31%	4.8 KB
15	xanadu-bbs.net	28.9 KB	0.0 KB	0.0 KB	28.9 KB	100%	2.4 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		65.6 MB	95.6 KB	43.4 MB	109.1 MB	60%	3.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 13 04:15:00 - 04:59:59	332	1.6%	0.12	1004.9 KB	1.5%	0.37
Dec 13 05:00:00 - 05:59:59	544	2.6%	0.15	2.3 MB	3.6%	0.67
Dec 13 06:00:00 - 06:59:59	506	2.4%	0.14	2.1 MB	3.2%	0.59
Dec 13 07:00:00 - 07:59:59	667	3.2%	0.19	2.0 MB	3.1%	0.58
Dec 13 08:00:00 - 08:59:59	833	3.9%	0.23	2.3 MB	3.5%	0.64
Dec 13 09:00:00 - 09:59:59	915	4.3%	0.25	2.4 MB	3.7%	0.69
Dec 13 10:00:00 - 10:59:59	983	4.7%	0.27	2.7 MB	4.1%	0.76
Dec 13 11:00:00 - 11:59:59	992	4.7%	0.28	3.3 MB	5.1%	0.95
Dec 13 12:00:00 - 12:59:59	920	4.4%	0.26	2.7 MB	4.2%	0.78
Dec 13 13:00:00 - 13:59:59	994	4.7%	0.28	2.6 MB	4.0%	0.74
Dec 13 14:00:00 - 14:59:59	1089	5.2%	0.30	3.7 MB	5.6%	1.04
Dec 13 15:00:00 - 15:59:59	1316	6.2%	0.37	4.9 MB	7.5%	1.40
Dec 13 16:00:00 - 16:59:59	1392	6.6%	0.39	4.8 MB	7.4%	1.37
Dec 13 17:00:00 - 17:59:59	1195	5.7%	0.33	3.0 MB	4.6%	0.86
Dec 13 18:00:00 - 18:59:59	1153	5.5%	0.32	3.2 MB	4.8%	0.90
Dec 13 19:00:00 - 19:59:59	1360	6.4%	0.38	4.2 MB	6.4%	1.20
Dec 13 20:00:00 - 20:59:59	1119	5.3%	0.31	2.8 MB	4.3%	0.80
Dec 13 21:00:00 - 21:59:59	1061	5.0%	0.29	3.4 MB	5.2%	0.97
Dec 13 22:00:00 - 22:59:59	867	4.1%	0.24	2.7 MB	4.1%	0.76
Dec 13 23:00:00 - 23:59:59	741	3.5%	0.21	2.4 MB	3.7%	0.68
Dec 14 00:00:00 - 00:59:59	533	2.5%	0.15	1.6 MB	2.5%	0.46
Dec 14 01:00:00 - 01:59:59	505	2.4%	0.14	1.5 MB	2.2%	0.42
Dec 14 02:00:00 - 02:59:59	492	2.3%	0.14	1.6 MB	2.5%	0.46
Dec 14 03:00:00 - 03:59:59	495	2.3%	0.14	1.7 MB	2.6%	0.48
Dec 14 04:00:00 - 04:15:00	96	0.5%	0.11	278.8 KB	0.4%	0.31
TOTAL: 24:00:00	21100	100.0%	0.24	65.3 MB	100.0%	0.77

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	3249	347	7	2895
2	newsfeed.neva.ru	1987	164	3	1820
3	feeder.eternal-september.org	1146	80	0	1066
4	newsfeed.fu-berlin.de	780	32	0	748
5	news-out.mixmin.net	481	6	0	475
6	csiph-out.news.weretis.net	409	209	0	200
7	news.fcku.it	332	0	0	332
8	news-out.aioe.org	96	42	0	54
9	news.redatomik.org	18	0	0	18
10	news.swapon.de	17	0	0	17
11	news.freedyn.net	16	3	0	13
12	nntp.pasdenom.info	10	2	0	8
13	newsfeeds.xmission.com	9	4	0	5
TOTAL: 13		8550	889	10	7651

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	81
alt.survival	71
lada.auto	69
alt.computer.workshop	60
mozilla.dev.security.policy	53
gmane.linux.alsa.devel	49
it.annunci.immobiliari	34
it.annunci.commerciali	32
it.annunci.varie	30
mozilla.general	29
alt.windows7.general	29
mozilla.support.seamonkey	21
gmane.linux.kernel	21
alt.politics.usa	15
it-alt.discussioni.ebay	13
mozilla.support.firefox	13
it-alt.sport.calcio.juventus	13
spline.eisfair	10
spline.eisfair.dev	9
it-alt.comp.software.mozilla	8
TOTAL: 125	889

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5509
EMP (phn path)	452
EMP (phn nph)	313
Binary: misplaced rar	215
Too many newsgroups	59
User-issued cancel	36
Scoring filter (10)	35
Binary: non-binary distribution	24
HTML Multipart	22
Binary Payload	20
Scoring filter (11)	14
Scoring filter (15)	13
Too many newsgroups (low_xpost)	11
EMP (phl)	10
HTML post	9
Scoring filter (14)	8
Scoring filter (9)	6
Poison newsgroup	5
Binary: misplaced PAR2	4
HTML Image Tags	3
TOTAL: 25	6775

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	117	0	161	161
TOTAL: 1	117	0	161	161

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	csiph-out.feeder.erje.net	178
	csiph-out.news.weretis.net	70
	feeder.eternal-september.org	18
	news.fcku.it	18
	news-out.mixmin.net	14
	newsfeeds.xmission.com	4
	newsfeed.fu-berlin.de	2
	news.freedyn.net	1
	TOTAL: 8	305
Including strange strings
	newsfeed.fu-berlin.de	450
	csiph-out.feeder.erje.net	37
	news-out.mixmin.net	19
	news.swapon.de	17
	news-out.aioe.org	15
	news.redatomik.org	14
	csiph-out.news.weretis.net	5
	newsfeeds.xmission.com	1
	news.fcku.it	1
	newsfeed.neva.ru	1
	TOTAL: 10	560
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 3		866

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	22684	891	20198	0	0	3%	23:59:52
2	news.bbs.geek.nz	35540	873	19356	51	0	2%	23:59:53
3	news.freedyn.net	667329	805	17974	3	271829	0%	23:59:52
4	fu-berlin.de	19755	758	18997	0	0	3%	23:59:53
5	usenet.pasdenom.info	21953	105	19714	1238	540	0%	23:59:53
6	aioe	17571	93	17010	2	21	0%	23:50:19
7	weretis.net	17246	72	16292	12	0	0%	23:50:10
8	erje	16933	62	16277	1	0	0%	23:59:53
9	xmission	19140	60	17140	3	0	0%	23:59:47
10	news.redatomik.org	19927	48	19376	2	0	0%	23:59:53
11	news.swapon.de	1746	38	1663	2	0	2%	23:46:27
12	eternal-september	18038	27	17423	0	0	0%	23:59:53
13	news.mixmin.net	18925	23	18575	1	0	0%	23:59:46
14	neva.ru	19052	0	18752	79	0	0%	23:59:45
15	news.fcku.it	2062	0	2060	0	0	0%	22:26:34
16	bwh	0	0	0	0	20328	0%	23:58:42
17	au2pb	0	0	0	0	20345	0%	23:58:42
TOTAL: 17		917901	3855	240807	1394	313063	0%	405:49:14

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.3 MB	0.0 KB	8.3 MB	0.1 KB/s	9.5 KB	23:59:52
2	fu-berlin.de	8.0 MB	0.0 KB	8.0 MB	0.1 KB/s	10.8 KB	23:59:53
3	news.freedyn.net	7.8 MB	19.4 KB	7.9 MB	0.1 KB/s	10.0 KB	23:59:52
4	news.bbs.geek.nz	2.5 MB	211.6 KB	2.7 MB	0.0 KB/s	3.0 KB	23:59:53
5	usenet.pasdenom.info	335.0 KB	8.8 MB	9.1 MB	0.1 KB/s	6.9 KB	23:59:53
6	aioe	221.3 KB	30.3 KB	251.6 KB	0.0 KB/s	2.6 KB	23:50:19
7	weretis.net	150.3 KB	60.9 KB	211.2 KB	0.0 KB/s	2.5 KB	23:50:10
8	erje	123.3 KB	7.9 KB	131.2 KB	0.0 KB/s	2.1 KB	23:59:53
9	xmission	119.9 KB	7.9 KB	127.8 KB	0.0 KB/s	2.0 KB	23:59:47
10	news.redatomik.org	92.0 KB	4.2 KB	96.2 KB	0.0 KB/s	1.9 KB	23:59:53
11	news.swapon.de	65.8 KB	8.8 KB	74.6 KB	0.0 KB/s	1.9 KB	23:46:27
12	eternal-september	49.1 KB	0.0 KB	49.1 KB	0.0 KB/s	1.8 KB	23:59:53
13	news.mixmin.net	45.2 KB	6.5 KB	51.7 KB	0.0 KB/s	2.2 KB	23:59:46
14	neva.ru	0.0 KB	198.6 KB	198.6 KB	0.0 KB/s	2.5 KB	23:59:45
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:26:34
16	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
17	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
TOTAL: 17		27.7 MB	9.3 MB	37.0 MB	0.0 KB/s	7.2 KB	405:49:14

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp130-05-70-55-71-106.dsl.bell.ca	1550	97	262.2 KB	68	01:39:45
2	141.168.117.108	30	80	209.4 KB	43	00:26:31
TOTAL: 2		1580	177	471.6 KB	111	16:27:41

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	1550	97	262.2 KB	68	01:39:45
2	unresolved	31	80	209.4 KB	43	00:26:41
3	*.nielsenmedia.com	1	0	0.0 KB	0	00:30:02
4	*.bbox.io	5	0	0.0 KB	0	01:30:06
5	*.upc-a.chello.nl	48	0	0.0 KB	0	07:40:59
6	*.dhcp.stpt.wi.charter.com	12	0	0.0 KB	0	04:40:05
TOTAL: 6		1647	177	471.6 KB	111	16:27:41

NNRP auth users [Top 20]:

User	Conn
moussa	30
TOTAL: 1	30

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	3.441	0.733	0.000	07:40:59
97-83-183-23.dhcp.stpt.wi.charter.com	0.897	0.191	0.000	04:40:05
mtrlpq2314w-lp130-05-70-55-71-106.dsl.bell.ca	135.109	21.750	0.000	01:39:45
tempe0.bbox.io	0.283	0.061	0.000	01:30:06
challenger.nielsenmedia.com	0.095	0.008	0.000	00:30:02
141.168.117.108	3.050	0.796	0.110	00:26:31
107.170.249.207	0.068	0.008	0.000	00:00:09
TOTAL: 7	142.943	23.547	0.110	16:27:41

Curious NNRP server explorers [Top 20]:

System	Conn
a131033.upc-a.chello.nl	48
97-83-183-23.dhcp.stpt.wi.charter.com	12
tempe0.bbox.io	5
challenger.nielsenmedia.com	1
107.170.249.207	1
TOTAL: 5	67

NNRP client timeouts [Top 20]:

System	Conn	Peer
97-83-183-23.dhcp.stpt.wi.charter.com	8	0
tempe0.bbox.io	3	0
challenger.nielsenmedia.com	1	0
TOTAL: 3	12	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	100	56.5%
2	comp	41	23.2%
3	uk	8	4.5%
4	rec	8	4.5%
5	fr	7	4.0%
6	talk	6	3.4%
7	misc	4	2.3%
8	sci	2	1.1%
9	aus	1	0.6%
TOTAL: 9		177	100.0%

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

Newsgroup		Count
1	alt.comp.freeware	52
2	comp.os.vms	14
3	comp.sys.ibm.pc.games.action	13
4	fr.soc.politique	7
5	alt.home.repair	7
6	talk.politics.misc	6
7	rec.boats	5
8	alt.fan.rush-limbaugh	4
9	misc.survivalism	4
10	uk.media.tv.misc	3
11	comp.arch	3
12	comp.os.cpm	3
13	uk.rec.driving	3
14	alt.bible.prophecy	3
15	alt.sports.football.pro.sd-chargers	2
16	alt.life.sucks	2
17	alt.california	2
18	alt.comp.os.windows-10	2
19	alt.christnet.christianlife	2
20	alt.usage.english	2
21	comp.lang.python	2
22	alt.astronomy	2
23	alt.os.linux.mageia	2
24	alt.atheism	2
25	alt.christnet.theology	2
26	alt.philosophy.taoism	2
27	comp.sys.mac.system	2
28	alt.politics.trump	2
29	comp.sys.mac.apps	1
30	rec.food.cooking	1
31	sci.military.naval	1
32	alt.buddha.short.fat.guy	1
33	alt.conspiracy	1
34	uk.railway	1
35	alt.obituaries	1
36	rec.photo.digital	1
37	alt.guitar.amps	1
38	alt.music.michael-jackson	1
39	alt.society.liberalism	1
40	alt.arts.poetry.comments	1
41	aus.cars	1
42	uk.legal	1
43	alt.messianic	1
44	alt.happy.valley	1
45	rec.aviation.soaring	1
46	sci.electronics.repair	1
47	alt.global-warming	1
48	comp.lang.c	1
49	comp.mobile.android	1
50	comp.os.qnx	1
TOTAL: 50		177

Daily Usenet report for csiph.com

Dec 13 04:15:00 -- Dec 14 04:15:00