GDBを使用してPHPコードをデバッグし、PHPコードのデッドサイクル問題を解決する

8389 ワード

最近、同僚にSwoole Serverの問題を解決してもらったところ、1つのworkerプロセスがずっとRの状態にあり、CPUの消費時間が非常に高いことがわかりました.PHPコードでデッドサイクルが発生していると初歩的に判断した.
次に、PHPデッドサイクルの問題をどのように解決するかをコードで示します.

 
  
 #dead_loop.php 
  
 $array = array(); 
  
 for($i = 0; $i < 10000; $i++) 
  
 { 
  
     $array[] = $i; 
  
 } 
  
 include __DIR__."/include.php"; 
  
 #include.php 
  
 while(1) 
  
 { 
  
     usleep(10); 
  
     $keys = array_flip($array); 
  
     $index = array_search(rand(1500, 9999), $array); 
  
     $str = str_repeat('A', $index); 
  
     $strb = test($index, $str); 
  
 } 
  
 function test($index, $str) 
  
 { 
  
     return str_replace('A', 'B', $str); 
  
 }

psauxで得られたプロセスIDと状態は以下の通りであり、gdb-pプロセスptraceトラッキングを用いてbtコマンドで呼び出しスタックを得る

 
  
 htf 3834 2.6 0.2 166676 22060 pts/12 R+ 10:50 0:12 php dead_loop.php 
  
 gdb -p 3834 
  
 (gdb) bt 
  
 #0 0x00000000008cc03f in zend_mm_check_ptr (heap=0x1eaa2c0, ptr=0x2584910, silent=1, __zend_filename=0xee3d40 "/home/htf/workspace/php-5.4.27/Zend/zend_variables.c", 
  
 __zend_lineno=182, __zend_orig_filename=0xee1888 "/home/htf/workspace/php-5.4.27/Zend/zend_execute_API.c", __zend_orig_lineno=437) 
  
 at /home/htf/workspace/php-5.4.27/Zend/zend_alloc.c:1485 
  
 #1 0x00000000008cd643 in _zend_mm_free_int (heap=0x1eaa2c0, p=0x2584910, __zend_filename=0xee3d40 "/home/htf/workspace/php-5.4.27/Zend/zend_variables.c", __zend_lineno=182, 
  
 __zend_orig_filename=0xee1888 "/home/htf/workspace/php-5.4.27/Zend/zend_execute_API.c", __zend_orig_lineno=437) at /home/htf/workspace/php-5.4.27/Zend/zend_alloc.c:2064 
  
 #2 0x00000000008cebf7 in _efree (ptr=0x2584910, __zend_filename=0xee3d40 "/home/htf/workspace/php-5.4.27/Zend/zend_variables.c", __zend_lineno=182, 
  
 __zend_orig_filename=0xee1888 "/home/htf/workspace/php-5.4.27/Zend/zend_execute_API.c", __zend_orig_lineno=437) at /home/htf/workspace/php-5.4.27/Zend/zend_alloc.c:2436 
  
 #3 0x00000000008eda0a in _zval_ptr_dtor (zval_ptr=0x25849a0, __zend_filename=0xee3d40 "/home/htf/workspace/php-5.4.27/Zend/zend_variables.c", __zend_lineno=182) 
  
 at /home/htf/workspace/php-5.4.27/Zend/zend_execute_API.c:437 
  
 #4 0x00000000008fe687 in _zval_ptr_dtor_wrapper (zval_ptr=0x25849a0) at /home/htf/workspace/php-5.4.27/Zend/zend_variables.c:182 
  
 #5 0x000000000091259f in zend_hash_destroy (ht=0x7f7263f6e380) at /home/htf/workspace/php-5.4.27/Zend/zend_hash.c:560 
  
 #6 0x00000000008fe2c5 in _zval_dtor_func (zvalue=0x7f726426fe50, __zend_filename=0xeea290 "/home/htf/workspace/php-5.4.27/Zend/zend_execute.c", __zend_lineno=901) 
  
 at /home/htf/workspace/php-5.4.27/Zend/zend_variables.c:45 
  
 #7 0x0000000000936656 in _zval_dtor (zvalue=0x7f726426fe50, __zend_filename=0xeea290 "/home/htf/workspace/php-5.4.27/Zend/zend_execute.c", __zend_lineno=901) 
  
 at /home/htf/workspace/php-5.4.27/Zend/zend_variables.h:35 
  
 #8 0x0000000000939747 in zend_assign_to_variable (variable_ptr_ptr=0x7f7263f8e738, value=0x7f726426f6a8) at /home/htf/workspace/php-5.4.27/Zend/zend_execute.c:901 
  
 #9 0x0000000000997ee5 in ZEND_ASSIGN_SPEC_CV_VAR_HANDLER (execute_data=0x7f726d04b2a8) at /home/htf/workspace/php-5.4.27/Zend/zend_vm_execute.h:33168 
  
 #10 0x000000000093b5fd in execute (op_array=0x21d58b0) at /home/htf/workspace/php-5.4.27/Zend/zend_vm_execute.h:410 
  
 #11 0x0000000000901692 in zend_execute_scripts (type=8, retval=0x0, file_count=3) at /home/htf/workspace/php-5.4.27/Zend/zend.c:1315 
  
 #12 0x000000000087926a in php_execute_script (primary_file=0x7ffffe0038d0) at /home/htf/workspace/php-5.4.27/main/main.c:2502 
  
 #13 0x00000000009a32e3 in do_cli (argc=2, argv=0x7ffffe004d18) at /home/htf/workspace/php-5.4.27/sapi/cli/php_cli.c:989 
  
 #14 0x00000000009a4491 in main (argc=2, argv=0x7ffffe004d18) at /home/htf/workspace/php-5.4.27/sapi/cli/php_cli.c:1365

gdbを実行するとデッドサイクルのプロセスはTの状態になり,トレース中であることを示す.これは独占的なのでstrace/gdbまたは他のptraceツールを使用してこのプロセスをデバッグすることはできません.また、このプロセスは実行を中断します.gdbがcを入力すると、プログラムは下へ実行されます.次にctrl+c割り込みプログラムを再度押します.btコマンドでプロセスの呼び出しスタックを表示します.

 
  
 (gdb) bt 
  
 #0 _zend_mm_alloc_int (heap=0x1eaa2c0, size=72, __zend_filename=0xe43410 "/home/htf/workspace/php-5.4.27/ext/standard/array.c", __zend_lineno=2719, 
  
 __zend_orig_filename=0xee5a38 "/home/htf/workspace/php-5.4.27/Zend/zend_hash.c", __zend_orig_lineno=412) at /home/htf/workspace/php-5.4.27/Zend/zend_alloc.c:1895 
  
 #1 0x00000000008ceb86 in _emalloc (size=72, __zend_filename=0xe43410 "/home/htf/workspace/php-5.4.27/ext/standard/array.c", __zend_lineno=2719, 
  
 __zend_orig_filename=0xee5a38 "/home/htf/workspace/php-5.4.27/Zend/zend_hash.c", __zend_orig_lineno=412) at /home/htf/workspace/php-5.4.27/Zend/zend_alloc.c:2425 
  
 #2 0x0000000000911d85 in _zend_hash_index_update_or_next_insert (ht=0x2257a10, h=3972, pData=0x7ffffe0012b0, nDataSize=8, pDest=0x0, flag=1, 
  
 __zend_filename=0xe43410 "/home/htf/workspace/php-5.4.27/ext/standard/array.c", __zend_lineno=2719) at /home/htf/workspace/php-5.4.27/Zend/zend_hash.c:412 
  
 #3 0x00000000007767e1 in zif_array_flip (ht=1, return_value=0x7f726424ea68, return_value_ptr=0x0, this_ptr=0x0, return_value_used=1) 
  
 at /home/htf/workspace/php-5.4.27/ext/standard/array.c:2719 
  
 #4 0x000000000093c03e in zend_do_fcall_common_helper_SPEC (execute_data=0x7f726d04b2a8) at /home/htf/workspace/php-5.4.27/Zend/zend_vm_execute.h:643 
  
 #5 0x00000000009400e6 in ZEND_DO_FCALL_SPEC_CONST_HANDLER (execute_data=0x7f726d04b2a8) at /home/htf/workspace/php-5.4.27/Zend/zend_vm_execute.h:2233 
  
 #6 0x000000000093b5fd in execute (op_array=0x21d58b0) at /home/htf/workspace/php-5.4.27/Zend/zend_vm_execute.h:410

2回のBT情報が異なるのは,プログラムが異なる位置で中断されたためである.execute(oparray=0 x 21 d 58 b 0)という行が表示されます.ここでPHPがoparrayを実行する入り口です.gdbにf 6を入力します(スタック番号を呼び出すことで得られます).

 
  
 (gdb) f 6 
  
 #6 0x000000000093b5fd in execute (op_array=0x21d58b0) at /home/htf/workspace/php-5.4.27/Zend/zend_vm_execute.h:410 
  
 410 if ((ret = OPLINE->handler(execute_data TSRMLS_CC)) > 0) { 
  
 (gdb) p *op_array 
  
 $2 = {type = 2 '\002', function_name = 0x7f726d086540 "test", scope = 0x0, fn_flags = 134217728, prototype = 0x0, num_args = 2, required_num_args = 2, arg_info = 0x7f726d086bd8, 
  
 refcount = 0x7f726d0870f0, opcodes = 0x7f726424d600, last = 8, vars = 0x7f726424e890, last_var = 2, T = 1, brk_cont_array = 0x0, last_brk_cont = 0, try_catch_array = 0x0, 
  
 last_try_catch = 0, static_variables = 0x0, this_var = 4294967295, filename = 0x7f726424ba38 "/home/htf/wwwroot/include.php", line_start = 12, line_end = 15, doc_comment = 0x0, 
  
 doc_comment_len = 0, early_binding = 4294967295, literals = 0x7f726424eae0, last_literal = 4, run_time_cache = 0x7f726450bfb0, last_cache_slot = 1, reserved = {0x0, 0x0, 0x0, 0x0}}

ここのfilenameでop_が見えますArrayはどのPHPファイルですか.次にf 0を入力して現在位置に入ります.

 
  
 (gdb) p **executor_globals.opline_ptr 
  
 $4 = {handler = 0x93ff9c , op1 = {constant = 1680133296, var = 1680133296, num = 1680133296, hash = 140129283132592, opline_num = 1680133296, 
  
 jmp_addr = 0x7f726424ccb0, zv = 0x7f726424ccb0, literal = 0x7f726424ccb0, ptr = 0x7f726424ccb0}, op2 = {constant = 0, var = 0, num = 0, hash = 0, opline_num = 0, jmp_addr = 0x0, 
  
 zv = 0x0, literal = 0x0, ptr = 0x0}, result = {constant = 32, var = 32, num = 32, hash = 32, opline_num = 32, jmp_addr = 0x20, zv = 0x20, literal = 0x20, ptr = 0x20}, 
  
 extended_value = 1, lineno = 5, opcode = 60 '

ここのlinenoはOPCODEが存在するコードの行数を表し、対応するファイルにどのコードがあるかを見ることができます.GDBを使ってもっと情報を見ることができますが、ここでは紹介しません.興味のある方は自分で試してみてください.
zbacktraceの使用
zend公式はgdbのスクリプトを提供し,php関数の呼び出し関係を直接見ることができる命令をカプセル化した.phpソースパッケージのルートディレクトリに1つあります.gdbinit.使用

 
  
 source your_php_src_path/.gdbinit 
  
 zbacktrace

PHP関数の呼び出しスタックが直接見えます.
以上が本文のすべての内容で、みんなが好きになることを望みます.

【baserCMS：初心者向け】ページごとにヘッダーなどの読み込みを分岐させる

フィボナッチ数列の応用(アルゴリズム実装)