cddl/contrib/dtracetoolkit/Examples/sh_syscolors_example.txt

   1 The following are examples of sh_syscolors.d.
   2
   3 This is a simple script to trace the flow of Shell functions, lines, and
   4 system calls made. It renders the output in color ("colour") using terminal
   5 escape sequences (which you can tweak by modifying the script).
   6
   7 Here it traces the example program, Code/Shell/func_abc.sh.
   8
   9 WARNING: This output is full of terminal escape sequences, so if you are
  10 trying to view this through an editor or web browser - it may look awful.
  11 Try viewing this using "more" (although, depending on your terminal, it
  12 still may look awful).
  13
  14 # sh_syscolors.d -c ./func_abc.sh -o /tmp/out
  15 Function A
  16 Function B
  17 Function C
  18
  19 # cat /tmp/out
  20 C    PID  DELTA(us)              FILE:LINE TYPE     -- NAME
  21 \e[2;32m0  12979          2       func_abc.sh:-    syscall  -> munmap\e[0m
  22 \e[2;32m0  12979         35       func_abc.sh:-    syscall  <- munmap\e[0m
  23 \e[2;32m0  12979         56       func_abc.sh:-    syscall  -> mmap\e[0m
  24 \e[2;32m0  12979         18       func_abc.sh:-    syscall  <- mmap\e[0m
  25 \e[2;32m0  12979         40       func_abc.sh:-    syscall  -> setcontext\e[0m
  26 \e[2;32m0  12979         11       func_abc.sh:-    syscall  <- setcontext\e[0m
  27 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> getrlimit\e[0m
  28 \e[2;32m0  12979         11       func_abc.sh:-    syscall  <- getrlimit\e[0m
  29 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> getpid\e[0m
  30 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- getpid\e[0m
  31 \e[2;32m0  12979         61       func_abc.sh:-    syscall  -> setcontext\e[0m
  32 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- setcontext\e[0m
  33 \e[2;32m0  12979        865       func_abc.sh:-    syscall  -> sysi86\e[0m
  34 \e[2;32m0  12979         14       func_abc.sh:-    syscall  <- sysi86\e[0m
  35 \e[2;32m0  12979         84       func_abc.sh:-    syscall  -> open64\e[0m
  36 \e[2;32m0  12979         89       func_abc.sh:-    syscall  <- open64\e[0m
  37 \e[2;32m0  12979         14       func_abc.sh:-    syscall  -> ioctl\e[0m
  38 \e[2;32m0  12979         35       func_abc.sh:-    syscall  <- ioctl\e[0m
  39 \e[2;32m0  12979         15       func_abc.sh:-    syscall  -> close\e[0m
  40 \e[2;32m0  12979         16       func_abc.sh:-    syscall  <- close\e[0m
  41 \e[2;32m0  12979        119       func_abc.sh:-    syscall  -> getpid\e[0m
  42 \e[2;32m0  12979         10       func_abc.sh:-    syscall  <- getpid\e[0m
  43 \e[2;32m0  12979         17       func_abc.sh:-    syscall  -> setpgrp\e[0m
  44 \e[2;32m0  12979         10       func_abc.sh:-    syscall  <- setpgrp\e[0m
  45 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> setpgrp\e[0m
  46 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- setpgrp\e[0m
  47 \e[2;32m0  12979         12       func_abc.sh:-    syscall  -> access\e[0m
  48 \e[2;32m0  12979         20       func_abc.sh:-    syscall  <- access\e[0m
  49 \e[2;32m0  12979         15       func_abc.sh:-    syscall  -> brk\e[0m
  50 \e[2;32m0  12979         11       func_abc.sh:-    syscall  <- brk\e[0m
  51 \e[2;32m0  12979         15       func_abc.sh:-    syscall  -> sysconfig\e[0m
  52 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sysconfig\e[0m
  53 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sysconfig\e[0m
  54 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sysconfig\e[0m
  55 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> sigaltstack\e[0m
  56 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaltstack\e[0m
  57 \e[2;32m0  12979         16       func_abc.sh:-    syscall  -> sigaction\e[0m
  58 \e[2;32m0  12979         10       func_abc.sh:-    syscall  <- sigaction\e[0m
  59 \e[2;32m0  12979         12       func_abc.sh:-    syscall  -> sigaction\e[0m
  60 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  61 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  62 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  63 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  64 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  65 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> sigaction\e[0m
  66 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  67 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  68 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  69 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  70 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  71 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  72 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
  73 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  74 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
  75 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  76 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  77 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  78 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  79 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  80 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  81 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  82 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  83 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  84 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  85 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  86 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  87 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  88 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  89 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  90 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
  91 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  92 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
  93 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  94 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  95 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  96 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  97 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
  98 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
  99 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 100 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 101 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 102 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 103 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 104 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 105 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 106 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 107 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> sigaction\e[0m
 108 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 109 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 110 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 111 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 112 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 113 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 114 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 115 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 116 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 117 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 118 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 119 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 120 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 121 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 122 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 123 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 124 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 125 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 126 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 127 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 128 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 129 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 130 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 131 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 132 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 133 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 134 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 135 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> sigaction\e[0m
 136 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 137 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 138 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 139 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 140 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 141 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 142 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 143 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 144 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 145 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 146 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 147 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 148 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 149 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 150 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 151 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 152 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 153 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 154 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 155 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 156 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 157 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 158 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 159 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> sigaction\e[0m
 160 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- sigaction\e[0m
 161 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> sigaction\e[0m
 162 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- sigaction\e[0m
 163 \e[2;32m0  12979         61       func_abc.sh:-    syscall  -> brk\e[0m
 164 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- brk\e[0m
 165 \e[2;32m0  12979         13       func_abc.sh:-    syscall  -> getuid\e[0m
 166 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- getuid\e[0m
 167 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> getuid\e[0m
 168 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- getuid\e[0m
 169 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> getgid\e[0m
 170 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- getgid\e[0m
 171 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> getgid\e[0m
 172 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- getgid\e[0m
 173 \e[2;32m0  12979         15       func_abc.sh:-    syscall  -> open64\e[0m
 174 \e[2;32m0  12979         19       func_abc.sh:-    syscall  <- open64\e[0m
 175 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> close\e[0m
 176 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- close\e[0m
 177 \e[2;32m0  12979         24       func_abc.sh:-    syscall  -> fcntl\e[0m
 178 \e[2;32m0  12979         23       func_abc.sh:-    syscall  <- fcntl\e[0m
 179 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> close\e[0m
 180 \e[2;32m0  12979         10       func_abc.sh:-    syscall  <- close\e[0m
 181 \e[2;32m0  12979          9       func_abc.sh:-    syscall  -> fcntl\e[0m
 182 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- fcntl\e[0m
 183 \e[2;32m0  12979         28       func_abc.sh:-    syscall  -> ioctl\e[0m
 184 \e[2;32m0  12979         42       func_abc.sh:-    syscall  <- ioctl\e[0m
 185 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> ioctl\e[0m
 186 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- ioctl\e[0m
 187 \e[2;32m0  12979         14       func_abc.sh:-    syscall  -> read\e[0m
 188 \e[2;32m0  12979         33       func_abc.sh:-    syscall  <- read\e[0m
 189 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> brk\e[0m
 190 \e[2;32m0  12979         21       func_abc.sh:-    syscall  <- brk\e[0m
 191 \e[2;32m0  12979         12       func_abc.sh:-    syscall  -> brk\e[0m
 192 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- brk\e[0m
 193 \e[2;32m0  12979         19       func_abc.sh:-    syscall  -> brk\e[0m
 194 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- brk\e[0m
 195 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> brk\e[0m
 196 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- brk\e[0m
 197 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> read\e[0m
 198 \e[2;32m0  12979         15       func_abc.sh:-    syscall  <- read\e[0m
 199 \e[2;32m0  12979         28       func_abc.sh:-    syscall  -> brk\e[0m
 200 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- brk\e[0m
 201 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> brk\e[0m
 202 \e[2;32m0  12979          8       func_abc.sh:-    syscall  <- brk\e[0m
 203 \e[1;35m0  12979         14       func_abc.sh:23   line     -- \e[0m
 204 \e[2;35m0  12979         32       func_abc.sh:23   func     -> func_a\e[0m
 205 \e[1;35m0  12979         16       func_abc.sh:18   line       -- \e[0m
 206 \e[2;35m0  12979         18       func_abc.sh:18   builtin    -> echo\e[0m
 207 \e[2;32m0  12979         21       func_abc.sh:-    syscall      -> write\e[0m
 208 \e[2;32m0  12979         33       func_abc.sh:-    syscall      <- write\e[0m
 209 \e[2;35m0  12979        311       func_abc.sh:0    builtin    <- echo\e[0m
 210 \e[1;35m0  12979         65       func_abc.sh:19   line       -- \e[0m
 211 \e[2;32m0  12979         17       func_abc.sh:-    syscall    -> getuid\e[0m
 212 \e[2;32m0  12979         10       func_abc.sh:-    syscall    <- getuid\e[0m
 213 \e[2;32m0  12979         15       func_abc.sh:-    syscall    -> stat64\e[0m
 214 \e[2;32m0  12979         25       func_abc.sh:-    syscall    <- stat64\e[0m
 215 \e[2;32m0  12979         11       func_abc.sh:-    syscall    -> access\e[0m
 216 \e[2;32m0  12979         15       func_abc.sh:-    syscall    <- access\e[0m
 217 \e[2;32m0  12979         18       func_abc.sh:-    syscall    -> schedctl\e[0m
 218 \e[2;32m0  12979         46       func_abc.sh:-    syscall    <- schedctl\e[0m
 219 \e[2;32m0  12979        220       func_abc.sh:-    syscall    -> fork1\e[0m
 220 \e[2;32m0  12979     258957       func_abc.sh:-    syscall    <- fork1\e[0m
 221 \e[2;32m0  12979        244       func_abc.sh:-    syscall    -> lwp_sigmask\e[0m
 222 \e[2;32m0  12979         16       func_abc.sh:-    syscall    <- lwp_sigmask\e[0m
 223 \e[2;35m0  12979         31       func_abc.sh:19   cmd        -> sleep\e[0m
 224 \e[2;32m0  12979         53       func_abc.sh:-    syscall      -> waitsys\e[0m
 225 \e[2;32m0  12979    1008036       func_abc.sh:-    syscall      <- waitsys\e[0m
 226 \e[2;32m0  12979         38       func_abc.sh:-    syscall      -> ioctl\e[0m
 227 \e[2;32m0  12979         18       func_abc.sh:-    syscall      <- ioctl\e[0m
 228 \e[2;32m0  12979         12       func_abc.sh:-    syscall      -> setpgrp\e[0m
 229 \e[2;32m0  12979         10       func_abc.sh:-    syscall      <- setpgrp\e[0m
 230 \e[2;32m0  12979          9       func_abc.sh:-    syscall      -> ioctl\e[0m
 231 \e[2;32m0  12979          9       func_abc.sh:-    syscall      <- ioctl\e[0m
 232 \e[2;32m0  12979         11       func_abc.sh:-    syscall      -> ioctl\e[0m
 233 \e[2;32m0  12979         37       func_abc.sh:-    syscall      <- ioctl\e[0m
 234 \e[2;32m0  12979         12       func_abc.sh:-    syscall      -> waitsys\e[0m
 235 \e[2;32m0  12979         26       func_abc.sh:-    syscall      <- waitsys\e[0m
 236 \e[2;35m0  12979         14       func_abc.sh:0    cmd        <- sleep\e[0m
 237 \e[1;35m0  12979         21       func_abc.sh:20   line       -- \e[0m
 238 \e[2;35m0  12979         28       func_abc.sh:20   func       -> func_b\e[0m
 239 \e[1;35m0  12979         15       func_abc.sh:11   line         -- \e[0m
 240 \e[2;35m0  12979         17       func_abc.sh:11   builtin      -> echo\e[0m
 241 \e[2;32m0  12979         19       func_abc.sh:-    syscall        -> write\e[0m
 242 \e[2;32m0  12979         33       func_abc.sh:-    syscall        <- write\e[0m
 243 \e[2;35m0  12979        310       func_abc.sh:0    builtin      <- echo\e[0m
 244 \e[1;35m0  12979         16       func_abc.sh:12   line         -- \e[0m
 245 \e[2;32m0  12979        226       func_abc.sh:-    syscall      -> fork1\e[0m
 246 \e[2;32m0  12979      64931       func_abc.sh:-    syscall      <- fork1\e[0m
 247 \e[2;32m0  12979        262       func_abc.sh:-    syscall      -> lwp_sigmask\e[0m
 248 \e[2;32m0  12979         16       func_abc.sh:-    syscall      <- lwp_sigmask\e[0m
 249 \e[2;35m0  12979         31       func_abc.sh:12   cmd          -> sleep\e[0m
 250 \e[2;32m0  12979         31       func_abc.sh:-    syscall        -> waitsys\e[0m
 251 \e[2;32m0  12979    1003941       func_abc.sh:-    syscall        <- waitsys\e[0m
 252 \e[2;32m0  12979         30       func_abc.sh:-    syscall        -> ioctl\e[0m
 253 \e[2;32m0  12979         19       func_abc.sh:-    syscall        <- ioctl\e[0m
 254 \e[2;32m0  12979         11       func_abc.sh:-    syscall        -> setpgrp\e[0m
 255 \e[2;32m0  12979          9       func_abc.sh:-    syscall        <- setpgrp\e[0m
 256 \e[2;32m0  12979          9       func_abc.sh:-    syscall        -> ioctl\e[0m
 257 \e[2;32m0  12979          9       func_abc.sh:-    syscall        <- ioctl\e[0m
 258 \e[2;32m0  12979          9       func_abc.sh:-    syscall        -> ioctl\e[0m
 259 \e[2;32m0  12979         38       func_abc.sh:-    syscall        <- ioctl\e[0m
 260 \e[2;32m0  12979         11       func_abc.sh:-    syscall        -> waitsys\e[0m
 261 \e[2;32m0  12979         26       func_abc.sh:-    syscall        <- waitsys\e[0m
 262 \e[2;35m0  12979         14       func_abc.sh:0    cmd          <- sleep\e[0m
 263 \e[1;35m0  12979         33       func_abc.sh:13   line         -- \e[0m
 264 \e[2;35m0  12979         27       func_abc.sh:13   func         -> func_c\e[0m
 265 \e[1;35m0  12979         15       func_abc.sh:5    line           -- \e[0m
 266 \e[2;35m0  12979         17       func_abc.sh:5    builtin        -> echo\e[0m
 267 \e[2;32m0  12979         20       func_abc.sh:-    syscall          -> write\e[0m
 268 \e[2;32m0  12979         33       func_abc.sh:-    syscall          <- write\e[0m
 269 \e[2;35m0  12979        309       func_abc.sh:0    builtin        <- echo\e[0m
 270 \e[1;35m0  12979         17       func_abc.sh:6    line           -- \e[0m
 271 \e[2;32m0  12979        267       func_abc.sh:-    syscall        -> fork1\e[0m
 272 \e[2;32m0  12979      64649       func_abc.sh:-    syscall        <- fork1\e[0m
 273 \e[2;32m0  12979        257       func_abc.sh:-    syscall        -> lwp_sigmask\e[0m
 274 \e[2;32m0  12979         16       func_abc.sh:-    syscall        <- lwp_sigmask\e[0m
 275 \e[2;35m0  12979         31       func_abc.sh:6    cmd            -> sleep\e[0m
 276 \e[2;32m0  12979         31       func_abc.sh:-    syscall          -> waitsys\e[0m
 277 \e[2;32m0  12979    1004183       func_abc.sh:-    syscall          <- waitsys\e[0m
 278 \e[2;32m0  12979         31       func_abc.sh:-    syscall          -> ioctl\e[0m
 279 \e[2;32m0  12979         18       func_abc.sh:-    syscall          <- ioctl\e[0m
 280 \e[2;32m0  12979         11       func_abc.sh:-    syscall          -> setpgrp\e[0m
 281 \e[2;32m0  12979          9       func_abc.sh:-    syscall          <- setpgrp\e[0m
 282 \e[2;32m0  12979          9       func_abc.sh:-    syscall          -> ioctl\e[0m
 283 \e[2;32m0  12979          9       func_abc.sh:-    syscall          <- ioctl\e[0m
 284 \e[2;32m0  12979          9       func_abc.sh:-    syscall          -> ioctl\e[0m
 285 \e[2;32m0  12979         38       func_abc.sh:-    syscall          <- ioctl\e[0m
 286 \e[2;32m0  12979         12       func_abc.sh:-    syscall          -> waitsys\e[0m
 287 \e[2;32m0  12979         27       func_abc.sh:-    syscall          <- waitsys\e[0m
 288 \e[2;35m0  12979         14       func_abc.sh:0    cmd            <- sleep\e[0m
 289 \e[2;35m0  12979         32       func_abc.sh:-    func         <- func_c\e[0m
 290 \e[2;35m0  12979         16       func_abc.sh:-    func       <- func_b\e[0m
 291 \e[2;35m0  12979         10       func_abc.sh:-    func     <- func_a\e[0m
 292 \e[2;32m0  12979         13       func_abc.sh:-    syscall  -> brk\e[0m
 293 \e[2;32m0  12979         12       func_abc.sh:-    syscall  <- brk\e[0m
 294 \e[2;32m0  12979         12       func_abc.sh:-    syscall  -> read\e[0m
 295 \e[2;32m0  12979         16       func_abc.sh:-    syscall  <- read\e[0m
 296 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> ioctl\e[0m
 297 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- ioctl\e[0m
 298 \e[2;32m0  12979         10       func_abc.sh:-    syscall  -> ioctl\e[0m
 299 \e[2;32m0  12979          9       func_abc.sh:-    syscall  <- ioctl\e[0m
 300 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> close\e[0m
 301 \e[2;32m0  12979         13       func_abc.sh:-    syscall  <- close\e[0m
 302 \e[2;32m0  12979         37       func_abc.sh:-    syscall  -> open64\e[0m
 303 \e[2;32m0  12979        105       func_abc.sh:-    syscall  <- open64\e[0m
 304 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> ioctl\e[0m
 305 \e[2;32m0  12979         11       func_abc.sh:-    syscall  <- ioctl\e[0m
 306 \e[2;32m0  12979         11       func_abc.sh:-    syscall  -> close\e[0m
 307 \e[2;32m0  12979         15       func_abc.sh:-    syscall  <- close\e[0m
 308 \e[2;32m0  12979         31       func_abc.sh:-    syscall  -> rexit\e[0m
 309
 310 Here you can see the output showing the path the script follows as it is
 311 executed.
 312
 313 ie:
 314 \e[1;35m0  12979         14       func_abc.sh:23   line     -- \e[0m
 315 \e[2;35m0  12979         32       func_abc.sh:23   func     -> func_a\e[0m
 316 \e[1;35m0  12979         16       func_abc.sh:18   line       -- \e[0m
 317 \e[2;35m0  12979         18       func_abc.sh:18   builtin    -> echo\e[0m
 318 \e[2;32m0  12979         21       func_abc.sh:-    syscall      -> write\e[0m
 319 \e[2;32m0  12979         33       func_abc.sh:-    syscall      <- write\e[0m
 320 \e[2;35m0  12979        311       func_abc.sh:0    builtin    <- echo\e[0m
 321 \e[1;35m0  12979         65       func_abc.sh:19   line       -- \e[0m
 322
 323 shows that on CPU 0 we run func_a (which is line 23 of the example script),
 324 where it uses the shell built-in echo command (on line 18 of the example
 325 script) to write a line of text to the screen. You can see in column 3 (the
 326 delta time) it takes 311 microseconds from when the write syscall finishes to
 327 when the echo built-in completes its clean-up and finishes.
 328