Daily Usenet report for csiph.com: Jun 7 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	27292	42.9%	5.9 MB	58.3%
nnrpd	22469	35.4%	2.3 MB	23.4%
innd	10903	17.2%	1.3 MB	13.4%
innfeed	2813	4.4%	506.1 KB	4.9%
nocem	82	0.1%	8.6 KB	0.1%
TOTAL: 5	63559	100.0%	10.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	323113	54.0%
Negative hits	248657	41.5%
Do not exist	26388	4.4%
Cache misses	336	0.1%
TOTAL: 4	598494	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.255	0.0%	216	0.000	15.069	200.000
article cleanup	00:00:00.187	0.0%	26258	0.000	0.007	0.029
article logging	00:00:10.764	0.0%	26846	0.000	0.401	8.688
article parse	00:00:04.411	0.0%	73119	0.000	0.060	1.531
article write	00:03:39.774	0.3%	21017	0.483	10.457	79.066
artlog/artcncl	00:00:00.040	0.0%	186	0.000	0.215	1.810
artlog/artparse	00:00:00.148	0.0%	276	0.000	0.536	25.000
data move	00:00:00.178	0.0%	577991	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.077	0.0%	214	0.000	0.360	3.000
hishave/artcncl	00:00:00.019	0.0%	216	0.000	0.088	0.750
hishave/artparse	00:00:00.001	0.0%	273	0.000	0.004	0.200
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:03:09.178	0.2%	601259	0.004	0.315	1.827
history sync	00:00:08.342	0.0%	364	0.000	22.918	659.000
history write	00:04:38.736	0.3%	26260	0.339	10.614	53.940
hiswrite/artcncl	00:00:00.001	0.0%	2	0.000	0.500	1.000
hiswrite/artparse	00:00:03.354	0.0%	272	0.000	12.331	349.000
idle	23:29:37.508	97.8%	553339	90.869	152.849	537.614
nntp read	00:00:02.839	0.0%	583947	0.002	0.005	0.010
overview write	00:16:19.405	1.1%	21017	0.863	46.601	682.863
perl filter	00:00:54.045	0.1%	26213	1.250	2.062	3.689
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.394	0.0%	42112	0.000	0.009	0.027
TOTAL: 24:00:59.272	23:58:52.656	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.064	0.0%	21038	0.000	0.003	0.028
article prepare	00:00:00.002	0.0%	17888	0.000	0.000	0.013
article read	00:00:08.328	0.0%	2294	0.000	3.630	66.286
backlog stats	00:00:00.224	0.0%	407062	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.114	0.0%	306903	0.001	0.007	0.012
data write	00:00:01.835	0.0%	288540	0.002	0.006	0.012
idle	23:53:33.855	100.0%	407062	136.458	211.304	739.212
status file	00:00:01.127	0.0%	251	0.000	4.490	193.000
TOTAL: 23:53:57.148	23:53:47.549	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	14:38:54.539	99.3%	44756	98.583	1178.267	600182.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.940	0.0%	90152	0.000	0.010	12.094
readart	00:03:53.738	0.4%	9763	0.000	23.941	418.500
TOTAL: 14:45:12.550	14:42:49.217	99.7%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	8	42756	3880	38479	397	9%	48:16:05
2	csiph-out.feeder.erje.net	1153	87447	3106	82389	1952	3%	95:56:03
3	feeder.eternal-september.org	3	24318	2894	20737	687	11%	26:43:59
4	news-out.aioe.org	3	20512	2473	17965	74	12%	24:12:58
5	news.redatomik.org	1	21503	1969	19511	23	9%	27:43:48
6	newsfeeds.xmission.com	3	21590	1941	19636	13	8%	27:08:56
7	news-out.mixmin.net	2	21610	1684	19353	573	7%	24:08:32
8	newsfeed.neva.ru	148	21706	1339	18808	1559	6%	71:37:36
9	newsfeed.fu-berlin.de	12	19017	1220	17713	84	6%	25:01:50
10	news.fcku.it	2	9133	666	8325	142	7%	23:59:56
11	nntp.pasdenom.info	2	19655	79	19555	21	0%	23:59:11
12	news.swapon.de	1	1727	50	1669	8	2%	22:02:39
13	news.bbs.nz	1	17955	4	17951	0	0%	23:59:47
14	xanadu-bbs.net	9	724	3	720	1	0%	23:19:02
15	news.freedyn.net	3	987	0	986	1	0%	02:45:07
16	localhost	31	0	0	0	0	0%	00:00:08
TOTAL: 16		1382	330640	21308	303797	5535	6%	490:55:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	16.0 MB	0.0 KB	13.3 MB	29.3 MB	54%	5.9 KB
2	csiph-out.news.weretis.net	12.6 MB	0.0 KB	9.4 MB	22.0 MB	57%	5.3 KB
3	feeder.eternal-september.org	8.2 MB	0.0 KB	3.0 MB	11.2 MB	73%	3.2 KB
4	news-out.aioe.org	6.7 MB	0.0 KB	432.2 KB	7.1 MB	94%	2.9 KB
5	news-out.mixmin.net	6.1 MB	0.0 KB	1.2 MB	7.2 MB	84%	3.3 KB
6	newsfeeds.xmission.com	5.5 MB	0.0 KB	737.9 KB	6.2 MB	88%	3.3 KB
7	news.redatomik.org	4.9 MB	0.0 KB	38.7 KB	5.0 MB	99%	2.6 KB
8	newsfeed.neva.ru	4.4 MB	13.9 KB	5.0 MB	9.4 MB	46%	3.3 KB
9	newsfeed.fu-berlin.de	3.2 MB	0.0 KB	184.6 KB	3.4 MB	94%	2.7 KB
10	news.fcku.it	1.5 MB	0.0 KB	758.0 KB	2.2 MB	66%	2.8 KB
11	nntp.pasdenom.info	221.8 KB	0.0 KB	43.9 KB	265.6 KB	83%	2.7 KB
12	news.swapon.de	148.8 KB	0.0 KB	5.1 MB	5.2 MB	2%	92.6 KB
13	news.bbs.nz	9.4 KB	0.0 KB	0.0 KB	9.4 KB	100%	2.4 KB
14	xanadu-bbs.net	6.0 KB	0.0 KB	6.4 KB	12.4 KB	48%	3.1 KB
15	news.freedyn.net	0.0 KB	0.0 KB	1.8 KB	1.8 KB	0%	1.8 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		69.5 MB	13.9 KB	39.1 MB	108.6 MB	64%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 7 04:15:00 - 04:59:59	286	1.4%	0.11	1.1 MB	1.6%	0.41
Jun 7 05:00:00 - 05:59:59	402	1.9%	0.11	1.3 MB	1.9%	0.37
Jun 7 06:00:00 - 06:59:59	543	2.6%	0.15	1.7 MB	2.5%	0.49
Jun 7 07:00:00 - 07:59:59	768	3.7%	0.21	2.6 MB	3.8%	0.74
Jun 7 08:00:00 - 08:59:59	792	3.8%	0.22	2.0 MB	2.9%	0.56
Jun 7 09:00:00 - 09:59:59	966	4.6%	0.27	2.6 MB	3.8%	0.74
Jun 7 10:00:00 - 10:59:59	860	4.1%	0.24	2.4 MB	3.5%	0.69
Jun 7 11:00:00 - 11:59:59	929	4.4%	0.26	2.2 MB	3.3%	0.64
Jun 7 12:00:00 - 12:59:59	1102	5.2%	0.31	2.8 MB	4.1%	0.80
Jun 7 13:00:00 - 13:59:59	1071	5.1%	0.30	2.8 MB	4.1%	0.80
Jun 7 14:00:00 - 14:59:59	947	4.5%	0.26	3.2 MB	4.6%	0.90
Jun 7 15:00:00 - 15:59:59	1121	5.3%	0.31	3.0 MB	4.3%	0.85
Jun 7 16:00:00 - 16:59:59	1101	5.2%	0.31	3.3 MB	4.8%	0.93
Jun 7 17:00:00 - 17:59:59	1123	5.3%	0.31	3.1 MB	4.5%	0.87
Jun 7 18:00:00 - 18:59:59	1037	4.9%	0.29	3.1 MB	4.6%	0.89
Jun 7 19:00:00 - 19:59:59	880	4.2%	0.24	2.6 MB	3.8%	0.75
Jun 7 20:00:00 - 20:59:59	828	3.9%	0.23	2.4 MB	3.4%	0.67
Jun 7 21:00:00 - 21:59:59	828	3.9%	0.23	2.4 MB	3.5%	0.68
Jun 7 22:00:00 - 22:59:59	1216	5.8%	0.34	5.2 MB	7.6%	1.49
Jun 7 23:00:00 - 23:59:59	1142	5.4%	0.32	5.1 MB	7.4%	1.44
Jun 8 00:00:00 - 00:59:59	1008	4.8%	0.28	4.6 MB	6.6%	1.30
Jun 8 01:00:00 - 01:59:59	1012	4.8%	0.28	4.9 MB	7.2%	1.40
Jun 8 02:00:00 - 02:59:59	632	3.0%	0.18	2.9 MB	4.2%	0.83
Jun 8 03:00:00 - 03:59:59	345	1.6%	0.10	1.1 MB	1.6%	0.31
Jun 8 04:00:00 - 04:15:00	67	0.3%	0.07	292.3 KB	0.4%	0.32
TOTAL: 24:00:00	21006	100.0%	0.24	68.7 MB	100.0%	0.81

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1966	150	0	1816
2	newsfeed.neva.ru	1561	134	1	1426
3	feeder.eternal-september.org	656	28	0	628
4	news-out.mixmin.net	600	0	0	600
5	newsfeed.fu-berlin.de	543	32	0	511
6	csiph-out.news.weretis.net	416	174	0	242
7	news.fcku.it	146	6	0	140
8	news-out.aioe.org	81	70	0	11
9	news.redatomik.org	61	0	0	61
10	news.swapon.de	24	0	0	24
11	nntp.pasdenom.info	23	10	0	13
12	newsfeeds.xmission.com	16	4	0	12
13	news.freedyn.net	9	0	0	9
TOTAL: 13		6102	608	1	5493

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	41
it.annunci.commerciali	39
mozilla.support.thunderbird	37
mozilla.support.firefox	34
lada.auto	33
gmane.comp.gis.openstreetmap.tagging	32
it.annunci.varie	31
it-alt.sport.calcio.juventus	31
mpc.lists.freebsd.ports.bugs	27
spline.eisfair	25
it.annunci.immobiliari	20
mpc.lists.nanog	17
alt.politics.usa	16
alt.religion	12
alt.politics	11
lada.commerce	9
oesterreich.tratsch	9
local.spam.fr	9
gmane.comp.gis.openstreetmap.legal	8
alt.english.usage	8
TOTAL: 105	608

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3868
EMP (phn path)	351
EMP (phl)	125
EMP (phn nph)	51
Too many newsgroups	44
User-issued cancel	40
HTML Multipart	30
Binary Payload	16
User-issued spam cancel	12
Scoring filter (11)	12
Scoring filter (10)	11
Binary: misplaced par2	9
Scoring filter (13)	5
Scoring filter (9)	3
Too many newsgroups (low_xpost)	2
Too many newsgroups (meow)	2
Scoring filter (16)	1
HTML post	1
Binary: misplaced 003	1
Scoring filter (8)	1
TOTAL: 22	4587

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	49	0	57	57
TOTAL: 1	49	29	57	57

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	44
	TOTAL: 1	44
Huge articles
	csiph-out.feeder.erje.net	159
	csiph-out.news.weretis.net	94
	newsfeeds.xmission.com	9
	news.swapon.de	8
	feeder.eternal-september.org	3
	news.fcku.it	1
	news-out.mixmin.net	1
	TOTAL: 7	275
Including strange strings
	newsfeed.fu-berlin.de	459
	news.redatomik.org	40
	news-out.mixmin.net	33
	news.swapon.de	16
	csiph-out.feeder.erje.net	11
	news-out.aioe.org	9
	csiph-out.news.weretis.net	8
	feeder.eternal-september.org	3
	newsfeeds.xmission.com	2
	newsfeed.neva.ru	2
	TOTAL: 11	584
TOTAL: 3		903

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	erje	23358	1082	16584	51	0	4%	23:50:02
2	news.freedyn.net	22134	688	20249	6	0	3%	23:50:28
3	xanadu-bbs	23218	618	20349	2	0	2%	23:52:02
4	fu-berlin.de	19516	502	18995	0	54	2%	23:57:33
5	news.bbs.nz	37616	202	20238	9	0	0%	23:50:01
6	usenet.pasdenom.info	22290	191	19807	894	3	0%	23:50:52
7	aioe	18124	29	17262	1	0	0%	23:57:13
8	weretis.net	16441	16	15929	7	0	0%	23:50:02
9	xmission	22232	8	18485	0	0	0%	23:55:53
10	eternal-september	18397	6	17453	1	0	0%	23:50:01
11	neva.ru	19037	6	18706	147	0	0%	23:55:00
12	news.mixmin.net	19133	2	18582	0	0	0%	23:50:01
13	news.redatomik.org	19283	1	18543	0	0	0%	23:58:38
14	news.swapon.de	1765	0	1733	0	0	0%	23:56:25
15	news.fcku.it	2045	0	2032	0	0	0%	22:19:47
TOTAL: 15		284589	3351	244947	1118	57	1%	356:43:58

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	6.4 MB	26.5 KB	6.4 MB	0.1 KB/s	9.4 KB	23:50:28
2	xanadu-bbs	6.1 MB	3.6 KB	6.1 MB	0.1 KB/s	10.1 KB	23:52:02
3	fu-berlin.de	5.8 MB	0.0 KB	5.8 MB	0.1 KB/s	11.9 KB	23:57:33
4	erje	3.0 MB	249.6 KB	3.2 MB	0.0 KB/s	2.9 KB	23:50:02
5	usenet.pasdenom.info	572.6 KB	6.4 MB	6.9 MB	0.1 KB/s	6.6 KB	23:50:52
6	news.bbs.nz	501.3 KB	28.8 KB	530.2 KB	0.0 KB/s	2.5 KB	23:50:01
7	aioe	63.6 KB	1.9 KB	65.5 KB	0.0 KB/s	2.2 KB	23:57:13
8	weretis.net	41.1 KB	20.9 KB	62.0 KB	0.0 KB/s	2.7 KB	23:50:02
9	eternal-september	29.7 KB	6.3 KB	36.0 KB	0.0 KB/s	5.1 KB	23:50:01
10	xmission	17.1 KB	0.0 KB	17.1 KB	0.0 KB/s	2.1 KB	23:55:53
11	neva.ru	15.4 KB	368.8 KB	384.2 KB	0.0 KB/s	2.5 KB	23:55:00
12	news.mixmin.net	7.7 KB	0.0 KB	7.7 KB	0.0 KB/s	3.8 KB	23:50:01
13	news.redatomik.org	5.6 KB	0.0 KB	5.6 KB	0.0 KB/s	5.6 KB	23:58:38
14	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:56:25
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:19:47
TOTAL: 15		22.5 MB	7.1 MB	29.6 MB	0.0 KB/s	6.8 KB	356:43:58

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp130-01-70-49-71-241.dsl.bell.ca	1250	155	450.3 KB	112	01:59:17
2	208-71-239-109.cust.centrio.cz	2	6	20.5 KB	2	00:04:16
3	challenger.nielsenmedia.com	4	4	9.0 KB	4	01:13:34
TOTAL: 3		1256	165	479.8 KB	118	14:45:02

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	1250	155	450.3 KB	112	01:59:17
2	*.cust.centrio.cz	2	6	20.5 KB	2	00:04:16
3	*.nielsenmedia.com	4	4	9.0 KB	4	01:13:34
4	*.19-1.cable.virginm.net	1	0	0.0 KB	0	00:30:00
5	*.upc-a.chello.nl	48	0	0.0 KB	0	07:48:31
6	*.dip0.t-ipconnect.de	1	0	0.0 KB	0	00:00:05
7	unresolved	48	0	0.0 KB	0	00:38:33
8	*.ph.ph.cox.net	5	0	0.0 KB	0	02:30:42
TOTAL: 8		1359	165	479.8 KB	118	14:45:02

NNRP auth users [Top 20]:

User	Conn
ctomczyk	2
TOTAL: 1	2

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	3.407	0.675	0.000	07:48:31
ip72-222-200-117.ph.ph.cox.net	0.436	0.125	0.000	02:30:42
mtrlpq2314w-lp130-01-70-49-71-241.dsl.bell.ca	125.803	18.750	0.000	01:59:17
challenger.nielsenmedia.com	0.481	0.060	0.000	01:13:34
141.168.117.108	5.440	1.051	0.000	00:38:33
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	0.085	0.008	0.000	00:30:00
208-71-239-109.cust.centrio.cz	0.188	0.022	0.008	00:04:16
p2e5b54a7.dip0.t-ipconnect.de	0.086	0.035	0.000	00:00:05
TOTAL: 8	135.926	20.726	0.008	14:45:02

Curious NNRP server explorers [Top 20]:

System	Conn
a131033.upc-a.chello.nl	48
141.168.117.108	48
ip72-222-200-117.ph.ph.cox.net	5
p2e5b54a7.dip0.t-ipconnect.de	1
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1
TOTAL: 5	103

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	5	0
challenger.nielsenmedia.com	2	0
cpc116472-smal17-2-0-cust454.19-1.cable.virginm.net	1	0
TOTAL: 3	8	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	44	26.7%
2	uk	38	23.0%
3	comp	38	23.0%
4	perl	16	9.7%
5	rec	11	6.7%
6	fr	10	6.1%
7	talk	2	1.2%
8	sci	2	1.2%
9	or	2	1.2%
10	aus	1	0.6%
11	soc	1	0.6%
TOTAL: 11		165	100.0%

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

Newsgroup		Count
1	alt.comp.os.windows-10	21
2	uk.legal.moderated	15
3	perl.cpan.uploads	15
4	uk.legal	10
5	comp.lang.python	10
6	comp.os.linux.advocacy	8
7	alt.os.linux.ubuntu	7
8	uk.d-i-y	6
9	comp.lang.javascript	6
10	rec.boats	6
11	fr.comp.os.ms-windows	5
12	comp.lang.xharbour	4
13	alt.os.linux.mint	4
14	comp.lang.awk	4
15	alt.os.linux.mageia	3
16	uk.media.radio.archers	3
17	alt.sports.baseball.wash-nationals	3
18	alt.hvac	2
19	comp.sys.raspberry-pi	2
20	or.politics	2
21	comp.mobile.android	2
22	rec.food.cooking	2
23	talk.politics.guns	2
24	fr.sci.zetetique	2
25	alt.home.repair	2
26	rec.arts.tv	1
27	comp.databases.mysql	1
28	rec.arts.tv.uk.coronation-st	1
29	fr.misc.finance	1
30	comp.sys.mac.apps	1
31	fr.comp.sys.atari	1
32	alt.fan.rush-limbaugh	1
33	rec.gardens.edible	1
34	soc.retirement	1
35	perl.modules	1
36	fr.usenet.forums.evolution	1
37	aus.legal	1
38	sci.electronics.repair	1
39	sci.physics	1
40	uk.tech.digital-tv	1
41	uk.radio.amateur	1
42	uk.politics.misc	1
43	alt.usage.english	1
44	uk.telecom.broadband	1
TOTAL: 44		165

Daily Usenet report for csiph.com

Jun 7 04:15:00 -- Jun 8 04:15:00