linux awk sed strace,[20200402]strace过滤使用awk问题.txt-程序员宅基地

技术标签: linux awk sed strace  

[20200402]strace过滤使用awk问题.txt

--//昨天使用strace跟踪io_submit,我想计算每次调用io_submit的平均值。遇到一些问题做1个记录。

1.问题提出:

# strace -f -e io_submit -Ttt  -p 3831

Process 3831 attached - interrupt to quit

11:15:20.217558 io_submit(47787382317056, 2, { {0x2b765df0c210, 0, 1, 0, 256}, {0x2b765df0c460, 0, 1, 0, 257}}) = 2 <0.055500>

11:15:21.274563 io_submit(47787382317056, 2, { {0x2b765df0c210, 0, 1, 0, 256}, {0x2b765df0c460, 0, 1, 0, 257}}) = 2 <0.014881>

11:15:22.291352 io_submit(47787382317056, 2, { {0x2b765df0c210, 0, 1, 0, 256}, {0x2b765df0c460, 0, 1, 0, 257}}) = 2 <0.022738>

Process 3831 detached

--//就是计算最后字段的平均值。

# strace -f -e io_submit -Ttt  -p 3831 | awk '{print $16}'

Process 3831 attached - interrupt to quit

11:16:10.716024 io_submit(47787382317056, 2, { {0x2b765df0c210, 0, 1, 0, 256}, {0x2b765df0c460, 0, 1, 0, 257}}) = 2 <0.038544>

11:16:11.755982 io_submit(47787382317056, 2, { {0x2b765df0c210, 0, 1, 0, 256}, {0x2b765df0c460, 0, 1, 0, 257}}) = 2 <0.039956>

Process 3831 detached

--//很明显strace的输出信息到错误句柄2.无法通过awk过滤获得标准输入1的信息,修改如下:

# strace -f -e io_submit -Ttt  -p 3831 2>&1 | awk '{print $16}'

<0.028540>

<0.031370>

<0.023189>

<0.031105>

<0.023580>

--//OK现在视乎可以了。现在删除"<>"字符。

# strace -f -e io_submit -Ttt  -p 3831 2>&1 | awk '{print $16}' | tr -d "<>"

--//奇怪现在没有任何输出,为什么呢? 原来awk已经显示了输出,我在通过管道tr处理失败。为什么呢?

2.分析:

# pstree -p

...

|-tmux(19985)-+-bash(5192)---su(5225)---bash(5226)

|             |-bash(19986)-+-awk(7010)

|             |             |-strace(7009)

|             |             `-tr(7011)

# ls -l /proc/7009/fd

total 0

lrwx------ 1 root root 64 2020-04-02 11:21:51 0 -> /dev/pts/3

l-wx------ 1 root root 64 2020-04-02 11:21:51 1 -> pipe:[352472722]

l-wx------ 1 root root 64 2020-04-02 11:21:51 2 -> pipe:[352472722]

--//strace可以发现句柄1,2指向pipe:[352472722]。

# ls -l /proc/7010/fd

total 0

lr-x------ 1 root root 64 2020-04-02 11:22:34 0 -> pipe:[352472722]

l-wx------ 1 root root 64 2020-04-02 11:22:34 1 -> pipe:[352472724]

lrwx------ 1 root root 64 2020-04-02 11:22:34 2 -> /dev/pts/3

--//awk ,句柄0 指向pipe:[352472722],也就是接收strace 句柄1,2的输出。句柄1指向pipe:[352472724]。

# ls -l /proc/7011/fd

total 0

lr-x------ 1 root root 64 2020-04-02 11:24:26 0 -> pipe:[352472724]

lrwx------ 1 root root 64 2020-04-02 11:24:26 1 -> /dev/pts/3

lrwx------ 1 root root 64 2020-04-02 11:24:26 2 -> /dev/pts/3

--//tr 句柄0 指向 pipe:[352472724],没有任何问题啊

--//等一段时间我才发现有输出。也就是awk具有缓存输出的功能。当前版本是oracle 5.9。

--//我仅仅知道这个版本sed -u 参数关闭缓存。也就是如果通过管道过滤,中间使用awk要注意缓存问题。

# strace -f -e io_submit -Tt  -p 3831 2>&1  | sed -u -e "s/^.*/;s/>$//"

Process 3831 attached - interrupt to quit

0.029298

0.056492

0.023080

0.030876

0.030940

0.023609

0.031302

--//ok,现在有输出了。

#  strace -q -f -e io_submit -Tt  -p 3831 2>&1  | sed  -e "s/^.*/;s/>$//"  |  awk '{j++;i=i+$NF;print j,i,i/j}END{print j,i,i/j}'

--//又不行,也就是sed也具有类似缓存的功能,只有缓存满了才会输出。ses 加入-u测试:

# strace -q -f -e io_submit -Tt  -p 3831 2>&1  | sed  -u -e "s/^.*/;s/>$//"  |  awk '{j++;i=i+$NF;print j,i,i/j}END{print j,i,i/j}'

1 0.018685 0.018685

2 0.037464 0.018732

3 0.059714 0.0199047

4 0.095627 0.0239067

5 0.126476 0.0252952

6 0.15808 0.0263467

7 0.226031 0.0322901

8 0.244658 0.0305822

--//注:strace -q 避免开头输出。你可以发现现在有输出。但是最后awk的END部分没有执行。限制输出行数就ok了。

# strace -q -f -e io_submit -Tt  -p 3831 2>&1  | sed  -u -e "s/^.*/;s/>$//"  |  head -10 | awk '{j++;i=i+$NF;print j,i,i/j}END{print j,i,i/j}'

1 0.034537 0.034537

2 0.065231 0.0326155

3 0.088592 0.0295307

4 0.11966 0.029915

5 0.146256 0.0292512

6 0.190617 0.0317695

7 0.208893 0.0298419

8 0.240214 0.0300267

9 0.276311 0.0307012

10 0.307035 0.0307035

10 0.307035 0.0307035

--//现在ok了。

3.总结

--//实际上这些都不重要。主要是现场遇到这些问题有一些困惑。做一个记录。我仅仅知道sed -u,tcpdump -l可以关闭缓存。

--//expect包里面包含一个unbuffer,可以禁止输出缓存.

--//一些新版本linux版本的coreutils包里面包括一个命令stdbuf(Red Hat Enterprise Linux Server release 7.5就有这个命令)

--//找一台centos 7.7的机器测试:

# strace -q -f -e pwrite -Tt  -p 15386 2>&1  | stdbuf -i0 -o0 -e0 sed   -e "s/^.*/;s/>$//"  |   awk '{j++;i=i+$NF;print j,i,i/j}END{print j,i,i/j}'

1 0.000124 0.000124

2 0.000201 0.0001005

3 0.000348 0.000116

4 0.000439 0.00010975

^C

# strace -q -f -e pwrite -Ttt  -p 15386 2>&1 | stdbuf -i0 -o0 -e0  awk '{print $8}' | tr -d "<>"

0.000152

0.000101

0.000161

0.000076

^C

--//OK,这样就没有这个问题了。

# strace -q -f -e pwrite -Tt  -p 15386  2>&1  | sed  -u -e "s/^.*/;s/>$//"  | stdbuf -i0 -o0 -e0 head -10 | stdbuf -i0 -o0 -e0 awk '{j++;i=i+$NF;print j,i,i/j}END{print j,i,i/j}' | ts.awk

[2020-04-03 09:23:03] 1 0.000156 0.000156

[2020-04-03 09:23:03] 2 0.000301 0.0001505

[2020-04-03 09:23:06] 3 0.000528 0.000176

[2020-04-03 09:23:06] 4 0.000681 0.00017025

[2020-04-03 09:23:09] 5 0.000959 0.0001918

[2020-04-03 09:23:09] 6 0.001158 0.000193

[2020-04-03 09:23:12] 7 0.001352 0.000193143

[2020-04-03 09:23:12] 8 0.00146 0.0001825

[2020-04-03 09:23:15] 9 0.001738 0.000193111

[2020-04-03 09:23:15] 10 0.00193 0.000193

[2020-04-03 09:23:15] 10 0.00193 0.000193

--//注意看前面的时间戳。间隔3秒。奇怪这里变成间隔3秒,另外探究看看,难道没有配置dg就是这样吗?

# strace -q -f -e pwrite -Tt  -p 15386  2>&1  | sed  -u -e "s/^.*/;s/>$//"  | head -10 |  awk '{j++;i=i+$NF;print j,i,i/j}END{print j,i,i/j}' | ts.awk

[2020-04-03 09:24:57] 1 0.000216 0.000216

[2020-04-03 09:24:57] 2 0.000344 0.000172

[2020-04-03 09:24:57] 3 0.000484 0.000161333

[2020-04-03 09:24:57] 4 0.00058 0.000145

[2020-04-03 09:24:57] 5 0.000718 0.0001436

[2020-04-03 09:24:57] 6 0.000817 0.000136167

[2020-04-03 09:24:57] 7 0.001014 0.000144857

[2020-04-03 09:24:57] 8 0.001114 0.00013925

[2020-04-03 09:24:57] 9 0.001305 0.000145

[2020-04-03 09:24:57] 10 0.001428 0.0001428

[2020-04-03 09:24:57] 10 0.001428 0.0001428

--//时间都是一样的。

--//附上ts.awk的源代码。

# cat /usr/local/bin/ts.awk

# /bin/bash

gawk '{ print strftime("[%Y-%m-%d %H:%M:%S]"), $0 }'

版权声明:本文为博主原创文章,遵循 CC 4.0 BY-SA 版权协议,转载请附上原文出处链接和本声明。
本文链接:https://blog.csdn.net/weixin_29216957/article/details/117280668

智能推荐

Ubuntu 14.04 安装中文环境_乌班图language-pack-zh-hans离线包-程序员宅基地

文章浏览阅读6.9k次。Ubuntu 14.04 安装中文环境安装中文语言包sudo apt-get update && sudo apt-get install language-pack-zh-hans_乌班图language-pack-zh-hans离线包

使用STM32CUBEMX 新HAL库TF卡模拟U盘不能格式化问题_stm32 tf卡 格式化-程序员宅基地

文章浏览阅读2.8k次,点赞3次,收藏11次。单片机型号F767,CUBEMX版本V5.01,HAL库版本1.14.0,开发软件True Studio不得不说,基础很重要,按照网上之前的教程,照葫芦画瓢,但是新的HAL已经改动了,陆陆续续调了一个星期,WIN7下U盘盘符是有了,但是始终不能格式化,用这个板子测试CDC和HID都没有问题,一直静不下心来阅读USB协议和SD卡的相关协议,后来还是在论坛找到了原因。其实把usbd_stora..._stm32 tf卡 格式化

Spring Cloud分布式开发-服务调用_分布式微服务调用流程-程序员宅基地

文章浏览阅读406次。简介微服务是系统架构上的一种设计风格,主旨是将一个原本独立的系统拆分成多个小型服务,这些小型服务都在各自独立的进程中运行.服务之间通过基于HTTP的RESTful API进行通信协作.每一个小型服务都围绕系统中某一项耦合度较高的业务功能进行构建,并且每个服务都维护着自身的数据存储/业务开发/自动化测试案例以及独立部署机制.使用微服务设计风格的原因:不断扩大的需求使得单体应用变得越来越臃肿 单体应用系统部署在一个进程内,修改一个很小的功能会导致其他功能模块都需要重先部_分布式微服务调用流程

CoordinatorLayout + AppBarLayout + CollapsingToolbarLayout+NestedScrollView实现上下滑动悬停效果_collapsingtoolbarlayout 上下滚动-程序员宅基地

文章浏览阅读6.7k次,点赞5次,收藏15次。这张图解析上面几个控件的关系: 转载:https://www.jianshu.com/p/1f3974408528 CoordinatorLayout配合AppBarLayout、CollapsingToolbarLayout、Toolbar使用转载:https://blog.csdn.net/feather_wch/article/details/80021699 载:htt..._collapsingtoolbarlayout 上下滚动

华为云开发者学堂——学习笔记_华为开发者联盟学堂-程序员宅基地

文章浏览阅读626次。华为云学习过程中遇到的问题_华为开发者联盟学堂

GPS坐标(经纬度)转换为百度坐标(经纬度)续_经纬度转百度坐标-程序员宅基地

文章浏览阅读1w次,点赞2次,收藏4次。1、早前初步接触的时候转载过一个真实经纬度转百度经纬度的JAVA计算的方法,后续实用起来发现还是有一定的误差的,于是依然改为依赖网络调用百度接口去请求查询,此处依然先介绍一个java发送post请求调用百度提供的转换接口转换坐标import java.io.BufferedReader;import java.io.IOException;import java.io.InputStrea_经纬度转百度坐标

随便推点

oracle 表分区用完了,dbms_stats.lock_table_stats对于没有统计信息的表分区同样有效...-程序员宅基地

文章浏览阅读325次。常见的分区表DDL如 split partition、add partition都会生成没有统计信息的表分区table partition,长期以来我对dbms_stats.lock_table_stats有一个错误的认识,即对于没有统计信息的分区,LOCK_STATS并不生效。 实际测试发现锁表统计信息对没有统计信息的分区同样有效,结果就是自动收集统计信息的作业不会收集这些实际没有统计信息的分区...

java 日期时间操作_Java 各种时间日期相关的操作-程序员宅基地

文章浏览阅读614次。目录1、获取当前时间的时间戳1.1、时间进制1.2、获取毫秒级时间戳1.3、获取纳秒级时间戳2、java.util包2.1、Data2.2、Calendar3、java.time包3.1、LocalDate3.2、LocalTime3.3、LocalDateTime3.4、Clock3.5、Instant4、日期时间格式4.1、简单示例4.2、常用格式转换5、月份对应的英文前言平常会遇到很多的日期..._localdatetime 1毫秒等于多少纳秒

NET操作文件 二 -----FileSteam类的使用-程序员宅基地

文章浏览阅读461次。 NET操作文件 二 -----FileSteam类的使用FileSteam类的使用private void Page_Load(object sender, System.EventArgs e){FileStream fs = new FileStream(Server.MapPath(".")+"//FileStreamCreateText.txt",File_filesteam类

第四章 数组和指针-程序员宅基地

文章浏览阅读88次。1.列出使用数组而不是vector的缺点ANS:与vector类型相比,数组具有如下特点:数组的长度是固定的,而且数组不提供获取其容量大小的size操作,也不提供自动添加元素的push_back操作。因此,程序员无法再程序运行时知道一个给定数组的长度,而且如果需要更改数组的长度,程序员只能创建一个更大的新数组,然后把原数组的所有元素复制到新数组的存储空间中去。与使用vector类型的...

matlab编程之如何绘图_matlab画图-程序员宅基地

文章浏览阅读2.8k次。1、绘制一个直线x=[-5:15:100]y=2*x+4plot(y)2、绘制一条抛物线x=[-100:15:100]y=x.*x+4.*x-10plot(y)3、一个坐标轴里面绘制两个图形x=[-100:15:100]y=x.*x+4.*x-10z=4*x+536plot(x,y,x,z)如果一个图形在一个坐标轴里面呢??x=[-100:15:100]y=x.*x+4.*x-10z=4*x+536subplot(1,2,1)pl.._matlab画图

Xcode 6 上模拟器键盘弹出后找不到中文输入法的问题_swift 键盘弹出没有小地球-程序员宅基地

文章浏览阅读423次。今天在使用IOS模拟器的时候需要输入中文,却发现模拟器键盘不能切换输入法。后来找到了解决方法,给大家分享下:先在模拟器中找到设置,即Settings->General->Keyboard->Keyboards->Add New Keyboard...到了这里大家应该就都明白了,在列表中选择自己需要的输入法,我选择的中文输入法是Chinese-Simplified(PinYin)即简_swift 键盘弹出没有小地球