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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20995	49.1%	5.4 MB	64.3%
innd	17671	41.3%	2.3 MB	27.4%
innfeed	3549	8.3%	647.8 KB	7.5%
nnrpd	544	1.3%	61.1 KB	0.7%
nocem	18	0.0%	2.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42778	100.0%	8.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	339737	56.7%
Negative hits	239092	39.9%
Do not exist	20424	3.4%
Cache misses	238	0.0%
TOTAL: 4	599491	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.293	0.0%	35	0.000	8.371	19.000
article cleanup	00:00:00.115	0.0%	20187	0.000	0.006	0.041
article logging	00:00:00.297	0.0%	20642	0.000	0.014	0.050
article parse	00:00:00.816	0.0%	58797	0.000	0.014	0.077
article write	00:00:07.145	0.0%	16778	0.159	0.426	4.027
artlog/artcncl	00:00:00.002	0.0%	35	0.000	0.057	0.200
artlog/artparse	00:00:00.005	0.0%	324	0.000	0.015	1.000
data move	00:00:00.140	0.0%	552368	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.006	0.0%	35	0.000	0.171	1.000
hishave/artcncl	00:00:00.001	0.0%	35	0.000	0.029	0.083
hishave/artparse	00:00:00.000	0.0%	322	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:09.863	0.0%	601793	0.002	0.016	0.101
history sync	00:00:00.783	0.0%	335	0.000	2.337	13.500
history write	00:00:17.391	0.0%	20188	0.070	0.861	4.114
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.301	0.0%	322	0.000	0.935	7.333
idle	23:58:38.679	99.9%	561171	84.838	153.819	476.429
nntp read	00:00:02.082	0.0%	561889	0.001	0.004	0.007
overview write	00:00:20.178	0.0%	16778	0.109	1.203	7.676
perl filter	00:00:26.455	0.0%	20184	1.049	1.311	2.127
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.277	0.0%	33574	0.000	0.008	0.027
TOTAL: 24:00:38.521	24:00:04.829	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.035	0.0%	16907	0.000	0.002	0.021
article prepare	00:00:00.006	0.0%	16600	0.000	0.000	0.025
article read	00:00:00.283	0.0%	1843	0.000	0.154	7.667
backlog stats	00:00:00.214	0.0%	388729	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.394	0.0%	309166	0.000	0.005	0.010
data write	00:00:01.654	0.0%	291451	0.002	0.006	0.013
idle	23:53:43.538	100.0%	388729	122.777	221.294	624.037
status file	00:00:00.202	0.0%	299	0.000	0.676	2.000
TOTAL: 23:53:53.950	23:53:47.326	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	20:20:17.322	100.0%	460	63.500	159168.091	600171.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.007	0.0%	1066	0.000	0.007	0.167
readart	00:00:00.309	0.0%	67	0.000	4.612	55.000
TOTAL: 20:20:32.071	20:20:17.638	100.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	134
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	154

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	16798	4017	12728	53	23%	25:57:07
2	news-out.aioe.org	2	16277	3145	13043	89	19%	24:09:57
3	feeder.eternal-september.org	1	18178	2150	15727	301	11%	22:40:58
4	csiph-out.feeder.erje.net	1439	81384	1884	79066	434	2%	118:48:17
5	newsfeed.neva.ru	152	18585	1094	16979	512	5%	72:46:01
6	csiph-out.news.xs4all.nl	861	18632	917	16640	1075	4%	71:26:54
7	newsfeed.fu-berlin.de	15	18706	863	17518	325	4%	31:10:21
8	news-out.mixmin.net	1	17548	831	16347	370	4%	23:59:54
9	csiph-out.news.weretis.net	4	33691	715	32840	136	2%	47:59:46
10	news.freedyn.net	3	19612	340	19072	200	1%	24:08:41
11	news.fcku.it	9	2208	243	1962	3	11%	21:51:32
12	csiph-out.feed.uzoreto.com	864	26645	204	26242	199	0%	71:15:49
13	nntp.pasdenom.info	2	11546	176	11345	25	1%	23:58:08
14	news-out.neodome.net	2	17771	130	17614	27	0%	23:59:45
15	csiph-out.news.tnetconsulting.net	1	16187	97	16077	13	0%	23:59:58
16	news.swapon.de	7	1491	43	1447	1	2%	25:50:09
17	localhost	35	9	9	0	0	100%	00:00:04
18	news.samoylyk.net	2	16596	7	16589	0	0%	23:59:42
19	news.bbs.nz	2	23104	5	23099	0	0%	33:28:41
20	xanadu-bbs.net	31	514	0	514	0	0%	24:08:07
TOTAL: 20		3435	375482	16870	354849	3763	4%	735:39:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	11.8 MB	0.0 KB	2.8 MB	14.5 MB	81%	3.7 KB
2	csiph-out.feeder.erje.net	10.2 MB	0.0 KB	11.4 MB	21.6 MB	47%	9.6 KB
3	news-out.aioe.org	7.3 MB	0.0 KB	285.7 KB	7.6 MB	96%	2.4 KB
4	feeder.eternal-september.org	5.7 MB	0.0 KB	1.7 MB	7.5 MB	76%	3.1 KB
5	newsfeed.neva.ru	2.4 MB	0.0 KB	1.3 MB	3.7 MB	64%	2.4 KB
6	csiph-out.news.xs4all.nl	2.4 MB	0.0 KB	6.5 MB	8.8 MB	26%	4.5 KB
7	news-out.mixmin.net	2.3 MB	0.0 KB	907.0 KB	3.2 MB	72%	2.8 KB
8	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	897.8 KB	3.1 MB	71%	2.6 KB
9	csiph-out.news.weretis.net	2.1 MB	0.0 KB	2.4 MB	4.5 MB	46%	5.4 KB
10	news.freedyn.net	1.4 MB	0.0 KB	1.2 MB	2.5 MB	53%	4.8 KB
11	csiph-out.feed.uzoreto.com	718.6 KB	0.0 KB	1.7 MB	2.4 MB	29%	6.0 KB
12	news.fcku.it	397.8 KB	0.0 KB	12.5 KB	410.3 KB	96%	1.7 KB
13	nntp.pasdenom.info	374.8 KB	0.0 KB	43.4 KB	418.2 KB	89%	2.1 KB
14	news-out.neodome.net	345.7 KB	0.0 KB	805.6 KB	1.1 MB	30%	7.3 KB
15	csiph-out.news.tnetconsulting.net	311.5 KB	0.0 KB	167.7 KB	479.1 KB	65%	4.4 KB
16	news.swapon.de	113.0 KB	11.8 KB	11.8 KB	136.6 KB	82%	3.1 KB
17	news.bbs.nz	21.1 KB	0.0 KB	0.0 KB	21.1 KB	100%	4.2 KB
18	news.samoylyk.net	18.8 KB	0.0 KB	0.0 KB	18.8 KB	100%	2.7 KB
19	localhost	14.7 KB	0.0 KB	0.0 KB	14.7 KB	100%	1.6 KB
20	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 20		50.0 MB	11.8 KB	32.0 MB	82.0 MB	60%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 16 04:15:00 - 04:59:59	200	1.2%	0.07	727.2 KB	1.4%	0.27
Jan 16 05:00:00 - 05:59:59	431	2.6%	0.12	2.0 MB	4.0%	0.56
Jan 16 06:00:00 - 06:59:59	569	3.4%	0.16	1.7 MB	3.4%	0.47
Jan 16 07:00:00 - 07:59:59	548	3.3%	0.15	1.7 MB	3.5%	0.49
Jan 16 08:00:00 - 08:59:59	712	4.2%	0.20	1.8 MB	3.7%	0.52
Jan 16 09:00:00 - 09:59:59	836	5.0%	0.23	2.0 MB	4.1%	0.58
Jan 16 10:00:00 - 10:59:59	767	4.6%	0.21	2.1 MB	4.2%	0.60
Jan 16 11:00:00 - 11:59:59	747	4.5%	0.21	2.1 MB	4.2%	0.59
Jan 16 12:00:00 - 12:59:59	813	4.8%	0.23	2.5 MB	5.0%	0.70
Jan 16 13:00:00 - 13:59:59	716	4.3%	0.20	1.8 MB	3.5%	0.50
Jan 16 14:00:00 - 14:59:59	858	5.1%	0.24	2.2 MB	4.4%	0.62
Jan 16 15:00:00 - 15:59:59	979	5.8%	0.27	3.5 MB	7.0%	0.98
Jan 16 16:00:00 - 16:59:59	998	6.0%	0.28	3.2 MB	6.4%	0.91
Jan 16 17:00:00 - 17:59:59	1061	6.3%	0.29	3.0 MB	6.1%	0.86
Jan 16 18:00:00 - 18:59:59	952	5.7%	0.26	2.5 MB	5.0%	0.71
Jan 16 19:00:00 - 19:59:59	910	5.4%	0.25	2.7 MB	5.4%	0.76
Jan 16 20:00:00 - 20:59:59	796	4.7%	0.22	2.0 MB	4.0%	0.56
Jan 16 21:00:00 - 21:59:59	715	4.3%	0.20	2.1 MB	4.3%	0.61
Jan 16 22:00:00 - 22:59:59	706	4.2%	0.20	2.0 MB	4.1%	0.58
Jan 16 23:00:00 - 23:59:59	705	4.2%	0.20	2.8 MB	5.5%	0.78
Jan 17 00:00:00 - 00:59:59	479	2.9%	0.13	1.3 MB	2.6%	0.37
Jan 17 01:00:00 - 01:59:59	468	2.8%	0.13	1.5 MB	3.1%	0.44
Jan 17 02:00:00 - 02:59:59	348	2.1%	0.10	1006.5 KB	2.0%	0.28
Jan 17 03:00:00 - 03:59:59	373	2.2%	0.10	1.4 MB	2.8%	0.39
Jan 17 04:00:00 - 04:15:00	79	0.5%	0.09	221.8 KB	0.4%	0.25
TOTAL: 24:00:00	16766	100.0%	0.19	49.7 MB	100.0%	0.59

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	csiph-out.news.xs4all.nl	1079	36	0	0	1043
2	newsfeed.fu-berlin.de	623	41	0	0	582
3	newsfeed.neva.ru	512	74	0	0	438
4	csiph-out.feeder.erje.net	437	66	0	0	371
5	news-out.mixmin.net	372	7	0	0	365
6	feeder.eternal-september.org	318	34	0	1	283
7	news.freedyn.net	207	8	0	0	199
8	csiph-out.feed.uzoreto.com	201	7	0	0	194
9	news-out.aioe.org	171	72	0	0	99
10	csiph-out.news.weretis.net	136	66	0	0	70
11	newsfeeds.xmission.com	54	4	0	0	50
12	news-out.neodome.net	28	3	0	0	25
13	nntp.pasdenom.info	25	0	0	0	25
14	csiph-out.news.tnetconsulting.net	19	16	0	0	3
15	news.swapon.de	9	0	1	0	8
16	news.fcku.it	3	0	0	0	3
TOTAL: 16		4194	434	1	1	3758

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	83
lada.talk	38
alt.windows7.general	33
lada.commerce	16
spline.eisfair	15
mozilla.support.firefox	13
oesterreich.tratsch	13
lada.auto	13
alt.binaries.pictures.purebeauty	11
alt.bbs.synchronet	11
alt.survival	10
it-alt.sport.calcio.juventus	9
mozilla.support.thunderbird	9
mozilla.dev.platform	8
alt.politics.usa	8
alt.paranormal.spells	6
alt.religion	6
spline.eisfair.dev	5
mozilla.test	5
alt.politics	5
TOTAL: 93	434

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

Groups	Count
newsguy.pub.headlines	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2273
EMP (phn path)	322
EMP (phn nph)	163
EMP (phl)	88
0	55
Too many newsgroups	31
HTML Multipart	30
Too many newsgroups (low_xpost)	7
Scoring filter	6
Too many newsgroups (meow)	2
Binary Payload	1
TOTAL: 11	2978

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	2
	TOTAL: 1	2
Bad Message-ID's offered
	csiph-out.feeder.erje.net	51
	csiph-out.feed.uzoreto.com	38
	csiph-out.news.xs4all.nl	33
	TOTAL: 3	122
Huge articles
	csiph-out.feeder.erje.net	204
	newsfeeds.xmission.com	46
	csiph-out.news.weretis.net	25
	news-out.neodome.net	12
	csiph-out.news.xs4all.nl	10
	feeder.eternal-september.org	7
	news.freedyn.net	6
	csiph-out.feed.uzoreto.com	4
	news-out.mixmin.net	4
	csiph-out.news.tnetconsulting.net	3
	TOTAL: 11	322
Including strange strings
	newsfeed.fu-berlin.de	334
	news-out.aioe.org	84
	csiph-out.news.weretis.net	10
	news.swapon.de	8
	news-out.mixmin.net	7
	newsfeeds.xmission.com	3
	csiph-out.feed.uzoreto.com	3
	news.freedyn.net	2
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	1
	TOTAL: 10	454
No colon-space in header
	csiph-out.feeder.erje.net	2
	TOTAL: 1	2
TOTAL: 5		902

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	21489	1368	15394	3	1	6%	23:59:56
2	news.freedyn.net	16844	482	15909	14	0	2%	23:59:56
3	news.samoylyk.net	17432	463	16293	3	0	2%	23:59:56
4	fu-berlin.de	15839	456	15383	0	0	2%	23:59:39
5	news.bbs.nz	21862	400	10850	11	5041	1%	23:59:56
6	tnet	18332	187	16120	0	0	1%	23:59:55
7	usenet.pasdenom.info	16905	137	15930	59	29	0%	23:59:56
8	neva.ru	15050	82	14695	155	0	0%	23:59:44
9	newsfeed.xs4all.nl	16267	36	15657	15	131	0%	23:59:55
10	aioe	13051	32	12477	0	0	0%	23:59:41
11	neodome.net	17301	28	16579	0	0	0%	23:59:45
12	weretis.net	15812	15	15449	4	0	0%	23:59:56
13	xmission	16290	13	12315	0	0	0%	23:59:56
14	news.uzoreto.com	16481	10	16087	121	0	0%	23:59:56
15	news.swapon.de	1467	10	1439	0	2	0%	23:35:10
16	eternal-september	14644	9	13962	0	0	0%	23:59:42
17	news.mixmin.net	15990	9	15288	0	0	0%	23:59:56
18	erje	15361	2	14734	33	0	0%	23:59:43
19	news.fcku.it	1849	0	1846	0	0	0%	21:40:01
TOTAL: 19		288266	3739	256407	418	5204	1%	453:12:39

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.6 MB	11.8 KB	8.6 MB	0.1 KB/s	6.4 KB	23:59:56
2	news.freedyn.net	6.1 MB	17.6 KB	6.2 MB	0.1 KB/s	12.7 KB	23:59:56
3	news.samoylyk.net	6.0 MB	3.1 KB	6.0 MB	0.1 KB/s	13.3 KB	23:59:56
4	fu-berlin.de	6.0 MB	0.0 KB	6.0 MB	0.1 KB/s	13.5 KB	23:59:39
5	news.bbs.nz	1.0 MB	58.4 KB	1.1 MB	0.0 KB/s	2.7 KB	23:59:56
6	tnet	459.4 KB	0.0 KB	459.4 KB	0.0 KB/s	2.5 KB	23:59:55
7	usenet.pasdenom.info	399.5 KB	310.7 KB	710.2 KB	0.0 KB/s	3.6 KB	23:59:56
8	neodome.net	160.8 KB	0.0 KB	160.8 KB	0.0 KB/s	5.7 KB	23:59:45
9	neva.ru	155.5 KB	351.7 KB	507.2 KB	0.0 KB/s	2.1 KB	23:59:44
10	newsfeed.xs4all.nl	127.0 KB	60.2 KB	187.2 KB	0.0 KB/s	3.7 KB	23:59:55
11	aioe	68.1 KB	0.0 KB	68.1 KB	0.0 KB/s	2.1 KB	23:59:41
12	weretis.net	36.9 KB	7.6 KB	44.5 KB	0.0 KB/s	2.3 KB	23:59:56
13	xmission	23.2 KB	0.0 KB	23.2 KB	0.0 KB/s	1.8 KB	23:59:56
14	news.uzoreto.com	17.0 KB	476.9 KB	493.8 KB	0.0 KB/s	3.8 KB	23:59:56
15	news.swapon.de	16.8 KB	0.0 KB	16.8 KB	0.0 KB/s	1.7 KB	23:35:10
16	eternal-september	14.7 KB	0.0 KB	14.7 KB	0.0 KB/s	1.6 KB	23:59:42
17	news.mixmin.net	14.7 KB	0.0 KB	14.7 KB	0.0 KB/s	1.6 KB	23:59:56
18	erje	2.0 KB	65.8 KB	67.8 KB	0.0 KB/s	1.9 KB	23:59:43
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:40:01
TOTAL: 19		29.3 MB	1.3 MB	30.6 MB	0.0 KB/s	7.5 KB	453:12:39

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	36	46	99.3 KB	4	0	0	08:07:39
2	71-90-73-253.dhcp.ftbg.wi.charter.com	34	21	56.1 KB	18	10	9	11:12:40
TOTAL: 2		70	67	155.4 KB	22	10	9	20:20:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	36	46	99.3 KB	4	0	0	08:07:39
2	*.dhcp.ftbg.wi.charter.com	34	21	56.1 KB	18	10	9	11:12:40
3	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
4	*.ph.ph.cox.net	2	0	0.0 KB	0	0	0	01:00:07
5	unresolved	3	0	0.0 KB	0	0	0	00:00:03
TOTAL: 5		76	67	155.4 KB	22	10	9	20:20:31

NNRP auth users [Top 20]:

User	Conn
ohlandl	9
TOTAL: 1	9

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
71-90-73-253.dhcp.ftbg.wi.charter.com	2.884	0.619	0.026	11:12:40
a131033.upc-a.chello.nl	2.548	0.461	0.000	08:07:39
ip72-222-200-117.ph.ph.cox.net	0.224	0.023	0.000	01:00:07
94.164.242.1	0.139	0.015	0.000	00:00:02
scan-141.security.ipip.net	0.049	0.028	0.000	00:00:01
94.164.13.183	0.054	0.023	0.000	00:00:01
TOTAL: 6	5.898	1.169	0.026	20:20:31

Curious NNRP server explorers [Top 20]:

System	Conn
ip72-222-200-117.ph.ph.cox.net	2
94.164.242.1	2
scan-141.security.ipip.net	1
94.164.13.183	1
TOTAL: 4	6

NNRP unrecognized commands (by host):

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

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-90-73-253.dhcp.ftbg.wi.charter.com	13	0
ip72-222-200-117.ph.ph.cox.net	2	0
TOTAL: 2	15	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	69	100.0%
TOTAL: 1		69	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	69
TOTAL: 1		69

Daily Usenet report for csiph.com

Jan 16 04:15:00 -- Jan 17 04:15:00