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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	61746	45.4%	9.5 MB	57.6%
innd	39781	29.2%	3.9 MB	23.7%
nnrpd	32092	23.6%	2.7 MB	16.4%
innfeed	2516	1.8%	396.4 KB	2.3%
TOTAL: 4	136135	100.0%	16.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	549109	58.4%
Negative hits	328221	34.9%
Do not exist	60470	6.4%
Cache misses	2755	0.3%
TOTAL: 4	940555	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.377	0.0%	226	0.000	1.668	20.000
article cleanup	00:00:00.335	0.0%	51398	0.000	0.007	0.029
article logging	00:00:00.788	0.0%	51895	0.000	0.015	0.292
article parse	00:00:35.356	0.0%	1788695	0.000	0.020	0.086
article write	00:00:48.721	0.1%	25440	0.211	1.915	8.414
artlog/artcncl	00:00:00.004	0.0%	187	0.000	0.021	1.000
artlog/artparse	00:00:00.125	0.0%	9888	0.000	0.013	1.000
data move	00:00:01.343	0.0%	2349401	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.042	0.0%	221	0.000	0.190	15.000
hishave/artcncl	00:00:00.000	0.0%	226	0.000	0.000	0.000
hishave/artparse	00:00:00.037	0.0%	9888	0.000	0.004	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:09.608	0.0%	936190	0.001	0.010	0.067
history sync	00:00:02.122	0.0%	311	0.000	6.823	80.500
history write	00:01:28.788	0.1%	50872	0.093	1.745	6.706
hiswrite/artcncl	00:00:00.000	0.0%	5	0.000	0.000	0.000
hiswrite/artparse	00:00:21.912	0.0%	9886	0.000	2.216	16.429
idle	23:52:24.627	99.4%	2374914	8.125	36.189	345.413
nntp read	00:00:07.587	0.0%	2390017	0.002	0.003	0.006
overview write	00:01:32.043	0.1%	25440	0.567	3.618	15.688
perl filter	00:02:03.389	0.1%	50807	1.015	2.429	4.865
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.492	0.0%	50880	0.000	0.010	0.035
TOTAL: 24:00:22.938	23:59:37.696	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.082	0.0%	25705	0.000	0.003	0.029
article prepare	00:00:00.003	0.0%	30912	0.000	0.000	0.005
article read	00:00:00.650	0.0%	4219	0.000	0.154	2.421
backlog stats	00:00:00.169	0.0%	395003	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.632	0.0%	301116	0.000	0.005	0.010
data write	00:00:02.007	0.0%	281511	0.003	0.007	0.015
idle	23:53:45.184	100.0%	395003	122.223	217.784	690.062
status file	00:00:00.154	0.0%	235	0.000	0.655	12.000
TOTAL: 23:53:59.219	23:53:49.881	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:05.586	0.0%	80079	0.023	0.070	0.204
idle	188:02:26.449	99.9%	111570	45.250	6067.459	600160.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.390	0.0%	224067	0.000	0.006	0.167
readart	00:00:00.124	0.0%	69	0.000	1.797	59.000
TOTAL: 188:08:24.169	188:02:33.549	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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	47547	7984	26553	13010	16%	23:44:55
2	csiph-out.feeder.erje.net	1154	198357	4621	186286	7450	2%	94:58:23
3	feeder.eternal-september.org	10	43771	4360	37863	1548	9%	24:21:37
4	newsfeed.neva.ru	141	88280	1936	83471	2873	2%	71:34:55
5	au2pb.net	1	27549	1700	25701	148	6%	26:19:53
6	news-out.mixmin.net	2	28653	1466	26678	509	5%	24:08:44
7	newsfeed.fu-berlin.de	41	26986	1176	25694	116	4%	29:59:14
8	news.fcku.it	1	5961	683	5278	0	11%	20:38:31
9	newsfeeds.xmission.com	1	22180	535	21590	55	2%	20:24:40
10	news.freedyn.net	59	30071	293	29697	81	0%	25:06:19
11	xanadu-bbs.net	19	59027	236	48818	9973	0%	42:25:31
12	nntp.pasdenom.info	3	24325	88	24221	16	0%	24:08:37
13	news.swapon.de	3	2212	47	2165	0	2%	22:47:14
14	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 14		1749	604919	25125	544015	35779	4%	450:38:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	22.1 MB	362.3 KB	128.6 MB	151.0 MB	14%	7.4 KB
2	csiph-out.feeder.erje.net	21.6 MB	3.9 MB	54.7 MB	80.3 MB	26%	6.8 KB
3	feeder.eternal-september.org	11.3 MB	961.2 KB	21.8 MB	34.0 MB	33%	5.9 KB
4	newsfeed.neva.ru	5.2 MB	674.9 KB	18.2 MB	24.1 MB	21%	5.1 KB
5	news-out.mixmin.net	4.8 MB	50.0 KB	1.5 MB	6.3 MB	75%	3.3 KB
6	au2pb.net	3.8 MB	3.6 KB	454.8 KB	4.2 MB	89%	2.4 KB
7	newsfeed.fu-berlin.de	2.6 MB	0.0 KB	401.9 KB	3.0 MB	86%	2.4 KB
8	newsfeeds.xmission.com	1.7 MB	0.0 KB	458.6 KB	2.2 MB	79%	3.8 KB
9	news.fcku.it	1.2 MB	0.0 KB	0.0 KB	1.2 MB	100%	1.8 KB
10	xanadu-bbs.net	755.9 KB	38.2 KB	2.6 GB	2.6 GB	0%	266.4 KB
11	news.freedyn.net	745.9 KB	0.0 KB	1.3 MB	2.0 MB	36%	5.4 KB
12	nntp.pasdenom.info	188.4 KB	0.0 KB	189.1 KB	377.6 KB	49%	3.6 KB
13	news.swapon.de	124.2 KB	0.0 KB	0.0 KB	124.2 KB	100%	2.6 KB
14	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 14		76.1 MB	6.0 MB	2.8 GB	2.9 GB	2%	49.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 29 04:15:00 - 04:59:59	336	1.3%	0.12	1.2 MB	1.6%	0.47
Dec 29 05:00:00 - 05:59:59	463	1.8%	0.13	1.9 MB	2.5%	0.55
Dec 29 06:00:00 - 06:59:59	545	2.1%	0.15	1.8 MB	2.3%	0.50
Dec 29 07:00:00 - 07:59:59	596	2.3%	0.17	1.7 MB	2.2%	0.47
Dec 29 08:00:00 - 08:59:59	1139	4.5%	0.32	3.6 MB	4.6%	1.01
Dec 29 09:00:00 - 09:59:59	1193	4.7%	0.33	3.9 MB	5.1%	1.12
Dec 29 10:00:00 - 10:59:59	1365	5.4%	0.38	4.5 MB	5.8%	1.27
Dec 29 11:00:00 - 11:59:59	1204	4.7%	0.33	3.4 MB	4.4%	0.96
Dec 29 12:00:00 - 12:59:59	1369	5.4%	0.38	5.0 MB	6.5%	1.43
Dec 29 13:00:00 - 13:59:59	1085	4.3%	0.30	3.1 MB	4.0%	0.88
Dec 29 14:00:00 - 14:59:59	1190	4.7%	0.33	3.2 MB	4.2%	0.92
Dec 29 15:00:00 - 15:59:59	1241	4.9%	0.34	3.6 MB	4.6%	1.01
Dec 29 16:00:00 - 16:59:59	1416	5.6%	0.39	4.1 MB	5.3%	1.17
Dec 29 17:00:00 - 17:59:59	1427	5.6%	0.40	3.9 MB	5.1%	1.12
Dec 29 18:00:00 - 18:59:59	1416	5.6%	0.39	4.9 MB	6.3%	1.38
Dec 29 19:00:00 - 19:59:59	1436	5.6%	0.40	3.7 MB	4.8%	1.05
Dec 29 20:00:00 - 20:59:59	1420	5.6%	0.39	4.0 MB	5.2%	1.14
Dec 29 21:00:00 - 21:59:59	1629	6.4%	0.45	4.9 MB	6.4%	1.40
Dec 29 22:00:00 - 22:59:59	1263	5.0%	0.35	3.4 MB	4.4%	0.96
Dec 29 23:00:00 - 23:59:59	905	3.6%	0.25	2.4 MB	3.2%	0.69
Dec 30 00:00:00 - 00:59:59	818	3.2%	0.23	2.4 MB	3.2%	0.69
Dec 30 01:00:00 - 01:59:59	682	2.7%	0.19	2.0 MB	2.6%	0.57
Dec 30 02:00:00 - 02:59:59	571	2.2%	0.16	1.9 MB	2.4%	0.53
Dec 30 03:00:00 - 03:59:59	591	2.3%	0.16	2.1 MB	2.7%	0.59
Dec 30 04:00:00 - 04:15:00	146	0.6%	0.16	587.7 KB	0.7%	0.65
TOTAL: 24:00:00	25446	100.0%	0.29	77.1 MB	100.0%	0.91

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	usenet.blueworldhosting.com	12943	956	30	11957
2	xanadu-bbs.net	9979	59	2	9918
3	csiph-out.feeder.erje.net	7416	407	342	6667
4	newsfeed.neva.ru	2857	1037	58	1762
5	feeder.eternal-september.org	1549	105	81	1363
6	newsfeed.fu-berlin.de	536	21	0	515
7	news-out.mixmin.net	518	0	10	508
8	au2pb.net	147	137	2	8
9	news.freedyn.net	68	0	0	68
10	newsfeeds.xmission.com	60	56	0	4
11	news.fcku.it	22	0	0	22
12	nntp.pasdenom.info	16	12	0	4
13	news.swapon.de	2	0	0	2
TOTAL: 13		36113	2790	525	32798

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	381
lada.talk	199
ut.test	182
lada.auto	94
mailing.freebsd.svn-ports-all	86
mailing.freebsd.pkg-fallout	86
mailing.freebsd.svn-ports-head	81
alt.survival	69
pld.cvs.commit	67
mailing.freebsd.ports-bugs	58
mailing.openbsd.ports-changes	53
mailing.freebsd.svn-src-all	45
fa.freebsd.cvs-all	44
0	44
it-alt.sport.calcio.juventus	39
mailing.freebsd.svn-src-head	38
mailing.freebsd.current	38
mailing.unix.spamassassin-talk	34
fa.openbsd.tech	33
mailing.openbsd.tech	33
TOTAL: 240	2790

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	17251
EMP (phn path)	3216
EMP (phl)	833
PFM bot misc	698
EMP (phn nph)	128
HTML Multipart	86
Too many newsgroups	84
Binary Payload	16
HTML Image Tags	8
HTML post	8
Binary: misplaced par2	4
MID-Bot	3
User-issued spam cancel	3
Binary: misplaced sfv	2
Binary: misplaced rar	2
Binary: misplaced nfo	1
Binary: misplaced srr	1
Binary: misplaced par	1
Binary Image: misplaced jpg	1
TOTAL: 19	22346

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	62
	usenet.blueworldhosting.com	2
	TOTAL: 2	64
Huge articles
	xanadu-bbs.net	9646
	usenet.blueworldhosting.com	160
	feeder.eternal-september.org	50
	news-out.mixmin.net	12
	news.freedyn.net	10
	newsfeeds.xmission.com	4
	nntp.pasdenom.info	3
	au2pb.net	2
	newsfeed.fu-berlin.de	2
	TOTAL: 9	9889
Including strange strings
	newsfeed.fu-berlin.de	421
	news.fcku.it	22
	feeder.eternal-september.org	15
	csiph-out.feeder.erje.net	14
	news-out.mixmin.net	11
	usenet.blueworldhosting.com	7
	au2pb.net	5
	news.swapon.de	2
	newsfeed.neva.ru	1
	TOTAL: 9	498
TOTAL: 3		10451

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	26015	3073	21861	256	0	11%	23:59:53
2	xanadu-bbs	28729	1104	23847	257	315	3%	23:59:53
3	fu-berlin.de	23891	902	22976	13	0	3%	23:59:53
4	usenet.pasdenom.info	31298	209	23584	1565	0	0%	23:59:53
5	au2pb	23305	116	22670	57	0	0%	23:59:42
6	xmission	29030	14	23673	3	0	0%	23:59:51
7	eternal-september	22605	9	19201	0	0	0%	23:59:53
8	news.mixmin.net	26746	7	22944	0	0	0%	23:59:53
9	news.fcku.it	1930	6	1712	0	0	0%	22:41:56
10	neva.ru	25342	4	22209	103	0	0%	23:59:42
11	news.swapon.de	2343	1	2251	0	0	0%	23:43:41
12	bwh	16735	0	16322	1	0	0%	23:59:34
13	erje	17648	0	16304	41	0	0%	23:59:53
TOTAL: 13		275617	5445	239554	2296	315	1%	310:23:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	17.0 MB	1.2 MB	18.2 MB	0.2 KB/s	5.6 KB	23:59:53
2	xanadu-bbs	9.0 MB	542.9 KB	9.6 MB	0.1 KB/s	7.2 KB	23:59:53
3	fu-berlin.de	8.2 MB	16.0 KB	8.2 MB	0.1 KB/s	9.2 KB	23:59:53
4	usenet.pasdenom.info	942.6 KB	9.7 MB	10.7 MB	0.1 KB/s	6.2 KB	23:59:53
5	au2pb	480.4 KB	169.6 KB	650.0 KB	0.0 KB/s	3.8 KB	23:59:42
6	xmission	50.2 KB	6.4 KB	56.6 KB	0.0 KB/s	3.3 KB	23:59:51
7	eternal-september	40.7 KB	0.0 KB	40.7 KB	0.0 KB/s	4.5 KB	23:59:53
8	news.mixmin.net	40.7 KB	0.0 KB	40.7 KB	0.0 KB/s	5.8 KB	23:59:53
9	neva.ru	22.4 KB	726.9 KB	749.3 KB	0.0 KB/s	7.0 KB	23:59:42
10	news.fcku.it	21.2 KB	0.0 KB	21.2 KB	0.0 KB/s	3.5 KB	22:41:56
11	news.swapon.de	2.6 KB	0.0 KB	2.6 KB	0.0 KB/s	2.6 KB	23:43:41
12	bwh	0.0 KB	2.3 KB	2.3 KB	0.0 KB/s	2.3 KB	23:59:34
13	erje	0.0 KB	350.8 KB	350.8 KB	0.0 KB/s	8.6 KB	23:59:53
TOTAL: 13		35.8 MB	12.7 MB	48.5 MB	0.0 KB/s	6.4 KB	310:23:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	67	171.8 KB	61	04:37:49
2	67.216.24.146	8	2	3.4 KB	2	03:08:19
TOTAL: 2		296	69	175.3 KB	63	188:08:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	352	69	175.3 KB	63	178:10:35
2	*.hsd1.nj.comcast.net	5	0	0.0 KB	0	02:31:08
3	*.lightspeed.rcsntx.sbcglobal.net	4	0	0.0 KB	0	00:08:44
4	*.ip-188-165-239.eu	4	0	0.0 KB	0	00:08:21
5	*.chello.nl	15	0	0.0 KB	0	06:09:27
6	*.bbox.io	2	0	0.0 KB	0	01:00:01
TOTAL: 6		382	69	175.3 KB	63	188:08:20

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
63.142.120.8	5.724	5.213	0.000	134:22:49
162.212.88.221	0.465	0.871	0.000	36:01:37
dhcp-089-099-203-254.chello.nl	1.279	0.227	0.000	06:09:27
202.89.176.220	29.394	6.753	0.781	04:37:49
67.216.24.146	0.846	0.162	0.000	03:08:19
c-73-195-247-24.hsd1.nj.comcast.net	0.404	0.055	0.000	02:31:08
tempe0.bbox.io	0.270	0.053	0.000	01:00:01
99-180-119-17.lightspeed.rcsntx.sbcglobal.net	0.514	0.073	0.000	00:08:44
ns342002.ip-188-165-239.eu	0.377	0.202	0.000	00:08:21
TOTAL: 9	39.273	13.609	0.781	188:08:20

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	52
dhcp-089-099-203-254.chello.nl	15
c-73-195-247-24.hsd1.nj.comcast.net	5
99-180-119-17.lightspeed.rcsntx.sbcglobal.net	4
ns342002.ip-188-165-239.eu	4
162.212.88.221	4
tempe0.bbox.io	2
TOTAL: 7	86

NNRP client timeouts [Top 20]:

System	Conn	Peer
dhcp-089-099-203-254.chello.nl	11	0
67.216.24.146	6	0
c-73-195-247-24.hsd1.nj.comcast.net	5	0
tempe0.bbox.io	2	0
TOTAL: 4	24	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	68	98.6%
2	news	1	1.4%
TOTAL: 2		69	100.0%

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

Newsgroup		Count
1	comp.os.vms	35
2	comp.arch	27
3	comp.unix.aix	2
4	comp.arch.fpga	2
5	news.admin.peering	1
6	comp.ai.neural-nets	1
7	comp.sys.ibm.pc.games.rpg	1
TOTAL: 7		69

Daily Usenet report for csiph.com

Dec 29 04:15:00 -- Dec 30 04:15:00