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

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	21952	49.4%	5.6 MB	65.4%
innd	18379	41.4%	2.3 MB	27.2%
innfeed	3358	7.6%	565.0 KB	6.5%
nnrpd	656	1.5%	74.5 KB	0.9%
nocem	61	0.1%	6.6 KB	0.1%
TOTAL: 5	44406	100.0%	8.5 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	311551	57.7%
Negative hits	206747	38.3%
Do not exist	21216	3.9%
Cache misses	431	0.1%
TOTAL: 4	539945	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.442	0.0%	149	0.000	9.678	65.714
article cleanup	00:00:00.126	0.0%	20367	0.000	0.006	0.035
article logging	00:00:00.444	0.0%	20857	0.000	0.021	0.221
article parse	00:00:02.813	0.0%	81791	0.000	0.034	0.363
article write	00:03:08.395	0.2%	16833	0.289	11.192	93.117
artlog/artcncl	00:00:00.013	0.0%	128	0.000	0.102	5.500
artlog/artparse	00:00:00.157	0.0%	996	0.000	0.158	18.857
data move	00:00:00.129	0.0%	524801	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.186	0.0%	144	0.000	1.292	18.000
hishave/artcncl	00:00:00.007	0.0%	149	0.000	0.047	1.000
hishave/artparse	00:00:00.006	0.0%	995	0.000	0.006	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:45.923	0.1%	542620	0.002	0.085	0.453
history sync	00:00:01.132	0.0%	374	0.000	3.027	53.667
history write	00:00:55.913	0.1%	20368	0.266	2.745	10.790
hiswrite/artcncl	00:00:00.004	0.0%	5	0.750	0.800	1.000
hiswrite/artparse	00:00:01.913	0.0%	995	0.000	1.923	23.125
idle	23:51:38.499	99.4%	518782	87.658	165.577	582.474
nntp read	00:00:02.638	0.0%	531644	0.001	0.005	0.076
overview write	00:03:02.768	0.2%	16833	0.471	10.858	169.470
perl filter	00:00:36.806	0.0%	20367	1.343	1.807	5.013
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.306	0.0%	33724	0.000	0.009	0.030
TOTAL: 24:00:58.267	24:00:19.620	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.059	0.0%	17444	0.000	0.003	0.022
article prepare	00:00:00.001	0.0%	15116	0.000	0.000	0.003
article read	00:00:01.744	0.0%	1239	0.000	1.408	33.667
backlog stats	00:00:00.229	0.0%	363727	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.527	0.0%	278199	0.001	0.005	0.013
data write	00:00:01.736	0.0%	264578	0.003	0.007	0.013
idle	23:54:54.930	100.0%	363727	133.194	236.702	607.077
status file	00:00:01.074	0.0%	268	0.000	4.007	265.000
TOTAL: 23:55:09.884	23:55:01.300	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	24:51:51.602	100.0%	500	55.500	179023.204	600076.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.012	0.0%	1176	0.000	0.010	0.333
readart	00:00:00.610	0.0%	68	0.000	8.971	49.000
TOTAL: 24:52:30.447	24:51:52.224	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.news.weretis.net	4	33655	3720	29638	297	11%	47:34:57
2	feeder.eternal-september.org	4	18424	2235	16098	91	12%	23:30:10
3	newsfeeds.xmission.com	3	18381	1837	16536	8	9%	29:01:43
4	news.freedyn.net	3	20697	1501	17797	1399	7%	24:08:48
5	csiph-out.feeder.erje.net	1440	81060	1490	79116	454	1%	118:42:40
6	news-out.aioe.org	3	16319	1446	14864	9	8%	24:08:54
7	csiph-out.news.xs4all.nl	871	19021	1431	16270	1320	7%	71:28:08
8	newsfeed.neva.ru	142	21135	945	19817	373	4%	72:06:23
9	news-out.mixmin.net	2	17512	859	16428	225	4%	23:59:48
10	newsfeed.fu-berlin.de	13	15347	840	14458	49	5%	23:55:56
11	news.fcku.it	10	2231	245	1975	11	10%	22:13:43
12	csiph-out.feed.uzoreto.com	864	26697	219	26258	220	0%	71:11:42
13	nntp.pasdenom.info	5	11191	53	11095	43	0%	23:38:05
14	news.swapon.de	6	1281	24	1257	0	1%	22:10:51
15	localhost	43	13	13	0	0	100%	00:00:00
16	news.samoylyk.net	3	16333	12	16308	13	0%	23:59:29
17	news.bbs.nz	1	16858	0	16858	0	0%	23:59:52
18	xanadu-bbs.net	25	441	0	441	0	0%	21:43:52
TOTAL: 18		3442	336596	16870	315214	4512	5%	667:35:01

Incoming Volume (INN):

Server		AcceptVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.news.weretis.net	11.1 MB	5.6 MB	16.7 MB	66%	4.3 KB
2	csiph-out.feeder.erje.net	9.6 MB	10.6 MB	20.2 MB	47%	10.6 KB
3	feeder.eternal-september.org	6.1 MB	2.2 MB	8.3 MB	73%	3.7 KB
4	newsfeeds.xmission.com	5.3 MB	402.9 KB	5.7 MB	93%	3.2 KB
5	csiph-out.news.xs4all.nl	4.0 MB	14.1 MB	18.1 MB	22%	6.7 KB
6	news.freedyn.net	3.8 MB	56.2 MB	60.1 MB	6%	21.2 KB
7	news-out.mixmin.net	3.4 MB	686.6 KB	4.0 MB	83%	3.8 KB
8	news-out.aioe.org	3.1 MB	22.9 KB	3.2 MB	99%	2.2 KB
9	newsfeed.neva.ru	2.0 MB	1.3 MB	3.2 MB	60%	2.5 KB
10	newsfeed.fu-berlin.de	1.8 MB	125.3 KB	2.0 MB	93%	2.3 KB
11	csiph-out.feed.uzoreto.com	1007.8 KB	5.3 MB	6.3 MB	15%	14.6 KB
12	news.fcku.it	495.1 KB	16.5 KB	511.6 KB	96%	2.0 KB
13	nntp.pasdenom.info	120.5 KB	61.2 KB	181.7 KB	66%	1.9 KB
14	news.swapon.de	59.1 KB	0.0 KB	59.1 KB	100%	2.5 KB
15	news.samoylyk.net	36.8 KB	1.7 MB	1.7 MB	2%	69.9 KB
16	localhost	18.1 KB	0.0 KB	18.1 KB	100%	1.4 KB
17	news.bbs.nz	0.0 KB	0.0 KB	0.0 KB	0%	0
18	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 18		51.9 MB	98.4 MB	150.3 MB	34%	7.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 15 04:15:00 - 04:59:59	343	2.0%	0.13	1.4 MB	2.7%	0.53
Oct 15 05:00:00 - 05:59:59	446	2.7%	0.12	1.9 MB	3.6%	0.53
Oct 15 06:00:00 - 06:59:59	514	3.1%	0.14	1.8 MB	3.4%	0.51
Oct 15 07:00:00 - 07:59:59	668	4.0%	0.19	1.9 MB	3.6%	0.54
Oct 15 08:00:00 - 08:59:59	708	4.2%	0.20	1.9 MB	3.7%	0.54
Oct 15 09:00:00 - 09:59:59	803	4.8%	0.22	2.2 MB	4.3%	0.63
Oct 15 10:00:00 - 10:59:59	803	4.8%	0.22	2.7 MB	5.3%	0.78
Oct 15 11:00:00 - 11:59:59	732	4.4%	0.20	1.9 MB	3.6%	0.53
Oct 15 12:00:00 - 12:59:59	830	4.9%	0.23	2.1 MB	4.0%	0.59
Oct 15 13:00:00 - 13:59:59	894	5.3%	0.25	2.2 MB	4.3%	0.63
Oct 15 14:00:00 - 14:59:59	969	5.8%	0.27	3.8 MB	7.3%	1.07
Oct 15 15:00:00 - 15:59:59	920	5.5%	0.26	2.7 MB	5.1%	0.76
Oct 15 16:00:00 - 16:59:59	993	5.9%	0.28	3.0 MB	5.8%	0.85
Oct 15 17:00:00 - 17:59:59	995	5.9%	0.28	2.8 MB	5.4%	0.80
Oct 15 18:00:00 - 18:59:59	972	5.8%	0.27	3.1 MB	5.9%	0.87
Oct 15 19:00:00 - 19:59:59	921	5.5%	0.26	2.9 MB	5.7%	0.84
Oct 15 20:00:00 - 20:59:59	787	4.7%	0.22	2.2 MB	4.2%	0.62
Oct 15 21:00:00 - 21:59:59	673	4.0%	0.19	1.9 MB	3.6%	0.54
Oct 15 22:00:00 - 22:59:59	735	4.4%	0.20	2.4 MB	4.6%	0.68
Oct 15 23:00:00 - 23:59:59	498	3.0%	0.14	1.5 MB	2.9%	0.43
Oct 16 00:00:00 - 00:59:59	423	2.5%	0.12	1.1 MB	2.2%	0.32
Oct 16 01:00:00 - 01:59:59	353	2.1%	0.10	1.0 MB	2.0%	0.29
Oct 16 02:00:00 - 02:59:59	361	2.1%	0.10	1.6 MB	3.1%	0.45
Oct 16 03:00:00 - 03:59:59	355	2.1%	0.10	1.2 MB	2.4%	0.35
Oct 16 04:00:00 - 04:15:00	128	0.8%	0.14	822.7 KB	1.5%	0.91
TOTAL: 24:00:00	16824	100.0%	0.19	51.9 MB	100.0%	0.62

Sites sending bad articles:

Server		Total	Group	Other
1	news.freedyn.net	1394	12	1382
2	csiph-out.news.xs4all.nl	1370	26	1344
3	csiph-out.feeder.erje.net	458	63	395
4	newsfeed.fu-berlin.de	415	47	368
5	newsfeed.neva.ru	375	132	243
6	csiph-out.news.weretis.net	328	110	218
7	news-out.mixmin.net	237	3	234
8	csiph-out.feed.uzoreto.com	221	8	213
9	feeder.eternal-september.org	108	19	89
10	nntp.pasdenom.info	43	0	43
11	news.samoylyk.net	13	0	13
12	news-out.aioe.org	13	10	3
13	news.fcku.it	11	8	3
14	newsfeeds.xmission.com	8	1	7
15	news.swapon.de	7	0	7
TOTAL: 15		5001	439	4562

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	82
spline.eisfair	34
lada.auto	26
mozilla.support.thunderbird	24
alt.computer.workshop	23
alt.english.usage	16
it-alt.sport.calcio.juventus	15
alt.binaries.pictures.purebeauty	15
alt.binaries.ebooks	12
mozilla.support.seamonkey	10
mozilla.support.firefox	8
mozilla.general	8
mozilla.dev.apps.seamonkey	8
alt.bbs.synchronet	8
mozilla.dev.platform	8
alt.politics.usa	8
oesterreich.tratsch	7
alt.survival	7
rocksolid.shared.test	6
rocksolid.nodes	5
TOTAL: 81	439

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	2503
EMP (phn path)	165
EMP (phl)	149
EMP (phn nph)	118
Too many newsgroups	32
User-issued spam cancel	30
User-issued cancel	22
HTML Multipart	17
Binary Payload	14
Scoring filter (8)	6
Scoring filter (15)	5
Binary: misplaced rar	5
Scoring filter (10)	3
Scoring filter (9)	3
Too many newsgroups (low_xpost)	2
Too many newsgroups (meow)	1
Scoring filter (13)	1
Scoring filter (12)	1
HTML post	1
Scoring filter (14)	1
TOTAL: 20	3079

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	40	0	45	45
TOTAL: 1	40	18	45	45

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Bad Message-ID's offered
	csiph-out.feeder.erje.net	45
	TOTAL: 1	45
Huge articles
	news.freedyn.net	451
	csiph-out.feeder.erje.net	183
	csiph-out.news.xs4all.nl	168
	csiph-out.news.weretis.net	72
	csiph-out.feed.uzoreto.com	64
	feeder.eternal-september.org	30
	news.samoylyk.net	13
	newsfeeds.xmission.com	6
	news-out.mixmin.net	5
	TOTAL: 9	992
Including strange strings
	newsfeed.fu-berlin.de	364
	csiph-out.news.xs4all.nl	72
	csiph-out.news.weretis.net	18
	news-out.mixmin.net	14
	news.swapon.de	7
	csiph-out.feeder.erje.net	6
	newsfeed.neva.ru	3
	news-out.aioe.org	3
	news.freedyn.net	2
	feeder.eternal-september.org	1
	TOTAL: 10	490
No colon-space in header
	csiph-out.feeder.erje.net	1
	TOTAL: 1	1
TOTAL: 4		1528

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19550	992	15830	0	0	5%	23:59:35
2	news.samoylyk.net	17575	579	16228	5	107	3%	23:59:55
3	news.freedyn.net	15531	561	14719	16	0	3%	23:59:42
4	fu-berlin.de	15794	557	15237	0	0	3%	23:59:53
5	news.bbs.nz	31313	217	16043	6	0	0%	23:59:55
6	usenet.pasdenom.info	17236	75	16126	570	511	0%	23:59:55
7	erje	18514	44	15170	13	0	0%	23:59:47
8	newsfeed.xs4all.nl	15786	33	14865	1	55	0%	23:59:54
9	aioe	14749	19	14178	3	0	0%	23:59:55
10	news.uzoreto.com	16470	16	16277	15	0	0%	23:59:54
11	weretis.net	12579	16	12419	0	0	0%	23:59:55
12	neva.ru	15367	15	15008	77	0	0%	23:59:54
13	news.mixmin.net	15538	15	15214	0	0	0%	23:59:55
14	xmission	18192	14	14400	0	0	0%	23:59:26
15	eternal-september	14310	14	13887	0	0	0%	23:59:38
16	news.swapon.de	1378	13	1344	0	0	0%	23:52:05
17	news.fcku.it	1884	0	1880	0	0	0%	21:42:16
18	news.redatomik.org	0	0	0	0	16265	0%	23:59:55
TOTAL: 18		261766	3180	228825	706	16938	1%	429:31:29

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	7.9 MB	0.0 KB	7.9 MB	0.1 KB/s	8.2 KB	23:59:35
2	news.samoylyk.net	6.8 MB	17.7 KB	6.8 MB	0.1 KB/s	11.9 KB	23:59:55
3	news.freedyn.net	6.7 MB	28.1 KB	6.8 MB	0.1 KB/s	12.0 KB	23:59:42
4	fu-berlin.de	6.7 MB	0.0 KB	6.7 MB	0.1 KB/s	12.3 KB	23:59:53
5	news.bbs.nz	538.7 KB	13.3 KB	552.0 KB	0.0 KB/s	2.5 KB	23:59:55
6	usenet.pasdenom.info	191.4 KB	6.8 MB	7.0 MB	0.1 KB/s	11.1 KB	23:59:55
7	erje	147.1 KB	165.7 KB	312.8 KB	0.0 KB/s	5.5 KB	23:59:47
8	newsfeed.xs4all.nl	105.0 KB	4.9 KB	109.9 KB	0.0 KB/s	3.2 KB	23:59:54
9	aioe	32.2 KB	8.7 KB	40.9 KB	0.0 KB/s	1.9 KB	23:59:55
10	news.uzoreto.com	30.3 KB	97.3 KB	127.6 KB	0.0 KB/s	4.1 KB	23:59:54
11	weretis.net	28.4 KB	0.0 KB	28.4 KB	0.0 KB/s	1.8 KB	23:59:55
12	news.mixmin.net	25.8 KB	0.0 KB	25.8 KB	0.0 KB/s	1.7 KB	23:59:55
13	xmission	23.4 KB	0.0 KB	23.4 KB	0.0 KB/s	1.7 KB	23:59:26
14	eternal-september	23.4 KB	0.0 KB	23.4 KB	0.0 KB/s	1.7 KB	23:59:38
15	neva.ru	23.1 KB	177.0 KB	200.1 KB	0.0 KB/s	2.2 KB	23:59:54
16	news.swapon.de	18.2 KB	0.0 KB	18.2 KB	0.0 KB/s	1.4 KB	23:52:05
17	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:42:16
18	news.redatomik.org	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:55
TOTAL: 18		29.3 MB	7.3 MB	36.6 MB	0.0 KB/s	9.6 KB	429:31:29

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	71-82-224-227.dhcp.stpt.wi.charter.com	38	28	43.7 KB	18	13	12	11:37:06
2	208-71-239-109.cust.centrio.cz	2	21	51.2 KB	2	0	0	01:04:40
3	a131033.upc-a.chello.nl	57	19	32.4 KB	10	0	0	12:10:14
TOTAL: 3		97	68	127.2 KB	30	13	12	24:52:17

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.dhcp.stpt.wi.charter.com	38	28	43.7 KB	18	13	12	11:37:06
2	*.cust.centrio.cz	2	21	51.2 KB	2	0	0	01:04:40
3	*.upc-a.chello.nl	57	19	32.4 KB	10	0	0	12:10:14
4	*.security.ipip.net	1	0	0.0 KB	0	0	0	00:00:01
5	unresolved	1	0	0.0 KB	0	0	0	00:00:09
6	*.census.shodan.io	1	0	0.0 KB	0	0	0	00:00:04
7	*.sfj.corp.censys.io	1	0	0.0 KB	0	0	0	00:00:00
TOTAL: 7		101	68	127.2 KB	30	13	12	24:52:17

NNRP auth users [Top 20]:

User	Conn
ohlandl	12
ctomczyk	2
TOTAL: 2	14

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
a131033.upc-a.chello.nl	4.658	0.879	0.000	12:10:14
71-82-224-227.dhcp.stpt.wi.charter.com	3.435	0.683	0.034	11:37:06
208-71-239-109.cust.centrio.cz	0.255	0.014	0.006	01:04:40
159.203.201.137	0.066	0.017	0.000	00:00:09
battery.census.shodan.io	0.069	0.008	0.000	00:00:04
scan-141.security.ipip.net	0.071	0.008	0.000	00:00:01
worker-18.sfj.corp.censys.io	0.067	0.017	0.000	00:00:00
TOTAL: 7	8.621	1.626	0.040	24:52:17

Curious NNRP server explorers [Top 20]:

System	Conn
battery.census.shodan.io	1
scan-141.security.ipip.net	1
159.203.201.137	1
worker-18.sfj.corp.censys.io	1
TOTAL: 4	4

NNRP unrecognized commands (by host):

System	Conn
scan-141.security.ipip.net	4
TOTAL: 1	4

NNRP unrecognized commands (by command):

Command	Count
Connection: close	1
Host: 69.160.37.58:119	1
User-Agent: HTTP Banner Detection (https...	1
GET / HTTP/1.1	1
TOTAL: 4	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
71-82-224-227.dhcp.stpt.wi.charter.com	11	0
208-71-239-109.cust.centrio.cz	2	0
worker-18.sfj.corp.censys.io	1	1
TOTAL: 3	14	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	47
2	comp.lang.javascript	21
TOTAL: 2		68

Daily Usenet report for csiph.com

Oct 15 04:15:00 -- Oct 16 04:15:00