🥇PostgreSQL дээр түгжээний түүхийг авах аргуудын нэг

Нийтлэлийн үргэлжлэл "PostgreSQL-д зориулсан ASH-ийн аналогийг үүсгэх оролдлого ".

Нийтлэл нь pg_locks үзэх түүхийг ашиглан ямар хэрэгтэй мэдээллийг олж авах боломжтойг тодорхой асуулга, жишээн дээр авч үзэх болно.

Анхааруулга
Сэдвийн шинэлэг зүйл, туршилтын хугацаа бүрэн бус байгаа тул нийтлэлд алдаа гарч болзошгүй. Шүүмжлэл, санал хүсэлтийг хүлээн авч, хүлээж байна.

Оролтын мэдээлэл

pg_locks дүрслэлийн түүх

архивын_түгжих

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? бас энд - PostgreSQL-д зориулсан ASH-ийн аналогийг үүсгэх оролдлого.

Баганыг дүүргэхийн тулд queryid функцийг ашиглаж байна

Түүхийг_түгжихийг_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 хүснэгтэд шинэ хуваалт үүсгэгдсэн үед энэ утгыг түүхэн утгад хадгална.

Гаралт

Процессын талаархи ерөнхий мэдээлэл.

ТҮГЖЭЭРЭЭ ТҮГЖҮҮЛЭХИЙГ ХҮЛЭЭЖ БАЙНА

Хүсэлт гаргах

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

Жишээ нь:

| ТҮГЖЭЭРЭЭ ТҮГЖҮҮЛЭХИЙГ ХҮЛЭЭЖ БАЙНА +-------------------+----------------------- -------+-------------------- | locktype| горим| үргэлжлэх хугацаа +-------------------+--------------------- ---+-- ------------------ | гүйлгээ| sharelock| 19:39:26 | tuple| 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

Жишээ нь:

| ЦООЖИЙГ ЦООЖЭЭР АВАХ +-------------------+----------------------- -------+-------------------- | locktype| горим| үргэлжлэх хугацаа +-------------------+--------------------- ---+-- ------------------ | харилцаа| RowExclusiveLock| 51:11:10 | virtualxid| ExclusiveLock| 48:10:43 | гүйлгээ| ExclusiveLock| 44:24:53 | харилцаа| AccessShareLock| 20:06:13 | tuple| AccessExclusiveLock| 17:58:47 | tuple| ExclusiveLock| 01:40:41 | харилцаа| ShareUpdateExclusiveLock| 00:26:41 | объект| RowExclusiveLock| 00:00:01 | гүйлгээ| sharelock| 00:00:01 | сунгах| ExclusiveLock| 00:00:01 +--------------------+----------------------- -------+--------------------

Тодорхой queryid асуулгад зориулсан дэлгэрэнгүй мэдээлэл

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| locktype| горим| эхэлсэн| queryid| blocking_pids| үргэлжлэх хугацаа +----------+-------------------------+----------- ---------+------------------------------+--------- -----------+--------------------+----------------- --- | 11288| гүйлгээ| sharelock| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34 | 11626| гүйлгээ| sharelock| 2019-09-17 10:00:21.380921| 389015618226997618| {12380}| 00:00:29 | 11626| гүйлгээ| sharelock| 2019-09-17 10:00:21.380921| 389015618226997618| {11092}| 00:03:25 | 11626| гүйлгээ| sharelock| 2019-09-17 10:00:21.380921| 389015618226997618| {12213}| 00:01:55 | 11626| гүйлгээ| sharelock| 2019-09-17 10:00:21.380921| 389015618226997618| {12751}| 00:00:01 | 11629| гүйлгээ| sharelock| 2019-09-17 10:00:24.331935| 389015618226997618| {11092}| 00:03:22 | 11629| гүйлгээ| sharelock| 2019-09-17 10:00:24.331935| 389015618226997618| {12007}| 00:00:01 | 12007| гүйлгээ| sharelock| 2019-09-17 10:05:03.327933| 389015618226997618| {11629}| 00:00:13 | 12007| гүйлгээ| sharelock| 2019-09-17 10:05:03.327933| 389015618226997618| {11092}| 00:01:10 | 12007| гүйлгээ| sharelock| 2019-09-17 10:05:03.327933| 389015618226997618| {11288}| 00:00:05 | 12213| гүйлгээ| sharelock| 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| locktype| горим| эхэлсэн| 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| tuple| AccessExclusiveLock| 2019-09-17 10:00:00.302936| 389015618226997618| {11092}| 00:03:34

Гүйцэтгэлийн тохиолдлуудад дүн шинжилгээ хийхдээ хаах түүхийг ашиглах.

pid=389015618226997618 процессоор гүйцэтгэсэн queryid=11288 асуулга 2019-09-17-ны 10:00:00 цагаас хойш 3 минутын турш түгжигдэхийг хүлээж байна.
Түгжээг pid=11092-тай процессоор барьсан
11092-389015618226997618-2019-ны 09:17:10 цагаас хойш queryid=00-тай асуулга гүйцэтгэж байгаа pid=00 процесс нь түгжээг 3 минутын турш барьлаа.

Үр дүн

Одоо хамгийн сонирхолтой, хэрэгтэй зүйл эхлэх болно гэж найдаж байна - статистик мэдээлэл цуглуулах, хүлээлт, хаалтын түүхийн талаархи тохиолдлуудад дүн шинжилгээ хийх.

Ирээдүйд та ямар нэгэн тэмдэглэлийн багц (Oracle-ийн мета холбоостой төстэй) авах болно гэдэгт би итгэхийг хүсч байна.

Ерөнхийдөө ийм учраас ашиглаж буй аргачлалыг олон нийтэд таниулах зорилгоор аль болох хурдан харуулах болно.

Ойрын ирээдүйд би төслийг github дээр байрлуулахыг хичээх болно.

Эх сурвалж: www.habr.com

PostgreSQL дээр түгжээний түүхийг авах аргуудын нэг

Оролтын мэдээлэл

pg_locks дүрслэлийн түүх

Гаралт

ТҮГЖЭЭРЭЭ ТҮГЖҮҮЛЭХИЙГ ХҮЛЭЭЖ БАЙНА

ЦООЖИЙГ ТҮГЖЭЭР АВАХ

QUERYID-ээр цоожны төрлөөр түгжихийг хүлээж байна

QUERYID-ээр түгжээг АВАХ

Үр дүн

сэтгэгдэл нэмэх хариу цуцлах