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

Unknown entries from news log file:

First 1 / 1 lines (100.0%)

Dec 6 17:15:02 csiph pgpverify[86672]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	42552	45.4%	6.3 MB	57.6%
nnrpd	32045	34.2%	2.6 MB	24.0%
innd	17236	18.4%	1.7 MB	15.8%
innfeed	1833	2.0%	290.2 KB	2.6%
controlchan	4	0.0%	0.5 KB	0.0%
pgpverify	1	0.0%	0.1 KB	0.0%
TOTAL: 6	93671	100.0%	11.0 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	222095	47.4%
Negative hits	204636	43.7%
Do not exist	41712	8.9%
Cache misses	125	0.0%
TOTAL: 4	468568	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.353	0.0%	193	0.000	1.829	16.000
article cleanup	00:00:00.281	0.0%	39476	0.000	0.007	0.032
article logging	00:00:00.569	0.0%	39988	0.000	0.014	0.084
article parse	00:00:04.692	0.0%	501408	0.000	0.009	0.325
article write	00:00:48.330	0.1%	23900	0.154	2.022	9.369
artlog/artcncl	00:00:00.002	0.0%	149	0.000	0.013	1.000
artlog/artparse	00:00:00.038	0.0%	2465	0.000	0.015	0.200
data move	00:00:00.442	0.0%	910093	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.040	0.0%	193	0.000	0.207	8.667
hishave/artcncl	00:00:00.000	0.0%	193	0.000	0.000	0.000
hishave/artparse	00:00:00.007	0.0%	2465	0.000	0.003	0.167
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.140	0.0%	468289	0.001	0.009	0.102
history sync	00:00:01.854	0.0%	366	0.000	5.066	73.000
history write	00:00:35.701	0.0%	39464	0.069	0.905	9.617
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.996	0.0%	2461	0.000	0.405	69.000
idle	23:56:23.674	99.7%	886092	9.978	97.263	430.542
nntp read	00:00:02.739	0.0%	887992	0.001	0.003	0.006
overview write	00:01:01.518	0.1%	23900	0.443	2.574	23.778
perl filter	00:01:09.128	0.1%	39464	0.920	1.752	3.648
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.417	0.0%	47801	0.000	0.009	0.030
TOTAL: 24:00:53.500	24:00:14.921	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.071	0.0%	23850	0.000	0.003	0.024
article prepare	00:00:00.002	0.0%	4638	0.000	0.000	0.019
article read	00:00:00.187	0.0%	915	0.000	0.204	6.571
backlog stats	00:00:00.093	0.0%	261023	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.088	0.0%	203708	0.000	0.005	0.014
data write	00:00:01.367	0.0%	182905	0.000	0.007	0.017
idle	23:54:00.061	100.0%	261023	188.376	329.626	908.717
status file	00:00:00.104	0.0%	176	0.000	0.591	10.000
TOTAL: 23:54:06.545	23:54:02.973	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.013	0.0%	154	0.000	0.084	0.200
idle	24:33:45.226	99.9%	31702	0.000	2789.263	600261.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.388	0.0%	64546	0.000	0.006	0.333
readart	00:00:00.054	0.0%	135	0.000	0.400	35.000
TOTAL: 24:35:23.218	24:33:45.681	99.9%	-	-	-	-

Control commands to INND:

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

Control Channel:

Sender	newgroup	rmgroup	Other	Bad PGP	DoIt	OK
moderator@dana.de	0	0	0	1	0	0
TOTAL	0	0	0	1	0	0

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	au2pb.net	1	25377	6270	18094	1013	24%	23:18:00
2	feeder.eternal-september.org	5	35996	5898	28487	1611	16%	24:37:14
3	news-out.mixmin.net	3	30798	3457	23958	3383	11%	24:08:47
4	xanadu-bbs.net	5	41268	3108	29851	8309	7%	25:16:41
5	newsfeed.neva.ru	150	49497	1676	44620	3201	3%	72:49:36
6	newsfeeds.xmission.com	1	25580	1572	23906	102	6%	25:27:28
7	newsfeed.fu-berlin.de	46	28191	1355	26486	350	4%	31:22:25
8	nntp.pasdenom.info	4	23997	199	23761	37	0%	24:11:37
9	news.swapon.de	5	2542	153	2386	3	6%	23:46:59
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		246	263246	23688	221549	18009	8%	274:58:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	au2pb.net	16.4 MB	10.0 KB	5.6 MB	22.0 MB	74%	3.1 KB
2	feeder.eternal-september.org	16.0 MB	18.8 KB	12.5 MB	28.6 MB	56%	3.9 KB
3	news-out.mixmin.net	13.1 MB	4.3 KB	7.1 MB	20.2 MB	64%	3.0 KB
4	xanadu-bbs.net	8.4 MB	37.6 KB	615.0 MB	623.5 MB	1%	55.9 KB
5	newsfeed.neva.ru	5.2 MB	5.5 KB	15.9 MB	21.1 MB	24%	4.4 KB
6	newsfeeds.xmission.com	4.8 MB	1.9 KB	2.7 MB	7.5 MB	63%	4.6 KB
7	newsfeed.fu-berlin.de	2.8 MB	0.0 KB	811.6 KB	3.6 MB	77%	2.2 KB
8	nntp.pasdenom.info	512.3 KB	1.9 KB	801.0 KB	1.3 MB	38%	5.6 KB
9	news.swapon.de	423.7 KB	0.0 KB	7.1 KB	430.8 KB	98%	2.8 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		67.6 MB	80.0 KB	660.5 MB	728.1 MB	9%	17.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 6 04:15:00 - 04:59:59	354	1.5%	0.13	1.2 MB	1.7%	0.45
Dec 6 05:00:00 - 05:59:59	455	1.9%	0.13	1.5 MB	2.2%	0.43
Dec 6 06:00:00 - 06:59:59	445	1.9%	0.12	1.4 MB	2.1%	0.40
Dec 6 07:00:00 - 07:59:59	664	2.8%	0.18	2.1 MB	3.0%	0.59
Dec 6 08:00:00 - 08:59:59	798	3.3%	0.22	2.1 MB	3.0%	0.59
Dec 6 09:00:00 - 09:59:59	1040	4.4%	0.29	2.6 MB	3.8%	0.74
Dec 6 10:00:00 - 10:59:59	1192	5.0%	0.33	3.3 MB	4.8%	0.93
Dec 6 11:00:00 - 11:59:59	1154	4.8%	0.32	3.3 MB	4.8%	0.93
Dec 6 12:00:00 - 12:59:59	1261	5.3%	0.35	3.4 MB	4.9%	0.96
Dec 6 13:00:00 - 13:59:59	1237	5.2%	0.34	3.2 MB	4.7%	0.92
Dec 6 14:00:00 - 14:59:59	1115	4.7%	0.31	3.0 MB	4.4%	0.85
Dec 6 15:00:00 - 15:59:59	1244	5.2%	0.35	3.4 MB	5.0%	0.96
Dec 6 16:00:00 - 16:59:59	1429	6.0%	0.40	4.2 MB	6.2%	1.20
Dec 6 17:00:00 - 17:59:59	1459	6.1%	0.41	4.2 MB	6.2%	1.21
Dec 6 18:00:00 - 18:59:59	1423	6.0%	0.40	4.3 MB	6.2%	1.21
Dec 6 19:00:00 - 19:59:59	1298	5.4%	0.36	3.4 MB	5.0%	0.96
Dec 6 20:00:00 - 20:59:59	1316	5.5%	0.37	3.4 MB	4.9%	0.96
Dec 6 21:00:00 - 21:59:59	1314	5.5%	0.36	3.9 MB	5.7%	1.11
Dec 6 22:00:00 - 22:59:59	1178	4.9%	0.33	3.1 MB	4.6%	0.89
Dec 6 23:00:00 - 23:59:59	935	3.9%	0.26	2.8 MB	4.1%	0.79
Dec 7 00:00:00 - 00:59:59	755	3.2%	0.21	2.3 MB	3.3%	0.65
Dec 7 01:00:00 - 01:59:59	629	2.6%	0.17	1.9 MB	2.8%	0.55
Dec 7 02:00:00 - 02:59:59	553	2.3%	0.15	1.9 MB	2.8%	0.55
Dec 7 03:00:00 - 03:59:59	509	2.1%	0.14	2.0 MB	3.0%	0.58
Dec 7 04:00:00 - 04:15:00	138	0.6%	0.15	440.8 KB	0.6%	0.49
TOTAL: 24:00:00	23895	100.0%	0.28	68.2 MB	100.0%	0.81

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	8251	380	1	7870
2	news-out.mixmin.net	3405	5	2	3398
3	newsfeed.neva.ru	3207	734	3	2470
4	feeder.eternal-september.org	1651	189	2	1460
5	au2pb.net	1060	925	2	133
6	newsfeed.fu-berlin.de	792	58	0	734
7	newsfeeds.xmission.com	87	54	1	32
8	nntp.pasdenom.info	36	22	1	13
9	news.swapon.de	19	0	0	19
TOTAL: 9		18508	2367	12	16129

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	205
mailing.freebsd.pkg-fallout	151
lada.talk	130
alt.politics	126
ut.test	107
mailing.freebsd.ports-bugs	102
mailing.freebsd.svn-ports-all	91
mailing.freebsd.svn-ports-head	89
alt.survival	74
pld.cvs.commit	70
alt.politics.scorched-earth	52
mailing.openbsd.tech	49
fa.openbsd.tech	49
mailing.openbsd.source-changes	47
it-alt.sport.calcio.juventus	46
alt.windows7.general	39
fa.openbsd.source-changes	36
gmane.linux.alsa.devel	35
lada.auto	29
mpc.lists.nanog	29
TOTAL: 209	2367

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	8814
EMP (phn path)	2690
EMP (phl)	1053
EMP (phn nph)	284
PFM bot misc	201
Too many newsgroups	47
HTML Multipart	28
HTML post	14
HTML Image Tags	7
Too many newsgroups (low_xpost)	5
Binary: misplaced rar	4
User-issued spam cancel	2
U2 violation - invalid distribution	2
Binary: misplaced nfo	1
Binary: non-binary distribution	1
TOTAL: 15	13153

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	2304
	feeder.eternal-september.org	62
	au2pb.net	39
	newsfeeds.xmission.com	28
	news-out.mixmin.net	21
	nntp.pasdenom.info	9
	newsfeed.fu-berlin.de	1
	TOTAL: 7	2464
Including strange strings
	newsfeed.fu-berlin.de	428
	feeder.eternal-september.org	38
	news.swapon.de	16
	news-out.mixmin.net	10
	au2pb.net	9
	newsfeeds.xmission.com	4
	xanadu-bbs.net	3
	newsfeed.neva.ru	3
	nntp.pasdenom.info	1
	TOTAL: 9	512
TOTAL: 2		2976

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	usenet.pasdenom.info	27504	130	22949	617	0	12	0%	23:59:57
2	xanadu-bbs	22741	100	20548	38	0	0	0%	23:59:55
3	au2pb	18165	84	17363	75	0	0	0%	23:59:18
4	xmission	27649	21	22114	1	1	0	0%	23:59:57
5	fu-berlin.de	22257	20	22215	22	0	0	0%	23:59:57
6	news.mixmin.net	21137	11	20412	0	0	0	0%	23:59:57
7	neva.ru	23051	4	22054	29	0	0	0%	23:59:56
8	eternal-september	18172	2	17365	4	0	0	0%	23:59:54
9	news.swapon.de	2325	0	2313	1	0	0	0%	23:57:56
TOTAL: 9		183001	372	167333	787	1	12	0%	215:56:47

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	usenet.pasdenom.info	591.8 KB	1.4 MB	2.0 MB	2.8 KB	23:59:57
2	xanadu-bbs	522.3 KB	107.0 KB	629.3 KB	4.6 KB	23:59:55
3	au2pb	430.8 KB	201.1 KB	631.9 KB	4.0 KB	23:59:18
4	fu-berlin.de	112.2 KB	26.4 KB	138.6 KB	3.3 KB	23:59:57
5	xmission	57.4 KB	1.4 KB	58.7 KB	2.7 KB	23:59:57
6	news.mixmin.net	54.9 KB	0.0 KB	54.9 KB	5.0 KB	23:59:57
7	neva.ru	28.5 KB	147.5 KB	176.1 KB	5.3 KB	23:59:56
8	eternal-september	9.1 KB	6.1 KB	15.2 KB	2.5 KB	23:59:54
9	news.swapon.de	0.0 KB	3.0 KB	3.0 KB	3.0 KB	23:57:56
TOTAL: 9		1.8 MB	1.9 MB	3.7 MB	3.3 KB	215:56:47

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	133	419.7 KB	122	04:27:11
2	challenger.nielsenmedia.com	2	1	3.2 KB	1	00:30:12
3	pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	1	3.2 KB	1	01:01:12
TOTAL: 3		292	135	426.1 KB	124	24:35:19

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	318	133	419.7 KB	122	04:36:45
2	*.nielsenmedia.com	2	1	3.2 KB	1	00:30:12
3	*.tampfl.dsl-w.verizon.net	2	1	3.2 KB	1	01:01:12
4	*.bbox.io	6	0	0.0 KB	0	03:00:01
5	*.chello.nl	36	0	0.0 KB	0	14:25:55
6	*.248.91.75.dynamic.ip.windstream.net	1	0	0.0 KB	0	01:00:36
7	*.ip-188-165-239.eu	2	0	0.0 KB	0	00:00:35
TOTAL: 7		367	135	426.1 KB	124	24:35:19

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	3.103	0.621	0.000	14:25:55
202.89.176.220	31.762	6.499	0.759	04:27:11
tempe0.bbox.io	0.638	0.131	0.000	03:00:01
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.168	0.040	0.000	01:01:12
h130.248.91.75.dynamic.ip.windstream.net	0.201	0.031	0.000	01:00:36
challenger.nielsenmedia.com	0.212	0.063	0.000	00:30:12
89.99.203.254	0.086	0.023	0.000	00:09:31
ns342002.ip-188-165-239.eu	0.134	0.056	0.000	00:00:35
69.160.37.54	1.963	0.468	0.000	00:00:02
TOTAL: 9	38.267	7.932	0.759	24:35:19

Curious NNRP server explorers [Top 20]:

System	Conn
dhcp-089-099-203-254.chello.nl	36
69.160.37.54	25
tempe0.bbox.io	6
216.246.166.29	4
ns342002.ip-188-165-239.eu	2
89.99.203.254	1
h130.248.91.75.dynamic.ip.windstream.net	1
TOTAL: 7	75

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	26	0
tempe0.bbox.io	6	0
h130.248.91.75.dynamic.ip.windstream.net	2	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	0
challenger.nielsenmedia.com	1	0
TOTAL: 5	37	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.os.vms	50
2	comp.arch	39
3	comp.sys.ibm.pc.games.action	14
4	comp.arch.embedded	9
5	comp.os.os2.misc	9
6	comp.ai.philosophy	3
7	comp.lang.awk	2
8	comp.os.os2.announce	2
9	comp.ai.neural-nets	2
10	comp.sys.ibm.pc.games.war-historical	2
11	comp.bbs.majorbbs	1
12	comp.archives.ms-windows.discuss	1
13	comp.sys.ibm.pc.games.rpg	1
TOTAL: 13		135

Daily Usenet report for csiph.com

Dec 6 04:15:00 -- Dec 7 04:15:00