檢視原始碼 LTTng 與 Erlang/OTP

簡介

Linux Trace Toolkit：next generation 是一個開源系統軟體套件，用於關聯追蹤 Linux 核心、使用者應用程式和函式庫。

更多資訊，請瀏覽 http://lttng.org

建置支援 LTTng 的 Erlang/OTP

設定並建置支援 LTTng 的 Erlang

為了使 LTTng 能正常與 Erlang/OTP 運作，您需要安裝以下套件

  • LTTng-tools：一個用於控制追蹤會話的命令列介面。
  • LTTng-UST：使用者空間追蹤函式庫。

在 Ubuntu 上，這可以透過 aptitude 安裝

$ sudo aptitude install lttng-tools liblttng-ust-dev

請參閱 安裝 LTTng 以取得更多關於如何在您的系統上安裝 LTTng 的資訊。

在系統上正確安裝 LTTng 之後，就可以建置支援 LTTng 的 Erlang/OTP。

$ ./configure --with-dynamic-trace=lttng
$ make

Dyntrace 追蹤點

所有追蹤點都在 org_erlang_dyntrace 的網域中

所有 Erlang 類型在 LTTng 中都是字串等價物。

process_spawn

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • parent : string :: 處理序 ID。範例："<0.131.0>"
  • entry : string :: 程式碼位置。範例："lists:sort/1"

透過 erlang:trace/3 與追蹤旗標 procs 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

process_spawn: { cpu_id = 3 }, { pid = "<0.131.0>", parent = "<0.130.0>", entry = "erlang:apply/2" }

process_link

  • to : string :: 處理序 ID 或 Port ID。範例："<0.131.0>"
  • from : string :: 處理序 ID 或 Port ID。範例："<0.131.0>"

  • type : string :: "link" | "unlink"

透過 erlang:trace/3 與追蹤旗標 procs 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

process_link: { cpu_id = 3 }, { from = "<0.130.0>", to = "<0.131.0>", type = "link" }

process_exit

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • reason : string :: 結束原因。範例："normal"

透過 erlang:trace/3 與追蹤旗標 procs 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

process_exit: { cpu_id = 3 }, { pid = "<0.130.0>", reason = "normal" }

process_register

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • name : string :: 已註冊的名稱。範例："logger"

  • type : string :: "register" | "unregister"

範例

process_register: { cpu_id = 0 }, { pid = "<0.128.0>", name = "dyntrace_lttng_SUITE" type = "register" }

process_scheduled

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • entry : string :: 程式碼位置。範例："lists:sort/1"
  • type : string :: "in" | "out" | "in_exiting" | "out_exiting" | "out_exited"

透過 erlang:trace/3 與追蹤旗標 running 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

process_scheduled: { cpu_id = 0 }, { pid = "<0.136.0>", entry = "erlang:apply/2", type = "in" }

port_open

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"
  • port : string :: Port ID。範例："#Port<0.1031>"

透過 erlang:trace/3 與追蹤旗標 ports 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

port_open: { cpu_id = 5 }, { pid = "<0.131.0>", driver = "'/bin/sh -s unix:cmd'", port = "#Port<0.1887>" }

port_exit

  • port : string :: Port ID。範例："#Port<0.1031>"
  • reason : string :: 結束原因。範例："normal"

透過 erlang:trace/3 與追蹤旗標 ports 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

port_exit: { cpu_id = 5 }, { port = "#Port<0.1887>", reason = "normal" }

port_link

  • to : string :: 處理序 ID。範例："<0.131.0>"
  • from : string :: 處理序 ID。範例："<0.131.0>"

  • type : string :: "link" | "unlink"

透過 erlang:trace/3 與追蹤旗標 ports 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

port_link: { cpu_id = 5 }, { from = "#Port<0.1887>", to = "<0.131.0>", type = "unlink" }

port_scheduled

透過 erlang:trace/3 與追蹤旗標 running 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

  • port : string :: Port ID。範例："#Port<0.1031>"
  • entry : string :: 回呼。範例："open"
  • type : string :: "in" | "out" | "in_exiting" | "out_exiting" | "out_exited"

範例

port_scheduled: { cpu_id = 5 }, { pid = "#Port<0.1905>", entry = "close", type = "out" }

透過 erlang:trace/3 與追蹤旗標 running 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

function_call

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • entry : string :: 程式碼位置。範例："lists:sort/1"
  • depth : integer :: 堆疊深度。範例：0

透過 erlang:trace/3 與追蹤旗標 call 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

function_call: { cpu_id = 5 }, { pid = "<0.145.0>", entry = "dyntrace_lttng_SUITE:'-t_call/1-fun-1-'/0", depth = 0 }

function_return

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • entry : string :: 程式碼位置。範例："lists:sort/1"
  • depth : integer :: 堆疊深度。範例：0

透過 erlang:trace/3 與追蹤旗標 call 或 return_to 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

function_return: { cpu_id = 5 }, { pid = "<0.145.0>", entry = "dyntrace_lttng_SUITE:waiter/0", depth = 0 }

function_exception

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • entry : string :: 程式碼位置。範例："lists:sort/1"
  • class : string :: 錯誤原因。範例："error"

透過 erlang:trace/3 與追蹤旗標 call 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

function_exception: { cpu_id = 5 }, { pid = "<0.144.0>", entry = "t:call_exc/1", class = "error" }

message_send

  • from : string :: 處理序 ID 或 Port ID。範例："<0.131.0>"
  • to : string :: 處理序 ID 或 Port ID。範例："<0.131.0>"
  • message : string :: 已傳送的訊息。範例："{<0.162.0>,ok}"

透過 erlang:trace/3 與追蹤旗標 send 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

message_send: { cpu_id = 3 }, { from = "#Port<0.1938>", to = "<0.160.0>", message = "{#Port<0.1938>,eof}" }

message_receive

  • to : string :: 處理序 ID 或 Port ID。範例："<0.131.0>"
  • message : string :: 已接收的訊息。範例："{<0.162.0>,ok}"

透過 erlang:trace/3 與追蹤旗標 'receive' 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

message_receive: { cpu_id = 7 }, { to = "<0.167.0>", message = "{<0.165.0>,ok}" }

gc_minor_start

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • need : integer :: 堆積需求。範例：2
  • heap : integer :: 年輕堆積字組大小。範例：233
  • old_heap : integer :: 舊堆積字組大小。範例：233

透過 erlang:trace/3 與追蹤旗標 garbage_collection 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

gc_minor_start: { cpu_id = 0 }, { pid = "<0.172.0>", need = 0, heap = 610, old_heap = 0 }

gc_minor_end

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • reclaimed : integer :: 已回收的堆積。範例：2
  • heap : integer :: 年輕堆積字組大小。範例：233
  • old_heap : integer :: 舊堆積字組大小。範例：233

透過 erlang:trace/3 與追蹤旗標 garbage_collection 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

gc_minor_end: { cpu_id = 0 }, { pid = "<0.172.0>", reclaimed = 120, heap = 1598, old_heap = 1598 }

gc_major_start

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • need : integer :: 堆積需求。範例：2
  • heap : integer :: 年輕堆積字組大小。範例：233
  • old_heap : integer :: 舊堆積字組大小。範例：233

透過 erlang:trace/3 與追蹤旗標 garbage_collection 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

gc_major_start: { cpu_id = 0 }, { pid = "<0.172.0>", need = 8, heap = 2586, old_heap = 1598 }

gc_major_end

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • reclaimed : integer :: 已回收的堆積。範例：2
  • heap : integer :: 年輕堆積字組大小。範例：233
  • old_heap : integer :: 舊堆積字組大小。範例：233

透過 erlang:trace/3 與追蹤旗標 garbage_collection 和 {tracer,dyntrace,[]} 作為追蹤器模組提供。

範例

gc_major_end: { cpu_id = 0 }, { pid = "<0.172.0>", reclaimed = 240, heap = 4185, old_heap = 0 }

BEAM 追蹤點

所有追蹤點都在 org_erlang_otp 的網域中

所有 Erlang 類型在 LTTng 中都是字串等價物。

driver_init

  • driver : string :: 驅動程式名稱。範例："tcp_inet"
  • major : integer :: 主要版本。範例：3
  • minor : integer :: 次要版本。範例：1
  • flags : integer :: 旗標。範例：1

範例

driver_init: { cpu_id = 2 }, { driver = "caller_drv", major = 3, minor = 3, flags = 1 }

driver_start

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"
  • port : string :: Port ID。範例："#Port<0.1031>"

範例

driver_start: { cpu_id = 2 }, { pid = "<0.198.0>", driver = "caller_drv", port = "#Port<0.3676>" }

driver_output

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"
  • bytes : integer :: 返回的資料大小。範例：82

範例

driver_output: { cpu_id = 2 }, { pid = "<0.198.0>", port = "#Port<0.3677>", driver = "/bin/sh -s unix:cmd", bytes = 36 }

driver_outputv

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"
  • bytes : integer :: 返回的資料大小。範例：82

範例

driver_outputv: { cpu_id = 5 }, { pid = "<0.194.0>", port = "#Port<0.3663>", driver = "tcp_inet", bytes = 3 }

driver_ready_input

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"

範例

driver_ready_input: { cpu_id = 5 }, { pid = "<0.189.0>", port = "#Port<0.3637>", driver = "inet_gethost 4 " }

driver_ready_output

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"

範例

driver_ready_output: { cpu_id = 5 }, { pid = "<0.194.0>", port = "#Port<0.3663>", driver = "tcp_inet" }

driver_timeout

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"

範例

driver_timeout: { cpu_id = 5 }, { pid = "<0.196.0>", port = "#Port<0.3664>", driver = "tcp_inet" }

driver_stop_select

  • driver : string :: 驅動程式名稱。範例："tcp_inet"

範例

driver_stop_select: { cpu_id = 5 }, { driver = "unknown" }

driver_flush

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"

範例

driver_flush: { cpu_id = 7 }, { pid = "<0.204.0>", port = "#Port<0.3686>", driver = "tcp_inet" }

driver_stop

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"

範例

driver_stop: { cpu_id = 5 }, { pid = "[]", port = "#Port<0.3673>", driver = "tcp_inet" }

driver_process_exit

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"

driver_ready_async

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"

範例

driver_ready_async: { cpu_id = 3 }, { pid = "<0.181.0>", port = "#Port<0.3622>", driver = "tcp_inet" }

driver_call

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"
  • command : integer :: 命令整數。範例：1
  • bytes : integer :: 返回的資料大小。範例：82

範例

driver_call: { cpu_id = 2 }, { pid = "<0.202.0>", port = "#Port<0.3676>", driver = "caller_drv", command = 0, bytes = 2 }

driver_control

  • pid : string :: 處理序 ID。範例："<0.131.0>"
  • port : string :: Port ID。範例："#Port<0.1031>"
  • driver : string :: 驅動程式名稱。範例："tcp_inet"
  • command : integer :: 命令整數。範例：1
  • bytes : integer :: 返回的資料大小。範例：82

範例

driver_control: { cpu_id = 3 }, { pid = "<0.32767.8191>", port = "#Port<0.0>", driver = "forker", command = 83, bytes = 32 }

carrier_create

  • type : string :: 載體類型。範例："ets_alloc"
  • instance : integer :: 配置器實例。範例：1
  • size : integer :: 載體大小。範例：262144
  • mbc_carriers : integer :: 實例中多區塊載體的數量。範例：3
  • mbc_carriers_size : integer :: 實例中多區塊載體的總大小。範例：1343488
  • mbc_blocks : integer :: 實例中多區塊的數量。範例：122
  • mbc_blocks_size : integer :: 實例中所有多區塊的總大小。範例：285296
  • sbc_carriers : integer :: 實例中單區塊載體的數量。範例：1
  • sbc_carriers_size : integer :: 實例中單區塊載體的總大小。範例：1343488
  • sbc_blocks : integer :: 實例中單區塊的數量。範例：1
  • sbc_blocks_size : integer :: 實例中所有單區塊的總大小。範例：285296

範例

carrier_create: { cpu_id = 2 }, { type = "ets_alloc", instance = 7, size = 2097152, mbc_carriers = 4, mbc_carriers_size = 3440640, mbc_blocks = 526, mbc_blocks_size = 1278576, sbc_carriers = 0, sbc_carriers_size = 0, sbc_blocks = 0, sbc_blocks_size = 0 }

carrier_destroy

  • type : string :: 載體類型。範例："ets_alloc"
  • instance : integer :: 配置器實例。範例：1
  • size : integer :: 載體大小。範例：262144
  • mbc_carriers : integer :: 實例中多區塊載體的數量。範例：3
  • mbc_carriers_size : integer :: 實例中多區塊載體的總大小。範例：1343488
  • mbc_blocks : integer :: 實例中多區塊的數量。範例：122
  • mbc_blocks_size : integer :: 實例中所有多區塊的總大小。範例：285296
  • sbc_carriers : integer :: 實例中單區塊載體的數量。範例：1
  • sbc_carriers_size : integer :: 實例中單區塊載體的總大小。範例：1343488
  • sbc_blocks : integer :: 實例中單區塊的數量。範例：1
  • sbc_blocks_size : integer :: 實例中所有單區塊的總大小。範例：285296

範例

carrier_destroy: { cpu_id = 6 }, { type = "ets_alloc", instance = 7, size = 262144, mbc_carriers = 3, mbc_carriers_size = 3178496, mbc_blocks = 925, mbc_blocks_size = 2305336, sbc_carriers = 0, sbc_carriers_size = 0, sbc_blocks = 0, sbc_blocks_size = 0 }

carrier_pool_put

  • type : string :: 載體類型。範例："ets_alloc"
  • instance : integer :: 配置器實例。範例：1
  • size : integer :: 載體大小。範例：262144

範例

carrier_pool_put: { cpu_id = 3 }, { type = "ets_alloc", instance = 5, size = 1048576 }

carrier_pool_get

  • type : string :: 載體類型。範例："ets_alloc"
  • instance : integer :: 配置器實例。範例：1
  • size : integer :: 載體大小。範例：262144

範例

carrier_pool_get: { cpu_id = 7 }, { type = "ets_alloc", instance = 4, size = 3208 }

處理序追蹤範例

一個 os_mon 和相關程式碼的處理序追蹤範例。

在 bash shell 中清除啟動 lttng。

$ lttng create erlang-demo
Spawning a session daemon
Session erlang-demo created.
Traces will be written in /home/egil/lttng-traces/erlang-demo-20160526-165920

啟動一個啟用 lttng 的 Erlang 節點。

$ erl
Erlang/OTP 19 [erts-8.0] [source-4d7b24d] [64-bit] [smp:8:8] [async-threads:10] [hipe] [kernel-poll:false] [lttng]

Eshell V8.0  (abort with ^G)
1>

載入 dyntrace 模組。

1> l(dyntrace).
{module,dyntrace}

現在可以透過 dyntrace 查看所有追蹤點，並可以透過 lttng list -u 列出。

為 Erlang 啟用 process_register LTTng 追蹤點。

$ lttng enable-event -u org_erlang_dyntrace:process_register
UST event org_erlang_dyntrace:process_register created in channel channel0

啟用新處理序的處理序追蹤，並使用 dyntrace 作為追蹤器後端。

2> erlang:trace(new,true,[procs,{tracer,dyntrace,[]}]).
0

啟動 LTTng 追蹤。

$ lttng start
Tracing started for session erlang-demo

在 Erlang 中啟動 os_mon 應用程式。

3> application:ensure_all_started(os_mon).
{ok,[sasl,os_mon]}

停止 LTTng 追蹤並檢視結果。

$ lttng stop
Tracing stopped for session erlang-demo
$ lttng view
[17:20:42.561168759] (+?.?????????) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.66.0>", name = "sasl_sup", type = "register" }
[17:20:42.561215519] (+0.000046760) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.67.0>", name = "sasl_safe_sup", type = "register" }
[17:20:42.562149024] (+0.000933505) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.68.0>", name = "alarm_handler", type = "register" }
[17:20:42.571035803] (+0.008886779) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.69.0>", name = "release_handler", type = "register" }
[17:20:42.574939868] (+0.003904065) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.74.0>", name = "os_mon_sup", type = "register" }
[17:20:42.576818712] (+0.001878844) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.75.0>", name = "disksup", type = "register" }
[17:20:42.580032013] (+0.003213301) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.76.0>", name = "memsup", type = "register" }
[17:20:42.583046339] (+0.003014326) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.78.0>", name = "cpu_sup", type = "register" }
[17:20:42.586206242] (+0.003159903) elxd1168lx9 org_erlang_dyntrace:process_register: \
    { cpu_id = 5 }, { pid = "<0.82.0>", name = "timer_server", type = "register" }