Daily Usenet report: Nov 28 04:15:02

Unknown entries from news log file:

First 12 / 12 lines (100.0%)

Nov 28 05:24:19 newsfeed overchan[376715]: input line too long, skipping
Nov 28 06:19:03 newsfeed overchan[376715]: input line too long, skipping
Nov 28 13:53:32 newsfeed overchan[376715]: input line too long, skipping
Nov 28 15:02:59 newsfeed overchan[376715]: input line too long, skipping
Nov 28 19:21:53 newsfeed overchan[376715]: input line too long, skipping
Nov 28 19:36:59 newsfeed overchan[376715]: input line too long, skipping
Nov 28 19:50:25 newsfeed overchan[376715]: input line too long, skipping
Nov 28 20:06:16 newsfeed overchan[376715]: input line too long, skipping
Nov 28 21:51:22 newsfeed overchan[376715]: input line too long, skipping
Nov 28 23:42:54 newsfeed nnrpd[429697]: SERVER perl filter not defined
Nov 29 02:01:14 newsfeed overchan[376715]: input line too long, skipping
Nov 29 03:38:51 newsfeed overchan[376715]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	192082	89.9%	22.4 MB	90.0%
innd	12493	5.8%	1.6 MB	6.4%
nnrpd	7632	3.6%	778.1 KB	3.0%
innfeed	1396	0.7%	150.3 KB	0.6%
overchan	12	0.0%	1.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	213616	100.0%	24.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	189901	88.5%
Negative hits	12506	5.8%
Positive hits	12181	5.7%
Cache misses	50	0.0%
TOTAL: 4	214638	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.075	0.0%	81	0.000	13.272	42.000
article cleanup	00:00:01.279	0.0%	191088	0.001	0.007	0.016
article logging	00:00:04.056	0.0%	191102	0.010	0.021	0.033
article parse	00:00:06.420	0.0%	670375	0.005	0.010	0.015
article write	00:00:50.273	0.1%	179687	0.092	0.280	2.927
artlog/artcncl	00:00:00.002	0.0%	81	0.000	0.025	0.143
data move	00:00:01.061	0.0%	967596	0.000	0.001	0.003
hisgrep/artcncl	00:00:00.293	0.0%	81	0.000	3.617	18.000
hishave/artcncl	00:00:00.238	0.0%	81	0.000	2.938	8.300
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:11:49.778	0.8%	215169	1.289	3.299	9.595
history sync	00:00:00.015	0.0%	308	0.000	0.049	0.500
history write	00:14:00.833	1.0%	190430	2.240	4.415	9.024
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	23:29:13.736	97.8%	837701	19.614	100.935	196.007
nntp read	00:00:13.686	0.0%	682085	0.012	0.020	0.034
overview write	00:00:00.497	0.0%	179687	0.000	0.003	0.008
perl filter	00:03:16.608	0.2%	190430	0.786	1.032	1.489
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:05.883	0.0%	400155	0.008	0.015	0.029
TOTAL: 24:00:21.964	23:59:45.733	100.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.074	0.0%	40639	0.000	0.002	0.017
article prepare	00:00:00.000	0.0%	512	0.000	0.000	0.000
article read	00:00:00.008	0.0%	128	0.000	0.062	1.000
backlog stats	00:00:00.074	0.0%	172363	0.000	0.000	0.002
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.853	0.0%	96904	0.000	0.009	0.020
data write	00:00:02.054	0.0%	56288	0.008	0.036	0.077
idle	23:53:12.059	100.0%	172363	336.591	498.901	788.979
status file	00:00:00.208	0.0%	324	0.000	0.642	2.519
TOTAL: 23:53:17.496	23:53:15.330	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:09.137	34.9%	4168	0.000	2.192	129.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.163	0.6%	10075	0.000	0.016	0.500
TOTAL: 00:00:26.197	00:00:09.300	35.5%	-	-	-	-

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	89	180691	179844	8	839	99%	42:34:03
2	news.icm.edu.pl	2	22945	652	11712	10581	2%	24:20:12
3	localhost	2	1	1	0	0	100%	00:00:00
TOTAL: 3		93	203637	180497	11720	11420	88%	66:54:15

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	1.9 GB	10.0 MB	10.9 MB	1.9 GB	98%	11.2 KB
2	news.icm.edu.pl	12.3 MB	1.6 MB	154.6 MB	168.5 MB	7%	15.4 KB
3	localhost	1.5 KB	0.0 KB	0.0 KB	1.5 KB	100%	1.5 KB
TOTAL: 3		1.9 GB	11.6 MB	165.6 MB	2.1 GB	91%	11.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 28 04:15:02 - 04:59:59	3825	2.1%	1.42	46.8 MB	2.4%	17.78
Nov 28 05:00:00 - 05:59:59	4307	2.4%	1.20	51.7 MB	2.6%	14.71
Nov 28 06:00:00 - 06:59:59	5955	3.3%	1.65	79.0 MB	4.0%	22.47
Nov 28 07:00:00 - 07:59:59	5574	3.1%	1.55	65.0 MB	3.3%	18.48
Nov 28 08:00:00 - 08:59:59	5004	2.8%	1.39	51.6 MB	2.6%	14.67
Nov 28 09:00:00 - 09:59:59	5572	3.1%	1.55	52.7 MB	2.7%	14.99
Nov 28 10:00:00 - 10:59:59	7217	4.0%	2.00	113.1 MB	5.7%	32.16
Nov 28 11:00:00 - 11:59:59	7221	4.0%	2.01	91.3 MB	4.6%	25.97
Nov 28 12:00:00 - 12:59:59	6934	3.8%	1.93	79.8 MB	4.1%	22.71
Nov 28 13:00:00 - 13:59:59	8144	4.5%	2.26	166.4 MB	8.5%	47.34
Nov 28 14:00:00 - 14:59:59	7262	4.0%	2.02	80.9 MB	4.1%	23.02
Nov 28 15:00:00 - 15:59:59	8051	4.5%	2.24	85.2 MB	4.3%	24.23
Nov 28 16:00:00 - 16:59:59	8961	5.0%	2.49	128.1 MB	6.5%	36.43
Nov 28 17:00:00 - 17:59:59	13154	7.3%	3.65	104.7 MB	5.3%	29.77
Nov 28 18:00:00 - 18:59:59	9926	5.5%	2.76	86.2 MB	4.4%	24.53
Nov 28 19:00:00 - 19:59:59	7256	4.0%	2.02	79.8 MB	4.1%	22.70
Nov 28 20:00:00 - 20:59:59	6062	3.4%	1.68	53.8 MB	2.7%	15.29
Nov 28 21:00:00 - 21:59:59	9014	5.0%	2.50	88.7 MB	4.5%	25.24
Nov 28 22:00:00 - 22:59:59	9413	5.2%	2.61	102.7 MB	5.2%	29.22
Nov 28 23:00:00 - 23:59:59	7581	4.2%	2.11	76.4 MB	3.9%	21.74
Nov 29 00:00:00 - 00:59:59	7899	4.4%	2.19	76.6 MB	3.9%	21.78
Nov 29 01:00:00 - 01:59:59	7191	4.0%	2.00	56.3 MB	2.9%	16.00
Nov 29 02:00:00 - 02:59:59	8073	4.5%	2.24	60.9 MB	3.1%	17.32
Nov 29 03:00:00 - 03:59:59	6308	3.5%	1.75	55.5 MB	2.8%	15.77
Nov 29 04:00:00 - 04:15:02	4659	2.6%	5.17	35.0 MB	1.8%	39.73
TOTAL: 24:00:00	180563	100.0%	2.09	1.9 GB	100.0%	23.33

Sites sending bad articles:

Server		Total	Group	Duplic	Other
1	news.icm.edu.pl	10585	0	113	10472
2	newsfeed.pionier.net.pl	853	293	546	14
TOTAL: 2		11438	293	659	10486

Unwanted newsgroups [Top 20]:

Newsgroup	Count
fr.misc.actualite.covid19	81
uk.railway	48
alt.binaries.erotica.divx	48
comp.sys.raspberry-pi	23
eternal-september.talk	19
it.comp.os.win.windows10	18
comp.mobile.android	17
it.tlc.cellulari.android	12
alt.comp.software.firefox	9
fido7.english-tutor	6
eternal-september.newusers	2
alt.comp.software.seamonkey	2
eternal-september.support	2
rocksolid.shared.i2p	1
de.comm.software.mailreader	1
nl.comp.os.linux.techniek	1
rocksolid.shared.test	1
grisbi.test	1
rocksolid.shared.entertainment	1
TOTAL: 19	293

INND Perl filter [Top 20]:

Reason	Count
Binary in non-binary group	8544
Scoring filter (9)	1595
Scoring filter (8)	124
Scoring filter (10)	100
EMP (phl)	34
Scoring filter (11)	24
Scoring filter (12)	22
EMP (md5)	20
Scoring filter (13)	6
Scoring filter (14)	3
TOTAL: 10	10472

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	55714	109	39698	19	0	0%	23:59:58
2	poznan	803	1	629	0	0	0%	23:40:35
3	okapi	0	0	0	0	631	0%	23:57:48
4	panorama	0	0	0	0	40789	0%	23:57:48
5	nask	0	0	0	0	35924	0%	23:57:48
TOTAL: 5		56517	110	40327	19	77344	0%	119:33:57

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	1.1 MB	80.3 KB	1.1 MB	9.2 KB	23:59:58
2	poznan	24.5 KB	0.0 KB	24.5 KB	24.5 KB	23:40:35
3	okapi	0.0 KB	0.0 KB	0.0 KB	0	23:57:48
4	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:48
5	nask	0.0 KB	0.0 KB	0.0 KB	0	23:57:48
TOTAL: 5		1.1 MB	80.3 KB	1.2 MB	9.3 KB	119:33:57

Backlog files shrunk by innfeed:

Server	Size
panorama	3.8 MB
TOTAL: 1	3.8 MB

NNRP readership statistics:

System		Conn	Post	Elapsed
1	71.6.134.231	3	0	00:00:00
2	isvcs01.man.lodz.pl	1	1	00:00:00
3	212.51.192.185	96	0	00:00:00
4	scanner-07.ch1.censys-scanner.com	1	0	00:00:00
5	91.240.118.29	1	0	00:00:00
6	nms2.man.lodz.pl	1436	0	00:00:13
7	80.66.88.204	1	0	00:00:00
8	web.man.lodz.pl	288	0	00:00:08
9	80.111.142.213	4	0	00:00:02
TOTAL: 9		1831	1	00:00:26

NNRP readership statistics (by domain):

System		Conn	Post	Elapsed
1	*.ch1.censys-scanner.com	1	0	00:00:00
2	*.man.lodz.pl	1725	1	00:00:22
3	unresolved	105	0	00:00:04
TOTAL: 3		1831	1	00:00:26

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
nms2.man.lodz.pl	4.343	6.963	00:00:13
web.man.lodz.pl	0.920	1.360	00:00:08
80.111.142.213	0.020	0.017	00:00:02
212.51.192.185	0.325	0.410	00:00:00
71.6.134.231	0.003	0.018	00:00:00
scanner-07.ch1.censys-scanner.com	0.008	0.008	00:00:00
80.66.88.204	0.007	0.000	00:00:00
91.240.118.29	0.003	0.003	00:00:00
isvcs01.man.lodz.pl	0.006	0.012	00:00:00
TOTAL: 9	5.635	8.791	00:00:26

NNRP unrecognized commands (by host):

System	Conn
71.6.134.231	7
80.66.88.204	1
91.240.118.29	1
scanner-07.ch1.censys-scanner.com	1
TOTAL: 4	10

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
80.66.88.204	1	1
91.240.118.29	1	1
TOTAL: 2	2	2

Daily Usenet report

Nov 28 04:15:02 -- Nov 29 04:15:02