Daily Usenet report for csiph.com: Dec 11 04:15:01

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	135663	77.1%	14.5 MB	66.5%
inn	24836	14.1%	5.3 MB	24.1%
innd	12667	7.2%	1.6 MB	7.2%
innfeed	2858	1.6%	481.1 KB	2.2%
nocem	3	0.0%	0.2 KB	0.0%
TOTAL: 5	176027	100.0%	21.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	324931	56.7%
Negative hits	223625	39.0%
Do not exist	24159	4.2%
Cache misses	280	0.0%
TOTAL: 4	572995	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.344	0.0%	23	0.000	14.957	128.000
article cleanup	00:00:00.244	0.0%	23212	0.000	0.011	0.173
article logging	00:00:00.460	0.0%	23762	0.000	0.019	0.165
article parse	00:00:05.856	0.0%	73912	0.000	0.079	1.364
article write	00:01:26.954	0.1%	18336	0.226	4.742	45.851
artlog/artcncl	00:00:00.000	0.0%	23	0.000	0.000	0.000
artlog/artparse	00:00:00.016	0.0%	962	0.000	0.017	0.500
data move	00:00:00.472	0.0%	557351	0.000	0.001	0.017
hisgrep/artcncl	00:00:00.058	0.0%	22	0.000	2.636	12.000
hishave/artcncl	00:00:00.040	0.0%	23	0.000	1.739	14.000
hishave/artparse	00:00:00.003	0.0%	961	0.000	0.003	0.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:01:26.456	0.1%	572229	0.002	0.151	1.475
history sync	00:00:01.130	0.0%	359	0.000	3.148	32.000
history write	00:01:26.359	0.1%	23206	0.119	3.721	21.224
hiswrite/artcncl	00:00:00.001	0.0%	1	1.000	1.000	1.000
hiswrite/artparse	00:00:04.697	0.0%	961	0.000	4.888	50.000
idle	23:42:58.731	99.4%	546187	80.595	156.318	529.997
nntp read	00:00:04.577	0.0%	558250	0.003	0.008	0.131
overview write	00:01:32.053	0.1%	18336	0.380	5.020	259.014
perl filter	00:00:57.872	0.1%	23197	1.545	2.495	31.859
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.360	0.0%	36674	0.000	0.010	0.029
TOTAL: 23:50:52.437	23:50:06.683	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.098	0.0%	18406	0.000	0.005	0.083
article prepare	00:00:00.005	0.0%	15056	0.000	0.000	0.036
article read	00:00:01.849	0.0%	1564	0.000	1.182	24.250
backlog stats	00:00:00.236	0.0%	342039	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.880	0.0%	263542	0.001	0.007	0.014
data write	00:00:01.605	0.0%	247438	0.002	0.006	0.015
idle	23:54:44.838	100.0%	342039	140.498	251.681	744.341
status file	00:00:00.435	0.0%	240	0.000	1.812	21.000
TOTAL: 23:54:59.787	23:54:50.946	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	41:55:29.370	99.9%	182039	56.000	829.105	600194.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:02.076	0.0%	364998	0.000	0.006	0.167
readart	00:00:33.452	0.0%	10412	0.000	3.213	62.000
TOTAL: 41:57:34.237	41:56:04.898	99.9%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	8	60994	5544	52489	2961	9%	72:12:34
2	feeder.eternal-september.org	4	20656	1971	18527	158	9%	24:37:21
3	csiph-out.feeder.erje.net	1440	95496	1965	92625	906	2%	119:49:11
4	newsfeeds.xmission.com	3	17038	1681	15347	10	9%	22:46:41
5	news-out.aioe.org	2	18253	1645	16547	61	9%	24:09:02
6	news.redatomik.org	3	17681	1518	16098	65	8%	24:02:43
7	news-out.mixmin.net	3	19298	1381	17094	823	7%	24:08:32
8	newsfeed.neva.ru	144	23985	1133	22139	713	4%	72:25:31
9	newsfeed.fu-berlin.de	12	16624	1089	15346	189	6%	24:57:53
10	news.fcku.it	9	2345	348	1996	1	14%	22:20:06
11	news.swapon.de	6	2851	95	2755	1	3%	46:33:04
12	news.freedyn.net	3	19945	40	19890	15	0%	24:09:41
13	nntp.pasdenom.info	2	17065	32	17031	2	0%	23:58:50
14	localhost	42	16	16	0	0	100%	00:00:00
15	news.bbs.nz	2	18052	4	18048	0	0%	23:59:49
16	xanadu-bbs.net	25	515	0	513	2	0%	22:52:14
TOTAL: 16		1708	350814	18462	326445	5907	5%	573:03:12

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	16.8 MB	14.8 KB	91.9 MB	108.7 MB	15%	13.1 KB
2	csiph-out.feeder.erje.net	11.4 MB	0.0 KB	11.1 MB	22.5 MB	50%	8.0 KB
3	feeder.eternal-september.org	5.3 MB	9.1 KB	1.7 MB	7.0 MB	75%	3.4 KB
4	newsfeeds.xmission.com	4.7 MB	0.0 KB	551.4 KB	5.3 MB	89%	3.2 KB
5	news-out.mixmin.net	4.0 MB	0.0 KB	1.6 MB	5.6 MB	71%	2.6 KB
6	news.redatomik.org	3.8 MB	0.0 KB	1.4 MB	5.2 MB	73%	3.4 KB
7	news-out.aioe.org	3.7 MB	35.3 KB	415.7 KB	4.1 MB	89%	2.5 KB
8	newsfeed.neva.ru	2.8 MB	0.0 KB	2.6 MB	5.4 MB	52%	3.0 KB
9	newsfeed.fu-berlin.de	2.5 MB	0.0 KB	400.9 KB	2.9 MB	86%	2.3 KB
10	news.fcku.it	590.3 KB	0.0 KB	1.0 KB	591.3 KB	99%	1.7 KB
11	news.swapon.de	236.5 KB	0.0 KB	10.0 KB	246.6 KB	95%	2.6 KB
12	news.freedyn.net	156.3 KB	0.0 KB	80.8 KB	237.1 KB	65%	4.3 KB
13	nntp.pasdenom.info	81.8 KB	0.0 KB	3.9 KB	85.7 KB	95%	2.5 KB
14	localhost	29.3 KB	0.0 KB	0.0 KB	29.3 KB	100%	1.8 KB
15	news.bbs.nz	7.0 KB	0.0 KB	0.0 KB	7.0 KB	100%	1.7 KB
16	xanadu-bbs.net	0.0 KB	0.0 KB	5.9 KB	5.9 KB	0%	3.0 KB
TOTAL: 16		56.0 MB	59.1 KB	111.8 MB	167.8 MB	33%	7.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 11 04:15:01 - 04:59:59	271	1.5%	0.10	1.1 MB	1.9%	0.40
Dec 11 05:00:00 - 05:59:59	464	2.5%	0.13	2.1 MB	3.8%	0.60
Dec 11 06:00:00 - 06:59:59	504	2.7%	0.14	1.5 MB	2.7%	0.43
Dec 11 07:00:00 - 07:59:59	542	2.9%	0.15	2.1 MB	3.8%	0.60
Dec 11 08:00:00 - 08:59:59	611	3.3%	0.17	1.9 MB	3.3%	0.53
Dec 11 09:00:00 - 09:59:59	813	4.4%	0.23	2.1 MB	3.7%	0.59
Dec 11 10:00:00 - 10:59:59	996	5.4%	0.28	2.6 MB	4.7%	0.75
Dec 11 11:00:00 - 11:59:59	922	5.0%	0.26	2.7 MB	4.8%	0.77
Dec 11 12:00:00 - 12:59:59	885	4.8%	0.25	2.2 MB	4.0%	0.64
Dec 11 13:00:00 - 13:59:59	849	4.6%	0.24	2.4 MB	4.3%	0.68
Dec 11 14:00:00 - 14:59:59	960	5.2%	0.27	2.7 MB	4.9%	0.78
Dec 11 15:00:00 - 15:59:59	1071	5.8%	0.30	3.8 MB	6.7%	1.07
Dec 11 16:00:00 - 16:59:59	1104	6.0%	0.31	3.7 MB	6.5%	1.04
Dec 11 17:00:00 - 17:59:59	1040	5.6%	0.29	3.1 MB	5.5%	0.88
Dec 11 18:00:00 - 18:59:59	1125	6.1%	0.31	3.1 MB	5.5%	0.88
Dec 11 19:00:00 - 19:59:59	995	5.4%	0.28	3.1 MB	5.6%	0.89
Dec 11 20:00:00 - 20:59:59	968	5.3%	0.27	2.7 MB	4.8%	0.76
Dec 11 21:00:00 - 21:59:59	863	4.7%	0.24	2.3 MB	4.2%	0.66
Dec 11 22:00:00 - 22:59:59	892	4.8%	0.25	2.4 MB	4.3%	0.68
Dec 11 23:00:00 - 23:59:59	783	4.3%	0.22	2.6 MB	4.7%	0.75
Dec 12 00:00:00 - 00:59:59	528	2.9%	0.15	1.5 MB	2.7%	0.42
Dec 12 01:00:00 - 01:59:59	390	2.1%	0.11	1.1 MB	1.9%	0.31
Dec 12 02:00:00 - 02:59:59	371	2.0%	0.10	1.4 MB	2.5%	0.40
Dec 12 03:00:00 - 03:59:59	343	1.9%	0.10	1.4 MB	2.4%	0.38
Dec 12 04:00:00 - 04:15:00	118	0.6%	0.13	438.8 KB	0.8%	0.49
TOTAL: 23:59:59	18408	100.0%	0.21	55.8 MB	100.0%	0.66

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.weretis.net	2942	229	2	2711
2	csiph-out.feeder.erje.net	911	76	0	835
3	news-out.mixmin.net	835	3	0	832
4	newsfeed.neva.ru	713	152	0	561
5	newsfeed.fu-berlin.de	668	26	0	642
6	feeder.eternal-september.org	157	33	1	123
7	news.redatomik.org	76	0	0	76
8	news-out.aioe.org	65	41	4	20
9	news.freedyn.net	15	2	0	13
10	newsfeeds.xmission.com	13	1	0	12
11	news.swapon.de	5	0	0	5
12	xanadu-bbs.net	2	0	0	2
13	nntp.pasdenom.info	2	0	0	2
14	news.fcku.it	1	1	0	0
TOTAL: 14		6405	564	7	5834

Unwanted newsgroups [Top 20]:

Newsgroup	Count
gmane.linux.alsa.devel	92
lada.talk	89
gmane.comp.gis.openstreetmap	40
gmane.linux.kernel	28
lada.auto	25
mozilla.support.thunderbird	22
alt.windows7.general	21
alt.survival	15
mozilla.dev.security.policy	15
oesterreich.tratsch	12
mozilla.support.seamonkey	12
spline.eisfair	11
alt.music.pink-floyd.publius	11
mozilla.support.firefox	10
lada.movies	10
alt.binaries.multimedia.ba	8
alt.politics.usa	7
alt.politics	7
it-alt.comp.software.mozilla	5
alt.2600	5
TOTAL: 95	564

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	3595
EMP (phn path)	280
EMP (phn nph)	122
Too many newsgroups	80
User-issued cancel	79
Binary: misplaced rar	33
EMP (phl)	33
Scoring filter (10)	16
Scoring filter (13)	14
Scoring filter (12)	11
Scoring filter (11)	10
HTML Multipart	8
Binary Payload	5
Scoring filter (9)	4
Scoring filter (8)	3
Scoring filter (15)	3
Scoring filter (14)	3
HTML Image Tags	2
User-issued spam cancel	1
TOTAL: 19	4302

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	6
	TOTAL: 1	6
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.news.weretis.net	765
	csiph-out.feeder.erje.net	177
	feeder.eternal-september.org	12
	newsfeeds.xmission.com	9
	news.redatomik.org	7
	news-out.mixmin.net	1
	newsfeed.fu-berlin.de	1
	TOTAL: 7	972
Including strange strings
	newsfeed.fu-berlin.de	478
	csiph-out.news.weretis.net	18
	news-out.mixmin.net	17
	news.redatomik.org	11
	news-out.aioe.org	6
	feeder.eternal-september.org	5
	news.swapon.de	5
	csiph-out.feeder.erje.net	5
	newsfeed.neva.ru	4
	newsfeeds.xmission.com	2
	TOTAL: 10	551
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 5		1575

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	19116	745	17618	5	0	3%	23:59:47
2	xanadu-bbs	20282	652	17752	1	5	3%	23:59:54
3	fu-berlin.de	17108	612	16496	0	0	3%	23:59:54
4	news.bbs.nz	34689	178	17596	12	2	0%	23:59:54
5	usenet.pasdenom.info	19275	118	17087	1172	20	0%	23:59:54
6	aioe	16180	24	15516	1	0	0%	23:59:54
7	news.mixmin.net	16743	22	16248	0	0	0%	23:59:54
8	news.redatomik.org	16868	20	16239	0	9	0%	23:59:54
9	eternal-september	16407	19	15655	0	0	0%	23:59:54
10	xmission	18639	18	15992	1	1	0%	23:59:54
11	weretis.net	12276	17	12120	0	0	0%	23:59:54
12	erje	16796	17	16292	1	0	0%	23:59:39
13	news.swapon.de	1420	16	1385	0	0	1%	23:36:28
14	neva.ru	16574	8	16301	125	0	0%	23:59:54
15	news.fcku.it	1959	0	1945	0	0	0%	22:03:36
TOTAL: 15		244332	2466	214242	1318	37	1%	357:38:24

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	7.9 MB	13.7 KB	7.9 MB	0.1 KB/s	10.8 KB	23:59:47
2	xanadu-bbs	7.6 MB	6.2 KB	7.6 MB	0.1 KB/s	11.9 KB	23:59:54
3	fu-berlin.de	7.5 MB	0.0 KB	7.5 MB	0.1 KB/s	12.5 KB	23:59:54
4	news.bbs.nz	459.3 KB	70.3 KB	529.6 KB	0.0 KB/s	2.8 KB	23:59:54
5	usenet.pasdenom.info	351.7 KB	8.4 MB	8.7 MB	0.1 KB/s	6.9 KB	23:59:54
6	news.mixmin.net	45.6 KB	0.0 KB	45.6 KB	0.0 KB/s	2.1 KB	23:59:54
7	aioe	45.3 KB	3.8 KB	49.2 KB	0.0 KB/s	2.0 KB	23:59:54
8	eternal-september	43.0 KB	0.0 KB	43.0 KB	0.0 KB/s	2.3 KB	23:59:54
9	xmission	41.1 KB	1.7 KB	42.7 KB	0.0 KB/s	2.2 KB	23:59:54
10	weretis.net	37.5 KB	0.0 KB	37.5 KB	0.0 KB/s	2.2 KB	23:59:54
11	erje	37.5 KB	3.7 KB	41.2 KB	0.0 KB/s	2.3 KB	23:59:39
12	news.redatomik.org	33.8 KB	0.0 KB	33.8 KB	0.0 KB/s	1.7 KB	23:59:54
13	news.swapon.de	29.3 KB	0.0 KB	29.3 KB	0.0 KB/s	1.8 KB	23:36:28
14	neva.ru	13.1 KB	338.0 KB	351.1 KB	0.0 KB/s	2.6 KB	23:59:54
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:03:36
TOTAL: 15		24.1 MB	8.8 MB	32.9 MB	0.0 KB/s	8.9 KB	357:38:24

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	119-18-28-25.cust.aussiebb.net	48	161	439.9 KB	97	0	0	00:55:30
2	mtrlpq2314w-lp140-04-70-53-247-41.dsl.bell.ca	400	85	204.1 KB	28	0	0	09:39:30
3	71-90-72-193.dhcp.ftbg.wi.charter.com	38	21	40.0 KB	19	16	11	10:17:40
4	a131033.upc-a.chello.nl	60	19	37.7 KB	8	0	0	16:54:00
5	208-71-239-109.cust.centrio.cz	3	4	10.0 KB	2	0	0	00:37:41
TOTAL: 5		549	290	731.6 KB	154	16	11	41:57:24

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.cust.aussiebb.net	48	161	439.9 KB	97	0	0	00:55:30
2	*.dsl.bell.ca	400	85	204.1 KB	28	0	0	09:39:30
3	*.dhcp.ftbg.wi.charter.com	38	21	40.0 KB	19	16	11	10:17:40
4	*.upc-a.chello.nl	60	19	37.7 KB	8	0	0	16:54:00
5	*.cust.centrio.cz	3	4	10.0 KB	2	0	0	00:37:41
6	*.nielsenmedia.com	1	0	0.0 KB	0	0	0	00:30:08
7	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:00
8	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
9	*.ph.ph.cox.net	3	0	0.0 KB	0	0	0	02:32:49
10	unresolved	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 10		556	290	731.6 KB	154	16	11	41:57:24

NNRP auth users [Top 20]:

User	Conn
ohlandl	11
ctomczyk	3
TOTAL: 2	14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	5.048	0.732	0.000	16:54:00
71-90-72-193.dhcp.ftbg.wi.charter.com	3.573	0.585	0.041	10:17:40
mtrlpq2314w-lp140-04-70-53-247-41.dsl.bell.ca	46.309	11.119	0.000	09:39:30
ip72-222-200-117.ph.ph.cox.net	0.524	0.078	0.000	02:32:49
119-18-28-25.cust.aussiebb.net	5.550	1.041	0.000	00:55:30
208-71-239-109.cust.centrio.cz	0.350	0.049	0.009	00:37:41
challenger.nielsenmedia.com	0.090	0.015	0.000	00:30:08
c-67-160-62-214.hsd1.wa.comcast.net	0.060	0.020	0.000	00:30:00
94.162.67.166	0.055	0.008	0.000	00:00:01
scan-141.security.ipip.net	0.070	0.015	0.000	00:00:01
TOTAL: 10	61.629	13.662	0.050	41:57:24

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	3
94.162.67.166	1
scan-141.security.ipip.net	1
challenger.nielsenmedia.com	1
c-67-160-62-214.hsd1.wa.comcast.net	1
TOTAL: 5	7

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
User-Agent: HTTP Banner Detection (https...	1
GET / HTTP/1.1	1
Connection: close	1
Host: 69.160.37.58:119	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
mtrlpq2314w-lp140-04-70-53-247-41.dsl.bell.ca	100	100
71-90-72-193.dhcp.ftbg.wi.charter.com	12	0
ip72-222-200-117.ph.ph.cox.net	5	0
208-71-239-109.cust.centrio.cz	1	0
c-67-160-62-214.hsd1.wa.comcast.net	1	0
challenger.nielsenmedia.com	1	0
TOTAL: 6	120	100

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	192	66.2%
2	it	58	20.0%
3	alt	22	7.6%
4	linux	9	3.1%
5	uk	3	1.0%
6	pl	2	0.7%
7	de	1	0.3%
8	microsoft	1	0.3%
9	be	1	0.3%
10	fr	1	0.3%
TOTAL: 10		290	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	61
2	comp.os.vms	42
3	comp.sys.ibm.pc.games.action	38
4	it.comp.os.win.windows10	32
5	it.tlc.cellulari.android	19
6	alt.comp.freeware	16
7	comp.arch	15
8	comp.arch.embedded	8
9	comp.os.cpm	8
10	linux.debian.bugs.dist	7
11	comp.ai.philosophy	6
12	it.sport.calcio.inter-fc	5
13	comp.lang.javascript	4
14	comp.arch.fpga	4
15	comp.sys.raspberry-pi	3
16	alt.os.linux.mint	3
17	pl.pregierz	2
18	it.comp.os.win.windows7	2
19	alt.comp.os.windows-10	2
20	uk.music.charts	2
21	microsoft.public.fr.windows.server	1
22	linux.debian.bugs.rc	1
23	alt.os.linux.pclinuxos	1
24	de.alt.comm.android	1
25	linux.gentoo.user	1
26	fr.petites-annonces.divers	1
27	comp.ai.alife	1
28	comp.sys.ibm.pc.games.rpg	1
29	be.radio	1
30	uk.legal.moderated	1
31	comp.os.msdos.programmer	1
TOTAL: 31		290

Daily Usenet report for csiph.com

Dec 11 04:15:01 -- Dec 12 04:15:00