Daily Usenet report for csiph.com: Dec 22 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	25450	49.9%	6.0 MB	63.5%
innd	21673	42.5%	2.8 MB	29.5%
innfeed	3496	6.9%	633.1 KB	6.6%
nnrpd	381	0.7%	41.6 KB	0.4%
nocem	34	0.1%	4.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	51035	100.0%	9.4 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	387986	54.8%
Negative hits	292726	41.3%
Do not exist	24701	3.5%
Cache misses	2573	0.4%
TOTAL: 4	707986	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.250	0.0%	30	0.000	8.333	15.500
article cleanup	00:00:00.147	0.0%	24186	0.000	0.006	0.026
article logging	00:00:00.333	0.0%	24754	0.000	0.013	0.180
article parse	00:00:01.098	0.0%	86569	0.000	0.013	0.042
article write	00:00:07.470	0.0%	17019	0.157	0.439	11.392
artlog/artcncl	00:00:00.000	0.0%	30	0.000	0.000	0.000
artlog/artparse	00:00:00.009	0.0%	592	0.000	0.015	0.105
data move	00:00:00.213	0.0%	676667	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.010	0.0%	29	0.000	0.345	1.000
hishave/artcncl	00:00:00.001	0.0%	30	0.000	0.033	0.111
hishave/artparse	00:00:00.001	0.0%	591	0.000	0.002	0.043
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.561	0.0%	708270	0.002	0.005	0.034
history sync	00:00:01.040	0.0%	342	0.000	3.041	11.333
history write	00:00:12.545	0.0%	24143	0.067	0.520	4.961
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.313	0.0%	591	0.000	0.530	5.000
idle	23:47:33.376	99.8%	687428	81.839	124.600	267.832
nntp read	00:00:02.600	0.0%	688505	0.001	0.004	0.007
overview write	00:01:27.426	0.1%	17019	0.149	5.137	683.230
perl filter	00:00:30.175	0.0%	24142	0.955	1.250	2.156
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.274	0.0%	34072	0.000	0.008	0.025
TOTAL: 23:50:43.380	23:50:00.842	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.039	0.0%	17184	0.000	0.002	0.025
article prepare	00:00:00.003	0.0%	14828	0.000	0.000	0.004
article read	00:00:00.219	0.0%	1261	0.000	0.174	9.200
backlog stats	00:00:00.203	0.0%	406041	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.486	0.0%	318985	0.001	0.005	0.010
data write	00:00:01.752	0.0%	303077	0.001	0.006	0.017
idle	23:53:54.290	100.0%	406041	90.182	211.886	685.853
status file	00:00:00.182	0.0%	269	0.000	0.677	13.000
TOTAL: 23:54:04.469	23:53:58.174	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	14:34:28.191	100.0%	511	65.000	102677.477	600080.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.006	0.0%	1525	0.000	0.004	0.100
readart	00:00:00.824	0.0%	243	0.000	3.391	42.000
TOTAL: 14:34:40.005	14:34:29.021	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	2	15051	3862	11125	64	25%	24:09:03
2	newsfeeds.xmission.com	2	15185	3733	11403	49	24%	24:52:25
3	feeder.eternal-september.org	4	23051	1888	20798	365	8%	23:52:49
4	csiph-out.feeder.erje.net	1440	91373	1434	89377	562	1%	118:55:54
5	csiph-out.news.xs4all.nl	862	23367	1382	19125	2860	5%	71:22:46
6	csiph-out.news.weretis.net	4	39337	1059	37106	1172	2%	44:13:20
7	newsfeed.fu-berlin.de	6	23871	979	22817	75	4%	28:41:02
8	news-out.mixmin.net	3	22865	892	20863	1110	3%	24:08:15
9	newsfeed.neva.ru	149	17711	587	16836	288	3%	72:31:54
10	news.freedyn.net	3	24085	500	23293	292	2%	24:09:00
11	csiph-out.news.tnetconsulting.net	1	26767	395	26351	21	1%	39:40:45
12	csiph-out.feed.uzoreto.com	864	34454	366	33377	711	1%	71:11:25
13	nntp.pasdenom.info	3	13609	113	13487	9	0%	23:57:48
14	news-out.neodome.net	2	23076	79	22883	114	0%	23:59:53
15	news.fcku.it	13	1340	76	1263	1	5%	22:15:59
16	news.swapon.de	6	1248	32	1216	0	2%	20:31:19
17	news.samoylyk.net	1	15436	10	15424	2	0%	23:59:52
18	localhost	29	3	3	0	0	100%	00:00:04
19	news.bbs.nz	1	14641	2	14639	0	0%	23:59:53
20	xanadu-bbs.net	34	335	0	335	0	0%	20:03:25
TOTAL: 20		3429	426805	17392	401718	7695	4%	726:36:51

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	news-out.aioe.org	11.3 MB	6.4 KB	175.8 KB	11.5 MB	98%	3.0 KB
2	newsfeeds.xmission.com	11.0 MB	1.5 KB	2.2 MB	13.2 MB	83%	3.6 KB
3	csiph-out.feeder.erje.net	9.1 MB	19.4 KB	12.1 MB	21.2 MB	43%	10.9 KB
4	csiph-out.news.xs4all.nl	6.1 MB	0.0 KB	26.8 MB	32.9 MB	18%	7.9 KB
5	feeder.eternal-september.org	5.7 MB	11.7 KB	2.8 MB	8.5 MB	66%	3.9 KB
6	csiph-out.news.weretis.net	3.9 MB	10.3 KB	9.9 MB	13.8 MB	28%	6.3 KB
7	news-out.mixmin.net	3.0 MB	6.5 KB	4.4 MB	7.4 MB	40%	3.8 KB
8	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	287.4 KB	2.5 MB	88%	2.4 KB
9	news.freedyn.net	1.9 MB	6.5 KB	2.9 MB	4.8 MB	39%	6.2 KB
10	csiph-out.feed.uzoreto.com	1.8 MB	4.9 KB	13.7 MB	15.5 MB	11%	14.7 KB
11	newsfeed.neva.ru	1.6 MB	10.9 KB	1.1 MB	2.7 MB	59%	3.2 KB
12	csiph-out.news.tnetconsulting.net	1.4 MB	3.6 KB	113.9 KB	1.5 MB	92%	3.6 KB
13	news-out.neodome.net	311.3 KB	10.4 KB	791.7 KB	1.1 MB	27%	5.8 KB
14	nntp.pasdenom.info	250.5 KB	1.5 KB	11.8 KB	263.8 KB	94%	2.2 KB
15	news.fcku.it	142.3 KB	0.0 KB	0.8 KB	143.1 KB	99%	1.9 KB
16	news.swapon.de	85.4 KB	0.0 KB	0.0 KB	85.4 KB	100%	2.7 KB
17	news.samoylyk.net	20.7 KB	3.7 KB	3.7 KB	28.1 KB	73%	2.3 KB
18	localhost	8.9 KB	0.0 KB	0.0 KB	8.9 KB	100%	3.0 KB
19	news.bbs.nz	3.2 KB	0.0 KB	0.0 KB	3.2 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		59.8 MB	97.3 KB	77.1 MB	137.0 MB	43%	5.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 22 04:15:00 - 04:59:59	317	1.9%	0.12	1.3 MB	2.2%	0.50
Dec 22 05:00:00 - 05:59:59	287	1.7%	0.08	844.7 KB	1.4%	0.23
Dec 22 06:00:00 - 06:59:59	479	2.8%	0.13	2.0 MB	3.4%	0.57
Dec 22 07:00:00 - 07:59:59	518	3.0%	0.14	2.5 MB	4.2%	0.71
Dec 22 08:00:00 - 08:59:59	753	4.4%	0.21	3.9 MB	6.7%	1.12
Dec 22 09:00:00 - 09:59:59	833	4.9%	0.23	3.6 MB	6.1%	1.02
Dec 22 10:00:00 - 10:59:59	730	4.3%	0.20	2.7 MB	4.6%	0.77
Dec 22 11:00:00 - 11:59:59	768	4.5%	0.21	2.6 MB	4.4%	0.74
Dec 22 12:00:00 - 12:59:59	684	4.0%	0.19	1.7 MB	2.9%	0.49
Dec 22 13:00:00 - 13:59:59	815	4.8%	0.23	2.4 MB	4.0%	0.67
Dec 22 14:00:00 - 14:59:59	912	5.3%	0.25	2.6 MB	4.4%	0.73
Dec 22 15:00:00 - 15:59:59	833	4.9%	0.23	2.5 MB	4.3%	0.72
Dec 22 16:00:00 - 16:59:59	1051	6.1%	0.29	3.4 MB	5.8%	0.97
Dec 22 17:00:00 - 17:59:59	974	5.7%	0.27	2.8 MB	4.7%	0.79
Dec 22 18:00:00 - 18:59:59	810	4.7%	0.23	2.3 MB	3.9%	0.66
Dec 22 19:00:00 - 19:59:59	1098	6.4%	0.30	4.0 MB	6.7%	1.13
Dec 22 20:00:00 - 20:59:59	857	5.0%	0.24	2.8 MB	4.8%	0.81
Dec 22 21:00:00 - 21:59:59	898	5.3%	0.25	2.7 MB	4.6%	0.77
Dec 22 22:00:00 - 22:59:59	873	5.1%	0.24	3.2 MB	5.4%	0.92
Dec 22 23:00:00 - 23:59:59	751	4.4%	0.21	2.6 MB	4.4%	0.74
Dec 23 00:00:00 - 00:59:59	549	3.2%	0.15	1.7 MB	3.0%	0.50
Dec 23 01:00:00 - 01:59:59	405	2.4%	0.11	1.2 MB	2.1%	0.35
Dec 23 02:00:00 - 02:59:59	424	2.5%	0.12	1.4 MB	2.3%	0.39
Dec 23 03:00:00 - 03:59:59	359	2.1%	0.10	1.5 MB	2.5%	0.43
Dec 23 04:00:00 - 04:15:00	114	0.7%	0.13	654.3 KB	1.1%	0.73
TOTAL: 24:00:00	17092	100.0%	0.20	59.0 MB	100.0%	0.70

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	2846	17	0	2829
2	csiph-out.news.weretis.net	1245	52	6	1187
3	news-out.mixmin.net	1138	0	3	1135
4	csiph-out.feed.uzoreto.com	712	2	2	708
5	csiph-out.feeder.erje.net	559	55	9	495
6	newsfeed.fu-berlin.de	500	34	0	466
7	feeder.eternal-september.org	384	20	3	361
8	news.freedyn.net	303	3	3	297
9	newsfeed.neva.ru	290	70	6	214
10	news-out.aioe.org	156	56	3	97
11	news-out.neodome.net	114	0	3	111
12	newsfeeds.xmission.com	47	7	1	39
13	csiph-out.news.tnetconsulting.net	17	14	2	1
14	nntp.pasdenom.info	9	0	1	8
15	news.swapon.de	5	0	0	5
16	news.samoylyk.net	2	0	2	0
17	news.fcku.it	1	0	0	1
TOTAL: 17		8328	330	44	7954

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	39
spline.eisfair	37
it-alt.sport.calcio.juventus	28
alt.computer.workshop	25
mozilla.test	19
mozilla.general	17
alt.binaries.pictures.purebeauty	13
alt.bbs.synchronet	11
lada.auto	10
oesterreich.tratsch	10
alt.politics	9
alt.survival	6
alt.binaries.ebooks	6
alt.paranormal.spells	6
spline.eisfair.dev	5
alt.philosophy	5
alt.music.pink-floyd.publius	4
lada.photo	4
alt.binaries.android	4
it.hobby.droni	3
TOTAL: 68	330

INND Perl filter [Top 20]:

Reason	Count
EMP (phn path)	5063
EMP (md5)	1484
EMP (phn nph)	81
EMP (phl)	73
0	55
Too many newsgroups	18
Binary Payload	8
HTML Multipart	6
Too many newsgroups (meow)	3
Too many newsgroups (low_xpost)	1
Binary: misplaced binary	1
TOTAL: 11	6793

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feeder.erje.net	197
	csiph-out.news.xs4all.nl	156
	csiph-out.feed.uzoreto.com	131
	csiph-out.news.weretis.net	41
	newsfeeds.xmission.com	39
	news.freedyn.net	13
	feeder.eternal-september.org	11
	news-out.neodome.net	2
	newsfeed.fu-berlin.de	1
	csiph-out.news.tnetconsulting.net	1
	TOTAL: 10	592
Including strange strings
	newsfeed.fu-berlin.de	436
	news-out.aioe.org	93
	csiph-out.news.weretis.net	16
	news-out.mixmin.net	12
	news.swapon.de	5
	news.freedyn.net	4
	csiph-out.feed.uzoreto.com	1
	csiph-out.news.xs4all.nl	1
	newsfeed.neva.ru	1
	TOTAL: 9	569
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		1207

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	22388	770	16321	1	0	3%	23:59:48
2	news.samoylyk.net	17622	523	16559	1	0	2%	23:59:54
3	news.freedyn.net	16972	510	16018	26	0	3%	23:59:50
4	fu-berlin.de	16034	505	15529	0	0	3%	23:59:56
5	news.bbs.nz	32124	393	16142	30	0	1%	23:59:55
6	usenet.pasdenom.info	25052	215	16163	80	22	0%	23:59:56
7	neva.ru	16094	171	15600	63	0	1%	23:59:52
8	aioe	12224	89	11740	2	0	0%	23:59:22
9	newsfeed.xs4all.nl	16066	28	15404	3	112	0%	23:59:55
10	neodome.net	17427	21	16877	0	0	0%	23:59:47
11	news.uzoreto.com	16370	19	16075	157	0	0%	23:59:56
12	tnet	18272	14	16556	1	0	0%	23:59:56
13	news.mixmin.net	16009	9	15475	0	0	0%	23:59:56
14	xmission	15385	7	12911	0	0	0%	23:59:56
15	eternal-september	14993	6	14495	0	0	0%	23:59:56
16	weretis.net	15500	5	15333	9	0	0%	23:59:08
17	news.swapon.de	1336	3	1322	0	0	0%	23:35:43
18	erje	15618	2	15499	44	0	0%	23:59:44
19	news.fcku.it	1181	0	1179	0	0	0%	22:11:38
TOTAL: 19		306667	3290	265198	417	134	1%	453:44:08

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	6.9 MB	4.6 KB	6.9 MB	0.1 KB/s	9.1 KB	23:59:48
2	news.freedyn.net	6.2 MB	39.4 KB	6.2 MB	0.1 KB/s	11.9 KB	23:59:50
3	news.samoylyk.net	6.2 MB	1.4 KB	6.2 MB	0.1 KB/s	12.0 KB	23:59:54
4	fu-berlin.de	6.1 MB	0.0 KB	6.1 MB	0.1 KB/s	12.4 KB	23:59:56
5	news.bbs.nz	940.7 KB	106.4 KB	1.0 MB	0.0 KB/s	2.5 KB	23:59:55
6	usenet.pasdenom.info	566.8 KB	202.4 KB	769.2 KB	0.0 KB/s	2.6 KB	23:59:56
7	neva.ru	334.6 KB	129.7 KB	464.4 KB	0.0 KB/s	2.0 KB	23:59:52
8	aioe	149.9 KB	2.7 KB	152.6 KB	0.0 KB/s	1.7 KB	23:59:22
9	newsfeed.xs4all.nl	85.5 KB	14.6 KB	100.1 KB	0.0 KB/s	3.2 KB	23:59:55
10	neodome.net	67.2 KB	0.0 KB	67.2 KB	0.0 KB/s	3.2 KB	23:59:47
11	news.uzoreto.com	39.5 KB	322.3 KB	361.8 KB	0.0 KB/s	2.1 KB	23:59:56
12	tnet	36.2 KB	1.3 KB	37.5 KB	0.0 KB/s	2.5 KB	23:59:56
13	news.mixmin.net	22.9 KB	0.0 KB	22.9 KB	0.0 KB/s	2.5 KB	23:59:56
14	xmission	21.5 KB	0.0 KB	21.5 KB	0.0 KB/s	3.1 KB	23:59:56
15	weretis.net	15.3 KB	21.2 KB	36.5 KB	0.0 KB/s	2.6 KB	23:59:08
16	eternal-september	12.6 KB	0.0 KB	12.6 KB	0.0 KB/s	2.1 KB	23:59:56
17	news.swapon.de	8.9 KB	0.0 KB	8.9 KB	0.0 KB/s	3.0 KB	23:35:43
18	erje	5.9 KB	88.4 KB	94.3 KB	0.0 KB/s	2.1 KB	23:59:44
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	22:11:38
TOTAL: 19		27.6 MB	934.6 KB	28.5 MB	0.0 KB/s	7.9 KB	453:44:08

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	8	219	440.3 KB	8	3	3	02:18:50
2	a131033.upc-a.chello.nl	27	16	30.7 KB	4	0	0	07:12:37
3	71-13-20-234.dhcp.dlth.mn.charter.com	12	8	16.5 KB	5	0	0	05:03:04
TOTAL: 3		47	243	487.5 KB	17	3	3	14:34:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	8	219	440.3 KB	8	3	3	02:18:50
2	*.upc-a.chello.nl	27	16	30.7 KB	4	0	0	07:12:37
3	*.dhcp.dlth.mn.charter.com	12	8	16.5 KB	5	0	0	05:03:04
4	unresolved	4	0	0.0 KB	0	0	0	00:00:05
5	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:00
TOTAL: 5		52	243	487.5 KB	17	3	3	14:34:39

NNRP auth users [Top 20]:

User	Conn
kev009	3
TOTAL: 1	3

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	1.996	0.364	0.000	07:12:37
71-13-20-234.dhcp.dlth.mn.charter.com	1.058	0.188	0.000	05:03:04
ip72-222-200-117.ph.ph.cox.net	0.780	0.178	0.007	02:18:50
5.87.15.185	0.054	0.023	0.000	00:00:01
94.165.48.193	0.070	0.008	0.000	00:00:01
5.87.14.13	0.068	0.008	0.000	00:00:01
94.163.116.240	0.058	0.017	0.000	00:00:01
scan-141.security.ipip.net	0.059	0.017	0.000	00:00:00
TOTAL: 8	4.143	0.803	0.007	14:34:39

Curious NNRP server explorers [Top 20]:

System	Conn
5.87.15.185	1
scan-141.security.ipip.net	1
94.165.48.193	1
5.87.14.13	1
94.163.116.240	1
TOTAL: 5	5

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
Host: 69.160.37.58:119	1
Connection: close	1
GET / HTTP/1.1	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-13-20-234.dhcp.dlth.mn.charter.com	8	0
ip72-222-200-117.ph.ph.cox.net	3	0
TOTAL: 2	11	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	231	95.1%
2	news	12	4.9%
TOTAL: 2		243	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	219
2	comp.unix.aix	12
3	news.software.nntp	12
TOTAL: 3		243

Daily Usenet report for csiph.com

Dec 22 04:15:00 -- Dec 23 04:15:00