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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	43653	43.5%	8.0 MB	59.3%
nnrpd	28736	28.6%	2.4 MB	17.8%
innd	24860	24.7%	2.6 MB	19.1%
innfeed	3165	3.2%	515.3 KB	3.7%
nocem	47	0.0%	4.7 KB	0.0%
TOTAL: 5	100461	100.0%	13.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	417043	56.1%
Negative hits	284108	38.2%
Do not exist	41758	5.6%
Cache misses	614	0.1%
TOTAL: 4	743523	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.838	0.0%	178	0.000	4.708	88.000
article cleanup	00:00:00.294	0.0%	42740	0.000	0.007	0.033
article logging	00:00:04.925	0.0%	43293	0.000	0.114	1.143
article parse	00:00:02.637	0.0%	138953	0.000	0.019	0.225
article write	00:03:46.895	0.3%	22320	0.244	10.166	46.333
artlog/artcncl	00:00:00.003	0.0%	148	0.000	0.020	0.500
artlog/artparse	00:00:00.033	0.0%	153	0.000	0.216	2.000
data move	00:00:00.361	0.0%	674090	0.000	0.001	0.019
hisgrep/artcncl	00:00:00.238	0.0%	175	0.000	1.360	42.000
hishave/artcncl	00:00:00.084	0.0%	178	0.000	0.472	4.333
hishave/artparse	00:00:00.000	0.0%	152	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:02:24.071	0.2%	747246	0.002	0.193	0.958
history sync	00:00:05.415	0.0%	368	0.000	14.715	93.000
history write	00:04:25.308	0.3%	41799	0.479	6.347	39.600
hiswrite/artcncl	00:00:00.010	0.0%	3	0.000	3.333	5.000
hiswrite/artparse	00:00:00.992	0.0%	152	0.000	6.526	58.000
idle	23:41:01.582	98.6%	647171	68.123	131.745	496.673
nntp read	00:00:03.256	0.0%	684658	0.002	0.005	0.014
overview write	00:05:44.704	0.4%	22320	0.943	15.444	182.643
perl filter	00:01:46.250	0.1%	41653	1.411	2.551	3.810
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.408	0.0%	44679	0.000	0.009	0.041
TOTAL: 24:01:01.527	23:59:28.304	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.072	0.0%	22314	0.000	0.003	0.019
article prepare	00:00:00.001	0.0%	27920	0.000	0.000	0.008
article read	00:00:01.890	0.0%	4698	0.000	0.402	11.714
backlog stats	00:00:00.249	0.0%	409269	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.165	0.0%	317582	0.002	0.007	0.012
data write	00:00:01.878	0.0%	300850	0.002	0.006	0.011
idle	23:53:55.714	100.0%	409269	135.882	210.218	677.062
status file	00:00:00.461	0.0%	294	0.000	1.568	34.750
TOTAL: 23:54:11.389	23:54:02.430	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.927	0.0%	1655	0.406	0.560	0.630
idle	26:11:51.959	99.9%	30030	347.580	3140.591	600123.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.378	0.0%	61192	0.000	0.006	0.167
readart	00:00:23.995	0.0%	9331	0.000	2.572	48.000
TOTAL: 26:13:33.899	26:12:17.259	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1152	132105	6624	113613	11868	5%	95:02:39
2	csiph-out.news.weretis.net	4	48278	4797	42525	956	9%	50:03:21
3	feeder.eternal-september.org	53	36898	3076	28246	5576	8%	36:32:29
4	news-out.aioe.org	7	22649	2034	20567	48	8%	24:33:54
5	news-out.mixmin.net	2	24094	1709	21836	549	7%	24:08:55
6	newsfeed.neva.ru	136	55364	1288	51741	2335	2%	70:55:51
7	newsfeed.fu-berlin.de	36	24375	1133	22971	271	4%	31:31:27
8	news.redatomik.org	1	20775	831	19942	2	4%	23:40:14
9	newsfeeds.xmission.com	3	20743	542	20134	67	2%	23:10:12
10	news.fcku.it	2	10053	164	9828	61	1%	23:59:43
11	news.swapon.de	2	2022	62	1959	1	3%	28:51:24
12	news.freedyn.net	3	25705	62	25558	85	0%	24:09:52
13	nntp.pasdenom.info	3	20967	60	20895	12	0%	24:01:40
14	xanadu-bbs.net	7	947	51	890	6	5%	23:32:59
15	news.bbs.geek.nz	1	20458	6	20450	2	0%	23:59:49
16	localhost	35	0	0	0	0	0%	00:00:00
TOTAL: 16		1447	465433	22439	421155	21839	4%	528:14:29

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	21.3 MB	2.2 MB	72.8 MB	96.3 MB	22%	5.3 KB
2	csiph-out.news.weretis.net	14.5 MB	42.8 KB	11.1 MB	25.6 MB	56%	4.6 KB
3	feeder.eternal-september.org	7.9 MB	9.0 MB	70.9 MB	87.8 MB	9%	10.4 KB
4	news-out.mixmin.net	6.8 MB	0.0 KB	1.2 MB	8.0 MB	85%	3.6 KB
5	news-out.aioe.org	4.9 MB	1.9 KB	117.4 KB	5.0 MB	97%	2.5 KB
6	newsfeed.fu-berlin.de	2.8 MB	0.0 KB	554.4 KB	3.3 MB	83%	2.4 KB
7	newsfeed.neva.ru	2.7 MB	491.1 KB	23.6 MB	26.8 MB	10%	7.6 KB
8	news.redatomik.org	2.5 MB	0.0 KB	3.7 KB	2.5 MB	99%	3.1 KB
9	newsfeeds.xmission.com	1.5 MB	0.0 KB	250.3 KB	1.8 MB	86%	3.0 KB
10	news.fcku.it	282.0 KB	74.4 KB	506.0 KB	862.3 KB	32%	3.8 KB
11	news.freedyn.net	280.3 KB	37.3 KB	678.6 KB	996.1 KB	28%	6.8 KB
12	nntp.pasdenom.info	200.9 KB	5.1 KB	50.8 KB	256.7 KB	78%	3.6 KB
13	news.swapon.de	180.0 KB	0.0 KB	352.0 KB	532.0 KB	33%	8.4 KB
14	xanadu-bbs.net	142.7 KB	0.0 KB	126.0 KB	268.7 KB	53%	4.7 KB
15	news.bbs.geek.nz	8.7 KB	0.0 KB	5.0 KB	13.8 KB	63%	1.7 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		66.0 MB	11.9 MB	182.1 MB	260.0 MB	25%	6.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 13 04:15:00 - 04:59:59	320	1.4%	0.12	1.1 MB	1.7%	0.42
Apr 13 05:00:00 - 05:59:59	597	2.7%	0.17	2.6 MB	3.9%	0.74
Apr 13 06:00:00 - 06:59:59	705	3.2%	0.20	2.1 MB	3.1%	0.59
Apr 13 07:00:00 - 07:59:59	893	4.0%	0.25	2.6 MB	3.9%	0.73
Apr 13 08:00:00 - 08:59:59	1014	4.5%	0.28	2.7 MB	4.1%	0.75
Apr 13 09:00:00 - 09:59:59	1015	4.5%	0.28	2.6 MB	3.9%	0.74
Apr 13 10:00:00 - 10:59:59	1046	4.7%	0.29	2.8 MB	4.3%	0.80
Apr 13 11:00:00 - 11:59:59	1016	4.5%	0.28	2.9 MB	4.5%	0.83
Apr 13 12:00:00 - 12:59:59	1248	5.6%	0.35	3.2 MB	4.8%	0.90
Apr 13 13:00:00 - 13:59:59	1237	5.5%	0.34	3.5 MB	5.4%	1.00
Apr 13 14:00:00 - 14:59:59	1145	5.1%	0.32	3.5 MB	5.3%	0.99
Apr 13 15:00:00 - 15:59:59	1209	5.4%	0.34	3.4 MB	5.3%	0.98
Apr 13 16:00:00 - 16:59:59	1327	5.9%	0.37	3.8 MB	5.8%	1.08
Apr 13 17:00:00 - 17:59:59	1334	6.0%	0.37	4.1 MB	6.2%	1.16
Apr 13 18:00:00 - 18:59:59	1294	5.8%	0.36	3.8 MB	5.9%	1.09
Apr 13 19:00:00 - 19:59:59	1129	5.1%	0.31	3.2 MB	4.9%	0.92
Apr 13 20:00:00 - 20:59:59	1124	5.0%	0.31	3.4 MB	5.1%	0.95
Apr 13 21:00:00 - 21:59:59	1067	4.8%	0.30	3.2 MB	4.9%	0.92
Apr 13 22:00:00 - 22:59:59	793	3.5%	0.22	2.8 MB	4.2%	0.79
Apr 13 23:00:00 - 23:59:59	712	3.2%	0.20	2.2 MB	3.4%	0.63
Apr 14 00:00:00 - 00:59:59	616	2.8%	0.17	1.8 MB	2.7%	0.51
Apr 14 01:00:00 - 01:59:59	575	2.6%	0.16	1.5 MB	2.4%	0.44
Apr 14 02:00:00 - 02:59:59	438	2.0%	0.12	1.4 MB	2.1%	0.39
Apr 14 03:00:00 - 03:59:59	365	1.6%	0.10	1.0 MB	1.6%	0.30
Apr 14 04:00:00 - 04:15:00	125	0.6%	0.14	376.8 KB	0.6%	0.42
TOTAL: 24:00:00	22344	100.0%	0.26	65.5 MB	100.0%	0.78

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.feeder.erje.net	10701	386	185	5	10125
2	feeder.eternal-september.org	5607	52	709	0	4846
3	newsfeed.neva.ru	2378	387	38	0	1953
4	csiph-out.news.weretis.net	996	210	4	0	782
5	newsfeed.fu-berlin.de	624	41	0	0	583
6	news-out.mixmin.net	566	1	0	0	565
7	news.freedyn.net	84	1	1	0	82
8	news.fcku.it	61	0	2	0	59
9	news-out.aioe.org	57	23	1	0	33
10	newsfeeds.xmission.com	49	3	0	0	46
11	news.swapon.de	15	0	0	0	15
12	nntp.pasdenom.info	12	8	1	0	3
13	xanadu-bbs.net	6	0	0	0	6
14	news.redatomik.org	5	0	0	0	5
15	news.bbs.geek.nz	2	2	0	0	0
TOTAL: 15		21163	1114	941	5	19103

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	255
ut.test	186
it.annunci.immobiliari	37
mozilla.support.thunderbird	37
it.annunci.varie	36
it.annunci.commerciali	35
alt.windows7.general	34
it-alt.sport.calcio.juventus	30
spline.eisfair	28
lada.auto	28
gmane.linux.alsa.devel	26
oesterreich.tratsch	23
alt.survival	20
gmane.comp.gis.openstreetmap.tagging	17
mozilla.general	17
alt.tv.star-trek	14
mpc.lists.freebsd.gecko	13
mozilla.dev.security.policy	13
mpc.lists.nanog	12
cakewalk.audio	12
TOTAL: 124	1114

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

Groups	Count
alt.culture.china	2
uk.legal.moderated	1
it.politica.m5s	1
nz.politics.announce	1
TOTAL: 4	5

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	16169
EMP (phn path)	1303
EMP (phn nph)	138
Too many newsgroups	63
Scoring filter (8)	35
HTML Multipart	29
User-issued cancel	28
Binary Payload	16
Scoring filter (10)	12
Scoring filter (15)	9
Scoring filter (11)	7
Scoring filter (13)	7
Scoring filter (14)	7
Scoring filter (9)	6
Too many newsgroups (low_xpost)	6
Scoring filter (20)	5
HTML post	4
EMP (phl)	4
Binary: misplaced 270	1
Binary: misplaced 211	1
TOTAL: 422	18252

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	39	0	40	40
TOTAL: 1	39	0	40	40

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	146
	TOTAL: 1	146
Bad Message-ID's offered
	csiph-out.feeder.erje.net	12
	TOTAL: 1	12
Huge articles
	feeder.eternal-september.org	81
	csiph-out.news.weretis.net	62
	news.fcku.it	4
	news-out.mixmin.net	3
	xanadu-bbs.net	1
	news.swapon.de	1
	TOTAL: 6	152
Including strange strings
	newsfeed.fu-berlin.de	382
	csiph-out.feeder.erje.net	49
	csiph-out.news.weretis.net	39
	news-out.mixmin.net	33
	news.swapon.de	14
	newsfeed.neva.ru	12
	news-out.aioe.org	9
	newsfeeds.xmission.com	7
	feeder.eternal-september.org	4
	news.redatomik.org	3
	TOTAL: 10	552
TOTAL: 4		862

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.bbs.geek.nz	39474	2772	18800	112	0	7%	23:54:02
2	news.freedyn.net	22980	720	21470	3	0	3%	23:50:06
3	xanadu-bbs	24286	719	21498	0	17	2%	23:51:25
4	fu-berlin.de	20944	549	20395	0	0	2%	23:54:08
5	usenet.pasdenom.info	24423	254	20349	1626	13	1%	23:53:50
6	xmission	23528	52	20943	2	0	0%	23:58:41
7	aioe	19722	45	18610	2	0	0%	23:58:24
8	news.redatomik.org	21681	41	20829	14	0	0%	23:55:31
9	weretis.net	16569	4	16029	0	0	0%	23:50:06
10	erje	15577	2	15491	42	0	0%	23:55:30
11	news.fcku.it	2955	2	2886	0	0	0%	22:44:10
12	eternal-september	20267	2	18279	0	0	0%	23:50:06
13	neva.ru	20716	1	20091	13	0	0%	23:50:06
14	news.mixmin.net	20475	1	19611	0	0	0%	23:53:26
15	news.swapon.de	2023	1	1964	0	0	0%	23:57:19
16	au2pb	0	0	0	0	21679	0%	23:50:07
17	bwh	0	0	0	0	21677	0%	23:50:07
TOTAL: 17		295620	5165	257245	1814	43386	1%	404:57:04

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.bbs.geek.nz	7.0 MB	509.7 KB	7.5 MB	0.1 KB/s	2.7 KB	23:54:02
2	news.freedyn.net	5.4 MB	19.3 KB	5.4 MB	0.1 KB/s	7.7 KB	23:50:06
3	xanadu-bbs	5.2 MB	0.0 KB	5.2 MB	0.1 KB/s	7.4 KB	23:51:25
4	fu-berlin.de	4.8 MB	0.0 KB	4.8 MB	0.1 KB/s	9.0 KB	23:54:08
5	usenet.pasdenom.info	952.2 KB	6.7 MB	7.6 MB	0.1 KB/s	4.1 KB	23:53:50
6	xmission	121.3 KB	2.7 KB	124.0 KB	0.0 KB/s	2.3 KB	23:58:41
7	news.redatomik.org	120.8 KB	55.5 KB	176.3 KB	0.0 KB/s	3.2 KB	23:55:31
8	aioe	114.0 KB	7.0 KB	121.0 KB	0.0 KB/s	2.6 KB	23:58:24
9	erje	20.0 KB	159.1 KB	179.0 KB	0.0 KB/s	4.1 KB	23:55:30
10	weretis.net	10.4 KB	0.0 KB	10.4 KB	0.0 KB/s	2.6 KB	23:50:06
11	eternal-september	7.2 KB	0.0 KB	7.2 KB	0.0 KB/s	3.6 KB	23:50:06
12	news.mixmin.net	5.6 KB	0.0 KB	5.6 KB	0.0 KB/s	5.6 KB	23:53:26
13	neva.ru	3.7 KB	33.4 KB	37.1 KB	0.0 KB/s	2.6 KB	23:50:06
14	news.swapon.de	3.6 KB	0.0 KB	3.6 KB	0.0 KB/s	3.6 KB	23:57:19
15	news.fcku.it	3.0 KB	0.0 KB	3.0 KB	0.0 KB/s	1.5 KB	22:44:10
16	au2pb	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:07
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:07
TOTAL: 17		23.8 MB	7.4 MB	31.3 MB	0.0 KB/s	4.6 KB	404:57:04

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	144.138.90.254	248	105	336.8 KB	75	03:18:19
2	204-73-239-109.cust.centrio.cz	2	3	6.9 KB	3	00:23:13
3	tempe0.bbox.io	9	2	2.6 KB	1	04:28:41
TOTAL: 3		259	110	346.3 KB	79	26:13:30

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	252	105	336.8 KB	75	03:21:39
2	*.cust.centrio.cz	2	3	6.9 KB	3	00:23:13
3	*.bbox.io	9	2	2.6 KB	1	04:28:41
4	*.chello.nl	58	0	0.0 KB	0	09:29:21
5	*.47.95.111.ipv4.supernova.orange.pl	5	0	0.0 KB	0	00:07:09
6	*.hsd1.wa.comcast.net	4	0	0.0 KB	0	02:00:02
7	*.173.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	02:09:21
8	*.dhcp.mdsn.wi.charter.com	12	0	0.0 KB	0	04:14:00
TOTAL: 8		343	110	346.3 KB	79	26:13:30

NNRP auth users [Top 20]:

User	Conn
moussa	248
ctomczyk	4
TOTAL: 2	252

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
dhcp-089-099-203-254.chello.nl	4.443	0.844	0.000	09:29:21
tempe0.bbox.io	0.919	0.170	0.000	04:28:41
68-185-181-64.dhcp.mdsn.wi.charter.com	0.844	0.228	0.000	04:14:00
144.138.90.254	22.815	5.962	0.896	03:18:19
h71.173.22.98.dynamic.ip.windstream.net	0.109	0.140	0.000	02:09:21
c-174-61-130-222.hsd1.wa.comcast.net	0.250	0.071	0.000	02:00:02
204-73-239-109.cust.centrio.cz	0.291	0.017	0.023	00:23:13
188.47.95.111.ipv4.supernova.orange.pl	0.377	0.128	0.006	00:07:09
71.94.21.184	0.165	0.053	0.000	00:02:38
196.52.16.4	0.376	1.238	0.000	00:00:40
94.162.209.77	0.045	0.022	0.000	00:00:01
TOTAL: 11	30.634	8.873	0.925	26:13:30

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	58
68-185-181-64.dhcp.mdsn.wi.charter.com	12
188.47.95.111.ipv4.supernova.orange.pl	5
c-174-61-130-222.hsd1.wa.comcast.net	4
71.94.21.184	2
94.162.209.77	1
h71.173.22.98.dynamic.ip.windstream.net	1
196.52.16.4	1
TOTAL: 8	84

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	8	0
68-185-181-64.dhcp.mdsn.wi.charter.com	5	0
c-174-61-130-222.hsd1.wa.comcast.net	4	0
h71.173.22.98.dynamic.ip.windstream.net	1	0
TOTAL: 4	18	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	109	99.1%
2	pl	1	0.9%
TOTAL: 2		110	100.0%

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

Newsgroup		Count
1	comp.arch	38
2	comp.os.vms	30
3	comp.arch.fpga	11
4	comp.os.msdos.misc	7
5	comp.arch.embedded	6
6	comp.sys.ibm.ps2.hardware	3
7	comp.windows.misc	3
8	comp.sys.ibm.pc.games.action	3
9	comp.lang.javascript	2
10	comp.sys.ibm.pc.games.war-historical	2
11	comp.os.cpm	2
12	comp.os.os2.announce	1
13	pl.comp.lang.javascript	1
14	comp.sys.ibm.pc.games.flight-sim	1
TOTAL: 14		110

Daily Usenet report for csiph.com

Apr 13 04:15:00 -- Apr 14 04:15:00