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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
nnrpd	48271	57.4%	5.2 MB	44.1%
inn	21945	26.1%	4.8 MB	40.3%
innd	10977	13.1%	1.3 MB	11.3%
innfeed	2884	3.4%	522.9 KB	4.3%
nocem	33	0.0%	3.5 KB	0.0%
controlchan	1	0.0%	0.2 KB	0.0%
TOTAL: 6	84111	100.0%	11.8 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	283715	58.1%
Negative hits	182994	37.5%
Do not exist	21319	4.4%
Cache misses	335	0.1%
TOTAL: 4	488363	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.749	0.0%	53	0.000	14.132	68.143
article cleanup	00:00:00.154	0.0%	21085	0.000	0.007	0.051
article logging	00:00:00.348	0.0%	21518	0.000	0.016	0.069
article parse	00:00:00.894	0.0%	56567	0.000	0.016	0.039
article write	00:00:30.149	0.0%	17184	0.195	1.754	24.650
artlog/artcncl	00:00:00.000	0.0%	53	0.000	0.000	0.000
artlog/artparse	00:00:00.002	0.0%	384	0.000	0.005	0.200
data move	00:00:00.179	0.0%	463451	0.000	0.000	0.007
hisgrep/artcncl	00:00:00.019	0.0%	52	0.000	0.365	1.429
hishave/artcncl	00:00:00.333	0.0%	53	0.000	6.283	47.286
hishave/artparse	00:00:00.001	0.0%	384	0.000	0.003	1.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:04.567	0.0%	491477	0.004	0.009	0.069
history sync	00:00:00.473	0.0%	362	0.000	1.307	4.000
history write	00:00:08.700	0.0%	21060	0.194	0.413	2.272
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.153	0.0%	384	0.000	0.398	4.000
idle	23:57:45.657	99.8%	471345	109.947	183.020	528.558
nntp read	00:00:04.868	0.0%	470548	0.002	0.010	0.192
overview write	00:00:45.580	0.1%	17184	0.179	2.652	357.429
perl filter	00:00:40.788	0.0%	21057	1.211	1.937	10.026
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.326	0.0%	34400	0.000	0.009	0.038
TOTAL: 24:00:54.897	24:00:03.940	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.046	0.0%	17186	0.000	0.003	0.033
article prepare	00:00:00.001	0.0%	14288	0.000	0.000	0.010
article read	00:00:00.330	0.0%	1667	0.000	0.198	4.111
backlog stats	00:00:00.232	0.0%	331284	0.000	0.001	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.771	0.0%	248518	0.001	0.007	0.018
data write	00:00:01.451	0.0%	234114	0.001	0.006	0.015
idle	23:53:48.148	100.0%	331284	153.607	259.681	724.319
status file	00:00:00.225	0.0%	256	0.000	0.879	15.000
TOTAL: 23:53:59.614	23:53:52.204	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	1518:45:12.510	99.2%	31225127	96.483	175.100	600089.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:08:21.841	0.0%	91657818	0.000	0.005	2.077
readart	12:26:03.182	0.8%	31059657	0.000	1.441	163.000
TOTAL: 1531:41:07.619	1531:19:37.533	100.0%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	5
flushlogs	2
go	2
logmode	2
mode	112
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	132

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	35274	5034	29800	440	14%	47:03:37
2	csiph-out.feeder.erje.net	1451	88747	2879	84458	1410	3%	119:29:49
3	feeder.eternal-september.org	3	18996	2484	15926	586	13%	24:04:51
4	newsfeeds.xmission.com	2	17829	1582	16232	15	8%	27:35:37
5	news-out.aioe.org	2	16886	1485	15342	59	8%	24:09:02
6	newsfeed.neva.ru	140	23690	1035	21733	922	4%	71:12:05
7	newsfeed.fu-berlin.de	9	14936	900	13878	158	6%	22:42:30
8	news.redatomik.org	8	16692	678	15955	59	4%	23:58:15
9	news.fcku.it	11	2336	458	1875	3	19%	21:58:04
10	news-out.mixmin.net	1	17782	345	16952	485	1%	23:59:36
11	news.freedyn.net	2	18387	114	18228	45	0%	24:08:24
12	nntp.pasdenom.info	2	16199	48	16101	50	0%	23:59:32
13	news.swapon.de	2	1313	47	1264	2	3%	24:08:52
14	news.bbs.nz	1	17824	3	17816	5	0%	23:59:51
15	xanadu-bbs.net	15	743	1	742	0	0%	24:09:25
16	localhost	26	0	0	0	0	0%	00:00:04
TOTAL: 16		1679	307634	17093	286302	4239	5%	526:39:34

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	14.3 MB	6.1 KB	6.2 MB	20.5 MB	69%	3.8 KB
2	csiph-out.feeder.erje.net	11.3 MB	7.1 KB	12.8 MB	24.2 MB	46%	5.8 KB
3	feeder.eternal-september.org	6.5 MB	21.1 KB	6.1 MB	12.7 MB	51%	4.2 KB
4	newsfeeds.xmission.com	4.5 MB	2.5 KB	752.7 KB	5.3 MB	86%	3.4 KB
5	news-out.aioe.org	3.3 MB	14.3 KB	483.0 KB	3.7 MB	87%	2.5 KB
6	newsfeed.neva.ru	2.5 MB	0.0 KB	3.2 MB	5.7 MB	43%	3.0 KB
7	news.redatomik.org	2.0 MB	12.1 KB	1.1 MB	3.1 MB	64%	4.3 KB
8	newsfeed.fu-berlin.de	1.9 MB	2.7 KB	368.2 KB	2.3 MB	83%	2.2 KB
9	news-out.mixmin.net	1.1 MB	10.0 KB	1.1 MB	2.2 MB	48%	2.7 KB
10	news.fcku.it	709.4 KB	0.0 KB	117.5 KB	826.9 KB	85%	1.8 KB
11	news.freedyn.net	332.0 KB	0.0 KB	493.4 KB	825.4 KB	40%	5.2 KB
12	news.swapon.de	134.3 KB	0.0 KB	212.1 KB	346.4 KB	38%	7.1 KB
13	nntp.pasdenom.info	102.9 KB	2.6 KB	104.9 KB	210.4 KB	48%	2.1 KB
14	news.bbs.nz	6.3 KB	5.6 KB	213.2 KB	225.1 KB	2%	28.1 KB
15	xanadu-bbs.net	1.5 KB	0.0 KB	0.0 KB	1.5 KB	100%	1.5 KB
16	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 16		48.7 MB	84.2 KB	33.2 MB	81.9 MB	59%	3.9 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 26 04:15:00 - 04:59:59	336	2.0%	0.12	1.7 MB	3.6%	0.66
Oct 26 05:00:00 - 05:59:59	384	2.2%	0.11	1.3 MB	2.6%	0.37
Oct 26 06:00:00 - 06:59:59	545	3.2%	0.15	1.8 MB	3.7%	0.51
Oct 26 07:00:00 - 07:59:59	635	3.7%	0.18	1.5 MB	3.1%	0.44
Oct 26 08:00:00 - 08:59:59	806	4.7%	0.22	2.1 MB	4.4%	0.61
Oct 26 09:00:00 - 09:59:59	853	5.0%	0.24	2.1 MB	4.3%	0.60
Oct 26 10:00:00 - 10:59:59	934	5.4%	0.26	2.5 MB	5.2%	0.72
Oct 26 11:00:00 - 11:59:59	718	4.2%	0.20	1.8 MB	3.7%	0.51
Oct 26 12:00:00 - 12:59:59	800	4.7%	0.22	2.0 MB	4.1%	0.56
Oct 26 13:00:00 - 13:59:59	867	5.0%	0.24	2.2 MB	4.4%	0.61
Oct 26 14:00:00 - 14:59:59	928	5.4%	0.26	2.5 MB	5.1%	0.71
Oct 26 15:00:00 - 15:59:59	978	5.7%	0.27	3.2 MB	6.6%	0.92
Oct 26 16:00:00 - 16:59:59	999	5.8%	0.28	2.8 MB	5.8%	0.80
Oct 26 17:00:00 - 17:59:59	1003	5.8%	0.28	2.7 MB	5.5%	0.77
Oct 26 18:00:00 - 18:59:59	1053	6.1%	0.29	2.8 MB	5.8%	0.80
Oct 26 19:00:00 - 19:59:59	959	5.6%	0.27	2.7 MB	5.6%	0.78
Oct 26 20:00:00 - 20:59:59	951	5.5%	0.26	2.8 MB	5.7%	0.80
Oct 26 21:00:00 - 21:59:59	886	5.2%	0.25	2.3 MB	4.7%	0.65
Oct 26 22:00:00 - 22:59:59	561	3.3%	0.16	1.7 MB	3.5%	0.49
Oct 26 23:00:00 - 23:59:59	460	2.7%	0.13	1.4 MB	2.8%	0.38
Oct 27 00:00:00 - 00:59:59	359	2.1%	0.10	1010.5 KB	2.0%	0.28
Oct 27 01:00:00 - 01:59:59	385	2.2%	0.11	1.2 MB	2.5%	0.35
Oct 27 02:00:00 - 02:59:59	381	2.2%	0.11	1.4 MB	2.8%	0.39
Oct 27 03:00:00 - 03:59:59	295	1.7%	0.08	996.2 KB	2.0%	0.28
Oct 27 04:00:00 - 04:15:00	98	0.6%	0.11	251.1 KB	0.5%	0.28
TOTAL: 24:00:00	17174	100.0%	0.20	48.8 MB	100.0%	0.58

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.feeder.erje.net	1446	95	2	1349
2	newsfeed.neva.ru	931	136	0	795
3	feeder.eternal-september.org	591	30	7	554
4	newsfeed.fu-berlin.de	503	38	1	464
5	news-out.mixmin.net	498	0	3	495
6	csiph-out.news.weretis.net	473	176	2	295
7	news.redatomik.org	66	0	4	62
8	news-out.aioe.org	62	51	3	8
9	nntp.pasdenom.info	50	22	1	27
10	news.freedyn.net	45	0	0	45
11	newsfeeds.xmission.com	31	1	1	29
12	news.swapon.de	19	0	0	19
13	news.fcku.it	3	0	0	3
14	news.bbs.nz	1	0	1	0
TOTAL: 14		4719	549	25	4145

Unwanted newsgroups [Top 20]:

Newsgroup	Count
gmane.comp.gis.openstreetmap.tagging	114
lada.talk	57
spline.eisfair	37
lada.auto	35
local.spam.fr	22
alt.music.pink-floyd.publius	20
alt.bbs.synchronet	16
alt.windows7.general	13
mozilla.support.thunderbird	13
alt.politics.usa	10
alt.survival	10
it-alt.sport.calcio.juventus	8
gmane.comp.gis.openstreetmap	8
mozilla.support.firefox	8
mozilla.governance	8
mozilla.support.seamonkey	7
alt.binaries.ctb	6
alt.politics	6
alt.binaries.comics.reposts	5
lada.soft	5
TOTAL: 100	549

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2284
EMP (phn path)	351
User-issued cancel	254
EMP (phl)	194
EMP (phn nph)	82
Too many newsgroups	51
User-issued spam cancel	27
HTML Multipart	26
Scoring filter (10)	19
Binary Payload	15
Scoring filter (9)	4
Too many newsgroups (meow)	4
Scoring filter (13)	3
Binary Image: misplaced jpg	2
Binary: misplaced nzb	2
Scoring filter (17)	1
Binary: misplaced 100	1
Binary: misplaced PAR2	1
Scoring filter (15)	1
Scoring filter (8)	1
TOTAL: 20	3323

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	2
	TOTAL: 1	2
Bad Message-ID's offered
	csiph-out.feeder.erje.net	51
	TOTAL: 1	51
Huge articles
	csiph-out.feeder.erje.net	183
	csiph-out.news.weretis.net	84
	feeder.eternal-september.org	79
	newsfeeds.xmission.com	14
	news.redatomik.org	14
	news-out.mixmin.net	5
	news.freedyn.net	3
	news.fcku.it	2
	news.swapon.de	2
	TOTAL: 9	386
Including strange strings
	newsfeed.fu-berlin.de	338
	csiph-out.feeder.erje.net	34
	csiph-out.news.weretis.net	18
	news.swapon.de	17
	newsfeeds.xmission.com	15
	news.redatomik.org	4
	news-out.mixmin.net	3
	news-out.aioe.org	2
	feeder.eternal-september.org	1
	newsfeed.neva.ru	1
	TOTAL: 10	433
TOTAL: 4		872

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	18045	744	16310	5	1	4%	23:59:55
2	xanadu-bbs	20126	661	16505	7	0	3%	23:59:55
3	fu-berlin.de	16020	515	15505	0	0	3%	23:59:50
4	news.bbs.nz	32564	188	16422	24	1	0%	23:59:53
5	usenet.pasdenom.info	17907	73	15968	1085	0	0%	23:59:55
6	neva.ru	15507	12	15142	172	1	0%	23:59:48
7	erje	14647	9	14170	44	0	0%	23:59:55
8	news.mixmin.net	16453	6	15874	0	0	0%	23:59:40
9	aioe	14952	6	14158	6	0	0%	23:59:27
10	weretis.net	12752	3	11115	5	0	0%	23:59:50
11	xmission	18018	3	15027	0	0	0%	23:59:52
12	eternal-september	14883	2	14026	0	0	0%	23:59:51
13	news.redatomik.org	16834	1	15973	1	44	0%	23:59:55
14	news.swapon.de	1307	1	1275	0	0	0%	23:52:32
15	news.fcku.it	1721	0	1710	0	0	0%	21:13:19
TOTAL: 15		231736	2224	199180	1349	47	0%	357:03:37

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	5.6 MB	33.0 KB	5.6 MB	0.1 KB/s	7.7 KB	23:59:55
2	xanadu-bbs	5.3 MB	25.9 KB	5.3 MB	0.1 KB/s	8.1 KB	23:59:55
3	fu-berlin.de	4.9 MB	0.0 KB	4.9 MB	0.1 KB/s	9.7 KB	23:59:50
4	news.bbs.nz	474.2 KB	66.9 KB	541.1 KB	0.0 KB/s	2.6 KB	23:59:53
5	usenet.pasdenom.info	236.6 KB	5.9 MB	6.1 MB	0.1 KB/s	5.4 KB	23:59:55
6	neva.ru	31.1 KB	406.7 KB	437.8 KB	0.0 KB/s	2.4 KB	23:59:48
7	erje	17.1 KB	161.6 KB	178.7 KB	0.0 KB/s	3.4 KB	23:59:55
8	news.mixmin.net	11.3 KB	0.0 KB	11.3 KB	0.0 KB/s	1.9 KB	23:59:40
9	aioe	9.8 KB	9.5 KB	19.3 KB	0.0 KB/s	1.6 KB	23:59:27
10	xmission	9.4 KB	0.0 KB	9.4 KB	0.0 KB/s	3.1 KB	23:59:52
11	weretis.net	8.0 KB	29.4 KB	37.3 KB	0.0 KB/s	4.7 KB	23:59:50
12	news.swapon.de	5.4 KB	0.0 KB	5.4 KB	0.0 KB/s	5.4 KB	23:52:32
13	eternal-september	3.1 KB	0.0 KB	3.1 KB	0.0 KB/s	1.6 KB	23:59:51
14	news.redatomik.org	1.3 KB	1.7 KB	3.0 KB	0.0 KB/s	1.5 KB	23:59:55
15	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:13:19
TOTAL: 15		16.6 MB	6.6 MB	23.1 MB	0.0 KB/s	6.6 KB	357:03:37

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	mtrlpq2314w-lp130-02-70-24-220-50.dsl.bell.ca	1476	14602844	41.2 GB	22379	1510:53:10
2	167-179-154-5.a7b39a.mel.nbn.aussiebb.net	45	757	2.7 MB	95	00:57:50
3	a131033.upc-a.chello.nl	55	7	14.2 KB	2	15:56:53
4	208-71-239-109.cust.centrio.cz	3	6	8.1 KB	3	00:40:24
TOTAL: 4		1579	14603614	41.2 GB	22479	1531:40:38

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.dsl.bell.ca	1476	14602844	41.2 GB	22379	1510:53:10
2	*.a7b39a.mel.nbn.aussiebb.net	45	757	2.7 MB	95	00:57:50
3	*.upc-a.chello.nl	55	7	14.2 KB	2	15:56:53
4	*.cust.centrio.cz	3	6	8.1 KB	3	00:40:24
5	*.dhcp.mdsn.wi.charter.com	8	0	0.0 KB	0	01:42:01
6	*.ph.ph.cox.net	2	0	0.0 KB	0	01:00:11
7	*.nielsenmedia.com	1	0	0.0 KB	0	00:30:06
TOTAL: 7		1590	14603614	41.2 GB	22479	1531:40:38

NNRP auth users [Top 20]:

User	Conn
ctomczyk	3
TOTAL: 1	3

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
mtrlpq2314w-lp130-02-70-24-220-50.dsl.bell.ca	1947.227	3312.265	0.000	1510:53:10
a131033.upc-a.chello.nl	3.837	0.582	0.000	15:56:53
66-188-80-150.dhcp.mdsn.wi.charter.com	0.631	0.111	0.000	01:42:01
ip72-222-200-117.ph.ph.cox.net	0.237	0.024	0.000	01:00:11
167-179-154-5.a7b39a.mel.nbn.aussiebb.net	5.179	1.035	0.000	00:57:50
208-71-239-109.cust.centrio.cz	0.350	0.047	0.013	00:40:24
challenger.nielsenmedia.com	0.044	0.027	0.000	00:30:06
TOTAL: 7	1957.505	3314.091	0.013	1531:40:38

Curious NNRP server explorers [Top 20]:

System	Conn
66-188-80-150.dhcp.mdsn.wi.charter.com	8
ip72-222-200-117.ph.ph.cox.net	2
challenger.nielsenmedia.com	1
TOTAL: 3	11

NNRP client timeouts [Top 20]:

System	Conn	Peer
mtrlpq2314w-lp130-02-70-24-220-50.dsl.bell.ca	26	26
ip72-222-200-117.ph.ph.cox.net	2	0
66-188-80-150.dhcp.mdsn.wi.charter.com	2	0
challenger.nielsenmedia.com	1	0
208-71-239-109.cust.centrio.cz	1	0
TOTAL: 5	32	26

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	3034108	29.3%
2	alt	2909346	28.1%
3	fr	2183371	21.1%
4	sci	962783	9.3%
5	uk	680781	6.6%
6	can	417550	4.0%
7	rec	150865	1.5%
8	news	36	0.0%
9	perl	10	0.0%
10	soc	6	0.0%
11	pl	6	0.0%
12	talk	5	0.0%
13	aus	1	0.0%
TOTAL: 13		10338868	100.0%

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

Newsgroup		Count
1	comp.os.linux.advocacy	3033734
2	alt.atheism	2885002
3	fr.soc.politique	2183371
4	sci.physics	962783
5	uk.politics.misc	680762
6	can.politics	417550
7	rec.arts.tv	150860
8	alt.messianic	23874
9	alt.comp.freeware	409
10	comp.ai.philosophy	115
11	comp.os.vms	70
12	comp.sys.ibm.pc.games.action	38
13	comp.arch	36
14	news.lists.filters	36
15	comp.os.cpm	30
16	comp.arch.embedded	29
17	alt.os.linux.ubuntu	16
18	uk.legal.moderated	13
19	alt.comp.os.windows-10	13
20	comp.mobile.android	11
21	comp.arch.fpga	11
22	alt.os.linux.debian	8
23	perl.cpan.uploads	8
24	comp.os.msdos.programmer	8
25	alt.os.linux.mageia	7
26	alt.home.repair	7
27	comp.sys.ibm.ps2.hardware	7
28	pl.comp.www	6
29	talk.politics.misc	5
30	alt.russian.z1	4
31	uk.legal	4
32	comp.sys.ibm.pc.hardware.chips	4
33	comp.sys.ibm.pc.games.rpg	4
34	soc.history.medieval	2
35	perl.modules	2
36	soc.culture.israel	2
37	comp.os.os2.announce	2
38	rec.sport.pro-wrestling	2
39	comp.windows.x	2
40	alt.sports.baseball.bos-redsox	1
41	comp.bbs.misc	1
42	soc.net-people	1
43	alt.war.vietnam	1
44	comp.sys.ibm.pc.games.war-historical	1
45	alt.conspiracy	1
46	uk.d-i-y	1
47	rec.sport.tennis	1
48	uk.rec.sheds	1
49	alt.arts.poetry.comments	1
50	rec.radio.shortwave	1
51	rec.drugs.cannabis	1
52	soc.culture.bulgaria	1
53	alt.global-warming	1
54	comp.answers	1
55	comp.sys.ibm.pc.games.strategic	1
56	comp.os.msdos.misc	1
57	aus.religion.christian	1
58	comp.mobile.ipad	1
59	alt.usage.english	1
60	comp.os.msdos.djgpp	1
TOTAL: 60		10338868

Daily Usenet report for csiph.com

Oct 26 04:15:00 -- Oct 27 04:15:00