Daily Usenet report: Dec 17 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Dec 17 08:26:12 newsfeed overchan[304823]: input line too long, skipping
Dec 17 10:57:41 newsfeed overchan[304823]: input line too long, skipping
Dec 17 13:50:15 newsfeed overchan[304823]: input line too long, skipping
Dec 17 15:05:14 newsfeed overchan[304823]: input line too long, skipping
Dec 17 15:33:42 newsfeed overchan[304823]: input line too long, skipping
Dec 17 15:39:55 newsfeed overchan[304823]: input line too long, skipping
Dec 17 15:44:19 newsfeed overchan[304823]: input line too long, skipping
Dec 17 19:13:28 newsfeed overchan[304823]: input line too long, skipping
Dec 17 19:14:08 newsfeed overchan[304823]: input line too long, skipping
Dec 17 19:54:20 newsfeed overchan[304823]: input line too long, skipping
Dec 17 22:29:14 newsfeed nnrpd[354025]: SERVER perl filter not defined
Dec 17 22:31:56 newsfeed nnrpd[354147]: SERVER perl filter not defined
Dec 18 00:42:08 newsfeed overchan[304823]: input line too long, skipping
Dec 18 02:19:38 newsfeed overchan[304823]: input line too long, skipping
Dec 18 02:20:52 newsfeed overchan[304823]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	231743	95.3%	26.3 MB	95.6%
nnrpd	7649	3.1%	794.0 KB	2.8%
innd	2297	0.9%	290.6 KB	1.0%
innfeed	1489	0.6%	160.6 KB	0.6%
overchan	14	0.0%	1.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	243193	100.0%	27.6 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	230134	97.1%
Positive hits	4639	2.0%
Negative hits	2061	0.9%
Cache misses	82	0.0%
TOTAL: 4	236916	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:01.402	0.0%	314	0.000	4.465	46.000
article cleanup	00:00:01.713	0.0%	231239	0.002	0.007	0.014
article logging	00:00:05.929	0.0%	231257	0.014	0.026	0.038
article parse	00:00:09.424	0.0%	760896	0.008	0.012	0.019
article write	00:00:56.689	0.1%	229995	0.099	0.246	4.447
artlog/artcncl	00:00:00.006	0.0%	312	0.000	0.019	1.000
data move	00:00:01.394	0.0%	1103529	0.000	0.001	0.004
hisgrep/artcncl	00:00:00.603	0.0%	313	0.000	1.927	24.800
hishave/artcncl	00:00:00.096	0.0%	314	0.000	0.306	8.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:14:10.304	1.0%	237197	0.393	3.585	11.224
history sync	00:00:00.020	0.0%	302	0.000	0.066	1.000
history write	00:27:17.849	1.9%	230708	1.713	7.099	16.602
hiswrite/artcncl	00:00:00.010	0.0%	1	10.000	10.000	10.000
idle	23:11:33.270	96.6%	905606	12.189	92.196	247.307
nntp read	00:00:17.659	0.0%	732237	0.012	0.024	0.037
overview write	00:00:00.823	0.0%	229995	0.000	0.004	0.009
perl filter	00:04:50.748	0.3%	230708	0.997	1.260	1.878
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:08.860	0.0%	491603	0.012	0.018	0.026
TOTAL: 24:00:27.925	23:59:36.799	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.084	0.0%	31504	0.000	0.003	0.019
article prepare	00:00:00.000	0.0%	568	0.000	0.000	0.000
article read	00:00:00.006	0.0%	142	0.000	0.042	1.000
backlog stats	00:00:00.050	0.0%	134318	0.000	0.000	0.003
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.788	0.0%	74996	0.000	0.011	0.048
data write	00:00:02.078	0.0%	43530	0.017	0.048	0.169
idle	23:54:17.008	100.0%	134318	323.949	640.696	1181.484
status file	00:00:00.252	0.0%	369	0.000	0.683	3.857
TOTAL: 23:54:22.363	23:54:20.266	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:19.716	52.8%	4172	0.000	4.726	9732.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.214	0.6%	10089	0.000	0.021	0.500
TOTAL: 00:00:37.343	00:00:19.930	53.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	62	230756	229833	1	922	99%	37:12:20
2	news.icm.edu.pl	1	3518	332	2871	315	9%	17:21:33
3	localhost	3	2	2	0	0	100%	00:00:00
TOTAL: 3		66	234276	230167	2872	1237	98%	54:33:53

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	2.5 GB	6.2 MB	10.5 MB	2.5 GB	99%	11.4 KB
2	news.icm.edu.pl	5.0 MB	1.1 MB	5.5 MB	11.7 MB	42%	18.4 KB
3	localhost	2.7 KB	0.0 KB	0.0 KB	2.7 KB	100%	1.3 KB
TOTAL: 3		2.5 GB	7.3 MB	16.0 MB	2.5 GB	99%	11.4 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 17 04:15:02 - 04:59:59	4319	1.9%	1.60	43.3 MB	1.7%	16.43
Dec 17 05:00:00 - 05:59:59	6933	3.0%	1.93	56.2 MB	2.2%	15.99
Dec 17 06:00:00 - 06:59:59	5542	2.4%	1.54	53.9 MB	2.1%	15.33
Dec 17 07:00:00 - 07:59:59	7055	3.1%	1.96	109.9 MB	4.3%	31.26
Dec 17 08:00:00 - 08:59:59	11241	4.9%	3.12	112.5 MB	4.4%	32.00
Dec 17 09:00:00 - 09:59:59	22219	9.7%	6.17	256.6 MB	10.0%	73.00
Dec 17 10:00:00 - 10:59:59	22265	9.7%	6.18	257.2 MB	10.1%	73.16
Dec 17 11:00:00 - 11:59:59	11481	5.0%	3.19	118.0 MB	4.6%	33.56
Dec 17 12:00:00 - 12:59:59	10684	4.6%	2.97	243.3 MB	9.5%	69.20
Dec 17 13:00:00 - 13:59:59	10243	4.5%	2.85	146.6 MB	5.7%	41.70
Dec 17 14:00:00 - 14:59:59	11655	5.1%	3.24	236.4 MB	9.3%	67.23
Dec 17 15:00:00 - 15:59:59	8692	3.8%	2.41	73.2 MB	2.9%	20.82
Dec 17 16:00:00 - 16:59:59	7637	3.3%	2.12	58.3 MB	2.3%	16.57
Dec 17 17:00:00 - 17:59:59	9286	4.0%	2.58	80.8 MB	3.2%	22.99
Dec 17 18:00:00 - 18:59:59	10214	4.4%	2.84	92.9 MB	3.6%	26.43
Dec 17 19:00:00 - 19:59:59	10718	4.7%	2.98	125.4 MB	4.9%	35.67
Dec 17 20:00:00 - 20:59:59	9136	4.0%	2.54	70.9 MB	2.8%	20.15
Dec 17 21:00:00 - 21:59:59	8122	3.5%	2.26	63.3 MB	2.5%	18.00
Dec 17 22:00:00 - 22:59:59	7154	3.1%	1.99	60.3 MB	2.4%	17.14
Dec 17 23:00:00 - 23:59:59	7122	3.1%	1.98	61.5 MB	2.4%	17.49
Dec 18 00:00:00 - 00:59:59	6668	2.9%	1.85	54.2 MB	2.1%	15.42
Dec 18 01:00:00 - 01:59:59	8736	3.8%	2.43	71.2 MB	2.8%	20.24
Dec 18 02:00:00 - 02:59:59	5548	2.4%	1.54	40.9 MB	1.6%	11.63
Dec 18 03:00:00 - 03:59:59	6072	2.6%	1.69	53.2 MB	2.1%	15.14
Dec 18 04:00:00 - 04:15:01	1407	0.6%	1.56	13.8 MB	0.5%	15.63
TOTAL: 23:59:59	230149	100.0%	2.66	2.5 GB	100.0%	30.26

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	943	502	421	1	19
2	news.icm.edu.pl	341	1	110	0	230
TOTAL: 2		1284	503	531	1	249

Unwanted newsgroups [Top 20]:

Newsgroup	Count
comp.mobile.android	263
uk.railway	52
fr.misc.actualite.covid19	48
alt.binaries.erotica.divx	44
rocksolid.nodes.help	16
it.tlc.cellulari.android	13
alt.comp.software.firefox	13
eternal-september.support	7
it.comp.os.win.windows10	7
eternal-september.talk	6
comp.sys.mac.vintage	6
alt.comp.software.seamonkey	4
grisbi.user.french	4
comp.sys.raspberry-pi	4
eternal-september.test	4
de.comp.office-pakete.ms-office.excel	3
it.discussioni.energia	3
rocksolid.shared.tor	2
de.comm.software.mailreader	1
grisbi.test	1
TOTAL: 22	503

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

Groups	Count
soc.culture.jewish.holocaust	1
TOTAL: 1	1

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	135
Scoring filter (9)	35
Binary in non-binary group	32
Scoring filter (8)	24
Scoring filter (10)	4
Scoring filter (11)	1
TOTAL: 6	231

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Spool	%Took	Elapsed
1	icm	43142	102	30875	39	2	0%	23:59:57
2	poznan	495	1	419	0	0	0%	23:39:41
3	panorama	0	0	0	0	31604	0%	23:57:47
4	nask	0	0	0	0	25901	0%	23:57:47
5	okapi	0	0	0	0	587	0%	23:57:47
TOTAL: 5		43637	103	31294	39	58094	0%	119:32:59

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	758.8 KB	383.2 KB	1.1 MB	8.1 KB	23:59:57
2	poznan	17.0 KB	0.0 KB	17.0 KB	17.0 KB	23:39:41
3	panorama	0.0 KB	0.0 KB	0.0 KB	0	23:57:47
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		775.8 KB	383.2 KB	1.1 MB	8.2 KB	119:32:59

Backlog files shrunk by innfeed:

Server	Size
panorama	2.9 MB
TOTAL: 1	2.9 MB

NNRP readership statistics:

System		Conn	Post	Elapsed
1	web.man.lodz.pl	287	0	00:00:07
2	scanner-29.ch1.censys-scanner.com	1	0	00:00:00
3	212.51.192.185	96	0	00:00:01
4	80.111.142.213	4	0	00:00:03
5	nms2.man.lodz.pl	1440	0	00:00:14
6	194.165.16.73	1	0	00:00:00
7	152.150.216.162.bc.googleusercontent.com	1	0	00:00:00
8	isvcs01.man.lodz.pl	2	2	00:00:00
9	107.170.225.19	1	0	00:00:00
10	162.243.138.52	1	0	00:00:09
11	71.6.134.234	3	0	00:00:00
TOTAL: 11		1837	2	00:00:37

NNRP readership statistics (by domain):

System		Conn	Post	Elapsed
1	unresolved	106	0	00:00:14
2	*.man.lodz.pl	1729	2	00:00:21
3	*.ch1.censys-scanner.com	1	0	00:00:00
4	*.150.216.162.bc.googleusercontent.com	1	0	00:00:00
TOTAL: 4		1837	2	00:00:37

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
nms2.man.lodz.pl	5.596	10.482	00:00:14
162.243.138.52	0.006	0.006	00:00:09
web.man.lodz.pl	0.994	2.100	00:00:07
80.111.142.213	0.022	0.035	00:00:03
212.51.192.185	0.315	0.788	00:00:01
71.6.134.234	0.008	0.021	00:00:00
scanner-29.ch1.censys-scanner.com	0.007	0.013	00:00:00
107.170.225.19	0.000	0.006	00:00:00
152.150.216.162.bc.googleusercontent.com	0.005	0.005	00:00:00
isvcs01.man.lodz.pl	0.004	0.025	00:00:00
194.165.16.73	0.006	0.006	00:00:00
TOTAL: 11	6.963	13.487	00:00:37

NNRP unrecognized commands (by host):

System	Conn
71.6.134.234	7
152.150.216.162.bc.googleusercontent.com	3
107.170.225.19	1
scanner-29.ch1.censys-scanner.com	1
194.165.16.73	1
TOTAL: 5	13

NNRP unrecognized commands (by command):

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

NNRP client timeouts [Top 20]:

System	Conn	Peer
194.165.16.73	1	1
TOTAL: 1	1	1

Daily Usenet report

Dec 17 04:15:02 -- Dec 18 04:15:01