Một trong những phương pháp lấy lịch sử khóa trong PostgreSQL

Tiếp tục bài viết "Nỗ lực tạo một dạng tương tự của ASH cho PostgreSQL ".

Bài viết sẽ xem xét và hiển thị trên các truy vấn và ví dụ cụ thể những thông tin hữu ích nào có thể thu được bằng cách sử dụng lịch sử xem pg_locks.

Cảnh báo
Do tính mới của đề tài và chưa hoàn thiện trong thời gian thử nghiệm nên bài viết có thể còn sai sót. Phê bình và bình luận được hoan nghênh và mong đợi.

Dữ liệu đầu vào

lịch sử đại diện pg_locks

archive_locking

CREATE TABLE archive_locking 
(       timepoint timestamp without time zone ,
	locktype text ,
	relation oid ,
	mode text ,
	tid xid ,
	vtid text ,
	pid integer ,
	blocking_pids integer[] ,
	granted boolean ,
        queryid bigint 
);

Về cơ bản, bảng tương tự như bảng archive_pg_stat_activityđược mô tả chi tiết hơn ở đây - pg_stat_statements + pg_stat_activity + loq_query = pg_ash? và đây - Nỗ lực tạo ra một dạng tương tự của ASH cho PostgreSQL.

Để điền vào một cột truy vấn chức năng được sử dụng

update_history_locking_by_queryid

--update_history_locking_by_queryid.sql
CREATE OR REPLACE FUNCTION update_history_locking_by_queryid() RETURNS boolean AS $$
DECLARE
  result boolean ;
  current_minute double precision ; 
  
  start_minute integer ;
  finish_minute integer ;
  
  start_period timestamp without time zone ;
  finish_period timestamp without time zone ;
  
  lock_rec record ; 
  endpoint_rec record ; 
  
  current_hour_diff double precision ;
BEGIN
  RAISE NOTICE '***update_history_locking_by_queryid';
  
  result = TRUE ;
  
  current_minute = extract ( minute from now() );

  SELECT * FROM endpoint WHERE is_need_monitoring
  INTO endpoint_rec ;
  
  current_hour_diff = endpoint_rec.hour_diff ;
  
  IF current_minute < 5 
  THEN
	RAISE NOTICE 'Current time is less than 5 minute.';
	
	start_period = date_trunc('hour',now()) + (current_hour_diff * interval '1 hour');
    finish_period = start_period - interval '5 minute' ;
  ELSE 
    finish_minute =  extract ( minute from now() ) / 5 ;
    start_minute =  finish_minute - 1 ;
  
    start_period = date_trunc('hour',now()) + interval '1 minute'*start_minute*5+(current_hour_diff * interval '1 hour');
    finish_period = date_trunc('hour',now()) + interval '1 minute'*finish_minute*5+(current_hour_diff * interval '1 hour') ;
    
  END IF ;  
  
  RAISE NOTICE 'start_period = %', start_period;
  RAISE NOTICE 'finish_period = %', finish_period;

	FOR lock_rec IN   
	WITH act_queryid AS
	 (
		SELECT 
				pid , 
				timepoint ,
				query_start AS started ,			
				MAX(timepoint) OVER (PARTITION BY pid ,	query_start   ) AS finished ,			
				queryid 
		FROM 
				activity_hist.history_pg_stat_activity 			
		WHERE 			
				timepoint BETWEEN start_period and 
								  finish_period
		GROUP BY 
				pid , 
				timepoint ,  
				query_start ,
				queryid 
	 ),
	 lock_pids AS
		(
			SELECT
				hl.pid , 
				hl.locktype  ,
				hl.mode ,
				hl.timepoint , 
				MIN ( timepoint ) OVER (PARTITION BY pid , locktype  ,mode ) as started 
			FROM 
				activity_hist.history_locking hl
			WHERE 
				hl.timepoint between start_period and 
								     finish_period
			GROUP BY 
				hl.pid , 
				hl.locktype  ,
				hl.mode ,
				hl.timepoint 
		)
	SELECT 
		lp.pid , 
		lp.locktype  ,
		lp.mode ,
		lp.timepoint ,     
		aq.queryid 
	FROM lock_pids 	lp LEFT OUTER JOIN act_queryid aq ON ( lp.pid = aq.pid AND lp.started BETWEEN aq.started AND aq.finished )
	WHERE aq.queryid IS NOT NULL 
	GROUP BY  
		lp.pid , 
		lp.locktype  ,
		lp.mode ,
		lp.timepoint , 
		aq.queryid
	LOOP
		UPDATE activity_hist.history_locking SET queryid = lock_rec.queryid 
		WHERE pid = lock_rec.pid AND locktype = lock_rec.locktype AND mode = lock_rec.mode AND timepoint = lock_rec.timepoint ;	
	END LOOP;    
  
  RETURN result ;
END
$$ LANGUAGE plpgsql;

Giải thích: giá trị của cột queryid được cập nhật trong bảng history_locking, sau đó khi một phân vùng mới được tạo cho bảng archive_locking, giá trị sẽ được lưu trữ trong các giá trị lịch sử.

Выходные данные

Thông tin chung về các quy trình nói chung.

CHỜ KHÓA BẰNG LOCKTYPES

Yêu cầu

WITH
t AS
(
	SELECT 
		locktype  ,
		mode ,
		count(*) as total 
	FROM 
		activity_hist.archive_locking
	WHERE 
		timepoint between pg_stat_history_begin+(current_hour_diff * interval '1 hour') AND pg_stat_history_end+(current_hour_diff * interval '1 hour') AND 
		NOT granted
	GROUP BY 
		locktype  ,
		mode  
)
SELECT 
	locktype  ,
	mode ,
	total * interval '1 second' as duration			
FROM t 		
ORDER BY 3 DESC 

Ví dụ

| CHỜ KHÓA BẰNG LOCKTYPES +--------------------+-------------------- -------------------------- | loại khóa| chế độ| thời lượng +----------+--------------------- ---+-- ------------------ | mã giao dịch| khóa chia sẻ| 19:39:26 | tuple| Truy cập ExclusiveLock| 00:03:35 +--------------------+----------------------- --------+--------------------

LẤY KHÓA BẰNG CÁC LOẠI KHÓA

Yêu cầu

WITH
t AS
(
	SELECT 
		locktype  ,
		mode ,
		count(*) as total 
	FROM 
		activity_hist.archive_locking
	WHERE 
		timepoint between pg_stat_history_begin+(current_hour_diff * interval '1 hour') AND pg_stat_history_end+(current_hour_diff * interval '1 hour') AND 
		granted
	GROUP BY 
		locktype  ,
		mode  
)
SELECT 
	locktype  ,
	mode ,
	total * interval '1 second' as duration			
FROM t 		
ORDER BY 3 DESC 

Ví dụ

| LẤY KHÓA BẰNG CÁC LOẠI KHÓA +--------------------+-------------------- -------------------------- | loại khóa| chế độ| thời lượng +----------+--------------------- ---+-- ------------------ | quan hệ| HàngĐộc quyềnKhóa| 51:11:10 | ảoxid| Khóa độc quyền| 48:10:43 | mã giao dịch| Khóa độc quyền| 44:24:53 | quan hệ| AccessShareLock| 20:06:13 | tuple| Truy cập ExclusiveLock| 17:58:47 | tuple| Khóa độc quyền| 01:40:41 | quan hệ| Chia sẻCập nhậtĐộc quyềnKhóa| 00:26:41 | đối tượng| HàngĐộc quyềnKhóa| 00:00:01 | mã giao dịch| khóa chia sẻ| 00:00:01 | mở rộng| Khóa độc quyền| 00:00:01 +------------------+----------------------- --------+--------------------

Thông tin chi tiết cho các truy vấn queryid cụ thể

CHỜ KHÓA BẰNG LOCKTYPES BẰNG QUERYID

Yêu cầu

WITH
lt AS
(
	SELECT
		pid , 
		locktype  ,
		mode ,
		timepoint , 
		queryid , 
		blocking_pids ,
                MIN ( timepoint ) OVER (PARTITION BY pid , locktype  ,mode ) as started  
	FROM 
		activity_hist.archive_locking
	WHERE 
		timepoint between pg_stat_history_begin+(current_hour_diff * interval '1 hour') AND 
			                  pg_stat_history_end+(current_hour_diff * interval '1 hour') AND 
		NOT granted AND
	       queryid IS NOT NULL 
	GROUP BY 
	        pid , 
		locktype  ,
		mode ,
		timepoint ,
		queryid ,
		blocking_pids 
)
SELECT 
        lt.pid , 
	lt.locktype  ,
	lt.mode ,			
        lt.started ,
	lt.queryid  ,
	lt.blocking_pids ,
	COUNT(*)  * interval '1 second'	 as duration		
FROM lt 	
GROUP BY 
	lt.pid , 
        lt.locktype  ,
	lt.mode ,			
        lt.started ,
        lt.queryid ,
	lt.blocking_pids 
ORDER BY 4

Ví dụ

| CHỜ ĐỢI KHÓA BẰNG KHÓA BẰNG QUERYID +----------+----------------------+------ ----------+-----------------------------------+--- ------+---------------------+---------- - --------- | pid | loại khóa| chế độ| bắt đầu| truy vấn| block_pids| thời lượng +-----------+-------------------------+------------ ---------+------------------------------+--------- ---+---------------------+----------------- --- | 11288| mã giao dịch| khóa chia sẻ| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11626| mã giao dịch| khóa chia sẻ| 2019-09-17 10:00:21.380921| 389015618226997618| {12380}| 00:00:29 | 11626| mã giao dịch| khóa chia sẻ| 2019-09-17 10:00:21.380921| 389015618226997618| {11092}| 00:03:25 | 11626| mã giao dịch| khóa chia sẻ| 2019-09-17 10:00:21.380921| 389015618226997618| {12213}| 00:01:55 | 11626| mã giao dịch| khóa chia sẻ| 2019-09-17 10:00:21.380921| 389015618226997618| {12751}| 00:00:01 | 11629| mã giao dịch| khóa chia sẻ| 2019-09-17 10:00:24.331935| 389015618226997618| {11092}| 00:03:22 | 11629| mã giao dịch| khóa chia sẻ| 2019-09-17 10:00:24.331935| 389015618226997618| {12007}| 00:00:01 | 12007| mã giao dịch| khóa chia sẻ| 2019-09-17 10:05:03.327933| 389015618226997618| {11629}| 00:00:13 | 12007| mã giao dịch| khóa chia sẻ| 2019-09-17 10:05:03.327933| 389015618226997618| {11092}| 00:01:10 | 12007| mã giao dịch| khóa chia sẻ| 2019-09-17 10:05:03.327933| 389015618226997618| {11288}| 00:00:05 | 12213| mã giao dịch| khóa chia sẻ| 2019-09-17 10:06:07.328019| 389015618226997618| {12007}| 00:00:10

LẤY KHÓA BẰNG LOCKTYPES BẰNG QUERYID

Yêu cầu

WITH
lt AS
(
	SELECT
		pid , 
		locktype  ,
		mode ,
		timepoint , 
		queryid , 
		blocking_pids ,
                MIN ( timepoint ) OVER (PARTITION BY pid , locktype  ,mode ) as started  
	FROM 
		activity_hist.archive_locking
	WHERE 
		timepoint between pg_stat_history_begin+(current_hour_diff * interval '1 hour') AND 
			                  pg_stat_history_end+(current_hour_diff * interval '1 hour') AND 
		granted AND
		queryid IS NOT NULL 
	GROUP BY 
	        pid , 
		locktype  ,
		mode ,
		timepoint ,
		queryid ,
		blocking_pids 
)
SELECT 
        lt.pid , 
	lt.locktype  ,
	lt.mode ,			
        lt.started ,
	lt.queryid  ,
	lt.blocking_pids ,
	COUNT(*)  * interval '1 second'	 as duration			
FROM lt 	
GROUP BY 
	lt.pid , 
	lt.locktype  ,
	lt.mode ,			
        lt.started ,
	lt.queryid ,
	lt.blocking_pids 
ORDER BY 4

Ví dụ

| LẤY KHÓA THEO LOCKTYPES BẰNG QUERYID +-----------+----------------------------------+------ --------------+----------------------------------+----- -+---------------------+-------- -------- | pid | loại khóa| chế độ| bắt đầu| truy vấn| block_pids| thời lượng +-----------+-------------------------+------------ ---------+------------------------------+--------- ---+---------------------+----------------- --- | 11288| quan hệ| HàngĐộc quyềnKhóa| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11092| mã giao dịch| Khóa độc quyền| 2019-09-17 10:00:00.302936| 389015618226997618| {}| 00:03:34 | 11288| quan hệ| HàngĐộc quyềnKhóa| 2019-09-17 10:00:00.302936| 389015618226997618| {}| 00:00:10 | 11092| quan hệ| HàngĐộc quyềnKhóa| 2019-09-17 10:00:00.302936| 389015618226997618| {}| 00:03:34 | 11092| ảoxid| Khóa độc quyền| 2019-09-17 10:00:00.302936| 389015618226997618| {}| 00:03:34 | 11288| ảoxid| Khóa độc quyền| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11288| mã giao dịch| Khóa độc quyền| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11288| tuple| Truy cập ExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34

Sử dụng lịch sử chặn khi phân tích sự cố hiệu suất.

  1. Một truy vấn có queryid=389015618226997618 được thực thi bởi một quy trình có pid=11288 đã chờ khóa kể từ 2019-09-17 10:00:00 trong 3 phút.
  2. Khóa được giữ bởi một quá trình với pid=11092
  3. Một quy trình với pid=11092 đang thực thi một truy vấn với queryid=389015618226997618 kể từ 2019-09-17 10:00:00 đã giữ khóa trong 3 phút.

Tổng

Bây giờ, tôi hy vọng, điều thú vị và hữu ích nhất sẽ bắt đầu - thu thập số liệu thống kê và phân tích các trường hợp về lịch sử của các kỳ vọng và chặn.

Trong tương lai, tôi muốn tin rằng, bạn sẽ nhận được một bộ ghi chú nào đó (tương tự như metalink của Oracle).

Nói chung, chính vì lý do này mà phương pháp được sử dụng được hiển thị càng nhanh càng tốt để công chúng làm quen.

Trong thời gian tới tôi sẽ cố gắng đưa dự án lên github.

Nguồn: www.habr.com

Thêm một lời nhận xét