Daily Usenet report for csiph.com: Nov 24 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	58201	48.2%	8.5 MB	60.0%
nnrpd	32548	27.0%	2.7 MB	19.0%
innd	27877	23.1%	2.7 MB	18.9%
innfeed	2025	1.7%	310.3 KB	2.1%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 5	120652	100.0%	14.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	263494	46.8%
Negative hits	237269	42.2%
Do not exist	58461	10.4%
Cache misses	3405	0.6%
TOTAL: 4	562629	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.259	0.0%	123	0.000	2.106	49.000
article cleanup	00:00:00.302	0.0%	46604	0.000	0.006	0.026
article logging	00:00:00.646	0.0%	47171	0.000	0.014	0.040
article parse	00:00:22.109	0.0%	2177540	0.004	0.010	0.152
article write	00:01:36.676	0.1%	27650	0.221	3.496	10.912
artlog/artcncl	00:00:00.002	0.0%	115	0.000	0.017	0.333
artlog/artparse	00:00:00.132	0.0%	10901	0.000	0.012	0.167
data move	00:00:01.970	0.0%	2625589	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.059	0.0%	123	0.000	0.480	27.000
hishave/artcncl	00:00:00.001	0.0%	123	0.000	0.008	0.333
hishave/artparse	00:00:00.042	0.0%	10901	0.000	0.004	0.143
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.841	0.0%	553515	0.001	0.009	0.092
history sync	00:00:02.580	0.0%	325	0.000	7.938	105.333
history write	00:01:00.124	0.1%	46604	0.080	1.290	7.751
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:05.070	0.0%	10900	0.000	0.465	23.500
idle	23:53:47.565	99.5%	2580951	7.992	33.332	299.772
nntp read	00:00:08.410	0.0%	2586770	0.001	0.003	0.007
overview write	00:01:11.507	0.1%	27650	0.562	2.586	14.353
perl filter	00:01:23.708	0.1%	46604	0.988	1.796	3.778
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.465	0.0%	55300	0.000	0.008	0.023
TOTAL: 24:00:35.086	23:59:46.468	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.089	0.0%	29286	0.000	0.003	0.017
article prepare	00:00:00.001	0.0%	10864	0.000	0.000	0.019
article read	00:00:00.460	0.0%	2393	0.000	0.192	15.000
backlog stats	00:00:00.102	0.0%	306060	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.323	0.0%	233683	0.001	0.006	0.011
data write	00:00:01.521	0.0%	212666	0.001	0.007	0.015
idle	23:53:48.050	100.0%	306060	146.929	281.082	834.938
status file	00:00:00.123	0.0%	293	0.000	0.420	1.000
TOTAL: 23:53:58.112	23:53:51.669	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.509	0.0%	11996	0.000	0.042	1.000
idle	51:48:54.726	99.8%	43637	0.000	4274.692	600315.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.520	0.0%	88419	0.000	0.006	0.333
readart	00:00:00.014	0.0%	111	0.000	0.126	1.000
TOTAL: 51:54:17.791	51:48:55.769	99.8%	-	-	-	-

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	feeder.eternal-september.org	6	44467	8225	32598	3644	18%	26:34:43
2	au2pb.net	1	30925	6440	23070	1415	20%	24:33:11
3	news-out.mixmin.net	3	34357	4876	25479	4002	14%	24:11:51
4	newsfeeds.xmission.com	1	28638	3272	25235	131	11%	23:38:50
5	xanadu-bbs.net	18	56616	1771	39880	14965	3%	67:40:47
6	newsfeed.neva.ru	142	57576	1453	50788	5335	2%	72:12:12
7	newsfeed.fu-berlin.de	63	30252	1348	28593	311	4%	33:07:44
8	nntp.pasdenom.info	6	29281	238	28919	124	0%	23:59:51
9	news.swapon.de	1	2283	198	2081	4	8%	22:18:58
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		267	314395	27821	256643	29931	8%	318:18:07

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	22.0 MB	26.7 MB	48.7 MB	45%	4.2 KB
2	news-out.mixmin.net	16.9 MB	7.7 MB	24.6 MB	68%	2.8 KB
3	au2pb.net	16.8 MB	5.8 MB	22.5 MB	74%	2.9 KB
4	newsfeeds.xmission.com	9.0 MB	2.4 MB	11.4 MB	78%	3.4 KB
5	newsfeed.neva.ru	4.5 MB	42.2 MB	46.7 MB	9%	7.0 KB
6	xanadu-bbs.net	4.5 MB	3.5 GB	3.5 GB	0%	221.1 KB
7	newsfeed.fu-berlin.de	3.1 MB	991.7 KB	4.1 MB	76%	2.5 KB
8	nntp.pasdenom.info	741.9 KB	1.7 MB	2.4 MB	30%	6.8 KB
9	news.swapon.de	537.3 KB	7.5 KB	544.8 KB	98%	2.7 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		78.0 MB	3.6 GB	3.7 GB	2%	66.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 24 04:15:00 - 04:59:59	392	1.4%	0.15	1.3 MB	1.7%	0.50
Nov 24 05:00:00 - 05:59:59	611	2.2%	0.17	2.0 MB	2.6%	0.56
Nov 24 06:00:00 - 06:59:59	576	2.1%	0.16	2.0 MB	2.5%	0.56
Nov 24 07:00:00 - 07:59:59	813	2.9%	0.23	2.4 MB	3.1%	0.68
Nov 24 08:00:00 - 08:59:59	1192	4.3%	0.33	3.6 MB	4.7%	1.03
Nov 24 09:00:00 - 09:59:59	1371	5.0%	0.38	3.5 MB	4.6%	1.01
Nov 24 10:00:00 - 10:59:59	1427	5.2%	0.40	3.8 MB	4.9%	1.07
Nov 24 11:00:00 - 11:59:59	1313	4.7%	0.36	3.6 MB	4.6%	1.01
Nov 24 12:00:00 - 12:59:59	1323	4.8%	0.37	3.3 MB	4.2%	0.93
Nov 24 13:00:00 - 13:59:59	1392	5.0%	0.39	3.8 MB	4.9%	1.08
Nov 24 14:00:00 - 14:59:59	1445	5.2%	0.40	3.9 MB	5.0%	1.10
Nov 24 15:00:00 - 15:59:59	1770	6.4%	0.49	5.2 MB	6.7%	1.48
Nov 24 16:00:00 - 16:59:59	1566	5.7%	0.43	4.2 MB	5.4%	1.20
Nov 24 17:00:00 - 17:59:59	1539	5.6%	0.43	4.2 MB	5.5%	1.20
Nov 24 18:00:00 - 18:59:59	1489	5.4%	0.41	3.7 MB	4.8%	1.06
Nov 24 19:00:00 - 19:59:59	1529	5.5%	0.42	4.1 MB	5.3%	1.17
Nov 24 20:00:00 - 20:59:59	1427	5.2%	0.40	3.7 MB	4.9%	1.07
Nov 24 21:00:00 - 21:59:59	1463	5.3%	0.41	4.0 MB	5.1%	1.13
Nov 24 22:00:00 - 22:59:59	1229	4.4%	0.34	3.7 MB	4.8%	1.06
Nov 24 23:00:00 - 23:59:59	1083	3.9%	0.30	3.2 MB	4.2%	0.91
Nov 25 00:00:00 - 00:59:59	810	2.9%	0.23	2.5 MB	3.2%	0.70
Nov 25 01:00:00 - 01:59:59	654	2.4%	0.18	2.0 MB	2.6%	0.57
Nov 25 02:00:00 - 02:59:59	626	2.3%	0.17	1.8 MB	2.3%	0.51
Nov 25 03:00:00 - 03:59:59	483	1.7%	0.13	1.4 MB	1.8%	0.40
Nov 25 04:00:00 - 04:15:00	127	0.5%	0.14	427.0 KB	0.5%	0.47
TOTAL: 24:00:00	27650	100.0%	0.32	77.3 MB	100.0%	0.92

Sites sending bad articles:

Server		Total	Group	Other
1	xanadu-bbs.net	14919	238	14681
2	newsfeed.neva.ru	5327	1421	3906
3	news-out.mixmin.net	4055	13	4042
4	feeder.eternal-september.org	3647	521	3126
5	au2pb.net	1413	1356	57
6	newsfeed.fu-berlin.de	768	36	732
7	newsfeeds.xmission.com	142	109	33
8	nntp.pasdenom.info	124	84	40
9	news.swapon.de	41	0	41
TOTAL: 9		30436	3778	26658

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	941
alt.politics.scorched-earth	226
lada.talk	188
ut.test	165
alt.politics	122
lada.auto	107
mailing.freebsd.pkg-fallout	98
mailing.openbsd.source-changes	71
mailing.gcc.gcc-cvs	67
mailing.freebsd.ports-bugs	66
mailing.freebsd.svn-ports-all	51
mailing.freebsd.svn-ports-head	51
pld.cvs.commit	48
fa.openbsd.source-changes	46
alt.windows7.general	45
mailing.unix.spamassassin-talk	44
gmane.comp.gis.openstreetmap.tagging	41
mailing.openbsd.misc	36
fa.freebsd.cvs-all	35
mailing.freebsd.svn-src-all	35
TOTAL: 256	3778

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10774
EMP (phn path)	3007
EMP (phl)	829
PFM bot misc	181
Binary: misplaced rar	97
HTML Multipart	83
EMP (phn nph)	73
HTML post	59
Too many newsgroups	48
Binary: misplaced rev	10
Binary: misplaced par2	7
User-issued spam cancel	5
Binary Payload	5
MID-Bot	2
Binary Image: misplaced gif	1
HTML Image Tags	1
Binary: misplaced sfv	1
Binary: misplaced JPG	1
Binary: misplaced srr	1
Binary: misplaced nfo	1
TOTAL: 22	15188

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	10764
	feeder.eternal-september.org	64
	au2pb.net	24
	newsfeeds.xmission.com	22
	news-out.mixmin.net	17
	nntp.pasdenom.info	8
	newsfeed.fu-berlin.de	3
	TOTAL: 7	10902
Including strange strings
	newsfeed.fu-berlin.de	438
	feeder.eternal-september.org	45
	news.swapon.de	37
	news-out.mixmin.net	24
	au2pb.net	11
	newsfeeds.xmission.com	8
	xanadu-bbs.net	3
	newsfeed.neva.ru	1
	nntp.pasdenom.info	1
	TOTAL: 9	568
TOTAL: 2		11470

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	33014	888	24634	382	1592	2%	23:59:55
2	usenet.pasdenom.info	31509	217	26493	702	80	0%	23:59:55
3	au2pb	22148	183	20847	217	0	0%	23:59:41
4	fu-berlin.de	25861	27	25815	18	0	0%	23:59:39
5	news.mixmin.net	23715	19	22719	2	0	0%	23:59:52
6	eternal-september	19666	6	18612	4	0	0%	23:59:55
7	xmission	30664	5	24089	1	0	0%	23:59:51
8	neva.ru	26183	4	25499	25	0	0%	23:59:55
9	news.swapon.de	2297	0	2282	4	0	0%	23:59:11
TOTAL: 9		215057	1349	190990	1355	1672	0%	215:57:54

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	2.8 MB	875.6 KB	3.7 MB	2.9 KB	23:59:55
2	usenet.pasdenom.info	922.7 KB	1.4 MB	2.3 MB	2.6 KB	23:59:55
3	au2pb	750.7 KB	631.4 KB	1.3 MB	3.5 KB	23:59:41
4	fu-berlin.de	120.5 KB	23.8 KB	144.3 KB	3.2 KB	23:59:39
5	news.mixmin.net	90.5 KB	16.4 KB	106.8 KB	5.1 KB	23:59:52
6	eternal-september	26.5 KB	6.7 KB	33.2 KB	3.3 KB	23:59:55
7	neva.ru	12.4 KB	111.5 KB	123.9 KB	4.3 KB	23:59:55
8	xmission	9.9 KB	1.5 KB	11.4 KB	1.9 KB	23:59:51
9	news.swapon.de	0.0 KB	9.1 KB	9.1 KB	2.3 KB	23:59:11
TOTAL: 9		4.7 MB	3.1 MB	7.8 MB	2.9 KB	215:57:54

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	111	301.0 KB	102	0	0	04:20:27
TOTAL: 1		288	111	301.0 KB	102	0	0	51:54:13

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	404	111	301.0 KB	102	35:48:36
2	*.tampfl.dsl-w.verizon.net	5	0	0.0 KB	0	02:52:26
3	*.bbox.io	45	0	0.0 KB	0	07:38:40
4	*.139.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	00:30:17
5	*.ip-188-165-239.eu	2	0	0.0 KB	0	00:01:10
6	*.nielsenmedia.com	4	0	0.0 KB	0	01:42:51
7	*.chello.nl	10	0	0.0 KB	0	03:20:10
TOTAL: 7		471	111	301.0 KB	102	51:54:13

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
162.212.88.214	3.611	1.175	0.000	24:00:37
tempe0.bbox.io	3.935	0.789	0.000	07:38:40
63.142.120.8	4.440	0.868	0.000	07:27:29
202.89.176.220	30.413	6.558	0.734	04:20:27
dhcp-089-099-203-254.chello.nl	0.820	0.168	0.000	03:20:10
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.626	0.126	0.000	02:52:26
challenger.nielsenmedia.com	0.276	0.074	0.000	01:42:51
h60.139.22.98.dynamic.ip.windstream.net	0.058	0.025	0.000	00:30:17
ns342002.ip-188-165-239.eu	0.181	0.064	0.000	00:01:10
69.160.37.54	1.987	0.380	0.000	00:00:02
TOTAL: 10	46.347	10.227	0.734	51:54:13

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	50
tempe0.bbox.io	45
162.212.88.214	41
69.160.37.54	25
dhcp-089-099-203-254.chello.nl	10
pool-71-98-160-84.tampfl.dsl-w.verizon.net	5
challenger.nielsenmedia.com	4
ns342002.ip-188-165-239.eu	2
h60.139.22.98.dynamic.ip.windstream.net	1
TOTAL: 9	183

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	12	0
dhcp-089-099-203-254.chello.nl	5	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	4	0
challenger.nielsenmedia.com	3	0
h60.139.22.98.dynamic.ip.windstream.net	1	0
TOTAL: 5	25	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch.embedded	32
2	comp.os.vms	29
3	comp.arch	26
4	comp.sys.ibm.pc.games.rpg	7
5	comp.sys.ibm.as400.misc	4
6	comp.sys.ibm.pc.games.action	4
7	comp.sys.ibm.pc.games.war-historical	4
8	comp.os.os2.programmer.misc	2
9	comp.os.linux.networking	1
10	comp.arch.fpga	1
11	comp.ai.neural-nets	1
TOTAL: 11		111

Daily Usenet report for csiph.com

Nov 24 04:15:00 -- Nov 25 04:15:00