Daily Usenet report for csiph.com: Apr 20 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	67420	48.1%	6.5 MB	36.4%
inn	43562	31.1%	8.1 MB	45.4%
innd	25951	18.5%	2.7 MB	15.2%
innfeed	3217	2.3%	537.1 KB	2.9%
nocem	75	0.1%	7.9 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	140226	100.0%	17.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	446361	55.9%
Negative hits	308326	38.6%
Do not exist	42594	5.3%
Cache misses	682	0.1%
TOTAL: 4	797963	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.195	0.0%	260	0.000	4.596	57.333
article cleanup	00:00:00.293	0.0%	42350	0.000	0.007	0.021
article logging	00:00:05.132	0.0%	42988	0.000	0.119	2.172
article parse	00:00:04.671	0.0%	146501	0.004	0.032	0.356
article write	00:02:34.487	0.2%	23176	0.176	6.666	36.125
artlog/artcncl	00:00:00.005	0.0%	199	0.000	0.025	0.154
artlog/artparse	00:00:00.054	0.0%	382	0.000	0.141	5.000
data move	00:00:00.315	0.0%	731048	0.000	0.000	0.004
hisgrep/artcncl	00:00:00.229	0.0%	259	0.000	0.884	8.167
hishave/artcncl	00:00:00.055	0.0%	260	0.000	0.212	7.667
hishave/artparse	00:00:00.001	0.0%	378	0.000	0.003	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:01.194	0.1%	798794	0.003	0.152	1.073
history sync	00:00:05.402	0.0%	360	0.000	15.006	89.667
history write	00:04:01.307	0.3%	42299	0.105	5.705	34.459
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:02.943	0.0%	378	0.000	7.786	46.000
idle	23:42:14.841	98.7%	714535	63.654	119.427	320.413
nntp read	00:00:03.351	0.0%	743812	0.002	0.005	0.008
overview write	00:06:16.691	0.4%	23176	1.434	16.253	714.547
perl filter	00:01:46.436	0.1%	42294	1.802	2.517	3.714
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.452	0.0%	46416	0.000	0.010	0.036
TOTAL: 24:00:54.324	23:59:19.054	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.036	0.0%	23189	0.000	0.002	0.017
article prepare	00:00:00.004	0.0%	23218	0.000	0.000	0.007
article read	00:00:01.108	0.0%	3510	0.000	0.316	8.750
backlog stats	00:00:00.237	0.0%	422531	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.191	0.0%	326860	0.003	0.007	0.011
data write	00:00:01.879	0.0%	311652	0.002	0.006	0.012
idle	23:53:04.673	100.0%	422531	123.367	203.499	547.385
status file	00:00:00.395	0.0%	279	0.000	1.416	16.000
TOTAL: 23:53:20.296	23:53:10.523	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	152:46:05.495	98.6%	4881156	79.000	112.671	600057.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:01:06.345	0.0%	11580303	0.000	0.006	1.500
readart	02:01:34.210	1.3%	4798809	0.000	1.520	178.000
TOTAL: 154:55:03.962	154:48:46.050	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1440	150548	7543	132901	10104	5%	118:51:19
2	csiph-out.news.weretis.net	4	51746	4793	45847	1106	9%	52:44:24
3	feeder.eternal-september.org	8	39272	3067	30903	5302	7%	26:04:54
4	news-out.mixmin.net	3	24659	1936	22343	380	7%	24:08:35
5	newsfeed.neva.ru	148	54760	1470	50948	2342	2%	71:31:18
6	news-out.aioe.org	3	23401	1347	22008	46	5%	24:09:51
7	newsfeed.fu-berlin.de	41	26688	1316	25090	282	4%	36:20:33
8	news.redatomik.org	1	25237	801	24423	13	3%	28:11:27
9	newsfeeds.xmission.com	3	23964	674	23278	12	2%	26:19:34
10	news.fcku.it	1	9224	433	8752	39	4%	23:59:51
11	news.freedyn.net	3	26215	86	26048	81	0%	24:09:47
12	nntp.pasdenom.info	2	21674	36	21637	1	0%	23:58:35
13	xanadu-bbs.net	7	272	20	250	2	7%	09:27:06
14	localhost	44	7	7	0	0	100%	00:00:01
15	news.bbs.geek.nz	2	22164	1	22163	0	0%	23:59:42
TOTAL: 15		1710	499831	23530	456591	19710	4%	513:56:57

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	26.0 MB	298.4 KB	69.0 MB	95.3 MB	27%	5.5 KB
2	csiph-out.news.weretis.net	14.4 MB	0.0 KB	15.0 MB	29.3 MB	48%	5.1 KB
3	feeder.eternal-september.org	8.0 MB	3.3 KB	74.7 MB	82.7 MB	9%	10.1 KB
4	news-out.mixmin.net	7.4 MB	12.5 KB	1.1 MB	8.6 MB	86%	3.8 KB
5	news-out.aioe.org	3.4 MB	0.0 KB	146.8 KB	3.5 MB	95%	2.6 KB
6	newsfeed.fu-berlin.de	3.3 MB	0.0 KB	624.4 KB	3.9 MB	84%	2.5 KB
7	newsfeed.neva.ru	3.3 MB	153.4 KB	22.9 MB	26.3 MB	12%	7.1 KB
8	newsfeeds.xmission.com	2.5 MB	0.0 KB	807.8 KB	3.3 MB	76%	4.9 KB
9	news.redatomik.org	2.4 MB	2.9 KB	2.9 MB	5.3 MB	45%	6.7 KB
10	news.fcku.it	878.6 KB	1.8 KB	2.8 MB	3.7 MB	23%	7.9 KB
11	news.freedyn.net	387.0 KB	0.0 KB	1.7 MB	2.1 MB	18%	12.7 KB
12	nntp.pasdenom.info	92.3 KB	0.0 KB	1.3 KB	93.6 KB	98%	2.5 KB
13	xanadu-bbs.net	41.7 KB	0.0 KB	25.8 KB	67.4 KB	61%	3.1 KB
14	localhost	16.5 KB	0.0 KB	0.0 KB	16.5 KB	100%	2.4 KB
15	news.bbs.geek.nz	1.8 KB	0.0 KB	0.0 KB	1.8 KB	100%	1.8 KB
TOTAL: 15		72.1 MB	472.2 KB	191.7 MB	264.3 MB	27%	6.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 20 04:15:00 - 04:59:59	369	1.6%	0.14	1.1 MB	1.6%	0.43
Apr 20 05:00:00 - 05:59:59	632	2.7%	0.18	2.7 MB	3.8%	0.77
Apr 20 06:00:00 - 06:59:59	781	3.4%	0.22	2.2 MB	3.1%	0.61
Apr 20 07:00:00 - 07:59:59	977	4.2%	0.27	2.8 MB	4.0%	0.80
Apr 20 08:00:00 - 08:59:59	1054	4.5%	0.29	3.1 MB	4.4%	0.88
Apr 20 09:00:00 - 09:59:59	1085	4.7%	0.30	2.9 MB	4.1%	0.83
Apr 20 10:00:00 - 10:59:59	1098	4.7%	0.30	3.7 MB	5.3%	1.06
Apr 20 11:00:00 - 11:59:59	1017	4.4%	0.28	3.0 MB	4.3%	0.87
Apr 20 12:00:00 - 12:59:59	1100	4.7%	0.31	3.0 MB	4.3%	0.87
Apr 20 13:00:00 - 13:59:59	1150	5.0%	0.32	3.1 MB	4.4%	0.89
Apr 20 14:00:00 - 14:59:59	1312	5.7%	0.36	4.2 MB	6.0%	1.20
Apr 20 15:00:00 - 15:59:59	1297	5.6%	0.36	4.0 MB	5.6%	1.13
Apr 20 16:00:00 - 16:59:59	1313	5.7%	0.36	3.6 MB	5.1%	1.02
Apr 20 17:00:00 - 17:59:59	1389	6.0%	0.39	4.1 MB	5.8%	1.17
Apr 20 18:00:00 - 18:59:59	1348	5.8%	0.37	4.5 MB	6.4%	1.28
Apr 20 19:00:00 - 19:59:59	1232	5.3%	0.34	3.8 MB	5.4%	1.09
Apr 20 20:00:00 - 20:59:59	1122	4.8%	0.31	3.5 MB	5.0%	1.01
Apr 20 21:00:00 - 21:59:59	1173	5.1%	0.33	3.3 MB	4.6%	0.93
Apr 20 22:00:00 - 22:59:59	923	4.0%	0.26	3.0 MB	4.2%	0.84
Apr 20 23:00:00 - 23:59:59	705	3.0%	0.20	2.2 MB	3.2%	0.64
Apr 21 00:00:00 - 00:59:59	548	2.4%	0.15	1.6 MB	2.3%	0.46
Apr 21 01:00:00 - 01:59:59	442	1.9%	0.12	1.3 MB	1.9%	0.38
Apr 21 02:00:00 - 02:59:59	475	2.0%	0.13	1.5 MB	2.1%	0.43
Apr 21 03:00:00 - 03:59:59	512	2.2%	0.14	1.6 MB	2.3%	0.46
Apr 21 04:00:00 - 04:15:00	128	0.6%	0.14	502.1 KB	0.7%	0.56
TOTAL: 24:00:00	23182	100.0%	0.27	70.6 MB	100.0%	0.84

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	10175	349	29	2	9795
2	feeder.eternal-september.org	5208	83	1	0	5124
3	newsfeed.neva.ru	2330	198	16	0	2116
4	csiph-out.news.weretis.net	1070	249	0	0	821
5	newsfeed.fu-berlin.de	750	57	0	0	693
6	news-out.mixmin.net	423	2	5	0	416
7	news.freedyn.net	81	9	0	0	72
8	news-out.aioe.org	60	39	1	0	20
9	news.fcku.it	39	4	1	0	34
10	news.redatomik.org	15	0	1	0	14
11	newsfeeds.xmission.com	12	0	0	0	12
12	news.swapon.de	10	0	0	0	10
13	xanadu-bbs.net	7	0	0	0	7
14	nntp.pasdenom.info	2	0	1	0	1
TOTAL: 14		20182	990	55	2	19135

Unwanted newsgroups [Top 20]:

Newsgroup	Count
ut.test	97
it-alt.sport.calcio.juventus	89
lada.talk	80
mozilla.support.firefox	47
lada.auto	39
it.annunci.commerciali	38
spline.eisfair	38
it.annunci.immobiliari	35
it.annunci.varie	34
mpc.lists.freebsd.ports.bugs	33
alt.politics.scorched-earth	32
mozilla.dev.security.policy	29
mozilla.support.seamonkey	28
cakewalk.audio	26
mozilla.support.thunderbird	24
it-alt.comp.software.mozilla	23
gmane.linux.alsa.devel	16
alt.windows7.general	13
spline.eisfair.dev	11
alt.binaries.kindle	11
TOTAL: 126	990

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)	16443
EMP (phn path)	1402
EMP (phn nph)	53
Too many newsgroups	35
User-issued cancel	35
Scoring filter (10)	27
HTML Multipart	24
Scoring filter (8)	22
Scoring filter (9)	14
Binary Payload	12
Scoring filter (11)	10
Scoring filter (14)	7
Scoring filter (12)	7
EMP (phl)	5
Binary Image: misplaced jpg	4
Scoring filter (17)	2
Scoring filter (15)	2
Scoring filter (13)	2
HTML post	2
Scoring filter (19)	1
TOTAL: 23	18112

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	64	0	73	73
TOTAL: 1	64	0	73	73

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	5
	TOTAL: 1	5
Huge articles
	csiph-out.feeder.erje.net	151
	feeder.eternal-september.org	101
	csiph-out.news.weretis.net	74
	news.redatomik.org	11
	news.fcku.it	11
	news-out.mixmin.net	9
	news.freedyn.net	8
	newsfeeds.xmission.com	8
	xanadu-bbs.net	4
	news.swapon.de	3
	TOTAL: 10	380
Including strange strings
	newsfeed.fu-berlin.de	479
	csiph-out.news.weretis.net	47
	csiph-out.feeder.erje.net	44
	news-out.mixmin.net	33
	news-out.aioe.org	11
	newsfeed.neva.ru	7
	news.swapon.de	7
	feeder.eternal-september.org	4
	newsfeeds.xmission.com	3
	news.redatomik.org	2
	TOTAL: 11	638
No colon-space in header
	csiph-out.feeder.erje.net	4
	TOTAL: 1	4
TOTAL: 4		1027

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	news.bbs.geek.nz	42403	1365	21077	116	1	0	3%	23:59:54
2	news.freedyn.net	24063	815	22277	5	0	0	3%	23:59:54
3	xanadu-bbs	25633	744	22385	1	0	54	2%	23:59:54
4	fu-berlin.de	21645	596	21049	0	0	0	2%	23:59:54
5	usenet.pasdenom.info	24930	244	21189	1713	0	16	0%	23:59:54
6	xmission	24830	44	21795	1	0	0	0%	23:59:52
7	news.redatomik.org	22600	25	21813	5	0	0	0%	23:59:49
8	aioe	20900	22	19869	3	0	0	0%	23:59:54
9	weretis.net	18142	14	17291	2	0	0	0%	23:59:54
10	eternal-september	20866	10	19258	3	0	0	0%	23:59:54
11	news.mixmin.net	20985	9	20194	0	0	0	0%	23:59:47
12	neva.ru	21422	6	20805	22	0	0	0%	23:59:21
13	news.swapon.de	2175	4	2126	5	0	0	0%	23:59:54
14	au2pb	0	0	0	0	0	22559	0%	23:58:42
15	news.fcku.it	2248	0	2228	0	0	0	0%	23:08:34
16	erje	15662	0	15472	64	0	0	0%	23:59:54
17	bwh	0	0	0	0	0	22543	0%	23:58:42
TOTAL: 17		308504	3898	268828	1940	1	45172	1%	407:03:47

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	7.6 MB	39.8 KB	7.6 MB	0.1 KB/s	9.6 KB	23:59:54
2	xanadu-bbs	7.4 MB	2.0 KB	7.4 MB	0.1 KB/s	10.2 KB	23:59:54
3	fu-berlin.de	6.9 MB	0.0 KB	6.9 MB	0.1 KB/s	11.9 KB	23:59:54
4	news.bbs.geek.nz	3.5 MB	474.5 KB	4.0 MB	0.0 KB/s	2.8 KB	23:59:54
5	usenet.pasdenom.info	1007.2 KB	8.8 MB	9.8 MB	0.1 KB/s	5.1 KB	23:59:54
6	xmission	137.0 KB	1.9 KB	138.9 KB	0.0 KB/s	3.1 KB	23:59:52
7	news.redatomik.org	69.0 KB	16.8 KB	85.8 KB	0.0 KB/s	2.9 KB	23:59:49
8	aioe	66.8 KB	13.0 KB	79.9 KB	0.0 KB/s	3.2 KB	23:59:54
9	news.mixmin.net	63.2 KB	0.0 KB	63.2 KB	0.0 KB/s	7.0 KB	23:59:47
10	weretis.net	41.8 KB	4.3 KB	46.1 KB	0.0 KB/s	2.9 KB	23:59:54
11	eternal-september	25.2 KB	6.3 KB	31.5 KB	0.0 KB/s	2.4 KB	23:59:54
12	neva.ru	15.6 KB	59.8 KB	75.3 KB	0.0 KB/s	2.7 KB	23:59:21
13	news.swapon.de	11.4 KB	10.4 KB	21.8 KB	0.0 KB/s	2.4 KB	23:59:54
14	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:08:34
16	erje	0.0 KB	392.8 KB	392.8 KB	0.0 KB/s	6.1 KB	23:59:54
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:58:42
TOTAL: 17		26.8 MB	9.8 MB	36.6 MB	0.0 KB/s	6.4 KB	407:03:47

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	mtrlpq2314w-lp140-04-70-53-246-3.dsl.bell.ca	2235	908549	3.0 GB	3712	0	0	133:56:14
2	144.138.90.254	288	69	181.9 KB	66	0	0	03:29:49
3	68-185-181-64.dhcp.mdsn.wi.charter.com	21	9	20.0 KB	7	7	7	05:43:31
4	dhcp-089-099-203-254.chello.nl	47	7	16.5 KB	3	0	0	09:14:59
TOTAL: 4		2591	908634	3.0 GB	3788	7	7	154:54:44

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dsl.bell.ca	2235	908549	3.0 GB	3712	0	0	133:56:14
2	unresolved	288	69	181.9 KB	66	0	0	03:29:49
3	*.dhcp.mdsn.wi.charter.com	21	9	20.0 KB	7	7	7	05:43:31
4	*.chello.nl	47	7	16.5 KB	3	0	0	09:14:59
5	*.bbox.io	5	0	0.0 KB	0	0	0	02:30:08
TOTAL: 5		2596	908634	3.0 GB	3788	7	7	154:54:44

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	7
TOTAL: 2	295

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mtrlpq2314w-lp140-04-70-53-246-3.dsl.bell.ca	463.262	477.998	0.000	133:56:14
dhcp-089-099-203-254.chello.nl	3.508	0.937	0.000	09:14:59
68-185-181-64.dhcp.mdsn.wi.charter.com	1.873	0.425	0.024	05:43:31
144.138.90.254	24.149	6.531	1.002	03:29:49
tempe0.bbox.io	0.525	0.078	0.000	02:30:08
TOTAL: 5	493.317	485.969	1.026	154:54:44

Curious NNRP server explorers [Top 20]:

System	Conn
tempe0.bbox.io	5
TOTAL: 1	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
mtrlpq2314w-lp140-04-70-53-246-3.dsl.bell.ca	36	0
68-185-181-64.dhcp.mdsn.wi.charter.com	5	0
tempe0.bbox.io	5	0
TOTAL: 3	46	0

Newsgroup request counts (by category):

Category		Count	Pct
1	alt	892681	100.0%
2	comp	89	0.0%
3	uk	16	0.0%
4	rec	11	0.0%
5	fr	10	0.0%
6	soc	5	0.0%
7	talk	4	0.0%
8	sci	2	0.0%
TOTAL: 8		892818	100.0%

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

Newsgroup		Count
1	alt.fan.rush-limbaugh	767474
2	alt.usenet.kooks	125158
3	comp.os.vms	28
4	comp.sys.ibm.ps2.hardware	25
5	comp.sys.ibm.pc.hardware.storage	9
6	fr.soc.politique	9
7	alt.atheism	8
8	alt.christnet.christianlife	7
9	alt.society.liberalism	6
10	alt.politics.economics	6
11	alt.home.repair	6
12	uk.rec.drugs.cannabis	6
13	comp.arch.embedded	5
14	comp.os.msdos.programmer	5
15	comp.sys.ibm.pc.games.action	4
16	alt.politics.trump	4
17	uk.legal	4
18	talk.politics.misc	4
19	soc.culture.usa	3
20	alt.war.vietnam	3
21	uk.politics.misc	3
22	rec.photo.digital	2
23	alt.music.michael-jackson	2
24	comp.arch	2
25	comp.sys.ibm.pc.games.war-historical	2
26	alt.comp.freeware	2
27	comp.unix.aix	2
28	rec.arts.drwho	2
29	rec.arts.tv	2
30	comp.lang.fortran	1
31	soc.retirement	1
32	rec.sport.tennis	1
33	comp.dsp	1
34	alt.bible.prophecy	1
35	alt.california	1
36	alt.prophecies.nostradamus	1
37	comp.os.os2.announce	1
38	comp.ai.neural-nets	1
39	comp.lang.forth	1
40	alt.comp.os.windows-10	1
41	fr.rec.photo	1
42	rec.food.cooking	1
43	soc.culture.polish	1
44	rec.sport.golf	1
45	sci.physics	1
46	alt.sports.football.pro.phila-eagles	1
47	uk.d-i-y	1
48	rec.gambling.poker	1
49	uk.tech.digital-tv	1
50	comp.sys.ibm.pc.games.adventure	1
51	rec.radio.shortwave	1
52	uk.legal.moderated	1
53	sci.logic	1
54	comp.ai.nat-lang	1
TOTAL: 54		892818

Daily Usenet report for csiph.com

Apr 20 04:15:00 -- Apr 21 04:15:00