(CommandList children: [ (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:tracing) op: Equal rhs: {(/sys/kernel/debug/tracing)} spids: [163] ) ] spids: [163] ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:flock) op: Equal rhs: {(/var/tmp/.ftrace-lock)} spids: [166] ) ] spids: [166] ) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:bufsize_kb) op:Equal rhs:{(4096)} spids:[169])] spids: [169] ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_duration) op:Equal rhs:{(0)} spids:[172])] spids: [172] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:duration) op:Equal rhs:{(EmptyPart)} spids:[176])] spids: [176] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_name) op:Equal rhs:{(0)} spids:[179])] spids: [179] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:name) op:Equal rhs:{(EmptyPart)} spids:[183])] spids: [183] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_pid) op:Equal rhs:{(0)} spids:[186])] spids: [186] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:pid) op:Equal rhs:{(EmptyPart)} spids:[190])] spids: [190] ) terminator: <Op_Semi ';'> ) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:ftext) op:Equal rhs:{(EmptyPart)} spids:[193])] spids: [193] ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_start) op:Equal rhs:{(0)} spids:[195])] spids: [195] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_end) op:Equal rhs:{(0)} spids:[199])] spids: [199] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_device) op:Equal rhs:{(0)} spids:[203])] spids: [203] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:device) op:Equal rhs:{(EmptyPart)} spids:[207])] spids: [207] ) terminator: <Op_Semi ';'> ) (Sentence child: (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_iotype) op:Equal rhs:{(0)} spids:[210])] spids: [210] ) terminator: <Op_Semi ';'> ) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:iotype) op:Equal rhs:{(EmptyPart)} spids:[214])] spids: [214] ) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_queue) op:Equal rhs:{(0)} spids:[216])] spids: [216] ) (C {(trap)} {(SQ <':'>)} {(INT)} {(QUIT)} {(TERM)} {(PIPE)} {(HUP)}) (FuncDef name: usage body: (BraceGroup children: [ (SimpleCommand words: [{(cat)}] redirects: [ (HereDoc op_id: Redir_DLessDash fd: 16777215 body: { (DQ ('USAGE: iosnoop [-hQst] [-d device] [-i iotype] [-p PID] [-n name]\n') (' [duration]\n') (' -d device # device string (eg, ') (Right_DoubleQuote '"') ('202,1)\n') ( " -i iotype # match type (eg, '*R*' for all reads)\n" ) (' -n name # process name to match on I/O issue\n') (' -p PID # PID to match on I/O issue\n') (' -Q # use queue insert as start time\n') (' -s # include start time of I/O (s)\n') (' -t # include completion time of I/O (s)\n') (' -h # this usage message\n') (' duration # duration seconds, and use buffers\n') (' eg,\n') (' iosnoop # watch block I/O live (unbuffered)\n') (' iosnoop 1 # trace 1 sec (buffered)\n') (' iosnoop -Q # include queueing time in LATms\n') (' iosnoop -ts # include start and end timestamps\n') (" iosnoop -i '*R*' # trace reads\n") (' iosnoop -p 91 # show I/O issued when PID 91 is on-CPU\n') ( ' iosnoop -Qp 91 # show I/O queued by PID 91, queue time\n' ) ('\n') ('See the man page and example file for more info.\n') ) } do_expansion: True here_end: END was_filled: T spids: [248] ) (Redir op_id:Redir_GreatAnd fd:16777215 arg_word:{(2)} spids:[251]) ] ) (ControlFlow token:<ControlFlow_Exit exit>) ] spids: [243] ) spids: [239 242] ) (FuncDef name: warn body: (BraceGroup children: [ (If arms: [ (if_arm cond: [ (Sentence child: (Pipeline children:[(C {(eval)} {(DQ ($ VSub_At '$@'))})] negated:T) terminator: <Op_Semi ';'> ) ] action: [ (SimpleCommand words: [ {(echo)} { (DQ ('WARNING: command failed ') (EscapedLiteralPart token: <Lit_EscapedChar '\\"'> ) ($ VSub_At '$@') (EscapedLiteralPart token:<Lit_EscapedChar '\\"'>) ) } ] redirects: [(Redir op_id:Redir_GreatAnd fd:16777215 arg_word:{(2)} spids:[307])] ) ] spids: [16777215 302] ) ] spids: [16777215 318] ) ] spids: [288] ) spids: [284 287] ) (FuncDef name: end body: (BraceGroup children: [ (SimpleCommand words: [{(echo)}] redirects: [(Redir op_id:Redir_Great fd:2 arg_word:{(/dev/null)} spids:[336])] ) (SimpleCommand words: [{(echo)} {(DQ ('Ending tracing...'))}] redirects: [(Redir op_id:Redir_Great fd:2 arg_word:{(/dev/null)} spids:[346])] ) (C {(cd)} {($ VSub_Name '$tracing')}) (C {(warn)} {(DQ ('echo 0 > events/block/') ($ VSub_Name '$b_start') (/enable))}) (C {(warn)} {(DQ ('echo 0 > events/block/block_rq_complete/enable'))}) (If arms: [ (if_arm cond: [ (Sentence child: (DParen child: (ArithBinary op_id: Arith_DPipe left: (ArithBinary op_id: Arith_DPipe left: (ArithVarRef name:opt_device) right: (ArithVarRef name:opt_iotype) ) right: (ArithVarRef name:opt_pid) ) ) terminator: <Op_Semi ';'> ) ] action: [ (C {(warn)} {(DQ ('echo 0 > events/block/') ($ VSub_Name '$b_start') (/filter))}) (C {(warn)} {(DQ ('echo 0 > events/block/block_rq_complete/filter'))}) ] spids: [16777215 389] ) ] spids: [16777215 408] ) (C {(warn)} {(DQ ('echo > trace'))}) (AndOr ops: [Op_DAmp] children: [ (DParen child:(ArithVarRef name:wroteflock)) (C {(warn)} {(DQ ('rm ') ($ VSub_Name '$flock'))}) ] ) ] spids: [327] ) spids: [323 326] ) (FuncDef name: die body: (BraceGroup children: [ (SimpleCommand words: [{(echo)} {(DQ ($ VSub_At '$@'))}] redirects: [(Redir op_id:Redir_GreatAnd fd:16777215 arg_word:{(2)} spids:[446])] ) (ControlFlow token:<ControlFlow_Exit exit> arg_word:{(1)}) ] spids: [441] ) spids: [437 440] ) (FuncDef name: edie body: (BraceGroup children: [ (SimpleCommand words: [{(echo)} {(DQ ($ VSub_At '$@'))}] redirects: [(Redir op_id:Redir_GreatAnd fd:16777215 arg_word:{(2)} spids:[474])] ) (SimpleCommand words: [{(exec)}] redirects: [ (Redir op_id: Redir_Great fd: 16777215 arg_word: {(/dev/null)} spids: [484] ) (Redir op_id:Redir_GreatAnd fd:2 arg_word:{(1)} spids:[487]) ] ) (C {(end)}) (ControlFlow token:<ControlFlow_Exit exit> arg_word:{(1)}) ] spids: [465] ) spids: [461 464] ) (While cond: [ (C {(getopts)} {(d) (Lit_Other ':') (hi) (Lit_Other ':') (n) (Lit_Other ':') (p) (Lit_Other ':') (Qst)} {(opt)} ) ] body: (DoGroup children: [ (Case to_match: {($ VSub_Name '$opt')} arms: [ (case_arm pat_list: [{(d)}] action: [ (Sentence child: (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:opt_device) op: Equal rhs: {(1)} spids: [533] ) ] spids: [533] ) terminator: <Op_Semi ';'> ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:device) op: Equal rhs: {($ VSub_Name '$OPTARG')} spids: [537] ) ] spids: [537] ) ] spids: [530 531 540 16777215] ) (case_arm pat_list: [{(i)}] action: [ (Sentence child: (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:opt_iotype) op: Equal rhs: {(1)} spids: [546] ) ] spids: [546] ) terminator: <Op_Semi ';'> ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:iotype) op: Equal rhs: {($ VSub_Name '$OPTARG')} spids: [550] ) ] spids: [550] ) ] spids: [543 544 553 16777215] ) (case_arm pat_list: [{(n)}] action: [ (Sentence child: (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:opt_name) op: Equal rhs: {(1)} spids: [559] ) ] spids: [559] ) terminator: <Op_Semi ';'> ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:name) op: Equal rhs: {($ VSub_Name '$OPTARG')} spids: [563] ) ] spids: [563] ) ] spids: [556 557 566 16777215] ) (case_arm pat_list: [{(p)}] action: [ (Sentence child: (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:opt_pid) op: Equal rhs: {(1)} spids: [572] ) ] spids: [572] ) terminator: <Op_Semi ';'> ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:pid) op: Equal rhs: {($ VSub_Name '$OPTARG')} spids: [576] ) ] spids: [576] ) ] spids: [569 570 579 16777215] ) (case_arm pat_list: [{(Q)}] action: [ (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:opt_queue) op: Equal rhs: {(1)} spids: [585] ) ] spids: [585] ) ] spids: [582 583 588 16777215] ) (case_arm pat_list: [{(s)}] action: [ (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:opt_start) op: Equal rhs: {(1)} spids: [594] ) ] spids: [594] ) ] spids: [591 592 597 16777215] ) (case_arm pat_list: [{(t)}] action: [ (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_end) op:Equal rhs:{(1)} spids:[603])] spids: [603] ) ] spids: [600 601 606 16777215] ) (case_arm pat_list: [{(h)} {(Lit_Other '?')}] action: [(C {(usage)})] spids: [609 612 616 16777215] ) ] spids: [523 527 619] ) ] spids: [520 621] ) ) (C {(shift)} { (ArithSubPart anode: (ArithBinary op_id: Arith_Minus left: (ArithWord w:{($ VSub_Name '$OPTIND')}) right: (ArithWord w:{(Lit_Digits 1)}) ) spids: [625 634] ) } ) (If arms: [ (if_arm cond: [ (Sentence child: (DParen child:(ArithWord w:{($ VSub_Pound '$#')})) terminator: <Op_Semi ';'> ) ] action: [ (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:opt_duration) op:Equal rhs:{(1)} spids:[649])] spids: [649] ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:duration) op: Equal rhs: {($ VSub_Number '$1')} spids: [653] ) ] spids: [653] ) (C {(shift)}) ] spids: [16777215 646] ) ] spids: [16777215 659] ) (If arms: [ (if_arm cond: [ (Sentence child: (DParen child:(ArithVarRef name:opt_device)) terminator: <Op_Semi ';'> ) ] action: [ (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:major) op: Equal rhs: { (BracedVarSub token: <VSub_Name device> suffix_op: (StringUnary op_id:VOp1_Percent arg_word:{(',*')}) spids: [675 679] ) } spids: [674] ) ] spids: [674] ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:minor) op: Equal rhs: { (BracedVarSub token: <VSub_Name device> suffix_op: (StringUnary op_id:VOp1_Pound arg_word:{('*,')}) spids: [683 687] ) } spids: [682] ) ] spids: [682] ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:dev) op: Equal rhs: { (ArithSubPart anode: (ArithBinary op_id: Arith_Plus left: (ArithBinary op_id: Arith_DLess left: (ArithVarRef name:major) right: (ArithWord w:{(Lit_Digits 20)}) ) right: (ArithVarRef name:minor) ) spids: [691 706] ) } spids: [690] ) ] spids: [690] ) ] spids: [16777215 671] ) ] spids: [16777215 708] ) (AndOr ops: [Op_DAmp] children: [ (DParen child: (ArithBinary op_id: Arith_DAmp left: (ArithVarRef name:opt_pid) right: (ArithVarRef name:opt_name) ) ) (C {(die)} {(DQ ('ERROR: use either -p or -n.'))}) ] ) (AndOr ops: [Op_DAmp] children: [ (DParen child:(ArithVarRef name:opt_pid)) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:ftext) op: Equal rhs: {(DQ (' issued by PID ') ($ VSub_Name '$pid'))} spids: [742] ) ] spids: [742] ) ] ) (AndOr ops: [Op_DAmp] children: [ (DParen child:(ArithVarRef name:opt_name)) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:ftext) op: Equal rhs: { (DQ (' issued by process name ') (EscapedLiteralPart token:<Lit_EscapedChar '\\"'>) ($ VSub_Name '$name') (EscapedLiteralPart token:<Lit_EscapedChar '\\"'>) ) } spids: [757] ) ] spids: [757] ) ] ) (If arms: [ (if_arm cond: [ (Sentence child: (DParen child:(ArithVarRef name:opt_duration)) terminator: <Op_Semi ';'> ) ] action: [ (C {(echo)} { (DQ ('Tracing block I/O') ($ VSub_Name '$ftext') (' for ') ($ VSub_Name '$duration') (' seconds (buffered)...') ) } ) ] spids: [16777215 775] ) ] else_action: [ (C {(echo)} {(DQ ('Tracing block I/O') ($ VSub_Name '$ftext') ('. Ctrl-C to end.'))}) ] spids: [788 799] ) (If arms: [ (if_arm cond: [(Sentence child:(DParen child:(ArithVarRef name:opt_queue)) terminator:<Op_Semi ';'>)] action: [ (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:b_start) op: Equal rhs: {(block_rq_insert)} spids: [814] ) ] spids: [814] ) ] spids: [16777215 811] ) ] else_action: [ (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:b_start) op: Equal rhs: {(block_rq_issue)} spids: [820] ) ] spids: [820] ) ] spids: [817 823] ) (AndOr ops: [Op_DAmp Op_DPipe] children: [ (DParen child:(ArithVarRef name:opt_duration)) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:use) op:Equal rhs:{(mawk)} spids:[838])] spids: [838] ) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:use) op:Equal rhs:{(gawk)} spids:[843])] spids: [843] ) ] ) (AndOr ops: [Op_DAmp Op_DPipe] children: [ (DBracket expr:(BoolUnary op_id:BoolUnary_x child:{(/usr/bin/) ($ VSub_Name '$use')})) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:awk) op: Equal rhs: {($ VSub_Name '$use')} spids: [860] ) ] spids: [860] ) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:awk) op:Equal rhs:{(awk)} spids:[865])] spids: [865] ) ] ) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:wroteflock) op:Equal rhs:{(1)} spids:[868])] spids: [868] ) (AndOr ops: [Op_DPipe] children: [ (C {(cd)} {($ VSub_Name '$tracing')}) (C {(die)} { (DQ ('ERROR: accessing tracing. Root user? Kernel has FTRACE?\n') (' debugfs mounted? (mount -t debugfs debugfs /sys/kernel/debug)') ) } ) ] ) (AndOr ops: [Op_DAmp] children: [ (DBracket expr:(BoolUnary op_id:BoolUnary_e child:{($ VSub_Name '$flock')})) (C {(die)} { (DQ ('ERROR: ftrace may be in use by PID ') (CommandSubPart command_list: (CommandList children:[(C {(cat)} {($ VSub_Name '$flock')})]) left_token: <Left_CommandSub '$('> spids: [906 910] ) (' ') ($ VSub_Name '$flock') ) } ) ] ) (AndOr ops: [Op_DPipe] children: [ (SimpleCommand words: [{(echo)} {($ VSub_Dollar '$$')}] redirects: [ (Redir op_id: Redir_Great fd: 16777215 arg_word: {($ VSub_Name '$flock')} spids: [919] ) ] ) (C {(die)} {(DQ ('ERROR: unable to write ') ($ VSub_Name '$flock') (.))}) ] ) (SimpleCommand words: [{(echo)} {(nop)}] redirects: [(Redir op_id:Redir_Great fd:16777215 arg_word:{(current_tracer)} spids:[941])] ) (C {(warn)} {(DQ ('echo ') ($ VSub_Name '$bufsize_kb') (' > buffer_size_kb'))}) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:filter) op:Equal rhs:{(EmptyPart)} spids:[953])] spids: [953] ) (If arms: [ (if_arm cond: [ (Sentence child: (DParen child:(ArithVarRef name:opt_iotype)) terminator: <Op_Semi ';'> ) ] action: [ (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:filter) op: Equal rhs: { (DQ ('rwbs ~ ') (EscapedLiteralPart token:<Lit_EscapedChar '\\"'>) ($ VSub_Name '$iotype') (EscapedLiteralPart token:<Lit_EscapedChar '\\"'>) ) } spids: [968] ) ] spids: [968] ) ] spids: [16777215 965] ) ] spids: [16777215 976] ) (If arms: [ (if_arm cond: [ (Sentence child: (DParen child:(ArithVarRef name:opt_device)) terminator: <Op_Semi ';'> ) ] action: [ (AndOr ops: [Op_DAmp] children: [ (DBracket expr: (BoolBinary op_id:BoolBinary_GlobNEqual left:{(DQ ($ VSub_Name '$filter'))} right:{(DQ )}) ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:filter) op: Equal rhs: {(DQ ($ VSub_Name '$filter') (' && '))} spids: [1006] ) ] spids: [1006] ) ] ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:filter) op: Equal rhs: {(DQ (${ VSub_Name filter) ('dev == ') ($ VSub_Name '$dev'))} spids: [1013] ) ] spids: [1013] ) ] spids: [16777215 988] ) ] spids: [16777215 1022] ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:filter_i) op: Equal rhs: {($ VSub_Name '$filter')} spids: [1024] ) ] spids: [1024] ) (If arms: [ (if_arm cond: [(Sentence child:(DParen child:(ArithVarRef name:opt_pid)) terminator:<Op_Semi ';'>)] action: [ (AndOr ops: [Op_DAmp] children: [ (DBracket expr: (BoolBinary op_id:BoolBinary_GlobNEqual left:{(DQ ($ VSub_Name '$filter_i'))} right:{(DQ )}) ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:filter_i) op: Equal rhs: {(DQ ($ VSub_Name '$filter_i') (' && '))} spids: [1055] ) ] spids: [1055] ) ] ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:filter_i) op: Equal rhs: {(DQ (${ VSub_Name filter_i) ('common_pid == ') ($ VSub_Name '$pid'))} spids: [1062] ) ] spids: [1062] ) (AndOr ops: [Op_DAmp] children: [ (DBracket expr: (BoolBinary op_id:BoolBinary_GlobDEqual left:{(DQ ($ VSub_Name '$filter'))} right:{(DQ )}) ) (Assignment keyword: Assign_None pairs: [(assign_pair lhs:(LhsName name:filter) op:Equal rhs:{(0)} spids:[1087])] spids: [1087] ) ] ) ] spids: [16777215 1037] ) ] spids: [16777215 1090] ) (If arms: [ (if_arm cond: [ (Sentence child: (DParen child: (ArithBinary op_id: Arith_DPipe left: (ArithBinary op_id: Arith_DPipe left: (ArithVarRef name:opt_iotype) right: (ArithVarRef name:opt_device) ) right: (ArithVarRef name:opt_pid) ) ) terminator: <Op_Semi ';'> ) ] action: [ (If arms: [ (if_arm cond: [ (AndOr ops: [Op_DPipe] children: [ (Pipeline children: [ (SimpleCommand words: [{(echo)} {(DQ ($ VSub_Name '$filter_i'))}] redirects: [ (Redir op_id: Redir_Great fd: 16777215 arg_word: {(events/block/) ($ VSub_Name '$b_start') (/filter)} spids: [1123] ) ] ) ] negated: T ) (Pipeline children: [ (SimpleCommand words: [{(echo)} {(DQ ($ VSub_Name '$filter'))}] redirects: [ (Redir op_id: Redir_Great fd: 16777215 arg_word: {(events/block/block_rq_complete/filter)} spids: [1141] ) ] ) ] negated: T ) ] ) ] action: [(C {(edie)} {(DQ ('ERROR: setting -d or -t filter. Exiting.'))})] spids: [16777215 1146] ) ] spids: [16777215 1156] ) ] spids: [16777215 1110] ) ] spids: [16777215 1158] ) (If arms: [ (if_arm cond: [ (Sentence child: (AndOr ops: [Op_DPipe] children: [ (Pipeline children: [ (SimpleCommand words: [{(echo)} {(1)}] redirects: [ (Redir op_id: Redir_Great fd: 16777215 arg_word: {(events/block/) ($ VSub_Name '$b_start') (/enable)} spids: [1168] ) ] ) ] negated: T ) (Pipeline children: [ (SimpleCommand words: [{(echo)} {(1)}] redirects: [ (Redir op_id: Redir_Great fd: 16777215 arg_word: {(events/block/block_rq_complete/enable)} spids: [1184] ) ] ) ] negated: T ) ] ) terminator: <Op_Semi ';'> ) ] action: [(C {(edie)} {(DQ ('ERROR: enabling block I/O tracepoints. Exiting.'))})] spids: [16777215 1189] ) ] spids: [16777215 1198] ) (AndOr ops: [Op_DAmp] children: [ (DParen child:(ArithVarRef name:opt_start)) (C {(printf)} {(DQ ('%-15s '))} {(DQ (STARTs))}) ] ) (AndOr ops: [Op_DAmp] children: [(DParen child:(ArithVarRef name:opt_end)) (C {(printf)} {(DQ ('%-15s '))} {(DQ (ENDs))})] ) (C {(printf)} {(DQ ('%-12.12s %-6s %-4s %-8s %-12s %-6s %8s') (Lit_Other '\\') (n))} {(DQ (COMM))} {(DQ (PID))} {(DQ (TYPE))} {(DQ (DEV))} {(DQ (BLOCK))} {(DQ (BYTES))} {(DQ (LATms))} ) (Assignment keyword: Assign_None pairs: [ (assign_pair lhs: (LhsName name:offset) op: Equal rhs: { (CommandSubPart command_list: (CommandList children: [ (C {($ VSub_Name '$awk')} { (SQ <'BEGIN { o = 0; }\n'> <'\t$1 == "#" && $2 ~ /TASK/ && NF == 6 { o = 1; }\n'> <'\t$2 ~ /TASK/ { print o; exit }'> ) } {(trace)} ) ] ) left_token: <Left_CommandSub '$('> spids: [1299 1309] ) } spids: [1298] ) ] spids: [1298] ) (C {(warn)} {(DQ ('echo > trace'))}) (Pipeline children: [ (Subshell child: (If arms: [ (if_arm cond: [ (Sentence child: (DParen child:(ArithVarRef name:opt_duration)) terminator: <Op_Semi ';'> ) ] action: [(C {(sleep)} {($ VSub_Name '$duration')}) (C {(cat)} {(trace)})] spids: [16777215 1333] ) ] else_action: [(C {(cat)} {(trace_pipe)})] spids: [1349 1360] ) spids: [1321 1362] ) (C {($ VSub_Name '$awk')} {(-v)} {(Lit_VarLike 'o=') ($ VSub_Name '$offset')} {(-v)} {(Lit_VarLike 'opt_name=') ($ VSub_Name '$opt_name')} {(-v)} {(Lit_VarLike 'name=') ($ VSub_Name '$name')} {(-v)} {(Lit_VarLike 'opt_duration=') ($ VSub_Name '$opt_duration')} {(-v)} {(Lit_VarLike 'opt_start=') ($ VSub_Name '$opt_start')} {(-v)} {(Lit_VarLike 'opt_end=') ($ VSub_Name '$opt_end')} {(-v)} {(Lit_VarLike 'b_start=') ($ VSub_Name '$b_start')} { (SQ <'\n'> <'\t# common fields\n'> <'\t$1 != "#" {\n'> <'\t\t# task name can contain dashes\n'> <'\t\tcomm = pid = $1\n'> <'\t\tsub(/-[0-9][0-9]*/, "", comm)\n'> <'\t\tsub(/.*-/, "", pid)\n'> <'\t\ttime = $(3+o); sub(":", "", time)\n'> <'\t\tdev = $(5+o)\n'> <'\t}\n'> <'\n'> <'\t# block I/O request\n'> <'\t$1 != "#" && $0 ~ b_start {\n'> <'\t\tif (opt_name && match(comm, name) == 0)\n'> <'\t\t\tnext\n'> <'\t\t#\n'> <'\t\t# example: (fields1..4+o) 202,1 W 0 () 12862264 + 8 [tar]\n'> <'\t\t# The cmd field "()" might contain multiple words (hex),\n'> <'\t\t# hence stepping from the right (NF-3).\n'> <'\t\t#\n'> <'\t\tloc = $(NF-3)\n'> <'\t\tstarts[dev, loc] = time\n'> <'\t\tcomms[dev, loc] = comm\n'> <'\t\tpids[dev, loc] = pid\n'> <'\t\tnext\n'> <'\t}\n'> <'\n'> <'\t# block I/O completion\n'> <'\t$1 != "#" && $0 ~ /rq_complete/ {\n'> <'\t\t#\n'> <'\t\t# example: (fields1..4+o) 202,1 W () 12862256 + 8 [0]\n'> <'\t\t#\n'> <'\t\tdir = $(6+o)\n'> <'\t\tloc = $(NF-3)\n'> <'\t\tnsec = $(NF-1)\n'> <'\n'> <'\t\tif (starts[dev, loc] > 0) {\n'> <'\t\t\tlatency = sprintf("%.2f",\n'> <'\t\t\t 1000 * (time - starts[dev, loc]))\n'> <'\t\t\tcomm = comms[dev, loc]\n'> <'\t\t\tpid = pids[dev, loc]\n'> <'\n'> <'\t\t\tif (opt_start)\n'> <'\t\t\t\tprintf "%-15s ", starts[dev, loc]\n'> <'\t\t\tif (opt_end)\n'> <'\t\t\t\tprintf "%-15s ", time\n'> <'\t\t\tprintf "%-12.12s %-6s %-4s %-8s %-12s %-6s %8s\\n",\n'> <'\t\t\t comm, pid, dir, dev, loc, nsec * 512, latency\n'> <'\t\t\tif (!opt_duration)\n'> <'\t\t\t\tfflush()\n'> <'\n'> <'\t\t\tdelete starts[dev, loc]\n'> <'\t\t\tdelete comms[dev, loc]\n'> <'\t\t\tdelete pids[dev, loc]\n'> <'\t\t}\n'> <'\t\tnext\n'> <'\t}\n'> <'\n'> <'\t$0 ~ /LOST.*EVENTS/ { print "WARNING: " $0 > "/dev/stderr" }\n'> ) } ) ] negated: F ) (C {(end)}) ] )