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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	44985	39.2%	8.7 MB	56.0%
nnrpd	44261	38.6%	3.9 MB	25.1%
innd	22369	19.5%	2.4 MB	15.5%
innfeed	3110	2.7%	534.4 KB	3.4%
nocem	66	0.1%	6.7 KB	0.0%
TOTAL: 5	114791	100.0%	15.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	530585	57.5%
Negative hits	347921	37.7%
Do not exist	43990	4.8%
Cache misses	671	0.1%
TOTAL: 4	923167	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.524	0.0%	226	0.000	2.319	27.000
article cleanup	00:00:00.292	0.0%	43287	0.000	0.007	0.022
article logging	00:00:00.642	0.0%	43811	0.000	0.015	0.115
article parse	00:00:02.569	0.0%	155987	0.003	0.016	0.328
article write	00:01:52.480	0.1%	25376	0.273	4.433	30.816
artlog/artcncl	00:00:00.002	0.0%	187	0.000	0.011	0.056
artlog/artparse	00:00:00.011	0.0%	924	0.000	0.012	0.500
data move	00:00:00.300	0.0%	881552	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.068	0.0%	221	0.000	0.308	8.000
hishave/artcncl	00:00:00.002	0.0%	226	0.000	0.009	0.118
hishave/artparse	00:00:00.000	0.0%	328	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:12.135	0.0%	927654	0.002	0.013	0.270
history sync	00:00:02.404	0.0%	355	0.000	6.772	97.333
history write	00:00:53.281	0.1%	43866	0.087	1.215	13.356
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hiswrite/artparse	00:00:01.091	0.0%	328	0.000	3.326	48.000
idle	23:53:16.346	99.5%	900145	58.818	95.536	209.473
nntp read	00:00:03.033	0.0%	908798	0.001	0.003	0.006
overview write	00:01:24.972	0.1%	25376	0.503	3.349	37.034
perl filter	00:01:43.570	0.1%	43269	1.584	2.394	3.658
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.461	0.0%	50810	0.000	0.009	0.026
TOTAL: 24:00:52.971	23:59:34.183	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.074	0.0%	25350	0.000	0.003	0.024
article prepare	00:00:00.002	0.0%	25068	0.000	0.000	0.018
article read	00:00:01.730	0.0%	2955	0.000	0.585	19.727
backlog stats	00:00:00.253	0.0%	565186	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.218	0.0%	423074	0.001	0.005	0.010
data write	00:00:02.843	0.0%	406702	0.002	0.007	0.012
idle	23:53:30.749	100.0%	565186	86.437	152.181	370.664
status file	00:00:00.195	0.0%	247	0.000	0.789	16.000
TOTAL: 23:53:51.753	23:53:38.064	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.225	0.0%	5744	0.034	0.039	0.049
idle	70:48:32.640	98.7%	64757	15.000	3936.449	600161.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.081	0.0%	130586	0.000	0.008	25.500
readart	00:00:27.125	0.0%	12539	0.000	2.163	70.000
TOTAL: 71:42:47.240	70:49:01.071	98.8%	-	-	-	-

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	usenet.blueworldhosting.com	288	29851	5599	22347	1905	18%	23:44:31
2	csiph-out.feeder.erje.net	1152	140701	4045	127394	9262	2%	94:57:49
3	feeder.eternal-september.org	2	37703	3754	32861	1088	9%	23:59:50
4	news-out.mixmin.net	3	28279	2679	24964	636	9%	24:08:48
5	csiph-out.news.weretis.net	7	65102	2655	60911	1536	4%	55:22:40
6	newsfeed.neva.ru	147	59464	2378	53322	3764	3%	71:54:25
7	news-out.aioe.org	3	24524	1432	23061	31	5%	24:09:35
8	newsfeed.fu-berlin.de	58	24513	943	23160	410	3%	28:30:29
9	newsfeeds.xmission.com	0	24374	582	23769	23	2%	21:54:31
10	news.freedyn.net	4	27546	538	26938	70	1%	24:09:36
11	news.fcku.it	1	10892	389	10479	24	3%	25:27:15
12	news.redatomik.org	1	22512	112	22400	0	0%	22:26:07
13	au2pb.net	1	28769	101	28650	18	0%	24:12:48
14	news.swapon.de	1	1684	65	1618	1	3%	22:43:51
15	nntp.pasdenom.info	3	26493	48	26442	3	0%	24:08:26
16	xanadu-bbs.net	7	776	25	746	5	3%	23:47:41
17	localhost	46	11	11	0	0	100%	00:00:00
18	news.bbs.geek.nz	1	26093	11	26082	0	0%	23:59:51
TOTAL: 18		1725	579287	25367	535144	18776	4%	559:38:13

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	17.1 MB	3.6 KB	20.9 MB	38.0 MB	44%	5.2 KB
2	csiph-out.feeder.erje.net	16.6 MB	22.7 KB	41.1 MB	57.7 MB	28%	4.4 KB
3	feeder.eternal-september.org	10.0 MB	6.9 KB	17.4 MB	27.4 MB	36%	5.8 KB
4	news-out.mixmin.net	9.6 MB	4.2 KB	2.0 MB	11.6 MB	83%	3.6 KB
5	csiph-out.news.weretis.net	7.9 MB	0.0 KB	20.0 MB	27.9 MB	28%	6.8 KB
6	newsfeed.neva.ru	6.4 MB	13.2 KB	22.8 MB	29.2 MB	21%	4.9 KB
7	news-out.aioe.org	3.3 MB	0.9 KB	50.8 KB	3.3 MB	98%	2.3 KB
8	newsfeed.fu-berlin.de	2.1 MB	0.0 KB	920.9 KB	3.0 MB	70%	2.3 KB
9	newsfeeds.xmission.com	1.8 MB	0.0 KB	470.9 KB	2.3 MB	79%	3.9 KB
10	news.freedyn.net	1.6 MB	0.0 KB	123.9 KB	1.7 MB	92%	2.8 KB
11	news.fcku.it	917.3 KB	0.0 KB	532.3 KB	1.4 MB	63%	3.5 KB
12	news.redatomik.org	346.6 KB	0.0 KB	0.0 KB	346.6 KB	100%	3.1 KB
13	au2pb.net	290.6 KB	0.0 KB	160.7 KB	451.3 KB	64%	3.8 KB
14	news.swapon.de	150.7 KB	0.0 KB	94.8 KB	245.5 KB	61%	3.7 KB
15	xanadu-bbs.net	100.1 KB	0.0 KB	62.3 KB	162.4 KB	61%	5.4 KB
16	nntp.pasdenom.info	97.5 KB	0.0 KB	6.6 KB	104.1 KB	93%	2.0 KB
17	localhost	16.0 KB	0.0 KB	0.0 KB	16.0 KB	100%	1.5 KB
18	news.bbs.geek.nz	15.5 KB	0.0 KB	0.0 KB	15.5 KB	100%	1.4 KB
TOTAL: 18		78.3 MB	51.5 KB	126.6 MB	204.9 MB	38%	4.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jun 29 04:15:00 - 04:59:59	520	2.0%	0.19	2.3 MB	3.0%	0.89
Jun 29 05:00:00 - 05:59:59	677	2.7%	0.19	2.9 MB	3.7%	0.82
Jun 29 06:00:00 - 06:59:59	770	3.0%	0.21	2.0 MB	2.6%	0.58
Jun 29 07:00:00 - 07:59:59	907	3.6%	0.25	2.6 MB	3.3%	0.73
Jun 29 08:00:00 - 08:59:59	1018	4.0%	0.28	3.2 MB	4.1%	0.91
Jun 29 09:00:00 - 09:59:59	1135	4.5%	0.32	3.4 MB	4.3%	0.96
Jun 29 10:00:00 - 10:59:59	1192	4.7%	0.33	3.3 MB	4.2%	0.95
Jun 29 11:00:00 - 11:59:59	1292	5.1%	0.36	4.3 MB	5.4%	1.21
Jun 29 12:00:00 - 12:59:59	1281	5.0%	0.36	3.5 MB	4.5%	1.00
Jun 29 13:00:00 - 13:59:59	1457	5.7%	0.40	3.9 MB	5.0%	1.12
Jun 29 14:00:00 - 14:59:59	1661	6.5%	0.46	5.3 MB	6.8%	1.51
Jun 29 15:00:00 - 15:59:59	1514	6.0%	0.42	4.8 MB	6.1%	1.36
Jun 29 16:00:00 - 16:59:59	1368	5.4%	0.38	4.2 MB	5.3%	1.18
Jun 29 17:00:00 - 17:59:59	1424	5.6%	0.40	4.6 MB	5.9%	1.32
Jun 29 18:00:00 - 18:59:59	1485	5.8%	0.41	4.4 MB	5.6%	1.25
Jun 29 19:00:00 - 19:59:59	1208	4.8%	0.34	3.9 MB	5.0%	1.11
Jun 29 20:00:00 - 20:59:59	1245	4.9%	0.35	3.9 MB	5.0%	1.11
Jun 29 21:00:00 - 21:59:59	1184	4.7%	0.33	3.5 MB	4.5%	1.01
Jun 29 22:00:00 - 22:59:59	996	3.9%	0.28	3.2 MB	4.0%	0.90
Jun 29 23:00:00 - 23:59:59	731	2.9%	0.20	2.2 MB	2.8%	0.62
Jun 30 00:00:00 - 00:59:59	587	2.3%	0.16	1.7 MB	2.2%	0.48
Jun 30 01:00:00 - 01:59:59	514	2.0%	0.14	1.4 MB	1.8%	0.40
Jun 30 02:00:00 - 02:59:59	511	2.0%	0.14	1.7 MB	2.2%	0.49
Jun 30 03:00:00 - 03:59:59	535	2.1%	0.15	1.7 MB	2.2%	0.48
Jun 30 04:00:00 - 04:15:00	180	0.7%	0.20	639.6 KB	0.8%	0.71
TOTAL: 24:00:00	25392	100.0%	0.29	78.5 MB	100.0%	0.93

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	9308	767	3	0	8538
2	newsfeed.neva.ru	3781	1273	2	0	2506
3	usenet.blueworldhosting.com	1909	793	2	2	1112
4	csiph-out.news.weretis.net	1565	248	0	0	1317
5	feeder.eternal-september.org	1109	180	3	0	926
6	newsfeed.fu-berlin.de	836	43	0	0	793
7	news-out.mixmin.net	678	7	4	0	667
8	news.freedyn.net	70	0	1	0	69
9	news.fcku.it	42	0	1	0	41
10	news-out.aioe.org	41	29	1	0	11
11	au2pb.net	33	29	0	0	4
12	newsfeeds.xmission.com	20	9	0	0	11
13	xanadu-bbs.net	5	0	0	0	5
14	news.swapon.de	5	0	0	0	5
15	news.redatomik.org	2	0	0	0	2
16	nntp.pasdenom.info	2	0	0	0	2
TOTAL: 16		19406	3378	17	2	16009

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	774
lada.talk	283
mailing.freebsd.pkg-fallout	253
lada.auto	130
ut.test	114
mailing.freebsd.ports-bugs	106
cakewalk.audio	63
alt.windows7.general	56
mailing.freebsd.svn-ports-head	55
mailing.freebsd.svn-ports-all	55
it-alt.sport.calcio.juventus	51
mailing.freebsd.svn-src-all	41
fa.freebsd.cvs-all	41
mailing.gcc.gcc-cvs	34
fa.netbsd.bugs	31
gmane.linux.alsa.devel	28
spline.eisfair	28
mailing.freebsd.svn-src-head	27
mailing.unix.spamassassin-talk	27
alt.politics.scorched-earth	26
TOTAL: 255	3378

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)	11137
EMP (phn path)	2071
EMP (phl)	675
EMP (phn nph)	148
Binary Payload	104
Too many newsgroups	82
PFM bot misc	79
HTML Multipart	58
Scoring filter (18)	24
Scoring filter (10)	16
Scoring filter (8)	16
Scoring filter (11)	15
User-issued cancel	13
HTML Image Tags	12
Scoring filter (16)	12
Binary Image: misplaced jpg	11
Scoring filter (20)	11
Scoring filter (12)	9
Scoring filter (17)	7
Scoring filter (13)	7
TOTAL: 38	14558

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	58	0	65	65
TOTAL: 1	58	0	65	65

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	usenet.blueworldhosting.com	1
	TOTAL: 2	5
Huge articles
	feeder.eternal-september.org	119
	usenet.blueworldhosting.com	98
	csiph-out.news.weretis.net	78
	news-out.mixmin.net	18
	news.fcku.it	7
	newsfeeds.xmission.com	5
	newsfeed.fu-berlin.de	1
	au2pb.net	1
	xanadu-bbs.net	1
	news.swapon.de	1
	TOTAL: 11	330
Including strange strings
	newsfeed.fu-berlin.de	380
	csiph-out.feeder.erje.net	41
	feeder.eternal-september.org	33
	news-out.mixmin.net	30
	csiph-out.news.weretis.net	16
	news-out.aioe.org	9
	newsfeed.neva.ru	5
	news.swapon.de	4
	usenet.blueworldhosting.com	3
	news.fcku.it	2
	TOTAL: 11	524
No colon-space in header
	csiph-out.feeder.erje.net	593
	usenet.blueworldhosting.com	3
	TOTAL: 2	596
TOTAL: 4		1455

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	47037	1386	23037	41	0	2%	23:50:06
2	news.freedyn.net	27986	1050	23784	11	0	3%	23:59:51
3	xanadu-bbs	28321	906	24447	0	0	3%	23:59:51
4	fu-berlin.de	24086	785	23301	0	0	3%	23:59:51
5	aioe	23813	127	21681	7	0	0%	23:58:50
6	weretis.net	22701	119	21287	32	14	0%	23:59:34
7	usenet.pasdenom.info	32227	95	24139	1114	9	0%	23:59:50
8	news.redatomik.org	25544	85	24024	9	0	0%	23:50:06
9	au2pb	26337	71	24418	1	0	0%	23:59:51
10	erje	21614	62	21012	201	20	0%	23:59:51
11	xmission	28865	50	23808	2	0	0%	23:59:49
12	eternal-september	23169	21	20359	0	0	0%	23:59:50
13	news.mixmin.net	23172	19	21605	0	0	0%	23:59:50
14	bwh	20839	12	18793	0	0	0%	23:59:51
15	news.swapon.de	1873	10	1771	2	0	0%	23:50:55
16	neva.ru	24942	9	21665	45	0	0%	23:59:50
17	news.fcku.it	2480	1	2312	0	0	0%	22:19:04
TOTAL: 17		405006	4808	341443	1465	43	1%	405:46:50

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	8.8 MB	91.7 KB	8.8 MB	0.1 KB/s	8.5 KB	23:59:51
2	xanadu-bbs	8.2 MB	0.0 KB	8.2 MB	0.1 KB/s	9.3 KB	23:59:51
3	fu-berlin.de	7.9 MB	0.0 KB	7.9 MB	0.1 KB/s	10.4 KB	23:59:51
4	news.bbs.geek.nz	3.4 MB	123.6 KB	3.6 MB	0.0 KB/s	2.6 KB	23:50:06
5	usenet.pasdenom.info	399.6 KB	8.6 MB	9.0 MB	0.1 KB/s	7.6 KB	23:59:50
6	weretis.net	321.9 KB	121.2 KB	443.1 KB	0.0 KB/s	2.9 KB	23:59:34
7	aioe	237.6 KB	17.8 KB	255.4 KB	0.0 KB/s	1.9 KB	23:58:50
8	news.redatomik.org	206.5 KB	33.3 KB	239.8 KB	0.0 KB/s	2.6 KB	23:50:06
9	au2pb	173.1 KB	1.5 KB	174.6 KB	0.0 KB/s	2.4 KB	23:59:51
10	erje	138.9 KB	654.5 KB	793.3 KB	0.0 KB/s	3.0 KB	23:59:51
11	xmission	129.6 KB	23.3 KB	152.9 KB	0.0 KB/s	2.9 KB	23:59:49
12	eternal-september	59.4 KB	0.0 KB	59.4 KB	0.0 KB/s	2.8 KB	23:59:50
13	news.mixmin.net	50.1 KB	0.0 KB	50.1 KB	0.0 KB/s	2.6 KB	23:59:50
14	neva.ru	36.0 KB	392.2 KB	428.2 KB	0.0 KB/s	7.9 KB	23:59:50
15	bwh	17.6 KB	0.0 KB	17.6 KB	0.0 KB/s	1.5 KB	23:59:51
16	news.swapon.de	15.6 KB	2.0 KB	17.6 KB	0.0 KB/s	1.5 KB	23:50:55
17	news.fcku.it	2.3 KB	0.0 KB	2.3 KB	0.0 KB/s	2.3 KB	22:19:04
TOTAL: 17		30.1 MB	10.0 MB	40.2 MB	0.0 KB/s	6.6 KB	405:46:50

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	39	76.9 KB	35	0	0	05:18:31
2	68-185-181-64.dhcp.mdsn.wi.charter.com	23	22	39.1 KB	12	11	9	04:37:34
3	dhcp-089-099-203-254.chello.nl	101	18	35.3 KB	7	0	0	31:12:49
4	mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	120	15	36.5 KB	11	0	0	00:42:46
5	tempe0.bbox.io	8	2	3.1 KB	2	0	0	03:30:28
TOTAL: 5		540	96	190.9 KB	67	11	9	71:42:41

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	298	39	76.9 KB	35	0	0	28:03:22
2	*.dhcp.mdsn.wi.charter.com	23	22	39.1 KB	12	11	9	04:37:34
3	*.chello.nl	101	18	35.3 KB	7	0	0	31:12:49
4	*.dsl.bell.ca	120	15	36.5 KB	11	0	0	00:42:46
5	*.bbox.io	8	2	3.1 KB	2	0	0	03:30:28
6	*.shodan.io	1	0	0.0 KB	0	0	0	00:00:02
7	*.nielsenmedia.com	10	0	0.0 KB	0	0	0	03:35:38
TOTAL: 7		561	96	190.9 KB	67	11	9	71:42:41

NNRP auth users [Top 20]:

User	Conn
moussa	288
ohlandl	9
TOTAL: 2	297

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	9.101	2.053	0.000	31:12:49
216.246.166.30	0.414	0.388	0.000	20:46:17
202.89.176.220	30.699	7.513	0.777	05:18:31
68-185-181-64.dhcp.mdsn.wi.charter.com	2.647	0.579	0.024	04:37:34
challenger.nielsenmedia.com	0.851	0.235	0.000	03:35:38
tempe0.bbox.io	0.776	0.175	0.000	03:30:28
71.98.160.36	0.425	0.085	0.000	01:28:25
mtrlpq2314w-lp130-02-1176034363.dsl.bell.ca	15.164	4.076	0.000	00:42:46
24.114.29.182	0.126	0.024	0.000	00:30:06
census6.shodan.io	0.071	0.039	0.000	00:00:02
TOTAL: 10	60.274	15.167	0.801	71:42:41

Curious NNRP server explorers [Top 20]:

System	Conn
challenger.nielsenmedia.com	10
71.98.160.36	5
216.246.166.30	4
24.114.29.182	1
census6.shodan.io	1
TOTAL: 5	21

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	7	0
challenger.nielsenmedia.com	6	1
71.98.160.36	2	0
68-185-181-64.dhcp.mdsn.wi.charter.com	1	0
24.114.29.182	1	0
TOTAL: 5	17	1

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	82	85.4%
2	rec	8	8.3%
3	uk	3	3.1%
4	alt	2	2.1%
5	sci	1	1.0%
TOTAL: 5		96	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	64
2	rec.arts.tv	5
3	comp.ai.neural-nets	4
4	comp.os.msdos.programmer	4
5	comp.arch.embedded	3
6	rec.boats	2
7	comp.os.os2.setup.storage	2
8	alt.happy.valley	2
9	rec.food.cooking	1
10	sci.physics	1
11	comp.lang.ada	1
12	comp.os.vms	1
13	comp.os.os2.announce	1
14	comp.ai.philosophy	1
15	uk.rec.motorcycles	1
16	comp.ai.genetic	1
17	uk.rec.drugs.cannabis	1
18	uk.legal	1
TOTAL: 18		96

Daily Usenet report for csiph.com

Jun 29 04:15:00 -- Jun 30 04:15:00