aboutsummaryrefslogtreecommitdiff
path: root/Examples/tcl_insflow_example.txt
blob: 2919f8eb72fd5b069c865dbd0f5abbac759633ba (plain) (blame)
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
158
159
160
161
162
163
164
165
166
167
168
169
170
171
172
173
174
175
176
177
178
179
180
181
182
183
184
185
186
187
188
189
190
191
192
193
194
195
196
197
198
199
200
201
202
203
204
205
206
207
208
209
210
211
212
213
214
215
216
217
218
219
220
221
222
223
224
225
226
227
228
229
230
231
232
233
234
235
236
237
238
239
240
241
242
243
244
245
246
247
248
249
250
251
252
253
254
255
256
257
258
259
260
261
262
263
264
265
266
267
268
269
270
271
272
273
274
275
276
277
278
279
280
281
282
283
284
285
286
287
288
289
290
291
292
293
294
295
296
297
298
299
300
301
302
303
304
305
306
307
308
309
310
311
312
313
314
315
316
317
318
319
320
321
322
323
324
325
326
327
328
329
330
331
332
333
334
335
336
337
338
339
340
341
342
343
344
345
346
347
348
349
350
351
352
353
354
355
356
357
358
359
360
361
362
363
364
365
366
367
368
369
370
371
372
373
374
375
376
377
378
379
380
381
382
383
384
385
386
387
388
389
390
391
392
393
394
395
396
397
398
399
400
401
402
403
404
405
406
407
408
409
410
411
412
413
414
415
416
417
418
419
420
421
422
423
424
425
426
427
428
429
430
431
432
433
434
435
436
437
438
439
440
441
442
443
444
445
446
447
448
449
450
451
452
453
454
455
456
457
458
459
460
461
462
463
464
465
466
467
468
469
470
471
472
473
474
475
476
477
478
479
480
481
482
483
484
485
486
487
488
489
490
491
492
493
494
495
496
497
498
499
500
501
502
503
504
505
506
507
508
509
510
511
512
513
514
515
516
517
518
519
520
521
522
523
524
525
526
527
528
529
530
531
532
533
534
535
536
537
538
539
540
541
542
543
544
545
546
547
548
549
550
551
552
553
554
555
556
557
558
559
560
561
562
563
564
565
566
567
568
569
570
571
572
573
574
575
576
577
578
579
580
581
582
583
584
585
586
587
588
589
590
591
592
593
594
595
596
597
598
599
600
601
602
603
604
605
606
607
608
609
610
611
612
613
614
615
616
617
618
619
620
621
622
623
624
625
626
627
628
629
630
631
632
633
634
635
636
637
638
639
640
641
642
643
644
645
646
647
648
649
650
651
652
653
654
655
656
657
658
659
660
661
662
663
664
665
666
667
668
669
670
671
672
673
674
675
676
677
678
679
680
681
682
683
684
685
686
687
688
689
690
691
692
693
694
695
696
697
698
699
700
701
702
703
704
705
706
707
708
709
710
711
712
713
714
715
716
717
718
719
720
721
722
723
724
725
726
727
728
729
730
731
732
733
734
735
736
737
738
739
740
741
742
743
744
745
746
747
748
749
750
751
752
753
754
755
756
757
758
759
760
761
762
763
764
765
766
767
768
769
770
771
772
773
774
775
776
777
778
779
780
781
782
783
784
785
786
787
788
789
790
791
792
793
794
795
796
797
798
799
800
801
802
803
804
805
806
807
808
809
810
811
812
813
814
815
816
817
818
819
820
821
822
823
824
825
826
827
828
829
830
831
832
833
834
835
836
837
838
839
840
841
842
843
844
845
846
847
848
849
850
851
852
853
854
855
856
857
858
859
860
861
862
863
864
865
866
867
868
869
870
871
872
873
874
875
876
877
878
879
880
881
882
883
884
885
886
887
888
889
890
891
892
893
894
895
896
897
898
899
900
901
902
903
904
905
906
907
908
909
910
911
912
913
914
915
916
917
918
919
920
921
922
923
924
925
926
927
928
929
930
931
932
933
934
935
936
937
938
939
940
941
942
943
944
945
946
947
948
949
950
951
952
953
954
955
956
957
958
959
960
961
962
963
964
965
966
967
968
969
970
971
972
973
974
975
976
977
978
979
980
981
982
983
984
985
986
987
988
989
990
991
992
993
994
995
996
997
The following are examples of running tcl_insflow.d

Here you can see the script running while tracing Code/Tcl/func_abc.tcl

# tcl_insflow.d
  C    PID TIME(us)         DELTA(us)  TYPE -- CALL
  0 174829 4436207514685            3   cmd -> if
  0 174829 4436207514793          107  inst   -> push1
  0 174829 4436207514805           11  inst   <- push1
  0 174829 4436207514814            8  inst   -> push1
  0 174829 4436207514820            5  inst   <- push1
  0 174829 4436207514826            5  inst   -> push1
  0 174829 4436207514832            5  inst   <- push1
  0 174829 4436207514838            5  inst   -> invokeStk1
  0 174829 4436207514845            6   cmd     -> info
  0 174829 4436207514883           38   cmd     <- info
  0 174829 4436207514895           11  inst   <- invokeStk1
  0 174829 4436207514901            6  inst   -> push1
  0 174829 4436207514907            5  inst   <- push1
  0 174829 4436207514913            5  inst   -> eq
  0 174829 4436207514927           14  inst   <- eq
  0 174829 4436207514933            6  inst   -> done
  0 174829 4436207514940            6  inst   <- done
  0 174829 4436207514978           38  inst   -> push1
  0 174829 4436207514985            6  inst   <- push1
  0 174829 4436207514991            5  inst   -> push1
  0 174829 4436207514996            5  inst   <- push1
  0 174829 4436207515002            5  inst   -> push1
  0 174829 4436207515007            5  inst   <- push1
  0 174829 4436207515013            5  inst   -> push1
  0 174829 4436207515019            5  inst   <- push1
  0 174829 4436207515024            5  inst   -> invokeStk1
  0 174829 4436207515031            6   cmd     -> proc
  0 174829 4436207515045           13   cmd     <- proc
  0 174829 4436207515051            6  inst   <- invokeStk1
  0 174829 4436207515057            6  inst   -> done
  0 174829 4436207515063            5  inst   <- done
  0 174829 4436207515069            6   cmd <- if
  0 174829 4436207515086           16   cmd -> tclInit
  0 174829 4436207515295          208  proc   -> tclInit
  0 174829 4436207515305           10  inst     -> push1
  0 174829 4436207515311            5  inst     <- push1
  0 174829 4436207515317            6  inst     -> push1
  0 174829 4436207515323            5  inst     <- push1
  0 174829 4436207515328            5  inst     -> push1
  0 174829 4436207515334            5  inst     <- push1
  0 174829 4436207515340            5  inst     -> push1
  0 174829 4436207515345            5  inst     <- push1
  0 174829 4436207515351            5  inst     -> invokeStk1
  0 174829 4436207515357            6   cmd       -> global
  0 174829 4436207515369           11   cmd       <- global
  0 174829 4436207515375            6  inst     <- invokeStk1
  0 174829 4436207515381            5  inst     -> pop
  0 174829 4436207515387            5  inst     <- pop
  0 174829 4436207515393            5  inst     -> push1
  0 174829 4436207515398            5  inst     <- push1
  0 174829 4436207515404            5  inst     -> push1
  0 174829 4436207515410            5  inst     <- push1
  0 174829 4436207515415            5  inst     -> push1
  0 174829 4436207515421            5  inst     <- push1
  0 174829 4436207515427            5  inst     -> invokeStk1
  0 174829 4436207515433            6   cmd       -> global
  0 174829 4436207515440            7   cmd       <- global
  0 174829 4436207515446            6  inst     <- invokeStk1
  0 174829 4436207515452            5  inst     -> pop
  0 174829 4436207515458            5  inst     <- pop
  0 174829 4436207515463            5  inst     -> push1
  0 174829 4436207515469            5  inst     <- push1
  0 174829 4436207515475            5  inst     -> push1
  0 174829 4436207515480            5  inst     <- push1
  0 174829 4436207515486            5  inst     -> push1
  0 174829 4436207515492            5  inst     <- push1
  0 174829 4436207515497            5  inst     -> invokeStk1
  0 174829 4436207515504            6   cmd       -> rename
  0 174829 4436207515553           49   cmd       <- rename
  0 174829 4436207515560            6  inst     <- invokeStk1
  0 174829 4436207515566            6  inst     -> pop
  0 174829 4436207515571            5  inst     <- pop
  0 174829 4436207515577            5  inst     -> push1
  0 174829 4436207515583            5  inst     <- push1
  0 174829 4436207515589            5  inst     -> storeScalar1
  0 174829 4436207515598            9  inst     <- storeScalar1
  0 174829 4436207515605            6  inst     -> push1
  0 174829 4436207515610            5  inst     <- push1
  0 174829 4436207515616            5  inst     -> storeScalar1
  0 174829 4436207515622            5  inst     <- storeScalar1
  0 174829 4436207515628            5  inst     -> push1
  0 174829 4436207515633            5  inst     <- push1
  0 174829 4436207515639            5  inst     -> push1
  0 174829 4436207515645            5  inst     <- push1
  0 174829 4436207515650            5  inst     -> push1
  0 174829 4436207515656            5  inst     <- push1
  0 174829 4436207515662            5  inst     -> invokeStk1
  0 174829 4436207515668            6   cmd       -> info
  0 174829 4436207515679           10   cmd       <- info
  0 174829 4436207515685            6  inst     <- invokeStk1
  0 174829 4436207515691            5  inst     -> tryCvtToNumeric
  0 174829 4436207515701           10  inst     <- tryCvtToNumeric
  0 174829 4436207515708            6  inst     -> jumpFalse1
  0 174829 4436207515714            5  inst     <- jumpFalse1
  0 174829 4436207515719            5  inst     -> push1
  0 174829 4436207515725            5  inst     <- push1
  0 174829 4436207515731            5  inst     -> push1
  0 174829 4436207515736            5  inst     <- push1
  0 174829 4436207515742            5  inst     -> push1
  0 174829 4436207515747            5  inst     <- push1
  0 174829 4436207515753            5  inst     -> invokeStk1
  0 174829 4436207515760            6   cmd       -> info
  0 174829 4436207515787           27   cmd       <- info
  0 174829 4436207515793            6  inst     <- invokeStk1
  0 174829 4436207515799            5  inst     -> tryCvtToNumeric
  0 174829 4436207515805            5  inst     <- tryCvtToNumeric
  0 174829 4436207515811            5  inst     -> jumpFalse1
  0 174829 4436207515817            5  inst     <- jumpFalse1
  0 174829 4436207515823            5  inst     -> push1
  0 174829 4436207515828            5  inst     <- push1
  0 174829 4436207515834            5  inst     -> pop
  0 174829 4436207515839            5  inst     <- pop
  0 174829 4436207515845            5  inst     -> beginCatch4
  0 174829 4436207515851            5  inst     <- beginCatch4
  0 174829 4436207515857            5  inst     -> loadScalar1
  0 174829 4436207515863            5  inst     <- loadScalar1
  0 174829 4436207515868            5  inst     -> lappendScalar1
  0 174829 4436207515877            8  inst     <- lappendScalar1
  0 174829 4436207515883            6  inst     -> push1
  0 174829 4436207515889            5  inst     <- push1
  0 174829 4436207515895            5  inst     -> push1
  0 174829 4436207515900            5  inst     <- push1
  0 174829 4436207515906            5  inst     -> invokeStk1
  0 174829 4436207515912            6   cmd       -> unset
  0 174829 4436207515920            7   cmd       <- unset
  0 174829 4436207515926            6  inst     <- invokeStk1
  0 174829 4436207515932            5  inst     -> pop
  0 174829 4436207515938            5  inst     <- pop
  0 174829 4436207515943            5  inst     -> push1
  0 174829 4436207515949            5  inst     <- push1
  0 174829 4436207515955            5  inst     -> jump1
  0 174829 4436207515960            5  inst     <- jump1
  0 174829 4436207515966            5  inst     -> endCatch
  0 174829 4436207515972            5  inst     <- endCatch
  0 174829 4436207515977            5  inst     -> pop
  0 174829 4436207515983            5  inst     <- pop
  0 174829 4436207515989            5  inst     -> push1
  0 174829 4436207515994            5  inst     <- push1
  0 174829 4436207516000            5  inst     -> loadScalar1
  0 174829 4436207516006            5  inst     <- loadScalar1
  0 174829 4436207516012            5  inst     -> loadScalar1
  0 174829 4436207516017            5  inst     <- loadScalar1
  0 174829 4436207516023            5  inst     -> invokeStk1
  0 174829 4436207516029            6   cmd       -> concat
  0 174829 4436207516049           19   cmd       <- concat
  0 174829 4436207516055            6  inst     <- invokeStk1
  0 174829 4436207516061            5  inst     -> storeScalar1
  0 174829 4436207516068            6  inst     <- storeScalar1
  0 174829 4436207516074            6  inst     -> loadScalar1
  0 174829 4436207516080            5  inst     <- loadScalar1
  0 174829 4436207516085            5  inst     -> storeScalar1
  0 174829 4436207516091            5  inst     <- storeScalar1
  0 174829 4436207516097            5  inst     -> foreach_start4
  0 174829 4436207516104            6  inst     <- foreach_start4
  0 174829 4436207516110            6  inst     -> foreach_step4
  0 174829 4436207516125           14  inst     <- foreach_step4
  0 174829 4436207516131            5  inst     -> loadScalar1
  0 174829 4436207516137            5  inst     <- loadScalar1
  0 174829 4436207516143            5  inst     -> storeScalar1
  0 174829 4436207516148            5  inst     <- storeScalar1
  0 174829 4436207516154            5  inst     -> push1
  0 174829 4436207516160            5  inst     <- push1
  0 174829 4436207516165            5  inst     -> push1
  0 174829 4436207516171            5  inst     <- push1
  0 174829 4436207516177            5  inst     -> loadScalar1
  0 174829 4436207516182            5  inst     <- loadScalar1
  0 174829 4436207516188            5  inst     -> push1
  0 174829 4436207516194            5  inst     <- push1
  0 174829 4436207516200            5  inst     -> invokeStk1
  0 174829 4436207516206            6   cmd       -> file
  0 174829 4436207516218           12   cmd       <- file
  0 174829 4436207516224            6  inst     <- invokeStk1
  0 174829 4436207516230            5  inst     -> storeScalar1
  0 174829 4436207516236            5  inst     <- storeScalar1
  0 174829 4436207516242            5  inst     -> push1
  0 174829 4436207516247            5  inst     <- push1
  0 174829 4436207516253            5  inst     -> push1
  0 174829 4436207516258            5  inst     <- push1
  0 174829 4436207516264            5  inst     -> loadScalar1
  0 174829 4436207516270            5  inst     <- loadScalar1
  0 174829 4436207516276            5  inst     -> invokeStk1
  0 174829 4436207516282            6   cmd       -> file
  0 174829 4436207516368           86   cmd       <- file
  0 174829 4436207516375            6  inst     <- invokeStk1
  0 174829 4436207516381            6  inst     -> tryCvtToNumeric
  0 174829 4436207516387            5  inst     <- tryCvtToNumeric
  0 174829 4436207516393            5  inst     -> jumpFalse1
  0 174829 4436207516398            5  inst     <- jumpFalse1
  0 174829 4436207516404            5  inst     -> push1
  0 174829 4436207516410            5  inst     <- push1
  0 174829 4436207516416            5  inst     -> pop
  0 174829 4436207516421            5  inst     <- pop
  0 174829 4436207516427            5  inst     -> jump1
  0 174829 4436207516432            5  inst     <- jump1
  0 174829 4436207516438            5  inst     -> foreach_step4
  0 174829 4436207516444            5  inst     <- foreach_step4
  0 174829 4436207516450            5  inst     -> loadScalar1
  0 174829 4436207516456            5  inst     <- loadScalar1
  0 174829 4436207516462            6  inst     -> storeScalar1
  0 174829 4436207516468            5  inst     <- storeScalar1
  0 174829 4436207516473            5  inst     -> push1
  0 174829 4436207516479            5  inst     <- push1
  0 174829 4436207516485            5  inst     -> push1
  0 174829 4436207516490            5  inst     <- push1
  0 174829 4436207516496            5  inst     -> loadScalar1
  0 174829 4436207516502            5  inst     <- loadScalar1
  0 174829 4436207516508            5  inst     -> push1
  0 174829 4436207516513            5  inst     <- push1
  0 174829 4436207516519            5  inst     -> invokeStk1
  0 174829 4436207516525            6   cmd       -> file
  0 174829 4436207516536           10   cmd       <- file
  0 174829 4436207516542            6  inst     <- invokeStk1
  0 174829 4436207516548            5  inst     -> storeScalar1
  0 174829 4436207516555            6  inst     <- storeScalar1
  0 174829 4436207516561            6  inst     -> push1
  0 174829 4436207516566            5  inst     <- push1
  0 174829 4436207516572            5  inst     -> push1
  0 174829 4436207516578            5  inst     <- push1
  0 174829 4436207516583            5  inst     -> loadScalar1
  0 174829 4436207516589            5  inst     <- loadScalar1
  0 174829 4436207516595            5  inst     -> invokeStk1
  0 174829 4436207516601            6   cmd       -> file
  0 174829 4436207516709          107   cmd       <- file
  0 174829 4436207516716            6  inst     <- invokeStk1
  0 174829 4436207516722            6  inst     -> tryCvtToNumeric
  0 174829 4436207516728            5  inst     <- tryCvtToNumeric
  0 174829 4436207516733            5  inst     -> jumpFalse1
  0 174829 4436207516739            5  inst     <- jumpFalse1
  0 174829 4436207516745            5  inst     -> push1
  0 174829 4436207516751            5  inst     <- push1
  0 174829 4436207516756            5  inst     -> pop
  0 174829 4436207516762            5  inst     <- pop
  0 174829 4436207516768            5  inst     -> jump1
  0 174829 4436207516773            5  inst     <- jump1
  0 174829 4436207516779            5  inst     -> foreach_step4
  0 174829 4436207516785            5  inst     <- foreach_step4
  0 174829 4436207516791            5  inst     -> loadScalar1
  0 174829 4436207516796            5  inst     <- loadScalar1
  0 174829 4436207516802            5  inst     -> storeScalar1
  0 174829 4436207516808            5  inst     <- storeScalar1
  0 174829 4436207516814            5  inst     -> push1
  0 174829 4436207516820            5  inst     <- push1
  0 174829 4436207516825            5  inst     -> push1
  0 174829 4436207516831            5  inst     <- push1
  0 174829 4436207516837            5  inst     -> loadScalar1
  0 174829 4436207516842            5  inst     <- loadScalar1
  0 174829 4436207516848            5  inst     -> push1
  0 174829 4436207516854            5  inst     <- push1
  0 174829 4436207516859            5  inst     -> invokeStk1
  0 174829 4436207516866            6   cmd       -> file
  0 174829 4436207516876           10   cmd       <- file
  0 174829 4436207516882            6  inst     <- invokeStk1
  0 174829 4436207516888            5  inst     -> storeScalar1
  0 174829 4436207516895            6  inst     <- storeScalar1
  0 174829 4436207516901            6  inst     -> push1
  0 174829 4436207516906            5  inst     <- push1
  0 174829 4436207516912            5  inst     -> push1
  0 174829 4436207516918            5  inst     <- push1
  0 174829 4436207516923            5  inst     -> loadScalar1
  0 174829 4436207516929            5  inst     <- loadScalar1
  0 174829 4436207516935            5  inst     -> invokeStk1
  0 174829 4436207516941            6   cmd       -> file
  0 174829 4436207517027           86   cmd       <- file
  0 174829 4436207517034            6  inst     <- invokeStk1
  0 174829 4436207517040            6  inst     -> tryCvtToNumeric
  0 174829 4436207517046            5  inst     <- tryCvtToNumeric
  0 174829 4436207517052            5  inst     -> jumpFalse1
  0 174829 4436207517057            5  inst     <- jumpFalse1
  0 174829 4436207517063            5  inst     -> push1
  0 174829 4436207517069            5  inst     <- push1
  0 174829 4436207517075            5  inst     -> pop
  0 174829 4436207517080            5  inst     <- pop
  0 174829 4436207517086            5  inst     -> jump1
  0 174829 4436207517091            5  inst     <- jump1
  0 174829 4436207517097            5  inst     -> foreach_step4
  0 174829 4436207517103            5  inst     <- foreach_step4
  0 174829 4436207517109            5  inst     -> loadScalar1
  0 174829 4436207517115            5  inst     <- loadScalar1
  0 174829 4436207517121            5  inst     -> storeScalar1
  0 174829 4436207517127            5  inst     <- storeScalar1
  0 174829 4436207517132            5  inst     -> push1
  0 174829 4436207517138            5  inst     <- push1
  0 174829 4436207517144            5  inst     -> push1
  0 174829 4436207517149            5  inst     <- push1
  0 174829 4436207517155            5  inst     -> loadScalar1
  0 174829 4436207517161            5  inst     <- loadScalar1
  0 174829 4436207517167            5  inst     -> push1
  0 174829 4436207517172            5  inst     <- push1
  0 174829 4436207517178            5  inst     -> invokeStk1
  0 174829 4436207517184            6   cmd       -> file
  0 174829 4436207517194           10   cmd       <- file
  0 174829 4436207517201            6  inst     <- invokeStk1
  0 174829 4436207517206            5  inst     -> storeScalar1
  0 174829 4436207517213            6  inst     <- storeScalar1
  0 174829 4436207517219            5  inst     -> push1
  0 174829 4436207517225            5  inst     <- push1
  0 174829 4436207517231            5  inst     -> push1
  0 174829 4436207517236            5  inst     <- push1
  0 174829 4436207517242            5  inst     -> loadScalar1
  0 174829 4436207517247            5  inst     <- loadScalar1
  0 174829 4436207517253            5  inst     -> invokeStk1
  0 174829 4436207517260            6   cmd       -> file
  0 174829 4436207517313           53   cmd       <- file
  0 174829 4436207517319            6  inst     <- invokeStk1
  0 174829 4436207517325            5  inst     -> tryCvtToNumeric
  0 174829 4436207517331            6  inst     <- tryCvtToNumeric
  0 174829 4436207517337            5  inst     -> jumpFalse1
  0 174829 4436207517343            5  inst     <- jumpFalse1
  0 174829 4436207517348            5  inst     -> beginCatch4
  0 174829 4436207517354            5  inst     <- beginCatch4
  0 174829 4436207517360            6  inst     -> push1
  0 174829 4436207517366            5  inst     <- push1
  0 174829 4436207517371            5  inst     -> push1
  0 174829 4436207517377            5  inst     <- push1
  0 174829 4436207517383            5  inst     -> push1
  0 174829 4436207517388            5  inst     <- push1
  0 174829 4436207517394            5  inst     -> loadScalar1
  0 174829 4436207517400            5  inst     <- loadScalar1
  0 174829 4436207517405            5  inst     -> list
  0 174829 4436207517412            6  inst     <- list
  0 174829 4436207517418            5  inst     -> invokeStk1
  0 174829 4436207517424            6   cmd       -> uplevel
  0 174829 4436207517436           11   cmd         -> source
  0 174829 4436207517878          441   cmd           -> if
  0 174829 4436207517897           18  inst             -> push1
  0 174829 4436207517903            6  inst             <- push1
  0 174829 4436207517910            6  inst             -> push1
  0 174829 4436207517915            5  inst             <- push1
  0 174829 4436207517921            5  inst             -> push1
  0 174829 4436207517927            5  inst             <- push1
  0 174829 4436207517932            5  inst             -> invokeStk1
  0 174829 4436207517939            6   cmd               -> info
  0 174829 4436207517947            8   cmd               <- info
  0 174829 4436207517954            6  inst             <- invokeStk1
  0 174829 4436207517960            5  inst             -> push1
  0 174829 4436207517965            5  inst             <- push1
  0 174829 4436207517971            5  inst             -> eq
  0 174829 4436207517979            7  inst             <- eq
  0 174829 4436207517985            5  inst             -> done
  0 174829 4436207517991            5  inst             <- done
  0 174829 4436207517997            6   cmd           <- if
  0 174829 4436207518010           12   cmd           -> package
  0 174829 4436207518021           10   cmd           <- package
  0 174829 4436207518034           13   cmd           -> if
  0 174829 4436207518046           11  inst             -> push1
  0 174829 4436207518051            5  inst             <- push1
  0 174829 4436207518057            5  inst             -> push1
  0 174829 4436207518063            5  inst             <- push1
  0 174829 4436207518068            5  inst             -> push1
  0 174829 4436207518074            5  inst             <- push1
  0 174829 4436207518080            5  inst             -> invokeStk1
  0 174829 4436207518086            6   cmd               -> info
  0 174829 4436207518094            7   cmd               <- info
  0 174829 4436207518099            5  inst             <- invokeStk1
  0 174829 4436207518105            5  inst             -> not
  0 174829 4436207518111            6  inst             <- not
  0 174829 4436207518117            5  inst             -> done
  0 174829 4436207518123            5  inst             <- done
  0 174829 4436207518147           24  inst             -> push1
  0 174829 4436207518153            5  inst             <- push1
  0 174829 4436207518159            5  inst             -> push1
  0 174829 4436207518164            5  inst             <- push1
  0 174829 4436207518170            5  inst             -> push1
  0 174829 4436207518175            5  inst             <- push1
  0 174829 4436207518181            5  inst             -> invokeStk1
  0 174829 4436207518187            6   cmd               -> info
  0 174829 4436207518212           25   cmd               <- info
  0 174829 4436207518218            6  inst             <- invokeStk1
  0 174829 4436207518224            5  inst             -> tryCvtToNumeric
  0 174829 4436207518230            5  inst             <- tryCvtToNumeric
  0 174829 4436207518236            5  inst             -> jumpFalse1
  0 174829 4436207518242            5  inst             <- jumpFalse1
  0 174829 4436207518248            5  inst             -> push1
  0 174829 4436207518253            5  inst             <- push1
  0 174829 4436207518259            5  inst             -> push1
  0 174829 4436207518264            5  inst             <- push1
  0 174829 4436207518270            5  inst             -> storeScalarStk
  0 174829 4436207518278            7  inst             <- storeScalarStk
  0 174829 4436207518284            5  inst             -> done
  0 174829 4436207518289            5  inst             <- done
  0 174829 4436207518295            6   cmd           <- if
  0 174829 4436207518315           19   cmd           -> namespace
  0 174829 4436207518421          106  inst             -> push1
  0 174829 4436207518428            6  inst             <- push1
  0 174829 4436207518434            5  inst             -> push1
  0 174829 4436207518440            5  inst             <- push1
  0 174829 4436207518445            5  inst             -> invokeStk1
  0 174829 4436207518452            6   cmd               -> variable
  0 174829 4436207518460            8   cmd               <- variable
  0 174829 4436207518466            6  inst             <- invokeStk1
  0 174829 4436207518472            5  inst             -> pop
  0 174829 4436207518477            5  inst             <- pop
  0 174829 4436207518483            5  inst             -> push1
  0 174829 4436207518489            5  inst             <- push1
  0 174829 4436207518494            5  inst             -> push1
  0 174829 4436207518500            5  inst             <- push1
  0 174829 4436207518506            5  inst             -> invokeStk1
  0 174829 4436207518513            7   cmd               -> info
  0 174829 4436207518526           13   cmd               <- info
  0 174829 4436207518532            6  inst             <- invokeStk1
  0 174829 4436207518538            5  inst             -> push1
  0 174829 4436207518544            5  inst             <- push1
  0 174829 4436207518549            5  inst             -> strneq
  0 174829 4436207518555            6  inst             <- strneq
  0 174829 4436207518561            5  inst             -> push1
  0 174829 4436207518567            5  inst             <- push1
  0 174829 4436207518573            5  inst             -> push1
  0 174829 4436207518578            5  inst             <- push1
  0 174829 4436207518584            5  inst             -> push1
  0 174829 4436207518589            5  inst             <- push1
  0 174829 4436207518595            5  inst             -> push1
  0 174829 4436207518600            5  inst             <- push1
  0 174829 4436207518606            5  inst             -> push1
  0 174829 4436207518612            5  inst             <- push1
  0 174829 4436207518617            5  inst             -> invokeStk1
  0 174829 4436207518624            6   cmd               -> info
  0 174829 4436207518631            7   cmd               <- info
  0 174829 4436207518637            6  inst             <- invokeStk1
  0 174829 4436207518643            5  inst             -> push1
  0 174829 4436207518648            5  inst             <- push1
  0 174829 4436207518654            5  inst             -> push1
  0 174829 4436207518660            5  inst             <- push1
  0 174829 4436207518665            5  inst             -> push1
  0 174829 4436207518671            5  inst             <- push1
  0 174829 4436207518677            5  inst             -> push1
  0 174829 4436207518682            5  inst             <- push1
  0 174829 4436207518688            5  inst             -> invokeStk1
  0 174829 4436207518694            6   cmd               -> info
  0 174829 4436207518701            7   cmd               <- info
  0 174829 4436207518707            6  inst             <- invokeStk1
  0 174829 4436207518713            5  inst             -> invokeStk1
  0 174829 4436207518720            7   cmd               -> file
  0 174829 4436207518741           20   cmd               <- file
  0 174829 4436207518748            6  inst             <- invokeStk1
  0 174829 4436207518753            5  inst             -> invokeStk1
  0 174829 4436207518760            6   cmd               -> list
  0 174829 4436207518768            8   cmd               <- list
  0 174829 4436207518774            6  inst             <- invokeStk1
  0 174829 4436207518780            5  inst             -> push1
  0 174829 4436207518786            5  inst             <- push1
  0 174829 4436207518791            5  inst             -> invokeStk1
  0 174829 4436207518798            6   cmd               -> foreach
  0 174829 4436207518821           23  inst                 -> push1
  0 174829 4436207518827            6  inst                 <- push1
  0 174829 4436207518833            5  inst                 -> push1
  0 174829 4436207518839            5  inst                 <- push1
  0 174829 4436207518844            5  inst                 -> push1
  0 174829 4436207518850            5  inst                 <- push1
  0 174829 4436207518856            5  inst                 -> loadScalarStk
  0 174829 4436207518862            6  inst                 <- loadScalarStk
  0 174829 4436207518868            5  inst                 -> push1
  0 174829 4436207518874            5  inst                 <- push1
  0 174829 4436207518879            5  inst                 -> loadScalarStk
  0 174829 4436207518886            6  inst                 <- loadScalarStk
  0 174829 4436207518892            5  inst                 -> invokeStk1
  0 174829 4436207518898            6   cmd                   -> lsearch
  0 174829 4436207518906            8   cmd                   <- lsearch
  0 174829 4436207518913            6  inst                 <- invokeStk1
  0 174829 4436207518918            5  inst                 -> push1
  0 174829 4436207518924            5  inst                 <- push1
  0 174829 4436207518930            5  inst                 -> lt
  0 174829 4436207518936            6  inst                 <- lt
  0 174829 4436207518942            5  inst                 -> push1
  0 174829 4436207518947            5  inst                 <- push1
  0 174829 4436207518953            5  inst                 -> push1
  0 174829 4436207518958            5  inst                 <- push1
  0 174829 4436207518964            5  inst                 -> push1
  0 174829 4436207518969            5  inst                 <- push1
  0 174829 4436207518975            5  inst                 -> loadScalarStk
  0 174829 4436207518981            6  inst                 <- loadScalarStk
  0 174829 4436207518987            5  inst                 -> invokeStk1
  0 174829 4436207518993            6   cmd                   -> lappend
  0 174829 4436207519002            8   cmd                   <- lappend
  0 174829 4436207519008            6  inst                 <- invokeStk1
  0 174829 4436207519013            5  inst                 -> jump1
  0 174829 4436207519019            5  inst                 <- jump1
  0 174829 4436207519025            5  inst                 -> done
  0 174829 4436207519030            5  inst                 <- done
  0 174829 4436207519038            8  inst                 -> push1
  0 174829 4436207519044            5  inst                 <- push1
  0 174829 4436207519050            5  inst                 -> push1
  0 174829 4436207519055            5  inst                 <- push1
  0 174829 4436207519061            5  inst                 -> push1
  0 174829 4436207519066            5  inst                 <- push1
  0 174829 4436207519072            5  inst                 -> loadScalarStk
  0 174829 4436207519078            5  inst                 <- loadScalarStk
  0 174829 4436207519084            5  inst                 -> push1
  0 174829 4436207519090            5  inst                 <- push1
  0 174829 4436207519095            5  inst                 -> loadScalarStk
  0 174829 4436207519102            6  inst                 <- loadScalarStk
  0 174829 4436207519108            5  inst                 -> invokeStk1
  0 174829 4436207519114            6   cmd                   -> lsearch
  0 174829 4436207519120            6   cmd                   <- lsearch
  0 174829 4436207519126            5  inst                 <- invokeStk1
  0 174829 4436207519132            5  inst                 -> push1
  0 174829 4436207519138            5  inst                 <- push1
  0 174829 4436207519143            5  inst                 -> lt
  0 174829 4436207519149            5  inst                 <- lt
  0 174829 4436207519155            5  inst                 -> push1
  0 174829 4436207519160            5  inst                 <- push1
  0 174829 4436207519166            5  inst                 -> push1
  0 174829 4436207519171            5  inst                 <- push1
  0 174829 4436207519177            5  inst                 -> push1
  0 174829 4436207519182            5  inst                 <- push1
  0 174829 4436207519188            5  inst                 -> loadScalarStk
  0 174829 4436207519194            5  inst                 <- loadScalarStk
  0 174829 4436207519200            5  inst                 -> invokeStk1
  0 174829 4436207519206            6   cmd                   -> lappend
  0 174829 4436207519213            7   cmd                   <- lappend
  0 174829 4436207519219            6  inst                 <- invokeStk1
  0 174829 4436207519225            5  inst                 -> jump1
  0 174829 4436207519231            5  inst                 <- jump1
  0 174829 4436207519236            5  inst                 -> done
  0 174829 4436207519242            5  inst                 <- done
  0 174829 4436207519248            6   cmd               <- foreach
  0 174829 4436207519255            6  inst             <- invokeStk1
  0 174829 4436207519260            5  inst             -> jump1
  0 174829 4436207519266            5  inst             <- jump1
  0 174829 4436207519272            5  inst             -> pop
  0 174829 4436207519277            5  inst             <- pop
  0 174829 4436207519283            5  inst             -> push1
  0 174829 4436207519288            5  inst             <- push1
  0 174829 4436207519294            5  inst             -> push1
  0 174829 4436207519300            5  inst             <- push1
  0 174829 4436207519305            5  inst             -> push1
  0 174829 4436207519311            5  inst             <- push1
  0 174829 4436207519316            5  inst             -> push1
  0 174829 4436207519322            5  inst             <- push1
  0 174829 4436207519328            5  inst             -> push1
  0 174829 4436207519333            5  inst             <- push1
  0 174829 4436207519339            5  inst             -> push1
  0 174829 4436207519344            5  inst             <- push1
  0 174829 4436207519350            5  inst             -> push1
  0 174829 4436207519356            5  inst             <- push1
  0 174829 4436207519362            5  inst             -> push1
  0 174829 4436207519367            5  inst             <- push1
  0 174829 4436207519373            5  inst             -> push1
  0 174829 4436207519378            5  inst             <- push1
  0 174829 4436207519384            5  inst             -> invokeStk1
  0 174829 4436207519390            6   cmd               -> info
  0 174829 4436207519399            8   cmd               <- info
  0 174829 4436207519405            5  inst             <- invokeStk1
  0 174829 4436207519411            5  inst             -> invokeStk1
  0 174829 4436207519417            6   cmd               -> file
  0 174829 4436207519435           18   cmd               <- file
  0 174829 4436207519442            6  inst             <- invokeStk1
  0 174829 4436207519448            5  inst             -> invokeStk1
  0 174829 4436207519454            6   cmd               -> file
  0 174829 4436207519471           17   cmd               <- file
  0 174829 4436207519478            6  inst             <- invokeStk1
  0 174829 4436207519484            5  inst             -> push1
  0 174829 4436207519490            5  inst             <- push1
  0 174829 4436207519495            5  inst             -> invokeStk1
  0 174829 4436207519502            6   cmd               -> file
  0 174829 4436207519512            9   cmd               <- file
  0 174829 4436207519518            6  inst             <- invokeStk1
  0 174829 4436207519524            5  inst             -> storeScalarStk
  0 174829 4436207519530            6  inst             <- storeScalarStk
  0 174829 4436207519536            6  inst             -> push1
  0 174829 4436207519542            5  inst             <- push1
  0 174829 4436207519547            5  inst             -> push1
  0 174829 4436207519553            5  inst             <- push1
  0 174829 4436207519559            5  inst             -> push1
  0 174829 4436207519564            5  inst             <- push1
  0 174829 4436207519570            5  inst             -> loadScalarStk
  0 174829 4436207519576            6  inst             <- loadScalarStk
  0 174829 4436207519582            5  inst             -> push1
  0 174829 4436207519587            5  inst             <- push1
  0 174829 4436207519593            5  inst             -> loadScalarStk
  0 174829 4436207519599            5  inst             <- loadScalarStk
  0 174829 4436207519605            5  inst             -> invokeStk1
  0 174829 4436207519611            6   cmd               -> lsearch
  0 174829 4436207519617            6   cmd               <- lsearch
  0 174829 4436207519623            6  inst             <- invokeStk1
  0 174829 4436207519629            5  inst             -> push1
  0 174829 4436207519635            5  inst             <- push1
  0 174829 4436207519640            5  inst             -> lt
  0 174829 4436207519646            5  inst             <- lt
  0 174829 4436207519652            5  inst             -> push1
  0 174829 4436207519657            5  inst             <- push1
  0 174829 4436207519663            5  inst             -> push1
  0 174829 4436207519668            5  inst             <- push1
  0 174829 4436207519674            5  inst             -> push1
  0 174829 4436207519679            5  inst             <- push1
  0 174829 4436207519685            5  inst             -> loadScalarStk
  0 174829 4436207519691            5  inst             <- loadScalarStk
  0 174829 4436207519697            5  inst             -> invokeStk1
  0 174829 4436207519703            6   cmd               -> lappend
  0 174829 4436207519710            6   cmd               <- lappend
  0 174829 4436207519716            6  inst             <- invokeStk1
  0 174829 4436207519722            5  inst             -> jump1
  0 174829 4436207519727            5  inst             <- jump1
  0 174829 4436207519733            5  inst             -> pop
  0 174829 4436207519739            5  inst             <- pop
  0 174829 4436207519744            5  inst             -> push1
  0 174829 4436207519750            5  inst             <- push1
  0 174829 4436207519756            5  inst             -> push1
  0 174829 4436207519761            5  inst             <- push1
  0 174829 4436207519767            5  inst             -> push1
  0 174829 4436207519772            5  inst             <- push1
  0 174829 4436207519778            5  inst             -> invokeStk1
  0 174829 4436207519784            6   cmd               -> info
  0 174829 4436207519791            6   cmd               <- info
  0 174829 4436207519797            6  inst             <- invokeStk1
  0 174829 4436207519803            5  inst             -> tryCvtToNumeric
  0 174829 4436207519809            5  inst             <- tryCvtToNumeric
  0 174829 4436207519815            5  inst             -> jumpFalse1
  0 174829 4436207519820            5  inst             <- jumpFalse1
  0 174829 4436207519826            5  inst             -> push1
  0 174829 4436207519832            5  inst             <- push1
  0 174829 4436207519837            5  inst             -> push1
  0 174829 4436207519843            5  inst             <- push1
  0 174829 4436207519849            5  inst             -> push1
  0 174829 4436207519854            5  inst             <- push1
  0 174829 4436207519860            5  inst             -> loadScalarStk
  0 174829 4436207519866            6  inst             <- loadScalarStk
  0 174829 4436207519872            5  inst             -> push1
  0 174829 4436207519877            5  inst             <- push1
  0 174829 4436207519883            5  inst             -> invokeStk1
  0 174829 4436207519889            6   cmd               -> foreach
  0 174829 4436207519899            9  inst                 -> push1
  0 174829 4436207519904            5  inst                 <- push1
  0 174829 4436207519910            5  inst                 -> push1
  0 174829 4436207519915            5  inst                 <- push1
  0 174829 4436207519921            5  inst                 -> push1
  0 174829 4436207519927            5  inst                 <- push1
  0 174829 4436207519932            5  inst                 -> loadScalarStk
  0 174829 4436207519938            6  inst                 <- loadScalarStk
  0 174829 4436207519944            5  inst                 -> push1
  0 174829 4436207519950            5  inst                 <- push1
  0 174829 4436207519955            5  inst                 -> loadScalarStk
  0 174829 4436207519962            6  inst                 <- loadScalarStk
  0 174829 4436207519968            5  inst                 -> invokeStk1
  0 174829 4436207519974            6   cmd                   -> lsearch
  0 174829 4436207519980            6   cmd                   <- lsearch
  0 174829 4436207519986            6  inst                 <- invokeStk1
  0 174829 4436207519992            5  inst                 -> push1
  0 174829 4436207519998            5  inst                 <- push1
  0 174829 4436207520003            5  inst                 -> lt
  0 174829 4436207520009            5  inst                 <- lt
  0 174829 4436207520015            5  inst                 -> push1
  0 174829 4436207520020            5  inst                 <- push1
  0 174829 4436207520026            5  inst                 -> push1
  0 174829 4436207520031            5  inst                 <- push1
  0 174829 4436207520037            5  inst                 -> push1
  0 174829 4436207520043            5  inst                 <- push1
  0 174829 4436207520048            5  inst                 -> loadScalarStk
  0 174829 4436207520054            5  inst                 <- loadScalarStk
  0 174829 4436207520060            5  inst                 -> invokeStk1
  0 174829 4436207520066            6   cmd                   -> lappend
  0 174829 4436207520073            6   cmd                   <- lappend
  0 174829 4436207520079            5  inst                 <- invokeStk1
  0 174829 4436207520085            5  inst                 -> jump1
  0 174829 4436207520090            5  inst                 <- jump1
  0 174829 4436207520096            5  inst                 -> done
  0 174829 4436207520102            5  inst                 <- done
  0 174829 4436207520108            6   cmd               <- foreach
  0 174829 4436207520114            5  inst             <- invokeStk1
  0 174829 4436207520119            5  inst             -> jump1
  0 174829 4436207520125            5  inst             <- jump1
  0 174829 4436207520131            5  inst             -> done
  0 174829 4436207520136            5  inst             <- done
  0 174829 4436207520143            6   cmd           <- namespace
  0 174829 4436207520171           28   cmd           -> if
  0 174829 4436207520192           20  inst             -> push1
  0 174829 4436207520198            6  inst             <- push1
  0 174829 4436207520203            5  inst             -> push1
  0 174829 4436207520209            5  inst             <- push1
  0 174829 4436207520215            5  inst             -> invokeStk1
  0 174829 4436207520221            6   cmd               -> interp
  0 174829 4436207520230            9   cmd               <- interp
  0 174829 4436207520236            5  inst             <- invokeStk1
  0 174829 4436207520242            5  inst             -> not
  0 174829 4436207520247            5  inst             <- not
  0 174829 4436207520253            5  inst             -> jumpTrue1
  0 174829 4436207520259            5  inst             <- jumpTrue1
  0 174829 4436207520265            5  inst             -> push1
  0 174829 4436207520270            5  inst             <- push1
  0 174829 4436207520276            5  inst             -> dup
  0 174829 4436207520281            5  inst             <- dup
  0 174829 4436207520287            5  inst             -> jumpFalse1
  0 174829 4436207520293            5  inst             <- jumpFalse1
  0 174829 4436207520298            5  inst             -> push1
  0 174829 4436207520304            5  inst             <- push1
  0 174829 4436207520310            5  inst             -> push1
  0 174829 4436207520315            5  inst             <- push1
  0 174829 4436207520321            5  inst             -> loadArrayStk
  0 174829 4436207520328            6  inst             <- loadArrayStk
  0 174829 4436207520334            5  inst             -> push1
  0 174829 4436207520339            5  inst             <- push1
  0 174829 4436207520345            5  inst             -> streq
  0 174829 4436207520351            5  inst             <- streq
  0 174829 4436207520357            5  inst             -> land
  0 174829 4436207520363            6  inst             <- land
  0 174829 4436207520368            5  inst             -> done
  0 174829 4436207520374            5  inst             <- done
  0 174829 4436207520381            6   cmd           <- if
  0 174829 4436207520394           13   cmd           -> package
  0 174829 4436207520401            6   cmd           <- package
  0 174829 4436207520413           11   cmd           -> if
  0 174829 4436207520424           11  inst             -> push1
  0 174829 4436207520429            5  inst             <- push1
  0 174829 4436207520435            5  inst             -> push1
  0 174829 4436207520441            5  inst             <- push1
  0 174829 4436207520446            5  inst             -> invokeStk1
  0 174829 4436207520453            6   cmd               -> interp
  0 174829 4436207520459            6   cmd               <- interp
  0 174829 4436207520465            5  inst             <- invokeStk1
  0 174829 4436207520471            5  inst             -> not
  0 174829 4436207520476            5  inst             <- not
  0 174829 4436207520482            5  inst             -> done
  0 174829 4436207520488            5  inst             <- done
  0 174829 4436207520527           39  inst             -> push1
  0 174829 4436207520533            5  inst             <- push1
  0 174829 4436207520539            5  inst             -> push1
  0 174829 4436207520544            5  inst             <- push1
  0 174829 4436207520550            5  inst             -> loadArrayStk
  0 174829 4436207520557            6  inst             <- loadArrayStk
  0 174829 4436207520563            5  inst             -> push1
  0 174829 4436207520568            5  inst             <- push1
  0 174829 4436207520574            5  inst             -> streq
  0 174829 4436207520580            5  inst             <- streq
  0 174829 4436207520586            5  inst             -> push1
  0 174829 4436207520591            5  inst             <- push1
  0 174829 4436207520597            5  inst             -> dup
  0 174829 4436207520602            5  inst             <- dup
  0 174829 4436207520608            5  inst             -> jumpFalse1
  0 174829 4436207520614            5  inst             <- jumpFalse1
  0 174829 4436207520619            5  inst             -> push1
  0 174829 4436207520625            5  inst             <- push1
  0 174829 4436207520631            5  inst             -> push1
  0 174829 4436207520636            5  inst             <- push1
  0 174829 4436207520642            5  inst             -> loadArrayStk
  0 174829 4436207520648            6  inst             <- loadArrayStk
  0 174829 4436207520654            5  inst             -> push1
  0 174829 4436207520660            5  inst             <- push1
  0 174829 4436207520665            5  inst             -> streq
  0 174829 4436207520671            5  inst             <- streq
  0 174829 4436207520677            5  inst             -> land
  0 174829 4436207520682            5  inst             <- land
  0 174829 4436207520688            5  inst             -> jumpFalse1
  0 174829 4436207520694            5  inst             <- jumpFalse1
  0 174829 4436207520700            5  inst             -> push1
  0 174829 4436207520705            5  inst             <- push1
  0 174829 4436207520711            5  inst             -> pop
  0 174829 4436207520716            5  inst             <- pop
  0 174829 4436207520722            5  inst             -> push1
  0 174829 4436207520728            5  inst             <- push1
  0 174829 4436207520733            5  inst             -> push1
  0 174829 4436207520739            5  inst             <- push1
  0 174829 4436207520744            5  inst             -> loadArrayStk
  0 174829 4436207520751            6  inst             <- loadArrayStk
  0 174829 4436207520757            5  inst             -> push1
  0 174829 4436207520762            5  inst             <- push1
  0 174829 4436207520768            5  inst             -> streq
  0 174829 4436207520773            5  inst             <- streq
  0 174829 4436207520779            5  inst             -> push1
  0 174829 4436207520785            5  inst             <- push1
  0 174829 4436207520791            5  inst             -> done
  0 174829 4436207520796            5  inst             <- done
  0 174829 4436207520802            6   cmd           <- if
  0 174829 4436207520822           19   cmd           -> if
  0 174829 4436207520835           13  inst             -> push1
  0 174829 4436207520841            5  inst             <- push1
  0 174829 4436207520847            5  inst             -> push1
  0 174829 4436207520852            5  inst             <- push1
  0 174829 4436207520858            5  inst             -> push1
  0 174829 4436207520864            5  inst             <- push1
  0 174829 4436207520869            5  inst             -> push1
  0 174829 4436207520875            5  inst             <- push1
  0 174829 4436207520881            5  inst             -> invokeStk1
  0 174829 4436207520887            6   cmd               -> namespace
  0 174829 4436207520896            8   cmd               <- namespace
  0 174829 4436207520902            6  inst             <- invokeStk1
  0 174829 4436207520908            5  inst             -> push1
  0 174829 4436207520913            5  inst             <- push1
  0 174829 4436207520919            5  inst             -> streq
  0 174829 4436207520925            6  inst             <- streq
  0 174829 4436207520931            5  inst             -> done
  0 174829 4436207520936            5  inst             <- done
  0 174829 4436207520942            6   cmd           <- if
  0 174829 4436207521503          560   cmd           -> set
  0 174829 4436207521515           11   cmd           <- set
  0 174829 4436207521524            9   cmd           -> set
  0 174829 4436207521531            6   cmd           <- set
  0 174829 4436207521541           10   cmd           -> if
  0 174829 4436207521559           17  inst             -> push1
  0 174829 4436207521566            7  inst             <- push1
  0 174829 4436207521573            6  inst             -> push1
  0 174829 4436207521578            5  inst             <- push1
  0 174829 4436207521584            5  inst             -> push1
  0 174829 4436207521590            5  inst             <- push1
  0 174829 4436207521596            5  inst             -> push1
  0 174829 4436207521601            5  inst             <- push1
  0 174829 4436207521607            5  inst             -> invokeStk1
  0 174829 4436207521613            6   cmd               -> namespace
  0 174829 4436207521621            7   cmd               <- namespace
  0 174829 4436207521627            6  inst             <- invokeStk1
  0 174829 4436207521633            5  inst             -> push1
  0 174829 4436207521639            5  inst             <- push1
  0 174829 4436207521644            5  inst             -> streq
  0 174829 4436207521650            5  inst             <- streq
  0 174829 4436207521656            5  inst             -> done
  0 174829 4436207521662            5  inst             <- done
  0 174829 4436207521674           11  inst             -> push1
  0 174829 4436207521679            5  inst             <- push1
  0 174829 4436207521685            5  inst             -> push1
  0 174829 4436207521691            5  inst             <- push1
  0 174829 4436207521697            5  inst             -> push1
  0 174829 4436207521702            5  inst             <- push1
  0 174829 4436207521708            5  inst             -> push1
  0 174829 4436207521714            5  inst             <- push1
  0 174829 4436207521720            5  inst             -> invokeStk1
  0 174829 4436207521726            6   cmd               -> proc
  0 174829 4436207521738           12   cmd               <- proc
  0 174829 4436207521744            6  inst             <- invokeStk1
  0 174829 4436207521750            5  inst             -> done
  0 174829 4436207521756            5  inst             <- done
  0 174829 4436207521762            6   cmd           <- if
  0 174829 4436207521862           99   cmd           -> proc
  0 174829 4436207521872           10   cmd           <- proc
  0 174829 4436207521891           19   cmd           -> proc
  0 174829 4436207521902           10   cmd           <- proc
  0 174829 4436207521932           30   cmd           -> proc
  0 174829 4436207521941            8   cmd           <- proc
  0 174829 4436207521961           19   cmd           -> proc
  0 174829 4436207521970            9   cmd           <- proc
  0 174829 4436207521985           14   cmd           -> proc
  0 174829 4436207521994            8   cmd           <- proc
  0 174829 4436207522039           45   cmd           -> if
  0 174829 4436207522053           14  inst             -> push1
  0 174829 4436207522059            5  inst             <- push1
  0 174829 4436207522065            6  inst             -> push1
  0 174829 4436207522070            5  inst             <- push1
  0 174829 4436207522076            5  inst             -> loadArrayStk
  0 174829 4436207522083            7  inst             <- loadArrayStk
  0 174829 4436207522089            5  inst             -> push1
  0 174829 4436207522094            5  inst             <- push1
  0 174829 4436207522100            5  inst             -> streq
  0 174829 4436207522106            5  inst             <- streq
  0 174829 4436207522112            5  inst             -> done
  0 174829 4436207522117            5  inst             <- done
  0 174829 4436207522134           16  inst             -> push1
  0 174829 4436207522140            5  inst             <- push1
  0 174829 4436207522146            5  inst             -> push1
  0 174829 4436207522151            5  inst             <- push1
  0 174829 4436207522157            5  inst             -> push1
  0 174829 4436207522163            5  inst             <- push1
  0 174829 4436207522168            5  inst             -> push1
  0 174829 4436207522174            5  inst             <- push1
  0 174829 4436207522180            5  inst             -> invokeStk1
  0 174829 4436207522186            6   cmd               -> proc
  0 174829 4436207522205           19   cmd               <- proc
  0 174829 4436207522212            6  inst             <- invokeStk1
  0 174829 4436207522218            5  inst             -> done
  0 174829 4436207522223            5  inst             <- done
  0 174829 4436207522230            6   cmd           <- if
  0 174829 4436207522274           44   cmd           -> proc
  0 174829 4436207522286           11   cmd           <- proc
  0 174829 4436207522294            8   cmd         <- source
  0 174829 4436207522301            6   cmd       <- uplevel
  0 174829 4436207522307            6  inst     <- invokeStk1
  0 174829 4436207522313            6  inst     -> storeScalar1
  0 174829 4436207522319            5  inst     <- storeScalar1
  0 174829 4436207522325            5  inst     -> push1
  0 174829 4436207522331            5  inst     <- push1
  0 174829 4436207522337            5  inst     -> jump1
  0 174829 4436207522342            5  inst     <- jump1
  0 174829 4436207522348            5  inst     -> endCatch
  0 174829 4436207522354            5  inst     <- endCatch
  0 174829 4436207522360            5  inst     -> not
  0 174829 4436207522366            5  inst     <- not
  0 174829 4436207522371            5  inst     -> jumpFalse1
  0 174829 4436207522377            5  inst     <- jumpFalse1
  0 174829 4436207522383            5  inst     -> push1
  0 174829 4436207522389            5  inst     <- push1
  0 174829 4436207522394            5  inst     -> done
  0 174829 4436207522400            5  inst     <- done
  0 174829 4436207522409            8  proc   <- tclInit
  0 174829 4436207522426           17   cmd <- tclInit
  0 174829 4436207522671          245   cmd -> proc
  0 174829 4436207522681            9   cmd <- proc
  0 174829 4436207522691            9   cmd -> proc
  0 174829 4436207522698            7   cmd <- proc
  0 174829 4436207522708            9   cmd -> proc
  0 174829 4436207522715            7   cmd <- proc
  0 174829 4436207522723            8   cmd -> func_a
  0 174829 4436207522742           18  proc   -> func_a
  0 174829 4436207522752           10  inst     -> push1
  0 174829 4436207522757            5  inst     <- push1
  0 174829 4436207522763            5  inst     -> push1
  0 174829 4436207522769            5  inst     <- push1
  0 174829 4436207522775            5  inst     -> invokeStk1
  0 174829 4436207522781            6   cmd       -> puts
  0 174829 4436207523212          430   cmd       <- puts
  0 174829 4436207523266           54  inst     <- invokeStk1
  0 174829 4436207523275            8  inst     -> pop
  0 174829 4436207523281            6  inst     <- pop
  0 174829 4436207523287            5  inst     -> push1
  0 174829 4436207523292            5  inst     <- push1
  0 174829 4436207523298            5  inst     -> push1
  0 174829 4436207523304            5  inst     <- push1
  0 174829 4436207523310            5  inst     -> invokeStk1
  0 174829 4436207523318            7   cmd       -> after
  0 174829 4436208530951      1007632   cmd       <- after
  0 174829 4436208530972           21  inst     <- invokeStk1
  0 174829 4436208530984           12  inst     -> pop
  0 174829 4436208530993            9  inst     <- pop
  0 174829 4436208530999            5  inst     -> push1
  0 174829 4436208531005            5  inst     <- push1
  0 174829 4436208531010            5  inst     -> invokeStk1
  0 174829 4436208531021           10   cmd       -> func_b
  0 174829 4436208531057           35  proc         -> func_b
  0 174829 4436208531067           10  inst           -> push1
  0 174829 4436208531073            5  inst           <- push1
  0 174829 4436208531079            5  inst           -> push1
  0 174829 4436208531084            5  inst           <- push1
  0 174829 4436208531090            5  inst           -> invokeStk1
  0 174829 4436208531096            6   cmd             -> puts
  0 174829 4436208531137           40   cmd             <- puts
  0 174829 4436208531144            6  inst           <- invokeStk1
  0 174829 4436208531150            5  inst           -> pop
  0 174829 4436208531155            5  inst           <- pop
  0 174829 4436208531161            5  inst           -> push1
  0 174829 4436208531166            5  inst           <- push1
  0 174829 4436208531172            5  inst           -> push1
  0 174829 4436208531178            5  inst           <- push1
  0 174829 4436208531184            5  inst           -> invokeStk1
  0 174829 4436208531190            6   cmd             -> after
  0 174829 4436209540924      1009734   cmd             <- after
  0 174829 4436209540946           21  inst           <- invokeStk1
  0 174829 4436209540957           11  inst           -> pop
  0 174829 4436209540967            9  inst           <- pop
  0 174829 4436209540973            5  inst           -> push1
  0 174829 4436209540978            5  inst           <- push1
  0 174829 4436209540984            5  inst           -> invokeStk1
  0 174829 4436209540995           10   cmd             -> func_c
  0 174829 4436209541029           34  proc               -> func_c
  0 174829 4436209541039           10  inst                 -> push1
  0 174829 4436209541045            5  inst                 <- push1
  0 174829 4436209541051            5  inst                 -> push1
  0 174829 4436209541056            5  inst                 <- push1
  0 174829 4436209541062            5  inst                 -> invokeStk1
  0 174829 4436209541068            6   cmd                   -> puts
  0 174829 4436209541111           42   cmd                   <- puts
  0 174829 4436209541118            7  inst                 <- invokeStk1
  0 174829 4436209541124            5  inst                 -> pop
  0 174829 4436209541129            5  inst                 <- pop
  0 174829 4436209541135            5  inst                 -> push1
  0 174829 4436209541141            5  inst                 <- push1
  0 174829 4436209541147            5  inst                 -> push1
  0 174829 4436209541153            5  inst                 <- push1
  0 174829 4436209541158            5  inst                 -> invokeStk1
  0 174829 4436209541165            6   cmd                   -> after
  0 174829 4436210550785      1009619   cmd                   <- after
  0 174829 4436210550807           22  inst                 <- invokeStk1
  0 174829 4436210550819           11  inst                 -> done
  0 174829 4436210550830           10  inst                 <- done
  0 174829 4436210550839            9  proc               <- func_c
  0 174829 4436210550850           11   cmd             <- func_c
  0 174829 4436210550856            6  inst           <- invokeStk1
  0 174829 4436210550862            5  inst           -> done
  0 174829 4436210550868            5  inst           <- done
  0 174829 4436210550874            6  proc         <- func_b
  0 174829 4436210550880            6   cmd       <- func_b
  0 174829 4436210550887            6  inst     <- invokeStk1
  0 174829 4436210550892            5  inst     -> done
  0 174829 4436210550898            5  inst     <- done
  0 174829 4436210550904            6  proc   <- func_a
  0 174829 4436210550911            6   cmd <- func_a
  0 174829 4436210550938           27   cmd -> exit

As you can see the output is quite long, and in seven columns.  The first
column is the CPU the action is on.  The second is the PID.  The third is the
time since boot in microseconds.  

The fourth column is the number of microseconds that has elapsed between the
previous line and the current one.

The fifth column is the type of event that occurred (procedure, command or
instruction).

The sixth and seventh columns are indented by 2 spaces to show when a new
event occurs.  This shows us which command is calling which.

If the output looks strange, check the CPU "C" column - if it changes,
then the output is probably shuffled. See Notes/ALLsnoop_notes.txt for
details and suggested workarounds.

See Notes/ALLflow_notes.txt for important notes about reading flow outputs.