Daily Usenet report: Sep 18 04:15:01

Unknown entries from news log file:

First 14 / 14 lines (100.0%)

Sep 18 10:36:00 newsfeed nnrpd[1201433]: SERVER perl filter not defined
Sep 18 10:36:00 newsfeed nnrpd[1201433]: SERVER perl filter not defined
Sep 18 10:36:15 newsfeed nnrpd[1201596]: SERVER perl filter not defined
Sep 18 10:36:15 newsfeed nnrpd[1201596]: SERVER perl filter not defined
Sep 18 12:33:08 newsfeed nnrpd[6664]: SERVER perl filter not defined
Sep 18 12:33:08 newsfeed nnrpd[6664]: SERVER perl filter not defined
Sep 18 12:33:32 newsfeed nnrpd[6922]: SERVER perl filter not defined
Sep 18 12:33:32 newsfeed nnrpd[6922]: SERVER perl filter not defined
Sep 18 12:36:10 newsfeed nnrpd[7007]: SERVER perl filter not defined
Sep 18 12:36:10 newsfeed nnrpd[7007]: SERVER perl filter not defined
Sep 18 15:59:40 newsfeed nnrpd[31437]: SERVER perl filter not defined
Sep 18 15:59:40 newsfeed nnrpd[31437]: SERVER perl filter not defined
Sep 18 22:17:36 newsfeed nnrpd[76411]: SERVER perl filter not defined
Sep 18 22:17:36 newsfeed nnrpd[76411]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	277278	88.2%	30.9 MB	89.6%
innd	19964	6.4%	2.0 MB	5.7%
nnrpd	15788	5.0%	1.5 MB	4.3%
innfeed	1222	0.4%	146.6 KB	0.4%
controlchan	4	0.0%	0.2 KB	0.0%
overchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	314258	100.0%	34.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	550824	99.7%
Negative hits	1490	0.3%
Positive hits	102	0.0%
Cache misses	2	0.0%
TOTAL: 4	552418	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.020	0.0%	48	0.000	0.417	3.000
article cleanup	00:00:01.446	0.0%	553024	0.000	0.003	0.008
article logging	00:00:06.368	0.0%	553102	0.005	0.012	0.028
article parse	00:00:08.124	0.0%	1693370	0.002	0.005	0.009
article write	00:00:16.434	0.0%	553024	0.020	0.030	0.250
artlog/artcncl	00:00:00.000	0.0%	12	0.000	0.000	0.000
data move	00:00:00.900	0.0%	2190526	0.000	0.000	0.003
hisgrep/artcncl	00:00:00.006	0.0%	60	0.000	0.100	1.000
hishave/artcncl	00:00:00.000	0.0%	12	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:31.246	0.0%	554610	0.001	0.056	0.658
history sync	00:00:00.056	0.0%	750	0.000	0.075	1.000
history write	00:01:04.678	0.0%	553024	0.027	0.117	0.753
idle	47:34:22.158	99.7%	1950388	37.605	87.809	283.956
nntp read	00:00:11.736	0.0%	1536928	0.005	0.008	0.013
overview write	00:00:00.740	0.0%	553024	0.000	0.001	0.006
perl filter	00:03:59.338	0.1%	553024	0.346	0.433	0.664
python filter	00:00:00.104	0.0%	553038	0.000	0.000	0.001
site send	00:00:06.408	0.0%	1118610	0.002	0.006	0.011
TOTAL: 47:41:40.962	47:40:49.762	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.014	0.0%	12518	0.000	0.001	0.031
article prepare	00:00:00.000	0.0%	880	0.000	0.000	0.000
article read	00:00:00.006	0.0%	220	0.000	0.027	1.000
backlog stats	00:00:00.016	0.0%	74206	0.000	0.000	0.011
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.230	0.0%	34920	0.000	0.007	0.042
data write	00:00:00.582	0.0%	22218	0.000	0.026	0.190
idle	47:36:42.274	100.0%	74206	874.773	2309.817	11141.981
status file	00:00:00.130	0.0%	328	0.000	0.396	4.000
TOTAL: 47:36:44.008	47:36:43.252	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:42.112	71.6%	8820	0.000	11.577	10048.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.228	0.2%	29828	0.000	0.008	0.667
TOTAL: 00:02:22.600	00:01:42.340	71.8%	-	-	-	-

Control commands to INND:

Command	Number
flush	54
flushlogs	4
go	4
logmode	4
lowmark	2
mode	298
name	4
pause	4
paused	4
reload	4
reserve	4
TOTAL: 11	386

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	102	554210	554210	0	100%	67:00:04
2	localhost	16	14	14	0	100%	00:00:00
3	news.icm.edu.pl	62	92	0	92	0%	12:38:08
TOTAL: 3		180	554316	554224	92	99%	79:38:12

Incoming Volume (INN):

Server		AcceptVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	4.1 GB	4.1 GB	100%	7.8 KB
2	localhost	20.7 KB	20.7 KB	100%	1.5 KB
3	news.icm.edu.pl	0.0 KB	0.0 KB	0%	0
TOTAL: 3		4.1 GB	4.1 GB	100%	7.8 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 18 04:15:01 - 04:59:59	3136	1.1%	1.16	26.8 MB	1.3%	10.19
Sep 18 05:00:00 - 05:59:59	9923	3.6%	2.76	60.8 MB	2.9%	17.30
Sep 18 06:00:00 - 06:59:59	9763	3.5%	2.71	70.8 MB	3.3%	20.14
Sep 18 07:00:00 - 07:59:59	12135	4.4%	3.37	86.2 MB	4.1%	24.53
Sep 18 08:00:00 - 08:59:59	12183	4.4%	3.38	82.4 MB	3.9%	23.44
Sep 18 09:00:00 - 09:59:59	10661	3.8%	2.96	80.0 MB	3.8%	22.77
Sep 18 10:00:00 - 10:59:59	15563	5.6%	4.32	112.1 MB	5.3%	31.90
Sep 18 11:00:00 - 11:59:59	9702	3.5%	2.69	81.8 MB	3.9%	23.28
Sep 18 12:00:00 - 12:59:59	11290	4.1%	3.14	88.0 MB	4.1%	25.04
Sep 18 13:00:00 - 13:59:59	8192	3.0%	2.28	65.9 MB	3.1%	18.73
Sep 18 14:00:00 - 14:59:59	8562	3.1%	2.38	71.2 MB	3.4%	20.26
Sep 18 15:00:00 - 15:59:59	21046	7.6%	5.85	157.9 MB	7.4%	44.92
Sep 18 16:00:00 - 16:59:59	13665	4.9%	3.80	97.1 MB	4.6%	27.61
Sep 18 17:00:00 - 17:59:59	15004	5.4%	4.17	124.1 MB	5.8%	35.30
Sep 18 18:00:00 - 18:59:59	12790	4.6%	3.55	106.3 MB	5.0%	30.24
Sep 18 19:00:00 - 19:59:59	7920	2.9%	2.20	71.4 MB	3.4%	20.31
Sep 18 20:00:00 - 20:59:59	5332	1.9%	1.48	51.3 MB	2.4%	14.59
Sep 18 21:00:00 - 21:59:59	8449	3.0%	2.35	67.4 MB	3.2%	19.17
Sep 18 22:00:00 - 22:59:59	8351	3.0%	2.32	68.3 MB	3.2%	19.41
Sep 18 23:00:00 - 23:59:59	20031	7.2%	5.56	154.8 MB	7.3%	44.02
Sep 19 00:00:00 - 00:59:59	14321	5.2%	3.98	102.5 MB	4.8%	29.14
Sep 19 01:00:00 - 01:59:59	10588	3.8%	2.94	86.1 MB	4.1%	24.49
Sep 19 02:00:00 - 02:59:59	12780	4.6%	3.55	82.9 MB	3.9%	23.59
Sep 19 03:00:00 - 03:59:59	12785	4.6%	3.55	99.8 MB	4.7%	28.38
Sep 19 04:00:00 - 04:15:01	3061	1.1%	3.40	26.3 MB	1.2%	29.92
TOTAL: 24:00:00	277233	100.0%	3.21	2.1 GB	100.0%	25.15

Sites sending bad articles:

Server		Total	Group	Dist	Duplic	Unapp	TooOld	Site	Line	Other
1	newsfeed.pionier.net.pl	39	0	0	0	0	0	0	0	39
TOTAL: 1		39	0	0	0	0	0	0	0	39

Miscellaneous innd statistics [Top 10]:

Event	Server	Number
Including strange strings
	newsfeed.pionier.net.pl	39
	TOTAL: 1	39
TOTAL: 1		39

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	icm	22550	182	12262	38	0%	47:33:16
2	poznan	0	0	0	0	0%	00:40:00
TOTAL: 2		22550	182	12262	38	0%	48:13:16

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	941.0 KB	805.8 KB	1.7 MB	7.9 KB	47:33:16
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	00:40:00
TOTAL: 2		941.0 KB	805.8 KB	1.7 MB	7.9 KB	48:13:16

NNRP readership statistics:

System		Conn	Post	Elapsed
1	182.186.132.66.censys-scanner.com	2	0	00:00:03
2	69-5-169-77.infrawat.ch	2	0	00:00:00
3	205.210.31.39	2	0	00:00:00
4	172.16.2.4	574	0	00:00:42
5	69-5-169-15.infrawat.ch	2	0	00:00:00
6	147.185.133.93	2	0	00:00:03
7	sh-chi-us-cpp-wk106.internet-census.org	2	0	00:00:00
8	nms1.man.lodz.pl	2870	0	00:00:34
9	isvcs01.man.lodz.pl	14	14	00:00:00
10	zl-laxc-us-cpp-wk109.internet-census.org	4	0	00:00:00
11	zl-laxk-us-gp1-wk133c.internet-census.org	2	0	00:00:21
12	193-176-31-250.infrawat.ch	2	0	00:00:00
13	sh-ams-nl-cpp-wk104.internet-census.org	2	0	00:00:00
14	sh-chi-us-cpp-wk105.internet-census.org	2	0	00:00:00
15	sfo2-81.beryllium.do.prod.binaryedge.ninja	6	0	00:00:10
16	69-5-169-45.infrawat.ch	2	0	00:00:00
17	80.111.142.213	8	0	00:00:05
18	sh-ams-nl-cpp-wk103.internet-census.org	2	0	00:00:00
19	71.6.134.232	2	0	00:00:00
20	azpdcg8bkl6w.stretchoid.com	4	0	00:00:20
TOTAL: 20		3506	14	00:02:23

NNRP readership statistics (by domain):

System		Conn	Post	Elapsed
1	unresolved	588	0	00:00:51
2	*.186.132.66.censys-scanner.com	2	0	00:00:03
3	*.stretchoid.com	4	0	00:00:20
4	*.internet-census.org	14	0	00:00:21
5	*.beryllium.do.prod.binaryedge.ninja	6	0	00:00:10
6	*.infrawat.ch	8	0	00:00:00
7	*.man.lodz.pl	2884	14	00:00:35
TOTAL: 7		3506	14	00:02:23

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
172.16.2.4	1.354	2.998	00:00:42
nms1.man.lodz.pl	7.566	14.392	00:00:34
zl-laxk-us-gp1-wk133c.internet-census.org	0.004	0.010	00:00:21
azpdcg8bkl6w.stretchoid.com	0.008	0.018	00:00:20
sfo2-81.beryllium.do.prod.binaryedge.ninja	0.010	0.032	00:00:10
80.111.142.213	0.014	0.042	00:00:05
147.185.133.93	0.004	0.010	00:00:03
182.186.132.66.censys-scanner.com	0.054	0.014	00:00:03
isvcs01.man.lodz.pl	0.050	0.084	00:00:00
71.6.134.232	0.008	0.008	00:00:00
205.210.31.39	0.004	0.008	00:00:00
69-5-169-45.infrawat.ch	0.002	0.012	00:00:00
zl-laxc-us-cpp-wk109.internet-census.org	0.010	0.024	00:00:00
69-5-169-77.infrawat.ch	0.006	0.008	00:00:00
69-5-169-15.infrawat.ch	0.006	0.008	00:00:00
193-176-31-250.infrawat.ch	0.004	0.012	00:00:00
sh-ams-nl-cpp-wk103.internet-census.org	0.002	0.014	00:00:00
sh-ams-nl-cpp-wk104.internet-census.org	0.004	0.010	00:00:00
sh-chi-us-cpp-wk105.internet-census.org	0.004	0.010	00:00:00
sh-chi-us-cpp-wk106.internet-census.org	0.004	0.010	00:00:00
TOTAL: 20	9.118	17.724	00:02:23

NNRP unrecognized commands (by host) [Top 20]:

System	Conn
147.185.133.93	8
182.186.132.66.censys-scanner.com	2
azpdcg8bkl6w.stretchoid.com	2
TOTAL: 3	12

NNRP unrecognized commands (by command) [Top 20]:

Command	Count
MGLNDD_212.191.2.21_119	2
User-Agent: Hello from Palo Alto Network...	2
Host: 212.191.2.21:119	2
GET / HTTP/1.1	2
EHLO www.censys.io	2
Accept-Encoding: gzip	2
TOTAL: 6	12

NNRP client timeouts [Top 20]:

System	Conn	Peer
69-5-169-45.infrawat.ch	2	2
69-5-169-77.infrawat.ch	2	2
TOTAL: 2	4	10

Daily Usenet report

Sep 18 04:15:01 -- Sep 19 04:15:01