11:50:23:ST3_Shared:INFO:	oooooooooooooooooooooooooooooooooooooooooooooooooooooooooooo
11:50:23:ST3_Shared:INFO:	                          FEB-ASIC                          
11:50:23:ST3_Shared:INFO:	oooooooooooooooooooooooooooooooooooooooooooooooooooooooooooo
11:50:23:febtest:INFO:	Testing FEB with SN 2262
11:50:24:smx_tester:INFO:	Scanning setup
11:50:24:elinks:INFO:	Disabling clock on downlink 0
11:50:24:elinks:INFO:	Disabling clock on downlink 1
11:50:24:elinks:INFO:	Disabling clock on downlink 2
11:50:24:elinks:INFO:	Disabling clock on downlink 3
11:50:24:elinks:INFO:	Disabling clock on downlink 4
11:50:24:setup_element:INFO:	Checking SOS, encoding_mode: SOS
11:50:24:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [0]
11:50:24:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
11:50:24:elinks:INFO:	Disabling clock on downlink 0
11:50:24:elinks:INFO:	Disabling clock on downlink 1
11:50:24:elinks:INFO:	Disabling clock on downlink 2
11:50:24:elinks:INFO:	Disabling clock on downlink 3
11:50:24:elinks:INFO:	Disabling clock on downlink 4
11:50:24:setup_element:INFO:	Checking SOS, encoding_mode: SOS
11:50:24:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [1]
11:50:24:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
11:50:24:elinks:INFO:	Disabling clock on downlink 0
11:50:25:elinks:INFO:	Disabling clock on downlink 1
11:50:25:elinks:INFO:	Disabling clock on downlink 2
11:50:25:elinks:INFO:	Disabling clock on downlink 3
11:50:25:elinks:INFO:	Disabling clock on downlink 4
11:50:25:setup_element:INFO:	Checking SOS, encoding_mode: SOS
11:50:25:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 16
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 17
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 18
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 19
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 20
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 21
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 22
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 23
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 24
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 25
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 26
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 27
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 28
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 29
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 30
11:50:25:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 31
11:50:25:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
11:50:25:elinks:INFO:	Disabling clock on downlink 0
11:50:25:elinks:INFO:	Disabling clock on downlink 1
11:50:25:elinks:INFO:	Disabling clock on downlink 2
11:50:25:elinks:INFO:	Disabling clock on downlink 3
11:50:25:elinks:INFO:	Disabling clock on downlink 4
11:50:25:setup_element:INFO:	Checking SOS, encoding_mode: SOS
11:50:25:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [3]
11:50:25:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
11:50:25:elinks:INFO:	Disabling clock on downlink 0
11:50:25:elinks:INFO:	Disabling clock on downlink 1
11:50:25:elinks:INFO:	Disabling clock on downlink 2
11:50:25:elinks:INFO:	Disabling clock on downlink 3
11:50:25:elinks:INFO:	Disabling clock on downlink 4
11:50:25:setup_element:INFO:	Checking SOS, encoding_mode: SOS
11:50:25:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [4]
11:50:25:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
==============================================OOO==============================================
11:50:25:setup_element:INFO:	Scanning clock phase
11:50:25:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
11:50:25:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [2]
11:50:25:setup_element:INFO:	Clock phase scan results for group 0, downlink 2
11:50:25:setup_element:INFO:	Eye window for uplink 16: _____________________________________________________________________XXXXXXXX___
Clock Delay: 32
11:50:25:setup_element:INFO:	Eye window for uplink 17: _____________________________________________________________________XXXXXXXX___
Clock Delay: 32
11:50:25:setup_element:INFO:	Eye window for uplink 18: _______________________________________________________________________XXXXXXX__
Clock Delay: 34
11:50:25:setup_element:INFO:	Eye window for uplink 19: _______________________________________________________________________XXXXXXX__
Clock Delay: 34
11:50:25:setup_element:INFO:	Eye window for uplink 20: ______________________________________________________________________XXXXXXXXX_
Clock Delay: 34
11:50:25:setup_element:INFO:	Eye window for uplink 21: ______________________________________________________________________XXXXXXXXX_
Clock Delay: 34
11:50:25:setup_element:INFO:	Eye window for uplink 22: ______________________________________________________________________XXXXXXXX__
Clock Delay: 33
11:50:25:setup_element:INFO:	Eye window for uplink 23: ______________________________________________________________________XXXXXXXX__
Clock Delay: 33
11:50:25:setup_element:INFO:	Eye window for uplink 24: _____________________________________________________________________XXXXXXXX___
Clock Delay: 32
11:50:25:setup_element:INFO:	Eye window for uplink 25: _____________________________________________________________________XXXXXXXX___
Clock Delay: 32
11:50:25:setup_element:INFO:	Eye window for uplink 26: ________________________________________________________________________________
Clock Delay: 40
11:50:25:setup_element:INFO:	Eye window for uplink 27: ________________________________________________________________________________
Clock Delay: 40
11:50:25:setup_element:INFO:	Eye window for uplink 28: ______________________________________________________________________XXXXXXXX__
Clock Delay: 33
11:50:25:setup_element:INFO:	Eye window for uplink 29: ______________________________________________________________________XXXXXXXX__
Clock Delay: 33
11:50:25:setup_element:INFO:	Eye window for uplink 30: ________________________________________________________________________XXXXXXX_
Clock Delay: 35
11:50:25:setup_element:INFO:	Eye window for uplink 31: ________________________________________________________________________XXXXXXX_
Clock Delay: 35
11:50:25:setup_element:INFO:	Setting the clock phase to 33 for group 0, downlink 2
==============================================OOO==============================================
11:50:25:setup_element:INFO:	Scanning data phases
11:50:25:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
11:50:25:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [2]
11:50:31:setup_element:INFO:	Data phase scan results for group 0, downlink 2
11:50:31:setup_element:INFO:	Eye window for uplink 16: X___________________________________XXXX
Data delay found: 18
11:50:31:setup_element:INFO:	Eye window for uplink 17: __________________________________XXXXX_
Data delay found: 16
11:50:31:setup_element:INFO:	Eye window for uplink 18: _XXXXXX_________________________XXXXXXXX
Data delay found: 19
11:50:31:setup_element:INFO:	Eye window for uplink 19: XXXXX___________________________XXXXXXXX
Data delay found: 18
11:50:31:setup_element:INFO:	Eye window for uplink 20: XXXXX__________________________________X
Data delay found: 21
11:50:31:setup_element:INFO:	Eye window for uplink 21: XXX___________________________________XX
Data delay found: 20
11:50:31:setup_element:INFO:	Eye window for uplink 22: XXXXX_________________________________XX
Data delay found: 21
11:50:31:setup_element:INFO:	Eye window for uplink 23: XXXXXXXX_____________________________XXX
Data delay found: 22
11:50:31:setup_element:INFO:	Eye window for uplink 24: _________XXXXX__________________________
Data delay found: 31
11:50:31:setup_element:INFO:	Eye window for uplink 25: ___________XXXXX________________________
Data delay found: 33
11:50:31:setup_element:INFO:	Eye window for uplink 26: __________XXXXX_________________________
Data delay found: 32
11:50:31:setup_element:INFO:	Eye window for uplink 27: _____________XXXXXX_____________________
Data delay found: 35
11:50:31:setup_element:INFO:	Eye window for uplink 28: ____________XXXXXXXXXXXXXXXXXXXXXXXXXXXX
Data delay found: 5
11:50:31:setup_element:INFO:	Eye window for uplink 29: ____________XXXXXXXXXXXXXXXXXXXXXXXXXXXX
Data delay found: 5
11:50:31:setup_element:INFO:	Eye window for uplink 30: ___________________XXXXX________________
Data delay found: 1
11:50:31:setup_element:INFO:	Eye window for uplink 31: ___________________XXXXXX_______________
Data delay found: 1
11:50:31:setup_element:INFO:	Setting the data phase to 18 for uplink 16
11:50:31:setup_element:INFO:	Setting the data phase to 16 for uplink 17
11:50:31:setup_element:INFO:	Setting the data phase to 19 for uplink 18
11:50:31:setup_element:INFO:	Setting the data phase to 18 for uplink 19
11:50:31:setup_element:INFO:	Setting the data phase to 21 for uplink 20
11:50:31:setup_element:INFO:	Setting the data phase to 20 for uplink 21
11:50:31:setup_element:INFO:	Setting the data phase to 21 for uplink 22
11:50:31:setup_element:INFO:	Setting the data phase to 22 for uplink 23
11:50:31:setup_element:INFO:	Setting the data phase to 31 for uplink 24
11:50:31:setup_element:INFO:	Setting the data phase to 33 for uplink 25
11:50:31:setup_element:INFO:	Setting the data phase to 32 for uplink 26
11:50:31:setup_element:INFO:	Setting the data phase to 35 for uplink 27
11:50:31:setup_element:INFO:	Setting the data phase to 5 for uplink 28
11:50:31:setup_element:INFO:	Setting the data phase to 5 for uplink 29
11:50:31:setup_element:INFO:	Setting the data phase to 1 for uplink 30
11:50:31:setup_element:INFO:	Setting the data phase to 1 for uplink 31
==============================================OOO==============================================
11:50:31:setup_element:INFO:	Beginning SMX ASICs map scan
11:50:31:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
11:50:31:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [2]
11:50:31:master:INFO:	Setting encoding mode EOS for groups [0], downlinks [2]
11:50:31:master:INFO:	Setting encoding mode FRAME for groups [0], downlinks [2]
11:50:31:uplink:INFO:	Setting uplinks mask [16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]
11:50:31:setup_element:INFO:	Adding ASIC 0x0, ASIC uplink 0, uplink 23
11:50:31:setup_element:INFO:	Adding ASIC 0x0, ASIC uplink 1, uplink 22
11:50:31:setup_element:INFO:	Adding ASIC 0x1, ASIC uplink 0, uplink 30
11:50:31:setup_element:INFO:	Adding ASIC 0x1, ASIC uplink 1, uplink 31
11:50:31:setup_element:INFO:	Adding ASIC 0x2, ASIC uplink 0, uplink 21
11:50:31:setup_element:INFO:	Adding ASIC 0x2, ASIC uplink 1, uplink 20
11:50:31:setup_element:INFO:	Adding ASIC 0x3, ASIC uplink 0, uplink 28
11:50:31:setup_element:INFO:	Adding ASIC 0x3, ASIC uplink 1, uplink 29
11:50:32:setup_element:INFO:	Adding ASIC 0x4, ASIC uplink 0, uplink 19
11:50:32:setup_element:INFO:	Adding ASIC 0x4, ASIC uplink 1, uplink 18
11:50:32:setup_element:INFO:	Adding ASIC 0x5, ASIC uplink 0, uplink 26
11:50:32:setup_element:INFO:	Adding ASIC 0x5, ASIC uplink 1, uplink 27
11:50:32:setup_element:INFO:	Adding ASIC 0x6, ASIC uplink 0, uplink 17
11:50:32:setup_element:INFO:	Adding ASIC 0x6, ASIC uplink 1, uplink 16
11:50:32:setup_element:INFO:	Adding ASIC 0x7, ASIC uplink 0, uplink 24
11:50:32:setup_element:INFO:	Adding ASIC 0x7, ASIC uplink 1, uplink 25
11:50:33:ST3_emu:INFO:	
Setup Element:
  Group: 0
  Downlink: 2
  Uplinks: [16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]
  ASICs Map:
    ASIC address 0x0: (ASIC uplink, uplink): (0, 23), (1, 22)
    ASIC address 0x1: (ASIC uplink, uplink): (0, 30), (1, 31)
    ASIC address 0x2: (ASIC uplink, uplink): (0, 21), (1, 20)
    ASIC address 0x3: (ASIC uplink, uplink): (0, 28), (1, 29)
    ASIC address 0x4: (ASIC uplink, uplink): (0, 19), (1, 18)
    ASIC address 0x5: (ASIC uplink, uplink): (0, 26), (1, 27)
    ASIC address 0x6: (ASIC uplink, uplink): (0, 17), (1, 16)
    ASIC address 0x7: (ASIC uplink, uplink): (0, 24), (1, 25)
  Clock Phase Characteristic:
    Optimal Phase: 33
    Window Length: 70
    Eye Windows:
      Uplink 16: _____________________________________________________________________XXXXXXXX___
      Uplink 17: _____________________________________________________________________XXXXXXXX___
      Uplink 18: _______________________________________________________________________XXXXXXX__
      Uplink 19: _______________________________________________________________________XXXXXXX__
      Uplink 20: ______________________________________________________________________XXXXXXXXX_
      Uplink 21: ______________________________________________________________________XXXXXXXXX_
      Uplink 22: ______________________________________________________________________XXXXXXXX__
      Uplink 23: ______________________________________________________________________XXXXXXXX__
      Uplink 24: _____________________________________________________________________XXXXXXXX___
      Uplink 25: _____________________________________________________________________XXXXXXXX___
      Uplink 26: ________________________________________________________________________________
      Uplink 27: ________________________________________________________________________________
      Uplink 28: ______________________________________________________________________XXXXXXXX__
      Uplink 29: ______________________________________________________________________XXXXXXXX__
      Uplink 30: ________________________________________________________________________XXXXXXX_
      Uplink 31: ________________________________________________________________________XXXXXXX_
  Data phase characteristics:
    Uplink 16:
      Optimal Phase: 18
      Window Length: 35
      Eye Window: X___________________________________XXXX
    Uplink 17:
      Optimal Phase: 16
      Window Length: 35
      Eye Window: __________________________________XXXXX_
    Uplink 18:
      Optimal Phase: 19
      Window Length: 25
      Eye Window: _XXXXXX_________________________XXXXXXXX
    Uplink 19:
      Optimal Phase: 18
      Window Length: 27
      Eye Window: XXXXX___________________________XXXXXXXX
    Uplink 20:
      Optimal Phase: 21
      Window Length: 34
      Eye Window: XXXXX__________________________________X
    Uplink 21:
      Optimal Phase: 20
      Window Length: 35
      Eye Window: XXX___________________________________XX
    Uplink 22:
      Optimal Phase: 21
      Window Length: 33
      Eye Window: XXXXX_________________________________XX
    Uplink 23:
      Optimal Phase: 22
      Window Length: 29
      Eye Window: XXXXXXXX_____________________________XXX
    Uplink 24:
      Optimal Phase: 31
      Window Length: 35
      Eye Window: _________XXXXX__________________________
    Uplink 25:
      Optimal Phase: 33
      Window Length: 35
      Eye Window: ___________XXXXX________________________
    Uplink 26:
      Optimal Phase: 32
      Window Length: 35
      Eye Window: __________XXXXX_________________________
    Uplink 27:
      Optimal Phase: 35
      Window Length: 34
      Eye Window: _____________XXXXXX_____________________
    Uplink 28:
      Optimal Phase: 5
      Window Length: 12
      Eye Window: ____________XXXXXXXXXXXXXXXXXXXXXXXXXXXX
    Uplink 29:
      Optimal Phase: 5
      Window Length: 12
      Eye Window: ____________XXXXXXXXXXXXXXXXXXXXXXXXXXXX
    Uplink 30:
      Optimal Phase: 1
      Window Length: 35
      Eye Window: ___________________XXXXX________________
    Uplink 31:
      Optimal Phase: 1
      Window Length: 34
      Eye Window: ___________________XXXXXX_______________

==============================================OOO==============================================
11:50:33:setup_element:INFO:	Performing Elink synchronization
11:50:33:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
11:50:33:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [2]
11:50:33:master:INFO:	Setting encoding mode EOS for groups [0], downlinks [2]
11:50:33:master:INFO:	Setting encoding mode FRAME for groups [0], downlinks [2]
==============================================OOO==============================================
11:50:33:setup_element:INFO:	Writing SMX Elink masks for group 0, downlink 2
11:50:33:uplink:INFO:	Enabling uplinks [16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31]
==============================================OOO==============================================
|_________________________________________________________________________|
_addr_|_upli_|_dwnli_|_grp_|_uplinks_|_#uplinks_|_uplinks_map_
 0   | [0]  |   2   |  0  |  [23]   |    2    | [(0, 23), (1, 22)]
 1   | [0]  |   2   |  0  |  [30]   |    2    | [(0, 30), (1, 31)]
 2   | [0]  |   2   |  0  |  [21]   |    2    | [(0, 21), (1, 20)]
 3   | [0]  |   2   |  0  |  [28]   |    2    | [(0, 28), (1, 29)]
 4   | [0]  |   2   |  0  |  [19]   |    2    | [(0, 19), (1, 18)]
 5   | [0]  |   2   |  0  |  [26]   |    2    | [(0, 26), (1, 27)]
 6   | [0]  |   2   |  0  |  [17]   |    2    | [(0, 17), (1, 16)]
 7   | [0]  |   2   |  0  |  [24]   |    2    | [(0, 24), (1, 25)]
|_________________________________________________________________________|
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_h_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_h_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_h_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_h_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_h_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_h_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_e_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_e_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_e_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_e_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_e_0_23 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_e_0_23 (Potential memory leak).
TCanvas::Constructor:0: RuntimeWarning: Deleting canvas with same name: cDist_FEB_B__addr_0__upli_23
11:50:34:febtest:INFO:	Init all SMX (CSA): 30
Traceback (most recent call last):
  File "febtest.py", line 773, in DoFEB_AsicTest
    if self.DoScanFEB8():
  File "febtest.py", line 612, in DoScanFEB8
    self.EMU.mysmx[i].ConfigASIC_FAST(self.sbCSAIN.value())
  File "/home/cbm/ST3_v2.29.38/lib/ST3_smx.py", line 372, in ConfigASIC_FAST
    self.smx.write(ch, (2*d+1), 128) # default TRIM
  File "/home/cbm/ST3_BASE/smx_software_FEB8_2_20MHz/python/smx_tester/smx.py", line 51, in write
    return self.ack_monitor.check_write()
  File "/home/cbm/ST3_BASE/smx_software_FEB8_2_20MHz/python/hctsp/ack_monitor.py", line 63, in check_write
    return self._check(self._check_write, timeout)
  File "/home/cbm/ST3_BASE/smx_software_FEB8_2_20MHz/python/hctsp/ack_monitor.py", line 55, in _check
    return check_function()
  File "/home/cbm/ST3_BASE/smx_software_FEB8_2_20MHz/python/hctsp/ack_monitor.py", line 85, in _check_write
    raise AckInvalidHeader
hctsp.ack_monitor.AckInvalidHeader: Invalid header in Ack frame