Usenet report

Nov 6 02:17:01 -- Nov 7 02:17:01

Log entries by program
History cache
INND timer
INNfeed timer
nnrpd timer
Control commands to INND
Incoming Feeds (INN)
Incoming Volume (INN)
Incoming articles
CNFS buffer status
Sites sending bad articles
Unwanted newsgroups
INND perl filter
Miscellaneous innd statistics
Outgoing Feeds (innfeed) by Articles
Outgoing Feeds (innfeed) by Volume
Backlog files shrunk by innfeed
NNRP readership statistics
NNRP readership statistics (by domain)
NNRP total resource statistics

Program name	Lines	%Lines	Size	%Size

innfeed	3420	36.7%	556.2 KB	32.5%
inn	2762	29.6%	716.6 KB	41.9%
innd	2424	26.0%	309.8 KB	18.1%
cnfsstat	720	7.7%	128.6 KB	7.5%
nnrpd	3	0.0%	0.3 KB	0.0%

TOTAL: 5	9329	100.0%	1.7 MB	100.0%

History cache:

Reason	Count	%Count

Positive hits	25148	68.3%
Negative hits	8982	24.4%
Do not exist	2682	7.3%
Cache misses	20	0.1%

TOTAL: 4	36832	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)

article cancel	00:00:00.093	0.0%	44	0.000	2.114	13.000
article cleanup	00:00:00.095	0.0%	2684	0.000	0.035	0.500
article logging	00:00:00.103	0.0%	2716	0.000	0.038	0.500
article parse	00:00:00.086	0.0%	5338	0.000	0.016	0.200
article write	00:00:03.754	0.0%	2620	0.000	1.433	44.500
artlog/artcncl	00:00:00.001	0.0%	44	0.000	0.023	0.200
artlog/artparse	00:00:00.000	0.0%	5	0.000	0.000	0.000
data move	00:00:00.060	0.0%	38613	0.000	0.002	0.042
hisgrep/artcncl	00:00:00.000	0.0%	44	0.000	0.000	0.000
hishave/artcncl	00:00:00.089	0.0%	44	0.000	2.023	13.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:16.519	0.0%	36804	0.000	0.449	14.000
history sync	00:00:00.037	0.0%	534	0.000	0.069	1.000
history write	00:00:00.335	0.0%	2684	0.000	0.125	5.000
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	24:01:36.646	99.9%	38531	543.326	2244.859	150488.000
nntp read	00:00:00.633	0.0%	39642	0.000	0.016	0.111
overview write	00:00:09.477	0.0%	2620	0.000	3.617	82.000
perl filter	00:00:06.144	0.0%	2684	1.000	2.289	4.750
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.111	0.0%	5100	0.000	0.022	0.250

TOTAL: 24:02:23.353	24:02:14.183	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)

article new	00:00:00.026	0.0%	2710	0.000	0.010	0.021
article prepare	00:00:00.010	0.0%	7632	0.000	0.001	0.002
article read	00:00:00.801	0.0%	1395	0.190	0.574	0.691
backlog stats	00:00:00.384	0.0%	65076	0.005	0.006	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.920	0.0%	40793	0.021	0.023	0.023
data write	00:00:00.733	0.0%	38145	0.017	0.019	0.021
idle	26:07:59.396	99.5%	65076	1056.360	1445.685	2388.545
status file	00:00:01.147	0.0%	620	1.787	1.850	1.955

TOTAL: 26:15:11.092	26:08:03.417	99.5%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)

idle	00:00:00.192	2.6%	1	192.000	192.000	192.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.000	0.0%	3	0.000	0.000	0.000

TOTAL: 00:00:07.465	00:00:00.192	2.6%	-	-	-	-

Control commands to INND:

Command	Number

flush	1
flushlogs	1
paused	2

TOTAL: 3	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed

1	newsfeed.fu-berlin.de	6	2274	719	1555	0	31%	25:49:29
2	news.musoftware.de	25	2474	680	1794	0	27%	23:26:25
3	news.leine.de	9	2089	308	1781	0	14%	23:39:31
4	news.akk.org	29	2254	274	1978	2	12%	23:04:59
5	outgoing.news.telefonica.de	121	2401	187	2155	59	7%	38:25:31
6	news.hotze.com	29	2214	182	2032	0	8%	22:39:10
7	feed.news.tnib.de	25	2478	102	2372	4	4%	23:18:10
8	news.weisnix.org	5	2255	33	2222	0	1%	25:52:26
9	feed.news.bawue.net	6	2242	32	2210	0	1%	25:20:50
10	news.datentrampelpfad.de	6	2241	29	2211	1	1%	25:50:23
11	oerks.net	31	2251	6	2242	3	0%	23:08:31
12	nessy.newsmonster.de	10	3797	4	3793	0	0%	42:52:45
13	localhost	25	0	0	0	0	0%	00:00:01

TOTAL: 13		327	28970	2556	26345	69	8%	323:28:11

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	news.musoftware.de	1.5 MB	0.0 KB	1.5 MB	100%	2.3 KB	23:26:25
2	newsfeed.fu-berlin.de	1.4 MB	0.0 KB	1.4 MB	100%	2.0 KB	25:49:29
3	outgoing.news.telefonica.de	1.3 MB	0.0 KB	1.3 MB	100%	5.3 KB	38:25:31
4	news.leine.de	852.6 KB	0.0 KB	852.6 KB	100%	2.8 KB	23:39:31
5	news.akk.org	684.8 KB	0.0 KB	684.8 KB	100%	2.5 KB	23:04:59
6	news.hotze.com	454.3 KB	0.0 KB	454.3 KB	100%	2.5 KB	22:39:10
7	feed.news.tnib.de	260.2 KB	0.0 KB	260.2 KB	100%	2.5 KB	23:18:10
8	feed.news.bawue.net	75.4 KB	0.0 KB	75.4 KB	100%	2.4 KB	25:20:50
9	news.weisnix.org	72.6 KB	0.0 KB	72.6 KB	100%	2.2 KB	25:52:26
10	news.datentrampelpfad.de	61.7 KB	0.0 KB	61.7 KB	100%	2.1 KB	25:50:23
11	oerks.net	9.8 KB	0.0 KB	9.8 KB	100%	1.1 KB	23:08:31
12	nessy.newsmonster.de	8.6 KB	0.0 KB	8.6 KB	100%	2.2 KB	42:52:45
13	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0	00:00:01

TOTAL: 13		6.6 MB	0.0 KB	6.6 MB	100%	2.6 KB	323:28:11

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec

Nov 6 02:17:01 - 02:59:59	22	0.8%	0.01	70.8 KB	1.0%	0.03
Nov 6 03:00:00 - 03:59:59	27	1.0%	0.01	72.2 KB	1.0%	0.02
Nov 6 04:00:00 - 04:59:59	12	0.5%	0.00	56.1 KB	0.8%	0.02
Nov 6 05:00:00 - 05:59:59	21	0.8%	0.01	135.8 KB	1.9%	0.04
Nov 6 06:00:00 - 06:59:59	34	1.3%	0.01	74.9 KB	1.1%	0.02
Nov 6 07:00:00 - 07:59:59	49	1.9%	0.01	111.1 KB	1.6%	0.03
Nov 6 08:00:00 - 08:59:59	82	3.1%	0.02	253.4 KB	3.6%	0.07
Nov 6 09:00:00 - 09:59:59	96	3.7%	0.03	364.0 KB	5.1%	0.10
Nov 6 10:00:00 - 10:59:59	102	3.9%	0.03	223.4 KB	3.1%	0.06
Nov 6 11:00:00 - 11:59:59	176	6.7%	0.05	445.9 KB	6.3%	0.12
Nov 6 12:00:00 - 12:59:59	135	5.2%	0.04	340.4 KB	4.8%	0.09
Nov 6 13:00:00 - 13:59:59	185	7.1%	0.05	449.1 KB	6.3%	0.12
Nov 6 14:00:00 - 14:59:59	155	5.9%	0.04	329.9 KB	4.6%	0.09
Nov 6 15:00:00 - 15:59:59	138	5.3%	0.04	350.0 KB	4.9%	0.10
Nov 6 16:00:00 - 16:59:59	127	4.8%	0.04	313.5 KB	4.4%	0.09
Nov 6 17:00:00 - 17:59:59	181	6.9%	0.05	441.0 KB	6.2%	0.12
Nov 6 18:00:00 - 18:59:59	191	7.3%	0.05	430.1 KB	6.1%	0.12
Nov 6 19:00:00 - 19:59:59	171	6.5%	0.05	436.9 KB	6.2%	0.12
Nov 6 20:00:00 - 20:59:59	186	7.1%	0.05	478.6 KB	6.7%	0.13
Nov 6 21:00:00 - 21:59:59	155	5.9%	0.04	530.9 KB	7.5%	0.15
Nov 6 22:00:00 - 22:59:59	145	5.5%	0.04	380.3 KB	5.4%	0.11
Nov 6 23:00:00 - 23:59:59	106	4.0%	0.03	245.1 KB	3.5%	0.07
Nov 7 00:00:00 - 00:59:59	67	2.6%	0.02	174.8 KB	2.5%	0.05
Nov 7 01:00:00 - 01:59:59	30	1.1%	0.01	246.4 KB	3.5%	0.07
Nov 7 02:00:00 - 02:17:01	26	1.0%	0.03	148.0 KB	2.1%	0.14

TOTAL: 24:00:00	2619	100.0%	0.03	6.9 MB	100.0%	0.08

CNFS buffer status:

Buffer	Class	Size	Used	%Used	Cycles	KB/sec	Days

DE1	DE	512.0 MB	172.0 MB	33.6%	40	1.71	3.56
DE2	DE	512.0 MB	169.0 MB	33.0%	40	1.70	3.56
DE3	DE	512.0 MB	168.0 MB	32.8%	40	1.71	3.56
DE4	DE	512.0 MB	172.0 MB	33.6%	40	1.71	3.56
REST1	REST	32.0 MB	11.0 MB	34.4%	1607	1.71	0.22

TOTAL: 5	-	2.0 GB	692.0 MB	33.3%	1767	1.71	-

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	outgoing.news.telefonica.de	59	58	0	0	0	0	0	0	1
2	newsfeed.fu-berlin.de	31	0	0	0	0	0	0	0	31
3	oerks.net	3	0	0	0	0	0	0	0	3
4	feed.news.tnib.de	3	0	0	0	0	0	0	0	3
5	news.akk.org	2	0	0	0	0	0	0	0	2
6	news.weisnix.org	1	0	0	0	0	0	0	0	1

TOTAL: 6		99	58	0	0	0	0	0	0	41

Unwanted newsgroups [Top 20]:

Newsgroup	Count

perl.cpan.uploads	54
perl.win32.vanilla	4

TOTAL: 2	58

INND perl filter [Top 20]:

Reason	Count

Binary in non-binary group	5

TOTAL: 1	5

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Including strange strings
	newsfeed.fu-berlin.de	31
	TOTAL: 1	31

TOTAL: 1		31

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed

1	detebe.org	3955	1644	1789	8	0	0	41%	33:28:40
2	telefonica	3642	349	3291	1	0	1	9%	32:26:22
3	newsmonster.de	2584	160	2083	5	0	0	6%	23:06:27
4	news.datentrampelpfad.de	4996	109	3303	2	0	0	2%	33:18:51
5	leine.de	3220	56	2890	41	0	0	1%	33:28:39
6	hotze.com	4027	51	3138	0	0	0	1%	33:25:55
7	weisnix.org	4764	47	3689	0	0	3	0%	33:35:16
8	bawue	3135	33	2632	0	0	0	1%	25:51:15
9	oerks	4642	15	3416	3	0	0	0%	33:28:45
10	akk	3515	12	3429	0	0	0	0%	33:28:41
11	tnib.de	2691	5	2538	0	0	0	0%	24:56:58
12	musoftware.de	1081	4	985	1	0	0	0%	15:00:17
13	fu-berlin	2227	0	2227	0	0	0	0%	30:08:47

TOTAL: 13		44479	2485	35410	61	0	11902	5%	505:54:53

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed

1	detebe.org	3.8 MB	14.5 KB	3.9 MB	0.0 KB/s	2.4 KB	33:28:40
2	telefonica	820.7 KB	0.9 KB	821.5 KB	0.0 KB/s	2.3 KB	32:26:22
3	newsmonster.de	407.5 KB	10.3 KB	417.7 KB	0.0 KB/s	2.5 KB	23:06:27
4	news.datentrampelpfad.de	250.6 KB	2.9 KB	253.5 KB	0.0 KB/s	2.3 KB	33:18:51
5	leine.de	225.5 KB	89.8 KB	315.3 KB	0.0 KB/s	3.3 KB	33:28:39
6	weisnix.org	122.6 KB	0.0 KB	122.6 KB	0.0 KB/s	2.6 KB	33:35:16
7	hotze.com	103.2 KB	0.0 KB	103.2 KB	0.0 KB/s	2.0 KB	33:25:55
8	bawue	87.3 KB	0.0 KB	87.3 KB	0.0 KB/s	2.6 KB	25:51:15
9	oerks	41.2 KB	5.3 KB	46.5 KB	0.0 KB/s	2.6 KB	33:28:45
10	akk	40.3 KB	0.0 KB	40.3 KB	0.0 KB/s	3.4 KB	33:28:41
11	tnib.de	24.5 KB	0.0 KB	24.5 KB	0.0 KB/s	4.9 KB	24:56:58
12	musoftware.de	8.9 KB	1.6 KB	10.5 KB	0.0 KB/s	2.1 KB	15:00:17
13	fu-berlin	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	30:08:47

TOTAL: 13		5.9 MB	125.2 KB	6.1 MB	0.0 KB/s	2.4 KB	505:54:53

Backlog files shrunk by innfeed:

Server	Size

t-online	1.0 MB

TOTAL: 1	1.0 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	c-24-18-146-105.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:00:07

TOTAL: 1		1	0	0.0 KB	0	0	0	00:00:07

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:00:07

TOTAL: 1		1	0	0.0 KB	0	0	0	00:00:07

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed

c-24-18-146-105.hsd1.wa.comcast.net	0.006	0.006	0.000	00:00:07

TOTAL: 1	0.006	0.006	0.000	00:00:07