[12:33:45.041] <TB3> INFO: *** Welcome to pxar ***
[12:33:45.041] <TB3> INFO: *** Today: 2015/11/23
[12:33:45.100] <TB3> INFO: *** Version: 206d-dirty
[12:33:45.100] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//000_PixelAlive_p17//dacParameters35_C15.dat
[12:33:45.101] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//000_PixelAlive_p17//tbmParameters_C0b.dat
[12:33:45.101] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//000_PixelAlive_p17//defaultMaskFile.dat
[12:33:45.101] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//000_PixelAlive_p17//trimParameters35_C15.dat
[12:33:45.183] <TB3> INFO: clk: 4
[12:33:45.183] <TB3> INFO: ctr: 4
[12:33:45.183] <TB3> INFO: sda: 19
[12:33:45.183] <TB3> INFO: tin: 9
[12:33:45.183] <TB3> INFO: level: 15
[12:33:45.183] <TB3> INFO: triggerdelay: 0
[12:33:45.183] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:33:45.183] <TB3> INFO: Log level: INFO
[12:33:45.197] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:33:45.211] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:33:45.214] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:33:45.217] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:33:46.758] <TB3> INFO: DUT info:
[12:33:46.758] <TB3> INFO: The DUT currently contains the following objects:
[12:33:46.758] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[12:33:46.758] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:33:46.758] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:33:46.758] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:33:46.758] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:46.758] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:33:47.159] <TB3> INFO: enter 'restricted' command line mode
[12:33:47.159] <TB3> INFO: enter test to run
[12:33:47.159] <TB3> INFO: test: PixelAlive no parameter change
[12:33:47.159] <TB3> INFO: running: pixelalive
[12:33:47.163] <TB3> INFO: ######################################################################
[12:33:47.164] <TB3> INFO: PixTestAlive::doTest()
[12:33:47.164] <TB3> INFO: ######################################################################
[12:33:47.165] <TB3> INFO: ----------------------------------------------------------------------
[12:33:47.165] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:33:47.165] <TB3> INFO: ----------------------------------------------------------------------
[12:33:47.477] <TB3> INFO: Expecting 41600 events.
[12:33:51.655] <TB3> INFO: 41600 events read in total (3461ms).
[12:33:51.828] <TB3> INFO: Test took 4662ms.
[12:33:51.834] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:52.085] <TB3> INFO: PixTestAlive::aliveTest() done
[12:33:52.085] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 0 1 0 0 0 0 0 0
[12:33:52.086] <TB3> INFO: ----------------------------------------------------------------------
[12:33:52.086] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:33:52.086] <TB3> INFO: ----------------------------------------------------------------------
[12:33:52.387] <TB3> INFO: Expecting 41600 events.
[12:33:55.380] <TB3> INFO: 41600 events read in total (2278ms).
[12:33:55.380] <TB3> INFO: Test took 3292ms.
[12:33:55.381] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:55.381] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:33:55.784] <TB3> INFO: PixTestAlive::maskTest() done
[12:33:55.784] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:33:55.785] <TB3> INFO: ----------------------------------------------------------------------
[12:33:55.785] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:33:55.785] <TB3> INFO: ----------------------------------------------------------------------
[12:33:56.085] <TB3> INFO: Expecting 41600 events.
[12:34:00.305] <TB3> INFO: 41600 events read in total (3505ms).
[12:34:00.305] <TB3> INFO: Test took 4518ms.
[12:34:00.311] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:34:00.695] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[12:34:00.695] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:34:00.695] <TB3> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[12:34:00.724] <TB3> INFO: enter test to run
[12:34:00.724] <TB3> INFO: test: no parameter change
[12:34:00.782] <TB3> QUIET: Connection to board 121 closed.
[12:34:01.698] <TB3> INFO: pXar: this is the end, my friend

[12:39:26.275] <TB3> INFO: *** Welcome to pxar ***
[12:39:26.275] <TB3> INFO: *** Today: 2015/11/23
[12:39:26.368] <TB3> INFO: *** Version: 206d-dirty
[12:39:26.368] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//dacParameters35_C15.dat
[12:39:26.369] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[12:39:26.370] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:39:26.370] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:39:26.453] <TB3> INFO: clk: 4
[12:39:26.453] <TB3> INFO: ctr: 4
[12:39:26.453] <TB3> INFO: sda: 19
[12:39:26.453] <TB3> INFO: tin: 9
[12:39:26.453] <TB3> INFO: level: 15
[12:39:26.453] <TB3> INFO: triggerdelay: 0
[12:39:26.453] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:39:26.453] <TB3> INFO: Log level: INFO
[12:39:26.469] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:39:26.484] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:39:26.487] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:39:26.489] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:39:28.036] <TB3> INFO: DUT info:
[12:39:28.036] <TB3> INFO: The DUT currently contains the following objects:
[12:39:28.036] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[12:39:28.036] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:39:28.036] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:39:28.036] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:39:28.036] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.036] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.036] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.036] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.036] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.037] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:28.438] <TB3> INFO: enter 'restricted' command line mode
[12:39:28.438] <TB3> INFO: enter test to run
[12:39:28.438] <TB3> INFO: test: delay setting parameters: ->5<-
[12:39:28.438] <TB3> INFO: delay test by 5 seconds...
[12:39:33.438] <TB3> INFO: enter test to run
[12:39:33.438] <TB3> INFO: test: highrate no parameter change
[12:39:33.438] <TB3> INFO: running: highrate
[12:39:33.443] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[12:39:33.585] <TB3> INFO: ----------------------------------------------------------------------
[12:39:33.585] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:39:33.585] <TB3> INFO: ----------------------------------------------------------------------
[12:39:33.585] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:39:33.585] <TB3> INFO: edge/corner pixel THR is adjusted
[12:39:33.585] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:39:34.544] <TB3> INFO: Collecting data for 1 seconds...
[12:39:35.546] <TB3> INFO: Done with hot pixel readout
[12:39:39.504] <TB3> INFO: PixTest:: pg_setup set to default.
[12:39:39.505] <TB3> INFO: 1 hot pixels found in step 0
[12:39:40.560] <TB3> INFO: Collecting data for 1 seconds...
[12:39:41.563] <TB3> INFO: Done with hot pixel readout
[12:39:45.522] <TB3> INFO: PixTest:: pg_setup set to default.
[12:39:45.523] <TB3> INFO: 0 hot pixels found in step 1
[12:39:45.530] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[12:39:45.602] <TB3> INFO: PixTest::trimHotPixels() done
[12:39:45.603] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C0.dat
[12:39:45.609] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C1.dat
[12:39:45.616] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C2.dat
[12:39:45.624] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C3.dat
[12:39:45.631] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C4.dat
[12:39:45.639] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C5.dat
[12:39:45.647] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C6.dat
[12:39:45.656] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C7.dat
[12:39:45.664] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C8.dat
[12:39:45.672] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C9.dat
[12:39:45.679] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C10.dat
[12:39:45.687] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C11.dat
[12:39:45.695] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C12.dat
[12:39:45.702] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C13.dat
[12:39:45.709] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C14.dat
[12:39:45.717] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:39:45.725] <TB3> INFO: write masked pixels into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:39:45.765] <TB3> INFO: enter test to run
[12:39:45.765] <TB3> INFO: test: no parameter change
[12:39:45.843] <TB3> QUIET: Connection to board 121 closed.
[12:39:45.923] <TB3> INFO: pXar: this is the end, my friend

[12:40:55.265] <TB3> INFO: *** Welcome to pxar ***
[12:40:55.265] <TB3> INFO: *** Today: 2015/11/23
[12:40:55.366] <TB3> INFO: *** Version: 206d-dirty
[12:40:55.366] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//dacParameters35_C15.dat
[12:40:55.366] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0b.dat
[12:40:55.367] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[12:40:55.367] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[12:40:55.439] <TB3> INFO: clk: 4
[12:40:55.439] <TB3> INFO: ctr: 4
[12:40:55.439] <TB3> INFO: sda: 19
[12:40:55.439] <TB3> INFO: tin: 9
[12:40:55.439] <TB3> INFO: level: 15
[12:40:55.439] <TB3> INFO: triggerdelay: 0
[12:40:55.439] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:40:55.439] <TB3> INFO: Log level: INFO
[12:40:55.452] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:40:55.466] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:40:55.469] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:40:55.472] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:40:57.024] <TB3> INFO: DUT info:
[12:40:57.024] <TB3> INFO: The DUT currently contains the following objects:
[12:40:57.024] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[12:40:57.024] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:40:57.024] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:40:57.024] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:40:57.024] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.024] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:57.425] <TB3> INFO: enter 'restricted' command line mode
[12:40:57.425] <TB3> INFO: enter test to run
[12:40:57.425] <TB3> INFO: test: delay setting parameters: ->5<-
[12:40:57.425] <TB3> INFO: delay test by 5 seconds...
[12:41:02.425] <TB3> INFO: enter test to run
[12:41:02.425] <TB3> INFO: test: highrate no parameter change
[12:41:02.425] <TB3> INFO: running: highrate
[12:41:02.428] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C15.dat
[12:41:02.624] <TB3> INFO: ----------------------------------------------------------------------
[12:41:02.624] <TB3> INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[12:41:02.624] <TB3> INFO: ----------------------------------------------------------------------
[12:41:02.624] <TB3> INFO: THR = 10, corresponding to ~ 5.33333 MHz/cm2
[12:41:02.624] <TB3> INFO: edge/corner pixel THR is adjusted
[12:41:02.624] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:41:03.583] <TB3> INFO: Collecting data for 5 seconds...
[12:41:08.593] <TB3> INFO: Done with hot pixel readout
[12:41:15.886] <TB3> INFO: PixTest:: pg_setup set to default.
[12:41:15.888] <TB3> INFO: 3 hot pixels found in step 0
[12:41:17.019] <TB3> INFO: Collecting data for 5 seconds...
[12:41:22.028] <TB3> INFO: Done with hot pixel readout
[12:41:29.798] <TB3> INFO: PixTest:: pg_setup set to default.
[12:41:29.799] <TB3> INFO: 2 hot pixels found in step 1
[12:41:30.925] <TB3> INFO: Collecting data for 5 seconds...
[12:41:35.935] <TB3> INFO: Done with hot pixel readout
[12:41:43.339] <TB3> INFO: PixTest:: pg_setup set to default.
[12:41:43.340] <TB3> INFO: 1 hot pixels found in step 2
[12:41:44.469] <TB3> INFO: Collecting data for 5 seconds...
[12:41:49.479] <TB3> INFO: Done with hot pixel readout
[12:41:56.886] <TB3> INFO: PixTest:: pg_setup set to default.
[12:41:56.887] <TB3> INFO: 1 hot pixels found in step 3
[12:41:58.015] <TB3> INFO: Collecting data for 5 seconds...
[12:42:03.025] <TB3> INFO: Done with hot pixel readout
[12:42:10.527] <TB3> INFO: PixTest:: pg_setup set to default.
[12:42:10.528] <TB3> INFO: 0 hot pixels found in step 4
[12:42:10.531] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[12:42:10.706] <TB3> INFO: PixTest::trimHotPixels() done
[12:42:10.706] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat
[12:42:10.716] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C1.dat
[12:42:10.724] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C2.dat
[12:42:10.736] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C3.dat
[12:42:10.743] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C4.dat
[12:42:10.753] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C5.dat
[12:42:10.762] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C6.dat
[12:42:10.770] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C7.dat
[12:42:10.781] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C8.dat
[12:42:10.788] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C9.dat
[12:42:10.799] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C10.dat
[12:42:10.808] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C11.dat
[12:42:10.816] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C12.dat
[12:42:10.827] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C13.dat
[12:42:10.834] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C14.dat
[12:42:10.845] <TB3> INFO: write trim parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[12:42:10.853] <TB3> INFO: write masked pixels into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[12:42:10.891] <TB3> INFO: enter test to run
[12:42:10.891] <TB3> INFO: test: no parameter change
[12:42:10.952] <TB3> QUIET: Connection to board 121 closed.
[12:42:11.032] <TB3> INFO: pXar: this is the end, my friend

[12:42:50.403] <TB3> INFO: *** Welcome to pxar ***
[12:42:50.403] <TB3> INFO: *** Today: 2015/11/23
[12:42:50.782] <TB3> INFO: *** Version: 206d-dirty
[12:42:50.783] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//dacParameters35_C15.dat
[12:42:50.785] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//tbmParameters_C0b.dat
[12:42:50.785] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//defaultMaskFile.dat
[12:42:50.785] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//trimParameters35_C15.dat
[12:42:50.879] <TB3> INFO: clk: 4
[12:42:50.879] <TB3> INFO: ctr: 4
[12:42:50.879] <TB3> INFO: sda: 19
[12:42:50.879] <TB3> INFO: tin: 9
[12:42:50.879] <TB3> INFO: level: 15
[12:42:50.879] <TB3> INFO: triggerdelay: 0
[12:42:50.879] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:42:50.879] <TB3> INFO: Log level: INFO
[12:42:50.891] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:42:50.906] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:42:50.909] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:42:50.912] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:42:52.479] <TB3> INFO: DUT info:
[12:42:52.480] <TB3> INFO: The DUT currently contains the following objects:
[12:42:52.480] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[12:42:52.480] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:42:52.480] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:42:52.480] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:42:52.480] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.480] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:52.881] <TB3> INFO: enter 'restricted' command line mode
[12:42:52.881] <TB3> INFO: enter test to run
[12:42:52.881] <TB3> INFO: test: delay setting parameters: ->5<-
[12:42:52.881] <TB3> INFO: delay test by 5 seconds...
[12:42:57.881] <TB3> INFO: enter test to run
[12:42:57.881] <TB3> INFO: test: Xray no parameter change
[12:42:57.881] <TB3> INFO: running: xray
[12:42:57.884] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//004_HRData_50//phCalibrationFitErr35_C15.dat
[12:42:58.062] <TB3> INFO: ######################################################################
[12:42:58.062] <TB3> INFO: PixTestXray::doTest()
[12:42:58.062] <TB3> INFO: ######################################################################
[12:42:58.062] <TB3> INFO: ----------------------------------------------------------------------
[12:42:58.062] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:42:58.062] <TB3> INFO: ----------------------------------------------------------------------
[12:42:59.027] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:43:10.538] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[12:43:38.067] <TB3> INFO: Resuming triggers.
[12:43:49.577] <TB3> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[12:44:16.376] <TB3> INFO: Resuming triggers.
[12:44:27.887] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[12:44:54.860] <TB3> INFO: Resuming triggers.
[12:45:06.372] <TB3> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[12:45:34.473] <TB3> INFO: Resuming triggers.
[12:45:45.996] <TB3> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[12:46:13.521] <TB3> INFO: Resuming triggers.
[12:46:25.045] <TB3> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[12:46:52.921] <TB3> INFO: Resuming triggers.
[12:47:04.431] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[12:47:31.913] <TB3> INFO: Resuming triggers.
[12:47:43.425] <TB3> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[12:48:11.661] <TB3> INFO: Resuming triggers.
[12:48:19.726] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[12:48:39.977] <TB3> INFO: PixTest:: pg_setup set to default.
[12:48:39.978] <TB3> INFO: PixTestXray::doPhRun() done
[12:48:39.978] <TB3> INFO: PixTestXray::doTest() done
[12:48:40.163] <TB3> INFO: enter test to run
[12:48:40.163] <TB3> INFO: test: no parameter change
[12:48:40.264] <TB3> QUIET: Connection to board 121 closed.
[12:48:40.344] <TB3> INFO: pXar: this is the end, my friend

[12:54:33.926] <TB3> INFO: *** Welcome to pxar ***
[12:54:33.926] <TB3> INFO: *** Today: 2015/11/23
[12:54:34.003] <TB3> INFO: *** Version: 206d-dirty
[12:54:34.003] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//dacParameters35_C15.dat
[12:54:34.004] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//tbmParameters_C0b.dat
[12:54:34.004] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//defaultMaskFile.dat
[12:54:34.004] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//trimParameters35_C15.dat
[12:54:34.084] <TB3> INFO: clk: 4
[12:54:34.084] <TB3> INFO: ctr: 4
[12:54:34.084] <TB3> INFO: sda: 19
[12:54:34.084] <TB3> INFO: tin: 9
[12:54:34.084] <TB3> INFO: level: 15
[12:54:34.084] <TB3> INFO: triggerdelay: 0
[12:54:34.084] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[12:54:34.084] <TB3> INFO: Log level: INFO
[12:54:34.098] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:54:34.113] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:54:34.116] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:54:34.118] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:54:35.671] <TB3> INFO: DUT info:
[12:54:35.671] <TB3> INFO: The DUT currently contains the following objects:
[12:54:35.671] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[12:54:35.672] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:54:35.672] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:54:35.672] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:54:35.672] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:35.672] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:36.073] <TB3> INFO: enter 'restricted' command line mode
[12:54:36.073] <TB3> INFO: enter test to run
[12:54:36.073] <TB3> INFO: test: delay setting parameters: ->5<-
[12:54:36.073] <TB3> INFO: delay test by 5 seconds...
[12:54:41.074] <TB3> INFO: enter test to run
[12:54:41.074] <TB3> INFO: test: Xray no parameter change
[12:54:41.074] <TB3> INFO: running: xray
[12:54:41.078] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//005_HRData_150//phCalibrationFitErr35_C15.dat
[12:54:41.253] <TB3> INFO: ######################################################################
[12:54:41.253] <TB3> INFO: PixTestXray::doTest()
[12:54:41.253] <TB3> INFO: ######################################################################
[12:54:41.253] <TB3> INFO: ----------------------------------------------------------------------
[12:54:41.253] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:54:41.253] <TB3> INFO: ----------------------------------------------------------------------
[12:54:42.218] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:54:48.834] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[12:55:18.650] <TB3> INFO: Resuming triggers.
[12:55:25.269] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[12:55:54.342] <TB3> INFO: Resuming triggers.
[12:56:00.962] <TB3> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[12:56:30.617] <TB3> INFO: Resuming triggers.
[12:56:37.249] <TB3> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[12:57:06.228] <TB3> INFO: Resuming triggers.
[12:57:12.848] <TB3> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[12:57:42.768] <TB3> INFO: Resuming triggers.
[12:57:49.391] <TB3> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[12:58:18.722] <TB3> INFO: Resuming triggers.
[12:58:25.355] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[12:58:54.039] <TB3> INFO: Resuming triggers.
[12:59:00.659] <TB3> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[12:59:29.538] <TB3> INFO: Resuming triggers.
[12:59:36.161] <TB3> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[13:00:04.901] <TB3> INFO: Resuming triggers.
[13:00:11.523] <TB3> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[13:00:40.059] <TB3> INFO: Resuming triggers.
[13:00:46.682] <TB3> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[13:01:15.677] <TB3> INFO: Resuming triggers.
[13:01:22.310] <TB3> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[13:01:51.166] <TB3> INFO: Resuming triggers.
[13:01:57.788] <TB3> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[13:02:27.155] <TB3> INFO: Resuming triggers.
[13:02:33.775] <TB3> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[13:03:03.771] <TB3> INFO: Resuming triggers.
[13:03:10.392] <TB3> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[13:03:39.845] <TB3> INFO: Resuming triggers.
[13:03:40.686] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[13:03:44.842] <TB3> INFO: PixTest:: pg_setup set to default.
[13:03:44.844] <TB3> INFO: PixTestXray::doPhRun() done
[13:03:44.844] <TB3> INFO: PixTestXray::doTest() done
[13:03:45.036] <TB3> INFO: enter test to run
[13:03:45.036] <TB3> INFO: test: no parameter change
[13:03:45.166] <TB3> QUIET: Connection to board 121 closed.
[13:03:45.247] <TB3> INFO: pXar: this is the end, my friend

[13:14:03.637] <TB3> INFO: *** Welcome to pxar ***
[13:14:03.637] <TB3> INFO: *** Today: 2015/11/23
[13:14:03.764] <TB3> INFO: *** Version: 206d-dirty
[13:14:03.764] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//dacParameters35_C15.dat
[13:14:03.765] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//tbmParameters_C0b.dat
[13:14:03.765] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//defaultMaskFile.dat
[13:14:03.765] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//trimParameters35_C15.dat
[13:14:03.841] <TB3> INFO: clk: 4
[13:14:03.841] <TB3> INFO: ctr: 4
[13:14:03.841] <TB3> INFO: sda: 19
[13:14:03.841] <TB3> INFO: tin: 9
[13:14:03.841] <TB3> INFO: level: 15
[13:14:03.841] <TB3> INFO: triggerdelay: 0
[13:14:03.841] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[13:14:03.841] <TB3> INFO: Log level: INFO
[13:14:03.855] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:14:03.872] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:14:03.875] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:14:03.878] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[13:14:05.439] <TB3> INFO: DUT info:
[13:14:05.439] <TB3> INFO: The DUT currently contains the following objects:
[13:14:05.439] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[13:14:05.439] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:14:05.439] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:14:05.439] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:14:05.439] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.440] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:14:05.841] <TB3> INFO: enter 'restricted' command line mode
[13:14:05.841] <TB3> INFO: enter test to run
[13:14:05.841] <TB3> INFO: test: Highrate no parameter change
[13:14:05.841] <TB3> INFO: running: highrate
[13:14:05.843] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[13:14:06.024] <TB3> INFO: ----------------------------------------------------------------------
[13:14:06.024] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[13:14:06.024] <TB3> INFO: ----------------------------------------------------------------------
[13:14:06.029] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[13:14:06.041] <TB3> INFO: dacScan step from 15 .. 34
[13:14:06.041] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[13:14:06.041] <TB3> INFO: run 1 of 1
[13:14:06.670] <TB3> INFO: Expecting 4160000 events.
[13:14:44.460] <TB3> INFO: 830650 events read in total (37262ms).
[13:15:21.009] <TB3> INFO: 1662200 events read in total (73811ms).
[13:15:58.905] <TB3> INFO: 2493850 events read in total (111707ms).
[13:16:36.318] <TB3> INFO: 3323250 events read in total (149120ms).
[13:17:13.679] <TB3> INFO: 4150700 events read in total (186481ms).
[13:17:14.266] <TB3> INFO: 4160000 events read in total (187068ms).
[13:17:14.511] <TB3> INFO: Test took 188469ms.
[13:17:16.595] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:17:19.630] <TB3> INFO: dacScan step from 35 .. 54
[13:17:19.630] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[13:17:19.630] <TB3> INFO: run 1 of 1
[13:17:20.230] <TB3> INFO: Expecting 4160000 events.
[13:17:52.889] <TB3> INFO: 568850 events read in total (32126ms).
[13:18:25.820] <TB3> INFO: 1136900 events read in total (65057ms).
[13:18:58.970] <TB3> INFO: 1703400 events read in total (98207ms).
[13:19:30.411] <TB3> INFO: 2267850 events read in total (129648ms).
[13:20:02.440] <TB3> INFO: 2827300 events read in total (161677ms).
[13:20:33.952] <TB3> INFO: 3381600 events read in total (193189ms).
[13:21:07.226] <TB3> INFO: 3931900 events read in total (226463ms).
[13:21:20.669] <TB3> INFO: 4160000 events read in total (239906ms).
[13:21:20.852] <TB3> INFO: Test took 241221ms.
[13:21:21.886] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:21:25.443] <TB3> INFO: dacScan step from 55 .. 74
[13:21:25.443] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[13:21:25.443] <TB3> INFO: run 1 of 1
[13:21:26.072] <TB3> INFO: Expecting 4160000 events.
[13:21:58.109] <TB3> INFO: 512600 events read in total (31510ms).
[13:22:29.850] <TB3> INFO: 1025050 events read in total (63251ms).
[13:23:02.072] <TB3> INFO: 1537800 events read in total (95473ms).
[13:23:33.624] <TB3> INFO: 2050600 events read in total (127025ms).
[13:24:06.051] <TB3> INFO: 2563300 events read in total (159452ms).
[13:24:38.493] <TB3> INFO: 3076050 events read in total (191894ms).
[13:25:10.751] <TB3> INFO: 3588850 events read in total (224152ms).
[13:25:42.224] <TB3> INFO: 4101400 events read in total (255625ms).
[13:25:45.748] <TB3> INFO: 4160000 events read in total (259149ms).
[13:25:45.876] <TB3> INFO: Test took 260432ms.
[13:25:46.843] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:25:50.430] <TB3> INFO: dacScan step from 75 .. 75
[13:25:50.430] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[13:25:50.430] <TB3> INFO: run 1 of 1
[13:25:51.050] <TB3> INFO: Expecting 208000 events.
[13:26:04.922] <TB3> INFO: 208000 events read in total (13332ms).
[13:26:04.927] <TB3> INFO: Test took 14497ms.
[13:26:04.979] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:26:06.274] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:08.237] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:09.450] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:10.638] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:11.843] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:13.013] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:14.205] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:15.399] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:16.583] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:17.750] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:18.813] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:19.986] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:21.165] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:22.290] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:23.349] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:24.374] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[13:26:25.425] <TB3> INFO: PixTest:: pg_setup set to default.
[13:26:25.427] <TB3> INFO: vcal mean: 36.33 36.12 36.30 37.26 37.98 38.60 39.11 38.92 39.07 39.11 39.37 38.89 38.26 36.77 36.95 36.83
[13:26:25.427] <TB3> INFO: vcal RMS: 1.21 0.90 1.03 1.22 1.19 1.27 1.13 1.10 1.19 1.22 1.16 1.23 1.05 0.98 0.91 0.87
[13:26:25.427] <TB3> INFO: number of X-ray hits detected: 101223 108667 95172 170330 180006 217621 208362 215678 223098 214572 227215 205813 182781 112272 123220 107400
[13:26:25.427] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:26:25.427] <TB3> INFO: X-ray hit rate [MHz/cm2]: 29.7 31.9 27.9 49.9 52.8 63.8 61.1 63.2 65.4 62.9 66.6 60.3 53.6 32.9 36.1 31.5
[13:26:25.427] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[13:26:25.720] <TB3> INFO: enter test to run
[13:26:25.726] <TB3> INFO: test: no parameter change
[13:26:25.846] <TB3> QUIET: Connection to board 121 closed.
[13:26:25.929] <TB3> INFO: pXar: this is the end, my friend

[13:56:59.237] <TB3> INFO: *** Welcome to pxar ***
[13:56:59.237] <TB3> INFO: *** Today: 2015/11/23
[13:56:59.411] <TB3> INFO: *** Version: 206d-dirty
[13:56:59.411] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:56:59.412] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[13:56:59.412] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[13:56:59.412] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[13:56:59.482] <TB3> INFO: clk: 4
[13:56:59.482] <TB3> INFO: ctr: 4
[13:56:59.482] <TB3> INFO: sda: 19
[13:56:59.482] <TB3> INFO: tin: 9
[13:56:59.482] <TB3> INFO: level: 15
[13:56:59.482] <TB3> INFO: triggerdelay: 0
[13:56:59.483] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[13:56:59.483] <TB3> INFO: Log level: INFO
[13:56:59.495] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:56:59.512] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:56:59.515] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:56:59.517] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[13:57:01.089] <TB3> INFO: DUT info:
[13:57:01.090] <TB3> INFO: The DUT currently contains the following objects:
[13:57:01.090] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[13:57:01.090] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:57:01.090] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:57:01.090] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:57:01.090] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.090] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:01.491] <TB3> INFO: enter 'restricted' command line mode
[13:57:01.491] <TB3> INFO: enter test to run
[13:57:01.491] <TB3> INFO: test: HighRate no parameter change
[13:57:01.491] <TB3> INFO: running: highrate
[13:57:01.495] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[13:57:01.670] <TB3> INFO: ----------------------------------------------------------------------
[13:57:01.670] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:57:01.670] <TB3> INFO: ----------------------------------------------------------------------
[13:57:01.806] <TB3> INFO: Expecting 768 events.
[13:57:02.939] <TB3> INFO: 768 events read in total (415ms).
[13:57:03.127] <TB3> INFO: Test took 1453ms.
[13:57:03.742] <TB3> INFO: Expecting 41600 events.
[13:57:06.944] <TB3> INFO: 41600 events read in total (2675ms).
[13:57:06.945] <TB3> INFO: Test took 3814ms.
[13:57:06.990] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:07.690] <TB3> INFO: Expecting 41600 events.
[13:57:11.089] <TB3> INFO: 41600 events read in total (2872ms).
[13:57:11.091] <TB3> INFO: Test took 4081ms.
[13:57:11.143] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:11.830] <TB3> INFO: Expecting 41600 events.
[13:57:15.238] <TB3> INFO: 41600 events read in total (2882ms).
[13:57:15.239] <TB3> INFO: Test took 4072ms.
[13:57:15.292] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:15.973] <TB3> INFO: Expecting 41600 events.
[13:57:19.437] <TB3> INFO: 41600 events read in total (2938ms).
[13:57:19.438] <TB3> INFO: Test took 4125ms.
[13:57:19.485] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:20.180] <TB3> INFO: Expecting 41600 events.
[13:57:23.578] <TB3> INFO: 41600 events read in total (2871ms).
[13:57:23.579] <TB3> INFO: Test took 4075ms.
[13:57:23.626] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:24.319] <TB3> INFO: Expecting 41600 events.
[13:57:27.766] <TB3> INFO: 41600 events read in total (2921ms).
[13:57:27.767] <TB3> INFO: Test took 4122ms.
[13:57:27.818] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:28.507] <TB3> INFO: Expecting 41600 events.
[13:57:31.782] <TB3> INFO: 41600 events read in total (2749ms).
[13:57:31.783] <TB3> INFO: Test took 3943ms.
[13:57:31.830] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:32.530] <TB3> INFO: Expecting 41600 events.
[13:57:35.873] <TB3> INFO: 41600 events read in total (2816ms).
[13:57:35.874] <TB3> INFO: Test took 4025ms.
[13:57:35.922] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:36.620] <TB3> INFO: Expecting 41600 events.
[13:57:40.014] <TB3> INFO: 41600 events read in total (2868ms).
[13:57:40.015] <TB3> INFO: Test took 4074ms.
[13:57:40.062] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:40.761] <TB3> INFO: Expecting 41600 events.
[13:57:44.388] <TB3> INFO: 41600 events read in total (3101ms).
[13:57:44.389] <TB3> INFO: Test took 4308ms.
[13:57:44.436] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:45.117] <TB3> INFO: Expecting 41600 events.
[13:57:48.681] <TB3> INFO: 41600 events read in total (3038ms).
[13:57:48.683] <TB3> INFO: Test took 4227ms.
[13:57:48.733] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:49.419] <TB3> INFO: Expecting 41600 events.
[13:57:52.858] <TB3> INFO: 41600 events read in total (2913ms).
[13:57:52.859] <TB3> INFO: Test took 4104ms.
[13:57:52.906] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:53.603] <TB3> INFO: Expecting 41600 events.
[13:57:57.063] <TB3> INFO: 41600 events read in total (2934ms).
[13:57:57.065] <TB3> INFO: Test took 4140ms.
[13:57:57.121] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:57.808] <TB3> INFO: Expecting 41600 events.
[13:58:01.241] <TB3> INFO: 41600 events read in total (2906ms).
[13:58:01.242] <TB3> INFO: Test took 4096ms.
[13:58:01.288] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:01.966] <TB3> INFO: Expecting 41600 events.
[13:58:05.298] <TB3> INFO: 41600 events read in total (2805ms).
[13:58:05.299] <TB3> INFO: Test took 3988ms.
[13:58:05.349] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:06.039] <TB3> INFO: Expecting 41600 events.
[13:58:09.585] <TB3> INFO: 41600 events read in total (3020ms).
[13:58:09.587] <TB3> INFO: Test took 4213ms.
[13:58:09.639] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:10.321] <TB3> INFO: Expecting 41600 events.
[13:58:13.845] <TB3> INFO: 41600 events read in total (2998ms).
[13:58:13.846] <TB3> INFO: Test took 4186ms.
[13:58:13.893] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:14.586] <TB3> INFO: Expecting 41600 events.
[13:58:18.037] <TB3> INFO: 41600 events read in total (2925ms).
[13:58:18.038] <TB3> INFO: Test took 4125ms.
[13:58:18.093] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:18.784] <TB3> INFO: Expecting 41600 events.
[13:58:22.330] <TB3> INFO: 41600 events read in total (3020ms).
[13:58:22.332] <TB3> INFO: Test took 4218ms.
[13:58:22.388] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:23.080] <TB3> INFO: Expecting 41600 events.
[13:58:26.450] <TB3> INFO: 41600 events read in total (2844ms).
[13:58:26.451] <TB3> INFO: Test took 4043ms.
[13:58:26.498] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:26.881] <TB3> INFO: enter test to run
[13:58:26.881] <TB3> INFO: test: Pretest no parameter change
[13:58:26.881] <TB3> INFO: running: pretest
[13:58:26.882] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[13:58:26.882] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[13:58:26.882] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[13:58:26.882] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[13:58:26.882] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[13:58:26.882] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[13:58:26.882] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[13:58:26.883] <TB3> INFO: write dac parameters into /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:58:26.884] <TB3> INFO: enter test to run
[13:58:26.884] <TB3> INFO: test: no parameter change
[13:58:27.026] <TB3> QUIET: Connection to board 121 closed.
[13:58:27.106] <TB3> INFO: pXar: this is the end, my friend

[13:59:08.932] <TB3> INFO: *** Welcome to pxar ***
[13:59:08.932] <TB3> INFO: *** Today: 2015/11/23
[13:59:09.192] <TB3> INFO: *** Version: 206d-dirty
[13:59:09.192] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//dacParameters35_C15.dat
[13:59:09.193] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//tbmParameters_C0b.dat
[13:59:09.193] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//defaultMaskFile.dat
[13:59:09.193] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//trimParameters35_C15.dat
[13:59:09.272] <TB3> INFO: clk: 4
[13:59:09.272] <TB3> INFO: ctr: 4
[13:59:09.272] <TB3> INFO: sda: 19
[13:59:09.272] <TB3> INFO: tin: 9
[13:59:09.272] <TB3> INFO: level: 15
[13:59:09.272] <TB3> INFO: triggerdelay: 0
[13:59:09.272] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[13:59:09.272] <TB3> INFO: Log level: INFO
[13:59:09.285] <TB3> INFO: Found DTB DTB_WWV6Z5
[13:59:09.301] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[13:59:09.304] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[13:59:09.307] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[13:59:10.874] <TB3> INFO: DUT info:
[13:59:10.874] <TB3> INFO: The DUT currently contains the following objects:
[13:59:10.874] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[13:59:10.874] <TB3> INFO: TBM Core alpha (0): 7 registers set
[13:59:10.874] <TB3> INFO: TBM Core beta (1): 7 registers set
[13:59:10.874] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:59:10.874] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.874] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.875] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.875] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:10.875] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:11.275] <TB3> INFO: enter 'restricted' command line mode
[13:59:11.275] <TB3> INFO: enter test to run
[13:59:11.275] <TB3> INFO: test: PixelAlive no parameter change
[13:59:11.275] <TB3> INFO: running: pixelalive
[13:59:11.282] <TB3> INFO: ######################################################################
[13:59:11.282] <TB3> INFO: PixTestAlive::doTest()
[13:59:11.282] <TB3> INFO: ######################################################################
[13:59:11.284] <TB3> INFO: ----------------------------------------------------------------------
[13:59:11.284] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:59:11.284] <TB3> INFO: ----------------------------------------------------------------------
[13:59:11.626] <TB3> INFO: Expecting 208000 events.
[13:59:22.460] <TB3> INFO: 208000 events read in total (10116ms).
[13:59:22.554] <TB3> INFO: Test took 11268ms.
[13:59:22.565] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:59:22.829] <TB3> INFO: PixTestAlive::aliveTest() done
[13:59:22.829] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 1 1 0 0 0 0 0 0
[13:59:22.831] <TB3> INFO: ----------------------------------------------------------------------
[13:59:22.831] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:59:22.831] <TB3> INFO: ----------------------------------------------------------------------
[13:59:23.148] <TB3> INFO: Expecting 208000 events.
[13:59:29.685] <TB3> INFO: 208000 events read in total (5820ms).
[13:59:29.686] <TB3> INFO: Test took 6854ms.
[13:59:29.686] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:59:29.687] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:59:30.089] <TB3> INFO: PixTestAlive::maskTest() done
[13:59:30.089] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:59:30.091] <TB3> INFO: ----------------------------------------------------------------------
[13:59:30.091] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:59:30.091] <TB3> INFO: ----------------------------------------------------------------------
[13:59:30.425] <TB3> INFO: Expecting 208000 events.
[13:59:41.097] <TB3> INFO: 208000 events read in total (9957ms).
[13:59:41.098] <TB3> INFO: Test took 11005ms.
[13:59:41.104] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:59:41.431] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[13:59:41.431] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:59:41.431] <TB3> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[13:59:41.461] <TB3> INFO: enter test to run
[13:59:41.461] <TB3> INFO: test: delay setting parameters: ->2<-
[13:59:41.461] <TB3> INFO: delay test by 2 seconds...
[13:59:43.461] <TB3> INFO: enter test to run
[13:59:43.461] <TB3> INFO: test: HighRate no parameter change
[13:59:43.461] <TB3> INFO: running: highrate
[13:59:43.461] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[13:59:43.596] <TB3> INFO: ----------------------------------------------------------------------
[13:59:43.596] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:59:43.596] <TB3> INFO: ----------------------------------------------------------------------
[13:59:44.196] <TB3> INFO: Expecting 208000 events.
[13:59:55.211] <TB3> INFO: 208000 events read in total (10488ms).
[13:59:55.215] <TB3> INFO: Test took 11615ms.
[13:59:55.354] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:59:55.596] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 1 0 0 0 0 0 0 0
[13:59:55.596] <TB3> INFO: number of red-efficiency pixels: 58 55 64 109 116 141 139 124 132 126 149 136 109 1365 62 67
[13:59:55.596] <TB3> INFO: number of X-ray hits detected: 46138 48720 42494 78764 81480 101306 95569 98917 101271 98139 105192 95230 84505 51356 55653 48613
[13:59:55.596] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:59:55.596] <TB3> INFO: number of Vcal hits detected: 207843 207945 207935 207890 207835 207810 207859 207875 207816 207851 207848 207861 207890 206305 207938 207933
[13:59:55.596] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.2 100.0 100.0
[13:59:55.596] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.2 100.0 100.0
[13:59:55.596] <TB3> INFO: X-ray hit rate [MHz/cm2]: 13.5 14.3 12.5 23.1 23.9 29.7 28.0 29.0 29.7 28.8 30.8 27.9 24.8 15.1 16.3 14.2
[13:59:55.596] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[13:59:55.622] <TB3> INFO: PixTest:: pg_setup set to default.
[13:59:55.629] <TB3> INFO: enter test to run
[13:59:55.629] <TB3> INFO: test: no parameter change
[13:59:55.741] <TB3> QUIET: Connection to board 121 closed.
[13:59:55.821] <TB3> INFO: pXar: this is the end, my friend

[14:00:29.443] <TB3> INFO: *** Welcome to pxar ***
[14:00:29.443] <TB3> INFO: *** Today: 2015/11/23
[14:00:30.004] <TB3> INFO: *** Version: 206d-dirty
[14:00:30.004] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//dacParameters35_C15.dat
[14:00:30.006] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//tbmParameters_C0b.dat
[14:00:30.006] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//defaultMaskFile.dat
[14:00:30.006] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//trimParameters35_C15.dat
[14:00:30.094] <TB3> INFO: clk: 4
[14:00:30.094] <TB3> INFO: ctr: 4
[14:00:30.094] <TB3> INFO: sda: 19
[14:00:30.094] <TB3> INFO: tin: 9
[14:00:30.094] <TB3> INFO: level: 15
[14:00:30.094] <TB3> INFO: triggerdelay: 0
[14:00:30.094] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[14:00:30.094] <TB3> INFO: Log level: INFO
[14:00:30.107] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:00:30.123] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:00:30.126] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:00:30.129] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[14:00:31.689] <TB3> INFO: DUT info:
[14:00:31.689] <TB3> INFO: The DUT currently contains the following objects:
[14:00:31.689] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[14:00:31.689] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:00:31.689] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:00:31.689] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:00:31.689] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.689] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:31.690] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:00:32.091] <TB3> INFO: enter 'restricted' command line mode
[14:00:32.091] <TB3> INFO: enter test to run
[14:00:32.091] <TB3> INFO: test: PixelAlive no parameter change
[14:00:32.091] <TB3> INFO: running: pixelalive
[14:00:32.097] <TB3> INFO: ######################################################################
[14:00:32.097] <TB3> INFO: PixTestAlive::doTest()
[14:00:32.097] <TB3> INFO: ######################################################################
[14:00:32.099] <TB3> INFO: ----------------------------------------------------------------------
[14:00:32.099] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:00:32.099] <TB3> INFO: ----------------------------------------------------------------------
[14:00:32.429] <TB3> INFO: Expecting 208000 events.
[14:00:42.933] <TB3> INFO: 208000 events read in total (9787ms).
[14:00:43.047] <TB3> INFO: Test took 10946ms.
[14:00:43.056] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:00:43.312] <TB3> INFO: PixTestAlive::aliveTest() done
[14:00:43.313] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 1 1 0 0 0 0 0 0
[14:00:43.314] <TB3> INFO: ----------------------------------------------------------------------
[14:00:43.314] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:00:43.314] <TB3> INFO: ----------------------------------------------------------------------
[14:00:43.646] <TB3> INFO: Expecting 208000 events.
[14:00:50.006] <TB3> INFO: 208000 events read in total (5645ms).
[14:00:50.006] <TB3> INFO: Test took 6691ms.
[14:00:50.006] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:00:50.007] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:00:50.409] <TB3> INFO: PixTestAlive::maskTest() done
[14:00:50.409] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:00:50.410] <TB3> INFO: ----------------------------------------------------------------------
[14:00:50.410] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:00:50.410] <TB3> INFO: ----------------------------------------------------------------------
[14:00:50.715] <TB3> INFO: Expecting 208000 events.
[14:01:01.558] <TB3> INFO: 208000 events read in total (10128ms).
[14:01:01.559] <TB3> INFO: Test took 11147ms.
[14:01:01.565] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:01:01.888] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:01:01.888] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:01:01.888] <TB3> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[14:01:01.926] <TB3> INFO: enter test to run
[14:01:01.926] <TB3> INFO: test: delay setting parameters: ->2<-
[14:01:01.926] <TB3> INFO: delay test by 2 seconds...
[14:01:03.926] <TB3> INFO: enter test to run
[14:01:03.926] <TB3> INFO: test: HighRate no parameter change
[14:01:03.926] <TB3> INFO: running: highrate
[14:01:03.926] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//013_HREfficiency_100//phCalibrationFitErr35_C15.dat
[14:01:04.088] <TB3> INFO: ----------------------------------------------------------------------
[14:01:04.088] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:01:04.088] <TB3> INFO: ----------------------------------------------------------------------
[14:01:04.687] <TB3> INFO: Expecting 208000 events.
[14:01:17.715] <TB3> INFO: 208000 events read in total (12501ms).
[14:01:17.721] <TB3> INFO: Test took 13630ms.
[14:01:18.010] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:01:18.298] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 0 0 0 0 0 0 0 0
[14:01:18.299] <TB3> INFO: number of red-efficiency pixels: 141 128 156 333 369 433 394 471 394 377 539 465 388 1466 191 127
[14:01:18.299] <TB3> INFO: number of X-ray hits detected: 101013 108199 95974 170651 177621 216094 207417 214205 221786 211823 225590 204509 182021 112545 123269 106127
[14:01:18.299] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:01:18.299] <TB3> INFO: number of Vcal hits detected: 207758 207869 207837 207648 207553 207498 207578 207505 207523 207572 207410 207494 207586 206161 207798 207872
[14:01:18.299] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.1 99.9 99.9
[14:01:18.299] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.1 99.9 99.9
[14:01:18.299] <TB3> INFO: X-ray hit rate [MHz/cm2]: 29.6 31.7 28.1 50.0 52.1 63.3 60.8 62.8 65.0 62.1 66.1 59.9 53.4 33.0 36.1 31.1
[14:01:18.299] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:01:18.325] <TB3> INFO: PixTest:: pg_setup set to default.
[14:01:18.333] <TB3> INFO: enter test to run
[14:01:18.333] <TB3> INFO: test: no parameter change
[14:01:18.417] <TB3> QUIET: Connection to board 121 closed.
[14:01:18.496] <TB3> INFO: pXar: this is the end, my friend

[14:01:53.944] <TB3> INFO: *** Welcome to pxar ***
[14:01:53.944] <TB3> INFO: *** Today: 2015/11/23
[14:01:53.993] <TB3> INFO: *** Version: 206d-dirty
[14:01:53.993] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//dacParameters35_C15.dat
[14:01:53.993] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//tbmParameters_C0b.dat
[14:01:53.993] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//defaultMaskFile.dat
[14:01:53.993] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//trimParameters35_C15.dat
[14:01:54.061] <TB3> INFO: clk: 4
[14:01:54.061] <TB3> INFO: ctr: 4
[14:01:54.061] <TB3> INFO: sda: 19
[14:01:54.061] <TB3> INFO: tin: 9
[14:01:54.061] <TB3> INFO: level: 15
[14:01:54.061] <TB3> INFO: triggerdelay: 0
[14:01:54.062] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[14:01:54.062] <TB3> INFO: Log level: INFO
[14:01:54.074] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:01:54.089] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:01:54.092] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:01:54.095] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[14:01:55.671] <TB3> INFO: DUT info:
[14:01:55.671] <TB3> INFO: The DUT currently contains the following objects:
[14:01:55.671] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[14:01:55.671] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:01:55.671] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:01:55.671] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:01:55.671] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:55.671] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:01:56.072] <TB3> INFO: enter 'restricted' command line mode
[14:01:56.072] <TB3> INFO: enter test to run
[14:01:56.072] <TB3> INFO: test: PixelAlive no parameter change
[14:01:56.072] <TB3> INFO: running: pixelalive
[14:01:56.076] <TB3> INFO: ######################################################################
[14:01:56.076] <TB3> INFO: PixTestAlive::doTest()
[14:01:56.076] <TB3> INFO: ######################################################################
[14:01:56.078] <TB3> INFO: ----------------------------------------------------------------------
[14:01:56.078] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:01:56.078] <TB3> INFO: ----------------------------------------------------------------------
[14:01:56.418] <TB3> INFO: Expecting 208000 events.
[14:02:07.567] <TB3> INFO: 208000 events read in total (10431ms).
[14:02:07.662] <TB3> INFO: Test took 11583ms.
[14:02:07.673] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:02:07.940] <TB3> INFO: PixTestAlive::aliveTest() done
[14:02:07.940] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 1 1 0 0 0 0 0 0
[14:02:07.942] <TB3> INFO: ----------------------------------------------------------------------
[14:02:07.942] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:02:07.942] <TB3> INFO: ----------------------------------------------------------------------
[14:02:08.286] <TB3> INFO: Expecting 208000 events.
[14:02:15.044] <TB3> INFO: 208000 events read in total (6043ms).
[14:02:15.044] <TB3> INFO: Test took 7100ms.
[14:02:15.044] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:02:15.045] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:02:15.442] <TB3> INFO: PixTestAlive::maskTest() done
[14:02:15.442] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:02:15.444] <TB3> INFO: ----------------------------------------------------------------------
[14:02:15.444] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:02:15.444] <TB3> INFO: ----------------------------------------------------------------------
[14:02:15.756] <TB3> INFO: Expecting 208000 events.
[14:02:26.931] <TB3> INFO: 208000 events read in total (10460ms).
[14:02:26.931] <TB3> INFO: Test took 11485ms.
[14:02:26.937] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:02:27.262] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:02:27.262] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:02:27.263] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[14:02:27.299] <TB3> INFO: enter test to run
[14:02:27.299] <TB3> INFO: test: delay setting parameters: ->2<-
[14:02:27.299] <TB3> INFO: delay test by 2 seconds...
[14:02:29.299] <TB3> INFO: enter test to run
[14:02:29.299] <TB3> INFO: test: HighRate no parameter change
[14:02:29.299] <TB3> INFO: running: highrate
[14:02:29.299] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//014_HREfficiency_150//phCalibrationFitErr35_C15.dat
[14:02:29.438] <TB3> INFO: ----------------------------------------------------------------------
[14:02:29.438] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:02:29.438] <TB3> INFO: ----------------------------------------------------------------------
[14:02:30.047] <TB3> INFO: Expecting 208000 events.
[14:02:45.355] <TB3> INFO: 208000 events read in total (14782ms).
[14:02:45.363] <TB3> INFO: Test took 15922ms.
[14:02:45.814] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:02:46.158] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 0 0 0 0 0 0 0 0
[14:02:46.159] <TB3> INFO: number of red-efficiency pixels: 267 228 320 667 749 877 818 890 846 854 1218 1006 749 1582 349 266
[14:02:46.159] <TB3> INFO: number of X-ray hits detected: 151445 162713 143830 252532 265953 320090 308122 317364 330110 314971 333834 304644 271092 168701 184628 160221
[14:02:46.159] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:02:46.159] <TB3> INFO: number of Vcal hits detected: 207627 207764 207645 207211 207099 206894 207035 206964 206969 206946 206441 206747 207117 205925 207634 207721
[14:02:46.159] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.6 99.6 99.6 99.5 99.5 99.5 99.3 99.5 99.6 99.0 99.8 99.9
[14:02:46.159] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.8 99.6 99.6 99.5 99.5 99.5 99.5 99.5 99.3 99.4 99.6 99.0 99.8 99.9
[14:02:46.159] <TB3> INFO: X-ray hit rate [MHz/cm2]: 44.4 47.7 42.2 74.0 78.0 93.8 90.3 93.0 96.8 92.3 97.8 89.3 79.5 49.4 54.1 47.0
[14:02:46.159] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:02:46.186] <TB3> INFO: PixTest:: pg_setup set to default.
[14:02:46.195] <TB3> INFO: enter test to run
[14:02:46.195] <TB3> INFO: test: no parameter change
[14:02:46.295] <TB3> QUIET: Connection to board 121 closed.
[14:02:46.374] <TB3> INFO: pXar: this is the end, my friend

[14:03:25.236] <TB3> INFO: *** Welcome to pxar ***
[14:03:25.236] <TB3> INFO: *** Today: 2015/11/23
[14:03:25.498] <TB3> INFO: *** Version: 206d-dirty
[14:03:25.498] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//dacParameters35_C15.dat
[14:03:25.498] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//tbmParameters_C0b.dat
[14:03:25.498] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//defaultMaskFile.dat
[14:03:25.498] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//trimParameters35_C15.dat
[14:03:25.574] <TB3> INFO: clk: 4
[14:03:25.574] <TB3> INFO: ctr: 4
[14:03:25.574] <TB3> INFO: sda: 19
[14:03:25.574] <TB3> INFO: tin: 9
[14:03:25.574] <TB3> INFO: level: 15
[14:03:25.574] <TB3> INFO: triggerdelay: 0
[14:03:25.574] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[14:03:25.574] <TB3> INFO: Log level: INFO
[14:03:25.586] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:03:25.600] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:03:25.604] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:03:25.606] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[14:03:27.154] <TB3> INFO: DUT info:
[14:03:27.154] <TB3> INFO: The DUT currently contains the following objects:
[14:03:27.154] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[14:03:27.154] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:03:27.154] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:03:27.154] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:03:27.154] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.154] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:03:27.555] <TB3> INFO: enter 'restricted' command line mode
[14:03:27.555] <TB3> INFO: enter test to run
[14:03:27.555] <TB3> INFO: test: PixelAlive no parameter change
[14:03:27.555] <TB3> INFO: running: pixelalive
[14:03:27.560] <TB3> INFO: ######################################################################
[14:03:27.560] <TB3> INFO: PixTestAlive::doTest()
[14:03:27.560] <TB3> INFO: ######################################################################
[14:03:27.562] <TB3> INFO: ----------------------------------------------------------------------
[14:03:27.562] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:03:27.562] <TB3> INFO: ----------------------------------------------------------------------
[14:03:27.882] <TB3> INFO: Expecting 208000 events.
[14:03:38.591] <TB3> INFO: 208000 events read in total (9992ms).
[14:03:38.703] <TB3> INFO: Test took 11140ms.
[14:03:38.717] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:03:38.969] <TB3> INFO: PixTestAlive::aliveTest() done
[14:03:38.969] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 1 1 0 0 0 0 0 0
[14:03:38.971] <TB3> INFO: ----------------------------------------------------------------------
[14:03:38.971] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:03:38.971] <TB3> INFO: ----------------------------------------------------------------------
[14:03:39.301] <TB3> INFO: Expecting 208000 events.
[14:03:45.789] <TB3> INFO: 208000 events read in total (5773ms).
[14:03:45.789] <TB3> INFO: Test took 6817ms.
[14:03:45.789] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:03:45.790] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:03:46.196] <TB3> INFO: PixTestAlive::maskTest() done
[14:03:46.196] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:03:46.198] <TB3> INFO: ----------------------------------------------------------------------
[14:03:46.198] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:03:46.198] <TB3> INFO: ----------------------------------------------------------------------
[14:03:46.527] <TB3> INFO: Expecting 208000 events.
[14:03:57.742] <TB3> INFO: 208000 events read in total (10500ms).
[14:03:57.743] <TB3> INFO: Test took 11543ms.
[14:03:57.753] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:03:58.062] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:03:58.062] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:03:58.062] <TB3> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[14:03:58.106] <TB3> INFO: enter test to run
[14:03:58.106] <TB3> INFO: test: delay setting parameters: ->2<-
[14:03:58.106] <TB3> INFO: delay test by 2 seconds...
[14:04:00.106] <TB3> INFO: enter test to run
[14:04:00.106] <TB3> INFO: test: HighRate no parameter change
[14:04:00.106] <TB3> INFO: running: highrate
[14:04:00.107] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//015_HREfficiency_200//phCalibrationFitErr35_C15.dat
[14:04:00.246] <TB3> INFO: ----------------------------------------------------------------------
[14:04:00.246] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:04:00.246] <TB3> INFO: ----------------------------------------------------------------------
[14:04:00.848] <TB3> INFO: Expecting 208000 events.
[14:04:18.687] <TB3> INFO: 208000 events read in total (17313ms).
[14:04:18.698] <TB3> INFO: Test took 18449ms.
[14:04:19.338] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:04:19.730] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 0 0 0 0 0 0 0 0
[14:04:19.730] <TB3> INFO: number of red-efficiency pixels: 458 471 576 1257 1419 1666 1526 1753 1731 1621 2243 1862 1563 1803 694 466
[14:04:19.730] <TB3> INFO: number of X-ray hits detected: 211835 228276 201304 352045 367327 443306 427063 440404 460331 436510 462998 421223 375950 234439 258058 224215
[14:04:19.730] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:04:19.730] <TB3> INFO: number of Vcal hits detected: 207397 207498 207275 206349 205962 205511 205751 205562 205446 205623 204327 205107 205906 205389 207215 207511
[14:04:19.730] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.3 99.2 99.0 99.1 98.9 98.9 99.0 98.4 98.8 99.1 98.8 99.6 99.8
[14:04:19.730] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.8 99.7 99.2 99.0 98.8 98.9 98.8 98.8 98.9 98.2 98.6 99.0 98.7 99.6 99.8
[14:04:19.730] <TB3> INFO: X-ray hit rate [MHz/cm2]: 62.1 66.9 59.0 103.2 107.7 129.9 125.2 129.1 134.9 127.9 135.7 123.5 110.2 68.7 75.6 65.7
[14:04:19.730] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:04:19.756] <TB3> INFO: PixTest:: pg_setup set to default.
[14:04:19.766] <TB3> INFO: enter test to run
[14:04:19.766] <TB3> INFO: test: no parameter change
[14:04:19.836] <TB3> QUIET: Connection to board 121 closed.
[14:04:19.915] <TB3> INFO: pXar: this is the end, my friend

[14:05:04.180] <TB3> INFO: *** Welcome to pxar ***
[14:05:04.180] <TB3> INFO: *** Today: 2015/11/23
[14:05:04.854] <TB3> INFO: *** Version: 206d-dirty
[14:05:04.854] <TB3> INFO: readRocDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//dacParameters35_C15.dat
[14:05:04.855] <TB3> INFO: readTbmDacs: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//tbmParameters_C0b.dat
[14:05:04.855] <TB3> INFO: readMaskFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//defaultMaskFile.dat
[14:05:04.855] <TB3> INFO: readTrimFile: /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//trimParameters35_C15.dat
[14:05:04.950] <TB3> INFO: clk: 4
[14:05:04.950] <TB3> INFO: ctr: 4
[14:05:04.950] <TB3> INFO: sda: 19
[14:05:04.950] <TB3> INFO: tin: 9
[14:05:04.950] <TB3> INFO: level: 15
[14:05:04.950] <TB3> INFO: triggerdelay: 0
[14:05:04.951] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[14:05:04.951] <TB3> INFO: Log level: INFO
[14:05:04.964] <TB3> INFO: Found DTB DTB_WWV6Z5
[14:05:04.978] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[14:05:04.982] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[14:05:04.984] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[14:05:06.552] <TB3> INFO: DUT info:
[14:05:06.552] <TB3> INFO: The DUT currently contains the following objects:
[14:05:06.552] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[14:05:06.552] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:05:06.552] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:05:06.552] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:05:06.552] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.553] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:05:06.954] <TB3> INFO: enter 'restricted' command line mode
[14:05:06.954] <TB3> INFO: enter test to run
[14:05:06.954] <TB3> INFO: test: PixelAlive no parameter change
[14:05:06.954] <TB3> INFO: running: pixelalive
[14:05:06.958] <TB3> INFO: ######################################################################
[14:05:06.958] <TB3> INFO: PixTestAlive::doTest()
[14:05:06.958] <TB3> INFO: ######################################################################
[14:05:06.960] <TB3> INFO: ----------------------------------------------------------------------
[14:05:06.960] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:05:06.960] <TB3> INFO: ----------------------------------------------------------------------
[14:05:07.295] <TB3> INFO: Expecting 208000 events.
[14:05:18.361] <TB3> INFO: 208000 events read in total (10349ms).
[14:05:18.463] <TB3> INFO: Test took 11502ms.
[14:05:18.475] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:05:18.738] <TB3> INFO: PixTestAlive::aliveTest() done
[14:05:18.738] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 1 1 0 0 0 0 0 0
[14:05:18.739] <TB3> INFO: ----------------------------------------------------------------------
[14:05:18.739] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:05:18.739] <TB3> INFO: ----------------------------------------------------------------------
[14:05:19.074] <TB3> INFO: Expecting 208000 events.
[14:05:25.471] <TB3> INFO: 208000 events read in total (5682ms).
[14:05:25.471] <TB3> INFO: Test took 6730ms.
[14:05:25.471] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:05:25.471] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:05:25.877] <TB3> INFO: PixTestAlive::maskTest() done
[14:05:25.878] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:05:25.879] <TB3> INFO: ----------------------------------------------------------------------
[14:05:25.879] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:05:25.879] <TB3> INFO: ----------------------------------------------------------------------
[14:05:26.207] <TB3> INFO: Expecting 208000 events.
[14:05:36.923] <TB3> INFO: 208000 events read in total (10001ms).
[14:05:36.923] <TB3> INFO: Test took 11043ms.
[14:05:36.932] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:05:37.256] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:05:37.256] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:05:37.256] <TB3> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[14:05:37.294] <TB3> INFO: enter test to run
[14:05:37.294] <TB3> INFO: test: delay setting parameters: ->2<-
[14:05:37.294] <TB3> INFO: delay test by 2 seconds...
[14:05:39.294] <TB3> INFO: enter test to run
[14:05:39.294] <TB3> INFO: test: HighRate no parameter change
[14:05:39.294] <TB3> INFO: running: highrate
[14:05:39.294] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4570_XrayQualification_2015-11-23_13h32m_1448281936//016_HREfficiency_250//phCalibrationFitErr35_C15.dat
[14:05:39.439] <TB3> INFO: ----------------------------------------------------------------------
[14:05:39.439] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:05:39.439] <TB3> INFO: ----------------------------------------------------------------------
[14:05:40.045] <TB3> INFO: Expecting 208000 events.
[14:06:00.108] <TB3> INFO: 208000 events read in total (19536ms).
[14:06:00.121] <TB3> INFO: Test took 20678ms.
[14:06:00.867] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:06:01.308] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 1 1 0 0 0 0 0 0 0 0 0 0
[14:06:01.308] <TB3> INFO: number of red-efficiency pixels: 721 663 844 1948 2155 2428 2295 2557 2577 2350 3020 2710 2250 2014 1171 661
[14:06:01.308] <TB3> INFO: number of X-ray hits detected: 261463 283043 249695 434735 454896 551067 528874 546155 569542 542964 572519 524474 465915 290902 319667 278725
[14:06:01.308] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:06:01.308] <TB3> INFO: number of Vcal hits detected: 207094 207250 206751 204928 204298 203409 203819 203484 203293 203493 201256 202554 204275 204675 206594 207262
[14:06:01.308] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.5 98.7 98.4 98.1 98.3 98.0 97.9 98.1 97.1 97.7 98.4 98.5 99.4 99.7
[14:06:01.308] <TB3> INFO: Vcal hit overall efficiency (%): 99.6 99.6 99.4 98.5 98.2 97.8 98.0 97.8 97.7 97.8 96.8 97.4 98.2 98.4 99.3 99.6
[14:06:01.308] <TB3> INFO: X-ray hit rate [MHz/cm2]: 76.6 83.0 73.2 127.4 133.3 161.5 155.0 160.1 166.9 159.1 167.8 153.7 136.6 85.3 93.7 81.7
[14:06:01.308] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[14:06:01.334] <TB3> INFO: PixTest:: pg_setup set to default.
[14:06:01.349] <TB3> INFO: enter test to run
[14:06:01.350] <TB3> INFO: test: no parameter change
[14:06:01.426] <TB3> QUIET: Connection to board 121 closed.
[14:06:01.506] <TB3> INFO: pXar: this is the end, my friend