Daily Usenet report: Oct 27 04:15:01

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Oct 27 11:10:20 newsfeed nnrpd[448686]: SERVER perl filter not defined
Oct 27 11:11:27 newsfeed nnrpd[448697]: SERVER perl filter not defined
Oct 27 11:39:14 newsfeed overchan[429802]: input line too long, skipping
Oct 27 11:41:46 newsfeed overchan[429802]: input line too long, skipping
Oct 27 15:07:59 newsfeed nnrpd[459692]: SERVER perl filter not defined
Oct 27 15:16:34 newsfeed overchan[429802]: input line too long, skipping
Oct 27 15:33:26 newsfeed overchan[429802]: input line too long, skipping
Oct 27 15:34:52 newsfeed overchan[429802]: input line too long, skipping
Oct 27 16:17:43 newsfeed overchan[429802]: input line too long, skipping
Oct 27 16:32:46 newsfeed overchan[429802]: input line too long, skipping
Oct 27 16:37:58 newsfeed overchan[429802]: input line too long, skipping
Oct 27 17:17:05 newsfeed nnrpd[465402]: SERVER perl filter not defined
Oct 27 19:16:41 newsfeed nnrpd[470657]: SERVER perl filter not defined
Oct 27 19:26:15 newsfeed overchan[429802]: input line too long, skipping
Oct 27 19:31:11 newsfeed overchan[429802]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	176967	78.9%	20.6 MB	78.0%
innd	38074	17.0%	4.9 MB	18.5%
nnrpd	7713	3.4%	783.3 KB	2.9%
innfeed	1466	0.7%	158.4 KB	0.6%
overchan	11	0.0%	1.5 KB	0.0%
controlchan	1	0.0%	0.0 KB	0.0%
TOTAL: 6	224232	100.0%	26.4 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	175977	81.4%
Negative hits	38106	17.6%
Positive hits	2094	1.0%
Cache misses	19	0.0%
TOTAL: 4	216196	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.425	0.0%	34	0.000	12.500	27.000
article cleanup	00:00:01.360	0.0%	177229	0.002	0.008	0.014
article logging	00:00:04.171	0.0%	177236	0.007	0.024	0.039
article parse	00:00:07.708	0.0%	658798	0.006	0.012	0.017
article write	00:00:26.443	0.0%	140411	0.090	0.188	0.967
artlog/artcncl	00:00:00.001	0.0%	33	0.000	0.030	1.000
data move	00:00:01.237	0.0%	1011063	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.170	0.0%	32	0.000	5.312	14.667
hishave/artcncl	00:00:00.077	0.0%	34	0.000	2.265	9.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:09:04.594	0.6%	217294	1.135	2.506	5.863
history sync	00:00:00.018	0.0%	306	0.000	0.059	0.500
history write	00:12:55.257	0.9%	176909	2.353	4.382	7.639
hiswrite/artcncl	00:00:00.004	0.0%	2	1.000	2.000	3.000
idle	23:33:32.656	98.1%	823434	29.276	102.999	293.747
nntp read	00:00:14.656	0.0%	692946	0.014	0.021	0.030
overview write	00:00:00.490	0.0%	140411	0.000	0.003	0.009
perl filter	00:03:11.155	0.2%	176909	0.819	1.081	1.687
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:05.031	0.0%	308019	0.009	0.016	0.026
TOTAL: 24:00:25.409	23:59:45.453	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.075	0.0%	27136	0.000	0.003	0.018
article prepare	00:00:00.000	0.0%	720	0.000	0.000	0.000
article read	00:00:00.008	0.0%	180	0.000	0.044	1.000
backlog stats	00:00:00.069	0.0%	123310	0.000	0.001	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.645	0.0%	67133	0.000	0.010	0.021
data write	00:00:01.658	0.0%	39949	0.005	0.042	0.097
idle	23:54:28.848	100.0%	123310	213.904	697.988	1601.402
status file	00:00:00.258	0.0%	361	0.000	0.715	2.815
TOTAL: 23:54:33.286	23:54:31.561	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:21.013	52.3%	4238	0.000	4.958	10037.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.180	0.4%	10263	0.000	0.018	0.500
readart	00:00:00.001	0.0%	32	0.000	0.031	0.500
TOTAL: 00:00:40.148	00:00:21.194	52.8%	-	-	-	-

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	73	140271	139725	51	495	99%	46:09:43
2	news.icm.edu.pl	1	38200	364	1694	36142	0%	23:24:26
3	localhost	6	5	5	0	0	100%	00:00:00
TOTAL: 3		80	178476	140094	1745	36637	78%	69:34:09

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	1.7 GB	9.1 MB	9.4 MB	1.7 GB	98%	12.9 KB
2	news.icm.edu.pl	14.7 MB	383.1 KB	399.0 MB	414.1 MB	3%	11.6 KB
3	localhost	7.3 KB	0.0 KB	0.0 KB	7.3 KB	100%	1.5 KB
TOTAL: 3		1.7 GB	9.5 MB	408.5 MB	2.1 GB	80%	12.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Oct 27 04:15:01 - 04:59:59	6096	4.3%	2.26	65.5 MB	3.7%	24.86
Oct 27 05:00:00 - 05:59:59	7612	5.4%	2.11	82.8 MB	4.7%	23.56
Oct 27 06:00:00 - 06:59:59	6930	4.9%	1.93	77.5 MB	4.4%	22.06
Oct 27 07:00:00 - 07:59:59	4782	3.4%	1.33	54.4 MB	3.1%	15.49
Oct 27 08:00:00 - 08:59:59	5405	3.9%	1.50	64.0 MB	3.6%	18.19
Oct 27 09:00:00 - 09:59:59	5610	4.0%	1.56	59.4 MB	3.4%	16.89
Oct 27 10:00:00 - 10:59:59	5715	4.1%	1.59	67.5 MB	3.8%	19.21
Oct 27 11:00:00 - 11:59:59	6903	4.9%	1.92	88.6 MB	5.0%	25.21
Oct 27 12:00:00 - 12:59:59	6821	4.9%	1.89	75.8 MB	4.3%	21.57
Oct 27 13:00:00 - 13:59:59	6862	4.9%	1.91	152.9 MB	8.7%	43.50
Oct 27 14:00:00 - 14:59:59	6074	4.3%	1.69	85.0 MB	4.8%	24.18
Oct 27 15:00:00 - 15:59:59	5931	4.2%	1.65	73.4 MB	4.2%	20.89
Oct 27 16:00:00 - 16:59:59	5668	4.0%	1.57	91.6 MB	5.2%	26.05
Oct 27 17:00:00 - 17:59:59	4628	3.3%	1.29	54.7 MB	3.1%	15.56
Oct 27 18:00:00 - 18:59:59	4971	3.5%	1.38	76.5 MB	4.3%	21.76
Oct 27 19:00:00 - 19:59:59	4590	3.3%	1.27	57.7 MB	3.3%	16.41
Oct 27 20:00:00 - 20:59:59	7565	5.4%	2.10	100.4 MB	5.7%	28.55
Oct 27 21:00:00 - 21:59:59	4023	2.9%	1.12	44.5 MB	2.5%	12.65
Oct 27 22:00:00 - 22:59:59	5769	4.1%	1.60	59.9 MB	3.4%	17.04
Oct 27 23:00:00 - 23:59:59	6696	4.8%	1.86	65.7 MB	3.7%	18.70
Oct 28 00:00:00 - 00:59:59	5499	3.9%	1.53	84.0 MB	4.8%	23.90
Oct 28 01:00:00 - 01:59:59	4939	3.5%	1.37	62.8 MB	3.6%	17.86
Oct 28 02:00:00 - 02:59:59	4357	3.1%	1.21	52.9 MB	3.0%	15.04
Oct 28 03:00:00 - 03:59:59	5877	4.2%	1.63	55.8 MB	3.2%	15.88
Oct 28 04:00:00 - 04:15:01	881	0.6%	0.98	10.8 MB	0.6%	12.22
TOTAL: 24:00:00	140204	100.0%	1.62	1.7 GB	100.0%	20.91

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.icm.edu.pl	36228	0	17	36211
2	newsfeed.pionier.net.pl	502	192	303	7
TOTAL: 2		36730	192	320	36218

Unwanted newsgroups [Top 20]:

Newsgroup	Count
eternal-september.support	50
it.tlc.cellulari.android	36
it.comp.os.win.windows10	27
comp.sys.raspberry-pi	13
fr.misc.actualite.covid19	12
alt.comp.software.firefox	10
uk.railway	8
comp.mobile.android	7
de.comm.software.mailreader	5
eternal-september.newusers	5
eternal-september.test	5
fr.comp.os.android	3
de.rec.sf.startrek	3
comp.sys.mac.vintage	2
eternal-september.talk	2
fido7.r50.crisis	1
aioe.news.assistenza	1
comp.lang.go	1
grisbi.test	1
TOTAL: 19	192

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	36153
Scoring filter (8)	32
Scoring filter (9)	13
EMP (md5)	11
Scoring filter (11)	1
Scoring filter (12)	1
TOTAL: 6	36211

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	39890	147	26476	33	0	0%	23:59:57
2	panorama	0	0	0	0	27208	0%	23:57:47
3	poznan	446	0	368	0	0	0%	22:10:43
4	nask	0	0	0	0	22464	0%	23:57:47
5	okapi	0	0	0	0	965	0%	23:57:47
TOTAL: 5		40336	147	26844	33	50637	0%	118:04:01

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	776.0 KB	282.0 KB	1.0 MB	5.9 KB	23:59:57
2	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
3	poznan	0.0 KB	0.0 KB	0.0 KB	0	22:10:43
4	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
5	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
TOTAL: 5		776.0 KB	282.0 KB	1.0 MB	5.9 KB	118:04:01

Backlog files shrunk by innfeed:

Server	Size
panorama	1.9 MB
TOTAL: 1	1.9 MB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	32	33.9 KB	14	0	00:00:08
2	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 2		293	32	33.9 KB	14	5	00:00:40

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	1733	32	33.9 KB	14	5	00:00:22
2	unresolved	107	0	0.0 KB	0	0	00:00:14
3	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
4	*.li.binaryedge.ninja	1	0	0.0 KB	0	0	00:00:02
TOTAL: 4		1842	32	33.9 KB	14	5	00:00:40

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
nms2.man.lodz.pl	5.243	8.240	00:00:14
104.152.52.85	0.000	0.010	00:00:10
web.man.lodz.pl	0.992	1.732	00:00:08
80.111.142.213	0.015	0.036	00:00:02
prod-boron-us-west-64.li.binaryedge.ninja	0.006	0.006	00:00:02
212.51.192.185	0.399	0.568	00:00:01
scanner-26.ch1.censys-scanner.com	0.015	0.004	00:00:00
198.20.101.86	0.013	0.006	00:00:00
192.241.207.8	0.011	0.004	00:00:00
isvcs01.man.lodz.pl	0.034	0.036	00:00:00
45.227.254.49	0.003	0.006	00:00:00
80.66.88.215	0.005	0.005	00:00:00
TOTAL: 12	6.736	10.653	00:00:40

Curious NNRP server explorers [Top 20]:

System	Conn
nms2.man.lodz.pl	1440
212.51.192.185	96
80.111.142.213	4
198.20.101.86	3
104.152.52.85	1
45.227.254.49	1
scanner-26.ch1.censys-scanner.com	1
192.241.207.8	1
prod-boron-us-west-64.li.binaryedge.ninja	1
80.66.88.215	1
TOTAL: 10	1549

NNRP unrecognized commands (by host):

System	Conn
198.20.101.86	7
192.241.207.8	1
45.227.254.49	1
scanner-26.ch1.censys-scanner.com	1
80.66.88.215	1
TOTAL: 5	11

NNRP unrecognized commands (by command):

Command	Count
#003	2
#026#003#001	1
Accept-Encoding: gzip	1
Accept: /	1
User-Agent: Mozilla/5.0 (Windows NT 10.0...	1
EHLO www.censys.io	1
#023#003#023#001#023#002#001	1
Host: 212.191.2.21:119	1
GET / HTTP/1.1	1
MGLNDD_212.191.2.21_119	1
TOTAL: 10	11

NNRP client timeouts [Top 20]:

System	Conn	Peer
80.66.88.215	1	1
45.227.254.49	1	1
TOTAL: 2	2	2

Newsgroup request counts (by category):

Category		Count	Pct
1	pl	32	100.0%
TOTAL: 1		32	100.0%

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

Newsgroup		Count
1	pl.comp.os.ms-windows.winnt	18
2	pl.comp.pecet	14
TOTAL: 2		32

Daily Usenet report

Oct 27 04:15:01 -- Oct 28 04:15:01