Daily Usenet report: Jan 27 04:15:01

Unknown entries from news log file:

First 8 / 8 lines (100.0%)

Jan 27 19:30:23 newsfeed pgpverify[2121815]: pgpverify: verification failed
Jan 27 19:30:23 newsfeed pgpverify[2121815]: pgpverify: verification failed
Jan 27 19:30:23 newsfeed controlchan[2011194]: skipping newgroup y control@usenet-fr.news.eu.org (pgpverify failed) in <newgroup-fr.rec.divers-1769538210@news.trigofacile.com>
Jan 27 19:30:23 newsfeed controlchan[2011194]: skipping newgroup y control@usenet-fr.news.eu.org (pgpverify failed) in <newgroup-fr.rec.divers-1769538210@news.trigofacile.com>
Jan 27 19:32:25 newsfeed pgpverify[2121842]: pgpverify: verification failed
Jan 27 19:32:25 newsfeed pgpverify[2121842]: pgpverify: verification failed
Jan 27 23:05:46 newsfeed pgpverify[2152090]: pgpverify: verification failed
Jan 27 23:05:46 newsfeed pgpverify[2152090]: pgpverify: verification failed

Log entries by program:

Program name	Lines	%Lines	Size	%Size
inn	172818	81.2%	19.3 MB	83.4%
innd	22126	10.4%	2.1 MB	9.2%
nnrpd	16238	7.6%	1.5 MB	6.6%
innfeed	1540	0.7%	179.8 KB	0.8%
controlchan	48	0.0%	11.0 KB	0.0%
pgpverify	6	0.0%	0.6 KB	0.0%
overchan	2	0.0%	0.3 KB	0.0%
TOTAL: 7	212778	100.0%	23.1 MB	100.0%

History cache:

Reason	Count	%Count
Do not exist	342842	99.7%
Negative hits	894	0.3%
Positive hits	180	0.1%
Cache misses	14	0.0%
TOTAL: 4	343930	100.0%

INND timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article cancel	00:00:00.016	0.0%	100	0.000	0.160	3.000
article cleanup	00:00:00.914	0.0%	344042	0.000	0.003	0.009
article logging	00:00:04.168	0.0%	344150	0.005	0.012	0.029
article parse	00:00:06.476	0.0%	1232678	0.002	0.005	0.010
article write	00:00:12.232	0.0%	343996	0.020	0.036	0.099
artlog/artcncl	00:00:00.000	0.0%	14	0.000	0.000	0.000
data move	00:00:00.872	0.0%	1764140	0.000	0.000	0.002
hisgrep/artcncl	00:00:00.010	0.0%	114	0.000	0.088	1.000
hishave/artcncl	00:00:00.000	0.0%	14	0.000	0.000	0.000
history grep	00:00:00.000	0.0%	0	0.000	0.000	0.000
history lookup	00:00:24.748	0.0%	345070	0.000	0.072	3.138
history sync	00:01:09.538	0.0%	778	0.000	89.380	11585.667
history write	00:00:46.938	0.0%	343996	0.032	0.136	1.353
idle	47:54:06.064	99.7%	1490216	67.248	115.719	755.288
nntp read	00:00:09.674	0.0%	1183610	0.005	0.008	0.016
overview write	00:00:00.456	0.0%	343996	0.000	0.001	0.007
perl filter	00:02:58.180	0.1%	343996	0.345	0.518	0.908
python filter	00:00:00.040	0.0%	343996	0.000	0.000	0.004
site send	00:00:04.840	0.0%	707128	0.003	0.007	0.015
TOTAL: 48:02:01.180	48:00:05.166	99.9%	-	-	-	-

INNfeed timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
article new	00:00:00.032	0.0%	19120	0.000	0.002	0.038
article prepare	00:00:00.000	0.0%	1376	0.000	0.000	0.000
article read	00:00:00.008	0.0%	344	0.000	0.023	1.000
backlog stats	00:00:00.024	0.0%	105092	0.000	0.000	0.007
callbacks	00:00:00.000	0.0%	0	0.000	0.000	0.000
data read	00:00:00.304	0.0%	52694	0.000	0.006	0.029
data write	00:00:00.862	0.0%	32588	0.000	0.026	0.100
idle	47:54:49.910	100.0%	105092	505.182	1641.323	4440.383
status file	00:00:00.714	0.0%	434	0.000	1.645	204.000
TOTAL: 47:54:52.750	47:54:51.854	100.0%	-	-	-	-

nnrpd timer:

Code region	Time	Pct	Invoked	Min(ms)	Avg(ms)	Max(ms)
idle	00:03:37.444	82.5%	8940	0.000	24.323	10037.000
newnews	00:00:00.000	0.0%	0	0.000	0.000	0.000
nntpwrite	00:00:00.370	0.1%	30318	0.000	0.012	0.500
TOTAL: 00:04:23.590	00:03:37.814	82.6%	-	-	-	-

Control commands to INND:

Command	Number
flush	54
flushlogs	4
go	4
logmode	4
lowmark	2
mode	298
name	4
pause	4
paused	4
reload	4
reserve	4
TOTAL: 11	386

Control Channel:

Sender	Other	Bad PGP	OK
control@usenet-fr.news.eu.org	2	2	2
nl-admin@nic.surfnet.nl	2	2	2
TOTAL	4	4	4

Incoming Feeds (INN):

Server		Connects	Offered	Taken	Refused	Reject	%Accpt	Elapsed
1	newsfeed.pionier.net.pl	180	345324	345268	16	40	99%	76:51:48
2	news.icm.edu.pl	116	170	46	118	6	27%	23:38:22
3	localhost	2	0	0	0	0	0%	00:00:00
TOTAL: 3		298	345494	345314	134	46	99%	100:30:10

Incoming Volume (INN):

Server		AcceptVol	DupVol	TotalVol	%Acc	Vol/Art
1	newsfeed.pionier.net.pl	3.5 GB	952.2 KB	3.5 GB	99%	10.6 KB
2	news.icm.edu.pl	2.1 MB	95.0 KB	2.2 MB	95%	43.3 KB
3	localhost	0.0 KB	0.0 KB	0.0 KB	0%	0
TOTAL: 3		3.5 GB	1.0 MB	3.5 GB	99%	10.6 KB

Incoming articles:

Date	Articles	%Arts	Art/sec	Size	%Size	KB/sec
Jan 27 04:15:01 - 04:59:59	5227	3.0%	1.94	54.0 MB	3.0%	20.49
Jan 27 05:00:00 - 05:59:59	6221	3.6%	1.73	68.0 MB	3.8%	19.35
Jan 27 06:00:00 - 06:59:59	5499	3.2%	1.53	60.3 MB	3.4%	17.14
Jan 27 07:00:00 - 07:59:59	7753	4.5%	2.15	52.4 MB	2.9%	14.89
Jan 27 08:00:00 - 08:59:59	5968	3.5%	1.66	57.1 MB	3.2%	16.23
Jan 27 09:00:00 - 09:59:59	7534	4.4%	2.09	75.8 MB	4.3%	21.57
Jan 27 10:00:00 - 10:59:59	5180	3.0%	1.44	63.0 MB	3.5%	17.92
Jan 27 11:00:00 - 11:59:59	6555	3.8%	1.82	66.4 MB	3.7%	18.89
Jan 27 12:00:00 - 12:59:59	9968	5.8%	2.77	68.8 MB	3.9%	19.58
Jan 27 13:00:00 - 13:59:59	6725	3.9%	1.87	79.2 MB	4.4%	22.52
Jan 27 14:00:00 - 14:59:59	6021	3.5%	1.67	65.2 MB	3.7%	18.56
Jan 27 15:00:00 - 15:59:59	6780	3.9%	1.88	84.8 MB	4.8%	24.13
Jan 27 16:00:00 - 16:59:59	7358	4.3%	2.04	97.1 MB	5.4%	27.61
Jan 27 17:00:00 - 17:59:59	7413	4.3%	2.06	88.7 MB	5.0%	25.22
Jan 27 18:00:00 - 18:59:59	9050	5.2%	2.51	108.4 MB	6.1%	30.83
Jan 27 19:00:00 - 19:59:59	5452	3.2%	1.51	66.1 MB	3.7%	18.79
Jan 27 20:00:00 - 20:59:59	7554	4.4%	2.10	83.2 MB	4.7%	23.66
Jan 27 21:00:00 - 21:59:59	8116	4.7%	2.25	80.5 MB	4.5%	22.90
Jan 27 22:00:00 - 22:59:59	7737	4.5%	2.15	89.2 MB	5.0%	25.36
Jan 27 23:00:00 - 23:59:59	9151	5.3%	2.54	89.7 MB	5.0%	25.51
Jan 28 00:00:00 - 00:59:59	11048	6.4%	3.07	89.5 MB	5.0%	25.46
Jan 28 01:00:00 - 01:59:59	3594	2.1%	1.00	32.3 MB	1.8%	9.18
Jan 28 02:00:00 - 02:59:59	8884	5.1%	2.47	87.8 MB	4.9%	24.96
Jan 28 03:00:00 - 03:59:59	5656	3.3%	1.57	59.0 MB	3.3%	16.78
Jan 28 04:00:00 - 04:15:01	2290	1.3%	2.54	15.0 MB	0.8%	17.03
TOTAL: 24:00:00	172734	100.0%	2.00	1.7 GB	100.0%	21.11

Sites sending bad articles:

Server		Total	Duplic	Other
1	newsfeed.pionier.net.pl	74	20	54
2	news.icm.edu.pl	3	3	0
TOTAL: 2		77	23	54

Miscellaneous innd statistics [Top 10]:

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

Outgoing Feeds (innfeed) by Articles:

Server		Offered	Taken	Refused	Reject	%Took	Elapsed
1	icm	34966	288	18734	56	0%	47:58:38
2	poznan	68	0	46	0	0%	07:39:00
TOTAL: 2		35034	288	18780	56	0%	55:37:38

Outgoing Feeds (innfeed) by Volume:

Server		AcceptVol	RejectVol	TotalVol	Vol/Art	Elapsed
1	icm	404.6 KB	615.4 KB	1020.0 KB	3.0 KB	47:58:38
2	poznan	0.0 KB	0.0 KB	0.0 KB	0	07:39:00
TOTAL: 2		404.6 KB	615.4 KB	1020.0 KB	3.0 KB	55:37:38

NNRP readership statistics:

System		Conn	Elapsed
1	zl-dala-us-gp1-wk134c.internet-census.org	2	00:00:21
2	198.235.24.220	2	00:00:00
3	66.61.98.95	16	00:00:14
4	205.210.31.38	2	00:00:04
5	sh-chi-us-cpp-wk106.internet-census.org	4	00:00:08
6	147.185.132.112	2	00:00:02
7	113.34.168.206.censys-scanner.com	2	00:00:02
8	o308.scanner.modat.io	2	00:00:00
9	prod52client01.academyforinternetresearch.org	120	00:01:21
10	82.147.84.134	2	00:00:03
11	nms2.man.lodz.pl	2880	00:00:22
12	azpdcsnhalu2.stretchoid.com	4	00:00:20
13	60.138.94.167.censys-scanner.com	8	00:00:26
14	80.111.142.213	8	00:00:05
15	172.16.2.4	576	00:00:33
16	sh-ams-nl-cpp-wk103.internet-census.org	4	00:00:08
17	zl-laxd-us-cpp-wk110.internet-census.org	4	00:00:08
TOTAL: 17		3638	00:04:24

NNRP readership statistics (by domain):

System		Conn	Elapsed
1	*.academyforinternetresearch.org	120	00:01:21
2	*.internet-census.org	14	00:00:47
3	*.stretchoid.com	4	00:00:20
4	*.scanner.modat.io	2	00:00:00
5	unresolved	608	00:01:04
6	*.34.168.206.censys-scanner.com	2	00:00:02
7	*.138.94.167.censys-scanner.com	8	00:00:26
8	*.man.lodz.pl	2880	00:00:22
TOTAL: 8		3638	00:04:24

NNRP total resource statistics [Top 20]:

System	User(ms)	System(ms)	Elapsed
prod52client01.academyforinternetresearch.org	3.538	0.634	00:01:21
172.16.2.4	1.282	2.802	00:00:33
60.138.94.167.censys-scanner.com	0.018	0.040	00:00:26
nms2.man.lodz.pl	5.892	13.126	00:00:22
zl-dala-us-gp1-wk134c.internet-census.org	0.004	0.010	00:00:21
azpdcsnhalu2.stretchoid.com	0.016	0.012	00:00:20
66.61.98.95	0.026	0.082	00:00:14
zl-laxd-us-cpp-wk110.internet-census.org	0.006	0.020	00:00:08
sh-chi-us-cpp-wk106.internet-census.org	0.006	0.022	00:00:08
sh-ams-nl-cpp-wk103.internet-census.org	0.008	0.018	00:00:08
80.111.142.213	0.028	0.028	00:00:05
205.210.31.38	0.006	0.006	00:00:04
82.147.84.134	0.002	0.012	00:00:03
113.34.168.206.censys-scanner.com	0.064	0.010	00:00:02
147.185.132.112	0.004	0.010	00:00:02
o308.scanner.modat.io	0.002	0.010	00:00:00
198.235.24.220	0.002	0.012	00:00:00
TOTAL: 17	10.904	16.854	00:04:24

NNRP unrecognized commands (by host) [Top 20]:

System	Conn
azpdcsnhalu2.stretchoid.com	2
113.34.168.206.censys-scanner.com	2
TOTAL: 2	4

NNRP unrecognized commands (by command) [Top 20]:

Command	Count
EHLO www.censys.io	2
MGLNDD_212.191.2.21_119	2
TOTAL: 2	4

NNRP client timeouts [Top 20]:

System	Conn	Peer
60.138.94.167.censys-scanner.com	2	8
prod52client01.academyforinternetresearch.org	2	2
TOTAL: 2	4	18

Daily Usenet report

Jan 27 04:15:01 -- Jan 28 04:15:01