Daily Usenet report: Mar 3 04:15:01

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Mar 3 08:09:22 newsfeed nnrpd[990949]: SERVER perl filter not defined
Mar 3 08:09:22 newsfeed nnrpd[990949]: SERVER perl filter not defined
Mar 3 08:36:31 newsfeed nnrpd[994104]: SERVER perl filter not defined
Mar 3 08:36:31 newsfeed nnrpd[994104]: SERVER perl filter not defined
Mar 3 22:01:34 newsfeed nnrpd[1090627]: SERVER perl filter not defined
Mar 3 22:01:34 newsfeed nnrpd[1090627]: SERVER perl filter not defined
Mar 4 00:09:06 newsfeed nnrpd[1105794]: SERVER perl filter not defined
Mar 4 00:09:06 newsfeed nnrpd[1105794]: SERVER perl filter not defined
Mar 4 00:09:06 newsfeed nnrpd[1105795]: SERVER perl filter not defined
Mar 4 00:09:06 newsfeed nnrpd[1105795]: SERVER perl filter not defined
Mar 4 00:14:29 newsfeed nnrpd[1106405]: SERVER perl filter not defined
Mar 4 00:14:29 newsfeed nnrpd[1106405]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	170885	81.8%	18.9 MB	84.0%
innd	20716	9.9%	2.0 MB	8.7%
nnrpd	16116	7.7%	1.5 MB	6.6%
innfeed	1218	0.6%	153.8 KB	0.7%
controlchan	2	0.0%	0.1 KB	0.0%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 6	208939	100.0%	22.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	340818	99.7%
Negative hits	894	0.3%
Positive hits	120	0.0%
Cache misses	6	0.0%
TOTAL: 4	341838	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.002	0.0%	98	0.000	0.020	1.000
article cleanup	00:00:00.872	0.0%	342660	0.000	0.003	0.008
article logging	00:00:03.844	0.0%	342692	0.004	0.011	0.032
article parse	00:00:05.242	0.0%	1073378	0.003	0.005	0.011
article write	00:01:37.834	0.1%	342652	0.013	0.286	30.822
artlog/artcncl	00:00:00.000	0.0%	22	0.000	0.000	0.000
data move	00:00:00.938	0.0%	1460342	0.000	0.001	0.002
hisgrep/artcncl	00:00:00.002	0.0%	120	0.000	0.017	1.000
hishave/artcncl	00:00:00.000	0.0%	22	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:01.188	0.0%	343654	0.000	0.003	0.016
history sync	00:01:28.196	0.1%	756	0.000	116.661	14695.667
history write	00:03:53.062	0.1%	342656	0.029	0.680	74.391
idle	47:52:31.820	99.6%	1311080	66.449	131.458	413.866
nntp read	00:00:08.186	0.0%	1007848	0.004	0.008	0.013
overview write	00:00:00.560	0.0%	342652	0.000	0.002	0.007
perl filter	00:02:42.276	0.1%	342656	0.359	0.474	0.661
python filter	00:00:00.062	0.0%	342668	0.000	0.000	0.002
site send	00:00:04.818	0.0%	697546	0.003	0.007	0.015
TOTAL: 48:03:20.006	48:02:38.902	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.022	0.0%	12186	0.000	0.002	0.030
article prepare	00:00:00.000	0.0%	424	0.000	0.000	0.000
article read	00:00:00.002	0.0%	106	0.000	0.019	0.250
backlog stats	00:00:00.020	0.0%	73240	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.200	0.0%	34180	0.000	0.006	0.027
data write	00:00:00.556	0.0%	21792	0.000	0.026	0.231
idle	47:39:29.254	100.0%	73240	1266.320	2342.562	8717.333
status file	00:00:46.064	0.0%	314	0.000	146.701	22972.000
TOTAL: 47:40:16.732	47:40:16.118	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:02:39.978	53.7%	15196	0.000	10.528	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.318	0.1%	30226	0.000	0.011	0.500
TOTAL: 00:04:57.922	00:02:40.296	53.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	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	106	341744	341742	0	2	99%	59:46:36
2	localhost	14	12	8	0	4	66%	00:00:00
3	news.icm.edu.pl	58	104	2	100	2	1%	13:45:16
TOTAL: 3		178	341860	341752	100	8	99%	73:31:52

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	2.8 GB	16.2 KB	0.0 KB	2.8 GB	99%	8.6 KB
2	news.icm.edu.pl	16.2 KB	37.4 KB	0.0 KB	53.6 KB	30%	13.4 KB
3	localhost	12.2 KB	0.0 KB	2.6 MB	2.6 MB	0%	225.1 KB
TOTAL: 3		2.8 GB	53.6 KB	2.6 MB	2.8 GB	99%	8.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Mar 3 04:15:01 - 04:59:59	3574	2.1%	1.32	27.5 MB	1.9%	10.44
Mar 3 05:00:00 - 05:59:59	4323	2.5%	1.20	33.1 MB	2.3%	9.43
Mar 3 06:00:00 - 06:59:59	5283	3.1%	1.47	38.6 MB	2.7%	10.99
Mar 3 07:00:00 - 07:59:59	4384	2.6%	1.22	32.8 MB	2.3%	9.33
Mar 3 08:00:00 - 08:59:59	4573	2.7%	1.27	38.0 MB	2.7%	10.82
Mar 3 09:00:00 - 09:59:59	5025	2.9%	1.40	38.4 MB	2.7%	10.93
Mar 3 10:00:00 - 10:59:59	4449	2.6%	1.24	32.9 MB	2.3%	9.37
Mar 3 11:00:00 - 11:59:59	4816	2.8%	1.34	42.8 MB	3.0%	12.18
Mar 3 12:00:00 - 12:59:59	7320	4.3%	2.03	65.0 MB	4.5%	18.48
Mar 3 13:00:00 - 13:59:59	9824	5.7%	2.73	79.4 MB	5.5%	22.57
Mar 3 14:00:00 - 14:59:59	8633	5.1%	2.40	70.3 MB	4.9%	19.99
Mar 3 15:00:00 - 15:59:59	7217	4.2%	2.00	60.6 MB	4.2%	17.24
Mar 3 16:00:00 - 16:59:59	7982	4.7%	2.22	65.4 MB	4.6%	18.59
Mar 3 17:00:00 - 17:59:59	8595	5.0%	2.39	87.1 MB	6.1%	24.77
Mar 3 18:00:00 - 18:59:59	6812	4.0%	1.89	64.6 MB	4.5%	18.37
Mar 3 19:00:00 - 19:59:59	8287	4.9%	2.30	90.2 MB	6.3%	25.66
Mar 3 20:00:00 - 20:59:59	10192	6.0%	2.83	102.6 MB	7.2%	29.19
Mar 3 21:00:00 - 21:59:59	12484	7.3%	3.47	89.9 MB	6.3%	25.57
Mar 3 22:00:00 - 22:59:59	11886	7.0%	3.30	81.0 MB	5.6%	23.04
Mar 3 23:00:00 - 23:59:59	8959	5.2%	2.49	62.5 MB	4.4%	17.77
Mar 4 00:00:00 - 00:59:59	5628	3.3%	1.56	51.0 MB	3.6%	14.51
Mar 4 01:00:00 - 01:59:59	6688	3.9%	1.86	56.1 MB	3.9%	15.94
Mar 4 02:00:00 - 02:59:59	6613	3.9%	1.84	53.7 MB	3.7%	15.26
Mar 4 03:00:00 - 03:59:59	5959	3.5%	1.66	60.2 MB	4.2%	17.12
Mar 4 04:00:00 - 04:15:01	1348	0.8%	1.50	10.5 MB	0.7%	11.91
TOTAL: 24:00:00	170854	100.0%	1.98	1.4 GB	100.0%	17.00

Sites sending bad articles:

Server		Total	Duplic	Other
1	newsfeed.pionier.net.pl	17	1	16
2	localhost	2	0	2
3	news.icm.edu.pl	1	1	0
TOTAL: 3		20	2	18

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	4
TOTAL: 1	4

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	icm	22274	104	12118	2	0%	47:59:56
2	poznan	4	0	2	0	0%	00:40:10
TOTAL: 2		22278	104	12120	2	0%	48:40:06

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	259.4 KB	13.2 KB	272.6 KB	2.6 KB	47:59:56
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	00:40:10
TOTAL: 2		259.4 KB	13.2 KB	272.6 KB	2.6 KB	48:40:06

NNRP readership statistics:

System		Conn	Post	Rej	Elapsed
1	80.111.142.213	8	0	0	00:00:05
2	85.11.183.23	8	0	0	00:01:10
3	172.16.2.4	580	0	8	00:00:33
4	ec2-13-52-219-138.us-west-1.compute.amazonaws.com	2	0	0	00:00:00
5	zl-laxd-us-cpp-wk111.internet-census.org	4	0	0	00:00:08
6	159.65.237.176	2	0	0	00:00:20
7	147.185.132.49	2	0	0	00:00:01
8	azpdsge43nsk.stretchoid.com	4	0	0	00:00:20
9	85.11.182.21	4	0	0	00:00:40
10	205.210.31.219	2	0	0	00:00:00
11	nms1.man.lodz.pl	2880	0	0	00:00:23
12	68.183.16.131	32	0	0	00:00:03
13	zl-dala-us-gp1-wk144d.internet-census.org	2	0	0	00:00:21
14	sh-ams-nl-cpp-wk104.internet-census.org	4	0	0	00:00:08
15	isvcs01.man.lodz.pl	8	8	0	00:00:00
16	124.125.142.162.censys-scanner.com	6	0	0	00:00:08
17	sh-chi-us-cpp-wk107.internet-census.org	4	0	0	00:00:08
18	azpdesn63bnl.stretchoid.com	4	0	0	00:00:20
19	205.210.31.183	2	0	0	00:00:01
TOTAL: 19		3558	8	8	00:04:59

NNRP readership statistics (by domain):

System		Conn	Post	Rej	Elapsed
1	*.stretchoid.com	8	0	0	00:00:41
2	*.us-west-1.compute.amazonaws.com	2	0	0	00:00:00
3	unresolved	640	0	8	00:02:57
4	*.internet-census.org	14	0	0	00:00:47
5	*.man.lodz.pl	2888	8	0	00:00:24
6	*.125.142.162.censys-scanner.com	6	0	0	00:00:08
TOTAL: 6		3558	8	8	00:04:59

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
85.11.183.23	0.012	0.040	00:01:10
85.11.182.21	0.012	0.012	00:00:40
172.16.2.4	1.324	2.794	00:00:33
nms1.man.lodz.pl	6.030	12.650	00:00:23
zl-dala-us-gp1-wk144d.internet-census.org	0.004	0.010	00:00:21
azpdsge43nsk.stretchoid.com	0.006	0.020	00:00:20
azpdesn63bnl.stretchoid.com	0.006	0.018	00:00:20
159.65.237.176	0.006	0.008	00:00:20
zl-laxd-us-cpp-wk111.internet-census.org	0.008	0.016	00:00:08
sh-chi-us-cpp-wk107.internet-census.org	0.002	0.024	00:00:08
124.125.142.162.censys-scanner.com	0.070	0.034	00:00:08
sh-ams-nl-cpp-wk104.internet-census.org	0.006	0.020	00:00:08
80.111.142.213	0.022	0.034	00:00:05
68.183.16.131	0.058	0.146	00:00:03
147.185.132.49	0.004	0.008	00:00:01
205.210.31.183	0.002	0.010	00:00:01
ec2-13-52-219-138.us-west-1.compute.amazonaws.com	0.006	0.008	00:00:00
205.210.31.219	0.008	0.006	00:00:00
isvcs01.man.lodz.pl	0.020	0.046	00:00:00
?	0.010	0.026	00:00:00
TOTAL: 20	7.616	15.930	00:04:59

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	6
TOTAL: 1	6

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

System	Conn
68.183.16.131	44
85.11.183.23	36
85.11.182.21	20
azpdesn63bnl.stretchoid.com	2
azpdsge43nsk.stretchoid.com	2
124.125.142.162.censys-scanner.com	2
TOTAL: 6	106

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

Command	Count
#026#003#001#001	10
À#024#023#001#023#002#023#003#001	10
GET / HTTP/1.1	8
Host: 212.191.2.21:119	8
#026#003#001#002	6
Connection: close	6
À#024À#011À#023	6
Accept-Language: en-US,en;q=0.9	6
User-Agent: Mozilla/5.0 (Windows NT 10.0...	6
Accept-Encoding: gzip, deflate, br	6
Accept: text/html,application/xhtml+xml,...	6
MGLNDD_212.191.2.21_119	4
User-Agent: Mozilla/5.0 (Android 4.4; Mo...	2
*1	2
EHLO www.censys.io	2
$4	2
Accept: /	2
#010#013#010#004#010#005#010#006#004#001#005#001#006#001#003#003#003#001#003#002#004#002#005#002#006#002	2
CSeq: 1	2
#003	2
TOTAL: 24	106

NNRP client timeouts [Top 20]:

System	Conn	Peer
124.125.142.162.censys-scanner.com	2	4
TOTAL: 1	2	10

Daily Usenet report

Mar 3 04:15:01 -- Mar 4 04:15:01