Daily Usenet report for csiph.com: Apr 21 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	23076	50.5%	6.1 MB	66.4%
innd	18079	39.5%	2.3 MB	25.5%
innfeed	3528	7.7%	646.8 KB	6.9%
nnrpd	1019	2.2%	111.5 KB	1.2%
nocem	32	0.1%	3.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	45735	100.0%	9.2 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	374323	57.1%
Negative hits	258015	39.4%
Do not exist	22360	3.4%
Cache misses	398	0.1%
TOTAL: 4	655096	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.244	0.0%	21	0.000	11.619	90.000
article cleanup	00:00:00.119	0.0%	22187	0.000	0.005	0.038
article logging	00:00:00.327	0.0%	22821	0.000	0.014	0.218
article parse	00:00:00.721	0.0%	61147	0.000	0.012	0.075
article write	00:00:05.882	0.0%	19159	0.177	0.307	5.070
artlog/artcncl	00:00:00.000	0.0%	21	0.000	0.000	0.000
artlog/artparse	00:00:00.001	0.0%	230	0.000	0.004	0.125
data move	00:00:00.189	0.0%	600397	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.004	0.0%	21	0.000	0.190	1.000
hishave/artcncl	00:00:00.003	0.0%	21	0.000	0.143	1.000
hishave/artparse	00:00:00.001	0.0%	221	0.000	0.005	0.333
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:03.009	0.0%	656245	0.000	0.005	0.012
history sync	00:00:00.969	0.0%	360	0.000	2.692	12.250
history write	00:00:09.954	0.0%	22181	0.077	0.449	1.475
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.130	0.0%	221	0.000	0.588	5.000
idle	23:57:50.237	99.7%	609574	77.276	141.525	494.732
nntp read	00:00:02.177	0.0%	609752	0.001	0.004	0.008
overview write	00:02:11.593	0.2%	19159	0.078	6.868	2240.854
perl filter	00:00:29.136	0.0%	22165	1.096	1.315	1.868
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.296	0.0%	38348	0.000	0.008	0.041
TOTAL: 24:01:30.742	24:00:54.992	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.045	0.0%	19310	0.000	0.002	0.035
article prepare	00:00:00.004	0.0%	12132	0.000	0.000	0.019
article read	00:00:00.224	0.0%	1520	0.000	0.147	2.875
backlog stats	00:00:00.209	0.0%	447556	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.540	0.0%	354030	0.000	0.004	0.013
data write	00:00:01.855	0.0%	340018	0.001	0.005	0.011
idle	23:54:33.617	100.0%	447556	109.498	192.319	688.553
status file	00:00:00.183	0.0%	278	0.000	0.658	2.000
TOTAL: 23:54:47.164	23:54:37.677	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	52:37:32.154	99.8%	627	354.333	302156.545	600213.667
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.013	0.0%	1409	0.000	0.009	0.167
readart	00:00:00.339	0.0%	31	0.000	10.935	42.000
TOTAL: 52:42:32.632	52:37:32.506	99.8%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeeds.xmission.com	2	18516	4562	13891	63	24%	23:30:35
2	news-out.aioe.org	4	18756	4177	14521	58	22%	24:09:32
3	feeder.eternal-september.org	4	21378	2770	18385	223	12%	24:58:26
4	csiph-out.feeder.erje.net	1440	94334	1296	92785	253	1%	118:45:01
5	csiph-out.news.xs4all.nl	861	20694	1239	18250	1205	5%	71:26:09
6	newsfeed.neva.ru	149	19475	1078	18179	218	5%	71:53:57
7	csiph-out.news.weretis.net	6	41325	1067	39966	292	2%	49:37:46
8	news-out.mixmin.net	3	20320	958	19043	319	4%	24:08:52
9	newsfeed.fu-berlin.de	24	17240	946	16129	165	5%	24:58:08
10	news.fcku.it	14	2280	377	1900	3	16%	22:02:02
11	csiph-out.feed.uzoreto.com	864	29412	244	28742	426	0%	71:11:20
12	csiph-out.news.tnetconsulting.net	2	19620	127	19466	27	0%	23:59:52
13	news-out.neodome.net	2	20377	125	20242	10	0%	23:59:54
14	nntp.pasdenom.info	2	13918	76	13817	25	0%	23:58:28
15	news.swapon.de	5	2062	45	2017	0	2%	22:46:30
16	news.bbs.nz	1	19320	32	19288	0	0%	23:59:53
17	news.samoylyk.net	2	19370	13	19355	2	0%	24:57:26
18	localhost	32	6	6	0	0	100%	00:00:01
19	xanadu-bbs.net	94	720	0	720	0	0%	85:39:45
TOTAL: 19		3511	399123	19138	376696	3289	4%	756:03:37

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeeds.xmission.com	13.4 MB	0.0 KB	4.8 MB	18.2 MB	73%	4.0 KB
2	news-out.aioe.org	9.6 MB	0.0 KB	169.0 KB	9.7 MB	98%	2.4 KB
3	feeder.eternal-september.org	6.9 MB	1.6 KB	1.7 MB	8.6 MB	80%	3.0 KB
4	csiph-out.feeder.erje.net	5.3 MB	3.2 KB	3.2 MB	8.5 MB	62%	5.6 KB
5	csiph-out.news.xs4all.nl	3.4 MB	0.0 KB	11.2 MB	14.6 MB	23%	6.1 KB
6	news-out.mixmin.net	3.0 MB	1.6 KB	540.5 KB	3.5 MB	85%	2.8 KB
7	csiph-out.news.weretis.net	2.7 MB	6.9 KB	1.7 MB	4.4 MB	61%	3.3 KB
8	newsfeed.neva.ru	2.4 MB	4.9 KB	553.1 KB	2.9 MB	81%	2.3 KB
9	newsfeed.fu-berlin.de	2.2 MB	0.0 KB	371.3 KB	2.6 MB	85%	2.4 KB
10	csiph-out.feed.uzoreto.com	774.7 KB	1.6 KB	5.6 MB	6.3 MB	11%	9.7 KB
11	news.fcku.it	622.0 KB	1.6 KB	4.0 KB	627.6 KB	99%	1.7 KB
12	csiph-out.news.tnetconsulting.net	428.3 KB	5.3 KB	269.2 KB	702.7 KB	60%	4.6 KB
13	news-out.neodome.net	367.8 KB	5.1 KB	20.0 KB	392.9 KB	93%	2.9 KB
14	nntp.pasdenom.info	166.6 KB	1.7 KB	32.5 KB	200.8 KB	82%	2.0 KB
15	news.swapon.de	127.8 KB	0.0 KB	0.0 KB	127.8 KB	100%	2.8 KB
16	news.bbs.nz	60.0 KB	0.0 KB	0.0 KB	60.0 KB	100%	1.9 KB
17	news.samoylyk.net	38.0 KB	1.6 KB	3.1 KB	42.7 KB	88%	2.8 KB
18	localhost	7.9 KB	0.0 KB	0.0 KB	7.9 KB	100%	1.3 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		51.4 MB	35.1 KB	30.0 MB	81.4 MB	63%	3.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 21 04:15:00 - 04:59:59	214	1.1%	0.08	912.9 KB	1.7%	0.34
Apr 21 05:00:00 - 05:59:59	451	2.4%	0.13	1.1 MB	2.2%	0.33
Apr 21 06:00:00 - 06:59:59	660	3.4%	0.18	2.3 MB	4.4%	0.65
Apr 21 07:00:00 - 07:59:59	724	3.8%	0.20	1.8 MB	3.6%	0.52
Apr 21 08:00:00 - 08:59:59	797	4.2%	0.22	2.1 MB	4.0%	0.59
Apr 21 09:00:00 - 09:59:59	871	4.5%	0.24	2.2 MB	4.2%	0.61
Apr 21 10:00:00 - 10:59:59	907	4.7%	0.25	2.4 MB	4.7%	0.70
Apr 21 11:00:00 - 11:59:59	897	4.7%	0.25	2.1 MB	4.0%	0.59
Apr 21 12:00:00 - 12:59:59	1036	5.4%	0.29	2.6 MB	5.1%	0.74
Apr 21 13:00:00 - 13:59:59	1007	5.3%	0.28	2.7 MB	5.3%	0.78
Apr 21 14:00:00 - 14:59:59	1051	5.5%	0.29	2.5 MB	4.9%	0.72
Apr 21 15:00:00 - 15:59:59	1088	5.7%	0.30	3.0 MB	5.9%	0.87
Apr 21 16:00:00 - 16:59:59	1224	6.4%	0.34	3.2 MB	6.1%	0.90
Apr 21 17:00:00 - 17:59:59	1172	6.1%	0.33	3.0 MB	5.9%	0.86
Apr 21 18:00:00 - 18:59:59	1178	6.1%	0.33	3.1 MB	6.0%	0.88
Apr 21 19:00:00 - 19:59:59	1051	5.5%	0.29	2.7 MB	5.3%	0.77
Apr 21 20:00:00 - 20:59:59	1009	5.3%	0.28	2.6 MB	5.1%	0.75
Apr 21 21:00:00 - 21:59:59	960	5.0%	0.27	2.6 MB	5.1%	0.75
Apr 21 22:00:00 - 22:59:59	661	3.4%	0.18	1.8 MB	3.5%	0.51
Apr 21 23:00:00 - 23:59:59	583	3.0%	0.16	1.7 MB	3.3%	0.48
Apr 22 00:00:00 - 00:59:59	384	2.0%	0.11	1.2 MB	2.4%	0.35
Apr 22 01:00:00 - 01:59:59	466	2.4%	0.13	1.4 MB	2.8%	0.41
Apr 22 02:00:00 - 02:59:59	391	2.0%	0.11	1.1 MB	2.1%	0.31
Apr 22 03:00:00 - 03:59:59	283	1.5%	0.08	890.5 KB	1.7%	0.25
Apr 22 04:00:00 - 04:15:00	101	0.5%	0.11	316.2 KB	0.6%	0.35
TOTAL: 24:00:00	19166	100.0%	0.22	51.5 MB	100.0%	0.61

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	1206	30	0	1176
2	newsfeed.fu-berlin.de	692	31	0	661
3	csiph-out.feed.uzoreto.com	424	8	1	415
4	news-out.mixmin.net	323	12	1	310
5	csiph-out.feeder.erje.net	255	44	2	209
6	csiph-out.news.weretis.net	238	64	2	172
7	newsfeed.neva.ru	217	58	3	156
8	feeder.eternal-september.org	203	29	1	173
9	news-out.aioe.org	174	44	0	130
10	newsfeeds.xmission.com	74	4	0	70
11	csiph-out.news.tnetconsulting.net	36	23	1	12
12	nntp.pasdenom.info	25	0	1	24
13	news-out.neodome.net	9	0	1	8
14	news.swapon.de	5	0	0	5
15	news.fcku.it	3	2	1	0
16	news.samoylyk.net	2	0	1	1
TOTAL: 16		3886	349	15	3522

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	30
mozilla.support.seamonkey	27
spline.eisfair	21
mozilla.support.thunderbird	18
alt.computer.workshop	18
alt.bbs.synchronet	15
alt.politics.usa	14
alt.survival	13
alt.politics	12
alt.windows7.general	12
oesterreich.tratsch	11
mozilla.support.bugzilla	9
lada.auto	8
lada.commerce	7
free.it.religioni.scientology	7
alt.binaries.pictures.purebeauty	6
mozilla.dev.security.policy	6
alt.music.pink-floyd.publius	6
it-alt.comp.software.mozilla	6
alt.paranormal.spells	5
TOTAL: 84	349

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1728
EMP (phn path)	314
EMP (phl)	270
EMP (phn nph)	135
Too many newsgroups	92
0	68
HTML Multipart	19
Binary Payload	7
Binary: misplaced binary	5
Scoring filter	5
Too many newsgroups (meow)	4
HTML post	2
Too many newsgroups (low_xpost)	2
TOTAL: 13	2651

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Article posted in the future
	csiph-out.feed.uzoreto.com	3
	csiph-out.news.xs4all.nl	2
	csiph-out.feeder.erje.net	2
	TOTAL: 3	7
Bad Message-ID's offered
	csiph-out.feeder.erje.net	65
	csiph-out.feed.uzoreto.com	6
	csiph-out.news.xs4all.nl	5
	news-out.neodome.net	1
	TOTAL: 4	77
Huge articles
	csiph-out.news.xs4all.nl	61
	newsfeeds.xmission.com	59
	csiph-out.feeder.erje.net	49
	csiph-out.feed.uzoreto.com	29
	feeder.eternal-september.org	9
	csiph-out.news.weretis.net	8
	csiph-out.news.tnetconsulting.net	3
	news-out.mixmin.net	2
	TOTAL: 8	220
Including strange strings
	newsfeed.fu-berlin.de	487
	news-out.aioe.org	111
	newsfeeds.xmission.com	11
	csiph-out.news.weretis.net	8
	news.swapon.de	5
	news-out.mixmin.net	5
	newsfeed.neva.ru	3
	csiph-out.feeder.erje.net	3
	csiph-out.news.xs4all.nl	1
	csiph-out.feed.uzoreto.com	1
	TOTAL: 10	635
No colon-space in header
	csiph-out.news.xs4all.nl	7
	csiph-out.feed.uzoreto.com	2
	TOTAL: 2	9
TOTAL: 5		948

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	24054	962	18201	3	2	3%	23:59:51
2	news.bbs.nz	36578	401	18321	7	1	1%	23:59:46
3	fu-berlin.de	17932	389	17543	0	0	2%	23:59:53
4	news.samoylyk.net	19714	375	18771	7	30	1%	23:59:53
5	tnet	20056	140	18625	0	1	0%	23:59:53
6	erje	21092	100	17378	250	1	0%	23:59:43
7	neva.ru	17657	90	17327	64	0	0%	23:59:28
8	news.freedyn.net	19543	54	19111	1	0	0%	23:59:48
9	newsfeed.xs4all.nl	18384	40	17755	3	119	0%	23:59:53
10	weretis.net	17855	30	17584	1	0	0%	23:59:53
11	news.mixmin.net	18046	19	17514	0	0	0%	23:59:50
12	aioe	14236	19	13686	0	0	0%	23:59:53
13	xmission	16233	19	14086	0	0	0%	23:59:53
14	neodome.net	19568	15	18964	0	0	0%	23:59:53
15	usenet.pasdenom.info	19431	12	18670	3	23	0%	23:59:53
16	news.swapon.de	2153	6	2087	0	0	0%	23:46:26
17	news.uzoreto.com	18602	6	18316	15	0	0%	23:59:45
18	eternal-september	16425	6	15868	0	1	0%	23:59:41
19	news.fcku.it	1866	0	1860	0	0	0%	21:39:26
TOTAL: 19		339425	2683	301667	354	178	0%	453:22:41

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	4.3 MB	54.1 KB	4.3 MB	0.1 KB/s	4.6 KB	23:59:51
2	fu-berlin.de	2.8 MB	0.0 KB	2.8 MB	0.0 KB/s	7.4 KB	23:59:53
3	news.samoylyk.net	2.7 MB	67.1 KB	2.8 MB	0.0 KB/s	7.4 KB	23:59:53
4	news.bbs.nz	1.1 MB	74.6 KB	1.1 MB	0.0 KB/s	2.8 KB	23:59:46
5	tnet	380.3 KB	0.0 KB	380.3 KB	0.0 KB/s	2.7 KB	23:59:53
6	news.freedyn.net	373.6 KB	1.6 KB	375.2 KB	0.0 KB/s	6.8 KB	23:59:48
7	erje	223.7 KB	1.3 MB	1.5 MB	0.0 KB/s	4.3 KB	23:59:43
8	neva.ru	212.3 KB	153.1 KB	365.4 KB	0.0 KB/s	2.4 KB	23:59:28
9	newsfeed.xs4all.nl	135.2 KB	12.2 KB	147.4 KB	0.0 KB/s	3.4 KB	23:59:53
10	weretis.net	130.2 KB	1.1 KB	131.2 KB	0.0 KB/s	4.2 KB	23:59:53
11	xmission	48.1 KB	0.0 KB	48.1 KB	0.0 KB/s	2.5 KB	23:59:53
12	usenet.pasdenom.info	41.2 KB	5.5 KB	46.7 KB	0.0 KB/s	3.1 KB	23:59:53
13	news.mixmin.net	34.4 KB	0.0 KB	34.4 KB	0.0 KB/s	1.8 KB	23:59:50
14	aioe	30.0 KB	0.0 KB	30.0 KB	0.0 KB/s	1.6 KB	23:59:53
15	neodome.net	30.0 KB	0.0 KB	30.0 KB	0.0 KB/s	2.0 KB	23:59:53
16	news.uzoreto.com	8.5 KB	45.5 KB	54.0 KB	0.0 KB/s	2.6 KB	23:59:45
17	news.swapon.de	8.0 KB	0.0 KB	8.0 KB	0.0 KB/s	1.3 KB	23:46:26
18	eternal-september	8.0 KB	0.0 KB	8.0 KB	0.0 KB/s	1.3 KB	23:59:41
19	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:39:26
TOTAL: 19		12.5 MB	1.7 MB	14.1 MB	0.0 KB/s	4.8 KB	453:22:41

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	a131033.upc-a.chello.nl	67	21	34.6 KB	7	0	0	18:43:12
2	96-42-18-55.dhcp.mdsn.wi.charter.com	25	7	8.9 KB	7	6	4	06:59:08
3	5-168-143-94.cust.centrio.cz	5	3	10.4 KB	2	0	0	02:30:20
TOTAL: 3		97	31	53.9 KB	16	6	4	52:42:31

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.upc-a.chello.nl	67	21	34.6 KB	7	0	0	18:43:12
2	*.dhcp.mdsn.wi.charter.com	25	7	8.9 KB	7	6	4	06:59:08
3	*.cust.centrio.cz	5	3	10.4 KB	2	0	0	02:30:20
4	*.hsd1.wa.comcast.net	1	0	0.0 KB	0	0	0	00:30:01
5	unresolved	74	0	0.0 KB	0	0	0	23:59:47
6	*.census.shodan.io	1	0	0.0 KB	0	0	0	00:00:01
TOTAL: 6		173	31	53.9 KB	16	6	4	52:42:31

NNRP auth users [Top 20]:

User	Conn
ctomczyk	5
ohlandl	4
TOTAL: 2	9

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
91.187.33.87	4.742	1.180	0.000	23:59:44
a131033.upc-a.chello.nl	4.765	1.000	0.000	18:43:12
96-42-18-55.dhcp.mdsn.wi.charter.com	1.874	0.379	0.010	06:59:08
5-168-143-94.cust.centrio.cz	0.401	0.077	0.012	02:30:20
c-73-140-175-55.hsd1.wa.comcast.net	0.061	0.015	0.000	00:30:01
dojo.census.shodan.io	0.063	0.016	0.000	00:00:01
94.166.190.131	0.061	0.015	0.000	00:00:01
94.166.101.246	0.070	0.009	0.000	00:00:01
TOTAL: 8	12.037	2.691	0.022	52:42:31

Curious NNRP server explorers [Top 20]:

System	Conn
91.187.33.87	72
94.166.190.131	1
94.166.101.246	1
dojo.census.shodan.io	1
c-73-140-175-55.hsd1.wa.comcast.net	1
TOTAL: 5	76

NNRP client timeouts [Top 20]:

System	Conn	Peer
96-42-18-55.dhcp.mdsn.wi.charter.com	7	0
5-168-143-94.cust.centrio.cz	5	0
c-73-140-175-55.hsd1.wa.comcast.net	1	0
TOTAL: 3	13	0

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	28
2	comp.lang.javascript	3
TOTAL: 2		31

Daily Usenet report for csiph.com

Apr 21 04:15:00 -- Apr 22 04:15:00