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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	39251	48.6%	4.5 MB	38.0%
inn	25266	31.3%	5.2 MB	44.0%
innd	13290	16.5%	1.7 MB	13.9%
innfeed	2885	3.6%	493.8 KB	4.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	80693	100.0%	11.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	299445	56.2%
Negative hits	208865	39.2%
Do not exist	24538	4.6%
Cache misses	327	0.1%
TOTAL: 4	533175	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.156	0.0%	21	1.000	7.429	22.000
article cleanup	00:00:00.194	0.0%	24422	0.000	0.008	0.034
article logging	00:00:00.419	0.0%	24902	0.000	0.017	0.060
article parse	00:00:01.158	0.0%	78295	0.000	0.015	0.042
article write	00:00:54.173	0.1%	18229	0.163	2.972	124.391
artlog/artcncl	00:00:00.001	0.0%	21	0.000	0.048	0.125
artlog/artparse	00:00:00.008	0.0%	393	0.000	0.020	0.222
data move	00:00:00.203	0.0%	520507	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.005	0.0%	21	0.000	0.238	1.000
hishave/artcncl	00:00:00.002	0.0%	21	0.000	0.095	0.400
hishave/artparse	00:00:00.001	0.0%	392	0.000	0.003	0.042
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.394	0.0%	538065	0.003	0.008	0.072
history sync	00:00:00.612	0.0%	383	0.000	1.598	5.000
history write	00:00:09.635	0.0%	24411	0.061	0.395	1.856
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.156	0.0%	392	0.000	0.398	3.000
idle	23:57:38.948	99.8%	533937	84.348	161.553	492.677
nntp read	00:00:03.314	0.0%	529744	0.002	0.006	0.120
overview write	00:00:25.544	0.0%	18229	0.121	1.401	38.395
perl filter	00:00:45.644	0.1%	24406	1.365	1.870	2.864
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.333	0.0%	36458	0.000	0.009	0.036
TOTAL: 24:01:11.605	24:00:04.900	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.055	0.0%	18306	0.000	0.003	0.031
article prepare	00:00:00.000	0.0%	13656	0.000	0.000	0.000
article read	00:00:01.330	0.0%	1475	0.000	0.902	45.167
backlog stats	00:00:00.214	0.0%	342865	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.846	0.0%	261987	0.002	0.007	0.014
data write	00:00:01.609	0.0%	246643	0.001	0.007	0.015
idle	23:54:18.374	100.0%	342865	130.358	250.998	746.294
status file	00:00:00.814	0.0%	257	0.000	3.167	39.250
TOTAL: 23:54:33.574	23:54:24.242	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	28:51:58.859	99.6%	44694	0.000	2325.119	600182.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.583	0.0%	90439	0.000	0.006	0.438
readart	00:01:58.241	0.1%	11252	0.000	10.508	81.000
TOTAL: 28:59:29.758	28:53:57.683	99.7%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	6	37672	4925	32115	632	13%	48:20:58
2	feeder.eternal-september.org	4	22204	2281	19510	413	10%	27:02:54
3	news-out.mixmin.net	3	19125	2167	16052	906	11%	24:08:34
4	csiph-out.feeder.erje.net	1440	94990	1922	91725	1343	2%	118:42:40
5	newsfeeds.xmission.com	2	17170	1727	15435	8	10%	23:55:51
6	news-out.aioe.org	2	18289	1694	16526	69	9%	24:09:02
7	newsfeed.neva.ru	138	24928	1112	20927	2889	4%	71:26:25
8	newsfeed.fu-berlin.de	12	19159	986	17931	242	5%	28:25:33
9	news.redatomik.org	3	17638	842	16728	68	4%	24:08:51
10	news.fcku.it	12	2091	363	1726	2	17%	21:44:18
11	news.swapon.de	5	1468	52	1416	0	3%	24:05:36
12	news.freedyn.net	1	18616	45	18520	51	0%	21:45:59
13	nntp.pasdenom.info	2	16752	23	16727	2	0%	23:58:48
14	localhost	31	5	5	0	0	100%	00:00:03
15	xanadu-bbs.net	21	522	0	521	1	0%	19:19:03
16	news.bbs.nz	1	17443	0	17443	0	0%	23:59:52
TOTAL: 16		1683	328072	18144	303302	6626	5%	525:14:27

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	14.3 MB	8.1 KB	14.4 MB	28.8 MB	49%	5.3 KB
2	csiph-out.feeder.erje.net	10.5 MB	0.0 KB	14.0 MB	24.6 MB	42%	7.7 KB
3	news-out.mixmin.net	6.5 MB	0.0 KB	2.2 MB	8.7 MB	74%	2.9 KB
4	feeder.eternal-september.org	6.1 MB	2.3 KB	3.0 MB	9.1 MB	67%	3.5 KB
5	newsfeeds.xmission.com	5.0 MB	0.0 KB	403.2 KB	5.4 MB	92%	3.2 KB
6	news-out.aioe.org	4.3 MB	10.3 KB	467.9 KB	4.7 MB	90%	2.8 KB
7	newsfeed.neva.ru	3.1 MB	7.1 KB	29.4 MB	32.6 MB	9%	8.3 KB
8	news.redatomik.org	2.5 MB	0.0 KB	1.5 MB	4.0 MB	62%	4.5 KB
9	newsfeed.fu-berlin.de	2.4 MB	0.0 KB	673.2 KB	3.1 MB	78%	2.6 KB
10	news.fcku.it	613.7 KB	0.0 KB	12.9 KB	626.6 KB	97%	1.7 KB
11	news.freedyn.net	212.5 KB	0.0 KB	2.3 MB	2.5 MB	8%	27.1 KB
12	news.swapon.de	140.6 KB	0.0 KB	0.0 KB	140.6 KB	100%	2.7 KB
13	nntp.pasdenom.info	49.4 KB	0.0 KB	7.4 KB	56.8 KB	86%	2.3 KB
14	localhost	4.8 KB	0.0 KB	0.0 KB	4.8 KB	100%	1.0 KB
15	xanadu-bbs.net	0.0 KB	0.0 KB	2.9 KB	2.9 KB	0%	2.9 KB
16	news.bbs.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		55.9 MB	27.8 KB	68.4 MB	124.3 MB	44%	5.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 5 04:15:00 - 04:59:59	219	1.2%	0.08	643.2 KB	1.1%	0.24
Dec 5 05:00:00 - 05:59:59	387	2.1%	0.11	1.6 MB	2.9%	0.47
Dec 5 06:00:00 - 06:59:59	474	2.6%	0.13	1.7 MB	3.0%	0.48
Dec 5 07:00:00 - 07:59:59	621	3.4%	0.17	2.4 MB	4.3%	0.69
Dec 5 08:00:00 - 08:59:59	666	3.7%	0.18	2.0 MB	3.6%	0.57
Dec 5 09:00:00 - 09:59:59	724	4.0%	0.20	2.2 MB	4.0%	0.64
Dec 5 10:00:00 - 10:59:59	805	4.4%	0.22	2.5 MB	4.5%	0.71
Dec 5 11:00:00 - 11:59:59	846	4.6%	0.23	2.5 MB	4.5%	0.72
Dec 5 12:00:00 - 12:59:59	808	4.4%	0.22	2.6 MB	4.5%	0.73
Dec 5 13:00:00 - 13:59:59	936	5.1%	0.26	2.5 MB	4.4%	0.70
Dec 5 14:00:00 - 14:59:59	965	5.3%	0.27	2.6 MB	4.7%	0.75
Dec 5 15:00:00 - 15:59:59	1192	6.5%	0.33	4.5 MB	8.0%	1.28
Dec 5 16:00:00 - 16:59:59	1131	6.2%	0.31	3.2 MB	5.7%	0.92
Dec 5 17:00:00 - 17:59:59	1141	6.3%	0.32	3.3 MB	5.9%	0.94
Dec 5 18:00:00 - 18:59:59	1045	5.7%	0.29	3.0 MB	5.4%	0.86
Dec 5 19:00:00 - 19:59:59	1064	5.8%	0.30	3.1 MB	5.5%	0.89
Dec 5 20:00:00 - 20:59:59	1073	5.9%	0.30	3.0 MB	5.3%	0.84
Dec 5 21:00:00 - 21:59:59	965	5.3%	0.27	2.9 MB	5.2%	0.82
Dec 5 22:00:00 - 22:59:59	787	4.3%	0.22	2.1 MB	3.8%	0.60
Dec 5 23:00:00 - 23:59:59	610	3.3%	0.17	2.1 MB	3.7%	0.59
Dec 6 00:00:00 - 00:59:59	503	2.8%	0.14	1.6 MB	2.8%	0.44
Dec 6 01:00:00 - 01:59:59	420	2.3%	0.12	1.4 MB	2.5%	0.39
Dec 6 02:00:00 - 02:59:59	372	2.0%	0.10	1.1 MB	1.9%	0.31
Dec 6 03:00:00 - 03:59:59	369	2.0%	0.10	1.4 MB	2.4%	0.39
Dec 6 04:00:00 - 04:15:00	92	0.5%	0.10	292.2 KB	0.5%	0.32
TOTAL: 24:00:00	18215	100.0%	0.21	56.2 MB	100.0%	0.67

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	2896	137	2	2757
2	csiph-out.feeder.erje.net	1353	76	0	1277
3	news-out.mixmin.net	932	1	0	931
4	newsfeed.fu-berlin.de	635	22	0	613
5	csiph-out.news.weretis.net	621	198	3	420
6	feeder.eternal-september.org	379	46	1	332
7	news.redatomik.org	77	0	1	76
8	news-out.aioe.org	59	49	3	7
9	news.freedyn.net	52	1	0	51
10	news.swapon.de	12	0	0	12
11	newsfeeds.xmission.com	9	3	1	5
12	nntp.pasdenom.info	2	1	0	1
13	news.fcku.it	2	1	0	1
14	news.bbs.nz	1	0	1	0
TOTAL: 14		7030	535	12	6483

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	73
gmane.comp.gis.openstreetmap.tagging	61
gmane.linux.kernel	39
alt.survival	32
alt.bbs.synchronet	28
gmane.linux.alsa.devel	20
lada.auto	19
alt.music.pink-floyd.publius	16
mozilla.dev.security.policy	14
alt.politics	14
spline.eisfair	13
lada.photo	12
alt.job	11
alt.hack.nl	11
it-alt.sport.calcio.juventus	10
oesterreich.tratsch	10
alt.windows7.general	9
alt.philosophy	9
lada.commerce	9
mozilla.support.thunderbird	9
TOTAL: 85	535

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	4254
Binary: misplaced rar	641
EMP (phn path)	381
Too many newsgroups	90
User-issued cancel	75
EMP (phn nph)	47
Binary: misplaced par2	22
EMP (phl)	17
HTML Multipart	16
Scoring filter (8)	16
Binary Payload	12
Scoring filter (9)	8
Scoring filter (11)	7
Scoring filter (10)	6
Scoring filter (12)	4
Too many newsgroups (low_xpost)	4
U2 violation - invalid distribution	1
Scoring filter (14)	1
Scoring filter (13)	1
Scoring filter (18)	1
TOTAL: 20	5604

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	3
	TOTAL: 1	3
Bad Message-ID's offered
	csiph-out.feeder.erje.net	65
	TOTAL: 1	65
Huge articles
	csiph-out.feeder.erje.net	185
	csiph-out.news.weretis.net	151
	feeder.eternal-september.org	15
	news.redatomik.org	15
	news.freedyn.net	14
	news-out.mixmin.net	8
	newsfeeds.xmission.com	5
	newsfeed.fu-berlin.de	2
	TOTAL: 8	395
Including strange strings
	newsfeed.fu-berlin.de	400
	news-out.mixmin.net	32
	news.swapon.de	12
	csiph-out.news.weretis.net	10
	csiph-out.feeder.erje.net	9
	news.redatomik.org	8
	news-out.aioe.org	4
	feeder.eternal-september.org	2
	newsfeed.neva.ru	2
	TOTAL: 9	479
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 5		943

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	18833	682	17473	5	0	3%	23:59:25
2	xanadu-bbs	20100	639	17548	0	2	3%	23:54:47
3	fu-berlin.de	17080	569	16511	0	0	3%	24:00:02
4	news.bbs.nz	34601	139	17522	10	2	0%	24:08:27
5	usenet.pasdenom.info	19069	91	16997	1105	104	0%	23:59:47
6	aioe	15777	10	15118	1	0	0%	24:00:36
7	weretis.net	12812	8	12403	5	5	0%	24:00:06
8	xmission	20653	7	15788	3	0	0%	24:05:44
9	news.swapon.de	1550	5	1518	0	0	0%	23:43:50
10	neva.ru	16399	5	16141	107	0	0%	23:56:01
11	news.mixmin.net	15746	5	15283	0	0	0%	24:00:02
12	eternal-september	15890	4	15162	0	0	0%	24:00:13
13	news.redatomik.org	17429	4	16779	0	4	0%	24:00:02
14	erje	16590	2	16202	10	0	0%	23:54:36
15	news.fcku.it	1694	0	1688	0	0	0%	21:26:59
TOTAL: 15		244223	2170	212133	1246	117	0%	357:10:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	6.9 MB	42.3 KB	7.0 MB	0.1 KB/s	10.4 KB	23:59:25
2	xanadu-bbs	6.7 MB	0.0 KB	6.7 MB	0.1 KB/s	10.8 KB	23:54:47
3	fu-berlin.de	6.6 MB	0.0 KB	6.6 MB	0.1 KB/s	11.8 KB	24:00:02
4	news.bbs.nz	395.0 KB	21.0 KB	416.1 KB	0.0 KB/s	2.8 KB	24:08:27
5	usenet.pasdenom.info	227.2 KB	7.5 MB	7.7 MB	0.1 KB/s	6.6 KB	23:59:47
6	aioe	20.2 KB	21.9 KB	42.1 KB	0.0 KB/s	3.8 KB	24:00:36
7	weretis.net	13.9 KB	12.0 KB	25.9 KB	0.0 KB/s	2.0 KB	24:00:06
8	xmission	10.4 KB	16.2 KB	26.6 KB	0.0 KB/s	2.7 KB	24:05:44
9	neva.ru	8.0 KB	235.9 KB	243.9 KB	0.0 KB/s	2.2 KB	23:56:01
10	news.swapon.de	4.8 KB	0.0 KB	4.8 KB	0.0 KB/s	1.0 KB	23:43:50
11	news.mixmin.net	4.8 KB	0.0 KB	4.8 KB	0.0 KB/s	1.0 KB	24:00:02
12	eternal-september	3.9 KB	0.0 KB	3.9 KB	0.0 KB/s	1.0 KB	24:00:13
13	news.redatomik.org	3.9 KB	0.0 KB	3.9 KB	0.0 KB/s	1.0 KB	24:00:02
14	erje	1.9 KB	57.2 KB	59.2 KB	0.0 KB/s	4.9 KB	23:54:36
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:26:59
TOTAL: 15		20.9 MB	7.9 MB	28.8 MB	0.0 KB/s	8.6 KB	357:10:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp140-04-70-53-247-41.dsl.bell.ca	4500	456	1.4 MB	214	0	0	07:17:56
2	ip72-222-200-117.ph.ph.cox.net	7	17	23.0 KB	2	0	0	02:31:23
3	a131033.upc-a.chello.nl	29	6	6.0 KB	5	0	0	08:34:06
4	71-90-72-193.dhcp.ftbg.wi.charter.com	27	6	6.0 KB	6	5	4	08:41:38
5	challenger.nielsenmedia.com	4	1	2.7 KB	1	0	0	01:53:35
TOTAL: 5		4567	486	1.4 MB	228	5	4	28:58:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	4500	456	1.4 MB	214	0	0	07:17:56
2	*.ph.ph.cox.net	7	17	23.0 KB	2	0	0	02:31:23
3	*.upc-a.chello.nl	29	6	6.0 KB	5	0	0	08:34:06
4	*.dhcp.ftbg.wi.charter.com	27	6	6.0 KB	6	5	4	08:41:38
5	*.nielsenmedia.com	4	1	2.7 KB	1	0	0	01:53:35
6	*.compute-1.amazonaws.com	1	0	0.0 KB	0	0	0	00:00:00
TOTAL: 6		4568	486	1.4 MB	228	5	4	28:58:40

NNRP auth users [Top 20]:

User	Conn
ohlandl	4
TOTAL: 1	4

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
71-90-72-193.dhcp.ftbg.wi.charter.com	2.333	0.467	0.013	08:41:38
a131033.upc-a.chello.nl	2.544	0.463	0.000	08:34:06
mtrlpq2314w-lp140-04-70-53-247-41.dsl.bell.ca	357.396	59.316	0.000	07:17:56
ip72-222-200-117.ph.ph.cox.net	0.669	0.080	0.000	02:31:23
challenger.nielsenmedia.com	0.372	0.045	0.000	01:53:35
ec2-54-87-44-94.compute-1.amazonaws.com	0.052	0.009	0.000	00:00:00
TOTAL: 6	363.366	60.380	0.013	28:58:40

Curious NNRP server explorers [Top 20]:

System	Conn
ec2-54-87-44-94.compute-1.amazonaws.com	1
TOTAL: 1	1

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-90-72-193.dhcp.ftbg.wi.charter.com	11	0
ip72-222-200-117.ph.ph.cox.net	4	0
challenger.nielsenmedia.com	3	0
TOTAL: 3	18	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	137	28.2%
2	uk	86	17.7%
3	rec	75	15.4%
4	comp	60	12.3%
5	soc	35	7.2%
6	fr	31	6.4%
7	sci	25	5.1%
8	perl	10	2.1%
9	talk	9	1.9%
10	aus	7	1.4%
11	misc	3	0.6%
12	relcom	3	0.6%
13	scot	2	0.4%
14	seattle	1	0.2%
15	or	1	0.2%
16	can	1	0.2%
TOTAL: 16		486	100.0%

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

Newsgroup		Count
1	alt.comp.os.windows-10	52
2	comp.sys.ibm.ps2.hardware	29
3	uk.legal.moderated	21
4	alt.comp.freeware	21
5	rec.arts.drwho	16
6	fr.soc.politique	11
7	alt.home.repair	8
8	alt.bible.prophecy	7
9	uk.legal	6
10	uk.d-i-y	6
11	uk.politics.misc	5
12	sci.physics.relativity	5
13	alt.os.linux.mint	5
14	uk.railway	5
15	rec.arts.tv	5
16	alt.os.linux.ubuntu	5
17	talk.origins	4
18	comp.mobile.android	4
19	uk.telecom	4
20	soc.genealogy.jewish	4
21	uk.transport.london	4
22	uk.religion.christian	4
23	rec.gambling.poker	4
24	uk.sport.cricket	4
25	aus.politics	4
26	soc.history	4
27	alt.usage.english	4
28	alt.russian.z1	4
29	rec.boats	4
30	uk.current-events.terrorism	4
31	rec.autos.sport.f1	4
32	soc.retirement	4
33	talk.politics.guns	4
34	sci.lang	3
35	soc.culture.brazil	3
36	soc.culture.indian	3
37	soc.culture.usa	3
38	uk.people.silversurfers	3
39	fr.sci.physique	3
40	rec.sport.tennis	3
41	rec.sport.pro-wrestling	3
42	soc.penpals	3
43	uk.media.radio.archers	3
44	sci.med.pharmacy	3
45	rec.food.cooking	3
46	uk.rec.sheds	3
47	perl.cpan.uploads	3
48	uk.sci.weather	3
49	comp.lang.python	3
50	relcom.wheels	3
51	fr.rec.sport.football	2
52	alt.suicide.methods	2
53	soc.culture.china	2
54	rec.bicycles.tech	2
55	rec.sport.cricket	2
56	sci.astro.amateur	2
57	comp.mobile.ipad	2
58	perl.daily-build.reports	2
59	alt.os.development	2
60	sci.space.policy	2
61	comp.lang.forth	2
62	comp.sys.mac.advocacy	2
63	aus.cars	2
64	sci.physics	2
65	fr.soc.environnement	2
66	soc.culture.israel	2
67	fr.soc.economie	2
68	rec.sport.football.college	2
69	alt.support.depression	2
70	rec.arts.sf.fandom	2
71	fr.rec.moto	2
72	alt.jobs	2
73	comp.ai.philosophy	2
74	sci.math.num-analysis	2
75	rec.arts.comics.strips	2
76	scot.politics	2
77	comp.arch.fpga	2
78	comp.sys.mac.system	2
79	misc.news.internet.discuss	2
80	sci.electronics.design	2
81	rec.radio.amateur.dx	2
82	sci.math	2
83	rec.arts.comics.creative	2
84	perl.perl5.porters	2
85	fr.misc.finance	2
86	rec.music.classical.recordings	2
87	alt.support.schizophrenia	2
88	perl.perl5.changes	2
89	rec.games.pinball	2
90	alt.fan.rush-limbaugh	2
91	rec.arts.tv.soaps.cbs	2
92	rec.arts.sf.written	2
93	comp.theory	2
94	rec.music.rock-pop-r+b.1950s	2
95	rec.arts.disney.parks	2
96	soc.culture.jewish	2
97	alt.arts.poetry.comments	1
98	uk.rec.cars.maintenance	1
99	seattle.politics	1
100	uk.tech.broadcast	1
TOTAL: 164		486

Daily Usenet report for csiph.com

Dec 5 04:15:00 -- Dec 6 04:15:00