！！诚心请教有识之士：为什么rollback那么多

狡兔

有一引擎，用户反映慢，经检查，系统性能正常。但数据库状态很不妥，有大量的回滚操作。具体情看onstat的输出。

为什么有这么多的rollbk？

刚刚onstat -z清空记录后，马上onstat -z的输出：0 commit, 32 rollback

618$ onstat -p

Informix Dynamic Server Version 7.31.UC5    -- On-Line -- Up 20 days 05:43:34 --
585728 Kbytes

Profile
dskreads pagreads bufreads %cached dskwrits pagwrits bufwrits %cached
4        22       26718    99.99   269      1        686      60.79

isamtot  open     start    read     write    rewrite  delete   commit   rollbk
21383    1140     5020     4663     90       12       0        0        32

gp_read  gp_write gp_rewrt gp_del   gp_alloc gp_free  gp_curs
0        0        0        0        0        0        0

ovlock   ovuserthread ovbuff   usercpu  syscpu   numckpts flushes
0        0            0        4.06     1.98     1        1

bufwaits lokwaits lockreqs deadlks  dltouts  ckpwaits compress seqscans
0        4        9582     0        0        1        33       359

ixda-RA  idx-RA   da-RA    RA-pgsused lchwaits
0        0        0        0          90


写完帖子后，再onstat -p的输出：242 commit，14778 rollback

619$ onstat -p

Informix Dynamic Server Version 7.31.UC5    -- On-Line -- Up 20 days 05:47:40 --
585728 Kbytes

Profile
dskreads pagreads bufreads %cached dskwrits pagwrits bufwrits %cached
280550   387960   11775743 97.62   459      13158    337757   99.86

isamtot  open     start    read     write    rewrite  delete   commit   rollbk
6073760  240555   987371   2626923  44835    5570     447      242      14778

gp_read  gp_write gp_rewrt gp_del   gp_alloc gp_free  gp_curs
0        0        0        0        0        0        0

ovlock   ovuserthread ovbuff   usercpu  syscpu   numckpts flushes
0        0            0        306.37   113.88   1        1

bufwaits lokwaits lockreqs deadlks  dltouts  ckpwaits compress seqscans
28122    2429     9539275  0        0        1        15684    72316

ixda-RA  idx-RA   da-RA    RA-pgsused lchwaits
125303   7        97705    222331     8320



此时的日志：onstat -m
========
17:25:57  Checkpoint Completed:  duration was 3 seconds.
17:31:07  Checkpoint Completed:  duration was 5 seconds.
17:33:30  Logical Log 9499 Complete.
17:33:33  Process exited with return code 142: /bin/sh /bin/sh -c /usr/informix/
etc/log_full.sh 2 23 "Logical Log 9499 Complete." "Logical Log 9499 Complete."
17:36:15  Checkpoint Completed:  duration was 5 seconds.
17:41:21  Checkpoint Completed:  duration was 2 seconds.
17:43:12  Logical Log 9500 Complete.
17:43:17  Process exited with return code 142: /bin/sh /bin/sh -c /usr/informix/
etc/log_full.sh 2 23 "Logical Log 9500 Complete." "Logical Log 9500 Complete."
17:46:28  Checkpoint Completed:  duration was 1 seconds.

wjj9912130

有道理!

狡兔

锁是够的，100万。ovlock参数也显示 0

wolfop

牛啊，不知道应用怎么写的。