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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	44616	50.7%	8.4 MB	63.8%
innd	24366	27.7%	2.6 MB	19.7%
nnrpd	15775	17.9%	1.7 MB	12.7%
innfeed	3122	3.5%	515.4 KB	3.8%
nocem	72	0.1%	7.3 KB	0.1%
TOTAL: 5	87951	100.0%	13.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	450829	53.7%
Negative hits	344152	41.0%
Do not exist	43483	5.2%
Cache misses	743	0.1%
TOTAL: 4	839207	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:02.122	0.0%	212	0.000	10.009	79.500
article cleanup	00:00:00.356	0.0%	43681	0.000	0.008	0.024
article logging	00:00:00.701	0.0%	44313	0.000	0.016	0.356
article parse	00:00:01.607	0.0%	161215	0.002	0.010	0.529
article write	00:07:01.107	0.5%	24751	0.481	17.014	72.461
artlog/artcncl	00:00:00.001	0.0%	174	0.000	0.006	0.067
artlog/artparse	00:00:00.003	0.0%	252	0.000	0.012	0.500
data move	00:00:00.337	0.0%	777005	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.254	0.0%	207	0.000	1.227	12.000
hishave/artcncl	00:00:00.005	0.0%	212	0.000	0.024	0.500
hishave/artparse	00:00:00.003	0.0%	248	0.000	0.012	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:12.408	0.0%	843148	0.002	0.015	0.561
history sync	00:00:02.113	0.0%	356	0.000	5.935	80.500
history write	00:00:44.025	0.1%	43437	0.102	1.014	30.251
hiswrite/artcncl	00:00:00.107	0.0%	5	0.000	21.400	106.000
hiswrite/artparse	00:00:00.322	0.0%	248	0.000	1.298	59.333
idle	23:47:07.582	99.0%	771038	54.403	111.055	417.076
nntp read	00:00:03.710	0.0%	788738	0.002	0.005	0.013
overview write	00:02:39.701	0.2%	24751	0.172	6.452	686.400
perl filter	00:01:45.055	0.1%	43433	1.602	2.419	3.630
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.474	0.0%	49566	0.000	0.010	0.023
TOTAL: 24:00:53.021	23:59:41.993	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.078	0.0%	24887	0.000	0.003	0.026
article prepare	00:00:00.001	0.0%	22864	0.000	0.000	0.007
article read	00:00:06.459	0.0%	3648	0.000	1.771	91.333
backlog stats	00:00:00.351	0.0%	441858	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.618	0.0%	344517	0.003	0.008	0.014
data write	00:00:02.411	0.0%	329117	0.003	0.007	0.021
idle	23:53:55.903	100.0%	441858	93.394	194.714	539.247
status file	00:00:00.444	0.0%	275	0.000	1.615	19.000
TOTAL: 23:54:17.388	23:54:08.265	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.622	0.0%	15906	0.027	0.039	0.060
idle	23:03:19.022	99.8%	109959	82.865	754.818	600960.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.989	0.0%	220320	0.000	0.009	1.927
readart	00:01:41.499	0.1%	10305	0.000	9.849	265.000
TOTAL: 23:06:44.230	23:05:03.132	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	134156	6536	118562	9058	4%	94:57:15
2	csiph-out.news.weretis.net	5	57817	6060	50700	1057	10%	51:54:51
3	feeder.eternal-september.org	5	38622	3550	29447	5625	9%	24:15:31
4	news-out.aioe.org	3	24106	1890	22203	13	7%	24:09:53
5	news-out.mixmin.net	4	27021	1418	25356	247	5%	24:20:56
6	newsfeeds.xmission.com	3	24460	1359	23087	14	5%	25:19:02
7	newsfeed.neva.ru	150	46255	1250	42220	2785	2%	72:01:55
8	news.redatomik.org	1	24029	1127	22877	25	4%	24:38:37
9	newsfeed.fu-berlin.de	70	23620	1107	22168	345	4%	34:04:07
10	news.fcku.it	2	10352	132	10171	49	1%	23:59:24
11	news.freedyn.net	4	27710	121	27480	109	0%	24:13:36
12	news.swapon.de	0	2033	65	1965	3	3%	25:53:28
13	xanadu-bbs.net	5	210	44	162	4	20%	08:21:27
14	nntp.pasdenom.info	4	38457	36	38359	62	0%	23:57:10
15	news.bbs.geek.nz	3	30157	3	30153	1	0%	29:36:22
16	localhost	35	0	0	0	0	0%	00:00:00
TOTAL: 16		1446	509005	24698	464910	19397	4%	511:43:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	24.1 MB	2.3 MB	45.1 MB	71.5 MB	33%	4.7 KB
2	csiph-out.news.weretis.net	16.9 MB	24.2 KB	13.2 MB	30.1 MB	56%	4.3 KB
3	feeder.eternal-september.org	9.5 MB	360.9 KB	77.2 MB	87.0 MB	10%	9.7 KB
4	news-out.mixmin.net	6.8 MB	3.7 KB	1.4 MB	8.2 MB	82%	5.0 KB
5	news-out.aioe.org	4.4 MB	2.0 KB	40.9 KB	4.5 MB	99%	2.4 KB
6	newsfeeds.xmission.com	4.1 MB	0.0 KB	738.6 KB	4.8 MB	85%	3.6 KB
7	newsfeed.neva.ru	3.5 MB	105.5 KB	25.6 MB	29.2 MB	11%	7.4 KB
8	news.redatomik.org	2.9 MB	3.8 KB	1.1 MB	4.1 MB	72%	3.6 KB
9	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	721.4 KB	3.1 MB	77%	2.2 KB
10	news.freedyn.net	529.1 KB	0.0 KB	1.3 MB	1.8 MB	29%	7.9 KB
11	news.fcku.it	233.6 KB	0.0 KB	2.1 MB	2.3 MB	9%	13.2 KB
12	news.swapon.de	188.2 KB	0.0 KB	51.3 KB	239.5 KB	78%	3.5 KB
13	xanadu-bbs.net	110.0 KB	0.0 KB	8.6 KB	118.7 KB	92%	2.5 KB
14	nntp.pasdenom.info	65.4 KB	0.0 KB	210.1 KB	275.5 KB	23%	2.8 KB
15	news.bbs.geek.nz	11.9 KB	0.0 KB	377.9 KB	389.8 KB	3%	97.4 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		75.7 MB	2.8 MB	169.1 MB	247.6 MB	30%	5.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 6 04:15:00 - 04:59:59	307	1.2%	0.11	1.1 MB	1.4%	0.40
Dec 6 05:00:00 - 05:59:59	523	2.1%	0.15	1.7 MB	2.3%	0.49
Dec 6 06:00:00 - 06:59:59	500	2.0%	0.14	2.0 MB	2.6%	0.56
Dec 6 07:00:00 - 07:59:59	777	3.1%	0.22	2.1 MB	2.8%	0.61
Dec 6 08:00:00 - 08:59:59	1046	4.2%	0.29	2.7 MB	3.6%	0.78
Dec 6 09:00:00 - 09:59:59	1090	4.4%	0.30	2.8 MB	3.7%	0.80
Dec 6 10:00:00 - 10:59:59	1083	4.4%	0.30	2.7 MB	3.6%	0.77
Dec 6 11:00:00 - 11:59:59	1516	6.1%	0.42	5.9 MB	7.8%	1.67
Dec 6 12:00:00 - 12:59:59	1505	6.1%	0.42	6.0 MB	8.0%	1.72
Dec 6 13:00:00 - 13:59:59	1179	4.8%	0.33	3.1 MB	4.1%	0.88
Dec 6 14:00:00 - 14:59:59	1168	4.7%	0.32	3.0 MB	3.9%	0.85
Dec 6 15:00:00 - 15:59:59	1439	5.8%	0.40	4.5 MB	5.9%	1.27
Dec 6 16:00:00 - 16:59:59	1551	6.3%	0.43	4.6 MB	6.1%	1.31
Dec 6 17:00:00 - 17:59:59	1499	6.1%	0.42	4.1 MB	5.3%	1.15
Dec 6 18:00:00 - 18:59:59	1443	5.8%	0.40	4.1 MB	5.3%	1.15
Dec 6 19:00:00 - 19:59:59	1419	5.7%	0.39	4.7 MB	6.2%	1.34
Dec 6 20:00:00 - 20:59:59	1112	4.5%	0.31	3.1 MB	4.0%	0.87
Dec 6 21:00:00 - 21:59:59	1208	4.9%	0.34	3.7 MB	4.8%	1.04
Dec 6 22:00:00 - 22:59:59	1113	4.5%	0.31	3.4 MB	4.4%	0.96
Dec 6 23:00:00 - 23:59:59	784	3.2%	0.22	2.6 MB	3.4%	0.73
Dec 7 00:00:00 - 00:59:59	671	2.7%	0.19	2.2 MB	2.9%	0.63
Dec 7 01:00:00 - 01:59:59	642	2.6%	0.18	2.0 MB	2.6%	0.56
Dec 7 02:00:00 - 02:59:59	549	2.2%	0.15	1.8 MB	2.3%	0.50
Dec 7 03:00:00 - 03:59:59	517	2.1%	0.14	1.7 MB	2.2%	0.49
Dec 7 04:00:00 - 04:15:00	129	0.5%	0.14	438.1 KB	0.6%	0.49
TOTAL: 24:00:00	24770	100.0%	0.29	75.8 MB	100.0%	0.90

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	9105	262	204	3	8636
2	feeder.eternal-september.org	5472	71	29	0	5372
3	newsfeed.neva.ru	2745	294	10	0	2441
4	csiph-out.news.weretis.net	914	115	2	0	797
5	newsfeed.fu-berlin.de	809	55	0	0	754
6	news-out.mixmin.net	255	1	1	0	253
7	news.freedyn.net	109	0	0	0	109
8	newsfeeds.xmission.com	64	2	0	0	62
9	nntp.pasdenom.info	62	12	0	0	50
10	news.fcku.it	52	0	0	0	52
11	news.redatomik.org	37	0	1	0	36
12	news-out.aioe.org	20	10	1	0	9
13	news.swapon.de	12	0	0	0	12
14	xanadu-bbs.net	12	0	0	0	12
15	news.bbs.geek.nz	4	1	0	0	3
TOTAL: 15		19672	823	248	3	18598

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.auto	112
lada.talk	107
alt.survival	49
ut.test	37
lada.kitchen	32
alt.windows7.general	26
alt.binaries.camilla	24
it-alt.sport.calcio.juventus	21
mozilla.support.seamonkey	17
gmane.linux.alsa.devel	17
abg.test	16
gmane.linux.kernel	16
mozilla.support.firefox	16
spline.eisfair	15
mpc.lists.nanog	14
alt.politics	13
mozilla.support.thunderbird	13
lada.commerce	10
cakewalk.audio	9
gmane.comp.gis.openstreetmap.tagging	8
TOTAL: 135	823

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
nz.politics.announce	3
TOTAL: 1	3

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14424
EMP (phn path)	2402
EMP (phl)	472
Binary Payload	141
EMP (phn nph)	105
Too many newsgroups	51
HTML Multipart	26
User-issued cancel	17
Scoring filter (12)	13
Scoring filter (8)	13
Scoring filter (9)	7
HTML post	6
Scoring filter (19)	5
Scoring filter (16)	5
Scoring filter (14)	5
Binary Image: misplaced jpg	3
HTML Image Tags	3
Scoring filter (10)	3
Binary: non-binary distribution	3
Binary: misplaced par2	1
TOTAL: 20	17705

NoCeM on Spool:

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

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	feeder.eternal-september.org	143
	csiph-out.news.weretis.net	32
	news.fcku.it	23
	news.redatomik.org	19
	news-out.mixmin.net	17
	newsfeeds.xmission.com	11
	news.freedyn.net	4
	news.bbs.geek.nz	3
	xanadu-bbs.net	3
	nntp.pasdenom.info	1
	TOTAL: 11	257
Including strange strings
	newsfeed.fu-berlin.de	444
	csiph-out.feeder.erje.net	54
	newsfeeds.xmission.com	51
	csiph-out.news.weretis.net	27
	feeder.eternal-september.org	13
	news-out.mixmin.net	11
	news.redatomik.org	11
	news.swapon.de	9
	news-out.aioe.org	7
	newsfeed.neva.ru	5
	TOTAL: 10	632
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 3		890

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	44466	1855	22267	18	88	4%	23:50:56
2	news.freedyn.net	25033	759	23795	3	0	3%	23:50:06
3	xanadu-bbs	28226	598	23985	0	1	2%	23:59:56
4	fu-berlin.de	23307	500	22806	0	0	2%	23:58:43
5	usenet.pasdenom.info	26268	128	22945	1660	86	0%	23:59:56
6	weretis.net	17442	34	16863	7	0	0%	23:53:34
7	news.redatomik.org	23564	23	22937	9	0	0%	23:50:06
8	aioe	21671	21	20449	8	0	0%	23:50:05
9	xmission	26197	19	22808	1	1	0%	23:59:35
10	erje	18201	17	18016	23	0	0%	23:50:06
11	eternal-september	21377	9	20301	0	0	0%	23:59:56
12	news.swapon.de	1951	3	1931	2	0	0%	23:55:40
13	news.fcku.it	3244	2	3197	0	0	0%	22:49:20
14	news.mixmin.net	22666	1	22020	0	0	0%	23:50:06
15	neva.ru	23128	1	22677	19	0	0%	23:59:56
16	au2pb	0	0	0	0	24147	0%	23:50:06
17	bwh	0	0	0	0	24117	0%	23:50:06
TOTAL: 17		326741	3970	286997	1750	48440	1%	405:18:13

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	5.4 MB	14.6 KB	5.4 MB	0.1 KB/s	7.3 KB	23:50:06
2	news.bbs.geek.nz	5.2 MB	75.1 KB	5.3 MB	0.1 KB/s	2.9 KB	23:50:56
3	xanadu-bbs	4.7 MB	0.0 KB	4.7 MB	0.1 KB/s	8.1 KB	23:59:56
4	fu-berlin.de	4.5 MB	0.0 KB	4.5 MB	0.1 KB/s	9.2 KB	23:58:43
5	usenet.pasdenom.info	512.9 KB	6.6 MB	7.1 MB	0.1 KB/s	4.1 KB	23:59:56
6	weretis.net	113.9 KB	38.1 KB	152.0 KB	0.0 KB/s	3.7 KB	23:53:34
7	news.redatomik.org	74.7 KB	107.5 KB	182.1 KB	0.0 KB/s	5.7 KB	23:50:06
8	erje	67.7 KB	161.2 KB	228.8 KB	0.0 KB/s	5.7 KB	23:50:06
9	aioe	67.1 KB	18.5 KB	85.6 KB	0.0 KB/s	3.0 KB	23:50:05
10	xmission	55.6 KB	2.8 KB	58.5 KB	0.0 KB/s	2.9 KB	23:59:35
11	eternal-september	34.5 KB	0.0 KB	34.5 KB	0.0 KB/s	3.8 KB	23:59:56
12	news.swapon.de	9.7 KB	5.3 KB	15.0 KB	0.0 KB/s	3.0 KB	23:55:40
13	news.mixmin.net	5.1 KB	0.0 KB	5.1 KB	0.0 KB/s	5.1 KB	23:50:06
14	neva.ru	3.7 KB	58.4 KB	62.1 KB	0.0 KB/s	3.1 KB	23:59:56
15	news.fcku.it	3.5 KB	0.0 KB	3.5 KB	0.0 KB/s	1.7 KB	22:49:20
16	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:06
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:06
TOTAL: 17		20.8 MB	7.1 MB	27.8 MB	0.0 KB/s	5.0 KB	405:18:13

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp140-06-70-55-73-71.dsl.bell.ca	326	174	835.5 KB	128	02:41:35
2	37.248.157.218	3	2	4.2 KB	2	00:38:33
TOTAL: 2		329	176	839.7 KB	130	23:06:41

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	326	174	835.5 KB	128	02:41:35
2	unresolved	22	2	4.2 KB	2	01:55:13
3	*.bbox.io	7	0	0.0 KB	0	01:30:27
4	*.chello.nl	61	0	0.0 KB	0	09:56:50
5	*.dhcp.mdsn.wi.charter.com	3	0	0.0 KB	0	01:03:58
6	*.nielsenmedia.com	16	0	0.0 KB	0	05:58:35
TOTAL: 6		435	176	839.7 KB	130	23:06:41

NNRP auth users [Top 20]:

User	Conn
ctomczyk	2
moussa	1
TOTAL: 2	3

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	4.003	1.138	0.000	09:56:50
challenger.nielsenmedia.com	1.048	0.341	0.000	05:58:35
mtrlpq2314w-lp140-06-70-55-73-71.dsl.bell.ca	38.219	11.657	0.000	02:41:35
tempe0.bbox.io	0.522	0.104	0.000	01:30:27
68-185-181-64.dhcp.mdsn.wi.charter.com	0.209	0.052	0.000	01:03:58
5.51.176.30	1.543	1.416	0.000	00:46:22
37.248.157.218	0.297	0.081	0.007	00:38:33
1.127.48.140	0.066	0.025	0.002	00:30:01
80.50.149.131	0.066	0.022	0.000	00:00:10
5.87.64.182	0.072	0.016	0.000	00:00:02
94.162.120.169	0.069	0.015	0.000	00:00:01
31.188.169.187	0.070	0.016	0.000	00:00:01
TOTAL: 12	46.184	14.883	0.009	23:06:41

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	61
challenger.nielsenmedia.com	16
5.51.176.30	14
tempe0.bbox.io	7
68-185-181-64.dhcp.mdsn.wi.charter.com	3
31.188.169.187	1
94.162.120.169	1
5.87.64.182	1
80.50.149.131	1
1.127.48.140	1
TOTAL: 10	106

NNRP client timeouts [Top 20]:

System	Conn	Peer
challenger.nielsenmedia.com	11	1
tempe0.bbox.io	3	0
68-185-181-64.dhcp.mdsn.wi.charter.com	2	0
mtrlpq2314w-lp140-06-70-55-73-71.dsl.bell.ca	2	2
1.127.48.140	1	0
TOTAL: 5	19	3

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	84	47.7%
2	uk	28	15.9%
3	comp	27	15.3%
4	rec	16	9.1%
5	sci	7	4.0%
6	misc	4	2.3%
7	linux	3	1.7%
8	aus	2	1.1%
9	talk	2	1.1%
10	qc	1	0.6%
11	soc	1	0.6%
12	fr	1	0.6%
TOTAL: 12		176	100.0%

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

Newsgroup		Count
1	alt.california	26
2	comp.lang.python	13
3	alt.society.liberalism	10
4	alt.conspiracy	9
5	alt.home.repair	7
6	rec.arts.tv	6
7	comp.lang.c++	6
8	alt.politics.economics	5
9	rec.aviation.soaring	5
10	sci.math	5
11	uk.people.silversurfers	5
12	uk.legal	5
13	uk.media.radio.archers	4
14	alt.usage.english	4
15	misc.survivalism	4
16	alt.christnet.christianlife	4
17	uk.rec.sheds	4
18	alt.happy.valley	4
19	linux.kernel	3
20	comp.lang.c	3
21	alt.support.diabetes	3
22	comp.lang.javascript	2
23	alt.comp.os.windows-10	2
24	uk.politics.misc	2
25	uk.d-i-y	2
26	uk.tech.digital-tv	2
27	aus.politics	2
28	rec.arts.sf.written	2
29	alt.stupidity	2
30	comp.lang.fortran	2
31	talk.politics.misc	2
32	uk.railway	1
33	comp.databases.oracle.server	1
34	rec.arts.drwho	1
35	alt.war.vietnam	1
36	alt.os.linux.mint	1
37	alt.bread.recipes	1
38	alt.russian.z1	1
39	uk.rec.cycling	1
40	rec.autos.sport.f1	1
41	uk.media.tv.misc	1
42	rec.arts.comics.strips	1
43	uk.radio.amateur	1
44	sci.logic	1
45	sci.electronics.design	1
46	alt.folklore.computers	1
47	fr.soc.politique	1
48	alt.slack	1
49	alt.sports.football.pro.sd-chargers	1
50	qc.politique	1
51	alt.life.sucks	1
52	soc.retirement	1
TOTAL: 52		176

Daily Usenet report for csiph.com

Dec 6 04:15:00 -- Dec 7 04:15:00