Daily Usenet report: Sep 26 04:15:01

Unknown entries from news log file:

First 7 / 7 lines (100.0%)

Sep 26 04:21:06 newsfeed nnrpd[496023]: nms1.man.lodz.pl rejected Expiring process 495861
Sep 26 23:15:28 newsfeed nnrpd[554229]: SERVER perl filter not defined
Sep 26 23:18:58 newsfeed nnrpd[554408]: SERVER perl filter not defined
Sep 26 23:20:31 newsfeed nnrpd[554519]: SERVER perl filter not defined
Sep 26 23:22:03 newsfeed nnrpd[554534]: SERVER perl filter not defined
Sep 26 23:24:21 newsfeed nnrpd[554558]: SERVER perl filter not defined
Sep 26 23:25:55 newsfeed nnrpd[554670]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	238302	95.3%	27.2 MB	95.7%
nnrpd	7783	3.1%	783.8 KB	2.7%
innd	2699	1.1%	323.4 KB	1.1%
innfeed	1295	0.5%	143.6 KB	0.5%
controlchan	1	0.0%	0.1 KB	0.0%
overchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	250081	100.0%	28.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	236560	98.8%
Negative hits	2759	1.2%
Positive hits	123	0.1%
Cache misses	44	0.0%
TOTAL: 4	239486	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.753	0.0%	86	0.000	20.384	68.750
article cleanup	00:00:01.209	0.0%	238410	0.000	0.005	0.012
article logging	00:00:04.633	0.0%	238424	0.008	0.019	0.086
article parse	00:00:03.954	0.0%	598541	0.003	0.007	0.012
article write	00:00:14.578	0.0%	238258	0.029	0.061	0.516
artlog/artcncl	00:00:00.000	0.0%	80	0.000	0.000	0.000
data move	00:00:00.565	0.0%	653372	0.000	0.001	0.005
hisgrep/artcncl	00:00:00.716	0.0%	82	0.000	8.732	26.000
hishave/artcncl	00:00:00.454	0.0%	86	0.000	5.279	17.250
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:32:01.622	2.2%	241259	5.440	7.965	17.784
history sync	00:00:00.023	0.0%	373	0.000	0.062	0.500
history write	00:34:11.909	2.4%	238404	6.262	8.607	20.197
hiswrite/artcncl	00:00:00.017	0.0%	4	4.250	4.250	4.250
idle	22:50:57.356	95.1%	529786	41.145	155.265	511.536
nntp read	00:00:05.976	0.0%	460503	0.007	0.013	0.036
overview write	00:00:00.535	0.0%	238258	0.000	0.002	0.008
perl filter	00:02:31.320	0.2%	238404	0.423	0.635	1.319
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:07.502	0.0%	614785	0.005	0.012	0.019
TOTAL: 24:00:53.265	24:00:24.122	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.148	0.0%	137731	0.000	0.001	0.048
article prepare	00:00:00.000	0.0%	124	0.000	0.000	0.000
article read	00:00:00.001	0.0%	31	0.000	0.032	0.333
backlog stats	00:00:00.054	0.0%	157726	0.000	0.000	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:01.165	0.0%	144818	0.000	0.008	0.036
data write	00:00:00.274	0.0%	7268	0.000	0.038	0.143
idle	23:58:23.429	100.0%	157726	74.085	547.173	7431.309
status file	00:00:00.222	0.0%	329	0.000	0.675	14.000
TOTAL: 23:58:27.407	23:58:25.293	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:28.545	81.3%	4279	0.000	20.693	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.163	0.1%	10466	0.000	0.016	0.500
readart	00:00:00.051	0.0%	28	0.000	1.821	2.750
TOTAL: 00:01:48.977	00:01:28.759	81.4%	-	-	-	-

Control commands to INND:

Command	Number
flush	27
flushlogs	2
go	2
logmode	2
lowmark	1
mode	148
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	192

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	98	238308	238158	0	150	99%	40:58:42
2	news.icm.edu.pl	32	88	7	79	2	7%	08:13:14
3	localhost	7	6	6	0	0	100%	00:00:00
TOTAL: 3		137	238402	238171	79	152	99%	49:11:56

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	1.5 GB	39.3 KB	617.0 KB	1.5 GB	99%	6.6 KB
2	news.icm.edu.pl	72.2 KB	8.1 KB	23.4 KB	103.8 KB	69%	11.5 KB
3	localhost	9.4 KB	0.0 KB	0.0 KB	9.4 KB	100%	1.6 KB
TOTAL: 3		1.5 GB	47.4 KB	640.4 KB	1.5 GB	99%	6.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 26 04:15:01 - 04:59:59	8931	3.8%	3.31	48.4 MB	3.1%	18.35
Sep 26 05:00:00 - 05:59:59	6017	2.5%	1.67	49.8 MB	3.2%	14.15
Sep 26 06:00:00 - 06:59:59	6109	2.6%	1.70	46.1 MB	3.0%	13.12
Sep 26 07:00:00 - 07:59:59	8641	3.6%	2.40	81.2 MB	5.3%	23.09
Sep 26 08:00:00 - 08:59:59	12724	5.3%	3.53	81.1 MB	5.3%	23.07
Sep 26 09:00:00 - 09:59:59	6991	2.9%	1.94	60.2 MB	3.9%	17.13
Sep 26 10:00:00 - 10:59:59	6473	2.7%	1.80	46.1 MB	3.0%	13.11
Sep 26 11:00:00 - 11:59:59	7772	3.3%	2.16	44.0 MB	2.9%	12.51
Sep 26 12:00:00 - 12:59:59	11870	5.0%	3.30	68.6 MB	4.5%	19.50
Sep 26 13:00:00 - 13:59:59	8397	3.5%	2.33	57.4 MB	3.7%	16.32
Sep 26 14:00:00 - 14:59:59	19394	8.1%	5.39	84.6 MB	5.5%	24.06
Sep 26 15:00:00 - 15:59:59	9044	3.8%	2.51	66.8 MB	4.3%	18.99
Sep 26 16:00:00 - 16:59:59	14176	6.0%	3.94	85.8 MB	5.6%	24.42
Sep 26 17:00:00 - 17:59:59	11144	4.7%	3.10	70.0 MB	4.6%	19.90
Sep 26 18:00:00 - 18:59:59	7852	3.3%	2.18	61.5 MB	4.0%	17.49
Sep 26 19:00:00 - 19:59:59	10007	4.2%	2.78	69.0 MB	4.5%	19.62
Sep 26 20:00:00 - 20:59:59	10129	4.3%	2.81	63.3 MB	4.1%	18.00
Sep 26 21:00:00 - 21:59:59	8982	3.8%	2.50	61.9 MB	4.0%	17.60
Sep 26 22:00:00 - 22:59:59	8145	3.4%	2.26	52.7 MB	3.4%	14.99
Sep 26 23:00:00 - 23:59:59	7122	3.0%	1.98	53.7 MB	3.5%	15.26
Sep 27 00:00:00 - 00:59:59	9102	3.8%	2.53	64.1 MB	4.2%	18.24
Sep 27 01:00:00 - 01:59:59	10841	4.6%	3.01	66.0 MB	4.3%	18.78
Sep 27 02:00:00 - 02:59:59	15048	6.3%	4.18	74.8 MB	4.9%	21.28
Sep 27 03:00:00 - 03:59:59	10108	4.2%	2.81	61.2 MB	4.0%	17.42
Sep 27 04:00:00 - 04:15:02	3037	1.3%	3.37	18.6 MB	1.2%	21.14
TOTAL: 24:00:01	238056	100.0%	2.76	1.5 GB	100.0%	18.21

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	164	121	5	24	14
2	news.icm.edu.pl	2	0	1	0	1
TOTAL: 2		166	121	6	24	15

Unwanted newsgroups [Top 20]:

Newsgroup	Count
eternal-september.test	41
uk.railway	35
alt.comp.software.firefox	12
perl.wxperl.users	6
comp.mobile.android	5
comp.sys.raspberry-pi	5
fr.misc.actualite.covid19	4
eternal-september.newusers	2
rocksolid.shared.test	2
alt.comp.software.seamonkey	1
it.tlc.cellulari.android	1
grisbi.test	1
fr.comp.os.android	1
free.thank-you.president.trump	1
it.comp.os.win.windows8	1
rocksolid.nodes.help	1
eternal-september.talk	1
it.discussioni.energia	1
TOTAL: 18	121

Supposedly-moderated groups with unmoderated postings [Top 20]:

Groups	Count
christnet.bible	24
TOTAL: 1	24

INND Perl filter [Top 20]:

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

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	7043	20	6111	11	0	0%	23:57:59
2	nask	0	0	0	0	135329	0%	23:57:46
3	poznan	6	0	6	0	0	0%	01:05:05
4	panorama	0	0	0	0	137963	0%	23:57:46
5	okapi	0	0	0	0	548	0%	23:57:46
TOTAL: 5		7049	20	6117	11	273840	0%	96:56:22

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	65.0 KB	311.9 KB	377.0 KB	12.2 KB	23:57:59
2	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:46
3	poznan	0.0 KB	0.0 KB	0.0 KB	0	01:05:05
4	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:46
5	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:46
TOTAL: 5		65.0 KB	311.9 KB	377.0 KB	12.2 KB	96:56:22

Backlog files shrunk by innfeed:

Server	Size
panorama	10.0 MB
TOTAL: 1	10.0 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	69.10.48.174	6	24	26.9 KB	2	0	00:00:33
2	web.man.lodz.pl	288	4	6.8 KB	2	0	00:00:09
3	isvcs01.man.lodz.pl	6	0	0.0 KB	0	6	00:00:00
TOTAL: 3		300	28	33.7 KB	4	6	00:01:49

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	115	24	26.9 KB	2	0	00:01:06
2	*.man.lodz.pl	1735	4	6.8 KB	2	6	00:00:22
3	*.stretchoid.com	2	0	0.0 KB	0	0	00:00:10
4	*.survey.inspici.com	1	0	0.0 KB	0	0	00:00:04
5	*.us-east-2.compute.amazonaws.com	4	0	0.0 KB	0	0	00:00:00
6	*.hsd1.ma.comcast.net	1	0	0.0 KB	0	0	00:00:05
TOTAL: 6		1858	28	33.7 KB	4	6	00:01:49

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
69.10.48.174	0.017	0.028	00:00:33
nms1.man.lodz.pl	3.077	6.593	00:00:13
147.185.132.94	0.004	0.002	00:00:10
205.210.31.79	0.005	0.005	00:00:10
azpdssc32.stretchoid.com	0.000	0.010	00:00:09
web.man.lodz.pl	0.674	1.540	00:00:09
c-73-167-93-199.hsd1.ma.comcast.net	0.004	0.003	00:00:05
167.94.145.110	0.003	0.025	00:00:04
206.168.34.113	0.025	0.006	00:00:04
server-0-3.survey.inspici.com	0.007	0.000	00:00:04
80.111.142.213	0.012	0.026	00:00:02
212.51.192.185	0.248	0.430	00:00:00
ec2-3-23-132-121.us-east-2.compute.amazonaws.com	0.013	0.019	00:00:00
azpdcgb58.stretchoid.com	0.006	0.006	00:00:00
isvcs01.man.lodz.pl	0.046	0.035	00:00:00
185.242.226.41	0.000	0.006	00:00:00
TOTAL: 16	4.141	8.734	00:01:49

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	1441
212.51.192.185	96
80.111.142.213	4
ec2-3-23-132-121.us-east-2.compute.amazonaws.com	4
167.94.145.110	3
206.168.34.113	3
server-0-3.survey.inspici.com	1
azpdssc32.stretchoid.com	1
147.185.132.94	1
205.210.31.79	1
azpdcgb58.stretchoid.com	1
c-73-167-93-199.hsd1.ma.comcast.net	1
185.242.226.41	1
TOTAL: 13	1558

NNRP unrecognized commands (by host):

System	Conn
ec2-3-23-132-121.us-east-2.compute.amazonaws.com	10
185.242.226.41	5
206.168.34.113	1
azpdcgb58.stretchoid.com	1
167.94.145.110	1
TOTAL: 5	18

NNRP unrecognized commands (by command):

Command	Count
Accept-Encoding: gzip	2
#026#003#001	2
Host: 212.191.2.21:119	2
Accept: /	2
EHLO www.censys.io	2
GET / HTTP/1.1	2
#001	2
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
MGLNDD_212.191.2.21_119	1
ªÑ)KÓó$º"¬#014;žÕaQž”û#037€š?Lu[±~B	1
User-Agent: Mozilla/5.0 (Macintosh; Inte...	1
TOTAL: 11	18

NNRP client timeouts [Top 20]:

System	Conn	Peer
167.94.145.110	1	2
206.168.34.113	1	2
TOTAL: 2	2	4

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	24	85.7%
2	pl	4	14.3%
TOTAL: 2		28	100.0%

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

Newsgroup		Count
1	lodman.info	24
2	pl.comp.pecet	4
TOTAL: 2		28

Daily Usenet report

Sep 26 04:15:01 -- Sep 27 04:15:02