Daily Usenet report: Apr 20 04:15:03

Unknown entries from news log file:

First 2 / 2 lines (100.0%)

Apr 20 18:44:09 newsfeed nnrpd[32723]: unable to get certificate from '/etc/news/cert.pem'
Apr 20 18:44:09 newsfeed nnrpd[32723]: 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	2283958	97.0%	259.0 MB	96.6%
innfeed	45891	1.9%	5.4 MB	2.0%
innd	18713	0.8%	3.3 MB	1.2%
nnrpd	4844	0.2%	514.1 KB	0.2%
TOTAL: 4	2353406	100.0%	268.3 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	2280300	98.8%
Negative hits	21552	0.9%
Positive hits	6999	0.3%
Cache misses	104	0.0%
TOTAL: 4	2308955	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:03.375	0.0%	210	0.000	16.071	470.000
article cleanup	00:00:32.966	0.0%	2283735	0.003	0.014	0.029
article logging	00:01:14.873	0.1%	2284226	0.013	0.033	0.983
article parse	01:17:32.533	5.4%	189950356	0.012	0.024	0.079
article write	00:28:58.862	2.0%	2281122	0.415	0.762	3.814
artlog/artcncl	00:00:00.004	0.0%	204	0.000	0.020	1.000
data move	00:02:56.067	0.2%	205654270	0.000	0.001	0.010
hisgrep/artcncl	00:00:00.201	0.0%	195	0.000	1.031	12.500
hishave/artcncl	00:00:00.132	0.0%	210	0.000	0.629	7.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:36:32.366	2.5%	2310430	0.115	0.949	14.477
history sync	00:00:00.016	0.0%	291	0.000	0.055	1.000
history write	00:50:13.247	3.5%	2281871	0.226	1.321	30.642
hiswrite/artcncl	00:00:00.021	0.0%	15	0.000	1.400	7.000
idle	13:00:11.308	54.2%	137956622	0.114	0.339	0.777
nntp read	01:17:01.846	5.3%	188153759	0.014	0.025	0.038
overview write	00:00:13.138	0.0%	2281122	0.000	0.006	0.013
perl filter	05:24:27.596	22.5%	2281871	5.675	8.531	12.427
python filter	00:00:00.000	0.0%	0	0.000	0.000	0.000
site send	00:04:14.559	0.3%	4607952	0.032	0.055	0.106
TOTAL: 24:00:12.115	23:04:13.110	96.1%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.259	0.0%	96879	0.000	0.003	0.083
article prepare	00:00:00.021	0.0%	87158	0.000	0.000	0.062
article read	00:01:01.074	0.1%	21768	0.000	2.806	2016.000
backlog stats	00:00:00.214	0.0%	277122	0.000	0.001	0.017
callbacks	00:00:00.000	0.0%	12	0.000	0.000	0.000
data read	00:00:02.098	0.0%	149062	0.000	0.014	0.119
data write	00:00:12.475	0.0%	108872	0.000	0.115	0.889
idle	23:57:20.814	99.9%	277122	27.982	311.202	1109.714
status file	00:00:14.184	0.0%	16067	0.167	0.883	69.667
TOTAL: 23:59:04.016	23:58:51.139	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	02:16:08.581	99.9%	3124	0.000	2614.783	450088.500
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.178	0.0%	7039	0.000	0.025	0.667
readart	00:00:00.446	0.0%	94	0.000	4.745	29.000
TOTAL: 02:16:20.565	02:16:09.205	99.9%	-	-	-	-

Control commands to INND:

Command	Number
L	1
flush	24
flushlogs	2
go	2
logmode	2
mode	149
name	2
pause	2
paused	2
reload	2
reserve	2
TOTAL: 11	190

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	855	2281204	2278619	296	2289	99%	301:25:13
2	news.nask.pl	0	6847	1778	4874	195	25%	12:17:13
3	news.icm.edu.pl	38	443	167	148	128	37%	17:24:15
4	localhost	1	0	0	0	0	0%	00:00:00
TOTAL: 4		894	2288494	2280564	5318	2612	99%	331:06:41

Incoming Volume (INN):

Server		AcceptVol	DupVol	RejVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	826.6 GB	82.2 MB	124.2 MB	826.8 GB	99%	380.1 KB
2	news.nask.pl	9.9 MB	748.8 KB	764.8 KB	11.3 MB	86%	5.9 KB
3	news.icm.edu.pl	8.7 MB	52.9 KB	2.4 MB	11.2 MB	78%	38.8 KB
4	localhost	0.0 KB	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 4		826.6 GB	82.9 MB	127.3 MB	826.8 GB	99%	379.7 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Apr 20 04:15:03 - 04:59:59	77267	3.4%	28.65	28.7 GB	3.5%	11168.65
Apr 20 05:00:00 - 05:59:59	102393	4.5%	28.44	38.6 GB	4.7%	11240.26
Apr 20 06:00:00 - 06:59:59	97818	4.3%	27.17	40.4 GB	4.9%	11761.44
Apr 20 07:00:00 - 07:59:59	103115	4.5%	28.64	40.7 GB	4.9%	11859.30
Apr 20 08:00:00 - 08:59:59	93972	4.1%	26.10	37.2 GB	4.5%	10822.35
Apr 20 09:00:00 - 09:59:59	85603	3.8%	23.78	30.7 GB	3.7%	8939.42
Apr 20 10:00:00 - 10:59:59	99999	4.4%	27.78	37.6 GB	4.5%	10953.46
Apr 20 11:00:00 - 11:59:59	94321	4.1%	26.20	30.7 GB	3.7%	8935.58
Apr 20 12:00:00 - 12:59:59	113942	5.0%	31.65	37.3 GB	4.5%	10866.70
Apr 20 13:00:00 - 13:59:59	114591	5.0%	31.83	37.7 GB	4.6%	10970.83
Apr 20 14:00:00 - 14:59:59	93029	4.1%	25.84	33.7 GB	4.1%	9828.91
Apr 20 15:00:00 - 15:59:59	107072	4.7%	29.74	35.1 GB	4.2%	10227.81
Apr 20 16:00:00 - 16:59:59	109956	4.8%	30.54	35.9 GB	4.3%	10460.01
Apr 20 17:00:00 - 17:59:59	116437	5.1%	32.34	37.3 GB	4.5%	10858.23
Apr 20 18:00:00 - 18:59:59	92925	4.1%	25.81	34.2 GB	4.1%	9967.92
Apr 20 19:00:00 - 19:59:59	95343	4.2%	26.48	36.9 GB	4.5%	10755.26
Apr 20 20:00:00 - 20:59:59	99943	4.4%	27.76	35.2 GB	4.3%	10258.36
Apr 20 21:00:00 - 21:59:59	90268	4.0%	25.07	29.1 GB	3.5%	8477.03
Apr 20 22:00:00 - 22:59:59	87049	3.8%	24.18	30.2 GB	3.7%	8805.20
Apr 20 23:00:00 - 23:59:59	88412	3.9%	24.56	34.0 GB	4.1%	9899.42
Apr 21 00:00:00 - 00:59:59	65047	2.9%	18.07	24.0 GB	2.9%	6978.54
Apr 21 01:00:00 - 01:59:59	72565	3.2%	20.16	28.1 GB	3.4%	8183.37
Apr 21 02:00:00 - 02:59:59	79038	3.5%	21.95	32.9 GB	4.0%	9590.07
Apr 21 03:00:00 - 03:59:59	80206	3.5%	22.28	32.9 GB	4.0%	9569.25
Apr 21 04:00:00 - 04:15:02	20341	0.9%	22.55	8.5 GB	1.0%	9925.43
TOTAL: 23:59:59	2280652	100.0%	26.40	827.6 GB	100.0%	10044.40

Sites sending bad articles:

Server		Total	Group	Duplic	Unapp	Other
1	newsfeed.pionier.net.pl	2762	119	1670	9	964
2	news.nask.pl	208	3	189	1	15
3	news.icm.edu.pl	132	0	3	0	129
TOTAL: 3		3102	122	1862	10	1108

Unwanted newsgroups [Top 20]:

Newsgroup	Count
uk.railway	49
it.tlc.cellulari.android	27
comp.mobile.android	19
it.comp.os.win.windows10	5
comp.sys.raspberry-pi	4
de.comp.lang.vbclassic	4
it.comp.os.win.windows8	3
de.comp.lang.php	3
uk.rec.cycling.moderated	2
it.comp.os.win.windows7	2
hr.ponuda.hardver.komponente	1
it.comp.os.linux.ubuntu	1
nl.comp.sys.android	1
hr.alt.cellular.gsm.android	1
TOTAL: 14	122

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

Groups	Count
pl.sci.historia	7
pl.praca.oferowana	3
TOTAL: 2	10

INND Perl filter [Top 20]:

Reason	Count
EMP (fsl)	352
Binary in non-binary group	139
EMP (md5)	125
HTML post	1
TOTAL: 4	617

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	Miss	Spool	%Took	Elapsed
1	icm	56854	8921	24728	10100	0	0	15%	24:05:48
2	panorama	58831	1523	30233	525	24	64685	2%	24:04:12
3	poznan	2980	29	1779	2	0	0	0%	18:12:28
4	okapi	0	0	0	0	0	2355	0%	24:00:00
5	nask	0	0	0	0	0	16063	0%	24:00:00
TOTAL: 5		118665	10473	56740	10627	24	83103	8%	114:22:28

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Volume/sec	Vol/Art	Elapsed
1	icm	1.5 GB	2.0 GB	3.5 GB	41.9 KB/s	191.2 KB	24:05:48
2	panorama	7.1 MB	3.0 MB	10.0 MB	0.1 KB/s	5.0 KB	24:04:12
3	poznan	212.7 KB	14.8 KB	227.5 KB	0.0 KB/s	7.3 KB	18:12:28
4	okapi	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
5	nask	0.0 KB	0.0 KB	0.0 KB	0.0 KB/s	0	24:00:00
TOTAL: 5		1.5 GB	2.0 GB	3.5 GB	8.9 KB/s	172.8 KB	114:22:28

Backlog files shrunk by innfeed:

Server	Size
okapi	488.3 KB
TOTAL: 1	488.3 KB

NNRP readership statistics:

System		Conn	Arts	Size	Groups	Elapsed
1	pc-212-51-218-225.p.lodz.pl	9	62	115.5 KB	8	02:14:16
2	web.man.lodz.pl	288	32	26.6 KB	15	00:00:31
TOTAL: 2		297	94	142.1 KB	23	02:16:20

NNRP readership statistics (by domain):

System		Conn	Arts	Size	Groups	Elapsed
1	*.p.lodz.pl	9	62	115.5 KB	8	02:14:16
2	*.man.lodz.pl	672	32	26.6 KB	15	00:00:35
3	unresolved	5	0	0.0 KB	0	00:01:27
4	*.208-100-26.static.steadfastdns.net	2	0	0.0 KB	0	00:00:01
TOTAL: 4		688	94	142.1 KB	23	02:16:20

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
pc-212-51-218-225.p.lodz.pl	0.040	0.158	02:14:16
212.51.203.199	0.012	0.025	00:01:22
web.man.lodz.pl	0.993	4.832	00:00:31
118.193.20.114	0.012	0.046	00:00:04
mon.man.lodz.pl	0.992	4.252	00:00:03
ip232.208-100-26.static.steadfastdns.net	0.005	0.037	00:00:01
david.man.lodz.pl	0.322	1.459	00:00:00
?	0.000	0.019	00:00:00
TOTAL: 8	2.376	10.828	02:16:20

Curious NNRP server explorers [Top 20]:

System	Conn
mon.man.lodz.pl	288
david.man.lodz.pl	96
118.193.20.114	3
ip232.208-100-26.static.steadfastdns.net	2
212.51.203.199	2
TOTAL: 5	391

NNRP gethostbyaddr failures [Top 20]:

System	Conn
? (can't getpeername)	1
TOTAL: 1	1

NNRP unrecognized commands (by host):

System	Conn
118.193.20.114	3
TOTAL: 1	3

NNRP unrecognized commands (by command):

Command	Count
À"À!	1
À/À+À'À#À#023À#011À#037À#036	1
#026#003#001#0018#001	1
TOTAL: 3	3

NNRP client timeouts [Top 20]:

System	Conn	Peer
pc-212-51-218-225.p.lodz.pl	3	0
118.193.20.114	1	1
TOTAL: 2	4	1

Newsgroup request counts (by category):

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

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

Newsgroup		Count
1	pl.misc.elektronika	40
2	pl.misc.kolej	22
3	pl.comp.pecet	16
4	pl.comp.os.ms-windows.winnt	16
TOTAL: 4		94

Daily Usenet report

Apr 20 04:15:03 -- Apr 21 04:15:02