Daily Usenet report for csiph.com: Jan 11 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	58685	48.5%	10.8 MB	64.2%
nnrpd	32015	26.5%	2.7 MB	15.8%
innd	26922	22.3%	2.8 MB	16.6%
innfeed	3198	2.6%	563.7 KB	3.3%
nocem	90	0.1%	9.6 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	120911	100.0%	16.9 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	692303	57.3%
Negative hits	457244	37.9%
Do not exist	57560	4.8%
Cache misses	917	0.1%
TOTAL: 4	1208024	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.418	0.0%	293	0.000	1.427	24.000
article cleanup	00:00:00.291	0.0%	52459	0.000	0.006	0.024
article logging	00:00:00.711	0.0%	52997	0.000	0.013	0.053
article parse	00:01:11.043	0.1%	315980	0.004	0.225	0.612
article write	00:01:46.924	0.1%	29448	0.215	3.631	17.922
artlog/artcncl	00:00:00.002	0.0%	259	0.000	0.008	0.143
artlog/artparse	00:00:00.080	0.0%	5410	0.000	0.015	1.000
data move	00:00:00.459	0.0%	1238218	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.036	0.0%	288	0.000	0.125	2.500
hishave/artcncl	00:00:00.012	0.0%	293	0.000	0.041	10.000
hishave/artparse	00:00:00.005	0.0%	2524	0.000	0.002	0.083
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:06.899	0.0%	1210685	0.001	0.006	0.057
history sync	00:00:02.769	0.0%	357	0.000	7.756	89.667
history write	00:01:01.877	0.1%	55255	0.104	1.120	11.459
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hiswrite/artparse	00:00:01.123	0.0%	2523	0.000	0.445	14.222
idle	23:51:52.255	99.4%	1259699	28.554	68.201	216.734
nntp read	00:00:04.264	0.0%	1271075	0.002	0.003	0.006
overview write	00:01:10.510	0.1%	29448	0.287	2.394	19.692
perl filter	00:02:22.334	0.2%	52233	1.649	2.725	4.524
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.508	0.0%	58978	0.000	0.009	0.028
TOTAL: 24:00:52.495	23:59:42.520	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.077	0.0%	29432	0.000	0.003	0.022
article prepare	00:00:00.005	0.0%	45504	0.000	0.000	0.004
article read	00:00:02.479	0.0%	5941	0.000	0.417	41.750
backlog stats	00:00:00.331	0.0%	704831	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.581	0.0%	510629	0.001	0.005	0.008
data write	00:00:03.363	0.0%	491176	0.004	0.007	0.011
idle	23:52:15.987	100.0%	704831	72.090	121.924	321.368
status file	00:00:00.180	0.0%	281	0.000	0.641	1.250
TOTAL: 23:52:35.557	23:52:25.003	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.440	0.0%	3890	0.025	0.113	0.259
idle	40:12:37.516	99.9%	35403	105.000	4088.849	600208.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.420	0.0%	71785	0.000	0.006	0.125
readart	00:00:00.038	0.0%	97	0.000	0.392	29.000
TOTAL: 40:13:57.203	40:12:38.414	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	39577	6302	26198	7077	15%	23:45:16
2	csiph-out.feeder.erje.net	1152	195520	5157	182272	8091	2%	94:58:13
3	feeder.eternal-september.org	4	44416	4374	39313	729	9%	24:50:05
4	csiph-out.news.weretis.net	4	69571	2908	66268	395	4%	53:48:58
5	news-out.aioe.org	6	33038	2858	30016	164	8%	24:46:05
6	newsfeed.neva.ru	149	63804	2311	55701	5792	3%	73:14:23
7	news-out.mixmin.net	2	33754	1602	31516	636	4%	24:08:48
8	newsfeed.fu-berlin.de	81	34101	1250	32554	297	3%	38:10:41
9	news.redatomik.org	1	24343	709	23598	36	2%	18:40:59
10	xanadu-bbs.net	1	49898	652	44137	5109	1%	23:59:41
11	newsfeeds.xmission.com	1	33480	578	32868	34	1%	27:27:03
12	news.fcku.it	1	9603	454	9148	1	4%	25:28:19
13	news.freedyn.net	13	31616	151	31449	16	0%	21:15:21
14	news.swapon.de	3	2370	129	2222	19	5%	23:11:09
15	nntp.pasdenom.info	3	30265	32	30211	22	0%	24:08:37
16	localhost	35	0	0	0	0	0%	00:00:00
17	news.bbs.geek.nz	1	11936	0	11936	0	0%	13:14:25
TOTAL: 17		1745	707292	29467	649407	28418	4%	535:08:03

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	20.6 MB	665.3 KB	37.7 MB	59.0 MB	34%	4.6 KB
2	usenet.blueworldhosting.com	17.8 MB	0.0 KB	302.7 MB	320.5 MB	5%	24.5 KB
3	feeder.eternal-september.org	11.5 MB	15.5 KB	11.0 MB	22.5 MB	50%	4.5 KB
4	csiph-out.news.weretis.net	8.1 MB	0.0 KB	6.9 MB	15.0 MB	54%	4.6 KB
5	news-out.aioe.org	7.4 MB	4.9 KB	778.1 KB	8.2 MB	90%	2.8 KB
6	newsfeed.neva.ru	6.7 MB	228.5 KB	37.2 MB	44.2 MB	15%	5.6 KB
7	news-out.mixmin.net	6.3 MB	2.7 KB	1.5 MB	7.8 MB	80%	3.6 KB
8	newsfeed.fu-berlin.de	2.8 MB	0.0 KB	656.4 KB	3.4 MB	81%	2.3 KB
9	newsfeeds.xmission.com	1.9 MB	0.0 KB	278.2 KB	2.1 MB	87%	3.6 KB
10	news.redatomik.org	1.7 MB	0.0 KB	685.4 KB	2.4 MB	71%	3.2 KB
11	xanadu-bbs.net	1.7 MB	40.6 KB	53.1 MB	54.8 MB	3%	9.7 KB
12	news.fcku.it	849.9 KB	0.0 KB	0.9 KB	850.8 KB	99%	1.9 KB
13	news.freedyn.net	555.1 KB	7.8 KB	324.4 KB	887.3 KB	62%	5.3 KB
14	news.swapon.de	370.4 KB	0.0 KB	67.0 KB	437.3 KB	84%	3.0 KB
15	nntp.pasdenom.info	81.4 KB	0.0 KB	164.4 KB	245.8 KB	33%	4.6 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
17	news.bbs.geek.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 17		88.3 MB	965.3 KB	453.0 MB	542.3 MB	16%	9.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 11 04:15:00 - 04:59:59	442	1.5%	0.16	1.5 MB	1.7%	0.56
Jan 11 05:00:00 - 05:59:59	711	2.4%	0.20	2.7 MB	3.0%	0.76
Jan 11 06:00:00 - 06:59:59	780	2.7%	0.22	3.7 MB	4.2%	1.06
Jan 11 07:00:00 - 07:59:59	901	3.1%	0.25	2.6 MB	3.0%	0.75
Jan 11 08:00:00 - 08:59:59	1136	3.9%	0.32	3.2 MB	3.6%	0.91
Jan 11 09:00:00 - 09:59:59	1237	4.2%	0.34	3.3 MB	3.8%	0.94
Jan 11 10:00:00 - 10:59:59	1317	4.5%	0.37	3.8 MB	4.4%	1.09
Jan 11 11:00:00 - 11:59:59	1390	4.7%	0.39	4.0 MB	4.6%	1.14
Jan 11 12:00:00 - 12:59:59	1287	4.4%	0.36	3.6 MB	4.1%	1.03
Jan 11 13:00:00 - 13:59:59	1434	4.9%	0.40	3.9 MB	4.4%	1.11
Jan 11 14:00:00 - 14:59:59	1652	5.6%	0.46	4.4 MB	5.0%	1.26
Jan 11 15:00:00 - 15:59:59	1756	6.0%	0.49	5.4 MB	6.1%	1.53
Jan 11 16:00:00 - 16:59:59	1908	6.5%	0.53	5.8 MB	6.6%	1.64
Jan 11 17:00:00 - 17:59:59	1666	5.7%	0.46	4.9 MB	5.5%	1.39
Jan 11 18:00:00 - 18:59:59	1715	5.8%	0.48	5.1 MB	5.8%	1.46
Jan 11 19:00:00 - 19:59:59	1577	5.4%	0.44	4.4 MB	5.0%	1.26
Jan 11 20:00:00 - 20:59:59	1663	5.7%	0.46	5.3 MB	6.0%	1.50
Jan 11 21:00:00 - 21:59:59	1339	4.6%	0.37	3.8 MB	4.3%	1.08
Jan 11 22:00:00 - 22:59:59	1480	5.0%	0.41	4.3 MB	4.9%	1.22
Jan 11 23:00:00 - 23:59:59	1197	4.1%	0.33	3.5 MB	4.0%	0.99
Jan 12 00:00:00 - 00:59:59	853	2.9%	0.24	2.5 MB	2.8%	0.71
Jan 12 01:00:00 - 01:59:59	736	2.5%	0.20	2.4 MB	2.7%	0.68
Jan 12 02:00:00 - 02:59:59	562	1.9%	0.16	1.8 MB	2.0%	0.50
Jan 12 03:00:00 - 03:59:59	535	1.8%	0.15	1.7 MB	1.9%	0.47
Jan 12 04:00:00 - 04:15:00	130	0.4%	0.14	429.6 KB	0.5%	0.48
TOTAL: 24:00:00	29404	100.0%	0.34	88.0 MB	100.0%	1.04

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	8111	2564	62	7	5478
2	usenet.blueworldhosting.com	7105	1104	0	2	5999
3	newsfeed.neva.ru	5793	1765	21	0	4007
4	xanadu-bbs.net	5165	41	1	0	5123
5	feeder.eternal-september.org	742	119	1	0	622
6	newsfeed.fu-berlin.de	734	37	0	0	697
7	news-out.mixmin.net	640	2	1	0	637
8	csiph-out.news.weretis.net	366	231	0	0	135
9	news-out.aioe.org	179	123	1	0	55
10	news.swapon.de	47	0	0	0	47
11	news.redatomik.org	37	0	0	0	37
12	newsfeeds.xmission.com	31	30	0	0	1
13	au2pb.net	29	26	1	0	2
14	nntp.pasdenom.info	22	17	0	0	5
15	news.freedyn.net	17	1	2	0	14
16	news.fcku.it	4	0	0	0	4
TOTAL: 16		29022	6060	90	9	22863

Unwanted newsgroups [Top 20]:

Newsgroup	Count
microsoft.public.windows.chromeffects	1866
fa.linux.kernel	1150
lada.talk	219
ut.test	204
mailing.database.pgsql-general	126
mozilla.general	104
alt.binaries.multimedia.tatu	93
mailing.freebsd.pkg-fallout	92
mailing.freebsd.ports-bugs	91
lada.auto	90
mailing.freebsd.svn-src-all	80
fa.freebsd.cvs-all	78
mailing.freebsd.svn-ports-all	69
it-alt.sport.calcio.juventus	66
mailing.openbsd.ports-changes	64
mailing.freebsd.svn-ports-head	63
fa.openbsd.source-changes	51
mailing.openbsd.source-changes	51
mailing.gcc.gcc-cvs	49
mpc.lists.nanog	44
TOTAL: 278	6060

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
uk.radio.amateur.moderated	9
TOTAL: 1	9

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	11506
EMP (phn path)	2451
PFM bot misc	1416
EMP (phl)	811
EMP (phn nph)	163
User-issued cancel	154
HTML Multipart	51
Too many newsgroups	40
Scoring filter (21)	39
Scoring filter (19)	22
Scoring filter (22)	13
Scoring filter (17)	13
Binary Payload	12
Scoring filter (23)	10
Scoring filter (14)	9
Scoring filter (16)	8
HTML post	8
Scoring filter (13)	7
Too many newsgroups (low_xpost)	6
Scoring filter (11)	4
TOTAL: 39	16781

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	82	0	84	84
TOTAL: 1	82	0	84	84

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	128
	usenet.blueworldhosting.com	7
	TOTAL: 2	135
Bad Message-ID's offered
	csiph-out.feeder.erje.net	4
	usenet.blueworldhosting.com	1
	TOTAL: 2	5
Huge articles
	usenet.blueworldhosting.com	2244
	xanadu-bbs.net	135
	feeder.eternal-september.org	68
	csiph-out.news.weretis.net	55
	news-out.mixmin.net	11
	news.redatomik.org	4
	nntp.pasdenom.info	2
	news.freedyn.net	2
	au2pb.net	1
	newsfeeds.xmission.com	1
	TOTAL: 10	2523
Including strange strings
	newsfeed.fu-berlin.de	430
	news.swapon.de	27
	csiph-out.feeder.erje.net	19
	csiph-out.news.weretis.net	16
	news-out.aioe.org	16
	feeder.eternal-september.org	14
	newsfeed.neva.ru	9
	news-out.mixmin.net	4
	news.fcku.it	3
	usenet.blueworldhosting.com	1
	TOTAL: 10	539
No colon-space in header
	csiph-out.feeder.erje.net	569
	usenet.blueworldhosting.com	4
	TOTAL: 2	573
TOTAL: 5		3775

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	erje	32070	3233	20711	143	0	10%	23:59:55
2	news.bbs.geek.nz	54163	1489	26890	47	0	2%	23:59:46
3	news.freedyn.net	33998	1451	27794	4	50	4%	23:59:55
4	xanadu-bbs	31519	1170	27577	5	23	3%	23:59:55
5	fu-berlin.de	27780	966	26814	0	0	3%	23:59:55
6	aioe	27288	464	23181	16	0	1%	23:59:55
7	usenet.pasdenom.info	37156	303	27678	1394	3	0%	23:59:55
8	news.redatomik.org	34025	211	27403	23	1	0%	23:59:55
9	au2pb	29182	158	28129	14	0	0%	23:59:55
10	neva.ru	31445	30	25635	200	0	0%	23:59:34
11	xmission	31807	24	27758	4	0	0%	23:59:55
12	weretis.net	25299	22	24696	2	0	0%	23:59:48
13	news.mixmin.net	30836	17	26234	0	0	0%	23:59:50
14	news.fcku.it	4154	15	3459	0	0	0%	23:29:42
15	eternal-september	29223	7	23481	0	0	0%	23:59:55
16	news.swapon.de	2456	1	2141	1	0	0%	23:56:24
17	bwh	23364	1	21966	0	0	0%	23:59:55
TOTAL: 17		485765	9562	391547	1853	77	1%	407:24:09

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	10.3 MB	11.5 KB	10.3 MB	0.1 KB/s	7.3 KB	23:59:55
2	xanadu-bbs	9.6 MB	31.0 KB	9.6 MB	0.1 KB/s	8.4 KB	23:59:55
3	erje	9.2 MB	545.9 KB	9.8 MB	0.1 KB/s	3.0 KB	23:59:55
4	fu-berlin.de	8.9 MB	0.0 KB	8.9 MB	0.1 KB/s	9.4 KB	23:59:55
5	news.bbs.geek.nz	4.1 MB	185.6 KB	4.3 MB	0.1 KB/s	2.9 KB	23:59:46
6	aioe	1.3 MB	98.5 KB	1.4 MB	0.0 KB/s	3.0 KB	23:59:55
7	usenet.pasdenom.info	1.0 MB	9.7 MB	10.7 MB	0.1 KB/s	6.4 KB	23:59:55
8	news.redatomik.org	732.5 KB	129.5 KB	862.0 KB	0.0 KB/s	3.7 KB	23:59:55
9	au2pb	579.6 KB	74.2 KB	653.8 KB	0.0 KB/s	3.8 KB	23:59:55
10	neva.ru	112.9 KB	696.4 KB	809.2 KB	0.0 KB/s	3.5 KB	23:59:34
11	news.mixmin.net	64.7 KB	0.0 KB	64.7 KB	0.0 KB/s	3.8 KB	23:59:50
12	weretis.net	62.1 KB	38.8 KB	100.9 KB	0.0 KB/s	4.2 KB	23:59:48
13	xmission	60.4 KB	11.9 KB	72.3 KB	0.0 KB/s	2.6 KB	23:59:55
14	news.fcku.it	25.4 KB	0.0 KB	25.4 KB	0.0 KB/s	1.7 KB	23:29:42
15	eternal-september	22.2 KB	0.0 KB	22.2 KB	0.0 KB/s	3.2 KB	23:59:55
16	bwh	2.2 KB	0.0 KB	2.2 KB	0.0 KB/s	2.2 KB	23:59:55
17	news.swapon.de	1.9 KB	1.7 KB	3.6 KB	0.0 KB/s	1.8 KB	23:56:24
TOTAL: 17		46.0 MB	11.4 MB	57.5 MB	0.0 KB/s	5.2 KB	407:24:09

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	95	357.9 KB	90	04:54:02
2	tempe0.bbox.io	35	2	6.8 KB	1	04:58:46
TOTAL: 2		323	97	364.7 KB	91	40:13:53

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	293	95	357.9 KB	90	18:56:31
2	*.bbox.io	35	2	6.8 KB	1	04:58:46
3	*.chello.nl	33	0	0.0 KB	0	14:10:34
4	*.sub-70-193-253.myvzw.com	2	0	0.0 KB	0	01:00:01
5	*.census.shodan.io	1	0	0.0 KB	0	00:00:01
6	*.nielsenmedia.com	5	0	0.0 KB	0	01:07:58
TOTAL: 6		369	97	364.7 KB	91	40:13:53

NNRP auth users [Top 20]:

User	Conn
moussa	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	2.596	0.631	0.000	14:10:34
162.212.88.221	0.693	0.331	0.000	13:32:27
tempe0.bbox.io	2.909	0.611	0.000	04:58:46
202.89.176.220	29.567	6.812	0.770	04:54:02
challenger.nielsenmedia.com	0.232	0.048	0.000	01:07:58
31.sub-70-193-253.myvzw.com	0.162	0.032	0.000	01:00:01
89.99.203.254	0.058	0.017	0.000	00:30:02
rim.census.shodan.io	0.098	0.016	0.000	00:00:01
TOTAL: 8	36.315	8.498	0.770	40:13:53

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	33
challenger.nielsenmedia.com	5
162.212.88.221	4
31.sub-70-193-253.myvzw.com	2
89.99.203.254	1
rim.census.shodan.io	1
TOTAL: 6	46

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	26	0
tempe0.bbox.io	9	0
31.sub-70-193-253.myvzw.com	2	0
challenger.nielsenmedia.com	2	0
89.99.203.254	1	0
TOTAL: 5	40	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	95	97.9%
2	bit	2	2.1%
TOTAL: 2		97	100.0%

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

Newsgroup		Count
1	comp.os.vms	36
2	comp.arch	24
3	comp.arch.embedded	7
4	comp.ai.philosophy	7
5	comp.sys.ibm.as400.misc	5
6	comp.sys.ibm.pc.games.action	5
7	comp.os.os2.apps	2
8	comp.sys.ibm.ps2.hardware	2
9	bit.listserv.ibm-main	2
10	comp.arch.fpga	1
11	comp.sys.ibm.pc.games.flight-sim	1
12	comp.sys.ibm.pc.games.war-historical	1
13	comp.answers	1
14	comp.os.os2.announce	1
15	comp.sys.ibm.pc.games.rpg	1
16	comp.os.qnx	1
TOTAL: 16		97

Daily Usenet report for csiph.com

Jan 11 04:15:00 -- Jan 12 04:15:00