Daily Usenet report: Sep 12 04:15:01

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Sep 12 10:55:09 newsfeed nnrpd[1369322]: SERVER perl filter not defined
Sep 12 12:10:32 newsfeed nnrpd[1372629]: SERVER perl filter not defined
Sep 12 12:30:07 newsfeed nnrpd[1373492]: SERVER perl filter not defined
Sep 12 12:30:24 newsfeed nnrpd[1373497]: SERVER perl filter not defined
Sep 12 15:29:08 newsfeed nnrpd[1381215]: SERVER perl filter not defined
Sep 12 15:31:06 newsfeed nnrpd[1381330]: SERVER perl filter not defined
Sep 12 15:47:28 newsfeed nnrpd[1382057]: SERVER perl filter not defined
Sep 12 15:47:48 newsfeed nnrpd[1382063]: SERVER perl filter not defined

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	294346	96.1%	34.4 MB	96.4%
nnrpd	7803	2.5%	799.4 KB	2.2%
innd	2932	1.0%	369.1 KB	1.0%
innfeed	1274	0.4%	147.1 KB	0.4%
overchan	1	0.0%	0.2 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	306357	100.0%	35.7 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	292837	97.3%
Negative hits	6135	2.0%
Cache misses	1948	0.6%
Positive hits	87	0.0%
TOTAL: 4	301007	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.401	0.0%	53	0.000	26.434	47.250
article cleanup	00:00:01.475	0.0%	294175	0.001	0.005	0.017
article logging	00:00:05.621	0.0%	294267	0.009	0.019	0.038
article parse	00:00:05.257	0.0%	706746	0.003	0.007	0.011
article write	00:00:21.032	0.0%	293841	0.036	0.072	0.938
artlog/artcncl	00:00:00.001	0.0%	53	0.000	0.019	0.125
data move	00:00:00.700	0.0%	772246	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.539	0.0%	53	0.000	10.170	23.375
hishave/artcncl	00:00:00.276	0.0%	53	0.000	5.208	11.875
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:37:03.040	2.6%	302108	4.176	7.358	17.882
history sync	00:00:00.010	0.0%	316	0.000	0.032	0.500
history write	00:38:27.722	2.7%	293989	5.333	7.850	21.766
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	22:39:50.678	94.4%	633019	17.509	128.891	429.422
nntp read	00:00:07.628	0.0%	542089	0.009	0.014	0.022
overview write	00:00:00.689	0.0%	293841	0.000	0.002	0.007
perl filter	00:03:25.748	0.2%	293989	0.487	0.700	1.186
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:09.158	0.0%	708678	0.007	0.013	0.022
TOTAL: 24:00:20.683	23:59:40.975	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.136	0.0%	120994	0.000	0.001	0.011
article prepare	00:00:00.000	0.0%	144	0.000	0.000	0.000
article read	00:00:00.002	0.0%	36	0.000	0.056	1.000
backlog stats	00:00:00.054	0.0%	142537	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.929	0.0%	128770	0.000	0.007	0.041
data write	00:00:00.337	0.0%	7974	0.000	0.042	0.138
idle	23:58:54.852	100.0%	142537	142.311	605.701	5798.657
status file	00:00:00.208	0.0%	317	0.000	0.656	15.000
TOTAL: 23:58:58.525	23:58:56.518	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:01:29.302	70.0%	4301	0.000	20.763	10050.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.163	0.1%	10401	0.000	0.016	0.500
readart	00:00:00.000	0.0%	20	0.000	0.000	0.000
TOTAL: 00:02:07.611	00:01:29.465	70.1%	-	-	-	-

Control commands to INND:

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

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	142	296019	293849	1840	330	99%	50:08:19
2	localhost	9	8	8	0	0	100%	00:00:00
3	news.icm.edu.pl	35	68	5	59	4	7%	07:54:50
TOTAL: 3		186	296095	293862	1899	334	99%	58:03:09

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	1.7 GB	1.2 MB	1.5 MB	1.7 GB	99%	6.2 KB
2	news.icm.edu.pl	44.6 KB	47.6 KB	47.6 KB	139.8 KB	31%	15.5 KB
3	localhost	11.9 KB	0.0 KB	0.0 KB	11.9 KB	100%	1.5 KB
TOTAL: 3		1.7 GB	1.2 MB	1.6 MB	1.7 GB	99%	6.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Sep 12 04:15:01 - 04:59:59	9624	3.3%	3.57	41.0 MB	2.3%	15.57
Sep 12 05:00:00 - 05:59:59	7652	2.6%	2.13	39.3 MB	2.2%	11.18
Sep 12 06:00:00 - 06:59:59	10215	3.5%	2.84	47.9 MB	2.7%	13.62
Sep 12 07:00:00 - 07:59:59	6738	2.3%	1.87	41.1 MB	2.3%	11.70
Sep 12 08:00:00 - 08:59:59	7086	2.4%	1.97	45.1 MB	2.5%	12.84
Sep 12 09:00:00 - 09:59:59	10646	3.6%	2.96	71.7 MB	4.0%	20.40
Sep 12 10:00:00 - 10:59:59	5526	1.9%	1.53	54.0 MB	3.0%	15.35
Sep 12 11:00:00 - 11:59:59	11200	3.8%	3.11	70.4 MB	3.9%	20.02
Sep 12 12:00:00 - 12:59:59	12071	4.1%	3.35	72.4 MB	4.1%	20.60
Sep 12 13:00:00 - 13:59:59	12076	4.1%	3.35	63.3 MB	3.5%	18.00
Sep 12 14:00:00 - 14:59:59	16319	5.6%	4.53	93.6 MB	5.2%	26.63
Sep 12 15:00:00 - 15:59:59	16290	5.5%	4.53	101.5 MB	5.7%	28.88
Sep 12 16:00:00 - 16:59:59	13298	4.5%	3.69	67.7 MB	3.8%	19.27
Sep 12 17:00:00 - 17:59:59	34225	11.6%	9.51	234.6 MB	13.1%	66.73
Sep 12 18:00:00 - 18:59:59	24392	8.3%	6.78	117.4 MB	6.6%	33.39
Sep 12 19:00:00 - 19:59:59	22224	7.6%	6.17	120.8 MB	6.8%	34.36
Sep 12 20:00:00 - 20:59:59	18329	6.2%	5.09	89.3 MB	5.0%	25.41
Sep 12 21:00:00 - 21:59:59	7579	2.6%	2.11	52.0 MB	2.9%	14.78
Sep 12 22:00:00 - 22:59:59	10641	3.6%	2.96	65.5 MB	3.7%	18.62
Sep 12 23:00:00 - 23:59:59	6836	2.3%	1.90	41.9 MB	2.3%	11.90
Sep 13 00:00:00 - 00:59:59	11832	4.0%	3.29	60.0 MB	3.4%	17.06
Sep 13 01:00:00 - 01:59:59	5286	1.8%	1.47	45.7 MB	2.6%	13.00
Sep 13 02:00:00 - 02:59:59	5687	1.9%	1.58	64.9 MB	3.6%	18.45
Sep 13 03:00:00 - 03:59:59	6692	2.3%	1.86	68.9 MB	3.9%	19.61
Sep 13 04:00:00 - 04:15:02	1403	0.5%	1.56	14.8 MB	0.8%	16.79
TOTAL: 24:00:01	293867	100.0%	3.40	1.7 GB	100.0%	21.15

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	422	140	182	8	92
2	news.icm.edu.pl	4	0	4	0	0
TOTAL: 2		426	140	186	8	92

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	34
eternal-september.test	27
alt.comp.software.seamonkey	10
alt.comp.software.firefox	9
eternal-september.support	8
it.tlc.cellulari.android	8
eternal-september.talk	8
it.comp.os.win.windows10	6
rocksolid.nodes.help	4
comp.mobile.android	4
comp.mobile.ipad	4
nl.comp.os.linux.techniek	3
de.comp.lang.perl	3
eternal-september.grouprequests	3
aioe.news.helpdesk	2
grisbi.devel	2
it.eventi.covid19	1
it.comp.os.linux.ubuntu	1
fr.misc.automobile.electrique	1
fido7.english-tutor	1
TOTAL: 21	140

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

Groups	Count
christnet.bible	8
TOTAL: 1	8

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	7826	34	6673	1	0	0%	24:09:40
2	poznan	6	1	4	0	0	16%	00:40:08
3	panorama	0	0	0	0	121250	0%	23:57:45
4	nask	0	0	0	0	118476	0%	23:57:45
5	okapi	0	0	0	0	743	0%	23:57:45
TOTAL: 5		7832	35	6677	1	240469	0%	96:43:03

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	163.8 KB	2.3 KB	166.1 KB	4.7 KB	24:09:40
2	poznan	8.0 KB	0.0 KB	8.0 KB	8.0 KB	00:40:08
3	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:45
4	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:45
5	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:45
TOTAL: 5		171.8 KB	2.3 KB	174.2 KB	4.8 KB	96:43:03

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	10	16	17.3 KB	1	0	00:00:40
2	web.man.lodz.pl	288	4	7.3 KB	2	0	00:00:09
3	isvcs01.man.lodz.pl	8	0	0.0 KB	0	8	00:00:00
TOTAL: 3		306	20	24.6 KB	3	8	00:02:08

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	119	16	17.3 KB	1	0	00:01:31
2	*.man.lodz.pl	1736	4	7.3 KB	2	8	00:00:23
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:03
TOTAL: 4		1858	20	24.6 KB	3	8	00:02:08

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
69.10.48.174	0.010	0.095	00:00:40
nms1.man.lodz.pl	3.393	8.662	00:00:12
206.168.34.124	0.000	0.009	00:00:11
206.168.34.212	0.003	0.013	00:00:10
198.235.24.3	0.000	0.013	00:00:10
198.235.24.237	0.000	0.012	00:00:10
azpdssc3.stretchoid.com	0.005	0.005	00:00:09
web.man.lodz.pl	0.746	1.871	00:00:09
162.142.125.213	0.015	0.027	00:00:04
server-0-3.survey.inspici.com	0.000	0.008	00:00:03
80.111.142.213	0.011	0.020	00:00:02
212.51.192.185	0.226	0.613	00:00:01
162.142.125.215	0.003	0.007	00:00:00
isvcs01.man.lodz.pl	0.030	0.062	00:00:00
185.242.226.41	0.000	0.008	00:00:00
azpdeg66.stretchoid.com	0.000	0.015	00:00:00
TOTAL: 16	4.442	11.440	00:02:08

Curious NNRP server explorers [Top 20]:

System	Conn
nms1.man.lodz.pl	1440
212.51.192.185	96
80.111.142.213	4
162.142.125.213	3
azpdssc3.stretchoid.com	1
206.168.34.212	1
185.242.226.41	1
server-0-3.survey.inspici.com	1
162.142.125.215	1
198.235.24.3	1
198.235.24.237	1
azpdeg66.stretchoid.com	1
206.168.34.124	1
TOTAL: 13	1552

NNRP unrecognized commands (by host):

System	Conn
185.242.226.41	5
azpdeg66.stretchoid.com	1
206.168.34.124	1
162.142.125.215	1
162.142.125.213	1
206.168.34.212	1
TOTAL: 6	10

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	4
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
MGLNDD_212.191.2.21_119	1
Accept: /	1
Host: 212.191.2.21:119	1
GET / HTTP/1.1	1
Accept-Encoding: gzip	1
TOTAL: 7	10

NNRP client timeouts [Top 20]:

System	Conn	Peer
162.142.125.213	1	2
TOTAL: 1	1	2

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	16	80.0%
2	pl	4	20.0%
TOTAL: 2		20	100.0%

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

Newsgroup		Count
1	lodman.info	16
2	pl.comp.pecet	4
TOTAL: 2		20

Daily Usenet report

Sep 12 04:15:01 -- Sep 13 04:15:02