Test Date: 2015-08-11 16:58
Analysis date: 2016-05-25 23:17
Logfile
commander_PixelAlive.log
[14:59:12.316] <TB2> INFO: *** Welcome to pxar ***
[14:59:12.316] <TB2> INFO: *** Today: 2015/08/11
[14:59:12.316] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//000_PixelAlive_p17//dacParameters35_C15.dat
[14:59:12.317] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//000_PixelAlive_p17//tbmParameters_C0b.dat
[14:59:12.317] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//000_PixelAlive_p17//defaultMaskFile.dat
[14:59:12.317] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//000_PixelAlive_p17//trimParameters35_C15.dat
[14:59:12.387] <TB2> INFO: clk: 4
[14:59:12.387] <TB2> INFO: ctr: 4
[14:59:12.387] <TB2> INFO: sda: 19
[14:59:12.387] <TB2> INFO: tin: 9
[14:59:12.387] <TB2> INFO: level: 15
[14:59:12.387] <TB2> INFO: triggerdelay: 0
[14:59:12.387] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[14:59:12.387] <TB2> INFO: Log level: INFO
[14:59:13.399] <TB2> INFO: Found DTB DTB_WXENWR
[14:59:16.419] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:59:16.422] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[14:59:16.425] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[14:59:17.962] <TB2> INFO: DUT info:
[14:59:17.962] <TB2> INFO: The DUT currently contains the following objects:
[14:59:17.962] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:59:17.962] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:59:17.962] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:59:17.962] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:59:17.962] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.962] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.963] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.963] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.963] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.963] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:17.963] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:59:18.364] <TB2> INFO: enter 'restricted' command line mode
[14:59:18.364] <TB2> INFO: enter test to run
[14:59:18.364] <TB2> INFO: test: PixelAlive no parameter change
[14:59:18.364] <TB2> INFO: running: pixelalive
[14:59:18.371] <TB2> INFO: ######################################################################
[14:59:18.371] <TB2> INFO: PixTestAlive::doTest()
[14:59:18.371] <TB2> INFO: ######################################################################
[14:59:18.373] <TB2> INFO: ----------------------------------------------------------------------
[14:59:18.373] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:59:18.373] <TB2> INFO: ----------------------------------------------------------------------
[14:59:21.934] <TB2> INFO: Test took 3559ms.
[14:59:21.958] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:59:22.223] <TB2> INFO: PixTestAlive::aliveTest() done
[14:59:22.223] <TB2> INFO: number of dead pixels (per ROC): 1 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:59:22.225] <TB2> INFO: ----------------------------------------------------------------------
[14:59:22.225] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:59:22.225] <TB2> INFO: ----------------------------------------------------------------------
[14:59:25.002] <TB2> INFO: Test took 2774ms.
[14:59:25.005] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:59:25.006] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:59:25.249] <TB2> INFO: PixTestAlive::maskTest() done
[14:59:25.249] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:59:25.251] <TB2> INFO: ----------------------------------------------------------------------
[14:59:25.251] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:59:25.251] <TB2> INFO: ----------------------------------------------------------------------
[14:59:28.678] <TB2> INFO: Test took 3425ms.
[14:59:28.700] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:59:28.942] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[14:59:28.942] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:59:28.943] <TB2> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[14:59:28.982] <TB2> INFO: enter test to run
[14:59:28.982] <TB2> INFO: test: no parameter change
[14:59:29.112] <TB2> QUIET: Connection to board 162 closed.
[14:59:29.191] <TB2> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[15:04:38.380] <TB2> INFO: *** Welcome to pxar ***
[15:04:38.380] <TB2> INFO: *** Today: 2015/08/11
[15:04:38.380] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:04:38.382] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:04:38.382] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:04:38.382] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:04:38.463] <TB2> INFO: clk: 4
[15:04:38.463] <TB2> INFO: ctr: 4
[15:04:38.463] <TB2> INFO: sda: 19
[15:04:38.463] <TB2> INFO: tin: 9
[15:04:38.463] <TB2> INFO: level: 15
[15:04:38.463] <TB2> INFO: triggerdelay: 0
[15:04:38.463] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:04:38.463] <TB2> INFO: Log level: INFO
[15:04:39.472] <TB2> INFO: Found DTB DTB_WXENWR
[15:04:42.493] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[15:04:42.496] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[15:04:42.499] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[15:04:44.036] <TB2> INFO: DUT info:
[15:04:44.036] <TB2> INFO: The DUT currently contains the following objects:
[15:04:44.036] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[15:04:44.036] <TB2> INFO: TBM Core alpha (0): 7 registers set
[15:04:44.036] <TB2> INFO: TBM Core beta (1): 7 registers set
[15:04:44.036] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:04:44.036] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.036] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.037] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.037] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.037] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.037] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.037] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.037] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:04:44.439] <TB2> INFO: enter 'restricted' command line mode
[15:04:44.439] <TB2> INFO: enter test to run
[15:04:44.439] <TB2> INFO: test: delay setting parameters: ->5<-
[15:04:44.439] <TB2> INFO: delay test by 5 seconds...
[15:04:49.439] <TB2> INFO: enter test to run
[15:04:49.439] <TB2> INFO: test: highrate no parameter change
[15:04:49.439] <TB2> INFO: running: highrate
[15:04:49.440] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:04:49.585] <TB2> INFO: ----------------------------------------------------------------------
[15:04:49.585] <TB2> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:04:49.585] <TB2> INFO: ----------------------------------------------------------------------
[15:04:49.585] <TB2> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[15:04:49.585] <TB2> INFO: edge/corner pixel THR is adjusted
[15:04:49.585] <TB2> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:04:50.552] <TB2> INFO: Collecting data for 1 seconds...
[15:04:51.553] <TB2> INFO: Done with hot pixel readout
[15:04:56.875] <TB2> INFO: PixTest:: pg_setup set to default.
[15:04:56.876] <TB2> INFO: 7 hot pixels found in step 0
[15:04:57.844] <TB2> INFO: Collecting data for 1 seconds...
[15:04:58.846] <TB2> INFO: Done with hot pixel readout
[15:05:04.119] <TB2> INFO: PixTest:: pg_setup set to default.
[15:05:04.121] <TB2> INFO: 2 hot pixels found in step 1
[15:05:05.091] <TB2> INFO: Collecting data for 1 seconds...
[15:05:06.092] <TB2> INFO: Done with hot pixel readout
[15:05:11.347] <TB2> INFO: PixTest:: pg_setup set to default.
[15:05:11.348] <TB2> INFO: 2 hot pixels found in step 2
[15:05:12.316] <TB2> INFO: Collecting data for 1 seconds...
[15:05:13.318] <TB2> INFO: Done with hot pixel readout
[15:05:18.617] <TB2> INFO: PixTest:: pg_setup set to default.
[15:05:18.619] <TB2> INFO: 0 hot pixels found in step 3
[15:05:18.629] <TB2> INFO: 0 hot pixels could not be trimmed and have been masked.
[15:05:18.671] <TB2> INFO: PixTest::trimHotPixels() done
[15:05:18.671] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:05:18.677] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:05:18.683] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:05:18.692] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:05:18.698] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:05:18.704] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:05:18.710] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:05:18.716] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:05:18.723] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:05:18.729] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:05:18.735] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:05:18.741] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:05:18.747] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:05:18.753] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:05:18.759] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:05:18.765] <TB2> INFO: write trim parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:05:18.771] <TB2> INFO: write masked pixels into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:05:18.805] <TB2> INFO: enter test to run
[15:05:18.805] <TB2> INFO: test: no parameter change
[15:05:18.964] <TB2> QUIET: Connection to board 162 closed.
[15:05:19.044] <TB2> INFO: pXar: this is the end, my friend
commander_HRData.log
[15:06:31.346] <TB2> INFO: *** Welcome to pxar ***
[15:06:31.346] <TB2> INFO: *** Today: 2015/08/11
[15:06:31.346] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//dacParameters35_C15.dat
[15:06:31.347] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//tbmParameters_C0b.dat
[15:06:31.347] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//defaultMaskFile.dat
[15:06:31.347] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//trimParameters35_C15.dat
[15:06:31.428] <TB2> INFO: clk: 4
[15:06:31.428] <TB2> INFO: ctr: 4
[15:06:31.428] <TB2> INFO: sda: 19
[15:06:31.428] <TB2> INFO: tin: 9
[15:06:31.428] <TB2> INFO: level: 15
[15:06:31.428] <TB2> INFO: triggerdelay: 0
[15:06:31.428] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:06:31.428] <TB2> INFO: Log level: INFO
[15:06:32.440] <TB2> INFO: Found DTB DTB_WXENWR
[15:06:35.459] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[15:06:35.463] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[15:06:35.466] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[15:06:37.041] <TB2> INFO: DUT info:
[15:06:37.041] <TB2> INFO: The DUT currently contains the following objects:
[15:06:37.041] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[15:06:37.041] <TB2> INFO: TBM Core alpha (0): 7 registers set
[15:06:37.041] <TB2> INFO: TBM Core beta (1): 7 registers set
[15:06:37.041] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:06:37.041] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.041] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.041] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.041] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.042] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:06:37.443] <TB2> INFO: enter 'restricted' command line mode
[15:06:37.443] <TB2> INFO: enter test to run
[15:06:37.444] <TB2> INFO: test: delay setting parameters: ->5<-
[15:06:37.444] <TB2> INFO: delay test by 5 seconds...
[15:06:42.444] <TB2> INFO: enter test to run
[15:06:42.444] <TB2> INFO: test: Xray no parameter change
[15:06:42.444] <TB2> INFO: running: xray
[15:06:42.444] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//003_HRData_50//phCalibrationFitErr35_C15.dat
[15:06:42.595] <TB2> INFO: ######################################################################
[15:06:42.595] <TB2> INFO: PixTestXray::doTest()
[15:06:42.595] <TB2> INFO: ######################################################################
[15:06:42.595] <TB2> INFO: ----------------------------------------------------------------------
[15:06:42.595] <TB2> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:06:42.595] <TB2> INFO: ----------------------------------------------------------------------
[15:06:43.573] <TB2> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:06:49.616] <TB2> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[15:07:09.533] <TB2> INFO: Resuming triggers.
[15:07:15.588] <TB2> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[15:07:19.063] <TB2> WARNING: Channel 3 ROC 0: Readback start marker after 32 readouts!

[15:07:19.063] <TB2> WARNING: Channel 3 ROC 3: Readback start marker after 32 readouts!

[15:07:36.279] <TB2> INFO: Resuming triggers.
[15:07:42.338] <TB2> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[15:08:01.802] <TB2> INFO: Resuming triggers.
[15:08:07.858] <TB2> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[15:08:28.512] <TB2> INFO: Resuming triggers.
[15:08:34.568] <TB2> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[15:08:55.226] <TB2> INFO: Resuming triggers.
[15:09:01.279] <TB2> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[15:09:21.440] <TB2> INFO: Resuming triggers.
[15:09:27.499] <TB2> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[15:09:49.260] <TB2> INFO: Resuming triggers.
[15:09:55.319] <TB2> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[15:10:16.044] <TB2> INFO: Resuming triggers.
[15:10:22.098] <TB2> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[15:10:44.099] <TB2> INFO: Resuming triggers.
[15:10:50.155] <TB2> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[15:11:12.396] <TB2> INFO: Resuming triggers.
[15:11:18.450] <TB2> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[15:11:40.802] <TB2> INFO: Resuming triggers.
[15:11:46.854] <TB2> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[15:12:08.082] <TB2> INFO: Resuming triggers.
[15:12:14.133] <TB2> INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[15:12:34.712] <TB2> INFO: Resuming triggers.
[15:12:40.763] <TB2> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[15:13:00.335] <TB2> INFO: Resuming triggers.
[15:13:06.389] <TB2> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[15:13:26.525] <TB2> INFO: Resuming triggers.
[15:13:32.581] <TB2> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[15:13:54.043] <TB2> INFO: Resuming triggers.
[15:13:57.267] <TB2> INFO: data taking finished, elapsed time: 100 seconds.
[15:14:08.163] <TB2> INFO: PixTest:: pg_setup set to default.
[15:14:08.165] <TB2> INFO: PixTestXray::doPhRun() done
[15:14:08.165] <TB2> INFO: PixTestXray::doTest() done
[15:14:08.378] <TB2> INFO: enter test to run
[15:14:08.378] <TB2> INFO: test: no parameter change
[15:14:08.563] <TB2> QUIET: Connection to board 162 closed.
[15:14:08.643] <TB2> INFO: pXar: this is the end, my friend
commander_HRData.log
[15:15:12.801] <TB2> INFO: *** Welcome to pxar ***
[15:15:12.802] <TB2> INFO: *** Today: 2015/08/11
[15:15:12.802] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//dacParameters35_C15.dat
[15:15:12.803] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//tbmParameters_C0b.dat
[15:15:12.803] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//defaultMaskFile.dat
[15:15:12.803] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//trimParameters35_C15.dat
[15:15:12.888] <TB2> INFO: clk: 4
[15:15:12.888] <TB2> INFO: ctr: 4
[15:15:12.888] <TB2> INFO: sda: 19
[15:15:12.888] <TB2> INFO: tin: 9
[15:15:12.888] <TB2> INFO: level: 15
[15:15:12.888] <TB2> INFO: triggerdelay: 0
[15:15:12.888] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:15:12.888] <TB2> INFO: Log level: INFO
[15:15:13.900] <TB2> INFO: Found DTB DTB_WXENWR
[15:15:16.920] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[15:15:16.923] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[15:15:16.926] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[15:15:18.478] <TB2> INFO: DUT info:
[15:15:18.478] <TB2> INFO: The DUT currently contains the following objects:
[15:15:18.478] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[15:15:18.478] <TB2> INFO: TBM Core alpha (0): 7 registers set
[15:15:18.478] <TB2> INFO: TBM Core beta (1): 7 registers set
[15:15:18.478] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:15:18.478] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.478] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.479] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.479] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:18.880] <TB2> INFO: enter 'restricted' command line mode
[15:15:18.880] <TB2> INFO: enter test to run
[15:15:18.880] <TB2> INFO: test: delay setting parameters: ->5<-
[15:15:18.880] <TB2> INFO: delay test by 5 seconds...
[15:15:23.880] <TB2> INFO: enter test to run
[15:15:23.880] <TB2> INFO: test: Xray no parameter change
[15:15:23.880] <TB2> INFO: running: xray
[15:15:23.881] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//004_HRData_150//phCalibrationFitErr35_C15.dat
[15:15:24.071] <TB2> INFO: ######################################################################
[15:15:24.071] <TB2> INFO: PixTestXray::doTest()
[15:15:24.071] <TB2> INFO: ######################################################################
[15:15:24.071] <TB2> INFO: ----------------------------------------------------------------------
[15:15:24.071] <TB2> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:15:24.071] <TB2> INFO: ----------------------------------------------------------------------
[15:15:25.047] <TB2> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:15:28.218] <TB2> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[15:15:49.055] <TB2> INFO: Resuming triggers.
[15:15:52.247] <TB2> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[15:15:55.541] <TB2> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (171) != TBM ID (105)

[15:15:55.541] <TB2> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (0) != Token Chain Length (4)

[15:15:55.541] <TB2> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (106) != TBM ID (171)

[15:16:15.273] <TB2> INFO: Resuming triggers.
[15:16:18.464] <TB2> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[15:16:40.207] <TB2> INFO: Resuming triggers.
[15:16:43.398] <TB2> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[15:17:05.072] <TB2> INFO: Resuming triggers.
[15:17:08.261] <TB2> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[15:17:30.352] <TB2> INFO: Resuming triggers.
[15:17:33.546] <TB2> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[15:17:56.737] <TB2> INFO: Resuming triggers.
[15:17:59.926] <TB2> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[15:18:23.620] <TB2> INFO: Resuming triggers.
[15:18:26.808] <TB2> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[15:18:49.851] <TB2> INFO: Resuming triggers.
[15:18:53.041] <TB2> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[15:19:16.534] <TB2> INFO: Resuming triggers.
[15:19:19.721] <TB2> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[15:19:42.034] <TB2> INFO: Resuming triggers.
[15:19:45.222] <TB2> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[15:20:07.337] <TB2> INFO: Resuming triggers.
[15:20:10.522] <TB2> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[15:20:32.013] <TB2> INFO: Resuming triggers.
[15:20:35.202] <TB2> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[15:20:55.877] <TB2> INFO: Resuming triggers.
[15:20:59.063] <TB2> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[15:21:21.036] <TB2> INFO: Resuming triggers.
[15:21:24.222] <TB2> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[15:21:46.029] <TB2> INFO: Resuming triggers.
[15:21:49.214] <TB2> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[15:22:11.266] <TB2> INFO: Resuming triggers.
[15:22:14.453] <TB2> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[15:22:36.649] <TB2> INFO: Resuming triggers.
[15:22:39.835] <TB2> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[15:22:51.292] <TB2> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 1 Number of ROCs (5) != Token Chain Length (4)

[15:23:02.121] <TB2> INFO: Resuming triggers.
[15:23:05.310] <TB2> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[15:23:26.961] <TB2> INFO: Resuming triggers.
[15:23:30.148] <TB2> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[15:23:53.156] <TB2> INFO: Resuming triggers.
[15:23:56.341] <TB2> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[15:24:18.913] <TB2> INFO: Resuming triggers.
[15:24:22.100] <TB2> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[15:24:44.374] <TB2> INFO: Resuming triggers.
[15:24:47.561] <TB2> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[15:25:10.880] <TB2> INFO: Resuming triggers.
[15:25:14.061] <TB2> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[15:25:37.494] <TB2> INFO: Resuming triggers.
[15:25:40.678] <TB2> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[15:26:04.010] <TB2> INFO: Resuming triggers.
[15:26:07.196] <TB2> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[15:26:30.428] <TB2> INFO: Resuming triggers.
[15:26:33.618] <TB2> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[15:26:56.189] <TB2> INFO: Resuming triggers.
[15:26:59.376] <TB2> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[15:27:22.202] <TB2> INFO: Resuming triggers.
[15:27:25.386] <TB2> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[15:27:46.936] <TB2> INFO: Resuming triggers.
[15:27:50.119] <TB2> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[15:28:13.683] <TB2> INFO: Resuming triggers.
[15:28:16.865] <TB2> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[15:28:39.373] <TB2> INFO: Resuming triggers.
[15:28:40.670] <TB2> INFO: data taking finished, elapsed time: 100 seconds.
[15:28:49.794] <TB2> INFO: PixTest:: pg_setup set to default.
[15:28:49.796] <TB2> INFO: PixTestXray::doPhRun() done
[15:28:49.796] <TB2> INFO: PixTestXray::doTest() done
[15:28:49.983] <TB2> INFO: enter test to run
[15:28:49.983] <TB2> INFO: test: no parameter change
[15:28:50.178] <TB2> QUIET: Connection to board 162 closed.
[15:28:50.257] <TB2> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[15:29:48.247] <TB2> INFO: *** Welcome to pxar ***
[15:29:48.247] <TB2> INFO: *** Today: 2015/08/11
[15:29:48.247] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//dacParameters35_C15.dat
[15:29:48.248] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//tbmParameters_C0b.dat
[15:29:48.248] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//defaultMaskFile.dat
[15:29:48.248] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//trimParameters35_C15.dat
[15:29:48.328] <TB2> INFO: clk: 4
[15:29:48.328] <TB2> INFO: ctr: 4
[15:29:48.328] <TB2> INFO: sda: 19
[15:29:48.328] <TB2> INFO: tin: 9
[15:29:48.328] <TB2> INFO: level: 15
[15:29:48.328] <TB2> INFO: triggerdelay: 0
[15:29:48.328] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:29:48.328] <TB2> INFO: Log level: INFO
[15:29:49.340] <TB2> INFO: Found DTB DTB_WXENWR
[15:29:52.361] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[15:29:52.364] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[15:29:52.367] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[15:29:53.932] <TB2> INFO: DUT info:
[15:29:53.932] <TB2> INFO: The DUT currently contains the following objects:
[15:29:53.932] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[15:29:53.932] <TB2> INFO: TBM Core alpha (0): 7 registers set
[15:29:53.932] <TB2> INFO: TBM Core beta (1): 7 registers set
[15:29:53.932] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:29:53.932] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:53.933] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:54.335] <TB2> INFO: enter 'restricted' command line mode
[15:29:54.335] <TB2> INFO: enter test to run
[15:29:54.335] <TB2> INFO: test: Highrate no parameter change
[15:29:54.335] <TB2> INFO: running: highrate
[15:29:54.335] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[15:29:54.555] <TB2> INFO: ----------------------------------------------------------------------
[15:29:54.555] <TB2> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[15:29:54.555] <TB2> INFO: ----------------------------------------------------------------------
[15:29:54.563] <TB2> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 100 (1) hits flags = 384 (plus default)
[15:29:54.579] <TB2> INFO: dacScan step from 0 .. 0
[15:30:06.432] <TB2> INFO: Test took 11852ms.
[15:30:09.146] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:09.519] <TB2> INFO: dacScan step from 1 .. 1
[15:30:21.680] <TB2> INFO: Test took 12161ms.
[15:30:24.080] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:24.413] <TB2> INFO: dacScan step from 2 .. 2
[15:30:36.388] <TB2> INFO: Test took 11975ms.
[15:30:38.528] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:38.889] <TB2> INFO: dacScan step from 3 .. 3
[15:30:51.034] <TB2> INFO: Test took 12145ms.
[15:30:53.613] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:30:53.886] <TB2> INFO: dacScan step from 4 .. 4
[15:31:05.911] <TB2> INFO: Test took 12025ms.
[15:31:07.984] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:08.271] <TB2> INFO: dacScan step from 5 .. 5
[15:31:20.417] <TB2> INFO: Test took 12145ms.
[15:31:23.039] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:23.411] <TB2> INFO: dacScan step from 6 .. 6
[15:31:35.703] <TB2> INFO: Test took 12292ms.
[15:31:37.943] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:38.255] <TB2> INFO: dacScan step from 7 .. 7
[15:31:50.130] <TB2> INFO: Test took 11874ms.
[15:31:52.466] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:52.788] <TB2> INFO: dacScan step from 8 .. 8
[15:32:04.599] <TB2> INFO: Test took 11811ms.
[15:32:07.157] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:07.521] <TB2> INFO: dacScan step from 9 .. 9
[15:32:19.455] <TB2> INFO: Test took 11934ms.
[15:32:21.745] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:22.093] <TB2> INFO: dacScan step from 10 .. 10
[15:32:34.186] <TB2> INFO: Test took 12093ms.
[15:32:36.339] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:36.651] <TB2> INFO: dacScan step from 11 .. 11
[15:32:48.917] <TB2> INFO: Test took 12266ms.
[15:32:51.534] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:51.884] <TB2> INFO: dacScan step from 12 .. 12
[15:33:04.066] <TB2> INFO: Test took 12181ms.
[15:33:06.354] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:06.697] <TB2> INFO: dacScan step from 13 .. 13
[15:33:18.903] <TB2> INFO: Test took 12206ms.
[15:33:21.153] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:21.505] <TB2> INFO: dacScan step from 14 .. 14
[15:33:33.545] <TB2> INFO: Test took 12039ms.
[15:33:36.137] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:36.460] <TB2> INFO: dacScan step from 15 .. 15
[15:33:48.362] <TB2> INFO: Test took 11901ms.
[15:33:50.732] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:33:51.012] <TB2> INFO: dacScan step from 16 .. 16
[15:34:02.978] <TB2> INFO: Test took 11966ms.
[15:34:05.044] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:05.322] <TB2> INFO: dacScan step from 17 .. 17
[15:34:17.712] <TB2> INFO: Test took 12390ms.
[15:34:20.119] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:20.399] <TB2> INFO: dacScan step from 18 .. 18
[15:34:32.983] <TB2> INFO: Test took 12583ms.
[15:34:35.673] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:36.013] <TB2> INFO: dacScan step from 19 .. 19
[15:34:48.429] <TB2> INFO: Test took 12416ms.
[15:34:50.992] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:51.350] <TB2> INFO: dacScan step from 20 .. 20
[15:35:03.732] <TB2> INFO: Test took 12382ms.
[15:35:06.042] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:06.398] <TB2> INFO: dacScan step from 21 .. 21
[15:35:18.411] <TB2> INFO: Test took 12013ms.
[15:35:20.774] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:21.093] <TB2> INFO: dacScan step from 22 .. 22
[15:35:33.092] <TB2> INFO: Test took 11999ms.
[15:35:35.357] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:35.700] <TB2> INFO: dacScan step from 23 .. 23
[15:35:47.711] <TB2> INFO: Test took 12011ms.
[15:35:49.966] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:35:50.273] <TB2> INFO: dacScan step from 24 .. 24
[15:36:02.710] <TB2> INFO: Test took 12436ms.
[15:36:05.355] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:05.666] <TB2> INFO: dacScan step from 25 .. 25
[15:36:18.235] <TB2> INFO: Test took 12568ms.
[15:36:20.274] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:20.550] <TB2> INFO: dacScan step from 26 .. 26
[15:36:33.113] <TB2> INFO: Test took 12563ms.
[15:36:35.190] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:35.473] <TB2> INFO: dacScan step from 27 .. 27
[15:36:47.748] <TB2> INFO: Test took 12274ms.
[15:36:49.867] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:50.144] <TB2> INFO: dacScan step from 28 .. 28
[15:37:02.227] <TB2> INFO: Test took 12082ms.
[15:37:04.347] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:04.623] <TB2> INFO: dacScan step from 29 .. 29
[15:37:16.795] <TB2> INFO: Test took 12171ms.
[15:37:19.387] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:19.715] <TB2> INFO: dacScan step from 30 .. 30
[15:37:31.915] <TB2> INFO: Test took 12199ms.
[15:37:34.022] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:34.314] <TB2> INFO: dacScan step from 31 .. 31
[15:37:46.695] <TB2> INFO: Test took 12380ms.
[15:37:49.166] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:49.449] <TB2> INFO: dacScan step from 32 .. 32
[15:38:01.994] <TB2> INFO: Test took 12545ms.
[15:38:04.341] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:04.673] <TB2> INFO: dacScan step from 33 .. 33
[15:38:17.285] <TB2> INFO: Test took 12611ms.
[15:38:19.375] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:19.661] <TB2> INFO: dacScan step from 34 .. 34
[15:38:32.218] <TB2> INFO: Test took 12557ms.
[15:38:34.871] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:35.222] <TB2> INFO: dacScan step from 35 .. 35
[15:38:47.489] <TB2> INFO: Test took 12266ms.
[15:38:50.120] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:38:50.422] <TB2> INFO: dacScan step from 36 .. 36
[15:39:02.604] <TB2> INFO: Test took 12181ms.
[15:39:04.702] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:04.996] <TB2> INFO: dacScan step from 37 .. 37
[15:39:17.273] <TB2> INFO: Test took 12276ms.
[15:39:19.488] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:19.807] <TB2> INFO: dacScan step from 38 .. 38
[15:39:32.308] <TB2> INFO: Test took 12500ms.
[15:39:34.528] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:34.823] <TB2> INFO: dacScan step from 39 .. 39
[15:39:47.723] <TB2> INFO: Test took 12899ms.
[15:39:49.915] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:39:50.239] <TB2> INFO: dacScan step from 40 .. 40
[15:40:03.400] <TB2> INFO: Test took 13161ms.
[15:40:06.150] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:06.524] <TB2> INFO: dacScan step from 41 .. 41
[15:40:19.663] <TB2> INFO: Test took 13139ms.
[15:40:22.361] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:22.723] <TB2> INFO: dacScan step from 42 .. 42
[15:40:36.139] <TB2> INFO: Test took 13415ms.
[15:40:38.849] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:39.173] <TB2> INFO: dacScan step from 43 .. 43
[15:40:52.621] <TB2> INFO: Test took 13447ms.
[15:40:55.198] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:55.519] <TB2> INFO: dacScan step from 44 .. 44
[15:41:08.850] <TB2> INFO: Test took 13330ms.
[15:41:11.226] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:41:11.532] <TB2> INFO: dacScan step from 45 .. 45
[15:41:25.190] <TB2> INFO: Test took 13657ms.
[15:41:27.827] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:41:28.203] <TB2> INFO: dacScan step from 46 .. 46
[15:41:42.114] <TB2> INFO: Test took 13910ms.
[15:41:44.861] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:41:45.185] <TB2> INFO: dacScan step from 47 .. 47
[15:41:59.706] <TB2> INFO: Test took 14520ms.
[15:42:02.066] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:42:02.403] <TB2> INFO: dacScan step from 48 .. 48
[15:42:17.412] <TB2> INFO: Test took 15008ms.
[15:42:20.210] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:42:20.586] <TB2> INFO: dacScan step from 49 .. 49
[15:42:35.611] <TB2> INFO: Test took 15024ms.
[15:42:38.569] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:42:38.904] <TB2> INFO: dacScan step from 50 .. 50
[15:42:53.990] <TB2> INFO: Test took 15085ms.
[15:42:56.886] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:42:57.268] <TB2> INFO: dacScan step from 51 .. 51
[15:43:12.233] <TB2> INFO: Test took 14964ms.
[15:43:15.200] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:43:15.591] <TB2> INFO: dacScan step from 52 .. 52
[15:43:30.306] <TB2> INFO: Test took 14714ms.
[15:43:33.019] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:43:33.332] <TB2> INFO: dacScan step from 53 .. 53
[15:43:47.863] <TB2> INFO: Test took 14530ms.
[15:43:50.463] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:43:50.839] <TB2> INFO: dacScan step from 54 .. 54
[15:44:05.365] <TB2> INFO: Test took 14526ms.
[15:44:08.255] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:44:08.564] <TB2> INFO: dacScan step from 55 .. 55
[15:44:23.111] <TB2> INFO: Test took 14547ms.
[15:44:25.396] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:44:25.701] <TB2> INFO: dacScan step from 56 .. 56
[15:44:40.537] <TB2> INFO: Test took 14836ms.
[15:44:43.063] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:44:43.357] <TB2> INFO: dacScan step from 57 .. 57
[15:44:58.398] <TB2> INFO: Test took 15040ms.
[15:45:01.317] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:01.650] <TB2> INFO: dacScan step from 58 .. 58
[15:45:16.736] <TB2> INFO: Test took 15085ms.
[15:45:19.668] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:20.021] <TB2> INFO: dacScan step from 59 .. 59
[15:45:35.058] <TB2> INFO: Test took 15037ms.
[15:45:37.777] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:38.146] <TB2> INFO: dacScan step from 60 .. 60
[15:45:52.430] <TB2> INFO: Test took 14283ms.
[15:45:55.246] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:55.600] <TB2> INFO: dacScan step from 61 .. 61
[15:46:09.854] <TB2> INFO: Test took 14254ms.
[15:46:12.607] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:12.974] <TB2> INFO: dacScan step from 62 .. 62
[15:46:27.508] <TB2> INFO: Test took 14533ms.
[15:46:29.751] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:30.034] <TB2> INFO: dacScan step from 63 .. 63
[15:46:44.838] <TB2> INFO: Test took 14803ms.
[15:46:47.518] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:47.832] <TB2> INFO: dacScan step from 64 .. 64
[15:47:02.526] <TB2> INFO: Test took 14693ms.
[15:47:05.486] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:05.869] <TB2> INFO: dacScan step from 65 .. 65
[15:47:20.605] <TB2> INFO: Test took 14735ms.
[15:47:23.536] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:23.921] <TB2> INFO: dacScan step from 66 .. 66
[15:47:38.358] <TB2> INFO: Test took 14436ms.
[15:47:41.217] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:41.630] <TB2> INFO: dacScan step from 67 .. 67
[15:47:55.591] <TB2> INFO: Test took 13960ms.
[15:47:58.265] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:58.648] <TB2> INFO: dacScan step from 68 .. 68
[15:48:12.753] <TB2> INFO: Test took 14104ms.
[15:48:15.643] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:16.018] <TB2> INFO: dacScan step from 69 .. 69
[15:48:30.555] <TB2> INFO: Test took 14536ms.
[15:48:32.925] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:33.235] <TB2> INFO: dacScan step from 70 .. 70
[15:48:47.911] <TB2> INFO: Test took 14675ms.
[15:48:50.495] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:50.862] <TB2> INFO: dacScan step from 71 .. 71
[15:49:05.668] <TB2> INFO: Test took 14805ms.
[15:49:07.986] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:08.289] <TB2> INFO: dacScan step from 72 .. 72
[15:49:22.658] <TB2> INFO: Test took 14368ms.
[15:49:25.347] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:25.726] <TB2> INFO: dacScan step from 73 .. 73
[15:49:39.958] <TB2> INFO: Test took 14231ms.
[15:49:42.932] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:43.319] <TB2> INFO: dacScan step from 74 .. 74
[15:49:57.721] <TB2> INFO: Test took 14401ms.
[15:50:00.018] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:00.332] <TB2> INFO: dacScan step from 75 .. 75
[15:50:15.179] <TB2> INFO: Test took 14846ms.
[15:50:17.962] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:18.270] <TB2> INFO: dacScan step from 76 .. 76
[15:50:33.073] <TB2> INFO: Test took 14802ms.
[15:50:35.402] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:35.695] <TB2> INFO: dacScan step from 77 .. 77
[15:50:50.630] <TB2> INFO: Test took 14934ms.
[15:50:53.356] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:53.711] <TB2> INFO: dacScan step from 78 .. 78
[15:51:08.512] <TB2> INFO: Test took 14800ms.
[15:51:10.803] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:11.113] <TB2> INFO: dacScan step from 79 .. 79
[15:51:25.712] <TB2> INFO: Test took 14598ms.
[15:51:28.495] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:28.847] <TB2> INFO: dacScan step from 80 .. 80
[15:51:43.560] <TB2> INFO: Test took 14712ms.
[15:51:46.367] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:46.702] <TB2> INFO: dacScan step from 81 .. 81
[15:52:01.283] <TB2> INFO: Test took 14580ms.
[15:52:04.076] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:04.436] <TB2> INFO: dacScan step from 82 .. 82
[15:52:19.382] <TB2> INFO: Test took 14945ms.
[15:52:21.787] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:22.114] <TB2> INFO: dacScan step from 83 .. 83
[15:52:37.384] <TB2> INFO: Test took 15269ms.
[15:52:40.356] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:40.716] <TB2> INFO: dacScan step from 84 .. 84
[15:52:55.862] <TB2> INFO: Test took 15145ms.
[15:52:58.540] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:58.916] <TB2> INFO: dacScan step from 85 .. 85
[15:53:13.841] <TB2> INFO: Test took 14924ms.
[15:53:16.334] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:53:16.643] <TB2> INFO: dacScan step from 86 .. 86
[15:53:30.861] <TB2> INFO: Test took 14217ms.
[15:53:33.840] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:53:34.215] <TB2> INFO: dacScan step from 87 .. 87
[15:53:48.374] <TB2> INFO: Test took 14158ms.
[15:53:51.319] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:53:51.700] <TB2> INFO: dacScan step from 88 .. 88
[15:54:06.319] <TB2> INFO: Test took 14618ms.
[15:54:08.950] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:09.300] <TB2> INFO: dacScan step from 89 .. 89
[15:54:24.026] <TB2> INFO: Test took 14725ms.
[15:54:26.574] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:26.888] <TB2> INFO: dacScan step from 90 .. 90
[15:54:41.514] <TB2> INFO: Test took 14625ms.
[15:54:44.440] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:44.819] <TB2> INFO: dacScan step from 91 .. 91
[15:54:59.475] <TB2> INFO: Test took 14655ms.
[15:55:02.416] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:02.787] <TB2> INFO: dacScan step from 92 .. 92
[15:55:17.355] <TB2> INFO: Test took 14567ms.
[15:55:20.281] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:20.654] <TB2> INFO: dacScan step from 93 .. 93
[15:55:35.186] <TB2> INFO: Test took 14531ms.
[15:55:37.447] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:37.753] <TB2> INFO: dacScan step from 94 .. 94
[15:55:52.037] <TB2> INFO: Test took 14283ms.
[15:55:54.687] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:55.025] <TB2> INFO: dacScan step from 95 .. 95
[15:56:09.597] <TB2> INFO: Test took 14571ms.
[15:56:11.994] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:12.315] <TB2> INFO: dacScan step from 96 .. 96
[15:56:26.808] <TB2> INFO: Test took 14492ms.
[15:56:29.174] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:29.464] <TB2> INFO: dacScan step from 97 .. 97
[15:56:43.949] <TB2> INFO: Test took 14484ms.
[15:56:46.481] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:46.771] <TB2> INFO: dacScan step from 98 .. 98
[15:57:01.112] <TB2> INFO: Test took 14340ms.
[15:57:03.506] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:57:03.880] <TB2> INFO: dacScan step from 99 .. 99
[15:57:18.316] <TB2> INFO: Test took 14434ms.
[15:57:20.696] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:57:21.009] <TB2> INFO: dacScan step from 100 .. 100
[15:57:35.244] <TB2> INFO: Test took 14234ms.
[15:57:37.662] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:57:38.043] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:39.387] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:40.683] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:41.969] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:43.383] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:44.778] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:46.332] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:47.830] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:49.329] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:50.866] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:52.498] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:54.064] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:55.474] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:56.867] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:58.158] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:57:59.459] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[15:58:00.752] <TB2> INFO: PixTest:: pg_setup set to default.
[15:58:00.754] <TB2> INFO: vcal mean: 39.51 38.81 37.99 42.20 43.10 44.54 42.52 43.41 44.45 44.38 44.47 43.32 42.54 40.61 39.93 40.55
[15:58:00.754] <TB2> INFO: vcal RMS: 1.53 1.42 1.07 1.91 1.37 1.52 1.46 1.46 1.60 1.46 1.59 1.60 1.35 1.49 1.21 1.33
[15:58:00.754] <TB2> INFO: number of X-ray hits detected: 213440 230497 192963 351665 399497 478931 381605 422747 466741 466323 481669 392168 367852 232758 213042 234054
[15:58:00.754] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:58:00.754] <TB2> INFO: X-ray hit rate [MHz/cm2]: 62.6 67.6 56.6 103.1 117.1 140.4 111.9 123.9 136.8 136.7 141.2 114.9 107.8 68.2 62.4 68.6
[15:58:00.754] <TB2> INFO: PixTestHighRate::doXNoiseMaps() done
[15:58:00.851] <TB2> INFO: enter test to run
[15:58:00.851] <TB2> INFO: test: no parameter change
[15:58:01.037] <TB2> QUIET: Connection to board 162 closed.
[15:58:01.116] <TB2> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[16:18:53.512] <TB2> INFO: *** Welcome to pxar ***
[16:18:53.513] <TB2> INFO: *** Today: 2015/08/11
[16:18:53.513] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:18:53.514] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[16:18:53.514] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[16:18:53.515] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[16:18:53.586] <TB2> INFO: clk: 4
[16:18:53.586] <TB2> INFO: ctr: 4
[16:18:53.586] <TB2> INFO: sda: 19
[16:18:53.586] <TB2> INFO: tin: 9
[16:18:53.586] <TB2> INFO: level: 15
[16:18:53.586] <TB2> INFO: triggerdelay: 0
[16:18:53.586] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:18:53.586] <TB2> INFO: Log level: INFO
[16:18:54.598] <TB2> INFO: Found DTB DTB_WXENWR
[16:18:57.617] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[16:18:57.620] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[16:18:57.623] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[16:18:59.151] <TB2> INFO: DUT info:
[16:18:59.151] <TB2> INFO: The DUT currently contains the following objects:
[16:18:59.151] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[16:18:59.151] <TB2> INFO: TBM Core alpha (0): 7 registers set
[16:18:59.151] <TB2> INFO: TBM Core beta (1): 7 registers set
[16:18:59.151] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:18:59.151] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.151] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.151] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.152] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:59.553] <TB2> INFO: enter 'restricted' command line mode
[16:18:59.553] <TB2> INFO: enter test to run
[16:18:59.553] <TB2> INFO: test: HighRate no parameter change
[16:18:59.553] <TB2> INFO: running: highrate
[16:18:59.553] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[16:18:59.715] <TB2> INFO: ----------------------------------------------------------------------
[16:18:59.715] <TB2> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[16:18:59.715] <TB2> INFO: ----------------------------------------------------------------------
[16:19:00.802] <TB2> INFO: Test took 1081ms.
[16:19:04.204] <TB2> INFO: Test took 3396ms.
[16:19:04.376] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:07.938] <TB2> INFO: Test took 3522ms.
[16:19:08.139] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:11.789] <TB2> INFO: Test took 3604ms.
[16:19:11.957] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:15.505] <TB2> INFO: Test took 3516ms.
[16:19:15.687] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:19.321] <TB2> INFO: Test took 3593ms.
[16:19:19.509] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:23.076] <TB2> INFO: Test took 3533ms.
[16:19:23.265] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:26.809] <TB2> INFO: Test took 3509ms.
[16:19:27.012] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:30.542] <TB2> INFO: Test took 3488ms.
[16:19:30.749] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:34.318] <TB2> INFO: Test took 3528ms.
[16:19:34.502] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:38.086] <TB2> INFO: Test took 3552ms.
[16:19:38.269] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:41.931] <TB2> INFO: Test took 3629ms.
[16:19:42.103] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:45.737] <TB2> INFO: Test took 3602ms.
[16:19:45.934] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:49.598] <TB2> INFO: Test took 3623ms.
[16:19:49.785] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:53.402] <TB2> INFO: Test took 3583ms.
[16:19:53.582] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:19:57.141] <TB2> INFO: Test took 3527ms.
[16:19:57.323] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:20:00.836] <TB2> INFO: Test took 3478ms.
[16:20:01.029] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:20:04.520] <TB2> INFO: Test took 3459ms.
[16:20:04.728] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:20:08.259] <TB2> INFO: Test took 3492ms.
[16:20:08.464] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:20:11.989] <TB2> INFO: Test took 3479ms.
[16:20:12.210] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:20:15.676] <TB2> INFO: Test took 3426ms.
[16:20:15.859] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:20:16.230] <TB2> INFO: enter test to run
[16:20:16.230] <TB2> INFO: test: Pretest no parameter change
[16:20:16.230] <TB2> INFO: running: pretest
[16:20:16.231] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[16:20:16.231] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[16:20:16.231] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[16:20:16.231] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[16:20:16.232] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[16:20:16.232] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[16:20:16.232] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[16:20:16.232] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[16:20:16.232] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[16:20:16.232] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[16:20:16.232] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[16:20:16.233] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[16:20:16.233] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[16:20:16.233] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[16:20:16.233] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[16:20:16.233] <TB2> INFO: write dac parameters into /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:20:16.233] <TB2> INFO: enter test to run
[16:20:16.233] <TB2> INFO: test: no parameter change
[16:20:16.423] <TB2> QUIET: Connection to board 162 closed.
[16:20:16.502] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:20:54.821] <TB2> INFO: *** Welcome to pxar ***
[16:20:54.821] <TB2> INFO: *** Today: 2015/08/11
[16:20:54.821] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//dacParameters35_C15.dat
[16:20:54.822] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//tbmParameters_C0b.dat
[16:20:54.822] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//defaultMaskFile.dat
[16:20:54.822] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//trimParameters35_C15.dat
[16:20:54.891] <TB2> INFO: clk: 4
[16:20:54.891] <TB2> INFO: ctr: 4
[16:20:54.891] <TB2> INFO: sda: 19
[16:20:54.891] <TB2> INFO: tin: 9
[16:20:54.891] <TB2> INFO: level: 15
[16:20:54.891] <TB2> INFO: triggerdelay: 0
[16:20:54.891] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:20:54.891] <TB2> INFO: Log level: INFO
[16:20:55.901] <TB2> INFO: Found DTB DTB_WXENWR
[16:20:58.920] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[16:20:58.924] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[16:20:58.927] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[16:21:00.468] <TB2> INFO: DUT info:
[16:21:00.468] <TB2> INFO: The DUT currently contains the following objects:
[16:21:00.468] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[16:21:00.468] <TB2> INFO: TBM Core alpha (0): 7 registers set
[16:21:00.468] <TB2> INFO: TBM Core beta (1): 7 registers set
[16:21:00.468] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:21:00.468] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.468] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.469] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.469] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.469] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.469] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.469] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.469] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:00.870] <TB2> INFO: enter 'restricted' command line mode
[16:21:00.870] <TB2> INFO: enter test to run
[16:21:00.870] <TB2> INFO: test: HighRate no parameter change
[16:21:00.870] <TB2> INFO: running: highrate
[16:21:00.871] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[16:21:01.024] <TB2> INFO: ----------------------------------------------------------------------
[16:21:01.024] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:21:01.024] <TB2> INFO: ----------------------------------------------------------------------
[16:21:13.085] <TB2> INFO: Test took 12054ms.
[16:21:14.273] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:14.640] <TB2> INFO: number of dead pixels (per ROC): 0 1 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[16:21:14.640] <TB2> INFO: number of red-efficiency pixels: 139 170 145 269 340 451 261 350 421 467 490 316 268 170 146 156
[16:21:14.640] <TB2> INFO: number of X-ray hits detected: 107047 113850 93657 177715 201694 245121 191055 214057 234472 237700 246175 197691 185725 114027 105360 117340
[16:21:14.640] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:21:14.640] <TB2> INFO: number of Vcal hits detected: 207854 207775 207842 207671 207638 207514 207722 207614 207551 207487 207462 207664 207721 207823 207852 207838
[16:21:14.640] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[16:21:14.640] <TB2> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.9 99.8 99.8 99.8 99.7 99.8 99.9 99.9 99.9 99.9
[16:21:14.640] <TB2> INFO: X-ray hit rate [MHz/cm2]: 31.4 33.4 27.5 52.1 59.1 71.8 56.0 62.7 68.7 69.7 72.2 57.9 54.4 33.4 30.9 34.4
[16:21:14.640] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[16:21:14.686] <TB2> INFO: PixTest:: pg_setup set to default.
[16:21:14.737] <TB2> INFO: enter test to run
[16:21:14.737] <TB2> INFO: test: no parameter change
[16:21:14.883] <TB2> QUIET: Connection to board 162 closed.
[16:21:14.963] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:21:48.762] <TB2> INFO: *** Welcome to pxar ***
[16:21:48.762] <TB2> INFO: *** Today: 2015/08/11
[16:21:48.762] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//dacParameters35_C15.dat
[16:21:48.763] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//tbmParameters_C0b.dat
[16:21:48.764] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//defaultMaskFile.dat
[16:21:48.764] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//trimParameters35_C15.dat
[16:21:48.841] <TB2> INFO: clk: 4
[16:21:48.841] <TB2> INFO: ctr: 4
[16:21:48.841] <TB2> INFO: sda: 19
[16:21:48.841] <TB2> INFO: tin: 9
[16:21:48.841] <TB2> INFO: level: 15
[16:21:48.841] <TB2> INFO: triggerdelay: 0
[16:21:48.841] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:21:48.841] <TB2> INFO: Log level: INFO
[16:21:49.851] <TB2> INFO: Found DTB DTB_WXENWR
[16:21:52.869] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[16:21:52.873] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[16:21:52.876] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[16:21:54.411] <TB2> INFO: DUT info:
[16:21:54.411] <TB2> INFO: The DUT currently contains the following objects:
[16:21:54.411] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[16:21:54.411] <TB2> INFO: TBM Core alpha (0): 7 registers set
[16:21:54.411] <TB2> INFO: TBM Core beta (1): 7 registers set
[16:21:54.411] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:21:54.411] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.411] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:54.813] <TB2> INFO: enter 'restricted' command line mode
[16:21:54.813] <TB2> INFO: enter test to run
[16:21:54.813] <TB2> INFO: test: HighRate no parameter change
[16:21:54.813] <TB2> INFO: running: highrate
[16:21:54.813] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[16:21:54.969] <TB2> INFO: ----------------------------------------------------------------------
[16:21:54.969] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:21:54.969] <TB2> INFO: ----------------------------------------------------------------------
[16:22:09.093] <TB2> INFO: Test took 14117ms.
[16:22:11.976] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:12.397] <TB2> INFO: number of dead pixels (per ROC): 0 1 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[16:22:12.397] <TB2> INFO: number of red-efficiency pixels: 369 402 578 996 1303 1710 1177 1370 1641 1748 1902 1212 1117 581 416 485
[16:22:12.397] <TB2> INFO: number of X-ray hits detected: 215743 231235 194826 353072 400392 481554 385648 426094 466466 470468 487078 394450 369686 232299 216717 235248
[16:22:12.397] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:22:12.397] <TB2> INFO: number of Vcal hits detected: 207612 207520 207227 206723 206177 205304 206394 206242 205656 205360 204999 206323 206652 207194 207543 207470
[16:22:12.397] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.5 99.2 98.9 99.3 99.2 99.0 98.9 98.7 99.3 99.4 99.7 99.8 99.8
[16:22:12.397] <TB2> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.6 99.4 99.1 98.7 99.2 99.2 98.9 98.7 98.6 99.2 99.4 99.6 99.8 99.7
[16:22:12.397] <TB2> INFO: X-ray hit rate [MHz/cm2]: 63.2 67.8 57.1 103.5 117.4 141.1 113.0 124.9 136.7 137.9 142.8 115.6 108.4 68.1 63.5 69.0
[16:22:12.397] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[16:22:12.442] <TB2> INFO: PixTest:: pg_setup set to default.
[16:22:12.478] <TB2> INFO: enter test to run
[16:22:12.478] <TB2> INFO: test: no parameter change
[16:22:12.620] <TB2> QUIET: Connection to board 162 closed.
[16:22:12.699] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:22:49.179] <TB2> INFO: *** Welcome to pxar ***
[16:22:49.179] <TB2> INFO: *** Today: 2015/08/11
[16:22:49.179] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//dacParameters35_C15.dat
[16:22:49.180] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//tbmParameters_C0b.dat
[16:22:49.181] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//defaultMaskFile.dat
[16:22:49.181] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//trimParameters35_C15.dat
[16:22:49.253] <TB2> INFO: clk: 4
[16:22:49.253] <TB2> INFO: ctr: 4
[16:22:49.253] <TB2> INFO: sda: 19
[16:22:49.253] <TB2> INFO: tin: 9
[16:22:49.253] <TB2> INFO: level: 15
[16:22:49.253] <TB2> INFO: triggerdelay: 0
[16:22:49.253] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:22:49.253] <TB2> INFO: Log level: INFO
[16:22:50.265] <TB2> INFO: Found DTB DTB_WXENWR
[16:22:53.283] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[16:22:53.286] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[16:22:53.289] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[16:22:54.832] <TB2> INFO: DUT info:
[16:22:54.832] <TB2> INFO: The DUT currently contains the following objects:
[16:22:54.832] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[16:22:54.832] <TB2> INFO: TBM Core alpha (0): 7 registers set
[16:22:54.832] <TB2> INFO: TBM Core beta (1): 7 registers set
[16:22:54.832] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:22:54.832] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:54.832] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:22:55.234] <TB2> INFO: enter 'restricted' command line mode
[16:22:55.234] <TB2> INFO: enter test to run
[16:22:55.234] <TB2> INFO: test: HighRate no parameter change
[16:22:55.234] <TB2> INFO: running: highrate
[16:22:55.234] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[16:22:55.383] <TB2> INFO: ----------------------------------------------------------------------
[16:22:55.383] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:22:55.383] <TB2> INFO: ----------------------------------------------------------------------
[16:23:11.501] <TB2> INFO: Test took 16111ms.
[16:23:16.970] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:23:17.473] <TB2> INFO: number of dead pixels (per ROC): 0 1 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[16:23:17.473] <TB2> INFO: number of red-efficiency pixels: 798 962 998 1911 2496 3184 2285 2690 3130 3059 3277 2375 2236 1093 922 945
[16:23:17.473] <TB2> INFO: number of X-ray hits detected: 311588 336745 283821 506660 575453 688615 555532 612073 671932 672938 696431 566390 530466 337901 314811 339485
[16:23:17.473] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:23:17.473] <TB2> INFO: number of Vcal hits detected: 207055 206829 206121 204783 202914 200093 203491 202896 201021 200405 199510 203355 204304 205911 206941 206852
[16:23:17.473] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.6 99.5 99.3 98.7 97.9 96.7 98.1 97.8 97.0 96.8 96.5 98.1 98.4 99.2 99.5 99.5
[16:23:17.473] <TB2> INFO: Vcal hit overall efficiency (%): 99.5 99.4 99.1 98.5 97.6 96.2 97.8 97.5 96.6 96.3 95.9 97.8 98.2 99.0 99.5 99.4
[16:23:17.473] <TB2> INFO: X-ray hit rate [MHz/cm2]: 91.3 98.7 83.2 148.5 168.7 201.8 162.8 179.4 196.9 197.2 204.1 166.0 155.5 99.0 92.3 99.5
[16:23:17.473] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[16:23:17.518] <TB2> INFO: PixTest:: pg_setup set to default.
[16:23:17.557] <TB2> INFO: enter test to run
[16:23:17.557] <TB2> INFO: test: no parameter change
[16:23:17.692] <TB2> QUIET: Connection to board 162 closed.
[16:23:17.772] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:23:50.713] <TB2> INFO: *** Welcome to pxar ***
[16:23:50.713] <TB2> INFO: *** Today: 2015/08/11
[16:23:50.713] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//dacParameters35_C15.dat
[16:23:50.715] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//tbmParameters_C0b.dat
[16:23:50.715] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//defaultMaskFile.dat
[16:23:50.715] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//trimParameters35_C15.dat
[16:23:50.811] <TB2> INFO: clk: 4
[16:23:50.811] <TB2> INFO: ctr: 4
[16:23:50.811] <TB2> INFO: sda: 19
[16:23:50.811] <TB2> INFO: tin: 9
[16:23:50.811] <TB2> INFO: level: 15
[16:23:50.811] <TB2> INFO: triggerdelay: 0
[16:23:50.811] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:23:50.811] <TB2> INFO: Log level: INFO
[16:23:51.823] <TB2> INFO: Found DTB DTB_WXENWR
[16:23:54.842] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[16:23:54.845] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[16:23:54.849] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[16:23:56.412] <TB2> INFO: DUT info:
[16:23:56.412] <TB2> INFO: The DUT currently contains the following objects:
[16:23:56.412] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[16:23:56.412] <TB2> INFO: TBM Core alpha (0): 7 registers set
[16:23:56.412] <TB2> INFO: TBM Core beta (1): 7 registers set
[16:23:56.412] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:23:56.412] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.412] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:56.813] <TB2> INFO: enter 'restricted' command line mode
[16:23:56.813] <TB2> INFO: enter test to run
[16:23:56.813] <TB2> INFO: test: HighRate no parameter change
[16:23:56.813] <TB2> INFO: running: highrate
[16:23:56.813] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[16:23:56.960] <TB2> INFO: ----------------------------------------------------------------------
[16:23:56.960] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:23:56.960] <TB2> INFO: ----------------------------------------------------------------------
[16:24:15.269] <TB2> INFO: Test took 18302ms.
[16:24:24.093] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:24:24.691] <TB2> INFO: number of dead pixels (per ROC): 0 1 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[16:24:24.691] <TB2> INFO: number of red-efficiency pixels: 1501 1782 1581 3095 3555 3986 3408 3784 3985 3929 4050 3557 3369 1673 1636 1726
[16:24:24.691] <TB2> INFO: number of X-ray hits detected: 423116 456311 387709 681120 773048 920459 751125 822123 902046 903452 933147 763091 714098 459276 427514 457329
[16:24:24.691] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:24:24.691] <TB2> INFO: number of Vcal hits detected: 205830 205389 203704 200215 196043 189187 196990 195519 190954 190092 188082 196659 199152 203212 205789 205368
[16:24:24.691] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.1 98.9 98.3 96.7 95.0 91.9 95.4 94.5 92.5 92.3 91.5 95.2 96.2 98.1 99.0 98.9
[16:24:24.691] <TB2> INFO: Vcal hit overall efficiency (%): 99.0 98.7 97.9 96.3 94.3 91.0 94.7 94.0 91.8 91.4 90.4 94.5 95.7 97.7 98.9 98.7
[16:24:24.691] <TB2> INFO: X-ray hit rate [MHz/cm2]: 124.0 133.7 113.6 199.6 226.6 269.8 220.2 241.0 264.4 264.8 273.5 223.7 209.3 134.6 125.3 134.0
[16:24:24.691] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[16:24:24.736] <TB2> INFO: PixTest:: pg_setup set to default.
[16:24:24.776] <TB2> INFO: enter test to run
[16:24:24.776] <TB2> INFO: test: no parameter change
[16:24:24.894] <TB2> QUIET: Connection to board 162 closed.
[16:24:24.974] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:24:57.964] <TB2> INFO: *** Welcome to pxar ***
[16:24:57.965] <TB2> INFO: *** Today: 2015/08/11
[16:24:57.965] <TB2> INFO: readRocDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//dacParameters35_C15.dat
[16:24:57.966] <TB2> INFO: readTbmDacs: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//tbmParameters_C0b.dat
[16:24:57.966] <TB2> INFO: readMaskFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//defaultMaskFile.dat
[16:24:57.966] <TB2> INFO: readTrimFile: /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//trimParameters35_C15.dat
[16:24:58.042] <TB2> INFO: clk: 4
[16:24:58.042] <TB2> INFO: ctr: 4
[16:24:58.042] <TB2> INFO: sda: 19
[16:24:58.042] <TB2> INFO: tin: 9
[16:24:58.042] <TB2> INFO: level: 15
[16:24:58.042] <TB2> INFO: triggerdelay: 0
[16:24:58.042] <TB2> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:24:58.042] <TB2> INFO: Log level: INFO
[16:24:59.054] <TB2> INFO: Found DTB DTB_WXENWR
[16:25:02.074] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[16:25:02.078] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[16:25:02.081] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[16:25:03.638] <TB2> INFO: DUT info:
[16:25:03.638] <TB2> INFO: The DUT currently contains the following objects:
[16:25:03.638] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[16:25:03.638] <TB2> INFO: TBM Core alpha (0): 7 registers set
[16:25:03.638] <TB2> INFO: TBM Core beta (1): 7 registers set
[16:25:03.638] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:25:03.638] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:03.638] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:04.040] <TB2> INFO: enter 'restricted' command line mode
[16:25:04.040] <TB2> INFO: enter test to run
[16:25:04.040] <TB2> INFO: test: HighRate no parameter change
[16:25:04.040] <TB2> INFO: running: highrate
[16:25:04.040] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2048_XrayQualification_2015-08-11_16h58m_1439305117//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[16:25:04.229] <TB2> INFO: ----------------------------------------------------------------------
[16:25:04.229] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:25:04.229] <TB2> INFO: ----------------------------------------------------------------------
[16:25:22.480] <TB2> INFO: Test took 18243ms.
[16:25:32.179] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:25:32.781] <TB2> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:25:32.781] <TB2> INFO: number of red-efficiency pixels: 1614 1866 1677 3218 3643 4037 3564 3883 4006 4000 4065 3652 3468 1761 1691 1793
[16:25:32.781] <TB2> INFO: number of X-ray hits detected: 436593 472431 406633 701377 794702 940425 776214 848288 930691 928882 948718 782896 732848 474118 443894 470463
[16:25:32.781] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:25:32.781] <TB2> INFO: number of Vcal hits detected: 205705 205209 203399 199649 195159 188017 195885 194177 189515 188492 187057 195827 198490 202955 205571 205249
[16:25:32.781] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.0 98.8 98.2 96.5 94.6 91.4 94.9 93.9 91.9 91.6 91.0 94.8 95.9 98.0 98.9 98.8
[16:25:32.781] <TB2> INFO: Vcal hit overall efficiency (%): 98.9 98.7 97.8 96.0 93.8 90.4 94.2 93.4 91.1 90.6 89.9 94.1 95.4 97.6 98.8 98.7
[16:25:32.781] <TB2> INFO: X-ray hit rate [MHz/cm2]: 128.0 138.5 119.2 205.6 232.9 275.6 227.5 248.6 272.8 272.3 278.1 229.5 214.8 139.0 130.1 137.9
[16:25:32.781] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[16:25:32.831] <TB2> INFO: PixTest:: pg_setup set to default.
[16:25:32.886] <TB2> INFO: enter test to run
[16:25:32.886] <TB2> INFO: test: no parameter change
[16:25:33.021] <TB2> QUIET: Connection to board 162 closed.
[16:25:33.101] <TB2> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master