[12:31:10.472] <TB1> INFO: *** Welcome to pxar ***
[12:31:10.472] <TB1> INFO: *** Today: 2016/01/14
[12:31:10.534] <TB1> INFO: *** Version: b2d3
[12:31:10.534] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//000_PixelAlive_p17//dacParameters35_C15.dat
[12:31:10.535] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//000_PixelAlive_p17//tbmParameters_C0b.dat
[12:31:10.535] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//000_PixelAlive_p17//defaultMaskFile.dat
[12:31:10.535] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//000_PixelAlive_p17//trimParameters35_C15.dat
[12:31:10.617] <TB1> INFO: clk: 4
[12:31:10.617] <TB1> INFO: ctr: 4
[12:31:10.617] <TB1> INFO: sda: 19
[12:31:10.617] <TB1> INFO: tin: 9
[12:31:10.617] <TB1> INFO: level: 15
[12:31:10.617] <TB1> INFO: triggerdelay: 0
[12:31:10.617] <TB1> QUIET: Instanciating API for pxar prod-12
[12:31:10.617] <TB1> INFO: Log level: INFO
[12:31:10.630] <TB1> INFO: Found DTB DTB_WWXTQT
[12:31:10.640] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:31:10.643] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:31:10.645] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:31:12.192] <TB1> INFO: DUT info:
[12:31:12.192] <TB1> INFO: The DUT currently contains the following objects:
[12:31:12.192] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:31:12.192] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:31:12.192] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:31:12.192] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:31:12.192] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.192] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.192] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.192] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.192] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.192] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.192] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.192] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.193] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.193] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.193] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.193] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.193] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.193] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.193] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.193] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:31:12.594] <TB1> INFO: enter 'restricted' command line mode
[12:31:12.594] <TB1> INFO: enter test to run
[12:31:12.594] <TB1> INFO: test: PixelAlive no parameter change
[12:31:12.594] <TB1> INFO: running: pixelalive
[12:31:12.600] <TB1> INFO: ######################################################################
[12:31:12.600] <TB1> INFO: PixTestAlive::doTest()
[12:31:12.600] <TB1> INFO: ######################################################################
[12:31:12.602] <TB1> INFO: ----------------------------------------------------------------------
[12:31:12.602] <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)
[12:31:12.602] <TB1> INFO: ----------------------------------------------------------------------
[12:31:12.917] <TB1> INFO: Expecting 41600 events.
[12:31:17.409] <TB1> INFO: 41600 events read in total (3774ms).
[12:31:17.481] <TB1> INFO: Test took 4877ms.
[12:31:17.488] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:31:17.738] <TB1> INFO: PixTestAlive::aliveTest() done
[12:31:17.738] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 2 0 0 1 0 0 0 0
[12:31:17.739] <TB1> INFO: ----------------------------------------------------------------------
[12:31:17.739] <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)
[12:31:17.739] <TB1> INFO: ----------------------------------------------------------------------
[12:31:18.037] <TB1> INFO: Expecting 41600 events.
[12:31:21.206] <TB1> INFO: 41600 events read in total (2454ms).
[12:31:21.207] <TB1> INFO: Test took 3466ms.
[12:31:21.207] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:31:21.208] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:31:21.520] <TB1> INFO: PixTestAlive::maskTest() done
[12:31:21.520] <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
[12:31:21.521] <TB1> INFO: ----------------------------------------------------------------------
[12:31:21.521] <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)
[12:31:21.521] <TB1> INFO: ----------------------------------------------------------------------
[12:31:21.829] <TB1> INFO: Expecting 41600 events.
[12:31:26.141] <TB1> INFO: 41600 events read in total (3596ms).
[12:31:26.141] <TB1> INFO: Test took 4618ms.
[12:31:26.149] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:31:26.433] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:31:26.433] <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
[12:31:26.433] <TB1> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[12:31:26.468] <TB1> INFO: enter test to run
[12:31:26.468] <TB1> INFO: test: no parameter change
[12:31:26.608] <TB1> QUIET: Connection to board 147 closed.
[12:31:26.687] <TB1> INFO: pXar: this is the end, my friend

[12:36:43.952] <TB1> INFO: *** Welcome to pxar ***
[12:36:43.952] <TB1> INFO: *** Today: 2016/01/14
[12:36:44.016] <TB1> INFO: *** Version: b2d3
[12:36:44.016] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//dacParameters35_C15.dat
[12:36:44.017] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[12:36:44.017] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:36:44.017] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:36:44.087] <TB1> INFO: clk: 4
[12:36:44.087] <TB1> INFO: ctr: 4
[12:36:44.087] <TB1> INFO: sda: 19
[12:36:44.087] <TB1> INFO: tin: 9
[12:36:44.087] <TB1> INFO: level: 15
[12:36:44.087] <TB1> INFO: triggerdelay: 0
[12:36:44.087] <TB1> QUIET: Instanciating API for pxar prod-12
[12:36:44.087] <TB1> INFO: Log level: INFO
[12:36:44.100] <TB1> INFO: Found DTB DTB_WWXTQT
[12:36:44.110] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:36:44.113] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:36:44.115] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:36:45.673] <TB1> INFO: DUT info:
[12:36:45.673] <TB1> INFO: The DUT currently contains the following objects:
[12:36:45.673] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:36:45.673] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:36:45.673] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:36:45.674] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:36:45.674] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:45.674] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:46.074] <TB1> INFO: enter 'restricted' command line mode
[12:36:46.074] <TB1> INFO: enter test to run
[12:36:46.075] <TB1> INFO: test: delay setting parameters: ->5<-
[12:36:46.075] <TB1> INFO: delay test by 5 seconds...
[12:36:51.075] <TB1> INFO: enter test to run
[12:36:51.075] <TB1> INFO: test: highrate no parameter change
[12:36:51.075] <TB1> INFO: running: highrate
[12:36:51.075] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[12:36:51.212] <TB1> INFO: ----------------------------------------------------------------------
[12:36:51.212] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:36:51.212] <TB1> INFO: ----------------------------------------------------------------------
[12:36:51.212] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:36:51.212] <TB1> INFO: edge/corner pixel THR is adjusted
[12:36:51.212] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:36:52.172] <TB1> INFO: Collecting data for 1 seconds...
[12:36:53.174] <TB1> INFO: Done with hot pixel readout
[12:37:01.976] <TB1> INFO: PixTest:: pg_setup set to default.
[12:37:01.977] <TB1> INFO: 4 hot pixels found in step 0
[12:37:02.940] <TB1> INFO: Collecting data for 1 seconds...
[12:37:03.941] <TB1> INFO: Done with hot pixel readout
[12:37:12.727] <TB1> INFO: PixTest:: pg_setup set to default.
[12:37:12.728] <TB1> INFO: 4 hot pixels found in step 1
[12:37:13.691] <TB1> INFO: Collecting data for 1 seconds...
[12:37:14.692] <TB1> INFO: Done with hot pixel readout
[12:37:23.100] <TB1> INFO: PixTest:: pg_setup set to default.
[12:37:23.101] <TB1> INFO: 3 hot pixels found in step 2
[12:37:24.063] <TB1> INFO: Collecting data for 1 seconds...
[12:37:25.064] <TB1> INFO: Done with hot pixel readout
[12:37:33.249] <TB1> INFO: PixTest:: pg_setup set to default.
[12:37:33.250] <TB1> INFO: 0 hot pixels found in step 3
[12:37:33.259] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[12:37:33.298] <TB1> INFO: PixTest::trimHotPixels() done
[12:37:33.298] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C0.dat
[12:37:33.306] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C1.dat
[12:37:33.314] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C2.dat
[12:37:33.322] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C3.dat
[12:37:33.330] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C4.dat
[12:37:33.338] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C5.dat
[12:37:33.346] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C6.dat
[12:37:33.355] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C7.dat
[12:37:33.363] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C8.dat
[12:37:33.371] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C9.dat
[12:37:33.380] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C10.dat
[12:37:33.387] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C11.dat
[12:37:33.396] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C12.dat
[12:37:33.404] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C13.dat
[12:37:33.412] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C14.dat
[12:37:33.420] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:37:33.428] <TB1> INFO: write masked pixels into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:37:33.466] <TB1> INFO: enter test to run
[12:37:33.466] <TB1> INFO: test: no parameter change
[12:37:33.624] <TB1> QUIET: Connection to board 147 closed.
[12:37:33.704] <TB1> INFO: pXar: this is the end, my friend

[12:38:57.537] <TB1> INFO: *** Welcome to pxar ***
[12:38:57.537] <TB1> INFO: *** Today: 2016/01/14
[12:38:57.593] <TB1> INFO: *** Version: b2d3
[12:38:57.593] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//dacParameters35_C15.dat
[12:38:57.594] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0b.dat
[12:38:57.594] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[12:38:57.594] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[12:38:57.664] <TB1> INFO: clk: 4
[12:38:57.664] <TB1> INFO: ctr: 4
[12:38:57.664] <TB1> INFO: sda: 19
[12:38:57.664] <TB1> INFO: tin: 9
[12:38:57.664] <TB1> INFO: level: 15
[12:38:57.664] <TB1> INFO: triggerdelay: 0
[12:38:57.664] <TB1> QUIET: Instanciating API for pxar prod-12
[12:38:57.664] <TB1> INFO: Log level: INFO
[12:38:57.677] <TB1> INFO: Found DTB DTB_WWXTQT
[12:38:57.688] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:38:57.691] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:38:57.693] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:38:59.260] <TB1> INFO: DUT info:
[12:38:59.260] <TB1> INFO: The DUT currently contains the following objects:
[12:38:59.260] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:38:59.260] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:38:59.260] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:38:59.260] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:38:59.260] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.260] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:59.662] <TB1> INFO: enter 'restricted' command line mode
[12:38:59.662] <TB1> INFO: enter test to run
[12:38:59.662] <TB1> INFO: test: delay setting parameters: ->5<-
[12:38:59.662] <TB1> INFO: delay test by 5 seconds...
[12:39:04.663] <TB1> INFO: enter test to run
[12:39:04.663] <TB1> INFO: test: highrate no parameter change
[12:39:04.663] <TB1> INFO: running: highrate
[12:39:04.663] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C15.dat
[12:39:04.939] <TB1> INFO: ----------------------------------------------------------------------
[12:39:04.939] <TB1> INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[12:39:04.939] <TB1> INFO: ----------------------------------------------------------------------
[12:39:04.939] <TB1> INFO: THR = 10, corresponding to ~ 5.33333 MHz/cm2
[12:39:04.939] <TB1> INFO: edge/corner pixel THR is adjusted
[12:39:04.939] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:39:05.899] <TB1> INFO: Collecting data for 5 seconds...
[12:39:10.904] <TB1> INFO: Done with hot pixel readout
[12:39:21.849] <TB1> INFO: PixTest:: pg_setup set to default.
[12:39:21.850] <TB1> INFO: 3 hot pixels found in step 0
[12:39:22.891] <TB1> INFO: Collecting data for 5 seconds...
[12:39:27.895] <TB1> INFO: Done with hot pixel readout
[12:39:38.948] <TB1> INFO: PixTest:: pg_setup set to default.
[12:39:38.949] <TB1> INFO: 0 hot pixels found in step 1
[12:39:38.952] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[12:39:39.034] <TB1> INFO: PixTest::trimHotPixels() done
[12:39:39.035] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat
[12:39:39.042] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C1.dat
[12:39:39.049] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C2.dat
[12:39:39.060] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C3.dat
[12:39:39.068] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C4.dat
[12:39:39.077] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C5.dat
[12:39:39.087] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C6.dat
[12:39:39.094] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C7.dat
[12:39:39.106] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C8.dat
[12:39:39.113] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C9.dat
[12:39:39.120] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C10.dat
[12:39:39.127] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C11.dat
[12:39:39.136] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C12.dat
[12:39:39.146] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C13.dat
[12:39:39.153] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C14.dat
[12:39:39.164] <TB1> INFO: write trim parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[12:39:39.172] <TB1> INFO: write masked pixels into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[12:39:39.202] <TB1> INFO: enter test to run
[12:39:39.202] <TB1> INFO: test: no parameter change
[12:39:39.354] <TB1> QUIET: Connection to board 147 closed.
[12:39:39.434] <TB1> INFO: pXar: this is the end, my friend

[12:40:26.889] <TB1> INFO: *** Welcome to pxar ***
[12:40:26.889] <TB1> INFO: *** Today: 2016/01/14
[12:40:26.954] <TB1> INFO: *** Version: b2d3
[12:40:26.955] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//dacParameters35_C15.dat
[12:40:26.955] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//tbmParameters_C0b.dat
[12:40:26.955] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//defaultMaskFile.dat
[12:40:26.955] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//trimParameters35_C15.dat
[12:40:27.025] <TB1> INFO: clk: 4
[12:40:27.025] <TB1> INFO: ctr: 4
[12:40:27.025] <TB1> INFO: sda: 19
[12:40:27.025] <TB1> INFO: tin: 9
[12:40:27.025] <TB1> INFO: level: 15
[12:40:27.025] <TB1> INFO: triggerdelay: 0
[12:40:27.025] <TB1> QUIET: Instanciating API for pxar prod-12
[12:40:27.025] <TB1> INFO: Log level: INFO
[12:40:27.038] <TB1> INFO: Found DTB DTB_WWXTQT
[12:40:27.049] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:40:27.052] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:40:27.055] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:40:28.577] <TB1> INFO: DUT info:
[12:40:28.577] <TB1> INFO: The DUT currently contains the following objects:
[12:40:28.577] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:40:28.577] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:40:28.577] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:40:28.577] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:40:28.577] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.577] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.577] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.578] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:40:28.979] <TB1> INFO: enter 'restricted' command line mode
[12:40:28.979] <TB1> INFO: enter test to run
[12:40:28.980] <TB1> INFO: test: delay setting parameters: ->5<-
[12:40:28.980] <TB1> INFO: delay test by 5 seconds...
[12:40:33.980] <TB1> INFO: enter test to run
[12:40:33.980] <TB1> INFO: test: Xray no parameter change
[12:40:33.980] <TB1> INFO: running: xray
[12:40:33.980] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//004_HRData_50//phCalibrationFitErr35_C15.dat
[12:40:34.266] <TB1> INFO: ######################################################################
[12:40:34.266] <TB1> INFO: PixTestXray::doTest()
[12:40:34.266] <TB1> INFO: ######################################################################
[12:40:34.266] <TB1> INFO: ----------------------------------------------------------------------
[12:40:34.266] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:40:34.266] <TB1> INFO: ----------------------------------------------------------------------
[12:40:35.235] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:40:41.340] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[12:41:14.509] <TB1> INFO: Resuming triggers.
[12:41:20.619] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[12:41:51.660] <TB1> INFO: Resuming triggers.
[12:41:57.773] <TB1> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[12:42:29.654] <TB1> INFO: Resuming triggers.
[12:42:35.761] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[12:43:08.338] <TB1> INFO: Resuming triggers.
[12:43:14.439] <TB1> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[12:43:46.525] <TB1> INFO: Resuming triggers.
[12:43:52.623] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[12:44:23.530] <TB1> INFO: Resuming triggers.
[12:44:29.629] <TB1> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[12:45:01.137] <TB1> INFO: Resuming triggers.
[12:45:07.241] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[12:45:39.701] <TB1> INFO: Resuming triggers.
[12:45:45.799] <TB1> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[12:46:18.128] <TB1> INFO: Resuming triggers.
[12:46:24.228] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[12:46:56.651] <TB1> INFO: Resuming triggers.
[12:47:02.749] <TB1> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[12:47:35.178] <TB1> INFO: Resuming triggers.
[12:47:41.270] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[12:48:12.814] <TB1> INFO: Resuming triggers.
[12:48:18.909] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[12:48:50.989] <TB1> INFO: Resuming triggers.
[12:48:57.079] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[12:49:29.572] <TB1> INFO: Resuming triggers.
[12:49:35.663] <TB1> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[12:50:06.439] <TB1> INFO: Resuming triggers.
[12:50:12.527] <TB1> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[12:50:35.256] <TB1> INFO: Resuming triggers.
[12:50:37.760] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[12:50:47.405] <TB1> INFO: PixTest:: pg_setup set to default.
[12:50:47.407] <TB1> INFO: PixTestXray::doPhRun() done
[12:50:47.407] <TB1> INFO: PixTestXray::doTest() done
[12:50:47.582] <TB1> INFO: enter test to run
[12:50:47.582] <TB1> INFO: test: no parameter change
[12:50:47.854] <TB1> QUIET: Connection to board 147 closed.
[12:50:47.934] <TB1> INFO: pXar: this is the end, my friend

[12:51:03.466] <TB1> INFO: *** Welcome to pxar ***
[12:51:03.466] <TB1> INFO: *** Today: 2016/01/14
[12:51:03.522] <TB1> INFO: *** Version: b2d3
[12:51:03.522] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//dacParameters35_C15.dat
[12:51:03.523] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//tbmParameters_C0b.dat
[12:51:03.523] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//defaultMaskFile.dat
[12:51:03.523] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//trimParameters35_C15.dat
[12:51:03.601] <TB1> INFO: clk: 4
[12:51:03.601] <TB1> INFO: ctr: 4
[12:51:03.601] <TB1> INFO: sda: 19
[12:51:03.601] <TB1> INFO: tin: 9
[12:51:03.601] <TB1> INFO: level: 15
[12:51:03.601] <TB1> INFO: triggerdelay: 0
[12:51:03.601] <TB1> QUIET: Instanciating API for pxar prod-12
[12:51:03.601] <TB1> INFO: Log level: INFO
[12:51:03.614] <TB1> INFO: Found DTB DTB_WWXTQT
[12:51:03.624] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:51:03.627] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:51:03.630] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:51:05.160] <TB1> INFO: DUT info:
[12:51:05.160] <TB1> INFO: The DUT currently contains the following objects:
[12:51:05.160] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:51:05.160] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:51:05.160] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:51:05.160] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:51:05.160] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.160] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.161] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.161] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.161] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.161] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.161] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:51:05.562] <TB1> INFO: enter 'restricted' command line mode
[12:51:05.562] <TB1> INFO: enter test to run
[12:51:05.562] <TB1> INFO: test: delay setting parameters: ->5<-
[12:51:05.562] <TB1> INFO: delay test by 5 seconds...
[12:51:10.562] <TB1> INFO: enter test to run
[12:51:10.562] <TB1> INFO: test: Xray no parameter change
[12:51:10.562] <TB1> INFO: running: xray
[12:51:10.562] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//005_HRData_150//phCalibrationFitErr35_C15.dat
[12:51:10.704] <TB1> INFO: ######################################################################
[12:51:10.704] <TB1> INFO: PixTestXray::doTest()
[12:51:10.704] <TB1> INFO: ######################################################################
[12:51:10.704] <TB1> INFO: ----------------------------------------------------------------------
[12:51:10.704] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:51:10.704] <TB1> INFO: ----------------------------------------------------------------------
[12:51:11.669] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:51:14.871] <TB1> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[12:51:47.543] <TB1> INFO: Resuming triggers.
[12:51:50.762] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[12:52:22.661] <TB1> INFO: Resuming triggers.
[12:52:25.880] <TB1> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[12:52:58.475] <TB1> INFO: Resuming triggers.
[12:53:01.694] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[12:53:34.372] <TB1> INFO: Resuming triggers.
[12:53:37.591] <TB1> INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[12:54:10.580] <TB1> INFO: Resuming triggers.
[12:54:13.798] <TB1> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[12:54:46.177] <TB1> INFO: Resuming triggers.
[12:54:49.396] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[12:55:21.551] <TB1> INFO: Resuming triggers.
[12:55:24.772] <TB1> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[12:55:57.093] <TB1> INFO: Resuming triggers.
[12:56:00.312] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[12:56:31.729] <TB1> INFO: Resuming triggers.
[12:56:34.947] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[12:57:06.112] <TB1> INFO: Resuming triggers.
[12:57:09.326] <TB1> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[12:57:39.949] <TB1> INFO: Resuming triggers.
[12:57:43.165] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[12:58:16.308] <TB1> INFO: Resuming triggers.
[12:58:19.523] <TB1> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[12:58:52.151] <TB1> INFO: Resuming triggers.
[12:58:55.364] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[12:59:27.305] <TB1> INFO: Resuming triggers.
[12:59:30.520] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[13:00:01.439] <TB1> INFO: Resuming triggers.
[13:00:04.653] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[13:00:37.469] <TB1> INFO: Resuming triggers.
[13:00:40.683] <TB1> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[13:01:12.432] <TB1> INFO: Resuming triggers.
[13:01:15.644] <TB1> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[13:01:46.911] <TB1> INFO: Resuming triggers.
[13:01:50.122] <TB1> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[13:02:22.313] <TB1> INFO: Resuming triggers.
[13:02:25.525] <TB1> INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[13:02:58.840] <TB1> INFO: Resuming triggers.
[13:03:02.050] <TB1> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[13:03:34.862] <TB1> INFO: Resuming triggers.
[13:03:38.075] <TB1> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[13:04:09.585] <TB1> INFO: Resuming triggers.
[13:04:12.797] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[13:04:43.944] <TB1> INFO: Resuming triggers.
[13:04:47.154] <TB1> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[13:05:18.787] <TB1> INFO: Resuming triggers.
[13:05:21.996] <TB1> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[13:05:52.429] <TB1> INFO: Resuming triggers.
[13:05:55.639] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[13:06:26.070] <TB1> INFO: Resuming triggers.
[13:06:29.279] <TB1> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[13:07:00.179] <TB1> INFO: Resuming triggers.
[13:07:03.386] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[13:07:33.838] <TB1> INFO: Resuming triggers.
[13:07:37.047] <TB1> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[13:07:59.020] <TB1> INFO: Resuming triggers.
[13:08:02.229] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[13:08:24.508] <TB1> INFO: Resuming triggers.
[13:08:27.717] <TB1> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[13:08:49.946] <TB1> INFO: Resuming triggers.
[13:08:50.410] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[13:08:53.974] <TB1> INFO: PixTest:: pg_setup set to default.
[13:08:53.975] <TB1> INFO: PixTestXray::doPhRun() done
[13:08:53.975] <TB1> INFO: PixTestXray::doTest() done
[13:08:54.155] <TB1> INFO: enter test to run
[13:08:54.155] <TB1> INFO: test: no parameter change
[13:08:54.368] <TB1> QUIET: Connection to board 147 closed.
[13:08:54.447] <TB1> INFO: pXar: this is the end, my friend

[13:09:10.613] <TB1> INFO: *** Welcome to pxar ***
[13:09:10.613] <TB1> INFO: *** Today: 2016/01/14
[13:09:10.671] <TB1> INFO: *** Version: b2d3
[13:09:10.671] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//dacParameters35_C15.dat
[13:09:10.673] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//tbmParameters_C0b.dat
[13:09:10.673] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//defaultMaskFile.dat
[13:09:10.673] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//trimParameters35_C15.dat
[13:09:10.749] <TB1> INFO: clk: 4
[13:09:10.749] <TB1> INFO: ctr: 4
[13:09:10.749] <TB1> INFO: sda: 19
[13:09:10.749] <TB1> INFO: tin: 9
[13:09:10.749] <TB1> INFO: level: 15
[13:09:10.749] <TB1> INFO: triggerdelay: 0
[13:09:10.749] <TB1> QUIET: Instanciating API for pxar prod-12
[13:09:10.749] <TB1> INFO: Log level: INFO
[13:09:10.762] <TB1> INFO: Found DTB DTB_WWXTQT
[13:09:10.772] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:09:10.775] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:09:10.777] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:09:12.351] <TB1> INFO: DUT info:
[13:09:12.351] <TB1> INFO: The DUT currently contains the following objects:
[13:09:12.352] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:09:12.352] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:09:12.352] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:09:12.352] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:09:12.352] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.352] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.353] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:09:12.754] <TB1> INFO: enter 'restricted' command line mode
[13:09:12.754] <TB1> INFO: enter test to run
[13:09:12.754] <TB1> INFO: test: Highrate no parameter change
[13:09:12.754] <TB1> INFO: running: highrate
[13:09:12.754] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[13:09:13.006] <TB1> INFO: ----------------------------------------------------------------------
[13:09:13.006] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[13:09:13.006] <TB1> INFO: ----------------------------------------------------------------------
[13:09:13.012] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[13:09:13.027] <TB1> INFO: dacScan step from 15 .. 34
[13:09:13.027] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:09:13.027] <TB1> INFO: run 1 of 1
[13:09:13.673] <TB1> INFO: Expecting 4160000 events.
[13:09:49.725] <TB1> INFO: 417950 events read in total (35523ms).
[13:10:25.068] <TB1> INFO: 837900 events read in total (70866ms).
[13:11:00.869] <TB1> INFO: 1256850 events read in total (106667ms).
[13:11:37.125] <TB1> INFO: 1677150 events read in total (142923ms).
[13:12:11.365] <TB1> INFO: 2096700 events read in total (177163ms).
[13:12:45.920] <TB1> INFO: 2516550 events read in total (211718ms).
[13:13:21.186] <TB1> INFO: 2936350 events read in total (246984ms).
[13:13:56.320] <TB1> INFO: 3355050 events read in total (282118ms).
[13:14:30.458] <TB1> INFO: 3774200 events read in total (316256ms).
[13:15:04.517] <TB1> INFO: 4160000 events read in total (350315ms).
[13:15:04.912] <TB1> INFO: Test took 351885ms.
[13:15:06.929] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:15:12.685] <TB1> INFO: dacScan step from 35 .. 54
[13:15:12.685] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:15:12.685] <TB1> INFO: run 1 of 1
[13:15:13.280] <TB1> INFO: Expecting 4160000 events.
[13:15:47.183] <TB1> INFO: 358400 events read in total (33376ms).
[13:16:20.122] <TB1> INFO: 717850 events read in total (66315ms).
[13:16:53.087] <TB1> INFO: 1076700 events read in total (99280ms).
[13:17:28.384] <TB1> INFO: 1434750 events read in total (134577ms).
[13:18:03.314] <TB1> INFO: 1791950 events read in total (169507ms).
[13:18:36.681] <TB1> INFO: 2147550 events read in total (202874ms).
[13:19:11.218] <TB1> INFO: 2501350 events read in total (237411ms).
[13:19:46.433] <TB1> INFO: 2852600 events read in total (272626ms).
[13:20:20.268] <TB1> INFO: 3200550 events read in total (306461ms).
[13:20:51.827] <TB1> INFO: 3546550 events read in total (338020ms).
[13:21:26.962] <TB1> INFO: 3891950 events read in total (373155ms).
[13:21:54.891] <TB1> INFO: 4160000 events read in total (401084ms).
[13:21:55.122] <TB1> INFO: Test took 402437ms.
[13:21:57.071] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:22:03.515] <TB1> INFO: dacScan step from 55 .. 74
[13:22:03.515] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:22:03.515] <TB1> INFO: run 1 of 1
[13:22:04.133] <TB1> INFO: Expecting 4160000 events.
[13:22:37.757] <TB1> INFO: 316950 events read in total (33097ms).
[13:23:11.514] <TB1> INFO: 634600 events read in total (66854ms).
[13:23:44.212] <TB1> INFO: 952600 events read in total (99552ms).
[13:24:18.102] <TB1> INFO: 1270050 events read in total (133442ms).
[13:24:50.879] <TB1> INFO: 1587900 events read in total (166219ms).
[13:25:25.135] <TB1> INFO: 1905800 events read in total (200475ms).
[13:25:58.056] <TB1> INFO: 2223500 events read in total (233396ms).
[13:26:31.537] <TB1> INFO: 2541200 events read in total (266877ms).
[13:27:03.692] <TB1> INFO: 2858900 events read in total (299032ms).
[13:27:36.707] <TB1> INFO: 3176550 events read in total (332047ms).
[13:28:10.930] <TB1> INFO: 3494300 events read in total (366270ms).
[13:28:36.403] <TB1> INFO: 3812100 events read in total (391743ms).
[13:29:01.735] <TB1> INFO: 4129250 events read in total (417075ms).
[13:29:04.451] <TB1> INFO: 4160000 events read in total (419791ms).
[13:29:04.676] <TB1> INFO: Test took 421160ms.
[13:29:06.503] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:29:12.091] <TB1> INFO: dacScan step from 75 .. 75
[13:29:12.091] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:29:12.091] <TB1> INFO: run 1 of 1
[13:29:12.681] <TB1> INFO: Expecting 208000 events.
[13:29:30.558] <TB1> INFO: 208000 events read in total (17350ms).
[13:29:30.566] <TB1> INFO: Test took 18474ms.
[13:29:30.655] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:29:30.936] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:31.981] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:32.975] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:33.975] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:35.017] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:36.058] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:37.120] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:38.158] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:39.209] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:40.233] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:41.260] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:42.314] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:43.350] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:44.359] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:45.346] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:46.335] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:29:47.315] <TB1> INFO: PixTest:: pg_setup set to default.
[13:29:47.317] <TB1> INFO: vcal mean: 39.53 39.70 39.27 42.57 42.15 43.42 43.14 44.54 43.83 42.75 43.89 42.88 41.04 39.79 39.48 39.39
[13:29:47.317] <TB1> INFO: vcal RMS: 1.21 1.33 0.98 1.48 1.24 1.43 1.39 1.54 1.60 1.44 1.53 1.74 1.22 1.34 1.04 1.16
[13:29:47.317] <TB1> INFO: number of X-ray hits detected: 232799 238444 215386 360871 378485 443048 427532 479732 449616 407044 457105 389257 322800 221298 219999 222324
[13:29:47.317] <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
[13:29:47.317] <TB1> INFO: X-ray hit rate [MHz/cm2]: 68.2 69.9 63.1 105.8 110.9 129.9 125.3 140.6 131.8 119.3 134.0 114.1 94.6 64.9 64.5 65.2
[13:29:47.317] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[13:29:47.409] <TB1> INFO: enter test to run
[13:29:47.409] <TB1> INFO: test: no parameter change
[13:29:47.581] <TB1> QUIET: Connection to board 147 closed.
[13:29:47.666] <TB1> INFO: pXar: this is the end, my friend

[13:48:21.464] <TB1> INFO: *** Welcome to pxar ***
[13:48:21.464] <TB1> INFO: *** Today: 2016/01/14
[13:48:21.523] <TB1> INFO: *** Version: b2d3
[13:48:21.523] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:48:21.523] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[13:48:21.523] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[13:48:21.524] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[13:48:21.593] <TB1> INFO: clk: 4
[13:48:21.593] <TB1> INFO: ctr: 4
[13:48:21.593] <TB1> INFO: sda: 19
[13:48:21.594] <TB1> INFO: tin: 9
[13:48:21.594] <TB1> INFO: level: 15
[13:48:21.594] <TB1> INFO: triggerdelay: 0
[13:48:21.594] <TB1> QUIET: Instanciating API for pxar prod-12
[13:48:21.594] <TB1> INFO: Log level: INFO
[13:48:21.606] <TB1> INFO: Found DTB DTB_WWXTQT
[13:48:21.616] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:48:21.619] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:48:21.622] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:48:23.187] <TB1> INFO: DUT info:
[13:48:23.187] <TB1> INFO: The DUT currently contains the following objects:
[13:48:23.187] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:48:23.187] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:48:23.188] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:48:23.188] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:48:23.188] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.188] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:48:23.589] <TB1> INFO: enter 'restricted' command line mode
[13:48:23.589] <TB1> INFO: enter test to run
[13:48:23.589] <TB1> INFO: test: HighRate no parameter change
[13:48:23.589] <TB1> INFO: running: highrate
[13:48:23.590] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[13:48:23.841] <TB1> INFO: ----------------------------------------------------------------------
[13:48:23.841] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:48:23.842] <TB1> INFO: ----------------------------------------------------------------------
[13:48:23.979] <TB1> INFO: Expecting 768 events.
[13:48:25.230] <TB1> INFO: 768 events read in total (533ms).
[13:48:25.325] <TB1> INFO: Test took 1478ms.
[13:48:25.940] <TB1> INFO: Expecting 41600 events.
[13:48:30.008] <TB1> INFO: 41600 events read in total (3540ms).
[13:48:30.010] <TB1> INFO: Test took 4680ms.
[13:48:30.095] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:30.738] <TB1> INFO: Expecting 41600 events.
[13:48:35.021] <TB1> INFO: 41600 events read in total (3756ms).
[13:48:35.023] <TB1> INFO: Test took 4897ms.
[13:48:35.109] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:35.771] <TB1> INFO: Expecting 41600 events.
[13:48:40.058] <TB1> INFO: 41600 events read in total (3756ms).
[13:48:40.059] <TB1> INFO: Test took 4907ms.
[13:48:40.146] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:40.790] <TB1> INFO: Expecting 41600 events.
[13:48:45.287] <TB1> INFO: 41600 events read in total (3970ms).
[13:48:45.289] <TB1> INFO: Test took 5111ms.
[13:48:45.377] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:46.020] <TB1> INFO: Expecting 41600 events.
[13:48:50.156] <TB1> INFO: 41600 events read in total (3609ms).
[13:48:50.158] <TB1> INFO: Test took 4750ms.
[13:48:50.244] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:50.886] <TB1> INFO: Expecting 41600 events.
[13:48:55.352] <TB1> INFO: 41600 events read in total (3939ms).
[13:48:55.354] <TB1> INFO: Test took 5079ms.
[13:48:55.440] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:56.084] <TB1> INFO: Expecting 41600 events.
[13:49:00.320] <TB1> INFO: 41600 events read in total (3709ms).
[13:49:00.322] <TB1> INFO: Test took 4850ms.
[13:49:00.410] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:01.054] <TB1> INFO: Expecting 41600 events.
[13:49:05.421] <TB1> INFO: 41600 events read in total (3840ms).
[13:49:05.423] <TB1> INFO: Test took 4981ms.
[13:49:05.510] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:06.161] <TB1> INFO: Expecting 41600 events.
[13:49:10.316] <TB1> INFO: 41600 events read in total (3628ms).
[13:49:10.319] <TB1> INFO: Test took 4777ms.
[13:49:10.414] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:11.064] <TB1> INFO: Expecting 41600 events.
[13:49:15.213] <TB1> INFO: 41600 events read in total (3622ms).
[13:49:15.215] <TB1> INFO: Test took 4762ms.
[13:49:15.314] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:15.977] <TB1> INFO: Expecting 41600 events.
[13:49:19.957] <TB1> INFO: 41600 events read in total (3452ms).
[13:49:19.959] <TB1> INFO: Test took 4607ms.
[13:49:20.047] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:20.690] <TB1> INFO: Expecting 41600 events.
[13:49:24.750] <TB1> INFO: 41600 events read in total (3533ms).
[13:49:24.752] <TB1> INFO: Test took 4674ms.
[13:49:24.839] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:25.482] <TB1> INFO: Expecting 41600 events.
[13:49:29.441] <TB1> INFO: 41600 events read in total (3432ms).
[13:49:29.443] <TB1> INFO: Test took 4573ms.
[13:49:29.529] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:30.172] <TB1> INFO: Expecting 41600 events.
[13:49:34.220] <TB1> INFO: 41600 events read in total (3521ms).
[13:49:34.222] <TB1> INFO: Test took 4661ms.
[13:49:34.314] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:34.959] <TB1> INFO: Expecting 41600 events.
[13:49:38.895] <TB1> INFO: 41600 events read in total (3409ms).
[13:49:38.897] <TB1> INFO: Test took 4550ms.
[13:49:38.985] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:39.638] <TB1> INFO: Expecting 41600 events.
[13:49:43.731] <TB1> INFO: 41600 events read in total (3566ms).
[13:49:43.732] <TB1> INFO: Test took 4711ms.
[13:49:43.817] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:44.461] <TB1> INFO: Expecting 41600 events.
[13:49:48.676] <TB1> INFO: 41600 events read in total (3688ms).
[13:49:48.678] <TB1> INFO: Test took 4829ms.
[13:49:48.762] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:49.406] <TB1> INFO: Expecting 41600 events.
[13:49:53.108] <TB1> INFO: 41600 events read in total (3175ms).
[13:49:53.110] <TB1> INFO: Test took 4316ms.
[13:49:53.193] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:53.836] <TB1> INFO: Expecting 41600 events.
[13:49:57.459] <TB1> INFO: 41600 events read in total (3096ms).
[13:49:57.460] <TB1> INFO: Test took 4235ms.
[13:49:57.542] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:49:58.185] <TB1> INFO: Expecting 41600 events.
[13:50:01.755] <TB1> INFO: 41600 events read in total (3043ms).
[13:50:01.757] <TB1> INFO: Test took 4183ms.
[13:50:01.840] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:50:02.181] <TB1> INFO: enter test to run
[13:50:02.181] <TB1> INFO: test: Pretest no parameter change
[13:50:02.181] <TB1> INFO: running: pretest
[13:50:02.181] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[13:50:02.181] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[13:50:02.181] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[13:50:02.181] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[13:50:02.181] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[13:50:02.182] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[13:50:02.182] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[13:50:02.182] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[13:50:02.182] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[13:50:02.182] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[13:50:02.182] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[13:50:02.182] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[13:50:02.182] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[13:50:02.183] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[13:50:02.183] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[13:50:02.183] <TB1> INFO: write dac parameters into /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:50:02.183] <TB1> INFO: enter test to run
[13:50:02.183] <TB1> INFO: test: no parameter change
[13:50:02.380] <TB1> QUIET: Connection to board 147 closed.
[13:50:02.460] <TB1> INFO: pXar: this is the end, my friend

[13:50:31.683] <TB1> INFO: *** Welcome to pxar ***
[13:50:31.683] <TB1> INFO: *** Today: 2016/01/14
[13:50:31.787] <TB1> INFO: *** Version: b2d3
[13:50:31.787] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//dacParameters35_C15.dat
[13:50:31.788] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//tbmParameters_C0b.dat
[13:50:31.788] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//defaultMaskFile.dat
[13:50:31.788] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//trimParameters35_C15.dat
[13:50:31.858] <TB1> INFO: clk: 4
[13:50:31.858] <TB1> INFO: ctr: 4
[13:50:31.858] <TB1> INFO: sda: 19
[13:50:31.858] <TB1> INFO: tin: 9
[13:50:31.858] <TB1> INFO: level: 15
[13:50:31.858] <TB1> INFO: triggerdelay: 0
[13:50:31.858] <TB1> QUIET: Instanciating API for pxar prod-12
[13:50:31.858] <TB1> INFO: Log level: INFO
[13:50:31.871] <TB1> INFO: Found DTB DTB_WWXTQT
[13:50:31.881] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:50:31.885] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:50:31.887] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:50:33.436] <TB1> INFO: DUT info:
[13:50:33.436] <TB1> INFO: The DUT currently contains the following objects:
[13:50:33.436] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:50:33.436] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:50:33.436] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:50:33.436] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:50:33.436] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.437] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:50:33.837] <TB1> INFO: enter 'restricted' command line mode
[13:50:33.837] <TB1> INFO: enter test to run
[13:50:33.837] <TB1> INFO: test: PixelAlive no parameter change
[13:50:33.837] <TB1> INFO: running: pixelalive
[13:50:33.843] <TB1> INFO: ######################################################################
[13:50:33.843] <TB1> INFO: PixTestAlive::doTest()
[13:50:33.843] <TB1> INFO: ######################################################################
[13:50:33.844] <TB1> INFO: ----------------------------------------------------------------------
[13:50:33.844] <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)
[13:50:33.844] <TB1> INFO: ----------------------------------------------------------------------
[13:50:34.153] <TB1> INFO: Expecting 208000 events.
[13:50:46.537] <TB1> INFO: 208000 events read in total (11666ms).
[13:50:46.538] <TB1> INFO: Test took 12693ms.
[13:50:46.547] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:50:46.803] <TB1> INFO: PixTestAlive::aliveTest() done
[13:50:46.803] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:50:46.805] <TB1> INFO: ----------------------------------------------------------------------
[13:50:46.805] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:50:46.805] <TB1> INFO: ----------------------------------------------------------------------
[13:50:47.154] <TB1> INFO: Expecting 208000 events.
[13:50:55.262] <TB1> INFO: 208000 events read in total (7393ms).
[13:50:55.263] <TB1> INFO: Test took 8456ms.
[13:50:55.263] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:50:55.263] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:50:55.572] <TB1> INFO: PixTestAlive::maskTest() done
[13:50:55.572] <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
[13:50:55.573] <TB1> INFO: ----------------------------------------------------------------------
[13:50:55.574] <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)
[13:50:55.574] <TB1> INFO: ----------------------------------------------------------------------
[13:50:55.879] <TB1> INFO: Expecting 208000 events.
[13:51:07.924] <TB1> INFO: 208000 events read in total (11329ms).
[13:51:07.925] <TB1> INFO: Test took 12350ms.
[13:51:07.931] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:08.159] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:51:08.159] <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
[13:51:08.159] <TB1> INFO: PixTestAlive::doTest() done, duration: 34 seconds
[13:51:08.196] <TB1> INFO: enter test to run
[13:51:08.196] <TB1> INFO: test: delay setting parameters: ->2<-
[13:51:08.196] <TB1> INFO: delay test by 2 seconds...
[13:51:10.196] <TB1> INFO: enter test to run
[13:51:10.196] <TB1> INFO: test: HighRate no parameter change
[13:51:10.196] <TB1> INFO: running: highrate
[13:51:10.196] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[13:51:10.380] <TB1> INFO: ----------------------------------------------------------------------
[13:51:10.380] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:51:10.380] <TB1> INFO: ----------------------------------------------------------------------
[13:51:11.018] <TB1> INFO: Expecting 208000 events.
[13:51:25.243] <TB1> INFO: 208000 events read in total (13698ms).
[13:51:25.248] <TB1> INFO: Test took 14865ms.
[13:51:25.557] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:25.857] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:51:25.857] <TB1> INFO: number of red-efficiency pixels: 151 155 148 300 318 423 369 483 410 346 449 308 219 170 174 156
[13:51:25.857] <TB1> INFO: number of X-ray hits detected: 117651 118864 105556 182972 189919 222472 217087 240253 223735 204681 232581 194312 161179 109263 109422 111973
[13:51:25.857] <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
[13:51:25.857] <TB1> INFO: number of Vcal hits detected: 207845 207842 207845 207684 207669 207544 207596 207475 207546 207616 207525 207626 207775 207821 207819 207838
[13:51:25.857] <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.8 99.8 99.9 99.9 99.9 99.9 99.9
[13:51:25.857] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9
[13:51:25.857] <TB1> INFO: X-ray hit rate [MHz/cm2]: 34.5 34.8 30.9 53.6 55.7 65.2 63.6 70.4 65.6 60.0 68.2 57.0 47.2 32.0 32.1 32.8
[13:51:25.857] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:51:25.887] <TB1> INFO: PixTest:: pg_setup set to default.
[13:51:25.896] <TB1> INFO: enter test to run
[13:51:25.896] <TB1> INFO: test: no parameter change
[13:51:26.155] <TB1> QUIET: Connection to board 147 closed.
[13:51:26.235] <TB1> INFO: pXar: this is the end, my friend

[13:51:56.813] <TB1> INFO: *** Welcome to pxar ***
[13:51:56.813] <TB1> INFO: *** Today: 2016/01/14
[13:51:56.878] <TB1> INFO: *** Version: b2d3
[13:51:56.878] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//dacParameters35_C15.dat
[13:51:56.879] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//tbmParameters_C0b.dat
[13:51:56.879] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//defaultMaskFile.dat
[13:51:56.879] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//trimParameters35_C15.dat
[13:51:56.949] <TB1> INFO: clk: 4
[13:51:56.949] <TB1> INFO: ctr: 4
[13:51:56.949] <TB1> INFO: sda: 19
[13:51:56.949] <TB1> INFO: tin: 9
[13:51:56.949] <TB1> INFO: level: 15
[13:51:56.949] <TB1> INFO: triggerdelay: 0
[13:51:56.949] <TB1> QUIET: Instanciating API for pxar prod-12
[13:51:56.949] <TB1> INFO: Log level: INFO
[13:51:56.962] <TB1> INFO: Found DTB DTB_WWXTQT
[13:51:56.971] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:51:56.974] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:51:56.977] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:51:58.492] <TB1> INFO: DUT info:
[13:51:58.492] <TB1> INFO: The DUT currently contains the following objects:
[13:51:58.492] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:51:58.492] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:51:58.492] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:51:58.492] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:51:58.492] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.492] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:51:58.893] <TB1> INFO: enter 'restricted' command line mode
[13:51:58.893] <TB1> INFO: enter test to run
[13:51:58.893] <TB1> INFO: test: PixelAlive no parameter change
[13:51:58.893] <TB1> INFO: running: pixelalive
[13:51:58.898] <TB1> INFO: ######################################################################
[13:51:58.898] <TB1> INFO: PixTestAlive::doTest()
[13:51:58.898] <TB1> INFO: ######################################################################
[13:51:58.900] <TB1> INFO: ----------------------------------------------------------------------
[13:51:58.900] <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)
[13:51:58.900] <TB1> INFO: ----------------------------------------------------------------------
[13:51:59.252] <TB1> INFO: Expecting 208000 events.
[13:52:11.739] <TB1> INFO: 208000 events read in total (11769ms).
[13:52:11.746] <TB1> INFO: Test took 12844ms.
[13:52:11.757] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:12.026] <TB1> INFO: PixTestAlive::aliveTest() done
[13:52:12.026] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:52:12.028] <TB1> INFO: ----------------------------------------------------------------------
[13:52:12.028] <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)
[13:52:12.028] <TB1> INFO: ----------------------------------------------------------------------
[13:52:12.368] <TB1> INFO: Expecting 208000 events.
[13:52:20.607] <TB1> INFO: 208000 events read in total (7523ms).
[13:52:20.607] <TB1> INFO: Test took 8577ms.
[13:52:20.608] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:20.608] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:52:20.916] <TB1> INFO: PixTestAlive::maskTest() done
[13:52:20.916] <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
[13:52:20.918] <TB1> INFO: ----------------------------------------------------------------------
[13:52:20.918] <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)
[13:52:20.918] <TB1> INFO: ----------------------------------------------------------------------
[13:52:21.231] <TB1> INFO: Expecting 208000 events.
[13:52:32.918] <TB1> INFO: 208000 events read in total (10972ms).
[13:52:32.919] <TB1> INFO: Test took 12000ms.
[13:52:32.926] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:33.158] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:52:33.158] <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
[13:52:33.158] <TB1> INFO: PixTestAlive::doTest() done, duration: 34 seconds
[13:52:33.188] <TB1> INFO: enter test to run
[13:52:33.188] <TB1> INFO: test: delay setting parameters: ->2<-
[13:52:33.188] <TB1> INFO: delay test by 2 seconds...
[13:52:35.188] <TB1> INFO: enter test to run
[13:52:35.188] <TB1> INFO: test: HighRate no parameter change
[13:52:35.188] <TB1> INFO: running: highrate
[13:52:35.188] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[13:52:35.377] <TB1> INFO: ----------------------------------------------------------------------
[13:52:35.377] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:52:35.377] <TB1> INFO: ----------------------------------------------------------------------
[13:52:36.009] <TB1> INFO: Expecting 208000 events.
[13:52:52.855] <TB1> INFO: 208000 events read in total (16319ms).
[13:52:52.863] <TB1> INFO: Test took 17483ms.
[13:52:53.317] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:53.716] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:52:53.717] <TB1> INFO: number of red-efficiency pixels: 266 266 274 619 561 830 830 1006 797 707 872 661 457 338 251 321
[13:52:53.717] <TB1> INFO: number of X-ray hits detected: 170686 173342 156750 266463 276901 322278 315449 349286 328720 297586 337955 283317 237080 160713 161040 163413
[13:52:53.717] <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
[13:52:53.717] <TB1> INFO: number of Vcal hits detected: 207723 207721 207704 207307 207375 207014 207028 206797 207040 207171 206949 207189 207510 207614 207739 207660
[13:52:53.717] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.6 99.6 99.5 99.6 99.6 99.6 99.7 99.8 99.8 99.9 99.9
[13:52:53.717] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.5 99.5 99.4 99.5 99.6 99.5 99.6 99.8 99.8 99.9 99.8
[13:52:53.717] <TB1> INFO: X-ray hit rate [MHz/cm2]: 50.0 50.8 45.9 78.1 81.2 94.5 92.5 102.4 96.4 87.2 99.1 83.0 69.5 47.1 47.2 47.9
[13:52:53.717] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:52:53.746] <TB1> INFO: PixTest:: pg_setup set to default.
[13:52:53.758] <TB1> INFO: enter test to run
[13:52:53.758] <TB1> INFO: test: no parameter change
[13:52:53.986] <TB1> QUIET: Connection to board 147 closed.
[13:52:54.065] <TB1> INFO: pXar: this is the end, my friend

[13:53:23.642] <TB1> INFO: *** Welcome to pxar ***
[13:53:23.642] <TB1> INFO: *** Today: 2016/01/14
[13:53:23.700] <TB1> INFO: *** Version: b2d3
[13:53:23.700] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//dacParameters35_C15.dat
[13:53:23.701] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//tbmParameters_C0b.dat
[13:53:23.701] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//defaultMaskFile.dat
[13:53:23.701] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//trimParameters35_C15.dat
[13:53:23.771] <TB1> INFO: clk: 4
[13:53:23.771] <TB1> INFO: ctr: 4
[13:53:23.771] <TB1> INFO: sda: 19
[13:53:23.771] <TB1> INFO: tin: 9
[13:53:23.771] <TB1> INFO: level: 15
[13:53:23.771] <TB1> INFO: triggerdelay: 0
[13:53:23.771] <TB1> QUIET: Instanciating API for pxar prod-12
[13:53:23.771] <TB1> INFO: Log level: INFO
[13:53:23.785] <TB1> INFO: Found DTB DTB_WWXTQT
[13:53:23.795] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:53:23.798] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:53:23.800] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:53:25.315] <TB1> INFO: DUT info:
[13:53:25.315] <TB1> INFO: The DUT currently contains the following objects:
[13:53:25.315] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:53:25.315] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:53:25.315] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:53:25.315] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:53:25.315] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.315] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:53:25.716] <TB1> INFO: enter 'restricted' command line mode
[13:53:25.716] <TB1> INFO: enter test to run
[13:53:25.716] <TB1> INFO: test: PixelAlive no parameter change
[13:53:25.716] <TB1> INFO: running: pixelalive
[13:53:25.720] <TB1> INFO: ######################################################################
[13:53:25.720] <TB1> INFO: PixTestAlive::doTest()
[13:53:25.720] <TB1> INFO: ######################################################################
[13:53:25.722] <TB1> INFO: ----------------------------------------------------------------------
[13:53:25.722] <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)
[13:53:25.722] <TB1> INFO: ----------------------------------------------------------------------
[13:53:26.026] <TB1> INFO: Expecting 208000 events.
[13:53:38.551] <TB1> INFO: 208000 events read in total (11807ms).
[13:53:38.576] <TB1> INFO: Test took 12853ms.
[13:53:38.584] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:53:38.847] <TB1> INFO: PixTestAlive::aliveTest() done
[13:53:38.847] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:53:38.849] <TB1> INFO: ----------------------------------------------------------------------
[13:53:38.849] <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)
[13:53:38.849] <TB1> INFO: ----------------------------------------------------------------------
[13:53:39.152] <TB1> INFO: Expecting 208000 events.
[13:53:47.462] <TB1> INFO: 208000 events read in total (7594ms).
[13:53:47.463] <TB1> INFO: Test took 8613ms.
[13:53:47.463] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:53:47.463] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:53:47.776] <TB1> INFO: PixTestAlive::maskTest() done
[13:53:47.776] <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
[13:53:47.778] <TB1> INFO: ----------------------------------------------------------------------
[13:53:47.778] <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)
[13:53:47.778] <TB1> INFO: ----------------------------------------------------------------------
[13:53:48.082] <TB1> INFO: Expecting 208000 events.
[13:54:00.366] <TB1> INFO: 208000 events read in total (11569ms).
[13:54:00.367] <TB1> INFO: Test took 12588ms.
[13:54:00.373] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:54:00.608] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:54:00.608] <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
[13:54:00.609] <TB1> INFO: PixTestAlive::doTest() done, duration: 34 seconds
[13:54:00.647] <TB1> INFO: enter test to run
[13:54:00.647] <TB1> INFO: test: delay setting parameters: ->2<-
[13:54:00.647] <TB1> INFO: delay test by 2 seconds...
[13:54:02.648] <TB1> INFO: enter test to run
[13:54:02.648] <TB1> INFO: test: HighRate no parameter change
[13:54:02.648] <TB1> INFO: running: highrate
[13:54:02.648] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[13:54:02.830] <TB1> INFO: ----------------------------------------------------------------------
[13:54:02.830] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:54:02.830] <TB1> INFO: ----------------------------------------------------------------------
[13:54:03.463] <TB1> INFO: Expecting 208000 events.
[13:54:22.929] <TB1> INFO: 208000 events read in total (18940ms).
[13:54:22.940] <TB1> INFO: Test took 20107ms.
[13:54:23.544] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:54:23.933] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:54:23.933] <TB1> INFO: number of red-efficiency pixels: 462 444 496 1180 1133 1496 1508 1834 1528 1393 1614 1198 824 545 454 491
[13:54:23.933] <TB1> INFO: number of X-ray hits detected: 232615 238451 215657 362139 377665 444204 429552 480873 448945 406649 459977 389129 324030 221342 221155 223342
[13:54:23.933] <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
[13:54:23.933] <TB1> INFO: number of Vcal hits detected: 207513 207516 207368 206460 206507 205804 205767 205287 205835 206113 205597 206364 207039 207283 207513 207456
[13:54:23.933] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.4 99.4 99.1 99.1 98.8 99.1 99.2 99.0 99.3 99.6 99.7 99.8 99.8
[13:54:23.933] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.7 99.3 99.3 98.9 98.9 98.7 99.0 99.1 98.8 99.2 99.5 99.7 99.8 99.7
[13:54:23.933] <TB1> INFO: X-ray hit rate [MHz/cm2]: 68.2 69.9 63.2 106.1 110.7 130.2 125.9 140.9 131.6 119.2 134.8 114.1 95.0 64.9 64.8 65.5
[13:54:23.933] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:54:23.963] <TB1> INFO: PixTest:: pg_setup set to default.
[13:54:23.973] <TB1> INFO: enter test to run
[13:54:23.973] <TB1> INFO: test: no parameter change
[13:54:24.171] <TB1> QUIET: Connection to board 147 closed.
[13:54:24.251] <TB1> INFO: pXar: this is the end, my friend

[13:54:51.261] <TB1> INFO: *** Welcome to pxar ***
[13:54:51.261] <TB1> INFO: *** Today: 2016/01/14
[13:54:51.326] <TB1> INFO: *** Version: b2d3
[13:54:51.326] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//dacParameters35_C15.dat
[13:54:51.326] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//tbmParameters_C0b.dat
[13:54:51.326] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//defaultMaskFile.dat
[13:54:51.327] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//trimParameters35_C15.dat
[13:54:51.393] <TB1> INFO: clk: 4
[13:54:51.393] <TB1> INFO: ctr: 4
[13:54:51.393] <TB1> INFO: sda: 19
[13:54:51.393] <TB1> INFO: tin: 9
[13:54:51.393] <TB1> INFO: level: 15
[13:54:51.393] <TB1> INFO: triggerdelay: 0
[13:54:51.394] <TB1> QUIET: Instanciating API for pxar prod-12
[13:54:51.394] <TB1> INFO: Log level: INFO
[13:54:51.406] <TB1> INFO: Found DTB DTB_WWXTQT
[13:54:51.416] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:54:51.419] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:54:51.421] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:54:52.936] <TB1> INFO: DUT info:
[13:54:52.936] <TB1> INFO: The DUT currently contains the following objects:
[13:54:52.936] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:54:52.936] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:54:52.936] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:54:52.936] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:54:52.936] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:52.936] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:54:53.337] <TB1> INFO: enter 'restricted' command line mode
[13:54:53.337] <TB1> INFO: enter test to run
[13:54:53.337] <TB1> INFO: test: PixelAlive no parameter change
[13:54:53.337] <TB1> INFO: running: pixelalive
[13:54:53.343] <TB1> INFO: ######################################################################
[13:54:53.344] <TB1> INFO: PixTestAlive::doTest()
[13:54:53.344] <TB1> INFO: ######################################################################
[13:54:53.345] <TB1> INFO: ----------------------------------------------------------------------
[13:54:53.345] <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)
[13:54:53.345] <TB1> INFO: ----------------------------------------------------------------------
[13:54:53.649] <TB1> INFO: Expecting 208000 events.
[13:55:05.821] <TB1> INFO: 208000 events read in total (11454ms).
[13:55:05.838] <TB1> INFO: Test took 12492ms.
[13:55:05.846] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:06.095] <TB1> INFO: PixTestAlive::aliveTest() done
[13:55:06.095] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:55:06.097] <TB1> INFO: ----------------------------------------------------------------------
[13:55:06.097] <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)
[13:55:06.097] <TB1> INFO: ----------------------------------------------------------------------
[13:55:06.412] <TB1> INFO: Expecting 208000 events.
[13:55:14.605] <TB1> INFO: 208000 events read in total (7478ms).
[13:55:14.606] <TB1> INFO: Test took 8508ms.
[13:55:14.606] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:14.607] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:55:14.915] <TB1> INFO: PixTestAlive::maskTest() done
[13:55:14.915] <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
[13:55:14.917] <TB1> INFO: ----------------------------------------------------------------------
[13:55:14.917] <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)
[13:55:14.917] <TB1> INFO: ----------------------------------------------------------------------
[13:55:15.224] <TB1> INFO: Expecting 208000 events.
[13:55:26.737] <TB1> INFO: 208000 events read in total (10797ms).
[13:55:26.738] <TB1> INFO: Test took 11820ms.
[13:55:26.747] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:26.976] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:55:26.976] <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
[13:55:26.976] <TB1> INFO: PixTestAlive::doTest() done, duration: 33 seconds
[13:55:27.005] <TB1> INFO: enter test to run
[13:55:27.005] <TB1> INFO: test: delay setting parameters: ->2<-
[13:55:27.005] <TB1> INFO: delay test by 2 seconds...
[13:55:29.005] <TB1> INFO: enter test to run
[13:55:29.006] <TB1> INFO: test: HighRate no parameter change
[13:55:29.006] <TB1> INFO: running: highrate
[13:55:29.006] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[13:55:29.185] <TB1> INFO: ----------------------------------------------------------------------
[13:55:29.185] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:55:29.185] <TB1> INFO: ----------------------------------------------------------------------
[13:55:29.817] <TB1> INFO: Expecting 208000 events.
[13:55:52.590] <TB1> INFO: 208000 events read in total (22246ms).
[13:55:52.602] <TB1> INFO: Test took 23413ms.
[13:55:53.317] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:55:53.748] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:55:53.748] <TB1> INFO: number of red-efficiency pixels: 610 678 689 1653 1660 2150 2118 2650 2187 1903 2329 1713 1252 770 633 749
[13:55:53.748] <TB1> INFO: number of X-ray hits detected: 282540 289707 263383 438055 457613 531687 518694 583131 546307 492871 554036 469693 392164 270289 267664 271260
[13:55:53.748] <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
[13:55:53.748] <TB1> INFO: number of Vcal hits detected: 207307 207222 206970 205565 205527 204283 204239 203127 204250 204914 203890 205180 206381 206847 207302 207140
[13:55:53.748] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.7 99.6 99.6 99.0 99.0 98.4 98.5 97.9 98.4 98.7 98.3 98.9 99.3 99.5 99.7 99.6
[13:55:53.748] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.6 99.5 98.8 98.8 98.2 98.2 97.7 98.2 98.5 98.0 98.6 99.2 99.4 99.7 99.6
[13:55:53.748] <TB1> INFO: X-ray hit rate [MHz/cm2]: 82.8 84.9 77.2 128.4 134.1 155.8 152.0 170.9 160.1 144.5 162.4 137.7 114.9 79.2 78.5 79.5
[13:55:53.748] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:55:53.777] <TB1> INFO: PixTest:: pg_setup set to default.
[13:55:53.788] <TB1> INFO: enter test to run
[13:55:53.788] <TB1> INFO: test: no parameter change
[13:55:54.000] <TB1> QUIET: Connection to board 147 closed.
[13:55:54.080] <TB1> INFO: pXar: this is the end, my friend

[13:56:20.890] <TB1> INFO: *** Welcome to pxar ***
[13:56:20.890] <TB1> INFO: *** Today: 2016/01/14
[13:56:20.950] <TB1> INFO: *** Version: b2d3
[13:56:20.950] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//dacParameters35_C15.dat
[13:56:20.950] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//tbmParameters_C0b.dat
[13:56:20.950] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//defaultMaskFile.dat
[13:56:20.950] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//trimParameters35_C15.dat
[13:56:21.022] <TB1> INFO: clk: 4
[13:56:21.022] <TB1> INFO: ctr: 4
[13:56:21.022] <TB1> INFO: sda: 19
[13:56:21.022] <TB1> INFO: tin: 9
[13:56:21.022] <TB1> INFO: level: 15
[13:56:21.022] <TB1> INFO: triggerdelay: 0
[13:56:21.022] <TB1> QUIET: Instanciating API for pxar prod-12
[13:56:21.022] <TB1> INFO: Log level: INFO
[13:56:21.035] <TB1> INFO: Found DTB DTB_WWXTQT
[13:56:21.045] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:56:21.048] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:56:21.050] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:56:22.564] <TB1> INFO: DUT info:
[13:56:22.564] <TB1> INFO: The DUT currently contains the following objects:
[13:56:22.564] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:56:22.564] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:56:22.564] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:56:22.564] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:56:22.564] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.564] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:56:22.965] <TB1> INFO: enter 'restricted' command line mode
[13:56:22.965] <TB1> INFO: enter test to run
[13:56:22.965] <TB1> INFO: test: PixelAlive no parameter change
[13:56:22.965] <TB1> INFO: running: pixelalive
[13:56:22.971] <TB1> INFO: ######################################################################
[13:56:22.971] <TB1> INFO: PixTestAlive::doTest()
[13:56:22.971] <TB1> INFO: ######################################################################
[13:56:22.973] <TB1> INFO: ----------------------------------------------------------------------
[13:56:22.973] <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)
[13:56:22.973] <TB1> INFO: ----------------------------------------------------------------------
[13:56:23.333] <TB1> INFO: Expecting 208000 events.
[13:56:36.175] <TB1> INFO: 208000 events read in total (12123ms).
[13:56:36.190] <TB1> INFO: Test took 13215ms.
[13:56:36.202] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:56:36.455] <TB1> INFO: PixTestAlive::aliveTest() done
[13:56:36.455] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:56:36.457] <TB1> INFO: ----------------------------------------------------------------------
[13:56:36.457] <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)
[13:56:36.457] <TB1> INFO: ----------------------------------------------------------------------
[13:56:36.773] <TB1> INFO: Expecting 208000 events.
[13:56:44.730] <TB1> INFO: 208000 events read in total (7241ms).
[13:56:44.731] <TB1> INFO: Test took 8273ms.
[13:56:44.731] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:56:44.731] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:56:45.033] <TB1> INFO: PixTestAlive::maskTest() done
[13:56:45.033] <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
[13:56:45.034] <TB1> INFO: ----------------------------------------------------------------------
[13:56:45.034] <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)
[13:56:45.034] <TB1> INFO: ----------------------------------------------------------------------
[13:56:45.341] <TB1> INFO: Expecting 208000 events.
[13:56:57.976] <TB1> INFO: 208000 events read in total (11919ms).
[13:56:57.977] <TB1> INFO: Test took 12942ms.
[13:56:57.987] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:56:58.216] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:56:58.216] <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
[13:56:58.216] <TB1> INFO: PixTestAlive::doTest() done, duration: 35 seconds
[13:56:58.248] <TB1> INFO: enter test to run
[13:56:58.248] <TB1> INFO: test: delay setting parameters: ->2<-
[13:56:58.248] <TB1> INFO: delay test by 2 seconds...
[13:57:00.249] <TB1> INFO: enter test to run
[13:57:00.249] <TB1> INFO: test: HighRate no parameter change
[13:57:00.249] <TB1> INFO: running: highrate
[13:57:00.249] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[13:57:00.428] <TB1> INFO: ----------------------------------------------------------------------
[13:57:00.428] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:57:00.428] <TB1> INFO: ----------------------------------------------------------------------
[13:57:01.029] <TB1> INFO: Expecting 208000 events.
[13:57:26.758] <TB1> INFO: 208000 events read in total (25202ms).
[13:57:26.773] <TB1> INFO: Test took 26341ms.
[13:57:27.649] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:57:28.121] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:57:28.121] <TB1> INFO: number of red-efficiency pixels: 923 977 900 2228 2277 2772 2740 3353 2955 2566 2996 2289 1717 1044 893 1098
[13:57:28.121] <TB1> INFO: number of X-ray hits detected: 335497 345406 313903 517702 545220 629497 614965 693671 646260 585985 654198 558123 465152 323110 320692 322659
[13:57:28.121] <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
[13:57:28.121] <TB1> INFO: number of Vcal hits detected: 206893 206819 206414 203985 203887 201983 201698 199844 201613 202976 201130 203531 205462 206103 206958 206630
[13:57:28.121] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.5 99.5 99.4 98.3 98.3 97.4 97.4 96.4 97.2 97.8 97.1 98.2 98.9 99.3 99.5 99.4
[13:57:28.121] <TB1> INFO: Vcal hit overall efficiency (%): 99.5 99.4 99.2 98.1 98.0 97.1 97.0 96.1 96.9 97.6 96.7 97.9 98.8 99.1 99.5 99.3
[13:57:28.121] <TB1> INFO: X-ray hit rate [MHz/cm2]: 98.3 101.2 92.0 151.7 159.8 184.5 180.3 203.3 189.4 171.8 191.8 163.6 136.3 94.7 94.0 94.6
[13:57:28.121] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:57:28.150] <TB1> INFO: PixTest:: pg_setup set to default.
[13:57:28.162] <TB1> INFO: enter test to run
[13:57:28.162] <TB1> INFO: test: no parameter change
[13:57:28.351] <TB1> QUIET: Connection to board 147 closed.
[13:57:28.431] <TB1> INFO: pXar: this is the end, my friend

[13:57:55.420] <TB1> INFO: *** Welcome to pxar ***
[13:57:55.420] <TB1> INFO: *** Today: 2016/01/14
[13:57:55.495] <TB1> INFO: *** Version: b2d3
[13:57:55.495] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//dacParameters35_C15.dat
[13:57:55.496] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//tbmParameters_C0b.dat
[13:57:55.496] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//defaultMaskFile.dat
[13:57:55.496] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//trimParameters35_C15.dat
[13:57:55.567] <TB1> INFO: clk: 4
[13:57:55.567] <TB1> INFO: ctr: 4
[13:57:55.567] <TB1> INFO: sda: 19
[13:57:55.567] <TB1> INFO: tin: 9
[13:57:55.567] <TB1> INFO: level: 15
[13:57:55.567] <TB1> INFO: triggerdelay: 0
[13:57:55.567] <TB1> QUIET: Instanciating API for pxar prod-12
[13:57:55.567] <TB1> INFO: Log level: INFO
[13:57:55.580] <TB1> INFO: Found DTB DTB_WWXTQT
[13:57:55.589] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:57:55.592] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:57:55.595] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:57:57.115] <TB1> INFO: DUT info:
[13:57:57.115] <TB1> INFO: The DUT currently contains the following objects:
[13:57:57.115] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:57:57.115] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:57:57.115] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:57:57.115] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:57:57.115] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.115] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:57:57.516] <TB1> INFO: enter 'restricted' command line mode
[13:57:57.517] <TB1> INFO: enter test to run
[13:57:57.517] <TB1> INFO: test: PixelAlive no parameter change
[13:57:57.517] <TB1> INFO: running: pixelalive
[13:57:57.521] <TB1> INFO: ######################################################################
[13:57:57.521] <TB1> INFO: PixTestAlive::doTest()
[13:57:57.521] <TB1> INFO: ######################################################################
[13:57:57.522] <TB1> INFO: ----------------------------------------------------------------------
[13:57:57.522] <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)
[13:57:57.522] <TB1> INFO: ----------------------------------------------------------------------
[13:57:57.846] <TB1> INFO: Expecting 208000 events.
[13:58:10.192] <TB1> INFO: 208000 events read in total (11628ms).
[13:58:10.208] <TB1> INFO: Test took 12684ms.
[13:58:10.217] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:10.475] <TB1> INFO: PixTestAlive::aliveTest() done
[13:58:10.475] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:58:10.477] <TB1> INFO: ----------------------------------------------------------------------
[13:58:10.477] <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)
[13:58:10.477] <TB1> INFO: ----------------------------------------------------------------------
[13:58:10.786] <TB1> INFO: Expecting 208000 events.
[13:58:19.012] <TB1> INFO: 208000 events read in total (7510ms).
[13:58:19.012] <TB1> INFO: Test took 8534ms.
[13:58:19.012] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:19.013] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:58:19.325] <TB1> INFO: PixTestAlive::maskTest() done
[13:58:19.326] <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
[13:58:19.327] <TB1> INFO: ----------------------------------------------------------------------
[13:58:19.327] <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)
[13:58:19.327] <TB1> INFO: ----------------------------------------------------------------------
[13:58:19.634] <TB1> INFO: Expecting 208000 events.
[13:58:31.841] <TB1> INFO: 208000 events read in total (11492ms).
[13:58:31.841] <TB1> INFO: Test took 12513ms.
[13:58:31.851] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:58:32.075] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:58:32.075] <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
[13:58:32.075] <TB1> INFO: PixTestAlive::doTest() done, duration: 34 seconds
[13:58:32.111] <TB1> INFO: enter test to run
[13:58:32.111] <TB1> INFO: test: delay setting parameters: ->2<-
[13:58:32.111] <TB1> INFO: delay test by 2 seconds...
[13:58:34.111] <TB1> INFO: enter test to run
[13:58:34.111] <TB1> INFO: test: HighRate no parameter change
[13:58:34.111] <TB1> INFO: running: highrate
[13:58:34.112] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[13:58:34.283] <TB1> INFO: ----------------------------------------------------------------------
[13:58:34.283] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:58:34.283] <TB1> INFO: ----------------------------------------------------------------------
[13:58:34.911] <TB1> INFO: Expecting 208000 events.
[13:59:07.996] <TB1> INFO: 208000 events read in total (32558ms).
[13:59:08.012] <TB1> INFO: Test took 33726ms.
[13:59:09.155] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:59:09.784] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:59:09.784] <TB1> INFO: number of red-efficiency pixels: 1669 1782 1449 3328 3397 3850 3773 4074 3942 3653 3956 3433 2886 1625 1579 1983
[13:59:09.784] <TB1> INFO: number of X-ray hits detected: 452127 466446 426144 693820 732113 849118 821754 937394 871644 789775 877502 750218 627222 439321 433110 435241
[13:59:09.784] <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
[13:59:09.784] <TB1> INFO: number of Vcal hits detected: 205607 205405 204403 198787 198268 192904 192861 188264 192348 195666 191547 197083 201878 203608 205769 204843
[13:59:09.784] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.0 98.8 98.6 96.1 95.9 93.5 93.6 91.3 93.1 94.7 93.0 95.4 97.4 98.3 99.0 98.7
[13:59:09.784] <TB1> INFO: Vcal hit overall efficiency (%): 98.8 98.8 98.3 95.6 95.3 92.7 92.7 90.5 92.5 94.1 92.1 94.8 97.1 97.9 98.9 98.5
[13:59:09.784] <TB1> INFO: X-ray hit rate [MHz/cm2]: 132.5 136.7 124.9 203.4 214.6 248.9 240.9 274.8 255.5 231.5 257.2 219.9 183.8 128.8 126.9 127.6
[13:59:09.784] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:59:09.817] <TB1> INFO: PixTest:: pg_setup set to default.
[13:59:09.831] <TB1> INFO: enter test to run
[13:59:09.831] <TB1> INFO: test: no parameter change
[13:59:10.059] <TB1> QUIET: Connection to board 147 closed.
[13:59:10.138] <TB1> INFO: pXar: this is the end, my friend

[13:59:33.083] <TB1> INFO: *** Welcome to pxar ***
[13:59:33.083] <TB1> INFO: *** Today: 2016/01/14
[13:59:33.142] <TB1> INFO: *** Version: b2d3
[13:59:33.142] <TB1> INFO: readRocDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//dacParameters35_C15.dat
[13:59:33.142] <TB1> INFO: readTbmDacs: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//tbmParameters_C0b.dat
[13:59:33.142] <TB1> INFO: readMaskFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//defaultMaskFile.dat
[13:59:33.142] <TB1> INFO: readTrimFile: /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//trimParameters35_C15.dat
[13:59:33.231] <TB1> INFO: clk: 4
[13:59:33.231] <TB1> INFO: ctr: 4
[13:59:33.231] <TB1> INFO: sda: 19
[13:59:33.231] <TB1> INFO: tin: 9
[13:59:33.231] <TB1> INFO: level: 15
[13:59:33.231] <TB1> INFO: triggerdelay: 0
[13:59:33.231] <TB1> QUIET: Instanciating API for pxar prod-12
[13:59:33.231] <TB1> INFO: Log level: INFO
[13:59:33.245] <TB1> INFO: Found DTB DTB_WWXTQT
[13:59:33.255] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:59:33.258] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:59:33.260] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:59:34.775] <TB1> INFO: DUT info:
[13:59:34.775] <TB1> INFO: The DUT currently contains the following objects:
[13:59:34.775] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:59:34.775] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:59:34.775] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:59:34.775] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:59:34.775] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:34.775] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:59:35.175] <TB1> INFO: enter 'restricted' command line mode
[13:59:35.176] <TB1> INFO: enter test to run
[13:59:35.176] <TB1> INFO: test: PixelAlive no parameter change
[13:59:35.176] <TB1> INFO: running: pixelalive
[13:59:35.181] <TB1> INFO: ######################################################################
[13:59:35.181] <TB1> INFO: PixTestAlive::doTest()
[13:59:35.181] <TB1> INFO: ######################################################################
[13:59:35.182] <TB1> INFO: ----------------------------------------------------------------------
[13:59:35.182] <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)
[13:59:35.182] <TB1> INFO: ----------------------------------------------------------------------
[13:59:35.493] <TB1> INFO: Expecting 208000 events.
[13:59:48.120] <TB1> INFO: 208000 events read in total (11909ms).
[13:59:48.136] <TB1> INFO: Test took 12952ms.
[13:59:48.143] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:59:48.402] <TB1> INFO: PixTestAlive::aliveTest() done
[13:59:48.402] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[13:59:48.404] <TB1> INFO: ----------------------------------------------------------------------
[13:59:48.404] <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)
[13:59:48.404] <TB1> INFO: ----------------------------------------------------------------------
[13:59:48.757] <TB1> INFO: Expecting 208000 events.
[13:59:57.085] <TB1> INFO: 208000 events read in total (7613ms).
[13:59:57.085] <TB1> INFO: Test took 8679ms.
[13:59:57.085] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:59:57.086] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:59:57.390] <TB1> INFO: PixTestAlive::maskTest() done
[13:59:57.390] <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
[13:59:57.391] <TB1> INFO: ----------------------------------------------------------------------
[13:59:57.391] <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)
[13:59:57.391] <TB1> INFO: ----------------------------------------------------------------------
[13:59:57.695] <TB1> INFO: Expecting 208000 events.
[14:00:10.299] <TB1> INFO: 208000 events read in total (11889ms).
[14:00:10.299] <TB1> INFO: Test took 12907ms.
[14:00:10.309] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:00:10.527] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[14:00:10.527] <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
[14:00:10.527] <TB1> INFO: PixTestAlive::doTest() done, duration: 35 seconds
[14:00:10.562] <TB1> INFO: enter test to run
[14:00:10.562] <TB1> INFO: test: delay setting parameters: ->2<-
[14:00:10.562] <TB1> INFO: delay test by 2 seconds...
[14:00:12.562] <TB1> INFO: enter test to run
[14:00:12.562] <TB1> INFO: test: HighRate no parameter change
[14:00:12.562] <TB1> INFO: running: highrate
[14:00:12.562] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2135_XrayQualification_2016-01-14_13h30m_1452774642//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[14:00:12.704] <TB1> INFO: ----------------------------------------------------------------------
[14:00:12.704] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:00:12.704] <TB1> INFO: ----------------------------------------------------------------------
[14:00:13.331] <TB1> INFO: Expecting 208000 events.
[14:00:51.232] <TB1> INFO: 187150 events read in total (37374ms).
[14:00:55.153] <TB1> INFO: 208000 events read in total (41295ms).
[14:00:55.172] <TB1> INFO: Test took 42465ms.
[14:00:56.568] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:00:57.213] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[14:00:57.213] <TB1> INFO: number of red-efficiency pixels: 2424 2621 1945 3904 3939 4102 4094 4154 4138 4052 4136 3969 3662 2032 2414 2760
[14:00:57.213] <TB1> INFO: number of X-ray hits detected: 557566 578762 525157 852176 900000 1026610 1006316 1158619 1074166 969988 1075011 923929 770859 539915 535129 535887
[14:00:57.213] <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
[14:00:57.213] <TB1> INFO: number of Vcal hits detected: 203578 203323 201543 191275 189880 181934 180968 172255 179157 185246 178855 187706 196498 200239 203932 202309
[14:00:57.213] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.1 97.9 97.5 92.9 92.2 88.6 88.3 83.9 87.1 90.1 87.2 91.3 95.0 96.9 98.2 97.6
[14:00:57.213] <TB1> INFO: Vcal hit overall efficiency (%): 97.9 97.8 96.9 92.0 91.3 87.5 87.0 82.8 86.1 89.1 86.0 90.2 94.5 96.3 98.0 97.3
[14:00:57.213] <TB1> INFO: X-ray hit rate [MHz/cm2]: 163.4 169.6 153.9 249.8 263.8 300.9 295.0 339.6 314.8 284.3 315.1 270.8 225.9 158.3 156.9 157.1
[14:00:57.213] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[14:00:57.242] <TB1> INFO: PixTest:: pg_setup set to default.
[14:00:57.255] <TB1> INFO: enter test to run
[14:00:57.255] <TB1> INFO: test: no parameter change
[14:00:57.433] <TB1> QUIET: Connection to board 147 closed.
[14:00:57.517] <TB1> INFO: pXar: this is the end, my friend