Daily Usenet report for csiph.com: Jul 3 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	20483	48.6%	5.3 MB	64.0%
innd	17003	40.3%	2.2 MB	26.9%
innfeed	3456	8.2%	635.1 KB	7.5%
nnrpd	1208	2.9%	131.0 KB	1.5%
nocem	38	0.1%	4.3 KB	0.1%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	42189	100.0%	8.3 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	323534	56.6%
Negative hits	227708	39.9%
Do not exist	19682	3.4%
Cache misses	309	0.1%
TOTAL: 4	571233	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.206	0.0%	29	0.000	7.103	33.000
article cleanup	00:00:00.107	0.0%	19567	0.000	0.005	0.034
article logging	00:00:00.343	0.0%	20197	0.000	0.017	0.397
article parse	00:00:00.788	0.0%	57085	0.000	0.014	0.051
article write	00:00:16.027	0.0%	16536	0.164	0.969	19.469
artlog/artcncl	00:00:00.000	0.0%	29	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	294	0.000	0.017	0.500
data move	00:00:00.138	0.0%	530993	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.014	0.0%	28	0.000	0.500	2.000
hishave/artcncl	00:00:00.009	0.0%	29	0.000	0.310	1.000
hishave/artparse	00:00:00.000	0.0%	281	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:13.797	0.0%	576005	0.001	0.024	0.126
history sync	00:00:00.920	0.0%	366	0.000	2.514	13.667
history write	00:00:32.888	0.0%	19580	0.526	1.680	6.062
hiswrite/artcncl	00:00:00.000	0.0%	1	0.000	0.000	0.000
hiswrite/artparse	00:00:00.285	0.0%	281	0.000	1.014	18.000
idle	23:58:02.216	99.8%	536735	101.085	160.754	421.664
nntp read	00:00:02.086	0.0%	538142	0.001	0.004	0.008
overview write	00:00:43.907	0.1%	16536	0.130	2.655	40.123
perl filter	00:00:26.652	0.0%	19567	1.139	1.362	2.283
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.241	0.0%	33110	0.000	0.007	0.020
TOTAL: 24:00:57.056	24:00:20.629	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.037	0.0%	16671	0.000	0.002	0.022
article prepare	00:00:00.000	0.0%	10532	0.000	0.000	0.000
article read	00:00:00.318	0.0%	1167	0.000	0.272	4.938
backlog stats	00:00:00.194	0.0%	375586	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.331	0.0%	302251	0.001	0.004	0.012
data write	00:00:01.643	0.0%	288266	0.002	0.006	0.012
idle	23:54:23.333	100.0%	375586	139.458	229.144	698.339
status file	00:00:00.183	0.0%	248	0.000	0.738	2.000
TOTAL: 23:54:33.144	23:54:27.039	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	46:38:21.403	99.9%	948	184.000	177111.185	600133.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.017	0.0%	2119	0.000	0.008	0.143
readart	00:00:00.717	0.0%	88	0.000	8.148	43.000
TOTAL: 46:42:19.915	46:38:22.137	99.9%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	138
pause	2
paused	2
reload	2
reserve	2
TOTAL: 10	158

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	news-out.aioe.org	1	16091	3845	12128	118	23%	23:59:56
2	newsfeeds.xmission.com	3	16021	3755	12214	52	23%	24:29:22
3	feeder.eternal-september.org	6	18477	2401	15710	366	12%	24:34:17
4	csiph-out.news.weretis.net	3	29431	1106	28077	248	3%	39:26:17
5	newsfeed.fu-berlin.de	8	15353	993	14258	102	6%	22:49:11
6	news-out.mixmin.net	1	17609	903	16320	386	5%	23:59:50
7	newsfeed.neva.ru	146	18182	856	16956	370	4%	73:25:51
8	csiph-out.feeder.erje.net	1440	83784	816	82556	412	0%	118:47:52
9	csiph-out.news.xs4all.nl	858	18175	602	17011	562	3%	71:28:53
10	csiph-out.feed.uzoreto.com	864	25809	486	24725	598	1%	71:11:56
11	news-out.neodome.net	1	17817	180	17592	45	1%	23:59:53
12	news.fcku.it	7	1635	170	1462	3	10%	21:44:57
13	csiph-out.news.tnetconsulting.net	1	16641	160	16452	29	0%	23:59:58
14	nntp.pasdenom.info	2	11376	70	11206	100	0%	23:58:51
15	news.swapon.de	5	1524	35	1487	2	2%	24:07:12
16	localhost	42	16	16	0	0	100%	00:00:04
17	news.samoylyk.net	2	15970	12	15958	0	0%	23:59:46
18	news.bbs.nz	2	16491	1	16490	0	0%	23:59:41
19	xanadu-bbs.net	30	431	0	431	0	0%	21:39:54
TOTAL: 19		3422	340833	16407	321033	3393	4%	681:43:41

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	10.2 MB	2.8 MB	13.0 MB	78%	3.5 KB
2	news-out.aioe.org	9.0 MB	442.4 KB	9.5 MB	95%	2.4 KB
3	feeder.eternal-september.org	6.4 MB	2.9 MB	9.3 MB	68%	3.4 KB
4	csiph-out.feeder.erje.net	4.3 MB	4.3 MB	8.6 MB	50%	7.2 KB
5	csiph-out.news.weretis.net	3.1 MB	2.3 MB	5.4 MB	57%	4.1 KB
6	news-out.mixmin.net	2.6 MB	2.3 MB	5.0 MB	53%	3.9 KB
7	newsfeed.fu-berlin.de	2.3 MB	314.1 KB	2.6 MB	88%	2.4 KB
8	csiph-out.feed.uzoreto.com	1.8 MB	13.8 MB	15.6 MB	11%	14.8 KB
9	newsfeed.neva.ru	1.8 MB	1.4 MB	3.1 MB	56%	2.6 KB
10	csiph-out.news.xs4all.nl	1.7 MB	4.1 MB	5.8 MB	28%	5.1 KB
11	news-out.neodome.net	536.1 KB	102.7 KB	638.8 KB	83%	2.8 KB
12	csiph-out.news.tnetconsulting.net	475.6 KB	170.9 KB	646.5 KB	73%	3.4 KB
13	news.fcku.it	276.3 KB	3.4 KB	279.7 KB	98%	1.6 KB
14	nntp.pasdenom.info	197.6 KB	160.3 KB	357.9 KB	55%	2.1 KB
15	news.swapon.de	86.3 KB	25.0 KB	111.4 KB	77%	3.0 KB
16	localhost	48.5 KB	0.0 KB	48.5 KB	100%	3.0 KB
17	news.samoylyk.net	23.4 KB	0.0 KB	23.4 KB	100%	1.9 KB
18	news.bbs.nz	1.3 KB	0.0 KB	1.3 KB	100%	1.3 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		44.9 MB	35.1 MB	80.0 MB	56%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jul 3 04:15:00 - 04:59:59	287	1.7%	0.11	1.0 MB	2.3%	0.40
Jul 3 05:00:00 - 05:59:59	485	2.9%	0.13	1.7 MB	3.7%	0.48
Jul 3 06:00:00 - 06:59:59	614	3.7%	0.17	2.3 MB	5.0%	0.64
Jul 3 07:00:00 - 07:59:59	719	4.4%	0.20	1.9 MB	4.2%	0.54
Jul 3 08:00:00 - 08:59:59	851	5.2%	0.24	2.6 MB	5.8%	0.75
Jul 3 09:00:00 - 09:59:59	867	5.2%	0.24	2.2 MB	4.8%	0.62
Jul 3 10:00:00 - 10:59:59	925	5.6%	0.26	2.5 MB	5.5%	0.70
Jul 3 11:00:00 - 11:59:59	772	4.7%	0.21	1.9 MB	4.1%	0.53
Jul 3 12:00:00 - 12:59:59	793	4.8%	0.22	1.9 MB	4.2%	0.55
Jul 3 13:00:00 - 13:59:59	902	5.5%	0.25	2.2 MB	5.0%	0.64
Jul 3 14:00:00 - 14:59:59	938	5.7%	0.26	2.6 MB	5.7%	0.74
Jul 3 15:00:00 - 15:59:59	959	5.8%	0.27	2.5 MB	5.4%	0.70
Jul 3 16:00:00 - 16:59:59	806	4.9%	0.22	2.1 MB	4.7%	0.60
Jul 3 17:00:00 - 17:59:59	810	4.9%	0.23	2.0 MB	4.5%	0.58
Jul 3 18:00:00 - 18:59:59	814	4.9%	0.23	2.1 MB	4.6%	0.59
Jul 3 19:00:00 - 19:59:59	796	4.8%	0.22	2.2 MB	4.8%	0.62
Jul 3 20:00:00 - 20:59:59	789	4.8%	0.22	2.0 MB	4.5%	0.58
Jul 3 21:00:00 - 21:59:59	674	4.1%	0.19	1.8 MB	4.0%	0.52
Jul 3 22:00:00 - 22:59:59	637	3.9%	0.18	2.0 MB	4.4%	0.57
Jul 3 23:00:00 - 23:59:59	403	2.4%	0.11	1.3 MB	2.9%	0.38
Jul 4 00:00:00 - 00:59:59	414	2.5%	0.12	1.1 MB	2.4%	0.31
Jul 4 01:00:00 - 01:59:59	391	2.4%	0.11	1008.9 KB	2.2%	0.28
Jul 4 02:00:00 - 02:59:59	430	2.6%	0.12	1.1 MB	2.5%	0.32
Jul 4 03:00:00 - 03:59:59	336	2.0%	0.09	920.2 KB	2.0%	0.26
Jul 4 04:00:00 - 04:15:00	105	0.6%	0.12	302.2 KB	0.7%	0.34
TOTAL: 24:00:00	16517	100.0%	0.19	45.2 MB	100.0%	0.54

Sites sending bad articles:

Server		Total	Group	Other
1	newsfeed.fu-berlin.de	612	44	568
2	csiph-out.feed.uzoreto.com	602	42	560
3	csiph-out.news.xs4all.nl	561	39	522
4	news-out.mixmin.net	393	7	386
5	newsfeed.neva.ru	369	46	323
6	feeder.eternal-september.org	361	38	323
7	csiph-out.news.weretis.net	317	153	164
8	csiph-out.feeder.erje.net	285	54	231
9	news-out.aioe.org	204	85	119
10	nntp.pasdenom.info	99	0	99
11	newsfeeds.xmission.com	54	16	38
12	news-out.neodome.net	48	1	47
13	csiph-out.news.tnetconsulting.net	20	18	2
14	news.swapon.de	10	0	10
15	news.fcku.it	3	3	0
TOTAL: 15		3938	546	3392

Unwanted newsgroups [Top 20]:

Newsgroup	Count
alt.computer.workshop	151
lada.talk	29
mozilla.support.thunderbird	24
scinet.stats	22
alt.politics	22
alt.windows7.general	21
alt.binaries.pictures.purebeauty	19
mozilla.general	18
spline.eisfair	18
mozilla.dev.security.policy	17
alt.survival	16
alt.politics.usa	15
trollnet.cinema	15
fido.ger.gay	14
alt.paranormal.spells	12
mozilla.support.firefox	10
alt.bbs.synchronet	10
it-alt.sport.calcio.juventus	8
alt.religion	6
argonet.cfc	5
TOTAL: 86	546

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1593
EMP (phn path)	318
0	196
EMP (phl)	173
EMP (phn nph)	85
Too many newsgroups	56
HTML Multipart	31
Scoring filter	9
Binary: misplaced binary	3
Too many newsgroups (meow)	1
Binary Payload	1
HTML post	1
TOTAL: 12	2467

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	csiph-out.feed.uzoreto.com	121
	csiph-out.feeder.erje.net	66
	newsfeeds.xmission.com	34
	csiph-out.news.xs4all.nl	25
	feeder.eternal-september.org	19
	csiph-out.news.weretis.net	15
	newsfeed.fu-berlin.de	1
	news-out.mixmin.net	1
	TOTAL: 8	282
Including strange strings
	newsfeed.fu-berlin.de	505
	news-out.aioe.org	90
	csiph-out.news.weretis.net	16
	news.swapon.de	8
	news-out.mixmin.net	4
	newsfeeds.xmission.com	3
	newsfeed.neva.ru	2
	csiph-out.feed.uzoreto.com	1
	csiph-out.news.xs4all.nl	1
	csiph-out.feeder.erje.net	1
	TOTAL: 10	631
No colon-space in header
	csiph-out.news.xs4all.nl	10
	csiph-out.feed.uzoreto.com	2
	TOTAL: 2	12
TOTAL: 4		970

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19058	627	15888	1	0	3%	23:59:56
2	fu-berlin.de	15297	426	14871	0	0	2%	23:59:51
3	news.bbs.nz	31423	416	15637	30	0	1%	23:59:40
4	news.samoylyk.net	16831	415	16021	8	0	2%	23:50:05
5	tnet	17046	104	15920	3	0	0%	23:50:05
6	xmission	13818	73	12243	2	0	0%	23:59:56
7	newsfeed.xs4all.nl	16263	60	15753	11	127	0%	23:55:36
8	neva.ru	15265	59	14959	45	39	0%	23:59:56
9	news.freedyn.net	16786	56	16460	0	0	0%	23:59:56
10	erje	17001	37	15480	49	0	0%	23:59:56
11	aioe	11725	31	11308	0	0	0%	23:54:30
12	usenet.pasdenom.info	16624	19	15987	8	17	0%	23:59:56
13	weretis.net	15071	17	14783	0	0	0%	23:59:56
14	news.swapon.de	1564	15	1540	0	0	0%	23:50:22
15	news.mixmin.net	15174	15	14789	0	0	0%	23:59:55
16	neodome.net	16603	15	16185	0	0	0%	23:50:05
17	eternal-september	13921	15	13555	0	0	0%	23:59:56
18	news.uzoreto.com	15814	6	15585	69	0	0%	23:50:05
19	news.fcku.it	1388	0	1387	0	0	0%	22:07:01
TOTAL: 19		286672	2406	258351	226	183	0%	453:06:43

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	xanadu-bbs	3.8 MB	2.6 KB	3.8 MB	6.2 KB	23:59:56
2	fu-berlin.de	3.2 MB	0.0 KB	3.2 MB	7.7 KB	23:59:51
3	news.samoylyk.net	3.1 MB	62.2 KB	3.2 MB	7.8 KB	23:50:05
4	news.bbs.nz	1.1 MB	124.5 KB	1.2 MB	2.7 KB	23:59:40
5	news.freedyn.net	333.6 KB	0.0 KB	333.6 KB	6.0 KB	23:59:56
6	tnet	226.5 KB	3.7 KB	230.2 KB	2.2 KB	23:50:05
7	newsfeed.xs4all.nl	204.1 KB	51.6 KB	255.7 KB	3.6 KB	23:55:36
8	xmission	202.0 KB	2.4 KB	204.5 KB	2.7 KB	23:59:56
9	erje	136.9 KB	210.7 KB	347.6 KB	4.0 KB	23:59:56
10	neva.ru	126.9 KB	106.0 KB	232.9 KB	2.2 KB	23:59:56
11	aioe	74.3 KB	0.0 KB	74.3 KB	2.4 KB	23:54:30
12	usenet.pasdenom.info	67.4 KB	20.0 KB	87.4 KB	3.2 KB	23:59:56
13	weretis.net	53.7 KB	0.0 KB	53.7 KB	3.2 KB	23:59:56
14	news.swapon.de	46.2 KB	0.0 KB	46.2 KB	3.1 KB	23:50:22
15	eternal-september	44.3 KB	0.0 KB	44.3 KB	3.0 KB	23:59:56
16	news.mixmin.net	43.8 KB	0.0 KB	43.8 KB	2.9 KB	23:59:55
17	neodome.net	43.8 KB	0.0 KB	43.8 KB	2.9 KB	23:50:05
18	news.uzoreto.com	11.3 KB	177.8 KB	189.0 KB	2.5 KB	23:50:05
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0	22:07:01
TOTAL: 19		12.8 MB	761.5 KB	13.5 MB	5.3 KB	453:06:43

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	8.44.58.56	6	35	96.3 KB	3	0	0	00:00:31
2	071-013-248-209.res.spectrum.com	50	33	95.3 KB	24	16	14	10:42:29
3	a131033.upc-a.chello.nl	44	20	62.3 KB	10	0	0	10:37:52
TOTAL: 3		100	88	253.8 KB	37	16	14	46:42:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	unresolved	64	35	96.3 KB	3	0	0	17:47:43
2	*.res.spectrum.com	50	33	95.3 KB	24	16	14	10:42:29
3	*.upc-a.chello.nl	44	20	62.3 KB	10	0	0	10:37:52
4	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:00
5	*.ph.ph.cox.net	4	0	0.0 KB	0	0	0	03:04:41
6	*.net.upcbroadband.cz	12	0	0.0 KB	0	0	0	03:59:31
TOTAL: 6		175	88	253.8 KB	37	16	14	46:42:18

NNRP auth users [Top 20]:

User	Conn
ohlandl	14
TOTAL: 1	14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.025	0.907	0.000	17:46:57
071-013-248-209.res.spectrum.com	4.257	0.913	0.033	10:42:29
a131033.upc-a.chello.nl	3.599	0.573	0.000	10:37:52
ip-89-176-128-154.net.upcbroadband.cz	0.964	0.182	0.000	03:59:31
ip72-222-200-117.ph.ph.cox.net	0.560	0.143	0.000	03:04:41
c-73-140-175-55.hsd1.wa.comcast.net	0.057	0.024	0.000	00:30:00
8.44.58.56	0.492	0.117	0.000	00:00:31
192.241.229.102	0.055	0.024	0.000	00:00:09
151.38.218.216	0.074	0.008	0.000	00:00:02
151.38.64.233	0.072	0.008	0.000	00:00:01
185.220.101.4	0.069	0.008	0.000	00:00:00
TOTAL: 11	14.224	2.907	0.033	46:42:18

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	54
ip-89-176-128-154.net.upcbroadband.cz	12
ip72-222-200-117.ph.ph.cox.net	4
185.220.101.4	1
151.38.64.233	1
192.241.229.102	1
151.38.218.216	1
c-73-140-175-55.hsd1.wa.comcast.net	1
TOTAL: 8	75

NNRP unrecognized commands (by host):

System	Conn
185.220.101.4	5
TOTAL: 1	5

NNRP unrecognized commands (by command):

Command	Count
Accept-Encoding: deflate, gzip	1
Accept: /	1
GET / HTTP/1.1	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
Host: 69.160.37.58:119	1
TOTAL: 5	5

NNRP client timeouts [Top 20]:

System	Conn	Peer
071-013-248-209.res.spectrum.com	9	0
ip72-222-200-117.ph.ph.cox.net	6	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
TOTAL: 3	16	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	88
TOTAL: 1		88

Daily Usenet report for csiph.com

Jul 3 04:15:00 -- Jul 4 04:15:00