mirror of
https://github.com/fofolee/uTools-Manuals.git
synced 2025-10-11 00:43:20 +08:00
语法高亮，滚动条美化，设置页面调整
This commit is contained in:
fofolee
@@ -4,7 +4,7 @@
|
||||
<p><strong>strace命令</strong> 是一个集诊断、调试、统计与一体的工具，我们可以使用strace对应用的系统调用和信号传递的跟踪结果来对应用进行分析，以达到解决问题或者是了解应用工作过程的目的。当然strace与专业的调试工具比如说gdb之类的是没法相比的，因为它不是一个专业的调试器。</p>
|
||||
<p>strace的最简单的用法就是执行一个指定的命令，在指定的命令结束之后它也就退出了。在命令执行的过程中，strace会记录和解析命令进程的所有系统调用以及这个进程所接收到的所有的信号值。</p>
|
||||
<h3 id="语法">语法</h3>
|
||||
<pre><code>strace [ -dffhiqrtttTvxx ] [ -acolumn ] [ -eexpr ] ...
|
||||
<pre><code class="language-bash">strace [ -dffhiqrtttTvxx ] [ -acolumn ] [ -eexpr ] ...
|
||||
[ -ofile ] [-ppid ] ... [ -sstrsize ] [ -uusername ]
|
||||
[ -Evar=val ] ... [ -Evar ]...
|
||||
[command [ arg ... ] ]
|
||||
@@ -12,7 +12,7 @@
|
||||
strace -c [ -eexpr ] ... [ -Ooverhead ] [ -Ssortby ]
|
||||
[ command [ arg... ] ]</code></pre>
|
||||
<h3 id="选项">选项</h3>
|
||||
<pre><code>-c 统计每一系统调用的所执行的时间,次数和出错的次数等.
|
||||
<pre><code class="language-bash">-c 统计每一系统调用的所执行的时间,次数和出错的次数等.
|
||||
-d 输出strace关于标准错误的调试信息.
|
||||
-f 跟踪由fork调用所产生的子进程.
|
||||
-ff 如果提供-o filename,则所有进程的跟踪结果输出到相应的filename.pid中,pid是各进程的进程号.
|
||||
@@ -50,7 +50,7 @@ qualifier只能是 trace,abbrev,verbose,raw,signal,read,write其中之一.value
|
||||
<h3 id="实例">实例</h3>
|
||||
<p><strong>追踪系统调用</strong></p>
|
||||
<p>现在我们做一个很简单的程序来演示strace的基本用法。这个程序的C语言代码如下：</p>
|
||||
<pre><code># filename test.c
|
||||
<pre><code class="language-bash"># filename test.c
|
||||
#include <stdio.h>
|
||||
|
||||
int main()
|
||||
@@ -61,9 +61,9 @@ int main()
|
||||
return 0;
|
||||
}</code></pre>
|
||||
<p>然后我们用<code>gcc -o test test.c</code>编译一下，得到一个可执行的文件test。然后用strace调用执行：</p>
|
||||
<pre><code>strace ./test</code></pre>
|
||||
<pre><code class="language-bash">strace ./test</code></pre>
|
||||
<p>执行期间会要求你输入一个整数，我们输入99，最后得到如下的结果：</p>
|
||||
<pre><code>// 直接执行test的结果
|
||||
<pre><code class="language-bash">// 直接执行test的结果
|
||||
oracle@orainst[orcl]:~ $./test
|
||||
|
||||
// 执行的结果
|
||||
@@ -103,9 +103,9 @@ exit_group(0) = ?</code></pre>
|
||||
<p>从trace结构可以看到，系统首先调用execve开始一个新的进行，接着进行些环境的初始化操作，最后停顿在”read(0,”上面，这也就是执行到了我们的scanf函数，等待我们输入数字呢，在输入完99之后，在调用write函数将格式化后的数值”000000099″输出到屏幕，最后调用exit_group退出进行，完成整个程序的执行过程。</p>
|
||||
<p><strong>跟踪信号传递</strong></p>
|
||||
<p>我们还是使用上面的那个test程序，来观察进程接收信号的情况。还是先<code>strace ./test</code>，等到等待输入的画面的时候不要输入任何东西，然后打开另外一个窗口，输入如下的命令</p>
|
||||
<pre><code>killall test</code></pre>
|
||||
<pre><code class="language-bash">killall test</code></pre>
|
||||
<p>这时候就能看到我们的程序推出了，最后的trace结果如下：</p>
|
||||
<pre><code>oracle@orainst[orcl]:~
|
||||
<pre><code class="language-bash">oracle@orainst[orcl]:~
|
||||
$strace ./test
|
||||
|
||||
execve("./test", ["./test"], [/* 41 vars */]) = 0
|
||||
@@ -133,9 +133,9 @@ read(0, 0xbf5ff000, 1024) = ? ERESTARTSYS (To be restarted)
|
||||
<p>strace不光能追踪系统调用，通过使用参数-c，它还能将进程所有的系统调用做一个统计分析给你，下面就来看看strace的统计，这次我们执行带-c参数的strace：</p>
|
||||
<p>strace -c ./test</p>
|
||||
<p>最后能得到这样的trace结果：</p>
|
||||
<pre><code>oracle@orainst[orcl]:~
|
||||
<pre><code class="language-bash">oracle@orainst[orcl]:~
|
||||
$strace -c ./test</code></pre>
|
||||
<pre><code>execve("./test", ["./test"], [/* 41 vars */]) = 0
|
||||
<pre><code class="language-bash">execve("./test", ["./test"], [/* 41 vars */]) = 0
|
||||
% time seconds usecs/call calls errors syscall
|
||||
------ ----------- ----------- --------- --------- ----------------
|
||||
45.90 0.000140 5 27 25 open
|
||||
@@ -157,12 +157,12 @@ $strace -c ./test</code></pre>
|
||||
<p>除了-c参数之外，strace还提供了其他有用的参数给我们，让我们能很方便的得到自己想要的信息，下面就对那些常用的参数一一做个介绍。</p>
|
||||
<p><strong>重定向输出</strong></p>
|
||||
<p>参数-o用在将strace的结果输出到文件中，如果不指定-o参数的话，默认的输出设备是STDERR，也就是说使用”-o filename”和” 2>filename”的结果是一样的。</p>
|
||||
<pre><code># 这两个命令都是将strace结果输出到文件test.txt中
|
||||
<pre><code class="language-bash"># 这两个命令都是将strace结果输出到文件test.txt中
|
||||
strace -c -o test.txt ./test
|
||||
strace -c ./test 2>test.txt</code></pre>
|
||||
<p><strong>对系统调用进行计时</strong></p>
|
||||
<p>strace可以使用参数-T将每个系统调用所花费的时间打印出来，每个调用的时间花销现在在调用行最右边的尖括号里面。</p>
|
||||
<pre><code>oracle@orainst[orcl]:~
|
||||
<pre><code class="language-bash">oracle@orainst[orcl]:~
|
||||
$strace -T ./test
|
||||
|
||||
// 这里只摘录部分结果
|
||||
@@ -228,28 +228,28 @@ exit_group(0) = ?</code></pre>
|
||||
</table>
|
||||
<p><strong>截断输出</strong></p>
|
||||
<p>-s参数用于指定trace结果的每一行输出的字符串的长度，下面看看test程序中-s参数对结果有什么影响，现指定-s为20，然后在read的是是很我们输入一个超过20个字符的数字串</p>
|
||||
<pre><code>strace -s 20 ./test
|
||||
<pre><code class="language-bash">strace -s 20 ./test
|
||||
|
||||
read(0, 2222222222222222222222222 // 我们输入的2一共有25个
|
||||
"22222222222222222222"..., 1024) = 26 // 而我们看到的结果中2只有20个</code></pre>
|
||||
<p><strong>trace一个现有的进程</strong></p>
|
||||
<p>strace不光能自己初始化一个进程进行trace，还能追踪现有的进程，参数-p就是取这个作用的，用法也很简单，具体如下。</p>
|
||||
<pre><code>strace -p pid</code></pre>
|
||||
<pre><code class="language-bash">strace -p pid</code></pre>
|
||||
<h3 id="综合例子">综合例子</h3>
|
||||
<p>说了那么多的功能和参数，现在我们来一个实用点的，就是研究下Oracle的lgwr进程，看看这个进程是不是像文档所说的那样没3s钟写一次log文件，考虑到lgwr写日志的触发条件比较多，我们需要找一个空闲的Oracle实例做这个实验。</p>
|
||||
<p>我们先要得到lgwr进程的pid，运行下面的命令</p>
|
||||
<pre><code>ps -ef|grep lgwr
|
||||
<pre><code class="language-bash">ps -ef|grep lgwr
|
||||
|
||||
oracle 5912 1 0 Nov12 ? 00:14:56 ora_lgwr_orcl</code></pre>
|
||||
<p>得到lgwr的pid是5912，现在启动strace，然后将trace的几个输出到lgwr.txt文件中，执行下面的命令</p>
|
||||
<pre><code>strace -tt -s 10 -o lgwr.txt -p 5912</code></pre>
|
||||
<pre><code class="language-bash">strace -tt -s 10 -o lgwr.txt -p 5912</code></pre>
|
||||
<p>过一会之后停止strace，然后查看结果。由于输出的结果比较多，为了方便我们只看Oracle写入log文件时用的pwrite函数的调用</p>
|
||||
<pre><code>grep pwrite\(20 lgwr.txt</code></pre>
|
||||
<pre><code class="language-bash">grep pwrite\(20 lgwr.txt</code></pre>
|
||||
<p>等等，为什么grep的时候用的是”pwrite(2″呢？，因为我知道我这个机器打开的当前的log文件的句柄编号都是2开始的。具体查找方法是先使用下面的语句找出当前活动的日志文件都有哪些：</p>
|
||||
<pre><code>select member, v$log.status from v$log, v$logfile
|
||||
<pre><code class="language-bash">select member, v$log.status from v$log, v$logfile
|
||||
where v$log.group#=v$logfile.group#;</code></pre>
|
||||
<p>得到</p>
|
||||
<pre><code>MEMBER STATUS
|
||||
<pre><code class="language-bash">MEMBER STATUS
|
||||
-------------------------------------------------- ----------------
|
||||
/db/databases/orcl/redo-01-a/redo-t01-g03-m1.log INACTIVE
|
||||
/db/databases/orcl/redo-03-a/redo-t01-g03-m2.log INACTIVE
|
||||
@@ -260,9 +260,9 @@ where v$log.group#=v$logfile.group#;</code></pre>
|
||||
/db/databases/orcl/redo-02-a/redo-t01-g04-m1.log INACTIVE
|
||||
/db/databases/orcl/redo-04-a/redo-t01-g04-m2.log INACTIVE</code></pre>
|
||||
<p>然后到/proc中去找打开文件的句柄：</p>
|
||||
<pre><code>ll /proc/.5912/fd/</code></pre>
|
||||
<pre><code class="language-bash">ll /proc/.5912/fd/</code></pre>
|
||||
<p>得到</p>
|
||||
<pre><code>lrwx------ 1 oracle dba 64 Dec 30 10:55 18 -> /db/databases/orcl/redo-01-a/redo-t01-g01-m1.log
|
||||
<pre><code class="language-bash">lrwx------ 1 oracle dba 64 Dec 30 10:55 18 -> /db/databases/orcl/redo-01-a/redo-t01-g01-m1.log
|
||||
lrwx------ 1 oracle dba 64 Dec 30 10:55 19 -> /db/databases/orcl/redo-03-a/redo-t01-g01-m2.log
|
||||
lrwx------ 1 oracle dba 64 Dec 30 10:55 20 -> /db/databases/orcl/redo-02-a/redo-t01-g02-m1.log
|
||||
lrwx------ 1 oracle dba 64 Dec 30 10:55 21 -> /db/databases/orcl/redo-04-a/redo-t01-g02-m2.log
|
||||
@@ -272,7 +272,7 @@ lrwx------ 1 oracle dba 64 Dec 30 10:55 24 -> /db/databases/o
|
||||
lrwx------ 1 oracle dba 64 Dec 30 10:55 25 -> /db/databases/orcl/redo-04-a/redo-t01-g04-m2.log</code></pre>
|
||||
<p>现在能看到我机器当前日志文件的句柄分别是20和21。</p>
|
||||
<p>现在我们得到如下结果</p>
|
||||
<pre><code>11:13:55.603245 pwrite(20, "\1\"\0\0J!"..., 1536, 4363264) = 1536
|
||||
<pre><code class="language-bash">11:13:55.603245 pwrite(20, "\1\"\0\0J!"..., 1536, 4363264) = 1536
|
||||
11:13:55.603569 pwrite(21, "\1\"\0\0J!"..., 1536, 4363264) = 1536
|
||||
11:13:55.606888 pwrite(20, "\1\"\0\0M!"..., 1536, 4364800) = 1536
|
||||
11:13:55.607172 pwrite(21, "\1\"\0\0M!"..., 1536, 4364800) = 1536
|
||||
|
||||
Reference in New Issue
Block a user