ProHoster > وبلاگ > اداره > یکی از روش های دریافت تاریخچه قفل در PostgreSQL

یکی از روش های دریافت تاریخچه قفل در PostgreSQL

ادامه مقاله "تلاشی برای ایجاد آنالوگ ASH برای PostgreSQL ".

این مقاله بررسی می‌کند و در مورد پرسش‌ها و مثال‌های خاص نشان می‌دهد که چه اطلاعات مفیدی را می‌توان با استفاده از تاریخچه مشاهده pg_locks به دست آورد.

اخطار.
به دلیل جدید بودن موضوع و ناقص بودن دوره تست، ممکن است مقاله دارای خطا باشد. انتقاد و نظر قابل قبول و انتظار است.

داده های ورودی

تاریخچه نمایش 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 
);

اساساً جدول مشابه جدول است archive_pg_stat_activityدر اینجا با جزئیات بیشتر توضیح داده شده است - pg_stat_statements + pg_stat_activity + loq_query = pg_ash؟ و اینجا - تلاشی برای ایجاد آنالوگ ASH برای PostgreSQL.

برای پر کردن یک ستون پرس و جو تابع استفاده می شود

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;

توضیح: مقدار ستون queryid در جدول history_locking به روز می شود، و سپس زمانی که یک پارتیشن جدید برای جدول archive_locking ایجاد می شود، مقدار در مقادیر تاریخی ذخیره می شود.

خروجی

اطلاعات کلی در مورد فرآیندها به طور کلی.

انتظار برای قفل بر اساس LOCKTYPES

درخواست

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

مثال

| انتظار برای قفل بر اساس قفل +------------------------------------------- -------+-------------------- | نوع قفل| حالت| مدت +----------------------------------------------- ------------------ | معامله شده| سهام قفل| 19:39:26 | تاپل| AccessExclusiveLock| 00:03:35 +--------------------------------------------- -------+--------------------

گرفتن قفل بر اساس نوع قفل

درخواست

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

مثال

| گرفتن قفل بر اساس نوع قفل +------------------------------------------- -------+-------------------- | نوع قفل| حالت| مدت +----------------------------------------------- ------------------ | رابطه| RowExclusiveLock| 51:11:10 | virtualxid| ExclusiveLock| 48:10:43 | معامله شده| ExclusiveLock| 44:24:53 | رابطه| AccessShareLock| 20:06:13 | تاپل| AccessExclusiveLock| 17:58:47 | تاپل| ExclusiveLock| 01:40:41 | رابطه| ShareUpdateExclusiveLock| 00:26:41 | شیء| RowExclusiveLock| 00:00:01 | معامله شده| سهام قفل| 00:00:01 | تمدید| ExclusiveLock| 00:00:01 +-------------------------------------------- -------+--------------------

اطلاعات دقیق برای پرس و جوهای خاص

انتظار برای قفل بر اساس نوع قفل توسط QUERYID

درخواست

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

مثال

| انتظار برای قفل بر اساس نوع قفل توسط QUERYID +----------+------------------------------- -------------------------------------------------- ------------------------------------------------- --------- | pid| نوع قفل| حالت| شروع شد| queryid| blocking_pids| مدت +---------+------------------------------------ ---------+-------------------------------------- ---+------------------------------------- --- | 11288| معامله شده| سهام قفل| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11626| معامله شده| سهام قفل| 2019-09-17 10:00:21.380921| 389015618226997618| {12380}| 00:00:29 | 11626| معامله شده| سهام قفل| 2019-09-17 10:00:21.380921| 389015618226997618| {11092}| 00:03:25 | 11626| معامله شده| سهام قفل| 2019-09-17 10:00:21.380921| 389015618226997618| {12213}| 00:01:55 | 11626| معامله شده| سهام قفل| 2019-09-17 10:00:21.380921| 389015618226997618| {12751}| 00:00:01 | 11629| معامله شده| سهام قفل| 2019-09-17 10:00:24.331935| 389015618226997618| {11092}| 00:03:22 | 11629| معامله شده| سهام قفل| 2019-09-17 10:00:24.331935| 389015618226997618| {12007}| 00:00:01 | 12007| معامله شده| سهام قفل| 2019-09-17 10:05:03.327933| 389015618226997618| {11629}| 00:00:13 | 12007| معامله شده| سهام قفل| 2019-09-17 10:05:03.327933| 389015618226997618| {11092}| 00:01:10 | 12007| معامله شده| سهام قفل| 2019-09-17 10:05:03.327933| 389015618226997618| {11288}| 00:00:05 | 12213| معامله شده| سهام قفل| 2019-09-17 10:06:07.328019| 389015618226997618| {12007}| 00:00:10

گرفتن قفل بر اساس نوع قفل توسط QUERYID

درخواست

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

مثال

| گرفتن قفل بر اساس نوع قفل توسط QUERYID +------------------------------------------- --------------------------------------------------- -+-------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------| pid| نوع قفل| حالت| شروع شد| queryid| blocking_pids| مدت +---------+------------------------------------ ---------+-------------------------------------- ---+------------------------------------- --- | 11288| رابطه| RowExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11092| معامله شده| ExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {}| 00:03:34 | 11288| رابطه| RowExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {}| 00:00:10 | 11092| رابطه| RowExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {}| 00:03:34 | 11092| virtualxid| ExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {}| 00:03:34 | 11288| virtualxid| ExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11288| معامله شده| ExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11288| تاپل| AccessExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34

استفاده از تاریخچه مسدود کردن هنگام تجزیه و تحلیل حوادث عملکرد.

  1. یک پرس و جو با queryid=389015618226997618 که توسط فرآیندی با pid=11288 اجرا شده است از 2019/09/17 ساعت 10:00:00 به مدت 3 دقیقه منتظر قفل است.
  2. قفل توسط فرآیندی با pid=11092 نگه داشته شد
  3. فرآیندی با pid=11092 اجرای یک پرس و جو با queryid=389015618226997618 از 2019-09-17 ساعت 10:00:00 قفل را به مدت 3 دقیقه نگه داشت.

مجموع

اکنون، امیدوارم جالب ترین و مفیدترین کار آغاز شود - جمع آوری آمار و تجزیه و تحلیل موارد در مورد تاریخچه انتظارات و مسدود کردن.

در آینده، من می خواهم باور کنم، مجموعه ای از نوعی یادداشت (شبیه به متالینک اوراکل) دریافت خواهید کرد.

به طور کلی، به همین دلیل است که روش مورد استفاده در سریع ترین زمان ممکن برای آشنایی عمومی نمایش داده می شود.

در آینده نزدیک سعی خواهم کرد پروژه را در github قرار دهم.

منبع: www.habr.com

اضافه کردن نظر