Test Date: 2015-08-11 09:36
Analysis date: 2016-05-25 23:53
Logfile
commander_PixelAlive.log
[07:37:02.333] <TB0> INFO: *** Welcome to pxar ***
[07:37:02.333] <TB0> INFO: *** Today: 2015/08/11
[07:37:02.333] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//000_PixelAlive_p17//dacParameters35_C15.dat
[07:37:02.334] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//000_PixelAlive_p17//tbmParameters_C0b.dat
[07:37:02.334] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//000_PixelAlive_p17//defaultMaskFile.dat
[07:37:02.334] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//000_PixelAlive_p17//trimParameters35_C15.dat
[07:37:02.399] <TB0> INFO: clk: 4
[07:37:02.399] <TB0> INFO: ctr: 4
[07:37:02.399] <TB0> INFO: sda: 19
[07:37:02.399] <TB0> INFO: tin: 9
[07:37:02.399] <TB0> INFO: level: 15
[07:37:02.399] <TB0> INFO: triggerdelay: 0
[07:37:02.399] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[07:37:02.399] <TB0> INFO: Log level: INFO
[07:37:02.413] <TB0> INFO: Found DTB DTB_WWXTQT
[07:37:02.426] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[07:37:02.429] <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:
------------------------------------------------------
[07:37:02.431] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[07:37:03.944] <TB0> INFO: DUT info:
[07:37:03.944] <TB0> INFO: The DUT currently contains the following objects:
[07:37:03.944] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[07:37:03.944] <TB0> INFO: TBM Core alpha (0): 7 registers set
[07:37:03.944] <TB0> INFO: TBM Core beta (1): 7 registers set
[07:37:03.944] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:37:03.944] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:03.944] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:04.345] <TB0> INFO: enter 'restricted' command line mode
[07:37:04.345] <TB0> INFO: enter test to run
[07:37:04.345] <TB0> INFO: test: PixelAlive no parameter change
[07:37:04.345] <TB0> INFO: running: pixelalive
[07:37:04.350] <TB0> INFO: ######################################################################
[07:37:04.350] <TB0> INFO: PixTestAlive::doTest()
[07:37:04.350] <TB0> INFO: ######################################################################
[07:37:04.351] <TB0> INFO: ----------------------------------------------------------------------
[07:37:04.351] <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)
[07:37:04.351] <TB0> INFO: ----------------------------------------------------------------------
[07:37:07.658] <TB0> INFO: Test took 3305ms.
[07:37:07.676] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:37:07.925] <TB0> INFO: PixTestAlive::aliveTest() done
[07:37:07.925] <TB0> INFO: number of dead pixels (per ROC): 0 1 0 0 0 1 1 0 0 0 0 1 0 0 1 0
[07:37:07.927] <TB0> INFO: ----------------------------------------------------------------------
[07:37:07.927] <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)
[07:37:07.927] <TB0> INFO: ----------------------------------------------------------------------
[07:37:10.558] <TB0> INFO: Test took 2630ms.
[07:37:10.559] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:37:10.560] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[07:37:10.783] <TB0> INFO: PixTestAlive::maskTest() done
[07:37:10.783] <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
[07:37:10.784] <TB0> INFO: ----------------------------------------------------------------------
[07:37:10.784] <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)
[07:37:10.784] <TB0> INFO: ----------------------------------------------------------------------
[07:37:14.318] <TB0> INFO: Test took 3532ms.
[07:37:14.335] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:37:14.568] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[07:37:14.568] <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
[07:37:14.568] <TB0> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[07:37:14.610] <TB0> INFO: enter test to run
[07:37:14.610] <TB0> INFO: test: no parameter change
[07:37:14.750] <TB0> QUIET: Connection to board 147 closed.
[07:37:14.830] <TB0> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[07:42:30.645] <TB0> INFO: *** Welcome to pxar ***
[07:42:30.645] <TB0> INFO: *** Today: 2015/08/11
[07:42:30.645] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//dacParameters35_C15.dat
[07:42:30.645] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[07:42:30.645] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//defaultMaskFile.dat
[07:42:30.645] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C15.dat
[07:42:30.711] <TB0> INFO: clk: 4
[07:42:30.711] <TB0> INFO: ctr: 4
[07:42:30.711] <TB0> INFO: sda: 19
[07:42:30.711] <TB0> INFO: tin: 9
[07:42:30.711] <TB0> INFO: level: 15
[07:42:30.711] <TB0> INFO: triggerdelay: 0
[07:42:30.711] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[07:42:30.711] <TB0> INFO: Log level: INFO
[07:42:31.721] <TB0> INFO: Found DTB DTB_WWXTQT
[07:42:34.732] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[07:42:34.735] <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:
------------------------------------------------------
[07:42:34.738] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[07:42:36.250] <TB0> INFO: DUT info:
[07:42:36.250] <TB0> INFO: The DUT currently contains the following objects:
[07:42:36.250] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[07:42:36.250] <TB0> INFO: TBM Core alpha (0): 7 registers set
[07:42:36.250] <TB0> INFO: TBM Core beta (1): 7 registers set
[07:42:36.250] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:42:36.250] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.250] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:42:36.651] <TB0> INFO: enter 'restricted' command line mode
[07:42:36.651] <TB0> INFO: enter test to run
[07:42:36.651] <TB0> INFO: test: delay setting parameters: ->5<-
[07:42:36.651] <TB0> INFO: delay test by 5 seconds...
[07:42:41.651] <TB0> INFO: enter test to run
[07:42:41.652] <TB0> INFO: test: highrate no parameter change
[07:42:41.652] <TB0> INFO: running: highrate
[07:42:41.652] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[07:42:41.791] <TB0> INFO: ----------------------------------------------------------------------
[07:42:41.791] <TB0> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[07:42:41.791] <TB0> INFO: ----------------------------------------------------------------------
[07:42:41.791] <TB0> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[07:42:41.791] <TB0> INFO: edge/corner pixel THR is adjusted
[07:42:41.791] <TB0> INFO: PixTestHighRate::trimHotPixels: step 0...
[07:42:42.753] <TB0> INFO: Collecting data for 1 seconds...
[07:42:43.755] <TB0> INFO: Done with hot pixel readout
[07:42:48.956] <TB0> INFO: PixTest:: pg_setup set to default.
[07:42:48.957] <TB0> INFO: 6 hot pixels found in step 0
[07:42:49.919] <TB0> INFO: Collecting data for 1 seconds...
[07:42:50.921] <TB0> INFO: Done with hot pixel readout
[07:42:56.997] <TB0> INFO: PixTest:: pg_setup set to default.
[07:42:56.998] <TB0> INFO: 4 hot pixels found in step 1
[07:42:57.961] <TB0> INFO: Collecting data for 1 seconds...
[07:42:58.963] <TB0> INFO: Done with hot pixel readout
[07:43:05.058] <TB0> INFO: PixTest:: pg_setup set to default.
[07:43:05.059] <TB0> INFO: 2 hot pixels found in step 2
[07:43:06.022] <TB0> INFO: Collecting data for 1 seconds...
[07:43:07.024] <TB0> INFO: Done with hot pixel readout
[07:43:13.164] <TB0> INFO: PixTest:: pg_setup set to default.
[07:43:13.165] <TB0> INFO: 0 hot pixels found in step 3
[07:43:13.174] <TB0> INFO: 0 hot pixels could not be trimmed and have been masked.
[07:43:13.206] <TB0> INFO: PixTest::trimHotPixels() done
[07:43:13.206] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C0.dat
[07:43:13.215] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C1.dat
[07:43:13.222] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C2.dat
[07:43:13.229] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C3.dat
[07:43:13.236] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C4.dat
[07:43:13.244] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C5.dat
[07:43:13.251] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C6.dat
[07:43:13.258] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C7.dat
[07:43:13.265] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C8.dat
[07:43:13.272] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C9.dat
[07:43:13.279] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C10.dat
[07:43:13.287] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C11.dat
[07:43:13.294] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C12.dat
[07:43:13.301] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C13.dat
[07:43:13.308] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C14.dat
[07:43:13.316] <TB0> INFO: write trim parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//trimParameters35_C15.dat
[07:43:13.323] <TB0> INFO: write masked pixels into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//002_RetrimHotPixels_150//defaultMaskFile.dat
[07:43:13.359] <TB0> INFO: enter test to run
[07:43:13.359] <TB0> INFO: test: no parameter change
[07:43:13.544] <TB0> QUIET: Connection to board 147 closed.
[07:43:13.623] <TB0> INFO: pXar: this is the end, my friend
commander_HRData.log
[07:43:53.543] <TB0> INFO: *** Welcome to pxar ***
[07:43:53.543] <TB0> INFO: *** Today: 2015/08/11
[07:43:53.543] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//dacParameters35_C15.dat
[07:43:53.544] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//tbmParameters_C0b.dat
[07:43:53.544] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//defaultMaskFile.dat
[07:43:53.544] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//trimParameters35_C15.dat
[07:43:53.608] <TB0> INFO: clk: 4
[07:43:53.608] <TB0> INFO: ctr: 4
[07:43:53.608] <TB0> INFO: sda: 19
[07:43:53.608] <TB0> INFO: tin: 9
[07:43:53.608] <TB0> INFO: level: 15
[07:43:53.608] <TB0> INFO: triggerdelay: 0
[07:43:53.608] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[07:43:53.608] <TB0> INFO: Log level: INFO
[07:43:54.618] <TB0> INFO: Found DTB DTB_WWXTQT
[07:43:57.629] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[07:43:57.632] <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:
------------------------------------------------------
[07:43:57.635] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[07:43:59.148] <TB0> INFO: DUT info:
[07:43:59.148] <TB0> INFO: The DUT currently contains the following objects:
[07:43:59.148] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[07:43:59.148] <TB0> INFO: TBM Core alpha (0): 7 registers set
[07:43:59.148] <TB0> INFO: TBM Core beta (1): 7 registers set
[07:43:59.148] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:43:59.148] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.148] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:43:59.549] <TB0> INFO: enter 'restricted' command line mode
[07:43:59.549] <TB0> INFO: enter test to run
[07:43:59.549] <TB0> INFO: test: delay setting parameters: ->5<-
[07:43:59.549] <TB0> INFO: delay test by 5 seconds...
[07:44:04.549] <TB0> INFO: enter test to run
[07:44:04.549] <TB0> INFO: test: Xray no parameter change
[07:44:04.549] <TB0> INFO: running: xray
[07:44:04.550] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//003_HRData_50//phCalibrationFitErr35_C15.dat
[07:44:04.682] <TB0> INFO: ######################################################################
[07:44:04.682] <TB0> INFO: PixTestXray::doTest()
[07:44:04.682] <TB0> INFO: ######################################################################
[07:44:04.682] <TB0> INFO: ----------------------------------------------------------------------
[07:44:04.682] <TB0> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[07:44:04.682] <TB0> INFO: ----------------------------------------------------------------------
[07:44:05.653] <TB0> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[07:44:12.289] <TB0> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[07:44:38.939] <TB0> INFO: Resuming triggers.
[07:44:45.586] <TB0> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[07:44:50.229] <TB0> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[07:44:50.229] <TB0> WARNING: Channel 3 ROC 3: Readback start marker after 15 readouts!

[07:45:09.332] <TB0> INFO: Resuming triggers.
[07:45:15.979] <TB0> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[07:45:38.620] <TB0> INFO: Resuming triggers.
[07:45:45.269] <TB0> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[07:46:11.158] <TB0> INFO: Resuming triggers.
[07:46:17.806] <TB0> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[07:46:38.209] <TB0> INFO: Resuming triggers.
[07:46:44.856] <TB0> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[07:47:10.046] <TB0> INFO: Resuming triggers.
[07:47:16.697] <TB0> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[07:47:44.989] <TB0> INFO: Resuming triggers.
[07:47:51.641] <TB0> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[07:48:18.873] <TB0> INFO: Resuming triggers.
[07:48:25.525] <TB0> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[07:48:51.269] <TB0> INFO: Resuming triggers.
[07:48:57.923] <TB0> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[07:49:25.585] <TB0> INFO: Resuming triggers.
[07:49:32.239] <TB0> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[07:49:56.807] <TB0> INFO: Resuming triggers.
[07:50:03.461] <TB0> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[07:50:28.719] <TB0> INFO: Resuming triggers.
[07:50:35.371] <TB0> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[07:51:00.044] <TB0> INFO: Resuming triggers.
[07:51:06.696] <TB0> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[07:51:30.373] <TB0> INFO: Resuming triggers.
[07:51:37.028] <TB0> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[07:52:00.109] <TB0> INFO: Resuming triggers.
[07:52:00.483] <TB0> INFO: data taking finished, elapsed time: 100 seconds.
[07:52:02.052] <TB0> INFO: PixTest:: pg_setup set to default.
[07:52:02.053] <TB0> INFO: PixTestXray::doPhRun() done
[07:52:02.053] <TB0> INFO: PixTestXray::doTest() done
[07:52:02.301] <TB0> INFO: enter test to run
[07:52:02.301] <TB0> INFO: test: no parameter change
[07:52:02.526] <TB0> QUIET: Connection to board 147 closed.
[07:52:02.605] <TB0> INFO: pXar: this is the end, my friend
commander_HRData.log
[07:52:45.774] <TB0> INFO: *** Welcome to pxar ***
[07:52:45.774] <TB0> INFO: *** Today: 2015/08/11
[07:52:45.774] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//dacParameters35_C15.dat
[07:52:45.775] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//tbmParameters_C0b.dat
[07:52:45.775] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//defaultMaskFile.dat
[07:52:45.775] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//trimParameters35_C15.dat
[07:52:45.839] <TB0> INFO: clk: 4
[07:52:45.839] <TB0> INFO: ctr: 4
[07:52:45.839] <TB0> INFO: sda: 19
[07:52:45.839] <TB0> INFO: tin: 9
[07:52:45.839] <TB0> INFO: level: 15
[07:52:45.839] <TB0> INFO: triggerdelay: 0
[07:52:45.839] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[07:52:45.839] <TB0> INFO: Log level: INFO
[07:52:46.849] <TB0> INFO: Found DTB DTB_WWXTQT
[07:52:49.860] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[07:52:49.863] <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:
------------------------------------------------------
[07:52:49.866] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[07:52:51.380] <TB0> INFO: DUT info:
[07:52:51.380] <TB0> INFO: The DUT currently contains the following objects:
[07:52:51.380] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[07:52:51.380] <TB0> INFO: TBM Core alpha (0): 7 registers set
[07:52:51.380] <TB0> INFO: TBM Core beta (1): 7 registers set
[07:52:51.380] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:52:51.380] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.380] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:52:51.781] <TB0> INFO: enter 'restricted' command line mode
[07:52:51.781] <TB0> INFO: enter test to run
[07:52:51.781] <TB0> INFO: test: delay setting parameters: ->5<-
[07:52:51.781] <TB0> INFO: delay test by 5 seconds...
[07:52:56.781] <TB0> INFO: enter test to run
[07:52:56.781] <TB0> INFO: test: Xray no parameter change
[07:52:56.781] <TB0> INFO: running: xray
[07:52:56.782] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//004_HRData_150//phCalibrationFitErr35_C15.dat
[07:52:56.919] <TB0> INFO: ######################################################################
[07:52:56.919] <TB0> INFO: PixTestXray::doTest()
[07:52:56.919] <TB0> INFO: ######################################################################
[07:52:56.919] <TB0> INFO: ----------------------------------------------------------------------
[07:52:56.919] <TB0> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[07:52:56.919] <TB0> INFO: ----------------------------------------------------------------------
[07:52:57.889] <TB0> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[07:53:01.553] <TB0> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[07:53:28.963] <TB0> INFO: Resuming triggers.
[07:53:32.641] <TB0> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[07:53:37.095] <TB0> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (166) != TBM ID (28)

[07:53:37.095] <TB0> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (1) != Token Chain Length (4)

[07:53:37.095] <TB0> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (29) != TBM ID (166)

[07:53:56.629] <TB0> INFO: Resuming triggers.
[07:54:00.305] <TB0> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[07:54:24.016] <TB0> INFO: Resuming triggers.
[07:54:27.692] <TB0> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[07:54:49.746] <TB0> INFO: Resuming triggers.
[07:54:53.421] <TB0> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[07:55:17.229] <TB0> INFO: Resuming triggers.
[07:55:20.901] <TB0> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[07:55:45.306] <TB0> INFO: Resuming triggers.
[07:55:48.976] <TB0> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[07:56:13.366] <TB0> INFO: Resuming triggers.
[07:56:17.031] <TB0> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[07:56:40.703] <TB0> INFO: Resuming triggers.
[07:56:44.368] <TB0> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[07:57:07.616] <TB0> INFO: Resuming triggers.
[07:57:11.284] <TB0> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[07:57:34.419] <TB0> INFO: Resuming triggers.
[07:57:38.087] <TB0> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[07:58:01.118] <TB0> INFO: Resuming triggers.
[07:58:04.780] <TB0> INFO: run duration 43 seconds, buffer almost full (81%), pausing triggers.
[07:58:28.382] <TB0> INFO: Resuming triggers.
[07:58:32.046] <TB0> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[07:58:54.796] <TB0> INFO: Resuming triggers.
[07:58:58.462] <TB0> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[07:59:20.695] <TB0> INFO: Resuming triggers.
[07:59:24.362] <TB0> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[07:59:47.626] <TB0> INFO: Resuming triggers.
[07:59:51.289] <TB0> INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[08:00:15.606] <TB0> INFO: Resuming triggers.
[08:00:19.270] <TB0> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[08:00:42.723] <TB0> INFO: Resuming triggers.
[08:00:46.385] <TB0> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[08:01:09.361] <TB0> INFO: Resuming triggers.
[08:01:13.025] <TB0> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[08:01:36.841] <TB0> INFO: Resuming triggers.
[08:01:40.504] <TB0> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[08:02:06.597] <TB0> INFO: Resuming triggers.
[08:02:10.264] <TB0> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[08:02:33.641] <TB0> INFO: Resuming triggers.
[08:02:37.299] <TB0> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[08:03:04.400] <TB0> INFO: Resuming triggers.
[08:03:08.062] <TB0> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[08:03:32.025] <TB0> INFO: Resuming triggers.
[08:03:35.686] <TB0> INFO: run duration 87 seconds, buffer almost full (81%), pausing triggers.
[08:04:01.513] <TB0> INFO: Resuming triggers.
[08:04:05.177] <TB0> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[08:04:30.047] <TB0> INFO: Resuming triggers.
[08:04:33.705] <TB0> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[08:05:00.362] <TB0> INFO: Resuming triggers.
[08:05:04.024] <TB0> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[08:05:34.283] <TB0> INFO: Resuming triggers.
[08:05:35.442] <TB0> INFO: data taking finished, elapsed time: 100 seconds.
[08:05:42.230] <TB0> INFO: PixTest:: pg_setup set to default.
[08:05:42.232] <TB0> INFO: PixTestXray::doPhRun() done
[08:05:42.232] <TB0> INFO: PixTestXray::doTest() done
[08:05:42.414] <TB0> INFO: enter test to run
[08:05:42.414] <TB0> INFO: test: no parameter change
[08:05:42.596] <TB0> QUIET: Connection to board 147 closed.
[08:05:42.676] <TB0> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[08:08:09.622] <TB0> INFO: *** Welcome to pxar ***
[08:08:09.623] <TB0> INFO: *** Today: 2015/08/11
[08:08:09.623] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//dacParameters35_C15.dat
[08:08:09.623] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//tbmParameters_C0b.dat
[08:08:09.623] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//defaultMaskFile.dat
[08:08:09.623] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//trimParameters35_C15.dat
[08:08:09.689] <TB0> INFO: clk: 4
[08:08:09.689] <TB0> INFO: ctr: 4
[08:08:09.689] <TB0> INFO: sda: 19
[08:08:09.689] <TB0> INFO: tin: 9
[08:08:09.689] <TB0> INFO: level: 15
[08:08:09.689] <TB0> INFO: triggerdelay: 0
[08:08:09.689] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[08:08:09.689] <TB0> INFO: Log level: INFO
[08:08:10.699] <TB0> INFO: Found DTB DTB_WWXTQT
[08:08:13.710] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:08:13.714] <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:08:13.716] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:08:15.231] <TB0> INFO: DUT info:
[08:08:15.231] <TB0> INFO: The DUT currently contains the following objects:
[08:08:15.231] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:08:15.231] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:08:15.231] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:08:15.231] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:08:15.231] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.231] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.232] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.232] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:08:15.632] <TB0> INFO: enter 'restricted' command line mode
[08:08:15.632] <TB0> INFO: enter test to run
[08:08:15.633] <TB0> INFO: test: Highrate no parameter change
[08:08:15.633] <TB0> INFO: running: highrate
[08:08:15.633] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[08:08:15.762] <TB0> INFO: ----------------------------------------------------------------------
[08:08:15.762] <TB0> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[08:08:15.762] <TB0> INFO: ----------------------------------------------------------------------
[08:08:15.768] <TB0> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 100 (1) hits flags = 384 (plus default)
[08:08:15.779] <TB0> INFO: dacScan step from 0 .. 0
[08:08:28.501] <TB0> INFO: Test took 12722ms.
[08:08:30.050] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:30.348] <TB0> INFO: dacScan step from 1 .. 1
[08:08:44.513] <TB0> INFO: Test took 14164ms.
[08:08:45.945] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:46.168] <TB0> INFO: dacScan step from 2 .. 2
[08:09:00.905] <TB0> INFO: Test took 14736ms.
[08:09:02.440] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:02.666] <TB0> INFO: dacScan step from 3 .. 3
[08:09:17.153] <TB0> INFO: Test took 14487ms.
[08:09:18.537] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:18.765] <TB0> INFO: dacScan step from 4 .. 4
[08:09:32.727] <TB0> INFO: Test took 13962ms.
[08:09:34.097] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:34.319] <TB0> INFO: dacScan step from 5 .. 5
[08:09:47.464] <TB0> INFO: Test took 13144ms.
[08:09:48.809] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:49.059] <TB0> INFO: dacScan step from 6 .. 6
[08:10:00.829] <TB0> INFO: Test took 11770ms.
[08:10:02.180] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:10:02.403] <TB0> INFO: dacScan step from 7 .. 7
[08:10:15.869] <TB0> INFO: Test took 13466ms.
[08:10:17.219] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:10:17.448] <TB0> INFO: dacScan step from 8 .. 8
[08:10:31.677] <TB0> INFO: Test took 14229ms.
[08:10:33.189] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:10:33.412] <TB0> INFO: dacScan step from 9 .. 9
[08:10:48.330] <TB0> INFO: Test took 14917ms.
[08:10:49.672] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:10:49.896] <TB0> INFO: dacScan step from 10 .. 10
[08:11:03.670] <TB0> INFO: Test took 13774ms.
[08:11:05.042] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:11:05.285] <TB0> INFO: dacScan step from 11 .. 11
[08:11:18.039] <TB0> INFO: Test took 12753ms.
[08:11:19.786] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:11:20.076] <TB0> INFO: dacScan step from 12 .. 12
[08:11:32.007] <TB0> INFO: Test took 11930ms.
[08:11:33.356] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:11:33.582] <TB0> INFO: dacScan step from 13 .. 13
[08:11:46.707] <TB0> INFO: Test took 13125ms.
[08:11:48.049] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:11:48.272] <TB0> INFO: dacScan step from 14 .. 14
[08:12:02.370] <TB0> INFO: Test took 14098ms.
[08:12:03.752] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:12:03.975] <TB0> INFO: dacScan step from 15 .. 15
[08:12:18.222] <TB0> INFO: Test took 14246ms.
[08:12:19.709] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:12:19.932] <TB0> INFO: dacScan step from 16 .. 16
[08:12:33.959] <TB0> INFO: Test took 14026ms.
[08:12:35.317] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:12:35.540] <TB0> INFO: dacScan step from 17 .. 17
[08:12:48.624] <TB0> INFO: Test took 13084ms.
[08:12:50.138] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:12:50.375] <TB0> INFO: dacScan step from 18 .. 18
[08:13:02.358] <TB0> INFO: Test took 11982ms.
[08:13:03.749] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:13:03.990] <TB0> INFO: dacScan step from 19 .. 19
[08:13:17.264] <TB0> INFO: Test took 13274ms.
[08:13:18.803] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:13:19.039] <TB0> INFO: dacScan step from 20 .. 20
[08:13:33.336] <TB0> INFO: Test took 14296ms.
[08:13:34.717] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:13:34.948] <TB0> INFO: dacScan step from 21 .. 21
[08:13:49.853] <TB0> INFO: Test took 14905ms.
[08:13:51.586] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:13:51.812] <TB0> INFO: dacScan step from 22 .. 22
[08:14:05.816] <TB0> INFO: Test took 14004ms.
[08:14:07.422] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:14:07.676] <TB0> INFO: dacScan step from 23 .. 23
[08:14:21.092] <TB0> INFO: Test took 13416ms.
[08:14:22.556] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:14:22.807] <TB0> INFO: dacScan step from 24 .. 24
[08:14:35.098] <TB0> INFO: Test took 12291ms.
[08:14:36.495] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:14:36.737] <TB0> INFO: dacScan step from 25 .. 25
[08:14:49.283] <TB0> INFO: Test took 12545ms.
[08:14:50.688] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:14:50.930] <TB0> INFO: dacScan step from 26 .. 26
[08:15:04.429] <TB0> INFO: Test took 13498ms.
[08:15:05.854] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:15:06.087] <TB0> INFO: dacScan step from 27 .. 27
[08:15:20.860] <TB0> INFO: Test took 14772ms.
[08:15:22.239] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:15:22.478] <TB0> INFO: dacScan step from 28 .. 28
[08:15:37.451] <TB0> INFO: Test took 14972ms.
[08:15:38.823] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:15:39.055] <TB0> INFO: dacScan step from 29 .. 29
[08:15:53.647] <TB0> INFO: Test took 14592ms.
[08:15:55.098] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:15:55.342] <TB0> INFO: dacScan step from 30 .. 30
[08:16:08.745] <TB0> INFO: Test took 13403ms.
[08:16:10.227] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:16:10.462] <TB0> INFO: dacScan step from 31 .. 31
[08:16:23.012] <TB0> INFO: Test took 12549ms.
[08:16:24.447] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:16:24.681] <TB0> INFO: dacScan step from 32 .. 32
[08:16:37.412] <TB0> INFO: Test took 12731ms.
[08:16:38.790] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:16:39.023] <TB0> INFO: dacScan step from 33 .. 33
[08:16:52.544] <TB0> INFO: Test took 13521ms.
[08:16:53.959] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:16:54.194] <TB0> INFO: dacScan step from 34 .. 34
[08:17:09.261] <TB0> INFO: Test took 15067ms.
[08:17:10.714] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:17:10.952] <TB0> INFO: dacScan step from 35 .. 35
[08:17:26.110] <TB0> INFO: Test took 15157ms.
[08:17:27.767] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:17:28.010] <TB0> INFO: dacScan step from 36 .. 36
[08:17:42.800] <TB0> INFO: Test took 14789ms.
[08:17:44.432] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:17:44.672] <TB0> INFO: dacScan step from 37 .. 37
[08:17:59.153] <TB0> INFO: Test took 14480ms.
[08:18:00.762] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:18:00.999] <TB0> INFO: dacScan step from 38 .. 38
[08:18:15.103] <TB0> INFO: Test took 14103ms.
[08:18:16.595] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:18:16.828] <TB0> INFO: dacScan step from 39 .. 39
[08:18:30.386] <TB0> INFO: Test took 13558ms.
[08:18:31.937] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:18:32.184] <TB0> INFO: dacScan step from 40 .. 40
[08:18:45.552] <TB0> INFO: Test took 13367ms.
[08:18:47.080] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:18:47.320] <TB0> INFO: dacScan step from 41 .. 41
[08:19:01.643] <TB0> INFO: Test took 14323ms.
[08:19:03.177] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:19:03.477] <TB0> INFO: dacScan step from 42 .. 42
[08:19:18.563] <TB0> INFO: Test took 15085ms.
[08:19:20.068] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:19:20.311] <TB0> INFO: dacScan step from 43 .. 43
[08:19:35.747] <TB0> INFO: Test took 15435ms.
[08:19:37.237] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:19:37.475] <TB0> INFO: dacScan step from 44 .. 44
[08:19:53.695] <TB0> INFO: Test took 16219ms.
[08:19:55.361] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:19:55.592] <TB0> INFO: dacScan step from 45 .. 45
[08:20:13.165] <TB0> INFO: Test took 17573ms.
[08:20:14.762] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:20:14.994] <TB0> INFO: dacScan step from 46 .. 46
[08:20:33.036] <TB0> INFO: Test took 18041ms.
[08:20:34.577] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:20:34.820] <TB0> INFO: dacScan step from 47 .. 47
[08:20:52.502] <TB0> INFO: Test took 17681ms.
[08:20:53.996] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:20:54.247] <TB0> INFO: dacScan step from 48 .. 48
[08:21:12.409] <TB0> INFO: Test took 18161ms.
[08:21:13.934] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:21:14.166] <TB0> INFO: dacScan step from 49 .. 49
[08:21:32.445] <TB0> INFO: Test took 18279ms.
[08:21:33.976] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:21:34.210] <TB0> INFO: dacScan step from 50 .. 50
[08:21:52.405] <TB0> INFO: Test took 18195ms.
[08:21:53.979] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:21:54.275] <TB0> INFO: dacScan step from 51 .. 51
[08:22:11.981] <TB0> INFO: Test took 17705ms.
[08:22:13.784] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:22:14.087] <TB0> INFO: dacScan step from 52 .. 52
[08:22:31.358] <TB0> INFO: Test took 17270ms.
[08:22:32.979] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:22:33.210] <TB0> INFO: dacScan step from 53 .. 53
[08:22:50.337] <TB0> INFO: Test took 17126ms.
[08:22:51.917] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:22:52.149] <TB0> INFO: dacScan step from 54 .. 54
[08:23:08.261] <TB0> INFO: Test took 16111ms.
[08:23:09.795] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:23:10.032] <TB0> INFO: dacScan step from 55 .. 55
[08:23:25.880] <TB0> INFO: Test took 15847ms.
[08:23:27.419] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:23:27.650] <TB0> INFO: dacScan step from 56 .. 56
[08:23:43.672] <TB0> INFO: Test took 16021ms.
[08:23:45.266] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:23:45.506] <TB0> INFO: dacScan step from 57 .. 57
[08:24:02.284] <TB0> INFO: Test took 16777ms.
[08:24:04.276] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:24:04.571] <TB0> INFO: dacScan step from 58 .. 58
[08:24:21.726] <TB0> INFO: Test took 17154ms.
[08:24:23.296] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:24:23.533] <TB0> INFO: dacScan step from 59 .. 59
[08:24:41.432] <TB0> INFO: Test took 17899ms.
[08:24:43.149] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:24:43.380] <TB0> INFO: dacScan step from 60 .. 60
[08:25:01.270] <TB0> INFO: Test took 17889ms.
[08:25:02.811] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:25:03.046] <TB0> INFO: dacScan step from 61 .. 61
[08:25:20.643] <TB0> INFO: Test took 17596ms.
[08:25:22.187] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:25:22.423] <TB0> INFO: dacScan step from 62 .. 62
[08:25:38.385] <TB0> INFO: Test took 15961ms.
[08:25:39.986] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:25:40.233] <TB0> INFO: dacScan step from 63 .. 63
[08:25:55.814] <TB0> INFO: Test took 15580ms.
[08:25:57.462] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:25:57.717] <TB0> INFO: dacScan step from 64 .. 64
[08:26:13.642] <TB0> INFO: Test took 15924ms.
[08:26:15.346] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:26:15.595] <TB0> INFO: dacScan step from 65 .. 65
[08:26:32.877] <TB0> INFO: Test took 17281ms.
[08:26:34.561] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:26:34.805] <TB0> INFO: dacScan step from 66 .. 66
[08:26:52.823] <TB0> INFO: Test took 18017ms.
[08:26:54.344] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:26:54.576] <TB0> INFO: dacScan step from 67 .. 67
[08:27:12.957] <TB0> INFO: Test took 18380ms.
[08:27:14.565] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:27:14.816] <TB0> INFO: dacScan step from 68 .. 68
[08:27:32.923] <TB0> INFO: Test took 18106ms.
[08:27:34.770] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:27:35.019] <TB0> INFO: dacScan step from 69 .. 69
[08:27:52.243] <TB0> INFO: Test took 17223ms.
[08:27:53.851] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:27:54.098] <TB0> INFO: dacScan step from 70 .. 70
[08:28:10.037] <TB0> INFO: Test took 15938ms.
[08:28:11.697] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:28:11.949] <TB0> INFO: dacScan step from 71 .. 71
[08:28:27.590] <TB0> INFO: Test took 15640ms.
[08:28:29.131] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:28:29.362] <TB0> INFO: dacScan step from 72 .. 72
[08:28:46.034] <TB0> INFO: Test took 16671ms.
[08:28:47.564] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:28:47.809] <TB0> INFO: dacScan step from 73 .. 73
[08:29:04.861] <TB0> INFO: Test took 17052ms.
[08:29:06.477] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:29:06.709] <TB0> INFO: dacScan step from 74 .. 74
[08:29:24.893] <TB0> INFO: Test took 18184ms.
[08:29:26.518] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:29:26.774] <TB0> INFO: dacScan step from 75 .. 75
[08:29:45.905] <TB0> INFO: Test took 19130ms.
[08:29:47.747] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:29:48.005] <TB0> INFO: dacScan step from 76 .. 76
[08:30:06.194] <TB0> INFO: Test took 18188ms.
[08:30:07.937] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:30:08.172] <TB0> INFO: dacScan step from 77 .. 77
[08:30:25.472] <TB0> INFO: Test took 17299ms.
[08:30:27.081] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:30:27.323] <TB0> INFO: dacScan step from 78 .. 78
[08:30:43.210] <TB0> INFO: Test took 15886ms.
[08:30:44.771] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:30:45.010] <TB0> INFO: dacScan step from 79 .. 79
[08:31:00.814] <TB0> INFO: Test took 15803ms.
[08:31:02.535] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:31:02.772] <TB0> INFO: dacScan step from 80 .. 80
[08:31:19.538] <TB0> INFO: Test took 16766ms.
[08:31:21.146] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:31:21.396] <TB0> INFO: dacScan step from 81 .. 81
[08:31:39.525] <TB0> INFO: Test took 18128ms.
[08:31:41.071] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:31:41.315] <TB0> INFO: dacScan step from 82 .. 82
[08:32:00.302] <TB0> INFO: Test took 18986ms.
[08:32:01.883] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:32:02.126] <TB0> INFO: dacScan step from 83 .. 83
[08:32:20.425] <TB0> INFO: Test took 18298ms.
[08:32:22.083] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:32:22.316] <TB0> INFO: dacScan step from 84 .. 84
[08:32:39.152] <TB0> INFO: Test took 16835ms.
[08:32:40.774] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:32:41.031] <TB0> INFO: dacScan step from 85 .. 85
[08:32:56.470] <TB0> INFO: Test took 15438ms.
[08:32:58.136] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:32:58.440] <TB0> INFO: dacScan step from 86 .. 86
[08:33:14.522] <TB0> INFO: Test took 16081ms.
[08:33:16.260] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:33:16.520] <TB0> INFO: dacScan step from 87 .. 87
[08:33:33.640] <TB0> INFO: Test took 17119ms.
[08:33:35.259] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:33:35.492] <TB0> INFO: dacScan step from 88 .. 88
[08:33:53.209] <TB0> INFO: Test took 17716ms.
[08:33:55.110] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:33:55.357] <TB0> INFO: dacScan step from 89 .. 89
[08:34:14.167] <TB0> INFO: Test took 18809ms.
[08:34:15.886] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:34:16.139] <TB0> INFO: dacScan step from 90 .. 90
[08:34:34.712] <TB0> INFO: Test took 18572ms.
[08:34:36.426] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:34:36.663] <TB0> INFO: dacScan step from 91 .. 91
[08:34:54.027] <TB0> INFO: Test took 17363ms.
[08:34:55.728] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:34:55.997] <TB0> INFO: dacScan step from 92 .. 92
[08:35:12.695] <TB0> INFO: Test took 16697ms.
[08:35:14.397] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:35:14.635] <TB0> INFO: dacScan step from 93 .. 93
[08:35:30.874] <TB0> INFO: Test took 16238ms.
[08:35:32.745] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:35:33.000] <TB0> INFO: dacScan step from 94 .. 94
[08:35:48.665] <TB0> INFO: Test took 15664ms.
[08:35:50.411] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:35:50.663] <TB0> INFO: dacScan step from 95 .. 95
[08:36:07.484] <TB0> INFO: Test took 16820ms.
[08:36:09.176] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:36:09.418] <TB0> INFO: dacScan step from 96 .. 96
[08:36:27.760] <TB0> INFO: Test took 18341ms.
[08:36:29.467] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:36:29.809] <TB0> INFO: dacScan step from 97 .. 97
[08:36:48.049] <TB0> INFO: Test took 18239ms.
[08:36:49.819] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:36:50.073] <TB0> INFO: dacScan step from 98 .. 98
[08:37:07.971] <TB0> INFO: Test took 17897ms.
[08:37:09.704] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:37:09.953] <TB0> INFO: dacScan step from 99 .. 99
[08:37:27.091] <TB0> INFO: Test took 17137ms.
[08:37:28.834] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:37:29.089] <TB0> INFO: dacScan step from 100 .. 100
[08:37:44.215] <TB0> INFO: Test took 15125ms.
[08:37:45.888] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:37:46.144] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:47.503] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:48.804] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:50.105] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:51.463] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:52.885] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:54.261] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:55.592] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:56.977] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:58.349] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:37:59.746] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:38:01.144] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:38:02.501] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:38:03.899] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:38:05.157] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:38:06.513] <TB0> INFO: dumping ASCII scurve output file: XSCurveData
[08:38:07.882] <TB0> INFO: PixTest:: pg_setup set to default.
[08:38:07.884] <TB0> INFO: vcal mean: 38.17 39.17 38.21 41.50 41.63 43.46 41.95 43.44 42.57 41.81 42.19 40.44 40.42 38.11 38.19 38.43
[08:38:07.884] <TB0> INFO: vcal RMS: 1.23 1.50 1.18 1.52 1.28 1.49 1.52 1.52 1.53 1.42 1.55 1.50 1.38 1.23 1.19 1.19
[08:38:07.884] <TB0> INFO: number of X-ray hits detected: 170738 199031 186954 308859 310506 423008 364497 426776 369449 332023 347877 284044 256630 153988 166839 164320
[08:38:07.884] <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:38:07.884] <TB0> INFO: X-ray hit rate [MHz/cm2]: 50.0 58.3 54.8 90.5 91.0 124.0 106.8 125.1 108.3 97.3 102.0 83.3 75.2 45.1 48.9 48.2
[08:38:07.884] <TB0> INFO: PixTestHighRate::doXNoiseMaps() done
[08:38:07.980] <TB0> INFO: enter test to run
[08:38:07.980] <TB0> INFO: test: no parameter change
[08:38:08.137] <TB0> QUIET: Connection to board 147 closed.
[08:38:08.216] <TB0> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[08:58:40.040] <TB0> INFO: *** Welcome to pxar ***
[08:58:40.040] <TB0> INFO: *** Today: 2015/08/11
[08:58:40.040] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[08:58:40.041] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[08:58:40.041] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[08:58:40.041] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[08:58:40.109] <TB0> INFO: clk: 4
[08:58:40.109] <TB0> INFO: ctr: 4
[08:58:40.109] <TB0> INFO: sda: 19
[08:58:40.109] <TB0> INFO: tin: 9
[08:58:40.109] <TB0> INFO: level: 15
[08:58:40.109] <TB0> INFO: triggerdelay: 0
[08:58:40.109] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[08:58:40.109] <TB0> INFO: Log level: INFO
[08:58:41.119] <TB0> INFO: Found DTB DTB_WWXTQT
[08:58:44.130] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[08:58:44.133] <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:58:44.135] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[08:58:45.650] <TB0> INFO: DUT info:
[08:58:45.650] <TB0> INFO: The DUT currently contains the following objects:
[08:58:45.650] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:58:45.650] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:58:45.650] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:58:45.650] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:58:45.650] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:45.650] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:58:46.051] <TB0> INFO: enter 'restricted' command line mode
[08:58:46.051] <TB0> INFO: enter test to run
[08:58:46.051] <TB0> INFO: test: HighRate no parameter change
[08:58:46.051] <TB0> INFO: running: highrate
[08:58:46.051] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[08:58:46.180] <TB0> INFO: ----------------------------------------------------------------------
[08:58:46.180] <TB0> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[08:58:46.180] <TB0> INFO: ----------------------------------------------------------------------
[08:58:47.261] <TB0> INFO: Test took 1075ms.
[08:58:50.522] <TB0> INFO: Test took 3257ms.
[08:58:50.684] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:58:54.140] <TB0> INFO: Test took 3431ms.
[08:58:54.281] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:58:57.997] <TB0> INFO: Test took 3691ms.
[08:58:58.138] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:02.054] <TB0> INFO: Test took 3891ms.
[08:59:02.240] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:06.202] <TB0> INFO: Test took 3923ms.
[08:59:06.387] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:10.601] <TB0> INFO: Test took 4178ms.
[08:59:10.748] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:14.740] <TB0> INFO: Test took 3966ms.
[08:59:14.879] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:19.057] <TB0> INFO: Test took 4152ms.
[08:59:19.211] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:23.453] <TB0> INFO: Test took 4213ms.
[08:59:23.610] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:27.684] <TB0> INFO: Test took 4048ms.
[08:59:27.841] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:32.158] <TB0> INFO: Test took 4281ms.
[08:59:32.307] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:36.338] <TB0> INFO: Test took 4003ms.
[08:59:36.485] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:40.394] <TB0> INFO: Test took 3881ms.
[08:59:40.592] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:44.459] <TB0> INFO: Test took 3840ms.
[08:59:44.599] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:48.440] <TB0> INFO: Test took 3815ms.
[08:59:48.595] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:52.386] <TB0> INFO: Test took 3763ms.
[08:59:52.538] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:56.134] <TB0> INFO: Test took 3570ms.
[08:59:56.293] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:59.911] <TB0> INFO: Test took 3588ms.
[09:00:00.066] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:00:03.823] <TB0> INFO: Test took 3730ms.
[09:00:03.969] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:00:07.627] <TB0> INFO: Test took 3631ms.
[09:00:07.776] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:00:08.092] <TB0> INFO: enter test to run
[09:00:08.092] <TB0> INFO: test: Pretest no parameter change
[09:00:08.092] <TB0> INFO: running: pretest
[09:00:08.092] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[09:00:08.092] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[09:00:08.092] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[09:00:08.093] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[09:00:08.093] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[09:00:08.093] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[09:00:08.093] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[09:00:08.093] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[09:00:08.093] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[09:00:08.093] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[09:00:08.094] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[09:00:08.094] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[09:00:08.094] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[09:00:08.094] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[09:00:08.094] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[09:00:08.094] <TB0> INFO: write dac parameters into /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[09:00:08.094] <TB0> INFO: enter test to run
[09:00:08.094] <TB0> INFO: test: no parameter change
[09:00:08.493] <TB0> QUIET: Connection to board 147 closed.
[09:00:08.572] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:00:48.148] <TB0> INFO: *** Welcome to pxar ***
[09:00:48.148] <TB0> INFO: *** Today: 2015/08/11
[09:00:48.148] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//dacParameters35_C15.dat
[09:00:48.149] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//tbmParameters_C0b.dat
[09:00:48.149] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//defaultMaskFile.dat
[09:00:48.149] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//trimParameters35_C15.dat
[09:00:48.215] <TB0> INFO: clk: 4
[09:00:48.215] <TB0> INFO: ctr: 4
[09:00:48.215] <TB0> INFO: sda: 19
[09:00:48.215] <TB0> INFO: tin: 9
[09:00:48.215] <TB0> INFO: level: 15
[09:00:48.215] <TB0> INFO: triggerdelay: 0
[09:00:48.215] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[09:00:48.215] <TB0> INFO: Log level: INFO
[09:00:49.224] <TB0> INFO: Found DTB DTB_WWXTQT
[09:00:52.236] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[09:00:52.239] <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:00:52.241] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[09:00:53.756] <TB0> INFO: DUT info:
[09:00:53.756] <TB0> INFO: The DUT currently contains the following objects:
[09:00:53.756] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[09:00:53.756] <TB0> INFO: TBM Core alpha (0): 7 registers set
[09:00:53.756] <TB0> INFO: TBM Core beta (1): 7 registers set
[09:00:53.756] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:00:53.756] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.756] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:53.757] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:00:54.157] <TB0> INFO: enter 'restricted' command line mode
[09:00:54.158] <TB0> INFO: enter test to run
[09:00:54.158] <TB0> INFO: test: HighRate no parameter change
[09:00:54.158] <TB0> INFO: running: highrate
[09:00:54.158] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[09:00:54.287] <TB0> INFO: ----------------------------------------------------------------------
[09:00:54.287] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:00:54.287] <TB0> INFO: ----------------------------------------------------------------------
[09:01:05.837] <TB0> INFO: Test took 11544ms.
[09:01:06.610] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:01:06.913] <TB0> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:01:06.913] <TB0> INFO: number of red-efficiency pixels: 121 169 147 195 283 386 262 426 271 269 270 189 165 95 99 94
[09:01:06.913] <TB0> INFO: number of X-ray hits detected: 85650 98706 91658 156030 156199 216766 184355 219122 186845 167731 178092 141807 129447 75708 82888 81754
[09:01:06.913] <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
[09:01:06.913] <TB0> INFO: number of Vcal hits detected: 207875 207779 207847 207798 207708 207586 207722 207544 207717 207719 207718 207806 207832 207905 207900 207905
[09:01:06.913] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.8 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[09:01:06.913] <TB0> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.8 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[09:01:06.913] <TB0> INFO: X-ray hit rate [MHz/cm2]: 25.1 28.9 26.9 45.7 45.8 63.5 54.0 64.2 54.8 49.2 52.2 41.6 37.9 22.2 24.3 24.0
[09:01:06.913] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[09:01:06.944] <TB0> INFO: PixTest:: pg_setup set to default.
[09:01:06.978] <TB0> INFO: enter test to run
[09:01:06.978] <TB0> INFO: test: no parameter change
[09:01:07.166] <TB0> QUIET: Connection to board 147 closed.
[09:01:07.246] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:01:42.012] <TB0> INFO: *** Welcome to pxar ***
[09:01:42.012] <TB0> INFO: *** Today: 2015/08/11
[09:01:42.012] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//dacParameters35_C15.dat
[09:01:42.013] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//tbmParameters_C0b.dat
[09:01:42.013] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//defaultMaskFile.dat
[09:01:42.013] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//trimParameters35_C15.dat
[09:01:42.082] <TB0> INFO: clk: 4
[09:01:42.082] <TB0> INFO: ctr: 4
[09:01:42.082] <TB0> INFO: sda: 19
[09:01:42.082] <TB0> INFO: tin: 9
[09:01:42.082] <TB0> INFO: level: 15
[09:01:42.082] <TB0> INFO: triggerdelay: 0
[09:01:42.082] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[09:01:42.082] <TB0> INFO: Log level: INFO
[09:01:43.092] <TB0> INFO: Found DTB DTB_WWXTQT
[09:01:46.103] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[09:01:46.106] <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:01:46.109] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[09:01:47.626] <TB0> INFO: DUT info:
[09:01:47.626] <TB0> INFO: The DUT currently contains the following objects:
[09:01:47.626] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[09:01:47.626] <TB0> INFO: TBM Core alpha (0): 7 registers set
[09:01:47.626] <TB0> INFO: TBM Core beta (1): 7 registers set
[09:01:47.626] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:01:47.626] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:47.626] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:01:48.027] <TB0> INFO: enter 'restricted' command line mode
[09:01:48.027] <TB0> INFO: enter test to run
[09:01:48.027] <TB0> INFO: test: HighRate no parameter change
[09:01:48.028] <TB0> INFO: running: highrate
[09:01:48.028] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[09:01:48.163] <TB0> INFO: ----------------------------------------------------------------------
[09:01:48.163] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:01:48.163] <TB0> INFO: ----------------------------------------------------------------------
[09:02:02.360] <TB0> INFO: Test took 14192ms.
[09:02:04.483] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:02:04.870] <TB0> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:02:04.870] <TB0> INFO: number of red-efficiency pixels: 313 470 391 770 908 1442 1062 1462 994 972 895 608 670 371 272 301
[09:02:04.870] <TB0> INFO: number of X-ray hits detected: 172862 200830 186840 311215 314135 426690 366492 432941 370842 333800 350548 283224 259817 155813 168054 164399
[09:02:04.870] <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
[09:02:04.870] <TB0> INFO: number of Vcal hits detected: 207669 207441 207531 207115 206864 206045 206643 206070 206799 206812 206922 207330 207257 207563 207712 207684
[09:02:04.870] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.9 99.8 99.8 99.6 99.5 99.2 99.4 99.2 99.5 99.5 99.5 99.7 99.7 99.8 99.9 99.9
[09:02:04.870] <TB0> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.8 99.6 99.5 99.1 99.3 99.1 99.4 99.4 99.5 99.7 99.6 99.8 99.9 99.8
[09:02:04.870] <TB0> INFO: X-ray hit rate [MHz/cm2]: 50.7 58.9 54.8 91.2 92.1 125.1 107.4 126.9 108.7 97.8 102.7 83.0 76.2 45.7 49.3 48.2
[09:02:04.870] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[09:02:04.908] <TB0> INFO: PixTest:: pg_setup set to default.
[09:02:04.946] <TB0> INFO: enter test to run
[09:02:04.946] <TB0> INFO: test: no parameter change
[09:02:05.136] <TB0> QUIET: Connection to board 147 closed.
[09:02:05.216] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:02:43.144] <TB0> INFO: *** Welcome to pxar ***
[09:02:43.144] <TB0> INFO: *** Today: 2015/08/11
[09:02:43.144] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//dacParameters35_C15.dat
[09:02:43.144] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//tbmParameters_C0b.dat
[09:02:43.145] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//defaultMaskFile.dat
[09:02:43.145] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//trimParameters35_C15.dat
[09:02:43.211] <TB0> INFO: clk: 4
[09:02:43.211] <TB0> INFO: ctr: 4
[09:02:43.211] <TB0> INFO: sda: 19
[09:02:43.211] <TB0> INFO: tin: 9
[09:02:43.211] <TB0> INFO: level: 15
[09:02:43.211] <TB0> INFO: triggerdelay: 0
[09:02:43.211] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[09:02:43.211] <TB0> INFO: Log level: INFO
[09:02:44.221] <TB0> INFO: Found DTB DTB_WWXTQT
[09:02:47.232] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[09:02:47.235] <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:02:47.237] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[09:02:48.754] <TB0> INFO: DUT info:
[09:02:48.754] <TB0> INFO: The DUT currently contains the following objects:
[09:02:48.754] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[09:02:48.754] <TB0> INFO: TBM Core alpha (0): 7 registers set
[09:02:48.754] <TB0> INFO: TBM Core beta (1): 7 registers set
[09:02:48.754] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:02:48.754] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:48.754] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:02:49.155] <TB0> INFO: enter 'restricted' command line mode
[09:02:49.155] <TB0> INFO: enter test to run
[09:02:49.155] <TB0> INFO: test: HighRate no parameter change
[09:02:49.155] <TB0> INFO: running: highrate
[09:02:49.155] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[09:02:49.288] <TB0> INFO: ----------------------------------------------------------------------
[09:02:49.288] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:02:49.288] <TB0> INFO: ----------------------------------------------------------------------
[09:03:06.560] <TB0> INFO: Test took 17267ms.
[09:03:10.376] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:03:10.839] <TB0> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:03:10.839] <TB0> INFO: number of red-efficiency pixels: 635 949 772 1583 1816 2741 2121 2838 2103 1927 1803 1246 1451 688 531 622
[09:03:10.839] <TB0> INFO: number of X-ray hits detected: 251876 291277 273055 445563 448683 610679 523023 621147 531415 478272 500612 410422 374080 227294 244338 239564
[09:03:10.839] <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
[09:03:10.839] <TB0> INFO: number of Vcal hits detected: 207270 206836 206809 205660 205016 202250 204272 202550 204693 204850 205199 206328 206042 206994 207412 207306
[09:03:10.839] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.7 99.5 99.5 99.0 98.8 97.6 98.5 97.6 98.6 98.7 98.8 99.3 99.2 99.6 99.7 99.7
[09:03:10.839] <TB0> INFO: Vcal hit overall efficiency (%): 99.6 99.4 99.4 98.9 98.6 97.2 98.2 97.4 98.4 98.5 98.7 99.2 99.1 99.5 99.7 99.7
[09:03:10.839] <TB0> INFO: X-ray hit rate [MHz/cm2]: 73.8 85.4 80.0 130.6 131.5 179.0 153.3 182.1 155.8 140.2 146.7 120.3 109.6 66.6 71.6 70.2
[09:03:10.839] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[09:03:10.872] <TB0> INFO: PixTest:: pg_setup set to default.
[09:03:10.914] <TB0> INFO: enter test to run
[09:03:10.914] <TB0> INFO: test: no parameter change
[09:03:11.081] <TB0> QUIET: Connection to board 147 closed.
[09:03:11.161] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:03:46.276] <TB0> INFO: *** Welcome to pxar ***
[09:03:46.276] <TB0> INFO: *** Today: 2015/08/11
[09:03:46.276] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//dacParameters35_C15.dat
[09:03:46.277] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//tbmParameters_C0b.dat
[09:03:46.277] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//defaultMaskFile.dat
[09:03:46.277] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//trimParameters35_C15.dat
[09:03:46.379] <TB0> INFO: clk: 4
[09:03:46.380] <TB0> INFO: ctr: 4
[09:03:46.380] <TB0> INFO: sda: 19
[09:03:46.380] <TB0> INFO: tin: 9
[09:03:46.380] <TB0> INFO: level: 15
[09:03:46.380] <TB0> INFO: triggerdelay: 0
[09:03:46.380] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[09:03:46.380] <TB0> INFO: Log level: INFO
[09:03:47.390] <TB0> INFO: Found DTB DTB_WWXTQT
[09:03:50.401] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[09:03:50.404] <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:03:50.407] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[09:03:51.924] <TB0> INFO: DUT info:
[09:03:51.924] <TB0> INFO: The DUT currently contains the following objects:
[09:03:51.924] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[09:03:51.924] <TB0> INFO: TBM Core alpha (0): 7 registers set
[09:03:51.924] <TB0> INFO: TBM Core beta (1): 7 registers set
[09:03:51.924] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:03:51.924] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:51.924] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:03:52.325] <TB0> INFO: enter 'restricted' command line mode
[09:03:52.325] <TB0> INFO: enter test to run
[09:03:52.325] <TB0> INFO: test: HighRate no parameter change
[09:03:52.325] <TB0> INFO: running: highrate
[09:03:52.325] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[09:03:52.458] <TB0> INFO: ----------------------------------------------------------------------
[09:03:52.458] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:03:52.458] <TB0> INFO: ----------------------------------------------------------------------
[09:04:12.446] <TB0> INFO: Test took 19982ms.
[09:04:19.709] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:04:20.310] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:04:20.310] <TB0> INFO: number of red-efficiency pixels: 1227 1780 1208 2622 2890 3784 3247 3899 3366 2992 2984 2211 2427 1131 953 1130
[09:04:20.310] <TB0> INFO: number of X-ray hits detected: 340950 396768 371254 602240 607465 818806 704159 832380 714079 638994 668195 552511 505105 308467 333506 323892
[09:04:20.310] <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
[09:04:20.310] <TB0> INFO: number of Vcal hits detected: 206442 205462 205299 202693 201255 194158 199196 194452 199840 200749 201125 203996 203693 205709 206848 206614
[09:04:20.310] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.3 98.9 99.0 97.8 97.2 94.1 96.3 94.0 96.4 97.0 97.1 98.3 98.2 99.1 99.5 99.4
[09:04:20.310] <TB0> INFO: Vcal hit overall efficiency (%): 99.3 98.8 98.7 97.4 96.8 93.3 95.8 93.5 96.1 96.5 96.7 98.1 97.9 98.9 99.4 99.3
[09:04:20.310] <TB0> INFO: X-ray hit rate [MHz/cm2]: 99.9 116.3 108.8 176.5 178.1 240.0 206.4 244.0 209.3 187.3 195.9 161.9 148.0 90.4 97.8 94.9
[09:04:20.310] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[09:04:20.341] <TB0> INFO: PixTest:: pg_setup set to default.
[09:04:20.392] <TB0> INFO: enter test to run
[09:04:20.392] <TB0> INFO: test: no parameter change
[09:04:20.592] <TB0> QUIET: Connection to board 147 closed.
[09:04:20.677] <TB0> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[09:04:52.528] <TB0> INFO: *** Welcome to pxar ***
[09:04:52.528] <TB0> INFO: *** Today: 2015/08/11
[09:04:52.528] <TB0> INFO: readRocDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//dacParameters35_C15.dat
[09:04:52.529] <TB0> INFO: readTbmDacs: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//tbmParameters_C0b.dat
[09:04:52.529] <TB0> INFO: readMaskFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//defaultMaskFile.dat
[09:04:52.529] <TB0> INFO: readTrimFile: /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//trimParameters35_C15.dat
[09:04:52.603] <TB0> INFO: clk: 4
[09:04:52.603] <TB0> INFO: ctr: 4
[09:04:52.603] <TB0> INFO: sda: 19
[09:04:52.603] <TB0> INFO: tin: 9
[09:04:52.603] <TB0> INFO: level: 15
[09:04:52.603] <TB0> INFO: triggerdelay: 0
[09:04:52.604] <TB0> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[09:04:52.604] <TB0> INFO: Log level: INFO
[09:04:53.613] <TB0> INFO: Found DTB DTB_WWXTQT
[09:04:56.625] <TB0> QUIET: Connection to board DTB_WWXTQT opened.
[09:04:56.628] <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:04:56.631] <TB0> INFO: RPC call hashes of host and DTB match: 447413373
[09:04:58.724] <TB0> INFO: DUT info:
[09:04:58.724] <TB0> INFO: The DUT currently contains the following objects:
[09:04:58.724] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[09:04:58.724] <TB0> INFO: TBM Core alpha (0): 7 registers set
[09:04:58.724] <TB0> INFO: TBM Core beta (1): 7 registers set
[09:04:58.724] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:04:58.724] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.724] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.724] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.724] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.724] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.724] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.724] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.724] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.725] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.725] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.725] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.725] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.725] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.725] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.725] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:58.725] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:04:59.126] <TB0> INFO: enter 'restricted' command line mode
[09:04:59.126] <TB0> INFO: enter test to run
[09:04:59.126] <TB0> INFO: test: HighRate no parameter change
[09:04:59.126] <TB0> INFO: running: highrate
[09:04:59.126] <TB0> INFO: readGainPedestalParameters /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2054_XrayQualification_2015-08-11_09h36m_1439278608//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[09:04:59.828] <TB0> INFO: ----------------------------------------------------------------------
[09:04:59.828] <TB0> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[09:04:59.828] <TB0> INFO: ----------------------------------------------------------------------
[09:05:20.646] <TB0> INFO: Test took 20787ms.
[09:05:27.218] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:05:27.792] <TB0> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:05:27.792] <TB0> INFO: number of red-efficiency pixels: 1276 1832 1251 2800 2986 3793 3338 3946 3422 3161 3034 2340 2529 1183 1122 1169
[09:05:27.792] <TB0> INFO: number of X-ray hits detected: 351439 409796 385780 617053 622659 836324 726206 854085 736771 658056 686275 569052 518460 320740 344936 334599
[09:05:27.792] <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
[09:05:27.792] <TB0> INFO: number of Vcal hits detected: 206336 205366 205261 202129 200636 193502 198453 193549 199175 200012 200612 203655 203302 205620 206635 206548
[09:05:27.792] <TB0> INFO: Vcal hit fiducial efficiency (%): 99.3 98.8 99.0 97.5 96.9 93.8 96.0 93.6 96.2 96.6 96.9 98.2 98.0 99.1 99.4 99.4
[09:05:27.792] <TB0> INFO: Vcal hit overall efficiency (%): 99.2 98.7 98.7 97.2 96.5 93.0 95.4 93.1 95.8 96.2 96.4 97.9 97.7 98.9 99.3 99.3
[09:05:27.792] <TB0> INFO: X-ray hit rate [MHz/cm2]: 103.0 120.1 113.1 180.9 182.5 245.1 212.9 250.3 216.0 192.9 201.2 166.8 152.0 94.0 101.1 98.1
[09:05:27.792] <TB0> INFO: PixTestHighRate::doXPixelAlive() done
[09:05:27.817] <TB0> INFO: PixTest:: pg_setup set to default.
[09:05:27.853] <TB0> INFO: enter test to run
[09:05:27.853] <TB0> INFO: test: no parameter change
[09:05:28.009] <TB0> QUIET: Connection to board 147 closed.
[09:05:28.089] <TB0> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master