lock problem

Rural Hunter <ruralhunter@xxxxxxxxx> · Wed, 21 Dec 2011 15:55:18 +0800



    I'm seeing connection hang issue these days. many concurrent
    connections are hanging on db. They basically do the same thing:
    update different rows in same table. The sql itself should run very
    fast as it's updating just one row based on an unique key. I though
    it might be lock problem.0„2 The I list the locks ordered by query
    start time(see list below).0„2 I'm confused why the oldest connection
    are still waiting for the lock? anything else can hold that lock?

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„2 1580056836 |
      ShareLock0„20„20„20„20„20„20„2 | f0„20„20„20„20„20„2 | update article set tm_update=$ |
      2011-12-21 13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    
    select 

    0„20„20„20„2 pg_class.relname,pg_locks.transactionid, pg_locks.mode,
    pg_locks.granted,0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 0„2

    0„20„20„20„2 substr(pg_stat_activity.current_query,1,30),
    pg_stat_activity.query_start,0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 0„2

    0„20„20„20„2 age(now(),pg_stat_activity.query_start) as "age",
    pg_stat_activity.procpid 

    0„20„2 from pg_stat_activity,pg_locks left 

    0„20„20„20„2 outer join pg_class on (pg_locks.relation = pg_class.oid) 0„2

    0„20„2 where pg_locks.pid=pg_stat_activity.procpid order by query_start
    limit 50;

    0„20„20„20„20„20„20„20„20„2 relname0„20„20„20„20„20„20„20„20„20„2 | transactionid |0„20„20„20„20„20„2 mode0„20„20„20„20„20„2 |
    granted |0„20„20„20„20„20„20„20„20„20„20„20„2 substr0„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„2
    query_start0„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„2 age0„20„20„20„20„20„2 | procpid 

----------------------------+---------------+------------------+---------+--------------------------------+-------------------------------+-----------------+---------

    0„2article_title_hash_idx0„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„2 1580056836 | ShareLock0„20„20„20„20„20„20„2 |
    f0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„2 1579897513 | ExclusiveLock0„20„20„2 |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_fid_author_idx0„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_stage_idx0„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_fid_idx0„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_cid_time_style_idx |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | ExclusiveLock0„20„20„2 |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_tm_spider_idx0„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_tm_update_idx0„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_guid_idx0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_url_hash0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_rfid_idx0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_url_idx0„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article_pkey0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:28:56.643105+08 | 00:24:51.599424 |0„20„2 21020

    0„2article0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_cid_time_style_idx |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_fid_idx0„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_rfid_idx0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_pkey0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„2 1579921995 | ExclusiveLock0„20„20„2 |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_url_idx0„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_title_hash_idx0„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_guid_idx0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_tm_update_idx0„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„2 1580056836 | ShareLock0„20„20„20„20„20„20„2 |
    f0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_fid_author_idx0„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_tm_spider_idx0„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_stage_idx0„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_url_hash0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | ExclusiveLock0„20„20„2 |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:01.947787+08 | 00:23:46.294742 |0„20„20„20„2 706

    0„2article_title_hash_idx0„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„2 1580056836 | ShareLock0„20„20„20„20„20„20„2 |
    f0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_stage_idx0„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_fid_idx0„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_pkey0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_url_hash0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_cid_time_style_idx |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_fid_author_idx0„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_tm_update_idx0„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_rfid_idx0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_url_idx0„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | ExclusiveLock0„20„20„2 |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_guid_idx0„20„20„20„20„20„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_tm_spider_idx0„20„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„20„2 |0„20„20„2 1579925267 | ExclusiveLock0„20„20„2 |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:11.735228+08 | 00:23:36.507301 |0„20„2 22892

    0„2article_title_hash_idx0„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:26.843451+08 | 00:23:21.399078 |0„20„2 32700

    0„2article_fid_author_idx0„20„20„20„2 |0„20„20„20„20„20„20„20„20„20„20„20„20„20„2 | RowExclusiveLock |
    t0„20„20„20„20„20„2 | update article set tm_update=$ | 2011-12-21
    13:30:26.843451+08 | 00:23:21.399078 |0„20„2 32700

    (50 rows)