[15:24:02.378] <TB1> INFO: *** Welcome to pxar ***
[15:24:02.378] <TB1> INFO: *** Today: 2016/08/22
[15:24:02.450] <TB1> INFO: *** Version: f5d3-dirty
[15:24:02.450] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//000_PixelAlive_p17//dacParameters35_C15.dat
[15:24:02.451] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//000_PixelAlive_p17//tbmParameters_C0b.dat
[15:24:02.451] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//000_PixelAlive_p17//defaultMaskFile.dat
[15:24:02.451] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//000_PixelAlive_p17//trimParameters35_C15.dat
[15:24:02.520] <TB1> INFO: clk: 4
[15:24:02.520] <TB1> INFO: ctr: 4
[15:24:02.520] <TB1> INFO: sda: 19
[15:24:02.520] <TB1> INFO: tin: 9
[15:24:02.520] <TB1> INFO: level: 15
[15:24:02.520] <TB1> INFO: triggerdelay: 0
[15:24:02.520] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:24:02.520] <TB1> INFO: Log level: INFO
[15:24:02.534] <TB1> INFO: Found DTB DTB_WWXTQT
[15:24:02.544] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:24:02.546] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:24:02.548] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:24:04.096] <TB1> INFO: DUT info:
[15:24:04.096] <TB1> INFO: The DUT currently contains the following objects:
[15:24:04.096] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:24:04.096] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:24:04.096] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:24:04.096] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:24:04.096] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.096] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:24:04.497] <TB1> INFO: enter 'restricted' command line mode
[15:24:04.497] <TB1> INFO: enter test to run
[15:24:04.497] <TB1> INFO: test: PixelAlive no parameter change
[15:24:04.497] <TB1> INFO: running: pixelalive
[15:24:04.500] <TB1> INFO: ######################################################################
[15:24:04.500] <TB1> INFO: PixTestAlive::doTest()
[15:24:04.500] <TB1> INFO: ######################################################################
[15:24:04.501] <TB1> INFO: ----------------------------------------------------------------------
[15:24:04.501] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:24:04.501] <TB1> INFO: ----------------------------------------------------------------------
[15:24:04.770] <TB1> INFO: Expecting 41600 events.
[15:24:08.615] <TB1> INFO: 41600 events read in total (3286ms).
[15:24:08.661] <TB1> INFO: Test took 4158ms.
[15:24:08.884] <TB1> INFO: PixTestAlive::aliveTest() done
[15:24:08.884] <TB1> INFO: number of dead pixels (per ROC): 0 0 3 0 1 3 1 0 0 0 0 0 2 0 0 1
[15:24:08.885] <TB1> INFO: ----------------------------------------------------------------------
[15:24:08.885] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:24:08.885] <TB1> INFO: ----------------------------------------------------------------------
[15:24:09.146] <TB1> INFO: Expecting 41600 events.
[15:24:12.064] <TB1> INFO: 41600 events read in total (2362ms).
[15:24:12.065] <TB1> INFO: Test took 3179ms.
[15:24:12.065] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:24:12.312] <TB1> INFO: PixTestAlive::maskTest() done
[15:24:12.312] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:24:12.313] <TB1> INFO: ----------------------------------------------------------------------
[15:24:12.313] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:24:12.314] <TB1> INFO: ----------------------------------------------------------------------
[15:24:12.579] <TB1> INFO: Expecting 41600 events.
[15:24:16.408] <TB1> INFO: 41600 events read in total (3273ms).
[15:24:16.408] <TB1> INFO: Test took 4093ms.
[15:24:16.630] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:24:16.630] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:24:16.630] <TB1> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[15:24:16.664] <TB1> INFO: enter test to run
[15:24:16.664] <TB1> INFO: test: no parameter change
[15:24:16.815] <TB1> QUIET: Connection to board 147 closed.
[15:24:16.894] <TB1> INFO: pXar: this is the end, my friend

[15:29:54.706] <TB1> INFO: *** Welcome to pxar ***
[15:29:54.706] <TB1> INFO: *** Today: 2016/08/22
[15:29:54.775] <TB1> INFO: *** Version: f5d3-dirty
[15:29:54.775] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:29:54.776] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:29:54.776] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:29:54.776] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:29:54.847] <TB1> INFO: clk: 4
[15:29:54.847] <TB1> INFO: ctr: 4
[15:29:54.847] <TB1> INFO: sda: 19
[15:29:54.847] <TB1> INFO: tin: 9
[15:29:54.847] <TB1> INFO: level: 15
[15:29:54.847] <TB1> INFO: triggerdelay: 0
[15:29:54.847] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:29:54.847] <TB1> INFO: Log level: INFO
[15:29:54.860] <TB1> INFO: Found DTB DTB_WWXTQT
[15:29:54.870] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:29:54.872] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:29:54.873] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:29:56.408] <TB1> INFO: DUT info:
[15:29:56.408] <TB1> INFO: The DUT currently contains the following objects:
[15:29:56.408] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:29:56.408] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:29:56.408] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:29:56.408] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:29:56.408] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.409] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.409] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.409] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.809] <TB1> INFO: enter 'restricted' command line mode
[15:29:56.809] <TB1> INFO: enter test to run
[15:29:56.809] <TB1> INFO: test: delay setting parameters: ->5<-
[15:29:56.809] <TB1> INFO: delay test by 5 seconds...
[15:30:01.809] <TB1> INFO: enter test to run
[15:30:01.810] <TB1> INFO: test: highrate no parameter change
[15:30:01.810] <TB1> INFO: running: highrate
[15:30:01.810] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:30:01.985] <TB1> INFO: ----------------------------------------------------------------------
[15:30:01.985] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:30:01.985] <TB1> INFO: ----------------------------------------------------------------------
[15:30:01.985] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:30:01.985] <TB1> INFO: edge/corner pixel THR is adjusted
[15:30:01.985] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:30:02.704] <TB1> INFO: Collecting data for 1 seconds...
[15:30:03.705] <TB1> INFO: Done with hot pixel readout
[15:30:11.534] <TB1> INFO: PixTest:: pg_setup set to default.
[15:30:11.535] <TB1> INFO: 1 hot pixels found in step 0
[15:30:12.255] <TB1> INFO: Collecting data for 1 seconds...
[15:30:13.257] <TB1> INFO: Done with hot pixel readout
[15:30:20.702] <TB1> INFO: PixTest:: pg_setup set to default.
[15:30:20.703] <TB1> INFO: 1 hot pixels found in step 1
[15:30:21.423] <TB1> INFO: Collecting data for 1 seconds...
[15:30:22.424] <TB1> INFO: Done with hot pixel readout
[15:30:30.049] <TB1> INFO: PixTest:: pg_setup set to default.
[15:30:30.050] <TB1> INFO: 1 hot pixels found in step 2
[15:30:30.771] <TB1> INFO: Collecting data for 1 seconds...
[15:30:31.772] <TB1> INFO: Done with hot pixel readout
[15:30:39.245] <TB1> INFO: PixTest:: pg_setup set to default.
[15:30:39.246] <TB1> INFO: 0 hot pixels found in step 3
[15:30:39.255] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:30:39.283] <TB1> INFO: PixTest::trimHotPixels() done
[15:30:39.284] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:30:39.290] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:30:39.299] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:30:39.306] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:30:39.313] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:30:39.320] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:30:39.326] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:30:39.333] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:30:39.339] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:30:39.346] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:30:39.353] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:30:39.359] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:30:39.365] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:30:39.372] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:30:39.379] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:30:39.385] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:30:39.391] <TB1> INFO: write masked pixels into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:30:39.424] <TB1> INFO: enter test to run
[15:30:39.424] <TB1> INFO: test: no parameter change
[15:30:39.655] <TB1> QUIET: Connection to board 147 closed.
[15:30:39.734] <TB1> INFO: pXar: this is the end, my friend

[15:29:54.706] <TB1> INFO: *** Welcome to pxar ***
[15:29:54.706] <TB1> INFO: *** Today: 2016/08/22
[15:29:54.775] <TB1> INFO: *** Version: f5d3-dirty
[15:29:54.775] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:29:54.776] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:29:54.776] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:29:54.776] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:29:54.847] <TB1> INFO: clk: 4
[15:29:54.847] <TB1> INFO: ctr: 4
[15:29:54.847] <TB1> INFO: sda: 19
[15:29:54.847] <TB1> INFO: tin: 9
[15:29:54.847] <TB1> INFO: level: 15
[15:29:54.847] <TB1> INFO: triggerdelay: 0
[15:29:54.847] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:29:54.847] <TB1> INFO: Log level: INFO
[15:29:54.860] <TB1> INFO: Found DTB DTB_WWXTQT
[15:29:54.870] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:29:54.872] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:29:54.873] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:29:56.408] <TB1> INFO: DUT info:
[15:29:56.408] <TB1> INFO: The DUT currently contains the following objects:
[15:29:56.408] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:29:56.408] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:29:56.408] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:29:56.408] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:29:56.408] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.408] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.409] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.409] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.409] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:56.809] <TB1> INFO: enter 'restricted' command line mode
[15:29:56.809] <TB1> INFO: enter test to run
[15:29:56.809] <TB1> INFO: test: delay setting parameters: ->5<-
[15:29:56.809] <TB1> INFO: delay test by 5 seconds...
[15:30:01.809] <TB1> INFO: enter test to run
[15:30:01.810] <TB1> INFO: test: highrate no parameter change
[15:30:01.810] <TB1> INFO: running: highrate
[15:30:01.810] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:30:01.985] <TB1> INFO: ----------------------------------------------------------------------
[15:30:01.985] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:30:01.985] <TB1> INFO: ----------------------------------------------------------------------
[15:30:01.985] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:30:01.985] <TB1> INFO: edge/corner pixel THR is adjusted
[15:30:01.985] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:30:02.704] <TB1> INFO: Collecting data for 1 seconds...
[15:30:03.705] <TB1> INFO: Done with hot pixel readout
[15:30:11.534] <TB1> INFO: PixTest:: pg_setup set to default.
[15:30:11.535] <TB1> INFO: 1 hot pixels found in step 0
[15:30:12.255] <TB1> INFO: Collecting data for 1 seconds...
[15:30:13.257] <TB1> INFO: Done with hot pixel readout
[15:30:20.702] <TB1> INFO: PixTest:: pg_setup set to default.
[15:30:20.703] <TB1> INFO: 1 hot pixels found in step 1
[15:30:21.423] <TB1> INFO: Collecting data for 1 seconds...
[15:30:22.424] <TB1> INFO: Done with hot pixel readout
[15:30:30.049] <TB1> INFO: PixTest:: pg_setup set to default.
[15:30:30.050] <TB1> INFO: 1 hot pixels found in step 2
[15:30:30.771] <TB1> INFO: Collecting data for 1 seconds...
[15:30:31.772] <TB1> INFO: Done with hot pixel readout
[15:30:39.245] <TB1> INFO: PixTest:: pg_setup set to default.
[15:30:39.246] <TB1> INFO: 0 hot pixels found in step 3
[15:30:39.255] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:30:39.283] <TB1> INFO: PixTest::trimHotPixels() done
[15:30:39.284] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:30:39.290] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:30:39.299] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:30:39.306] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:30:39.313] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:30:39.320] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:30:39.326] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:30:39.333] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:30:39.339] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:30:39.346] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:30:39.353] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:30:39.359] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:30:39.365] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:30:39.372] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:30:39.379] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:30:39.385] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:30:39.391] <TB1> INFO: write masked pixels into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:30:39.424] <TB1> INFO: enter test to run
[15:30:39.424] <TB1> INFO: test: no parameter change
[15:30:39.655] <TB1> QUIET: Connection to board 147 closed.
[15:30:39.734] <TB1> INFO: pXar: this is the end, my friend
[15:31:23.972] <TB1> INFO: *** Welcome to pxar ***
[15:31:23.972] <TB1> INFO: *** Today: 2016/08/22
[15:31:24.041] <TB1> INFO: *** Version: f5d3-dirty
[15:31:24.041] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//dacParameters35_C15.dat
[15:31:24.042] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[15:31:24.042] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//defaultMaskFile.dat
[15:31:24.042] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C15.dat
[15:31:24.111] <TB1> INFO: clk: 4
[15:31:24.111] <TB1> INFO: ctr: 4
[15:31:24.111] <TB1> INFO: sda: 19
[15:31:24.111] <TB1> INFO: tin: 9
[15:31:24.111] <TB1> INFO: level: 15
[15:31:24.111] <TB1> INFO: triggerdelay: 0
[15:31:24.111] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:31:24.111] <TB1> INFO: Log level: INFO
[15:31:24.125] <TB1> INFO: Found DTB DTB_WWXTQT
[15:31:24.135] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:31:24.137] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:31:24.138] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:31:25.675] <TB1> INFO: DUT info:
[15:31:25.675] <TB1> INFO: The DUT currently contains the following objects:
[15:31:25.675] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:31:25.675] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:31:25.675] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:31:25.675] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:31:25.675] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:25.675] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:26.076] <TB1> INFO: enter 'restricted' command line mode
[15:31:26.076] <TB1> INFO: enter test to run
[15:31:26.076] <TB1> INFO: test: delay setting parameters: ->5<-
[15:31:26.076] <TB1> INFO: delay test by 5 seconds...
[15:31:31.076] <TB1> INFO: enter test to run
[15:31:31.076] <TB1> INFO: test: highrate no parameter change
[15:31:31.076] <TB1> INFO: running: highrate
[15:31:31.076] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[15:31:31.209] <TB1> INFO: ----------------------------------------------------------------------
[15:31:31.209] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:31:31.209] <TB1> INFO: ----------------------------------------------------------------------
[15:31:31.209] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:31:31.209] <TB1> INFO: edge/corner pixel THR is adjusted
[15:31:31.209] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:31:31.926] <TB1> INFO: Collecting data for 1 seconds...
[15:31:32.927] <TB1> INFO: Done with hot pixel readout
[15:31:37.047] <TB1> INFO: PixTest:: pg_setup set to default.
[15:31:37.048] <TB1> INFO: 0 hot pixels found in step 0
[15:31:37.062] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:31:37.109] <TB1> INFO: PixTest::trimHotPixels() done
[15:31:37.109] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C0.dat
[15:31:37.122] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C1.dat
[15:31:37.131] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C2.dat
[15:31:37.138] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C3.dat
[15:31:37.147] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C4.dat
[15:31:37.154] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C5.dat
[15:31:37.160] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C6.dat
[15:31:37.166] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C7.dat
[15:31:37.175] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C8.dat
[15:31:37.182] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C9.dat
[15:31:37.188] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C10.dat
[15:31:37.194] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C11.dat
[15:31:37.200] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C12.dat
[15:31:37.212] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C13.dat
[15:31:37.220] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C14.dat
[15:31:37.226] <TB1> INFO: write trim parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//trimParameters35_C15.dat
[15:31:37.232] <TB1> INFO: write masked pixels into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//003_RetrimHotPixels_50//defaultMaskFile.dat
[15:31:37.274] <TB1> INFO: enter test to run
[15:31:37.274] <TB1> INFO: test: no parameter change
[15:31:37.521] <TB1> QUIET: Connection to board 147 closed.
[15:31:37.601] <TB1> INFO: pXar: this is the end, my friend

[15:32:28.829] <TB1> INFO: *** Welcome to pxar ***
[15:32:28.829] <TB1> INFO: *** Today: 2016/08/22
[15:32:28.900] <TB1> INFO: *** Version: f5d3-dirty
[15:32:28.900] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//dacParameters35_C15.dat
[15:32:28.901] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//tbmParameters_C0b.dat
[15:32:28.901] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//defaultMaskFile.dat
[15:32:28.901] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//trimParameters35_C15.dat
[15:32:28.972] <TB1> INFO: clk: 4
[15:32:28.972] <TB1> INFO: ctr: 4
[15:32:28.972] <TB1> INFO: sda: 19
[15:32:28.972] <TB1> INFO: tin: 9
[15:32:28.972] <TB1> INFO: level: 15
[15:32:28.972] <TB1> INFO: triggerdelay: 0
[15:32:28.972] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:32:28.972] <TB1> INFO: Log level: INFO
[15:32:28.986] <TB1> INFO: Found DTB DTB_WWXTQT
[15:32:28.996] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:32:28.998] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:32:29.000] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:32:30.552] <TB1> INFO: DUT info:
[15:32:30.552] <TB1> INFO: The DUT currently contains the following objects:
[15:32:30.552] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:32:30.552] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:32:30.552] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:32:30.552] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:32:30.552] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.552] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.553] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.553] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.553] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.553] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:30.955] <TB1> INFO: enter 'restricted' command line mode
[15:32:30.955] <TB1> INFO: enter test to run
[15:32:30.955] <TB1> INFO: test: delay setting parameters: ->5<-
[15:32:30.955] <TB1> INFO: delay test by 5 seconds...
[15:32:35.955] <TB1> INFO: enter test to run
[15:32:35.955] <TB1> INFO: test: Xray no parameter change
[15:32:35.955] <TB1> INFO: running: xray
[15:32:35.955] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//004_HRData_50//phCalibrationFitErr35_C15.dat
[15:32:36.100] <TB1> INFO: ######################################################################
[15:32:36.100] <TB1> INFO: PixTestXray::doTest()
[15:32:36.100] <TB1> INFO: ######################################################################
[15:32:36.100] <TB1> INFO: ----------------------------------------------------------------------
[15:32:36.100] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:32:36.100] <TB1> INFO: ----------------------------------------------------------------------
[15:32:36.827] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:32:43.090] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[15:33:12.067] <TB1> INFO: Resuming triggers.
[15:33:18.342] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[15:33:47.300] <TB1> INFO: Resuming triggers.
[15:33:53.575] <TB1> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[15:34:22.433] <TB1> INFO: Resuming triggers.
[15:34:28.710] <TB1> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[15:34:58.070] <TB1> INFO: Resuming triggers.
[15:35:04.345] <TB1> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[15:35:33.617] <TB1> INFO: Resuming triggers.
[15:35:39.888] <TB1> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[15:36:09.505] <TB1> INFO: Resuming triggers.
[15:36:15.779] <TB1> INFO: run duration 43 seconds, buffer almost full (81%), pausing triggers.
[15:36:45.963] <TB1> INFO: Resuming triggers.
[15:36:52.230] <TB1> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[15:37:22.318] <TB1> INFO: Resuming triggers.
[15:37:28.588] <TB1> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[15:37:58.220] <TB1> INFO: Resuming triggers.
[15:38:04.490] <TB1> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[15:38:33.621] <TB1> INFO: Resuming triggers.
[15:38:39.892] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[15:39:09.345] <TB1> INFO: Resuming triggers.
[15:39:15.615] <TB1> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[15:39:45.268] <TB1> INFO: Resuming triggers.
[15:39:51.535] <TB1> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[15:40:21.200] <TB1> INFO: Resuming triggers.
[15:40:27.471] <TB1> INFO: run duration 87 seconds, buffer almost full (81%), pausing triggers.
[15:40:56.077] <TB1> INFO: Resuming triggers.
[15:41:02.342] <TB1> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[15:41:30.067] <TB1> INFO: Resuming triggers.
[15:41:36.089] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[15:42:04.146] <TB1> INFO: PixTest:: pg_setup set to default.
[15:42:04.147] <TB1> INFO: PixTestXray::doPhRun() done
[15:42:04.147] <TB1> INFO: PixTestXray::doTest() done
[15:42:04.349] <TB1> INFO: enter test to run
[15:42:04.350] <TB1> INFO: test: no parameter change
[15:42:04.676] <TB1> QUIET: Connection to board 147 closed.
[15:42:04.756] <TB1> INFO: pXar: this is the end, my friend

[15:42:40.956] <TB1> INFO: *** Welcome to pxar ***
[15:42:40.956] <TB1> INFO: *** Today: 2016/08/22
[15:42:41.027] <TB1> INFO: *** Version: f5d3-dirty
[15:42:41.027] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//dacParameters35_C15.dat
[15:42:41.028] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//tbmParameters_C0b.dat
[15:42:41.028] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//defaultMaskFile.dat
[15:42:41.028] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//trimParameters35_C15.dat
[15:42:41.109] <TB1> INFO: clk: 4
[15:42:41.109] <TB1> INFO: ctr: 4
[15:42:41.109] <TB1> INFO: sda: 19
[15:42:41.109] <TB1> INFO: tin: 9
[15:42:41.109] <TB1> INFO: level: 15
[15:42:41.109] <TB1> INFO: triggerdelay: 0
[15:42:41.109] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:42:41.109] <TB1> INFO: Log level: INFO
[15:42:41.122] <TB1> INFO: Found DTB DTB_WWXTQT
[15:42:41.132] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:42:41.134] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:42:41.136] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:42:42.695] <TB1> INFO: DUT info:
[15:42:42.695] <TB1> INFO: The DUT currently contains the following objects:
[15:42:42.695] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:42:42.695] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:42:42.695] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:42:42.695] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:42:42.695] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.695] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.695] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.695] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.695] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.695] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.695] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.695] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.696] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.696] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.696] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.696] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.696] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.696] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.696] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:42.696] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:42:43.097] <TB1> INFO: enter 'restricted' command line mode
[15:42:43.097] <TB1> INFO: enter test to run
[15:42:43.097] <TB1> INFO: test: delay setting parameters: ->5<-
[15:42:43.097] <TB1> INFO: delay test by 5 seconds...
[15:42:48.097] <TB1> INFO: enter test to run
[15:42:48.098] <TB1> INFO: test: Xray no parameter change
[15:42:48.098] <TB1> INFO: running: xray
[15:42:48.098] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//005_HRData_150//phCalibrationFitErr35_C15.dat
[15:42:48.229] <TB1> INFO: ######################################################################
[15:42:48.229] <TB1> INFO: PixTestXray::doTest()
[15:42:48.229] <TB1> INFO: ######################################################################
[15:42:48.229] <TB1> INFO: ----------------------------------------------------------------------
[15:42:48.229] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:42:48.229] <TB1> INFO: ----------------------------------------------------------------------
[15:42:48.952] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:42:52.148] <TB1> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[15:43:20.989] <TB1> INFO: Resuming triggers.
[15:43:24.190] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[15:43:53.862] <TB1> INFO: Resuming triggers.
[15:43:57.060] <TB1> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[15:44:27.218] <TB1> INFO: Resuming triggers.
[15:44:30.414] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[15:45:01.067] <TB1> INFO: Resuming triggers.
[15:45:04.264] <TB1> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[15:45:33.821] <TB1> INFO: Resuming triggers.
[15:45:37.020] <TB1> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[15:46:08.005] <TB1> INFO: Resuming triggers.
[15:46:11.200] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[15:46:41.147] <TB1> INFO: Resuming triggers.
[15:46:44.346] <TB1> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[15:47:15.602] <TB1> INFO: Resuming triggers.
[15:47:18.800] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[15:47:48.974] <TB1> INFO: Resuming triggers.
[15:47:52.170] <TB1> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[15:48:23.302] <TB1> INFO: Resuming triggers.
[15:48:26.500] <TB1> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[15:48:57.270] <TB1> INFO: Resuming triggers.
[15:49:00.467] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[15:49:30.738] <TB1> INFO: Resuming triggers.
[15:49:33.935] <TB1> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[15:50:04.279] <TB1> INFO: Resuming triggers.
[15:50:07.472] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[15:50:37.801] <TB1> INFO: Resuming triggers.
[15:50:40.998] <TB1> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[15:51:11.452] <TB1> INFO: Resuming triggers.
[15:51:14.649] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[15:51:44.990] <TB1> INFO: Resuming triggers.
[15:51:48.184] <TB1> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[15:52:20.714] <TB1> INFO: Resuming triggers.
[15:52:23.912] <TB1> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[15:52:55.781] <TB1> INFO: Resuming triggers.
[15:52:58.978] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[15:53:29.485] <TB1> INFO: Resuming triggers.
[15:53:32.680] <TB1> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[15:54:03.131] <TB1> INFO: Resuming triggers.
[15:54:06.326] <TB1> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[15:54:36.340] <TB1> INFO: Resuming triggers.
[15:54:39.536] <TB1> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[15:55:09.309] <TB1> INFO: Resuming triggers.
[15:55:12.505] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[15:55:42.442] <TB1> INFO: Resuming triggers.
[15:55:45.636] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[15:56:16.350] <TB1> INFO: Resuming triggers.
[15:56:19.545] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[15:56:49.768] <TB1> INFO: Resuming triggers.
[15:56:52.957] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[15:57:22.811] <TB1> INFO: Resuming triggers.
[15:57:26.003] <TB1> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[15:57:54.952] <TB1> INFO: Resuming triggers.
[15:57:58.145] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[15:58:27.063] <TB1> INFO: Resuming triggers.
[15:58:30.255] <TB1> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[15:58:59.078] <TB1> INFO: Resuming triggers.
[15:59:02.270] <TB1> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[15:59:31.810] <TB1> INFO: Resuming triggers.
[15:59:35.003] <TB1> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[16:00:04.916] <TB1> INFO: Resuming triggers.
[16:00:05.938] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[16:00:15.205] <TB1> INFO: PixTest:: pg_setup set to default.
[16:00:15.206] <TB1> INFO: PixTestXray::doPhRun() done
[16:00:15.206] <TB1> INFO: PixTestXray::doTest() done
[16:00:15.384] <TB1> INFO: enter test to run
[16:00:15.384] <TB1> INFO: test: no parameter change
[16:00:15.680] <TB1> QUIET: Connection to board 147 closed.
[16:00:15.763] <TB1> INFO: pXar: this is the end, my friend

[16:00:42.861] <TB1> INFO: *** Welcome to pxar ***
[16:00:42.861] <TB1> INFO: *** Today: 2016/08/22
[16:00:42.925] <TB1> INFO: *** Version: f5d3-dirty
[16:00:42.925] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//dacParameters35_C15.dat
[16:00:42.926] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//tbmParameters_C0b.dat
[16:00:42.926] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//defaultMaskFile.dat
[16:00:42.926] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//trimParameters35_C15.dat
[16:00:42.997] <TB1> INFO: clk: 4
[16:00:42.997] <TB1> INFO: ctr: 4
[16:00:42.997] <TB1> INFO: sda: 19
[16:00:42.997] <TB1> INFO: tin: 9
[16:00:42.997] <TB1> INFO: level: 15
[16:00:42.997] <TB1> INFO: triggerdelay: 0
[16:00:42.997] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:00:42.997] <TB1> INFO: Log level: INFO
[16:00:43.011] <TB1> INFO: Found DTB DTB_WWXTQT
[16:00:43.020] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:00:43.022] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:00:43.024] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:00:44.591] <TB1> INFO: DUT info:
[16:00:44.591] <TB1> INFO: The DUT currently contains the following objects:
[16:00:44.591] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:00:44.591] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:00:44.591] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:00:44.591] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:00:44.591] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.591] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:00:44.992] <TB1> INFO: enter 'restricted' command line mode
[16:00:44.992] <TB1> INFO: enter test to run
[16:00:44.992] <TB1> INFO: test: Highrate no parameter change
[16:00:44.992] <TB1> INFO: running: highrate
[16:00:44.992] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[16:00:45.126] <TB1> INFO: ----------------------------------------------------------------------
[16:00:45.126] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[16:00:45.126] <TB1> INFO: ----------------------------------------------------------------------
[16:00:45.131] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[16:00:45.142] <TB1> INFO: dacScan step from 15 .. 34
[16:00:45.142] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[16:00:45.142] <TB1> INFO: run 1 of 1
[16:00:45.623] <TB1> INFO: Expecting 4160000 events.
[16:01:20.078] <TB1> INFO: 428450 events read in total (34051ms).
[16:01:53.823] <TB1> INFO: 857450 events read in total (67796ms).
[16:02:28.206] <TB1> INFO: 1286500 events read in total (102179ms).
[16:03:02.820] <TB1> INFO: 1715700 events read in total (136793ms).
[16:03:37.035] <TB1> INFO: 2144700 events read in total (171008ms).
[16:04:11.040] <TB1> INFO: 2573500 events read in total (205013ms).
[16:04:45.324] <TB1> INFO: 3002100 events read in total (239297ms).
[16:05:19.587] <TB1> INFO: 3430400 events read in total (273560ms).
[16:05:53.649] <TB1> INFO: 3858600 events read in total (307622ms).
[16:06:17.638] <TB1> INFO: 4160000 events read in total (331611ms).
[16:06:17.944] <TB1> INFO: Test took 332801ms.
[16:06:26.781] <TB1> INFO: dacScan step from 35 .. 54
[16:06:26.781] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[16:06:26.781] <TB1> INFO: run 1 of 1
[16:06:27.294] <TB1> INFO: Expecting 4160000 events.
[16:06:59.689] <TB1> INFO: 356450 events read in total (31994ms).
[16:07:31.947] <TB1> INFO: 713500 events read in total (64252ms).
[16:08:03.821] <TB1> INFO: 1069850 events read in total (96126ms).
[16:08:35.728] <TB1> INFO: 1425100 events read in total (128033ms).
[16:09:08.004] <TB1> INFO: 1779450 events read in total (160309ms).
[16:09:40.114] <TB1> INFO: 2132350 events read in total (192419ms).
[16:10:12.486] <TB1> INFO: 2482900 events read in total (224791ms).
[16:10:44.548] <TB1> INFO: 2831000 events read in total (256853ms).
[16:11:18.222] <TB1> INFO: 3176750 events read in total (290527ms).
[16:11:50.001] <TB1> INFO: 3520500 events read in total (322306ms).
[16:12:22.062] <TB1> INFO: 3862750 events read in total (354367ms).
[16:12:49.626] <TB1> INFO: 4160000 events read in total (381931ms).
[16:12:49.965] <TB1> INFO: Test took 383183ms.
[16:12:58.245] <TB1> INFO: dacScan step from 55 .. 74
[16:12:58.245] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[16:12:58.245] <TB1> INFO: run 1 of 1
[16:12:58.731] <TB1> INFO: Expecting 4160000 events.
[16:13:30.799] <TB1> INFO: 322700 events read in total (31663ms).
[16:14:01.882] <TB1> INFO: 645700 events read in total (62746ms).
[16:14:33.317] <TB1> INFO: 968850 events read in total (94181ms).
[16:15:04.377] <TB1> INFO: 1291850 events read in total (125241ms).
[16:15:35.627] <TB1> INFO: 1614950 events read in total (156491ms).
[16:16:07.003] <TB1> INFO: 1937850 events read in total (187867ms).
[16:16:38.593] <TB1> INFO: 2261250 events read in total (219457ms).
[16:17:09.616] <TB1> INFO: 2584300 events read in total (250480ms).
[16:17:41.150] <TB1> INFO: 2907100 events read in total (282014ms).
[16:18:12.243] <TB1> INFO: 3230150 events read in total (313107ms).
[16:18:43.823] <TB1> INFO: 3553100 events read in total (344687ms).
[16:19:15.417] <TB1> INFO: 3875950 events read in total (376281ms).
[16:19:43.368] <TB1> INFO: 4160000 events read in total (404232ms).
[16:19:43.587] <TB1> INFO: Test took 405341ms.
[16:19:50.998] <TB1> INFO: dacScan step from 75 .. 75
[16:19:50.998] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[16:19:50.998] <TB1> INFO: run 1 of 1
[16:19:51.475] <TB1> INFO: Expecting 208000 events.
[16:20:13.056] <TB1> INFO: 208000 events read in total (21180ms).
[16:20:13.065] <TB1> INFO: Test took 22067ms.
[16:20:13.595] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:14.731] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:15.744] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:16.763] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:17.804] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:18.854] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:19.905] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:20.942] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:21.991] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:23.023] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:24.063] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:25.120] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:26.163] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:27.199] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:28.216] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:29.260] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:20:30.372] <TB1> INFO: PixTest:: pg_setup set to default.
[16:20:30.374] <TB1> INFO: vcal mean: 37.95 38.92 37.76 40.52 40.56 41.40 40.89 41.56 41.41 40.70 41.81 41.84 40.51 38.20 38.55 38.56
[16:20:30.374] <TB1> INFO: vcal RMS: 1.18 1.22 1.23 1.55 1.45 2.01 1.81 1.53 1.55 1.46 1.59 1.52 1.40 1.15 1.10 1.26
[16:20:30.374] <TB1> INFO: number of X-ray hits detected: 220222 237183 212651 352302 358795 456836 423201 420406 426632 404163 443799 356860 336259 204890 232024 215777
[16:20:30.374] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:20:30.374] <TB1> INFO: X-ray hit rate [MHz/cm2]: 64.5 69.5 62.3 103.3 105.2 133.9 124.0 123.2 125.0 118.5 130.1 104.6 98.6 60.1 68.0 63.2
[16:20:30.374] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[16:20:30.489] <TB1> INFO: enter test to run
[16:20:30.489] <TB1> INFO: test: no parameter change
[16:20:30.763] <TB1> QUIET: Connection to board 147 closed.
[16:20:30.842] <TB1> INFO: pXar: this is the end, my friend

[16:41:30.999] <TB1> INFO: *** Welcome to pxar ***
[16:41:30.999] <TB1> INFO: *** Today: 2016/08/22
[16:41:31.066] <TB1> INFO: *** Version: f5d3-dirty
[16:41:31.066] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:41:31.067] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[16:41:31.067] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[16:41:31.067] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[16:41:31.175] <TB1> INFO: clk: 4
[16:41:31.175] <TB1> INFO: ctr: 4
[16:41:31.175] <TB1> INFO: sda: 19
[16:41:31.175] <TB1> INFO: tin: 9
[16:41:31.175] <TB1> INFO: level: 15
[16:41:31.175] <TB1> INFO: triggerdelay: 0
[16:41:31.175] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:41:31.175] <TB1> INFO: Log level: INFO
[16:41:31.189] <TB1> INFO: Found DTB DTB_WWXTQT
[16:41:31.199] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:41:31.201] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:41:31.203] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:41:32.736] <TB1> INFO: DUT info:
[16:41:32.736] <TB1> INFO: The DUT currently contains the following objects:
[16:41:32.736] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:41:32.736] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:41:32.736] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:41:32.736] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:41:32.736] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.736] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.736] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.736] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.736] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:32.737] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:33.137] <TB1> INFO: enter 'restricted' command line mode
[16:41:33.137] <TB1> INFO: enter test to run
[16:41:33.137] <TB1> INFO: test: HighRate no parameter change
[16:41:33.137] <TB1> INFO: running: highrate
[16:41:33.138] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[16:41:33.270] <TB1> INFO: ----------------------------------------------------------------------
[16:41:33.270] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[16:41:33.270] <TB1> INFO: ----------------------------------------------------------------------
[16:41:33.363] <TB1> INFO: Expecting 768 events.
[16:41:34.358] <TB1> INFO: 768 events read in total (437ms).
[16:41:34.422] <TB1> INFO: Test took 1148ms.
[16:41:34.909] <TB1> INFO: Expecting 41600 events.
[16:41:38.641] <TB1> INFO: 41600 events read in total (3330ms).
[16:41:38.643] <TB1> INFO: Test took 4216ms.
[16:41:39.231] <TB1> INFO: Expecting 41600 events.
[16:41:43.059] <TB1> INFO: 41600 events read in total (3426ms).
[16:41:43.061] <TB1> INFO: Test took 4309ms.
[16:41:43.655] <TB1> INFO: Expecting 41600 events.
[16:41:47.385] <TB1> INFO: 41600 events read in total (3328ms).
[16:41:47.387] <TB1> INFO: Test took 4211ms.
[16:41:47.983] <TB1> INFO: Expecting 41600 events.
[16:41:51.752] <TB1> INFO: 41600 events read in total (3368ms).
[16:41:51.754] <TB1> INFO: Test took 4253ms.
[16:41:52.374] <TB1> INFO: Expecting 41600 events.
[16:41:56.209] <TB1> INFO: 41600 events read in total (3433ms).
[16:41:56.211] <TB1> INFO: Test took 4339ms.
[16:41:56.829] <TB1> INFO: Expecting 41600 events.
[16:42:00.648] <TB1> INFO: 41600 events read in total (3417ms).
[16:42:00.650] <TB1> INFO: Test took 4314ms.
[16:42:01.279] <TB1> INFO: Expecting 41600 events.
[16:42:05.160] <TB1> INFO: 41600 events read in total (3480ms).
[16:42:05.162] <TB1> INFO: Test took 4376ms.
[16:42:05.769] <TB1> INFO: Expecting 41600 events.
[16:42:09.589] <TB1> INFO: 41600 events read in total (3419ms).
[16:42:09.591] <TB1> INFO: Test took 4316ms.
[16:42:10.186] <TB1> INFO: Expecting 41600 events.
[16:42:14.124] <TB1> INFO: 41600 events read in total (3537ms).
[16:42:14.126] <TB1> INFO: Test took 4421ms.
[16:42:14.756] <TB1> INFO: Expecting 41600 events.
[16:42:18.685] <TB1> INFO: 41600 events read in total (3528ms).
[16:42:18.688] <TB1> INFO: Test took 4436ms.
[16:42:19.285] <TB1> INFO: Expecting 41600 events.
[16:42:23.175] <TB1> INFO: 41600 events read in total (3488ms).
[16:42:23.178] <TB1> INFO: Test took 4373ms.
[16:42:23.809] <TB1> INFO: Expecting 41600 events.
[16:42:27.712] <TB1> INFO: 41600 events read in total (3501ms).
[16:42:27.714] <TB1> INFO: Test took 4412ms.
[16:42:28.312] <TB1> INFO: Expecting 41600 events.
[16:42:32.177] <TB1> INFO: 41600 events read in total (3463ms).
[16:42:32.179] <TB1> INFO: Test took 4346ms.
[16:42:32.779] <TB1> INFO: Expecting 41600 events.
[16:42:36.656] <TB1> INFO: 41600 events read in total (3476ms).
[16:42:36.658] <TB1> INFO: Test took 4361ms.
[16:42:37.360] <TB1> INFO: Expecting 41600 events.
[16:42:41.244] <TB1> INFO: 41600 events read in total (3483ms).
[16:42:41.246] <TB1> INFO: Test took 4430ms.
[16:42:41.957] <TB1> INFO: Expecting 41600 events.
[16:42:45.822] <TB1> INFO: 41600 events read in total (3463ms).
[16:42:45.825] <TB1> INFO: Test took 4437ms.
[16:42:46.458] <TB1> INFO: Expecting 41600 events.
[16:42:50.406] <TB1> INFO: 41600 events read in total (3546ms).
[16:42:50.408] <TB1> INFO: Test took 4456ms.
[16:42:51.015] <TB1> INFO: Expecting 41600 events.
[16:42:54.846] <TB1> INFO: 41600 events read in total (3429ms).
[16:42:54.848] <TB1> INFO: Test took 4327ms.
[16:42:55.445] <TB1> INFO: Expecting 41600 events.
[16:42:59.217] <TB1> INFO: 41600 events read in total (3371ms).
[16:42:59.220] <TB1> INFO: Test took 4258ms.
[16:42:59.840] <TB1> INFO: Expecting 41600 events.
[16:43:03.558] <TB1> INFO: 41600 events read in total (3317ms).
[16:43:03.560] <TB1> INFO: Test took 4227ms.
[16:43:03.961] <TB1> INFO: enter test to run
[16:43:03.961] <TB1> INFO: test: Pretest no parameter change
[16:43:03.961] <TB1> INFO: running: pretest
[16:43:03.961] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[16:43:03.961] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[16:43:03.961] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[16:43:03.961] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[16:43:03.961] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[16:43:03.961] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[16:43:03.961] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[16:43:03.961] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[16:43:03.962] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[16:43:03.962] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[16:43:03.962] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[16:43:03.962] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[16:43:03.962] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[16:43:03.962] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[16:43:03.962] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[16:43:03.962] <TB1> INFO: write dac parameters into /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:43:03.962] <TB1> INFO: enter test to run
[16:43:03.962] <TB1> INFO: test: no parameter change
[16:43:04.229] <TB1> QUIET: Connection to board 147 closed.
[16:43:04.308] <TB1> INFO: pXar: this is the end, my friend

[16:43:48.280] <TB1> INFO: *** Welcome to pxar ***
[16:43:48.280] <TB1> INFO: *** Today: 2016/08/22
[16:43:48.348] <TB1> INFO: *** Version: f5d3-dirty
[16:43:48.348] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//dacParameters35_C15.dat
[16:43:48.348] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//tbmParameters_C0b.dat
[16:43:48.348] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//defaultMaskFile.dat
[16:43:48.348] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//trimParameters35_C15.dat
[16:43:48.418] <TB1> INFO: clk: 4
[16:43:48.418] <TB1> INFO: ctr: 4
[16:43:48.418] <TB1> INFO: sda: 19
[16:43:48.419] <TB1> INFO: tin: 9
[16:43:48.419] <TB1> INFO: level: 15
[16:43:48.419] <TB1> INFO: triggerdelay: 0
[16:43:48.419] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:43:48.419] <TB1> INFO: Log level: INFO
[16:43:48.432] <TB1> INFO: Found DTB DTB_WWXTQT
[16:43:48.442] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:43:48.444] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:43:48.445] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:43:49.986] <TB1> INFO: DUT info:
[16:43:49.986] <TB1> INFO: The DUT currently contains the following objects:
[16:43:49.986] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:43:49.986] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:43:49.986] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:43:49.986] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:43:49.986] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:49.986] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:50.387] <TB1> INFO: enter 'restricted' command line mode
[16:43:50.387] <TB1> INFO: enter test to run
[16:43:50.387] <TB1> INFO: test: PixelAlive no parameter change
[16:43:50.387] <TB1> INFO: running: pixelalive
[16:43:50.391] <TB1> INFO: ######################################################################
[16:43:50.391] <TB1> INFO: PixTestAlive::doTest()
[16:43:50.391] <TB1> INFO: ######################################################################
[16:43:50.392] <TB1> INFO: ----------------------------------------------------------------------
[16:43:50.392] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:43:50.392] <TB1> INFO: ----------------------------------------------------------------------
[16:43:50.654] <TB1> INFO: Expecting 208000 events.
[16:44:01.891] <TB1> INFO: 208000 events read in total (10679ms).
[16:44:01.893] <TB1> INFO: Test took 11499ms.
[16:44:02.142] <TB1> INFO: PixTestAlive::aliveTest() done
[16:44:02.142] <TB1> INFO: number of dead pixels (per ROC): 0 0 1 0 1 3 1 0 0 0 0 0 1 0 0 1
[16:44:02.143] <TB1> INFO: ----------------------------------------------------------------------
[16:44:02.143] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:44:02.143] <TB1> INFO: ----------------------------------------------------------------------
[16:44:02.416] <TB1> INFO: Expecting 208000 events.
[16:44:09.907] <TB1> INFO: 208000 events read in total (6935ms).
[16:44:09.908] <TB1> INFO: Test took 7763ms.
[16:44:09.908] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:44:10.145] <TB1> INFO: PixTestAlive::maskTest() done
[16:44:10.145] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:44:10.146] <TB1> INFO: ----------------------------------------------------------------------
[16:44:10.146] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:44:10.146] <TB1> INFO: ----------------------------------------------------------------------
[16:44:10.437] <TB1> INFO: Expecting 208000 events.
[16:44:21.842] <TB1> INFO: 208000 events read in total (10849ms).
[16:44:21.843] <TB1> INFO: Test took 11696ms.
[16:44:22.043] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:44:22.043] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:44:22.043] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:44:22.073] <TB1> INFO: enter test to run
[16:44:22.073] <TB1> INFO: test: delay setting parameters: ->2<-
[16:44:22.073] <TB1> INFO: delay test by 2 seconds...
[16:44:24.073] <TB1> INFO: enter test to run
[16:44:24.073] <TB1> INFO: test: HighRate no parameter change
[16:44:24.073] <TB1> INFO: running: highrate
[16:44:24.074] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[16:44:24.210] <TB1> INFO: ----------------------------------------------------------------------
[16:44:24.210] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:44:24.210] <TB1> INFO: ----------------------------------------------------------------------
[16:44:24.696] <TB1> INFO: Expecting 208000 events.
[16:44:40.504] <TB1> INFO: 208000 events read in total (15406ms).
[16:44:40.510] <TB1> INFO: Test took 16296ms.
[16:44:41.060] <TB1> INFO: number of dead pixels (per ROC): 0 0 2 0 1 3 1 0 0 0 0 0 1 0 0 1
[16:44:41.060] <TB1> INFO: number of red-efficiency pixels: 161 153 170 302 283 444 350 377 356 322 404 268 245 150 148 161
[16:44:41.060] <TB1> INFO: number of X-ray hits detected: 107196 115055 102621 171661 175003 223770 204489 203840 206411 197393 217423 174038 165764 97791 112309 105912
[16:44:41.060] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:44:41.060] <TB1> INFO: number of Vcal hits detected: 207831 207841 207671 207684 207645 207383 207571 207598 207622 207665 207570 207716 207695 207837 207849 207787
[16:44:41.060] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.9 99.8 99.9 99.9 99.9 99.9 99.9
[16:44:41.060] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[16:44:41.060] <TB1> INFO: X-ray hit rate [MHz/cm2]: 31.4 33.7 30.1 50.3 51.3 65.6 59.9 59.7 60.5 57.9 63.7 51.0 48.6 28.7 32.9 31.0
[16:44:41.060] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:44:41.089] <TB1> INFO: PixTest:: pg_setup set to default.
[16:44:41.098] <TB1> INFO: enter test to run
[16:44:41.098] <TB1> INFO: test: no parameter change
[16:44:41.408] <TB1> QUIET: Connection to board 147 closed.
[16:44:41.488] <TB1> INFO: pXar: this is the end, my friend

[16:45:25.947] <TB1> INFO: *** Welcome to pxar ***
[16:45:25.947] <TB1> INFO: *** Today: 2016/08/22
[16:45:26.012] <TB1> INFO: *** Version: f5d3-dirty
[16:45:26.012] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//dacParameters35_C15.dat
[16:45:26.013] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//tbmParameters_C0b.dat
[16:45:26.013] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//defaultMaskFile.dat
[16:45:26.013] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//trimParameters35_C15.dat
[16:45:26.112] <TB1> INFO: clk: 4
[16:45:26.112] <TB1> INFO: ctr: 4
[16:45:26.112] <TB1> INFO: sda: 19
[16:45:26.112] <TB1> INFO: tin: 9
[16:45:26.112] <TB1> INFO: level: 15
[16:45:26.112] <TB1> INFO: triggerdelay: 0
[16:45:26.112] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:45:26.112] <TB1> INFO: Log level: INFO
[16:45:26.125] <TB1> INFO: Found DTB DTB_WWXTQT
[16:45:26.135] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:45:26.137] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:45:26.138] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:45:27.670] <TB1> INFO: DUT info:
[16:45:27.670] <TB1> INFO: The DUT currently contains the following objects:
[16:45:27.670] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:45:27.670] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:45:27.670] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:45:27.670] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:45:27.670] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:27.670] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:28.071] <TB1> INFO: enter 'restricted' command line mode
[16:45:28.071] <TB1> INFO: enter test to run
[16:45:28.071] <TB1> INFO: test: PixelAlive no parameter change
[16:45:28.071] <TB1> INFO: running: pixelalive
[16:45:28.074] <TB1> INFO: ######################################################################
[16:45:28.074] <TB1> INFO: PixTestAlive::doTest()
[16:45:28.074] <TB1> INFO: ######################################################################
[16:45:28.076] <TB1> INFO: ----------------------------------------------------------------------
[16:45:28.076] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:45:28.076] <TB1> INFO: ----------------------------------------------------------------------
[16:45:28.377] <TB1> INFO: Expecting 208000 events.
[16:45:39.731] <TB1> INFO: 208000 events read in total (10796ms).
[16:45:39.733] <TB1> INFO: Test took 11656ms.
[16:45:39.958] <TB1> INFO: PixTestAlive::aliveTest() done
[16:45:39.958] <TB1> INFO: number of dead pixels (per ROC): 0 0 2 0 0 3 1 0 0 0 0 0 1 0 0 1
[16:45:39.960] <TB1> INFO: ----------------------------------------------------------------------
[16:45:39.960] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:45:39.960] <TB1> INFO: ----------------------------------------------------------------------
[16:45:40.233] <TB1> INFO: Expecting 208000 events.
[16:45:47.837] <TB1> INFO: 208000 events read in total (7048ms).
[16:45:47.837] <TB1> INFO: Test took 7875ms.
[16:45:47.837] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:45:48.074] <TB1> INFO: PixTestAlive::maskTest() done
[16:45:48.074] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:45:48.075] <TB1> INFO: ----------------------------------------------------------------------
[16:45:48.075] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:45:48.075] <TB1> INFO: ----------------------------------------------------------------------
[16:45:48.340] <TB1> INFO: Expecting 208000 events.
[16:45:59.759] <TB1> INFO: 208000 events read in total (10863ms).
[16:45:59.759] <TB1> INFO: Test took 11682ms.
[16:45:59.956] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:45:59.956] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:45:59.956] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:45:59.990] <TB1> INFO: enter test to run
[16:45:59.990] <TB1> INFO: test: delay setting parameters: ->2<-
[16:45:59.990] <TB1> INFO: delay test by 2 seconds...
[16:46:01.990] <TB1> INFO: enter test to run
[16:46:01.990] <TB1> INFO: test: HighRate no parameter change
[16:46:01.990] <TB1> INFO: running: highrate
[16:46:01.990] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[16:46:02.154] <TB1> INFO: ----------------------------------------------------------------------
[16:46:02.154] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:46:02.154] <TB1> INFO: ----------------------------------------------------------------------
[16:46:02.664] <TB1> INFO: Expecting 208000 events.
[16:46:20.955] <TB1> INFO: 208000 events read in total (17890ms).
[16:46:20.963] <TB1> INFO: Test took 18806ms.
[16:46:21.714] <TB1> INFO: number of dead pixels (per ROC): 0 0 3 0 1 3 1 0 0 0 0 0 1 0 0 1
[16:46:21.714] <TB1> INFO: number of red-efficiency pixels: 313 298 302 568 573 858 753 724 820 688 862 555 511 311 274 265
[16:46:21.714] <TB1> INFO: number of X-ray hits detected: 159847 171173 152871 254100 259166 329609 303045 302736 306349 290751 321347 257665 244016 145607 166677 156899
[16:46:21.714] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:46:21.714] <TB1> INFO: number of Vcal hits detected: 207674 207688 207504 207364 207283 206819 207049 207185 207062 207200 206959 207391 207385 207654 207716 207676
[16:46:21.714] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.6 99.6 99.6 99.6 99.7 99.6 99.7 99.8 99.9 99.9 99.9
[16:46:21.714] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.8 99.7 99.7 99.4 99.5 99.6 99.5 99.6 99.5 99.7 99.7 99.8 99.9 99.8
[16:46:21.714] <TB1> INFO: X-ray hit rate [MHz/cm2]: 46.9 50.2 44.8 74.5 76.0 96.6 88.8 88.7 89.8 85.2 94.2 75.5 71.5 42.7 48.9 46.0
[16:46:21.714] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:46:21.740] <TB1> INFO: PixTest:: pg_setup set to default.
[16:46:21.750] <TB1> INFO: enter test to run
[16:46:21.750] <TB1> INFO: test: no parameter change
[16:46:22.031] <TB1> QUIET: Connection to board 147 closed.
[16:46:22.111] <TB1> INFO: pXar: this is the end, my friend

[16:47:09.703] <TB1> INFO: *** Welcome to pxar ***
[16:47:09.703] <TB1> INFO: *** Today: 2016/08/22
[16:47:09.770] <TB1> INFO: *** Version: f5d3-dirty
[16:47:09.770] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//dacParameters35_C15.dat
[16:47:09.770] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//tbmParameters_C0b.dat
[16:47:09.770] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//defaultMaskFile.dat
[16:47:09.770] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//trimParameters35_C15.dat
[16:47:09.840] <TB1> INFO: clk: 4
[16:47:09.840] <TB1> INFO: ctr: 4
[16:47:09.840] <TB1> INFO: sda: 19
[16:47:09.840] <TB1> INFO: tin: 9
[16:47:09.840] <TB1> INFO: level: 15
[16:47:09.840] <TB1> INFO: triggerdelay: 0
[16:47:09.840] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:47:09.840] <TB1> INFO: Log level: INFO
[16:47:09.852] <TB1> INFO: Found DTB DTB_WWXTQT
[16:47:09.862] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:47:09.864] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:47:09.865] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:47:11.431] <TB1> INFO: DUT info:
[16:47:11.431] <TB1> INFO: The DUT currently contains the following objects:
[16:47:11.431] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:47:11.431] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:47:11.431] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:47:11.431] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:47:11.431] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.431] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.432] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:11.832] <TB1> INFO: enter 'restricted' command line mode
[16:47:11.832] <TB1> INFO: enter test to run
[16:47:11.832] <TB1> INFO: test: PixelAlive no parameter change
[16:47:11.832] <TB1> INFO: running: pixelalive
[16:47:11.836] <TB1> INFO: ######################################################################
[16:47:11.836] <TB1> INFO: PixTestAlive::doTest()
[16:47:11.836] <TB1> INFO: ######################################################################
[16:47:11.837] <TB1> INFO: ----------------------------------------------------------------------
[16:47:11.837] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:47:11.837] <TB1> INFO: ----------------------------------------------------------------------
[16:47:12.098] <TB1> INFO: Expecting 208000 events.
[16:47:23.580] <TB1> INFO: 208000 events read in total (10924ms).
[16:47:23.582] <TB1> INFO: Test took 11743ms.
[16:47:23.798] <TB1> INFO: PixTestAlive::aliveTest() done
[16:47:23.798] <TB1> INFO: number of dead pixels (per ROC): 0 0 2 0 0 3 1 0 0 0 0 0 1 0 0 1
[16:47:23.799] <TB1> INFO: ----------------------------------------------------------------------
[16:47:23.799] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:47:23.800] <TB1> INFO: ----------------------------------------------------------------------
[16:47:24.061] <TB1> INFO: Expecting 208000 events.
[16:47:31.382] <TB1> INFO: 208000 events read in total (6764ms).
[16:47:31.382] <TB1> INFO: Test took 7581ms.
[16:47:31.383] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:47:31.627] <TB1> INFO: PixTestAlive::maskTest() done
[16:47:31.627] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:47:31.628] <TB1> INFO: ----------------------------------------------------------------------
[16:47:31.628] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:47:31.628] <TB1> INFO: ----------------------------------------------------------------------
[16:47:31.906] <TB1> INFO: Expecting 208000 events.
[16:47:43.084] <TB1> INFO: 208000 events read in total (10622ms).
[16:47:43.084] <TB1> INFO: Test took 11455ms.
[16:47:43.284] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:47:43.284] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:47:43.284] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:47:43.314] <TB1> INFO: enter test to run
[16:47:43.314] <TB1> INFO: test: delay setting parameters: ->2<-
[16:47:43.314] <TB1> INFO: delay test by 2 seconds...
[16:47:45.314] <TB1> INFO: enter test to run
[16:47:45.314] <TB1> INFO: test: HighRate no parameter change
[16:47:45.314] <TB1> INFO: running: highrate
[16:47:45.314] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[16:47:45.493] <TB1> INFO: ----------------------------------------------------------------------
[16:47:45.493] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:47:45.493] <TB1> INFO: ----------------------------------------------------------------------
[16:47:46.003] <TB1> INFO: Expecting 208000 events.
[16:48:07.112] <TB1> INFO: 208000 events read in total (20708ms).
[16:48:07.123] <TB1> INFO: Test took 21627ms.
[16:48:08.102] <TB1> INFO: number of dead pixels (per ROC): 0 0 3 0 1 3 1 0 0 0 0 0 1 0 0 1
[16:48:08.102] <TB1> INFO: number of red-efficiency pixels: 612 526 556 1044 1045 1679 1495 1430 1483 1360 1643 1021 935 536 480 539
[16:48:08.102] <TB1> INFO: number of X-ray hits detected: 220746 237018 212658 353386 359732 457060 424615 420683 427511 405915 444101 357774 337471 203664 231109 217178
[16:48:08.102] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:48:08.102] <TB1> INFO: number of Vcal hits detected: 207321 207421 207145 206662 206566 205336 205772 206056 206021 206123 205583 206675 206826 207318 207477 207349
[16:48:08.102] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.7 99.4 99.4 98.9 99.1 99.1 99.1 99.2 99.0 99.4 99.5 99.7 99.8 99.7
[16:48:08.102] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.6 99.4 99.3 98.7 98.9 99.1 99.0 99.1 98.8 99.4 99.4 99.7 99.7 99.7
[16:48:08.102] <TB1> INFO: X-ray hit rate [MHz/cm2]: 64.7 69.5 62.3 103.6 105.4 134.0 124.5 123.3 125.3 119.0 130.2 104.9 98.9 59.7 67.7 63.7
[16:48:08.102] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:48:08.138] <TB1> INFO: PixTest:: pg_setup set to default.
[16:48:08.151] <TB1> INFO: enter test to run
[16:48:08.151] <TB1> INFO: test: no parameter change
[16:48:08.433] <TB1> QUIET: Connection to board 147 closed.
[16:48:08.513] <TB1> INFO: pXar: this is the end, my friend

[16:48:54.415] <TB1> INFO: *** Welcome to pxar ***
[16:48:54.415] <TB1> INFO: *** Today: 2016/08/22
[16:48:54.484] <TB1> INFO: *** Version: f5d3-dirty
[16:48:54.484] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//dacParameters35_C15.dat
[16:48:54.484] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//tbmParameters_C0b.dat
[16:48:54.485] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//defaultMaskFile.dat
[16:48:54.485] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//trimParameters35_C15.dat
[16:48:54.557] <TB1> INFO: clk: 4
[16:48:54.557] <TB1> INFO: ctr: 4
[16:48:54.557] <TB1> INFO: sda: 19
[16:48:54.557] <TB1> INFO: tin: 9
[16:48:54.557] <TB1> INFO: level: 15
[16:48:54.557] <TB1> INFO: triggerdelay: 0
[16:48:54.557] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:48:54.557] <TB1> INFO: Log level: INFO
[16:48:54.569] <TB1> INFO: Found DTB DTB_WWXTQT
[16:48:54.578] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:48:54.580] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:48:54.582] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:48:56.117] <TB1> INFO: DUT info:
[16:48:56.117] <TB1> INFO: The DUT currently contains the following objects:
[16:48:56.117] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:48:56.117] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:48:56.117] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:48:56.117] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:48:56.117] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.117] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:48:56.518] <TB1> INFO: enter 'restricted' command line mode
[16:48:56.518] <TB1> INFO: enter test to run
[16:48:56.518] <TB1> INFO: test: PixelAlive no parameter change
[16:48:56.518] <TB1> INFO: running: pixelalive
[16:48:56.522] <TB1> INFO: ######################################################################
[16:48:56.522] <TB1> INFO: PixTestAlive::doTest()
[16:48:56.522] <TB1> INFO: ######################################################################
[16:48:56.523] <TB1> INFO: ----------------------------------------------------------------------
[16:48:56.523] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:48:56.523] <TB1> INFO: ----------------------------------------------------------------------
[16:48:56.788] <TB1> INFO: Expecting 208000 events.
[16:49:08.209] <TB1> INFO: 208000 events read in total (10863ms).
[16:49:08.211] <TB1> INFO: Test took 11686ms.
[16:49:08.441] <TB1> INFO: PixTestAlive::aliveTest() done
[16:49:08.441] <TB1> INFO: number of dead pixels (per ROC): 0 0 2 0 0 3 1 0 0 0 0 0 1 0 0 1
[16:49:08.443] <TB1> INFO: ----------------------------------------------------------------------
[16:49:08.443] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:49:08.443] <TB1> INFO: ----------------------------------------------------------------------
[16:49:08.739] <TB1> INFO: Expecting 208000 events.
[16:49:16.134] <TB1> INFO: 208000 events read in total (6839ms).
[16:49:16.136] <TB1> INFO: Test took 7691ms.
[16:49:16.136] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:49:16.373] <TB1> INFO: PixTestAlive::maskTest() done
[16:49:16.373] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:49:16.374] <TB1> INFO: ----------------------------------------------------------------------
[16:49:16.374] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:49:16.374] <TB1> INFO: ----------------------------------------------------------------------
[16:49:16.639] <TB1> INFO: Expecting 208000 events.
[16:49:27.899] <TB1> INFO: 208000 events read in total (10704ms).
[16:49:27.900] <TB1> INFO: Test took 11525ms.
[16:49:28.100] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:49:28.100] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:49:28.100] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:49:28.131] <TB1> INFO: enter test to run
[16:49:28.131] <TB1> INFO: test: delay setting parameters: ->2<-
[16:49:28.131] <TB1> INFO: delay test by 2 seconds...
[16:49:30.131] <TB1> INFO: enter test to run
[16:49:30.131] <TB1> INFO: test: HighRate no parameter change
[16:49:30.131] <TB1> INFO: running: highrate
[16:49:30.131] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[16:49:30.273] <TB1> INFO: ----------------------------------------------------------------------
[16:49:30.273] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:49:30.273] <TB1> INFO: ----------------------------------------------------------------------
[16:49:30.762] <TB1> INFO: Expecting 208000 events.
[16:49:54.193] <TB1> INFO: 208000 events read in total (23030ms).
[16:49:54.206] <TB1> INFO: Test took 23930ms.
[16:49:55.396] <TB1> INFO: number of dead pixels (per ROC): 0 0 3 0 1 3 1 0 0 0 0 0 1 0 0 1
[16:49:55.396] <TB1> INFO: number of red-efficiency pixels: 835 790 770 1568 1631 2462 2174 2215 2263 1983 2456 1528 1489 733 735 784
[16:49:55.396] <TB1> INFO: number of X-ray hits detected: 271250 289749 261457 431324 441671 560036 523570 517818 525793 499944 543766 437672 413534 251224 283057 264532
[16:49:55.396] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:49:55.396] <TB1> INFO: number of Vcal hits detected: 207031 207108 206669 205632 205433 203184 203789 204518 204311 204625 203481 205703 205845 206888 207162 207036
[16:49:55.396] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.6 99.5 99.0 99.0 98.1 98.3 98.5 98.4 98.6 98.1 99.0 99.1 99.6 99.6 99.6
[16:49:55.396] <TB1> INFO: Vcal hit overall efficiency (%): 99.5 99.6 99.4 98.9 98.8 97.7 98.0 98.3 98.2 98.4 97.8 98.9 99.0 99.5 99.6 99.5
[16:49:55.396] <TB1> INFO: X-ray hit rate [MHz/cm2]: 79.5 84.9 76.6 126.4 129.5 164.2 153.5 151.8 154.1 146.5 159.4 128.3 121.2 73.6 83.0 77.5
[16:49:55.396] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:49:55.422] <TB1> INFO: PixTest:: pg_setup set to default.
[16:49:55.434] <TB1> INFO: enter test to run
[16:49:55.434] <TB1> INFO: test: no parameter change
[16:49:55.689] <TB1> QUIET: Connection to board 147 closed.
[16:49:55.769] <TB1> INFO: pXar: this is the end, my friend

[16:50:39.882] <TB1> INFO: *** Welcome to pxar ***
[16:50:39.882] <TB1> INFO: *** Today: 2016/08/22
[16:50:39.948] <TB1> INFO: *** Version: f5d3-dirty
[16:50:39.948] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//dacParameters35_C15.dat
[16:50:39.949] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//tbmParameters_C0b.dat
[16:50:39.949] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//defaultMaskFile.dat
[16:50:39.949] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//trimParameters35_C15.dat
[16:50:40.018] <TB1> INFO: clk: 4
[16:50:40.018] <TB1> INFO: ctr: 4
[16:50:40.018] <TB1> INFO: sda: 19
[16:50:40.018] <TB1> INFO: tin: 9
[16:50:40.018] <TB1> INFO: level: 15
[16:50:40.019] <TB1> INFO: triggerdelay: 0
[16:50:40.019] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:50:40.019] <TB1> INFO: Log level: INFO
[16:50:40.032] <TB1> INFO: Found DTB DTB_WWXTQT
[16:50:40.042] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:50:40.044] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:50:40.045] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:50:41.577] <TB1> INFO: DUT info:
[16:50:41.577] <TB1> INFO: The DUT currently contains the following objects:
[16:50:41.577] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:50:41.577] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:50:41.577] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:50:41.577] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:50:41.577] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.577] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.577] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.577] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.577] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.577] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.577] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.577] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.578] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.578] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.578] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.578] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.578] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.578] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.578] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.578] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:50:41.978] <TB1> INFO: enter 'restricted' command line mode
[16:50:41.978] <TB1> INFO: enter test to run
[16:50:41.978] <TB1> INFO: test: PixelAlive no parameter change
[16:50:41.978] <TB1> INFO: running: pixelalive
[16:50:41.982] <TB1> INFO: ######################################################################
[16:50:41.982] <TB1> INFO: PixTestAlive::doTest()
[16:50:41.982] <TB1> INFO: ######################################################################
[16:50:41.983] <TB1> INFO: ----------------------------------------------------------------------
[16:50:41.983] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:50:41.983] <TB1> INFO: ----------------------------------------------------------------------
[16:50:42.275] <TB1> INFO: Expecting 208000 events.
[16:50:53.661] <TB1> INFO: 208000 events read in total (10828ms).
[16:50:53.662] <TB1> INFO: Test took 11677ms.
[16:50:53.890] <TB1> INFO: PixTestAlive::aliveTest() done
[16:50:53.890] <TB1> INFO: number of dead pixels (per ROC): 0 0 1 0 0 3 1 0 0 0 0 0 0 0 0 1
[16:50:53.892] <TB1> INFO: ----------------------------------------------------------------------
[16:50:53.892] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:50:53.892] <TB1> INFO: ----------------------------------------------------------------------
[16:50:54.159] <TB1> INFO: Expecting 208000 events.
[16:51:01.636] <TB1> INFO: 208000 events read in total (6921ms).
[16:51:01.637] <TB1> INFO: Test took 7743ms.
[16:51:01.637] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:51:01.883] <TB1> INFO: PixTestAlive::maskTest() done
[16:51:01.883] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:51:01.884] <TB1> INFO: ----------------------------------------------------------------------
[16:51:01.884] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:51:01.884] <TB1> INFO: ----------------------------------------------------------------------
[16:51:02.178] <TB1> INFO: Expecting 208000 events.
[16:51:13.543] <TB1> INFO: 208000 events read in total (10808ms).
[16:51:13.544] <TB1> INFO: Test took 11658ms.
[16:51:13.742] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:51:13.742] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:51:13.742] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:51:13.773] <TB1> INFO: enter test to run
[16:51:13.773] <TB1> INFO: test: delay setting parameters: ->2<-
[16:51:13.773] <TB1> INFO: delay test by 2 seconds...
[16:51:15.773] <TB1> INFO: enter test to run
[16:51:15.773] <TB1> INFO: test: HighRate no parameter change
[16:51:15.773] <TB1> INFO: running: highrate
[16:51:15.774] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[16:51:15.940] <TB1> INFO: ----------------------------------------------------------------------
[16:51:15.940] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:51:15.940] <TB1> INFO: ----------------------------------------------------------------------
[16:51:16.452] <TB1> INFO: Expecting 208000 events.
[16:51:43.018] <TB1> INFO: 208000 events read in total (26165ms).
[16:51:43.032] <TB1> INFO: Test took 27088ms.
[16:51:44.364] <TB1> INFO: number of dead pixels (per ROC): 0 0 3 0 1 3 1 0 0 0 0 0 0 0 0 1
[16:51:44.364] <TB1> INFO: number of red-efficiency pixels: 1217 1067 1017 2221 2280 3151 2954 2996 3079 2731 3229 2142 1977 1026 1086 1126
[16:51:44.364] <TB1> INFO: number of X-ray hits detected: 326249 349381 315375 519234 533004 677867 639067 628193 637817 606507 657431 526264 497055 303174 340912 318427
[16:51:44.364] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:51:44.364] <TB1> INFO: number of Vcal hits detected: 206422 206693 205903 203908 203517 199844 200410 201832 201368 202059 200080 204134 204746 206136 206701 206526
[16:51:44.364] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.3 99.4 99.2 98.3 98.2 96.6 96.9 97.3 97.1 97.5 96.7 98.4 98.6 99.3 99.4 99.4
[16:51:44.364] <TB1> INFO: Vcal hit overall efficiency (%): 99.2 99.4 99.0 98.0 97.8 96.1 96.4 97.0 96.8 97.1 96.2 98.1 98.4 99.1 99.4 99.3
[16:51:44.364] <TB1> INFO: X-ray hit rate [MHz/cm2]: 95.6 102.4 92.4 152.2 156.2 198.7 187.3 184.1 186.9 177.8 192.7 154.3 145.7 88.9 99.9 93.3
[16:51:44.364] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:51:44.394] <TB1> INFO: PixTest:: pg_setup set to default.
[16:51:44.410] <TB1> INFO: enter test to run
[16:51:44.410] <TB1> INFO: test: no parameter change
[16:51:44.691] <TB1> QUIET: Connection to board 147 closed.
[16:51:44.770] <TB1> INFO: pXar: this is the end, my friend

[16:52:26.395] <TB1> INFO: *** Welcome to pxar ***
[16:52:26.395] <TB1> INFO: *** Today: 2016/08/22
[16:52:26.455] <TB1> INFO: *** Version: f5d3-dirty
[16:52:26.455] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//dacParameters35_C15.dat
[16:52:26.455] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//tbmParameters_C0b.dat
[16:52:26.455] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//defaultMaskFile.dat
[16:52:26.455] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//trimParameters35_C15.dat
[16:52:26.527] <TB1> INFO: clk: 4
[16:52:26.527] <TB1> INFO: ctr: 4
[16:52:26.527] <TB1> INFO: sda: 19
[16:52:26.527] <TB1> INFO: tin: 9
[16:52:26.527] <TB1> INFO: level: 15
[16:52:26.527] <TB1> INFO: triggerdelay: 0
[16:52:26.527] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:52:26.527] <TB1> INFO: Log level: INFO
[16:52:26.539] <TB1> INFO: Found DTB DTB_WWXTQT
[16:52:26.549] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:52:26.551] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:52:26.553] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:52:28.092] <TB1> INFO: DUT info:
[16:52:28.092] <TB1> INFO: The DUT currently contains the following objects:
[16:52:28.092] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:52:28.092] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:52:28.092] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:52:28.092] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:52:28.092] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.092] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:52:28.493] <TB1> INFO: enter 'restricted' command line mode
[16:52:28.493] <TB1> INFO: enter test to run
[16:52:28.493] <TB1> INFO: test: PixelAlive no parameter change
[16:52:28.493] <TB1> INFO: running: pixelalive
[16:52:28.496] <TB1> INFO: ######################################################################
[16:52:28.496] <TB1> INFO: PixTestAlive::doTest()
[16:52:28.496] <TB1> INFO: ######################################################################
[16:52:28.498] <TB1> INFO: ----------------------------------------------------------------------
[16:52:28.498] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:52:28.498] <TB1> INFO: ----------------------------------------------------------------------
[16:52:28.803] <TB1> INFO: Expecting 208000 events.
[16:52:40.758] <TB1> INFO: 208000 events read in total (11397ms).
[16:52:40.760] <TB1> INFO: Test took 12261ms.
[16:52:41.007] <TB1> INFO: PixTestAlive::aliveTest() done
[16:52:41.007] <TB1> INFO: number of dead pixels (per ROC): 0 0 2 0 1 3 1 0 0 0 0 0 1 0 0 1
[16:52:41.009] <TB1> INFO: ----------------------------------------------------------------------
[16:52:41.009] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:52:41.009] <TB1> INFO: ----------------------------------------------------------------------
[16:52:41.313] <TB1> INFO: Expecting 208000 events.
[16:52:48.805] <TB1> INFO: 208000 events read in total (6935ms).
[16:52:48.806] <TB1> INFO: Test took 7795ms.
[16:52:48.806] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:52:49.050] <TB1> INFO: PixTestAlive::maskTest() done
[16:52:49.050] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:52:49.052] <TB1> INFO: ----------------------------------------------------------------------
[16:52:49.052] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:52:49.052] <TB1> INFO: ----------------------------------------------------------------------
[16:52:49.345] <TB1> INFO: Expecting 208000 events.
[16:53:00.803] <TB1> INFO: 208000 events read in total (10902ms).
[16:53:00.803] <TB1> INFO: Test took 11750ms.
[16:53:01.011] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:53:01.011] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:53:01.011] <TB1> INFO: PixTestAlive::doTest() done, duration: 32 seconds
[16:53:01.044] <TB1> INFO: enter test to run
[16:53:01.044] <TB1> INFO: test: delay setting parameters: ->2<-
[16:53:01.044] <TB1> INFO: delay test by 2 seconds...
[16:53:03.044] <TB1> INFO: enter test to run
[16:53:03.044] <TB1> INFO: test: HighRate no parameter change
[16:53:03.044] <TB1> INFO: running: highrate
[16:53:03.044] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[16:53:03.218] <TB1> INFO: ----------------------------------------------------------------------
[16:53:03.218] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:53:03.218] <TB1> INFO: ----------------------------------------------------------------------
[16:53:03.710] <TB1> INFO: Expecting 208000 events.
[16:53:39.683] <TB1> INFO: 208000 events read in total (35572ms).
[16:53:39.702] <TB1> INFO: Test took 36481ms.
[16:53:41.430] <TB1> INFO: number of dead pixels (per ROC): 0 0 2 0 1 3 1 0 0 0 0 0 0 0 0 1
[16:53:41.430] <TB1> INFO: number of red-efficiency pixels: 2200 2028 1614 3522 3573 4083 4034 4033 4079 3905 4074 3427 3285 1651 2086 2041
[16:53:41.430] <TB1> INFO: number of X-ray hits detected: 453509 482417 438168 726218 750509 956601 929294 892688 907664 864668 931779 729911 689740 421304 474366 436338
[16:53:41.430] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:53:41.430] <TB1> INFO: number of Vcal hits detected: 204194 204937 203059 196931 196065 185098 184545 190232 188349 190628 186016 197596 199404 203279 204819 204545
[16:53:41.430] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.4 98.6 98.1 95.4 95.0 90.1 90.0 92.1 91.3 92.6 90.5 95.6 96.3 98.2 98.6 98.6
[16:53:41.430] <TB1> INFO: Vcal hit overall efficiency (%): 98.2 98.5 97.6 94.7 94.3 89.0 88.7 91.5 90.6 91.6 89.4 95.0 95.9 97.7 98.5 98.3
[16:53:41.430] <TB1> INFO: X-ray hit rate [MHz/cm2]: 132.9 141.4 128.4 212.9 220.0 280.4 272.4 261.7 266.0 253.4 273.1 213.9 202.2 123.5 139.0 127.9
[16:53:41.430] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:53:41.460] <TB1> INFO: PixTest:: pg_setup set to default.
[16:53:41.472] <TB1> INFO: enter test to run
[16:53:41.472] <TB1> INFO: test: no parameter change
[16:53:41.758] <TB1> QUIET: Connection to board 147 closed.
[16:53:41.838] <TB1> INFO: pXar: this is the end, my friend

[16:54:21.063] <TB1> INFO: *** Welcome to pxar ***
[16:54:21.063] <TB1> INFO: *** Today: 2016/08/22
[16:54:21.133] <TB1> INFO: *** Version: f5d3-dirty
[16:54:21.133] <TB1> INFO: readRocDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//dacParameters35_C15.dat
[16:54:21.134] <TB1> INFO: readTbmDacs: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//tbmParameters_C0b.dat
[16:54:21.134] <TB1> INFO: readMaskFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//defaultMaskFile.dat
[16:54:21.134] <TB1> INFO: readTrimFile: /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//trimParameters35_C15.dat
[16:54:21.204] <TB1> INFO: clk: 4
[16:54:21.204] <TB1> INFO: ctr: 4
[16:54:21.204] <TB1> INFO: sda: 19
[16:54:21.204] <TB1> INFO: tin: 9
[16:54:21.204] <TB1> INFO: level: 15
[16:54:21.204] <TB1> INFO: triggerdelay: 0
[16:54:21.204] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:54:21.204] <TB1> INFO: Log level: INFO
[16:54:21.218] <TB1> INFO: Found DTB DTB_WWXTQT
[16:54:21.228] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:54:21.230] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:54:21.231] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[16:54:22.770] <TB1> INFO: DUT info:
[16:54:22.770] <TB1> INFO: The DUT currently contains the following objects:
[16:54:22.770] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:54:22.770] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:54:22.770] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:54:22.770] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:54:22.770] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:22.770] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:54:23.171] <TB1> INFO: enter 'restricted' command line mode
[16:54:23.171] <TB1> INFO: enter test to run
[16:54:23.171] <TB1> INFO: test: PixelAlive no parameter change
[16:54:23.171] <TB1> INFO: running: pixelalive
[16:54:23.174] <TB1> INFO: ######################################################################
[16:54:23.174] <TB1> INFO: PixTestAlive::doTest()
[16:54:23.174] <TB1> INFO: ######################################################################
[16:54:23.176] <TB1> INFO: ----------------------------------------------------------------------
[16:54:23.176] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:54:23.176] <TB1> INFO: ----------------------------------------------------------------------
[16:54:23.457] <TB1> INFO: Expecting 208000 events.
[16:54:34.767] <TB1> INFO: 208000 events read in total (10752ms).
[16:54:34.768] <TB1> INFO: Test took 11591ms.
[16:54:35.011] <TB1> INFO: PixTestAlive::aliveTest() done
[16:54:35.011] <TB1> INFO: number of dead pixels (per ROC): 0 0 1 0 0 3 1 0 0 0 0 0 0 0 0 1
[16:54:35.013] <TB1> INFO: ----------------------------------------------------------------------
[16:54:35.013] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:54:35.013] <TB1> INFO: ----------------------------------------------------------------------
[16:54:35.305] <TB1> INFO: Expecting 208000 events.
[16:54:42.643] <TB1> INFO: 208000 events read in total (6782ms).
[16:54:42.645] <TB1> INFO: Test took 7630ms.
[16:54:42.645] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:54:42.884] <TB1> INFO: PixTestAlive::maskTest() done
[16:54:42.884] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:54:42.886] <TB1> INFO: ----------------------------------------------------------------------
[16:54:42.886] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:54:42.886] <TB1> INFO: ----------------------------------------------------------------------
[16:54:43.164] <TB1> INFO: Expecting 208000 events.
[16:54:54.395] <TB1> INFO: 208000 events read in total (10675ms).
[16:54:54.396] <TB1> INFO: Test took 11509ms.
[16:54:54.599] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:54:54.599] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:54:54.599] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:54:54.633] <TB1> INFO: enter test to run
[16:54:54.633] <TB1> INFO: test: delay setting parameters: ->2<-
[16:54:54.633] <TB1> INFO: delay test by 2 seconds...
[16:54:56.633] <TB1> INFO: enter test to run
[16:54:56.633] <TB1> INFO: test: HighRate no parameter change
[16:54:56.633] <TB1> INFO: running: highrate
[16:54:56.633] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2292_XrayQualification_2016-08-22_17h23m_1471879389//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[16:54:56.817] <TB1> INFO: ----------------------------------------------------------------------
[16:54:56.817] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:54:56.818] <TB1> INFO: ----------------------------------------------------------------------
[16:54:57.326] <TB1> INFO: Expecting 208000 events.
[16:55:36.401] <TB1> INFO: 169900 events read in total (38673ms).
[16:55:44.921] <TB1> INFO: 208000 events read in total (47193ms).
[16:55:44.949] <TB1> INFO: Test took 48129ms.
[16:55:47.182] <TB1> INFO: number of dead pixels (per ROC): 0 0 3 0 1 3 94 0 0 0 0 0 1 0 0 1
[16:55:47.182] <TB1> INFO: number of red-efficiency pixels: 3119 3030 2207 4031 4045 4160 4160 4160 4159 4149 4160 4011 3911 2118 3013 2861
[16:55:47.182] <TB1> INFO: number of X-ray hits detected: 574512 609732 553057 920673 961850 1250213 1327249 1168728 1187087 1132114 1222810 930940 873661 530913 599467 546850
[16:55:47.182] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:55:47.182] <TB1> INFO: number of Vcal hits detected: 200609 201784 198785 185976 183830 158848 144051 169868 164395 171486 160769 186750 190957 199181 201539 201580
[16:55:47.182] <TB1> INFO: Vcal hit fiducial efficiency (%): 96.9 97.2 96.5 90.5 89.6 78.1 72.6 82.7 80.3 83.9 78.9 90.9 92.7 96.5 97.2 97.3
[16:55:47.182] <TB1> INFO: Vcal hit overall efficiency (%): 96.4 97.0 95.6 89.4 88.4 76.4 69.3 81.7 79.0 82.4 77.3 89.8 91.8 95.8 96.9 96.9
[16:55:47.182] <TB1> INFO: X-ray hit rate [MHz/cm2]: 168.4 178.7 162.1 269.9 281.9 366.4 389.0 342.6 347.9 331.8 358.4 272.9 256.1 155.6 175.7 160.3
[16:55:47.182] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:55:47.212] <TB1> INFO: PixTest:: pg_setup set to default.
[16:55:47.224] <TB1> INFO: enter test to run
[16:55:47.225] <TB1> INFO: test: no parameter change
[16:55:47.550] <TB1> QUIET: Connection to board 147 closed.
[16:55:47.631] <TB1> INFO: pXar: this is the end, my friend
[20:30:57.847] INFO: ----------------------------------------------------------------------
[20:30:57.847] INFO: RETEST
[20:30:57.847] INFO: ----------------------------------------------------------------------
[20:30:57.847] INFO: ----------------------------------------------------------------------
[20:30:57.848] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[20:30:57.848] INFO: ----------------------------------------------------------------------
[20:30:58.331] INFO: Expecting 208000 events.
[20:31:28.131] INFO: 208000 events read in total (29398ms).
[20:31:28.148] INFO: Test took 30297ms.
[20:31:29.654] INFO: number of dead pixels (per ROC): 0 0 1 0 0 3 1 0 0 0 0 0 1 0 0 1
[20:31:29.654] INFO: number of red-efficiency pixels: 1944 1752 1512 3211 3150 3863 3690 3886 3714 3370 3695 2857 2614 1306 1501 1490
[20:31:29.654] INFO: number of X-ray hits detected: 421732 447539 410169 662136 684226 853804 797812 805104 769802 710509 768253 628476 588591 355238 397503 377239
[20:31:29.654] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[20:31:29.654] INFO: number of Vcal hits detected: 204890 205465 203906 199735 199063 192255 194345 194905 196672 198449 195919 201427 202674 205178 206003 205836
[20:31:29.654] INFO: Vcal hit fiducial efficiency (%): 98.7 98.9 98.4 96.5 96.3 93.3 94.3 94.2 95.0 96.0 94.8 97.2 97.7 98.9 99.1 99.1
[20:31:29.654] INFO: Vcal hit overall efficiency (%): 98.5 98.8 98.0 96.0 95.7 92.4 93.4 93.7 94.6 95.4 94.2 96.8 97.4 98.6 99.0 99.0
[20:31:29.654] INFO: X-ray hit rate [MHz/cm2]: 123.6 131.2 120.2 194.1 200.6 250.3 233.8 236.0 225.6 208.3 225.2 184.2 172.5 104.1 116.5 110.6
[20:31:29.654] INFO: PixTestHighRate::doXPixelAlive() done
[20:31:29.688] INFO: PixTest:: pg_setup set to default.
[20:31:50.000] QUIET: Connection to board 83 closed.