Daily Usenet report

Jul 28 03:00:03 -- Jul 29 03:00: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
Sites sending bad articles
Unwanted newsgroups
INND perl filter
Miscellaneous innd statistics
NNRP readership statistics
NNRP readership statistics (by domain)
NNRP total resource statistics
Curious NNRP server explorers
NNRP client timeouts
Newsgroup request counts (by category)
Newsgroup request counts (by newsgroup)

Program name	Lines	%Lines	Size	%Size

innfeed	668473	78.3%	51.5 MB	72.6%
innd	89030	10.4%	6.1 MB	8.6%
inn	87002	10.2%	12.5 MB	17.7%
nnrpd	9685	1.1%	802.4 KB	1.1%

TOTAL: 4	854190	100.0%	71.0 MB	100.0%

History cache:

Reason	Count	%Count

Positive hits	136724	39.9%
Negative hits	119383	34.8%
Do not exist	86484	25.2%
Cache misses	133	0.0%

TOTAL: 4	342724	100.0%

INND timer:

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

article cancel	00:00:01.975	0.0%	694	0.000	2.846	188.000
article cleanup	00:00:02.869	0.0%	86566	0.000	0.033	0.079
article logging	00:00:03.530	0.0%	86667	0.004	0.041	0.919
article parse	00:00:04.284	0.0%	157017	0.006	0.027	0.049
article write	00:02:10.334	0.2%	30539	0.509	4.268	238.277
artlog/artcncl	00:00:00.012	0.0%	369	0.000	0.033	0.500
artlog/artparse	00:00:00.001	0.0%	30	0.000	0.033	0.111
data move	00:00:01.090	0.0%	267255	0.000	0.004	0.012
hisgrep/artcncl	00:00:00.324	0.0%	645	0.000	0.502	25.000
hishave/artcncl	00:00:00.343	0.0%	694	0.000	0.494	123.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:47.654	0.1%	342666	0.005	0.139	3.885
history sync	00:00:00.170	0.0%	463	0.000	0.367	1.000
history write	00:00:42.409	0.0%	86547	0.088	0.490	13.651
hiswrite/artcncl	00:00:00.091	0.0%	49	0.000	1.857	14.000
idle	23:45:47.659	98.9%	320232	54.362	267.143	615.759
nntp read	00:00:04.945	0.0%	301423	0.008	0.016	0.032
overview write	00:01:41.803	0.1%	30539	0.163	3.334	49.362
perl filter	00:04:12.571	0.3%	86539	1.290	2.919	4.462
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:02.142	0.0%	41669	0.000	0.051	0.775

TOTAL: 24:01:59.143	23:55:44.206	99.6%	-	-	-	-

INNfeed timer:

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

article new	00:00:00.000	0.0%	0	0.000	0.000	0.000
article prepare	00:00:00.000	0.0%	0	0.000	0.000	0.000
article read	00:00:00.000	0.0%	0	0.000	0.000	0.000
backlog stats	00:00:00.071	0.0%	21333	0.000	0.003	1.000
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.000	0.0%	0	0.000	0.000	0.000
data write	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	00:00:01.026	0.1%	21333	0.000	0.048	25.000
status file	00:15:56.170	71.1%	1386645	0.600	0.690	5.600

TOTAL: 00:22:24.125	00:15:57.267	71.2%	-	-	-	-

nnrpd timer:

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

idle	10:52:14.836	99.8%	9182	0.000	4262.125	1200080.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:01.083	0.0%	21617	0.000	0.050	6.404
readart	00:00:00.180	0.0%	69	0.000	2.609	12.000

TOTAL: 10:53:47.753	10:52:16.099	99.8%	-	-	-	-

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	news-out.bofh.it	32	21816	13941	7841	34	63%	61:35:37
2	goblin.stu.neva.ru	50	23467	6835	16101	531	29%	23:07:54
3	newsfeed.neva.ru	92	44259	6725	36861	673	15%	46:44:41
4	news-out.newsland.it	1	30743	6678	23832	233	21%	23:29:44
5	news.panservice.it	2	22191	2282	19883	26	10%	45:41:16
6	gothmog.csi.it	1	16050	715	13923	1412	4%	23:35:35
7	localhost	1	0	0	0	0	0%	00:00:00

TOTAL: 7		180	158526	37176	118441	2909	23%	224:14:47

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art	Elapsed

1	news-out.newsland.it	24.7 MB	259.0 KB	24.9 MB	98%	3.7 KB	23:29:44
2	news-out.bofh.it	23.6 MB	0.0 KB	23.6 MB	100%	1.7 KB	61:35:37
3	goblin.stu.neva.ru	20.6 MB	14.8 KB	20.6 MB	99%	2.9 KB	23:07:54
4	newsfeed.neva.ru	19.1 MB	472.1 KB	19.6 MB	97%	2.7 KB	46:44:41
5	news.panservice.it	4.0 MB	9.5 KB	4.0 MB	99%	1.8 KB	45:41:16
6	gothmog.csi.it	1.6 MB	0.0 KB	1.6 MB	100%	0.8 KB	23:35:35
7	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0	00:00:00

TOTAL: 7		93.7 MB	755.3 KB	94.4 MB	99%	2.4 KB	224:14:47

Incoming articles:

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

Jul 28 03:00:03 - 03:59:59	924	3.0%	0.26	3.2 MB	3.8%	0.90
Jul 28 04:00:00 - 04:59:59	983	3.2%	0.27	4.0 MB	4.8%	1.14
Jul 28 05:00:00 - 05:59:59	785	2.6%	0.22	2.3 MB	2.7%	0.65
Jul 28 06:00:00 - 06:59:59	784	2.6%	0.22	2.2 MB	2.6%	0.62
Jul 28 07:00:00 - 07:59:59	726	2.4%	0.20	1.9 MB	2.2%	0.53
Jul 28 08:00:00 - 08:59:59	902	3.0%	0.25	2.1 MB	2.5%	0.59
Jul 28 09:00:00 - 09:59:59	1187	3.9%	0.33	2.7 MB	3.2%	0.76
Jul 28 10:00:00 - 10:59:59	1353	4.4%	0.38	3.3 MB	4.0%	0.95
Jul 28 11:00:00 - 11:59:59	1282	4.2%	0.36	3.0 MB	3.5%	0.84
Jul 28 12:00:00 - 12:59:59	1324	4.3%	0.37	2.9 MB	3.4%	0.81
Jul 28 13:00:00 - 13:59:59	1353	4.4%	0.38	3.3 MB	3.9%	0.93
Jul 28 14:00:00 - 14:59:59	1779	5.8%	0.49	4.1 MB	4.9%	1.16
Jul 28 15:00:00 - 15:59:59	1930	6.3%	0.54	4.5 MB	5.4%	1.28
Jul 28 16:00:00 - 16:59:59	1876	6.1%	0.52	4.4 MB	5.2%	1.24
Jul 28 17:00:00 - 17:59:59	1736	5.7%	0.48	4.0 MB	4.7%	1.13
Jul 28 18:00:00 - 18:59:59	1547	5.1%	0.43	3.9 MB	4.7%	1.11
Jul 28 19:00:00 - 19:59:59	1571	5.1%	0.44	4.0 MB	4.8%	1.15
Jul 28 20:00:00 - 20:59:59	1342	4.4%	0.37	3.4 MB	4.0%	0.96
Jul 28 21:00:00 - 21:59:59	1523	5.0%	0.42	3.9 MB	4.6%	1.11
Jul 28 22:00:00 - 22:59:59	1426	4.7%	0.40	5.9 MB	7.0%	1.67
Jul 28 23:00:00 - 23:59:59	1407	4.6%	0.39	4.0 MB	4.8%	1.15
Jul 29 00:00:00 - 00:59:59	1065	3.5%	0.30	3.7 MB	4.4%	1.04
Jul 29 01:00:00 - 01:59:59	904	3.0%	0.25	5.3 MB	6.3%	1.51
Jul 29 02:00:00 - 03:00:01	808	2.6%	0.22	2.3 MB	2.7%	0.66

TOTAL: 23:59:58	30517	100.0%	0.35	84.0 MB	100.0%	1.00

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other

1	newsfeed.x-privat.org	53093	51785	0	0	0	0	0	0	1308
2	gothmog.csi.it	1462	1447	0	0	0	0	0	0	15
3	newsfeed.neva.ru	692	309	0	14	0	0	0	0	369
4	goblin.stu.neva.ru	540	216	0	2	0	0	0	0	322
5	news-out.newsland.it	291	0	0	3	0	0	0	0	288
6	news-out.bofh.it	23	0	0	0	0	0	0	0	23
7	news.panservice.it	8	0	0	0	0	0	0	0	8
8	?	7	0	0	0	0	0	0	0	7

TOTAL: 8		56116	53757	0	19	0	0	0	0	2340

Unwanted newsgroups [Top 20]:

Newsgroup	Count

alt.binaries.test	13031
alt.marketplace.online.ebay	660
linux.kernel	508
fa.linux.kernel	494
alt.atheism	481
fr.soc.politique	475
pl.pregierz	468
alt.support.diabetes	456
lada.talk	421
relcom.hot-news	410
nl.politiek	368
pl.misc.samochody	318
uk.legal	316
rec.travel	306
linux.debian.bugs.dist	305
alt.politics	302
alt.fan.rush-limbaugh	292
fido7.su.hardw.other	291
fr.comp.os.linux.debats	288
uk.rec.motorcycles	266

TOTAL: 2335	53757

INND perl filter [Top 20]:

Reason	Count

EMP (md5)	613
EMP (phl)	608
Binary in non-binary group	565
EMP (fsl)	175
Scoring filter (8)	88
HTML post	44
Excessively crossposted test article	34
Scoring filter (9)	25
Cancel in forbidden group	10
Excessive Supersedes (seedling.hc.pinetree.org)	10
Scoring filter (12)	8
Scoring filter (10)	5
Scoring filter (14)	4
Scoring filter (17)	3
Scoring filter (13)	2
Scoring filter (11)	2
Scoring filter (15)	2
Scoring filter (20)	2

TOTAL: 18	2200

Miscellaneous innd statistics [Top 10]:

Event	Server	Number

Article posted in the future
	newsfeed.x-privat.org	2
	TOTAL: 1	2
Including strange strings
	news-out.newsland.it	45
	news-out.bofh.it	18
	newsfeed.neva.ru	16
	gothmog.csi.it	13
	news.panservice.it	5
	goblin.stu.neva.ru	5
	TOTAL: 6	102

TOTAL: 2		104

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	212.183.173.85	19	68	233.1 KB	54	6	0	09:51:40
2	orbit.interac.it	1	1	1.3 KB	1	0	0	01:00:01

TOTAL: 2		20	69	234.4 KB	55	6	0	10:53:36

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed

1	unresolved	19	68	233.1 KB	54	6	0	09:51:40
2	*.interac.it	289	1	1.3 KB	1	0	0	01:00:08
3	*.cu.mi.it	2876	0	0.0 KB	0	0	0	00:01:46
4	*.hsi.kabelbw.de	1	0	0.0 KB	0	0	0	00:00:01
5	*.central.biz.rr.com	1	0	0.0 KB	0	0	0	00:00:00

TOTAL: 5		3186	69	234.4 KB	55	6	0	10:53:36

NNRP total resource statistics [Top 20]:

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

212.183.173.85	0.580	0.400	0.000	09:51:40
orbit.interac.it	0.040	0.020	0.000	01:00:01
diesel.cu.mi.it	58.340	47.040	0.000	00:01:46
hawthorn.interac.it	5.760	4.720	0.000	00:00:06
hsi-kbw-085-216-004-108.hsi.kabelbw.de	0.020	0.010	0.000	00:00:01
rrcs-96-11-228-247.central.biz.rr.com	0.020	0.020	0.000	00:00:00

TOTAL: 6	64.760	52.210	0.000	10:53:36

Curious NNRP server explorers [Top 20]:

System	Conn

diesel.cu.mi.it	2876
hawthorn.interac.it	288
rrcs-96-11-228-247.central.biz.rr.com	1
hsi-kbw-085-216-004-108.hsi.kabelbw.de	1

TOTAL: 4	3166

NNRP client timeouts [Top 20]:

System	Conn	Peer

212.183.173.85	9	0
orbit.interac.it	1	0

TOTAL: 2	10	0

Newsgroup request counts (by category):

Category		Count	Pct

1	it	69	100.0%

TOTAL: 1		69	100.0%

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

Newsgroup		Count

1	it.politica.internazionale	35
2	it.cultura.religioni.cristiani	33
3	it.sport.calcio.inter	1

TOTAL: 3		69