Daily Usenet report: Sep 16 04:15:01

Unknown entries from news log file:

First 10 / 10 lines (100.0%)

Sep 16 10:34:55 newsfeed nnrpd[1007816]: SERVER perl filter not defined
Sep 16 10:34:55 newsfeed nnrpd[1007816]: SERVER perl filter not defined
Sep 16 10:36:11 newsfeed nnrpd[1007873]: SERVER perl filter not defined
Sep 16 10:36:11 newsfeed nnrpd[1007873]: SERVER perl filter not defined
Sep 16 15:02:30 newsfeed nnrpd[1039546]: SERVER perl filter not defined
Sep 16 15:02:30 newsfeed nnrpd[1039546]: SERVER perl filter not defined
Sep 16 15:16:16 newsfeed nnrpd[1041400]: SERVER perl filter not defined
Sep 16 15:16:16 newsfeed nnrpd[1041400]: SERVER perl filter not defined
Sep 16 16:01:51 newsfeed nnrpd[1046698]: SERVER perl filter not defined
Sep 16 16:01:51 newsfeed nnrpd[1046698]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	176276	80.1%	19.4 MB	82.5%
innd	26848	12.2%	2.5 MB	10.6%
nnrpd	15714	7.1%	1.5 MB	6.2%
innfeed	1232	0.6%	157.2 KB	0.7%
controlchan	2	0.0%	0.1 KB	0.0%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 6	220074	100.0%	23.5 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	352112	99.7%
Negative hits	822	0.2%
Positive hits	110	0.0%
Cache misses	2	0.0%
TOTAL: 4	353046	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.012	0.0%	52	0.000	0.231	5.000
article cleanup	00:00:00.914	0.0%	352452	0.000	0.003	0.008
article logging	00:00:04.298	0.0%	352630	0.005	0.012	0.026
article parse	00:00:07.466	0.0%	1439020	0.003	0.005	0.008
article write	00:00:14.634	0.0%	352452	0.023	0.042	0.320
artlog/artcncl	00:00:00.000	0.0%	6	0.000	0.000	0.000
data move	00:00:00.928	0.0%	2127722	0.000	0.000	0.001
hisgrep/artcncl	00:00:00.004	0.0%	58	0.000	0.069	1.000
hishave/artcncl	00:00:00.000	0.0%	6	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:12.920	0.0%	353380	0.000	0.037	2.772
history sync	00:00:00.022	0.0%	614	0.000	0.036	0.500
history write	00:00:31.746	0.0%	352452	0.028	0.090	1.271
idle	47:55:08.096	99.8%	1700234	54.715	101.461	327.096
nntp read	00:00:11.216	0.0%	1389842	0.004	0.008	0.012
overview write	00:00:00.558	0.0%	352452	0.000	0.002	0.006
perl filter	00:03:19.720	0.1%	352452	0.454	0.567	0.770
python filter	00:00:00.072	0.0%	352462	0.000	0.000	0.002
site send	00:00:04.952	0.0%	717434	0.003	0.007	0.014
TOTAL: 48:00:34.482	47:59:57.558	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.024	0.0%	12500	0.000	0.002	0.045
article prepare	00:00:00.000	0.0%	560	0.000	0.000	0.000
article read	00:00:00.000	0.0%	140	0.000	0.000	0.000
backlog stats	00:00:00.022	0.0%	77588	0.000	0.000	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.294	0.0%	35928	0.000	0.008	0.043
data write	00:00:00.780	0.0%	23272	0.000	0.034	0.125
idle	47:40:26.874	100.0%	77588	1205.601	2212.029	7059.235
status file	00:00:00.180	0.0%	320	0.000	0.562	4.000
TOTAL: 47:40:30.484	47:40:28.174	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:13.862	75.8%	8770	1.000	8.422	10007.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.292	0.3%	29658	0.000	0.010	0.333
TOTAL: 00:01:37.450	00:01:14.154	76.1%	-	-	-	-

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	138	352236	352236	0	100%	72:02:52
2	localhost	12	10	10	0	100%	00:00:00
3	news.icm.edu.pl	74	108	2	106	1%	14:49:42
TOTAL: 3		224	352354	352248	106	99%	86:52:34

Incoming Volume (INN):

Server		AcceptVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	4.1 GB	4.1 GB	100%	12.3 KB
2	news.icm.edu.pl	18.9 KB	18.9 KB	100%	9.4 KB
3	localhost	16.4 KB	16.4 KB	100%	1.6 KB
TOTAL: 3		4.1 GB	4.1 GB	100%	12.3 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 16 04:15:01 - 04:59:59	8726	5.0%	3.23	113.3 MB	5.4%	42.97
Sep 16 05:00:00 - 05:59:59	9413	5.3%	2.61	107.4 MB	5.1%	30.56
Sep 16 06:00:00 - 06:59:59	7416	4.2%	2.06	92.0 MB	4.4%	26.16
Sep 16 07:00:00 - 07:59:59	9125	5.2%	2.53	97.4 MB	4.6%	27.69
Sep 16 08:00:00 - 08:59:59	6276	3.6%	1.74	81.7 MB	3.9%	23.23
Sep 16 09:00:00 - 09:59:59	5522	3.1%	1.53	65.9 MB	3.1%	18.75
Sep 16 10:00:00 - 10:59:59	7201	4.1%	2.00	80.2 MB	3.8%	22.82
Sep 16 11:00:00 - 11:59:59	7417	4.2%	2.06	84.6 MB	4.0%	24.05
Sep 16 12:00:00 - 12:59:59	7110	4.0%	1.98	84.6 MB	4.0%	24.05
Sep 16 13:00:00 - 13:59:59	7743	4.4%	2.15	87.2 MB	4.1%	24.81
Sep 16 14:00:00 - 14:59:59	7028	4.0%	1.95	84.1 MB	4.0%	23.92
Sep 16 15:00:00 - 15:59:59	7738	4.4%	2.15	95.9 MB	4.5%	27.28
Sep 16 16:00:00 - 16:59:59	5974	3.4%	1.66	74.7 MB	3.5%	21.24
Sep 16 17:00:00 - 17:59:59	7746	4.4%	2.15	104.7 MB	5.0%	29.77
Sep 16 18:00:00 - 18:59:59	7762	4.4%	2.16	100.3 MB	4.8%	28.53
Sep 16 19:00:00 - 19:59:59	6535	3.7%	1.82	86.5 MB	4.1%	24.61
Sep 16 20:00:00 - 20:59:59	8899	5.1%	2.47	102.8 MB	4.9%	29.23
Sep 16 21:00:00 - 21:59:59	7319	4.2%	2.03	95.7 MB	4.5%	27.22
Sep 16 22:00:00 - 22:59:59	7922	4.5%	2.20	87.8 MB	4.2%	24.98
Sep 16 23:00:00 - 23:59:59	5146	2.9%	1.43	64.5 MB	3.1%	18.35
Sep 17 00:00:00 - 00:59:59	6300	3.6%	1.75	73.8 MB	3.5%	21.00
Sep 17 01:00:00 - 01:59:59	8833	5.0%	2.45	98.5 MB	4.7%	28.02
Sep 17 02:00:00 - 02:59:59	5674	3.2%	1.58	66.8 MB	3.2%	19.01
Sep 17 03:00:00 - 03:59:59	6185	3.5%	1.72	67.5 MB	3.2%	19.19
Sep 17 04:00:00 - 04:15:01	1174	0.7%	1.30	12.4 MB	0.6%	14.05
TOTAL: 24:00:00	176184	100.0%	2.04	2.1 GB	100.0%	25.01

Sites sending bad articles:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	icm	23592	136	12390	2	0%	47:58:34
2	poznan	2	2	0	0	100%	00:40:00
TOTAL: 2		23594	138	12390	2	0%	48:38:34

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	966.8 KB	3.2 KB	970.1 KB	7.0 KB	47:58:34
2	poznan	18.9 KB	0.0 KB	18.9 KB	9.4 KB	00:40:00
TOTAL: 2		985.7 KB	3.2 KB	988.9 KB	7.1 KB	48:38:34

NNRP readership statistics:

System		Conn	Post	Elapsed
1	147.185.132.118	2	0	00:00:04
2	205.210.31.156	2	0	00:00:04
3	azpdsgsq1clq.stretchoid.com	4	0	00:00:20
4	167.94.138.191	2	0	00:00:00
5	nms1.man.lodz.pl	2880	0	00:00:21
6	167.94.146.50	6	0	00:00:07
7	172.16.2.4	574	0	00:00:32
8	80.111.142.213	8	0	00:00:05
9	isvcs01.man.lodz.pl	10	10	00:00:00
TOTAL: 9		3488	10	00:01:38

NNRP readership statistics (by domain):

System		Conn	Post	Elapsed
1	*.stretchoid.com	4	0	00:00:20
2	*.man.lodz.pl	2890	10	00:00:22
3	unresolved	594	0	00:00:55
TOTAL: 3		3488	10	00:01:38

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
172.16.2.4	1.220	2.832	00:00:32
nms1.man.lodz.pl	5.798	13.154	00:00:21
azpdsgsq1clq.stretchoid.com	0.010	0.016	00:00:20
167.94.146.50	0.066	0.032	00:00:07
80.111.142.213	0.016	0.042	00:00:05
205.210.31.156	0.006	0.006	00:00:04
147.185.132.118	0.002	0.010	00:00:04
167.94.138.191	0.066	0.012	00:00:00
isvcs01.man.lodz.pl	0.034	0.048	00:00:00
TOTAL: 9	7.218	16.152	00:01:38

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

System	Conn
azpdsgsq1clq.stretchoid.com	2
167.94.146.50	2
167.94.138.191	2
TOTAL: 3	6

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

Command	Count
EHLO www.censys.io	4
MGLNDD_212.191.2.21_119	2
TOTAL: 2	6

NNRP client timeouts [Top 20]:

System	Conn	Peer
167.94.146.50	2	4
TOTAL: 1	2	8

Daily Usenet report

Sep 16 04:15:01 -- Sep 17 04:15:01