[15:54:01.764] <TB1> INFO: *** Welcome to pxar ***
[15:54:01.764] <TB1> INFO: *** Today: 2015/08/21
[15:54:01.764] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//dacParameters35_C15.dat
[15:54:01.765] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//tbmParameters_C0b.dat
[15:54:01.765] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//defaultMaskFile.dat
[15:54:01.765] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//trimParameters35_C15.dat
[15:54:01.842] <TB1> INFO: clk: 4
[15:54:01.842] <TB1> INFO: ctr: 4
[15:54:01.842] <TB1> INFO: sda: 19
[15:54:01.842] <TB1> INFO: tin: 9
[15:54:01.842] <TB1> INFO: level: 15
[15:54:01.842] <TB1> INFO: triggerdelay: 0
[15:54:01.842] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:54:01.842] <TB1> INFO: Log level: INFO
[15:54:01.855] <TB1> INFO: Found DTB DTB_WS6UZO
[15:54:01.867] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[15:54:01.870] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[15:54:01.873] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[15:54:03.394] <TB1> INFO: DUT info:
[15:54:03.394] <TB1> INFO: The DUT currently contains the following objects:
[15:54:03.394] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:54:03.394] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:54:03.394] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:54:03.394] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:54:03.394] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.394] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.395] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:03.796] <TB1> INFO: enter 'restricted' command line mode
[15:54:03.796] <TB1> INFO: enter test to run
[15:54:03.796] <TB1> INFO: test: PixelAlive no parameter change
[15:54:03.796] <TB1> INFO: running: pixelalive
[15:54:03.802] <TB1> INFO: ######################################################################
[15:54:03.802] <TB1> INFO: PixTestAlive::doTest()
[15:54:03.802] <TB1> INFO: ######################################################################
[15:54:03.803] <TB1> INFO: ----------------------------------------------------------------------
[15:54:03.803] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:03.803] <TB1> INFO: ----------------------------------------------------------------------
[15:54:07.165] <TB1> INFO: Test took 3360ms.
[15:54:07.183] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:07.433] <TB1> INFO: PixTestAlive::aliveTest() done
[15:54:07.433] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 12 0 0 0 4 0 0 0 0 2 0 0 0
[15:54:07.434] <TB1> INFO: ----------------------------------------------------------------------
[15:54:07.434] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:07.434] <TB1> INFO: ----------------------------------------------------------------------
[15:54:10.105] <TB1> INFO: Test took 2669ms.
[15:54:10.107] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:10.107] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:54:10.330] <TB1> INFO: PixTestAlive::maskTest() done
[15:54:10.330] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:54:10.332] <TB1> INFO: ----------------------------------------------------------------------
[15:54:10.332] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:10.332] <TB1> INFO: ----------------------------------------------------------------------
[15:54:13.727] <TB1> INFO: Test took 3394ms.
[15:54:13.750] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:13.976] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:54:13.976] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:54:13.976] <TB1> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[15:54:14.005] <TB1> INFO: enter test to run
[15:54:14.005] <TB1> INFO: test: no parameter change
[15:54:14.148] <TB1> QUIET: Connection to board 83 closed.
[15:54:14.227] <TB1> INFO: pXar: this is the end, my friend

[15:59:25.454] <TB1> INFO: *** Welcome to pxar ***
[15:59:25.454] <TB1> INFO: *** Today: 2015/08/21
[15:59:25.454] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:59:25.454] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:59:25.454] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:59:25.454] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:59:25.529] <TB1> INFO: clk: 4
[15:59:25.529] <TB1> INFO: ctr: 4
[15:59:25.529] <TB1> INFO: sda: 19
[15:59:25.529] <TB1> INFO: tin: 9
[15:59:25.529] <TB1> INFO: level: 15
[15:59:25.529] <TB1> INFO: triggerdelay: 0
[15:59:25.530] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:59:25.530] <TB1> INFO: Log level: INFO
[15:59:25.544] <TB1> INFO: Found DTB DTB_WS6UZO
[15:59:25.556] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[15:59:25.559] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[15:59:25.562] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[15:59:27.087] <TB1> INFO: DUT info:
[15:59:27.087] <TB1> INFO: The DUT currently contains the following objects:
[15:59:27.087] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:59:27.087] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:59:27.087] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:59:27.087] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:59:27.087] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.087] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.087] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.087] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.088] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:27.489] <TB1> INFO: enter 'restricted' command line mode
[15:59:27.489] <TB1> INFO: enter test to run
[15:59:27.489] <TB1> INFO: test: delay setting parameters: ->5<-
[15:59:27.489] <TB1> INFO: delay test by 5 seconds...
[15:59:32.489] <TB1> INFO: enter test to run
[15:59:32.489] <TB1> INFO: test: highrate no parameter change
[15:59:32.489] <TB1> INFO: running: highrate
[15:59:32.490] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:59:32.625] <TB1> INFO: ----------------------------------------------------------------------
[15:59:32.625] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:59:32.625] <TB1> INFO: ----------------------------------------------------------------------
[15:59:32.625] <TB1> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[15:59:32.625] <TB1> INFO: edge/corner pixel THR is adjusted
[15:59:32.625] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:59:33.603] <TB1> INFO: Collecting data for 1 seconds...
[15:59:34.604] <TB1> INFO: Done with hot pixel readout
[15:59:40.020] <TB1> INFO: PixTest:: pg_setup set to default.
[15:59:40.021] <TB1> INFO: 18 hot pixels found in step 0
[15:59:40.984] <TB1> INFO: Collecting data for 1 seconds...
[15:59:41.986] <TB1> INFO: Done with hot pixel readout
[15:59:47.286] <TB1> INFO: PixTest:: pg_setup set to default.
[15:59:47.287] <TB1> INFO: 11 hot pixels found in step 1
[15:59:48.251] <TB1> INFO: Collecting data for 1 seconds...
[15:59:49.253] <TB1> INFO: Done with hot pixel readout
[15:59:54.502] <TB1> INFO: PixTest:: pg_setup set to default.
[15:59:54.503] <TB1> INFO: 3 hot pixels found in step 2
[15:59:55.466] <TB1> INFO: Collecting data for 1 seconds...
[15:59:56.468] <TB1> INFO: Done with hot pixel readout
[16:00:01.653] <TB1> INFO: PixTest:: pg_setup set to default.
[16:00:01.654] <TB1> INFO: 0 hot pixels found in step 3
[16:00:01.662] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[16:00:01.692] <TB1> INFO: PixTest::trimHotPixels() done
[16:00:01.692] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C0.dat
[16:00:01.699] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C1.dat
[16:00:01.705] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C2.dat
[16:00:01.711] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C3.dat
[16:00:01.718] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C4.dat
[16:00:01.724] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C5.dat
[16:00:01.731] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C6.dat
[16:00:01.737] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C7.dat
[16:00:01.743] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C8.dat
[16:00:01.750] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C9.dat
[16:00:01.756] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C10.dat
[16:00:01.763] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C11.dat
[16:00:01.770] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C12.dat
[16:00:01.776] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C13.dat
[16:00:01.783] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C14.dat
[16:00:01.790] <TB1> INFO: write trim parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C15.dat
[16:00:01.796] <TB1> INFO: write masked pixels into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//defaultMaskFile.dat
[16:00:01.828] <TB1> INFO: enter test to run
[16:00:01.828] <TB1> INFO: test: no parameter change
[16:00:02.001] <TB1> QUIET: Connection to board 83 closed.
[16:00:02.081] <TB1> INFO: pXar: this is the end, my friend

[16:01:18.478] <TB1> INFO: *** Welcome to pxar ***
[16:01:18.478] <TB1> INFO: *** Today: 2015/08/21
[16:01:18.478] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//dacParameters35_C15.dat
[16:01:18.479] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//tbmParameters_C0b.dat
[16:01:18.479] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//defaultMaskFile.dat
[16:01:18.479] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//trimParameters35_C15.dat
[16:01:18.547] <TB1> INFO: clk: 4
[16:01:18.547] <TB1> INFO: ctr: 4
[16:01:18.547] <TB1> INFO: sda: 19
[16:01:18.547] <TB1> INFO: tin: 9
[16:01:18.547] <TB1> INFO: level: 15
[16:01:18.547] <TB1> INFO: triggerdelay: 0
[16:01:18.547] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:01:18.547] <TB1> INFO: Log level: INFO
[16:01:18.561] <TB1> INFO: Found DTB DTB_WS6UZO
[16:01:18.573] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[16:01:18.576] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[16:01:18.579] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[16:01:20.117] <TB1> INFO: DUT info:
[16:01:20.117] <TB1> INFO: The DUT currently contains the following objects:
[16:01:20.117] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:01:20.117] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:01:20.117] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:01:20.117] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:01:20.117] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.117] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.118] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.118] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.118] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.118] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:20.519] <TB1> INFO: enter 'restricted' command line mode
[16:01:20.519] <TB1> INFO: enter test to run
[16:01:20.519] <TB1> INFO: test: delay setting parameters: ->5<-
[16:01:20.519] <TB1> INFO: delay test by 5 seconds...
[16:01:25.519] <TB1> INFO: enter test to run
[16:01:25.519] <TB1> INFO: test: Xray no parameter change
[16:01:25.519] <TB1> INFO: running: xray
[16:01:25.519] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//phCalibrationFitErr35_C15.dat
[16:01:25.656] <TB1> INFO: ######################################################################
[16:01:25.656] <TB1> INFO: PixTestXray::doTest()
[16:01:25.656] <TB1> INFO: ######################################################################
[16:01:25.656] <TB1> INFO: ----------------------------------------------------------------------
[16:01:25.656] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[16:01:25.656] <TB1> INFO: ----------------------------------------------------------------------
[16:01:26.625] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[16:01:32.774] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[16:01:59.982] <TB1> INFO: Resuming triggers.
[16:02:06.139] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[16:02:30.607] <TB1> INFO: Resuming triggers.
[16:02:36.758] <TB1> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[16:03:06.206] <TB1> INFO: Resuming triggers.
[16:03:12.356] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[16:03:37.381] <TB1> INFO: Resuming triggers.
[16:03:43.525] <TB1> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[16:04:10.431] <TB1> INFO: Resuming triggers.
[16:04:16.575] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[16:04:45.021] <TB1> INFO: Resuming triggers.
[16:04:51.165] <TB1> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[16:05:15.507] <TB1> INFO: Resuming triggers.
[16:05:21.651] <TB1> INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[16:05:47.158] <TB1> INFO: Resuming triggers.
[16:05:53.300] <TB1> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[16:06:23.174] <TB1> INFO: Resuming triggers.
[16:06:29.316] <TB1> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[16:06:57.940] <TB1> INFO: Resuming triggers.
[16:07:04.078] <TB1> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[16:07:26.471] <TB1> INFO: Resuming triggers.
[16:07:32.612] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[16:08:02.720] <TB1> INFO: Resuming triggers.
[16:08:08.860] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[16:08:33.761] <TB1> INFO: Resuming triggers.
[16:08:39.901] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[16:09:02.641] <TB1> INFO: Resuming triggers.
[16:09:08.779] <TB1> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[16:09:26.827] <TB1> INFO: Resuming triggers.
[16:09:32.962] <TB1> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[16:09:51.110] <TB1> INFO: Resuming triggers.
[16:09:52.914] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[16:09:58.420] <TB1> INFO: PixTest:: pg_setup set to default.
[16:09:58.422] <TB1> INFO: PixTestXray::doPhRun() done
[16:09:58.422] <TB1> INFO: PixTestXray::doTest() done
[16:09:58.606] <TB1> INFO: enter test to run
[16:09:58.606] <TB1> INFO: test: no parameter change
[16:09:58.788] <TB1> QUIET: Connection to board 83 closed.
[16:09:58.867] <TB1> INFO: pXar: this is the end, my friend

[16:10:14.914] <TB1> INFO: *** Welcome to pxar ***
[16:10:14.914] <TB1> INFO: *** Today: 2015/08/21
[16:10:14.914] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//dacParameters35_C15.dat
[16:10:14.915] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//tbmParameters_C0b.dat
[16:10:14.916] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//defaultMaskFile.dat
[16:10:14.916] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//trimParameters35_C15.dat
[16:10:14.986] <TB1> INFO: clk: 4
[16:10:14.986] <TB1> INFO: ctr: 4
[16:10:14.986] <TB1> INFO: sda: 19
[16:10:14.986] <TB1> INFO: tin: 9
[16:10:14.986] <TB1> INFO: level: 15
[16:10:14.986] <TB1> INFO: triggerdelay: 0
[16:10:14.986] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:10:14.986] <TB1> INFO: Log level: INFO
[16:10:15.000] <TB1> INFO: Found DTB DTB_WS6UZO
[16:10:15.012] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[16:10:15.015] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[16:10:15.018] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[16:10:16.551] <TB1> INFO: DUT info:
[16:10:16.551] <TB1> INFO: The DUT currently contains the following objects:
[16:10:16.551] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:10:16.551] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:10:16.551] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:10:16.551] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:10:16.551] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.551] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.551] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.551] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.552] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:16.953] <TB1> INFO: enter 'restricted' command line mode
[16:10:16.953] <TB1> INFO: enter test to run
[16:10:16.953] <TB1> INFO: test: delay setting parameters: ->5<-
[16:10:16.953] <TB1> INFO: delay test by 5 seconds...
[16:10:21.953] <TB1> INFO: enter test to run
[16:10:21.953] <TB1> INFO: test: Xray no parameter change
[16:10:21.954] <TB1> INFO: running: xray
[16:10:21.954] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//phCalibrationFitErr35_C15.dat
[16:10:22.109] <TB1> INFO: ######################################################################
[16:10:22.109] <TB1> INFO: PixTestXray::doTest()
[16:10:22.110] <TB1> INFO: ######################################################################
[16:10:22.110] <TB1> INFO: ----------------------------------------------------------------------
[16:10:22.110] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[16:10:22.110] <TB1> INFO: ----------------------------------------------------------------------
[16:10:23.079] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[16:10:26.339] <TB1> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[16:10:53.909] <TB1> INFO: Resuming triggers.
[16:10:57.187] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.



[16:11:20.329] <TB1> INFO: Resuming triggers.
[16:11:23.604] <TB1> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[16:11:51.054] <TB1> INFO: Resuming triggers.
[16:11:54.330] <TB1> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[16:12:17.993] <TB1> INFO: Resuming triggers.
[16:12:21.266] <TB1> INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[16:12:48.095] <TB1> INFO: Resuming triggers.
[16:12:51.368] <TB1> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[16:13:19.039] <TB1> INFO: Resuming triggers.
[16:13:22.312] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[16:13:49.512] <TB1> INFO: Resuming triggers.
[16:13:52.789] <TB1> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[16:14:19.155] <TB1> INFO: Resuming triggers.
[16:14:22.428] <TB1> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[16:14:54.217] <TB1> INFO: Resuming triggers.
[16:14:57.493] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[16:15:22.813] <TB1> INFO: Resuming triggers.
[16:15:26.088] <TB1> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[16:15:49.557] <TB1> INFO: Resuming triggers.
[16:15:52.832] <TB1> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[16:16:16.190] <TB1> INFO: Resuming triggers.
[16:16:19.462] <TB1> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[16:16:45.755] <TB1> INFO: Resuming triggers.
[16:16:49.029] <TB1> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[16:17:16.993] <TB1> INFO: Resuming triggers.
[16:17:20.265] <TB1> INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[16:17:42.951] <TB1> INFO: Resuming triggers.
[16:17:46.225] <TB1> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[16:18:08.937] <TB1> INFO: Resuming triggers.
[16:18:12.209] <TB1> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[16:18:38.345] <TB1> INFO: Resuming triggers.
[16:18:41.618] <TB1> INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[16:19:04.881] <TB1> INFO: Resuming triggers.
[16:19:08.152] <TB1> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[16:19:30.814] <TB1> INFO: Resuming triggers.
[16:19:34.085] <TB1> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[16:19:58.068] <TB1> INFO: Resuming triggers.
[16:20:01.347] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[16:20:26.253] <TB1> INFO: Resuming triggers.
[16:20:29.523] <TB1> INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[16:20:54.360] <TB1> INFO: Resuming triggers.
[16:20:57.633] <TB1> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[16:21:23.078] <TB1> INFO: Resuming triggers.
[16:21:26.346] <TB1> INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[16:21:55.564] <TB1> INFO: Resuming triggers.
[16:21:58.834] <TB1> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[16:22:21.844] <TB1> INFO: Resuming triggers.
[16:22:25.114] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[16:22:47.242] <TB1> INFO: Resuming triggers.
[16:22:50.513] <TB1> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[16:23:17.136] <TB1> INFO: Resuming triggers.
[16:23:20.402] <TB1> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[16:23:42.185] <TB1> INFO: Resuming triggers.
[16:23:45.449] <TB1> INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[16:24:03.716] <TB1> INFO: Resuming triggers.
[16:24:06.981] <TB1> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[16:24:25.731] <TB1> INFO: Resuming triggers.
[16:24:27.673] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[16:24:38.995] <TB1> INFO: PixTest:: pg_setup set to default.
[16:24:38.997] <TB1> INFO: PixTestXray::doPhRun() done
[16:24:38.997] <TB1> INFO: PixTestXray::doTest() done
[16:24:39.192] <TB1> INFO: enter test to run
[16:24:39.192] <TB1> INFO: test: no parameter change
[16:24:39.378] <TB1> QUIET: Connection to board 83 closed.
[16:24:39.457] <TB1> INFO: pXar: this is the end, my friend

[16:24:55.781] <TB1> INFO: *** Welcome to pxar ***
[16:24:55.781] <TB1> INFO: *** Today: 2015/08/21
[16:24:55.781] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//dacParameters35_C15.dat
[16:24:55.782] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//tbmParameters_C0b.dat
[16:24:55.782] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//defaultMaskFile.dat
[16:24:55.782] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//trimParameters35_C15.dat
[16:24:55.858] <TB1> INFO: clk: 4
[16:24:55.858] <TB1> INFO: ctr: 4
[16:24:55.858] <TB1> INFO: sda: 19
[16:24:55.858] <TB1> INFO: tin: 9
[16:24:55.858] <TB1> INFO: level: 15
[16:24:55.858] <TB1> INFO: triggerdelay: 0
[16:24:55.858] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:24:55.858] <TB1> INFO: Log level: INFO
[16:24:55.872] <TB1> INFO: Found DTB DTB_WS6UZO
[16:24:55.883] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[16:24:55.886] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[16:24:55.889] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[16:24:57.451] <TB1> INFO: DUT info:
[16:24:57.451] <TB1> INFO: The DUT currently contains the following objects:
[16:24:57.451] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:24:57.451] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:24:57.451] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:24:57.451] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:24:57.451] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.451] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.452] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.452] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.452] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.452] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.452] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.452] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:57.853] <TB1> INFO: enter 'restricted' command line mode
[16:24:57.853] <TB1> INFO: enter test to run
[16:24:57.853] <TB1> INFO: test: Highrate no parameter change
[16:24:57.853] <TB1> INFO: running: highrate
[16:24:57.854] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[16:24:58.025] <TB1> INFO: ----------------------------------------------------------------------
[16:24:58.025] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[16:24:58.025] <TB1> INFO: ----------------------------------------------------------------------
[16:24:58.031] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 100 (1) hits flags = 384 (plus default)
[16:24:58.055] <TB1> INFO: dacScan step from 0 .. 0
[16:25:12.849] <TB1> INFO: Test took 14793ms.
[16:25:15.220] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:25:15.533] <TB1> INFO: dacScan step from 1 .. 1
[16:25:31.065] <TB1> INFO: Test took 15531ms.
[16:25:33.246] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:25:33.553] <TB1> INFO: dacScan step from 2 .. 2
[16:25:49.563] <TB1> INFO: Test took 16009ms.
[16:25:51.485] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:25:51.804] <TB1> INFO: dacScan step from 3 .. 3
[16:26:07.039] <TB1> INFO: Test took 15235ms.
[16:26:09.378] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:26:09.719] <TB1> INFO: dacScan step from 4 .. 4
[16:26:24.667] <TB1> INFO: Test took 14947ms.
[16:26:26.913] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:26:27.220] <TB1> INFO: dacScan step from 5 .. 5
[16:26:41.587] <TB1> INFO: Test took 14367ms.
[16:26:43.688] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:26:43.983] <TB1> INFO: dacScan step from 6 .. 6
[16:26:58.496] <TB1> INFO: Test took 14513ms.
[16:27:00.594] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:00.912] <TB1> INFO: dacScan step from 7 .. 7
[16:27:16.684] <TB1> INFO: Test took 15772ms.
[16:27:19.225] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:19.515] <TB1> INFO: dacScan step from 8 .. 8
[16:27:35.499] <TB1> INFO: Test took 15983ms.
[16:27:37.546] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:37.828] <TB1> INFO: dacScan step from 9 .. 9
[16:27:52.857] <TB1> INFO: Test took 15028ms.
[16:27:55.210] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:55.533] <TB1> INFO: dacScan step from 10 .. 10
[16:28:10.096] <TB1> INFO: Test took 14562ms.
[16:28:12.133] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:28:12.427] <TB1> INFO: dacScan step from 11 .. 11
[16:28:27.195] <TB1> INFO: Test took 14768ms.
[16:28:29.257] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:28:29.545] <TB1> INFO: dacScan step from 12 .. 12
[16:28:43.616] <TB1> INFO: Test took 14070ms.
[16:28:45.895] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:28:46.234] <TB1> INFO: dacScan step from 13 .. 13
[16:29:00.664] <TB1> INFO: Test took 14430ms.
[16:29:02.774] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:29:03.081] <TB1> INFO: dacScan step from 14 .. 14
[16:29:18.260] <TB1> INFO: Test took 15179ms.
[16:29:20.479] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:29:20.797] <TB1> INFO: dacScan step from 15 .. 15
[16:29:36.407] <TB1> INFO: Test took 15610ms.
[16:29:38.541] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:29:38.832] <TB1> INFO: dacScan step from 16 .. 16
[16:29:53.985] <TB1> INFO: Test took 15152ms.
[16:29:56.254] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:29:56.536] <TB1> INFO: dacScan step from 17 .. 17
[16:30:10.738] <TB1> INFO: Test took 14202ms.
[16:30:12.731] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:30:13.023] <TB1> INFO: dacScan step from 18 .. 18
[16:30:26.907] <TB1> INFO: Test took 13883ms.
[16:30:29.051] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:30:29.354] <TB1> INFO: dacScan step from 19 .. 19
[16:30:43.950] <TB1> INFO: Test took 14595ms.
[16:30:46.014] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:30:46.289] <TB1> INFO: dacScan step from 20 .. 20
[16:31:01.177] <TB1> INFO: Test took 14887ms.
[16:31:03.342] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:31:03.641] <TB1> INFO: dacScan step from 21 .. 21
[16:31:19.161] <TB1> INFO: Test took 15520ms.
[16:31:21.271] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:31:21.559] <TB1> INFO: dacScan step from 22 .. 22
[16:31:36.679] <TB1> INFO: Test took 15120ms.
[16:31:38.677] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:31:38.953] <TB1> INFO: dacScan step from 23 .. 23
[16:31:54.000] <TB1> INFO: Test took 15047ms.
[16:31:56.065] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:31:56.349] <TB1> INFO: dacScan step from 24 .. 24
[16:32:11.056] <TB1> INFO: Test took 14707ms.
[16:32:13.098] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:32:13.383] <TB1> INFO: dacScan step from 25 .. 25
[16:32:27.536] <TB1> INFO: Test took 14153ms.
[16:32:29.555] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:32:29.828] <TB1> INFO: dacScan step from 26 .. 26
[16:32:43.972] <TB1> INFO: Test took 14143ms.
[16:32:46.116] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:32:46.406] <TB1> INFO: dacScan step from 27 .. 27
[16:33:01.726] <TB1> INFO: Test took 15320ms.
[16:33:03.949] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:33:04.233] <TB1> INFO: dacScan step from 28 .. 28
[16:33:19.633] <TB1> INFO: Test took 15399ms.
[16:33:21.658] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:33:21.959] <TB1> INFO: dacScan step from 29 .. 29
[16:33:37.098] <TB1> INFO: Test took 15138ms.
[16:33:39.177] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:33:39.472] <TB1> INFO: dacScan step from 30 .. 30
[16:33:54.165] <TB1> INFO: Test took 14693ms.
[16:33:56.073] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:33:56.344] <TB1> INFO: dacScan step from 31 .. 31
[16:34:10.982] <TB1> INFO: Test took 14637ms.
[16:34:13.053] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:13.337] <TB1> INFO: dacScan step from 32 .. 32
[16:34:27.837] <TB1> INFO: Test took 14499ms.
[16:34:29.971] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:30.252] <TB1> INFO: dacScan step from 33 .. 33
[16:34:44.405] <TB1> INFO: Test took 14153ms.
[16:34:46.665] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:46.958] <TB1> INFO: dacScan step from 34 .. 34
[16:35:00.785] <TB1> INFO: Test took 13827ms.
[16:35:02.914] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:03.209] <TB1> INFO: dacScan step from 35 .. 35
[16:35:16.901] <TB1> INFO: Test took 13692ms.
[16:35:19.115] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:19.438] <TB1> INFO: dacScan step from 36 .. 36
[16:35:33.425] <TB1> INFO: Test took 13986ms.
[16:35:35.729] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:36.021] <TB1> INFO: dacScan step from 37 .. 37
[16:35:50.292] <TB1> INFO: Test took 14271ms.
[16:35:52.559] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:52.866] <TB1> INFO: dacScan step from 38 .. 38
[16:36:07.629] <TB1> INFO: Test took 14762ms.
[16:36:09.878] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:10.172] <TB1> INFO: dacScan step from 39 .. 39
[16:36:24.721] <TB1> INFO: Test took 14549ms.
[16:36:27.111] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:27.413] <TB1> INFO: dacScan step from 40 .. 40
[16:36:42.219] <TB1> INFO: Test took 14805ms.
[16:36:44.505] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:44.799] <TB1> INFO: dacScan step from 41 .. 41
[16:36:59.626] <TB1> INFO: Test took 14826ms.
[16:37:01.939] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:37:02.234] <TB1> INFO: dacScan step from 42 .. 42
[16:37:17.502] <TB1> INFO: Test took 15268ms.
[16:37:19.819] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:37:20.119] <TB1> INFO: dacScan step from 43 .. 43
[16:37:36.229] <TB1> INFO: Test took 16109ms.
[16:37:38.507] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:37:38.808] <TB1> INFO: dacScan step from 44 .. 44
[16:37:54.933] <TB1> INFO: Test took 16124ms.
[16:37:57.202] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:37:57.511] <TB1> INFO: dacScan step from 45 .. 45
[16:38:13.933] <TB1> INFO: Test took 16421ms.
[16:38:16.206] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:38:16.510] <TB1> INFO: dacScan step from 46 .. 46
[16:38:33.573] <TB1> INFO: Test took 17062ms.
[16:38:35.859] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:38:36.180] <TB1> INFO: dacScan step from 47 .. 47
[16:38:54.090] <TB1> INFO: Test took 17910ms.
[16:38:56.465] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:38:56.784] <TB1> INFO: dacScan step from 48 .. 48
[16:39:15.242] <TB1> INFO: Test took 18457ms.
[16:39:18.151] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:39:18.452] <TB1> INFO: dacScan step from 49 .. 49
[16:39:37.967] <TB1> INFO: Test took 19514ms.
[16:39:40.318] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:39:40.615] <TB1> INFO: dacScan step from 50 .. 50
[16:39:59.626] <TB1> INFO: Test took 19010ms.
[16:40:02.108] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:02.440] <TB1> INFO: dacScan step from 51 .. 51
[16:40:21.372] <TB1> INFO: Test took 18931ms.
[16:40:23.639] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:23.934] <TB1> INFO: dacScan step from 52 .. 52
[16:40:42.260] <TB1> INFO: Test took 18326ms.
[16:40:44.999] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:45.315] <TB1> INFO: dacScan step from 53 .. 53
[16:41:03.386] <TB1> INFO: Test took 18070ms.
[16:41:05.795] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:41:06.090] <TB1> INFO: dacScan step from 54 .. 54
[16:41:23.928] <TB1> INFO: Test took 17838ms.
[16:41:26.256] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:41:26.582] <TB1> INFO: dacScan step from 55 .. 55
[16:41:44.722] <TB1> INFO: Test took 18139ms.
[16:41:47.069] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:41:47.371] <TB1> INFO: dacScan step from 56 .. 56
[16:42:05.723] <TB1> INFO: Test took 18351ms.
[16:42:08.215] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:42:08.546] <TB1> INFO: dacScan step from 57 .. 57
[16:42:27.736] <TB1> INFO: Test took 19189ms.
[16:42:30.101] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:42:30.403] <TB1> INFO: dacScan step from 58 .. 58
[16:42:49.729] <TB1> INFO: Test took 19325ms.
[16:42:52.033] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:42:52.346] <TB1> INFO: dacScan step from 59 .. 59
[16:43:10.749] <TB1> INFO: Test took 18402ms.
[16:43:13.698] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:43:14.003] <TB1> INFO: dacScan step from 60 .. 60
[16:43:31.580] <TB1> INFO: Test took 17577ms.
[16:43:34.149] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:43:34.454] <TB1> INFO: dacScan step from 61 .. 61
[16:43:52.191] <TB1> INFO: Test took 17736ms.
[16:43:54.712] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:43:55.021] <TB1> INFO: dacScan step from 62 .. 62
[16:44:12.890] <TB1> INFO: Test took 17868ms.
[16:44:15.279] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:44:15.582] <TB1> INFO: dacScan step from 63 .. 63
[16:44:35.141] <TB1> INFO: Test took 19558ms.
[16:44:38.489] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:44:38.798] <TB1> INFO: dacScan step from 64 .. 64
[16:44:58.202] <TB1> INFO: Test took 19404ms.
[16:45:00.608] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:45:00.899] <TB1> INFO: dacScan step from 65 .. 65
[16:45:19.631] <TB1> INFO: Test took 18731ms.
[16:45:22.326] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:45:22.648] <TB1> INFO: dacScan step from 66 .. 66
[16:45:40.310] <TB1> INFO: Test took 17662ms.
[16:45:43.101] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:45:43.396] <TB1> INFO: dacScan step from 67 .. 67
[16:46:01.145] <TB1> INFO: Test took 17748ms.
[16:46:03.585] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:46:03.901] <TB1> INFO: dacScan step from 68 .. 68
[16:46:21.260] <TB1> INFO: Test took 17358ms.
[16:46:23.627] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:46:23.912] <TB1> INFO: dacScan step from 69 .. 69
[16:46:42.324] <TB1> INFO: Test took 18411ms.
[16:46:44.731] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:46:45.043] <TB1> INFO: dacScan step from 70 .. 70
[16:47:03.225] <TB1> INFO: Test took 18181ms.
[16:47:05.514] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:47:05.836] <TB1> INFO: dacScan step from 71 .. 71
[16:47:24.187] <TB1> INFO: Test took 18350ms.
[16:47:26.610] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:47:26.898] <TB1> INFO: dacScan step from 72 .. 72
[16:47:46.184] <TB1> INFO: Test took 19285ms.
[16:47:49.160] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:47:49.471] <TB1> INFO: dacScan step from 73 .. 73
[16:48:09.031] <TB1> INFO: Test took 19559ms.
[16:48:11.519] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:48:11.809] <TB1> INFO: dacScan step from 74 .. 74
[16:48:30.855] <TB1> INFO: Test took 19045ms.
[16:48:33.266] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:48:33.593] <TB1> INFO: dacScan step from 75 .. 75
[16:48:51.819] <TB1> INFO: Test took 18225ms.
[16:48:54.239] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:48:54.544] <TB1> INFO: dacScan step from 76 .. 76
[16:49:11.858] <TB1> INFO: Test took 17313ms.
[16:49:14.251] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:49:14.561] <TB1> INFO: dacScan step from 77 .. 77
[16:49:31.815] <TB1> INFO: Test took 17253ms.
[16:49:34.220] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:49:34.536] <TB1> INFO: dacScan step from 78 .. 78
[16:49:51.709] <TB1> INFO: Test took 17172ms.
[16:49:54.136] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:49:54.469] <TB1> INFO: dacScan step from 79 .. 79
[16:50:11.871] <TB1> INFO: Test took 17401ms.
[16:50:14.248] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:50:14.534] <TB1> INFO: dacScan step from 80 .. 80
[16:50:33.501] <TB1> INFO: Test took 18966ms.
[16:50:35.814] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:50:36.110] <TB1> INFO: dacScan step from 81 .. 81
[16:50:55.448] <TB1> INFO: Test took 19337ms.
[16:50:57.983] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:50:58.310] <TB1> INFO: dacScan step from 82 .. 82
[16:51:17.596] <TB1> INFO: Test took 19285ms.
[16:51:20.075] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:51:20.377] <TB1> INFO: dacScan step from 83 .. 83
[16:51:38.951] <TB1> INFO: Test took 18574ms.
[16:51:41.568] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:51:41.854] <TB1> INFO: dacScan step from 84 .. 84
[16:51:59.875] <TB1> INFO: Test took 18020ms.
[16:52:02.324] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:52:02.649] <TB1> INFO: dacScan step from 85 .. 85
[16:52:19.560] <TB1> INFO: Test took 16910ms.
[16:52:22.101] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:52:22.394] <TB1> INFO: dacScan step from 86 .. 86
[16:52:39.923] <TB1> INFO: Test took 17528ms.
[16:52:42.365] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:52:42.709] <TB1> INFO: dacScan step from 87 .. 87
[16:53:00.386] <TB1> INFO: Test took 17675ms.
[16:53:02.799] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:53:03.176] <TB1> INFO: dacScan step from 88 .. 88
[16:53:22.281] <TB1> INFO: Test took 19104ms.
[16:53:24.439] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:53:24.718] <TB1> INFO: dacScan step from 89 .. 89
[16:53:44.769] <TB1> INFO: Test took 20051ms.
[16:53:47.140] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:53:47.456] <TB1> INFO: dacScan step from 90 .. 90
[16:54:02.417] <TB1> INFO: Test took 14960ms.
[16:54:04.608] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:54:04.922] <TB1> INFO: dacScan step from 91 .. 91
[16:54:18.693] <TB1> INFO: Test took 13770ms.
[16:54:20.760] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:54:21.041] <TB1> INFO: dacScan step from 92 .. 92
[16:54:34.740] <TB1> INFO: Test took 13698ms.
[16:54:36.822] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:54:37.096] <TB1> INFO: dacScan step from 93 .. 93
[16:54:50.741] <TB1> INFO: Test took 13644ms.
[16:54:52.814] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:54:53.085] <TB1> INFO: dacScan step from 94 .. 94
[16:55:06.645] <TB1> INFO: Test took 13559ms.
[16:55:08.757] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:55:09.035] <TB1> INFO: dacScan step from 95 .. 95
[16:55:23.029] <TB1> INFO: Test took 13993ms.
[16:55:25.136] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:55:25.414] <TB1> INFO: dacScan step from 96 .. 96
[16:55:38.923] <TB1> INFO: Test took 13508ms.
[16:55:41.034] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:55:41.308] <TB1> INFO: dacScan step from 97 .. 97
[16:55:55.129] <TB1> INFO: Test took 13820ms.
[16:55:57.188] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:55:57.462] <TB1> INFO: dacScan step from 98 .. 98
[16:56:10.913] <TB1> INFO: Test took 13450ms.
[16:56:12.981] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:56:13.256] <TB1> INFO: dacScan step from 99 .. 99
[16:56:26.900] <TB1> INFO: Test took 13643ms.
[16:56:28.980] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:56:29.254] <TB1> INFO: dacScan step from 100 .. 100
[16:56:43.034] <TB1> INFO: Test took 13779ms.
[16:56:45.077] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:56:45.347] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:46.681] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:47.949] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:49.202] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:50.548] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:51.895] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:53.316] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:54.689] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:56.065] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:57.386] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:56:58.712] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:57:00.060] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:57:01.362] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:57:02.667] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:57:03.889] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:57:05.113] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:57:06.350] <TB1> INFO: PixTest:: pg_setup set to default.
[16:57:06.351] <TB1> INFO: vcal mean: 38.97 39.66 39.07 42.67 43.34 43.55 42.85 43.95 42.55 42.74 43.89 42.96 41.93 39.68 38.87 39.17
[16:57:06.351] <TB1> INFO: vcal RMS: 1.30 1.37 1.14 3.85 1.42 1.48 1.46 2.08 1.51 1.53 1.59 1.76 1.52 1.43 1.25 1.37
[16:57:06.351] <TB1> INFO: number of X-ray hits detected: 217590 241993 215073 387319 408707 445839 397515 444652 402578 399799 456951 397273 350009 215938 216141 228339
[16:57:06.351] <TB1> 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:57:06.351] <TB1> INFO: X-ray hit rate [MHz/cm2]: 63.8 70.9 63.0 113.5 119.8 130.7 116.5 130.3 118.0 117.2 133.9 116.4 102.6 63.3 63.4 66.9
[16:57:06.351] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[16:57:06.443] <TB1> INFO: enter test to run
[16:57:06.443] <TB1> INFO: test: no parameter change
[16:57:06.586] <TB1> QUIET: Connection to board 83 closed.
[16:57:06.666] <TB1> INFO: pXar: this is the end, my friend

[17:14:06.610] <TB1> INFO: *** Welcome to pxar ***
[17:14:06.610] <TB1> INFO: *** Today: 2015/08/21
[17:14:06.610] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[17:14:06.610] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[17:14:06.610] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[17:14:06.610] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[17:14:06.677] <TB1> INFO: clk: 4
[17:14:06.677] <TB1> INFO: ctr: 4
[17:14:06.677] <TB1> INFO: sda: 19
[17:14:06.677] <TB1> INFO: tin: 9
[17:14:06.677] <TB1> INFO: level: 15
[17:14:06.677] <TB1> INFO: triggerdelay: 0
[17:14:06.677] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:14:06.677] <TB1> INFO: Log level: INFO
[17:14:06.690] <TB1> INFO: Found DTB DTB_WS6UZO
[17:14:06.702] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[17:14:06.705] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[17:14:06.707] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[17:14:08.233] <TB1> INFO: DUT info:
[17:14:08.233] <TB1> INFO: The DUT currently contains the following objects:
[17:14:08.233] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[17:14:08.233] <TB1> INFO: TBM Core alpha (0): 7 registers set
[17:14:08.233] <TB1> INFO: TBM Core beta (1): 7 registers set
[17:14:08.233] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:14:08.233] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.233] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:08.634] <TB1> INFO: enter 'restricted' command line mode
[17:14:08.634] <TB1> INFO: enter test to run
[17:14:08.634] <TB1> INFO: test: HighRate no parameter change
[17:14:08.634] <TB1> INFO: running: highrate
[17:14:08.634] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[17:14:08.772] <TB1> INFO: ----------------------------------------------------------------------
[17:14:08.772] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[17:14:08.772] <TB1> INFO: ----------------------------------------------------------------------
[17:14:09.855] <TB1> INFO: Test took 1077ms.
[17:14:14.015] <TB1> INFO: Test took 4155ms.
[17:14:14.186] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:18.413] <TB1> INFO: Test took 4196ms.
[17:14:18.579] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:23.032] <TB1> INFO: Test took 4423ms.
[17:14:23.206] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:27.568] <TB1> INFO: Test took 4331ms.
[17:14:27.739] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:32.194] <TB1> INFO: Test took 4418ms.
[17:14:32.360] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:36.397] <TB1> INFO: Test took 4005ms.
[17:14:36.588] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:40.864] <TB1> INFO: Test took 4245ms.
[17:14:41.038] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:45.341] <TB1> INFO: Test took 4272ms.
[17:14:45.514] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:49.725] <TB1> INFO: Test took 4177ms.
[17:14:49.897] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:53.927] <TB1> INFO: Test took 3995ms.
[17:14:54.127] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:58.233] <TB1> INFO: Test took 4067ms.
[17:14:58.407] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:02.440] <TB1> INFO: Test took 4000ms.
[17:15:02.633] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:06.637] <TB1> INFO: Test took 3966ms.
[17:15:06.821] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:10.701] <TB1> INFO: Test took 3843ms.
[17:15:10.883] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:15.156] <TB1> INFO: Test took 4242ms.
[17:15:15.337] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:19.429] <TB1> INFO: Test took 4060ms.
[17:15:19.611] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:23.230] <TB1> INFO: Test took 3587ms.
[17:15:23.396] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:26.947] <TB1> INFO: Test took 3521ms.
[17:15:27.112] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:30.684] <TB1> INFO: Test took 3541ms.
[17:15:30.863] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:34.335] <TB1> INFO: Test took 3442ms.
[17:15:34.495] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:34.814] <TB1> INFO: enter test to run
[17:15:34.814] <TB1> INFO: test: Pretest no parameter change
[17:15:34.814] <TB1> INFO: running: pretest
[17:15:34.814] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[17:15:34.815] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[17:15:34.816] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[17:15:34.816] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[17:15:34.816] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[17:15:34.816] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[17:15:34.816] <TB1> INFO: write dac parameters into /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[17:15:34.816] <TB1> INFO: enter test to run
[17:15:34.816] <TB1> INFO: test: no parameter change
[17:15:34.972] <TB1> QUIET: Connection to board 83 closed.
[17:15:35.052] <TB1> INFO: pXar: this is the end, my friend

[17:16:06.269] <TB1> INFO: *** Welcome to pxar ***
[17:16:06.269] <TB1> INFO: *** Today: 2015/08/21
[17:16:06.269] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//dacParameters35_C15.dat
[17:16:06.270] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//tbmParameters_C0b.dat
[17:16:06.270] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//defaultMaskFile.dat
[17:16:06.270] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//trimParameters35_C15.dat
[17:16:06.340] <TB1> INFO: clk: 4
[17:16:06.340] <TB1> INFO: ctr: 4
[17:16:06.340] <TB1> INFO: sda: 19
[17:16:06.340] <TB1> INFO: tin: 9
[17:16:06.340] <TB1> INFO: level: 15
[17:16:06.340] <TB1> INFO: triggerdelay: 0
[17:16:06.341] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:16:06.341] <TB1> INFO: Log level: INFO
[17:16:06.355] <TB1> INFO: Found DTB DTB_WS6UZO
[17:16:06.367] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[17:16:06.370] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[17:16:06.373] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[17:16:07.921] <TB1> INFO: DUT info:
[17:16:07.921] <TB1> INFO: The DUT currently contains the following objects:
[17:16:07.921] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[17:16:07.921] <TB1> INFO: TBM Core alpha (0): 7 registers set
[17:16:07.921] <TB1> INFO: TBM Core beta (1): 7 registers set
[17:16:07.921] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:16:07.921] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.921] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.922] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.922] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.922] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.922] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:07.922] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:08.323] <TB1> INFO: enter 'restricted' command line mode
[17:16:08.323] <TB1> INFO: enter test to run
[17:16:08.323] <TB1> INFO: test: HighRate no parameter change
[17:16:08.323] <TB1> INFO: running: highrate
[17:16:08.324] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[17:16:08.464] <TB1> INFO: ----------------------------------------------------------------------
[17:16:08.464] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:16:08.464] <TB1> INFO: ----------------------------------------------------------------------
[17:16:19.870] <TB1> INFO: Test took 11400ms.
[17:16:20.870] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:16:21.194] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 3 0 0 0 3 0 0 0 0 0 0 0 0
[17:16:21.194] <TB1> INFO: number of red-efficiency pixels: 149 148 200 326 345 421 378 365 313 339 455 336 263 150 124 156
[17:16:21.194] <TB1> INFO: number of X-ray hits detected: 108551 120682 105964 196941 207828 228045 201236 225092 201297 200080 234005 202382 176311 106184 107133 114965
[17:16:21.194] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[17:16:21.194] <TB1> INFO: number of Vcal hits detected: 207848 207851 207793 207509 207632 207551 207600 207418 207671 207647 207505 207641 207725 207838 207874 207840
[17:16:21.194] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.9 99.8 99.8 99.8 99.9 99.9 99.9 99.9
[17:16:21.194] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9
[17:16:21.194] <TB1> INFO: X-ray hit rate [MHz/cm2]: 31.8 35.4 31.1 57.7 60.9 66.8 59.0 66.0 59.0 58.6 68.6 59.3 51.7 31.1 31.4 33.7
[17:16:21.194] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[17:16:21.230] <TB1> INFO: PixTest:: pg_setup set to default.
[17:16:21.265] <TB1> INFO: enter test to run
[17:16:21.265] <TB1> INFO: test: no parameter change
[17:16:21.433] <TB1> QUIET: Connection to board 83 closed.
[17:16:21.522] <TB1> INFO: pXar: this is the end, my friend

[17:16:57.435] <TB1> INFO: *** Welcome to pxar ***
[17:16:57.435] <TB1> INFO: *** Today: 2015/08/21
[17:16:57.435] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//dacParameters35_C15.dat
[17:16:57.436] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//tbmParameters_C0b.dat
[17:16:57.436] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//defaultMaskFile.dat
[17:16:57.437] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//trimParameters35_C15.dat
[17:16:57.509] <TB1> INFO: clk: 4
[17:16:57.509] <TB1> INFO: ctr: 4
[17:16:57.509] <TB1> INFO: sda: 19
[17:16:57.509] <TB1> INFO: tin: 9
[17:16:57.509] <TB1> INFO: level: 15
[17:16:57.509] <TB1> INFO: triggerdelay: 0
[17:16:57.509] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:16:57.509] <TB1> INFO: Log level: INFO
[17:16:57.523] <TB1> INFO: Found DTB DTB_WS6UZO
[17:16:57.534] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[17:16:57.537] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[17:16:57.540] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[17:16:59.077] <TB1> INFO: DUT info:
[17:16:59.077] <TB1> INFO: The DUT currently contains the following objects:
[17:16:59.077] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[17:16:59.077] <TB1> INFO: TBM Core alpha (0): 7 registers set
[17:16:59.077] <TB1> INFO: TBM Core beta (1): 7 registers set
[17:16:59.077] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:16:59.077] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.077] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:59.479] <TB1> INFO: enter 'restricted' command line mode
[17:16:59.479] <TB1> INFO: enter test to run
[17:16:59.479] <TB1> INFO: test: HighRate no parameter change
[17:16:59.479] <TB1> INFO: running: highrate
[17:16:59.479] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[17:16:59.620] <TB1> INFO: ----------------------------------------------------------------------
[17:16:59.620] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:16:59.620] <TB1> INFO: ----------------------------------------------------------------------
[17:17:14.323] <TB1> INFO: Test took 14696ms.
[17:17:17.088] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:17:17.507] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 3 0 0 0 4 0 0 0 0 0 0 0 0
[17:17:17.507] <TB1> INFO: number of red-efficiency pixels: 446 494 627 1179 1352 1532 1530 1517 1350 1195 1606 1205 958 496 393 457
[17:17:17.507] <TB1> INFO: number of X-ray hits detected: 216773 242203 215389 388469 410928 447077 401127 447827 404731 400502 458321 402412 351345 217678 218388 228720
[17:17:17.507] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[17:17:17.507] <TB1> INFO: number of Vcal hits detected: 207526 207449 207154 206334 206054 205830 205755 205694 206197 206380 205673 206334 206830 207363 207578 207504
[17:17:17.507] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.3 99.2 99.1 99.1 99.1 99.2 99.3 99.0 99.3 99.5 99.7 99.8 99.8
[17:17:17.507] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.6 99.2 99.1 99.0 98.9 98.9 99.1 99.2 98.9 99.2 99.4 99.7 99.8 99.8
[17:17:17.507] <TB1> INFO: X-ray hit rate [MHz/cm2]: 63.5 71.0 63.1 113.9 120.4 131.0 117.6 131.3 118.6 117.4 134.3 117.9 103.0 63.8 64.0 67.0
[17:17:17.507] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[17:17:17.545] <TB1> INFO: PixTest:: pg_setup set to default.
[17:17:17.580] <TB1> INFO: enter test to run
[17:17:17.580] <TB1> INFO: test: no parameter change
[17:17:17.721] <TB1> QUIET: Connection to board 83 closed.
[17:17:17.813] <TB1> INFO: pXar: this is the end, my friend

[17:17:51.132] <TB1> INFO: *** Welcome to pxar ***
[17:17:51.132] <TB1> INFO: *** Today: 2015/08/21
[17:17:51.133] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//dacParameters35_C15.dat
[17:17:51.133] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//tbmParameters_C0b.dat
[17:17:51.133] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//defaultMaskFile.dat
[17:17:51.133] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//trimParameters35_C15.dat
[17:17:51.207] <TB1> INFO: clk: 4
[17:17:51.207] <TB1> INFO: ctr: 4
[17:17:51.207] <TB1> INFO: sda: 19
[17:17:51.207] <TB1> INFO: tin: 9
[17:17:51.207] <TB1> INFO: level: 15
[17:17:51.207] <TB1> INFO: triggerdelay: 0
[17:17:51.207] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:17:51.207] <TB1> INFO: Log level: INFO
[17:17:51.221] <TB1> INFO: Found DTB DTB_WS6UZO
[17:17:51.233] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[17:17:51.236] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[17:17:51.238] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[17:17:52.771] <TB1> INFO: DUT info:
[17:17:52.771] <TB1> INFO: The DUT currently contains the following objects:
[17:17:52.771] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[17:17:52.771] <TB1> INFO: TBM Core alpha (0): 7 registers set
[17:17:52.771] <TB1> INFO: TBM Core beta (1): 7 registers set
[17:17:52.771] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:17:52.771] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.771] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:52.772] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:53.174] <TB1> INFO: enter 'restricted' command line mode
[17:17:53.174] <TB1> INFO: enter test to run
[17:17:53.174] <TB1> INFO: test: HighRate no parameter change
[17:17:53.174] <TB1> INFO: running: highrate
[17:17:53.174] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[17:17:53.319] <TB1> INFO: ----------------------------------------------------------------------
[17:17:53.319] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:17:53.319] <TB1> INFO: ----------------------------------------------------------------------
[17:18:11.910] <TB1> INFO: Test took 18585ms.
[17:18:17.352] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:18:17.850] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 1 0 0 0 4 0 0 0 0 0 0 0 0
[17:18:17.850] <TB1> INFO: number of red-efficiency pixels: 1002 1015 1127 2336 2574 2845 2669 2984 2622 2375 2948 2410 2026 960 822 948
[17:18:17.850] <TB1> INFO: number of X-ray hits detected: 314430 348864 313697 554579 588695 638267 575078 642705 579021 574332 651147 574331 504225 313078 315293 330755
[17:18:17.850] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[17:18:17.850] <TB1> INFO: number of Vcal hits detected: 206801 206806 205865 203697 202690 201810 201884 201763 203012 203385 201288 203220 204731 206293 207062 206864
[17:18:17.850] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.5 99.5 99.2 98.2 97.8 97.4 97.5 97.4 97.9 98.1 97.2 98.0 98.6 99.3 99.6 99.5
[17:18:17.850] <TB1> INFO: Vcal hit overall efficiency (%): 99.4 99.4 99.0 97.9 97.4 97.0 97.1 97.0 97.6 97.8 96.8 97.7 98.4 99.2 99.5 99.5
[17:18:17.850] <TB1> INFO: X-ray hit rate [MHz/cm2]: 92.2 102.3 91.9 162.6 172.6 187.1 168.6 188.4 169.7 168.3 190.9 168.3 147.8 91.8 92.4 96.9
[17:18:17.850] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[17:18:17.888] <TB1> INFO: PixTest:: pg_setup set to default.
[17:18:17.930] <TB1> INFO: enter test to run
[17:18:17.930] <TB1> INFO: test: no parameter change
[17:18:18.063] <TB1> QUIET: Connection to board 83 closed.
[17:18:18.143] <TB1> INFO: pXar: this is the end, my friend

[17:18:48.251] <TB1> INFO: *** Welcome to pxar ***
[17:18:48.251] <TB1> INFO: *** Today: 2015/08/21
[17:18:48.251] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//dacParameters35_C15.dat
[17:18:48.252] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//tbmParameters_C0b.dat
[17:18:48.252] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//defaultMaskFile.dat
[17:18:48.252] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//trimParameters35_C15.dat
[17:18:48.328] <TB1> INFO: clk: 4
[17:18:48.328] <TB1> INFO: ctr: 4
[17:18:48.328] <TB1> INFO: sda: 19
[17:18:48.328] <TB1> INFO: tin: 9
[17:18:48.328] <TB1> INFO: level: 15
[17:18:48.328] <TB1> INFO: triggerdelay: 0
[17:18:48.328] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:18:48.328] <TB1> INFO: Log level: INFO
[17:18:48.340] <TB1> INFO: Found DTB DTB_WS6UZO
[17:18:48.352] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[17:18:48.355] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[17:18:48.357] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[17:18:49.906] <TB1> INFO: DUT info:
[17:18:49.906] <TB1> INFO: The DUT currently contains the following objects:
[17:18:49.906] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[17:18:49.906] <TB1> INFO: TBM Core alpha (0): 7 registers set
[17:18:49.906] <TB1> INFO: TBM Core beta (1): 7 registers set
[17:18:49.906] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:18:49.906] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:49.906] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:50.307] <TB1> INFO: enter 'restricted' command line mode
[17:18:50.308] <TB1> INFO: enter test to run
[17:18:50.308] <TB1> INFO: test: HighRate no parameter change
[17:18:50.308] <TB1> INFO: running: highrate
[17:18:50.308] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[17:18:50.445] <TB1> INFO: ----------------------------------------------------------------------
[17:18:50.445] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:18:50.445] <TB1> INFO: ----------------------------------------------------------------------
[17:19:12.154] <TB1> INFO: Test took 21703ms.
[17:19:21.506] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:19:22.135] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 1 0 0 0 3 0 0 0 0 0 0 0 0
[17:19:22.136] <TB1> INFO: number of red-efficiency pixels: 1771 1864 1729 3459 3663 3841 3687 3935 3736 3547 3922 3508 3197 1545 1522 1638
[17:19:22.136] <TB1> INFO: number of X-ray hits detected: 422953 476469 425504 741364 787554 850140 768628 862950 778082 775243 870829 773692 676222 425171 427236 446502
[17:19:22.136] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[17:19:22.136] <TB1> INFO: number of Vcal hits detected: 205482 205308 203257 197690 195109 193550 194358 193076 195959 196890 191786 196684 200137 203970 206003 205590
[17:19:22.136] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.9 98.8 98.2 95.7 94.5 93.8 94.3 93.4 94.8 95.3 93.0 95.2 96.7 98.4 99.1 99.0
[17:19:22.136] <TB1> INFO: Vcal hit overall efficiency (%): 98.8 98.7 97.7 95.0 93.8 93.1 93.4 92.8 94.2 94.7 92.2 94.6 96.2 98.1 99.0 98.8
[17:19:22.136] <TB1> INFO: X-ray hit rate [MHz/cm2]: 124.0 139.7 124.7 217.3 230.8 249.2 225.3 252.9 228.1 227.2 255.2 226.8 198.2 124.6 125.2 130.9
[17:19:22.136] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[17:19:22.162] <TB1> INFO: PixTest:: pg_setup set to default.
[17:19:22.226] <TB1> INFO: enter test to run
[17:19:22.226] <TB1> INFO: test: no parameter change
[17:19:22.433] <TB1> QUIET: Connection to board 83 closed.
[17:19:22.518] <TB1> INFO: pXar: this is the end, my friend

[17:19:52.681] <TB1> INFO: *** Welcome to pxar ***
[17:19:52.681] <TB1> INFO: *** Today: 2015/08/21
[17:19:52.682] <TB1> INFO: readRocDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//dacParameters35_C15.dat
[17:19:52.682] <TB1> INFO: readTbmDacs: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//tbmParameters_C0b.dat
[17:19:52.682] <TB1> INFO: readMaskFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//defaultMaskFile.dat
[17:19:52.682] <TB1> INFO: readTrimFile: /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//trimParameters35_C15.dat
[17:19:52.758] <TB1> INFO: clk: 4
[17:19:52.758] <TB1> INFO: ctr: 4
[17:19:52.758] <TB1> INFO: sda: 19
[17:19:52.758] <TB1> INFO: tin: 9
[17:19:52.758] <TB1> INFO: level: 15
[17:19:52.758] <TB1> INFO: triggerdelay: 0
[17:19:52.758] <TB1> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:19:52.758] <TB1> INFO: Log level: INFO
[17:19:52.771] <TB1> INFO: Found DTB DTB_WS6UZO
[17:19:52.782] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[17:19:52.786] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[17:19:52.788] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[17:19:54.345] <TB1> INFO: DUT info:
[17:19:54.345] <TB1> INFO: The DUT currently contains the following objects:
[17:19:54.345] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[17:19:54.345] <TB1> INFO: TBM Core alpha (0): 7 registers set
[17:19:54.345] <TB1> INFO: TBM Core beta (1): 7 registers set
[17:19:54.345] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:19:54.345] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.346] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:54.748] <TB1> INFO: enter 'restricted' command line mode
[17:19:54.748] <TB1> INFO: enter test to run
[17:19:54.748] <TB1> INFO: test: HighRate no parameter change
[17:19:54.748] <TB1> INFO: running: highrate
[17:19:54.748] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2028_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[17:19:54.947] <TB1> INFO: ----------------------------------------------------------------------
[17:19:54.947] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:19:54.947] <TB1> INFO: ----------------------------------------------------------------------
[17:20:17.534] <TB1> INFO: Test took 22580ms.
[17:20:27.104] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:20:27.718] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 1 0 0 0 3 0 0 0 0 0 0 0 0
[17:20:27.718] <TB1> INFO: number of red-efficiency pixels: 1866 1933 1847 3557 3734 3898 3709 3996 3807 3658 3973 3574 3287 1627 1603 1761
[17:20:27.718] <TB1> INFO: number of X-ray hits detected: 432943 489108 440514 760714 810575 870535 788797 887518 804366 800065 890070 790233 692620 441667 442378 459534
[17:20:27.718] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[17:20:27.718] <TB1> INFO: number of Vcal hits detected: 205256 205125 203038 197139 194555 192409 193454 191676 194789 195838 190875 195780 199642 203704 205809 205308
[17:20:27.718] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.8 98.7 98.0 95.4 94.3 93.3 93.9 92.8 94.3 94.8 92.6 94.8 96.5 98.3 99.0 98.9
[17:20:27.718] <TB1> INFO: Vcal hit overall efficiency (%): 98.7 98.6 97.6 94.8 93.5 92.5 93.0 92.2 93.6 94.2 91.8 94.1 96.0 97.9 98.9 98.7
[17:20:27.718] <TB1> INFO: X-ray hit rate [MHz/cm2]: 126.9 143.4 129.1 223.0 237.6 255.2 231.2 260.1 235.8 234.5 260.9 231.6 203.0 129.5 129.7 134.7
[17:20:27.718] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[17:20:27.748] <TB1> INFO: PixTest:: pg_setup set to default.
[17:20:27.787] <TB1> INFO: enter test to run
[17:20:27.787] <TB1> INFO: test: no parameter change
[17:20:27.944] <TB1> QUIET: Connection to board 83 closed.
[17:20:28.026] <TB1> INFO: pXar: this is the end, my friend