14:31:48:ST3_Shared:INFO:	oooooooooooooooooooooooooooooooooooooooooooooooooooooooooooo
14:31:48:ST3_Shared:INFO:	                       FEB-Microcable                       
14:31:48:ST3_Shared:INFO:	oooooooooooooooooooooooooooooooooooooooooooooooooooooooooooo
14:31:48:febtest:INFO:	Testing FEB with SN 1263
14:31:50:smx_tester:INFO:	Scanning setup
14:31:50:elinks:INFO:	Disabling clock on downlink 0
14:31:50:elinks:INFO:	Disabling clock on downlink 1
14:31:50:elinks:INFO:	Disabling clock on downlink 2
14:31:50:elinks:INFO:	Disabling clock on downlink 3
14:31:50:elinks:INFO:	Disabling clock on downlink 4
14:31:50:setup_element:INFO:	Checking SOS, encoding_mode: SOS
14:31:50:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [0]
14:31:50:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
14:31:50:elinks:INFO:	Disabling clock on downlink 0
14:31:50:elinks:INFO:	Disabling clock on downlink 1
14:31:50:elinks:INFO:	Disabling clock on downlink 2
14:31:50:elinks:INFO:	Disabling clock on downlink 3
14:31:50:elinks:INFO:	Disabling clock on downlink 4
14:31:50:setup_element:INFO:	Checking SOS, encoding_mode: SOS
14:31:50:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [1]
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 0
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 1
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 2
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 3
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 4
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 5
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 6
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 7
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 8
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 9
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 10
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 11
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 12
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 13
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 14
14:31:50:setup_element:INFO:	SOS detected for group 0, downlink 1, uplink 15
14:31:50:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
14:31:50:elinks:INFO:	Disabling clock on downlink 0
14:31:50:elinks:INFO:	Disabling clock on downlink 1
14:31:50:elinks:INFO:	Disabling clock on downlink 2
14:31:50:elinks:INFO:	Disabling clock on downlink 3
14:31:50:elinks:INFO:	Disabling clock on downlink 4
14:31:50:setup_element:INFO:	Checking SOS, encoding_mode: SOS
14:31:50:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
14:31:50:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
14:31:50:elinks:INFO:	Disabling clock on downlink 0
14:31:50:elinks:INFO:	Disabling clock on downlink 1
14:31:50:elinks:INFO:	Disabling clock on downlink 2
14:31:50:elinks:INFO:	Disabling clock on downlink 3
14:31:50:elinks:INFO:	Disabling clock on downlink 4
14:31:50:setup_element:INFO:	Checking SOS, encoding_mode: SOS
14:31:50:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [3]
14:31:50:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
14:31:50:elinks:INFO:	Disabling clock on downlink 0
14:31:50:elinks:INFO:	Disabling clock on downlink 1
14:31:50:elinks:INFO:	Disabling clock on downlink 2
14:31:50:elinks:INFO:	Disabling clock on downlink 3
14:31:50:elinks:INFO:	Disabling clock on downlink 4
14:31:50:setup_element:INFO:	Checking SOS, encoding_mode: SOS
14:31:50:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [4]
14:31:51:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
==============================================OOO==============================================
14:31:51:setup_element:INFO:	Scanning clock phase
14:31:51:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [1]
14:31:51:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [1]
14:31:51:setup_element:INFO:	Clock phase scan results for group 0, downlink 1
14:31:51:setup_element:INFO:	Eye window for uplink 0 : ________________________________________________________________________XXXXXXX_
Clock Delay: 35
14:31:51:setup_element:INFO:	Eye window for uplink 1 : ________________________________________________________________________XXXXXXX_
Clock Delay: 35
14:31:51:setup_element:INFO:	Eye window for uplink 2 : _______________________________________________________________________XXXXXXXX_
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 3 : _______________________________________________________________________XXXXXXXX_
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 4 : _______________________________________________________________________XXXXXXXX_
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 5 : _______________________________________________________________________XXXXXXXX_
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 6 : ________________________________________________________________________XXXXXXX_
Clock Delay: 35
14:31:51:setup_element:INFO:	Eye window for uplink 7 : ________________________________________________________________________XXXXXXX_
Clock Delay: 35
14:31:51:setup_element:INFO:	Eye window for uplink 8 : ______________________________________________________________________XXXXXXX___
Clock Delay: 33
14:31:51:setup_element:INFO:	Eye window for uplink 9 : ______________________________________________________________________XXXXXXX___
Clock Delay: 33
14:31:51:setup_element:INFO:	Eye window for uplink 10: _______________________________________________________________________XXXXXXXX_
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 11: _______________________________________________________________________XXXXXXXX_
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 12: _______________________________________________________________________XXXXXXX__
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 13: _______________________________________________________________________XXXXXXX__
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 14: _______________________________________________________________________XXXXXXX__
Clock Delay: 34
14:31:51:setup_element:INFO:	Eye window for uplink 15: _______________________________________________________________________XXXXXXX__
Clock Delay: 34
14:31:51:setup_element:INFO:	Setting the clock phase to 34 for group 0, downlink 1
14:31:51:ST3_emu:DEBUG:	Clock phase is initialized
==============================================OOO==============================================
14:31:51:setup_element:INFO:	Scanning data phases
14:31:51:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [1]
14:31:51:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [1]
14:31:57:setup_element:INFO:	Data phase scan results for group 0, downlink 1
14:31:57:setup_element:INFO:	Eye window for uplink 0 : ___________XXXXXX_______________________
Data delay found: 33
14:31:57:setup_element:INFO:	Eye window for uplink 1 : _______XXXXX____________________________
Data delay found: 29
14:31:57:setup_element:INFO:	Eye window for uplink 2 : _________XXXXX__________________________
Data delay found: 31
14:31:57:setup_element:INFO:	Eye window for uplink 3 : ______XXXXX_____________________________
Data delay found: 28
14:31:57:setup_element:INFO:	Eye window for uplink 4 : ______XXXXX_____________________________
Data delay found: 28
14:31:57:setup_element:INFO:	Eye window for uplink 5 : __XXXXX_________________________________
Data delay found: 24
14:31:57:setup_element:INFO:	Eye window for uplink 6 : XXXXX___________________________________
Data delay found: 22
14:31:57:setup_element:INFO:	Eye window for uplink 7 : XX_________________________________XXXXX
Data delay found: 18
14:31:57:setup_element:INFO:	Eye window for uplink 8 : _________________________XXXX___________
Data delay found: 6
14:31:57:setup_element:INFO:	Eye window for uplink 9 : ______________________________XXXXXX____
Data delay found: 12
14:31:57:setup_element:INFO:	Eye window for uplink 10: ______________XXXXXXXXXXXXXXXXXXXX______
Data delay found: 3
14:31:57:setup_element:INFO:	Eye window for uplink 11: ______________XXXXXXXXXXXXXXXXXXXXXXX___
Data delay found: 5
14:31:57:setup_element:INFO:	Eye window for uplink 12: __________________XXXXXXXXXXXXXXXXXXXXXX
Data delay found: 8
14:31:57:setup_element:INFO:	Eye window for uplink 13: __________________XXXXXXXXXXXXXXXXXXXXXX
Data delay found: 8
14:31:57:setup_element:INFO:	Eye window for uplink 14: ____________________________XXXXX_______
Data delay found: 10
14:31:57:setup_element:INFO:	Eye window for uplink 15: ______________________________XXXXX_____
Data delay found: 12
14:31:57:setup_element:INFO:	Setting the data phase to 33 for uplink 0
14:31:57:setup_element:INFO:	Setting the data phase to 29 for uplink 1
14:31:57:setup_element:INFO:	Setting the data phase to 31 for uplink 2
14:31:57:setup_element:INFO:	Setting the data phase to 28 for uplink 3
14:31:57:setup_element:INFO:	Setting the data phase to 28 for uplink 4
14:31:57:setup_element:INFO:	Setting the data phase to 24 for uplink 5
14:31:57:setup_element:INFO:	Setting the data phase to 22 for uplink 6
14:31:57:setup_element:INFO:	Setting the data phase to 18 for uplink 7
14:31:57:setup_element:INFO:	Setting the data phase to 6 for uplink 8
14:31:57:setup_element:INFO:	Setting the data phase to 12 for uplink 9
14:31:57:setup_element:INFO:	Setting the data phase to 3 for uplink 10
14:31:57:setup_element:INFO:	Setting the data phase to 5 for uplink 11
14:31:57:setup_element:INFO:	Setting the data phase to 8 for uplink 12
14:31:57:setup_element:INFO:	Setting the data phase to 8 for uplink 13
14:31:57:setup_element:INFO:	Setting the data phase to 10 for uplink 14
14:31:57:setup_element:INFO:	Setting the data phase to 12 for uplink 15
14:31:57:ST3_emu:DEBUG:	Data phase is initialized
==============================================OOO==============================================
14:31:57:setup_element:INFO:	Beginning SMX ASICs map scan
14:31:57:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [1]
14:31:57:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [1]
14:31:57:master:INFO:	Setting encoding mode EOS for groups [0], downlinks [1]
14:31:57:master:INFO:	Setting encoding mode FRAME for groups [0], downlinks [1]
14:31:57:uplink:INFO:	Setting uplinks mask [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15]
14:31:57:setup_element:INFO:	Adding ASIC 0x0, ASIC uplink 0, uplink 1
14:31:57:setup_element:INFO:	Adding ASIC 0x0, ASIC uplink 1, uplink 0
14:31:57:setup_element:INFO:	Adding ASIC 0x1, ASIC uplink 0, uplink 8
14:31:57:setup_element:INFO:	Adding ASIC 0x1, ASIC uplink 1, uplink 9
Traceback (most recent call last):
  File "./febtest.py", line 795, in DoFEB_MicrocableTest
    if self.DoScanFEB8():
  File "./febtest.py", line 577, in DoScanFEB8
    self.EMU.Scan_FEB8(reporter)
  File "/home/cbm/ST3_v2.29.33/lib/ST3_emu_feb.py", line 52, in Scan_FEB8
    if super().init_chips():
  File "/home/cbm/ST3_v2.29.33/lib/ST3_emu.py", line 100, in init_chips
    se.scan_smx_asics_map()
  File "/home/cbm/ST3_BASE/smx_software_FEB8_2_20MHz/python/hctsp/setup_element.py", line 357, in scan_smx_asics_map
    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 69, in _check_write
    frame = self._parse_frame(frame)
  File "/home/cbm/ST3_BASE/smx_software_FEB8_2_20MHz/python/hctsp/ack_monitor.py", line 116, in _parse_frame
    raise AckMissed()
hctsp.ack_monitor.AckMissed: At least one Ack frame missed