Daily Usenet report: Nov 13 04:15:01

Unknown entries from news log file:

First 11 / 11 lines (100.0%)

Nov 13 09:07:38 newsfeed nnrpd[11336]: SERVER perl filter not defined
Nov 13 12:43:16 newsfeed nnrpd[11105]: SERVER perl filter not defined
Nov 13 16:53:06 newsfeed overchan[31311]: input line too long, skipping
Nov 13 17:10:16 newsfeed overchan[31311]: input line too long, skipping
Nov 13 17:15:02 newsfeed nnrpd[20019]: SERVER perl filter not defined
Nov 13 18:32:31 newsfeed nnrpd[31520]: SERVER perl filter not defined
Nov 13 19:53:19 newsfeed overchan[31311]: input line too long, skipping
Nov 13 19:57:44 newsfeed overchan[31311]: input line too long, skipping
Nov 13 21:38:29 newsfeed nnrpd[27071]: SERVER perl filter not defined
Nov 14 01:36:01 newsfeed nnrpd[30150]: unable to get certificate from '/etc/news/cert.pem'
Nov 14 01:36:01 newsfeed nnrpd[30150]: error initializing TLS: [CA_file: ] [CA_path: /etc/news] [cert_file: /etc/news/cert.pem] [key_file: /etc/news/key.pem]

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	598269	91.0%	65.8 MB	90.2%
innfeed	46585	7.1%	5.5 MB	7.5%
innd	8934	1.4%	1.4 MB	1.9%
nnrpd	3363	0.5%	310.5 KB	0.4%
overchan	5	0.0%	0.7 KB	0.0%
controlchan	1	0.0%	0.1 KB	0.0%
TOTAL: 6	657157	100.0%	73.0 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	593123	99.1%
Negative hits	4860	0.8%
Positive hits	221	0.0%
Cache misses	23	0.0%
TOTAL: 4	598227	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.834	0.0%	107	0.000	7.794	109.000
article cleanup	00:00:04.882	0.0%	598467	0.005	0.008	0.013
article logging	00:00:16.626	0.0%	598773	0.019	0.028	0.421
article parse	00:08:04.066	0.6%	73484267	0.005	0.007	0.012
article write	00:04:26.373	0.3%	598286	0.259	0.445	1.922
artlog/artcncl	00:00:00.001	0.0%	107	0.000	0.009	0.500
data move	00:01:05.228	0.1%	78187972	0.001	0.001	0.001
hisgrep/artcncl	00:00:00.271	0.0%	102	0.000	2.657	14.000
hishave/artcncl	00:00:00.065	0.0%	107	0.000	0.607	5.500
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:28:13.417	2.0%	603642	0.177	2.805	29.943
history sync	00:00:00.014	0.0%	296	0.000	0.047	0.500
history write	00:42:34.323	3.0%	598452	0.353	4.268	43.738
hiswrite/artcncl	00:00:00.031	0.0%	5	0.000	6.200	16.000
idle	21:21:51.295	89.0%	73091533	0.714	1.052	1.639
nntp read	00:21:02.663	1.5%	73183230	0.015	0.017	0.024
overview write	00:00:02.202	0.0%	598286	0.001	0.004	0.006
perl filter	00:37:40.533	2.6%	598452	3.066	3.777	4.844
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:00:17.042	0.0%	1207492	0.010	0.014	0.020
TOTAL: 24:00:07.017	23:45:39.866	99.0%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.095	0.0%	46450	0.000	0.002	0.010
article prepare	00:00:00.003	0.0%	8442	0.000	0.000	0.028
article read	00:00:03.363	0.0%	2111	0.000	1.593	17.200
backlog stats	00:00:00.125	0.0%	108734	0.000	0.001	0.005
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.515	0.0%	51748	0.000	0.010	0.033
data write	00:00:01.130	0.0%	41052	0.000	0.028	0.057
idle	23:50:36.793	99.6%	108734	390.915	789.420	1388.871
status file	00:04:58.893	0.3%	17311	0.415	17.266	963.342
TOTAL: 23:55:44.397	23:55:40.917	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:00:11.338	60.7%	2802	0.000	4.046	278.333
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.087	0.5%	5984	0.000	0.015	0.500
readart	00:00:00.003	0.0%	52	0.000	0.058	0.500
TOTAL: 00:00:18.669	00:00:11.428	61.2%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	27
flushlogs	2
go	2
logmode	2
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	182	597688	597570	0	118	99%	90:33:09
2	news.icm.edu.pl	38	196	20	127	49	10%	12:37:16
3	localhost	1446	5	5	0	0	100%	00:00:00
TOTAL: 3		1666	597889	597595	127	167	99%	103:10:25

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	272.8 GB	955.9 KB	1.2 MB	272.8 GB	99%	478.5 KB
2	news.icm.edu.pl	1.3 MB	0.0 KB	2.8 MB	4.1 MB	31%	60.9 KB
3	localhost	6.5 KB	0.0 KB	0.0 KB	6.5 KB	100%	1.3 KB
TOTAL: 3		272.8 GB	955.9 KB	4.0 MB	272.8 GB	99%	478.5 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Nov 13 04:15:01 - 04:59:59	18851	3.2%	6.98	8.7 GB	3.2%	3394.95
Nov 13 05:00:00 - 05:59:59	28404	4.8%	7.89	11.2 GB	4.1%	3262.84
Nov 13 06:00:00 - 06:59:59	28274	4.7%	7.85	11.1 GB	4.1%	3244.58
Nov 13 07:00:00 - 07:59:59	31244	5.2%	8.68	11.2 GB	4.1%	3269.17
Nov 13 08:00:00 - 08:59:59	33820	5.7%	9.39	12.2 GB	4.4%	3545.93
Nov 13 09:00:00 - 09:59:59	24233	4.1%	6.73	11.0 GB	4.0%	3215.38
Nov 13 10:00:00 - 10:59:59	23863	4.0%	6.63	11.5 GB	4.2%	3363.17
Nov 13 11:00:00 - 11:59:59	25018	4.2%	6.95	11.7 GB	4.3%	3417.53
Nov 13 12:00:00 - 12:59:59	22859	3.8%	6.35	10.9 GB	4.0%	3173.45
Nov 13 13:00:00 - 13:59:59	23858	4.0%	6.63	11.1 GB	4.0%	3220.45
Nov 13 14:00:00 - 14:59:59	23493	3.9%	6.53	10.5 GB	3.8%	3046.51
Nov 13 15:00:00 - 15:59:59	22629	3.8%	6.29	10.6 GB	3.9%	3075.95
Nov 13 16:00:00 - 16:59:59	24346	4.1%	6.76	11.4 GB	4.2%	3314.25
Nov 13 17:00:00 - 17:59:59	24588	4.1%	6.83	11.9 GB	4.4%	3468.66
Nov 13 18:00:00 - 18:59:59	26707	4.5%	7.42	11.9 GB	4.4%	3478.15
Nov 13 19:00:00 - 19:59:59	24932	4.2%	6.93	11.7 GB	4.3%	3412.32
Nov 13 20:00:00 - 20:59:59	25772	4.3%	7.16	11.5 GB	4.2%	3335.79
Nov 13 21:00:00 - 21:59:59	25608	4.3%	7.11	12.6 GB	4.6%	3682.92
Nov 13 22:00:00 - 22:59:59	20661	3.5%	5.74	10.6 GB	3.9%	3090.41
Nov 13 23:00:00 - 23:59:59	24441	4.1%	6.79	11.5 GB	4.2%	3338.71
Nov 14 00:00:00 - 00:59:59	22994	3.8%	6.39	11.0 GB	4.0%	3195.90
Nov 14 01:00:00 - 01:59:59	20231	3.4%	5.62	10.7 GB	3.9%	3103.94
Nov 14 02:00:00 - 02:59:59	22627	3.8%	6.29	11.5 GB	4.2%	3359.71
Nov 14 03:00:00 - 03:59:59	22749	3.8%	6.32	12.6 GB	4.6%	3655.97
Nov 14 04:00:00 - 04:15:01	5473	0.9%	6.07	3.0 GB	1.1%	3463.53
TOTAL: 24:00:00	597675	100.0%	6.92	273.6 GB	100.0%	3320.16

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	424	98	15	5	306
2	news.icm.edu.pl	63	0	0	0	63
TOTAL: 2		487	98	15	5	369

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	36
it.tlc.cellulari.android	20
comp.sys.raspberry-pi	9
alt.comp.software.seamonkey	9
comp.sys.mac.vintage	7
alt.comp.software.firefox	6
it.comp.os.win.windows10	4
nl.comp.os.linux.techniek	4
it.discussioni.energia	2
de.comm.software.mailreader	1
TOTAL: 10	98

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

Groups	Count
pl.praca.oferowana	5
TOTAL: 1	5

INND Perl filter [Top 20]:

Reason	Count
EMP (md5)	59
Binary in non-binary group	3
Scoring filter (9)	1
TOTAL: 3	63

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	17692	1716	8796	64	0	0	9%	23:52:38
2	panorama	38557	79	9781	39	1	36685	0%	23:59:57
3	poznan	22	0	10	3	0	0	0%	01:50:41
4	okapi	0	0	0	0	0	877	0%	23:57:46
5	nask	0	0	0	0	0	7671	0%	23:57:46
TOTAL: 5		56271	1795	18587	106	1	45233	3%	97:38:48

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	6.3 MB	193.5 KB	6.5 MB	0.1 KB/s	3.7 KB	23:52:38
2	panorama	189.2 KB	114.8 KB	304.0 KB	0.0 KB/s	2.6 KB	23:59:57
3	poznan	0.0 KB	224.5 KB	224.5 KB	0.0 KB/s	74.8 KB	01:50:41
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	23:57:46
TOTAL: 5		6.5 MB	532.8 KB	7.0 MB	0.0 KB/s	3.8 KB	97:38:48

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Post	Elapsed
1	web.man.lodz.pl	288	52	98.4 KB	22	0	00:00:12
2	isvcs01.man.lodz.pl	5	0	0.0 KB	0	5	00:00:00
TOTAL: 2		293	52	98.4 KB	22	5	00:00:18

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Post	Elapsed
1	*.man.lodz.pl	293	52	98.4 KB	22	5	00:00:13
2	unresolved	100	0	0.0 KB	0	0	00:00:04
3	*.ch1.censys-scanner.com	1	0	0.0 KB	0	0	00:00:00
TOTAL: 3		394	52	98.4 KB	22	5	00:00:18

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
web.man.lodz.pl	1.097	1.707	00:00:12
80.111.142.213	0.020	0.016	00:00:03
scanner-05.ch1.censys-scanner.com	0.005	0.005	00:00:00
212.51.192.185	0.342	0.389	00:00:00
isvcs01.man.lodz.pl	0.009	0.053	00:00:00
TOTAL: 5	1.473	2.170	00:00:18

Curious NNRP server explorers [Top 20]:

System	Conn
212.51.192.185	96
80.111.142.213	4
scanner-05.ch1.censys-scanner.com	1
TOTAL: 3	101

NNRP unrecognized commands (by host):

System	Conn
scanner-05.ch1.censys-scanner.com	1
TOTAL: 1	1

NNRP unrecognized commands (by command):

Command	Count
EHLO www.censys.io	1
TOTAL: 1	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.comp.pecet	48
2	pl.comp.os.ms-windows.winnt	4
TOTAL: 2		52

Daily Usenet report

Nov 13 04:15:01 -- Nov 14 04:15:01