CAC 2019-05-14
full_block:
     entry (P_event_wait_list_ptr, P_event_wait_info_ptr, P_code);

002214  aa   001140 6270 00   eax7      608
002215  aa  7 00034 3521 20   epp2      pr7|28,*       
002216  aa  2 01045 2721 00   tsp2      pr2|549             ext_entry  

1555286569.860407: DBG(324120974) 0: CPU TRACE 0: 00265:002600 4 001140627000 (EAX7 001140) 001140 627(0) 0 0 0 00
1555286569.861879: DBG(324120976) 0: CPU TRACE 0: 00265:002601 4 700034352120 (EPP2 PR7|34,N*) 000034 352(0) 1 0 1 00
1555286569.863350: DBG(324120978) 0: CPU TRACE 0: 00265:002602 4 201045272100 (TSP2 PR2|1045) 001045 272(0) 1 0 0 00

002221  aa  6 00032 3735 20   epp7      pr6|26,*
002222  aa  7 00004 3715 20   epp5      pr7|4,*
002223  aa  6 00214 6515 00   spri5     pr6|140
002224  aa  7 00006 3535 20   epp3      pr7|6,*        
002225  aa  6 00212 2535 00   spri3     pr6|138

1555286569.868213: DBG(324121022) 0: CPU TRACE 0: 00265:002605 4 600032373520 (EPP7 PR6|32,N*) 000032 373(1) 1 0 1 00
1555286569.869659: DBG(324121024) 0: CPU TRACE 0: 00265:002606 4 700004371520 (EPP5 PR7|4,N*) 000004 371(1) 1 0 1 00
1555286569.871062: DBG(324121026) 0: CPU TRACE 0: 00265:002607 4 600214651500 (SPRI5 PR6|214) 000214 651(1) 1 0 0 00
1555286569.872587: DBG(324121028) 0: CPU TRACE 0: 00265:002610 4 700006353520 (EPP3 PR7|6,N*) 000006 353(1) 1 0 1 00
1555286569.874105: DBG(324121030) 0: CPU TRACE 0: 00265:002611 4 600212253500 (SPRI3 PR6|212) 000212 253(1) 1 0 0 00

                                                            STATEMENT 1 ON LINE 707
          call find_ectp ();

002226  aa   000667 6700 04   tsp4      439,ic              003115
                                                            STATEMENT 1 ON LINE 709
          event_wait_list_ptr = P_event_wait_list_ptr;

002227  aa  6 00032 3735 20   epp7      pr6|26,*
002230  aa  7 00002 3715 20   epp5      pr7|2,*             P_event_wait_list_ptr
002231  aa  5 00000 3715 20   epp5      pr5|0,*             P_event_wait_list_ptr
002232  aa  6 00204 6515 00   spri5     pr6|132             event_wait_list_ptr

1555286569.891161: DBG(324121052) 0: CPU TRACE 0: 00265:002613 4 600032373520 (EPP7 PR6|32,N*) 000032 373(1) 1 0 1 00
1555286569.892593: DBG(324121054) 0: CPU TRACE 0: 00265:002614 4 700002371520 (EPP5 PR7|2,N*) 000002 371(1) 1 0 1 00
1555286569.894206: DBG(324121056) 0: CPU TRACE 0: 00265:002615 4 500000371520 (EPP5 PR5|0,N*) 000000 371(1) 1 0 1 00
1555286569.895682: DBG(324121058) 0: CPU TRACE 0: 00265:002616 4 600204651500 (SPRI5 PR6|204) 000204 651(1) 1 0 0 00

                                                            STATEMENT 1 ON LINE 710
          event_wait_info_ptr = P_event_wait_info_ptr;

002233  aa  6 00214 3535 20   epp3      pr6|140,*           P_event_wait_info_ptr
002234  aa  3 00000 3535 20   epp3      pr3|0,*             P_event_wait_info_ptr
002235  aa  6 00200 2535 00   spri3     pr6|128             event_wait_info_ptr

1555286569.897183: DBG(324121060) 0: CPU TRACE 0: 00265:002617 4 600214353520 (EPP3 PR6|214,N*) 000214 353(1) 1 0 1 00
1555286569.898735: DBG(324121062) 0: CPU TRACE 0: 00265:002620 4 300000353520 (EPP3 PR3|0,N*) 000000 353(1) 1 0 1 00
1555286569.900188: DBG(324121064) 0: CPU TRACE 0: 00265:002621 4 600200253500 (SPRI3 PR6|200) 000200 253(1) 1 0 0 00

                                                            STATEMENT 1 ON LINE 711
          event_wait_info.channel_index = 0;

002236  aa  3 00006 4501 00   stz       pr3|6               event_wait_info.channel_index

1555286569.901626: DBG(324121066) 0: CPU TRACE 0: 00265:002622 4 300006450100 (STZ PR3|6) 000006 450(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 713
          event_wait_list_n_channels = event_wait_list.n_channels;

002237  aa  5 00000 2361 00   ldq       pr5|0               event_wait_list.n_channels
002240  aa  6 00202 7561 00   stq       pr6|130             event_wait_list_n_channels

1555286569.903104: DBG(324121068) 0: CPU TRACE 0: 00265:002623 4 500000236100 (LDQ PR5|0) 000000 236(0) 1 0 0 00
Q=000000000001
1555286569.904610: DBG(324121070) 0: CPU TRACE 0: 00265:002624 4 600202756100 (STQ PR6|202) 000202 756(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 716
          if event_wait_list_n_channels <= 0
          then do;

002241  aa   000005 6054 04   tpnz      5,ic                002246

1555286569.906156: DBG(324121072) 0: CPU TRACE 0: 00265:002625 4 000005605404 (TPNZ 000005,IC) 000005 605(1) 0 0 0 04
1555286569.906164: DBG(324121072) 0: CPU TRACE read_tra_op 00265:002632

                                                            STATEMENT 1 ON LINE 722
          block_val = cu_$level_get ();

002246  aa  6 00101 3521 00   epp2      pr6|65              block_val
002247  aa  6 00602 2521 00   spri2     pr6|386
002250  aa  6 00600 6211 00   eax1      pr6|384
002251  aa   004000 4310 07   fld       2048,dl
002252  aa  6 00044 3701 20   epp4      pr6|36,*
002253  la  4 00012 3521 20   epp2      pr4|10,*            cu_$level_get
002254  aa  0 00623 7001 00   tsx0      pr0|403             call_ext_out

                                                            STATEMENT 1 ON LINE 723
          cur_ring = get_ring_ ();

002255  aa  6 00117 3521 00   epp2      pr6|79              cur_ring
002256  aa  6 00602 2521 00   spri2     pr6|386
002257  aa  6 00600 6211 00   eax1      pr6|384
002260  aa   004000 4310 07   fld       2048,dl
002261  aa  6 00044 3701 20   epp4      pr6|36,*
002262  la  4 00020 3521 20   epp2      pr4|16,*            get_ring_
002263  aa  0 00623 7001 00   tsx0      pr0|403             call_ext_out

                                                            STATEMENT 1 ON LINE 725
          event_call_in_progress = NO;

002264  aa  6 00130 4501 00   stz       pr6|88              event_call_in_progress

                                                            STATEMENT 1 ON LINE 727
          added_to_waiting_lists = NO;

002265  aa  6 00100 4501 00   stz       pr6|64              added_to_waiting_lists

          on cleanup
               begin;

002266  aa   000007 7260 07   lxl6      7,dl
002267  aa   775541 3520 04   epp2      -1183,ic            000030 = 143154145141
002270  aa  0 00717 7001 00   tsx0      pr0|463             enable_op
002271  aa   000004 7100 04   tra       4,ic                002275
002272  aa     000164000000
002273  aa   000041 7100 04   tra       33,ic               002334
BEGIN CONDITION cleanup.11

                                                            STATEMENT 1 ON LINE 741
          mask = ""b;

002334  aa  6 00147 4501 00   stz       pr6|103             mask

1555286569.979250: DBG(324121274) 0: CPU TRACE 0: 00265:002720 4 600147450100 (STZ PR6|147) 000147 450(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 742
          on any_other call any_other_handler ();

002335  aa   000011 7260 07   lxl6      9,dl
002336  aa   775474 3520 04   epp2      -1220,ic            000032 = 141156171137
002337  aa  0 00717 7001 00   tsx0      pr0|463             enable_op
002340  aa   000004 7100 04   tra       4,ic                002344
002341  aa     000156000000
002342  aa   000015 7100 04   tra       13,ic               002357

                                                            STATEMENT 1 ON LINE 744
          current_control_point_id = get_control_point_id_ ();

002357  aa  6 00120 3521 00   epp2      pr6|80              current_control_point_id
002360  aa  6 00602 2521 00   spri2     pr6|386
002361  aa  6 00600 6211 00   eax1      pr6|384
002362  aa   004000 4310 07   fld       2048,dl
002363  aa  6 00044 3701 20   epp4      pr6|36,*
002364  la  4 00076 3521 20   epp2      pr4|62,*            get_control_point_id_
002365  aa  0 00623 7001 00   tsx0      pr0|403             call_ext_out

1555286569.990754: DBG(324121332) 0: CPU TRACE 0: 00265:002743 4 600120352100 (EPP2 PR6|120) 000120 352(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 751
               call copy_itt_messages (NO);

002366  aa   004320 3520 04   epp2      2256,ic             006706 = 000002000000
002367  aa   000546 6700 04   tsp4      358,ic              003135

1555286570.005647: DBG(324121404) 0: CPU TRACE 0: 00265:002752 4 004320352004 (EPP2 004320,IC) 004320 352(0) 0 0 0 04
1555286570.007252: DBG(324121406) 0: CPU TRACE 0: 00265:002753 4 000546670004 (TSP4 000546,IC) 000546 670(0) 0 0 0 04

/* Pickup any new event messages which have arrived since we last blocked */

copy_itt_messages:
     procedure (p_set_wcp);

003135  aa  6 00224 6501 00   spri4     pr6|148
003136  aa  6 00226 2521 00   spri2     pr6|150

1555286570.008768: DBG(324121408) 0: CPU TRACE 0: 00265:003521 4 600224650100 (SPRI4 PR6|224) 000224 650(0) 1 0 0 00
1555286570.010275: DBG(324121410) 0: CPU TRACE 0: 00265:003522 4 600226252100 (SPRI2 PR6|226) 000226 252(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 938
          if ect_header.firstp (ITT_MESSAGE) = null
          then do;

003137  aa   000020 2360 07   ldq       16,dl
003140  aa  6 00172 3735 20   epp7      pr6|122,*           ect_ptr
003141  aa  7 00006 2371 06   ldaq      pr7|6,ql            ect_header.firstp
003142  aa   774664 6770 04   eraq      -1612,ic            000026 = 077777000043 000001000000
003143  aa  0 00460 3771 00   anaq      pr0|304             = 077777000077 777777077077
003144  aa   000040 6010 04   tnz       32,ic               003204

1555286570.011780: DBG(324121412) 0: CPU TRACE 0: 00265:003523 4 000020236007 (LDQ 000020,DL) 000020 236(0) 0 0 0 07
1555286570.013290: DBG(324121414) 0: CPU TRACE 0: 00265:003524 4 600172373520 (EPP7 PR6|172,N*) 000172 373(1) 1 0 1 00
1555286570.015252: DBG(324121416) 0: CPU TRACE 0: 00265:003525 4 700006237106 (LDAQ PR7|6,QL) 000006 237(0) 1 0 0 06
1555286570.016927: DBG(324121418) 0: CPU TRACE 0: 00265:003526 4 774664677004 (ERAQ 774664,IC) 774664 677(0) 0 0 0 04
1555286570.018389: DBG(324121420) 0: CPU TRACE 0: 00265:003527 4 000460377100 (ANAQ PR0|460) 000460 377(0) 1 0 0 00
1555286570.019909: DBG(324121422) 0: CPU TRACE 0: 00265:003530 4 000040601004 (TNZ 000040,IC) 000040 601(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 940
                    if block_val ^= cur_ring
                    then call cu_$level_set (cur_ring);

003145  aa  6 00101 2361 00   ldq       pr6|65              block_val
003146  aa  6 00117 1161 00   cmpq      pr6|79              cur_ring
003147  aa   000010 6000 04   tze       8,ic                003157
003150  aa  6 00117 3521 00   epp2      pr6|79              cur_ring
003151  aa  6 00652 2521 00   spri2     pr6|426
003152  aa  6 00650 6211 00   eax1      pr6|424
003153  aa   004000 4310 07   fld       2048,dl
003154  aa  6 00044 3701 20   epp4      pr6|36,*
003155  la  4 00014 3521 20   epp2      pr4|12,*            cu_$level_set
003156  aa  0 00623 7001 00   tsx0      pr0|403             call_ext_out

1555286570.021384: DBG(324121424) 0: CPU TRACE 0: 00265:003531 4 600101236100 (LDQ PR6|101) 000101 236(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 942
                    call hcs_$read_events (ipc_data_$fast_channel_events, ("0"b));

003157  aa   000000 2350 07   lda       0,dl
003160  aa  6 00654 7551 00   sta       pr6|428
003161  aa  6 00044 3701 20   epp4      pr6|36,*
003162  la  4 00072 3521 20   epp2      pr4|58,*            ipc_data_$fast_channel_events
003163  aa  6 00660 2521 00   spri2     pr6|432
003164  aa  6 00654 3521 00   epp2      pr6|428
003165  aa  6 00662 2521 00   spri2     pr6|434
003166  aa  6 00656 6211 00   eax1      pr6|430
003167  aa   010000 4310 07   fld       4096,dl
003170  la  4 00030 3521 20   epp2      pr4|24,*            hcs_$read_events
003171  aa  0 00623 7001 00   tsx0      pr0|403             call_ext_out

1555286570.025724: DBG(324121430) 0: CPU TRACE 0: 00265:003543 4 000000235007 (LDA 000000,DL) 000000 235(0) 0 0 0 07

                    if block_val ^= cur_ring
                    then call cu_$level_set (block_val);

003172  aa  6 00101 2361 00   ldq       pr6|65              block_val
003173  aa  6 00117 1161 00   cmpq      pr6|79              cur_ring
003174  aa   000010 6000 04   tze       8,ic                003204
003175  aa  6 00101 3521 00   epp2      pr6|65              block_val
003176  aa  6 00652 2521 00   spri2     pr6|426
003177  aa  6 00650 6211 00   eax1      pr6|424
003200  aa   004000 4310 07   fld       2048,dl
003201  aa  6 00044 3701 20   epp4      pr6|36,*
003202  la  4 00014 3521 20   epp2      pr4|12,*            cu_$level_set
003203  aa  0 00623 7001 00   tsx0      pr0|403             call_ext_out

1555286571.387316: DBG(324127108) 0: CPU TRACE 0: 00265:003556 4 600101236100 (LDQ PR6|101) 000101 236(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 945
               end;

                                                            STATEMENT 1 ON LINE 952
          if (p_set_wcp = YES) | (have_multiple_control_points () = YES)
          then do;

003204  aa   003456 3520 04   epp2      1838,ic             006662 = 000002000000
003205  aa   002350 6700 04   tsp4      1256,ic             005555
003206  aa  6 00654 2351 00   lda       pr6|428
003207  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
003210  aa   400000 1150 03   cmpa      131072,du
003211  aa  0 00512 7001 00   tsx0      pr0|330             r_e_as
003212  aa  6 00654 7551 00   sta       pr6|428
003213  aa  6 00226 3735 20   epp7      pr6|150,*
003214  aa  7 00002 2351 20   lda       pr7|2,*             p_set_wcp
003215  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
003216  aa   400000 1150 03   cmpa      131072,du
003217  aa  0 00512 7001 00   tsx0      pr0|330             r_e_as
003220  aa  6 00654 2751 00   ora       pr6|428
003221  aa   000054 6000 04   tze       44,ic               003275

1555286571.391555: DBG(324127114) 0: CPU TRACE 0: 00265:003570 4 003456352004 (EPP2 003456,IC) 003456 352(0) 0 0 0 04

1555286571.425047: DBG(324127170) 0: CPU TRACE 0: 00265:003605 4 000054600004 (TZE 000054,IC) 000054 600(0) 0 0 0 04
1555286571.425056: DBG(324127170) 0: CPU TRACE read_tra_op 00265:003661

                                                            STATEMENT 1 ON LINE 976
          call mask_ips_interrupts (mask);

003275  aa   003447 3520 04   epp2      1831,ic             006744 = 000002000000
003276  aa   002115 6700 04   tsp4      1101,ic             005413

1555286571.426483: DBG(324127172) 0: CPU TRACE 0: 00265:003661 4 003447352004 (EPP2 003447,IC) 003447 352(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 978
          do msg_ptr = ect_header.firstp (ITT_MESSAGE) repeat (ect_header.firstp (ITT_MESSAGE)) while (msg_ptr ^= null);

003277  aa   000020 2360 07   ldq       16,dl
003300  aa  6 00172 3735 20   epp7      pr6|122,*           ect_ptr
003301  aa  7 00006 3735 26   epp7      pr7|6,ql*           ect_header.firstp
003302  aa  6 00150 6535 00   spri7     pr6|104             msg_ptr
003303  aa   000000 0110 03   nop       0,du
003304  aa  6 00150 2371 00   ldaq      pr6|104             msg_ptr
003305  aa   774521 6770 04   eraq      -1711,ic            000026 = 077777000043 000001000000
003306  aa  0 00460 3771 00   anaq      pr0|304             = 077777000077 777777077077
003307  aa   000147 6000 04   tze       103,ic              003456

1555286571.475126: DBG(324127286) 0: CPU TRACE 0: 00265:003663 4 000020236007 (LDQ 000020,DL) 000020 236(0) 0 0 0 07

                                                            STATEMENT 1 ON LINE 980
               ect_header.firstp (ITT_MESSAGE) = msg_ptr -> itt_message.next_itt_msgp;

003310  aa   000020 2360 07   ldq       16,dl
003311  aa  6 00150 3735 20   epp7      pr6|104,*           msg_ptr
003312  aa  7 00001 7671 00   lprp7     pr7|1               itt_message.next_itt_msgp
003313  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003314  aa  5 00006 6535 06   spri7     pr5|6,ql            ect_header.firstp

1555286571.486664: DBG(324127304) 0: CPU TRACE 00265:003674 bound_ipc_:ipc_real_+03310
1555286571.487799: DBG(324127304) 0: CPU TRACE 003310  aa   000020 2360 07      ldq       16,dl
1555286571.488045: DBG(324127304) 0: CPU TRACE 0: 00265:003674 4 000020236007 (LDQ 000020,DL) 000020 236(0) 0 0 0 07

                                                            STATEMENT 1 ON LINE 981
               if ect_header.lastp (ITT_MESSAGE) = msg_ptr
               then ect_header.lastp (ITT_MESSAGE) = null;

003315  aa  6 00654 7561 00   stq       pr6|428
003316  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003317  aa  5 00010 2371 06   ldaq      pr5|8,ql            ect_header.lastp
003320  aa  6 00150 6771 00   eraq      pr6|104             msg_ptr
003321  aa  0 00460 3771 00   anaq      pr0|304             = 077777000077 777777077077
003322  aa   000004 6010 04   tnz       4,ic                003326
003323  aa   774503 2370 04   ldaq      -1725,ic            000026 = 077777000043 000001000000
003324  aa  6 00654 7271 00   lxl7      pr6|428
003325  aa  5 00010 7571 17   staq      pr5|8,7             ect_header.lastp

1555286571.493836: DBG(324127314) 0: CPU TRACE 00265:003701 bound_ipc_:ipc_real_+03315
1555286571.494997: DBG(324127314) 0: CPU TRACE 003315  aa  6 00654 7561 00      stq       pr6|428
1555286571.495210: DBG(324127314) 0: CPU TRACE 0: 00265:003701 4 600654756100 (STQ PR6|654) 000654 756(0) 1 0 0 00

               ect_header.count (ITT_MESSAGE) = ect_header.count (ITT_MESSAGE) - 1;

003326  aa   000001 3360 07   lcq       1,dl
003327  aa   000004 7270 07   lxl7      4,dl
003330  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003331  aa  5 00004 0561 17   asq       pr5|4,7             ect_header.count

1555286571.507214: DBG(324127332) 0: CPU TRACE 00265:003715 bound_ipc_:ipc_real_+03331
1555286571.508358: DBG(324127332) 0: CPU TRACE 003331  aa  5 00004 0561 17      asq       pr5|4,7             ect_header.count
1555286571.508590: DBG(324127332) 0: CPU TRACE 0: 00265:003715 4 500004056117 (ASQ PR5|4,7) 000004 056(0) 1 0 0 17
1555286571.508597: DBG(324127332) 0: CPU FINAL Read (Actual) Read:  iefpFinalAddress=61071420  readData=000000000004

                                                            STATEMENT 1 ON LINE 985
               call ipc_util_$verify_regular_channel (msg_ptr -> itt_message.channel_id, an_ectep, code);

003332  aa  6 00150 3535 20   epp3      pr6|104,*           msg_ptr
1555286571.508626: DBG(324127334) 0: CPU TRACE 00265:003716 bound_ipc_:ipc_real_+03332
1555286571.509760: DBG(324127334) 0: CPU TRACE 003332  aa  6 00150 3535 20      epp3      pr6|104,*           msg_ptr
1555286571.510001: DBG(324127334) 0: CPU TRACE 0: 00265:003716 4 600150353520 (EPP3 PR6|150,N*) 000150 353(1) 1 0 1 00

                                                            STATEMENT 1 ON LINE 987
               if code = 0
               then do;

003346  aa  6 00235 2361 00   ldq       pr6|157             code
003347  aa   000070 6010 04   tnz       56,ic               003437

1555286571.682801: DBG(324128101) 0: CPU TRACE 00265:003733 bound_ipc_:ipc_real_+03347
1555286571.684019: DBG(324128101) 0: CPU TRACE 003347  aa   000070 6010 04      tnz       56,ic               003437
1555286571.684230: DBG(324128101) 0: CPU TRACE 0: 00265:003733 4 000070601004 (TNZ 000070,IC) 000070 601(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 992
                         msg_ptr -> event_message.chanp = an_ectep;

003350  aa  6 00232 3735 20   epp7      pr6|154,*           an_ectep
003351  aa  6 00150 3715 20   epp5      pr6|104,*           msg_ptr
003352  aa  5 00001 5471 00   sprp7     pr5|1               event_message.chanp

1555286571.684258: DBG(324128103) 0: CPU TRACE 00265:003734 bound_ipc_:ipc_real_+03350
1555286571.685480: DBG(324128103) 0: CPU TRACE 003350  aa  6 00232 3735 20      epp7      pr6|154,*           an_ectep
1555286571.685691: DBG(324128103) 0: CPU TRACE 0: 00265:003734 4 600232373520 (EPP7 PR6|232,N*) 000232 373(1) 1 0 1 00

                                                            STATEMENT 1 ON LINE 994
                         if (p_set_wcp = YES) | (have_multiple_control_points () = YES)
                         then ect_header.wakeup_control_points, a_wait_channel.wakeup_control_points = YES;

003353  aa   003307 3520 04   epp2      1735,ic             006662 = 000002000000
003354  aa   002201 6700 04   tsp4      1153,ic             005555
003355  aa  6 00654 2351 00   lda       pr6|428
003356  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
003357  aa   400000 1150 03   cmpa      131072,du
003360  aa  0 00512 7001 00   tsx0      pr0|330             r_e_as
003361  aa  6 00654 7551 00   sta       pr6|428
003362  aa  6 00226 3735 20   epp7      pr6|150,*
003363  aa  7 00002 2351 20   lda       pr7|2,*             p_set_wcp
003364  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
003364  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
003365  aa   400000 1150 03   cmpa      131072,du
003366  aa  0 00512 7001 00   tsx0      pr0|330             r_e_as
003367  aa  6 00654 2751 00   ora       pr6|428
003370  aa   000015 6000 04   tze       13,ic               003405
003371  aa   200000 2350 03   lda       65536,du
003372  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003373  aa  6 00654 7551 00   sta       pr6|428
003374  aa  5 00043 6751 00   era       pr5|35              ect_header.wakeup_control_points
003375  aa   200000 3750 03   ana       65536,du
003376  aa  5 00043 6551 00   ersa      pr5|35              ect_header.wakeup_control_points
003377  aa  6 00654 2351 00   lda       pr6|428
003400  aa   000021 7710 00   arl       17
003401  aa  6 00232 3535 20   epp3      pr6|154,*           an_ectep
003402  aa  3 00003 6751 00   era       pr3|3               a_wait_channel.wakeup_control_points
003403  aa   400000 3750 07   ana       131072,dl
003404  aa  3 00003 6551 00   ersa      pr3|3               a_wait_channel.wakeup_control_points

1555286571.716588: DBG(324128151) 0: CPU TRACE 00265:003750 bound_ipc_:ipc_real_+03364
1555286571.717775: DBG(324128151) 0: CPU TRACE 003364  aa  0 00002 3771 00      anaq      pr0|2               = 400000000000 000000000000
1555286571.718011: DBG(324128151) 0: CPU TRACE 0: 00265:003750 4 000002377100 (ANAQ PR0|2) 000002 377(0) 1 0 0 00

                         if a_call_channel.type = CALL
                         then do;

003405  aa  6 00232 2351 20   lda       pr6|154,*           a_call_channel.type
003406  aa   000033 7350 00   als       27
003407  aa   000077 7330 00   lrs       63
003410  aa   000002 1160 07   cmpq      2,dl
003411  aa   000011 6010 04   tnz       9,ic                003422

1555286571.724830: DBG(324128167) 0: CPU TRACE 00265:003771 bound_ipc_:ipc_real_+03405
1555286571.726019: DBG(324128167) 0: CPU TRACE 003405  aa  6 00232 2351 20      lda       pr6|154,*           a_call_channel.type
1555286571.726228: DBG(324128167) 0: CPU TRACE 0: 00265:003771 4 600232235120 (LDA PR6|232,N*) 000232 235(0) 1 0 1 00

1555286571.730623: DBG(324128175) 0: CPU TRACE 00265:003775 bound_ipc_:ipc_real_+03411
1555286571.731835: DBG(324128175) 0: CPU TRACE 003411  aa   000011 6010 04      tnz       9,ic                003422
1555286571.732095: DBG(324128175) 0: CPU TRACE 0: 00265:003775 4 000011601004 (TNZ 000011,IC) 000011 601(0) 0 0 0 04
1555286571.732102: DBG(324128175) 0: CPU TRACE read_tra_op 00265:004006

                                                            STATEMENT 1 ON LINE 1004
                         else do;

                                                            STATEMENT 1 ON LINE 1005
                                   call insert_event_wait_message (msg_ptr);

003422  aa   003234 3520 04   epp2      1692,ic             006656 = 000002000000
003423  aa   000637 6700 04   tsp4      415,ic              004262

1555286571.732125: DBG(324128177) 0: CPU TRACE 00265:004006 bound_ipc_:ipc_real_+03422
1555286571.733294: DBG(324128177) 0: CPU TRACE 003422  aa   003234 3520 04      epp2      1692,ic             006656 = 000002000000
1555286571.733524: DBG(324128177) 0: CPU TRACE 0: 00265:004006 4 003234352004 (EPP2 003234,IC) 003234 352(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 1006
                                   ect_header.total_wait_wakeups = ect_header.total_wait_wakeups + 1;

003424  aa  6 00172 3735 20   epp7      pr6|122,*           ect_ptr
003425  aa  7 00037 0541 00   aos       pr7|31              ect_header.total_wait_wakeups

1555286571.912701: DBG(324128415) 0: CPU TRACE 00265:004010 bound_ipc_:ipc_real_+03424
1555286571.913935: DBG(324128415) 0: CPU TRACE 003424  aa  6 00172 3735 20      epp7      pr6|122,*           ect_ptr
1555286571.914142: DBG(324128415) 0: CPU TRACE 0: 00265:004010 4 600172373520 (EPP7 PR6|172,N*) 000172 373(1) 1 0 1 00

                                                            STATEMENT 1 ON LINE 1007
                              end;

                                                            STATEMENT 1 ON LINE 1009
                         ect_header.total_wakeups = ect_header.total_wakeups + 1;

003426  aa  7 00036 0541 00   aos       pr7|30              ect_header.total_wakeups

1555286571.915678: DBG(324128419) 0: CPU TRACE 00265:004012 bound_ipc_:ipc_real_+03426
1555286571.916894: DBG(324128419) 0: CPU TRACE 003426  aa  7 00036 0541 00      aos       pr7|30              ect_header.total_wakeups
1555286571.917120: DBG(324128419) 0: CPU TRACE 0: 00265:004012 4 700036054100 (AOS PR7|36) 000036 054(0) 1 

                                                            STATEMENT 1 ON LINE 1010
                         a_wait_channel.wakeup_count = a_wait_channel.wakeup_count + 1;

003427  aa  6 00232 3715 20   epp5      pr6|154,*           an_ectep
003430  aa  5 00003 2361 00   ldq       pr5|3               a_wait_channel.wakeup_count
003431  aa  0 00376 3771 00   anaq      pr0|254             = 000000000000 000000377777
003432  aa   000001 0760 07   adq       1,dl
003433  aa  5 00003 6761 00   erq       pr5|3               a_wait_channel.wakeup_count
003434  aa   377777 3760 07   anq       131071,dl
003435  aa  5 00003 6561 00   ersq      pr5|3               a_wait_channel.wakeup_count
                                                            STATEMENT 1 ON LINE 1011
                    end;

003436  aa   000014 7100 04   tra       12,ic               003452

1555286571.927497: DBG(324128435) 0: CPU TRACE 00265:004022 bound_ipc_:ipc_real_+03436
1555286571.928678: DBG(324128435) 0: CPU TRACE 003436  aa   000014 7100 04      tra       12,ic               003452
1555286571.928938: DBG(324128435) 0: CPU TRACE 0: 00265:004022 4 000014710004 (TRA 000014,IC) 000014 710(0) 0 0 0 04
1555286571.928946: DBG(324128435) 0: CPU TRACE read_tra_op 00265:004036

003452  aa   000020 2360 07   ldq       16,dl
003453  aa  7 00006 3715 26   epp5      pr7|6,ql*           ect_header.firstp
003454  aa  6 00150 6515 00   spri5     pr6|104             msg_ptr
003455  aa   777627 7100 04   tra       -105,ic             003304

1555286571.928980: DBG(324128437) 0: CPU TRACE 00265:004036 bound_ipc_:ipc_real_+03452
1555286571.930201: DBG(324128437) 0: CPU TRACE 003452  aa   000020 2360 07      ldq       16,dl
1555286571.930410: DBG(324128437) 0: CPU TRACE 0: 00265:004036 4 000020236007 (LDQ 000020,DL) 000020 236(0) 0 0 0 07

1555286571.933893: DBG(324128443) 0: CPU TRACE 00265:004041 bound_ipc_:ipc_real_+03455
1555286571.935338: DBG(324128443) 0: CPU TRACE 003455  aa   777627 7100 04      tra       -105,ic             003304
1555286571.935543: DBG(324128443) 0: CPU TRACE 0: 00265:004041 4 777627710004 (TRA 777627,IC) 777627 710(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 978
          do msg_ptr = ect_header.firstp (ITT_MESSAGE) repeat (ect_header.firstp (ITT_MESSAGE)) while (msg_ptr ^= null);

003277  aa   000020 2360 07   ldq       16,dl
003300  aa  6 00172 3735 20   epp7      pr6|122,*           ect_ptr
003301  aa  7 00006 3735 26   epp7      pr7|6,ql*           ect_header.firstp
003302  aa  6 00150 6535 00   spri7     pr6|104             msg_ptr
003303  aa   000000 0110 03   nop       0,du
003304  aa  6 00150 2371 00   ldaq      pr6|104             msg_ptr

1555286571.935587: DBG(324128445) 0: CPU TRACE 00265:003670 bound_ipc_:ipc_real_+03304
1555286571.936807: DBG(324128445) 0: CPU TRACE 003304  aa  6 00150 2371 00      ldaq      pr6|104             msg_ptr
1555286571.937045: DBG(324128445) 0: CPU TRACE 0: 00265:003670 4 600150237100 (LDAQ PR6|150) 000150 237(0) 1 0 0 00

003305  aa   774521 6770 04   eraq      -1711,ic            000026 = 077777000043 000001000000

1555286571.937075: DBG(324128447) 0: CPU TRACE 00265:003671 bound_ipc_:ipc_real_+03305
1555286571.938321: DBG(324128447) 0: CPU TRACE 003305  aa   774521 6770 04      eraq      -1711,ic            000026 = 077777000043 000001000000
1555286571.938536: DBG(324128447) 0: CPU TRACE 0: 00265:003671 4 774521677004 (ERAQ 774521,IC) 774521 677(0) 0 0 0 04

003306  aa  0 00460 3771 00   anaq      pr0|304             = 077777000077 777777077077

1555286571.938569: DBG(324128449) 0: CPU TRACE 00265:003672 bound_ipc_:ipc_real_+03306
1555286571.939696: DBG(324128449) 0: CPU TRACE 003306  aa  0 00460 3771 00      anaq      pr0|304             = 077777000077 777777077077
1555286571.939968: DBG(324128449) 0: CPU TRACE 0: 00265:003672 4 000460377100 (ANAQ PR0|460) 000460 377(0) 1 0 0 00

003307  aa   000147 6000 04   tze       103,ic              003456

1555286571.939998: DBG(324128451) 0: CPU TRACE 00265:003673 bound_ipc_:ipc_real_+03307
1555286571.941250: DBG(324128451) 0: CPU TRACE 003307  aa   000147 6000 04      tze       103,ic              003456
1555286571.941464: DBG(324128451) 0: CPU TRACE 0: 00265:003673 4 000147600004 (TZE 000147,IC) 000147 600(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 980
               ect_header.firstp (ITT_MESSAGE) = msg_ptr -> itt_message.next_itt_msgp;

003310  aa   000020 2360 07   ldq       16,dl  
003311  aa  6 00150 3735 20   epp7      pr6|104,*           msg_ptr
003312  aa  7 00001 7671 00   lprp7     pr7|1               itt_message.next_itt_msgp
003313  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003314  aa  5 00006 6535 06   spri7     pr5|6,ql            ect_header.firstp

1555286571.941493: DBG(324128453) 0: CPU TRACE 00265:003674 bound_ipc_:ipc_real_+03310
1555286571.942672: DBG(324128453) 0: CPU TRACE 003310  aa   000020 2360 07      ldq       16,dl
1555286571.942936: DBG(324128453) 0: CPU TRACE 0: 00265:003674 4 000020236007 (LDQ 000020,DL) 000020 236(0) 0 0 0 07

                                                            STATEMENT 1 ON LINE 981
               if ect_header.lastp (ITT_MESSAGE) = msg_ptr
               then ect_header.lastp (ITT_MESSAGE) = null;

003315  aa  6 00654 7561 00   stq       pr6|428
003316  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003317  aa  5 00010 2371 06   ldaq      pr5|8,ql            ect_header.lastp
003320  aa  6 00150 6771 00   eraq      pr6|104             msg_ptr
003321  aa  0 00460 3771 00   anaq      pr0|304             = 077777000077 777777077077
003322  aa   000004 6010 04   tnz       4,ic                003326
003323  aa   774503 2370 04   ldaq      -1725,ic            000026 = 077777000043 000001000000
003324  aa  6 00654 7271 00   lxl7      pr6|428
003325  aa  5 00010 7571 17   staq      pr5|8,7             ect_header.lastp

1555286571.948987: DBG(324128463) 0: CPU TRACE 00265:003701 bound_ipc_:ipc_real_+03315
1555286571.950158: DBG(324128463) 0: CPU TRACE 003315  aa  6 00654 7561 00      stq       pr6|428
1555286571.950376: DBG(324128463) 0: CPU TRACE 0: 00265:003701 4 600654756100 (STQ PR6|654) 000654 756(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 983
               ect_header.count (ITT_MESSAGE) = ect_header.count (ITT_MESSAGE) - 1;

003326  aa   000001 3360 07   lcq       1,dl
003327  aa   000004 7270 07   lxl7      4,dl
003330  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003331  aa  5 00004 0561 17   asq       pr5|4,7             ect_header.count

1555286571.957543: DBG(324128475) 0: CPU TRACE 00265:003712 bound_ipc_:ipc_real_+03326
1555286571.958712: DBG(324128475) 0: CPU TRACE 003326  aa   000001 3360 07      lcq       1,dl
1555286571.958941: DBG(324128475) 0: CPU TRACE 0: 00265:003712 4 000001336007 (LCQ 000001,DL) 000001 336(0) 0 0 0 07

               call ipc_util_$verify_regular_channel (msg_ptr -> itt_message.channel_id, an_ectep, code);

003332  aa  6 00150 3535 20   epp3      pr6|104,*           msg_ptr
003333  aa  3 00002 3521 00   epp2      pr3|2               itt_message.channel_id
003334  aa  6 00666 2521 00   spri2     pr6|438
003335  aa  6 00232 3521 00   epp2      pr6|154             an_ectep
003336  aa  6 00670 2521 00   spri2     pr6|440
003337  aa  6 00235 3521 00   epp2      pr6|157             code
003340  aa  6 00672 2521 00   spri2     pr6|442
003341  aa  6 00664 6211 00   eax1      pr6|436
003342  aa   014000 4310 07   fld       6144,dl
003343  aa  6 00044 3701 20   epp4      pr6|36,*
003344  la  4 00050 3521 20   epp2      pr4|40,*            ipc_util_$verify_regular_channel
003345  aa  0 00623 7001 00   tsx0      pr0|403             call_ext_out

1555286571.963384: DBG(324128483) 0: CPU TRACE 00265:003716 bound_ipc_:ipc_real_+03332
1555286571.964538: DBG(324128483) 0: CPU TRACE 003332  aa  6 00150 3535 20      epp3      pr6|104,*           msg_ptr
1555286571.964750: DBG(324128483) 0: CPU TRACE 0: 00265:003716 4 600150353520 (EPP3 PR6|150,N*) 000150 353(1) 1 0 1 00

                                                            STATEMENT 1 ON LINE 987
               if code = 0
               then do;

003346  aa  6 00235 2361 00   ldq       pr6|157             code
003347  aa   000070 6010 04   tnz       56,ic               003437

1555286572.137859: DBG(324129248) 0: CPU TRACE 00265:003732 bound_ipc_:ipc_real_+03346
1555286572.139121: DBG(324129248) 0: CPU TRACE 003346  aa  6 00235 2361 00      ldq       pr6|157             code
1555286572.139332: DBG(324129248) 0: CPU TRACE 0: 00265:003732 4 600235236100 (LDQ PR6|235) 000235 236(0) 1 0 0 00
Q=000000000000

1555286572.139359: DBG(324129250) 0: CPU TRACE 00265:003733 bound_ipc_:ipc_real_+03347
1555286572.140545: DBG(324129250) 0: CPU TRACE 003347  aa   000070 6010 04      tnz       56,ic               003437
1555286572.140761: DBG(324129250) 0: CPU TRACE 0: 00265:003733 4 000070601004 (TNZ 000070,IC) 000070 601(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 992
                         msg_ptr -> event_message.chanp = an_ectep;

003350  aa  6 00232 3735 20   epp7      pr6|154,*           an_ectep
003351  aa  6 00150 3715 20   epp5      pr6|104,*           msg_ptr
003352  aa  5 00001 5471 00   sprp7     pr5|1               event_message.chanp

1555286572.140790: DBG(324129252) 0: CPU TRACE 00265:003734 bound_ipc_:ipc_real_+03350
1555286572.142086: DBG(324129252) 0: CPU TRACE 003350  aa  6 00232 3735 20      epp7      pr6|154,*           an_ectep
1555286572.142297: DBG(324129252) 0: CPU TRACE 0: 00265:003734 4 600232373520 (EPP7 PR6|232,N*) 000232 373(1) 1 0 1 00

                                                            STATEMENT 1 ON LINE 994
                         if (p_set_wcp = YES) | (have_multiple_control_points () = YES)
                         then ect_header.wakeup_control_points, a_wait_channel.wakeup_control_points = YES;

003353  aa   003307 3520 04   epp2      1735,ic             006662 = 000002000000
003354  aa   002201 6700 04   tsp4      1153,ic             005555
003355  aa  6 00654 2351 00   lda       pr6|428
003356  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
003357  aa   400000 1150 03   cmpa      131072,du
003360  aa  0 00512 7001 00   tsx0      pr0|330             r_e_as
003361  aa  6 00654 7551 00   sta       pr6|428
003362  aa  6 00226 3735 20   epp7      pr6|150,*
003363  aa  7 00002 2351 20   lda       pr7|2,*             p_set_wcp
003364  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
003365  aa   400000 1150 03   cmpa      131072,du
003366  aa  0 00512 7001 00   tsx0      pr0|330             r_e_as
003367  aa  6 00654 2751 00   ora       pr6|428
003370  aa   000015 6000 04   tze       13,ic               003405
003371  aa   200000 2350 03   lda       65536,du
003372  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003373  aa  6 00654 7551 00   sta       pr6|428
003374  aa  5 00043 6751 00   era       pr5|35              ect_header.wakeup_control_points
003375  aa   200000 3750 03   ana       65536,du
003376  aa  5 00043 6551 00   ersa      pr5|35              ect_header.wakeup_control_points
003377  aa  6 00654 2351 00   lda       pr6|428
003400  aa   000021 7710 00   arl       17
003401  aa  6 00232 3535 20   epp3      pr6|154,*           an_ectep
003402  aa  3 00003 6751 00   era       pr3|3               a_wait_channel.wakeup_control_points
003403  aa   400000 3750 07   ana       131072,dl
003404  aa  3 00003 6551 00   ersa      pr3|3               a_wait_channel.wakeup_control_points

1555286572.145351: DBG(324129258) 0: CPU TRACE 00265:003737 bound_ipc_:ipc_real_+03353
1555286572.146557: DBG(324129258) 0: CPU TRACE 003353  aa   003307 3520 04      epp2      1735,ic             006662 = 000002000000
1555286572.146834: DBG(324129258) 0: CPU TRACE 0: 00265:003737 4 003307352004 (EPP2 003307,IC) 003307 352(0) 0 0 0 04

1555286572.181752: DBG(324129314) 0: CPU TRACE 003370  aa   000015 6000 04      tze       13,ic               003405
1555286572.181991: DBG(324129314) 0: CPU TRACE 0: 00265:003754 4 000015600004 (TZE 000015,IC) 000015 600(0) 0 0 0 04
1555286572.181997: DBG(324129314) 0: CPU TRACE read_tra_op 00265:003771

                                                            STATEMENT 1 ON LINE 998
                         if a_call_channel.type = CALL
                         then do;

003405  aa  6 00232 2351 20   lda       pr6|154,*           a_call_channel.type
003406  aa   000033 7350 00   als       27
003407  aa   000077 7330 00   lrs       63
003410  aa   000002 1160 07   cmpq      2,dl
003411  aa   000011 6010 04   tnz       9,ic                003422

1555286572.182031: DBG(324129316) 0: CPU TRACE 00265:003771 bound_ipc_:ipc_real_+03405
1555286572.183358: DBG(324129316) 0: CPU TRACE 003405  aa  6 00232 2351 20      lda       pr6|154,*           a_call_channel.type
1555286572.183567: DBG(324129316) 0: CPU TRACE 0: 00265:003771 4 600232235120 (LDA PR6|232,N*) 000232 235(0) 1 0 1 00

1555286572.188398: DBG(324129324) 0: CPU TRACE 00265:003775 bound_ipc_:ipc_real_+03411
1555286572.189619: DBG(324129324) 0: CPU TRACE 003411  aa   000011 6010 04      tnz       9,ic                003422
1555286572.189924: DBG(324129324) 0: CPU TRACE 0: 00265:003775 4 000011601004 (TNZ 000011,IC) 000011 601(0) 0 0 0 04
1555286572.189936: DBG(324129324) 0: CPU TRACE read_tra_op 00265:004006

                                                            STATEMENT 1 ON LINE 1004
                         else do;

                                                            STATEMENT 1 ON LINE 1005
                                   call insert_event_wait_message (msg_ptr);

003422  aa   003234 3520 04   epp2      1692,ic             006656 = 000002000000
003423  aa   000637 6700 04   tsp4      415,ic              004262

1555286572.189961: DBG(324129326) 0: CPU TRACE 00265:004006 bound_ipc_:ipc_real_+03422
1555286572.191126: DBG(324129326) 0: CPU TRACE 003422  aa   003234 3520 04      epp2      1692,ic             006656 = 000002000000
1555286572.191337: DBG(324129326) 0: CPU TRACE 0: 00265:004006 4 003234352004 (EPP2 003234,IC) 003234 352(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 1006
                                   ect_header.total_wait_wakeups = ect_header.total_wait_wakeups + 1;

003424  aa  6 00172 3735 20   epp7      pr6|122,*           ect_ptr
003425  aa  7 00037 0541 00   aos       pr7|31              ect_header.total_wait_wakeups

1555286572.370598: DBG(324129564) 0: CPU TRACE 00265:004010 bound_ipc_:ipc_real_+03424
1555286572.371777: DBG(324129564) 0: CPU TRACE 003424  aa  6 00172 3735 20      epp7      pr6|122,*           ect_ptr
1555286572.372070: DBG(324129564) 0: CPU TRACE 0: 00265:004010 4 600172373520 (EPP7 PR6|172,N*) 000172 373(1) 1 0 1 00

                                                            STATEMENT 1 ON LINE 1007
                              end;

                                                            STATEMENT 1 ON LINE 1009
                         ect_header.total_wakeups = ect_header.total_wakeups + 1;

003426  aa  7 00036 0541 00   aos       pr7|30              ect_header.total_wakeups

1555286572.372099: DBG(324129566) 0: CPU TRACE 00265:004011 bound_ipc_:ipc_real_+03425
1555286572.373319: DBG(324129566) 0: CPU TRACE 003425  aa  7 00037 0541 00      aos       pr7|31              ect_header.total_wait_wakeups
1555286572.373559: DBG(324129566) 0: CPU TRACE 0: 00265:004011 4 700037054100 (AOS PR7|37) 000037 054(0) 1 0 0 00
                                                            STATEMENT 1 ON LINE 1010
                         a_wait_channel.wakeup_count = a_wait_channel.wakeup_count + 1;

003427  aa  6 00232 3715 20   epp5      pr6|154,*           an_ectep
003430  aa  5 00003 2361 00   ldq       pr5|3               a_wait_channel.wakeup_count
003431  aa  0 00376 3771 00   anaq      pr0|254             = 000000000000 000000377777
003432  aa   000001 0760 07   adq       1,dl
003433  aa  5 00003 6761 00   erq       pr5|3               a_wait_channel.wakeup_count
003434  aa   377777 3760 07   anq       131071,dl
003435  aa  5 00003 6561 00   ersq      pr5|3               a_wait_channel.wakeup_count

1555286572.375069: DBG(324129570) 0: CPU TRACE 00265:004013 bound_ipc_:ipc_real_+03427
1555286572.376249: DBG(324129570) 0: CPU TRACE 003427  aa  6 00232 3715 20      epp5      pr6|154,*           an_ectep
1555286572.376457: DBG(324129570) 0: CPU TRACE 0: 00265:004013 4 600232371520 (EPP5 PR6|232,N*) 000232 371(1) 1 0 1 00

                                                            STATEMENT 1 ON LINE 1011
                    end;

003436  aa   000014 7100 04   tra       12,ic               003452

1555286572.385654: DBG(324129584) 0: CPU TRACE 00265:004022 bound_ipc_:ipc_real_+03436
1555286572.386913: DBG(324129584) 0: CPU TRACE 003436  aa   000014 7100 04      tra       12,ic               003452
1555286572.387132: DBG(324129584) 0: CPU TRACE 0: 00265:004022 4 000014710004 (TRA 000014,IC) 000014 710(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 1022
          end;

003452  aa   000020 2360 07   ldq       16,dl
003453  aa  7 00006 3715 26   epp5      pr7|6,ql*           ect_header.firstp
003454  aa  6 00150 6515 00   spri5     pr6|104             msg_ptr
003455  aa   777627 7100 04   tra       -105,ic             003304

1555286572.387174: DBG(324129586) 0: CPU TRACE 00265:004036 bound_ipc_:ipc_real_+03452
1555286572.388349: DBG(324129586) 0: CPU TRACE 003452  aa   000020 2360 07      ldq       16,dl
1555286572.388552: DBG(324129586) 0: CPU TRACE 0: 00265:004036 4 000020236007 (LDQ 000020,DL) 000020 236(0) 0 0 0 07

                                                            STATEMENT 1 ON LINE 978
          do msg_ptr = ect_header.firstp (ITT_MESSAGE) repeat (ect_header.firstp (ITT_MESSAGE)) while (msg_ptr ^= null);

003277  aa   000020 2360 07   ldq       16,dl
003300  aa  6 00172 3735 20   epp7      pr6|122,*           ect_ptr
003301  aa  7 00006 3735 26   epp7      pr7|6,ql*           ect_header.firstp
003302  aa  6 00150 6535 00   spri7     pr6|104             msg_ptr
003303  aa   000000 0110 03   nop       0,du
003304  aa  6 00150 2371 00   ldaq      pr6|104             msg_ptr
003305  aa   774521 6770 04   eraq      -1711,ic            000026 = 077777000043 000001000000
003306  aa  0 00460 3771 00   anaq      pr0|304             = 077777000077 777777077077
003307  aa   000147 6000 04   tze       103,ic              003456

1555286572.392969: DBG(324129594) 0: CPU TRACE 00265:003670 bound_ipc_:ipc_real_+03304
1555286572.394184: DBG(324129594) 0: CPU TRACE 003304  aa  6 00150 2371 00      ldaq      pr6|104             msg_ptr
1555286572.394440: DBG(324129594) 0: CPU TRACE 0: 00265:003670 4 600150237100 (LDAQ PR6|150) 000150 237(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 980
               ect_header.firstp (ITT_MESSAGE) = msg_ptr -> itt_message.next_itt_msgp;

003310  aa   000020 2360 07   ldq       16,dl
003311  aa  6 00150 3735 20   epp7      pr6|104,*           msg_ptr
003312  aa  7 00001 7671 00   lprp7     pr7|1               itt_message.next_itt_msgp
003313  aa  6 00172 3715 20   epp5      pr6|122,*           ect_ptr
003314  aa  5 00006 6535 06   spri7     pr5|6,ql            ect_header.firstp

1555286572.399009: DBG(324129602) 0: CPU TRACE 00265:003674 bound_ipc_:ipc_real_+03310
1555286572.400191: DBG(324129602) 0: CPU TRACE 003310  aa   000020 2360 07      ldq       16,dl
1555286572.400405: DBG(324129602) 0: CPU TRACE 0: 00265:003674 4 000020236007 (LDQ 000020,DL) 000020 236(0) 0 0 0 07

third time through the loop

1555286572.864497: DBG(324130743) 0: CPU TRACE 00265:003670 bound_ipc_:ipc_real_+03304
1555286572.865785: DBG(324130743) 0: CPU TRACE 003304  aa  6 00150 2371 00      ldaq      pr6|104             msg_ptr
1555286572.866096: DBG(324130743) 0: CPU TRACE 0: 00265:003670 4 600150237100 (LDAQ PR6|150) 000150 237(0) 1 0 0 00

1555286572.871059: DBG(324130751) 0: CPU TRACE 00265:003674 bound_ipc_:ipc_real_+03310
1555286572.872356: DBG(324130751) 0: CPU TRACE 003310  aa   000020 2360 07      ldq       16,dl
1555286572.872713: DBG(324130751) 0: CPU TRACE 0: 00265:003674 4 000020236007 (LDQ 000020,DL) 000020 236(0) 0 0 0 07

4th time

1555286573.325118: DBG(324131898) 0: CPU TRACE 00265:003670 bound_ipc_:ipc_real_+03304
1555286573.326570: DBG(324131898) 0: CPU TRACE 003304  aa  6 00150 2371 00      ldaq      pr6|104             msg_ptr
1555286573.326815: DBG(324131898) 0: CPU TRACE 0: 00265:003670 4 600150237100 (LDAQ PR6|150) 000150 237(0) 1 0 0 00

1555286573.325118: DBG(324131898) 0: CPU TRACE 00265:003670 bound_ipc_:ipc_real_+03304
1555286573.326570: DBG(324131898) 0: CPU TRACE 003304  aa  6 00150 2371 00      ldaq      pr6|104             msg_ptr
1555286573.326815: DBG(324131898) 0: CPU TRACE 0: 00265:003670 4 600150237100 (LDAQ PR6|150) 000150 237(0) 1 0 0 00

1555286573.329873: DBG(324131904) 0: CPU TRACE 00265:003673 bound_ipc_:ipc_real_+03307
1555286573.331054: DBG(324131904) 0: CPU TRACE 003307  aa   000147 6000 04      tze       103,ic              003456
1555286573.331269: DBG(324131904) 0: CPU TRACE 0: 00265:003673 4 000147600004 (TZE 000147,IC) 000147 600(0) 0 0 0 04
1555286573.331277: DBG(324131904) 0: CPU TRACE read_tra_op 00265:004042

Copied four messages.

                                                            STATEMENT 1 ON LINE 1024
          call unmask_ips_interrupts (mask);

003456  aa   003266 3520 04   epp2      1718,ic             006744 = 000002000000 
003457  aa   001753 6700 04   tsp4      1003,ic             005432

1555286573.331312: DBG(324131906) 0: CPU TRACE 00265:004042 bound_ipc_:ipc_real_+03456
1555286573.332509: DBG(324131906) 0: CPU TRACE 003456  aa   003266 3520 04      epp2      1718,ic             006744 = 000002000000
1555286573.332712: DBG(324131906) 0: CPU TRACE 0: 00265:004042 4 003266352004 (EPP2 003266,IC) 003266 352(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 1026
          return;

003460  aa  6 00224 6101 00   rtcd      pr6|148

1555286573.383933: DBG(324132028) 0: CPU TRACE 00265:004044 bound_ipc_:ipc_real_+03460
1555286573.385188: DBG(324132028) 0: CPU TRACE 003460  aa  6 00224 6101 00      rtcd      pr6|148
1555286573.385391: DBG(324132028) 0: CPU TRACE 0: 00265:004044 4 600224610100 (RTCD PR6|224) 000224 610(0) 1 0 0 00

leaving copy_itt_messages

back to full block

                                                            STATEMENT 1 ON LINE 754
               check_channels =                             /* we can only check for events if ... */
                    (have_multiple_control_points () = NO) |/* ... there is only one control point or ... */
                    (ect_header.wakeup_control_points = NO);

002370  aa  6 00172 3735 20   epp7      pr6|122,*           ect_ptr
002371  aa  7 00043 2351 00   lda       pr7|35              ect_header.wakeup_control_points
002372  aa   200000 3150 03   cana      65536,du
002373  aa  0 00512 7001 00   tsx0      pr0|330             r_e_as
002374  aa  6 00614 7551 00   sta       pr6|396
002375  aa   004303 3520 04   epp2      2243,ic             006700 = 000002000000
002376  aa   003157 6700 04   tsp4      1647,ic             005555
002377  aa  6 00615 2351 00   lda       pr6|397
002400  aa   400000 3150 03   cana      131072,du
002401  aa  0 00512 7001 00   tsx0      pr0|330             r_e_as
002402  aa  6 00614 2751 00   ora       pr6|396
002403  aa  6 00116 7551 00   sta       pr6|78              check_channels

1555286573.385436: DBG(324132030) 0: CPU TRACE 00265:002754 bound_ipc_:ipc_real_+02370
1555286573.386538: DBG(324132030) 0: CPU TRACE 002370  aa  6 00172 3735 20      epp7      pr6|122,*           ect_ptr
1555286573.386806: DBG(324132030) 0: CPU TRACE 0: 00265:002754 4 600172373520 (EPP7 PR6|172,N*) 000172 373(1) 1 0 1 00

1555286573.416240: DBG(324132080) 0: CPU TRACE 002402  aa  6 00614 2751 00      ora       pr6|396
1555286573.416591: DBG(324132080) 0: CPU TRACE 0: 00265:002766 4 600614275100 (ORA PR6|614) 000614 275(0) 1 0 0 00
1555286573.416595: DBG(324132080) 0: CPU FINAL Read (Actual) Read:  iefpFinalAddress=61072414  readData=400000000000

A=400000000000

                                                            STATEMENT 1 ON LINE 761
               do while (check_channels = YES);

002404  aa  6 00116 2351 00   lda       pr6|78              check_channels
002405  aa   400000 1150 03   cmpa      131072,du
002406  aa   000061 6010 04   tnz       49,ic               002467

1555286573.418104: DBG(324132084) 0: CPU TRACE 00265:002770 bound_ipc_:ipc_real_+02404
1555286573.419407: DBG(324132084) 0: CPU TRACE 002404  aa  6 00116 2351 00      lda       pr6|78              check_channels
1555286573.419663: DBG(324132084) 0: CPU TRACE 0: 00265:002770 4 600116235100 (LDA PR6|116) 000116 235(0) 1 0 0 00

1555286573.421273: DBG(324132088) 0: CPU TRACE 00265:002772 bound_ipc_:ipc_real_+02406
1555286573.422497: DBG(324132088) 0: CPU TRACE 002406  aa   000061 6010 04      tnz       49,ic               002467
1555286573.422917: DBG(324132088) 0: CPU TRACE 0: 00265:002772 4 000061601004 (TNZ 000061,IC) 000061 601(0) 0 0 0 04

                                                            STATEMENT 1 ON LINE 763
                    if ect_header.call_priority = YES
                    then do;

002407  aa  6 00172 3735 20   epp7      pr6|122,*           ect_ptr
002410  aa  7 00043 2351 00   lda       pr7|35              ect_header.call_priority
002411  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
002412  aa   400000 1150 03   cmpa      131072,du
002413  aa   000017 6010 04   tnz       15,ic               002432

1555286573.422970: DBG(324132090) 0: CPU TRACE 00265:002773 bound_ipc_:ipc_real_+02407
1555286573.424134: DBG(324132090) 0: CPU TRACE 002407  aa  6 00172 3735 20      epp7      pr6|122,*           ect_ptr
1555286573.424390: DBG(324132090) 0: CPU TRACE 0: 00265:002773 4 600172373520 (EPP7 PR6|172,N*) 000172 373(1) 1 0 1 00

1555286573.429204: DBG(324132098) 0: CPU TRACE 00265:002777 bound_ipc_:ipc_real_+02413
1555286573.430408: DBG(324132098) 0: CPU TRACE 002413  aa   000017 6010 04      tnz       15,ic               002432
1555286573.430667: DBG(324132098) 0: CPU TRACE 0: 00265:002777 4 000017601004 (TNZ 000017,IC) 000017 601(0) 0 0 0 04
1555286573.430675: DBG(324132098) 0: CPU TRACE read_tra_op 00265:003016

                                                            STATEMENT 1 ON LINE 775
                              call check_wait_channels (found_wait_event);

002432  aa   004234 3520 04   epp2      2204,ic             006666 = 000002000000
002433  aa   001242 6700 04   tsp4      674,ic              003675

1555286573.430708: DBG(324132100) 0: CPU TRACE 00265:003016 bound_ipc_:ipc_real_+02432
1555286573.431998: DBG(324132100) 0: CPU TRACE 002432  aa   004234 3520 04      epp2      2204,ic             006666 = 000002000000
1555286573.432393: DBG(324132100) 0: CPU TRACE 0: 00265:003016 4 004234352004 (EPP2 004234,IC) 004234 352(0) 0 0 0 04

1555286573.432506: DBG(324132102) 0: CPU TRACE 00265:003017 bound_ipc_:ipc_real_+02433
1555286573.434422: DBG(324132102) 0: CPU TRACE 002433  aa   001242 6700 04      tsp4      674,ic              003675
1555286573.434913: DBG(324132102) 0: CPU TRACE 0: 00265:003017 4 001242670004 (TSP4 001242,IC) 001242 670(0) 0 0 0 04
1555286573.434921: DBG(324132102) 0: CPU TRACE read_tra_op 00265:004261

ENTRY TO check_wait_channels                                STATEMENT 1 ON LINE 1119
check_wait_channels:
     procedure (P_found_event_wait);

003675  aa  6 00252 6501 00   spri4     pr6|170
003676  aa  6 00254 2521 00   spri2     pr6|172

1555286573.434967: DBG(324132104) 0: CPU TRACE 00265:004261 bound_ipc_:ipc_real_+03675
1555286573.436928: DBG(324132104) 0: CPU TRACE 003675  aa  6 00252 6501 00      spri4     pr6|170
1555286573.437216: DBG(324132104) 0: CPU TRACE 0: 00265:004261 4 600252650100 (SPRI4 PR6|252) 000252 650(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 1128
          P_found_event_wait = NO;

003677  aa  2 00002 4501 20   stz       pr2|2,*             P_found_event_wait

                                                            STATEMENT 1 ON LINE 1129 
          inhibit_count = 0;

003700  aa  6 00141 4501 00   stz       pr6|97              inhibit_count

          do loop = 1 to event_wait_list_n_channels;

003701  aa  6 00202 2361 00   ldq       pr6|130             event_wait_list_n_channels
003702  aa  6 00272 7561 00   stq       pr6|186
003703  aa   000001 2360 07   ldq       1,dl
003704  aa  6 00271 7561 00   stq       pr6|185             loop
003705  aa   000000 0110 03   nop       0,du
003706  aa  6 00271 2361 00   ldq       pr6|185             loop
003707  aa  6 00272 1161 00   cmpq      pr6|186
003710  aa   000077 6054 04   tpnz      63,ic               004007

1555286573.444654: DBG(324132112) 0: CPU TRACE 00265:004265 bound_ipc_:ipc_real_+03701
1555286573.446662: DBG(324132112) 0: CPU TRACE 003701  aa  6 00202 2361 00      ldq       pr6|130             event_wait_list_n_channels
1555286573.447113: DBG(324132112) 0: CPU TRACE 0: 00265:004265 4 600202236100 (LDQ PR6|202) 000202 236(0) 1 0 0 00

1555286573.458903: DBG(324132126) 0: CPU TRACE 00265:004274 bound_ipc_:ipc_real_+03710
1555286573.460133: DBG(324132126) 0: CPU TRACE 003710  aa   000077 6054 04      tpnz      63,ic               004007
1555286573.460356: DBG(324132126) 0: CPU TRACE 0: 00265:004274 4 000077605404 (TPNZ 000077,IC) 000077 605(1) 0 0 0 04

                                                            STATEMENT 1 ON LINE 1133
               temp_channel_name = event_wait_list.channel_id (loop);

003711  aa   000001 7360 00   qls       1
003712  aa  6 00204 2371 66   ldaq      pr6|132,*ql         event_wait_list.channel_id
003713  aa  6 00260 7571 00   staq      pr6|176             temp_channel_name

1555286573.460394: DBG(324132128) 0: CPU TRACE 00265:004275 bound_ipc_:ipc_real_+03711
1555286573.461576: DBG(324132128) 0: CPU TRACE 003711  aa   000001 7360 00      qls       1
1555286573.461761: DBG(324132128) 0: CPU TRACE 0: 00265:004275 4 000001736000 (QLS 000001) 000001 736(0) 0 0 0 00

                                                            STATEMENT 1 ON LINE 1135
               call ipc_util_$verify_channel (temp_channel_name, ectep, is_fast, P_code);

003714  aa  6 00260 3521 00   epp2      pr6|176             temp_channel_name
003715  aa  6 00714 2521 00   spri2     pr6|460
003716  aa  6 00174 3521 00   epp2      pr6|124             ectep
003717  aa  6 00716 2521 00   spri2     pr6|462
003720  aa  6 00142 3521 00   epp2      pr6|98              is_fast
003721  aa  6 00720 2521 00   spri2     pr6|464
003722  aa  6 00212 3521 20   epp2      pr6|138,*           P_code
003723  aa  6 00722 2521 00   spri2     pr6|466
003724  aa  6 00712 6211 00   eax1      pr6|458
003725  aa   020000 4310 07   fld       8192,dl
003726  aa  6 00044 3701 20   epp4      pr6|36,*
003727  la  4 00046 3521 20   epp2      pr4|38,*            ipc_util_$verify_channel
003730  aa  0 00623 7001 00   tsx0      pr0|403             call_ext_out

1555286573.464810: DBG(324132134) 0: CPU TRACE 00265:004300 bound_ipc_:ipc_real_+03714
1555286573.466127: DBG(324132134) 0: CPU TRACE 003714  aa  6 00260 3521 00      epp2      pr6|176             temp_channel_name
1555286573.466311: DBG(324132134) 0: CPU TRACE 0: 00265:004300 4 600260352100 (EPP2 PR6|260) 000260 352(0) 1 0 0 00

1555286573.482892: DBG(324132158) 0: CPU TRACE 00265:004314 bound_ipc_:ipc_real_+03730
1555286573.484108: DBG(324132158) 0: CPU TRACE 003730  aa  0 00623 7001 00      tsx0      pr0|403             call_ext_out
1555286573.484285: DBG(324132158) 0: CPU TRACE 0: 00265:004314 4 000623700100 (TSX0 PR0|623) 000623 700(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 1136
               if P_code ^= 0
               then return;

003731  aa  6 00212 2361 20   ldq       pr6|138,*           P_code
003732  aa   000002 6000 04   tze       2,ic                003734
003733  aa  6 00252 6101 00   rtcd      pr6|170

1555286573.645105: DBG(324132913) 0: CPU TRACE 00265:004315 bound_ipc_:ipc_real_+03731
1555286573.646385: DBG(324132913) 0: CPU TRACE 003731  aa  6 00212 2361 20      ldq       pr6|138,*           P_code
1555286573.646589: DBG(324132913) 0: CPU TRACE 0: 00265:004315 4 600212236120 (LDQ PR6|212,N*) 000212 236(0) 1 0 1 00

1555286573.646632: DBG(324132915) 0: CPU TRACE 00265:004316 bound_ipc_:ipc_real_+03732
1555286573.647893: DBG(324132915) 0: CPU TRACE 003732  aa   000002 6000 04      tze       2,ic                003734
1555286573.648077: DBG(324132915) 0: CPU TRACE 0: 00265:004316 4 000002600004 (TZE 000002,IC) 000002 600(0) 0 0 0 04
1555286573.648084: DBG(324132915) 0: CPU TRACE read_tra_op 00265:004320

                                                            STATEMENT 1 ON LINE 1139
               if is_fast = YES
               then call read_fast_channel (temp_channel_name, temp_found_event, addr (message_info));

003734  aa  6 00142 2351 00   lda       pr6|98              is_fast
003735  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
003736  aa   400000 1150 03   cmpa      131072,du
003737  aa   000006 6010 04   tnz       6,ic                003745
003740  aa  6 00262 3735 00   epp7      pr6|178             message_info
003741  aa  6 00724 6535 00   spri7     pr6|468
003742  aa   002670 3520 04   epp2      1464,ic             006632 = 000006000000
003743  aa   000156 6700 04   tsp4      110,ic              004121
003744  aa   000016 7100 04   tra       14,ic               003762

1555286573.648120: DBG(324132917) 0: CPU TRACE 00265:004320 bound_ipc_:ipc_real_+03734
1555286573.649338: DBG(324132917) 0: CPU TRACE 003734  aa  6 00142 2351 00      lda       pr6|98              is_fast
1555286573.649522: DBG(324132917) 0: CPU TRACE 0: 00265:004320 4 600142235100 (LDA PR6|142) 000142 235(0) 1 0 0 00

1555286573.652408: DBG(324132923) 0: CPU TRACE 00265:004323 bound_ipc_:ipc_real_+03737
1555286573.653628: DBG(324132923) 0: CPU TRACE 003737  aa   000006 6010 04      tnz       6,ic                003745
1555286573.653811: DBG(324132923) 0: CPU TRACE 0: 00265:004323 4 000006601004 (TNZ 000006,IC) 000006 601(0) 0 0 0 04
1555286573.653817: DBG(324132923) 0: CPU TRACE read_tra_op 00265:004331

                         if wait_channel.type ^= WAIT
                         then do;

003745  aa  6 00174 2351 20   lda       pr6|124,*           wait_channel.type
003746  aa   000033 7350 00   als       27
003747  aa   000077 7330 00   lrs       63
003750  aa   000001 1160 07   cmpq      1,dl
003751  aa   000005 6000 04   tze       5,ic                003756

1555286573.653888: DBG(324132925) 0: CPU TRACE 00265:004331 bound_ipc_:ipc_real_+03745
1555286573.655097: DBG(324132925) 0: CPU TRACE 003745  aa  6 00174 2351 20      lda       pr6|124,*           wait_channel.type
1555286573.655315: DBG(324132925) 0: CPU TRACE 0: 00265:004331 4 600174235120 (LDA PR6|174,N*) 000174 235(0) 1 0 1 00

1555286573.659727: DBG(324132933) 0: CPU TRACE 00265:004335 bound_ipc_:ipc_real_+03751
1555286573.661036: DBG(324132933) 0: CPU TRACE 003751  aa   000005 6000 04      tze       5,ic                003756
1555286573.661219: DBG(324132933) 0: CPU TRACE 0: 00265:004335 4 000005600004 (TZE 000005,IC) 000005 600(0) 0 0 0 04
1555286573.661226: DBG(324132933) 0: CPU TRACE read_tra_op 00265:004342

                                                            STATEMENT 1 ON LINE 1147
                         call read_channel (inhibit_count, temp_found_event, addr (message_info));

003756  aa  6 00262 3735 00   epp7      pr6|178             message_info
003757  aa  6 00724 6535 00   spri7     pr6|468
003760  aa   002642 3520 04   epp2      1442,ic             006622 = 000006000000
003761  aa   000036 6700 04   tsp4      30,ic               004017

1555286573.661249: DBG(324132935) 0: CPU TRACE 00265:004342 bound_ipc_:ipc_real_+03756
1555286573.662470: DBG(324132935) 0: CPU TRACE 003756  aa  6 00262 3735 00      epp7      pr6|178             message_info
1555286573.662652: DBG(324132935) 0: CPU TRACE 0: 00265:004342 4 600262373500 (EPP7 PR6|262) 000262 373(1) 1 0 0 00

                                                            STATEMENT 1 ON LINE 1149
               if temp_found_event ^= 0
               then do;

003762  aa  6 00154 2361 00   ldq       pr6|108             temp_found_event
003763  aa   000022 6000 04   tze       18,ic               004005

1555286574.087554: DBG(324133889) 0: CPU TRACE 00265:004346 bound_ipc_:ipc_real_+03762
1555286574.088997: DBG(324133889) 0: CPU TRACE 003762  aa  6 00154 2361 00      ldq       pr6|108             temp_found_event
1555286574.089272: DBG(324133889) 0: CPU TRACE 0: 00265:004346 4 600154236100 (LDQ PR6|154) 000154 236(0) 1 0 0 00

1555286574.089297: DBG(324133889) 0: CPU REGDUMPDSBR ADDR:16627154 BND:00177 U:0 STACK:0023
1555286574.089300: DBG(324133891) 0: CPU TRACE 00265:004347 bound_ipc_:ipc_real_+03763
1555286574.090712: DBG(324133891) 0: CPU TRACE 003763  aa   000022 6000 04      tze       18,ic               004005

                                                            STATEMENT 1 ON LINE 1151
                         event_wait_info.channel_id = message_info.channel_id;

003764  aa  6 00262 2371 00   ldaq      pr6|178             message_info.channel_id
003765  aa  6 00200 7571 20   staq      pr6|128,*           event_wait_info.channel_id

1555286574.091052: DBG(324133893) 0: CPU TRACE 00265:004350 bound_ipc_:ipc_real_+03764
1555286574.092293: DBG(324133893) 0: CPU TRACE 003764  aa  6 00262 2371 00      ldaq      pr6|178             message_info.channel_id
1555286574.092563: DBG(324133893) 0: CPU TRACE 0: 00265:004350 4 600262237100 (LDAQ PR6|262) 000262 237(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 1152
                         event_wait_info.message = message_info.message;

003766  aa  6 00264 2371 00   ldaq      pr6|180             message_info.message
003767  aa  6 00200 3735 20   epp7      pr6|128,*           event_wait_info_ptr
003770  aa  7 00002 7571 00   staq      pr7|2               event_wait_info.message

1555286574.094314: DBG(324133897) 0: CPU TRACE 00265:004352 bound_ipc_:ipc_real_+03766
1555286574.095704: DBG(324133897) 0: CPU TRACE 003766  aa  6 00264 2371 00      ldaq      pr6|180             message_info.message
1555286574.095999: DBG(324133897) 0: CPU TRACE 0: 00265:004352 4 600264237100 (LDAQ PR6|264) 000264 237(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 1153
                         event_wait_info.sender = message_info.sender;

003771  aa  6 00266 2351 00   lda       pr6|182             message_info.sender
003772  aa  7 00004 7551 00   sta       pr7|4               event_wait_info.sender

1555286574.099385: DBG(324133903) 0: CPU TRACE 00265:004355 bound_ipc_:ipc_real_+03771
1555286574.100743: DBG(324133903) 0: CPU TRACE 003771  aa  6 00266 2351 00      lda       pr6|182             message_info.sender
1555286574.100982: DBG(324133903) 0: CPU TRACE 0: 00265:004355 4 600266235100 (LDA PR6|266) 000266 235(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 1154
                         event_wait_info.dev_signal = message_info.dev_signal;

003773  aa  6 00267 2351 00   lda       pr6|183             message_info.dev_signal
003774  aa  7 00005 5511 60   stba      pr7|5,60            event_wait_info.dev_signal

1555286574.102500: DBG(324133907) 0: CPU TRACE 00265:004357 bound_ipc_:ipc_real_+03773
1555286574.103963: DBG(324133907) 0: CPU TRACE 003773  aa  6 00267 2351 00      lda       pr6|183             message_info.dev_signal
1555286574.104230: DBG(324133907) 0: CPU TRACE 0: 00265:004357 4 600267235100 (LDA PR6|267) 000267 235(0) 1 0 0 00

                                                            STATEMENT 1 ON LINE 1155
                         event_wait_info.ring = message_info.ring;

003775  aa  6 00267 2351 00   lda       pr6|183             message_info.ring
003776  aa  7 00005 5511 14   stba      pr7|5,14            event_wait_info.ring
                                                            STATEMENT 1 ON LINE 1156
                         event_wait_info.channel_index = loop;

003777  aa  6 00271 2361 00   ldq       pr6|185             loop
004000  aa  7 00006 7561 00   stq       pr7|6               event_wait_info.channel_index

                                                            STATEMENT 1 ON LINE 1157
                         P_found_event_wait = YES;

004001  aa   400000 2350 03   lda       131072,du
004002  aa  6 00254 3715 20   epp5      pr6|172,*
004003  aa  5 00002 7551 20   sta       pr5|2,*             P_found_event_wait
                                                            STATEMENT 1 ON LINE 1158
                         return;

004004  aa  6 00252 6101 00   rtcd      pr6|170

1555286574.117105: DBG(324133925) 0: CPU TRACE 00265:004370 bound_ipc_:ipc_real_+04004
1555286574.118314: DBG(324133925) 0: CPU TRACE 004004  aa  6 00252 6101 00      rtcd      pr6|170
1555286574.118494: DBG(324133925) 0: CPU TRACE 0: 00265:004370 4 600252610100 (RTCD PR6|252) 000252 610(0) 1 0 0 00

return from check_wait_channels

                                                            STATEMENT 1 ON LINE 776
                              if (found_wait_event = YES) | (P_code ^= 0)
                              then go to RETURN_FROM_FULL_BLOCK;

002434  aa  6 00140 2351 00   lda       pr6|96              found_wait_event
002435  aa  0 00002 3771 00   anaq      pr0|2               = 400000000000 000000000000
002436  aa   400000 1150 03   cmpa      131072,du
002437  aa   000065 6000 04   tze       53,ic               002524
002440  aa  6 00212 2361 20   ldq       pr6|138,*           P_code
002441  aa   000063 6010 04   tnz       51,ic               002524

1555286574.118526: DBG(324133927) 0: CPU TRACE 00265:003020 bound_ipc_:ipc_real_+02434
1555286574.119689: DBG(324133927) 0: CPU TRACE 002434  aa  6 00140 2351 00      lda       pr6|96              found_wait_event
1555286574.120010: DBG(324133927) 0: CPU TRACE 0: 00265:003020 4 600140235100 (LDA PR6|140) 000140 235(0) 1 0 0 00

1555286574.123001: DBG(324133933) 0: CPU TRACE 00265:003023 bound_ipc_:ipc_real_+02437
1555286574.124157: DBG(324133933) 0: CPU TRACE 002437  aa   000065 6000 04      tze       53,ic               002524
1555286574.124420: DBG(324133933) 0: CPU TRACE 0: 00265:003023 4 000065600004 (TZE 000065,IC) 000065 600(0) 0 0 0 04
1555286574.124428: DBG(324133933) 0: CPU TRACE read_tra_op 00265:003110

RETURN_FROM_FULL_BLOCK:
          if added_to_waiting_lists = YES
          then call delete_from_waiting_lists ();

002524  aa  6 00100 2351 00   lda       pr6|64              added_to_waiting_lists
002525  aa   400000 1150 03   cmpa      131072,du
002526  aa   000002 6010 04   tnz       2,ic                002530
002527  aa   003424 6700 04   tsp4      1812,ic             006153

1555286574.124450: DBG(324133935) 0: CPU TRACE 00265:003110 bound_ipc_:ipc_real_+02524
1555286574.125654: DBG(324133935) 0: CPU TRACE 002524  aa  6 00100 2351 00      lda       pr6|64              added_to_waiting_lists
1555286574.126039: DBG(324133935) 0: CPU TRACE 0: 00265:003110 4 600100235100 (LDA PR6|100) 000100 235(0) 1 0 0 00
A=000000000000

1555286574.126080: DBG(324133937) 0: CPU TRACE 00265:003111 bound_ipc_:ipc_real_+02525
1555286574.127279: DBG(324133937) 0: CPU TRACE 002525  aa   400000 1150 03      cmpa      131072,du
1555286574.127526: DBG(324133937) 0: CPU TRACE 0: 00265:003111 4 400000115003 (CMPA 400000,DU) 400000 115(0) 0 0 0 03

1555286574.127553: DBG(324133939) 0: CPU TRACE 00265:003112 bound_ipc_:ipc_real_+02526
1555286574.128716: DBG(324133939) 0: CPU TRACE 002526  aa   000002 6010 04      tnz       2,ic                002530
1555286574.129050: DBG(324133939) 0: CPU TRACE 0: 00265:003112 4 000002601004 (TNZ 000002,IC) 000002 601(0) 0 0 0 0
1555286574.129070: DBG(324133939) 0: CPU TRACE read_tra_op 00265:003114

                                                            STATEMENT 1 ON LINE 818
          return;

002530  aa  0 00631 7101 00   tra       pr0|409             return_mac
                                                            STATEMENT 1 ON LINE 431
          allocate itt_message in (ect_area) set (msg_ptr);

1555286570.340452: DBG(324122151) 0: CPU TRACE 00147:001643 bound_tty_active:hc_ipc+01441
1555286570.340884: DBG(324122151) 0: CPU TRACE 001441  aa  0 01402 7001 00      tsx0      pr0|770             op_alloc_
1555286570.340906: DBG(324122151) 0: CPU TRACE 0: 00147:001643 0 001402700100 (TSX0 PR0|1402) 001402 700(0) 1 0 0 00

in dispatch_message.

called at

                                                            STATEMENT 1 ON LINE 293
               call dispatch_message (itte_ptr, target_ring);

001027  aa   000601 3520 04   epp2      385,ic              001630 = 000004000000
001030  aa   000331 6700 04   tsp4      217,ic              001361

in hc_ipc.c$full_block

called at line 246 of fast_hc_ipc

    000153  aa  6 00000 2541 00    246            call      hc_ipc$full_block(argl)

in fast_hc_icp$check_full_block

called at list 89 in fast_hc_ipc.list

    000023  0a   000146 7050 00     89            tsx5      check_full_block    dredge out the old cruft

in fast_hc_ipc$fast_block_return

transferred to at

1555286570.186504: DBG(324121791) 0: CPU TRACE 00044:000075 bound_tc_priv:pxss+075
1555286570.186634: DBG(324121791) 0: CPU TRACE     000075  aa  2 00000 7101 00    298     tra       bp|0
1555286570.187110: DBG(324121791) 0: CPU TRACE 0: 00044:000075 0 200000710100 (TRA PR2|0) 000000 710(0) 1 0 0 00

in pxss$return_event_messages

transferred to from 

1555286570.158548: DBG(324121702) 0: CPU TRACE 00044:000106 bound_tc_priv:pxss+0106
1555286570.158681: DBG(324121702) 0: CPU TRACE     000106  0a   000044 7100 00    329     tra       return_event_messages
1555286570.159149: DBG(324121702) 0: CPU TRACE 0: 00044:000106 0 000044710000 (TRA 000044) 000044 710(0) 0 0 0 00

in pxss$fst_ipc_get_event

transferred to from

1555286570.107992: DBG(324121588) 0: CPU TRACE 00147:000055 bound_tty_active:fast_hc_ipc+055
1555286570.108023: DBG(324121588) 0: CPU TRACE     000055  4a  4 00030 6011 20    147     tnz       pxss$fast_ipc_get_event
1555286570.108072: DBG(324121588) 0: CPU TRACE 0: 00147:000055 0 400034601120 (TNZ PR4|34,N*) 000034 601(0) 1 0 1 00

in 

fast_hc_ipc$sfb_readevents_merge

transfers to from

1555286570.106632: DBG(324121568) 0: CPU TRACE 00147:000046 bound_tty_active:fast_hc_ipc+046
1555286570.106661: DBG(324121568) 0: CPU TRACE     000046  0a   000012 7100 00    138     tra       sfb_readevents_merge join common code
1555286570.106711: DBG(324121568) 0: CPU TRACE 0: 00147:000046 0 000012710000 (TRA 000012) 000012 710(0) 0 0 0 00

in

fast_hc_ipc$read_events

called from

1555286570.089553: DBG(324121534) 0: CPU TRACE 0: 00262:002415 0 700036670120 (TSP4 PR7|36,N*) 000036 670(0) 1 0 1 00

called from

1555286570.049178: DBG(324121476) 0: CPU TRACE 0: 00262:000362 0 700040272120 (TSP2 PR7|40,N*) 000040 272(0) 1 0 1 00

called from

1555286570.043539: DBG(324121468) 0: CPU TRACE 0: 00257:026143 4 200000713100 (CALL6 PR2|0) 000000 713(0) 1 0 0 00

called from

1555286570.040336: DBG(324121450) 0: CPU TRACE 00265:003555 bound_ipc_:ipc_real_+03171
1555286570.041736: DBG(324121450) 0: CPU TRACE 003171  aa  0 00623 7001 00      tsx0      pr0|403             call_ext_out
1555286570.042069: DBG(324121450) 0: CPU TRACE 0: 00265:003555 4 000623700100 (TSX0 PR0|623) 000623 700(0) 1 0 0 00

                    call hcs_$read_events (ipc_data_$fast_channel_events, ("0"b));

in ipc_real$copy_itt_messages

called from 

1555286570.005683: DBG(324121406) 0: CPU TRACE 00265:002753 bound_ipc_:ipc_real_+02367
1555286570.006948: DBG(324121406) 0: CPU TRACE 002367  aa   000546 6700 04      tsp4      358,ic              003135
1555286570.007252: DBG(324121406) 0: CPU TRACE 0: 00265:002753 4 000546670004 (TSP4 000546,IC) 000546 670(0) 0 0 0 04
               call copy_itt_messages (NO);

in 

full_block"
     entry (P_event_wait_list_ptr, P_event_wait_info_ptr, P_code);
ipc_real_$full_block
    copy_itt_messages
        hcs_$read_events
            fast_hc_ipc$read_events
               fast_hc_icp$check_full_block
                   hc_ipc$full_block
                       hc_ipc$dispatch_message
                           allocate itt_message in (ect_area) set (msg_ptr);
Unless otherwise stated, the content of this page is licensed under Creative Commons Attribution-ShareAlike 3.0 License