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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	60431	49.3%	8.9 MB	60.8%
nnrpd	32245	26.3%	2.7 MB	18.6%
innd	28152	22.9%	2.7 MB	18.7%
innfeed	1873	1.5%	288.9 KB	1.9%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 5	122702	100.0%	14.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	242785	44.4%
Negative hits	234277	42.9%
Do not exist	61942	11.3%
Cache misses	7470	1.4%
TOTAL: 4	546474	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.016	0.0%	423	0.000	7.130	63.000
article cleanup	00:00:00.274	0.0%	45771	0.000	0.006	0.026
article logging	00:00:00.667	0.0%	46584	0.000	0.014	0.064
article parse	00:00:26.899	0.0%	2518437	0.002	0.011	0.209
article write	00:01:22.958	0.1%	25508	0.330	3.252	8.838
artlog/artcncl	00:00:00.004	0.0%	394	0.000	0.010	1.000
artlog/artparse	00:00:00.149	0.0%	11528	0.000	0.013	0.333
data move	00:00:02.198	0.0%	2969828	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.214	0.0%	422	0.000	0.507	13.000
hishave/artcncl	00:00:00.001	0.0%	423	0.000	0.002	0.083
hishave/artparse	00:00:00.038	0.0%	11528	0.000	0.003	0.037
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.100	0.0%	536044	0.001	0.006	0.027
history sync	00:00:02.435	0.0%	321	0.000	7.586	73.000
history write	00:00:58.729	0.1%	45767	0.102	1.283	6.684
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:07.013	0.0%	11527	0.000	0.608	81.250
idle	23:54:07.266	99.6%	2909915	7.849	29.570	325.448
nntp read	00:00:09.200	0.0%	2915034	0.001	0.003	0.006
overview write	00:01:05.660	0.1%	25508	0.299	2.574	10.421
perl filter	00:01:17.413	0.1%	45767	1.004	1.691	3.000
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.451	0.0%	51016	0.000	0.009	0.025
TOTAL: 24:00:32.046	23:59:47.685	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.074	0.0%	25506	0.000	0.003	0.026
article prepare	00:00:00.003	0.0%	6596	0.000	0.000	0.028
article read	00:00:00.209	0.0%	1308	0.000	0.160	46.000
backlog stats	00:00:00.113	0.0%	290417	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.266	0.0%	219937	0.000	0.006	0.013
data write	00:00:01.491	0.0%	199373	0.002	0.007	0.023
idle	23:53:43.875	100.0%	290417	158.848	296.208	722.040
status file	00:00:00.092	0.0%	192	0.000	0.479	1.000
TOTAL: 23:53:51.244	23:53:47.123	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.127	0.0%	1966	0.000	0.065	0.125
idle	27:36:01.824	99.7%	33518	0.000	2964.432	600182.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.396	0.0%	68148	0.000	0.006	0.500
readart	00:00:00.182	0.0%	120	0.000	1.517	32.000
TOTAL: 27:41:38.417	27:36:02.529	99.7%	-	-	-	-

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	8	41527	7705	31001	2821	18%	25:23:46
2	au2pb.net	1	28255	5845	21299	1111	20%	24:54:21
3	news-out.mixmin.net	4	31702	4423	22777	4502	13%	24:11:55
4	newsfeeds.xmission.com	1	25531	3160	22232	139	12%	22:53:21
5	newsfeed.neva.ru	139	52382	2150	43478	6754	4%	71:55:22
6	newsfeed.fu-berlin.de	44	31820	1378	30133	309	4%	31:57:27
7	xanadu-bbs.net	8	56830	1261	40826	14743	2%	69:01:12
8	news.swapon.de	3	2012	200	1811	1	9%	26:08:06
9	nntp.pasdenom.info	3	28247	161	26647	1439	0%	24:09:32
10	localhost	26	0	0	0	0	0%	00:00:00
TOTAL: 10		237	298306	26283	240204	31819	8%	320:35:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	feeder.eternal-september.org	19.0 MB	28.2 KB	24.5 MB	43.5 MB	43%	4.2 KB
2	au2pb.net	15.0 MB	0.0 KB	6.1 MB	21.0 MB	71%	3.1 KB
3	news-out.mixmin.net	14.8 MB	13.3 KB	8.5 MB	23.3 MB	63%	2.7 KB
4	newsfeeds.xmission.com	8.0 MB	0.0 KB	3.5 MB	11.5 MB	69%	3.6 KB
5	newsfeed.neva.ru	6.4 MB	11.4 KB	66.8 MB	73.2 MB	8%	8.4 KB
6	xanadu-bbs.net	3.2 MB	13.1 KB	4.1 GB	4.1 GB	0%	268.7 KB
7	newsfeed.fu-berlin.de	3.2 MB	0.0 KB	1.4 MB	4.6 MB	69%	2.8 KB
8	news.swapon.de	520.3 KB	0.0 KB	2.2 KB	522.6 KB	99%	2.6 KB
9	nntp.pasdenom.info	316.5 KB	0.0 KB	27.1 MB	27.4 MB	1%	17.6 KB
10	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 10		70.4 MB	66.1 KB	4.2 GB	4.3 GB	1%	77.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 26 04:15:00 - 04:59:59	383	1.4%	0.14	1.0 MB	1.5%	0.39
Nov 26 05:00:00 - 05:59:59	533	2.0%	0.15	1.6 MB	2.2%	0.45
Nov 26 06:00:00 - 06:59:59	665	2.5%	0.18	2.0 MB	2.9%	0.58
Nov 26 07:00:00 - 07:59:59	873	3.3%	0.24	2.4 MB	3.5%	0.70
Nov 26 08:00:00 - 08:59:59	1144	4.3%	0.32	3.5 MB	5.0%	1.00
Nov 26 09:00:00 - 09:59:59	1304	4.9%	0.36	3.5 MB	5.0%	0.99
Nov 26 10:00:00 - 10:59:59	1269	4.8%	0.35	3.2 MB	4.6%	0.92
Nov 26 11:00:00 - 11:59:59	1240	4.7%	0.34	3.2 MB	4.6%	0.92
Nov 26 12:00:00 - 12:59:59	1148	4.3%	0.32	2.9 MB	4.1%	0.82
Nov 26 13:00:00 - 13:59:59	1396	5.3%	0.39	3.6 MB	5.2%	1.03
Nov 26 14:00:00 - 14:59:59	1344	5.1%	0.37	3.3 MB	4.8%	0.95
Nov 26 15:00:00 - 15:59:59	1450	5.5%	0.40	3.7 MB	5.3%	1.05
Nov 26 16:00:00 - 16:59:59	1652	6.2%	0.46	4.4 MB	6.2%	1.24
Nov 26 17:00:00 - 17:59:59	1617	6.1%	0.45	4.6 MB	6.5%	1.31
Nov 26 18:00:00 - 18:59:59	1338	5.1%	0.37	3.6 MB	5.1%	1.01
Nov 26 19:00:00 - 19:59:59	1300	4.9%	0.36	3.2 MB	4.6%	0.92
Nov 26 20:00:00 - 20:59:59	1293	4.9%	0.36	3.0 MB	4.3%	0.86
Nov 26 21:00:00 - 21:59:59	1322	5.0%	0.37	3.2 MB	4.6%	0.92
Nov 26 22:00:00 - 22:59:59	1074	4.1%	0.30	3.0 MB	4.3%	0.87
Nov 26 23:00:00 - 23:59:59	819	3.1%	0.23	2.6 MB	3.7%	0.74
Nov 27 00:00:00 - 00:59:59	583	2.2%	0.16	1.6 MB	2.3%	0.45
Nov 27 01:00:00 - 01:59:59	605	2.3%	0.17	2.0 MB	2.8%	0.57
Nov 27 02:00:00 - 02:59:59	541	2.0%	0.15	1.8 MB	2.5%	0.50
Nov 27 03:00:00 - 03:59:59	504	1.9%	0.14	1.6 MB	2.3%	0.46
Nov 27 04:00:00 - 04:15:00	1063	4.0%	1.18	1.5 MB	2.1%	1.69
TOTAL: 24:00:00	26460	100.0%	0.31	70.2 MB	100.0%	0.83

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	xanadu-bbs.net	14754	215	2	14537
2	newsfeed.neva.ru	6766	2143	1	4622
3	news-out.mixmin.net	4540	10	1	4529
4	feeder.eternal-september.org	2950	268	12	2670
5	nntp.pasdenom.info	1439	1385	0	54
6	au2pb.net	1243	1030	0	213
7	newsfeed.fu-berlin.de	720	57	0	663
8	newsfeeds.xmission.com	177	109	0	68
9	news.swapon.de	27	0	0	27
TOTAL: 9		32616	5217	16	27383

Unwanted newsgroups [Top 20]:

Newsgroup	Count
mailing.freebsd.pkg-fallout	2281
fa.linux.kernel	554
lada.auto	185
mailing.freebsd.ports-bugs	171
ut.test	168
lada.talk	109
alt.politics	103
it-alt.sport.calcio.juventus	75
mailing.gcc.gcc-cvs	67
mailing.openbsd.misc	52
alt.politics.scorched-earth	51
gmane.linux.alsa.devel	50
mailing.database.pgsql-general	45
mailing.openbsd.source-changes	41
alt.survival	41
pld.cvs.commit	40
mailing.freebsd.svn-ports-all	39
mailing.freebsd.svn-ports-head	37
mailing.freebsd.bugs	29
fa.openbsd.tech	28
TOTAL: 245	5217

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	10820
EMP (phn path)	2481
EMP (phl)	866
Binary: misplaced rar	322
EMP (phn nph)	174
PFM bot misc	149
Too many newsgroups	109
HTML Multipart	81
Binary: non-binary distribution	14
HTML post	9
Too many newsgroups (low_xpost)	7
Binary: misplaced rev	4
HTML Image Tags	3
Binary Payload	1
User-issued spam cancel	1
Binary: misplaced rtf	1
TOTAL: 16	15042

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Huge articles
	xanadu-bbs.net	11280
	feeder.eternal-september.org	105
	nntp.pasdenom.info	48
	au2pb.net	37
	newsfeeds.xmission.com	36
	news-out.mixmin.net	21
	newsfeed.fu-berlin.de	2
	TOTAL: 7	11529
Including strange strings
	newsfeed.fu-berlin.de	429
	feeder.eternal-september.org	149
	au2pb.net	143
	newsfeeds.xmission.com	29
	news.swapon.de	26
	news-out.mixmin.net	21
	newsfeed.neva.ru	11
	nntp.pasdenom.info	2
	xanadu-bbs.net	2
	TOTAL: 9	812
TOTAL: 2		12341

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	usenet.pasdenom.info	30376	216	25481	599	14	0%	23:59:57
2	au2pb	21401	180	20456	73	0	0%	23:59:48
3	xanadu-bbs	32641	172	24705	300	36	0%	23:59:57
4	fu-berlin.de	24718	35	24659	24	0	0%	23:59:53
5	neva.ru	25441	16	23999	46	0	0%	23:59:57
6	news.mixmin.net	22777	9	21977	0	0	0%	23:59:57
7	xmission	28679	5	22812	0	0	0%	23:59:53
8	eternal-september	18684	4	17815	2	0	0%	23:59:36
9	news.swapon.de	1841	0	1831	2	0	0%	23:51:04
TOTAL: 9		206558	637	183735	1046	50	0%	215:50:02

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	895.7 KB	683.9 KB	1.5 MB	3.3 KB	23:59:57
2	usenet.pasdenom.info	778.8 KB	1.2 MB	2.0 MB	2.5 KB	23:59:57
3	au2pb	753.0 KB	285.5 KB	1.0 MB	4.1 KB	23:59:48
4	fu-berlin.de	168.3 KB	32.6 KB	200.9 KB	3.4 KB	23:59:53
5	neva.ru	78.1 KB	216.7 KB	294.8 KB	4.8 KB	23:59:57
6	news.mixmin.net	40.4 KB	0.0 KB	40.4 KB	4.5 KB	23:59:57
7	eternal-september	9.2 KB	3.3 KB	12.5 KB	2.1 KB	23:59:36
8	xmission	8.0 KB	0.0 KB	8.0 KB	1.6 KB	23:59:53
9	news.swapon.de	0.0 KB	3.7 KB	3.7 KB	1.8 KB	23:51:04
TOTAL: 9		2.7 MB	2.4 MB	5.1 MB	3.1 KB	215:50:02

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	202.89.176.220	288	107	278.6 KB	100	04:21:27
2	pool-71-98-160-84.tampfl.dsl-w.verizon.net	6	7	9.7 KB	4	01:46:07
3	challenger.nielsenmedia.com	7	6	8.6 KB	3	01:31:44
TOTAL: 3		301	120	296.9 KB	107	27:41:34

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	367	107	278.6 KB	100	11:22:20
2	*.tampfl.dsl-w.verizon.net	6	7	9.7 KB	4	01:46:07
3	*.nielsenmedia.com	7	6	8.6 KB	3	01:31:44
4	*.139.22.98.dynamic.ip.windstream.net	1	0	0.0 KB	0	00:30:17
5	*.chello.nl	23	0	0.0 KB	0	09:00:05
6	*.bbox.io	13	0	0.0 KB	0	03:30:58
TOTAL: 6		417	120	296.9 KB	107	27:41:34

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	1.890	0.403	0.000	09:00:05
63.142.120.8	3.952	0.775	0.000	07:00:51
202.89.176.220	30.168	6.542	0.742	04:21:27
tempe0.bbox.io	1.197	0.239	0.000	03:30:58
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.784	0.175	0.000	01:46:07
challenger.nielsenmedia.com	0.735	0.156	0.000	01:31:44
h60.139.22.98.dynamic.ip.windstream.net	0.093	0.023	0.000	00:30:17
69.160.37.54	1.920	0.394	0.000	00:00:02
TOTAL: 8	40.739	8.707	0.742	27:41:34

Curious NNRP server explorers [Top 20]:

System	Conn
63.142.120.8	50
69.160.37.54	25
dhcp-089-099-203-254.chello.nl	23
tempe0.bbox.io	13
162.212.88.214	4
h60.139.22.98.dynamic.ip.windstream.net	1
TOTAL: 6	116

NNRP client timeouts [Top 20]:

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

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	36
2	comp.ai.philosophy	29
3	comp.lang.awk	13
4	comp.arch.embedded	8
5	comp.os.vms	8
6	comp.sys.ibm.pc.games.war-historical	6
7	comp.sys.ibm.pc.games.action	6
8	comp.os.msdos.misc	4
9	comp.sys.ibm.pc.games.adventure	3
10	comp.arch.fpga	2
11	comp.sys.ibm.pc.games.announce	2
12	comp.os.os2.misc	1
13	comp.sys.ibm.pc.games.rpg	1
14	comp.windows.x	1
TOTAL: 14		120

Daily Usenet report for csiph.com

Nov 26 04:15:00 -- Nov 27 04:15:00