Daily Usenet report: Dec 8 04:15:01

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Dec 8 12:23:32 newsfeed nnrpd[2176367]: SERVER perl filter not defined
Dec 8 12:23:32 newsfeed nnrpd[2176367]: SERVER perl filter not defined
Dec 8 12:54:06 newsfeed nnrpd[2179926]: SERVER perl filter not defined
Dec 8 12:54:06 newsfeed nnrpd[2179926]: SERVER perl filter not defined
Dec 8 13:49:02 newsfeed nnrpd[2186720]: SERVER perl filter not defined
Dec 8 13:49:02 newsfeed nnrpd[2186720]: SERVER perl filter not defined
Dec 8 13:49:28 newsfeed nnrpd[2186723]: SERVER perl filter not defined
Dec 8 13:49:28 newsfeed nnrpd[2186723]: SERVER perl filter not defined
Dec 8 14:38:54 newsfeed nnrpd[2192513]: SERVER perl filter not defined
Dec 8 14:38:54 newsfeed nnrpd[2192513]: SERVER perl filter not defined
Dec 8 21:47:26 newsfeed nnrpd[2243623]: SERVER perl filter not defined
Dec 8 21:47:26 newsfeed nnrpd[2243623]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	153291	79.6%	16.7 MB	81.9%
innd	21904	11.4%	2.0 MB	10.0%
nnrpd	16258	8.4%	1.5 MB	7.4%
innfeed	1220	0.6%	136.2 KB	0.7%
overchan	2	0.0%	0.3 KB	0.0%
controlchan	2	0.0%	0.1 KB	0.0%
TOTAL: 6	192677	100.0%	20.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	304964	99.5%
Negative hits	1414	0.5%
Positive hits	98	0.0%
Cache misses	26	0.0%
TOTAL: 4	306502	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.034	0.0%	170	0.000	0.200	3.000
article cleanup	00:00:00.892	0.0%	306094	0.000	0.003	0.012
article logging	00:00:03.848	0.0%	306140	0.002	0.013	0.028
article parse	00:00:05.656	0.0%	1024738	0.001	0.006	0.010
article write	00:02:05.570	0.1%	306094	0.023	0.410	22.931
artlog/artcncl	00:00:00.000	0.0%	40	0.000	0.000	0.000
data move	00:00:00.706	0.0%	1499498	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.004	0.0%	210	0.000	0.019	0.050
hishave/artcncl	00:00:00.000	0.0%	40	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:07.308	0.0%	307596	0.000	0.024	0.358
history sync	00:00:00.028	0.0%	608	0.000	0.046	0.500
history write	00:00:28.892	0.0%	306094	0.024	0.094	2.125
idle	47:49:37.166	99.6%	1267018	64.992	135.892	343.880
nntp read	00:00:08.974	0.0%	988852	0.004	0.009	0.016
overview write	00:00:00.472	0.0%	306094	0.000	0.002	0.005
perl filter	00:02:37.918	0.1%	306094	0.372	0.516	0.736
python filter	00:00:00.062	0.0%	306106	0.000	0.000	0.003
site send	00:00:04.364	0.0%	631228	0.003	0.007	0.013
TOTAL: 48:01:47.132	47:55:21.894	99.8%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.020	0.0%	19018	0.000	0.001	0.028
article prepare	00:00:00.000	0.0%	984	0.000	0.000	0.000
article read	00:00:00.010	0.0%	246	0.000	0.041	1.000
backlog stats	00:00:00.026	0.0%	103576	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.346	0.0%	51978	0.000	0.007	0.034
data write	00:00:00.862	0.0%	32052	0.000	0.027	0.096
idle	47:53:07.632	100.0%	103576	589.049	1664.359	3787.512
status file	00:00:00.134	0.0%	320	0.000	0.419	6.000
TOTAL: 47:53:09.838	47:53:09.030	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:03:33.632	76.7%	9024	0.000	23.674	10051.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.304	0.1%	30486	0.000	0.010	0.333
readart	00:00:00.000	0.0%	32	0.000	0.000	0.000
TOTAL: 00:04:38.488	00:03:33.936	76.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	90	306722	306722	0	100%	62:32:02
2	localhost	14	12	12	0	100%	00:00:00
3	news.icm.edu.pl	56	84	0	84	0%	11:41:24
TOTAL: 3		160	306818	306734	84	99%	74:13:26

Incoming Volume (INN):

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

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 8 04:15:01 - 04:59:59	3043	2.0%	1.13	40.3 MB	2.6%	15.27
Dec 8 05:00:00 - 05:59:59	3585	2.3%	1.00	42.8 MB	2.8%	12.18
Dec 8 06:00:00 - 06:59:59	3556	2.3%	0.99	38.9 MB	2.6%	11.07
Dec 8 07:00:00 - 07:59:59	4008	2.6%	1.11	44.9 MB	2.9%	12.78
Dec 8 08:00:00 - 08:59:59	3597	2.3%	1.00	36.3 MB	2.4%	10.33
Dec 8 09:00:00 - 09:59:59	4105	2.7%	1.14	39.8 MB	2.6%	11.32
Dec 8 10:00:00 - 10:59:59	5381	3.5%	1.49	60.2 MB	3.9%	17.12
Dec 8 11:00:00 - 11:59:59	5305	3.5%	1.47	58.4 MB	3.8%	16.61
Dec 8 12:00:00 - 12:59:59	6352	4.1%	1.76	77.1 MB	5.1%	21.94
Dec 8 13:00:00 - 13:59:59	6388	4.2%	1.77	61.8 MB	4.1%	17.57
Dec 8 14:00:00 - 14:59:59	7844	5.1%	2.18	84.0 MB	5.5%	23.89
Dec 8 15:00:00 - 15:59:59	7524	4.9%	2.09	66.4 MB	4.4%	18.87
Dec 8 16:00:00 - 16:59:59	7564	4.9%	2.10	76.8 MB	5.0%	21.85
Dec 8 17:00:00 - 17:59:59	8964	5.8%	2.49	79.3 MB	5.2%	22.54
Dec 8 18:00:00 - 18:59:59	7050	4.6%	1.96	70.6 MB	4.6%	20.09
Dec 8 19:00:00 - 19:59:59	6003	3.9%	1.67	52.9 MB	3.5%	15.05
Dec 8 20:00:00 - 20:59:59	10999	7.2%	3.06	82.1 MB	5.4%	23.37
Dec 8 21:00:00 - 21:59:59	5799	3.8%	1.61	62.3 MB	4.1%	17.72
Dec 8 22:00:00 - 22:59:59	6652	4.3%	1.85	79.0 MB	5.2%	22.47
Dec 8 23:00:00 - 23:59:59	7430	4.8%	2.06	71.3 MB	4.7%	20.30
Dec 9 00:00:00 - 00:59:59	6332	4.1%	1.76	66.9 MB	4.4%	19.02
Dec 9 01:00:00 - 01:59:59	7629	5.0%	2.12	74.3 MB	4.9%	21.14
Dec 9 02:00:00 - 02:59:59	7851	5.1%	2.18	81.5 MB	5.3%	23.19
Dec 9 03:00:00 - 03:59:59	8265	5.4%	2.30	63.2 MB	4.1%	17.97
Dec 9 04:00:00 - 04:15:01	2022	1.3%	2.24	13.7 MB	0.9%	15.56
TOTAL: 24:00:00	153248	100.0%	1.77	1.5 GB	100.0%	18.07

Sites sending bad articles:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	34404	238	18778	8	4	0%	47:59:56
2	poznan	0	0	0	0	0	0%	00:20:00
TOTAL: 2		34404	238	18778	8	4	0%	48:19:56

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	321.3 KB	68.0 KB	389.3 KB	1.6 KB	47:59:56
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	00:20:00
TOTAL: 2		321.3 KB	68.0 KB	389.3 KB	1.6 KB	48:19:56

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	66.61.98.95	16	24	25.4 KB	2	0	00:00:20
2	172.16.2.4	576	8	11.2 KB	4	0	00:01:32
3	isvcs01.man.lodz.pl	12	0	0.0 KB	0	12	00:00:00
TOTAL: 3		604	32	36.7 KB	6	12	00:04:39

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	612	32	36.7 KB	6	0	00:02:19
2	*.stretchoid.com	4	0	0.0 KB	0	0	00:00:20
3	*.ip.linodeusercontent.com	128	0	0.0 KB	0	0	00:01:25
4	*.man.lodz.pl	2892	0	0.0 KB	0	12	00:00:33
TOTAL: 4		3636	32	36.7 KB	6	12	00:04:39

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
172.16.2.4	1.262	2.874	00:01:32
139-162-186-99.ip.linodeusercontent.com	3.754	0.752	00:01:25
nms1.man.lodz.pl	5.906	13.576	00:00:32
66.61.98.95	0.042	0.072	00:00:20
azpdssdmebmt.stretchoid.com	0.014	0.012	00:00:20
199.45.154.146	0.070	0.034	00:00:12
80.111.142.213	0.024	0.032	00:00:05
205.210.31.9	0.002	0.012	00:00:05
205.210.31.71	0.006	0.006	00:00:02
isvcs01.man.lodz.pl	0.044	0.062	00:00:00
205.210.31.216	0.006	0.006	00:00:00
TOTAL: 11	11.130	17.438	00:04:39

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	2880
139-162-186-99.ip.linodeusercontent.com	128
80.111.142.213	8
199.45.154.146	6
azpdssdmebmt.stretchoid.com	4
205.210.31.9	2
205.210.31.216	2
205.210.31.71	2
TOTAL: 8	3032

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

System	Conn
199.45.154.146	2
azpdssdmebmt.stretchoid.com	2
TOTAL: 2	4

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

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
139-162-186-99.ip.linodeusercontent.com	2	2
199.45.154.146	2	4
TOTAL: 2	4	12

Newsgroup request counts (by hierarchy):

Hierarchy		Count	Pct
1	lodman	24	75.0%
2	pl	8	25.0%
TOTAL: 2		32	100.0%

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

Newsgroup		Count
1	lodman.info	24
2	pl.comp.os.ms-windows.winnt	8
TOTAL: 2		32

Daily Usenet report

Dec 8 04:15:01 -- Dec 9 04:15:01