12:06:29:ST3_Shared:INFO:	oooooooooooooooooooooooooooooooooooooooooooooooooooooooooooo
12:06:29:ST3_Shared:INFO:	                       FEB-Microcable                       
12:06:29:ST3_Shared:INFO:	oooooooooooooooooooooooooooooooooooooooooooooooooooooooooooo
12:06:29:febtest:INFO:	Testing FEB with SN 4096
12:06:30:smx_tester:INFO:	Scanning setup
12:06:31:elinks:INFO:	Disabling clock on downlink 0
12:06:31:elinks:INFO:	Disabling clock on downlink 1
12:06:31:elinks:INFO:	Disabling clock on downlink 2
12:06:31:elinks:INFO:	Disabling clock on downlink 3
12:06:31:elinks:INFO:	Disabling clock on downlink 4
12:06:31:setup_element:INFO:	Checking SOS, encoding_mode: SOS
12:06:31:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [0]
12:06:31:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
12:06:31:elinks:INFO:	Disabling clock on downlink 0
12:06:31:elinks:INFO:	Disabling clock on downlink 1
12:06:31:elinks:INFO:	Disabling clock on downlink 2
12:06:31:elinks:INFO:	Disabling clock on downlink 3
12:06:31:elinks:INFO:	Disabling clock on downlink 4
12:06:31:setup_element:INFO:	Checking SOS, encoding_mode: SOS
12:06:31:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [1]
12:06:31:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
12:06:31:elinks:INFO:	Disabling clock on downlink 0
12:06:31:elinks:INFO:	Disabling clock on downlink 1
12:06:31:elinks:INFO:	Disabling clock on downlink 2
12:06:31:elinks:INFO:	Disabling clock on downlink 3
12:06:31:elinks:INFO:	Disabling clock on downlink 4
12:06:31:setup_element:INFO:	Checking SOS, encoding_mode: SOS
12:06:31:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
12:06:31:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 24
12:06:31:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 25
12:06:31:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 26
12:06:31:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 27
12:06:31:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 28
12:06:31:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 29
12:06:31:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 30
12:06:31:setup_element:INFO:	SOS detected for group 0, downlink 2, uplink 31
12:06:31:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
12:06:31:elinks:INFO:	Disabling clock on downlink 0
12:06:31:elinks:INFO:	Disabling clock on downlink 1
12:06:31:elinks:INFO:	Disabling clock on downlink 2
12:06:31:elinks:INFO:	Disabling clock on downlink 3
12:06:31:elinks:INFO:	Disabling clock on downlink 4
12:06:31:setup_element:INFO:	Checking SOS, encoding_mode: SOS
12:06:31:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [3]
12:06:31:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
12:06:31:elinks:INFO:	Disabling clock on downlink 0
12:06:31:elinks:INFO:	Disabling clock on downlink 1
12:06:31:elinks:INFO:	Disabling clock on downlink 2
12:06:31:elinks:INFO:	Disabling clock on downlink 3
12:06:31:elinks:INFO:	Disabling clock on downlink 4
12:06:31:setup_element:INFO:	Checking SOS, encoding_mode: SOS
12:06:31:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [4]
12:06:31:setup_element:INFO:	Reassigning uplinks to uplinks which passed SOS detection
12:06:31:setup_element:INFO:	Scanning clock phase
12:06:31:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
12:06:31:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [2]
12:06:31:setup_element:INFO:	Clock phase scan results for group 0, downlink 2
12:06:31:setup_element:INFO:	Eye window for uplink 24: ________________________________________________________________XXXXXX__________
Clock Delay: 26
12:06:31:setup_element:INFO:	Eye window for uplink 25: ________________________________________________________________XXXXXX__________
Clock Delay: 26
12:06:31:setup_element:INFO:	Eye window for uplink 26: ________________________________________________________________________________
Clock Delay: 40
12:06:31:setup_element:INFO:	Eye window for uplink 27: ________________________________________________________________________________
Clock Delay: 40
12:06:31:setup_element:INFO:	Eye window for uplink 28: _______________________________________________________________XXXXXX___________
Clock Delay: 25
12:06:31:setup_element:INFO:	Eye window for uplink 29: _______________________________________________________________XXXXXX___________
Clock Delay: 25
12:06:31:setup_element:INFO:	Eye window for uplink 30: _____________________________________________________________XXXXXX_____________
Clock Delay: 23
12:06:31:setup_element:INFO:	Eye window for uplink 31: _____________________________________________________________XXXXXX_____________
Clock Delay: 23
12:06:31:setup_element:INFO:	Setting the clock phase to 25 for group 0, downlink 2
12:06:31:setup_element:INFO:	Scanning data phases
12:06:31:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
12:06:32:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [2]
12:06:37:setup_element:INFO:	Data phase scan results for group 0, downlink 2
12:06:37:setup_element:INFO:	Eye window for uplink 24: _XXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXXX
Data delay found: 20
12:06:37:setup_element:INFO:	Eye window for uplink 25: ___________XXXXX________________________
Data delay found: 33
12:06:37:setup_element:INFO:	Eye window for uplink 26: _______XXXXXXXX_________________________
Data delay found: 30
12:06:37:setup_element:INFO:	Eye window for uplink 27: ___________XXXXXXXXXX___________________
Data delay found: 35
12:06:37:setup_element:INFO:	Eye window for uplink 28: ______________XXXXXXX___________________
Data delay found: 37
12:06:37:setup_element:INFO:	Eye window for uplink 29: __________________XXXXXXX_______________
Data delay found: 1
12:06:37:setup_element:INFO:	Eye window for uplink 30: ____________XXXXXXXXXX__________________
Data delay found: 36
12:06:37:setup_element:INFO:	Eye window for uplink 31: _______________XXXXXXX__________________
Data delay found: 38
12:06:37:setup_element:INFO:	Setting the data phase to 20 for uplink 24
12:06:37:setup_element:INFO:	Setting the data phase to 33 for uplink 25
12:06:37:setup_element:INFO:	Setting the data phase to 30 for uplink 26
12:06:37:setup_element:INFO:	Setting the data phase to 35 for uplink 27
12:06:37:setup_element:INFO:	Setting the data phase to 37 for uplink 28
12:06:37:setup_element:INFO:	Setting the data phase to 1 for uplink 29
12:06:37:setup_element:INFO:	Setting the data phase to 36 for uplink 30
12:06:37:setup_element:INFO:	Setting the data phase to 38 for uplink 31
12:06:37:setup_element:INFO:	Beginning SMX ASICs map scan
12:06:37:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
12:06:37:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [2]
12:06:37:master:INFO:	Setting encoding mode EOS for groups [0], downlinks [2]
12:06:37:master:INFO:	Setting encoding mode FRAME for groups [0], downlinks [2]
12:06:37:uplink:INFO:	Setting uplinks mask [24, 25, 26, 27, 28, 29, 30, 31]
12:06:37:setup_element:INFO:	Adding ASIC 0x1, ASIC uplink 0, uplink 30
12:06:37:setup_element:INFO:	Adding ASIC 0x1, ASIC uplink 1, uplink 31
12:06:37:setup_element:INFO:	Adding ASIC 0x3, ASIC uplink 0, uplink 28
12:06:37:setup_element:INFO:	Adding ASIC 0x3, ASIC uplink 1, uplink 29
12:06:38:setup_element:INFO:	Adding ASIC 0x5, ASIC uplink 0, uplink 26
12:06:38:setup_element:INFO:	Adding ASIC 0x5, ASIC uplink 1, uplink 27
12:06:38:setup_element:INFO:	Adding ASIC 0x7, ASIC uplink 0, uplink 24
12:06:38:setup_element:INFO:	Adding ASIC 0x7, ASIC uplink 1, uplink 25
12:06:39:setup_element:INFO:	Performing Elink synchronization
12:06:39:master:INFO:	Setting encoding mode SOS for groups [0], downlinks [2]
12:06:39:master:INFO:	Setting encoding mode K.28.1 for groups [0], downlinks [2]
12:06:39:master:INFO:	Setting encoding mode EOS for groups [0], downlinks [2]
12:06:39:master:INFO:	Setting encoding mode FRAME for groups [0], downlinks [2]
12:06:39:setup_element:INFO:	Writing SMX Elink masks for group 0, downlink 2
12:06:39:uplink:INFO:	Enabling uplinks [24, 25, 26, 27, 28, 29, 30, 31]
|_________________________________________________________________________|
_addr_|_upli_|_dwnli_|_grp_|_uplinks_|_#uplinks_|_uplinks_map_
 1   | [0]  |   2   |  0  |  [30]   |    2    | [(0, 30), (1, 31)]
 3   | [0]  |   2   |  0  |  [28]   |    2    | [(0, 28), (1, 29)]
 5   | [0]  |   2   |  0  |  [26]   |    2    | [(0, 26), (1, 27)]
 7   | [0]  |   2   |  0  |  [24]   |    2    | [(0, 24), (1, 25)]
|_________________________________________________________________________|
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_h_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_h_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_h_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_h_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_h_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_h_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_e_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_e_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_e_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_e_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_e_1_30 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_e_1_30 (Potential memory leak).
TCanvas::Constructor:0: RuntimeWarning: Deleting canvas with same name: cDist_FEB_B__addr_1__upli_30
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_h_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_h_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_h_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_h_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_h_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_h_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_e_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_e_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_e_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_e_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_e_3_28 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_e_3_28 (Potential memory leak).
TCanvas::Constructor:0: RuntimeWarning: Deleting canvas with same name: cDist_FEB_B__addr_3__upli_28
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_h_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_h_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_h_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_h_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_h_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_h_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_e_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_e_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_e_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_e_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_e_5_26 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_e_5_26 (Potential memory leak).
TCanvas::Constructor:0: RuntimeWarning: Deleting canvas with same name: cDist_FEB_B__addr_5__upli_26
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_h_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_h_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_h_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_h_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_h_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_h_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_front_e_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: h2D_back_e_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_fastD_e_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_front_e_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hDist_back_e_7_24 (Potential memory leak).
TROOT::Append:0: RuntimeWarning: Replacing existing TH1: hBroken_e_7_24 (Potential memory leak).
TCanvas::Constructor:0: RuntimeWarning: Deleting canvas with same name: cDist_FEB_B__addr_7__upli_24
12:06:40:febtest:INFO:	Init all SMX (CSA): 30
12:06:49:febtest:INFO:	_Addr_|___________ASIC-ID_____________|_T_[C]_|_Vddm_[mV]_
12:06:49:febtest:INFO:	30-01 | XA-000-09-004-004-008-018-04 |  44.1 | 1141.9
12:06:49:febtest:INFO:	28-03 | XA-000-09-004-004-008-019-04 |  37.7 | 1171.5
12:06:49:febtest:INFO:	26-05 | XA-000-09-004-004-008-021-04 |  47.3 | 1141.9
12:06:49:febtest:INFO:	24-07 | XA-000-09-004-004-007-012-07 |  37.7 | 1177.4
12:06:50:febtest:INFO:	Set all CSA to ZERO
FEB type: B FEB_A: 0 FEB_B: 1
12:06:52:ST3_smx:INFO:	chip: 30-1 	 44.073563 C 	 1153.732915 mV
12:06:52:ST3_discr_histo:WARNING:	Not enough entries for fit!!!
12:06:52:ST3_discr_histo:WARNING:	Not enough entries for fit!!!
12:06:52:ST3_smx:INFO:		Electrons
12:06:52:ST3_smx:INFO:	# loops 0
12:06:54:ST3_smx:INFO:	# loops 1
12:06:56:ST3_smx:INFO:	# loops 2
12:06:58:ST3_smx:INFO:	Total # of broken channels: 0
12:06:58:ST3_smx:INFO:	List of broken channels: []
12:06:58:ST3_smx:INFO:	Total # of broken channels: 0
12:06:58:ST3_smx:INFO:	List of broken channels: []
12:07:00:ST3_smx:INFO:	chip: 28-3 	 37.726682 C 	 1183.292940 mV
12:07:00:ST3_discr_histo:WARNING:	Not enough entries for fit!!!
12:07:00:ST3_discr_histo:WARNING:	Not enough entries for fit!!!
12:07:00:ST3_smx:INFO:		Electrons
12:07:00:ST3_smx:INFO:	# loops 0
12:07:02:ST3_smx:INFO:	# loops 1
12:07:04:ST3_smx:INFO:	# loops 2
12:07:06:ST3_smx:INFO:	Total # of broken channels: 0
12:07:06:ST3_smx:INFO:	List of broken channels: []
12:07:06:ST3_smx:INFO:	Total # of broken channels: 0
12:07:06:ST3_smx:INFO:	List of broken channels: []
12:07:08:ST3_smx:INFO:	chip: 26-5 	 50.430383 C 	 1153.732915 mV
12:07:08:ST3_discr_histo:WARNING:	Not enough entries for fit!!!
12:07:08:ST3_discr_histo:WARNING:	Not enough entries for fit!!!
12:07:08:ST3_smx:INFO:		Electrons
12:07:08:ST3_smx:INFO:	# loops 0
12:07:10:ST3_smx:INFO:	# loops 1
12:07:12:ST3_smx:INFO:	# loops 2
12:07:14:ST3_smx:INFO:	Total # of broken channels: 1
12:07:14:ST3_smx:INFO:	List of broken channels: [118]
12:07:14:ST3_smx:INFO:	Total # of broken channels: 1
12:07:14:ST3_smx:INFO:	List of broken channels: [118]
12:07:16:ST3_smx:INFO:	chip: 24-7 	 40.898880 C 	 1183.292940 mV
12:07:16:ST3_discr_histo:WARNING:	Not enough entries for fit!!!
12:07:16:ST3_discr_histo:WARNING:	Not enough entries for fit!!!
12:07:16:ST3_smx:INFO:		Electrons
12:07:16:ST3_smx:INFO:	# loops 0
12:07:18:ST3_smx:INFO:	# loops 1
12:07:20:ST3_smx:INFO:	# loops 2
12:07:22:ST3_smx:INFO:	Total # of broken channels: 0
12:07:22:ST3_smx:INFO:	List of broken channels: []
12:07:22:ST3_smx:INFO:	Total # of broken channels: 0
12:07:22:ST3_smx:INFO:	List of broken channels: []
12:07:23:febtest:INFO:	_Addr_|___________ASIC-ID_____________|_T_[C]_|_Vddm_[mV]_
12:07:23:febtest:INFO:	30-01 | XA-000-09-004-004-008-018-04 |  44.1 | 1171.5
12:07:23:febtest:INFO:	28-03 | XA-000-09-004-004-008-019-04 |  40.9 | 1201.0
Traceback (most recent call last):
  File "febtest.py", line 815, in DoFEB_MicrocableTest
    self.Talk2FEB() # read temperatures
  File "febtest.py", line 470, in Talk2FEB
    vd = self.EMU.mysmx[i].ReadDiag('Vddm')
  File "/home/cbm/ST3_v2.29.27/lib/ST3_smx.py", line 668, in ReadDiag
    result = self.smx.read(192,34) # page 37 1-bit comparator for AFE_DIAG
  File "/home/cbm/ST3_BASE/smx_software_FEB8_2_20MHz/python/smx_tester/smx.py", line 39, in read
    return self.ack_monitor.check_read()
  File "/home/cbm/ST3_BASE/smx_software_FEB8_2_20MHz/python/hctsp/ack_monitor.py", line 88, in check_read
    return self._check(self._check_read, 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 94, in _check_read
    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