Test Date: 2015-07-10 10:45
Analysis date: 2016-05-25 21:06
Logfile
commander_PixelAlive.log
[08:45:26.183] <TB0> INFO: *** Welcome to pxar ***
[08:45:26.183] <TB0> INFO: *** Today: 2015/07/10
[08:45:26.183] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//000_PixelAlive_p17//dacParameters35_C15.dat
[08:45:26.184] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//000_PixelAlive_p17//tbmParameters_C0b.dat
[08:45:26.184] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//000_PixelAlive_p17//defaultMaskFile.dat
[08:45:26.184] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//000_PixelAlive_p17//trimParameters35_C15.dat
[08:45:26.252] <TB0> INFO: clk: 4
[08:45:26.252] <TB0> INFO: ctr: 4
[08:45:26.252] <TB0> INFO: sda: 19
[08:45:26.252] <TB0> INFO: tin: 9
[08:45:26.252] <TB0> INFO: level: 15
[08:45:26.252] <TB0> INFO: triggerdelay: 0
[08:45:26.252] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:45:26.252] <TB0> INFO: Log level: INFO
[08:45:26.267] <TB0> INFO: Found DTB DTB_WWXTQT
[08:45:26.275] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:45:26.278] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:45:26.281] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:45:27.822] <TB0> INFO: DUT info:
[08:45:27.822] <TB0> INFO: The DUT currently contains the following objects:
[08:45:27.822] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:45:27.822] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:45:27.822] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:45:27.822] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:45:27.822] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:27.822] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:45:28.223] <TB0> INFO: enter 'restricted' command line mode
[08:45:28.223] <TB0> INFO: enter test to run
[08:45:28.223] <TB0> INFO: test: PixelAlive no parameter change
[08:45:28.223] <TB0> INFO: running: pixelalive
[08:45:28.227] <TB0> INFO: ######################################################################
[08:45:28.227] <TB0> INFO: PixTestAlive::doTest()
[08:45:28.227] <TB0> INFO: ######################################################################
[08:45:28.229] <TB0> INFO: ----------------------------------------------------------------------
[08:45:28.229] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:45:28.229] <TB0> INFO: ----------------------------------------------------------------------
[08:45:31.589] <TB0> INFO: Test took 3359ms.
[08:45:31.620] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:45:31.874] <TB0> INFO: PixTestAlive::aliveTest() done
[08:45:31.874] <TB0> INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:45:31.876] <TB0> INFO: ----------------------------------------------------------------------
[08:45:31.876] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:45:31.876] <TB0> INFO: ----------------------------------------------------------------------
[08:45:34.522] <TB0> INFO: Test took 2645ms.
[08:45:34.523] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:45:34.524] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:45:34.747] <TB0> INFO: PixTestAlive::maskTest() done
[08:45:34.747] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:45:34.749] <TB0> INFO: ----------------------------------------------------------------------
[08:45:34.749] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:45:34.749] <TB0> INFO: ----------------------------------------------------------------------
[08:45:38.359] <TB0> INFO: Test took 3608ms.
[08:45:38.381] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:45:38.613] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[08:45:38.613] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:45:38.613] <TB0> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[08:45:38.642] <TB0> INFO: enter test to run
[08:45:38.642] <TB0> INFO: test: no parameter change
[08:45:38.800] <TB0> QUIET: Connection to board 147 closed.
[08:45:38.880] <TB0> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[08:49:08.794] <TB0> INFO: *** Welcome to pxar ***
[08:49:08.794] <TB0> INFO: *** Today: 2015/07/10
[08:49:08.794] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//dacParameters35_C15.dat
[08:49:08.794] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[08:49:08.794] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//defaultMaskFile.dat
[08:49:08.794] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C15.dat
[08:49:08.862] <TB0> INFO: clk: 4
[08:49:08.862] <TB0> INFO: ctr: 4
[08:49:08.862] <TB0> INFO: sda: 19
[08:49:08.862] <TB0> INFO: tin: 9
[08:49:08.862] <TB0> INFO: level: 15
[08:49:08.862] <TB0> INFO: triggerdelay: 0
[08:49:08.862] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:49:08.862] <TB0> INFO: Log level: INFO
[08:49:08.875] <TB0> INFO: Found DTB DTB_WWXTQT
[08:49:08.883] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:49:08.886] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:49:08.889] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:49:10.431] <TB0> INFO: DUT info:
[08:49:10.431] <TB0> INFO: The DUT currently contains the following objects:
[08:49:10.431] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:49:10.431] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:49:10.431] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:49:10.431] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:49:10.431] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.431] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.432] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.432] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.432] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.432] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:49:10.832] <TB0> INFO: enter 'restricted' command line mode
[08:49:10.832] <TB0> INFO: enter test to run
[08:49:10.833] <TB0> INFO: test: delay setting parameters: ->5<-
[08:49:10.833] <TB0> INFO: delay test by 5 seconds...
[08:49:15.833] <TB0> INFO: enter test to run
[08:49:15.833] <TB0> INFO: test: highrate no parameter change
[08:49:15.833] <TB0> INFO: running: highrate
[08:49:15.833] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[08:49:15.968] <TB0> INFO: ----------------------------------------------------------------------
[08:49:15.968] <TB0> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[08:49:15.968] <TB0> INFO: ----------------------------------------------------------------------
[08:49:15.968] <TB0> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[08:49:15.968] <TB0> INFO: edge/corner pixel THR is adjusted
[08:49:15.968] <TB0> INFO: PixTestHighRate::trimHotPixels: step 0...
[08:49:16.930] <TB0> INFO: Collecting data for 1 seconds...
[08:49:17.931] <TB0> INFO: Done with hot pixel readout
[08:49:22.962] <TB0> INFO: PixTest:: pg_setup set to default.
[08:49:22.963] <TB0> INFO: 5 hot pixels found in step 0
[08:49:23.926] <TB0> INFO: Collecting data for 1 seconds...
[08:49:24.927] <TB0> INFO: Done with hot pixel readout
[08:49:30.845] <TB0> INFO: PixTest:: pg_setup set to default.
[08:49:30.845] <TB0> INFO: 5 hot pixels found in step 1
[08:49:31.808] <TB0> INFO: Collecting data for 1 seconds...
[08:49:32.810] <TB0> INFO: Done with hot pixel readout
[08:49:38.749] <TB0> INFO: PixTest:: pg_setup set to default.
[08:49:38.750] <TB0> INFO: 0 hot pixels found in step 2
[08:49:38.758] <TB0> INFO: 0 hot pixels could not be trimmed and have been masked.
[08:49:38.793] <TB0> INFO: PixTest::trimHotPixels() done
[08:49:38.793] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C0.dat
[08:49:38.799] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C1.dat
[08:49:38.806] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C2.dat
[08:49:38.813] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C3.dat
[08:49:38.819] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C4.dat
[08:49:38.826] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C5.dat
[08:49:38.832] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C6.dat
[08:49:38.839] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C7.dat
[08:49:38.845] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C8.dat
[08:49:38.853] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C9.dat
[08:49:38.861] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C10.dat
[08:49:38.869] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C11.dat
[08:49:38.876] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C12.dat
[08:49:38.883] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C13.dat
[08:49:38.890] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C14.dat
[08:49:38.897] <TB0> INFO: write trim parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//trimParameters35_C15.dat
[08:49:38.904] <TB0> INFO: write masked pixels into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//002_RetrimHotPixels_150//defaultMaskFile.dat
[08:49:38.937] <TB0> INFO: enter test to run
[08:49:38.938] <TB0> INFO: test: no parameter change
[08:49:39.128] <TB0> QUIET: Connection to board 147 closed.
[08:49:39.208] <TB0> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[08:50:33.864] <TB0> INFO: *** Welcome to pxar ***
[08:50:33.864] <TB0> INFO: *** Today: 2015/07/10
[08:50:33.864] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[08:50:33.864] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[08:50:33.864] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[08:50:33.864] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[08:50:33.930] <TB0> INFO: clk: 4
[08:50:33.930] <TB0> INFO: ctr: 4
[08:50:33.930] <TB0> INFO: sda: 19
[08:50:33.930] <TB0> INFO: tin: 9
[08:50:33.930] <TB0> INFO: level: 15
[08:50:33.930] <TB0> INFO: triggerdelay: 0
[08:50:33.930] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:50:33.930] <TB0> INFO: Log level: INFO
[08:50:33.944] <TB0> INFO: Found DTB DTB_WWXTQT
[08:50:33.952] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:50:33.955] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:50:33.958] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:50:35.496] <TB0> INFO: DUT info:
[08:50:35.496] <TB0> INFO: The DUT currently contains the following objects:
[08:50:35.496] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:50:35.496] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:50:35.496] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:50:35.496] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:50:35.496] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.496] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.496] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.496] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.496] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.496] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.496] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.496] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.496] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.497] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.497] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.497] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.497] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.497] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.497] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.497] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:50:35.897] <TB0> INFO: enter 'restricted' command line mode
[08:50:35.897] <TB0> INFO: enter test to run
[08:50:35.898] <TB0> INFO: test: HighRate no parameter change
[08:50:35.898] <TB0> INFO: running: highrate
[08:50:35.898] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[08:50:36.026] <TB0> INFO: ----------------------------------------------------------------------
[08:50:36.026] <TB0> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[08:50:36.026] <TB0> INFO: ----------------------------------------------------------------------
[08:50:37.106] <TB0> INFO: Test took 1075ms.
[08:50:40.231] <TB0> INFO: Test took 3121ms.
[08:50:40.356] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:50:43.606] <TB0> INFO: Test took 3225ms.
[08:50:43.753] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:50:47.441] <TB0> INFO: Test took 3660ms.
[08:50:47.595] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:50:51.784] <TB0> INFO: Test took 4158ms.
[08:50:51.937] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:50:55.921] <TB0> INFO: Test took 3959ms.
[08:50:56.080] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:00.244] <TB0> INFO: Test took 4133ms.
[08:51:00.393] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:04.630] <TB0> INFO: Test took 4211ms.
[08:51:04.780] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:09.030] <TB0> INFO: Test took 4219ms.
[08:51:09.177] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:13.449] <TB0> INFO: Test took 4241ms.
[08:51:13.590] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:17.818] <TB0> INFO: Test took 4201ms.
[08:51:17.970] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:22.296] <TB0> INFO: Test took 4297ms.
[08:51:22.452] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:26.918] <TB0> INFO: Test took 4438ms.
[08:51:27.073] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:31.558] <TB0> INFO: Test took 4459ms.
[08:51:31.699] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:36.154] <TB0> INFO: Test took 4428ms.
[08:51:36.302] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:40.409] <TB0> INFO: Test took 4075ms.
[08:51:40.555] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:44.889] <TB0> INFO: Test took 4306ms.
[08:51:45.039] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:49.502] <TB0> INFO: Test took 4435ms.
[08:51:49.650] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:54.042] <TB0> INFO: Test took 4365ms.
[08:51:54.189] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:58.254] <TB0> INFO: Test took 4038ms.
[08:51:58.402] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:52:02.443] <TB0> INFO: Test took 4014ms.
[08:52:02.574] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:52:02.899] <TB0> INFO: enter test to run
[08:52:02.899] <TB0> INFO: test: Pretest no parameter change
[08:52:02.899] <TB0> INFO: running: pretest
[08:52:02.899] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[08:52:02.899] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[08:52:02.899] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[08:52:02.899] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[08:52:02.899] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[08:52:02.899] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[08:52:02.900] <TB0> INFO: write dac parameters into /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[08:52:02.901] <TB0> INFO: enter test to run
[08:52:02.901] <TB0> INFO: test: no parameter change
[08:52:03.103] <TB0> QUIET: Connection to board 147 closed.
[08:52:03.183] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:52:31.678] <TB0> INFO: *** Welcome to pxar ***
[08:52:31.678] <TB0> INFO: *** Today: 2015/07/10
[08:52:31.678] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//dacParameters35_C15.dat
[08:52:31.679] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//tbmParameters_C0b.dat
[08:52:31.679] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//defaultMaskFile.dat
[08:52:31.679] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//trimParameters35_C15.dat
[08:52:31.747] <TB0> INFO: clk: 4
[08:52:31.747] <TB0> INFO: ctr: 4
[08:52:31.747] <TB0> INFO: sda: 19
[08:52:31.747] <TB0> INFO: tin: 9
[08:52:31.747] <TB0> INFO: level: 15
[08:52:31.747] <TB0> INFO: triggerdelay: 0
[08:52:31.747] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:52:31.747] <TB0> INFO: Log level: INFO
[08:52:31.760] <TB0> INFO: Found DTB DTB_WWXTQT
[08:52:31.769] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:52:31.772] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:52:31.775] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:52:33.312] <TB0> INFO: DUT info:
[08:52:33.312] <TB0> INFO: The DUT currently contains the following objects:
[08:52:33.312] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:52:33.312] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:52:33.312] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:52:33.312] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:52:33.312] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.312] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.313] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.313] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:52:33.713] <TB0> INFO: enter 'restricted' command line mode
[08:52:33.713] <TB0> INFO: enter test to run
[08:52:33.713] <TB0> INFO: test: HighRate no parameter change
[08:52:33.713] <TB0> INFO: running: highrate
[08:52:33.714] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//004_HREfficiency_50//phCalibrationFitErr35_C15.dat
[08:52:33.841] <TB0> INFO: ----------------------------------------------------------------------
[08:52:33.841] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:52:33.841] <TB0> INFO: ----------------------------------------------------------------------
[08:52:45.504] <TB0> INFO: Test took 11657ms.
[08:52:46.272] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:52:46.575] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:52:46.575] <TB0> INFO: number of red-efficiency pixels: 120 123 118 223 212 316 308 256 235 215 274 278 212 128 114 136
[08:52:46.575] <TB0> INFO: number of X-ray hits detected: 90789 95951 86035 148397 154474 201290 193228 176591 170980 163085 187330 147901 135619 77031 84944 85138
[08:52:46.575] <TB0> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:52:46.575] <TB0> INFO: number of Vcal hits detected: 207877 207876 207878 207769 207778 207665 207673 207730 207756 207778 207711 207706 207780 207866 207884 207864
[08:52:46.575] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9
[08:52:46.575] <TB0> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9
[08:52:46.575] <TB0> INFO: X-ray hit rate [MHz/cm2]: 26.6 28.1 25.2 43.5 45.3 59.0 56.6 51.8 50.1 47.8 54.9 43.4 39.8 22.6 24.9 25.0
[08:52:46.575] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[08:52:46.611] <TB0> INFO: PixTest:: pg_setup set to default.
[08:52:46.647] <TB0> INFO: enter test to run
[08:52:46.647] <TB0> INFO: test: no parameter change
[08:52:46.800] <TB0> QUIET: Connection to board 147 closed.
[08:52:46.879] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:53:21.678] <TB0> INFO: *** Welcome to pxar ***
[08:53:21.678] <TB0> INFO: *** Today: 2015/07/10
[08:53:21.679] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//dacParameters35_C15.dat
[08:53:21.679] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//tbmParameters_C0b.dat
[08:53:21.679] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//defaultMaskFile.dat
[08:53:21.679] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//trimParameters35_C15.dat
[08:53:21.748] <TB0> INFO: clk: 4
[08:53:21.748] <TB0> INFO: ctr: 4
[08:53:21.748] <TB0> INFO: sda: 19
[08:53:21.748] <TB0> INFO: tin: 9
[08:53:21.748] <TB0> INFO: level: 15
[08:53:21.748] <TB0> INFO: triggerdelay: 0
[08:53:21.748] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:53:21.748] <TB0> INFO: Log level: INFO
[08:53:21.761] <TB0> INFO: Found DTB DTB_WWXTQT
[08:53:21.770] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:53:21.773] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:53:21.775] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:53:23.316] <TB0> INFO: DUT info:
[08:53:23.316] <TB0> INFO: The DUT currently contains the following objects:
[08:53:23.316] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:53:23.316] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:53:23.316] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:53:23.316] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:53:23.316] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.316] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:53:23.717] <TB0> INFO: enter 'restricted' command line mode
[08:53:23.717] <TB0> INFO: enter test to run
[08:53:23.717] <TB0> INFO: test: HighRate no parameter change
[08:53:23.717] <TB0> INFO: running: highrate
[08:53:23.717] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//005_HREfficiency_100//phCalibrationFitErr35_C15.dat
[08:53:23.848] <TB0> INFO: ----------------------------------------------------------------------
[08:53:23.848] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:53:23.848] <TB0> INFO: ----------------------------------------------------------------------
[08:53:37.624] <TB0> INFO: Test took 13770ms.
[08:53:39.710] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:53:40.109] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:53:40.109] <TB0> INFO: number of red-efficiency pixels: 359 313 320 657 770 1213 1128 915 850 819 1082 929 602 385 285 336
[08:53:40.109] <TB0> INFO: number of X-ray hits detected: 182350 194562 175753 296525 310327 399762 386897 354064 343315 328012 370864 296671 270894 157790 173605 171663
[08:53:40.109] <TB0> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:53:40.109] <TB0> INFO: number of Vcal hits detected: 207618 207661 207625 207250 207092 206420 206505 206882 206983 207017 206603 206837 207323 207542 207705 207647
[08:53:40.109] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.9 99.7 99.6 99.3 99.4 99.5 99.6 99.6 99.4 99.5 99.7 99.8 99.9 99.8
[08:53:40.109] <TB0> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.8 99.6 99.6 99.2 99.3 99.5 99.5 99.5 99.3 99.4 99.7 99.8 99.9 99.8
[08:53:40.109] <TB0> INFO: X-ray hit rate [MHz/cm2]: 53.4 57.0 51.5 86.9 91.0 117.2 113.4 103.8 100.6 96.1 108.7 87.0 79.4 46.2 50.9 50.3
[08:53:40.110] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[08:53:40.147] <TB0> INFO: PixTest:: pg_setup set to default.
[08:53:40.188] <TB0> INFO: enter test to run
[08:53:40.188] <TB0> INFO: test: no parameter change
[08:53:40.346] <TB0> QUIET: Connection to board 147 closed.
[08:53:40.426] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:54:15.582] <TB0> INFO: *** Welcome to pxar ***
[08:54:15.582] <TB0> INFO: *** Today: 2015/07/10
[08:54:15.582] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//dacParameters35_C15.dat
[08:54:15.583] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//tbmParameters_C0b.dat
[08:54:15.583] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//defaultMaskFile.dat
[08:54:15.583] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//trimParameters35_C15.dat
[08:54:15.653] <TB0> INFO: clk: 4
[08:54:15.653] <TB0> INFO: ctr: 4
[08:54:15.653] <TB0> INFO: sda: 19
[08:54:15.653] <TB0> INFO: tin: 9
[08:54:15.653] <TB0> INFO: level: 15
[08:54:15.653] <TB0> INFO: triggerdelay: 0
[08:54:15.653] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:54:15.653] <TB0> INFO: Log level: INFO
[08:54:15.666] <TB0> INFO: Found DTB DTB_WWXTQT
[08:54:15.674] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:54:15.678] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:54:15.680] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:54:17.219] <TB0> INFO: DUT info:
[08:54:17.219] <TB0> INFO: The DUT currently contains the following objects:
[08:54:17.219] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:54:17.219] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:54:17.219] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:54:17.219] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:54:17.219] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.219] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:54:17.620] <TB0> INFO: enter 'restricted' command line mode
[08:54:17.620] <TB0> INFO: enter test to run
[08:54:17.620] <TB0> INFO: test: HighRate no parameter change
[08:54:17.620] <TB0> INFO: running: highrate
[08:54:17.620] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//006_HREfficiency_150//phCalibrationFitErr35_C15.dat
[08:54:17.747] <TB0> INFO: ----------------------------------------------------------------------
[08:54:17.747] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:54:17.747] <TB0> INFO: ----------------------------------------------------------------------
[08:54:34.258] <TB0> INFO: Test took 16505ms.
[08:54:38.191] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:54:38.644] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:54:38.644] <TB0> INFO: number of red-efficiency pixels: 683 623 629 1411 1526 2275 2247 1820 1794 1632 2137 1812 1232 747 548 683
[08:54:38.644] <TB0> INFO: number of X-ray hits detected: 264338 283813 255048 428231 446728 572496 556189 510868 492589 473127 530217 424634 391694 231344 251231 249213
[08:54:38.644] <TB0> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:54:38.644] <TB0> INFO: number of Vcal hits detected: 207231 207313 207082 206055 205713 203957 203772 205261 205344 205580 204282 205081 206383 206859 207407 207237
[08:54:38.644] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.6 99.2 99.1 98.3 98.3 98.8 98.8 99.0 98.5 98.8 99.3 99.5 99.7 99.7
[08:54:38.644] <TB0> INFO: Vcal hit overall efficiency (%): 99.6 99.7 99.6 99.1 98.9 98.1 98.0 98.7 98.7 98.8 98.2 98.6 99.2 99.5 99.7 99.6
[08:54:38.644] <TB0> INFO: X-ray hit rate [MHz/cm2]: 77.5 83.2 74.8 125.5 130.9 167.8 163.0 149.7 144.4 138.7 155.4 124.5 114.8 67.8 73.6 73.0
[08:54:38.644] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[08:54:38.680] <TB0> INFO: PixTest:: pg_setup set to default.
[08:54:38.720] <TB0> INFO: enter test to run
[08:54:38.720] <TB0> INFO: test: no parameter change
[08:54:38.873] <TB0> QUIET: Connection to board 147 closed.
[08:54:38.952] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:55:15.673] <TB0> INFO: *** Welcome to pxar ***
[08:55:15.673] <TB0> INFO: *** Today: 2015/07/10
[08:55:15.673] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//dacParameters35_C15.dat
[08:55:15.673] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//tbmParameters_C0b.dat
[08:55:15.673] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//defaultMaskFile.dat
[08:55:15.673] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//trimParameters35_C15.dat
[08:55:15.739] <TB0> INFO: clk: 4
[08:55:15.739] <TB0> INFO: ctr: 4
[08:55:15.739] <TB0> INFO: sda: 19
[08:55:15.739] <TB0> INFO: tin: 9
[08:55:15.739] <TB0> INFO: level: 15
[08:55:15.739] <TB0> INFO: triggerdelay: 0
[08:55:15.739] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:55:15.739] <TB0> INFO: Log level: INFO
[08:55:15.751] <TB0> INFO: Found DTB DTB_WWXTQT
[08:55:15.759] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:55:15.763] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:55:15.765] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:55:17.306] <TB0> INFO: DUT info:
[08:55:17.306] <TB0> INFO: The DUT currently contains the following objects:
[08:55:17.306] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:55:17.306] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:55:17.306] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:55:17.306] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:55:17.306] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.306] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:55:17.707] <TB0> INFO: enter 'restricted' command line mode
[08:55:17.707] <TB0> INFO: enter test to run
[08:55:17.707] <TB0> INFO: test: HighRate no parameter change
[08:55:17.707] <TB0> INFO: running: highrate
[08:55:17.707] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//007_HREfficiency_200//phCalibrationFitErr35_C15.dat
[08:55:17.836] <TB0> INFO: ----------------------------------------------------------------------
[08:55:17.836] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:55:17.836] <TB0> INFO: ----------------------------------------------------------------------
[08:55:38.518] <TB0> INFO: Test took 20676ms.
[08:55:44.464] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:55:45.001] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:55:45.001] <TB0> INFO: number of red-efficiency pixels: 1357 1187 1023 2434 2540 3415 3408 3117 2961 2732 3304 2918 2117 1199 927 1245
[08:55:45.001] <TB0> INFO: number of X-ray hits detected: 358554 385477 347657 574886 601648 767395 751064 688126 664836 637209 713742 572067 529980 313592 342045 336437
[08:55:45.001] <TB0> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:55:45.001] <TB0> INFO: number of Vcal hits detected: 206214 206559 205997 203416 202666 198010 197589 201122 201493 202115 199362 200984 204419 205403 206919 206431
[08:55:45.001] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.2 99.4 99.2 98.1 97.8 95.8 95.6 97.0 97.2 97.5 96.4 97.1 98.5 99.0 99.5 99.3
[08:55:45.001] <TB0> INFO: Vcal hit overall efficiency (%): 99.1 99.3 99.0 97.8 97.4 95.2 95.0 96.7 96.9 97.2 95.8 96.6 98.3 98.8 99.5 99.2
[08:55:45.001] <TB0> INFO: X-ray hit rate [MHz/cm2]: 105.1 113.0 101.9 168.5 176.3 224.9 220.1 201.7 194.9 186.8 209.2 167.7 155.3 91.9 100.3 98.6
[08:55:45.001] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[08:55:45.036] <TB0> INFO: PixTest:: pg_setup set to default.
[08:55:45.081] <TB0> INFO: enter test to run
[08:55:45.081] <TB0> INFO: test: no parameter change
[08:55:45.256] <TB0> QUIET: Connection to board 147 closed.
[08:55:45.336] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[08:56:17.851] <TB0> INFO: *** Welcome to pxar ***
[08:56:17.851] <TB0> INFO: *** Today: 2015/07/10
[08:56:17.851] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//dacParameters35_C15.dat
[08:56:17.852] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//tbmParameters_C0b.dat
[08:56:17.852] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//defaultMaskFile.dat
[08:56:17.852] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//trimParameters35_C15.dat
[08:56:17.919] <TB0> INFO: clk: 4
[08:56:17.919] <TB0> INFO: ctr: 4
[08:56:17.919] <TB0> INFO: sda: 19
[08:56:17.919] <TB0> INFO: tin: 9
[08:56:17.919] <TB0> INFO: level: 15
[08:56:17.919] <TB0> INFO: triggerdelay: 0
[08:56:17.920] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:56:17.920] <TB0> INFO: Log level: INFO
[08:56:17.933] <TB0> INFO: Found DTB DTB_WWXTQT
[08:56:17.941] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:56:17.945] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:56:17.947] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:56:19.488] <TB0> INFO: DUT info:
[08:56:19.488] <TB0> INFO: The DUT currently contains the following objects:
[08:56:19.488] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:56:19.488] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:56:19.488] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:56:19.488] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:56:19.488] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.488] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:56:19.889] <TB0> INFO: enter 'restricted' command line mode
[08:56:19.889] <TB0> INFO: enter test to run
[08:56:19.889] <TB0> INFO: test: HighRate no parameter change
[08:56:19.889] <TB0> INFO: running: highrate
[08:56:19.890] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//008_HREfficiency_250//phCalibrationFitErr35_C15.dat
[08:56:20.020] <TB0> INFO: ----------------------------------------------------------------------
[08:56:20.020] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:56:20.020] <TB0> INFO: ----------------------------------------------------------------------
[08:56:40.380] <TB0> INFO: Test took 20355ms.
[08:56:46.998] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:56:47.548] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:56:47.548] <TB0> INFO: number of red-efficiency pixels: 1463 1297 1148 2486 2776 3576 3533 3244 3161 2849 3392 3059 2244 1296 1017 1282
[08:56:47.548] <TB0> INFO: number of X-ray hits detected: 369286 398361 362276 591240 621475 790477 774712 712075 686305 657444 729098 590722 543784 327390 354527 347097
[08:56:47.548] <TB0> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:56:47.548] <TB0> INFO: number of Vcal hits detected: 206111 206386 205758 203132 201963 196994 196640 200572 200739 201533 198717 200481 204164 205278 206812 206418
[08:56:47.548] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.2 99.3 99.1 98.0 97.5 95.4 95.2 96.8 96.8 97.3 96.1 96.8 98.4 98.9 99.5 99.3
[08:56:47.548] <TB0> INFO: Vcal hit overall efficiency (%): 99.1 99.2 98.9 97.7 97.1 94.7 94.5 96.4 96.5 96.9 95.5 96.4 98.2 98.7 99.4 99.2
[08:56:47.548] <TB0> INFO: X-ray hit rate [MHz/cm2]: 108.2 116.8 106.2 173.3 182.2 231.7 227.1 208.7 201.2 192.7 213.7 173.1 159.4 96.0 103.9 101.7
[08:56:47.548] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[08:56:47.582] <TB0> INFO: PixTest:: pg_setup set to default.
[08:56:47.630] <TB0> INFO: enter test to run
[08:56:47.630] <TB0> INFO: test: no parameter change
[08:56:47.852] <TB0> QUIET: Connection to board 147 closed.
[08:56:47.937] <TB0> INFO: pXar: this is the end, my friend
commander_HRData.log
[08:57:20.439] <TB0> INFO: *** Welcome to pxar ***
[08:57:20.439] <TB0> INFO: *** Today: 2015/07/10
[08:57:20.439] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//dacParameters35_C15.dat
[08:57:20.440] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//tbmParameters_C0b.dat
[08:57:20.440] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//defaultMaskFile.dat
[08:57:20.440] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//trimParameters35_C15.dat
[08:57:20.507] <TB0> INFO: clk: 4
[08:57:20.507] <TB0> INFO: ctr: 4
[08:57:20.507] <TB0> INFO: sda: 19
[08:57:20.507] <TB0> INFO: tin: 9
[08:57:20.507] <TB0> INFO: level: 15
[08:57:20.507] <TB0> INFO: triggerdelay: 0
[08:57:20.507] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:57:20.507] <TB0> INFO: Log level: INFO
[08:57:20.520] <TB0> INFO: Found DTB DTB_WWXTQT
[08:57:20.529] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:57:20.532] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[08:57:20.535] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:57:22.077] <TB0> INFO: DUT info:
[08:57:22.077] <TB0> INFO: The DUT currently contains the following objects:
[08:57:22.077] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:57:22.077] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:57:22.077] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:57:22.077] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:57:22.077] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.077] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.078] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.078] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.078] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.078] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.078] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:57:22.478] <TB0> INFO: enter 'restricted' command line mode
[08:57:22.479] <TB0> INFO: enter test to run
[08:57:22.479] <TB0> INFO: test: delay setting parameters: ->5<-
[08:57:22.479] <TB0> INFO: delay test by 5 seconds...
[08:57:27.479] <TB0> INFO: enter test to run
[08:57:27.479] <TB0> INFO: test: Xray no parameter change
[08:57:27.479] <TB0> INFO: running: xray
[08:57:27.479] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//009_HRData_50//phCalibrationFitErr35_C15.dat
[08:57:27.606] <TB0> INFO: ######################################################################
[08:57:27.607] <TB0> INFO: PixTestXray::doTest()
[08:57:27.607] <TB0> INFO: ######################################################################
[08:57:27.607] <TB0> INFO: ----------------------------------------------------------------------
[08:57:27.607] <TB0> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[08:57:27.607] <TB0> INFO: ----------------------------------------------------------------------
[08:57:28.575] <TB0> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[08:57:35.286] <TB0> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[08:58:02.415] <TB0> INFO: Resuming triggers.
[08:58:09.137] <TB0> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[08:58:30.063] <TB0> INFO: Resuming triggers.
[08:58:36.776] <TB0> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[08:58:57.977] <TB0> INFO: Resuming triggers.
[08:59:04.686] <TB0> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[08:59:35.550] <TB0> INFO: Resuming triggers.
[08:59:42.261] <TB0> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[09:00:07.759] <TB0> INFO: Resuming triggers.
[09:00:14.470] <TB0> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[09:00:35.490] <TB0> INFO: Resuming triggers.
[09:00:42.201] <TB0> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[09:01:10.152] <TB0> INFO: Resuming triggers.
[09:01:16.859] <TB0> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[09:01:45.353] <TB0> INFO: Resuming triggers.
[09:01:52.068] <TB0> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[09:02:18.767] <TB0> INFO: Resuming triggers.
[09:02:25.479] <TB0> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[09:02:45.480] <TB0> INFO: Resuming triggers.
[09:02:52.192] <TB0> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[09:03:15.388] <TB0> INFO: Resuming triggers.
[09:03:22.099] <TB0> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[09:03:41.725] <TB0> INFO: Resuming triggers.
[09:03:48.437] <TB0> INFO: run duration 87 seconds, buffer almost full (81%), pausing triggers.
[09:04:14.136] <TB0> INFO: Resuming triggers.
[09:04:20.848] <TB0> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[09:04:46.896] <TB0> INFO: Resuming triggers.
[09:04:53.033] <TB0> INFO: data taking finished, elapsed time: 100 seconds.
[09:05:13.911] <TB0> INFO: PixTest:: pg_setup set to default.
[09:05:13.913] <TB0> INFO: PixTestXray::doPhRun() done
[09:05:13.913] <TB0> INFO: PixTestXray::doTest() done
[09:05:14.091] <TB0> INFO: enter test to run
[09:05:14.091] <TB0> INFO: test: no parameter change
[09:05:14.310] <TB0> QUIET: Connection to board 147 closed.
[09:05:14.391] <TB0> INFO: pXar: this is the end, my friend
commander_HRData.log
[09:05:51.082] <TB0> INFO: *** Welcome to pxar ***
[09:05:51.082] <TB0> INFO: *** Today: 2015/07/10
[09:05:51.082] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//dacParameters35_C15.dat
[09:05:51.083] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//tbmParameters_C0b.dat
[09:05:51.083] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//defaultMaskFile.dat
[09:05:51.083] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//trimParameters35_C15.dat
[09:05:51.152] <TB0> INFO: clk: 4
[09:05:51.152] <TB0> INFO: ctr: 4
[09:05:51.152] <TB0> INFO: sda: 19
[09:05:51.152] <TB0> INFO: tin: 9
[09:05:51.152] <TB0> INFO: level: 15
[09:05:51.152] <TB0> INFO: triggerdelay: 0
[09:05:51.152] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[09:05:51.152] <TB0> INFO: Log level: INFO
[09:05:51.166] <TB0> INFO: Found DTB DTB_WWXTQT
[09:05:51.174] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[09:05:51.177] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[09:05:51.180] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[09:05:52.722] <TB0> INFO: DUT info:
[09:05:52.722] <TB0> INFO: The DUT currently contains the following objects:
[09:05:52.722] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[09:05:52.722] <TB0> INFO: TBM Core alpha (0): 7 registers set
[09:05:52.723] <TB0> INFO: TBM Core beta (1): 7 registers set
[09:05:52.723] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:05:52.723] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:52.723] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:05:53.124] <TB0> INFO: enter 'restricted' command line mode
[09:05:53.124] <TB0> INFO: enter test to run
[09:05:53.124] <TB0> INFO: test: delay setting parameters: ->5<-
[09:05:53.124] <TB0> INFO: delay test by 5 seconds...
[09:05:58.124] <TB0> INFO: enter test to run
[09:05:58.124] <TB0> INFO: test: Xray no parameter change
[09:05:58.124] <TB0> INFO: running: xray
[09:05:58.124] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-10_10h45m_1436517912//010_HRData_150//phCalibrationFitErr35_C15.dat
[09:05:58.257] <TB0> INFO: ######################################################################
[09:05:58.257] <TB0> INFO: PixTestXray::doTest()
[09:05:58.257] <TB0> INFO: ######################################################################
[09:05:58.257] <TB0> INFO: ----------------------------------------------------------------------
[09:05:58.257] <TB0> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:05:58.257] <TB0> INFO: ----------------------------------------------------------------------
[09:05:59.225] <TB0> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:06:02.924] <TB0> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[09:06:31.869] <TB0> INFO: Resuming triggers.
[09:06:35.586] <TB0> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[09:06:39.766] <TB0> ERROR: <datapipe.cc/CheckEventValidity:L437> Number of ROCs (1) != Token Chain Length (4)

[09:06:39.767] <TB0> ERROR: <datapipe.cc/CheckEventID:L420> Event ID mismatch: local ID (110) != TBM ID (182)

[09:06:39.767] <TB0> ERROR: <datapipe.cc/CheckEventValidity:L437> Number of ROCs (2) != Token Chain Length (4)

[09:06:39.767] <TB0> ERROR: <datapipe.cc/CheckEventID:L420> Event ID mismatch: local ID (183) != TBM ID (110)

[09:06:39.767] <TB0> WARNING: ROC 0: Readback start marker after 17 readouts!

[09:06:39.767] <TB0> WARNING: ROC 2: Readback start marker after 15 readouts!

[09:06:39.767] <TB0> WARNING: ROC 3: Readback start marker after 15 readouts!

[09:07:03.992] <TB0> INFO: Resuming triggers.
[09:07:07.705] <TB0> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[09:07:38.391] <TB0> INFO: Resuming triggers.
[09:07:42.110] <TB0> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[09:08:08.520] <TB0> INFO: Resuming triggers.
[09:08:12.239] <TB0> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[09:08:38.570] <TB0> INFO: Resuming triggers.
[09:08:42.287] <TB0> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[09:09:12.564] <TB0> INFO: Resuming triggers.
[09:09:16.282] <TB0> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[09:09:40.801] <TB0> INFO: Resuming triggers.
[09:09:44.522] <TB0> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[09:10:05.913] <TB0> INFO: Resuming triggers.
[09:10:09.627] <TB0> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[09:10:34.109] <TB0> INFO: Resuming triggers.
[09:10:37.825] <TB0> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[09:11:03.092] <TB0> INFO: Resuming triggers.
[09:11:06.811] <TB0> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[09:11:33.095] <TB0> INFO: Resuming triggers.
[09:11:36.809] <TB0> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[09:12:03.685] <TB0> INFO: Resuming triggers.
[09:12:07.411] <TB0> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[09:12:28.939] <TB0> INFO: Resuming triggers.
[09:12:32.653] <TB0> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[09:12:56.563] <TB0> INFO: Resuming triggers.
[09:13:00.275] <TB0> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[09:13:24.197] <TB0> INFO: Resuming triggers.
[09:13:27.911] <TB0> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[09:13:52.522] <TB0> INFO: Resuming triggers.
[09:13:56.233] <TB0> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[09:14:21.120] <TB0> INFO: Resuming triggers.
[09:14:24.838] <TB0> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[09:14:51.982] <TB0> INFO: Resuming triggers.
[09:14:55.693] <TB0> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[09:15:25.245] <TB0> INFO: Resuming triggers.
[09:15:28.959] <TB0> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[09:15:53.075] <TB0> INFO: Resuming triggers.
[09:15:56.790] <TB0> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[09:16:18.656] <TB0> INFO: Resuming triggers.
[09:16:22.367] <TB0> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[09:16:46.164] <TB0> INFO: Resuming triggers.
[09:16:49.873] <TB0> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[09:17:11.368] <TB0> INFO: Resuming triggers.
[09:17:15.080] <TB0> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[09:17:36.005] <TB0> INFO: Resuming triggers.
[09:17:39.717] <TB0> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[09:18:02.325] <TB0> INFO: Resuming triggers.
[09:18:06.039] <TB0> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[09:18:30.172] <TB0> INFO: Resuming triggers.
[09:18:33.690] <TB0> INFO: data taking finished, elapsed time: 100 seconds.
[09:18:59.212] <TB0> INFO: PixTest:: pg_setup set to default.
[09:18:59.214] <TB0> INFO: PixTestXray::doPhRun() done
[09:18:59.214] <TB0> INFO: PixTestXray::doTest() done
[09:18:59.407] <TB0> INFO: enter test to run
[09:18:59.407] <TB0> INFO: test: no parameter change
[09:18:59.598] <TB0> QUIET: Connection to board 147 closed.
[09:18:59.678] <TB0> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[11:28:58.821] <TB0> INFO: *** Welcome to pxar ***
[11:28:58.821] <TB0> INFO: *** Today: 2015/07/17
[11:28:58.821] <TB0> INFO: readRocDacs: /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//dacParameters35_C15.dat
[11:28:58.821] <TB0> INFO: readTbmDacs: /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//tbmParameters_C0b.dat
[11:28:58.821] <TB0> INFO: readMaskFile: /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//defaultMaskFile.dat
[11:28:58.821] <TB0> INFO: readTrimFile: /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//trimParameters35_C15.dat
[11:28:58.888] <TB0> INFO: clk: 4
[11:28:58.888] <TB0> INFO: ctr: 4
[11:28:58.888] <TB0> INFO: sda: 19
[11:28:58.888] <TB0> INFO: tin: 9
[11:28:58.888] <TB0> INFO: level: 15
[11:28:58.888] <TB0> INFO: triggerdelay: 0
[11:28:58.888] <TB0> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[11:28:58.888] <TB0> INFO: Log level: INFO
[11:28:58.901] <TB0> INFO: Found DTB DTB_WWXTQT
[11:28:58.917] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[11:28:58.920] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:28:58.923] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[11:29:00.464] <TB0> INFO: DUT info:
[11:29:00.464] <TB0> INFO: The DUT currently contains the following objects:
[11:29:00.464] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[11:29:00.464] <TB0> INFO: TBM Core alpha (0): 7 registers set
[11:29:00.464] <TB0> INFO: TBM Core beta (1): 7 registers set
[11:29:00.464] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:29:00.464] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.464] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:29:00.865] <TB0> INFO: enter 'restricted' command line mode
[11:29:00.865] <TB0> INFO: enter test to run
[11:29:00.865] <TB0> INFO: test: Highrate no parameter change
[11:29:00.865] <TB0> INFO: running: highrate
[11:29:00.865] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2027_XrayQualification_2015-07-17_13h27m_1437132422//001_HRSCurves_100//phCalibrationFitErr35_C15.dat
[11:29:00.994] <TB0> INFO: ----------------------------------------------------------------------
[11:29:00.994] <TB0> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[11:29:00.994] <TB0> INFO: ----------------------------------------------------------------------
[11:29:01.000] <TB0> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 150 (1) hits flags = 384 (plus default)
[11:29:01.011] <TB0> INFO: dacScan step from 0 .. 0
[11:29:12.495] <TB0> INFO: Test took 11484ms.
[11:29:13.945] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:14.174] <TB0> INFO: dacScan step from 1 .. 1
[11:29:28.963] <TB0> INFO: Test took 14789ms.
[11:29:30.554] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:30.795] <TB0> INFO: dacScan step from 2 .. 2
[11:29:46.040] <TB0> INFO: Test took 15244ms.
[11:29:47.500] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:47.757] <TB0> INFO: dacScan step from 3 .. 3
[11:30:02.263] <TB0> INFO: Test took 14506ms.
[11:30:03.874] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:04.109] <TB0> INFO: dacScan step from 4 .. 4
[11:30:18.417] <TB0> INFO: Test took 14308ms.
[11:30:19.822] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:20.057] <TB0> INFO: dacScan step from 5 .. 5
[11:30:33.198] <TB0> INFO: Test took 13141ms.
[11:30:34.680] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:34.926] <TB0> INFO: dacScan step from 6 .. 6
[11:30:46.881] <TB0> INFO: Test took 11955ms.
[11:30:48.272] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:48.512] <TB0> INFO: dacScan step from 7 .. 7
[11:31:01.664] <TB0> INFO: Test took 13152ms.
[11:31:03.136] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:03.369] <TB0> INFO: dacScan step from 8 .. 8
[11:31:17.196] <TB0> INFO: Test took 13826ms.
[11:31:18.970] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:19.200] <TB0> INFO: dacScan step from 9 .. 9
[11:31:33.745] <TB0> INFO: Test took 14544ms.
[11:31:35.290] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:35.593] <TB0> INFO: dacScan step from 10 .. 10
[11:31:50.694] <TB0> INFO: Test took 15100ms.
[11:31:52.403] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:52.660] <TB0> INFO: dacScan step from 11 .. 11
[11:32:07.323] <TB0> INFO: Test took 14663ms.
[11:32:08.700] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:08.930] <TB0> INFO: dacScan step from 12 .. 12
[11:32:22.960] <TB0> INFO: Test took 14030ms.
[11:32:24.451] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:24.689] <TB0> INFO: dacScan step from 13 .. 13
[11:32:37.774] <TB0> INFO: Test took 13084ms.
[11:32:39.470] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:39.717] <TB0> INFO: dacScan step from 14 .. 14
[11:32:51.914] <TB0> INFO: Test took 12198ms.
[11:32:53.325] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:53.573] <TB0> INFO: dacScan step from 15 .. 15
[11:33:06.708] <TB0> INFO: Test took 13135ms.
[11:33:08.325] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:33:08.574] <TB0> INFO: dacScan step from 16 .. 16
[11:33:21.900] <TB0> INFO: Test took 13325ms.
[11:33:23.276] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:33:23.512] <TB0> INFO: dacScan step from 17 .. 17
[11:33:38.416] <TB0> INFO: Test took 14905ms.
[11:33:40.358] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:33:40.652] <TB0> INFO: dacScan step from 18 .. 18
[11:33:56.170] <TB0> INFO: Test took 15518ms.
[11:33:57.591] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:33:57.818] <TB0> INFO: dacScan step from 19 .. 19
[11:34:12.638] <TB0> INFO: Test took 14820ms.
[11:34:14.092] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:34:14.322] <TB0> INFO: dacScan step from 20 .. 20
[11:34:28.098] <TB0> INFO: Test took 13776ms.
[11:34:29.552] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:34:29.789] <TB0> INFO: dacScan step from 21 .. 21
[11:34:42.511] <TB0> INFO: Test took 12722ms.
[11:34:44.035] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:34:44.262] <TB0> INFO: dacScan step from 22 .. 22
[11:34:56.395] <TB0> INFO: Test took 12133ms.
[11:34:57.807] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:34:58.044] <TB0> INFO: dacScan step from 23 .. 23
[11:35:11.320] <TB0> INFO: Test took 13275ms.
[11:35:12.747] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:35:12.985] <TB0> INFO: dacScan step from 24 .. 24
[11:35:27.440] <TB0> INFO: Test took 14455ms.
[11:35:28.997] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:35:29.228] <TB0> INFO: dacScan step from 25 .. 25
[11:35:43.737] <TB0> INFO: Test took 14509ms.
[11:35:45.158] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:35:45.388] <TB0> INFO: dacScan step from 26 .. 26
[11:35:59.031] <TB0> INFO: Test took 13642ms.
[11:36:00.508] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:00.743] <TB0> INFO: dacScan step from 27 .. 27
[11:36:13.788] <TB0> INFO: Test took 13044ms.
[11:36:15.259] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:15.496] <TB0> INFO: dacScan step from 28 .. 28
[11:36:27.622] <TB0> INFO: Test took 12125ms.
[11:36:29.543] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:29.786] <TB0> INFO: dacScan step from 29 .. 29
[11:36:42.450] <TB0> INFO: Test took 12663ms.
[11:36:43.944] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:44.183] <TB0> INFO: dacScan step from 30 .. 30
[11:36:57.831] <TB0> INFO: Test took 13648ms.
[11:36:59.259] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:59.503] <TB0> INFO: dacScan step from 31 .. 31
[11:37:14.030] <TB0> INFO: Test took 14526ms.
[11:37:15.420] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:37:15.653] <TB0> INFO: dacScan step from 32 .. 32
[11:37:30.526] <TB0> INFO: Test took 14872ms.
[11:37:32.121] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:37:32.358] <TB0> INFO: dacScan step from 33 .. 33
[11:37:46.493] <TB0> INFO: Test took 14134ms.
[11:37:47.926] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:37:48.162] <TB0> INFO: dacScan step from 34 .. 34
[11:38:02.113] <TB0> INFO: Test took 13951ms.
[11:38:03.542] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:38:03.792] <TB0> INFO: dacScan step from 35 .. 35
[11:38:16.688] <TB0> INFO: Test took 12896ms.
[11:38:18.248] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:38:18.496] <TB0> INFO: dacScan step from 36 .. 36
[11:38:31.191] <TB0> INFO: Test took 12694ms.
[11:38:32.733] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:38:32.979] <TB0> INFO: dacScan step from 37 .. 37
[11:38:46.702] <TB0> INFO: Test took 13723ms.
[11:38:48.232] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:38:48.482] <TB0> INFO: dacScan step from 38 .. 38
[11:39:03.409] <TB0> INFO: Test took 14926ms.
[11:39:04.913] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:39:05.161] <TB0> INFO: dacScan step from 39 .. 39
[11:39:21.284] <TB0> INFO: Test took 16123ms.
[11:39:22.803] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:39:23.041] <TB0> INFO: dacScan step from 40 .. 40
[11:39:38.660] <TB0> INFO: Test took 15618ms.
[11:39:40.139] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:39:40.376] <TB0> INFO: dacScan step from 41 .. 41
[11:39:56.986] <TB0> INFO: Test took 16609ms.
[11:39:58.878] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:39:59.172] <TB0> INFO: dacScan step from 42 .. 42
[11:40:15.458] <TB0> INFO: Test took 16286ms.
[11:40:17.076] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:40:17.345] <TB0> INFO: dacScan step from 43 .. 43
[11:40:33.937] <TB0> INFO: Test took 16591ms.
[11:40:35.590] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:40:35.853] <TB0> INFO: dacScan step from 44 .. 44
[11:40:53.015] <TB0> INFO: Test took 17161ms.
[11:40:54.629] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:40:54.867] <TB0> INFO: dacScan step from 45 .. 45
[11:41:12.648] <TB0> INFO: Test took 17781ms.
[11:41:14.172] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:41:14.426] <TB0> INFO: dacScan step from 46 .. 46
[11:41:32.032] <TB0> INFO: Test took 17605ms.
[11:41:33.656] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:41:33.900] <TB0> INFO: dacScan step from 47 .. 47
[11:41:50.995] <TB0> INFO: Test took 17095ms.
[11:41:52.532] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:41:52.773] <TB0> INFO: dacScan step from 48 .. 48
[11:42:09.620] <TB0> INFO: Test took 16847ms.
[11:42:11.170] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:42:11.414] <TB0> INFO: dacScan step from 49 .. 49
[11:42:28.198] <TB0> INFO: Test took 16783ms.
[11:42:29.823] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:42:30.061] <TB0> INFO: dacScan step from 50 .. 50
[11:42:46.552] <TB0> INFO: Test took 16490ms.
[11:42:48.219] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:42:48.479] <TB0> INFO: dacScan step from 51 .. 51
[11:43:04.083] <TB0> INFO: Test took 15604ms.
[11:43:05.721] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:43:05.983] <TB0> INFO: dacScan step from 52 .. 52
[11:43:21.827] <TB0> INFO: Test took 15843ms.
[11:43:23.465] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:43:23.703] <TB0> INFO: dacScan step from 53 .. 53
[11:43:38.914] <TB0> INFO: Test took 15210ms.
[11:43:40.521] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:43:40.764] <TB0> INFO: dacScan step from 54 .. 54
[11:43:57.070] <TB0> INFO: Test took 16305ms.
[11:43:58.637] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:43:58.876] <TB0> INFO: dacScan step from 55 .. 55
[11:44:16.490] <TB0> INFO: Test took 17614ms.
[11:44:18.065] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:44:18.322] <TB0> INFO: dacScan step from 56 .. 56
[11:44:36.748] <TB0> INFO: Test took 18426ms.
[11:44:38.350] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:44:38.595] <TB0> INFO: dacScan step from 57 .. 57
[11:44:56.476] <TB0> INFO: Test took 17880ms.
[11:44:58.067] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:44:58.317] <TB0> INFO: dacScan step from 58 .. 58
[11:45:15.395] <TB0> INFO: Test took 17077ms.
[11:45:16.964] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:45:17.211] <TB0> INFO: dacScan step from 59 .. 59
[11:45:34.158] <TB0> INFO: Test took 16946ms.
[11:45:35.748] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:45:36.015] <TB0> INFO: dacScan step from 60 .. 60
[11:45:50.780] <TB0> INFO: Test took 14765ms.
[11:45:52.434] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:45:52.690] <TB0> INFO: dacScan step from 61 .. 61
[11:46:08.578] <TB0> INFO: Test took 15887ms.
[11:46:10.187] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:46:10.439] <TB0> INFO: dacScan step from 62 .. 62
[11:46:27.056] <TB0> INFO: Test took 16616ms.
[11:46:28.643] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:46:28.893] <TB0> INFO: dacScan step from 63 .. 63
[11:46:46.972] <TB0> INFO: Test took 18079ms.
[11:46:49.169] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:46:49.465] <TB0> INFO: dacScan step from 64 .. 64
[11:47:07.673] <TB0> INFO: Test took 18207ms.
[11:47:09.417] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:09.683] <TB0> INFO: dacScan step from 65 .. 65
[11:47:27.779] <TB0> INFO: Test took 18095ms.
[11:47:29.498] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:29.755] <TB0> INFO: dacScan step from 66 .. 66
[11:47:47.129] <TB0> INFO: Test took 17375ms.
[11:47:48.792] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:49.043] <TB0> INFO: dacScan step from 67 .. 67
[11:48:05.837] <TB0> INFO: Test took 16793ms.
[11:48:07.429] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:07.673] <TB0> INFO: dacScan step from 68 .. 68
[11:48:23.527] <TB0> INFO: Test took 15853ms.
[11:48:25.100] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:25.343] <TB0> INFO: dacScan step from 69 .. 69
[11:48:40.948] <TB0> INFO: Test took 15604ms.
[11:48:42.601] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:42.861] <TB0> INFO: dacScan step from 70 .. 70
[11:48:59.222] <TB0> INFO: Test took 16360ms.
[11:49:00.862] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:01.127] <TB0> INFO: dacScan step from 71 .. 71
[11:49:17.592] <TB0> INFO: Test took 16464ms.
[11:49:19.222] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:19.477] <TB0> INFO: dacScan step from 72 .. 72
[11:49:37.512] <TB0> INFO: Test took 18034ms.
[11:49:39.228] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:39.496] <TB0> INFO: dacScan step from 73 .. 73
[11:49:57.616] <TB0> INFO: Test took 18120ms.
[11:49:59.290] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:59.667] <TB0> INFO: dacScan step from 74 .. 74
[11:50:17.179] <TB0> INFO: Test took 17511ms.
[11:50:18.784] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:19.035] <TB0> INFO: dacScan step from 75 .. 75
[11:50:36.023] <TB0> INFO: Test took 16988ms.
[11:50:37.618] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:37.865] <TB0> INFO: dacScan step from 76 .. 76
[11:50:53.751] <TB0> INFO: Test took 15886ms.
[11:50:55.315] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:55.557] <TB0> INFO: dacScan step from 77 .. 77
[11:51:11.374] <TB0> INFO: Test took 15816ms.
[11:51:12.932] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:13.174] <TB0> INFO: dacScan step from 78 .. 78
[11:51:29.058] <TB0> INFO: Test took 15884ms.
[11:51:30.648] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:30.895] <TB0> INFO: dacScan step from 79 .. 79
[11:51:47.906] <TB0> INFO: Test took 17010ms.
[11:51:49.495] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:49.742] <TB0> INFO: dacScan step from 80 .. 80
[11:52:07.507] <TB0> INFO: Test took 17764ms.
[11:52:09.114] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:52:09.388] <TB0> INFO: dacScan step from 81 .. 81
[11:52:26.956] <TB0> INFO: Test took 17567ms.
[11:52:28.560] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:52:28.799] <TB0> INFO: dacScan step from 82 .. 82
[11:52:46.718] <TB0> INFO: Test took 17918ms.
[11:52:48.380] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:52:48.639] <TB0> INFO: dacScan step from 83 .. 83
[11:53:06.262] <TB0> INFO: Test took 17622ms.
[11:53:07.889] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:08.144] <TB0> INFO: dacScan step from 84 .. 84
[11:53:24.431] <TB0> INFO: Test took 16286ms.
[11:53:26.116] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:26.379] <TB0> INFO: dacScan step from 85 .. 85
[11:53:42.565] <TB0> INFO: Test took 16185ms.
[11:53:44.172] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:44.414] <TB0> INFO: dacScan step from 86 .. 86
[11:53:59.878] <TB0> INFO: Test took 15463ms.
[11:54:01.459] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:54:01.718] <TB0> INFO: dacScan step from 87 .. 87
[11:54:18.706] <TB0> INFO: Test took 16988ms.
[11:54:20.359] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:54:20.614] <TB0> INFO: dacScan step from 88 .. 88
[11:54:37.405] <TB0> INFO: Test took 16791ms.
[11:54:39.042] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:54:39.302] <TB0> INFO: dacScan step from 89 .. 89
[11:54:56.860] <TB0> INFO: Test took 17557ms.
[11:54:58.552] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:54:58.841] <TB0> INFO: dacScan step from 90 .. 90
[11:55:15.786] <TB0> INFO: Test took 16943ms.
[11:55:17.429] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:55:17.688] <TB0> INFO: dacScan step from 91 .. 91
[11:55:34.345] <TB0> INFO: Test took 16656ms.
[11:55:35.984] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:55:36.228] <TB0> INFO: dacScan step from 92 .. 92
[11:55:52.487] <TB0> INFO: Test took 16258ms.
[11:55:54.144] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:55:54.404] <TB0> INFO: dacScan step from 93 .. 93
[11:56:10.354] <TB0> INFO: Test took 15949ms.
[11:56:12.043] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:12.306] <TB0> INFO: dacScan step from 94 .. 94
[11:56:28.213] <TB0> INFO: Test took 15906ms.
[11:56:29.795] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:30.038] <TB0> INFO: dacScan step from 95 .. 95
[11:56:47.039] <TB0> INFO: Test took 17000ms.
[11:56:48.686] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:48.945] <TB0> INFO: dacScan step from 96 .. 96
[11:57:06.996] <TB0> INFO: Test took 18050ms.
[11:57:08.666] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:57:08.924] <TB0> INFO: dacScan step from 97 .. 97
[11:57:28.043] <TB0> INFO: Test took 19118ms.
[11:57:30.038] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:57:30.278] <TB0> INFO: dacScan step from 98 .. 98
[11:57:49.036] <TB0> INFO: Test took 18757ms.
[11:57:50.740] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:57:50.985] <TB0> INFO: dacScan step from 99 .. 99
[11:58:09.091] <TB0> INFO: Test took 18105ms.
[11:58:10.657] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:58:10.900] <TB0> INFO: dacScan step from 100 .. 100
[11:58:27.466] <TB0> INFO: Test took 16565ms.
[11:58:29.030] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:58:29.272] <TB0> INFO: dacScan step from 101 .. 101
[11:58:44.282] <TB0> INFO: Test took 15009ms.
[11:58:45.831] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:58:46.094] <TB0> INFO: dacScan step from 102 .. 102
[11:59:02.241] <TB0> INFO: Test took 16146ms.
[11:59:03.878] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:59:04.120] <TB0> INFO: dacScan step from 103 .. 103
[11:59:21.493] <TB0> INFO: Test took 17372ms.
[11:59:23.131] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:59:23.381] <TB0> INFO: dacScan step from 104 .. 104
[11:59:40.933] <TB0> INFO: Test took 17551ms.
[11:59:42.499] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:59:42.738] <TB0> INFO: dacScan step from 105 .. 105
[12:00:01.155] <TB0> INFO: Test took 18416ms.
[12:00:02.992] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:03.250] <TB0> INFO: dacScan step from 106 .. 106
[12:00:20.661] <TB0> INFO: Test took 17410ms.
[12:00:22.307] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:22.563] <TB0> INFO: dacScan step from 107 .. 107
[12:00:38.972] <TB0> INFO: Test took 16408ms.
[12:00:40.572] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:40.825] <TB0> INFO: dacScan step from 108 .. 108
[12:00:56.435] <TB0> INFO: Test took 15608ms.
[12:00:58.086] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:58.348] <TB0> INFO: dacScan step from 109 .. 109
[12:01:14.669] <TB0> INFO: Test took 16320ms.
[12:01:16.322] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:01:16.575] <TB0> INFO: dacScan step from 110 .. 110
[12:01:33.314] <TB0> INFO: Test took 16738ms.
[12:01:34.911] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:01:35.158] <TB0> INFO: dacScan step from 111 .. 111
[12:01:52.928] <TB0> INFO: Test took 17769ms.
[12:01:54.508] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:01:54.753] <TB0> INFO: dacScan step from 112 .. 112
[12:02:12.980] <TB0> INFO: Test took 18225ms.
[12:02:14.643] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:14.903] <TB0> INFO: dacScan step from 113 .. 113
[12:02:33.787] <TB0> INFO: Test took 18883ms.
[12:02:35.364] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:35.605] <TB0> INFO: dacScan step from 114 .. 114
[12:02:53.893] <TB0> INFO: Test took 18287ms.
[12:02:55.470] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:55.710] <TB0> INFO: dacScan step from 115 .. 115
[12:03:13.333] <TB0> INFO: Test took 17622ms.
[12:03:14.906] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:03:15.147] <TB0> INFO: dacScan step from 116 .. 116
[12:03:31.911] <TB0> INFO: Test took 16763ms.
[12:03:33.562] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:03:33.821] <TB0> INFO: dacScan step from 117 .. 117
[12:03:49.635] <TB0> INFO: Test took 15813ms.
[12:03:51.347] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:03:51.609] <TB0> INFO: dacScan step from 118 .. 118
[12:04:07.928] <TB0> INFO: Test took 16317ms.
[12:04:09.514] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:04:09.758] <TB0> INFO: dacScan step from 119 .. 119
[12:04:27.126] <TB0> INFO: Test took 17367ms.
[12:04:28.781] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:04:29.042] <TB0> INFO: dacScan step from 120 .. 120
[12:04:47.370] <TB0> INFO: Test took 18327ms.
[12:04:49.045] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:04:49.303] <TB0> INFO: dacScan step from 121 .. 121
[12:05:08.040] <TB0> INFO: Test took 18736ms.
[12:05:09.631] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:05:09.932] <TB0> INFO: dacScan step from 122 .. 122
[12:05:28.611] <TB0> INFO: Test took 18678ms.
[12:05:30.329] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:05:30.578] <TB0> INFO: dacScan step from 123 .. 123
[12:05:48.709] <TB0> INFO: Test took 18130ms.
[12:05:50.294] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:05:50.538] <TB0> INFO: dacScan step from 124 .. 124
[12:06:07.850] <TB0> INFO: Test took 17310ms.
[12:06:09.595] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:06:09.855] <TB0> INFO: dacScan step from 125 .. 125
[12:06:25.895] <TB0> INFO: Test took 16039ms.
[12:06:27.585] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:06:27.848] <TB0> INFO: dacScan step from 126 .. 126
[12:06:43.780] <TB0> INFO: Test took 15930ms.
[12:06:45.479] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:06:45.740] <TB0> INFO: dacScan step from 127 .. 127
[12:07:01.520] <TB0> INFO: Test took 15779ms.
[12:07:03.116] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:07:03.355] <TB0> INFO: dacScan step from 128 .. 128
[12:07:20.619] <TB0> INFO: Test took 17263ms.
[12:07:22.243] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:07:22.503] <TB0> INFO: dacScan step from 129 .. 129
[12:07:41.273] <TB0> INFO: Test took 18768ms.
[12:07:42.914] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:07:43.169] <TB0> INFO: dacScan step from 130 .. 130
[12:08:01.968] <TB0> INFO: Test took 18798ms.
[12:08:03.771] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:08:04.041] <TB0> INFO: dacScan step from 131 .. 131
[12:08:22.497] <TB0> INFO: Test took 18454ms.
[12:08:24.162] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:08:24.411] <TB0> INFO: dacScan step from 132 .. 132
[12:08:42.230] <TB0> INFO: Test took 17817ms.
[12:08:43.908] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:08:44.160] <TB0> INFO: dacScan step from 133 .. 133
[12:09:01.422] <TB0> INFO: Test took 17260ms.
[12:09:03.315] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:09:03.582] <TB0> INFO: dacScan step from 134 .. 134
[12:09:20.123] <TB0> INFO: Test took 16540ms.
[12:09:21.803] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:09:22.054] <TB0> INFO: dacScan step from 135 .. 135
[12:09:38.516] <TB0> INFO: Test took 16461ms.
[12:09:40.053] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:09:40.293] <TB0> INFO: dacScan step from 136 .. 136
[12:09:56.076] <TB0> INFO: Test took 15782ms.
[12:09:57.700] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:09:57.963] <TB0> INFO: dacScan step from 137 .. 137
[12:10:15.712] <TB0> INFO: Test took 17747ms.
[12:10:17.316] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:10:17.562] <TB0> INFO: dacScan step from 138 .. 138
[12:10:35.346] <TB0> INFO: Test took 17782ms.
[12:10:37.031] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:10:37.319] <TB0> INFO: dacScan step from 139 .. 139
[12:10:55.527] <TB0> INFO: Test took 18206ms.
[12:10:57.199] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:10:57.462] <TB0> INFO: dacScan step from 140 .. 140
[12:11:14.211] <TB0> INFO: Test took 16747ms.
[12:11:15.877] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:16.140] <TB0> INFO: dacScan step from 141 .. 141
[12:11:32.594] <TB0> INFO: Test took 16453ms.
[12:11:34.164] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:34.403] <TB0> INFO: dacScan step from 142 .. 142
[12:11:49.679] <TB0> INFO: Test took 15274ms.
[12:11:51.301] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:51.548] <TB0> INFO: dacScan step from 143 .. 143
[12:12:07.568] <TB0> INFO: Test took 16019ms.
[12:12:09.218] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:12:09.479] <TB0> INFO: dacScan step from 144 .. 144
[12:12:26.501] <TB0> INFO: Test took 17020ms.
[12:12:28.252] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:12:28.492] <TB0> INFO: dacScan step from 145 .. 145
[12:12:45.151] <TB0> INFO: Test took 16658ms.
[12:12:47.628] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:12:48.010] <TB0> INFO: dacScan step from 146 .. 146
[12:13:05.427] <TB0> INFO: Test took 17415ms.
[12:13:07.075] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:07.316] <TB0> INFO: dacScan step from 147 .. 147
[12:13:25.037] <TB0> INFO: Test took 17719ms.
[12:13:26.706] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:26.950] <TB0> INFO: dacScan step from 148 .. 148
[12:13:45.035] <TB0> INFO: Test took 18083ms.
[12:13:46.612] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:46.855] <TB0> INFO: dacScan step from 149 .. 149
[12:14:04.107] <TB0> INFO: Test took 17251ms.
[12:14:05.850] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:06.120] <TB0> INFO: dacScan step from 150 .. 150
[12:14:22.497] <TB0> INFO: Test took 16375ms.
[12:14:24.050] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:24.293] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:25.975] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:27.636] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:29.278] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:31.004] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:32.733] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:34.471] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:36.180] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:37.896] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:39.607] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:41.333] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:43.210] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:44.964] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:46.668] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:48.291] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:49.943] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[12:14:51.577] <TB0> INFO: PixTest:: pg_setup set to default.
[12:14:51.579] <TB0> INFO: vcal mean: 37.38 37.93 37.03 40.07 40.49 42.16 41.66 41.05 41.61 40.90 42.07 40.83 40.33 37.49 38.03 37.60
[12:14:51.579] <TB0> INFO: vcal RMS: 1.23 1.32 1.18 1.51 1.35 1.42 1.58 1.55 1.57 1.54 1.63 1.54 1.34 1.26 1.15 1.24
[12:14:51.579] <TB0> INFO: number of X-ray hits detected: 184727 199855 178158 305327 314659 404839 390253 362158 345389 332221 372526 301411 273718 160289 173362 172323
[12:14:51.579] <TB0> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:14:51.579] <TB0> INFO: X-ray hit rate [MHz/cm2]: 54.1 58.6 52.2 89.5 92.2 118.7 114.4 106.2 101.2 97.4 109.2 88.3 80.2 47.0 50.8 50.5
[12:14:51.579] <TB0> INFO: PixTestHighRate::doXNoiseMaps() done
[12:14:51.732] <TB0> INFO: enter test to run
[12:14:51.732] <TB0> INFO: test: no parameter change
[12:14:51.931] <TB0> QUIET: Connection to board 147 closed.
[12:14:52.012] <TB0> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master