Daily Usenet report for csiph.com: Nov 30 04:15:00

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	18190	46.2%	4.6 MB	61.1%
innd	16839	42.7%	2.2 MB	29.4%
innfeed	3662	9.3%	655.5 KB	8.5%
nnrpd	677	1.7%	73.8 KB	1.0%
nocem	26	0.1%	2.9 KB	0.0%
controlchan	3	0.0%	0.3 KB	0.0%
TOTAL: 6	39397	100.0%	7.6 MB	100.0%

History cache:

Reason	Count	%Count
Positive hits	282937	58.2%
Negative hits	185717	38.2%
Do not exist	17548	3.6%
Cache misses	229	0.0%
TOTAL: 4	486431	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.132	0.0%	19	0.000	6.947	28.000
article cleanup	00:00:00.120	0.0%	17200	0.000	0.007	0.056
article logging	00:00:00.268	0.0%	17570	0.000	0.015	0.540
article parse	00:00:00.762	0.0%	53270	0.000	0.014	0.117
article write	00:00:22.852	0.0%	15020	0.148	1.521	57.302
artlog/artcncl	00:00:00.000	0.0%	19	0.000	0.000	0.000
artlog/artparse	00:00:00.005	0.0%	473	0.000	0.011	0.200
data move	00:00:00.166	0.0%	452514	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.017	0.0%	19	0.000	0.895	11.000
hishave/artcncl	00:00:00.001	0.0%	19	0.000	0.053	0.125
hishave/artparse	00:00:00.000	0.0%	469	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:04.343	0.0%	487944	0.002	0.009	0.137
history sync	00:00:00.672	0.0%	390	0.000	1.723	4.667
history write	00:00:08.298	0.0%	17157	0.196	0.484	3.736
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
hiswrite/artparse	00:00:00.271	0.0%	469	0.000	0.578	23.000
idle	23:48:47.367	99.8%	461798	106.579	185.638	571.126
nntp read	00:00:01.764	0.0%	463337	0.001	0.004	0.010
overview write	00:00:49.137	0.1%	15020	0.091	3.271	119.667
perl filter	00:00:23.484	0.0%	17153	0.994	1.369	2.118
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:00.238	0.0%	30062	0.000	0.008	0.059
TOTAL: 23:51:08.510	23:50:39.897	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.037	0.0%	15167	0.000	0.002	0.047
article prepare	00:00:00.003	0.0%	20628	0.000	0.000	0.007
article read	00:00:00.367	0.0%	1796	0.000	0.204	14.667
backlog stats	00:00:00.170	0.0%	358874	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.170	0.0%	270175	0.001	0.004	0.011
data write	00:00:01.512	0.0%	257655	0.001	0.006	0.012
idle	23:54:12.172	100.0%	358874	138.133	239.784	704.039
status file	00:00:00.264	0.0%	291	0.000	0.907	18.000
TOTAL: 23:54:21.590	23:54:15.695	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	19:23:58.842	100.0%	721	1881.500	96863.859	600098.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.212	0.0%	1929	0.000	0.110	0.845
readart	00:00:02.368	0.0%	208	0.000	11.385	53.000
TOTAL: 19:24:22.803	19:24:01.422	100.0%	-	-	-	-

Control commands to INND:

Command	Number
flush	5
flushlogs	2
go	2
logmode	2
lowmark	1
mode	139
pause	2
paused	2
reload	2
reserve	2
shutdown	6
TOTAL: 11	165

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	csiph-out.feeder.erje.net	1449	71219	3476	67421	322	4%	118:39:45
2	news-out.aioe.org	3	14086	2406	11635	45	17%	24:04:03
3	feeder.eternal-september.org	10	15571	1733	13724	114	11%	23:07:37
4	newsfeeds.xmission.com	5	14125	1698	12372	55	12%	24:39:13
5	csiph-out.news.xs4all.nl	863	16322	1163	14426	733	7%	71:16:28
6	news.freedyn.net	4	17002	1013	15388	601	5%	24:08:02
7	newsfeed.fu-berlin.de	13	16744	858	15837	49	5%	28:53:10
8	news-out.mixmin.net	3	15493	846	14496	151	5%	23:58:51
9	csiph-out.news.weretis.net	6	39906	807	39030	69	2%	61:45:11
10	newsfeed.neva.ru	153	17107	735	16123	249	4%	71:40:13
11	csiph-out.feed.uzoreto.com	866	23518	164	23125	229	0%	71:12:13
12	news.fcku.it	16	1099	85	1011	3	7%	21:18:55
13	nntp.pasdenom.info	3	9414	49	9313	52	0%	23:57:57
14	news.samoylyk.net	3	14148	34	14109	5	0%	23:59:18
15	news.swapon.de	14	1230	29	1201	0	2%	23:24:40
16	csiph-out.news.tnetconsulting.net	3	23782	17	23758	7	0%	36:46:25
17	localhost	38	12	12	0	0	100%	00:00:00
18	news.bbs.nz	3	22711	1	22710	0	0%	36:03:14
19	xanadu-bbs.net	44	309	0	309	0	0%	18:29:23
TOTAL: 19		3499	333798	15126	315988	2684	4%	727:24:38

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	csiph-out.feeder.erje.net	15.1 MB	24.6 KB	9.9 MB	25.0 MB	60%	6.7 KB
2	news-out.aioe.org	5.7 MB	8.0 KB	97.1 KB	5.8 MB	98%	2.4 KB
3	newsfeeds.xmission.com	5.2 MB	0.0 KB	2.7 MB	8.0 MB	65%	4.7 KB
4	feeder.eternal-september.org	4.8 MB	5.1 KB	2.6 MB	7.3 MB	64%	4.1 KB
5	csiph-out.news.xs4all.nl	3.3 MB	5.2 KB	7.2 MB	10.6 MB	31%	5.7 KB
6	news.freedyn.net	2.6 MB	8.1 KB	1.7 MB	4.4 MB	60%	2.8 KB
7	csiph-out.news.weretis.net	2.4 MB	8.1 KB	999.1 KB	3.4 MB	70%	4.0 KB
8	news-out.mixmin.net	2.2 MB	8.1 KB	334.2 KB	2.6 MB	87%	2.6 KB
9	newsfeed.fu-berlin.de	1.9 MB	0.0 KB	133.8 KB	2.1 MB	93%	2.3 KB
10	newsfeed.neva.ru	1.9 MB	22.2 KB	864.2 KB	2.8 MB	68%	2.9 KB
11	csiph-out.feed.uzoreto.com	545.7 KB	21.6 KB	4.6 MB	5.1 MB	10%	13.4 KB
12	news.fcku.it	179.6 KB	2.5 KB	4.6 KB	186.7 KB	96%	2.1 KB
13	nntp.pasdenom.info	99.6 KB	0.0 KB	73.6 KB	173.2 KB	57%	1.7 KB
14	news.samoylyk.net	96.4 KB	3.0 KB	1.0 MB	1.1 MB	8%	29.5 KB
15	news.swapon.de	78.2 KB	0.0 KB	0.0 KB	78.2 KB	100%	2.7 KB
16	csiph-out.news.tnetconsulting.net	43.3 KB	0.0 KB	14.6 KB	57.8 KB	74%	2.4 KB
17	localhost	21.3 KB	0.0 KB	0.0 KB	21.3 KB	100%	1.8 KB
18	news.bbs.nz	1.0 KB	0.0 KB	0.0 KB	1.0 KB	100%	1.0 KB
19	xanadu-bbs.net	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 19		46.3 MB	116.5 KB	32.3 MB	78.6 MB	58%	4.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 30 04:15:00 - 04:59:59	254	1.7%	0.09	747.1 KB	1.6%	0.28
Nov 30 05:00:00 - 05:59:59	298	2.0%	0.08	1.0 MB	2.2%	0.29
Nov 30 06:00:00 - 06:59:59	265	1.8%	0.07	1014.1 KB	2.1%	0.28
Nov 30 07:00:00 - 07:59:59	400	2.6%	0.11	1.9 MB	4.1%	0.54
Nov 30 08:00:00 - 08:59:59	588	3.9%	0.16	2.4 MB	5.2%	0.69
Nov 30 09:00:00 - 09:59:59	661	4.4%	0.18	2.4 MB	5.1%	0.67
Nov 30 10:00:00 - 10:59:59	790	5.2%	0.22	2.5 MB	5.3%	0.70
Nov 30 11:00:00 - 11:59:59	664	4.4%	0.18	2.2 MB	4.8%	0.64
Nov 30 12:00:00 - 12:59:59	674	4.5%	0.19	1.6 MB	3.4%	0.45
Nov 30 13:00:00 - 13:59:59	698	4.6%	0.19	1.8 MB	3.8%	0.50
Nov 30 14:00:00 - 14:59:59	769	5.1%	0.21	2.0 MB	4.3%	0.57
Nov 30 15:00:00 - 15:59:59	794	5.3%	0.22	2.5 MB	5.4%	0.71
Nov 30 16:00:00 - 16:59:59	845	5.6%	0.23	2.3 MB	4.9%	0.65
Nov 30 17:00:00 - 17:59:59	935	6.2%	0.26	2.5 MB	5.3%	0.70
Nov 30 18:00:00 - 18:59:59	800	5.3%	0.22	2.1 MB	4.5%	0.60
Nov 30 19:00:00 - 19:59:59	950	6.3%	0.26	3.1 MB	6.8%	0.89
Nov 30 20:00:00 - 20:59:59	745	4.9%	0.21	2.1 MB	4.6%	0.61
Nov 30 21:00:00 - 21:59:59	671	4.4%	0.19	1.9 MB	4.1%	0.55
Nov 30 22:00:00 - 22:59:59	677	4.5%	0.19	1.8 MB	3.9%	0.51
Nov 30 23:00:00 - 23:59:59	695	4.6%	0.19	2.5 MB	5.3%	0.70
Dec 1 00:00:00 - 00:59:59	590	3.9%	0.16	1.6 MB	3.5%	0.47
Dec 1 01:00:00 - 01:59:59	426	2.8%	0.12	1.3 MB	2.7%	0.36
Dec 1 02:00:00 - 02:59:59	496	3.3%	0.14	1.5 MB	3.1%	0.41
Dec 1 03:00:00 - 03:59:59	347	2.3%	0.10	1.5 MB	3.2%	0.42
Dec 1 04:00:00 - 04:15:00	90	0.6%	0.10	293.0 KB	0.6%	0.33
TOTAL: 24:00:00	15122	100.0%	0.18	46.4 MB	100.0%	0.55

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	csiph-out.news.xs4all.nl	758	34	2	722
2	news.freedyn.net	601	10	3	588
3	csiph-out.feeder.erje.net	325	83	9	233
4	newsfeed.fu-berlin.de	315	33	1	281
5	newsfeed.neva.ru	249	72	8	169
6	csiph-out.feed.uzoreto.com	230	8	8	214
7	news-out.mixmin.net	156	3	4	149
8	feeder.eternal-september.org	118	29	4	85
9	news-out.aioe.org	109	32	3	74
10	csiph-out.news.weretis.net	73	43	3	27
11	nntp.pasdenom.info	52	0	0	52
12	newsfeeds.xmission.com	51	2	0	49
13	news.samoylyk.net	5	1	1	3
14	news.fcku.it	3	0	1	2
15	news.swapon.de	2	0	0	2
TOTAL: 15		3047	350	47	2650

Unwanted newsgroups [Top 20]:

Newsgroup	Count
lada.talk	55
alt.survival	32
alt.binaries.ctb	26
alt.bbs.synchronet	21
mozilla.support.seamonkey	15
alt.windows7.general	15
spline.eisfair.dev	15
alt.computer.workshop	14
mozilla.support.firefox	12
spline.eisfair	11
alt.tv.star-trek	8
alt.binaries.ebooks	8
lada.movies	7
alt.binaries.pictures.purebeauty	6
oesterreich.tratsch	6
spline.fli4l.dev	5
lada.commerce	4
mozilla.support.thunderbird	4
rocksolid.shared.test	4
free.metaphysics	4
TOTAL: 74	350

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	1456
EMP (phl)	108
0	88
EMP (phn nph)	76
Too many newsgroups	36
HTML Multipart	24
Scoring filter	7
Binary: misplaced binary	5
HTML post	1
TOTAL: 9	1801

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.feeder.erje.net	174
	csiph-out.news.xs4all.nl	120
	csiph-out.feed.uzoreto.com	72
	newsfeeds.xmission.com	49
	feeder.eternal-september.org	36
	news.freedyn.net	12
	csiph-out.news.weretis.net	9
	news.samoylyk.net	3
	news-out.mixmin.net	1
	TOTAL: 9	476
Including strange strings
	newsfeed.fu-berlin.de	268
	news-out.aioe.org	60
	csiph-out.news.xs4all.nl	18
	news-out.mixmin.net	10
	csiph-out.news.weretis.net	6
	csiph-out.feeder.erje.net	4
	news.swapon.de	2
	news.freedyn.net	2
	csiph-out.feed.uzoreto.com	1
	feeder.eternal-september.org	1
	TOTAL: 10	372
No colon-space in header
	csiph-out.news.xs4all.nl	1
	TOTAL: 1	1
TOTAL: 4		894

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	xanadu-bbs	19305	1106	14055	0	1	5%	24:08:07
2	news.bbs.nz	28401	520	14125	45	9	1%	24:08:07
3	news.freedyn.net	14435	508	13565	16	0	3%	24:08:07
4	news.samoylyk.net	15680	475	14644	1	3	3%	24:06:12
5	fu-berlin.de	14304	462	13841	0	1	3%	24:08:07
6	erje	14021	401	10950	211	33	2%	24:08:08
7	tnet	17996	236	14460	0	1	1%	24:08:08
8	usenet.pasdenom.info	15597	209	14358	438	21	1%	23:59:29
9	neva.ru	14016	39	13549	228	2	0%	24:08:07
10	news.uzoreto.com	14910	27	14440	116	1	0%	24:08:05
11	newsfeed.xs4all.nl	14138	25	13601	5	58	0%	24:02:22
12	aioe	11976	17	11456	23	0	0%	24:08:07
13	eternal-september	13296	16	12714	0	3	0%	24:08:07
14	weretis.net	15612	15	13730	13	0	0%	24:08:07
15	xmission	15516	14	12921	1	2	0%	24:08:07
16	news.mixmin.net	14129	14	13632	1	1	0%	24:08:07
17	news.swapon.de	1250	10	1234	0	0	0%	23:37:41
18	news.fcku.it	953	0	947	0	0	0%	21:06:26
TOTAL: 18		255535	4094	218222	1098	136	1%	430:37:41

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	xanadu-bbs	8.2 MB	0.0 KB	8.2 MB	0.1 KB/s	7.6 KB	24:08:07
2	news.freedyn.net	6.6 MB	21.9 KB	6.6 MB	0.1 KB/s	12.9 KB	24:08:07
3	news.samoylyk.net	6.4 MB	16.8 KB	6.5 MB	0.1 KB/s	13.9 KB	24:06:12
4	fu-berlin.de	6.4 MB	0.0 KB	6.4 MB	0.1 KB/s	14.3 KB	24:08:07
5	news.bbs.nz	1.2 MB	96.9 KB	1.3 MB	0.0 KB/s	2.3 KB	24:08:07
6	erje	973.0 KB	639.1 KB	1.6 MB	0.0 KB/s	2.6 KB	24:08:08
7	tnet	508.3 KB	0.0 KB	508.3 KB	0.0 KB/s	2.2 KB	24:08:08
8	usenet.pasdenom.info	479.1 KB	5.6 MB	6.1 MB	0.1 KB/s	9.6 KB	23:59:29
9	newsfeed.xs4all.nl	81.3 KB	23.8 KB	105.1 KB	0.0 KB/s	3.5 KB	24:02:22
10	neva.ru	67.3 KB	466.6 KB	534.0 KB	0.0 KB/s	2.0 KB	24:08:07
11	news.uzoreto.com	62.6 KB	288.5 KB	351.1 KB	0.0 KB/s	2.5 KB	24:08:05
12	aioe	48.5 KB	47.5 KB	95.9 KB	0.0 KB/s	2.4 KB	24:08:07
13	eternal-september	30.3 KB	0.0 KB	30.3 KB	0.0 KB/s	1.9 KB	24:08:07
14	weretis.net	28.0 KB	31.2 KB	59.3 KB	0.0 KB/s	2.1 KB	24:08:07
15	news.mixmin.net	26.1 KB	1.5 KB	27.5 KB	0.0 KB/s	1.8 KB	24:08:07
16	xmission	25.4 KB	2.7 KB	28.1 KB	0.0 KB/s	1.9 KB	24:08:07
17	news.swapon.de	18.2 KB	0.0 KB	18.2 KB	0.0 KB/s	1.8 KB	23:37:41
18	news.fcku.it	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	21:06:26
TOTAL: 18		31.1 MB	7.2 MB	38.3 MB	0.0 KB/s	7.6 KB	430:37:41

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	ip72-222-200-117.ph.ph.cox.net	21	158	350.3 KB	17	3	3	06:20:05
2	a131033.upc-a.chello.nl	14	26	47.0 KB	5	0	0	02:30:06
3	68-185-181-68.dhcp.mdsn.wi.charter.com	40	23	45.8 KB	18	9	7	10:03:10
4	208-71-239-109.cust.centrio.cz	2	1	3.2 KB	1	0	0	00:30:22
TOTAL: 4		77	208	446.3 KB	41	12	10	19:24:22

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Rej	Elapsed
1	*.ph.ph.cox.net	21	158	350.3 KB	17	3	3	06:20:05
2	*.upc-a.chello.nl	14	26	47.0 KB	5	0	0	02:30:06
3	*.dhcp.mdsn.wi.charter.com	40	23	45.8 KB	18	9	7	10:03:10
4	*.cust.centrio.cz	2	1	3.2 KB	1	0	0	00:30:22
5	*.hinet-ip.hinet.net	1	0	0.0 KB	0	0	0	00:00:34
6	*.shodan.io	1	0	0.0 KB	0	0	0	00:00:03
TOTAL: 6		79	208	446.3 KB	41	12	10	19:24:22

NNRP auth users [Top 20]:

User	Conn
ohlandl	7
kev009	3
ctomczyk	2
TOTAL: 3	12

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Idle(ms)	Elapsed
68-185-181-68.dhcp.mdsn.wi.charter.com	3.395	0.602	0.017	10:03:10
ip72-222-200-117.ph.ph.cox.net	2.172	1.915	0.007	06:20:05
a131033.upc-a.chello.nl	1.159	0.227	0.000	02:30:06
208-71-239-109.cust.centrio.cz	0.215	0.025	0.004	00:30:22
220-128-243-66.hinet-ip.hinet.net	0.069	0.008	0.000	00:00:34
census3.shodan.io	0.075	0.000	0.000	00:00:03
TOTAL: 6	7.085	2.777	0.028	19:24:22

Curious NNRP server explorers [Top 20]:

System	Conn
220-128-243-66.hinet-ip.hinet.net	1
census3.shodan.io	1
TOTAL: 2	2

NNRP unrecognized commands (by host):

System	Conn
220-128-243-66.hinet-ip.hinet.net	10
TOTAL: 1	10

NNRP unrecognized commands (by command):

Command	Count
Content-Length: 586	1
Accept-Encoding: identity	1
Accept-Language: en-us	1
Authorization: Basic YWRtaW46ezEyMjEzQkQ...	1
Cache-Control: max-age=0	1
Content-Type: text/xml	1
Connection: close	1
User-Agent: ApiTool	1
Accept: /	1
Host: 69.160.37.58	1
TOTAL: 10	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
68-185-181-68.dhcp.mdsn.wi.charter.com	9	0
ip72-222-200-117.ph.ph.cox.net	9	0
208-71-239-109.cust.centrio.cz	1	0
TOTAL: 3	19	0

Newsgroup request counts (by category):

Category		Count	Pct
1	comp	188	90.4%
2	news	15	7.2%
3	alt	5	2.4%
TOTAL: 3		208	100.0%

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

Newsgroup		Count
1	comp.sys.ibm.ps2.hardware	187
2	news.lists.filters	12
3	alt.free.newsservers	5
4	news.software.nntp	3
5	comp.lang.javascript	1
TOTAL: 5		208

Daily Usenet report for csiph.com

Nov 30 04:15:00 -- Dec 1 04:15:00