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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	42063	52.4%	7.7 MB	64.7%
innd	24110	30.1%	2.5 MB	21.2%
nnrpd	10760	13.4%	1.1 MB	9.6%
innfeed	3200	4.0%	550.9 KB	4.5%
nocem	77	0.1%	8.1 KB	0.1%
TOTAL: 5	80210	100.0%	11.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	413763	54.5%
Negative hits	304566	40.1%
Do not exist	40506	5.3%
Cache misses	580	0.1%
TOTAL: 4	759415	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.607	0.0%	184	0.000	3.299	56.000
article cleanup	00:00:00.308	0.0%	41169	0.000	0.007	0.024
article logging	00:00:00.580	0.0%	41765	0.000	0.014	0.038
article parse	00:00:01.405	0.0%	156720	0.000	0.009	0.030
article write	00:03:17.116	0.2%	22093	1.425	8.922	76.275
artlog/artcncl	00:00:00.000	0.0%	127	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	261	0.000	0.019	1.000
data move	00:00:00.297	0.0%	716209	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.046	0.0%	181	0.000	0.254	7.000
hishave/artcncl	00:00:00.003	0.0%	184	0.000	0.016	0.167
hishave/artparse	00:00:00.001	0.0%	231	0.000	0.004	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.841	0.0%	768698	0.000	0.009	0.240
history sync	00:00:01.568	0.0%	360	0.000	4.356	107.667
history write	00:00:29.415	0.0%	40963	0.044	0.718	14.757
hiswrite/artcncl	00:00:00.000	0.0%	3	0.000	0.000	0.000
hiswrite/artparse	00:00:00.144	0.0%	231	0.000	0.623	8.000
idle	23:52:59.357	99.4%	718161	63.019	119.722	379.034
nntp read	00:00:03.350	0.0%	726845	0.002	0.005	0.007
overview write	00:01:20.787	0.1%	22093	0.139	3.657	73.434
perl filter	00:01:31.157	0.1%	40817	1.438	2.233	5.464
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.396	0.0%	44255	0.000	0.009	0.030
TOTAL: 24:00:56.428	23:59:53.383	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.071	0.0%	22072	0.000	0.003	0.024
article prepare	00:00:00.005	0.0%	43870	0.000	0.000	0.007
article read	00:00:10.662	0.0%	7943	0.028	1.342	77.808
backlog stats	00:00:00.275	0.0%	425147	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.449	0.0%	320426	0.003	0.008	0.013
data write	00:00:02.390	0.0%	302529	0.003	0.008	0.017
idle	23:53:27.722	100.0%	425147	120.508	202.301	502.009
status file	00:00:00.616	0.0%	309	0.000	1.994	50.000
TOTAL: 23:53:52.911	23:53:44.190	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	16:47:59.437	99.8%	63433	82.291	953.438	600080.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.008	0.0%	127881	0.000	0.008	0.167
readart	00:00:33.290	0.1%	8974	0.344	3.710	77.000
TOTAL: 16:49:30.640	16:48:33.735	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	128360	6226	112923	9211	4%	95:16:35
2	csiph-out.news.weretis.net	2	58283	5584	51871	828	9%	43:31:09
3	feeder.eternal-september.org	4	36357	3539	26811	6007	9%	24:28:51
4	news.redatomik.org	0	27778	1544	26172	62	5%	19:29:17
5	newsfeed.neva.ru	145	47737	1050	44352	2335	2%	71:53:26
6	newsfeed.fu-berlin.de	31	22646	1047	21238	361	4%	28:48:15
7	news-out.aioe.org	4	21679	761	20894	24	3%	24:12:56
8	newsfeeds.xmission.com	2	21122	694	20375	53	3%	22:57:01
9	news-out.mixmin.net	2	25259	667	24337	255	2%	23:37:21
10	news.fcku.it	2	9189	539	8598	52	5%	23:54:23
11	news.swapon.de	2	2581	186	2395	0	7%	23:44:16
12	xanadu-bbs.net	15	631	118	509	4	18%	22:24:53
13	news.freedyn.net	1	24802	107	24607	88	0%	22:26:00
14	news.bbs.geek.nz	1	6467	65	6376	26	1%	07:36:53
15	nntp.pasdenom.info	3	37378	59	37248	71	0%	23:49:00
16	localhost	35	0	0	0	0	0%	00:00:00
TOTAL: 16		1401	470269	22186	428706	19377	4%	478:10:16

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	21.0 MB	2.2 MB	52.9 MB	76.1 MB	27%	5.0 KB
2	csiph-out.news.weretis.net	16.3 MB	69.7 KB	7.4 MB	23.8 MB	68%	3.8 KB
3	feeder.eternal-september.org	9.8 MB	707.7 KB	79.9 MB	90.5 MB	10%	9.7 KB
4	news.redatomik.org	4.0 MB	86.7 KB	1.3 MB	5.3 MB	74%	3.4 KB
5	news-out.mixmin.net	3.7 MB	0.0 KB	1.4 MB	5.1 MB	72%	5.6 KB
6	newsfeed.neva.ru	2.5 MB	29.4 KB	18.8 MB	21.3 MB	11%	6.4 KB
7	news-out.aioe.org	2.4 MB	0.0 KB	42.2 KB	2.5 MB	98%	3.2 KB
8	newsfeed.fu-berlin.de	2.3 MB	5.3 KB	1.3 MB	3.7 MB	63%	2.7 KB
9	newsfeeds.xmission.com	2.0 MB	0.0 KB	570.6 KB	2.6 MB	78%	3.5 KB
10	news.fcku.it	1.6 MB	0.0 KB	2.4 MB	4.0 MB	40%	7.0 KB
11	xanadu-bbs.net	578.1 KB	0.0 KB	8.3 KB	586.4 KB	98%	4.8 KB
12	news.swapon.de	469.3 KB	0.0 KB	0.0 KB	469.3 KB	100%	2.5 KB
13	news.freedyn.net	396.2 KB	0.0 KB	2.2 MB	2.6 MB	14%	13.7 KB
14	news.bbs.geek.nz	163.7 KB	0.0 KB	892.9 KB	1.0 MB	15%	11.6 KB
15	nntp.pasdenom.info	130.5 KB	0.0 KB	224.3 KB	354.7 KB	36%	2.7 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		67.4 MB	3.1 MB	169.4 MB	239.9 MB	28%	5.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 30 04:15:00 - 04:59:59	328	1.5%	0.12	1.3 MB	1.9%	0.49
Dec 30 05:00:00 - 05:59:59	453	2.1%	0.13	1.3 MB	1.9%	0.37
Dec 30 06:00:00 - 06:59:59	509	2.3%	0.14	1.9 MB	2.8%	0.53
Dec 30 07:00:00 - 07:59:59	602	2.7%	0.17	1.8 MB	2.7%	0.51
Dec 30 08:00:00 - 08:59:59	1045	4.7%	0.29	3.7 MB	5.6%	1.06
Dec 30 09:00:00 - 09:59:59	1062	4.8%	0.29	3.6 MB	5.4%	1.03
Dec 30 10:00:00 - 10:59:59	973	4.4%	0.27	2.9 MB	4.3%	0.82
Dec 30 11:00:00 - 11:59:59	1056	4.8%	0.29	3.0 MB	4.5%	0.86
Dec 30 12:00:00 - 12:59:59	936	4.2%	0.26	2.5 MB	3.8%	0.72
Dec 30 13:00:00 - 13:59:59	960	4.3%	0.27	2.7 MB	4.0%	0.76
Dec 30 14:00:00 - 14:59:59	1187	5.4%	0.33	3.5 MB	5.2%	0.99
Dec 30 15:00:00 - 15:59:59	1187	5.4%	0.33	3.3 MB	4.9%	0.94
Dec 30 16:00:00 - 16:59:59	1182	5.3%	0.33	3.2 MB	4.8%	0.92
Dec 30 17:00:00 - 17:59:59	1248	5.6%	0.35	3.6 MB	5.4%	1.04
Dec 30 18:00:00 - 18:59:59	1276	5.8%	0.35	4.0 MB	6.0%	1.14
Dec 30 19:00:00 - 19:59:59	1336	6.0%	0.37	4.2 MB	6.3%	1.21
Dec 30 20:00:00 - 20:59:59	1235	5.6%	0.34	3.5 MB	5.3%	1.00
Dec 30 21:00:00 - 21:59:59	1015	4.6%	0.28	2.8 MB	4.3%	0.81
Dec 30 22:00:00 - 22:59:59	1018	4.6%	0.28	2.9 MB	4.3%	0.81
Dec 30 23:00:00 - 23:59:59	937	4.2%	0.26	2.8 MB	4.2%	0.79
Dec 31 00:00:00 - 00:59:59	826	3.7%	0.23	2.5 MB	3.7%	0.71
Dec 31 01:00:00 - 01:59:59	633	2.9%	0.18	2.4 MB	3.6%	0.68
Dec 31 02:00:00 - 02:59:59	496	2.2%	0.14	1.6 MB	2.4%	0.45
Dec 31 03:00:00 - 03:59:59	461	2.1%	0.13	1.5 MB	2.3%	0.43
Dec 31 04:00:00 - 04:15:00	133	0.6%	0.15	394.6 KB	0.6%	0.44
TOTAL: 24:00:00	22094	100.0%	0.26	66.9 MB	100.0%	0.79

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	9271	408	179	2	8682
2	feeder.eternal-september.org	6001	93	49	0	5859
3	newsfeed.neva.ru	2297	248	4	0	2045
4	csiph-out.news.weretis.net	902	169	0	0	733
5	newsfeed.fu-berlin.de	794	13	0	0	781
6	news-out.mixmin.net	262	0	0	0	262
7	news.freedyn.net	92	2	0	0	90
8	newsfeeds.xmission.com	62	0	0	0	62
9	news.redatomik.org	61	0	0	0	61
10	news.fcku.it	47	0	0	0	47
11	news-out.aioe.org	27	23	0	0	4
12	news.swapon.de	11	0	0	0	11
13	nntp.pasdenom.info	11	8	0	0	3
14	xanadu-bbs.net	4	0	0	0	4
TOTAL: 14		19842	964	232	2	18644

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	116
ut.test	96
it.annunci.immobiliari	66
it.annunci.commerciali	66
it.annunci.varie	64
it-alt.sport.calcio.juventus	40
lada.auto	37
alt.survival	27
alt.2600	27
alt.windows7.general	27
lada.photo	27
mozilla.support.thunderbird	25
alt.politics.scorched-earth	23
mozilla.support.seamonkey	21
lada.commerce	16
mpc.lists.nanog	14
hk.politics	14
lada.kitchen	11
spline.eisfair	11
lada.soft	11
TOTAL: 116	964

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	14968
EMP (phn path)	1807
EMP (phl)	567
EMP (phn nph)	106
Too many newsgroups	77
User-issued cancel	27
Binary Payload	26
Scoring filter (13)	11
HTML Multipart	11
Scoring filter (12)	10
Scoring filter (9)	9
Scoring filter (8)	8
Scoring filter (16)	7
Scoring filter (10)	7
HTML post	6
Scoring filter (20)	5
Scoring filter (18)	5
Scoring filter (19)	2
Scoring filter (11)	2
Scoring filter (17)	2
TOTAL: 26	17670

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	69	0	78	78
TOTAL: 1	69	0	78	78

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	116
	TOTAL: 1	116
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	TOTAL: 1	4
Huge articles
	feeder.eternal-september.org	126
	news.freedyn.net	24
	news.fcku.it	21
	news-out.mixmin.net	16
	csiph-out.news.weretis.net	15
	newsfeed.fu-berlin.de	13
	newsfeeds.xmission.com	9
	news.redatomik.org	6
	TOTAL: 8	230
Including strange strings
	newsfeed.fu-berlin.de	433
	csiph-out.feeder.erje.net	63
	feeder.eternal-september.org	41
	csiph-out.news.weretis.net	23
	news.swapon.de	11
	news.redatomik.org	10
	news-out.mixmin.net	8
	newsfeed.neva.ru	5
	news-out.aioe.org	2
	news.fcku.it	1
	TOTAL: 11	598
No colon-space in header
	csiph-out.feeder.erje.net	28
	TOTAL: 1	28
TOTAL: 5		976

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.geek.nz	36230	5863	15387	80	1	0	16%	23:50:03
2	news.freedyn.net	22889	765	21131	4	0	0	3%	23:50:03
3	xanadu-bbs	24907	719	21250	4	0	0	2%	23:59:55
4	fu-berlin.de	20702	609	20093	0	0	0	2%	23:54:08
5	usenet.pasdenom.info	25055	348	19767	1919	0	29	1%	23:59:55
6	erje	16663	317	15386	28	0	0	1%	23:50:03
7	aioe	20052	81	18674	34	0	0	0%	23:57:04
8	news.redatomik.org	20408	64	19581	36	0	0	0%	23:50:03
9	xmission	25286	18	20516	2	0	0	0%	23:59:19
10	neva.ru	21460	16	20132	30	0	0	0%	23:59:40
11	weretis.net	14743	12	14281	3	0	0	0%	23:52:36
12	news.mixmin.net	21596	5	20272	0	0	0	0%	23:59:51
13	eternal-september	19320	3	17653	0	0	0	0%	23:59:55
14	news.fcku.it	1561	1	1517	0	0	0	0%	22:41:46
15	au2pb	0	0	0	0	0	21415	0%	23:58:42
16	news.swapon.de	2311	0	2240	1	0	0	0%	23:58:03
17	bwh	0	0	0	0	0	21335	0%	23:50:04
TOTAL: 17		293183	8821	247880	2141	1	42779	3%	405:31:10

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	16.3 MB	419.1 KB	16.7 MB	0.2 KB/s	2.9 KB	23:50:03
2	news.freedyn.net	6.0 MB	10.9 KB	6.0 MB	0.1 KB/s	8.0 KB	23:50:03
3	xanadu-bbs	5.8 MB	15.2 KB	5.8 MB	0.1 KB/s	8.2 KB	23:59:55
4	fu-berlin.de	5.5 MB	0.0 KB	5.5 MB	0.1 KB/s	9.2 KB	23:54:08
5	usenet.pasdenom.info	1.3 MB	7.7 MB	9.0 MB	0.1 KB/s	4.1 KB	23:59:55
6	erje	813.0 KB	94.1 KB	907.1 KB	0.0 KB/s	2.6 KB	23:50:03
7	news.redatomik.org	223.2 KB	139.9 KB	363.2 KB	0.0 KB/s	3.6 KB	23:50:03
8	aioe	211.5 KB	115.7 KB	327.2 KB	0.0 KB/s	2.8 KB	23:57:04
9	xmission	59.4 KB	8.1 KB	67.5 KB	0.0 KB/s	3.4 KB	23:59:19
10	neva.ru	42.3 KB	131.0 KB	173.3 KB	0.0 KB/s	3.8 KB	23:59:40
11	weretis.net	36.5 KB	7.8 KB	44.4 KB	0.0 KB/s	3.0 KB	23:52:36
12	news.mixmin.net	19.0 KB	0.0 KB	19.0 KB	0.0 KB/s	3.8 KB	23:59:51
13	eternal-september	7.8 KB	0.0 KB	7.8 KB	0.0 KB/s	2.6 KB	23:59:55
14	news.fcku.it	0.9 KB	0.0 KB	0.9 KB	0.0 KB/s	0.9 KB	22:41:46
15	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
16	news.swapon.de	0.0 KB	4.9 KB	4.9 KB	0.0 KB/s	4.9 KB	23:58:03
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:04
TOTAL: 17		36.3 MB	8.6 MB	44.9 MB	0.0 KB/s	4.2 KB	405:31:10

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca	220	454	1.2 MB	204	02:07:18
2	ti0135a400-1919.bb.online.no	35	30	76.2 KB	5	01:58:07
3	tempe0.bbox.io	16	4	13.4 KB	1	06:52:25
TOTAL: 3		271	488	1.3 MB	210	16:49:28

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	220	454	1.2 MB	204	02:07:18
2	*.bb.online.no	35	30	76.2 KB	5	01:58:07
3	*.bbox.io	16	4	13.4 KB	1	06:52:25
4	*.chello.nl	30	0	0.0 KB	0	04:50:41
5	unresolved	1	0	0.0 KB	0	00:00:46
6	*.dhcp.mdsn.wi.charter.com	3	0	0.0 KB	0	01:00:09
TOTAL: 6		305	488	1.3 MB	210	16:49:28

NNRP auth users [Top 20]:

User	Conn
ctomczyk	8
moussa	1
TOTAL: 2	9

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
tempe0.bbox.io	1.197	0.266	0.000	06:52:25
dhcp-089-099-203-254.chello.nl	1.878	0.534	0.000	04:50:41
mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca	25.680	6.892	0.000	02:07:18
ti0135a400-1919.bb.online.no	2.510	0.460	0.022	01:58:07
68-185-181-64.dhcp.mdsn.wi.charter.com	0.181	0.062	0.000	01:00:09
1.127.48.73	0.076	0.008	0.002	00:00:46
TOTAL: 6	31.522	8.222	0.024	16:49:28

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	30
68-185-181-64.dhcp.mdsn.wi.charter.com	3
1.127.48.73	1
TOTAL: 3	34

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	12	0
mtrlpq2314w-lp140-05-70-55-56-27.dsl.bell.ca	2	2
68-185-181-64.dhcp.mdsn.wi.charter.com	2	0
ti0135a400-1919.bb.online.no	1	0
TOTAL: 4	17	2

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	256	52.5%
2	rec	63	12.9%
3	comp	53	10.9%
4	uk	38	7.8%
5	talk	24	4.9%
6	sci	18	3.7%
7	fr	15	3.1%
8	can	6	1.2%
9	soc	5	1.0%
10	muc	4	0.8%
11	misc	2	0.4%
12	linux	2	0.4%
13	aus	1	0.2%
14	us	1	0.2%
TOTAL: 14		488	100.0%

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

Newsgroup		Count
1	alt.christnet.christianlife	64
2	alt.home.repair	49
3	alt.california	34
4	comp.lang.javascript	30
5	alt.society.liberalism	29
6	rec.arts.tv	28
7	alt.rush-limbaugh	27
8	rec.boats	21
9	sci.military.naval	15
10	alt.atheism	15
11	fr.soc.politique	14
12	talk.politics.misc	14
13	talk.politics.guns	10
14	comp.lang.python	10
15	alt.politics.economics	10
16	uk.legal	9
17	uk.media.radio.archers	8
18	can.politics	6
19	soc.culture.usa	5
20	alt.os.linux.mint	4
21	comp.lang.c	4
22	uk.politics.misc	4
23	muc.lists.freebsd.hackers	4
24	uk.tech.digital-tv	3
25	rec.arts.drwho	3
26	alt.sports.football.pro.sd-chargers	3
27	alt.global-warming	3
28	alt.happy.valley	3
29	uk.radio.amateur	3
30	alt.conspiracy	3
31	rec.arts.sf.written	2
32	uk.sci.weather	2
33	misc.survivalism	2
34	linux.kernel	2
35	alt.comp.os.windows-10	2
36	rec.games.pinball	2
37	comp.misc	2
38	sci.math	2
39	alt.religion.christian	2
40	uk.media.tv.misc	2
41	uk.comp.sys.mac	1
42	comp.lang.fortran	1
43	alt.bbs.ads	1
44	alt.skate.figure	1
45	comp.databases.oracle.server	1
46	comp.os.vms	1
47	comp.sys.raspberry-pi	1
48	sci.physics	1
49	alt.life.sucks	1
50	fr.rec.photo	1
51	aus.politics	1
52	alt.support.depression	1
53	alt.comp.anti-virus	1
54	alt.usage.english	1
55	uk.d-i-y	1
56	uk.rec.cycling	1
57	uk.rec.driving	1
58	rec.music.rock-pop-r+b.1950s	1
59	uk.comp.homebuilt	1
60	comp.soft-sys.sas	1
61	alt.os.linux	1
62	rec.outdoors.rv-travel	1
63	comp.sys.mac.system	1
64	rec.autos.sport.f1	1
65	rec.aviation.military	1
66	alt.russian.z1	1
67	rec.bicycles.tech	1
68	rec.sport.football.college	1
69	uk.rec.motorcycles	1
70	uk.rec.drugs.cannabis	1
71	us.military.army	1
72	comp.mobile.ipad	1
73	rec.aviation.soaring	1
TOTAL: 73		488

Daily Usenet report for csiph.com

Dec 30 04:15:00 -- Dec 31 04:15:00