【深度】nginx strace和gstack源码调试

一、前提

1 nginx编译安装

假设已经安装好了nginx服务器,切能正常启动访问,个人版本为 nginx version: nginx/1.14.0,使用strace/pstack进行调试(或者gdb,没调试过)。strace 和ltrace 可以查看一个应用程序在运行过程中所发起的系统调用

2 strace命令

strace - trace system calls and signals 跟踪系统调用和信号,最重要的参数 -p,

strace -p pid

Attach to the process with the process ID pid and begin tracing. The trace may be terminated at any time by a keyboard interrupt signal (CTRL-C). strace will respond by detaching itself from the traced process(es) leaving it (them) to continue running. Multiple -p options can be used to attach to many processes in addition to command (which is optional if at least one -p option is given). -p "pidof PROG" syntax is supported

详细参数,自行查看 man strace(yum install strace)

3 nginx配置

nginx采用master-worker模式,且只有一个worker进程,方便调试

worker_processes  1;
events {
    worker_connections  1024;
}

二、gstack 调试


ps aux | grep nginx | grep -v grep

www      13366  0.0  0.1  21784  2164 ?        S    Mar23  0:00 nginx: worker process

root    15221  0.0  0.1  21784  2132 ?        ts  Mar13  0:00 nginx: master process /usr/local/nginx/sbin/nginx


[@bx16-77-246 /usr/local/nginx]# gstack 13366

#0  0x00007fe98da830f3 in __epoll_wait_nocancel () from /lib64/libc.so.6

#1  0x00000000004320b8 in ngx_epoll_process_events (cycle=0xd7e1b0, timer=18446744073709551615, flags=1) at src/event/modules/ngx_epoll_module.c:800

#2  0x0000000000429c48 in ngx_process_events_and_timers (cycle=cycle@entry=0xd7e1b0) at src/event/ngx_event.c:242

#3  0x0000000000430644 in ngx_worker_process_cycle (cycle=0xd7e1b0, data=<optimized out>) at src/os/unix/ngx_process_cycle.c:750

#4  0x000000000042ed72 in ngx_spawn_process (cycle=cycle@entry=0xd7e1b0, proc=proc@entry=0x4305d3 <ngx_worker_process_cycle>, data=data@entry=0x0, name=name@entry=0x480ead "worker process", respawn=respawn@entry=-4) at src/os/unix/ngx_process.c:199

#5  0x000000000042f90b in ngx_start_worker_processes (cycle=cycle@entry=0xd7e1b0, n=1, type=type@entry=-4) at src/os/unix/ngx_process_cycle.c:359

#6  0x0000000000431358 in ngx_master_process_cycle (cycle=cycle@entry=0xd7e1b0) at src/os/unix/ngx_process_cycle.c:244

#7  0x000000000040c84b in main (argc=<optimized out>, argv=<optimized out>) at src/core/nginx.c:382

从main()函数到epoll_wait()函数的调用关系一目了然,说明:(调用栈从下自上)

1 入口是nginx.c文件里的main函数,解析命令行参数,初始化

2 根据ngx_process变量,进入分支ngx_master_process_cycle(另一个分支是ngx_single_process_cycle)

3 进入master后,就需要启动worker进程,调用ngx_start_worker_processes

4 调用ngx_spawn_process启动worker进行,并执行回调ngx_worker_process_cycle

5 进入worker主循环,其中最重要的逻辑是ngx_process_events_and_timers

6 调用ngx_worker_process_init,执行各个模块的init钩子,并设置action为ngx_epoll_process_events

7 epoll开始进入事件等待 __epoll_wait_nocancel

三、strace 调试


#参数1:9是epoll_create创建文件描述符,等待事件触发,1代表rdlist就绪队列有事件要处理

epoll_wait(9, [{EPOLLIN, {u32=14344048, u64=14344048}}], 512, -1) = 1

#接收client请求,3是socket的文件描述符

accept4(17, {sa_family=AF_INET, sin_port=htons(57695), sin_addr=inet_addr("10.2.82.135")}, [16], SOCK_NONBLOCK) = 3

#将3 (accept4 产生)加入到epoll的事件监听机制

epoll_ctl(9, EPOLL_CTL_ADD, 3, {EPOLLIN|EPOLLRDHUP|EPOLLET, {u32=14344720, u64=14344720}}) = 0

#等待就绪事件,1表示有事件要处理

epoll_wait(9, [{EPOLLIN, {u32=14344720, u64=14344720}}], 512, 60000) = 1

#从client接收数据,长度484字节

recvfrom(3, "GET /ae/test HTTP/1.1\r\nHost: tem"..., 16384, 0, NULL, NULL) = 484

#判断_not_exists_是否存在,-1表示不存在

stat("/usr/local/nginx/html/_not_exists_", 0x7fff9e42c1c0) = -1 ENOENT (No such file or directory)

#更新事件注册

epoll_ctl(9, EPOLL_CTL_MOD, 3, {EPOLLIN|EPOLLOUT|EPOLLRDHUP|EPOLLET, {u32=14344720, u64=14344720}}) = 0

#初始化新的socket 4

socket(AF_INET, SOCK_STREAM, IPPROTO_IP) = 4

#对设备的I/O通道进行管理,0表示成功

ioctl(4, FIONBIO, [1])                  = 0

#将socket 4 加入epoll的事件监听机制

epoll_ctl(9, EPOLL_CTL_ADD, 4, {EPOLLIN|EPOLLOUT|EPOLLRDHUP|EPOLLET, {u32=14344944, u64=14344944}}) = 0

# socket 4 建立连接

connect(4, {sa_family=AF_INET, sin_port=htons(8080), sin_addr=inet_addr("127.0.0.1")}, 16) = -1 EINPROGRESS (Operation now in progress)

#rdlist就绪队列里有两个事件待处理

epoll_wait(9, [{EPOLLOUT, {u32=14344720, u64=14344720}}, {EPOLLOUT, {u32=14344944, u64=14344944}}], 512, 60000) = 2

#获取套接字的选项信息

# 第一个参数:socket套接字

# 第二个参数:套接字层次

# 第三个参数:要获取的信息项

getsockopt(4, SOL_SOCKET, SO_ERROR, [0], [4]) = 0

#响应头509字节内容写入socket4缓冲区

writev(4, [{"GET /ae/test HTTP/1.0\r\nX-Forward"..., 509}], 1) = 509

#rdlist就绪队列里有一个事件待处理,即socket 3

epoll_wait(9, [{EPOLLIN|EPOLLOUT|EPOLLRDHUP, {u32=14344944, u64=14344944}}], 512, 60000) = 1

#从socket 4 读取响应头及内容

recvfrom(4, "HTTP/1.0 200 OK\r\nContent-Length:"..., 4096, 0, NULL, NULL) = 4096

readv(4, [{"m&#39; =&gt; &#39;input&#39;,\n  "..., 4096}], 1) = 4096

readv(4, [{"  &#39;file_size&#39; =&gt; 0,\n "..., 4096}], 1) = 4096

readv(4, [{"put&#39;,\r\n      &#39;rule&#39; "..., 4096}], 1) = 4096

readv(4, [{"#39;2&#39; =&gt; array(\r\n      "..., 4096}], 1) = 4096

readv(4, [{"  &#39;file_size&#39; =&gt; arr"..., 4096}], 1) = 4096

readv(4, [{"\r\n        &#39;file_size&#39; =&"..., 4096}], 1) = 4096

readv(4, [{"            &#39;predownload&#39"..., 4096}], 1) = 4096

readv(4, [{"y (\n      &#39;label&#39; =&gt; "..., 4096}], 1) = 4096

#向socket 3 写入数据

writev(3, [{"HTTP/1.1 200 OK\r\nServer: nginx/1"..., 165}, {"<!DOCTYPE html>\n<html>\n  <head>\n"..., 3949}, {"m&#39; =&gt; &#39;input&#39;,\n  "..., 4096}], 3) = 8210

writev(3, [{"  &#39;file_size&#39; =&gt; 0,\n "..., 4096}, {"put&#39;,\r\n      &#39;rule&#39; "..., 4096}], 2) = 8192

writev(3, [{"#39;2&#39; =&gt; array(\r\n      "..., 4096}, {"  &#39;file_size&#39; =&gt; arr"..., 4096}], 2) = 8192

writev(3, [{"\r\n        &#39;file_size&#39; =&"..., 4096}, {"            &#39;predownload&#39"..., 4096}], 2) = 8192

writev(3, [{"y (\n      &#39;label&#39; =&gt; "..., 4096}], 1) = 4096

readv(4, [{"  array(\n                    &#3"..., 4096}, {"9;file_ext&#39; =&gt; &#39;mp4,g"..., 4096}, {"\r\n    <div class=\"col-md-1\">9</d"..., 4096}, {"=&gt; array(\r\n    &#39;gotourl&#"..., 4096}, {"tle\" id=\"exampleModalScrollableT"..., 4096}, {"", 4096}, {"", 4096}, {"", 4096}, {"", 4096}], 9) = 17810

readv(4, [{"", 2670}, {"", 4096}, {"", 4096}, {"", 4096}, {"", 4096}], 5) = 0

writev(3, [{"  array(\n                    &#3"..., 4096}, {"9;file_ext&#39; =&gt; &#39;mp4,g"..., 4096}, {"\r\n    <div class=\"col-md-1\">9</d"..., 4096}, {"=&gt; array(\r\n    &#39;gotourl&#"..., 4096}, {"tle\" id=\"exampleModalScrollableT"..., 1426}], 5) = 17810

#关闭socket 4

close(4)                                = 0

write(28, "10.2.82.135 - - [24/Mar/2020:12:"..., 220) = 220

setsockopt(3, SOL_TCP, TCP_NODELAY, [1], 4) = 0

#查看epoll的rdlist就绪队列是否有事件,0表示无

epoll_wait(9, [], 512, 65000)          = 0

#关闭socket 3

close(3)                                = 0

#继续等待事件触发

epoll_wait(9,

整个过程,你应该清晰的知道epoll对象上的rdlist就绪队列和rbtree的变化情况

延伸阅读

nginx 源码注释项目

参考文档
1 epoll_create
2 strace工具
3 nginx 源码注释

©著作权归作者所有,转载或内容合作请联系作者
  • 序言:七十年代末,一起剥皮案震惊了整个滨河市,随后出现的几起案子,更是在滨河造成了极大的恐慌,老刑警刘岩,带你破解...
    沈念sama阅读 216,324评论 6 498
  • 序言:滨河连续发生了三起死亡事件,死亡现场离奇诡异,居然都是意外死亡,警方通过查阅死者的电脑和手机,发现死者居然都...
    沈念sama阅读 92,356评论 3 392
  • 文/潘晓璐 我一进店门,熙熙楼的掌柜王于贵愁眉苦脸地迎上来,“玉大人,你说我怎么就摊上这事。” “怎么了?”我有些...
    开封第一讲书人阅读 162,328评论 0 353
  • 文/不坏的土叔 我叫张陵,是天一观的道长。 经常有香客问我,道长,这世上最难降的妖魔是什么? 我笑而不...
    开封第一讲书人阅读 58,147评论 1 292
  • 正文 为了忘掉前任,我火速办了婚礼,结果婚礼上,老公的妹妹穿的比我还像新娘。我一直安慰自己,他们只是感情好,可当我...
    茶点故事阅读 67,160评论 6 388
  • 文/花漫 我一把揭开白布。 她就那样静静地躺着,像睡着了一般。 火红的嫁衣衬着肌肤如雪。 梳的纹丝不乱的头发上,一...
    开封第一讲书人阅读 51,115评论 1 296
  • 那天,我揣着相机与录音,去河边找鬼。 笑死,一个胖子当着我的面吹牛,可吹牛的内容都是我干的。 我是一名探鬼主播,决...
    沈念sama阅读 40,025评论 3 417
  • 文/苍兰香墨 我猛地睁开眼,长吁一口气:“原来是场噩梦啊……” “哼!你这毒妇竟也来了?” 一声冷哼从身侧响起,我...
    开封第一讲书人阅读 38,867评论 0 274
  • 序言:老挝万荣一对情侣失踪,失踪者是张志新(化名)和其女友刘颖,没想到半个月后,有当地人在树林里发现了一具尸体,经...
    沈念sama阅读 45,307评论 1 310
  • 正文 独居荒郊野岭守林人离奇死亡,尸身上长有42处带血的脓包…… 初始之章·张勋 以下内容为张勋视角 年9月15日...
    茶点故事阅读 37,528评论 2 332
  • 正文 我和宋清朗相恋三年,在试婚纱的时候发现自己被绿了。 大学时的朋友给我发了我未婚夫和他白月光在一起吃饭的照片。...
    茶点故事阅读 39,688评论 1 348
  • 序言:一个原本活蹦乱跳的男人离奇死亡,死状恐怖,灵堂内的尸体忽然破棺而出,到底是诈尸还是另有隐情,我是刑警宁泽,带...
    沈念sama阅读 35,409评论 5 343
  • 正文 年R本政府宣布,位于F岛的核电站,受9级特大地震影响,放射性物质发生泄漏。R本人自食恶果不足惜,却给世界环境...
    茶点故事阅读 41,001评论 3 325
  • 文/蒙蒙 一、第九天 我趴在偏房一处隐蔽的房顶上张望。 院中可真热闹,春花似锦、人声如沸。这庄子的主人今日做“春日...
    开封第一讲书人阅读 31,657评论 0 22
  • 文/苍兰香墨 我抬头看了看天上的太阳。三九已至,却和暖如春,着一层夹袄步出监牢的瞬间,已是汗流浃背。 一阵脚步声响...
    开封第一讲书人阅读 32,811评论 1 268
  • 我被黑心中介骗来泰国打工, 没想到刚下飞机就差点儿被人妖公主榨干…… 1. 我叫王不留,地道东北人。 一个月前我还...
    沈念sama阅读 47,685评论 2 368
  • 正文 我出身青楼,却偏偏与公主长得像,于是被迫代替她去往敌国和亲。 传闻我的和亲对象是个残疾皇子,可洞房花烛夜当晚...
    茶点故事阅读 44,573评论 2 353

推荐阅读更多精彩内容