Bug #70581 mysql server hang
Submitted: 10 Oct 2013 4:16 Modified: 10 Nov 2013 8:28
Reporter: yang ting Email Updates:
Status: No Feedback Impact on me:
None 
Category:MySQL Server: InnoDB storage engine Severity:S3 (Non-critical)
Version:5.5.21 OS:Linux (centos 5.4 )
Assigned to: CPU Architecture:Any
Tags: hang

[10 Oct 2013 4:16] yang ting
Description:
MySQL handed itself 
Thread 1129904448  wait itself 

show engine innodb status:
Per second averages calculated from the last 19 seconds
-----------------
BACKGROUND THREAD
-----------------
srv_master_thread loops: 35207950 1_second, 35207932 sleeps, 3499605 10_second, 261547 background, 261355 flush
srv_master_thread log flush and writes: 35319532
----------
SEMAPHORES
----------
OS WAIT ARRAY INFO: reservation count 148682067, signal count 141629368
--Thread 1129904448 has waited at btr0cur.c line 523 for 1.00 seconds the semaphore:
X-lock (wait_ex) on RW-latch at 0x1182f268 created in file dict0dict.c line 1723
a writer (thread id 1129904448) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 1, lock_word: ffffffffffffffff
Last time read locked in file btr0cur.c line 530
Last time write locked in file /pb2/build/sb_0-4846558-1328010532.08/mysql-5.5.21/storage/innobase/ibuf/ibuf0ibuf.c line 
409
--Thread 1140394304 has waited at btr0cur.c line 530 for 1.00 seconds the semaphore:
S-lock on RW-latch at 0x1182f268 created in file dict0dict.c line 1723
a writer (thread id 1129904448) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 1, lock_word: ffffffffffffffff
Last time read locked in file btr0cur.c line 530
Last time write locked in file /pb2/build/sb_0-4846558-1328010532.08/mysql-5.5.21/storage/innobase/ibuf/ibuf0ibuf.c line 
409
--Thread 1150884160 has waited at btr0cur.c line 530 for 1.00 seconds the semaphore:
S-lock on RW-latch at 0x1182f268 created in file dict0dict.c line 1723
a writer (thread id 1129904448) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 1, lock_word: ffffffffffffffff
Last time read locked in file btr0cur.c line 530
Last time write locked in file /pb2/build/sb_0-4846558-1328010532.08/mysql-5.5.21/storage/innobase/ibuf/ibuf0ibuf.c line 
409
--Thread 1829583168 has waited at btr0cur.c line 530 for 1.00 seconds the semaphore:
S-lock on RW-latch at 0x1182f268 created in file dict0dict.c line 1723
a writer (thread id 1129904448) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 1, lock_word: ffffffffffffffff
Last time read locked in file btr0cur.c line 530
Last time write locked in file /pb2/build/sb_0-4846558-1328010532.08/mysql-5.5.21/storage/innobase/ibuf/ibuf0ibuf.c line 
409
--Thread 1284856128 has waited at btr0cur.c line 530 for 1.00 seconds the semaphore:
S-lock on RW-latch at 0x1182f268 created in file dict0dict.c line 1723
a writer (thread id 1129904448) has reserved it in mode  wait exclusive
number of readers 1, waiters flag 1, lock_word: ffffffffffffffff
Last time read locked in file btr0cur.c line 530
Last time write locked in file /pb2/build/sb_0-4846558-1328010532.08/mysql-5.5.21/storage/innobase/ibuf/ibuf0ibuf.c line 
409

------------
TRANSACTIONS
------------
Trx id counter 77C68947
Purge done for trx's n:o < 76D81F6E undo n:o < 0
History list length 7655
LIST OF TRANSACTIONS FOR EACH SESSION:
---TRANSACTION 0, not started waiting in InnoDB queue
mysql tables in use 1, locked 1
MySQL thread id 594270601, OS thread handle 0x2aab22daf940, query id 9441646581 10.108.79.212 quc_user_action update
insert useraction_29 set qid = '240304229' ,act_id = '1' ,act_time = '2013-10-09 12:35:51' ,ip = '3063191943' ,src = '12'
 ,ext = '360cloud' ,old_val = '' ,new_val = ''
---TRANSACTION 0, not started waiting in InnoDB queue
mysql tables in use 1, locked 1
MySQL thread id 594270600, OS thread handle 0x5663f940, query id 9441646576 10.102.79.17 quc_history_pass update
insert historypwd_80 set qid = '268747580' ,password = '2f5cc67c3fd1b55846b746833b514f4b' ,randomkey = '181715' ,sealtime
 = '20131009123551' ,ip = '1885383771' ,src = '15' ,create_time = '1381293351' ,method = ''
---TRANSACTION 0, not started waiting in InnoDB queue
mysql tables in use 1, locked 1
MySQL thread id 594270599, OS thread handle 0x62e53940, query id 9441646571 10.102.79.16 quc_user_action update
insert useraction_15 set qid = '74461215' ,act_id = '1' ,act_time = '2013-10-09 12:35:51' ,ip = '993302051' ,src = '42' ,
ext = '360caipiao' ,old_val = '' ,new_val = ''
---TRANSACTION 0, not started waiting in InnoDB queue
mysql tables in use 1, locked 1

How to repeat:
Unknown

Suggested fix:
Unknown
[10 Oct 2013 5:36] MySQL Verification Team
I'm sorry, but this is not any indication of a defect in MySQL...
[10 Oct 2013 8:28] MySQL Verification Team
At the least, we'd need to see a couple of complete SHOW ENGINE INNODB STATUS snapshots.  And if crash happens after 900 seconds, a core-file would be useful.  Also, please consider using 5.5.34.
[11 Nov 2013 1:00] Bugs System
No feedback was provided for this bug for over a month, so it is
being suspended automatically. If you are able to provide the
information that was originally requested, please do so and change
the status of the bug back to "Open".