ProHoster > Blog > Administrare > Una dintre metodele de obținere a istoricului blocajelor în PostgreSQL

Una dintre metodele de obținere a istoricului blocajelor în PostgreSQL

Continuarea articolului „Încercarea de a crea un analog ASH pentru PostgreSQL «.

Articolul va analiza și va ilustra, prin interogări și exemple specifice, ce informații utile se pot obține din istoria vizualizării pg_locks.

Atenție.
Datorită noutății subiectului și nefinalizării perioadei de testare, articolul poate conține erori. Criticile și comentariile sunt binevenite și așteptate.

Date de intrare

Istoria vizualizării 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 
);

Practic, tabela este similară cu tabela archive_pg_stat_activity, detaliată mai jos — pg_stat_statements + pg_stat_activity + loq_query = pg_ash? și aici — Încercarea de a crea un echivalent ASH pentru PostgreSQL.

Pentru a completa coloana queryid se utilizează funcția

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 'Ora curentă este mai mică de 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;

Explicație: Valoarea coloanei queryid este actualizată în tabela history_locking, iar apoi, atunci când se creează o nouă secțiune pentru tabela archive_locking, valoarea va fi păstrată în valorile istorice.

Datele de ieșire

Informații generale despre procese în ansamblu.

AȘTEPTÂND ÎNCHIDERILE DUPĂ TIPURI DE ÎNDUCERE

Interogare

CU
t CA
(
	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

Exemplu

| AȘTEPTÂND ÎNCHIDERILE DUPĂ TIPURI DE ÎNDUCERE
+--------------------+------------------------------+--------------------
|            locktype|                          mode|            duration
+--------------------+------------------------------+--------------------
|       transactionid|                     ShareLock|            19:39:26
|               tuple|           AccessExclusiveLock|            00:03:35
+--------------------+------------------------------+--------------------

ÎNCHIDERILE DUPĂ TIPURI DE ÎNDUCERE

Interogare

CU
t CA
(
	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

Exemplu

| ÎNCHIDERILE DUPĂ TIPURI DE ÎNDUCERE
+--------------------+------------------------------+--------------------
|            locktype|                          mode|            duration
+--------------------+------------------------------+--------------------
|            relation|              RowExclusiveLock|            51:11:10
|          virtualxid|                 ExclusiveLock|            48:10:43
|       transactionid|                 ExclusiveLock|            44:24:53
|            relation|               AccessShareLock|            20:06:13
|               tuple|           AccessExclusiveLock|            17:58:47
|               tuple|                 ExclusiveLock|            01:40:41
|            relation|      ShareUpdateExclusiveLock|            00:26:41
|              object|              RowExclusiveLock|            00:00:01
|       transactionid|                     ShareLock|            00:00:01
|              extend|                 ExclusiveLock|            00:00:01
+--------------------+------------------------------+--------------------

Informații detaliate despre cererile cu queryid specifice

AȘTEPTÂND ÎNCHIDERILE DUPĂ TIPURI DE ÎNDUCERE DUPĂ QUERYID

Interogare

CU
lt CA
(
	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

Exemplu

| AȘTEPTĂ PENTRU BLOCAJE DUPĂ TIPURI DE BLOCAJ ÎN FUNCȚIE DE ID-UL ÎNTREBĂRII
+----------+-------------------------+--------------------+------------------------------+--------------------+--------------------+--------------------
|       pid|                 tipblocaj|                mod|                       început|             idîntrebare|       pid-urile_blocante|            durată
+----------+-------------------------+--------------------+------------------------------+--------------------+--------------------+--------------------
|     11288|            id_ tranzacție|           ShareLock|    2019-09-17 10:00:00.302936|  389015618226997618|             {11092}|            00:03:34
|     11626|            id_ tranzacție|           ShareLock|    2019-09-17 10:00:21.380921|  389015618226997618|             {12380}|            00:00:29
|     11626|            id_ tranzacție|           ShareLock|    2019-09-17 10:00:21.380921|  389015618226997618|             {11092}|            00:03:25
|     11626|            id_ tranzacție|           ShareLock|    2019-09-17 10:00:21.380921|  389015618226997618|             {12213}|            00:01:55
|     11626|            id_ tranzacție|           ShareLock|    2019-09-17 10:00:21.380921|  389015618226997618|             {12751}|            00:00:01
|     11629|            id_ tranzacție|           ShareLock|    2019-09-17 10:00:24.331935|  389015618226997618|             {11092}|            00:03:22
|     11629|            id_ tranzacție|           ShareLock|    2019-09-17 10:00:24.331935|  389015618226997618|             {12007}|            00:00:01
|     12007|            id_ tranzacție|           ShareLock|    2019-09-17 10:05:03.327933|  389015618226997618|             {11629}|            00:00:13
|     12007|            id_ tranzacție|           ShareLock|    2019-09-17 10:05:03.327933|  389015618226997618|             {11092}|            00:01:10
|     12007|            id_ tranzacție|           ShareLock|    2019-09-17 10:05:03.327933|  389015618226997618|             {11288}|            00:00:05
|     12213|            id_ tranzacție|           ShareLock|    2019-09-17 10:06:07.328019|  389015618226997618|             {12007}|            00:00:10

PRELUARE BLOCAJELOR DUPĂ TIPURI DE BLOCAJĂ ÎN FUNCȚIE DE ID-UL ÎNTREBĂRII

Interogare

CU
lt AS
(
	SELECT
		pid , 
		tipblocaj  ,
		mod ,
		timp , 
		idîntrebare , 
		pid-urile_blocante ,
                MIN ( timp ) OVER (PARTITION BY pid , tipblocaj  ,mod ) as început  
	FROM 
		activitate_hist.baza_date_blocare
	WHERE 
		timp între pg_stat_history_begin+(current_hour_diff * interval '1 hour') ȘI 
			                  pg_stat_history_end+(current_hour_diff * interval '1 hour') ȘI 
		aprobat ȘI
		idîntrebare IS NOT NULL 
	GROUP BY 
	        pid , 
		tipblocaj  ,
		mod ,
		timp ,
		idîntrebare ,
		pid-urile_blocante 
)
SELECT 
        lt.pid , 
	lt.tipblocaj  ,
	lt.mod ,			
        ltînceput ,
	lt.idîntrebare  ,
	lt.pid-urile_blocante ,
	COUNT(*)  * interval '1 second'	 as durată			
FROM lt 	
GROUP BY 
	lt.pid , 
	lt.tipblocaj  ,
		lt.mod ,			
        ltînceput ,
	lt.idîntrebare ,
	lt.pid-urile_blocante 
ORDER BY 4

Exemplu

| OBȚINEREA BLOCAJELOR DUPĂ TIPURILE DE BLOCAJ ÎN FUNCȚIE DE QUERYID
+----------+-------------------------+--------------------+------------------------------+--------------------+--------------------+--------------------
|       pid|                 locktype|                mode|                       started|             queryid|       blocking_pids|            duration
+----------+-------------------------+--------------------+------------------------------+--------------------+--------------------+--------------------
|     11288|                 relation|    RowExclusiveLock|    2019-09-17 10:00:00.302936|  389015618226997618|             {11092}|            00:03:34
|     11092|            transactionid|       ExclusiveLock|    2019-09-17 10:00:00.302936|  389015618226997618|                  {}|            00:03:34
|     11288|                 relation|    RowExclusiveLock|    2019-09-17 10:00:00.302936|  389015618226997618|                  {}|            00:00:10
|     11092|                 relation|    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|            transactionid|       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

Utilizarea istoricului blocajelor în analiza incidentelor de performanță.

  1. Procesul cu queryid=389015618226997618 și pid=11288 a așteptat un blocaj începând cu 2019-09-17 10:00:00 timp de 3 minute.
  2. Blocajul a fost deținut de procesul cu pid=11092.
  3. Procesul cu pid=11092, executând o cerere cu queryid=389015618226997618, a deținut blocajul timp de 3 minute începând cu 2019-09-17 10:00:00.

Rezultatul

Acum, sper că începe partea cea mai interesantă și utilă - colectarea statisticilor și analiza cazurilor despre istoricul așteptărilor și blocajelor.

Pe termen lung, sper să reușim să obținem un set de note asemănătoare cu metalinkul Oracle.

Practic, tocmai din acest motiv metodologia utilizată este oferită cât mai repede pentru cunoștința tuturor.

În cel mai scurt timp, voi încerca să public proiectul pe github.

Sursa: habr.com

Cumpără un hosting fiabil pentru site-uri cu protecție DDoS, servere VPS VDS 🔥 Cumpără un hosting fiabil pentru site-uri cu protecție DDoS, servere VPS VDS | ProHoster