[09:51:45.013] <TB3> INFO: *** Welcome to pxar ***
[09:51:45.013] <TB3> INFO: *** Today: 2015/11/04
[09:51:45.116] <TB3> INFO: *** Version: 7db0-dirty
[09:51:45.116] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//000_PixelAlive_p17//dacParameters35_C15.dat
[09:51:45.116] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//000_PixelAlive_p17//tbmParameters_C0b.dat
[09:51:45.116] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//000_PixelAlive_p17//defaultMaskFile.dat
[09:51:45.117] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//000_PixelAlive_p17//trimParameters35_C15.dat
[09:51:45.190] <TB3> INFO: clk: 4
[09:51:45.190] <TB3> INFO: ctr: 4
[09:51:45.190] <TB3> INFO: sda: 19
[09:51:45.190] <TB3> INFO: tin: 9
[09:51:45.190] <TB3> INFO: level: 15
[09:51:45.190] <TB3> INFO: triggerdelay: 0
[09:51:45.190] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[09:51:45.190] <TB3> INFO: Log level: INFO
[09:51:45.203] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:51:45.214] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:51:45.218] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:51:45.220] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:51:46.789] <TB3> INFO: DUT info:
[09:51:46.789] <TB3> INFO: The DUT currently contains the following objects:
[09:51:46.789] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[09:51:46.789] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:51:46.789] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:51:46.789] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:51:46.789] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.789] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.790] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.790] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.790] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.790] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.790] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:46.790] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:51:47.191] <TB3> INFO: enter 'restricted' command line mode
[09:51:47.191] <TB3> INFO: enter test to run
[09:51:47.191] <TB3> INFO: test: PixelAlive no parameter change
[09:51:47.191] <TB3> INFO: running: pixelalive
[09:51:47.198] <TB3> INFO: ######################################################################
[09:51:47.198] <TB3> INFO: PixTestAlive::doTest()
[09:51:47.198] <TB3> INFO: ######################################################################
[09:51:47.200] <TB3> INFO: ----------------------------------------------------------------------
[09:51:47.200] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:51:47.200] <TB3> INFO: ----------------------------------------------------------------------
[09:51:47.514] <TB3> INFO: Expecting 41600 events.
[09:51:51.923] <TB3> INFO: 41600 events read in total (3691ms).
[09:51:52.097] <TB3> INFO: Test took 4895ms.
[09:51:52.103] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:51:52.352] <TB3> INFO: PixTestAlive::aliveTest() done
[09:51:52.352] <TB3> INFO: number of dead pixels (per ROC): 0 19 3 0 0 0 5 0 3 7 0 0 0 4 4 0
[09:51:52.354] <TB3> INFO: ----------------------------------------------------------------------
[09:51:52.354] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:51:52.354] <TB3> INFO: ----------------------------------------------------------------------
[09:51:52.659] <TB3> INFO: Expecting 41600 events.
[09:51:55.647] <TB3> INFO: 41600 events read in total (2274ms).
[09:51:55.647] <TB3> INFO: Test took 3292ms.
[09:51:55.647] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:51:55.648] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:51:56.051] <TB3> INFO: PixTestAlive::maskTest() done
[09:51:56.051] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:51:56.052] <TB3> INFO: ----------------------------------------------------------------------
[09:51:56.052] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:51:56.052] <TB3> INFO: ----------------------------------------------------------------------
[09:51:56.353] <TB3> INFO: Expecting 41600 events.
[09:52:00.480] <TB3> INFO: 41600 events read in total (3412ms).
[09:52:00.481] <TB3> INFO: Test took 4427ms.
[09:52:00.487] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:52:00.869] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[09:52:00.869] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:52:00.869] <TB3> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[09:52:00.904] <TB3> INFO: enter test to run
[09:52:00.904] <TB3> INFO: test: no parameter change
[09:52:00.951] <TB3> QUIET: Connection to board 121 closed.
[09:52:01.030] <TB3> INFO: pXar: this is the end, my friend

[09:56:59.880] <TB3> INFO: *** Welcome to pxar ***
[09:56:59.880] <TB3> INFO: *** Today: 2015/11/04
[09:56:59.957] <TB3> INFO: *** Version: 7db0-dirty
[09:56:59.957] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//dacParameters35_C15.dat
[09:56:59.959] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[09:56:59.959] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:56:59.959] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:57:00.032] <TB3> INFO: clk: 4
[09:57:00.032] <TB3> INFO: ctr: 4
[09:57:00.032] <TB3> INFO: sda: 19
[09:57:00.032] <TB3> INFO: tin: 9
[09:57:00.032] <TB3> INFO: level: 15
[09:57:00.032] <TB3> INFO: triggerdelay: 0
[09:57:00.032] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[09:57:00.032] <TB3> INFO: Log level: INFO
[09:57:00.045] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:57:00.056] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:57:00.059] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:57:00.062] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:57:01.629] <TB3> INFO: DUT info:
[09:57:01.629] <TB3> INFO: The DUT currently contains the following objects:
[09:57:01.629] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[09:57:01.629] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:57:01.629] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:57:01.629] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:57:01.630] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:01.630] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:57:02.031] <TB3> INFO: enter 'restricted' command line mode
[09:57:02.031] <TB3> INFO: enter test to run
[09:57:02.032] <TB3> INFO: test: delay setting parameters: ->5<-
[09:57:02.032] <TB3> INFO: delay test by 5 seconds...
[09:57:07.032] <TB3> INFO: enter test to run
[09:57:07.032] <TB3> INFO: test: highrate no parameter change
[09:57:07.032] <TB3> INFO: running: highrate
[09:57:07.035] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[09:57:07.222] <TB3> INFO: ----------------------------------------------------------------------
[09:57:07.222] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[09:57:07.222] <TB3> INFO: ----------------------------------------------------------------------
[09:57:07.222] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[09:57:07.222] <TB3> INFO: edge/corner pixel THR is adjusted
[09:57:07.222] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:57:08.180] <TB3> INFO: Collecting data for 1 seconds...
[09:57:09.183] <TB3> INFO: Done with hot pixel readout
[09:57:14.667] <TB3> INFO: PixTest:: pg_setup set to default.
[09:57:14.668] <TB3> INFO: 6 hot pixels found in step 0
[09:57:15.652] <TB3> INFO: Collecting data for 1 seconds...
[09:57:16.655] <TB3> INFO: Done with hot pixel readout
[09:57:22.161] <TB3> INFO: PixTest:: pg_setup set to default.
[09:57:22.162] <TB3> INFO: 4 hot pixels found in step 1
[09:57:23.174] <TB3> INFO: Collecting data for 1 seconds...
[09:57:24.177] <TB3> INFO: Done with hot pixel readout
[09:57:29.656] <TB3> INFO: PixTest:: pg_setup set to default.
[09:57:29.657] <TB3> INFO: 4 hot pixels found in step 2
[09:57:30.654] <TB3> INFO: Collecting data for 1 seconds...
[09:57:31.657] <TB3> INFO: Done with hot pixel readout
[09:57:37.438] <TB3> INFO: PixTest:: pg_setup set to default.
[09:57:37.439] <TB3> INFO: 0 hot pixels found in step 3
[09:57:37.447] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[09:57:37.483] <TB3> INFO: PixTest::trimHotPixels() done
[09:57:37.484] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C0.dat
[09:57:37.498] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C1.dat
[09:57:37.511] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C2.dat
[09:57:37.524] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C3.dat
[09:57:37.536] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C4.dat
[09:57:37.549] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C5.dat
[09:57:37.562] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C6.dat
[09:57:37.575] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C7.dat
[09:57:37.588] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C8.dat
[09:57:37.601] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C9.dat
[09:57:37.614] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C10.dat
[09:57:37.627] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C11.dat
[09:57:37.640] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C12.dat
[09:57:37.652] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C13.dat
[09:57:37.665] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C14.dat
[09:57:37.678] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:57:37.691] <TB3> INFO: write masked pixels into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:57:37.750] <TB3> INFO: enter test to run
[09:57:37.750] <TB3> INFO: test: no parameter change
[09:57:37.848] <TB3> QUIET: Connection to board 121 closed.
[09:57:37.929] <TB3> INFO: pXar: this is the end, my friend

[09:58:08.473] <TB3> INFO: *** Welcome to pxar ***
[09:58:08.473] <TB3> INFO: *** Today: 2015/11/04
[09:58:08.556] <TB3> INFO: *** Version: 7db0-dirty
[09:58:08.557] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//dacParameters35_C15.dat
[09:58:08.558] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0b.dat
[09:58:08.558] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[09:58:08.558] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[09:58:08.631] <TB3> INFO: clk: 4
[09:58:08.631] <TB3> INFO: ctr: 4
[09:58:08.631] <TB3> INFO: sda: 19
[09:58:08.631] <TB3> INFO: tin: 9
[09:58:08.631] <TB3> INFO: level: 15
[09:58:08.631] <TB3> INFO: triggerdelay: 0
[09:58:08.631] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[09:58:08.631] <TB3> INFO: Log level: INFO
[09:58:08.644] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:58:08.656] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:58:08.659] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:58:08.661] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:58:10.214] <TB3> INFO: DUT info:
[09:58:10.214] <TB3> INFO: The DUT currently contains the following objects:
[09:58:10.214] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[09:58:10.214] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:58:10.214] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:58:10.214] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:58:10.214] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.214] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:10.615] <TB3> INFO: enter 'restricted' command line mode
[09:58:10.615] <TB3> INFO: enter test to run
[09:58:10.615] <TB3> INFO: test: delay setting parameters: ->5<-
[09:58:10.616] <TB3> INFO: delay test by 5 seconds...
[09:58:15.616] <TB3> INFO: enter test to run
[09:58:15.616] <TB3> INFO: test: highrate no parameter change
[09:58:15.616] <TB3> INFO: running: highrate
[09:58:15.619] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C15.dat
[09:58:15.778] <TB3> INFO: ----------------------------------------------------------------------
[09:58:15.778] <TB3> INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[09:58:15.778] <TB3> INFO: ----------------------------------------------------------------------
[09:58:15.778] <TB3> INFO: THR = 10, corresponding to ~ 5.33333 MHz/cm2
[09:58:15.778] <TB3> INFO: edge/corner pixel THR is adjusted
[09:58:15.778] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:58:16.736] <TB3> INFO: Collecting data for 5 seconds...
[09:58:21.746] <TB3> INFO: Done with hot pixel readout
[09:58:29.866] <TB3> INFO: PixTest:: pg_setup set to default.
[09:58:29.867] <TB3> INFO: 8 hot pixels found in step 0
[09:58:30.998] <TB3> INFO: Collecting data for 5 seconds...
[09:58:36.008] <TB3> INFO: Done with hot pixel readout
[09:58:44.459] <TB3> INFO: PixTest:: pg_setup set to default.
[09:58:44.460] <TB3> INFO: 4 hot pixels found in step 1
[09:58:45.590] <TB3> INFO: Collecting data for 5 seconds...
[09:58:50.602] <TB3> INFO: Done with hot pixel readout
[09:58:58.811] <TB3> INFO: PixTest:: pg_setup set to default.
[09:58:58.812] <TB3> INFO: 4 hot pixels found in step 2
[09:58:59.904] <TB3> INFO: Collecting data for 5 seconds...
[09:59:04.926] <TB3> INFO: Done with hot pixel readout
[09:59:12.600] <TB3> INFO: PixTest:: pg_setup set to default.
[09:59:12.601] <TB3> INFO: 2 hot pixels found in step 3
[09:59:13.634] <TB3> INFO: Collecting data for 5 seconds...
[09:59:18.646] <TB3> INFO: Done with hot pixel readout
[09:59:26.423] <TB3> INFO: PixTest:: pg_setup set to default.
[09:59:26.424] <TB3> INFO: 2 hot pixels found in step 4
[09:59:27.511] <TB3> INFO: Collecting data for 5 seconds...
[09:59:32.517] <TB3> INFO: Done with hot pixel readout
[09:59:38.944] <TB3> INFO: PixTest:: pg_setup set to default.
[09:59:38.945] <TB3> INFO: 0 hot pixels found in step 5
[09:59:38.948] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[09:59:39.126] <TB3> INFO: PixTest::trimHotPixels() done
[09:59:39.126] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat
[09:59:39.132] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C1.dat
[09:59:39.138] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C2.dat
[09:59:39.144] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C3.dat
[09:59:39.150] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C4.dat
[09:59:39.156] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C5.dat
[09:59:39.162] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C6.dat
[09:59:39.168] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C7.dat
[09:59:39.174] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C8.dat
[09:59:39.180] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C9.dat
[09:59:39.185] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C10.dat
[09:59:39.191] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C11.dat
[09:59:39.197] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C12.dat
[09:59:39.203] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C13.dat
[09:59:39.209] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C14.dat
[09:59:39.215] <TB3> INFO: write trim parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[09:59:39.221] <TB3> INFO: write masked pixels into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[09:59:39.249] <TB3> INFO: enter test to run
[09:59:39.249] <TB3> INFO: test: no parameter change
[09:59:39.306] <TB3> QUIET: Connection to board 121 closed.
[09:59:39.386] <TB3> INFO: pXar: this is the end, my friend

[10:00:06.716] <TB3> INFO: *** Welcome to pxar ***
[10:00:06.717] <TB3> INFO: *** Today: 2015/11/04
[10:00:06.811] <TB3> INFO: *** Version: 7db0-dirty
[10:00:06.811] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//dacParameters35_C15.dat
[10:00:06.812] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//tbmParameters_C0b.dat
[10:00:06.812] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//defaultMaskFile.dat
[10:00:06.812] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//trimParameters35_C15.dat
[10:00:06.888] <TB3> INFO: clk: 4
[10:00:06.888] <TB3> INFO: ctr: 4
[10:00:06.888] <TB3> INFO: sda: 19
[10:00:06.888] <TB3> INFO: tin: 9
[10:00:06.888] <TB3> INFO: level: 15
[10:00:06.888] <TB3> INFO: triggerdelay: 0
[10:00:06.888] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:00:06.888] <TB3> INFO: Log level: INFO
[10:00:06.902] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:00:06.914] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:00:06.917] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:00:06.920] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:00:08.469] <TB3> INFO: DUT info:
[10:00:08.469] <TB3> INFO: The DUT currently contains the following objects:
[10:00:08.469] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:00:08.469] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:00:08.469] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:00:08.469] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:00:08.469] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.469] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:00:08.870] <TB3> INFO: enter 'restricted' command line mode
[10:00:08.871] <TB3> INFO: enter test to run
[10:00:08.871] <TB3> INFO: test: delay setting parameters: ->5<-
[10:00:08.871] <TB3> INFO: delay test by 5 seconds...
[10:00:13.871] <TB3> INFO: enter test to run
[10:00:13.871] <TB3> INFO: test: Xray no parameter change
[10:00:13.871] <TB3> INFO: running: xray
[10:00:13.875] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//004_HRData_50//phCalibrationFitErr35_C15.dat
[10:00:14.023] <TB3> INFO: ######################################################################
[10:00:14.023] <TB3> INFO: PixTestXray::doTest()
[10:00:14.023] <TB3> INFO: ######################################################################
[10:00:14.023] <TB3> INFO: ----------------------------------------------------------------------
[10:00:14.023] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[10:00:14.023] <TB3> INFO: ----------------------------------------------------------------------
[10:00:14.987] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[10:00:24.460] <TB3> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[10:00:54.969] <TB3> INFO: Resuming triggers.
[10:01:04.452] <TB3> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[10:01:33.063] <TB3> INFO: Resuming triggers.
[10:01:42.532] <TB3> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[10:02:11.646] <TB3> INFO: Resuming triggers.
[10:02:21.116] <TB3> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[10:02:51.122] <TB3> INFO: Resuming triggers.
[10:03:00.590] <TB3> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[10:03:31.557] <TB3> INFO: Resuming triggers.
[10:03:41.014] <TB3> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[10:04:10.883] <TB3> INFO: Resuming triggers.
[10:04:20.336] <TB3> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[10:04:51.426] <TB3> INFO: Resuming triggers.
[10:05:00.882] <TB3> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[10:05:30.484] <TB3> INFO: Resuming triggers.
[10:05:39.942] <TB3> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[10:06:09.378] <TB3> INFO: Resuming triggers.
[10:06:18.820] <TB3> INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[10:06:47.930] <TB3> INFO: Resuming triggers.
[10:06:53.492] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[10:07:11.305] <TB3> INFO: PixTest:: pg_setup set to default.
[10:07:11.307] <TB3> INFO: PixTestXray::doPhRun() done
[10:07:11.315] <TB3> INFO: PixTestXray::doTest() done
[10:07:11.506] <TB3> INFO: enter test to run
[10:07:11.506] <TB3> INFO: test: no parameter change
[10:07:11.627] <TB3> QUIET: Connection to board 121 closed.
[10:07:11.706] <TB3> INFO: pXar: this is the end, my friend

[10:08:02.737] <TB3> INFO: *** Welcome to pxar ***
[10:08:02.737] <TB3> INFO: *** Today: 2015/11/04
[10:08:02.901] <TB3> INFO: *** Version: 7db0-dirty
[10:08:02.901] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//dacParameters35_C15.dat
[10:08:02.903] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//tbmParameters_C0b.dat
[10:08:02.903] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//defaultMaskFile.dat
[10:08:02.903] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//trimParameters35_C15.dat
[10:08:02.984] <TB3> INFO: clk: 4
[10:08:02.984] <TB3> INFO: ctr: 4
[10:08:02.984] <TB3> INFO: sda: 19
[10:08:02.984] <TB3> INFO: tin: 9
[10:08:02.984] <TB3> INFO: level: 15
[10:08:02.984] <TB3> INFO: triggerdelay: 0
[10:08:02.984] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:08:02.984] <TB3> INFO: Log level: INFO
[10:08:02.996] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:08:03.008] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:08:03.011] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:08:03.014] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:08:04.590] <TB3> INFO: DUT info:
[10:08:04.591] <TB3> INFO: The DUT currently contains the following objects:
[10:08:04.591] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:08:04.591] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:08:04.591] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:08:04.591] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:08:04.591] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.591] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.592] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.592] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:08:04.993] <TB3> INFO: enter 'restricted' command line mode
[10:08:04.993] <TB3> INFO: enter test to run
[10:08:04.993] <TB3> INFO: test: delay setting parameters: ->5<-
[10:08:04.993] <TB3> INFO: delay test by 5 seconds...
[10:08:09.993] <TB3> INFO: enter test to run
[10:08:09.993] <TB3> INFO: test: Xray no parameter change
[10:08:09.993] <TB3> INFO: running: xray
[10:08:09.999] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//005_HRData_150//phCalibrationFitErr35_C15.dat
[10:08:10.184] <TB3> INFO: ######################################################################
[10:08:10.184] <TB3> INFO: PixTestXray::doTest()
[10:08:10.184] <TB3> INFO: ######################################################################
[10:08:10.184] <TB3> INFO: ----------------------------------------------------------------------
[10:08:10.184] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[10:08:10.184] <TB3> INFO: ----------------------------------------------------------------------
[10:08:11.148] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[10:08:16.206] <TB3> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[10:08:45.205] <TB3> INFO: Resuming triggers.
[10:08:50.265] <TB3> INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[10:09:19.700] <TB3> INFO: Resuming triggers.
[10:09:24.760] <TB3> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[10:09:54.006] <TB3> INFO: Resuming triggers.
[10:09:59.070] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[10:10:29.235] <TB3> INFO: Resuming triggers.
[10:10:34.293] <TB3> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[10:11:05.404] <TB3> INFO: Resuming triggers.
[10:11:10.463] <TB3> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[10:11:43.131] <TB3> INFO: Resuming triggers.
[10:11:48.186] <TB3> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[10:12:22.374] <TB3> INFO: Resuming triggers.
[10:12:27.424] <TB3> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[10:13:00.782] <TB3> INFO: Resuming triggers.
[10:13:05.838] <TB3> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[10:13:38.243] <TB3> INFO: Resuming triggers.
[10:13:43.291] <TB3> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[10:14:15.666] <TB3> INFO: Resuming triggers.
[10:14:20.717] <TB3> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[10:14:52.645] <TB3> INFO: Resuming triggers.
[10:14:57.692] <TB3> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[10:15:28.994] <TB3> INFO: Resuming triggers.
[10:15:34.041] <TB3> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[10:16:06.385] <TB3> INFO: Resuming triggers.
[10:16:11.439] <TB3> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[10:16:42.284] <TB3> INFO: Resuming triggers.
[10:16:47.339] <TB3> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[10:17:16.323] <TB3> INFO: Resuming triggers.
[10:17:21.377] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[10:17:50.145] <TB3> INFO: Resuming triggers.
[10:17:55.190] <TB3> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[10:18:26.175] <TB3> INFO: Resuming triggers.
[10:18:31.232] <TB3> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[10:19:02.095] <TB3> INFO: Resuming triggers.
[10:19:07.143] <TB3> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[10:19:36.253] <TB3> INFO: Resuming triggers.
[10:19:40.433] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[10:20:04.955] <TB3> INFO: PixTest:: pg_setup set to default.
[10:20:04.957] <TB3> INFO: PixTestXray::doPhRun() done
[10:20:04.957] <TB3> INFO: PixTestXray::doTest() done
[10:20:05.144] <TB3> INFO: enter test to run
[10:20:05.144] <TB3> INFO: test: no parameter change
[10:20:05.258] <TB3> QUIET: Connection to board 121 closed.
[10:20:05.350] <TB3> INFO: pXar: this is the end, my friend

[10:22:35.548] <TB3> INFO: *** Welcome to pxar ***
[10:22:35.548] <TB3> INFO: *** Today: 2015/11/04
[10:22:35.617] <TB3> INFO: *** Version: 7db0-dirty
[10:22:35.617] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//dacParameters35_C15.dat
[10:22:35.618] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//tbmParameters_C0b.dat
[10:22:35.618] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//defaultMaskFile.dat
[10:22:35.618] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//trimParameters35_C15.dat
[10:22:35.714] <TB3> INFO: clk: 4
[10:22:35.714] <TB3> INFO: ctr: 4
[10:22:35.714] <TB3> INFO: sda: 19
[10:22:35.714] <TB3> INFO: tin: 9
[10:22:35.714] <TB3> INFO: level: 15
[10:22:35.714] <TB3> INFO: triggerdelay: 0
[10:22:35.714] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:22:35.714] <TB3> INFO: Log level: INFO
[10:22:35.729] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:22:35.740] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:22:35.744] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:22:35.747] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:22:37.365] <TB3> INFO: DUT info:
[10:22:37.365] <TB3> INFO: The DUT currently contains the following objects:
[10:22:37.365] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:22:37.365] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:22:37.365] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:22:37.365] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:22:37.365] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.365] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:22:37.767] <TB3> INFO: enter 'restricted' command line mode
[10:22:37.767] <TB3> INFO: enter test to run
[10:22:37.767] <TB3> INFO: test: Highrate no parameter change
[10:22:37.767] <TB3> INFO: running: highrate
[10:22:37.770] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[10:22:37.932] <TB3> INFO: ----------------------------------------------------------------------
[10:22:37.933] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[10:22:37.933] <TB3> INFO: ----------------------------------------------------------------------
[10:22:37.938] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[10:22:37.950] <TB3> INFO: dacScan step from 15 .. 34
[10:22:37.950] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:22:37.950] <TB3> INFO: run 1 of 1
[10:22:38.556] <TB3> INFO: Expecting 4160000 events.
[10:23:15.222] <TB3> INFO: 641550 events read in total (36138ms).
[10:23:51.210] <TB3> INFO: 1285250 events read in total (72126ms).
[10:24:28.018] <TB3> INFO: 1929500 events read in total (108934ms).
[10:25:05.019] <TB3> INFO: 2572850 events read in total (145935ms).
[10:25:41.250] <TB3> INFO: 3215250 events read in total (182166ms).
[10:26:18.060] <TB3> INFO: 3856550 events read in total (218976ms).
[10:26:35.112] <TB3> INFO: 4160000 events read in total (236028ms).
[10:26:35.302] <TB3> INFO: Test took 237351ms.
[10:26:38.433] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:26:43.286] <TB3> INFO: dacScan step from 35 .. 54
[10:26:43.286] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:26:43.286] <TB3> INFO: run 1 of 1
[10:26:43.882] <TB3> INFO: Expecting 4160000 events.
[10:27:14.427] <TB3> INFO: 488350 events read in total (30019ms).
[10:27:48.042] <TB3> INFO: 977100 events read in total (63634ms).
[10:28:21.790] <TB3> INFO: 1463950 events read in total (97382ms).
[10:28:54.690] <TB3> INFO: 1949000 events read in total (130282ms).
[10:29:27.953] <TB3> INFO: 2431050 events read in total (163545ms).
[10:30:00.596] <TB3> INFO: 2908000 events read in total (196188ms).
[10:30:33.524] <TB3> INFO: 3380450 events read in total (229116ms).
[10:31:06.176] <TB3> INFO: 3850350 events read in total (261768ms).
[10:31:27.730] <TB3> INFO: 4160000 events read in total (283322ms).
[10:31:27.874] <TB3> INFO: Test took 284587ms.
[10:31:29.371] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:31:34.014] <TB3> INFO: dacScan step from 55 .. 74
[10:31:34.014] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:31:34.014] <TB3> INFO: run 1 of 1
[10:31:34.622] <TB3> INFO: Expecting 4160000 events.
[10:32:07.403] <TB3> INFO: 433200 events read in total (32245ms).
[10:32:39.154] <TB3> INFO: 866850 events read in total (63996ms).
[10:33:11.960] <TB3> INFO: 1300650 events read in total (96802ms).
[10:33:44.706] <TB3> INFO: 1734200 events read in total (129548ms).
[10:34:17.537] <TB3> INFO: 2167950 events read in total (162379ms).
[10:34:50.937] <TB3> INFO: 2601600 events read in total (195779ms).
[10:35:24.858] <TB3> INFO: 3035100 events read in total (229700ms).
[10:35:59.198] <TB3> INFO: 3469100 events read in total (264040ms).
[10:36:32.959] <TB3> INFO: 3902800 events read in total (297801ms).
[10:36:53.425] <TB3> INFO: 4160000 events read in total (318267ms).
[10:36:53.632] <TB3> INFO: Test took 319618ms.
[10:36:55.116] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:59.701] <TB3> INFO: dacScan step from 75 .. 75
[10:36:59.702] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:36:59.702] <TB3> INFO: run 1 of 1
[10:37:00.310] <TB3> INFO: Expecting 208000 events.
[10:37:18.152] <TB3> INFO: 208000 events read in total (17317ms).
[10:37:18.159] <TB3> INFO: Test took 18457ms.
[10:37:18.233] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:37:18.460] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:19.686] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:20.820] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:22.044] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:23.245] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:24.379] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:25.466] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:26.650] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:27.783] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:28.887] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:30.002] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:31.144] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:32.340] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:33.480] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:34.547] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:35.583] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:37:36.628] <TB3> INFO: PixTest:: pg_setup set to default.
[10:37:36.630] <TB3> INFO: vcal mean: 36.85 36.45 36.04 39.74 39.51 41.43 41.69 41.07 41.59 41.85 42.34 40.24 38.77 36.27 38.56 37.86
[10:37:36.630] <TB3> INFO: vcal RMS: 1.10 2.64 1.26 1.46 1.17 1.45 1.64 1.55 1.45 2.02 1.57 1.49 1.34 1.55 1.35 1.07
[10:37:36.630] <TB3> INFO: number of X-ray hits detected: 160464 166090 140343 269780 267720 344469 317751 334082 322945 338753 384657 302087 293863 175470 182108 180438
[10:37:36.630] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:37:36.630] <TB3> INFO: X-ray hit rate [MHz/cm2]: 47.0 48.7 41.1 79.1 78.5 101.0 93.1 97.9 94.7 99.3 112.7 88.5 86.1 51.4 53.4 52.9
[10:37:36.630] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[10:37:36.758] <TB3> INFO: enter test to run
[10:37:36.758] <TB3> INFO: test: no parameter change
[10:37:36.840] <TB3> QUIET: Connection to board 121 closed.
[10:37:36.921] <TB3> INFO: pXar: this is the end, my friend

[11:15:33.374] <TB3> INFO: *** Welcome to pxar ***
[11:15:33.374] <TB3> INFO: *** Today: 2015/11/04
[11:15:33.576] <TB3> INFO: *** Version: 7db0-dirty
[11:15:33.576] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:15:33.578] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[11:15:33.578] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[11:15:33.578] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[11:15:33.656] <TB3> INFO: clk: 4
[11:15:33.656] <TB3> INFO: ctr: 4
[11:15:33.656] <TB3> INFO: sda: 19
[11:15:33.656] <TB3> INFO: tin: 9
[11:15:33.656] <TB3> INFO: level: 15
[11:15:33.656] <TB3> INFO: triggerdelay: 0
[11:15:33.656] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:15:33.656] <TB3> INFO: Log level: INFO
[11:15:33.670] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:15:33.682] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:15:33.685] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:15:33.688] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:15:35.231] <TB3> INFO: DUT info:
[11:15:35.231] <TB3> INFO: The DUT currently contains the following objects:
[11:15:35.231] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:15:35.231] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:15:35.231] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:15:35.231] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:15:35.231] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.231] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.231] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.232] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:15:35.633] <TB3> INFO: enter 'restricted' command line mode
[11:15:35.633] <TB3> INFO: enter test to run
[11:15:35.633] <TB3> INFO: test: HighRate no parameter change
[11:15:35.633] <TB3> INFO: running: highrate
[11:15:35.639] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[11:15:35.795] <TB3> INFO: ----------------------------------------------------------------------
[11:15:35.795] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:15:35.795] <TB3> INFO: ----------------------------------------------------------------------
[11:15:35.932] <TB3> INFO: Expecting 768 events.
[11:15:37.069] <TB3> INFO: 768 events read in total (420ms).
[11:15:37.258] <TB3> INFO: Test took 1459ms.
[11:15:37.886] <TB3> INFO: Expecting 41600 events.
[11:15:41.558] <TB3> INFO: 41600 events read in total (3146ms).
[11:15:41.560] <TB3> INFO: Test took 4298ms.
[11:15:41.632] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:42.283] <TB3> INFO: Expecting 41600 events.
[11:15:45.806] <TB3> INFO: 41600 events read in total (2996ms).
[11:15:45.808] <TB3> INFO: Test took 4148ms.
[11:15:45.882] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:46.529] <TB3> INFO: Expecting 41600 events.
[11:15:50.155] <TB3> INFO: 41600 events read in total (3099ms).
[11:15:50.157] <TB3> INFO: Test took 4240ms.
[11:15:50.227] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:50.869] <TB3> INFO: Expecting 41600 events.
[11:15:54.633] <TB3> INFO: 41600 events read in total (3237ms).
[11:15:54.634] <TB3> INFO: Test took 4377ms.
[11:15:54.704] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:55.360] <TB3> INFO: Expecting 41600 events.
[11:15:58.968] <TB3> INFO: 41600 events read in total (3081ms).
[11:15:58.970] <TB3> INFO: Test took 4240ms.
[11:15:59.038] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:59.695] <TB3> INFO: Expecting 41600 events.
[11:16:03.342] <TB3> INFO: 41600 events read in total (3121ms).
[11:16:03.343] <TB3> INFO: Test took 4279ms.
[11:16:03.412] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:04.072] <TB3> INFO: Expecting 41600 events.
[11:16:07.770] <TB3> INFO: 41600 events read in total (3171ms).
[11:16:07.772] <TB3> INFO: Test took 4332ms.
[11:16:07.842] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:08.488] <TB3> INFO: Expecting 41600 events.
[11:16:12.212] <TB3> INFO: 41600 events read in total (3197ms).
[11:16:12.213] <TB3> INFO: Test took 4339ms.
[11:16:12.286] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:12.933] <TB3> INFO: Expecting 41600 events.
[11:16:16.708] <TB3> INFO: 41600 events read in total (3249ms).
[11:16:16.710] <TB3> INFO: Test took 4395ms.
[11:16:16.789] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:17.458] <TB3> INFO: Expecting 41600 events.
[11:16:21.165] <TB3> INFO: 41600 events read in total (3181ms).
[11:16:21.167] <TB3> INFO: Test took 4345ms.
[11:16:21.240] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:21.881] <TB3> INFO: Expecting 41600 events.
[11:16:25.812] <TB3> INFO: 41600 events read in total (3404ms).
[11:16:25.813] <TB3> INFO: Test took 4547ms.
[11:16:25.881] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:26.536] <TB3> INFO: Expecting 41600 events.
[11:16:30.372] <TB3> INFO: 41600 events read in total (3310ms).
[11:16:30.374] <TB3> INFO: Test took 4465ms.
[11:16:30.442] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:31.090] <TB3> INFO: Expecting 41600 events.
[11:16:34.767] <TB3> INFO: 41600 events read in total (3150ms).
[11:16:34.769] <TB3> INFO: Test took 4296ms.
[11:16:34.852] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:35.503] <TB3> INFO: Expecting 41600 events.
[11:16:39.402] <TB3> INFO: 41600 events read in total (3372ms).
[11:16:39.404] <TB3> INFO: Test took 4513ms.
[11:16:39.484] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:40.139] <TB3> INFO: Expecting 41600 events.
[11:16:43.866] <TB3> INFO: 41600 events read in total (3201ms).
[11:16:43.867] <TB3> INFO: Test took 4356ms.
[11:16:43.946] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:44.596] <TB3> INFO: Expecting 41600 events.
[11:16:48.298] <TB3> INFO: 41600 events read in total (3176ms).
[11:16:48.300] <TB3> INFO: Test took 4324ms.
[11:16:48.369] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:49.022] <TB3> INFO: Expecting 41600 events.
[11:16:52.730] <TB3> INFO: 41600 events read in total (3182ms).
[11:16:52.731] <TB3> INFO: Test took 4336ms.
[11:16:52.799] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:53.457] <TB3> INFO: Expecting 41600 events.
[11:16:57.099] <TB3> INFO: 41600 events read in total (3115ms).
[11:16:57.101] <TB3> INFO: Test took 4276ms.
[11:16:57.169] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:57.826] <TB3> INFO: Expecting 41600 events.
[11:17:01.044] <TB3> INFO: 41600 events read in total (2693ms).
[11:17:01.046] <TB3> INFO: Test took 3851ms.
[11:17:01.115] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:01.775] <TB3> INFO: Expecting 41600 events.
[11:17:04.894] <TB3> INFO: 41600 events read in total (2593ms).
[11:17:04.895] <TB3> INFO: Test took 3754ms.
[11:17:04.962] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:05.293] <TB3> INFO: enter test to run
[11:17:05.293] <TB3> INFO: test: Pretest no parameter change
[11:17:05.293] <TB3> INFO: running: pretest
[11:17:05.293] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[11:17:05.294] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[11:17:05.294] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[11:17:05.294] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[11:17:05.294] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[11:17:05.294] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[11:17:05.294] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[11:17:05.294] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[11:17:05.294] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[11:17:05.295] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[11:17:05.295] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[11:17:05.295] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[11:17:05.295] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[11:17:05.295] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[11:17:05.295] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[11:17:05.295] <TB3> INFO: write dac parameters into /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:17:05.295] <TB3> INFO: enter test to run
[11:17:05.295] <TB3> INFO: test: no parameter change
[11:17:05.404] <TB3> QUIET: Connection to board 121 closed.
[11:17:05.484] <TB3> INFO: pXar: this is the end, my friend

[11:17:29.076] <TB3> INFO: *** Welcome to pxar ***
[11:17:29.076] <TB3> INFO: *** Today: 2015/11/04
[11:17:29.276] <TB3> INFO: *** Version: 7db0-dirty
[11:17:29.277] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//dacParameters35_C15.dat
[11:17:29.278] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//tbmParameters_C0b.dat
[11:17:29.278] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//defaultMaskFile.dat
[11:17:29.278] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//trimParameters35_C15.dat
[11:17:29.368] <TB3> INFO: clk: 4
[11:17:29.368] <TB3> INFO: ctr: 4
[11:17:29.368] <TB3> INFO: sda: 19
[11:17:29.368] <TB3> INFO: tin: 9
[11:17:29.368] <TB3> INFO: level: 15
[11:17:29.368] <TB3> INFO: triggerdelay: 0
[11:17:29.368] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:17:29.368] <TB3> INFO: Log level: INFO
[11:17:29.381] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:17:29.392] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:17:29.396] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:17:29.403] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:17:30.981] <TB3> INFO: DUT info:
[11:17:30.981] <TB3> INFO: The DUT currently contains the following objects:
[11:17:30.981] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:17:30.981] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:17:30.981] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:17:30.982] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:17:30.982] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.982] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:31.383] <TB3> INFO: enter 'restricted' command line mode
[11:17:31.383] <TB3> INFO: enter test to run
[11:17:31.383] <TB3> INFO: test: PixelAlive no parameter change
[11:17:31.383] <TB3> INFO: running: pixelalive
[11:17:31.391] <TB3> INFO: ######################################################################
[11:17:31.391] <TB3> INFO: PixTestAlive::doTest()
[11:17:31.391] <TB3> INFO: ######################################################################
[11:17:31.392] <TB3> INFO: ----------------------------------------------------------------------
[11:17:31.392] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:17:31.392] <TB3> INFO: ----------------------------------------------------------------------
[11:17:31.722] <TB3> INFO: Expecting 208000 events.
[11:17:43.011] <TB3> INFO: 208000 events read in total (10571ms).
[11:17:43.125] <TB3> INFO: Test took 11731ms.
[11:17:43.133] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:43.392] <TB3> INFO: PixTestAlive::aliveTest() done
[11:17:43.392] <TB3> INFO: number of dead pixels (per ROC): 0 19 3 0 0 0 5 0 1 7 0 0 0 5 3 0
[11:17:43.394] <TB3> INFO: ----------------------------------------------------------------------
[11:17:43.394] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:17:43.394] <TB3> INFO: ----------------------------------------------------------------------
[11:17:43.735] <TB3> INFO: Expecting 208000 events.
[11:17:50.463] <TB3> INFO: 208000 events read in total (6013ms).
[11:17:50.463] <TB3> INFO: Test took 7067ms.
[11:17:50.463] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:50.463] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:17:50.871] <TB3> INFO: PixTestAlive::maskTest() done
[11:17:50.871] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:17:50.873] <TB3> INFO: ----------------------------------------------------------------------
[11:17:50.873] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:17:50.873] <TB3> INFO: ----------------------------------------------------------------------
[11:17:51.192] <TB3> INFO: Expecting 208000 events.
[11:18:02.117] <TB3> INFO: 208000 events read in total (10210ms).
[11:18:02.118] <TB3> INFO: Test took 11242ms.
[11:18:02.124] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:02.443] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:18:02.443] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:18:02.443] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[11:18:02.477] <TB3> INFO: enter test to run
[11:18:02.477] <TB3> INFO: test: delay setting parameters: ->2<-
[11:18:02.477] <TB3> INFO: delay test by 2 seconds...
[11:18:04.477] <TB3> INFO: enter test to run
[11:18:04.477] <TB3> INFO: test: HighRate no parameter change
[11:18:04.477] <TB3> INFO: running: highrate
[11:18:04.478] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[11:18:04.641] <TB3> INFO: ----------------------------------------------------------------------
[11:18:04.641] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:18:04.641] <TB3> INFO: ----------------------------------------------------------------------
[11:18:05.249] <TB3> INFO: Expecting 208000 events.
[11:18:16.840] <TB3> INFO: 208000 events read in total (11065ms).
[11:18:16.845] <TB3> INFO: Test took 12200ms.
[11:18:17.074] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:17.345] <TB3> INFO: number of dead pixels (per ROC): 0 19 2 0 0 0 5 0 1 7 0 0 0 4 3 0
[11:18:17.345] <TB3> INFO: number of red-efficiency pixels: 105 113 101 186 175 278 250 222 257 260 322 217 246 132 101 110
[11:18:17.346] <TB3> INFO: number of X-ray hits detected: 78909 81554 68645 133493 133025 175073 158610 167066 161617 168971 193616 150656 147440 85779 89468 89536
[11:18:17.346] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:18:17.346] <TB3> INFO: number of Vcal hits detected: 207894 206954 207752 207808 207819 207709 207492 207770 207683 207389 207657 207768 207745 207599 207751 207888
[11:18:17.346] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[11:18:17.346] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.5 99.9 99.9 99.9 99.9 99.8 99.9 99.8 99.7 99.8 99.9 99.9 99.8 99.9 99.9
[11:18:17.346] <TB3> INFO: X-ray hit rate [MHz/cm2]: 23.1 23.9 20.1 39.1 39.0 51.3 46.5 49.0 47.4 49.5 56.8 44.2 43.2 25.1 26.2 26.2
[11:18:17.346] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:18:17.372] <TB3> INFO: PixTest:: pg_setup set to default.
[11:18:17.380] <TB3> INFO: enter test to run
[11:18:17.380] <TB3> INFO: test: no parameter change
[11:18:17.459] <TB3> QUIET: Connection to board 121 closed.
[11:18:17.539] <TB3> INFO: pXar: this is the end, my friend

[11:18:42.047] <TB3> INFO: *** Welcome to pxar ***
[11:18:42.047] <TB3> INFO: *** Today: 2015/11/04
[11:18:42.112] <TB3> INFO: *** Version: 7db0-dirty
[11:18:42.112] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//dacParameters35_C15.dat
[11:18:42.112] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//tbmParameters_C0b.dat
[11:18:42.113] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//defaultMaskFile.dat
[11:18:42.113] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//trimParameters35_C15.dat
[11:18:42.198] <TB3> INFO: clk: 4
[11:18:42.198] <TB3> INFO: ctr: 4
[11:18:42.198] <TB3> INFO: sda: 19
[11:18:42.198] <TB3> INFO: tin: 9
[11:18:42.198] <TB3> INFO: level: 15
[11:18:42.198] <TB3> INFO: triggerdelay: 0
[11:18:42.198] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:18:42.198] <TB3> INFO: Log level: INFO
[11:18:42.210] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:18:42.221] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:18:42.224] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:18:42.227] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:18:43.779] <TB3> INFO: DUT info:
[11:18:43.779] <TB3> INFO: The DUT currently contains the following objects:
[11:18:43.779] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:18:43.779] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:18:43.779] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:18:43.779] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:18:43.779] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.779] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.780] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.780] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.780] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.780] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:43.780] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:44.181] <TB3> INFO: enter 'restricted' command line mode
[11:18:44.181] <TB3> INFO: enter test to run
[11:18:44.181] <TB3> INFO: test: PixelAlive no parameter change
[11:18:44.181] <TB3> INFO: running: pixelalive
[11:18:44.187] <TB3> INFO: ######################################################################
[11:18:44.187] <TB3> INFO: PixTestAlive::doTest()
[11:18:44.187] <TB3> INFO: ######################################################################
[11:18:44.189] <TB3> INFO: ----------------------------------------------------------------------
[11:18:44.189] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:18:44.189] <TB3> INFO: ----------------------------------------------------------------------
[11:18:44.500] <TB3> INFO: Expecting 208000 events.
[11:18:55.740] <TB3> INFO: 208000 events read in total (10523ms).
[11:18:55.838] <TB3> INFO: Test took 11647ms.
[11:18:55.844] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:56.100] <TB3> INFO: PixTestAlive::aliveTest() done
[11:18:56.100] <TB3> INFO: number of dead pixels (per ROC): 0 19 3 0 0 0 5 0 1 7 0 0 0 4 3 0
[11:18:56.101] <TB3> INFO: ----------------------------------------------------------------------
[11:18:56.102] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:18:56.102] <TB3> INFO: ----------------------------------------------------------------------
[11:18:56.418] <TB3> INFO: Expecting 208000 events.
[11:19:02.944] <TB3> INFO: 208000 events read in total (5811ms).
[11:19:02.945] <TB3> INFO: Test took 6842ms.
[11:19:02.945] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:02.945] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:19:03.346] <TB3> INFO: PixTestAlive::maskTest() done
[11:19:03.346] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:19:03.348] <TB3> INFO: ----------------------------------------------------------------------
[11:19:03.348] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:19:03.348] <TB3> INFO: ----------------------------------------------------------------------
[11:19:03.655] <TB3> INFO: Expecting 208000 events.
[11:19:14.629] <TB3> INFO: 208000 events read in total (10259ms).
[11:19:14.629] <TB3> INFO: Test took 11280ms.
[11:19:14.637] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:14.965] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:19:14.965] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:19:14.965] <TB3> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[11:19:14.995] <TB3> INFO: enter test to run
[11:19:14.995] <TB3> INFO: test: delay setting parameters: ->2<-
[11:19:14.995] <TB3> INFO: delay test by 2 seconds...
[11:19:16.996] <TB3> INFO: enter test to run
[11:19:16.996] <TB3> INFO: test: HighRate no parameter change
[11:19:16.996] <TB3> INFO: running: highrate
[11:19:16.996] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//013_HREfficiency_100//phCalibrationFitErr35_C15.dat
[11:19:17.166] <TB3> INFO: ----------------------------------------------------------------------
[11:19:17.166] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:19:17.166] <TB3> INFO: ----------------------------------------------------------------------
[11:19:17.787] <TB3> INFO: Expecting 208000 events.
[11:19:32.308] <TB3> INFO: 208000 events read in total (13994ms).
[11:19:32.316] <TB3> INFO: Test took 15146ms.
[11:19:32.761] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:33.106] <TB3> INFO: number of dead pixels (per ROC): 0 19 2 0 0 0 4 0 1 7 0 0 0 4 3 0
[11:19:33.106] <TB3> INFO: number of red-efficiency pixels: 295 265 320 592 644 992 874 912 848 934 1250 788 935 368 320 304
[11:19:33.106] <TB3> INFO: number of X-ray hits detected: 160565 166090 140449 268388 267944 347932 317329 334727 322728 337938 386391 301774 294223 175212 183256 180129
[11:19:33.106] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:19:33.106] <TB3> INFO: number of Vcal hits detected: 207688 206787 207487 207332 207277 206789 206702 206939 206966 206509 206348 207068 206871 207280 207513 207678
[11:19:33.106] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.5 99.5 99.5 99.6 99.5 99.3 99.6 99.5 99.8 99.8 99.9
[11:19:33.106] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.4 99.8 99.7 99.7 99.4 99.4 99.5 99.5 99.3 99.2 99.6 99.5 99.7 99.8 99.8
[11:19:33.106] <TB3> INFO: X-ray hit rate [MHz/cm2]: 47.1 48.7 41.2 78.7 78.5 102.0 93.0 98.1 94.6 99.1 113.3 88.5 86.2 51.4 53.7 52.8
[11:19:33.106] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:19:33.132] <TB3> INFO: PixTest:: pg_setup set to default.
[11:19:33.141] <TB3> INFO: enter test to run
[11:19:33.141] <TB3> INFO: test: no parameter change
[11:19:33.217] <TB3> QUIET: Connection to board 121 closed.
[11:19:33.297] <TB3> INFO: pXar: this is the end, my friend

[11:19:57.407] <TB3> INFO: *** Welcome to pxar ***
[11:19:57.407] <TB3> INFO: *** Today: 2015/11/04
[11:19:57.469] <TB3> INFO: *** Version: 7db0-dirty
[11:19:57.469] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//dacParameters35_C15.dat
[11:19:57.470] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//tbmParameters_C0b.dat
[11:19:57.470] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//defaultMaskFile.dat
[11:19:57.470] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//trimParameters35_C15.dat
[11:19:57.544] <TB3> INFO: clk: 4
[11:19:57.544] <TB3> INFO: ctr: 4
[11:19:57.544] <TB3> INFO: sda: 19
[11:19:57.544] <TB3> INFO: tin: 9
[11:19:57.544] <TB3> INFO: level: 15
[11:19:57.544] <TB3> INFO: triggerdelay: 0
[11:19:57.544] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:19:57.544] <TB3> INFO: Log level: INFO
[11:19:57.556] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:19:57.567] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:19:57.570] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:19:57.573] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:19:59.144] <TB3> INFO: DUT info:
[11:19:59.144] <TB3> INFO: The DUT currently contains the following objects:
[11:19:59.145] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:19:59.145] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:19:59.145] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:19:59.145] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:19:59.145] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.145] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:19:59.546] <TB3> INFO: enter 'restricted' command line mode
[11:19:59.546] <TB3> INFO: enter test to run
[11:19:59.546] <TB3> INFO: test: PixelAlive no parameter change
[11:19:59.546] <TB3> INFO: running: pixelalive
[11:19:59.555] <TB3> INFO: ######################################################################
[11:19:59.555] <TB3> INFO: PixTestAlive::doTest()
[11:19:59.555] <TB3> INFO: ######################################################################
[11:19:59.557] <TB3> INFO: ----------------------------------------------------------------------
[11:19:59.557] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:19:59.557] <TB3> INFO: ----------------------------------------------------------------------
[11:19:59.870] <TB3> INFO: Expecting 208000 events.
[11:20:11.128] <TB3> INFO: 208000 events read in total (10541ms).
[11:20:11.211] <TB3> INFO: Test took 11652ms.
[11:20:11.225] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:11.487] <TB3> INFO: PixTestAlive::aliveTest() done
[11:20:11.487] <TB3> INFO: number of dead pixels (per ROC): 0 19 3 0 0 0 4 0 1 7 0 0 0 4 3 0
[11:20:11.488] <TB3> INFO: ----------------------------------------------------------------------
[11:20:11.488] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:20:11.488] <TB3> INFO: ----------------------------------------------------------------------
[11:20:11.846] <TB3> INFO: Expecting 208000 events.
[11:20:18.560] <TB3> INFO: 208000 events read in total (5999ms).
[11:20:18.560] <TB3> INFO: Test took 7070ms.
[11:20:18.560] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:18.561] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:20:18.967] <TB3> INFO: PixTestAlive::maskTest() done
[11:20:18.967] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:20:18.968] <TB3> INFO: ----------------------------------------------------------------------
[11:20:18.968] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:20:18.968] <TB3> INFO: ----------------------------------------------------------------------
[11:20:19.281] <TB3> INFO: Expecting 208000 events.
[11:20:30.315] <TB3> INFO: 208000 events read in total (10319ms).
[11:20:30.316] <TB3> INFO: Test took 11346ms.
[11:20:30.325] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:30.638] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:20:30.638] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:20:30.638] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[11:20:30.670] <TB3> INFO: enter test to run
[11:20:30.670] <TB3> INFO: test: delay setting parameters: ->2<-
[11:20:30.670] <TB3> INFO: delay test by 2 seconds...
[11:20:32.670] <TB3> INFO: enter test to run
[11:20:32.670] <TB3> INFO: test: HighRate no parameter change
[11:20:32.670] <TB3> INFO: running: highrate
[11:20:32.670] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//014_HREfficiency_150//phCalibrationFitErr35_C15.dat
[11:20:32.864] <TB3> INFO: ----------------------------------------------------------------------
[11:20:32.864] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:20:32.864] <TB3> INFO: ----------------------------------------------------------------------
[11:20:33.469] <TB3> INFO: Expecting 208000 events.
[11:20:52.739] <TB3> INFO: 208000 events read in total (18744ms).
[11:20:52.751] <TB3> INFO: Test took 19884ms.
[11:20:53.382] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:53.783] <TB3> INFO: number of dead pixels (per ROC): 0 19 1 0 0 0 5 0 1 6 0 0 0 4 3 0
[11:20:53.783] <TB3> INFO: number of red-efficiency pixels: 549 499 598 1234 1262 2010 1733 1867 1714 1901 2383 1517 1926 731 586 599
[11:20:53.783] <TB3> INFO: number of X-ray hits detected: 234709 243267 207027 387867 386700 499510 454858 486084 463907 487026 554685 434729 425962 255406 266658 260859
[11:20:53.783] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:20:53.783] <TB3> INFO: number of Vcal hits detected: 207394 206529 206992 206317 206218 204779 204929 205259 205514 204586 203559 205648 204951 206611 207194 207331
[11:20:53.783] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.8 99.7 99.3 99.3 98.6 98.8 98.8 98.9 98.7 98.2 99.0 98.7 99.6 99.7 99.7
[11:20:53.783] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.3 99.5 99.2 99.1 98.5 98.5 98.7 98.8 98.4 97.9 98.9 98.5 99.3 99.6 99.7
[11:20:53.783] <TB3> INFO: X-ray hit rate [MHz/cm2]: 68.8 71.3 60.7 113.7 113.3 146.4 133.3 142.5 136.0 142.8 162.6 127.4 124.9 74.9 78.2 76.5
[11:20:53.783] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:20:53.811] <TB3> INFO: PixTest:: pg_setup set to default.
[11:20:53.821] <TB3> INFO: enter test to run
[11:20:53.821] <TB3> INFO: test: no parameter change
[11:20:53.890] <TB3> QUIET: Connection to board 121 closed.
[11:20:53.970] <TB3> INFO: pXar: this is the end, my friend

[11:21:17.954] <TB3> INFO: *** Welcome to pxar ***
[11:21:17.954] <TB3> INFO: *** Today: 2015/11/04
[11:21:18.005] <TB3> INFO: *** Version: 7db0-dirty
[11:21:18.005] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//dacParameters35_C15.dat
[11:21:18.005] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//tbmParameters_C0b.dat
[11:21:18.005] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//defaultMaskFile.dat
[11:21:18.005] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//trimParameters35_C15.dat
[11:21:18.077] <TB3> INFO: clk: 4
[11:21:18.077] <TB3> INFO: ctr: 4
[11:21:18.077] <TB3> INFO: sda: 19
[11:21:18.077] <TB3> INFO: tin: 9
[11:21:18.077] <TB3> INFO: level: 15
[11:21:18.077] <TB3> INFO: triggerdelay: 0
[11:21:18.077] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:21:18.077] <TB3> INFO: Log level: INFO
[11:21:18.090] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:21:18.102] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:21:18.105] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:21:18.107] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:21:19.677] <TB3> INFO: DUT info:
[11:21:19.677] <TB3> INFO: The DUT currently contains the following objects:
[11:21:19.677] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:21:19.678] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:21:19.678] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:21:19.678] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:21:19.678] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:19.678] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:20.080] <TB3> INFO: enter 'restricted' command line mode
[11:21:20.080] <TB3> INFO: enter test to run
[11:21:20.080] <TB3> INFO: test: PixelAlive no parameter change
[11:21:20.080] <TB3> INFO: running: pixelalive
[11:21:20.088] <TB3> INFO: ######################################################################
[11:21:20.088] <TB3> INFO: PixTestAlive::doTest()
[11:21:20.088] <TB3> INFO: ######################################################################
[11:21:20.090] <TB3> INFO: ----------------------------------------------------------------------
[11:21:20.090] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:21:20.090] <TB3> INFO: ----------------------------------------------------------------------
[11:21:20.401] <TB3> INFO: Expecting 208000 events.
[11:21:31.240] <TB3> INFO: 208000 events read in total (10121ms).
[11:21:31.345] <TB3> INFO: Test took 11253ms.
[11:21:31.354] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:31.624] <TB3> INFO: PixTestAlive::aliveTest() done
[11:21:31.624] <TB3> INFO: number of dead pixels (per ROC): 0 19 2 0 0 0 4 0 1 7 0 0 0 4 3 0
[11:21:31.626] <TB3> INFO: ----------------------------------------------------------------------
[11:21:31.626] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:21:31.626] <TB3> INFO: ----------------------------------------------------------------------
[11:21:31.971] <TB3> INFO: Expecting 208000 events.
[11:21:38.310] <TB3> INFO: 208000 events read in total (5624ms).
[11:21:38.310] <TB3> INFO: Test took 6683ms.
[11:21:38.310] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:38.311] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:21:38.713] <TB3> INFO: PixTestAlive::maskTest() done
[11:21:38.713] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:21:38.715] <TB3> INFO: ----------------------------------------------------------------------
[11:21:38.715] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:21:38.715] <TB3> INFO: ----------------------------------------------------------------------
[11:21:39.056] <TB3> INFO: Expecting 208000 events.
[11:21:50.659] <TB3> INFO: 208000 events read in total (10888ms).
[11:21:50.660] <TB3> INFO: Test took 11943ms.
[11:21:50.667] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:50.974] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:21:50.974] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:21:50.974] <TB3> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[11:21:51.017] <TB3> INFO: enter test to run
[11:21:51.017] <TB3> INFO: test: delay setting parameters: ->2<-
[11:21:51.017] <TB3> INFO: delay test by 2 seconds...
[11:21:53.017] <TB3> INFO: enter test to run
[11:21:53.017] <TB3> INFO: test: HighRate no parameter change
[11:21:53.017] <TB3> INFO: running: highrate
[11:21:53.017] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//015_HREfficiency_200//phCalibrationFitErr35_C15.dat
[11:21:53.171] <TB3> INFO: ----------------------------------------------------------------------
[11:21:53.171] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:21:53.171] <TB3> INFO: ----------------------------------------------------------------------
[11:21:53.776] <TB3> INFO: Expecting 208000 events.
[11:22:15.272] <TB3> INFO: 208000 events read in total (20970ms).
[11:22:15.286] <TB3> INFO: Test took 22111ms.
[11:22:16.121] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:16.597] <TB3> INFO: number of dead pixels (per ROC): 0 19 3 0 0 0 5 0 1 7 0 0 0 4 3 0
[11:22:16.597] <TB3> INFO: number of red-efficiency pixels: 1020 925 965 2236 2174 3137 2831 3099 2825 2995 3488 2557 3013 1222 1111 1042
[11:22:16.597] <TB3> INFO: number of X-ray hits detected: 318931 333128 283539 524610 522934 672849 614950 657485 626428 656178 745523 588200 574797 350659 362213 355409
[11:22:16.597] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:22:16.597] <TB3> INFO: number of Vcal hits detected: 206735 205975 205853 204067 203874 200195 201105 201389 202282 200365 197355 202381 200777 205196 206502 206703
[11:22:16.597] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.5 99.3 98.3 98.3 96.7 97.2 97.1 97.5 97.0 95.6 97.7 96.9 99.0 99.4 99.4
[11:22:16.597] <TB3> INFO: Vcal hit overall efficiency (%): 99.4 99.0 99.0 98.1 98.0 96.2 96.7 96.8 97.3 96.3 94.9 97.3 96.5 98.7 99.3 99.4
[11:22:16.597] <TB3> INFO: X-ray hit rate [MHz/cm2]: 93.5 97.6 83.1 153.8 153.3 197.2 180.2 192.7 183.6 192.3 218.5 172.4 168.5 102.8 106.2 104.2
[11:22:16.597] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:22:16.625] <TB3> INFO: PixTest:: pg_setup set to default.
[11:22:16.636] <TB3> INFO: enter test to run
[11:22:16.636] <TB3> INFO: test: no parameter change
[11:22:16.758] <TB3> QUIET: Connection to board 121 closed.
[11:22:16.837] <TB3> INFO: pXar: this is the end, my friend

[11:22:40.888] <TB3> INFO: *** Welcome to pxar ***
[11:22:40.888] <TB3> INFO: *** Today: 2015/11/04
[11:22:40.962] <TB3> INFO: *** Version: 7db0-dirty
[11:22:40.962] <TB3> INFO: readRocDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//dacParameters35_C15.dat
[11:22:40.963] <TB3> INFO: readTbmDacs: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//tbmParameters_C0b.dat
[11:22:40.963] <TB3> INFO: readMaskFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//defaultMaskFile.dat
[11:22:40.964] <TB3> INFO: readTrimFile: /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//trimParameters35_C15.dat
[11:22:41.060] <TB3> INFO: clk: 4
[11:22:41.060] <TB3> INFO: ctr: 4
[11:22:41.060] <TB3> INFO: sda: 19
[11:22:41.060] <TB3> INFO: tin: 9
[11:22:41.060] <TB3> INFO: level: 15
[11:22:41.060] <TB3> INFO: triggerdelay: 0
[11:22:41.060] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:22:41.060] <TB3> INFO: Log level: INFO
[11:22:41.074] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:22:41.086] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:22:41.089] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:22:41.094] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:22:42.655] <TB3> INFO: DUT info:
[11:22:42.655] <TB3> INFO: The DUT currently contains the following objects:
[11:22:42.655] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:22:42.655] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:22:42.655] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:22:42.655] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:22:42.655] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:42.655] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:22:43.056] <TB3> INFO: enter 'restricted' command line mode
[11:22:43.057] <TB3> INFO: enter test to run
[11:22:43.057] <TB3> INFO: test: PixelAlive no parameter change
[11:22:43.057] <TB3> INFO: running: pixelalive
[11:22:43.065] <TB3> INFO: ######################################################################
[11:22:43.066] <TB3> INFO: PixTestAlive::doTest()
[11:22:43.066] <TB3> INFO: ######################################################################
[11:22:43.067] <TB3> INFO: ----------------------------------------------------------------------
[11:22:43.067] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:22:43.067] <TB3> INFO: ----------------------------------------------------------------------
[11:22:43.415] <TB3> INFO: Expecting 208000 events.
[11:22:54.480] <TB3> INFO: 208000 events read in total (10347ms).
[11:22:54.562] <TB3> INFO: Test took 11493ms.
[11:22:54.576] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:54.841] <TB3> INFO: PixTestAlive::aliveTest() done
[11:22:54.841] <TB3> INFO: number of dead pixels (per ROC): 0 18 2 0 0 0 5 0 1 7 0 0 0 4 3 0
[11:22:54.843] <TB3> INFO: ----------------------------------------------------------------------
[11:22:54.843] <TB3> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:22:54.843] <TB3> INFO: ----------------------------------------------------------------------
[11:22:55.185] <TB3> INFO: Expecting 208000 events.
[11:23:01.891] <TB3> INFO: 208000 events read in total (5990ms).
[11:23:01.893] <TB3> INFO: Test took 7048ms.
[11:23:01.893] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:01.894] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:23:02.294] <TB3> INFO: PixTestAlive::maskTest() done
[11:23:02.294] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:23:02.296] <TB3> INFO: ----------------------------------------------------------------------
[11:23:02.296] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:23:02.296] <TB3> INFO: ----------------------------------------------------------------------
[11:23:02.647] <TB3> INFO: Expecting 208000 events.
[11:23:14.286] <TB3> INFO: 208000 events read in total (10924ms).
[11:23:14.287] <TB3> INFO: Test took 11989ms.
[11:23:14.297] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:14.597] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:23:14.597] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:23:14.598] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[11:23:14.640] <TB3> INFO: enter test to run
[11:23:14.640] <TB3> INFO: test: delay setting parameters: ->2<-
[11:23:14.640] <TB3> INFO: delay test by 2 seconds...
[11:23:16.640] <TB3> INFO: enter test to run
[11:23:16.640] <TB3> INFO: test: HighRate no parameter change
[11:23:16.640] <TB3> INFO: running: highrate
[11:23:16.640] <TB3> INFO: readGainPedestalParameters /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M3508_XrayQualification_2015-11-04_10h51m_1446630662//016_HREfficiency_250//phCalibrationFitErr35_C15.dat
[11:23:16.791] <TB3> INFO: ----------------------------------------------------------------------
[11:23:16.791] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:23:16.791] <TB3> INFO: ----------------------------------------------------------------------
[11:23:17.414] <TB3> INFO: Expecting 208000 events.
[11:23:42.303] <TB3> INFO: 208000 events read in total (24363ms).
[11:23:42.319] <TB3> INFO: Test took 25525ms.
[11:23:43.381] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:23:43.936] <TB3> INFO: number of dead pixels (per ROC): 0 19 3 0 0 0 5 0 1 7 0 0 0 4 3 0
[11:23:43.936] <TB3> INFO: number of red-efficiency pixels: 1549 1493 1386 3048 3024 3820 3510 3833 3659 3703 4001 3384 3743 1560 1632 1659
[11:23:43.936] <TB3> INFO: number of X-ray hits detected: 394283 412335 349693 646046 644139 830689 756843 813046 767146 809063 916816 721734 709735 434058 446540 439530
[11:23:43.936] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:23:43.936] <TB3> INFO: number of Vcal hits detected: 205792 205111 204344 200587 200384 193412 195557 194822 197036 194146 188524 197619 195119 203042 205572 205555
[11:23:43.936] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.1 99.1 98.6 96.8 96.9 93.8 94.8 94.2 95.2 94.3 91.7 95.7 94.5 98.2 99.0 99.0
[11:23:43.936] <TB3> INFO: Vcal hit overall efficiency (%): 98.9 98.6 98.2 96.4 96.3 93.0 94.0 93.7 94.7 93.3 90.6 95.0 93.8 97.6 98.8 98.8
[11:23:43.936] <TB3> INFO: X-ray hit rate [MHz/cm2]: 115.6 120.9 102.5 189.4 188.8 243.5 221.8 238.3 224.9 237.1 268.7 211.5 208.0 127.2 130.9 128.8
[11:23:43.936] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:23:43.962] <TB3> INFO: PixTest:: pg_setup set to default.
[11:23:43.974] <TB3> INFO: enter test to run
[11:23:43.974] <TB3> INFO: test: no parameter change
[11:23:44.072] <TB3> QUIET: Connection to board 121 closed.
[11:23:44.152] <TB3> INFO: pXar: this is the end, my friend