Daily Usenet report: Dec 20 04:15:02

Unknown entries from news log file:

First 15 / 15 lines (100.0%)

Dec 20 08:00:09 newsfeed overchan[2610]: input line too long, skipping
Dec 20 08:06:28 newsfeed overchan[2610]: input line too long, skipping
Dec 20 09:39:04 newsfeed nnrpd[20769]: SERVER perl filter not defined
Dec 20 10:31:56 newsfeed nnrpd[29077]: SERVER perl filter not defined
Dec 20 12:13:16 newsfeed nnrpd[12183]: unable to get certificate from '/etc/news/cert.pem'
Dec 20 12:13:16 newsfeed nnrpd[12183]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]
Dec 20 12:40:59 newsfeed overchan[2610]: input line too long, skipping
Dec 20 15:10:51 newsfeed overchan[2610]: input line too long, skipping
Dec 20 15:20:44 newsfeed overchan[2610]: input line too long, skipping
Dec 20 15:34:38 newsfeed overchan[2610]: input line too long, skipping
Dec 20 16:03:17 newsfeed overchan[2610]: input line too long, skipping
Dec 20 17:08:52 newsfeed overchan[2610]: input line too long, skipping
Dec 20 18:28:40 newsfeed overchan[2610]: input line too long, skipping
Dec 20 22:26:32 newsfeed overchan[2610]: input line too long, skipping
Dec 21 01:57:32 newsfeed overchan[2610]: input line too long, skipping

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	716443	91.9%	78.2 MB	91.0%
innfeed	49362	6.3%	5.8 MB	6.7%
innd	9685	1.2%	1.5 MB	1.8%
nnrpd	4213	0.5%	419.1 KB	0.5%
overchan	11	0.0%	2.1 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	779715	100.0%	85.9 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	710773	99.6%
Negative hits	2912	0.4%
Positive hits	184	0.0%
Cache misses	14	0.0%
TOTAL: 4	713883	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.614	0.0%	63	0.000	9.746	74.000
article cleanup	00:00:09.776	0.0%	713868	0.008	0.014	0.019
article logging	00:00:31.727	0.0%	714437	0.035	0.044	0.057
article parse	00:17:43.537	1.2%	51702221	0.016	0.021	0.025
article write	00:07:33.972	0.5%	713639	0.416	0.636	1.090
artlog/artcncl	00:00:00.001	0.0%	63	0.000	0.016	0.125
data move	00:00:42.242	0.0%	56614625	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.068	0.0%	63	0.000	1.079	11.000
hishave/artcncl	00:00:00.031	0.0%	63	0.000	0.492	3.625
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:20:41.837	1.4%	716927	0.469	1.732	10.009
history sync	00:00:00.024	0.0%	290	0.000	0.083	1.000
history write	00:10:35.596	0.7%	713850	0.526	0.890	7.221
hiswrite/artcncl	00:00:00.000	0.0%	0	0.000	0.000	0.000
idle	21:14:22.112	88.5%	50996187	1.349	1.499	1.988
nntp read	00:29:00.075	2.0%	51354307	0.028	0.034	0.040
overview write	00:00:03.888	0.0%	713639	0.003	0.005	0.009
perl filter	01:04:25.028	4.5%	713850	3.555	5.414	7.013
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:34.200	0.0%	1440057	0.019	0.024	0.029
TOTAL: 24:00:04.639	23:46:24.728	99.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.090	0.0%	50433	0.000	0.002	0.017
article prepare	00:00:00.003	0.0%	5880	0.000	0.001	0.042
article read	00:00:09.903	0.0%	1466	0.000	6.755	81.000
backlog stats	00:00:00.071	0.0%	116899	0.000	0.001	0.004
callbacks	00:00:00.000	0.0%	1	0.000	0.000	0.000
data read	00:00:00.960	0.0%	56090	0.004	0.017	0.033
data write	00:00:02.390	0.0%	43991	0.017	0.054	0.117
idle	23:53:56.895	99.9%	116899	440.718	735.993	1265.536
status file	00:01:01.707	0.1%	17085	0.760	3.612	193.156
TOTAL: 23:55:17.396	23:55:12.019	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
hisgrep	00:00:00.001	0.0%	2	0.500	0.500	0.500
idle	01:02:08.828	99.7%	3060	0.000	1218.571	900005.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.248	0.0%	6761	0.000	0.037	0.737
readart	00:00:00.002	0.0%	28	0.000	0.071	1.000
TOTAL: 01:02:20.972	01:02:09.079	99.7%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
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	226	715529	715375	0	154	99%	93:16:45
2	news.icm.edu.pl	38	202	19	117	66	9%	12:15:48
3	localhost	1443	2	2	0	0	100%	00:00:00
TOTAL: 3		1707	715733	715396	117	220	99%	105:32:33

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	296.9 GB	803.2 KB	1.2 MB	296.9 GB	99%	435.1 KB
2	news.icm.edu.pl	825.7 KB	24.0 KB	2.4 MB	3.2 MB	25%	38.7 KB
3	localhost	2.9 KB	0.0 KB	0.0 KB	2.9 KB	100%	1.5 KB
TOTAL: 3		296.9 GB	827.2 KB	3.5 MB	296.9 GB	99%	435.0 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Dec 20 04:15:02 - 04:59:59	14720	2.1%	5.46	7.5 GB	2.5%	2900.58
Dec 20 05:00:00 - 05:59:59	21719	3.0%	6.03	10.1 GB	3.4%	2946.79
Dec 20 06:00:00 - 06:59:59	27225	3.8%	7.56	12.7 GB	4.3%	3713.01
Dec 20 07:00:00 - 07:59:59	25051	3.5%	6.96	12.3 GB	4.1%	3569.39
Dec 20 08:00:00 - 08:59:59	22244	3.1%	6.18	11.2 GB	3.8%	3266.51
Dec 20 09:00:00 - 09:59:59	24348	3.4%	6.76	11.9 GB	4.0%	3471.66
Dec 20 10:00:00 - 10:59:59	27147	3.8%	7.54	12.3 GB	4.1%	3582.52
Dec 20 11:00:00 - 11:59:59	30896	4.3%	8.58	13.3 GB	4.5%	3874.56
Dec 20 12:00:00 - 12:59:59	30743	4.3%	8.54	13.4 GB	4.5%	3898.44
Dec 20 13:00:00 - 13:59:59	32176	4.5%	8.94	14.2 GB	4.8%	4121.97
Dec 20 14:00:00 - 14:59:59	29247	4.1%	8.12	13.0 GB	4.4%	3781.63
Dec 20 15:00:00 - 15:59:59	30943	4.3%	8.60	13.9 GB	4.7%	4058.93
Dec 20 16:00:00 - 16:59:59	30128	4.2%	8.37	13.4 GB	4.5%	3914.00
Dec 20 17:00:00 - 17:59:59	30479	4.3%	8.47	13.5 GB	4.5%	3936.19
Dec 20 18:00:00 - 18:59:59	29431	4.1%	8.18	14.2 GB	4.8%	4146.73
Dec 20 19:00:00 - 19:59:59	26174	3.7%	7.27	13.2 GB	4.4%	3836.52
Dec 20 20:00:00 - 20:59:59	27273	3.8%	7.58	12.1 GB	4.1%	3519.84
Dec 20 21:00:00 - 21:59:59	28702	4.0%	7.97	13.3 GB	4.5%	3866.04
Dec 20 22:00:00 - 22:59:59	26352	3.7%	7.32	11.5 GB	3.9%	3358.55
Dec 20 23:00:00 - 23:59:59	23618	3.3%	6.56	11.1 GB	3.7%	3221.96
Dec 21 00:00:00 - 00:59:59	41237	5.8%	11.45	11.3 GB	3.8%	3282.92
Dec 21 01:00:00 - 01:59:59	43812	6.1%	12.17	11.9 GB	4.0%	3475.93
Dec 21 02:00:00 - 02:59:59	41330	5.8%	11.48	11.9 GB	4.0%	3475.09
Dec 21 03:00:00 - 03:59:59	39864	5.6%	11.07	11.5 GB	3.8%	3335.49
Dec 21 04:00:00 - 04:15:02	10721	1.5%	11.89	3.1 GB	1.0%	3594.21
TOTAL: 24:00:00	715580	100.0%	8.28	297.8 GB	100.0%	3613.71

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	724	135	17	2	570
2	news.icm.edu.pl	76	0	1	0	75
TOTAL: 2		800	135	18	2	645

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	87
it.tlc.cellulari.android	25
it.comp.os.win.windows10	9
nl.comp.os.linux.techniek	8
it.comp.os.win.windows7	2
comp.sys.raspberry-pi	1
de.comp.lang.vbclassic	1
it.comp.os.linux.ubuntu	1
de.rec.sf.startrek	1
TOTAL: 9	135

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

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

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	74
Scoring filter (8)	1
TOTAL: 2	75

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	20245	354	11890	286	0	0	1%	23:50:01
2	panorama	39742	328	10980	137	2	39161	0%	23:59:57
3	poznan	18	0	12	0	0	0	0%	02:06:12
4	okapi	0	0	0	0	0	780	0%	23:57:48
5	nask	0	0	0	0	0	8355	0%	23:50:03
TOTAL: 5		60005	682	22882	423	2	48296	1%	97:44:01

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	panorama	1.7 MB	532.4 KB	2.2 MB	0.0 KB/s	4.9 KB	23:59:57
2	icm	1.1 MB	72.0 MB	73.0 MB	0.9 KB/s	116.9 KB	23:50:01
3	poznan	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	02:06:12
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:48
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:50:03
TOTAL: 5		2.8 MB	72.5 MB	75.3 MB	0.2 KB/s	69.8 KB	97:44:01

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	28	28.3 KB	13	0	00:00:22
2	isvcs01.man.lodz.pl	2	0	0.0 KB	0	2	00:00:00
TOTAL: 2		290	28	28.3 KB	13	2	01:02:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	578	28	28.3 KB	13	2	00:00:26
2	*.ch1.censys-scanner.com	2	0	0.0 KB	0	0	00:00:00
3	*.dynamic.chello.pl	1	0	0.0 KB	0	0	00:31:32
4	unresolved	101	0	0.0 KB	0	0	00:30:05
5	*.a2hosting.com	2	0	0.0 KB	0	0	00:00:16
TOTAL: 5		684	28	28.3 KB	13	2	01:02:20

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
89-64-149-5.dynamic.chello.pl	0.000	0.009	00:31:32
183.129.159.243	0.003	0.005	00:30:00
web.man.lodz.pl	1.537	2.979	00:00:22
az1-ss13.a2hosting.com	0.024	0.008	00:00:16
80.111.142.213	0.017	0.052	00:00:03
mon.man.lodz.pl	1.315	2.464	00:00:03
212.51.192.185	0.380	0.868	00:00:01
scanner-04.ch1.censys-scanner.com	0.008	0.021	00:00:00
isvcs01.man.lodz.pl	0.016	0.036	00:00:00
TOTAL: 9	3.300	6.442	01:02:20

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
212.51.192.185	96
80.111.142.213	4
az1-ss13.a2hosting.com	2
scanner-04.ch1.censys-scanner.com	2
89-64-149-5.dynamic.chello.pl	1
183.129.159.243	1
TOTAL: 7	394

NNRP unrecognized commands (by host):

System	Conn
scanner-04.ch1.censys-scanner.com	1
183.129.159.243	1
TOTAL: 2	2

NNRP unrecognized commands (by command):

Command	Count
GET / HTTP/1.0	1
EHLO www.censys.io	1
TOTAL: 2	2

NNRP client timeouts [Top 20]:

System	Conn	Peer
183.129.159.243	1	0
89-64-149-5.dynamic.chello.pl	1	0
TOTAL: 2	2	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	16
2	pl.comp.os.ms-windows.winnt	12
TOTAL: 2		28

Daily Usenet report

Dec 20 04:15:02 -- Dec 21 04:15:02