Daily Usenet report for csiph.com: May 27 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23395	40.6%	5.0 MB	55.7%
nnrpd	20723	36.0%	2.1 MB	24.1%
innd	10483	18.2%	1.3 MB	14.4%
innfeed	2884	5.0%	512.3 KB	5.6%
nocem	92	0.2%	9.8 KB	0.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	57578	100.0%	8.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	274099	55.3%
Negative hits	198553	40.1%
Do not exist	22473	4.5%
Cache misses	294	0.1%
TOTAL: 4	495419	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.659	0.0%	209	0.000	7.938	168.500
article cleanup	00:00:00.131	0.0%	22374	0.000	0.006	0.033
article logging	00:00:00.392	0.0%	22993	0.000	0.017	0.159
article parse	00:00:00.889	0.0%	56127	0.000	0.016	0.098
article write	00:00:42.545	0.0%	17661	0.257	2.409	32.048
artlog/artcncl	00:00:00.002	0.0%	167	0.000	0.012	0.100
artlog/artparse	00:00:00.006	0.0%	239	0.000	0.025	1.000
data move	00:00:00.132	0.0%	477199	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.027	0.0%	207	0.000	0.130	3.000
hishave/artcncl	00:00:00.008	0.0%	209	0.000	0.038	0.625
hishave/artparse	00:00:00.000	0.0%	236	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:19.477	0.0%	498399	0.002	0.039	0.302
history sync	00:00:00.999	0.0%	374	0.000	2.671	11.000
history write	00:00:30.735	0.0%	22373	0.218	1.374	9.756
hiswrite/artcncl	00:00:00.001	0.0%	2	0.000	0.500	1.000
hiswrite/artparse	00:00:00.198	0.0%	236	0.000	0.839	4.333
idle	23:52:48.947	99.4%	482718	98.066	178.094	600.471
nntp read	00:00:02.247	0.0%	484124	0.001	0.005	0.011
overview write	00:05:10.274	0.4%	17661	0.374	17.568	7391.730
perl filter	00:00:40.277	0.0%	22370	1.285	1.800	2.911
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.320	0.0%	35405	0.000	0.009	0.032
TOTAL: 24:01:01.024	24:00:19.266	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.027	0.0%	17633	0.000	0.002	0.017
article prepare	00:00:00.002	0.0%	15900	0.000	0.000	0.016
article read	00:00:00.498	0.0%	2194	0.000	0.227	19.000
backlog stats	00:00:00.173	0.0%	318967	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.481	0.0%	239196	0.001	0.006	0.012
data write	00:00:01.415	0.0%	223617	0.001	0.006	0.014
idle	23:54:46.093	100.0%	318967	162.604	269.890	907.749
status file	00:00:00.285	0.0%	254	0.000	1.122	79.000
TOTAL: 23:54:57.334	23:54:49.974	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	20:35:15.727	99.8%	40355	96.071	1836.593	600157.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.464	0.0%	81489	0.000	0.006	0.250
readart	00:00:45.763	0.1%	8942	0.000	5.118	66.000
TOTAL: 20:37:44.446	20:36:01.954	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	3	36015	3749	32045	221	10%	48:39:45
2	csiph-out.feeder.erje.net	1152	76190	3147	71472	1571	4%	95:02:32
3	feeder.eternal-september.org	4	20621	2711	16971	939	13%	25:03:23
4	news.redatomik.org	1	16509	2551	13900	58	15%	24:49:20
5	newsfeeds.xmission.com	2	16891	1482	15405	4	8%	24:55:00
6	news-out.aioe.org	3	17067	1464	15569	34	8%	24:08:55
7	newsfeed.fu-berlin.de	9	13384	909	12333	142	6%	19:30:26
8	newsfeed.neva.ru	148	19481	775	17337	1369	3%	71:34:19
9	news-out.mixmin.net	2	18742	481	17846	415	2%	24:08:44
10	news.fcku.it	2	7513	378	7017	118	5%	23:59:14
11	news.swapon.de	3	1423	44	1379	0	3%	22:52:19
12	nntp.pasdenom.info	2	15672	33	15638	1	0%	23:59:12
13	news.freedyn.net	3	36844	15	36790	39	0%	48:12:58
14	news.bbs.nz	2	15887	3	15884	0	0%	23:59:20
15	localhost	35	0	0	0	0	0%	00:00:05
16	xanadu-bbs.net	11	76	0	76	0	0%	05:33:28
TOTAL: 16		1382	312315	17742	289662	4911	5%	506:29:00

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	13.6 MB	14.2 KB	11.4 MB	25.1 MB	54%	5.4 KB
2	csiph-out.news.weretis.net	12.0 MB	0.0 KB	3.6 MB	15.6 MB	76%	4.0 KB
3	feeder.eternal-september.org	7.0 MB	0.0 KB	3.1 MB	10.1 MB	69%	2.8 KB
4	news.redatomik.org	6.4 MB	2.6 KB	693.4 KB	7.1 MB	90%	2.8 KB
5	newsfeeds.xmission.com	4.2 MB	0.0 KB	183.5 KB	4.4 MB	95%	3.0 KB
6	news-out.aioe.org	3.7 MB	14.8 KB	150.2 KB	3.8 MB	95%	2.6 KB
7	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	379.3 KB	2.6 MB	85%	2.5 KB
8	newsfeed.neva.ru	2.1 MB	22.2 KB	4.0 MB	6.1 MB	34%	2.9 KB
9	news-out.mixmin.net	1.4 MB	0.0 KB	977.8 KB	2.4 MB	60%	2.7 KB
10	news.fcku.it	1.0 MB	0.0 KB	1.1 MB	2.1 MB	47%	4.4 KB
11	news.swapon.de	112.4 KB	0.0 KB	0.0 KB	112.4 KB	100%	2.6 KB
12	nntp.pasdenom.info	77.6 KB	0.0 KB	1.4 KB	79.0 KB	98%	2.3 KB
13	news.freedyn.net	53.5 KB	0.0 KB	231.8 KB	285.3 KB	18%	5.3 KB
14	news.bbs.nz	5.1 KB	0.0 KB	0.0 KB	5.1 KB	100%	1.7 KB
15	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
16	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		53.9 MB	53.8 KB	25.8 MB	79.8 MB	67%	3.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
May 27 04:15:00 - 04:59:59	240	1.4%	0.09	664.4 KB	1.2%	0.25
May 27 05:00:00 - 05:59:59	338	1.9%	0.09	1011.0 KB	1.8%	0.28
May 27 06:00:00 - 06:59:59	587	3.3%	0.16	1.8 MB	3.3%	0.51
May 27 07:00:00 - 07:59:59	676	3.8%	0.19	2.7 MB	5.1%	0.78
May 27 08:00:00 - 08:59:59	799	4.5%	0.22	2.6 MB	4.8%	0.73
May 27 09:00:00 - 09:59:59	851	4.8%	0.24	2.6 MB	4.9%	0.75
May 27 10:00:00 - 10:59:59	865	4.9%	0.24	3.2 MB	6.0%	0.91
May 27 11:00:00 - 11:59:59	734	4.2%	0.20	1.9 MB	3.6%	0.55
May 27 12:00:00 - 12:59:59	708	4.0%	0.20	2.3 MB	4.3%	0.65
May 27 13:00:00 - 13:59:59	842	4.8%	0.23	2.7 MB	5.0%	0.76
May 27 14:00:00 - 14:59:59	901	5.1%	0.25	2.6 MB	4.9%	0.75
May 27 15:00:00 - 15:59:59	928	5.3%	0.26	2.9 MB	5.4%	0.82
May 27 16:00:00 - 16:59:59	1009	5.7%	0.28	2.6 MB	4.8%	0.74
May 27 17:00:00 - 17:59:59	980	5.6%	0.27	2.6 MB	4.9%	0.75
May 27 18:00:00 - 18:59:59	1139	6.5%	0.32	3.2 MB	6.0%	0.91
May 27 19:00:00 - 19:59:59	1074	6.1%	0.30	2.8 MB	5.3%	0.80
May 27 20:00:00 - 20:59:59	1030	5.8%	0.29	3.2 MB	6.0%	0.92
May 27 21:00:00 - 21:59:59	851	4.8%	0.24	2.4 MB	4.4%	0.67
May 27 22:00:00 - 22:59:59	710	4.0%	0.20	2.1 MB	3.9%	0.59
May 27 23:00:00 - 23:59:59	510	2.9%	0.14	1.6 MB	2.9%	0.45
May 28 00:00:00 - 00:59:59	418	2.4%	0.12	1.5 MB	2.8%	0.43
May 28 01:00:00 - 01:59:59	483	2.7%	0.13	1.3 MB	2.4%	0.36
May 28 02:00:00 - 02:59:59	405	2.3%	0.11	1.4 MB	2.5%	0.39
May 28 03:00:00 - 03:59:59	422	2.4%	0.12	1.4 MB	2.5%	0.38
May 28 04:00:00 - 04:15:00	156	0.9%	0.17	763.8 KB	1.4%	0.85
TOTAL: 24:00:00	17656	100.0%	0.20	53.6 MB	100.0%	0.64

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1599	127	1	1471
2	newsfeed.neva.ru	1374	219	1	1154
3	feeder.eternal-september.org	947	34	0	913
4	newsfeed.fu-berlin.de	640	43	0	597
5	news-out.mixmin.net	425	1	0	424
6	csiph-out.news.weretis.net	234	107	0	127
7	news.redatomik.org	154	0	0	154
8	news.fcku.it	104	3	0	101
9	news-out.aioe.org	39	33	2	4
10	news.freedyn.net	37	0	0	37
11	news.swapon.de	14	0	0	14
12	newsfeeds.xmission.com	4	1	0	3
13	nntp.pasdenom.info	2	1	0	1
TOTAL: 13		5573	569	4	5000

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	164
fido7.ru.android	49
spline.eisfair	36
gmane.comp.gis.openstreetmap.tagging	28
it-alt.sport.calcio.juventus	25
mozilla.support.firefox	22
lada.auto	14
alt.windows7.general	13
mozilla.support.thunderbird	12
alt.math.undergrad	11
alt.pl.nieruchomosci.gielda	11
gmane.linux.alsa.devel	8
free.it.religioni.scientology	7
oesterreich.tratsch	7
alt.survival	7
mpc.lists.nanog	7
alt.politics	6
cakewalk.audio	6
alt.politics.usa	6
gmane.comp.gis.openstreetmap	5
TOTAL: 96	569

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3368
EMP (phn path)	450
EMP (phl)	105
Too many newsgroups	64
EMP (phn nph)	62
Binary Payload	22
Scoring filter (12)	15
HTML Multipart	14
Scoring filter (10)	9
User-issued cancel	8
Scoring filter (9)	7
Scoring filter (8)	5
Binary: misplaced par2	4
Scoring filter (13)	2
Too many newsgroups (meow)	2
Scoring filter (14)	2
User-issued spam cancel	1
Binary: non-binary distribution	1
TOTAL: 18	4141

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	47	0	48	48
TOTAL: 1	47	36	48	48

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	TOTAL: 1	4
Huge articles
	csiph-out.feeder.erje.net	149
	csiph-out.news.weretis.net	52
	news.fcku.it	11
	feeder.eternal-september.org	8
	news-out.mixmin.net	6
	news.redatomik.org	6
	newsfeeds.xmission.com	3
	news.freedyn.net	1
	TOTAL: 8	236
Including strange strings
	newsfeed.fu-berlin.de	462
	news.redatomik.org	96
	csiph-out.feeder.erje.net	28
	news.swapon.de	14
	csiph-out.news.weretis.net	8
	newsfeed.neva.ru	4
	news-out.aioe.org	4
	news-out.mixmin.net	2
	feeder.eternal-september.org	2
	TOTAL: 9	620
TOTAL: 3		860

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	18803	791	16850	5	0	4%	23:59:55
2	fu-berlin.de	16425	617	15808	0	0	3%	23:59:55
3	news.bbs.nz	32938	602	16396	12	3	1%	23:59:47
4	xanadu-bbs	4023	187	3346	0	14144	4%	23:59:55
5	usenet.pasdenom.info	18824	180	15967	1476	6	0%	23:59:53
6	aioe	15440	21	14523	0	0	0%	23:59:55
7	weretis.net	13374	10	12685	10	0	0%	23:59:55
8	eternal-september	14961	7	14118	0	0	0%	23:59:55
9	neva.ru	16294	5	15966	75	0	0%	23:59:55
10	erje	14949	4	14459	1	0	0%	23:59:55
11	xmission	19246	4	15407	1	1	0%	23:59:43
12	news.redatomik.org	15278	3	14464	0	0	0%	23:58:47
13	news.mixmin.net	17067	2	16447	0	0	0%	23:59:55
14	news.fcku.it	1493	0	1479	0	0	0%	22:21:15
15	news.swapon.de	1522	0	1489	0	0	0%	23:51:49
TOTAL: 15		220637	2433	189404	1580	14154	1%	358:10:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	6.8 MB	32.4 KB	6.8 MB	0.1 KB/s	8.8 KB	23:59:55
2	fu-berlin.de	6.2 MB	0.0 KB	6.2 MB	0.1 KB/s	10.4 KB	23:59:55
3	xanadu-bbs	2.2 MB	0.0 KB	2.2 MB	0.0 KB/s	12.1 KB	23:59:55
4	news.bbs.nz	1.6 MB	31.7 KB	1.6 MB	0.0 KB/s	2.7 KB	23:59:47
5	usenet.pasdenom.info	489.7 KB	7.6 MB	8.1 MB	0.1 KB/s	5.0 KB	23:59:53
6	aioe	48.5 KB	0.0 KB	48.5 KB	0.0 KB/s	2.3 KB	23:59:55
7	weretis.net	33.7 KB	39.9 KB	73.5 KB	0.0 KB/s	3.7 KB	23:59:55
8	erje	20.4 KB	3.1 KB	23.5 KB	0.0 KB/s	4.7 KB	23:59:55
9	eternal-september	17.4 KB	0.0 KB	17.4 KB	0.0 KB/s	2.5 KB	23:59:55
10	neva.ru	13.4 KB	204.9 KB	218.2 KB	0.0 KB/s	2.7 KB	23:59:55
11	news.redatomik.org	8.8 KB	0.0 KB	8.8 KB	0.0 KB/s	2.9 KB	23:58:47
12	xmission	5.9 KB	7.0 KB	13.0 KB	0.0 KB/s	2.6 KB	23:59:43
13	news.mixmin.net	2.0 KB	0.0 KB	2.0 KB	0.0 KB/s	1.0 KB	23:59:55
14	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:21:15
15	news.swapon.de	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:51:49
TOTAL: 15		17.5 MB	8.0 MB	25.4 MB	0.0 KB/s	6.5 KB	358:10:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp140-05-70-55-57-156.dsl.bell.ca	1100	230	621.7 KB	138	01:41:05
2	208-71-239-109.cust.centrio.cz	8	8	16.9 KB	5	01:11:01
3	a131033.upc-a.chello.nl	32	7	10.8 KB	3	07:07:30
4	ip72-222-200-117.ph.ph.cox.net	20	1	1.0 KB	1	07:00:18
5	66-188-80-147.dhcp.mdsn.wi.charter.com	11	1	1.8 KB	1	02:24:19
6	141.168.117.108	48	1	1.8 KB	1	00:42:53
TOTAL: 6		1219	248	654.1 KB	149	20:37:35

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	1100	230	621.7 KB	138	01:41:05
2	*.cust.centrio.cz	8	8	16.9 KB	5	01:11:01
3	*.upc-a.chello.nl	32	7	10.8 KB	3	07:07:30
4	*.dhcp.mdsn.wi.charter.com	11	1	1.8 KB	1	02:24:19
5	*.ph.ph.cox.net	20	1	1.0 KB	1	07:00:18
6	unresolved	49	1	1.8 KB	1	00:43:03
7	*.dip0.t-ipconnect.de	1	0	0.0 KB	0	00:00:03
8	*.nielsenmedia.com	1	0	0.0 KB	0	00:30:13
TOTAL: 8		1222	248	654.1 KB	149	20:37:35

NNRP auth users [Top 20]:

User	Conn
ctomczyk	8
TOTAL: 1	8

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	2.504	0.515	0.000	07:07:30
ip72-222-200-117.ph.ph.cox.net	1.641	0.443	0.000	07:00:18
66-188-80-147.dhcp.mdsn.wi.charter.com	0.759	0.176	0.000	02:24:19
mtrlpq2314w-lp140-05-70-55-57-156.dsl.bell.ca	100.016	15.363	0.000	01:41:05
208-71-239-109.cust.centrio.cz	0.661	0.153	0.024	01:11:01
141.168.117.108	5.073	0.992	0.000	00:42:53
challenger.nielsenmedia.com	0.056	0.008	0.000	00:30:13
107.170.247.162	0.081	0.024	0.000	00:00:09
p2e5b5b5b.dip0.t-ipconnect.de	0.156	0.008	0.000	00:00:03
TOTAL: 9	110.947	17.682	0.024	20:37:35

Curious NNRP server explorers [Top 20]:

System	Conn
107.170.247.162	1
p2e5b5b5b.dip0.t-ipconnect.de	1
challenger.nielsenmedia.com	1
TOTAL: 3	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
ip72-222-200-117.ph.ph.cox.net	9	0
66-188-80-147.dhcp.mdsn.wi.charter.com	3	0
208-71-239-109.cust.centrio.cz	2	0
challenger.nielsenmedia.com	1	0
TOTAL: 4	15	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	70	28.2%
2	uk	61	24.6%
3	comp	40	16.1%
4	aus	23	9.3%
5	rec	17	6.9%
6	us	13	5.2%
7	perl	10	4.0%
8	fr	6	2.4%
9	sci	4	1.6%
10	soc	2	0.8%
11	talk	1	0.4%
12	news	1	0.4%
TOTAL: 12		248	100.0%

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

Newsgroup		Count
1	alt.comp.os.windows-10	33
2	aus.cars	23
3	alt.home.repair	20
4	uk.legal.moderated	16
5	uk.legal	16
6	us.military.army	13
7	comp.sys.ibm.ps2.hardware	9
8	uk.media.radio.archers	9
9	comp.lang.javascript	8
10	perl.cpan.uploads	8
11	uk.d-i-y	7
12	comp.os.linux.advocacy	6
13	alt.usage.english	6
14	comp.lang.python	6
15	comp.mobile.android	4
16	rec.arts.tv	4
17	uk.rec.sheds	4
18	rec.autos.sport.f1	4
19	uk.music.charts	3
20	rec.boats	3
21	rec.arts.tv.uk.coronation-st	3
22	sci.physics	3
23	alt.os.linux.mageia	3
24	uk.railway	3
25	fr.rec.sport.football	2
26	alt.sports.basketball.nba.gs-warriors	2
27	alt.sports.baseball.wash-nationals	2
28	comp.lang.c	2
29	perl.daily-build.reports	2
30	rec.sport.tennis	2
31	comp.lang.xharbour	2
32	comp.misc	1
33	soc.culture.polish	1
34	rec.crafts.metalworking	1
35	uk.rec.cycling	1
36	uk.radio.amateur.moderated	1
37	fr.comp.sys.atari	1
38	sci.lang	1
39	alt.comp.freeware	1
40	news.admin.peering	1
41	comp.lang.fortran	1
42	uk.people.silversurfers	1
43	alt.atheism	1
44	comp.os.vms	1
45	fr.lettres.langue.anglaise	1
46	fr.sci.physique	1
47	fr.comp.os.ms-windows	1
48	alt.russian.z1	1
49	alt.california	1
50	talk.politics.misc	1
51	soc.retirement	1
TOTAL: 51		248

Daily Usenet report for csiph.com

May 27 04:15:00 -- May 28 04:15:00