Daily Usenet report for csiph.com: Jan 23 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	37819	41.8%	8.0 MB	60.8%
nnrpd	33289	36.8%	2.8 MB	21.1%
innd	16071	17.8%	1.8 MB	14.0%
innfeed	3194	3.5%	546.6 KB	4.1%
nocem	69	0.1%	6.9 KB	0.1%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	90443	100.0%	13.1 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	493275	56.5%
Negative hits	341743	39.2%
Do not exist	36984	4.2%
Cache misses	523	0.1%
TOTAL: 4	872525	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.267	0.0%	230	0.000	1.161	13.400
article cleanup	00:00:00.220	0.0%	36718	0.000	0.006	0.031
article logging	00:00:00.534	0.0%	37206	0.000	0.014	0.167
article parse	00:00:01.649	0.0%	131448	0.000	0.013	0.136
article write	00:01:10.239	0.1%	25489	0.426	2.756	17.632
artlog/artcncl	00:00:00.002	0.0%	159	0.000	0.013	0.056
artlog/artparse	00:00:00.003	0.0%	438	0.000	0.007	0.200
data move	00:00:00.264	0.0%	858358	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.012	0.0%	228	0.000	0.053	2.000
hishave/artcncl	00:00:00.003	0.0%	230	0.000	0.013	0.500
hishave/artparse	00:00:00.002	0.0%	437	0.000	0.005	0.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:08.007	0.0%	875432	0.002	0.009	0.125
history sync	00:00:02.283	0.0%	359	0.000	6.359	110.333
history write	00:00:40.127	0.0%	36678	0.073	1.094	9.764
hiswrite/artcncl	00:00:00.000	0.0%	2	0.000	0.000	0.000
hiswrite/artparse	00:00:00.435	0.0%	437	0.000	0.995	10.400
idle	23:55:32.512	99.6%	869853	51.982	99.020	274.189
nntp read	00:00:02.795	0.0%	876192	0.001	0.003	0.006
overview write	00:01:01.818	0.1%	25489	0.390	2.425	35.448
perl filter	00:01:14.049	0.1%	36659	1.514	2.020	3.537
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.449	0.0%	51040	0.000	0.009	0.022
TOTAL: 24:00:54.713	23:59:55.670	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.072	0.0%	25482	0.000	0.003	0.016
article prepare	00:00:00.003	0.0%	28564	0.000	0.000	0.005
article read	00:00:00.566	0.0%	2709	0.000	0.209	5.100
backlog stats	00:00:00.275	0.0%	571439	0.000	0.000	0.001
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:02.156	0.0%	425381	0.002	0.005	0.010
data write	00:00:02.928	0.0%	406533	0.002	0.007	0.016
idle	23:53:32.420	100.0%	571439	70.779	150.519	416.513
status file	00:00:00.192	0.0%	294	0.000	0.653	1.000
TOTAL: 23:53:46.614	23:53:38.612	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:02.314	0.0%	10636	0.000	0.218	1.288
idle	47:54:05.261	99.9%	43455	67.500	3968.364	600152.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:04.144	0.0%	134090	0.000	0.031	3.424
readart	00:00:55.898	0.0%	31379	0.000	1.781	1.784
TOTAL: 47:56:15.320	47:55:07.617	100.0%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	usenet.blueworldhosting.com	288	29179	5199	22445	1535	17%	23:44:50
2	csiph-out.feeder.erje.net	1152	94808	3639	89906	1263	3%	94:57:55
3	news-out.mixmin.net	3	29394	3212	24414	1768	10%	24:08:53
4	feeder.eternal-september.org	1	31291	3088	27399	804	9%	22:42:11
5	csiph-out.news.weretis.net	4	52587	2422	49843	322	4%	46:57:54
6	news-out.aioe.org	3	24429	2299	22072	58	9%	24:09:48
7	newsfeed.neva.ru	136	43353	1890	38332	3131	4%	71:07:13
8	newsfeed.fu-berlin.de	27	25851	1154	24512	185	4%	26:04:09
9	news.redatomik.org	1	28267	662	27526	79	2%	25:38:32
10	newsfeeds.xmission.com	1	24268	541	23697	30	2%	22:44:19
11	xanadu-bbs.net	1	35765	473	33164	2128	1%	24:41:59
12	news.freedyn.net	3	27593	310	27068	215	1%	24:10:03
13	news.fcku.it	1	4295	146	4148	1	3%	16:35:59
14	news.swapon.de	6	2159	90	2067	2	4%	24:18:17
15	nntp.pasdenom.info	4	24415	41	24372	2	0%	24:07:14
16	news.bbs.geek.nz	1	28903	0	28903	0	0%	23:59:46
17	localhost	33	0	0	0	0	0%	00:00:00
TOTAL: 17		1665	506557	25166	469868	11523	4%	520:09:02

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	usenet.blueworldhosting.com	15.6 MB	17.2 KB	12.7 MB	28.3 MB	55%	4.3 KB
2	csiph-out.feeder.erje.net	15.5 MB	45.6 KB	3.6 MB	19.2 MB	81%	4.0 KB
3	news-out.mixmin.net	10.5 MB	20.9 KB	3.1 MB	13.6 MB	77%	2.8 KB
4	feeder.eternal-september.org	8.0 MB	23.4 KB	8.9 MB	17.0 MB	47%	4.5 KB
5	csiph-out.news.weretis.net	7.9 MB	18.1 KB	5.8 MB	13.7 MB	57%	5.1 KB
6	newsfeed.neva.ru	5.8 MB	40.6 KB	10.6 MB	16.4 MB	35%	3.3 KB
7	news-out.aioe.org	5.3 MB	0.0 KB	105.1 KB	5.4 MB	98%	2.3 KB
8	newsfeed.fu-berlin.de	2.7 MB	0.0 KB	547.2 KB	3.2 MB	83%	2.5 KB
9	newsfeeds.xmission.com	1.8 MB	15.1 KB	432.1 KB	2.3 MB	80%	4.0 KB
10	news.redatomik.org	1.5 MB	0.0 KB	830.9 KB	2.4 MB	65%	3.3 KB
11	news.freedyn.net	1.3 MB	15.1 KB	1.3 MB	2.6 MB	50%	5.1 KB
12	xanadu-bbs.net	1.1 MB	15.1 KB	21.6 MB	22.8 MB	4%	9.0 KB
13	news.fcku.it	277.2 KB	0.0 KB	1.4 KB	278.7 KB	99%	1.9 KB
14	news.swapon.de	220.2 KB	0.0 KB	3.0 KB	223.3 KB	98%	2.4 KB
15	nntp.pasdenom.info	76.2 KB	0.0 KB	11.8 KB	88.0 KB	86%	2.0 KB
16	news.bbs.geek.nz	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
17	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 17		77.7 MB	211.1 KB	69.4 MB	147.4 MB	52%	4.1 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 23 04:15:00 - 04:59:59	423	1.7%	0.16	1.4 MB	1.8%	0.53
Jan 23 05:00:00 - 05:59:59	523	2.1%	0.15	1.4 MB	1.8%	0.40
Jan 23 06:00:00 - 06:59:59	532	2.1%	0.15	1.5 MB	1.9%	0.42
Jan 23 07:00:00 - 07:59:59	675	2.6%	0.19	2.3 MB	2.9%	0.64
Jan 23 08:00:00 - 08:59:59	874	3.4%	0.24	2.7 MB	3.4%	0.76
Jan 23 09:00:00 - 09:59:59	969	3.8%	0.27	2.7 MB	3.4%	0.77
Jan 23 10:00:00 - 10:59:59	1140	4.5%	0.32	3.3 MB	4.2%	0.94
Jan 23 11:00:00 - 11:59:59	1256	4.9%	0.35	4.0 MB	5.1%	1.13
Jan 23 12:00:00 - 12:59:59	1334	5.2%	0.37	4.3 MB	5.5%	1.23
Jan 23 13:00:00 - 13:59:59	1347	5.3%	0.37	4.2 MB	5.4%	1.21
Jan 23 14:00:00 - 14:59:59	1314	5.2%	0.36	5.0 MB	6.4%	1.42
Jan 23 15:00:00 - 15:59:59	1459	5.7%	0.41	4.6 MB	5.8%	1.30
Jan 23 16:00:00 - 16:59:59	1535	6.0%	0.43	4.8 MB	6.1%	1.36
Jan 23 17:00:00 - 17:59:59	1559	6.1%	0.43	5.0 MB	6.4%	1.43
Jan 23 18:00:00 - 18:59:59	1518	6.0%	0.42	4.1 MB	5.3%	1.17
Jan 23 19:00:00 - 19:59:59	1406	5.5%	0.39	3.6 MB	4.6%	1.02
Jan 23 20:00:00 - 20:59:59	1282	5.0%	0.36	4.0 MB	5.0%	1.13
Jan 23 21:00:00 - 21:59:59	1643	6.4%	0.46	4.8 MB	6.2%	1.38
Jan 23 22:00:00 - 22:59:59	963	3.8%	0.27	2.4 MB	3.0%	0.67
Jan 23 23:00:00 - 23:59:59	1042	4.1%	0.29	3.6 MB	4.6%	1.02
Jan 24 00:00:00 - 00:59:59	871	3.4%	0.24	3.1 MB	3.9%	0.88
Jan 24 01:00:00 - 01:59:59	690	2.7%	0.19	2.2 MB	2.8%	0.61
Jan 24 02:00:00 - 02:59:59	512	2.0%	0.14	1.6 MB	2.1%	0.46
Jan 24 03:00:00 - 03:59:59	467	1.8%	0.13	1.2 MB	1.6%	0.35
Jan 24 04:00:00 - 04:15:00	153	0.6%	0.17	651.1 KB	0.8%	0.72
TOTAL: 24:00:00	25487	100.0%	0.29	78.4 MB	100.0%	0.93

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	newsfeed.neva.ru	3146	884	12	2250
2	xanadu-bbs.net	2211	36	1	2174
3	news-out.mixmin.net	1794	7	3	1784
4	usenet.blueworldhosting.com	1542	942	2	598
5	csiph-out.feeder.erje.net	1279	440	16	823
6	feeder.eternal-september.org	844	181	2	661
7	newsfeed.fu-berlin.de	562	38	0	524
8	csiph-out.news.weretis.net	333	161	2	170
9	news.freedyn.net	215	2	1	212
10	news-out.aioe.org	81	53	0	28
11	news.redatomik.org	73	0	0	73
12	au2pb.net	42	37	1	4
13	newsfeeds.xmission.com	31	22	1	8
14	news.swapon.de	14	0	0	14
15	news.fcku.it	2	0	0	2
16	nntp.pasdenom.info	2	2	0	0
TOTAL: 16		12171	2805	41	9325

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fa.linux.kernel	289
lada.talk	199
ut.test	158
mailing.freebsd.svn-ports-all	138
alt.politics.scorched-earth	132
mailing.freebsd.svn-ports-head	129
mailing.freebsd.pkg-fallout	102
mailing.freebsd.ports-bugs	94
lada.auto	58
alt.binaries.multimedia.tatu	51
alt.survival	43
mozilla.general	42
mailing.freebsd.svn-src-all	40
mailing.database.pgsql-general	40
fa.freebsd.cvs-all	40
mailing.freebsd.net	39
mozilla.dev.tree-alerts	38
fa.openbsd.tech	36
mailing.openbsd.tech	36
pld.cvs.commit	35
TOTAL: 228	2805

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	5007
EMP (phn path)	1231
EMP (phl)	1039
PFM bot misc	264
User-issued cancel	193
EMP (phn nph)	180
Binary: misplaced rar	98
Too many newsgroups	49
Scoring filter (26)	37
Binary Payload	32
Scoring filter (21)	28
Scoring filter (19)	26
HTML Multipart	24
Too many newsgroups (meow)	11
Scoring filter (30)	11
Scoring filter (27)	11
Scoring filter (29)	9
Scoring filter (16)	9
Scoring filter (24)	8
HTML post	8
TOTAL: 49	8379

NoCeM on Spool:

Id	Good	Bad	Unique	Total
bleachbot@httrack.com	63	0	65	65
TOTAL: 1	63	0	65	65

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feeder.erje.net	15
	usenet.blueworldhosting.com	3
	TOTAL: 2	18
Bad Message-ID's offered
	csiph-out.feeder.erje.net	3
	usenet.blueworldhosting.com	1
	TOTAL: 2	4
Huge articles
	xanadu-bbs.net	218
	feeder.eternal-september.org	81
	usenet.blueworldhosting.com	75
	csiph-out.news.weretis.net	39
	news.freedyn.net	10
	news.redatomik.org	5
	newsfeeds.xmission.com	4
	newsfeed.fu-berlin.de	3
	news-out.mixmin.net	2
	TOTAL: 9	437
Including strange strings
	newsfeed.fu-berlin.de	374
	news-out.mixmin.net	22
	news-out.aioe.org	22
	feeder.eternal-september.org	20
	csiph-out.feeder.erje.net	14
	news.swapon.de	12
	csiph-out.news.weretis.net	11
	news.redatomik.org	5
	xanadu-bbs.net	4
	newsfeed.neva.ru	2
	TOTAL: 11	487
No colon-space in header
	usenet.blueworldhosting.com	1
	TOTAL: 1	1
TOTAL: 5		947

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	news.freedyn.net	28331	1680	23498	3	0	5%	23:59:56
2	xanadu-bbs	27251	1380	23625	2	4	5%	23:59:48
3	fu-berlin.de	23910	1136	22772	0	0	4%	23:59:22
4	news.bbs.geek.nz	46352	359	23895	9	1	0%	23:59:48
5	aioe	23919	202	20925	39	0	0%	23:59:56
6	usenet.pasdenom.info	32722	198	23510	1738	50	0%	23:59:56
7	au2pb	24962	132	24051	7	0	0%	23:59:56
8	news.redatomik.org	26708	73	23584	1	1	0%	23:59:55
9	xmission	27018	17	23699	1	0	0%	23:59:56
10	neva.ru	26412	13	22071	84	0	0%	23:59:55
11	eternal-september	23927	9	20680	0	0	0%	23:59:56
12	weretis.net	20680	7	20158	0	0	0%	23:59:45
13	news.swapon.de	2281	6	2127	0	0	0%	23:55:36
14	erje	22983	6	21737	51	0	0%	23:59:56
15	news.mixmin.net	23345	6	20855	0	0	0%	23:59:53
16	news.fcku.it	2082	6	1871	0	0	0%	22:08:01
17	bwh	19995	0	18938	0	0	0%	23:59:56
TOTAL: 17		402878	5230	337996	1935	56	1%	406:01:31

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	news.freedyn.net	11.7 MB	18.8 KB	11.7 MB	0.1 KB/s	7.1 KB	23:59:56
2	xanadu-bbs	10.6 MB	4.1 KB	10.6 MB	0.1 KB/s	7.8 KB	23:59:48
3	fu-berlin.de	9.9 MB	0.0 KB	9.9 MB	0.1 KB/s	8.9 KB	23:59:22
4	news.bbs.geek.nz	1.1 MB	17.0 KB	1.1 MB	0.0 KB/s	3.0 KB	23:59:48
5	usenet.pasdenom.info	842.0 KB	10.9 MB	11.7 MB	0.1 KB/s	6.2 KB	23:59:56
6	aioe	719.5 KB	159.4 KB	878.9 KB	0.0 KB/s	3.6 KB	23:59:56
7	au2pb	499.7 KB	55.3 KB	555.1 KB	0.0 KB/s	4.0 KB	23:59:56
8	news.redatomik.org	268.9 KB	10.8 KB	279.7 KB	0.0 KB/s	3.8 KB	23:59:55
9	neva.ru	59.7 KB	316.7 KB	376.4 KB	0.0 KB/s	3.9 KB	23:59:55
10	xmission	34.3 KB	2.5 KB	36.8 KB	0.0 KB/s	2.0 KB	23:59:56
11	eternal-september	29.8 KB	0.0 KB	29.8 KB	0.0 KB/s	3.3 KB	23:59:56
12	weretis.net	25.6 KB	0.0 KB	25.6 KB	0.0 KB/s	3.7 KB	23:59:45
13	news.fcku.it	21.9 KB	0.0 KB	21.9 KB	0.0 KB/s	3.6 KB	22:08:01
14	news.swapon.de	16.6 KB	0.0 KB	16.6 KB	0.0 KB/s	2.8 KB	23:55:36
15	news.mixmin.net	12.3 KB	0.0 KB	12.3 KB	0.0 KB/s	2.1 KB	23:59:53
16	erje	11.8 KB	205.5 KB	217.3 KB	0.0 KB/s	3.8 KB	23:59:56
17	bwh	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:59:56
TOTAL: 17		35.7 MB	11.7 MB	47.4 MB	0.0 KB/s	6.8 KB	406:01:31

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	202.89.176.220	288	52	106.1 KB	51	0	0	04:26:07
TOTAL: 1		288	52	106.1 KB	51	0	0	47:56:11

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	unresolved	314	52	106.1 KB	51	37:07:50
2	*.tampfl.dsl-w.verizon.net	3	0	0.0 KB	0	01:12:18
3	*.chello.nl	9	0	0.0 KB	0	03:28:26
4	*.shodan.io	1	0	0.0 KB	0	00:00:03
5	*.bbox.io	21	0	0.0 KB	0	05:37:29
6	*.nielsenmedia.com	1	0	0.0 KB	0	00:30:03
TOTAL: 6		349	52	106.1 KB	51	47:56:11

NNRP auth users [Top 20]:

User	Conn
moussa	288
TOTAL: 1	288

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
162.212.88.221	2.335	0.924	0.000	32:40:31
tempe0.bbox.io	1.865	0.418	0.000	05:37:29
202.89.176.220	27.622	6.534	0.749	04:26:07
dhcp-089-099-203-254.chello.nl	0.717	0.133	0.000	03:28:26
pool-71-98-160-84.tampfl.dsl-w.verizon.net	0.279	0.063	0.000	01:12:18
challenger.nielsenmedia.com	0.068	0.015	0.000	00:30:03
206.125.41.104	0.967	2.301	0.000	00:01:09
census11.shodan.io	0.062	0.016	0.000	00:00:03
206.217.197.145	0.119	0.072	0.000	00:00:02
TOTAL: 9	34.034	10.476	0.749	47:56:11

Curious NNRP server explorers [Top 20]:

System	Conn
162.212.88.221	24
tempe0.bbox.io	21
dhcp-089-099-203-254.chello.nl	9
pool-71-98-160-84.tampfl.dsl-w.verizon.net	3
challenger.nielsenmedia.com	1
206.125.41.104	1
206.217.197.145	1
census11.shodan.io	1
TOTAL: 8	61

NNRP client timeouts [Top 20]:

System	Conn	Peer
tempe0.bbox.io	11	0
dhcp-089-099-203-254.chello.nl	6	0
pool-71-98-160-84.tampfl.dsl-w.verizon.net	2	0
challenger.nielsenmedia.com	1	0
TOTAL: 4	20	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.arch	16
2	comp.os.cpm	6
3	comp.os.vms	5
4	comp.sys.ibm.pc.hardware.storage	4
5	comp.arch.embedded	4
6	comp.ai.neural-nets	4
7	comp.windows.x.kde	3
8	comp.arch.fpga	2
9	comp.os.os2.ecomstation	1
10	comp.sys.ibm.as400.misc	1
11	comp.os.linux.networking	1
12	comp.os.qnx	1
13	comp.sys.ibm.pc.games.war-historical	1
14	comp.sys.ibm.pc.games.action	1
15	comp.os.os2.misc	1
16	comp.os.msdos.programmer	1
TOTAL: 16		52

Daily Usenet report for csiph.com

Jan 23 04:15:00 -- Jan 24 04:15:00