[10:15:02.140] <TB1> INFO: *** Welcome to pxar ***
[10:15:02.140] <TB1> INFO: *** Today: 2015/11/23
[10:15:02.227] <TB1> INFO: *** Version: 206d-dirty
[10:15:02.227] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//dacParameters35_C15.dat
[10:15:02.228] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//tbmParameters_C0b.dat
[10:15:02.228] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//defaultMaskFile.dat
[10:15:02.228] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//trimParameters35_C15.dat
[10:15:02.301] <TB1> INFO: clk: 4
[10:15:02.301] <TB1> INFO: ctr: 4
[10:15:02.301] <TB1> INFO: sda: 19
[10:15:02.301] <TB1> INFO: tin: 9
[10:15:02.301] <TB1> INFO: level: 15
[10:15:02.301] <TB1> INFO: triggerdelay: 0
[10:15:02.301] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:15:02.301] <TB1> INFO: Log level: INFO
[10:15:02.315] <TB1> INFO: Found DTB DTB_WWXTQT
[10:15:02.330] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[10:15:02.333] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[10:15:02.335] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[10:15:03.881] <TB1> INFO: DUT info:
[10:15:03.881] <TB1> INFO: The DUT currently contains the following objects:
[10:15:03.881] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[10:15:03.881] <TB1> INFO: TBM Core alpha (0): 7 registers set
[10:15:03.881] <TB1> INFO: TBM Core beta (1): 7 registers set
[10:15:03.881] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:15:03.881] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.881] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.882] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.882] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.882] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.882] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:03.882] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:04.283] <TB1> INFO: enter 'restricted' command line mode
[10:15:04.283] <TB1> INFO: enter test to run
[10:15:04.283] <TB1> INFO: test: PixelAlive no parameter change
[10:15:04.283] <TB1> INFO: running: pixelalive
[10:15:04.290] <TB1> INFO: ######################################################################
[10:15:04.290] <TB1> INFO: PixTestAlive::doTest()
[10:15:04.290] <TB1> INFO: ######################################################################
[10:15:04.292] <TB1> INFO: ----------------------------------------------------------------------
[10:15:04.292] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:15:04.292] <TB1> INFO: ----------------------------------------------------------------------
[10:15:04.605] <TB1> INFO: Expecting 41600 events.
































































































































































































































































































































































































































[10:15:10.276] <TB1> INFO: 140 events read in total (4953ms).

[10:15:10.761] <TB1> INFO: Expecting 41600 events.
















[10:15:15.150] <TB1> INFO: 41600 events read in total (3674ms).
[10:15:15.151] <TB1> INFO: Test took 4686ms.
[10:15:15.157] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:15:15.534] <TB1> INFO: PixTestAlive::aliveTest() done
[10:15:15.534] <TB1> INFO: number of dead pixels (per ROC): 3 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0
[10:15:15.536] <TB1> INFO: ----------------------------------------------------------------------
[10:15:15.536] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:15:15.536] <TB1> INFO: ----------------------------------------------------------------------
[10:15:15.852] <TB1> INFO: Expecting 41600 events.
[10:15:18.979] <TB1> INFO: 41600 events read in total (2412ms).
[10:15:18.980] <TB1> INFO: Test took 3443ms.
[10:15:18.980] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:15:18.980] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:15:19.391] <TB1> INFO: PixTestAlive::maskTest() done
[10:15:19.391] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:15:19.392] <TB1> INFO: ----------------------------------------------------------------------
[10:15:19.392] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:15:19.392] <TB1> INFO: ----------------------------------------------------------------------
[10:15:19.737] <TB1> INFO: Expecting 41600 events.
[10:15:24.031] <TB1> INFO: 41600 events read in total (3579ms).
[10:15:24.032] <TB1> INFO: Test took 4638ms.
[10:15:24.040] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:15:24.421] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[10:15:24.421] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:15:24.421] <TB1> INFO: PixTestAlive::doTest() done, duration: 20 seconds
[10:15:24.480] <TB1> INFO: enter test to run
[10:15:24.480] <TB1> INFO: test: no parameter change
[10:15:24.541] <TB1> QUIET: Connection to board 147 closed.
[10:15:24.621] <TB1> INFO: pXar: this is the end, my friend

[10:20:19.396] <TB1> INFO: *** Welcome to pxar ***
[10:20:19.396] <TB1> INFO: *** Today: 2015/11/23
[10:20:19.491] <TB1> INFO: *** Version: 206d-dirty
[10:20:19.491] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//dacParameters35_C15.dat
[10:20:19.492] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[10:20:19.492] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//defaultMaskFile.dat
[10:20:19.492] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C15.dat
[10:20:19.569] <TB1> INFO: clk: 4
[10:20:19.569] <TB1> INFO: ctr: 4
[10:20:19.569] <TB1> INFO: sda: 19
[10:20:19.569] <TB1> INFO: tin: 9
[10:20:19.569] <TB1> INFO: level: 15
[10:20:19.569] <TB1> INFO: triggerdelay: 0
[10:20:19.569] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:20:19.569] <TB1> INFO: Log level: INFO
[10:20:19.582] <TB1> INFO: Found DTB DTB_WWXTQT
[10:20:19.597] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[10:20:19.600] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[10:20:19.602] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[10:20:21.150] <TB1> INFO: DUT info:
[10:20:21.150] <TB1> INFO: The DUT currently contains the following objects:
[10:20:21.150] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[10:20:21.151] <TB1> INFO: TBM Core alpha (0): 7 registers set
[10:20:21.151] <TB1> INFO: TBM Core beta (1): 7 registers set
[10:20:21.151] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:20:21.151] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.151] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:21.552] <TB1> INFO: enter 'restricted' command line mode
[10:20:21.552] <TB1> INFO: enter test to run
[10:20:21.552] <TB1> INFO: test: delay setting parameters: ->5<-
[10:20:21.552] <TB1> INFO: delay test by 5 seconds...
[10:20:26.552] <TB1> INFO: enter test to run
[10:20:26.552] <TB1> INFO: test: highrate no parameter change
[10:20:26.552] <TB1> INFO: running: highrate
[10:20:26.558] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[10:20:26.741] <TB1> INFO: ----------------------------------------------------------------------
[10:20:26.741] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[10:20:26.741] <TB1> INFO: ----------------------------------------------------------------------
[10:20:26.741] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[10:20:26.741] <TB1> INFO: edge/corner pixel THR is adjusted
[10:20:26.741] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[10:20:27.700] <TB1> INFO: Collecting data for 1 seconds...
[10:20:28.702] <TB1> INFO: Done with hot pixel readout
[10:20:34.352] <TB1> INFO: PixTest:: pg_setup set to default.
[10:20:34.353] <TB1> INFO: 8 hot pixels found in step 0
[10:20:35.387] <TB1> INFO: Collecting data for 1 seconds...
[10:20:36.390] <TB1> INFO: Done with hot pixel readout
[10:20:42.592] <TB1> INFO: PixTest:: pg_setup set to default.
[10:20:42.593] <TB1> INFO: 7 hot pixels found in step 1
[10:20:43.631] <TB1> INFO: Collecting data for 1 seconds...
[10:20:44.634] <TB1> INFO: Done with hot pixel readout
[10:20:49.212] <TB1> INFO: PixTest:: pg_setup set to default.
[10:20:49.213] <TB1> INFO: 4 hot pixels found in step 2
[10:20:50.227] <TB1> INFO: Collecting data for 1 seconds...
[10:20:51.230] <TB1> INFO: Done with hot pixel readout
[10:20:55.910] <TB1> INFO: PixTest:: pg_setup set to default.
[10:20:55.911] <TB1> INFO: 1 hot pixels found in step 3
[10:20:56.950] <TB1> INFO: Collecting data for 1 seconds...
[10:20:57.953] <TB1> INFO: Done with hot pixel readout
[10:21:02.408] <TB1> INFO: PixTest:: pg_setup set to default.
[10:21:02.409] <TB1> INFO: 0 hot pixels found in step 4
[10:21:02.415] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[10:21:02.493] <TB1> INFO: PixTest::trimHotPixels() done
[10:21:02.494] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C0.dat
[10:21:02.504] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C1.dat
[10:21:02.510] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C2.dat
[10:21:02.516] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C3.dat
[10:21:02.522] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C4.dat
[10:21:02.527] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C5.dat
[10:21:02.533] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C6.dat
[10:21:02.539] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C7.dat
[10:21:02.545] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C8.dat
[10:21:02.551] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C9.dat
[10:21:02.556] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C10.dat
[10:21:02.562] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C11.dat
[10:21:02.568] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C12.dat
[10:21:02.574] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C13.dat
[10:21:02.579] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C14.dat
[10:21:02.585] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C15.dat
[10:21:02.591] <TB1> INFO: write masked pixels into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//defaultMaskFile.dat
[10:21:02.622] <TB1> INFO: enter test to run
[10:21:02.622] <TB1> INFO: test: no parameter change
[10:21:02.726] <TB1> QUIET: Connection to board 147 closed.
[10:21:02.807] <TB1> INFO: pXar: this is the end, my friend

[10:21:24.606] <TB1> INFO: *** Welcome to pxar ***
[10:21:24.606] <TB1> INFO: *** Today: 2015/11/23
[10:21:24.664] <TB1> INFO: *** Version: 206d-dirty
[10:21:24.664] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//dacParameters35_C15.dat
[10:21:24.664] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0b.dat
[10:21:24.665] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[10:21:24.665] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[10:21:24.738] <TB1> INFO: clk: 4
[10:21:24.738] <TB1> INFO: ctr: 4
[10:21:24.738] <TB1> INFO: sda: 19
[10:21:24.738] <TB1> INFO: tin: 9
[10:21:24.738] <TB1> INFO: level: 15
[10:21:24.738] <TB1> INFO: triggerdelay: 0
[10:21:24.738] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:21:24.738] <TB1> INFO: Log level: INFO
[10:21:24.751] <TB1> INFO: Found DTB DTB_WWXTQT
[10:21:24.767] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[10:21:24.771] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[10:21:24.773] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[10:21:26.326] <TB1> INFO: DUT info:
[10:21:26.326] <TB1> INFO: The DUT currently contains the following objects:
[10:21:26.326] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[10:21:26.326] <TB1> INFO: TBM Core alpha (0): 7 registers set
[10:21:26.326] <TB1> INFO: TBM Core beta (1): 7 registers set
[10:21:26.326] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:21:26.326] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.326] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:26.727] <TB1> INFO: enter 'restricted' command line mode
[10:21:26.727] <TB1> INFO: enter test to run
[10:21:26.728] <TB1> INFO: test: delay setting parameters: ->5<-
[10:21:26.728] <TB1> INFO: delay test by 5 seconds...
[10:21:31.728] <TB1> INFO: enter test to run
[10:21:31.728] <TB1> INFO: test: highrate no parameter change
[10:21:31.728] <TB1> INFO: running: highrate
[10:21:31.732] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C15.dat
[10:21:31.876] <TB1> INFO: ----------------------------------------------------------------------
[10:21:31.876] <TB1> INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[10:21:31.876] <TB1> INFO: ----------------------------------------------------------------------
[10:21:31.876] <TB1> INFO: THR = 10, corresponding to ~ 5.33333 MHz/cm2
[10:21:31.876] <TB1> INFO: edge/corner pixel THR is adjusted
[10:21:31.876] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[10:21:32.834] <TB1> INFO: Collecting data for 5 seconds...
[10:21:37.847] <TB1> INFO: Done with hot pixel readout
[10:21:46.711] <TB1> INFO: PixTest:: pg_setup set to default.
[10:21:46.712] <TB1> INFO: 2 hot pixels found in step 0
[10:21:47.845] <TB1> INFO: Collecting data for 5 seconds...
[10:21:52.856] <TB1> INFO: Done with hot pixel readout
[10:22:02.112] <TB1> INFO: PixTest:: pg_setup set to default.
[10:22:02.113] <TB1> INFO: 0 hot pixels found in step 1
[10:22:02.115] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[10:22:02.291] <TB1> INFO: PixTest::trimHotPixels() done
[10:22:02.292] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat
[10:22:02.303] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C1.dat
[10:22:02.312] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C2.dat
[10:22:02.320] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C3.dat
[10:22:02.329] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C4.dat
[10:22:02.338] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C5.dat
[10:22:02.347] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C6.dat
[10:22:02.356] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C7.dat
[10:22:02.365] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C8.dat
[10:22:02.374] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C9.dat
[10:22:02.381] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C10.dat
[10:22:02.388] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C11.dat
[10:22:02.396] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C12.dat
[10:22:02.405] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C13.dat
[10:22:02.413] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C14.dat
[10:22:02.422] <TB1> INFO: write trim parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[10:22:02.431] <TB1> INFO: write masked pixels into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[10:22:02.463] <TB1> INFO: enter test to run
[10:22:02.463] <TB1> INFO: test: no parameter change
[10:22:02.592] <TB1> QUIET: Connection to board 147 closed.
[10:22:02.672] <TB1> INFO: pXar: this is the end, my friend

[10:22:48.675] <TB1> INFO: *** Welcome to pxar ***
[10:22:48.675] <TB1> INFO: *** Today: 2015/11/23
[10:22:48.782] <TB1> INFO: *** Version: 206d-dirty
[10:22:48.782] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//dacParameters35_C15.dat
[10:22:48.783] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//tbmParameters_C0b.dat
[10:22:48.783] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//defaultMaskFile.dat
[10:22:48.783] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//trimParameters35_C15.dat
[10:22:48.858] <TB1> INFO: clk: 4
[10:22:48.858] <TB1> INFO: ctr: 4
[10:22:48.858] <TB1> INFO: sda: 19
[10:22:48.858] <TB1> INFO: tin: 9
[10:22:48.858] <TB1> INFO: level: 15
[10:22:48.858] <TB1> INFO: triggerdelay: 0
[10:22:48.858] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:22:48.858] <TB1> INFO: Log level: INFO
[10:22:48.870] <TB1> INFO: Found DTB DTB_WWXTQT
[10:22:48.886] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[10:22:48.889] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[10:22:48.891] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[10:22:50.451] <TB1> INFO: DUT info:
[10:22:50.451] <TB1> INFO: The DUT currently contains the following objects:
[10:22:50.451] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[10:22:50.451] <TB1> INFO: TBM Core alpha (0): 7 registers set
[10:22:50.451] <TB1> INFO: TBM Core beta (1): 7 registers set
[10:22:50.451] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:22:50.451] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.451] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.451] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.452] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:50.853] <TB1> INFO: enter 'restricted' command line mode
[10:22:50.853] <TB1> INFO: enter test to run
[10:22:50.853] <TB1> INFO: test: delay setting parameters: ->5<-
[10:22:50.853] <TB1> INFO: delay test by 5 seconds...
[10:22:55.854] <TB1> INFO: enter test to run
[10:22:55.854] <TB1> INFO: test: Xray no parameter change
[10:22:55.854] <TB1> INFO: running: xray
[10:22:55.860] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//phCalibrationFitErr35_C15.dat
[10:22:55.992] <TB1> INFO: ######################################################################
[10:22:55.992] <TB1> INFO: PixTestXray::doTest()
[10:22:55.992] <TB1> INFO: ######################################################################
[10:22:55.992] <TB1> INFO: ----------------------------------------------------------------------
[10:22:55.992] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[10:22:55.992] <TB1> INFO: ----------------------------------------------------------------------
[10:22:56.956] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[10:23:07.567] <TB1> INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[10:23:39.738] <TB1> INFO: Resuming triggers.
[10:23:50.347] <TB1> INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[10:24:23.782] <TB1> INFO: Resuming triggers.
[10:24:34.403] <TB1> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[10:25:09.020] <TB1> INFO: Resuming triggers.
[10:25:19.631] <TB1> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[10:25:53.587] <TB1> INFO: Resuming triggers.
[10:26:04.204] <TB1> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[10:26:38.538] <TB1> INFO: Resuming triggers.
[10:26:49.152] <TB1> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[10:27:22.993] <TB1> INFO: Resuming triggers.
[10:27:33.604] <TB1> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[10:28:08.152] <TB1> INFO: Resuming triggers.
[10:28:18.747] <TB1> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[10:28:53.099] <TB1> INFO: Resuming triggers.
[10:29:03.708] <TB1> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[10:29:29.872] <TB1> INFO: Resuming triggers.
[10:29:34.612] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[10:29:44.869] <TB1> INFO: PixTest:: pg_setup set to default.
[10:29:44.871] <TB1> INFO: PixTestXray::doPhRun() done
[10:29:44.871] <TB1> INFO: PixTestXray::doTest() done
[10:29:45.035] <TB1> INFO: enter test to run
[10:29:45.035] <TB1> INFO: test: no parameter change
[10:29:45.128] <TB1> QUIET: Connection to board 147 closed.
[10:29:45.208] <TB1> INFO: pXar: this is the end, my friend

[10:30:01.008] <TB1> INFO: *** Welcome to pxar ***
[10:30:01.008] <TB1> INFO: *** Today: 2015/11/23
[10:30:01.119] <TB1> INFO: *** Version: 206d-dirty
[10:30:01.119] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//dacParameters35_C15.dat
[10:30:01.120] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//tbmParameters_C0b.dat
[10:30:01.120] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//defaultMaskFile.dat
[10:30:01.120] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//trimParameters35_C15.dat
[10:30:01.218] <TB1> INFO: clk: 4
[10:30:01.218] <TB1> INFO: ctr: 4
[10:30:01.218] <TB1> INFO: sda: 19
[10:30:01.218] <TB1> INFO: tin: 9
[10:30:01.218] <TB1> INFO: level: 15
[10:30:01.218] <TB1> INFO: triggerdelay: 0
[10:30:01.218] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:30:01.218] <TB1> INFO: Log level: INFO
[10:30:01.231] <TB1> INFO: Found DTB DTB_WWXTQT
[10:30:01.246] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[10:30:01.249] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[10:30:01.252] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[10:30:02.824] <TB1> INFO: DUT info:
[10:30:02.824] <TB1> INFO: The DUT currently contains the following objects:
[10:30:02.824] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[10:30:02.824] <TB1> INFO: TBM Core alpha (0): 7 registers set
[10:30:02.824] <TB1> INFO: TBM Core beta (1): 7 registers set
[10:30:02.824] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:30:02.824] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:02.824] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:03.225] <TB1> INFO: enter 'restricted' command line mode
[10:30:03.225] <TB1> INFO: enter test to run
[10:30:03.226] <TB1> INFO: test: delay setting parameters: ->5<-
[10:30:03.226] <TB1> INFO: delay test by 5 seconds...
[10:30:08.226] <TB1> INFO: enter test to run
[10:30:08.226] <TB1> INFO: test: Xray no parameter change
[10:30:08.226] <TB1> INFO: running: xray
[10:30:08.230] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//phCalibrationFitErr35_C15.dat
[10:30:08.471] <TB1> INFO: ######################################################################
[10:30:08.472] <TB1> INFO: PixTestXray::doTest()
[10:30:08.472] <TB1> INFO: ######################################################################
[10:30:08.472] <TB1> INFO: ----------------------------------------------------------------------
[10:30:08.472] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[10:30:08.472] <TB1> INFO: ----------------------------------------------------------------------
[10:30:09.438] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[10:30:15.117] <TB1> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[10:30:51.070] <TB1> INFO: Resuming triggers.
[10:30:56.754] <TB1> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[10:31:33.888] <TB1> INFO: Resuming triggers.
[10:31:39.569] <TB1> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[10:32:16.400] <TB1> INFO: Resuming triggers.
[10:32:22.083] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[10:32:59.093] <TB1> INFO: Resuming triggers.
[10:33:04.778] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[10:33:41.835] <TB1> INFO: Resuming triggers.
[10:33:47.515] <TB1> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[10:34:24.862] <TB1> INFO: Resuming triggers.
[10:34:30.547] <TB1> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[10:35:06.978] <TB1> INFO: Resuming triggers.
[10:35:12.657] <TB1> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[10:35:49.797] <TB1> INFO: Resuming triggers.
[10:35:55.482] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.









[10:36:31.983] <TB1> INFO: Resuming triggers.
[10:36:37.666] <TB1> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[10:37:16.664] <TB1> INFO: Resuming triggers.
[10:37:22.347] <TB1> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[10:38:00.295] <TB1> INFO: Resuming triggers.
[10:38:05.976] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[10:38:43.349] <TB1> INFO: Resuming triggers.
[10:38:49.031] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[10:39:26.415] <TB1> INFO: Resuming triggers.
[10:39:32.093] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[10:40:08.291] <TB1> INFO: Resuming triggers.
[10:40:13.970] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[10:40:41.074] <TB1> INFO: Resuming triggers.
[10:40:46.751] <TB1> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[10:41:11.102] <TB1> INFO: Resuming triggers.
[10:41:16.786] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[10:41:40.888] <TB1> INFO: Resuming triggers.
[10:41:44.524] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[10:42:00.296] <TB1> INFO: PixTest:: pg_setup set to default.
[10:42:00.297] <TB1> INFO: PixTestXray::doPhRun() done
[10:42:00.297] <TB1> INFO: PixTestXray::doTest() done
[10:42:00.480] <TB1> INFO: enter test to run
[10:42:00.480] <TB1> INFO: test: no parameter change
[10:42:00.614] <TB1> QUIET: Connection to board 147 closed.
[10:42:00.696] <TB1> INFO: pXar: this is the end, my friend

[10:42:14.970] <TB1> INFO: *** Welcome to pxar ***
[10:42:14.970] <TB1> INFO: *** Today: 2015/11/23
[10:42:15.027] <TB1> INFO: *** Version: 206d-dirty
[10:42:15.027] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//dacParameters35_C15.dat
[10:42:15.028] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//tbmParameters_C0b.dat
[10:42:15.028] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//defaultMaskFile.dat
[10:42:15.028] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//trimParameters35_C15.dat
[10:42:15.119] <TB1> INFO: clk: 4
[10:42:15.119] <TB1> INFO: ctr: 4
[10:42:15.119] <TB1> INFO: sda: 19
[10:42:15.119] <TB1> INFO: tin: 9
[10:42:15.119] <TB1> INFO: level: 15
[10:42:15.119] <TB1> INFO: triggerdelay: 0
[10:42:15.119] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:42:15.119] <TB1> INFO: Log level: INFO
[10:42:15.133] <TB1> INFO: Found DTB DTB_WWXTQT
[10:42:15.147] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[10:42:15.151] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[10:42:15.153] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[10:42:16.702] <TB1> INFO: DUT info:
[10:42:16.702] <TB1> INFO: The DUT currently contains the following objects:
[10:42:16.702] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[10:42:16.702] <TB1> INFO: TBM Core alpha (0): 7 registers set
[10:42:16.702] <TB1> INFO: TBM Core beta (1): 7 registers set
[10:42:16.702] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:42:16.702] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.702] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:16.703] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:17.104] <TB1> INFO: enter 'restricted' command line mode
[10:42:17.104] <TB1> INFO: enter test to run
[10:42:17.104] <TB1> INFO: test: Highrate no parameter change
[10:42:17.104] <TB1> INFO: running: highrate
[10:42:17.108] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[10:42:17.243] <TB1> INFO: ----------------------------------------------------------------------
[10:42:17.243] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[10:42:17.243] <TB1> INFO: ----------------------------------------------------------------------
[10:42:17.247] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[10:42:17.259] <TB1> INFO: dacScan step from 15 .. 34
[10:42:17.259] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[10:42:17.259] <TB1> INFO: run 1 of 1
[10:42:17.855] <TB1> INFO: Expecting 4160000 events.
[10:43:02.498] <TB1> INFO: 742900 events read in total (44114ms).
[10:43:45.362] <TB1> INFO: 1487050 events read in total (86978ms).
[10:44:27.789] <TB1> INFO: 2230850 events read in total (129405ms).
[10:45:10.621] <TB1> INFO: 2974300 events read in total (172238ms).
[10:45:49.324] <TB1> INFO: 3716050 events read in total (210940ms).
[10:46:16.778] <TB1> INFO: 4160000 events read in total (238394ms).
[10:46:16.959] <TB1> INFO: Test took 239700ms.
[10:46:18.089] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:46:21.709] <TB1> INFO: dacScan step from 35 .. 54
[10:46:21.709] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[10:46:21.709] <TB1> INFO: run 1 of 1
[10:46:22.305] <TB1> INFO: Expecting 4160000 events.
[10:47:03.469] <TB1> INFO: 534750 events read in total (40636ms).
[10:47:44.096] <TB1> INFO: 1069550 events read in total (81263ms).
[10:48:24.849] <TB1> INFO: 1602800 events read in total (122016ms).
[10:49:04.575] <TB1> INFO: 2134050 events read in total (161742ms).
[10:49:44.214] <TB1> INFO: 2661000 events read in total (201381ms).
[10:50:24.084] <TB1> INFO: 3182100 events read in total (241251ms).
[10:51:05.255] <TB1> INFO: 3699300 events read in total (282422ms).
[10:51:41.355] <TB1> INFO: 4160000 events read in total (318522ms).
[10:51:41.555] <TB1> INFO: Test took 319846ms.
[10:51:44.049] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:51:48.087] <TB1> INFO: dacScan step from 55 .. 74
[10:51:48.087] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[10:51:48.087] <TB1> INFO: run 1 of 1
[10:51:48.705] <TB1> INFO: Expecting 4160000 events.
[10:52:28.958] <TB1> INFO: 476200 events read in total (39727ms).
[10:53:07.890] <TB1> INFO: 952950 events read in total (78659ms).
[10:53:46.344] <TB1> INFO: 1430000 events read in total (117113ms).
[10:54:24.769] <TB1> INFO: 1906850 events read in total (155538ms).
[10:55:01.842] <TB1> INFO: 2383700 events read in total (192611ms).
[10:55:37.344] <TB1> INFO: 2860550 events read in total (228113ms).
[10:56:04.994] <TB1> INFO: 3337400 events read in total (255763ms).
[10:56:31.554] <TB1> INFO: 3814300 events read in total (282323ms).
[10:56:50.787] <TB1> INFO: 4160000 events read in total (301556ms).
[10:56:50.966] <TB1> INFO: Test took 302879ms.
[10:56:52.060] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:56:55.621] <TB1> INFO: dacScan step from 75 .. 75
[10:56:55.621] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[10:56:55.621] <TB1> INFO: run 1 of 1
[10:56:56.209] <TB1> INFO: Expecting 208000 events.
[10:57:09.151] <TB1> INFO: 208000 events read in total (12416ms).
[10:57:09.156] <TB1> INFO: Test took 13535ms.
[10:57:09.216] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:57:09.393] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:10.398] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:11.376] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:12.348] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:13.331] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:14.329] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:15.338] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:16.368] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:17.379] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:18.369] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:19.387] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:20.393] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:21.401] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:22.414] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:23.425] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:24.424] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:57:25.398] <TB1> INFO: PixTest:: pg_setup set to default.
[10:57:25.400] <TB1> INFO: vcal mean: 37.52 36.47 37.32 38.36 39.19 40.67 40.32 40.54 40.02 40.02 40.86 39.66 39.65 37.42 37.73 37.78
[10:57:25.400] <TB1> INFO: vcal RMS: 1.30 1.17 0.92 1.11 1.17 1.29 1.27 1.25 1.21 1.22 1.30 1.20 1.11 1.05 1.00 1.00
[10:57:25.400] <TB1> INFO: number of X-ray hits detected: 137668 149629 133140 212507 237054 276397 260217 288763 261422 272789 283531 237485 223633 141501 152757 143289
[10:57:25.400] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:57:25.400] <TB1> INFO: X-ray hit rate [MHz/cm2]: 40.4 43.9 39.0 62.3 69.5 81.0 76.3 84.6 76.6 80.0 83.1 69.6 65.5 41.5 44.8 42.0
[10:57:25.400] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[10:57:25.497] <TB1> INFO: enter test to run
[10:57:25.497] <TB1> INFO: test: no parameter change
[10:57:25.600] <TB1> QUIET: Connection to board 147 closed.
[10:57:25.690] <TB1> INFO: pXar: this is the end, my friend

[11:14:10.472] <TB1> INFO: *** Welcome to pxar ***
[11:14:10.472] <TB1> INFO: *** Today: 2015/11/23
[11:14:10.539] <TB1> INFO: *** Version: 206d-dirty
[11:14:10.539] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:14:10.541] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[11:14:10.541] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[11:14:10.541] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[11:14:10.625] <TB1> INFO: clk: 4
[11:14:10.625] <TB1> INFO: ctr: 4
[11:14:10.625] <TB1> INFO: sda: 19
[11:14:10.625] <TB1> INFO: tin: 9
[11:14:10.625] <TB1> INFO: level: 15
[11:14:10.625] <TB1> INFO: triggerdelay: 0
[11:14:10.625] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:14:10.625] <TB1> INFO: Log level: INFO
[11:14:10.637] <TB1> INFO: Found DTB DTB_WWXTQT
[11:14:10.650] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:14:10.653] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:14:10.655] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:14:12.196] <TB1> INFO: DUT info:
[11:14:12.196] <TB1> INFO: The DUT currently contains the following objects:
[11:14:12.196] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[11:14:12.196] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:14:12.196] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:14:12.196] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:14:12.196] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.196] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.197] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.197] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:12.597] <TB1> INFO: enter 'restricted' command line mode
[11:14:12.598] <TB1> INFO: enter test to run
[11:14:12.598] <TB1> INFO: test: HighRate no parameter change
[11:14:12.598] <TB1> INFO: running: highrate
[11:14:12.601] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[11:14:12.734] <TB1> INFO: ----------------------------------------------------------------------
[11:14:12.734] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:14:12.734] <TB1> INFO: ----------------------------------------------------------------------
[11:14:12.871] <TB1> INFO: Expecting 768 events.
[11:14:14.017] <TB1> INFO: 768 events read in total (428ms).
[11:14:14.205] <TB1> INFO: Test took 1467ms.
[11:14:14.821] <TB1> INFO: Expecting 41600 events.
[11:14:18.239] <TB1> INFO: 41600 events read in total (2892ms).
[11:14:18.241] <TB1> INFO: Test took 4030ms.
[11:14:18.297] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:18.976] <TB1> INFO: Expecting 41600 events.
[11:14:22.516] <TB1> INFO: 41600 events read in total (3013ms).
[11:14:22.517] <TB1> INFO: Test took 4199ms.
[11:14:22.575] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:23.252] <TB1> INFO: Expecting 41600 events.
[11:14:27.028] <TB1> INFO: 41600 events read in total (3249ms).
[11:14:27.030] <TB1> INFO: Test took 4431ms.
[11:14:27.090] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:27.756] <TB1> INFO: Expecting 41600 events.
[11:14:31.775] <TB1> INFO: 41600 events read in total (3493ms).
[11:14:31.776] <TB1> INFO: Test took 4662ms.
[11:14:31.841] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:32.493] <TB1> INFO: Expecting 41600 events.
[11:14:36.430] <TB1> INFO: 41600 events read in total (3410ms).
[11:14:36.431] <TB1> INFO: Test took 4567ms.
[11:14:36.488] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:37.160] <TB1> INFO: Expecting 41600 events.
[11:14:41.184] <TB1> INFO: 41600 events read in total (3498ms).
[11:14:41.186] <TB1> INFO: Test took 4676ms.
[11:14:41.249] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:41.902] <TB1> INFO: Expecting 41600 events.
[11:14:46.037] <TB1> INFO: 41600 events read in total (3608ms).
[11:14:46.039] <TB1> INFO: Test took 4760ms.
[11:14:46.116] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:46.759] <TB1> INFO: Expecting 41600 events.
[11:14:50.840] <TB1> INFO: 41600 events read in total (3554ms).
[11:14:50.842] <TB1> INFO: Test took 4702ms.
[11:14:50.909] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:51.559] <TB1> INFO: Expecting 41600 events.
[11:14:55.622] <TB1> INFO: 41600 events read in total (3537ms).
[11:14:55.623] <TB1> INFO: Test took 4686ms.
[11:14:55.687] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:56.349] <TB1> INFO: Expecting 41600 events.
[11:15:00.315] <TB1> INFO: 41600 events read in total (3440ms).
[11:15:00.317] <TB1> INFO: Test took 4602ms.
[11:15:00.374] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:01.050] <TB1> INFO: Expecting 41600 events.
[11:15:05.104] <TB1> INFO: 41600 events read in total (3528ms).
[11:15:05.106] <TB1> INFO: Test took 4708ms.
[11:15:05.163] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:05.840] <TB1> INFO: Expecting 41600 events.
[11:15:09.663] <TB1> INFO: 41600 events read in total (3296ms).
[11:15:09.665] <TB1> INFO: Test took 4475ms.
[11:15:09.726] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:10.386] <TB1> INFO: Expecting 41600 events.
[11:15:14.256] <TB1> INFO: 41600 events read in total (3343ms).
[11:15:14.257] <TB1> INFO: Test took 4508ms.
[11:15:14.313] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:14.996] <TB1> INFO: Expecting 41600 events.
[11:15:18.940] <TB1> INFO: 41600 events read in total (3417ms).
[11:15:18.942] <TB1> INFO: Test took 4607ms.
[11:15:18.997] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:19.680] <TB1> INFO: Expecting 41600 events.
[11:15:23.640] <TB1> INFO: 41600 events read in total (3433ms).
[11:15:23.641] <TB1> INFO: Test took 4622ms.
[11:15:23.698] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:24.377] <TB1> INFO: Expecting 41600 events.
[11:15:28.132] <TB1> INFO: 41600 events read in total (3229ms).
[11:15:28.134] <TB1> INFO: Test took 4414ms.
[11:15:28.190] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:28.871] <TB1> INFO: Expecting 41600 events.
[11:15:32.758] <TB1> INFO: 41600 events read in total (3361ms).
[11:15:32.764] <TB1> INFO: Test took 4552ms.
[11:15:32.830] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:33.495] <TB1> INFO: Expecting 41600 events.
[11:15:36.917] <TB1> INFO: 41600 events read in total (2896ms).
[11:15:36.919] <TB1> INFO: Test took 4059ms.
[11:15:36.978] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:37.647] <TB1> INFO: Expecting 41600 events.
[11:15:40.995] <TB1> INFO: 41600 events read in total (2821ms).
[11:15:40.997] <TB1> INFO: Test took 3997ms.
[11:15:41.055] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:41.733] <TB1> INFO: Expecting 41600 events.
[11:15:44.997] <TB1> INFO: 41600 events read in total (2738ms).
[11:15:44.998] <TB1> INFO: Test took 3920ms.
[11:15:45.056] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:45.432] <TB1> INFO: enter test to run
[11:15:45.432] <TB1> INFO: test: Pretest no parameter change
[11:15:45.432] <TB1> INFO: running: pretest
[11:15:45.432] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[11:15:45.432] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[11:15:45.433] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[11:15:45.433] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[11:15:45.433] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[11:15:45.433] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[11:15:45.433] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[11:15:45.433] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[11:15:45.433] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[11:15:45.434] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[11:15:45.434] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[11:15:45.434] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[11:15:45.434] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[11:15:45.434] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[11:15:45.434] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[11:15:45.434] <TB1> INFO: write dac parameters into /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:15:45.434] <TB1> INFO: enter test to run
[11:15:45.434] <TB1> INFO: test: no parameter change
[11:15:45.516] <TB1> QUIET: Connection to board 147 closed.
[11:15:45.596] <TB1> INFO: pXar: this is the end, my friend

[11:16:05.173] <TB1> INFO: *** Welcome to pxar ***
[11:16:05.173] <TB1> INFO: *** Today: 2015/11/23
[11:16:05.246] <TB1> INFO: *** Version: 206d-dirty
[11:16:05.246] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//dacParameters35_C15.dat
[11:16:05.247] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//tbmParameters_C0b.dat
[11:16:05.248] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//defaultMaskFile.dat
[11:16:05.248] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//trimParameters35_C15.dat
[11:16:05.322] <TB1> INFO: clk: 4
[11:16:05.322] <TB1> INFO: ctr: 4
[11:16:05.322] <TB1> INFO: sda: 19
[11:16:05.322] <TB1> INFO: tin: 9
[11:16:05.322] <TB1> INFO: level: 15
[11:16:05.322] <TB1> INFO: triggerdelay: 0
[11:16:05.322] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:16:05.322] <TB1> INFO: Log level: INFO
[11:16:05.335] <TB1> INFO: Found DTB DTB_WWXTQT
[11:16:05.349] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:16:05.352] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:16:05.355] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:16:06.900] <TB1> INFO: DUT info:
[11:16:06.900] <TB1> INFO: The DUT currently contains the following objects:
[11:16:06.900] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[11:16:06.900] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:16:06.900] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:16:06.900] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:16:06.900] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.900] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.900] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.900] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:06.901] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:07.302] <TB1> INFO: enter 'restricted' command line mode
[11:16:07.302] <TB1> INFO: enter test to run
[11:16:07.302] <TB1> INFO: test: PixelAlive no parameter change
[11:16:07.302] <TB1> INFO: running: pixelalive
[11:16:07.311] <TB1> INFO: ######################################################################
[11:16:07.311] <TB1> INFO: PixTestAlive::doTest()
[11:16:07.311] <TB1> INFO: ######################################################################
[11:16:07.313] <TB1> INFO: ----------------------------------------------------------------------
[11:16:07.313] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:16:07.313] <TB1> INFO: ----------------------------------------------------------------------
[11:16:07.622] <TB1> INFO: Expecting 208000 events.
[11:16:19.581] <TB1> INFO: 208000 events read in total (11241ms).
[11:16:19.693] <TB1> INFO: Test took 12378ms.
[11:16:19.700] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:19.959] <TB1> INFO: PixTestAlive::aliveTest() done
[11:16:19.959] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:16:19.961] <TB1> INFO: ----------------------------------------------------------------------
[11:16:19.961] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:16:19.961] <TB1> INFO: ----------------------------------------------------------------------
[11:16:20.293] <TB1> INFO: Expecting 208000 events.
[11:16:28.144] <TB1> INFO: 208000 events read in total (7135ms).
[11:16:28.144] <TB1> INFO: Test took 8182ms.
[11:16:28.144] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:28.146] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:16:28.550] <TB1> INFO: PixTestAlive::maskTest() done
[11:16:28.550] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:16:28.552] <TB1> INFO: ----------------------------------------------------------------------
[11:16:28.552] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:16:28.552] <TB1> INFO: ----------------------------------------------------------------------
[11:16:28.897] <TB1> INFO: Expecting 208000 events.
[11:16:41.145] <TB1> INFO: 208000 events read in total (11533ms).
[11:16:41.145] <TB1> INFO: Test took 12591ms.
[11:16:41.156] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:41.473] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:16:41.473] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:16:41.473] <TB1> INFO: PixTestAlive::doTest() done, duration: 34 seconds
[11:16:41.514] <TB1> INFO: enter test to run
[11:16:41.514] <TB1> INFO: test: delay setting parameters: ->2<-
[11:16:41.514] <TB1> INFO: delay test by 2 seconds...
[11:16:43.514] <TB1> INFO: enter test to run
[11:16:43.514] <TB1> INFO: test: HighRate no parameter change
[11:16:43.514] <TB1> INFO: running: highrate
[11:16:43.514] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[11:16:43.660] <TB1> INFO: ----------------------------------------------------------------------
[11:16:43.660] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:16:43.660] <TB1> INFO: ----------------------------------------------------------------------
[11:16:44.259] <TB1> INFO: Expecting 208000 events.
[11:16:56.970] <TB1> INFO: 208000 events read in total (12184ms).
[11:16:56.973] <TB1> INFO: Test took 13310ms.
[11:16:57.152] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:57.407] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:16:57.407] <TB1> INFO: number of red-efficiency pixels: 90 96 74 130 176 200 157 223 168 189 235 131 144 74 110 65
[11:16:57.407] <TB1> INFO: number of X-ray hits detected: 62163 67815 59144 98249 107648 127817 119450 132949 118676 125121 132118 108153 103956 63507 69551 64941
[11:16:57.408] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:16:57.408] <TB1> INFO: number of Vcal hits detected: 207910 207904 207925 207868 207816 207794 207836 207773 207823 207806 207757 207867 207854 207923 207888 207934
[11:16:57.408] <TB1> 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 100.0 99.9 100.0
[11:16:57.408] <TB1> INFO: Vcal hit overall 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 100.0 99.9 100.0
[11:16:57.408] <TB1> INFO: X-ray hit rate [MHz/cm2]: 18.2 19.9 17.3 28.8 31.6 37.5 35.0 39.0 34.8 36.7 38.7 31.7 30.5 18.6 20.4 19.0
[11:16:57.408] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:16:57.438] <TB1> INFO: PixTest:: pg_setup set to default.
[11:16:57.448] <TB1> INFO: enter test to run
[11:16:57.449] <TB1> INFO: test: no parameter change
[11:16:57.552] <TB1> QUIET: Connection to board 147 closed.
[11:16:57.632] <TB1> INFO: pXar: this is the end, my friend

[11:17:18.868] <TB1> INFO: *** Welcome to pxar ***
[11:17:18.868] <TB1> INFO: *** Today: 2015/11/23
[11:17:18.956] <TB1> INFO: *** Version: 206d-dirty
[11:17:18.957] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//dacParameters35_C15.dat
[11:17:18.957] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//tbmParameters_C0b.dat
[11:17:18.957] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//defaultMaskFile.dat
[11:17:18.957] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//trimParameters35_C15.dat
[11:17:19.028] <TB1> INFO: clk: 4
[11:17:19.028] <TB1> INFO: ctr: 4
[11:17:19.028] <TB1> INFO: sda: 19
[11:17:19.028] <TB1> INFO: tin: 9
[11:17:19.028] <TB1> INFO: level: 15
[11:17:19.028] <TB1> INFO: triggerdelay: 0
[11:17:19.028] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:17:19.028] <TB1> INFO: Log level: INFO
[11:17:19.042] <TB1> INFO: Found DTB DTB_WWXTQT
[11:17:19.058] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:17:19.061] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:17:19.063] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:17:20.617] <TB1> INFO: DUT info:
[11:17:20.617] <TB1> INFO: The DUT currently contains the following objects:
[11:17:20.617] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[11:17:20.617] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:17:20.617] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:17:20.617] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:17:20.617] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.617] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.617] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.617] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.617] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:20.618] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:21.019] <TB1> INFO: enter 'restricted' command line mode
[11:17:21.019] <TB1> INFO: enter test to run
[11:17:21.019] <TB1> INFO: test: PixelAlive no parameter change
[11:17:21.019] <TB1> INFO: running: pixelalive
[11:17:21.023] <TB1> INFO: ######################################################################
[11:17:21.023] <TB1> INFO: PixTestAlive::doTest()
[11:17:21.023] <TB1> INFO: ######################################################################
[11:17:21.025] <TB1> INFO: ----------------------------------------------------------------------
[11:17:21.025] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:17:21.025] <TB1> INFO: ----------------------------------------------------------------------
[11:17:21.355] <TB1> INFO: Expecting 208000 events.
[11:17:33.368] <TB1> INFO: 208000 events read in total (11295ms).
[11:17:33.479] <TB1> INFO: Test took 12453ms.
[11:17:33.490] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:33.748] <TB1> INFO: PixTestAlive::aliveTest() done
[11:17:33.748] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:17:33.750] <TB1> INFO: ----------------------------------------------------------------------
[11:17:33.750] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:17:33.750] <TB1> INFO: ----------------------------------------------------------------------
[11:17:34.065] <TB1> INFO: Expecting 208000 events.
[11:17:41.366] <TB1> INFO: 208000 events read in total (6587ms).
[11:17:41.367] <TB1> INFO: Test took 7616ms.
[11:17:41.367] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:41.367] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:17:41.775] <TB1> INFO: PixTestAlive::maskTest() done
[11:17:41.775] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:17:41.777] <TB1> INFO: ----------------------------------------------------------------------
[11:17:41.777] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:17:41.777] <TB1> INFO: ----------------------------------------------------------------------
[11:17:42.129] <TB1> INFO: Expecting 208000 events.
[11:17:54.043] <TB1> INFO: 208000 events read in total (11199ms).
[11:17:54.044] <TB1> INFO: Test took 12266ms.
[11:17:54.053] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:54.375] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:17:54.375] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:17:54.375] <TB1> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:17:54.410] <TB1> INFO: enter test to run
[11:17:54.410] <TB1> INFO: test: delay setting parameters: ->2<-
[11:17:54.410] <TB1> INFO: delay test by 2 seconds...
[11:17:56.410] <TB1> INFO: enter test to run
[11:17:56.410] <TB1> INFO: test: HighRate no parameter change
[11:17:56.410] <TB1> INFO: running: highrate
[11:17:56.411] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//phCalibrationFitErr35_C15.dat
[11:17:56.555] <TB1> INFO: ----------------------------------------------------------------------
[11:17:56.555] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:17:56.555] <TB1> INFO: ----------------------------------------------------------------------
[11:17:57.172] <TB1> INFO: Expecting 208000 events.
[11:18:11.574] <TB1> INFO: 208000 events read in total (13875ms).
[11:18:11.582] <TB1> INFO: Test took 15024ms.
[11:18:11.964] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:12.284] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:18:12.284] <TB1> INFO: number of red-efficiency pixels: 230 256 258 510 593 677 570 761 682 575 858 541 456 276 311 233
[11:18:12.284] <TB1> INFO: number of X-ray hits detected: 136455 150510 132904 213549 235124 274963 259487 288236 260785 272644 283374 235995 224454 141329 152054 142496
[11:18:12.284] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:18:12.284] <TB1> INFO: number of Vcal hits detected: 207763 207734 207718 207453 207342 207244 207357 207136 207242 207379 207007 207398 207512 207697 207673 207752
[11:18:12.284] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.7 99.7 99.6 99.7 99.7 99.6 99.8 99.8 99.9 99.9 99.9
[11:18:12.284] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.6 99.7 99.6 99.6 99.7 99.5 99.7 99.8 99.9 99.8 99.9
[11:18:12.284] <TB1> INFO: X-ray hit rate [MHz/cm2]: 40.0 44.1 39.0 62.6 68.9 80.6 76.1 84.5 76.4 79.9 83.1 69.2 65.8 41.4 44.6 41.8
[11:18:12.284] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:18:12.317] <TB1> INFO: PixTest:: pg_setup set to default.
[11:18:12.329] <TB1> INFO: enter test to run
[11:18:12.329] <TB1> INFO: test: no parameter change
[11:18:12.403] <TB1> QUIET: Connection to board 147 closed.
[11:18:12.482] <TB1> INFO: pXar: this is the end, my friend

[11:18:33.484] <TB1> INFO: *** Welcome to pxar ***
[11:18:33.484] <TB1> INFO: *** Today: 2015/11/23
[11:18:33.570] <TB1> INFO: *** Version: 206d-dirty
[11:18:33.570] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//dacParameters35_C15.dat
[11:18:33.572] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//tbmParameters_C0b.dat
[11:18:33.572] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//defaultMaskFile.dat
[11:18:33.572] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//trimParameters35_C15.dat
[11:18:33.649] <TB1> INFO: clk: 4
[11:18:33.649] <TB1> INFO: ctr: 4
[11:18:33.649] <TB1> INFO: sda: 19
[11:18:33.649] <TB1> INFO: tin: 9
[11:18:33.649] <TB1> INFO: level: 15
[11:18:33.649] <TB1> INFO: triggerdelay: 0
[11:18:33.649] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:18:33.649] <TB1> INFO: Log level: INFO
[11:18:33.663] <TB1> INFO: Found DTB DTB_WWXTQT
[11:18:33.677] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:18:33.681] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:18:33.683] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:18:35.229] <TB1> INFO: DUT info:
[11:18:35.229] <TB1> INFO: The DUT currently contains the following objects:
[11:18:35.229] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[11:18:35.229] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:18:35.229] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:18:35.229] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:18:35.229] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.229] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:35.630] <TB1> INFO: enter 'restricted' command line mode
[11:18:35.630] <TB1> INFO: enter test to run
[11:18:35.630] <TB1> INFO: test: PixelAlive no parameter change
[11:18:35.630] <TB1> INFO: running: pixelalive
[11:18:35.637] <TB1> INFO: ######################################################################
[11:18:35.637] <TB1> INFO: PixTestAlive::doTest()
[11:18:35.637] <TB1> INFO: ######################################################################
[11:18:35.639] <TB1> INFO: ----------------------------------------------------------------------
[11:18:35.639] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:18:35.639] <TB1> INFO: ----------------------------------------------------------------------
[11:18:35.947] <TB1> INFO: Expecting 208000 events.
[11:18:48.005] <TB1> INFO: 208000 events read in total (11340ms).
[11:18:48.109] <TB1> INFO: Test took 12468ms.
[11:18:48.126] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:48.387] <TB1> INFO: PixTestAlive::aliveTest() done
[11:18:48.387] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:18:48.389] <TB1> INFO: ----------------------------------------------------------------------
[11:18:48.389] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:18:48.389] <TB1> INFO: ----------------------------------------------------------------------
[11:18:48.700] <TB1> INFO: Expecting 208000 events.
[11:18:55.930] <TB1> INFO: 208000 events read in total (6514ms).
[11:18:55.930] <TB1> INFO: Test took 7539ms.
[11:18:55.930] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:55.931] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:18:56.340] <TB1> INFO: PixTestAlive::maskTest() done
[11:18:56.340] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:18:56.341] <TB1> INFO: ----------------------------------------------------------------------
[11:18:56.341] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:18:56.341] <TB1> INFO: ----------------------------------------------------------------------
[11:18:56.673] <TB1> INFO: Expecting 208000 events.
[11:19:09.036] <TB1> INFO: 208000 events read in total (11648ms).
[11:19:09.037] <TB1> INFO: Test took 12694ms.
[11:19:09.048] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:09.355] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:19:09.355] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:19:09.355] <TB1> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:19:09.387] <TB1> INFO: enter test to run
[11:19:09.387] <TB1> INFO: test: delay setting parameters: ->2<-
[11:19:09.387] <TB1> INFO: delay test by 2 seconds...
[11:19:11.387] <TB1> INFO: enter test to run
[11:19:11.387] <TB1> INFO: test: HighRate no parameter change
[11:19:11.387] <TB1> INFO: running: highrate
[11:19:11.387] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//phCalibrationFitErr35_C15.dat
[11:19:11.535] <TB1> INFO: ----------------------------------------------------------------------
[11:19:11.535] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:19:11.535] <TB1> INFO: ----------------------------------------------------------------------
[11:19:12.163] <TB1> INFO: Expecting 208000 events.
[11:19:29.702] <TB1> INFO: 208000 events read in total (17012ms).
[11:19:29.712] <TB1> INFO: Test took 18172ms.
[11:19:30.251] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:30.624] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:19:30.624] <TB1> INFO: number of red-efficiency pixels: 449 541 537 1063 1216 1417 1178 1659 1629 1269 1890 1119 964 618 588 409
[11:19:30.624] <TB1> INFO: number of X-ray hits detected: 203999 225691 200224 317495 350510 407751 386117 430470 390012 404443 419340 351623 333151 212601 228461 212749
[11:19:30.624] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:19:30.624] <TB1> INFO: number of Vcal hits detected: 207499 207424 207342 206702 206324 206022 206408 205722 205829 206281 205171 206516 206866 207231 207359 207559
[11:19:30.624] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.7 99.7 99.4 99.3 99.2 99.3 99.0 99.0 99.3 98.8 99.4 99.5 99.7 99.7 99.8
[11:19:30.624] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.7 99.4 99.2 99.0 99.2 98.9 99.0 99.2 98.6 99.3 99.5 99.6 99.7 99.8
[11:19:30.624] <TB1> INFO: X-ray hit rate [MHz/cm2]: 59.8 66.2 58.7 93.1 102.7 119.5 113.2 126.2 114.3 118.5 122.9 103.1 97.6 62.3 67.0 62.4
[11:19:30.624] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:19:30.661] <TB1> INFO: PixTest:: pg_setup set to default.
[11:19:30.678] <TB1> INFO: enter test to run
[11:19:30.678] <TB1> INFO: test: no parameter change
[11:19:30.742] <TB1> QUIET: Connection to board 147 closed.
[11:19:30.822] <TB1> INFO: pXar: this is the end, my friend

[11:19:49.457] <TB1> INFO: *** Welcome to pxar ***
[11:19:49.457] <TB1> INFO: *** Today: 2015/11/23
[11:19:49.541] <TB1> INFO: *** Version: 206d-dirty
[11:19:49.542] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//dacParameters35_C15.dat
[11:19:49.542] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//tbmParameters_C0b.dat
[11:19:49.542] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//defaultMaskFile.dat
[11:19:49.542] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//trimParameters35_C15.dat
[11:19:49.614] <TB1> INFO: clk: 4
[11:19:49.614] <TB1> INFO: ctr: 4
[11:19:49.614] <TB1> INFO: sda: 19
[11:19:49.614] <TB1> INFO: tin: 9
[11:19:49.614] <TB1> INFO: level: 15
[11:19:49.614] <TB1> INFO: triggerdelay: 0
[11:19:49.614] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:19:49.614] <TB1> INFO: Log level: INFO
[11:19:49.627] <TB1> INFO: Found DTB DTB_WWXTQT
[11:19:49.642] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:19:49.645] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:19:49.648] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:19:51.197] <TB1> INFO: DUT info:
[11:19:51.197] <TB1> INFO: The DUT currently contains the following objects:
[11:19:51.197] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[11:19:51.197] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:19:51.197] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:19:51.197] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:19:51.197] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.197] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.197] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.197] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.198] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:51.599] <TB1> INFO: enter 'restricted' command line mode
[11:19:51.599] <TB1> INFO: enter test to run
[11:19:51.599] <TB1> INFO: test: PixelAlive no parameter change
[11:19:51.599] <TB1> INFO: running: pixelalive
[11:19:51.607] <TB1> INFO: ######################################################################
[11:19:51.607] <TB1> INFO: PixTestAlive::doTest()
[11:19:51.607] <TB1> INFO: ######################################################################
[11:19:51.608] <TB1> INFO: ----------------------------------------------------------------------
[11:19:51.608] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:19:51.608] <TB1> INFO: ----------------------------------------------------------------------
[11:19:51.919] <TB1> INFO: Expecting 208000 events.
[11:20:03.783] <TB1> INFO: 208000 events read in total (11146ms).
[11:20:03.862] <TB1> INFO: Test took 12252ms.
[11:20:03.869] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:04.129] <TB1> INFO: PixTestAlive::aliveTest() done
[11:20:04.129] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:20:04.130] <TB1> INFO: ----------------------------------------------------------------------
[11:20:04.130] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:20:04.131] <TB1> INFO: ----------------------------------------------------------------------
[11:20:04.457] <TB1> INFO: Expecting 208000 events.
[11:20:11.984] <TB1> INFO: 208000 events read in total (6812ms).
[11:20:11.984] <TB1> INFO: Test took 7852ms.
[11:20:11.984] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:11.985] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:20:12.391] <TB1> INFO: PixTestAlive::maskTest() done
[11:20:12.391] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:20:12.393] <TB1> INFO: ----------------------------------------------------------------------
[11:20:12.393] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:20:12.393] <TB1> INFO: ----------------------------------------------------------------------
[11:20:12.736] <TB1> INFO: Expecting 208000 events.
[11:20:24.742] <TB1> INFO: 208000 events read in total (11291ms).
[11:20:24.742] <TB1> INFO: Test took 12347ms.
[11:20:24.749] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:25.085] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:20:25.085] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:20:25.085] <TB1> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:20:25.118] <TB1> INFO: enter test to run
[11:20:25.118] <TB1> INFO: test: delay setting parameters: ->2<-
[11:20:25.118] <TB1> INFO: delay test by 2 seconds...
[11:20:27.118] <TB1> INFO: enter test to run
[11:20:27.118] <TB1> INFO: test: HighRate no parameter change
[11:20:27.118] <TB1> INFO: running: highrate
[11:20:27.119] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//phCalibrationFitErr35_C15.dat
[11:20:27.288] <TB1> INFO: ----------------------------------------------------------------------
[11:20:27.288] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:20:27.288] <TB1> INFO: ----------------------------------------------------------------------
[11:20:27.905] <TB1> INFO: Expecting 208000 events.
[11:20:49.718] <TB1> INFO: 208000 events read in total (21287ms).
[11:20:49.731] <TB1> INFO: Test took 22440ms.
[11:20:50.478] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:50.924] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:20:50.924] <TB1> INFO: number of red-efficiency pixels: 862 1052 941 2064 2299 2459 2177 2821 2800 2408 3081 2055 1742 1068 1161 797
[11:20:50.924] <TB1> INFO: number of X-ray hits detected: 283927 314696 281518 440029 486155 564668 534672 594416 538836 558186 575459 484956 459487 297817 318231 294810
[11:20:50.924] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:20:50.924] <TB1> INFO: number of Vcal hits detected: 206981 206739 206478 204687 203912 203151 203955 202601 202615 203580 200999 204500 205342 206326 206578 207101
[11:20:50.924] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.4 99.4 98.6 98.3 98.0 98.3 97.6 97.7 98.2 97.0 98.6 98.9 99.3 99.4 99.6
[11:20:50.924] <TB1> INFO: Vcal hit overall efficiency (%): 99.5 99.4 99.3 98.4 98.0 97.7 98.1 97.4 97.4 97.9 96.6 98.3 98.7 99.2 99.3 99.6
[11:20:50.924] <TB1> INFO: X-ray hit rate [MHz/cm2]: 83.2 92.2 82.5 129.0 142.5 165.5 156.7 174.2 157.9 163.6 168.7 142.1 134.7 87.3 93.3 86.4
[11:20:50.924] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:20:50.961] <TB1> INFO: PixTest:: pg_setup set to default.
[11:20:50.979] <TB1> INFO: enter test to run
[11:20:50.979] <TB1> INFO: test: no parameter change
[11:20:51.085] <TB1> QUIET: Connection to board 147 closed.
[11:20:51.165] <TB1> INFO: pXar: this is the end, my friend

[11:21:10.617] <TB1> INFO: *** Welcome to pxar ***
[11:21:10.617] <TB1> INFO: *** Today: 2015/11/23
[11:21:10.967] <TB1> INFO: *** Version: 206d-dirty
[11:21:10.967] <TB1> INFO: readRocDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//dacParameters35_C15.dat
[11:21:10.969] <TB1> INFO: readTbmDacs: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//tbmParameters_C0b.dat
[11:21:10.970] <TB1> INFO: readMaskFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//defaultMaskFile.dat
[11:21:10.970] <TB1> INFO: readTrimFile: /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//trimParameters35_C15.dat
[11:21:11.042] <TB1> INFO: clk: 4
[11:21:11.042] <TB1> INFO: ctr: 4
[11:21:11.042] <TB1> INFO: sda: 19
[11:21:11.042] <TB1> INFO: tin: 9
[11:21:11.042] <TB1> INFO: level: 15
[11:21:11.042] <TB1> INFO: triggerdelay: 0
[11:21:11.042] <TB1> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:21:11.042] <TB1> INFO: Log level: INFO
[11:21:11.055] <TB1> INFO: Found DTB DTB_WWXTQT
[11:21:11.071] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:21:11.074] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:21:11.076] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:21:12.618] <TB1> INFO: DUT info:
[11:21:12.618] <TB1> INFO: The DUT currently contains the following objects:
[11:21:12.618] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[11:21:12.618] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:21:12.618] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:21:12.618] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:21:12.618] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:12.618] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:13.019] <TB1> INFO: enter 'restricted' command line mode
[11:21:13.019] <TB1> INFO: enter test to run
[11:21:13.019] <TB1> INFO: test: PixelAlive no parameter change
[11:21:13.019] <TB1> INFO: running: pixelalive
[11:21:13.027] <TB1> INFO: ######################################################################
[11:21:13.027] <TB1> INFO: PixTestAlive::doTest()
[11:21:13.027] <TB1> INFO: ######################################################################
[11:21:13.029] <TB1> INFO: ----------------------------------------------------------------------
[11:21:13.029] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:21:13.029] <TB1> INFO: ----------------------------------------------------------------------
[11:21:13.334] <TB1> INFO: Expecting 208000 events.
[11:21:25.411] <TB1> INFO: 208000 events read in total (11360ms).
[11:21:25.517] <TB1> INFO: Test took 12486ms.
[11:21:25.531] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:25.803] <TB1> INFO: PixTestAlive::aliveTest() done
[11:21:25.804] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:21:25.805] <TB1> INFO: ----------------------------------------------------------------------
[11:21:25.805] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:21:25.805] <TB1> INFO: ----------------------------------------------------------------------
[11:21:26.119] <TB1> INFO: Expecting 208000 events.
[11:21:33.333] <TB1> INFO: 208000 events read in total (6498ms).
[11:21:33.335] <TB1> INFO: Test took 7528ms.
[11:21:33.335] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:33.335] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:21:33.732] <TB1> INFO: PixTestAlive::maskTest() done
[11:21:33.732] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:21:33.734] <TB1> INFO: ----------------------------------------------------------------------
[11:21:33.734] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:21:33.734] <TB1> INFO: ----------------------------------------------------------------------
[11:21:34.060] <TB1> INFO: Expecting 208000 events.
[11:21:46.186] <TB1> INFO: 208000 events read in total (11412ms).
[11:21:46.187] <TB1> INFO: Test took 12452ms.
[11:21:46.198] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:46.504] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:21:46.504] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:21:46.504] <TB1> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[11:21:46.541] <TB1> INFO: enter test to run
[11:21:46.541] <TB1> INFO: test: delay setting parameters: ->2<-
[11:21:46.541] <TB1> INFO: delay test by 2 seconds...
[11:21:48.541] <TB1> INFO: enter test to run
[11:21:48.541] <TB1> INFO: test: HighRate no parameter change
[11:21:48.541] <TB1> INFO: running: highrate
[11:21:48.541] <TB1> INFO: readGainPedestalParameters /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4560_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//phCalibrationFitErr35_C15.dat
[11:21:48.691] <TB1> INFO: ----------------------------------------------------------------------
[11:21:48.691] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:21:48.691] <TB1> INFO: ----------------------------------------------------------------------
[11:21:49.296] <TB1> INFO: Expecting 208000 events.
[11:22:14.599] <TB1> INFO: 208000 events read in total (24777ms).
[11:22:14.618] <TB1> INFO: Test took 25923ms.
[11:22:15.620] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:16.119] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:22:16.119] <TB1> INFO: number of red-efficiency pixels: 1415 1708 1402 2901 3051 3406 3092 3638 3598 3196 3785 2840 2587 1496 1758 1205
[11:22:16.119] <TB1> INFO: number of X-ray hits detected: 352914 390975 350420 547180 606405 701637 666843 737281 668947 697398 715975 603891 574192 370227 395968 366682
[11:22:16.119] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:22:16.119] <TB1> INFO: number of Vcal hits detected: 206133 205695 205119 201701 200195 198756 200144 197702 197682 199702 195153 201586 203172 204875 205612 206462
[11:22:16.119] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.2 99.0 98.9 97.3 96.7 96.1 96.7 95.5 95.5 96.5 94.5 97.4 98.0 98.7 98.9 99.3
[11:22:16.119] <TB1> INFO: Vcal hit overall efficiency (%): 99.1 98.9 98.6 97.0 96.2 95.6 96.2 95.0 95.0 96.0 93.8 96.9 97.7 98.5 98.9 99.3
[11:22:16.119] <TB1> INFO: X-ray hit rate [MHz/cm2]: 103.4 114.6 102.7 160.4 177.7 205.7 195.5 216.1 196.1 204.4 209.9 177.0 168.3 108.5 116.1 107.5
[11:22:16.119] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:22:16.148] <TB1> INFO: PixTest:: pg_setup set to default.
[11:22:16.160] <TB1> INFO: enter test to run
[11:22:16.160] <TB1> INFO: test: no parameter change
[11:22:16.257] <TB1> QUIET: Connection to board 147 closed.
[11:22:16.337] <TB1> INFO: pXar: this is the end, my friend