Daily Usenet report for csiph.com: May 19 04:15:02

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	22993	38.1%	2.3 MB	26.0%
inn	22857	37.9%	4.7 MB	52.8%
innd	11557	19.2%	1.4 MB	15.8%
innfeed	2847	4.7%	481.1 KB	5.3%
nocem	73	0.1%	7.7 KB	0.1%
TOTAL: 5	60327	100.0%	8.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	251815	53.7%
Negative hits	193874	41.3%
Do not exist	22004	4.7%
Cache misses	1408	0.3%
TOTAL: 4	469101	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:14.705	0.0%	304	0.000	48.372	801.000
article cleanup	00:00:00.178	0.0%	21748	0.000	0.008	0.040
article logging	00:00:12.331	0.0%	22259	0.000	0.554	9.717
article parse	00:00:12.965	0.0%	56187	0.000	0.231	3.905
article write	00:21:38.626	1.5%	16173	0.250	80.296	181.721
artlog/artcncl	00:00:00.006	0.0%	247	0.000	0.024	1.000
artlog/artparse	00:00:00.626	0.0%	378	0.000	1.656	37.400
data move	00:00:00.139	0.0%	443759	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.570	0.0%	229	0.000	2.489	20.636
hishave/artcncl	00:00:04.981	0.0%	304	0.000	16.385	168.083
hishave/artparse	00:00:00.001	0.0%	372	0.000	0.003	0.037
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:05:28.133	0.4%	472118	0.002	0.695	7.283
history sync	00:00:18.165	0.0%	357	0.000	50.882	775.500
history write	00:08:58.971	0.6%	21732	0.234	24.801	91.061
hiswrite/artcncl	00:00:04.892	0.0%	75	42.609	65.227	124.909
hiswrite/artparse	00:00:11.568	0.0%	372	0.000	31.097	186.111
idle	22:47:22.882	94.9%	399893	123.373	205.162	835.862
nntp read	00:00:02.061	0.0%	450624	0.001	0.005	0.009
overview write	00:33:10.885	2.3%	16173	0.579	123.099	3136.254
perl filter	00:00:43.244	0.1%	21715	1.216	1.991	8.327
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.313	0.0%	32413	0.000	0.010	0.034
TOTAL: 24:00:56.766	23:58:46.242	99.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.035	0.0%	16165	0.000	0.002	0.016
article prepare	00:00:00.002	0.0%	12704	0.000	0.000	0.021
article read	00:00:08.358	0.0%	1318	0.000	6.341	91.500
backlog stats	00:00:00.175	0.0%	287106	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.625	0.0%	224384	0.002	0.007	0.013
data write	00:00:01.201	0.0%	210448	0.001	0.006	0.012
idle	23:55:07.163	100.0%	287106	166.433	299.914	1038.628
status file	00:00:03.502	0.0%	254	0.000	13.787	809.000
TOTAL: 23:55:36.429	23:55:22.061	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	505:23:08.377	80.0%	10491574	93.918	173.414	600032.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:03:42.496	0.0%	29546134	0.000	0.008	0.167
readart	125:29:46.917	19.9%	10391431	0.000	43.477	336.333
TOTAL: 631:27:10.608	630:56:37.790	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	33362	3449	29591	322	10%	46:22:15
2	csiph-out.feeder.erje.net	1152	69655	2837	64861	1957	4%	94:58:34
3	news.redatomik.org	1	14624	2083	12465	76	14%	22:10:40
4	feeder.eternal-september.org	1	20020	1977	16975	1068	9%	25:21:02
5	newsfeeds.xmission.com	2	15957	1477	14470	10	9%	25:39:40
6	newsfeed.neva.ru	146	18288	1027	15579	1682	5%	71:11:53
7	news-out.aioe.org	2	15717	1026	14636	55	6%	23:59:27
8	newsfeed.fu-berlin.de	11	16028	1015	14895	118	6%	28:39:46
9	news-out.mixmin.net	2	17299	787	16079	433	4%	23:59:17
10	news.fcku.it	1	7358	298	6797	263	4%	23:59:58
11	news.freedyn.net	2	17321	79	17164	78	0%	23:10:52
12	nntp.pasdenom.info	2	15041	72	14961	8	0%	23:59:06
13	news.swapon.de	8	1555	41	1514	0	2%	24:04:18
14	localhost	42	8	8	0	0	100%	00:00:08
15	news.bbs.nz	1	16588	7	16580	1	0%	23:59:48
16	xanadu-bbs.net	26	580	4	575	1	0%	21:53:10
TOTAL: 16		1403	279401	16187	257142	6072	5%	503:29:54

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	11.9 MB	45.3 KB	12.4 MB	24.3 MB	48%	5.2 KB
2	csiph-out.news.weretis.net	10.1 MB	0.0 KB	6.0 MB	16.2 MB	62%	4.4 KB
3	feeder.eternal-september.org	4.9 MB	0.0 KB	5.9 MB	10.8 MB	45%	3.6 KB
4	news.redatomik.org	4.4 MB	0.0 KB	269.9 KB	4.7 MB	94%	2.2 KB
5	newsfeeds.xmission.com	4.1 MB	0.0 KB	608.0 KB	4.7 MB	87%	3.3 KB
6	newsfeed.neva.ru	3.0 MB	0.0 KB	5.1 MB	8.0 MB	36%	3.0 KB
7	news-out.aioe.org	2.7 MB	2.9 KB	239.1 KB	3.0 MB	92%	2.8 KB
8	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	305.4 KB	2.8 MB	89%	2.6 KB
9	news-out.mixmin.net	2.5 MB	0.0 KB	867.4 KB	3.4 MB	74%	2.8 KB
10	news.fcku.it	879.7 KB	0.0 KB	3.7 MB	4.5 MB	19%	8.2 KB
11	news.freedyn.net	209.2 KB	0.0 KB	2.4 MB	2.6 MB	7%	17.0 KB
12	nntp.pasdenom.info	170.3 KB	0.0 KB	14.7 KB	185.0 KB	92%	2.3 KB
13	news.swapon.de	98.7 KB	0.0 KB	0.0 KB	98.7 KB	100%	2.4 KB
14	localhost	11.9 KB	0.0 KB	0.0 KB	11.9 KB	100%	1.5 KB
15	news.bbs.nz	10.7 KB	0.0 KB	2.6 KB	13.3 KB	80%	1.7 KB
16	xanadu-bbs.net	10.3 KB	0.0 KB	2.0 KB	12.3 KB	83%	2.5 KB
TOTAL: 16		47.6 MB	48.2 KB	37.7 MB	85.4 MB	55%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 19 04:15:02 - 04:59:59	274	1.7%	0.10	741.4 KB	1.5%	0.27
May 19 05:00:00 - 05:59:59	394	2.4%	0.11	1.0 MB	2.2%	0.29
May 19 06:00:00 - 06:59:59	470	2.9%	0.13	1.6 MB	3.4%	0.46
May 19 07:00:00 - 07:59:59	646	4.0%	0.18	1.9 MB	4.0%	0.54
May 19 08:00:00 - 08:59:59	850	5.3%	0.24	3.1 MB	6.4%	0.87
May 19 09:00:00 - 09:59:59	666	4.1%	0.18	1.5 MB	3.2%	0.44
May 19 10:00:00 - 10:59:59	752	4.7%	0.21	2.3 MB	4.9%	0.66
May 19 11:00:00 - 11:59:59	724	4.5%	0.20	1.8 MB	3.8%	0.51
May 19 12:00:00 - 12:59:59	776	4.8%	0.22	2.1 MB	4.3%	0.59
May 19 13:00:00 - 13:59:59	947	5.9%	0.26	2.5 MB	5.2%	0.70
May 19 14:00:00 - 14:59:59	945	5.8%	0.26	3.6 MB	7.6%	1.04
May 19 15:00:00 - 15:59:59	763	4.7%	0.21	2.1 MB	4.5%	0.60
May 19 16:00:00 - 16:59:59	975	6.0%	0.27	2.6 MB	5.4%	0.74
May 19 17:00:00 - 17:59:59	771	4.8%	0.21	2.1 MB	4.5%	0.61
May 19 18:00:00 - 18:59:59	895	5.5%	0.25	2.6 MB	5.3%	0.73
May 19 19:00:00 - 19:59:59	882	5.5%	0.24	2.5 MB	5.3%	0.71
May 19 20:00:00 - 20:59:59	942	5.8%	0.26	2.9 MB	6.0%	0.82
May 19 21:00:00 - 21:59:59	739	4.6%	0.21	2.1 MB	4.4%	0.60
May 19 22:00:00 - 22:59:59	651	4.0%	0.18	2.0 MB	4.2%	0.57
May 19 23:00:00 - 23:59:59	555	3.4%	0.15	1.6 MB	3.4%	0.46
May 20 00:00:00 - 00:59:59	478	3.0%	0.13	1.5 MB	3.2%	0.44
May 20 01:00:00 - 01:59:59	434	2.7%	0.12	1.3 MB	2.7%	0.37
May 20 02:00:00 - 02:59:59	324	2.0%	0.09	1.1 MB	2.3%	0.32
May 20 03:00:00 - 03:59:59	222	1.4%	0.06	785.6 KB	1.6%	0.22
May 20 04:00:00 - 04:15:00	85	0.5%	0.09	306.6 KB	0.6%	0.34
TOTAL: 23:59:58	16160	100.0%	0.19	47.7 MB	100.0%	0.57

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1977	73	21	1883
2	newsfeed.neva.ru	1670	119	0	1551
3	feeder.eternal-september.org	967	33	0	934
4	newsfeed.fu-berlin.de	522	23	0	499
5	news-out.mixmin.net	431	0	0	431
6	csiph-out.news.weretis.net	308	106	0	202
7	news.fcku.it	287	4	0	283
8	news.redatomik.org	139	0	0	139
9	news.freedyn.net	78	1	0	77
10	news-out.aioe.org	52	44	1	7
11	newsfeeds.xmission.com	9	0	0	9
12	nntp.pasdenom.info	8	1	0	7
13	news.swapon.de	2	0	0	2
14	news.bbs.nz	1	1	0	0
15	xanadu-bbs.net	1	0	0	1
TOTAL: 15		6452	405	22	6025

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.auto	52
it-alt.sport.calcio.juventus	36
lada.talk	36
mpc.lists.freebsd.ports.bugs	29
alt.survival	29
gmane.comp.gis.openstreetmap.tagging	24
alt.windows7.general	17
spline.eisfair	15
mpc.lists.freebsd.x11	15
cakewalk.audio	14
oesterreich.tratsch	11
mozilla.support.firefox	8
gmane.linux.alsa.devel	7
alt.politics	6
alt.politics.usa	6
alt.religion	5
alt.computer.workshop	5
mozilla.support.thunderbird	4
alt.toronto	4
mpc.lists.nanog	4
TOTAL: 68	405

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4510
EMP (phn path)	264
User-issued cancel	120
Too many newsgroups	70
EMP (phl)	50
EMP (phn nph)	26
HTML Multipart	17
Scoring filter (9)	14
Binary Payload	11
Scoring filter (10)	9
Scoring filter (12)	7
User-issued spam cancel	5
Binary: misplaced par2	4
Binary: misplaced 054	2
Scoring filter (11)	2
HTML post	2
Binary: misplaced 025	1
Scoring filter (8)	1
Binary: misplaced 002	1
Binary: misplaced 029	1
TOTAL: 25	5122

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	37	0	43	43
TOTAL: 1	37	29	43	43

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	9
	TOTAL: 1	9
Huge articles
	csiph-out.feeder.erje.net	149
	news.fcku.it	96
	csiph-out.news.weretis.net	64
	news.freedyn.net	30
	feeder.eternal-september.org	23
	newsfeeds.xmission.com	6
	news-out.mixmin.net	5
	news.redatomik.org	3
	newsfeed.fu-berlin.de	1
	TOTAL: 9	377
Including strange strings
	newsfeed.fu-berlin.de	419
	news.redatomik.org	61
	csiph-out.feeder.erje.net	20
	news-out.mixmin.net	5
	news.swapon.de	2
	newsfeed.neva.ru	1
	feeder.eternal-september.org	1
	TOTAL: 7	509
TOTAL: 3		895

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	17499	712	15442	2	20	4%	23:59:52
2	news.freedyn.net	16712	611	15468	4	0	3%	23:59:43
3	fu-berlin.de	15050	442	14608	0	0	2%	23:59:50
4	usenet.pasdenom.info	17033	123	15130	837	9	0%	23:59:41
5	news.bbs.nz	25827	90	15522	2	1	0%	23:59:52
6	erje	13646	79	13098	70	0	0%	23:59:49
7	weretis.net	11746	14	11209	6	0	0%	23:57:40
8	aioe	13984	13	13440	0	0	0%	23:59:51
9	xmission	16028	10	14024	1	0	0%	23:59:52
10	news.redatomik.org	13980	9	13457	0	0	0%	23:59:48
11	news.swapon.de	1495	8	1473	0	0	0%	23:40:33
12	eternal-september	14038	8	13439	0	0	0%	23:59:52
13	news.mixmin.net	14809	8	14434	1	0	0%	23:59:52
14	neva.ru	14539	6	14317	119	0	0%	23:59:14
15	news.fcku.it	1095	3	1084	0	0	0%	22:47:22
TOTAL: 15		207481	2136	186145	1042	30	1%	358:22:51

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	5.7 MB	2.7 KB	5.7 MB	0.1 KB/s	8.2 KB	23:59:52
2	news.freedyn.net	5.6 MB	19.1 KB	5.6 MB	0.1 KB/s	9.4 KB	23:59:43
3	fu-berlin.de	5.1 MB	0.0 KB	5.1 MB	0.1 KB/s	11.9 KB	23:59:50
4	usenet.pasdenom.info	349.1 KB	5.8 MB	6.1 MB	0.1 KB/s	6.5 KB	23:59:41
5	news.bbs.nz	242.4 KB	4.3 KB	246.7 KB	0.0 KB/s	2.7 KB	23:59:52
6	erje	204.0 KB	143.9 KB	347.9 KB	0.0 KB/s	2.3 KB	23:59:49
7	aioe	24.1 KB	0.0 KB	24.1 KB	0.0 KB/s	1.9 KB	23:59:51
8	weretis.net	23.8 KB	23.0 KB	46.8 KB	0.0 KB/s	2.3 KB	23:57:40
9	xmission	18.6 KB	1.0 KB	19.7 KB	0.0 KB/s	1.8 KB	23:59:52
10	news.redatomik.org	16.7 KB	0.0 KB	16.7 KB	0.0 KB/s	1.9 KB	23:59:48
11	news.swapon.de	11.9 KB	0.0 KB	11.9 KB	0.0 KB/s	1.5 KB	23:40:33
12	eternal-september	11.9 KB	0.0 KB	11.9 KB	0.0 KB/s	1.5 KB	23:59:52
13	news.mixmin.net	11.9 KB	1.2 KB	13.2 KB	0.0 KB/s	1.5 KB	23:59:52
14	neva.ru	11.8 KB	300.5 KB	312.3 KB	0.0 KB/s	2.5 KB	23:59:14
15	news.fcku.it	7.3 KB	0.0 KB	7.3 KB	0.0 KB/s	2.4 KB	22:47:22
TOTAL: 15		17.4 MB	6.3 MB	23.6 MB	0.0 KB/s	7.6 KB	358:22:51

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp140-05-70-55-56-30.dsl.bell.ca	137	4281319	11.7 GB	10611	0	0	608:35:46
2	96-42-18-226.dhcp.mdsn.wi.charter.com	27	8	11.9 KB	8	8	8	07:10:06
3	141.168.117.108	48	8	11.9 KB	5	0	0	00:48:22
4	a131033.upc-a.chello.nl	32	6	9.8 KB	4	0	0	08:41:07
TOTAL: 4		244	4281341	11.7 GB	10628	8	8	631:27:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	137	4281319	11.7 GB	10611	0	0	608:35:46
2	*.dhcp.mdsn.wi.charter.com	27	8	11.9 KB	8	8	8	07:10:06
3	unresolved	48	8	11.9 KB	5	0	0	00:48:22
4	*.upc-a.chello.nl	32	6	9.8 KB	4	0	0	08:41:07
5	*.cust.centrio.cz	2	0	0.0 KB	0	0	0	00:30:09
6	*.ph.ph.cox.net	11	0	0.0 KB	0	0	0	04:41:23
7	*.nielsenmedia.com	2	0	0.0 KB	0	0	0	01:00:11
TOTAL: 7		259	4281341	11.7 GB	10628	8	8	631:27:07

NNRP auth users [Top 20]:

User	Conn
ohlandl	8
ctomczyk	2
TOTAL: 2	10

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mtrlpq2314w-lp140-05-70-55-56-30.dsl.bell.ca	633.498	1116.279	0.000	608:35:46
a131033.upc-a.chello.nl	2.655	0.522	0.000	08:41:07
96-42-18-226.dhcp.mdsn.wi.charter.com	2.416	0.522	1.086	07:10:06
ip72-222-200-117.ph.ph.cox.net	0.949	0.221	0.000	04:41:23
challenger.nielsenmedia.com	0.139	0.032	0.000	01:00:11
141.168.117.108	4.849	1.042	0.000	00:48:22
194-73-239-109.cust.centrio.cz	0.145	0.047	0.012	00:30:09
TOTAL: 7	644.651	1118.665	1.098	631:27:07

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	11
194-73-239-109.cust.centrio.cz	2
challenger.nielsenmedia.com	2
TOTAL: 3	15

NNRP client timeouts [Top 20]:

System	Conn	Peer
mtrlpq2314w-lp140-05-70-55-56-30.dsl.bell.ca	42	0
ip72-222-200-117.ph.ph.cox.net	9	0
96-42-18-226.dhcp.mdsn.wi.charter.com	8	0
challenger.nielsenmedia.com	2	0
194-73-239-109.cust.centrio.cz	1	0
TOTAL: 5	62	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	1175150	33.0%
2	sci	638102	17.9%
3	fr	424272	11.9%
4	comp	363455	10.2%
5	rec	278923	7.8%
6	soc	219968	6.2%
7	uk	190487	5.4%
8	aus	152903	4.3%
9	talk	113429	3.2%
10	news	73	0.0%
11	perl	8	0.0%
TOTAL: 11		3556770	100.0%

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

Newsgroup		Count
1	fr.soc.politique	424271
2	alt.atheism	419600
3	alt.home.repair	366266
4	comp.os.linux.advocacy	323990
5	sci.physics	320110
6	sci.electronics.design	286230
7	aus.cars	152903
8	uk.d-i-y	151325
9	rec.food.cooking	138970
10	alt.usage.english	136680
11	talk.politics.misc	113429
12	soc.culture.israel	112138
13	soc.retirement	107829
14	alt.global-warming	106986
15	rec.sport.pro-wrestling	102047
16	alt.bible.prophecy	76438
17	alt.comp.freeware	53697
18	comp.lang.python	39430
19	uk.legal	39149
20	rec.arts.drwho	34173
21	sci.math	16922
22	sci.physics.relativity	14840
23	alt.free.newsservers	14304
24	rec.sport.tennis	3726
25	alt.politics.economics	1165
26	news.lists.filters	73
27	comp.sys.ibm.ps2.hardware	22
28	comp.sys.raspberry-pi	9
29	perl.cpan.uploads	7
30	alt.comp.os.windows-10	6
31	rec.boats	5
32	uk.media.radio.archers	4
33	uk.legal.moderated	4
34	comp.mobile.android	4
35	alt.os.linux.mageia	2
36	alt.jobs.overseas	2
37	alt.jobs.offered	2
38	perl.perl5.porters	1
39	uk.rec.sheds	1
40	uk.radio.amateur.moderated	1
41	soc.culture.usa	1
42	fr.comp.sys.atari	1
43	rec.arts.tv.uk.coronation-st	1
44	uk.rec.cars.maintenance	1
45	uk.media.radio.bbc-r4	1
46	alt.gossip.celebrities	1
47	alt.jobs.jobsearch	1
48	rec.arts.tv	1
49	uk.telecom	1
TOTAL: 49		3556770

Daily Usenet report for csiph.com

May 19 04:15:02 -- May 20 04:15:00