Test Date: 2015-08-12 14:10
Analysis date: 2016-05-26 00:17
Logfile
commander_PixelAlive.log
[12:11:16.694] <TB3> INFO: *** Welcome to pxar ***
[12:11:16.694] <TB3> INFO: *** Today: 2015/08/12
[12:11:16.694] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//000_PixelAlive_p17//dacParameters35_C15.dat
[12:11:16.695] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//000_PixelAlive_p17//tbmParameters_C0b.dat
[12:11:16.695] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//000_PixelAlive_p17//defaultMaskFile.dat
[12:11:16.695] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//000_PixelAlive_p17//trimParameters35_C15.dat
[12:11:16.783] <TB3> INFO: clk: 4
[12:11:16.783] <TB3> INFO: ctr: 4
[12:11:16.783] <TB3> INFO: sda: 19
[12:11:16.783] <TB3> INFO: tin: 9
[12:11:16.783] <TB3> INFO: level: 15
[12:11:16.783] <TB3> INFO: triggerdelay: 0
[12:11:16.783] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:11:16.783] <TB3> INFO: Log level: INFO
[12:11:16.797] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:11:16.815] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:11:16.818] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:11:16.821] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:11:18.362] <TB3> INFO: DUT info:
[12:11:18.362] <TB3> INFO: The DUT currently contains the following objects:
[12:11:18.362] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:11:18.362] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:11:18.362] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:11:18.362] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:11:18.362] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.362] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:11:18.763] <TB3> INFO: enter 'restricted' command line mode
[12:11:18.764] <TB3> INFO: enter test to run
[12:11:18.764] <TB3> INFO: test: PixelAlive no parameter change
[12:11:18.764] <TB3> INFO: running: pixelalive
[12:11:18.769] <TB3> INFO: ######################################################################
[12:11:18.769] <TB3> INFO: PixTestAlive::doTest()
[12:11:18.769] <TB3> INFO: ######################################################################
[12:11:18.770] <TB3> INFO: ----------------------------------------------------------------------
[12:11:18.770] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:11:18.770] <TB3> INFO: ----------------------------------------------------------------------
[12:11:22.355] <TB3> INFO: Test took 3583ms.
[12:11:22.373] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:22.619] <TB3> INFO: PixTestAlive::aliveTest() done
[12:11:22.619] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 1 0 0 3 0 0 0 0 0 0 0 0 1
[12:11:22.620] <TB3> INFO: ----------------------------------------------------------------------
[12:11:22.620] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:11:22.620] <TB3> INFO: ----------------------------------------------------------------------
[12:11:25.419] <TB3> INFO: Test took 2798ms.
[12:11:25.421] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:25.421] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:11:25.640] <TB3> INFO: PixTestAlive::maskTest() done
[12:11:25.640] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:11:25.642] <TB3> INFO: ----------------------------------------------------------------------
[12:11:25.642] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:11:25.642] <TB3> INFO: ----------------------------------------------------------------------
[12:11:29.277] <TB3> INFO: Test took 3634ms.
[12:11:29.295] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:11:29.517] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[12:11:29.517] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:11:29.517] <TB3> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[12:11:29.545] <TB3> INFO: enter test to run
[12:11:29.545] <TB3> INFO: test: no parameter change
[12:11:29.685] <TB3> QUIET: Connection to board 121 closed.
[12:11:29.764] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[12:16:47.974] <TB3> INFO: *** Welcome to pxar ***
[12:16:47.974] <TB3> INFO: *** Today: 2015/08/12
[12:16:47.974] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//dacParameters35_C15.dat
[12:16:47.975] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[12:16:47.975] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:16:47.975] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:16:48.051] <TB3> INFO: clk: 4
[12:16:48.051] <TB3> INFO: ctr: 4
[12:16:48.051] <TB3> INFO: sda: 19
[12:16:48.051] <TB3> INFO: tin: 9
[12:16:48.051] <TB3> INFO: level: 15
[12:16:48.051] <TB3> INFO: triggerdelay: 0
[12:16:48.051] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:16:48.051] <TB3> INFO: Log level: INFO
[12:16:48.067] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:16:48.085] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:16:48.089] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:16:48.091] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:16:49.630] <TB3> INFO: DUT info:
[12:16:49.630] <TB3> INFO: The DUT currently contains the following objects:
[12:16:49.630] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:16:49.630] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:16:49.630] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:16:49.630] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:16:49.630] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.630] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.631] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.631] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.631] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.631] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:49.631] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:50.032] <TB3> INFO: enter 'restricted' command line mode
[12:16:50.032] <TB3> INFO: enter test to run
[12:16:50.032] <TB3> INFO: test: delay setting parameters: ->5<-
[12:16:50.032] <TB3> INFO: delay test by 5 seconds...
[12:16:55.032] <TB3> INFO: enter test to run
[12:16:55.032] <TB3> INFO: test: highrate no parameter change
[12:16:55.032] <TB3> INFO: running: highrate
[12:16:55.033] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[12:16:55.220] <TB3> INFO: ----------------------------------------------------------------------
[12:16:55.220] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:16:55.220] <TB3> INFO: ----------------------------------------------------------------------
[12:16:55.220] <TB3> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[12:16:55.220] <TB3> INFO: edge/corner pixel THR is adjusted
[12:16:55.220] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:16:56.183] <TB3> INFO: Collecting data for 1 seconds...
[12:16:57.184] <TB3> INFO: Done with hot pixel readout
[12:17:03.060] <TB3> INFO: PixTest:: pg_setup set to default.
[12:17:03.061] <TB3> INFO: 3 hot pixels found in step 0
[12:17:04.025] <TB3> INFO: Collecting data for 1 seconds...
[12:17:05.027] <TB3> INFO: Done with hot pixel readout
[12:17:11.025] <TB3> INFO: PixTest:: pg_setup set to default.
[12:17:11.025] <TB3> INFO: 2 hot pixels found in step 1
[12:17:11.988] <TB3> INFO: Collecting data for 1 seconds...
[12:17:12.990] <TB3> INFO: Done with hot pixel readout
[12:17:18.449] <TB3> INFO: PixTest:: pg_setup set to default.
[12:17:18.450] <TB3> INFO: 2 hot pixels found in step 2
[12:17:19.411] <TB3> INFO: Collecting data for 1 seconds...
[12:17:20.412] <TB3> INFO: Done with hot pixel readout
[12:17:20.728] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 0 Number of ROCs (2) != Token Chain Length (4)

[12:17:20.728] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 1 Number of ROCs (2) != Token Chain Length (4)

[12:17:20.728] <TB3> WARNING: Channel 0 ROC 3: Readback start marker after 15 readouts!

[12:17:20.728] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 15 readouts!

[12:17:25.470] <TB3> INFO: PixTest:: pg_setup set to default.
[12:17:25.471] <TB3> INFO: 0 hot pixels found in step 3
[12:17:25.479] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[12:17:25.506] <TB3> INFO: PixTest::trimHotPixels() done
[12:17:25.506] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C0.dat
[12:17:25.512] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C1.dat
[12:17:25.518] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C2.dat
[12:17:25.524] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C3.dat
[12:17:25.530] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C4.dat
[12:17:25.536] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C5.dat
[12:17:25.543] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C6.dat
[12:17:25.549] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C7.dat
[12:17:25.555] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C8.dat
[12:17:25.561] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C9.dat
[12:17:25.567] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C10.dat
[12:17:25.573] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C11.dat
[12:17:25.580] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C12.dat
[12:17:25.586] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C13.dat
[12:17:25.591] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C14.dat
[12:17:25.598] <TB3> INFO: write trim parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:17:25.604] <TB3> INFO: write masked pixels into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:17:25.637] <TB3> INFO: enter test to run
[12:17:25.637] <TB3> INFO: test: no parameter change
[12:17:25.784] <TB3> QUIET: Connection to board 121 closed.
[12:17:25.864] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[12:17:59.997] <TB3> INFO: *** Welcome to pxar ***
[12:17:59.997] <TB3> INFO: *** Today: 2015/08/12
[12:17:59.997] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//dacParameters35_C15.dat
[12:17:59.999] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//tbmParameters_C0b.dat
[12:17:59.999] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//defaultMaskFile.dat
[12:17:59.999] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//trimParameters35_C15.dat
[12:18:00.075] <TB3> INFO: clk: 4
[12:18:00.075] <TB3> INFO: ctr: 4
[12:18:00.075] <TB3> INFO: sda: 19
[12:18:00.075] <TB3> INFO: tin: 9
[12:18:00.075] <TB3> INFO: level: 15
[12:18:00.075] <TB3> INFO: triggerdelay: 0
[12:18:00.075] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:18:00.075] <TB3> INFO: Log level: INFO
[12:18:00.088] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:18:00.107] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:18:00.110] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:18:00.113] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:18:01.649] <TB3> INFO: DUT info:
[12:18:01.649] <TB3> INFO: The DUT currently contains the following objects:
[12:18:01.649] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:18:01.649] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:18:01.649] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:18:01.649] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:18:01.649] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:01.649] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:02.050] <TB3> INFO: enter 'restricted' command line mode
[12:18:02.050] <TB3> INFO: enter test to run
[12:18:02.050] <TB3> INFO: test: delay setting parameters: ->5<-
[12:18:02.050] <TB3> INFO: delay test by 5 seconds...
[12:18:07.050] <TB3> INFO: enter test to run
[12:18:07.051] <TB3> INFO: test: Xray no parameter change
[12:18:07.052] <TB3> INFO: running: xray
[12:18:07.053] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//003_HRData_50//phCalibrationFitErr35_C15.dat
[12:18:07.212] <TB3> INFO: ######################################################################
[12:18:07.212] <TB3> INFO: PixTestXray::doTest()
[12:18:07.212] <TB3> INFO: ######################################################################
[12:18:07.212] <TB3> INFO: ----------------------------------------------------------------------
[12:18:07.212] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:18:07.212] <TB3> INFO: ----------------------------------------------------------------------
[12:18:08.182] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:18:15.054] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[12:18:39.244] <TB3> INFO: Resuming triggers.
[12:18:46.129] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[12:18:49.469] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (158) != TBM ID (61)

[12:18:49.469] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[12:18:49.469] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (62) != TBM ID (158)

[12:18:49.469] <TB3> WARNING: Channel 3 ROC 1: Readback start marker after 17 readouts!

[12:19:07.973] <TB3> INFO: Resuming triggers.
[12:19:14.851] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[12:19:35.921] <TB3> INFO: Resuming triggers.
[12:19:42.798] <TB3> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[12:20:04.514] <TB3> INFO: Resuming triggers.
[12:20:11.392] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[12:20:35.732] <TB3> INFO: Resuming triggers.
[12:20:42.615] <TB3> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[12:21:01.984] <TB3> INFO: Resuming triggers.
[12:21:08.862] <TB3> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[12:21:32.825] <TB3> INFO: Resuming triggers.
[12:21:39.700] <TB3> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[12:22:04.603] <TB3> INFO: Resuming triggers.
[12:22:11.483] <TB3> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[12:22:32.881] <TB3> INFO: Resuming triggers.
[12:22:39.759] <TB3> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[12:23:01.321] <TB3> INFO: Resuming triggers.
[12:23:08.192] <TB3> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[12:23:28.713] <TB3> INFO: Resuming triggers.
[12:23:35.590] <TB3> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[12:23:56.088] <TB3> INFO: Resuming triggers.
[12:24:02.967] <TB3> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[12:24:24.763] <TB3> INFO: Resuming triggers.
[12:24:31.642] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[12:24:51.298] <TB3> INFO: Resuming triggers.
[12:24:55.116] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[12:25:08.881] <TB3> INFO: PixTest:: pg_setup set to default.
[12:25:08.883] <TB3> INFO: PixTestXray::doPhRun() done
[12:25:08.883] <TB3> INFO: PixTestXray::doTest() done
[12:25:09.061] <TB3> INFO: enter test to run
[12:25:09.061] <TB3> INFO: test: no parameter change
[12:25:09.237] <TB3> QUIET: Connection to board 121 closed.
[12:25:09.317] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[12:26:50.007] <TB3> INFO: *** Welcome to pxar ***
[12:26:50.007] <TB3> INFO: *** Today: 2015/08/12
[12:26:50.007] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//dacParameters35_C15.dat
[12:26:50.007] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//tbmParameters_C0b.dat
[12:26:50.007] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//defaultMaskFile.dat
[12:26:50.007] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//trimParameters35_C15.dat
[12:26:50.084] <TB3> INFO: clk: 4
[12:26:50.084] <TB3> INFO: ctr: 4
[12:26:50.084] <TB3> INFO: sda: 19
[12:26:50.084] <TB3> INFO: tin: 9
[12:26:50.084] <TB3> INFO: level: 15
[12:26:50.084] <TB3> INFO: triggerdelay: 0
[12:26:50.084] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:26:50.084] <TB3> INFO: Log level: INFO
[12:26:50.099] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:26:50.116] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:26:50.119] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:26:50.122] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:26:51.652] <TB3> INFO: DUT info:
[12:26:51.652] <TB3> INFO: The DUT currently contains the following objects:
[12:26:51.652] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:26:51.652] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:26:51.652] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:26:51.652] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:26:51.652] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:51.652] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:26:52.053] <TB3> INFO: enter 'restricted' command line mode
[12:26:52.053] <TB3> INFO: enter test to run
[12:26:52.054] <TB3> INFO: test: delay setting parameters: ->5<-
[12:26:52.054] <TB3> INFO: delay test by 5 seconds...
[12:26:57.054] <TB3> INFO: enter test to run
[12:26:57.054] <TB3> INFO: test: Xray no parameter change
[12:26:57.054] <TB3> INFO: running: xray
[12:26:57.054] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//004_HRData_150//phCalibrationFitErr35_C15.dat
[12:26:57.197] <TB3> INFO: ######################################################################
[12:26:57.197] <TB3> INFO: PixTestXray::doTest()
[12:26:57.197] <TB3> INFO: ######################################################################
[12:26:57.197] <TB3> INFO: ----------------------------------------------------------------------
[12:26:57.197] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:26:57.197] <TB3> INFO: ----------------------------------------------------------------------
[12:26:58.166] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:27:02.007] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[12:27:29.344] <TB3> INFO: Resuming triggers.
[12:27:33.199] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[12:27:36.872] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (6) != Token Chain Length (4)

[12:28:03.702] <TB3> INFO: Resuming triggers.
[12:28:07.555] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[12:28:32.922] <TB3> INFO: Resuming triggers.
[12:28:36.777] <TB3> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[12:29:00.771] <TB3> INFO: Resuming triggers.
[12:29:04.626] <TB3> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[12:29:28.382] <TB3> INFO: Resuming triggers.
[12:29:32.235] <TB3> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[12:29:57.374] <TB3> INFO: Resuming triggers.
[12:30:01.227] <TB3> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[12:30:22.267] <TB3> INFO: Resuming triggers.
[12:30:26.121] <TB3> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[12:30:50.654] <TB3> INFO: Resuming triggers.
[12:30:54.505] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[12:31:15.901] <TB3> INFO: Resuming triggers.
[12:31:19.753] <TB3> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[12:31:40.598] <TB3> INFO: Resuming triggers.
[12:31:44.452] <TB3> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[12:32:05.419] <TB3> INFO: Resuming triggers.
[12:32:09.272] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[12:32:30.685] <TB3> INFO: Resuming triggers.
[12:32:34.539] <TB3> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[12:32:55.426] <TB3> INFO: Resuming triggers.
[12:32:59.280] <TB3> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[12:33:22.636] <TB3> INFO: Resuming triggers.
[12:33:26.488] <TB3> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[12:33:52.054] <TB3> INFO: Resuming triggers.
[12:33:55.906] <TB3> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[12:34:20.232] <TB3> INFO: Resuming triggers.
[12:34:24.084] <TB3> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[12:34:48.381] <TB3> INFO: Resuming triggers.
[12:34:52.232] <TB3> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[12:35:18.125] <TB3> INFO: Resuming triggers.
[12:35:21.974] <TB3> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[12:35:46.898] <TB3> INFO: Resuming triggers.
[12:35:50.751] <TB3> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[12:36:16.843] <TB3> INFO: Resuming triggers.
[12:36:20.693] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[12:36:43.148] <TB3> INFO: Resuming triggers.
[12:36:46.997] <TB3> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[12:37:12.722] <TB3> INFO: Resuming triggers.
[12:37:16.574] <TB3> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[12:37:42.510] <TB3> INFO: Resuming triggers.
[12:37:46.362] <TB3> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[12:38:11.062] <TB3> INFO: Resuming triggers.
[12:38:14.913] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[12:38:39.831] <TB3> INFO: Resuming triggers.
[12:38:43.621] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[12:39:05.689] <TB3> INFO: PixTest:: pg_setup set to default.
[12:39:05.691] <TB3> INFO: PixTestXray::doPhRun() done
[12:39:05.691] <TB3> INFO: PixTestXray::doTest() done
[12:39:05.901] <TB3> INFO: enter test to run
[12:39:05.902] <TB3> INFO: test: no parameter change
[12:39:06.096] <TB3> QUIET: Connection to board 121 closed.
[12:39:06.176] <TB3> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[12:41:58.157] <TB3> INFO: *** Welcome to pxar ***
[12:41:58.157] <TB3> INFO: *** Today: 2015/08/12
[12:41:58.157] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//dacParameters35_C15.dat
[12:41:58.157] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//tbmParameters_C0b.dat
[12:41:58.158] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//defaultMaskFile.dat
[12:41:58.158] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//trimParameters35_C15.dat
[12:41:58.264] <TB3> INFO: clk: 4
[12:41:58.264] <TB3> INFO: ctr: 4
[12:41:58.264] <TB3> INFO: sda: 19
[12:41:58.264] <TB3> INFO: tin: 9
[12:41:58.264] <TB3> INFO: level: 15
[12:41:58.264] <TB3> INFO: triggerdelay: 0
[12:41:58.264] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:41:58.264] <TB3> INFO: Log level: INFO
[12:41:58.278] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:41:58.295] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:41:58.299] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:41:58.301] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:41:59.903] <TB3> INFO: DUT info:
[12:41:59.903] <TB3> INFO: The DUT currently contains the following objects:
[12:41:59.903] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:41:59.903] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:41:59.903] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:41:59.903] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:41:59.903] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:59.903] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:00.304] <TB3> INFO: enter 'restricted' command line mode
[12:42:00.304] <TB3> INFO: enter test to run
[12:42:00.304] <TB3> INFO: test: Highrate no parameter change
[12:42:00.304] <TB3> INFO: running: highrate
[12:42:00.305] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[12:42:00.482] <TB3> INFO: ----------------------------------------------------------------------
[12:42:00.483] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[12:42:00.483] <TB3> INFO: ----------------------------------------------------------------------
[12:42:00.488] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 100 (1) hits flags = 384 (plus default)
[12:42:00.499] <TB3> INFO: dacScan step from 0 .. 0
[12:42:14.213] <TB3> INFO: Test took 13714ms.
[12:42:15.609] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:42:15.827] <TB3> INFO: dacScan step from 1 .. 1
[12:42:29.128] <TB3> INFO: Test took 13301ms.
[12:42:30.379] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:42:30.675] <TB3> INFO: dacScan step from 2 .. 2
[12:42:43.869] <TB3> INFO: Test took 13194ms.
[12:42:45.260] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:42:45.478] <TB3> INFO: dacScan step from 3 .. 3
[12:42:58.663] <TB3> INFO: Test took 13185ms.
[12:43:00.162] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:43:00.402] <TB3> INFO: dacScan step from 4 .. 4
[12:43:13.629] <TB3> INFO: Test took 13227ms.
[12:43:14.935] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:43:15.188] <TB3> INFO: dacScan step from 5 .. 5
[12:43:28.338] <TB3> INFO: Test took 13150ms.
[12:43:29.652] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:43:29.878] <TB3> INFO: dacScan step from 6 .. 6
[12:43:43.127] <TB3> INFO: Test took 13248ms.
[12:43:44.400] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:43:44.620] <TB3> INFO: dacScan step from 7 .. 7
[12:43:57.991] <TB3> INFO: Test took 13370ms.
[12:43:59.342] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:43:59.593] <TB3> INFO: dacScan step from 8 .. 8
[12:44:12.713] <TB3> INFO: Test took 13119ms.
[12:44:14.028] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:44:14.270] <TB3> INFO: dacScan step from 9 .. 9
[12:44:26.923] <TB3> INFO: Test took 12652ms.
[12:44:28.247] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:44:28.478] <TB3> INFO: dacScan step from 10 .. 10
[12:44:41.408] <TB3> INFO: Test took 12930ms.
[12:44:42.622] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:44:42.842] <TB3> INFO: dacScan step from 11 .. 11
[12:44:55.859] <TB3> INFO: Test took 13017ms.
[12:44:57.204] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:44:57.453] <TB3> INFO: dacScan step from 12 .. 12
[12:45:10.496] <TB3> INFO: Test took 13042ms.
[12:45:11.744] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:45:11.970] <TB3> INFO: dacScan step from 13 .. 13
[12:45:24.986] <TB3> INFO: Test took 13016ms.
[12:45:26.259] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:45:26.476] <TB3> INFO: dacScan step from 14 .. 14
[12:45:39.163] <TB3> INFO: Test took 12686ms.
[12:45:40.417] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:45:40.649] <TB3> INFO: dacScan step from 15 .. 15
[12:45:53.700] <TB3> INFO: Test took 13050ms.
[12:45:55.034] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:45:55.261] <TB3> INFO: dacScan step from 16 .. 16
[12:46:08.187] <TB3> INFO: Test took 12925ms.
[12:46:09.510] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:46:09.736] <TB3> INFO: dacScan step from 17 .. 17
[12:46:22.768] <TB3> INFO: Test took 13031ms.
[12:46:24.133] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:46:24.390] <TB3> INFO: dacScan step from 18 .. 18
[12:46:29.097] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 1 Number of ROCs (3) != Token Chain Length (4)

[12:46:37.498] <TB3> INFO: Test took 13107ms.
[12:46:38.889] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:46:39.120] <TB3> INFO: dacScan step from 19 .. 19
[12:46:52.235] <TB3> INFO: Test took 13115ms.
[12:46:53.506] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:46:53.741] <TB3> INFO: dacScan step from 20 .. 20
[12:47:06.563] <TB3> INFO: Test took 12822ms.
[12:47:07.875] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:47:08.122] <TB3> INFO: dacScan step from 21 .. 21
[12:47:20.976] <TB3> INFO: Test took 12854ms.
[12:47:22.469] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:47:22.699] <TB3> INFO: dacScan step from 22 .. 22
[12:47:35.777] <TB3> INFO: Test took 13078ms.
[12:47:37.123] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:47:37.350] <TB3> INFO: dacScan step from 23 .. 23
[12:47:50.647] <TB3> INFO: Test took 13296ms.
[12:47:51.910] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:47:52.146] <TB3> INFO: dacScan step from 24 .. 24
[12:48:05.245] <TB3> INFO: Test took 13099ms.
[12:48:06.576] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:48:06.832] <TB3> INFO: dacScan step from 25 .. 25
[12:48:19.696] <TB3> INFO: Test took 12864ms.
[12:48:21.027] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:48:21.261] <TB3> INFO: dacScan step from 26 .. 26
[12:48:34.255] <TB3> INFO: Test took 12994ms.
[12:48:35.602] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:48:35.843] <TB3> INFO: dacScan step from 27 .. 27
[12:48:48.704] <TB3> INFO: Test took 12861ms.
[12:48:49.987] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:48:50.219] <TB3> INFO: dacScan step from 28 .. 28
[12:49:03.416] <TB3> INFO: Test took 13196ms.
[12:49:04.714] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:49:04.940] <TB3> INFO: dacScan step from 29 .. 29
[12:49:18.330] <TB3> INFO: Test took 13389ms.
[12:49:19.646] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:49:19.894] <TB3> INFO: dacScan step from 30 .. 30
[12:49:33.587] <TB3> INFO: Test took 13693ms.
[12:49:35.005] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:49:35.260] <TB3> INFO: dacScan step from 31 .. 31
[12:49:48.719] <TB3> INFO: Test took 13459ms.
[12:49:50.041] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:49:50.266] <TB3> INFO: dacScan step from 32 .. 32
[12:49:54.874] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 1 Number of ROCs (3) != Token Chain Length (4)

[12:50:03.188] <TB3> INFO: Test took 12921ms.
[12:50:04.547] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:50:04.781] <TB3> INFO: dacScan step from 33 .. 33
[12:50:17.713] <TB3> INFO: Test took 12932ms.
[12:50:19.002] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:50:19.234] <TB3> INFO: dacScan step from 34 .. 34
[12:50:32.595] <TB3> INFO: Test took 13360ms.
[12:50:34.029] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:50:34.261] <TB3> INFO: dacScan step from 35 .. 35
[12:50:47.564] <TB3> INFO: Test took 13302ms.
[12:50:49.099] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:50:49.329] <TB3> INFO: dacScan step from 36 .. 36
[12:51:02.976] <TB3> INFO: Test took 13647ms.
[12:51:04.256] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:51:04.486] <TB3> INFO: dacScan step from 37 .. 37
[12:51:18.241] <TB3> INFO: Test took 13755ms.
[12:51:19.569] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:51:19.794] <TB3> INFO: dacScan step from 38 .. 38
[12:51:33.524] <TB3> INFO: Test took 13730ms.
[12:51:34.921] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:51:35.161] <TB3> INFO: dacScan step from 39 .. 39
[12:51:49.000] <TB3> INFO: Test took 13838ms.
[12:51:50.540] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:51:50.788] <TB3> INFO: dacScan step from 40 .. 40
[12:52:05.165] <TB3> INFO: Test took 14377ms.
[12:52:06.481] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:52:06.705] <TB3> INFO: dacScan step from 41 .. 41
[12:52:21.541] <TB3> INFO: Test took 14835ms.
[12:52:22.924] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:52:23.167] <TB3> INFO: dacScan step from 42 .. 42
[12:52:38.114] <TB3> INFO: Test took 14946ms.
[12:52:39.661] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:52:39.888] <TB3> INFO: dacScan step from 43 .. 43
[12:52:54.857] <TB3> INFO: Test took 14969ms.
[12:52:56.248] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:52:56.481] <TB3> INFO: dacScan step from 44 .. 44
[12:53:11.808] <TB3> INFO: Test took 15326ms.
[12:53:13.156] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:53:13.381] <TB3> INFO: dacScan step from 45 .. 45
[12:53:28.884] <TB3> INFO: Test took 15502ms.
[12:53:30.342] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:53:30.586] <TB3> INFO: dacScan step from 46 .. 46
[12:53:46.007] <TB3> INFO: Test took 15421ms.
[12:53:47.629] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:53:47.914] <TB3> INFO: dacScan step from 47 .. 47
[12:54:04.103] <TB3> INFO: Test took 16188ms.
[12:54:05.690] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:05.929] <TB3> INFO: dacScan step from 48 .. 48
[12:54:22.174] <TB3> INFO: Test took 16245ms.
[12:54:23.803] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:24.052] <TB3> INFO: dacScan step from 49 .. 49
[12:54:40.158] <TB3> INFO: Test took 16106ms.
[12:54:41.548] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:41.774] <TB3> INFO: dacScan step from 50 .. 50
[12:54:57.986] <TB3> INFO: Test took 16212ms.
[12:54:59.729] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:55:00.015] <TB3> INFO: dacScan step from 51 .. 51
[12:55:16.308] <TB3> INFO: Test took 16292ms.
[12:55:17.930] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:55:18.176] <TB3> INFO: dacScan step from 52 .. 52
[12:55:34.471] <TB3> INFO: Test took 16295ms.
[12:55:36.074] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:55:36.347] <TB3> INFO: dacScan step from 53 .. 53
[12:55:52.997] <TB3> INFO: Test took 16649ms.
[12:55:54.463] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:55:54.759] <TB3> INFO: dacScan step from 54 .. 54
[12:56:11.122] <TB3> INFO: Test took 16362ms.
[12:56:12.639] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:56:12.916] <TB3> INFO: dacScan step from 55 .. 55
[12:56:29.229] <TB3> INFO: Test took 16312ms.
[12:56:30.693] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:56:30.944] <TB3> INFO: dacScan step from 56 .. 56
[12:56:47.067] <TB3> INFO: Test took 16122ms.
[12:56:48.508] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:56:48.760] <TB3> INFO: dacScan step from 57 .. 57
[12:57:04.805] <TB3> INFO: Test took 16045ms.
[12:57:06.340] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:57:06.575] <TB3> INFO: dacScan step from 58 .. 58
[12:57:22.655] <TB3> INFO: Test took 16079ms.
[12:57:24.166] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:57:24.392] <TB3> INFO: dacScan step from 59 .. 59
[12:57:40.492] <TB3> INFO: Test took 16099ms.
[12:57:42.029] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:57:42.310] <TB3> INFO: dacScan step from 60 .. 60
[12:57:58.589] <TB3> INFO: Test took 16278ms.
[12:58:00.297] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:58:00.535] <TB3> INFO: dacScan step from 61 .. 61
[12:58:16.929] <TB3> INFO: Test took 16393ms.
[12:58:18.596] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:58:18.876] <TB3> INFO: dacScan step from 62 .. 62
[12:58:35.339] <TB3> INFO: Test took 16462ms.
[12:58:36.939] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:58:37.189] <TB3> INFO: dacScan step from 63 .. 63
[12:58:53.699] <TB3> INFO: Test took 16509ms.
[12:58:55.187] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:58:55.430] <TB3> INFO: dacScan step from 64 .. 64
[12:59:11.397] <TB3> INFO: Test took 15966ms.
[12:59:12.876] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:13.120] <TB3> INFO: dacScan step from 65 .. 65
[12:59:17.839] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 0 Number of ROCs (3) != Token Chain Length (4)

[12:59:29.655] <TB3> INFO: Test took 16535ms.
[12:59:31.064] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:31.326] <TB3> INFO: dacScan step from 66 .. 66
[12:59:47.940] <TB3> INFO: Test took 16613ms.
[12:59:49.479] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:59:49.721] <TB3> INFO: dacScan step from 67 .. 67
[13:00:06.231] <TB3> INFO: Test took 16509ms.
[13:00:07.736] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:07.975] <TB3> INFO: dacScan step from 68 .. 68
[13:00:24.385] <TB3> INFO: Test took 16409ms.
[13:00:25.896] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:26.129] <TB3> INFO: dacScan step from 69 .. 69
[13:00:42.375] <TB3> INFO: Test took 16246ms.
[13:00:43.849] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:00:44.097] <TB3> INFO: dacScan step from 70 .. 70
[13:00:48.580] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 0 Number of ROCs (2) != Token Chain Length (4)

[13:00:48.580] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 1 Number of ROCs (2) != Token Chain Length (4)

[13:00:48.580] <TB3> WARNING: Channel 0 ROC 3: Readback start marker after 15 readouts!

[13:00:48.581] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 15 readouts!

[13:01:00.307] <TB3> INFO: Test took 16209ms.
[13:01:01.837] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:01:02.108] <TB3> INFO: dacScan step from 71 .. 71
[13:01:18.336] <TB3> INFO: Test took 16228ms.
[13:01:19.768] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:01:20.023] <TB3> INFO: dacScan step from 72 .. 72
[13:01:36.379] <TB3> INFO: Test took 16355ms.
[13:01:38.097] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:01:38.355] <TB3> INFO: dacScan step from 73 .. 73
[13:01:54.721] <TB3> INFO: Test took 16365ms.
[13:01:56.148] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:01:56.402] <TB3> INFO: dacScan step from 74 .. 74
[13:02:13.062] <TB3> INFO: Test took 16659ms.
[13:02:14.627] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:02:14.872] <TB3> INFO: dacScan step from 75 .. 75
[13:02:19.452] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 0 Event ID mismatch: local ID (175) != TBM ID (176)

[13:02:19.452] <TB3> WARNING: Channel 0 ROC 0: Readback start marker after 31 readouts!

[13:02:19.452] <TB3> WARNING: Channel 0 ROC 1: Readback start marker after 31 readouts!

[13:02:19.452] <TB3> WARNING: Channel 0 ROC 2: Readback start marker after 31 readouts!

[13:02:19.452] <TB3> WARNING: Channel 0 ROC 3: Readback start marker after 31 readouts!

[13:02:31.529] <TB3> INFO: Test took 16657ms.
[13:02:33.259] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:02:33.502] <TB3> INFO: dacScan step from 76 .. 76
[13:02:49.998] <TB3> INFO: Test took 16495ms.
[13:02:51.436] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:02:51.676] <TB3> INFO: dacScan step from 77 .. 77
[13:03:08.043] <TB3> INFO: Test took 16366ms.
[13:03:09.562] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:03:09.799] <TB3> INFO: dacScan step from 78 .. 78
[13:03:26.090] <TB3> INFO: Test took 16290ms.
[13:03:27.671] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:03:27.919] <TB3> INFO: dacScan step from 79 .. 79
[13:03:44.235] <TB3> INFO: Test took 16315ms.
[13:03:45.660] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:03:45.935] <TB3> INFO: dacScan step from 80 .. 80
[13:04:02.646] <TB3> INFO: Test took 16710ms.
[13:04:04.125] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:04:04.373] <TB3> INFO: dacScan step from 81 .. 81
[13:04:21.054] <TB3> INFO: Test took 16680ms.
[13:04:22.503] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:04:22.747] <TB3> INFO: dacScan step from 82 .. 82
[13:04:39.044] <TB3> INFO: Test took 16296ms.
[13:04:40.680] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:04:40.944] <TB3> INFO: dacScan step from 83 .. 83
[13:04:57.128] <TB3> INFO: Test took 16183ms.
[13:04:58.721] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:04:58.967] <TB3> INFO: dacScan step from 84 .. 84
[13:05:14.807] <TB3> INFO: Test took 15839ms.
[13:05:16.266] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:05:16.506] <TB3> INFO: dacScan step from 85 .. 85
[13:05:32.522] <TB3> INFO: Test took 16015ms.
[13:05:34.096] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:05:34.340] <TB3> INFO: dacScan step from 86 .. 86
[13:05:38.804] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 0 Number of ROCs (5) != Token Chain Length (4)

[13:05:50.756] <TB3> INFO: Test took 16415ms.
[13:05:52.310] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:05:52.567] <TB3> INFO: dacScan step from 87 .. 87
[13:05:57.055] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 0 Number of ROCs (2) != Token Chain Length (4)

[13:05:57.055] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 1 Number of ROCs (2) != Token Chain Length (4)

[13:05:57.056] <TB3> WARNING: Channel 0 ROC 3: Readback start marker after 15 readouts!

[13:05:57.056] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 15 readouts!

[13:06:09.074] <TB3> INFO: Test took 16505ms.
[13:06:10.534] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:06:10.802] <TB3> INFO: dacScan step from 88 .. 88
[13:06:27.408] <TB3> INFO: Test took 16605ms.
[13:06:28.900] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:06:29.168] <TB3> INFO: dacScan step from 89 .. 89
[13:06:45.758] <TB3> INFO: Test took 16589ms.
[13:06:47.292] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:06:47.532] <TB3> INFO: dacScan step from 90 .. 90
[13:07:04.345] <TB3> INFO: Test took 16812ms.
[13:07:05.814] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:07:06.084] <TB3> INFO: dacScan step from 91 .. 91
[13:07:22.654] <TB3> INFO: Test took 16569ms.
[13:07:24.151] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:07:24.401] <TB3> INFO: dacScan step from 92 .. 92
[13:07:41.125] <TB3> INFO: Test took 16723ms.
[13:07:42.885] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:07:43.147] <TB3> INFO: dacScan step from 93 .. 93
[13:07:59.714] <TB3> INFO: Test took 16565ms.
[13:08:01.181] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:08:01.416] <TB3> INFO: dacScan step from 94 .. 94
[13:08:17.715] <TB3> INFO: Test took 16298ms.
[13:08:19.225] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:08:19.477] <TB3> INFO: dacScan step from 95 .. 95
[13:08:35.283] <TB3> INFO: Test took 15805ms.
[13:08:36.752] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:08:36.992] <TB3> INFO: dacScan step from 96 .. 96
[13:08:52.660] <TB3> INFO: Test took 15667ms.
[13:08:54.106] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:08:54.347] <TB3> INFO: dacScan step from 97 .. 97
[13:09:10.003] <TB3> INFO: Test took 15655ms.
[13:09:11.415] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:09:11.639] <TB3> INFO: dacScan step from 98 .. 98
[13:09:27.920] <TB3> INFO: Test took 16280ms.
[13:09:29.356] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:09:29.611] <TB3> INFO: dacScan step from 99 .. 99
[13:09:46.359] <TB3> INFO: Test took 16747ms.
[13:09:47.886] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:09:48.130] <TB3> INFO: dacScan step from 100 .. 100
[13:10:04.872] <TB3> INFO: Test took 16741ms.
[13:10:06.335] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:10:06.567] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:07.920] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:09.271] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:10.545] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:11.968] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:13.406] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:14.829] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:16.298] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:17.659] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:19.011] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:20.379] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:21.751] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:23.099] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:24.426] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:25.711] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:27.005] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:10:28.293] <TB3> INFO: PixTest:: pg_setup set to default.
[13:10:28.294] <TB3> INFO: vcal mean: 38.75 38.12 38.13 40.91 40.29 41.30 42.24 42.39 41.98 43.13 42.11 41.73 41.24 38.93 39.40 39.50
[13:10:28.294] <TB3> INFO: vcal RMS: 1.33 1.18 1.11 1.42 1.26 1.48 2.04 1.52 1.48 1.47 1.49 1.58 1.40 1.35 1.27 1.30
[13:10:28.294] <TB3> INFO: number of X-ray hits detected: 168414 162578 145585 281814 276703 324548 328880 334364 338133 368852 344773 307823 287440 174460 180146 183876
[13:10:28.294] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:10:28.294] <TB3> INFO: X-ray hit rate [MHz/cm2]: 49.4 47.7 42.7 82.6 81.1 95.1 96.4 98.0 99.1 108.1 101.1 90.2 84.3 51.1 52.8 53.9
[13:10:28.294] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[13:10:28.392] <TB3> INFO: enter test to run
[13:10:28.393] <TB3> INFO: test: no parameter change
[13:10:28.562] <TB3> QUIET: Connection to board 121 closed.
[13:10:28.641] <TB3> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[13:31:43.679] <TB3> INFO: *** Welcome to pxar ***
[13:31:43.679] <TB3> INFO: *** Today: 2015/08/12
[13:31:43.679] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:31:43.680] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[13:31:43.681] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[13:31:43.681] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[13:31:43.758] <TB3> INFO: clk: 4
[13:31:43.758] <TB3> INFO: ctr: 4
[13:31:43.758] <TB3> INFO: sda: 19
[13:31:43.758] <TB3> INFO: tin: 9
[13:31:43.758] <TB3> INFO: level: 15
[13:31:43.758] <TB3> INFO: triggerdelay: 0
[13:31:43.758] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[13:31:43.758] <TB3> INFO: Log level: INFO
[13:31:43.772] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:31:43.790] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:31:43.793] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:31:43.796] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[13:31:45.315] <TB3> INFO: DUT info:
[13:31:45.315] <TB3> INFO: The DUT currently contains the following objects:
[13:31:45.315] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:31:45.316] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:31:45.316] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:31:45.316] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:31:45.316] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.316] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:45.717] <TB3> INFO: enter 'restricted' command line mode
[13:31:45.718] <TB3> INFO: enter test to run
[13:31:45.718] <TB3> INFO: test: HighRate no parameter change
[13:31:45.718] <TB3> INFO: running: highrate
[13:31:45.718] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[13:31:45.882] <TB3> INFO: ----------------------------------------------------------------------
[13:31:45.883] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:31:45.883] <TB3> INFO: ----------------------------------------------------------------------
[13:31:46.967] <TB3> INFO: Test took 1079ms.
[13:31:50.640] <TB3> INFO: Test took 3669ms.
[13:31:50.774] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:31:54.693] <TB3> INFO: Test took 3892ms.
[13:31:54.840] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:31:58.841] <TB3> INFO: Test took 3971ms.
[13:31:58.989] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:02.772] <TB3> INFO: Test took 3755ms.
[13:32:02.906] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:06.909] <TB3> INFO: Test took 3978ms.
[13:32:07.060] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:10.988] <TB3> INFO: Test took 3897ms.
[13:32:11.121] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:15.067] <TB3> INFO: Test took 3922ms.
[13:32:15.202] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:18.959] <TB3> INFO: Test took 3732ms.
[13:32:19.103] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:22.858] <TB3> INFO: Test took 3730ms.
[13:32:23.004] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:26.886] <TB3> INFO: Test took 3854ms.
[13:32:27.032] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:30.879] <TB3> INFO: Test took 3818ms.
[13:32:31.026] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:35.118] <TB3> INFO: Test took 4064ms.
[13:32:35.265] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:39.093] <TB3> INFO: Test took 3804ms.
[13:32:39.237] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:43.410] <TB3> INFO: Test took 4138ms.
[13:32:43.549] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:45.655] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 14 readouts!

[13:32:45.655] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 2 readouts!

[13:32:47.457] <TB3> INFO: Test took 3881ms.
[13:32:47.602] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:51.418] <TB3> INFO: Test took 3785ms.
[13:32:51.550] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:55.187] <TB3> INFO: Test took 3609ms.
[13:32:55.325] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:59.191] <TB3> INFO: Test took 3840ms.
[13:32:59.320] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:03.067] <TB3> INFO: Test took 3723ms.
[13:33:03.196] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:06.692] <TB3> INFO: Test took 3471ms.
[13:33:06.818] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:07.125] <TB3> INFO: enter test to run
[13:33:07.125] <TB3> INFO: test: Pretest no parameter change
[13:33:07.125] <TB3> INFO: running: pretest
[13:33:07.125] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[13:33:07.125] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[13:33:07.125] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[13:33:07.125] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[13:33:07.125] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[13:33:07.126] <TB3> INFO: write dac parameters into /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:33:07.127] <TB3> INFO: enter test to run
[13:33:07.127] <TB3> INFO: test: no parameter change
[13:33:07.311] <TB3> QUIET: Connection to board 121 closed.
[13:33:07.391] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:33:43.697] <TB3> INFO: *** Welcome to pxar ***
[13:33:43.697] <TB3> INFO: *** Today: 2015/08/12
[13:33:43.697] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//dacParameters35_C15.dat
[13:33:43.698] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//tbmParameters_C0b.dat
[13:33:43.698] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//defaultMaskFile.dat
[13:33:43.698] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//trimParameters35_C15.dat
[13:33:43.768] <TB3> INFO: clk: 4
[13:33:43.768] <TB3> INFO: ctr: 4
[13:33:43.768] <TB3> INFO: sda: 19
[13:33:43.768] <TB3> INFO: tin: 9
[13:33:43.768] <TB3> INFO: level: 15
[13:33:43.768] <TB3> INFO: triggerdelay: 0
[13:33:43.768] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[13:33:43.768] <TB3> INFO: Log level: INFO
[13:33:43.782] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:33:43.800] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:33:43.803] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:33:43.806] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[13:33:45.360] <TB3> INFO: DUT info:
[13:33:45.360] <TB3> INFO: The DUT currently contains the following objects:
[13:33:45.360] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:33:45.360] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:33:45.361] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:33:45.361] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:33:45.361] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.361] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:45.762] <TB3> INFO: enter 'restricted' command line mode
[13:33:45.762] <TB3> INFO: enter test to run
[13:33:45.762] <TB3> INFO: test: HighRate no parameter change
[13:33:45.762] <TB3> INFO: running: highrate
[13:33:45.762] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[13:33:45.903] <TB3> INFO: ----------------------------------------------------------------------
[13:33:45.903] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:33:45.903] <TB3> INFO: ----------------------------------------------------------------------
[13:33:58.796] <TB3> INFO: Test took 12888ms.
[13:33:59.458] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:59.754] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 3 0 0 0 0 0 0 0 0 0
[13:33:59.754] <TB3> INFO: number of red-efficiency pixels: 110 143 103 196 185 225 302 315 235 272 240 216 198 111 117 133
[13:33:59.754] <TB3> INFO: number of X-ray hits detected: 83956 80270 71201 141618 138988 163423 164900 166799 169289 185309 175898 155319 144686 85635 89575 91582
[13:33:59.754] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:33:59.754] <TB3> INFO: number of Vcal hits detected: 207889 207856 207894 207800 207811 207767 207540 207667 207758 207701 207750 207770 207792 207885 207882 207864
[13:33:59.754] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 99.9 100.0 99.9 99.9 99.9 99.9 99.8 99.9 99.9 99.9 99.9 99.9 100.0 100.0 99.9
[13:33:59.754] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9
[13:33:59.754] <TB3> INFO: X-ray hit rate [MHz/cm2]: 24.6 23.5 20.9 41.5 40.7 47.9 48.3 48.9 49.6 54.3 51.6 45.5 42.4 25.1 26.3 26.8
[13:33:59.754] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[13:33:59.780] <TB3> INFO: PixTest:: pg_setup set to default.
[13:33:59.811] <TB3> INFO: enter test to run
[13:33:59.811] <TB3> INFO: test: no parameter change
[13:34:00.002] <TB3> QUIET: Connection to board 121 closed.
[13:34:00.081] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:34:34.555] <TB3> INFO: *** Welcome to pxar ***
[13:34:34.555] <TB3> INFO: *** Today: 2015/08/12
[13:34:34.555] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//dacParameters35_C15.dat
[13:34:34.556] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//tbmParameters_C0b.dat
[13:34:34.556] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//defaultMaskFile.dat
[13:34:34.556] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//trimParameters35_C15.dat
[13:34:34.629] <TB3> INFO: clk: 4
[13:34:34.629] <TB3> INFO: ctr: 4
[13:34:34.629] <TB3> INFO: sda: 19
[13:34:34.629] <TB3> INFO: tin: 9
[13:34:34.629] <TB3> INFO: level: 15
[13:34:34.629] <TB3> INFO: triggerdelay: 0
[13:34:34.629] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[13:34:34.629] <TB3> INFO: Log level: INFO
[13:34:34.643] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:34:34.661] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:34:34.664] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:34:34.666] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[13:34:36.242] <TB3> INFO: DUT info:
[13:34:36.242] <TB3> INFO: The DUT currently contains the following objects:
[13:34:36.242] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:34:36.242] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:34:36.242] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:34:36.242] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:34:36.242] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.242] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.243] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.243] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.243] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.243] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.243] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.243] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:34:36.644] <TB3> INFO: enter 'restricted' command line mode
[13:34:36.644] <TB3> INFO: enter test to run
[13:34:36.644] <TB3> INFO: test: HighRate no parameter change
[13:34:36.644] <TB3> INFO: running: highrate
[13:34:36.644] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[13:34:36.783] <TB3> INFO: ----------------------------------------------------------------------
[13:34:36.783] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:34:36.783] <TB3> INFO: ----------------------------------------------------------------------
[13:34:52.327] <TB3> INFO: Test took 15539ms.
[13:34:54.077] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:34:54.447] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 3 0 0 0 0 0 0 0 0 0
[13:34:54.447] <TB3> INFO: number of red-efficiency pixels: 221 328 261 660 678 850 1004 945 857 1024 901 794 603 332 356 410
[13:34:54.447] <TB3> INFO: number of X-ray hits detected: 169298 164298 146863 282645 279269 325632 330990 336096 340297 368635 350434 310829 288374 175235 182920 185669
[13:34:54.447] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:34:54.447] <TB3> INFO: number of Vcal hits detected: 207769 207652 207703 207243 207198 206974 206592 206891 207002 206691 206887 207051 207317 207615 207625 207561
[13:34:54.447] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.8 99.9 99.7 99.7 99.6 99.5 99.5 99.6 99.4 99.5 99.6 99.7 99.8 99.8 99.8
[13:34:54.447] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.8 99.9 99.6 99.6 99.5 99.3 99.5 99.5 99.4 99.5 99.5 99.7 99.8 99.8 99.8
[13:34:54.447] <TB3> INFO: X-ray hit rate [MHz/cm2]: 49.6 48.2 43.0 82.8 81.9 95.4 97.0 98.5 99.7 108.0 102.7 91.1 84.5 51.4 53.6 54.4
[13:34:54.447] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[13:34:54.472] <TB3> INFO: PixTest:: pg_setup set to default.
[13:34:54.505] <TB3> INFO: enter test to run
[13:34:54.505] <TB3> INFO: test: no parameter change
[13:34:54.657] <TB3> QUIET: Connection to board 121 closed.
[13:34:54.737] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:35:28.519] <TB3> INFO: *** Welcome to pxar ***
[13:35:28.519] <TB3> INFO: *** Today: 2015/08/12
[13:35:28.519] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//dacParameters35_C15.dat
[13:35:28.520] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//tbmParameters_C0b.dat
[13:35:28.520] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//defaultMaskFile.dat
[13:35:28.520] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//trimParameters35_C15.dat
[13:35:28.590] <TB3> INFO: clk: 4
[13:35:28.590] <TB3> INFO: ctr: 4
[13:35:28.590] <TB3> INFO: sda: 19
[13:35:28.590] <TB3> INFO: tin: 9
[13:35:28.590] <TB3> INFO: level: 15
[13:35:28.591] <TB3> INFO: triggerdelay: 0
[13:35:28.591] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[13:35:28.591] <TB3> INFO: Log level: INFO
[13:35:28.603] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:35:28.620] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:35:28.624] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:35:28.626] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[13:35:30.154] <TB3> INFO: DUT info:
[13:35:30.154] <TB3> INFO: The DUT currently contains the following objects:
[13:35:30.154] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:35:30.154] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:35:30.154] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:35:30.154] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:35:30.154] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.154] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:30.555] <TB3> INFO: enter 'restricted' command line mode
[13:35:30.555] <TB3> INFO: enter test to run
[13:35:30.555] <TB3> INFO: test: HighRate no parameter change
[13:35:30.555] <TB3> INFO: running: highrate
[13:35:30.555] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[13:35:30.695] <TB3> INFO: ----------------------------------------------------------------------
[13:35:30.695] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:35:30.695] <TB3> INFO: ----------------------------------------------------------------------
[13:35:48.625] <TB3> INFO: Test took 17924ms.
[13:35:51.738] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:35:52.167] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 3 0 0 0 0 0 0 0 0 0
[13:35:52.167] <TB3> INFO: number of red-efficiency pixels: 540 598 496 1307 1359 1785 1954 1913 1785 2114 1875 1551 1305 677 748 784
[13:35:52.167] <TB3> INFO: number of X-ray hits detected: 245770 238759 214647 409656 404255 469560 476747 484479 489551 529762 501189 445566 417184 255253 264844 269325
[13:35:52.167] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:35:52.167] <TB3> INFO: number of Vcal hits detected: 207403 207334 207335 206192 205932 205187 204439 205195 205395 204313 205040 205578 206303 207069 207162 207095
[13:35:52.167] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.8 99.2 99.1 98.8 98.6 98.8 98.9 98.4 98.8 99.0 99.3 99.6 99.6 99.6
[13:35:52.167] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.7 99.1 99.0 98.6 98.3 98.7 98.7 98.2 98.6 98.8 99.2 99.6 99.6 99.6
[13:35:52.167] <TB3> INFO: X-ray hit rate [MHz/cm2]: 72.0 70.0 62.9 120.1 118.5 137.6 139.7 142.0 143.5 155.3 146.9 130.6 122.3 74.8 77.6 78.9
[13:35:52.167] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[13:35:52.193] <TB3> INFO: PixTest:: pg_setup set to default.
[13:35:52.228] <TB3> INFO: enter test to run
[13:35:52.228] <TB3> INFO: test: no parameter change
[13:35:52.360] <TB3> QUIET: Connection to board 121 closed.
[13:35:52.442] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:36:28.785] <TB3> INFO: *** Welcome to pxar ***
[13:36:28.786] <TB3> INFO: *** Today: 2015/08/12
[13:36:28.786] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//dacParameters35_C15.dat
[13:36:28.787] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//tbmParameters_C0b.dat
[13:36:28.787] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//defaultMaskFile.dat
[13:36:28.787] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//trimParameters35_C15.dat
[13:36:28.864] <TB3> INFO: clk: 4
[13:36:28.864] <TB3> INFO: ctr: 4
[13:36:28.864] <TB3> INFO: sda: 19
[13:36:28.864] <TB3> INFO: tin: 9
[13:36:28.864] <TB3> INFO: level: 15
[13:36:28.864] <TB3> INFO: triggerdelay: 0
[13:36:28.864] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[13:36:28.864] <TB3> INFO: Log level: INFO
[13:36:28.878] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:36:28.899] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:36:28.902] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:36:28.905] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[13:36:30.457] <TB3> INFO: DUT info:
[13:36:30.457] <TB3> INFO: The DUT currently contains the following objects:
[13:36:30.457] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:36:30.457] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:36:30.457] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:36:30.457] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:36:30.457] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.457] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.457] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.457] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.457] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.457] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.458] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:30.859] <TB3> INFO: enter 'restricted' command line mode
[13:36:30.859] <TB3> INFO: enter test to run
[13:36:30.859] <TB3> INFO: test: HighRate no parameter change
[13:36:30.859] <TB3> INFO: running: highrate
[13:36:30.859] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[13:36:31.016] <TB3> INFO: ----------------------------------------------------------------------
[13:36:31.016] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:36:31.016] <TB3> INFO: ----------------------------------------------------------------------
[13:36:51.121] <TB3> INFO: Test took 20099ms.
[13:36:56.320] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:36:56.822] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 3 0 0 0 0 0 0 0 0 0
[13:36:56.822] <TB3> INFO: number of red-efficiency pixels: 974 1170 826 2284 2329 2909 3154 3071 3034 3246 3064 2597 2271 1057 1386 1468
[13:36:56.822] <TB3> INFO: number of X-ray hits detected: 333045 326588 293983 553614 547707 631243 643531 655853 659942 713705 672725 600722 563932 346753 361611 363506
[13:36:56.822] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:36:56.822] <TB3> INFO: number of Vcal hits detected: 206812 206608 206583 203711 203341 201214 199577 201614 201457 199226 200796 202368 203990 206010 206247 206008
[13:36:56.822] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.4 99.5 98.2 98.1 97.2 96.6 97.2 97.1 96.3 97.0 97.6 98.3 99.2 99.2 99.2
[13:36:56.822] <TB3> INFO: Vcal hit overall efficiency (%): 99.4 99.3 99.3 97.9 97.8 96.7 96.0 96.9 96.9 95.8 96.5 97.3 98.1 99.0 99.2 99.0
[13:36:56.822] <TB3> INFO: X-ray hit rate [MHz/cm2]: 97.6 95.7 86.2 162.3 160.5 185.0 188.6 192.2 193.4 209.2 197.2 176.1 165.3 101.6 106.0 106.5
[13:36:56.822] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[13:36:56.847] <TB3> INFO: PixTest:: pg_setup set to default.
[13:36:56.880] <TB3> INFO: enter test to run
[13:36:56.881] <TB3> INFO: test: no parameter change
[13:36:57.031] <TB3> QUIET: Connection to board 121 closed.
[13:36:57.113] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:37:33.358] <TB3> INFO: *** Welcome to pxar ***
[13:37:33.358] <TB3> INFO: *** Today: 2015/08/12
[13:37:33.358] <TB3> INFO: readRocDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//dacParameters35_C15.dat
[13:37:33.359] <TB3> INFO: readTbmDacs: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//tbmParameters_C0b.dat
[13:37:33.359] <TB3> INFO: readMaskFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//defaultMaskFile.dat
[13:37:33.359] <TB3> INFO: readTrimFile: /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//trimParameters35_C15.dat
[13:37:33.447] <TB3> INFO: clk: 4
[13:37:33.447] <TB3> INFO: ctr: 4
[13:37:33.447] <TB3> INFO: sda: 19
[13:37:33.447] <TB3> INFO: tin: 9
[13:37:33.447] <TB3> INFO: level: 15
[13:37:33.447] <TB3> INFO: triggerdelay: 0
[13:37:33.447] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[13:37:33.447] <TB3> INFO: Log level: INFO
[13:37:33.460] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:37:33.478] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:37:33.481] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:37:33.483] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[13:37:35.042] <TB3> INFO: DUT info:
[13:37:35.042] <TB3> INFO: The DUT currently contains the following objects:
[13:37:35.042] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[13:37:35.042] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:37:35.042] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:37:35.042] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:37:35.043] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.043] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:37:35.445] <TB3> INFO: enter 'restricted' command line mode
[13:37:35.445] <TB3> INFO: enter test to run
[13:37:35.445] <TB3> INFO: test: HighRate no parameter change
[13:37:35.445] <TB3> INFO: running: highrate
[13:37:35.445] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2058_XrayQualification_2015-08-12_14h10m_1439381432//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[13:37:35.667] <TB3> INFO: ----------------------------------------------------------------------
[13:37:35.667] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:37:35.667] <TB3> INFO: ----------------------------------------------------------------------
[13:37:55.938] <TB3> INFO: Test took 20264ms.
[13:38:01.423] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:01.933] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 3 0 0 0 0 0 0 0 0 0
[13:38:01.933] <TB3> INFO: number of red-efficiency pixels: 1062 1290 873 2446 2477 3046 3214 3207 3242 3326 3172 2784 2446 1179 1460 1597
[13:38:01.934] <TB3> INFO: number of X-ray hits detected: 344731 339038 305412 569559 566192 648473 665636 677717 683317 735179 694201 620495 578980 359688 375208 375616
[13:38:01.934] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:38:01.934] <TB3> INFO: number of Vcal hits detected: 206701 206408 206514 203295 202882 200561 198987 200899 200729 198489 200122 201605 203560 205747 206116 205815
[13:38:01.934] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.3 99.4 98.0 97.9 96.9 96.3 96.9 96.8 96.0 96.7 97.3 98.1 99.1 99.2 99.1
[13:38:01.934] <TB3> INFO: Vcal hit overall efficiency (%): 99.4 99.2 99.3 97.7 97.5 96.4 95.7 96.6 96.5 95.4 96.2 96.9 97.9 98.9 99.1 98.9
[13:38:01.934] <TB3> INFO: X-ray hit rate [MHz/cm2]: 101.0 99.4 89.5 166.9 166.0 190.1 195.1 198.6 200.3 215.5 203.5 181.9 169.7 105.4 110.0 110.1
[13:38:01.934] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[13:38:01.959] <TB3> INFO: PixTest:: pg_setup set to default.
[13:38:01.993] <TB3> INFO: enter test to run
[13:38:01.993] <TB3> INFO: test: no parameter change
[13:38:02.168] <TB3> QUIET: Connection to board 121 closed.
[13:38:02.251] <TB3> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master