Daily Usenet report: Nov 3 04:15:02

Unknown entries from news log file:

First 5 / 5 lines (100.0%)

Nov 3 09:49:01 newsfeed overchan[178655]: input line too long, skipping
Nov 3 15:10:29 newsfeed nnrpd[208709]: SERVER perl filter not defined
Nov 3 16:18:50 newsfeed overchan[178655]: input line too long, skipping
Nov 3 19:15:12 newsfeed overchan[178655]: input line too long, skipping
Nov 3 20:29:11 newsfeed overchan[178655]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	136517	89.5%	16.2 MB	90.1%
nnrpd	7636	5.0%	777.7 KB	4.2%
innd	6901	4.5%	888.3 KB	4.8%
innfeed	1510	1.0%	160.4 KB	0.9%
overchan	5	0.0%	0.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	152570	100.0%	18.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	135429	93.1%
Negative hits	8443	5.8%
Positive hits	1575	1.1%
Cache misses	50	0.0%
TOTAL: 4	145497	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.006	0.0%	81	0.000	12.420	45.000
article cleanup	00:00:01.048	0.0%	136254	0.001	0.008	0.017
article logging	00:00:03.418	0.0%	136261	0.013	0.025	0.036
article parse	00:00:06.721	0.0%	577772	0.005	0.012	0.018
article write	00:00:24.126	0.0%	130463	0.077	0.185	1.708
artlog/artcncl	00:00:00.001	0.0%	80	0.000	0.013	0.053
data move	00:00:00.922	0.0%	825815	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.365	0.0%	68	0.000	5.368	17.000
hishave/artcncl	00:00:00.104	0.0%	81	0.000	1.284	11.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:05:24.641	0.4%	146082	0.899	2.222	9.417
history sync	00:00:00.017	0.0%	312	0.000	0.054	0.500
history write	00:12:16.415	0.9%	135918	3.453	5.418	15.506
hiswrite/artcncl	00:00:00.084	0.0%	13	3.667	6.462	10.000
idle	23:38:31.753	98.5%	696825	22.607	122.142	276.242
nntp read	00:00:13.271	0.0%	579651	0.017	0.023	0.033
overview write	00:00:00.486	0.0%	130463	0.000	0.004	0.014
perl filter	00:02:45.106	0.2%	135918	0.909	1.215	1.761
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:04.639	0.0%	283002	0.010	0.016	0.023
TOTAL: 24:00:24.857	23:59:54.123	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.058	0.0%	22009	0.000	0.003	0.029
article prepare	00:00:00.000	0.0%	596	0.000	0.000	0.000
article read	00:00:00.008	0.0%	149	0.000	0.054	1.000
backlog stats	00:00:00.047	0.0%	97081	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.525	0.0%	52993	0.000	0.010	0.029
data write	00:00:01.387	0.0%	31031	0.000	0.045	0.124
idle	23:55:23.435	100.0%	97081	466.795	887.130	2129.184
status file	00:00:00.217	0.0%	390	0.000	0.556	2.000
TOTAL: 23:55:27.438	23:55:25.677	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:05:42.868	94.2%	4503	0.000	76.142	71217.750
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.221	0.1%	11425	0.000	0.019	0.500
readart	00:00:00.605	0.2%	323	0.000	1.873	1.914
TOTAL: 00:06:04.162	00:05:43.694	94.4%	-	-	-	-

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	88	130857	130300	1	556	99%	43:28:30
2	news.icm.edu.pl	2	6765	350	1210	5205	5%	23:50:51
3	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 3		92	137623	130651	1211	5761	94%	67:19:21

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	1.9 GB	3.8 MB	4.4 MB	1.9 GB	99%	15.1 KB
2	news.icm.edu.pl	4.8 MB	589.3 KB	94.6 MB	100.0 MB	4%	18.4 KB
3	localhost	1.6 KB	0.0 KB	0.0 KB	1.6 KB	100%	1.6 KB
TOTAL: 3		1.9 GB	4.4 MB	99.0 MB	2.0 GB	94%	15.2 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 3 04:15:02 - 04:59:59	3171	2.4%	1.18	37.0 MB	1.9%	14.06
Nov 3 05:00:00 - 05:59:59	3785	2.9%	1.05	36.3 MB	1.9%	10.32
Nov 3 06:00:00 - 06:59:59	6006	4.6%	1.67	112.6 MB	5.9%	32.02
Nov 3 07:00:00 - 07:59:59	6387	4.9%	1.77	134.5 MB	7.0%	38.25
Nov 3 08:00:00 - 08:59:59	4822	3.7%	1.34	51.7 MB	2.7%	14.71
Nov 3 09:00:00 - 09:59:59	7843	6.0%	2.18	122.0 MB	6.3%	34.70
Nov 3 10:00:00 - 10:59:59	7160	5.5%	1.99	146.7 MB	7.6%	41.73
Nov 3 11:00:00 - 11:59:59	4692	3.6%	1.30	47.0 MB	2.4%	13.36
Nov 3 12:00:00 - 12:59:59	7767	5.9%	2.16	253.9 MB	13.2%	72.21
Nov 3 13:00:00 - 13:59:59	4968	3.8%	1.38	54.7 MB	2.8%	15.57
Nov 3 14:00:00 - 14:59:59	4285	3.3%	1.19	49.4 MB	2.6%	14.06
Nov 3 15:00:00 - 15:59:59	4812	3.7%	1.34	60.8 MB	3.2%	17.29
Nov 3 16:00:00 - 16:59:59	4302	3.3%	1.20	49.6 MB	2.6%	14.10
Nov 3 17:00:00 - 17:59:59	5576	4.3%	1.55	84.6 MB	4.4%	24.06
Nov 3 18:00:00 - 18:59:59	5253	4.0%	1.46	84.4 MB	4.4%	24.00
Nov 3 19:00:00 - 19:59:59	4777	3.7%	1.33	62.2 MB	3.2%	17.69
Nov 3 20:00:00 - 20:59:59	5163	4.0%	1.43	56.6 MB	2.9%	16.09
Nov 3 21:00:00 - 21:59:59	6518	5.0%	1.81	94.6 MB	4.9%	26.90
Nov 3 22:00:00 - 22:59:59	5199	4.0%	1.44	50.8 MB	2.6%	14.46
Nov 3 23:00:00 - 23:59:59	4414	3.4%	1.23	44.1 MB	2.3%	12.53
Nov 4 00:00:00 - 00:59:59	5751	4.4%	1.60	66.0 MB	3.4%	18.76
Nov 4 01:00:00 - 01:59:59	7070	5.4%	1.96	106.0 MB	5.5%	30.14
Nov 4 02:00:00 - 02:59:59	4783	3.7%	1.33	55.0 MB	2.9%	15.64
Nov 4 03:00:00 - 03:59:59	4584	3.5%	1.27	47.6 MB	2.5%	13.53
Nov 4 04:00:00 - 04:15:02	1568	1.2%	1.74	14.4 MB	0.8%	16.37
TOTAL: 24:00:00	130656	100.0%	1.51	1.9 GB	100.0%	22.78

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	news.icm.edu.pl	5218	0	52	0	5166
2	newsfeed.pionier.net.pl	563	271	283	1	8
TOTAL: 2		5781	271	335	1	5174

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.misc.actualite.covid19	64
comp.mobile.android	48
uk.railway	44
it.comp.os.win.windows10	23
eternal-september.support	18
alt.comp.software.firefox	18
de.rec.sf.startrek	13
it.tlc.cellulari.android	7
aioe.news.assistenza	5
eternal-september.newusers	5
eternal-september.talk	5
comp.sys.raspberry-pi	5
eternal-september.test	3
it.eventi.covid19	2
fido7.r50.crisis	1
grisbi.test	1
rocksolid.shared.test	1
fr.comp.os.android	1
de.comm.software.mailreader	1
de.comp.lang.vbclassic	1
TOTAL: 25	271

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

Groups	Count
pl.sci.matematyka	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	5141
Scoring filter (8)	15
EMP (phl)	6
Scoring filter (9)	3
EMP (md5)	1
Scoring filter (10)	1
TOTAL: 6	5167

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	30509	127	21422	22	3	0%	23:59:56
2	poznan	410	0	349	0	0	0%	19:56:06
3	okapi	0	0	0	0	642	0%	23:57:47
4	panorama	0	0	0	0	22044	0%	23:57:47
5	nask	0	0	0	0	17516	0%	23:57:47
TOTAL: 5		30919	127	21771	22	40205	0%	115:49:23

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	432.2 KB	158.5 KB	590.7 KB	4.0 KB	23:59:56
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	19:56:06
3	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
4	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
5	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
TOTAL: 5		432.2 KB	158.5 KB	590.7 KB	4.0 KB	115:49:23

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	46.219.210.180	1	313	463.0 KB	1	0	00:00:49
2	web.man.lodz.pl	288	8	17.8 KB	4	0	00:00:08
3	isvcs01.man.lodz.pl	1	0	0.0 KB	0	1	00:00:00
TOTAL: 3		290	321	480.9 KB	5	1	00:06:04

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	unresolved	102	313	463.0 KB	1	0	00:00:52
2	*.man.lodz.pl	1729	8	17.8 KB	4	1	00:00:22
3	*.klient.alfa-system.net	1	0	0.0 KB	0	0	00:04:48
4	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
TOTAL: 4		1833	321	480.9 KB	5	1	00:06:04

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
host176-97-25-60.klient.alfa-system.net	0.000	0.007	00:04:48
46.219.210.180	0.025	0.067	00:00:49
nms2.man.lodz.pl	5.311	7.985	00:00:13
web.man.lodz.pl	1.067	1.483	00:00:08
80.111.142.213	0.013	0.029	00:00:01
212.51.192.185	0.344	0.570	00:00:01
scanner-25.ch1.censys-scanner.com	0.012	0.006	00:00:00
80.66.88.211	0.006	0.006	00:00:00
isvcs01.man.lodz.pl	0.009	0.000	00:00:00
TOTAL: 9	6.787	10.153	00:06:04

Curious NNRP server explorers [Top 20]:

System	Conn
nms2.man.lodz.pl	1440
212.51.192.185	96
80.111.142.213	4
scanner-25.ch1.censys-scanner.com	1
host176-97-25-60.klient.alfa-system.net	1
80.66.88.211	1
TOTAL: 6	1543

NNRP unrecognized commands (by host):

System	Conn
scanner-25.ch1.censys-scanner.com	1
80.66.88.211	1
TOTAL: 2	2

NNRP unrecognized commands (by command):

Command	Count
#003	1
EHLO www.censys.io	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
80.66.88.211	1	1
TOTAL: 1	1	1

Newsgroup request counts (by category):

Category		Count	Pct
1	lodman	313	97.5%
2	pl	8	2.5%
TOTAL: 2		321	100.0%

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

Newsgroup		Count
1	lodman.info	313
2	pl.comp.pecet	8
TOTAL: 2		321

Daily Usenet report

Nov 3 04:15:02 -- Nov 4 04:15:02