Test Date: 2015-08-24 08:08
Analysis date: 2016-05-26 02:05
Logfile
commander_PixelAlive.log
[06:09:16.363] <TB1> INFO: *** Welcome to pxar ***
[06:09:16.363] <TB1> INFO: *** Today: 2015/08/24
[06:09:16.364] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//000_PixelAlive_p17//dacParameters35_C15.dat
[06:09:16.365] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//000_PixelAlive_p17//tbmParameters_C0b.dat
[06:09:16.365] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//000_PixelAlive_p17//defaultMaskFile.dat
[06:09:16.365] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//000_PixelAlive_p17//trimParameters35_C15.dat
[06:09:16.469] <TB1> INFO: clk: 4
[06:09:16.469] <TB1> INFO: ctr: 4
[06:09:16.469] <TB1> INFO: sda: 19
[06:09:16.469] <TB1> INFO: tin: 9
[06:09:16.469] <TB1> INFO: level: 15
[06:09:16.469] <TB1> INFO: triggerdelay: 0
[06:09:16.469] <TB1> QUIET: Instanciating API for pxar prod-01+80~g16e673b
[06:09:16.469] <TB1> INFO: Log level: INFO
[06:09:16.482] <TB1> INFO: Found DTB DTB_WS6UZO
[06:09:16.490] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[06:09:16.494] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[06:09:16.496] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[06:09:18.019] <TB1> INFO: DUT info:
[06:09:18.019] <TB1> INFO: The DUT currently contains the following objects:
[06:09:18.019] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[06:09:18.019] <TB1> INFO: TBM Core alpha (0): 7 registers set
[06:09:18.019] <TB1> INFO: TBM Core beta (1): 7 registers set
[06:09:18.019] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:09:18.019] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.019] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.020] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.020] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.020] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.020] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:18.421] <TB1> INFO: enter 'restricted' command line mode
[06:09:18.421] <TB1> INFO: enter test to run
[06:09:18.421] <TB1> INFO: test: PixelAlive no parameter change
[06:09:18.421] <TB1> INFO: running: pixelalive
[06:09:18.429] <TB1> INFO: ######################################################################
[06:09:18.429] <TB1> INFO: PixTestAlive::doTest()
[06:09:18.429] <TB1> INFO: ######################################################################
[06:09:18.431] <TB1> INFO: ----------------------------------------------------------------------
[06:09:18.431] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:09:18.431] <TB1> INFO: ----------------------------------------------------------------------
[06:09:21.771] <TB1> INFO: Test took 3339ms.
[06:09:21.789] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:22.040] <TB1> INFO: PixTestAlive::aliveTest() done
[06:09:22.040] <TB1> INFO: number of dead pixels (per ROC): 3 6 0 0 0 0 1 0 0 1 2 0 0 1 0 4
[06:09:22.041] <TB1> INFO: ----------------------------------------------------------------------
[06:09:22.041] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:09:22.041] <TB1> INFO: ----------------------------------------------------------------------
[06:09:24.743] <TB1> INFO: Test took 2700ms.
[06:09:24.744] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:24.752] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[06:09:24.975] <TB1> INFO: PixTestAlive::maskTest() done
[06:09:24.975] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[06:09:24.977] <TB1> INFO: ----------------------------------------------------------------------
[06:09:24.977] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:09:24.977] <TB1> INFO: ----------------------------------------------------------------------
[06:09:28.400] <TB1> INFO: Test took 3422ms.
[06:09:28.427] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:28.653] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[06:09:28.653] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[06:09:28.653] <TB1> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[06:09:28.687] <TB1> INFO: enter test to run
[06:09:28.687] <TB1> INFO: test: no parameter change
[06:09:28.854] <TB1> QUIET: Connection to board 83 closed.
[06:09:28.934] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[06:14:39.567] <TB1> INFO: *** Welcome to pxar ***
[06:14:39.567] <TB1> INFO: *** Today: 2015/08/24
[06:14:39.567] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//dacParameters35_C15.dat
[06:14:39.568] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[06:14:39.568] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//defaultMaskFile.dat
[06:14:39.568] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C15.dat
[06:14:39.641] <TB1> INFO: clk: 4
[06:14:39.641] <TB1> INFO: ctr: 4
[06:14:39.641] <TB1> INFO: sda: 19
[06:14:39.641] <TB1> INFO: tin: 9
[06:14:39.641] <TB1> INFO: level: 15
[06:14:39.641] <TB1> INFO: triggerdelay: 0
[06:14:39.641] <TB1> QUIET: Instanciating API for pxar prod-01+80~g16e673b
[06:14:39.641] <TB1> INFO: Log level: INFO
[06:14:39.654] <TB1> INFO: Found DTB DTB_WS6UZO
[06:14:39.663] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[06:14:39.666] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[06:14:39.669] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[06:14:41.189] <TB1> INFO: DUT info:
[06:14:41.189] <TB1> INFO: The DUT currently contains the following objects:
[06:14:41.189] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[06:14:41.189] <TB1> INFO: TBM Core alpha (0): 7 registers set
[06:14:41.189] <TB1> INFO: TBM Core beta (1): 7 registers set
[06:14:41.189] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:14:41.189] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.189] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.189] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.189] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.189] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.189] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.189] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.190] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:41.591] <TB1> INFO: enter 'restricted' command line mode
[06:14:41.591] <TB1> INFO: enter test to run
[06:14:41.591] <TB1> INFO: test: delay setting parameters: ->5<-
[06:14:41.591] <TB1> INFO: delay test by 5 seconds...
[06:14:46.591] <TB1> INFO: enter test to run
[06:14:46.591] <TB1> INFO: test: highrate no parameter change
[06:14:46.591] <TB1> INFO: running: highrate
[06:14:46.592] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[06:14:46.732] <TB1> INFO: ----------------------------------------------------------------------
[06:14:46.732] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[06:14:46.732] <TB1> INFO: ----------------------------------------------------------------------
[06:14:46.732] <TB1> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[06:14:46.732] <TB1> INFO: edge/corner pixel THR is adjusted
[06:14:46.732] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[06:14:47.694] <TB1> INFO: Collecting data for 1 seconds...
[06:14:48.696] <TB1> INFO: Done with hot pixel readout
[06:14:56.746] <TB1> INFO: PixTest:: pg_setup set to default.
[06:14:56.748] <TB1> INFO: 19 hot pixels found in step 0
[06:14:57.712] <TB1> INFO: Collecting data for 1 seconds...
[06:14:58.715] <TB1> INFO: Done with hot pixel readout
[06:15:07.113] <TB1> INFO: PixTest:: pg_setup set to default.
[06:15:07.115] <TB1> INFO: 18 hot pixels found in step 1
[06:15:08.079] <TB1> INFO: Collecting data for 1 seconds...
[06:15:09.081] <TB1> INFO: Done with hot pixel readout
[06:15:14.880] <TB1> INFO: PixTest:: pg_setup set to default.
[06:15:14.881] <TB1> INFO: 8 hot pixels found in step 2
[06:15:15.846] <TB1> INFO: Collecting data for 1 seconds...
[06:15:16.848] <TB1> INFO: Done with hot pixel readout
[06:15:22.762] <TB1> INFO: PixTest:: pg_setup set to default.
[06:15:22.763] <TB1> INFO: 3 hot pixels found in step 3
[06:15:23.726] <TB1> INFO: Collecting data for 1 seconds...
[06:15:24.728] <TB1> INFO: Done with hot pixel readout
[06:15:30.573] <TB1> INFO: PixTest:: pg_setup set to default.
[06:15:30.574] <TB1> INFO: 0 hot pixels found in step 4
[06:15:30.583] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[06:15:30.615] <TB1> INFO: PixTest::trimHotPixels() done
[06:15:30.615] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C0.dat
[06:15:30.622] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C1.dat
[06:15:30.629] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C2.dat
[06:15:30.637] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C3.dat
[06:15:30.644] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C4.dat
[06:15:30.651] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C5.dat
[06:15:30.658] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C6.dat
[06:15:30.665] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C7.dat
[06:15:30.672] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C8.dat
[06:15:30.678] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C9.dat
[06:15:30.685] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C10.dat
[06:15:30.692] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C11.dat
[06:15:30.699] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C12.dat
[06:15:30.706] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C13.dat
[06:15:30.713] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C14.dat
[06:15:30.720] <TB1> INFO: write trim parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//trimParameters35_C15.dat
[06:15:30.726] <TB1> INFO: write masked pixels into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//002_RetrimHotPixels_150//defaultMaskFile.dat
[06:15:30.764] <TB1> INFO: enter test to run
[06:15:30.764] <TB1> INFO: test: no parameter change
[06:15:30.922] <TB1> QUIET: Connection to board 83 closed.
[06:15:31.001] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[06:15:54.611] <TB1> INFO: *** Welcome to pxar ***
[06:15:54.611] <TB1> INFO: *** Today: 2015/08/24
[06:15:54.611] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//dacParameters35_C15.dat
[06:15:54.611] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//tbmParameters_C0b.dat
[06:15:54.612] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//defaultMaskFile.dat
[06:15:54.612] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//trimParameters35_C15.dat
[06:15:54.683] <TB1> INFO: clk: 4
[06:15:54.683] <TB1> INFO: ctr: 4
[06:15:54.683] <TB1> INFO: sda: 19
[06:15:54.683] <TB1> INFO: tin: 9
[06:15:54.683] <TB1> INFO: level: 15
[06:15:54.683] <TB1> INFO: triggerdelay: 0
[06:15:54.683] <TB1> QUIET: Instanciating API for pxar prod-01+80~g16e673b
[06:15:54.683] <TB1> INFO: Log level: INFO
[06:15:54.697] <TB1> INFO: Found DTB DTB_WS6UZO
[06:15:54.707] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[06:15:54.710] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[06:15:54.713] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[06:15:56.234] <TB1> INFO: DUT info:
[06:15:56.234] <TB1> INFO: The DUT currently contains the following objects:
[06:15:56.234] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[06:15:56.234] <TB1> INFO: TBM Core alpha (0): 7 registers set
[06:15:56.234] <TB1> INFO: TBM Core beta (1): 7 registers set
[06:15:56.235] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:15:56.235] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.235] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:15:56.636] <TB1> INFO: enter 'restricted' command line mode
[06:15:56.636] <TB1> INFO: enter test to run
[06:15:56.636] <TB1> INFO: test: delay setting parameters: ->5<-
[06:15:56.636] <TB1> INFO: delay test by 5 seconds...
[06:16:01.636] <TB1> INFO: enter test to run
[06:16:01.637] <TB1> INFO: test: Xray no parameter change
[06:16:01.637] <TB1> INFO: running: xray
[06:16:01.637] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//003_HRData_50//phCalibrationFitErr35_C15.dat
[06:16:01.851] <TB1> INFO: ######################################################################
[06:16:01.851] <TB1> INFO: PixTestXray::doTest()
[06:16:01.851] <TB1> INFO: ######################################################################
[06:16:01.851] <TB1> INFO: ----------------------------------------------------------------------
[06:16:01.851] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[06:16:01.851] <TB1> INFO: ----------------------------------------------------------------------
[06:16:02.824] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[06:16:08.537] <TB1> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[06:16:36.018] <TB1> INFO: Resuming triggers.
[06:16:41.736] <TB1> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[06:16:47.205] <TB1> ERROR: <datapipe.cc/CheckEventID:L453> Channel 3 Event ID mismatch: local ID (135) != TBM ID (4)

[06:16:47.205] <TB1> ERROR: <datapipe.cc/CheckEventValidity:L470> Channel 3 Number of ROCs (3) != Token Chain Length (4)

[06:16:47.205] <TB1> ERROR: <datapipe.cc/CheckEventID:L453> Channel 3 Event ID mismatch: local ID (5) != TBM ID (136)

[06:17:06.808] <TB1> INFO: Resuming triggers.
[06:17:12.532] <TB1> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[06:17:33.851] <TB1> INFO: Resuming triggers.
[06:17:39.573] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[06:18:03.592] <TB1> INFO: Resuming triggers.
[06:18:09.315] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[06:18:33.650] <TB1> INFO: Resuming triggers.
[06:18:39.371] <TB1> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[06:19:03.569] <TB1> INFO: Resuming triggers.
[06:19:09.284] <TB1> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[06:19:34.138] <TB1> INFO: Resuming triggers.
[06:19:39.855] <TB1> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[06:20:01.005] <TB1> INFO: Resuming triggers.
[06:20:06.724] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[06:20:31.680] <TB1> INFO: Resuming triggers.
[06:20:37.396] <TB1> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[06:21:01.509] <TB1> INFO: Resuming triggers.
[06:21:07.227] <TB1> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[06:21:33.609] <TB1> INFO: Resuming triggers.
[06:21:39.325] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[06:22:01.498] <TB1> INFO: Resuming triggers.
[06:22:07.213] <TB1> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[06:22:32.289] <TB1> INFO: Resuming triggers.
[06:22:38.003] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[06:22:59.211] <TB1> INFO: Resuming triggers.
[06:23:04.926] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[06:23:30.601] <TB1> INFO: Resuming triggers.
[06:23:36.320] <TB1> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[06:23:54.380] <TB1> INFO: Resuming triggers.
[06:24:00.092] <TB1> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[06:24:18.206] <TB1> INFO: Resuming triggers.
[06:24:21.126] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[06:24:30.502] <TB1> INFO: PixTest:: pg_setup set to default.
[06:24:30.504] <TB1> INFO: PixTestXray::doPhRun() done
[06:24:30.504] <TB1> INFO: PixTestXray::doTest() done
[06:24:30.680] <TB1> INFO: enter test to run
[06:24:30.680] <TB1> INFO: test: no parameter change
[06:24:30.872] <TB1> QUIET: Connection to board 83 closed.
[06:24:30.952] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[06:24:45.649] <TB1> INFO: *** Welcome to pxar ***
[06:24:45.649] <TB1> INFO: *** Today: 2015/08/24
[06:24:45.649] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//dacParameters35_C15.dat
[06:24:45.650] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//tbmParameters_C0b.dat
[06:24:45.650] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//defaultMaskFile.dat
[06:24:45.650] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//trimParameters35_C15.dat
[06:24:45.718] <TB1> INFO: clk: 4
[06:24:45.718] <TB1> INFO: ctr: 4
[06:24:45.718] <TB1> INFO: sda: 19
[06:24:45.718] <TB1> INFO: tin: 9
[06:24:45.718] <TB1> INFO: level: 15
[06:24:45.718] <TB1> INFO: triggerdelay: 0
[06:24:45.718] <TB1> QUIET: Instanciating API for pxar prod-01+80~g16e673b
[06:24:45.718] <TB1> INFO: Log level: INFO
[06:24:45.733] <TB1> INFO: Found DTB DTB_WS6UZO
[06:24:45.742] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[06:24:45.745] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[06:24:45.748] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[06:24:47.272] <TB1> INFO: DUT info:
[06:24:47.272] <TB1> INFO: The DUT currently contains the following objects:
[06:24:47.272] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[06:24:47.272] <TB1> INFO: TBM Core alpha (0): 7 registers set
[06:24:47.272] <TB1> INFO: TBM Core beta (1): 7 registers set
[06:24:47.272] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:24:47.272] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.272] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:24:47.674] <TB1> INFO: enter 'restricted' command line mode
[06:24:47.674] <TB1> INFO: enter test to run
[06:24:47.674] <TB1> INFO: test: delay setting parameters: ->5<-
[06:24:47.674] <TB1> INFO: delay test by 5 seconds...
[06:24:52.674] <TB1> INFO: enter test to run
[06:24:52.674] <TB1> INFO: test: Xray no parameter change
[06:24:52.674] <TB1> INFO: running: xray
[06:24:52.674] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//004_HRData_150//phCalibrationFitErr35_C15.dat
[06:24:52.817] <TB1> INFO: ######################################################################
[06:24:52.817] <TB1> INFO: PixTestXray::doTest()
[06:24:52.817] <TB1> INFO: ######################################################################
[06:24:52.817] <TB1> INFO: ----------------------------------------------------------------------
[06:24:52.817] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[06:24:52.817] <TB1> INFO: ----------------------------------------------------------------------
[06:24:53.786] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[06:24:56.737] <TB1> INFO: run duration 2 seconds, buffer almost full (81%), pausing triggers.
[06:25:24.606] <TB1> INFO: Resuming triggers.
[06:25:27.565] <TB1> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[06:25:53.188] <TB1> INFO: Resuming triggers.
[06:25:56.149] <TB1> INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[06:26:22.514] <TB1> INFO: Resuming triggers.
[06:26:25.476] <TB1> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[06:26:50.943] <TB1> INFO: Resuming triggers.
[06:26:53.904] <TB1> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[06:27:21.082] <TB1> INFO: Resuming triggers.
[06:27:24.044] <TB1> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[06:27:48.649] <TB1> INFO: Resuming triggers.
[06:27:51.613] <TB1> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[06:28:13.601] <TB1> INFO: Resuming triggers.
[06:28:16.563] <TB1> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[06:28:40.523] <TB1> INFO: Resuming triggers.
[06:28:43.485] <TB1> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[06:29:06.584] <TB1> INFO: Resuming triggers.
[06:29:09.548] <TB1> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[06:29:34.922] <TB1> INFO: Resuming triggers.
[06:29:37.883] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[06:29:40.833] <TB1> ERROR: <datapipe.cc/CheckEventValidity:L470> Channel 2 Number of ROCs (5) != Token Chain Length (4)

[06:30:00.109] <TB1> INFO: Resuming triggers.
[06:30:03.071] <TB1> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[06:30:26.621] <TB1> INFO: Resuming triggers.
[06:30:29.580] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[06:30:55.374] <TB1> INFO: Resuming triggers.
[06:30:58.335] <TB1> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[06:31:23.998] <TB1> INFO: Resuming triggers.
[06:31:26.958] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[06:31:53.678] <TB1> INFO: Resuming triggers.
[06:31:56.636] <TB1> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[06:32:19.142] <TB1> INFO: Resuming triggers.
[06:32:22.101] <TB1> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[06:32:46.317] <TB1> INFO: Resuming triggers.
[06:32:49.277] <TB1> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[06:33:17.073] <TB1> INFO: Resuming triggers.
[06:33:20.031] <TB1> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[06:33:46.723] <TB1> INFO: Resuming triggers.
[06:33:49.687] <TB1> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[06:34:13.599] <TB1> INFO: Resuming triggers.
[06:34:16.558] <TB1> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[06:34:42.490] <TB1> INFO: Resuming triggers.
[06:34:45.450] <TB1> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[06:35:11.278] <TB1> INFO: Resuming triggers.
[06:35:14.236] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[06:35:45.535] <TB1> INFO: Resuming triggers.
[06:35:48.494] <TB1> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[06:36:14.150] <TB1> INFO: Resuming triggers.
[06:36:17.110] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[06:36:39.776] <TB1> INFO: Resuming triggers.
[06:36:42.735] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[06:37:09.424] <TB1> INFO: Resuming triggers.
[06:37:12.384] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[06:37:35.879] <TB1> INFO: Resuming triggers.
[06:37:38.838] <TB1> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[06:37:59.378] <TB1> INFO: Resuming triggers.
[06:38:02.338] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[06:38:21.686] <TB1> INFO: Resuming triggers.
[06:38:24.642] <TB1> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[06:38:29.300] <TB1> WARNING: Channel 3 ROC 1: Readback start marker after 3 readouts!

[06:38:29.300] <TB1> WARNING: Channel 3 ROC 1: Readback start marker after 13 readouts!

[06:38:43.208] <TB1> INFO: Resuming triggers.
[06:38:46.166] <TB1> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[06:39:04.658] <TB1> INFO: Resuming triggers.
[06:39:07.615] <TB1> INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[06:39:26.292] <TB1> INFO: Resuming triggers.
[06:39:29.247] <TB1> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[06:39:47.938] <TB1> INFO: Resuming triggers.
[06:39:50.375] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[06:40:05.831] <TB1> INFO: PixTest:: pg_setup set to default.
[06:40:05.832] <TB1> INFO: PixTestXray::doPhRun() done
[06:40:05.832] <TB1> INFO: PixTestXray::doTest() done
[06:40:06.016] <TB1> INFO: enter test to run
[06:40:06.016] <TB1> INFO: test: no parameter change
[06:40:06.242] <TB1> QUIET: Connection to board 83 closed.
[06:40:06.323] <TB1> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[06:40:21.974] <TB1> INFO: *** Welcome to pxar ***
[06:40:21.974] <TB1> INFO: *** Today: 2015/08/24
[06:40:21.974] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//dacParameters35_C15.dat
[06:40:21.975] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//tbmParameters_C0b.dat
[06:40:21.975] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//defaultMaskFile.dat
[06:40:21.975] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//trimParameters35_C15.dat
[06:40:22.047] <TB1> INFO: clk: 4
[06:40:22.047] <TB1> INFO: ctr: 4
[06:40:22.047] <TB1> INFO: sda: 19
[06:40:22.047] <TB1> INFO: tin: 9
[06:40:22.047] <TB1> INFO: level: 15
[06:40:22.047] <TB1> INFO: triggerdelay: 0
[06:40:22.047] <TB1> QUIET: Instanciating API for pxar prod-01+80~g16e673b
[06:40:22.047] <TB1> INFO: Log level: INFO
[06:40:22.060] <TB1> INFO: Found DTB DTB_WS6UZO
[06:40:22.069] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[06:40:22.072] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[06:40:22.075] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[06:40:23.598] <TB1> INFO: DUT info:
[06:40:23.598] <TB1> INFO: The DUT currently contains the following objects:
[06:40:23.598] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[06:40:23.598] <TB1> INFO: TBM Core alpha (0): 7 registers set
[06:40:23.598] <TB1> INFO: TBM Core beta (1): 7 registers set
[06:40:23.598] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:40:23.598] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.598] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:23.999] <TB1> INFO: enter 'restricted' command line mode
[06:40:23.999] <TB1> INFO: enter test to run
[06:40:23.999] <TB1> INFO: test: Highrate no parameter change
[06:40:23.999] <TB1> INFO: running: highrate
[06:40:24.000] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[06:40:24.156] <TB1> INFO: ----------------------------------------------------------------------
[06:40:24.156] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[06:40:24.156] <TB1> INFO: ----------------------------------------------------------------------
[06:40:24.162] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 100 (1/-1) hits flags = 384 (plus default)
[06:40:24.173] <TB1> INFO: dacScan step from 0 .. 0
[06:40:24.173] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:40:24.173] <TB1> INFO: run 1 of 1
[06:40:41.009] <TB1> INFO: Test took 16836ms.
[06:40:43.716] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:40:44.038] <TB1> INFO: dacScan step from 1 .. 1
[06:40:44.038] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:40:44.038] <TB1> INFO: run 1 of 1
[06:41:00.813] <TB1> INFO: Test took 16774ms.
[06:41:03.385] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:41:03.702] <TB1> INFO: dacScan step from 2 .. 2
[06:41:03.702] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:41:03.702] <TB1> INFO: run 1 of 1
[06:41:19.288] <TB1> INFO: Test took 15586ms.
[06:41:22.002] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:41:22.347] <TB1> INFO: dacScan step from 3 .. 3
[06:41:22.347] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:41:22.347] <TB1> INFO: run 1 of 1
[06:41:37.379] <TB1> INFO: Test took 15032ms.
[06:41:39.967] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:41:40.307] <TB1> INFO: dacScan step from 4 .. 4
[06:41:40.307] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:41:40.307] <TB1> INFO: run 1 of 1
[06:41:55.632] <TB1> INFO: Test took 15325ms.
[06:41:58.204] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:41:58.554] <TB1> INFO: dacScan step from 5 .. 5
[06:41:58.554] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:41:58.554] <TB1> INFO: run 1 of 1
[06:42:14.949] <TB1> INFO: Test took 16395ms.
[06:42:17.531] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:42:17.835] <TB1> INFO: dacScan step from 6 .. 6
[06:42:17.835] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:42:17.835] <TB1> INFO: run 1 of 1
[06:42:34.040] <TB1> INFO: Test took 16205ms.
[06:42:37.062] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:42:37.431] <TB1> INFO: dacScan step from 7 .. 7
[06:42:37.431] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:42:37.431] <TB1> INFO: run 1 of 1
[06:42:52.544] <TB1> INFO: Test took 15113ms.
[06:42:55.117] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:42:55.441] <TB1> INFO: dacScan step from 8 .. 8
[06:42:55.441] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:42:55.441] <TB1> INFO: run 1 of 1
[06:43:10.196] <TB1> INFO: Test took 14754ms.
[06:43:12.943] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:43:13.269] <TB1> INFO: dacScan step from 9 .. 9
[06:43:13.269] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:43:13.269] <TB1> INFO: run 1 of 1
[06:43:28.935] <TB1> INFO: Test took 15666ms.
[06:43:31.593] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:43:31.937] <TB1> INFO: dacScan step from 10 .. 10
[06:43:31.937] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:43:31.937] <TB1> INFO: run 1 of 1
[06:43:48.144] <TB1> INFO: Test took 16207ms.
[06:43:50.859] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:43:51.176] <TB1> INFO: dacScan step from 11 .. 11
[06:43:51.176] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:43:51.176] <TB1> INFO: run 1 of 1
[06:44:06.696] <TB1> INFO: Test took 15519ms.
[06:44:09.281] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:44:09.597] <TB1> INFO: dacScan step from 12 .. 12
[06:44:09.597] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:44:09.597] <TB1> INFO: run 1 of 1
[06:44:24.731] <TB1> INFO: Test took 15133ms.
[06:44:27.351] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:44:27.651] <TB1> INFO: dacScan step from 13 .. 13
[06:44:27.651] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:44:27.651] <TB1> INFO: run 1 of 1
[06:44:42.991] <TB1> INFO: Test took 15339ms.
[06:44:45.589] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:44:45.936] <TB1> INFO: dacScan step from 14 .. 14
[06:44:45.936] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:44:45.936] <TB1> INFO: run 1 of 1
[06:45:02.487] <TB1> INFO: Test took 16551ms.
[06:45:05.353] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:45:05.710] <TB1> INFO: dacScan step from 15 .. 15
[06:45:05.710] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:45:05.710] <TB1> INFO: run 1 of 1
[06:45:22.127] <TB1> INFO: Test took 16416ms.
[06:45:24.764] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:45:25.097] <TB1> INFO: dacScan step from 16 .. 16
[06:45:25.097] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:45:25.097] <TB1> INFO: run 1 of 1
[06:45:39.776] <TB1> INFO: Test took 14678ms.
[06:45:42.639] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:45:42.958] <TB1> INFO: dacScan step from 17 .. 17
[06:45:42.958] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:45:42.958] <TB1> INFO: run 1 of 1
[06:45:57.949] <TB1> INFO: Test took 14991ms.
[06:46:00.640] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:46:00.966] <TB1> INFO: dacScan step from 18 .. 18
[06:46:00.966] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:46:00.966] <TB1> INFO: run 1 of 1
[06:46:17.347] <TB1> INFO: Test took 16380ms.
[06:46:20.040] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:46:20.370] <TB1> INFO: dacScan step from 19 .. 19
[06:46:20.370] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:46:20.370] <TB1> INFO: run 1 of 1
[06:46:36.766] <TB1> INFO: Test took 16395ms.
[06:46:39.711] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:46:40.082] <TB1> INFO: dacScan step from 20 .. 20
[06:46:40.082] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:46:40.082] <TB1> INFO: run 1 of 1
[06:46:55.947] <TB1> INFO: Test took 15865ms.
[06:46:58.718] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:46:59.050] <TB1> INFO: dacScan step from 21 .. 21
[06:46:59.050] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:46:59.050] <TB1> INFO: run 1 of 1
[06:47:14.723] <TB1> INFO: Test took 15673ms.
[06:47:17.302] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:47:17.626] <TB1> INFO: dacScan step from 22 .. 22
[06:47:17.626] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:47:17.626] <TB1> INFO: run 1 of 1
[06:47:33.521] <TB1> INFO: Test took 15895ms.
[06:47:36.097] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:47:36.429] <TB1> INFO: dacScan step from 23 .. 23
[06:47:36.429] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:47:36.429] <TB1> INFO: run 1 of 1
[06:47:53.043] <TB1> INFO: Test took 16613ms.
[06:47:55.729] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:47:56.059] <TB1> INFO: dacScan step from 24 .. 24
[06:47:56.059] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:47:56.060] <TB1> INFO: run 1 of 1
[06:48:11.879] <TB1> INFO: Test took 15819ms.
[06:48:14.546] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:48:14.881] <TB1> INFO: dacScan step from 25 .. 25
[06:48:14.881] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:48:14.881] <TB1> INFO: run 1 of 1
[06:48:29.525] <TB1> INFO: Test took 14644ms.
[06:48:32.239] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:48:32.560] <TB1> INFO: dacScan step from 26 .. 26
[06:48:32.560] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:48:32.560] <TB1> INFO: run 1 of 1
[06:48:48.174] <TB1> INFO: Test took 15614ms.
[06:48:50.893] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:48:51.222] <TB1> INFO: dacScan step from 27 .. 27
[06:48:51.222] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:48:51.222] <TB1> INFO: run 1 of 1
[06:49:08.089] <TB1> INFO: Test took 16866ms.
[06:49:10.641] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:49:10.990] <TB1> INFO: dacScan step from 28 .. 28
[06:49:10.990] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:49:10.990] <TB1> INFO: run 1 of 1
[06:49:27.300] <TB1> INFO: Test took 16309ms.
[06:49:29.826] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:49:30.141] <TB1> INFO: dacScan step from 29 .. 29
[06:49:30.141] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:49:30.141] <TB1> INFO: run 1 of 1
[06:49:45.477] <TB1> INFO: Test took 15336ms.
[06:49:48.152] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:49:48.511] <TB1> INFO: dacScan step from 30 .. 30
[06:49:48.511] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:49:48.511] <TB1> INFO: run 1 of 1
[06:50:03.709] <TB1> INFO: Test took 15197ms.
[06:50:06.548] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:50:06.883] <TB1> INFO: dacScan step from 31 .. 31
[06:50:06.883] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:50:06.883] <TB1> INFO: run 1 of 1
[06:50:22.072] <TB1> INFO: Test took 15188ms.
[06:50:24.665] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:50:24.980] <TB1> INFO: dacScan step from 32 .. 32
[06:50:24.980] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:50:24.980] <TB1> INFO: run 1 of 1
[06:50:41.109] <TB1> INFO: Test took 16129ms.
[06:50:43.699] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:50:44.038] <TB1> INFO: dacScan step from 33 .. 33
[06:50:44.038] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:50:44.038] <TB1> INFO: run 1 of 1
[06:51:00.258] <TB1> INFO: Test took 16219ms.
[06:51:02.852] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:51:03.181] <TB1> INFO: dacScan step from 34 .. 34
[06:51:03.181] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:51:03.181] <TB1> INFO: run 1 of 1
[06:51:20.251] <TB1> INFO: Test took 17070ms.
[06:51:23.038] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:51:23.370] <TB1> INFO: dacScan step from 35 .. 35
[06:51:23.370] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:51:23.370] <TB1> INFO: run 1 of 1
[06:51:39.428] <TB1> INFO: Test took 16058ms.
[06:51:42.091] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:51:42.428] <TB1> INFO: dacScan step from 36 .. 36
[06:51:42.429] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:51:42.429] <TB1> INFO: run 1 of 1
[06:51:59.007] <TB1> INFO: Test took 16578ms.
[06:52:01.939] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:52:02.249] <TB1> INFO: dacScan step from 37 .. 37
[06:52:02.249] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:52:02.249] <TB1> INFO: run 1 of 1
[06:52:18.901] <TB1> INFO: Test took 16652ms.
[06:52:21.814] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:52:22.200] <TB1> INFO: dacScan step from 38 .. 38
[06:52:22.201] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:52:22.201] <TB1> INFO: run 1 of 1
[06:52:38.756] <TB1> INFO: Test took 16555ms.
[06:52:41.491] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:52:41.813] <TB1> INFO: dacScan step from 39 .. 39
[06:52:41.813] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:52:41.814] <TB1> INFO: run 1 of 1
[06:52:58.266] <TB1> INFO: Test took 16452ms.
[06:53:01.051] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:53:01.430] <TB1> INFO: dacScan step from 40 .. 40
[06:53:01.430] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:53:01.430] <TB1> INFO: run 1 of 1
[06:53:17.450] <TB1> INFO: Test took 16019ms.
[06:53:20.093] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:53:20.410] <TB1> INFO: dacScan step from 41 .. 41
[06:53:20.410] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:53:20.420] <TB1> INFO: run 1 of 1
[06:53:36.513] <TB1> INFO: Test took 16092ms.
[06:53:39.264] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:53:39.602] <TB1> INFO: dacScan step from 42 .. 42
[06:53:39.602] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:53:39.602] <TB1> INFO: run 1 of 1
[06:53:55.927] <TB1> INFO: Test took 16324ms.
[06:53:58.742] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:53:59.082] <TB1> INFO: dacScan step from 43 .. 43
[06:53:59.082] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:53:59.082] <TB1> INFO: run 1 of 1
[06:54:15.444] <TB1> INFO: Test took 16361ms.
[06:54:18.410] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:54:18.740] <TB1> INFO: dacScan step from 44 .. 44
[06:54:18.740] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:54:18.740] <TB1> INFO: run 1 of 1
[06:54:35.026] <TB1> INFO: Test took 16285ms.
[06:54:37.980] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:54:38.315] <TB1> INFO: dacScan step from 45 .. 45
[06:54:38.315] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:54:38.315] <TB1> INFO: run 1 of 1
[06:54:55.122] <TB1> INFO: Test took 16807ms.
[06:54:58.280] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:54:58.654] <TB1> INFO: dacScan step from 46 .. 46
[06:54:58.654] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:54:58.654] <TB1> INFO: run 1 of 1
[06:55:15.721] <TB1> INFO: Test took 17066ms.
[06:55:18.870] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:55:19.244] <TB1> INFO: dacScan step from 47 .. 47
[06:55:19.244] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:55:19.244] <TB1> INFO: run 1 of 1
[06:55:36.945] <TB1> INFO: Test took 17700ms.
[06:55:39.921] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:55:40.271] <TB1> INFO: dacScan step from 48 .. 48
[06:55:40.271] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:55:40.271] <TB1> INFO: run 1 of 1
[06:56:00.118] <TB1> INFO: Test took 19847ms.
[06:56:03.310] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:56:03.642] <TB1> INFO: dacScan step from 49 .. 49
[06:56:03.642] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:56:03.642] <TB1> INFO: run 1 of 1
[06:56:23.796] <TB1> INFO: Test took 20153ms.
[06:56:27.388] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:56:27.709] <TB1> INFO: dacScan step from 50 .. 50
[06:56:27.709] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:56:27.709] <TB1> INFO: run 1 of 1
[06:56:46.691] <TB1> INFO: Test took 18981ms.
[06:56:49.979] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:56:50.320] <TB1> INFO: dacScan step from 51 .. 51
[06:56:50.320] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:56:50.320] <TB1> INFO: run 1 of 1
[06:57:08.809] <TB1> INFO: Test took 18488ms.
[06:57:11.757] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:57:12.101] <TB1> INFO: dacScan step from 52 .. 52
[06:57:12.101] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:57:12.101] <TB1> INFO: run 1 of 1
[06:57:30.952] <TB1> INFO: Test took 18851ms.
[06:57:34.010] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:57:34.358] <TB1> INFO: dacScan step from 53 .. 53
[06:57:34.358] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:57:34.358] <TB1> INFO: run 1 of 1
[06:57:53.311] <TB1> INFO: Test took 18953ms.
[06:57:56.225] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:57:56.590] <TB1> INFO: dacScan step from 54 .. 54
[06:57:56.590] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:57:56.590] <TB1> INFO: run 1 of 1
[06:58:16.912] <TB1> INFO: Test took 20321ms.
[06:58:20.254] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:58:20.620] <TB1> INFO: dacScan step from 55 .. 55
[06:58:20.620] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:58:20.620] <TB1> INFO: run 1 of 1
[06:58:40.179] <TB1> INFO: Test took 19558ms.
[06:58:43.137] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:58:43.484] <TB1> INFO: dacScan step from 56 .. 56
[06:58:43.485] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:58:43.485] <TB1> INFO: run 1 of 1
[06:59:02.119] <TB1> INFO: Test took 18634ms.
[06:59:04.917] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:59:05.263] <TB1> INFO: dacScan step from 57 .. 57
[06:59:05.263] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:59:05.263] <TB1> INFO: run 1 of 1
[06:59:23.386] <TB1> INFO: Test took 18122ms.
[06:59:26.438] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:59:26.799] <TB1> INFO: dacScan step from 58 .. 58
[06:59:26.799] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:59:26.799] <TB1> INFO: run 1 of 1
[06:59:45.931] <TB1> INFO: Test took 19132ms.
[06:59:48.966] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:59:49.335] <TB1> INFO: dacScan step from 59 .. 59
[06:59:49.335] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[06:59:49.335] <TB1> INFO: run 1 of 1
[07:00:09.270] <TB1> INFO: Test took 19934ms.
[07:00:12.083] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:00:12.416] <TB1> INFO: dacScan step from 60 .. 60
[07:00:12.416] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:00:12.416] <TB1> INFO: run 1 of 1
[07:00:32.338] <TB1> INFO: Test took 19922ms.
[07:00:35.231] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:00:35.562] <TB1> INFO: dacScan step from 61 .. 61
[07:00:35.562] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:00:35.562] <TB1> INFO: run 1 of 1
[07:00:54.663] <TB1> INFO: Test took 19100ms.
[07:00:57.779] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:00:58.129] <TB1> INFO: dacScan step from 62 .. 62
[07:00:58.129] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:00:58.129] <TB1> INFO: run 1 of 1
[07:01:16.463] <TB1> INFO: Test took 18334ms.
[07:01:20.144] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:01:20.548] <TB1> INFO: dacScan step from 63 .. 63
[07:01:20.548] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:01:20.548] <TB1> INFO: run 1 of 1
[07:01:38.617] <TB1> INFO: Test took 18068ms.
[07:01:41.684] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:01:42.014] <TB1> INFO: dacScan step from 64 .. 64
[07:01:42.014] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:01:42.014] <TB1> INFO: run 1 of 1
[07:02:01.876] <TB1> INFO: Test took 19861ms.
[07:02:04.954] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:02:05.313] <TB1> INFO: dacScan step from 65 .. 65
[07:02:05.313] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:02:05.313] <TB1> INFO: run 1 of 1
[07:02:25.426] <TB1> INFO: Test took 20112ms.
[07:02:28.650] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:02:29.038] <TB1> INFO: dacScan step from 66 .. 66
[07:02:29.038] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:02:29.038] <TB1> INFO: run 1 of 1
[07:02:48.117] <TB1> INFO: Test took 19078ms.
[07:02:51.436] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:02:51.793] <TB1> INFO: dacScan step from 67 .. 67
[07:02:51.793] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:02:51.793] <TB1> INFO: run 1 of 1
[07:03:10.396] <TB1> INFO: Test took 18602ms.
[07:03:13.610] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:03:13.973] <TB1> INFO: dacScan step from 68 .. 68
[07:03:13.973] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:03:13.973] <TB1> INFO: run 1 of 1
[07:03:32.488] <TB1> INFO: Test took 18514ms.
[07:03:35.481] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:03:35.828] <TB1> INFO: dacScan step from 69 .. 69
[07:03:35.828] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:03:35.828] <TB1> INFO: run 1 of 1
[07:03:55.395] <TB1> INFO: Test took 19566ms.
[07:03:58.584] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:03:58.938] <TB1> INFO: dacScan step from 70 .. 70
[07:03:58.938] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:03:58.938] <TB1> INFO: run 1 of 1
[07:04:18.976] <TB1> INFO: Test took 20037ms.
[07:04:21.839] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:04:22.172] <TB1> INFO: dacScan step from 71 .. 71
[07:04:22.172] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:04:22.172] <TB1> INFO: run 1 of 1
[07:04:41.378] <TB1> INFO: Test took 19205ms.
[07:04:44.403] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:04:44.725] <TB1> INFO: dacScan step from 72 .. 72
[07:04:44.725] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:04:44.725] <TB1> INFO: run 1 of 1
[07:05:03.340] <TB1> INFO: Test took 18614ms.
[07:05:06.513] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:05:06.890] <TB1> INFO: dacScan step from 73 .. 73
[07:05:06.890] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:05:06.890] <TB1> INFO: run 1 of 1
[07:05:24.891] <TB1> INFO: Test took 18000ms.
[07:05:28.029] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:05:28.382] <TB1> INFO: dacScan step from 74 .. 74
[07:05:28.382] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:05:28.382] <TB1> INFO: run 1 of 1
[07:05:46.771] <TB1> INFO: Test took 18388ms.
[07:05:49.852] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:05:50.195] <TB1> INFO: dacScan step from 75 .. 75
[07:05:50.196] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:05:50.196] <TB1> INFO: run 1 of 1
[07:06:10.896] <TB1> INFO: Test took 20699ms.
[07:06:14.438] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:06:14.827] <TB1> INFO: dacScan step from 76 .. 76
[07:06:14.827] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:06:14.827] <TB1> INFO: run 1 of 1
[07:06:34.521] <TB1> INFO: Test took 19693ms.
[07:06:37.926] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:06:38.313] <TB1> INFO: dacScan step from 77 .. 77
[07:06:38.313] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:06:38.313] <TB1> INFO: run 1 of 1
[07:06:56.817] <TB1> INFO: Test took 18503ms.
[07:06:59.956] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:07:00.304] <TB1> INFO: dacScan step from 78 .. 78
[07:07:00.304] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:07:00.304] <TB1> INFO: run 1 of 1
[07:07:19.130] <TB1> INFO: Test took 18825ms.
[07:07:22.186] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:07:22.524] <TB1> INFO: dacScan step from 79 .. 79
[07:07:22.524] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:07:22.524] <TB1> INFO: run 1 of 1
[07:07:41.029] <TB1> INFO: Test took 18504ms.
[07:07:43.841] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:07:44.182] <TB1> INFO: dacScan step from 80 .. 80
[07:07:44.182] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:07:44.182] <TB1> INFO: run 1 of 1
[07:08:02.066] <TB1> INFO: Test took 17883ms.
[07:08:04.879] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:08:05.195] <TB1> INFO: dacScan step from 81 .. 81
[07:08:05.195] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:08:05.195] <TB1> INFO: run 1 of 1
[07:08:25.660] <TB1> INFO: Test took 20464ms.
[07:08:28.885] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:08:29.275] <TB1> INFO: dacScan step from 82 .. 82
[07:08:29.275] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:08:29.275] <TB1> INFO: run 1 of 1
[07:08:48.639] <TB1> INFO: Test took 19363ms.
[07:08:51.782] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:08:52.104] <TB1> INFO: dacScan step from 83 .. 83
[07:08:52.104] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:08:52.104] <TB1> INFO: run 1 of 1
[07:09:11.602] <TB1> INFO: Test took 19497ms.
[07:09:14.689] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:09:15.025] <TB1> INFO: dacScan step from 84 .. 84
[07:09:15.025] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:09:15.025] <TB1> INFO: run 1 of 1
[07:09:33.818] <TB1> INFO: Test took 18792ms.
[07:09:37.197] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:09:37.506] <TB1> INFO: dacScan step from 85 .. 85
[07:09:37.506] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:09:37.506] <TB1> INFO: run 1 of 1
[07:09:53.186] <TB1> INFO: Test took 15679ms.
[07:09:56.021] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:09:56.371] <TB1> INFO: dacScan step from 86 .. 86
[07:09:56.371] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:09:56.371] <TB1> INFO: run 1 of 1
[07:10:11.280] <TB1> INFO: Test took 14908ms.
[07:10:13.952] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:10:14.279] <TB1> INFO: dacScan step from 87 .. 87
[07:10:14.279] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:10:14.279] <TB1> INFO: run 1 of 1
[07:10:28.615] <TB1> INFO: Test took 14335ms.
[07:10:31.130] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:10:31.428] <TB1> INFO: dacScan step from 88 .. 88
[07:10:31.428] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:10:31.428] <TB1> INFO: run 1 of 1
[07:10:45.645] <TB1> INFO: Test took 14216ms.
[07:10:48.147] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:10:48.451] <TB1> INFO: dacScan step from 89 .. 89
[07:10:48.451] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:10:48.451] <TB1> INFO: run 1 of 1
[07:11:02.678] <TB1> INFO: Test took 14226ms.
[07:11:05.220] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:11:05.525] <TB1> INFO: dacScan step from 90 .. 90
[07:11:05.525] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:11:05.525] <TB1> INFO: run 1 of 1
[07:11:19.957] <TB1> INFO: Test took 14431ms.
[07:11:22.510] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:11:22.819] <TB1> INFO: dacScan step from 91 .. 91
[07:11:22.819] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:11:22.819] <TB1> INFO: run 1 of 1
[07:11:37.007] <TB1> INFO: Test took 14187ms.
[07:11:39.563] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:11:39.870] <TB1> INFO: dacScan step from 92 .. 92
[07:11:39.870] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:11:39.870] <TB1> INFO: run 1 of 1
[07:11:54.037] <TB1> INFO: Test took 14167ms.
[07:11:56.569] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:11:56.873] <TB1> INFO: dacScan step from 93 .. 93
[07:11:56.873] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:11:56.873] <TB1> INFO: run 1 of 1
[07:12:11.248] <TB1> INFO: Test took 14375ms.
[07:12:13.777] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:12:14.077] <TB1> INFO: dacScan step from 94 .. 94
[07:12:14.077] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:12:14.077] <TB1> INFO: run 1 of 1
[07:12:28.341] <TB1> INFO: Test took 14264ms.
[07:12:30.893] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:12:31.200] <TB1> INFO: dacScan step from 95 .. 95
[07:12:31.200] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:12:31.200] <TB1> INFO: run 1 of 1
[07:12:45.328] <TB1> INFO: Test took 14127ms.
[07:12:47.861] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:12:48.160] <TB1> INFO: dacScan step from 96 .. 96
[07:12:48.160] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:12:48.160] <TB1> INFO: run 1 of 1
[07:13:02.407] <TB1> INFO: Test took 14246ms.
[07:13:04.972] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:13:05.276] <TB1> INFO: dacScan step from 97 .. 97
[07:13:05.276] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:13:05.276] <TB1> INFO: run 1 of 1
[07:13:19.648] <TB1> INFO: Test took 14371ms.
[07:13:22.184] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:13:22.492] <TB1> INFO: dacScan step from 98 .. 98
[07:13:22.492] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:13:22.492] <TB1> INFO: run 1 of 1
[07:13:36.910] <TB1> INFO: Test took 14417ms.
[07:13:39.508] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:13:39.820] <TB1> INFO: dacScan step from 99 .. 99
[07:13:39.820] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:13:39.820] <TB1> INFO: run 1 of 1
[07:13:54.184] <TB1> INFO: Test took 14363ms.
[07:13:56.770] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:13:57.077] <TB1> INFO: dacScan step from 100 .. 100
[07:13:57.077] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[07:13:57.077] <TB1> INFO: run 1 of 1
[07:14:11.295] <TB1> INFO: Test took 14217ms.
[07:14:13.844] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:14:14.148] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:15.458] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:16.748] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:18.035] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:19.439] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:20.843] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:22.293] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:23.689] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:25.107] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:26.541] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:27.951] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:29.346] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:30.707] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:32.072] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:33.323] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:34.601] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[07:14:35.867] <TB1> INFO: PixTest:: pg_setup set to default.
[07:14:35.868] <TB1> INFO: vcal mean: 39.97 40.72 39.40 42.95 43.70 44.25 44.08 45.04 44.58 44.44 44.91 43.83 42.87 39.59 39.20 39.32
[07:14:35.868] <TB1> INFO: vcal RMS: 1.57 1.66 1.19 1.59 1.37 1.50 1.70 1.64 1.69 1.70 1.85 1.75 1.50 1.52 1.26 1.66
[07:14:35.868] <TB1> INFO: number of X-ray hits detected: 252088 268484 217409 378660 445994 478775 484509 520151 498771 476765 532335 433368 402034 232209 231143 224984
[07:14:35.868] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[07:14:35.868] <TB1> INFO: X-ray hit rate [MHz/cm2]: 73.9 78.7 63.7 111.0 130.7 140.3 142.0 152.5 146.2 139.7 156.0 127.0 117.8 68.1 67.7 65.9
[07:14:35.868] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[07:14:35.965] <TB1> INFO: enter test to run
[07:14:35.965] <TB1> INFO: test: no parameter change
[07:14:36.142] <TB1> QUIET: Connection to board 83 closed.
[07:14:36.221] <TB1> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[07:31:24.324] <TB1> INFO: *** Welcome to pxar ***
[07:31:24.324] <TB1> INFO: *** Today: 2015/08/24
[07:31:24.325] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[07:31:24.325] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[07:31:24.325] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[07:31:24.325] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[07:31:24.392] <TB1> INFO: clk: 4
[07:31:24.392] <TB1> INFO: ctr: 4
[07:31:24.392] <TB1> INFO: sda: 19
[07:31:24.392] <TB1> INFO: tin: 9
[07:31:24.392] <TB1> INFO: level: 15
[07:31:24.392] <TB1> INFO: triggerdelay: 0
[07:31:24.392] <TB1> QUIET: Instanciating API for pxar prod-01+86~g1838649
[07:31:24.392] <TB1> INFO: Log level: INFO
[07:31:24.405] <TB1> INFO: Found DTB DTB_WS6UZO
[07:31:24.414] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[07:31:24.417] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[07:31:24.420] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[07:31:25.954] <TB1> INFO: DUT info:
[07:31:25.954] <TB1> INFO: The DUT currently contains the following objects:
[07:31:25.954] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:31:25.954] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:31:25.954] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:31:25.954] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:31:25.954] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.954] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.954] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.954] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:25.955] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:26.356] <TB1> INFO: enter 'restricted' command line mode
[07:31:26.356] <TB1> INFO: enter test to run
[07:31:26.356] <TB1> INFO: test: HighRate no parameter change
[07:31:26.356] <TB1> INFO: running: highrate
[07:31:26.357] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[07:31:26.596] <TB1> INFO: ----------------------------------------------------------------------
[07:31:26.596] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[07:31:26.596] <TB1> INFO: ----------------------------------------------------------------------
[07:31:27.696] <TB1> INFO: Test took 1094ms.
[07:31:32.177] <TB1> INFO: Test took 4475ms.
[07:31:32.355] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:31:36.870] <TB1> INFO: Test took 4483ms.
[07:31:37.065] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:31:41.423] <TB1> INFO: Test took 4325ms.
[07:31:41.665] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:31:45.987] <TB1> INFO: Test took 4288ms.
[07:31:46.176] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:31:50.556] <TB1> INFO: Test took 4346ms.
[07:31:50.750] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:31:55.028] <TB1> INFO: Test took 4244ms.
[07:31:55.232] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:31:59.376] <TB1> INFO: Test took 4102ms.
[07:31:59.575] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:03.677] <TB1> INFO: Test took 4067ms.
[07:32:03.898] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:07.800] <TB1> INFO: Test took 3859ms.
[07:32:07.988] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:11.959] <TB1> INFO: Test took 3936ms.
[07:32:12.191] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:16.201] <TB1> INFO: Test took 3968ms.
[07:32:16.386] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:20.646] <TB1> INFO: Test took 4227ms.
[07:32:20.845] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:25.128] <TB1> INFO: Test took 4247ms.
[07:32:25.332] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:29.721] <TB1> INFO: Test took 4351ms.
[07:32:29.912] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:34.147] <TB1> INFO: Test took 4202ms.
[07:32:34.341] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:38.774] <TB1> INFO: Test took 4396ms.
[07:32:38.974] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:43.352] <TB1> INFO: Test took 4343ms.
[07:32:43.566] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:47.317] <TB1> INFO: Test took 3715ms.
[07:32:47.513] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:51.330] <TB1> INFO: Test took 3779ms.
[07:32:51.514] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:55.162] <TB1> INFO: Test took 3615ms.
[07:32:55.391] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:32:55.711] <TB1> INFO: enter test to run
[07:32:55.711] <TB1> INFO: test: Pretest no parameter change
[07:32:55.711] <TB1> INFO: running: pretest
[07:32:55.711] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[07:32:55.711] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[07:32:55.711] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[07:32:55.712] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[07:32:55.712] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[07:32:55.712] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[07:32:55.712] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[07:32:55.712] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[07:32:55.712] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[07:32:55.713] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[07:32:55.713] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[07:32:55.713] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[07:32:55.713] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[07:32:55.713] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[07:32:55.713] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[07:32:55.713] <TB1> INFO: write dac parameters into /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[07:32:55.713] <TB1> INFO: enter test to run
[07:32:55.713] <TB1> INFO: test: no parameter change
[07:32:55.906] <TB1> QUIET: Connection to board 83 closed.
[07:32:55.985] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[07:33:24.623] <TB1> INFO: *** Welcome to pxar ***
[07:33:24.623] <TB1> INFO: *** Today: 2015/08/24
[07:33:24.623] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//dacParameters35_C15.dat
[07:33:24.623] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//tbmParameters_C0b.dat
[07:33:24.624] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//defaultMaskFile.dat
[07:33:24.624] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//trimParameters35_C15.dat
[07:33:24.692] <TB1> INFO: clk: 4
[07:33:24.692] <TB1> INFO: ctr: 4
[07:33:24.692] <TB1> INFO: sda: 19
[07:33:24.692] <TB1> INFO: tin: 9
[07:33:24.692] <TB1> INFO: level: 15
[07:33:24.692] <TB1> INFO: triggerdelay: 0
[07:33:24.692] <TB1> QUIET: Instanciating API for pxar prod-01+86~g1838649
[07:33:24.692] <TB1> INFO: Log level: INFO
[07:33:24.706] <TB1> INFO: Found DTB DTB_WS6UZO
[07:33:24.714] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[07:33:24.717] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[07:33:24.720] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[07:33:26.277] <TB1> INFO: DUT info:
[07:33:26.277] <TB1> INFO: The DUT currently contains the following objects:
[07:33:26.277] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:33:26.278] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:33:26.278] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:33:26.278] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:33:26.278] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.278] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.279] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:33:26.680] <TB1> INFO: enter 'restricted' command line mode
[07:33:26.680] <TB1> INFO: enter test to run
[07:33:26.680] <TB1> INFO: test: HighRate no parameter change
[07:33:26.680] <TB1> INFO: running: highrate
[07:33:26.681] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[07:33:26.917] <TB1> INFO: ----------------------------------------------------------------------
[07:33:26.917] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[07:33:26.917] <TB1> INFO: ----------------------------------------------------------------------
[07:33:38.525] <TB1> INFO: Test took 11602ms.
[07:33:39.687] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:33:40.024] <TB1> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 1 0 0 0 0 0 0 1 0 1
[07:33:40.024] <TB1> INFO: number of red-efficiency pixels: 180 232 209 302 455 476 476 504 498 474 551 383 337 167 143 119
[07:33:40.024] <TB1> INFO: number of X-ray hits detected: 126300 133993 107494 193688 225642 246839 246579 265185 253945 244593 272029 220864 204255 114349 114940 112396
[07:33:40.024] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[07:33:40.024] <TB1> INFO: number of Vcal hits detected: 207764 207752 207782 207678 207510 207487 207414 207453 207471 207488 207383 207580 207651 207773 207852 207822
[07:33:40.024] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.9 99.9 99.9
[07:33:40.024] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.7 99.7 99.7 99.8 99.7 99.8 99.8 99.9 99.9 99.9
[07:33:40.024] <TB1> INFO: X-ray hit rate [MHz/cm2]: 37.0 39.3 31.5 56.8 66.1 72.4 72.3 77.7 74.4 71.7 79.7 64.7 59.9 33.5 33.7 32.9
[07:33:40.024] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[07:33:40.057] <TB1> INFO: PixTest:: pg_setup set to default.
[07:33:40.092] <TB1> INFO: enter test to run
[07:33:40.092] <TB1> INFO: test: no parameter change
[07:33:40.244] <TB1> QUIET: Connection to board 83 closed.
[07:33:40.323] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[07:34:16.159] <TB1> INFO: *** Welcome to pxar ***
[07:34:16.159] <TB1> INFO: *** Today: 2015/08/24
[07:34:16.159] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//dacParameters35_C15.dat
[07:34:16.160] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//tbmParameters_C0b.dat
[07:34:16.160] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//defaultMaskFile.dat
[07:34:16.160] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//trimParameters35_C15.dat
[07:34:16.242] <TB1> INFO: clk: 4
[07:34:16.242] <TB1> INFO: ctr: 4
[07:34:16.242] <TB1> INFO: sda: 19
[07:34:16.242] <TB1> INFO: tin: 9
[07:34:16.242] <TB1> INFO: level: 15
[07:34:16.242] <TB1> INFO: triggerdelay: 0
[07:34:16.242] <TB1> QUIET: Instanciating API for pxar prod-01+86~g1838649
[07:34:16.242] <TB1> INFO: Log level: INFO
[07:34:16.255] <TB1> INFO: Found DTB DTB_WS6UZO
[07:34:16.263] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[07:34:16.266] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[07:34:16.269] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[07:34:17.799] <TB1> INFO: DUT info:
[07:34:17.799] <TB1> INFO: The DUT currently contains the following objects:
[07:34:17.799] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:34:17.799] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:34:17.799] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:34:17.799] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:34:17.799] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.799] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.800] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:17.800] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:34:18.200] <TB1> INFO: enter 'restricted' command line mode
[07:34:18.200] <TB1> INFO: enter test to run
[07:34:18.201] <TB1> INFO: test: HighRate no parameter change
[07:34:18.201] <TB1> INFO: running: highrate
[07:34:18.201] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[07:34:18.331] <TB1> INFO: ----------------------------------------------------------------------
[07:34:18.331] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[07:34:18.331] <TB1> INFO: ----------------------------------------------------------------------
[07:34:33.516] <TB1> INFO: Test took 15180ms.
[07:34:37.158] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:34:37.689] <TB1> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 1 0 0 0 0 0 0 1 0 0
[07:34:37.689] <TB1> INFO: number of red-efficiency pixels: 510 524 637 1080 1544 1741 1835 1997 1790 1680 2097 1526 1251 578 466 442
[07:34:37.689] <TB1> INFO: number of X-ray hits detected: 250032 269862 218761 381811 447082 481329 486408 523142 499673 477143 533078 435119 403770 232035 231323 224277
[07:34:37.689] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[07:34:37.689] <TB1> INFO: number of Vcal hits detected: 207403 207411 207110 206615 205614 205387 204977 204889 205321 205447 204452 205755 206365 207146 207500 207471
[07:34:37.689] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.7 99.6 99.4 99.0 98.9 98.8 98.7 98.9 98.9 98.5 99.1 99.3 99.7 99.8 99.8
[07:34:37.689] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.6 99.3 98.9 98.7 98.5 98.5 98.7 98.8 98.3 98.9 99.2 99.6 99.8 99.7
[07:34:37.689] <TB1> INFO: X-ray hit rate [MHz/cm2]: 73.3 79.1 64.1 111.9 131.0 141.1 142.6 153.3 146.5 139.9 156.2 127.5 118.3 68.0 67.8 65.7
[07:34:37.689] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[07:34:37.725] <TB1> INFO: PixTest:: pg_setup set to default.
[07:34:37.775] <TB1> INFO: enter test to run
[07:34:37.775] <TB1> INFO: test: no parameter change
[07:34:38.104] <TB1> QUIET: Connection to board 83 closed.
[07:34:38.187] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[07:35:09.759] <TB1> INFO: *** Welcome to pxar ***
[07:35:09.759] <TB1> INFO: *** Today: 2015/08/24
[07:35:09.759] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//dacParameters35_C15.dat
[07:35:09.760] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//tbmParameters_C0b.dat
[07:35:09.760] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//defaultMaskFile.dat
[07:35:09.760] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//trimParameters35_C15.dat
[07:35:09.828] <TB1> INFO: clk: 4
[07:35:09.828] <TB1> INFO: ctr: 4
[07:35:09.828] <TB1> INFO: sda: 19
[07:35:09.828] <TB1> INFO: tin: 9
[07:35:09.828] <TB1> INFO: level: 15
[07:35:09.828] <TB1> INFO: triggerdelay: 0
[07:35:09.828] <TB1> QUIET: Instanciating API for pxar prod-01+86~g1838649
[07:35:09.828] <TB1> INFO: Log level: INFO
[07:35:09.842] <TB1> INFO: Found DTB DTB_WS6UZO
[07:35:09.850] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[07:35:09.854] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[07:35:09.856] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[07:35:11.406] <TB1> INFO: DUT info:
[07:35:11.406] <TB1> INFO: The DUT currently contains the following objects:
[07:35:11.406] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:35:11.407] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:35:11.407] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:35:11.407] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:35:11.407] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.407] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.408] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:35:11.809] <TB1> INFO: enter 'restricted' command line mode
[07:35:11.809] <TB1> INFO: enter test to run
[07:35:11.809] <TB1> INFO: test: HighRate no parameter change
[07:35:11.809] <TB1> INFO: running: highrate
[07:35:11.810] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[07:35:11.965] <TB1> INFO: ----------------------------------------------------------------------
[07:35:11.965] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[07:35:11.965] <TB1> INFO: ----------------------------------------------------------------------
[07:35:31.866] <TB1> INFO: Test took 19895ms.
[07:35:37.828] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:35:38.350] <TB1> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 1 0 0 0 0 0 0 1 0 0
[07:35:38.350] <TB1> INFO: number of red-efficiency pixels: 1018 1140 1167 2158 2865 3083 3192 3499 3293 3060 3510 2764 2443 1088 979 809
[07:35:38.350] <TB1> INFO: number of X-ray hits detected: 361099 390432 317812 545645 640454 678993 696493 746822 710691 686080 760629 620151 578129 337646 335862 321894
[07:35:38.350] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[07:35:38.350] <TB1> INFO: number of Vcal hits detected: 206720 206586 205688 204108 201092 200612 199329 198779 200000 200160 197429 201875 203633 205870 206833 206989
[07:35:38.350] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.5 99.4 99.1 98.4 97.1 96.9 96.4 96.0 96.6 96.7 95.5 97.5 98.1 99.2 99.5 99.6
[07:35:38.350] <TB1> INFO: Vcal hit overall efficiency (%): 99.4 99.3 98.9 98.1 96.7 96.4 95.8 95.6 96.2 96.2 94.9 97.1 97.9 99.0 99.4 99.5
[07:35:38.350] <TB1> INFO: X-ray hit rate [MHz/cm2]: 105.8 114.4 93.2 159.9 187.7 199.0 204.1 218.9 208.3 201.1 222.9 181.8 169.5 99.0 98.4 94.3
[07:35:38.350] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[07:35:38.379] <TB1> INFO: PixTest:: pg_setup set to default.
[07:35:38.428] <TB1> INFO: enter test to run
[07:35:38.428] <TB1> INFO: test: no parameter change
[07:35:38.577] <TB1> QUIET: Connection to board 83 closed.
[07:35:38.658] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[07:36:09.799] <TB1> INFO: *** Welcome to pxar ***
[07:36:09.799] <TB1> INFO: *** Today: 2015/08/24
[07:36:09.799] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//dacParameters35_C15.dat
[07:36:09.800] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//tbmParameters_C0b.dat
[07:36:09.800] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//defaultMaskFile.dat
[07:36:09.800] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//trimParameters35_C15.dat
[07:36:09.870] <TB1> INFO: clk: 4
[07:36:09.870] <TB1> INFO: ctr: 4
[07:36:09.870] <TB1> INFO: sda: 19
[07:36:09.870] <TB1> INFO: tin: 9
[07:36:09.870] <TB1> INFO: level: 15
[07:36:09.870] <TB1> INFO: triggerdelay: 0
[07:36:09.870] <TB1> QUIET: Instanciating API for pxar prod-01+86~g1838649
[07:36:09.870] <TB1> INFO: Log level: INFO
[07:36:09.883] <TB1> INFO: Found DTB DTB_WS6UZO
[07:36:09.891] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[07:36:09.894] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[07:36:09.897] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[07:36:11.427] <TB1> INFO: DUT info:
[07:36:11.427] <TB1> INFO: The DUT currently contains the following objects:
[07:36:11.427] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:36:11.427] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:36:11.427] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:36:11.427] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:36:11.427] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.427] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:36:11.828] <TB1> INFO: enter 'restricted' command line mode
[07:36:11.829] <TB1> INFO: enter test to run
[07:36:11.829] <TB1> INFO: test: HighRate no parameter change
[07:36:11.829] <TB1> INFO: running: highrate
[07:36:11.829] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[07:36:11.969] <TB1> INFO: ----------------------------------------------------------------------
[07:36:11.969] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[07:36:11.969] <TB1> INFO: ----------------------------------------------------------------------
[07:36:34.549] <TB1> INFO: Test took 22574ms.
[07:36:45.988] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:36:46.614] <TB1> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 1 0 0 0 0 0 0 1 0 0
[07:36:46.614] <TB1> INFO: number of red-efficiency pixels: 1814 2129 1764 3361 3868 3941 4009 4114 4057 3978 4107 3732 3536 1624 1822 1399
[07:36:46.614] <TB1> INFO: number of X-ray hits detected: 488104 528484 429673 730650 863580 904049 930707 1002778 947135 906710 1018979 823302 773698 457000 454882 436059
[07:36:46.614] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[07:36:46.614] <TB1> INFO: number of Vcal hits detected: 205216 204657 202842 198641 191782 190873 187127 185552 188778 189853 182991 193982 197247 203182 205410 205990
[07:36:46.614] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.8 98.5 98.0 96.0 93.1 92.7 91.1 90.1 91.6 92.2 89.1 94.1 95.4 98.1 98.9 99.2
[07:36:46.614] <TB1> INFO: Vcal hit overall efficiency (%): 98.7 98.4 97.5 95.5 92.2 91.8 90.0 89.2 90.8 91.3 88.0 93.3 94.8 97.7 98.8 99.0
[07:36:46.614] <TB1> INFO: X-ray hit rate [MHz/cm2]: 143.1 154.9 125.9 214.2 253.1 265.0 272.8 293.9 277.6 265.8 298.7 241.3 226.8 134.0 133.3 127.8
[07:36:46.614] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[07:36:46.638] <TB1> INFO: PixTest:: pg_setup set to default.
[07:36:46.676] <TB1> INFO: enter test to run
[07:36:46.676] <TB1> INFO: test: no parameter change
[07:36:46.829] <TB1> QUIET: Connection to board 83 closed.
[07:36:46.908] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[07:37:14.272] <TB1> INFO: *** Welcome to pxar ***
[07:37:14.272] <TB1> INFO: *** Today: 2015/08/24
[07:37:14.272] <TB1> INFO: readRocDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//dacParameters35_C15.dat
[07:37:14.273] <TB1> INFO: readTbmDacs: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//tbmParameters_C0b.dat
[07:37:14.273] <TB1> INFO: readMaskFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//defaultMaskFile.dat
[07:37:14.273] <TB1> INFO: readTrimFile: /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//trimParameters35_C15.dat
[07:37:14.373] <TB1> INFO: clk: 4
[07:37:14.373] <TB1> INFO: ctr: 4
[07:37:14.373] <TB1> INFO: sda: 19
[07:37:14.373] <TB1> INFO: tin: 9
[07:37:14.373] <TB1> INFO: level: 15
[07:37:14.374] <TB1> INFO: triggerdelay: 0
[07:37:14.374] <TB1> QUIET: Instanciating API for pxar prod-01+86~g1838649
[07:37:14.374] <TB1> INFO: Log level: INFO
[07:37:14.388] <TB1> INFO: Found DTB DTB_WS6UZO
[07:37:14.396] <TB1> QUIET: Connection to board DTB_WS6UZO opened.
[07:37:14.399] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 83
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WS6UZO
MAC address: 40D855118053
Hostname: pixelDTB083
Comment:
------------------------------------------------------
[07:37:14.402] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[07:37:15.930] <TB1> INFO: DUT info:
[07:37:15.930] <TB1> INFO: The DUT currently contains the following objects:
[07:37:15.930] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[07:37:15.930] <TB1> INFO: TBM Core alpha (0): 7 registers set
[07:37:15.930] <TB1> INFO: TBM Core beta (1): 7 registers set
[07:37:15.930] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:37:15.930] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.930] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.930] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.930] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.930] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.930] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.930] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.930] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.931] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.931] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.931] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.931] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.931] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.931] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.931] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:15.931] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:37:16.332] <TB1> INFO: enter 'restricted' command line mode
[07:37:16.332] <TB1> INFO: enter test to run
[07:37:16.332] <TB1> INFO: test: HighRate no parameter change
[07:37:16.332] <TB1> INFO: running: highrate
[07:37:16.333] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2077_XrayQualification_2015-08-24_08h08m_1440396521//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[07:37:16.465] <TB1> INFO: ----------------------------------------------------------------------
[07:37:16.465] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[07:37:16.465] <TB1> INFO: ----------------------------------------------------------------------
[07:37:39.681] <TB1> INFO: Test took 23210ms.
[07:37:52.047] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[07:37:52.724] <TB1> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 1 0 0 0 0 0 0 0 0 1
[07:37:52.724] <TB1> INFO: number of red-efficiency pixels: 1928 2246 1926 3468 3908 4018 4010 4132 4091 4003 4122 3824 3651 1725 1943 1549
[07:37:52.724] <TB1> INFO: number of X-ray hits detected: 497978 542858 445796 745650 882873 923948 954237 1029442 973180 931439 1039162 848111 788309 473569 470005 448103
[07:37:52.724] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[07:37:52.724] <TB1> INFO: number of Vcal hits detected: 204979 204355 202504 198093 190751 189772 186222 183697 187144 188568 181534 192865 196586 202960 205226 205760
[07:37:52.724] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.7 98.4 97.8 95.8 92.6 92.1 90.6 89.2 90.8 91.6 88.4 93.5 95.1 98.0 98.8 99.1
[07:37:52.724] <TB1> INFO: Vcal hit overall efficiency (%): 98.5 98.2 97.4 95.2 91.7 91.2 89.5 88.3 90.0 90.7 87.3 92.7 94.5 97.6 98.7 98.9
[07:37:52.724] <TB1> INFO: X-ray hit rate [MHz/cm2]: 146.0 159.1 130.7 218.6 258.8 270.8 279.7 301.7 285.2 273.0 304.6 248.6 231.1 138.8 137.8 131.3
[07:37:52.724] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[07:37:52.749] <TB1> INFO: PixTest:: pg_setup set to default.
[07:37:52.787] <TB1> INFO: enter test to run
[07:37:52.787] <TB1> INFO: test: no parameter change
[07:37:52.957] <TB1> QUIET: Connection to board 83 closed.
[07:37:53.037] <TB1> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master