Test Date: 2016-09-27 17:30
Analysis date: 2016-09-27 19:26
Logfile
commander_PixelAlive.log
[15:31:40.569] <TB1> INFO: *** Welcome to pxar ***
[15:31:40.569] <TB1> INFO: *** Today: 2016/09/27
[15:31:40.659] <TB1> INFO: *** Version: f5d3-dirty
[15:31:40.659] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//000_PixelAlive_p17//dacParameters35_C15.dat
[15:31:40.661] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//000_PixelAlive_p17//tbmParameters_C0b.dat
[15:31:40.661] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//000_PixelAlive_p17//defaultMaskFile.dat
[15:31:40.661] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//000_PixelAlive_p17//trimParameters35_C15.dat
[15:31:40.746] <TB1> INFO: clk: 4
[15:31:40.746] <TB1> INFO: ctr: 4
[15:31:40.746] <TB1> INFO: sda: 19
[15:31:40.746] <TB1> INFO: tin: 9
[15:31:40.746] <TB1> INFO: level: 15
[15:31:40.746] <TB1> INFO: triggerdelay: 0
[15:31:40.746] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[15:31:40.746] <TB1> INFO: Log level: INFO
[15:31:40.760] <TB1> INFO: Found DTB DTB_WWXTQT
[15:31:40.769] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:31:40.771] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:31:40.773] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[15:31:42.361] <TB1> INFO: DUT info:
[15:31:42.361] <TB1> INFO: The DUT currently contains the following objects:
[15:31:42.361] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:31:42.361] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:31:42.361] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:31:42.361] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:31:42.361] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.361] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.362] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.362] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.362] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.362] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.362] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:31:42.763] <TB1> INFO: enter 'restricted' command line mode
[15:31:42.763] <TB1> INFO: enter test to run
[15:31:42.763] <TB1> INFO: test: PixelAlive no parameter change
[15:31:42.763] <TB1> INFO: running: pixelalive
[15:31:42.769] <TB1> INFO: ######################################################################
[15:31:42.769] <TB1> INFO: PixTestAlive::doTest()
[15:31:42.769] <TB1> INFO: ######################################################################
[15:31:42.771] <TB1> INFO: ----------------------------------------------------------------------
[15:31:42.771] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:31:42.771] <TB1> INFO: ----------------------------------------------------------------------
[15:31:43.035] <TB1> INFO: Expecting 41600 events.
[15:31:46.283] <TB1> INFO: 41600 events read in total (2689ms).
[15:31:46.324] <TB1> INFO: Test took 3550ms.
[15:31:46.545] <TB1> INFO: PixTestAlive::aliveTest() done
[15:31:46.545] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:31:46.546] <TB1> INFO: ----------------------------------------------------------------------
[15:31:46.546] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:31:46.546] <TB1> INFO: ----------------------------------------------------------------------
[15:31:46.806] <TB1> INFO: Expecting 41600 events.
[15:31:49.438] <TB1> INFO: 41600 events read in total (2075ms).
[15:31:49.439] <TB1> INFO: Test took 2891ms.
[15:31:49.440] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:31:49.679] <TB1> INFO: PixTestAlive::maskTest() done
[15:31:49.679] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:31:49.680] <TB1> INFO: ----------------------------------------------------------------------
[15:31:49.680] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:31:49.680] <TB1> INFO: ----------------------------------------------------------------------
[15:31:49.936] <TB1> INFO: Expecting 41600 events.
[15:31:53.171] <TB1> INFO: 41600 events read in total (2679ms).
[15:31:53.171] <TB1> INFO: Test took 3489ms.
[15:31:53.400] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:31:53.400] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:31:53.400] <TB1> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[15:31:53.431] <TB1> INFO: enter test to run
[15:31:53.431] <TB1> INFO: test: no parameter change
[15:31:53.839] <TB1> QUIET: Connection to board 147 closed.
[15:31:53.919] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[15:37:21.851] <TB1> INFO: *** Welcome to pxar ***
[15:37:21.851] <TB1> INFO: *** Today: 2016/09/27
[15:37:21.920] <TB1> INFO: *** Version: f5d3-dirty
[15:37:21.920] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:37:21.921] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:37:21.921] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:37:21.921] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:37:22.003] <TB1> INFO: clk: 4
[15:37:22.003] <TB1> INFO: ctr: 4
[15:37:22.003] <TB1> INFO: sda: 19
[15:37:22.003] <TB1> INFO: tin: 9
[15:37:22.003] <TB1> INFO: level: 15
[15:37:22.003] <TB1> INFO: triggerdelay: 0
[15:37:22.003] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[15:37:22.003] <TB1> INFO: Log level: INFO
[15:37:22.016] <TB1> INFO: Found DTB DTB_WWXTQT
[15:37:22.026] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:37:22.028] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:37:22.029] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[15:37:23.583] <TB1> INFO: DUT info:
[15:37:23.583] <TB1> INFO: The DUT currently contains the following objects:
[15:37:23.583] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:37:23.583] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:37:23.583] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:37:23.583] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:37:23.583] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.583] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.583] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.583] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.984] <TB1> INFO: enter 'restricted' command line mode
[15:37:23.984] <TB1> INFO: enter test to run
[15:37:23.984] <TB1> INFO: test: delay setting parameters: ->5<-
[15:37:23.984] <TB1> INFO: delay test by 5 seconds...
[15:37:28.985] <TB1> INFO: enter test to run
[15:37:28.985] <TB1> INFO: test: highrate no parameter change
[15:37:28.985] <TB1> INFO: running: highrate
[15:37:28.985] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:37:29.119] <TB1> INFO: ----------------------------------------------------------------------
[15:37:29.119] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:37:29.119] <TB1> INFO: ----------------------------------------------------------------------
[15:37:29.119] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:37:29.119] <TB1> INFO: edge/corner pixel THR is adjusted
[15:37:29.119] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:37:29.836] <TB1> INFO: Collecting data for 1 seconds...
[15:37:30.838] <TB1> INFO: Done with hot pixel readout
[15:37:35.493] <TB1> INFO: PixTest:: pg_setup set to default.
[15:37:35.500] <TB1> INFO: 0 hot pixels found in step 0
[15:37:35.514] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:37:35.541] <TB1> INFO: PixTest::trimHotPixels() done
[15:37:35.541] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:37:35.547] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:37:35.553] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:37:35.559] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:37:35.565] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:37:35.571] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:37:35.577] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:37:35.583] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:37:35.589] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:37:35.595] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:37:35.601] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:37:35.607] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:37:35.613] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:37:35.619] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:37:35.625] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:37:35.631] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:37:35.637] <TB1> INFO: write masked pixels into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:37:35.668] <TB1> INFO: enter test to run
[15:37:35.668] <TB1> INFO: test: no parameter change
[15:37:35.867] <TB1> QUIET: Connection to board 147 closed.
[15:37:35.946] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[15:37:21.851] <TB1> INFO: *** Welcome to pxar ***
[15:37:21.851] <TB1> INFO: *** Today: 2016/09/27
[15:37:21.920] <TB1> INFO: *** Version: f5d3-dirty
[15:37:21.920] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:37:21.921] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:37:21.921] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:37:21.921] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:37:22.003] <TB1> INFO: clk: 4
[15:37:22.003] <TB1> INFO: ctr: 4
[15:37:22.003] <TB1> INFO: sda: 19
[15:37:22.003] <TB1> INFO: tin: 9
[15:37:22.003] <TB1> INFO: level: 15
[15:37:22.003] <TB1> INFO: triggerdelay: 0
[15:37:22.003] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[15:37:22.003] <TB1> INFO: Log level: INFO
[15:37:22.016] <TB1> INFO: Found DTB DTB_WWXTQT
[15:37:22.026] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:37:22.028] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:37:22.029] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[15:37:23.583] <TB1> INFO: DUT info:
[15:37:23.583] <TB1> INFO: The DUT currently contains the following objects:
[15:37:23.583] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:37:23.583] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:37:23.583] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:37:23.583] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:37:23.583] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.583] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.583] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.583] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.584] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:37:23.984] <TB1> INFO: enter 'restricted' command line mode
[15:37:23.984] <TB1> INFO: enter test to run
[15:37:23.984] <TB1> INFO: test: delay setting parameters: ->5<-
[15:37:23.984] <TB1> INFO: delay test by 5 seconds...
[15:37:28.985] <TB1> INFO: enter test to run
[15:37:28.985] <TB1> INFO: test: highrate no parameter change
[15:37:28.985] <TB1> INFO: running: highrate
[15:37:28.985] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:37:29.119] <TB1> INFO: ----------------------------------------------------------------------
[15:37:29.119] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:37:29.119] <TB1> INFO: ----------------------------------------------------------------------
[15:37:29.119] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:37:29.119] <TB1> INFO: edge/corner pixel THR is adjusted
[15:37:29.119] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:37:29.836] <TB1> INFO: Collecting data for 1 seconds...
[15:37:30.838] <TB1> INFO: Done with hot pixel readout
[15:37:35.493] <TB1> INFO: PixTest:: pg_setup set to default.
[15:37:35.500] <TB1> INFO: 0 hot pixels found in step 0
[15:37:35.514] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:37:35.541] <TB1> INFO: PixTest::trimHotPixels() done
[15:37:35.541] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:37:35.547] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:37:35.553] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:37:35.559] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:37:35.565] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:37:35.571] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:37:35.577] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:37:35.583] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:37:35.589] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:37:35.595] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:37:35.601] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:37:35.607] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:37:35.613] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:37:35.619] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:37:35.625] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:37:35.631] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:37:35.637] <TB1> INFO: write masked pixels into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:37:35.668] <TB1> INFO: enter test to run
[15:37:35.668] <TB1> INFO: test: no parameter change
[15:37:35.867] <TB1> QUIET: Connection to board 147 closed.
[15:37:35.946] <TB1> INFO: pXar: this is the end, my friend
[15:38:26.351] <TB1> INFO: *** Welcome to pxar ***
[15:38:26.351] <TB1> INFO: *** Today: 2016/09/27
[15:38:26.426] <TB1> INFO: *** Version: f5d3-dirty
[15:38:26.426] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//dacParameters35_C15.dat
[15:38:26.427] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[15:38:26.427] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//defaultMaskFile.dat
[15:38:26.427] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C15.dat
[15:38:26.510] <TB1> INFO: clk: 4
[15:38:26.510] <TB1> INFO: ctr: 4
[15:38:26.510] <TB1> INFO: sda: 19
[15:38:26.510] <TB1> INFO: tin: 9
[15:38:26.510] <TB1> INFO: level: 15
[15:38:26.510] <TB1> INFO: triggerdelay: 0
[15:38:26.510] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[15:38:26.510] <TB1> INFO: Log level: INFO
[15:38:26.523] <TB1> INFO: Found DTB DTB_WWXTQT
[15:38:26.533] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:38:26.534] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:38:26.536] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[15:38:28.072] <TB1> INFO: DUT info:
[15:38:28.072] <TB1> INFO: The DUT currently contains the following objects:
[15:38:28.072] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:38:28.072] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:38:28.072] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:38:28.072] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:38:28.072] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.072] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:38:28.473] <TB1> INFO: enter 'restricted' command line mode
[15:38:28.473] <TB1> INFO: enter test to run
[15:38:28.473] <TB1> INFO: test: delay setting parameters: ->5<-
[15:38:28.473] <TB1> INFO: delay test by 5 seconds...
[15:38:33.473] <TB1> INFO: enter test to run
[15:38:33.473] <TB1> INFO: test: highrate no parameter change
[15:38:33.473] <TB1> INFO: running: highrate
[15:38:33.473] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[15:38:33.608] <TB1> INFO: ----------------------------------------------------------------------
[15:38:33.608] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:38:33.608] <TB1> INFO: ----------------------------------------------------------------------
[15:38:33.608] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:38:33.608] <TB1> INFO: edge/corner pixel THR is adjusted
[15:38:33.608] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:38:34.324] <TB1> INFO: Collecting data for 1 seconds...
[15:38:35.326] <TB1> INFO: Done with hot pixel readout
[15:38:38.359] <TB1> INFO: PixTest:: pg_setup set to default.
[15:38:38.360] <TB1> INFO: 0 hot pixels found in step 0
[15:38:38.367] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:38:38.415] <TB1> INFO: PixTest::trimHotPixels() done
[15:38:38.416] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C0.dat
[15:38:38.422] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C1.dat
[15:38:38.428] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C2.dat
[15:38:38.434] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C3.dat
[15:38:38.440] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C4.dat
[15:38:38.447] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C5.dat
[15:38:38.453] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C6.dat
[15:38:38.459] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C7.dat
[15:38:38.465] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C8.dat
[15:38:38.471] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C9.dat
[15:38:38.477] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C10.dat
[15:38:38.484] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C11.dat
[15:38:38.490] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C12.dat
[15:38:38.496] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C13.dat
[15:38:38.502] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C14.dat
[15:38:38.509] <TB1> INFO: write trim parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//trimParameters35_C15.dat
[15:38:38.515] <TB1> INFO: write masked pixels into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//003_RetrimHotPixels_50//defaultMaskFile.dat
[15:38:38.546] <TB1> INFO: enter test to run
[15:38:38.546] <TB1> INFO: test: no parameter change
[15:38:38.789] <TB1> QUIET: Connection to board 147 closed.
[15:38:38.868] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[15:39:30.753] <TB1> INFO: *** Welcome to pxar ***
[15:39:30.753] <TB1> INFO: *** Today: 2016/09/27
[15:39:30.824] <TB1> INFO: *** Version: f5d3-dirty
[15:39:30.824] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//dacParameters35_C15.dat
[15:39:30.824] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//tbmParameters_C0b.dat
[15:39:30.825] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//defaultMaskFile.dat
[15:39:30.825] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//trimParameters35_C15.dat
[15:39:30.912] <TB1> INFO: clk: 4
[15:39:30.912] <TB1> INFO: ctr: 4
[15:39:30.912] <TB1> INFO: sda: 19
[15:39:30.912] <TB1> INFO: tin: 9
[15:39:30.912] <TB1> INFO: level: 15
[15:39:30.912] <TB1> INFO: triggerdelay: 0
[15:39:30.912] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[15:39:30.913] <TB1> INFO: Log level: INFO
[15:39:30.926] <TB1> INFO: Found DTB DTB_WWXTQT
[15:39:30.936] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:39:30.938] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:39:30.940] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[15:39:32.497] <TB1> INFO: DUT info:
[15:39:32.497] <TB1> INFO: The DUT currently contains the following objects:
[15:39:32.497] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:39:32.497] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:39:32.497] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:39:32.497] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:39:32.497] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.497] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.498] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.498] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.498] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:39:32.899] <TB1> INFO: enter 'restricted' command line mode
[15:39:32.899] <TB1> INFO: enter test to run
[15:39:32.899] <TB1> INFO: test: delay setting parameters: ->5<-
[15:39:32.899] <TB1> INFO: delay test by 5 seconds...
[15:39:37.899] <TB1> INFO: enter test to run
[15:39:37.899] <TB1> INFO: test: Xray no parameter change
[15:39:37.899] <TB1> INFO: running: xray
[15:39:37.899] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//004_HRData_50//phCalibrationFitErr35_C15.dat
[15:39:38.033] <TB1> INFO: ######################################################################
[15:39:38.033] <TB1> INFO: PixTestXray::doTest()
[15:39:38.033] <TB1> INFO: ######################################################################
[15:39:38.033] <TB1> INFO: ----------------------------------------------------------------------
[15:39:38.033] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:39:38.033] <TB1> INFO: ----------------------------------------------------------------------
[15:39:38.755] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:39:46.146] <TB1> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[15:40:12.136] <TB1> INFO: Resuming triggers.
[15:40:19.533] <TB1> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[15:40:45.313] <TB1> INFO: Resuming triggers.
[15:40:52.709] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[15:41:18.547] <TB1> INFO: Resuming triggers.
[15:41:25.941] <TB1> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[15:41:51.444] <TB1> INFO: Resuming triggers.
[15:41:58.839] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[15:42:24.921] <TB1> INFO: Resuming triggers.
[15:42:32.320] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[15:42:57.890] <TB1> INFO: Resuming triggers.
[15:43:05.282] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[15:43:31.604] <TB1> INFO: Resuming triggers.
[15:43:38.998] <TB1> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[15:44:04.221] <TB1> INFO: Resuming triggers.
[15:44:11.615] <TB1> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[15:44:37.087] <TB1> INFO: Resuming triggers.
[15:44:44.483] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[15:45:10.599] <TB1> INFO: Resuming triggers.
[15:45:17.991] <TB1> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[15:45:44.291] <TB1> INFO: Resuming triggers.
[15:45:51.681] <TB1> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[15:46:18.151] <TB1> INFO: Resuming triggers.
[15:46:25.543] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[15:46:50.010] <TB1> INFO: Resuming triggers.
[15:46:53.981] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[15:47:07.863] <TB1> INFO: PixTest:: pg_setup set to default.
[15:47:07.864] <TB1> INFO: PixTestXray::doPhRun() done
[15:47:07.864] <TB1> INFO: PixTestXray::doTest() done
[15:47:08.052] <TB1> INFO: enter test to run
[15:47:08.052] <TB1> INFO: test: no parameter change
[15:47:08.324] <TB1> QUIET: Connection to board 147 closed.
[15:47:08.404] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[15:47:51.984] <TB1> INFO: *** Welcome to pxar ***
[15:47:51.984] <TB1> INFO: *** Today: 2016/09/27
[15:47:52.053] <TB1> INFO: *** Version: f5d3-dirty
[15:47:52.054] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//dacParameters35_C15.dat
[15:47:52.054] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//tbmParameters_C0b.dat
[15:47:52.055] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//defaultMaskFile.dat
[15:47:52.055] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//trimParameters35_C15.dat
[15:47:52.133] <TB1> INFO: clk: 4
[15:47:52.133] <TB1> INFO: ctr: 4
[15:47:52.133] <TB1> INFO: sda: 19
[15:47:52.133] <TB1> INFO: tin: 9
[15:47:52.133] <TB1> INFO: level: 15
[15:47:52.133] <TB1> INFO: triggerdelay: 0
[15:47:52.133] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[15:47:52.133] <TB1> INFO: Log level: INFO
[15:47:52.146] <TB1> INFO: Found DTB DTB_WWXTQT
[15:47:52.157] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:47:52.159] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:47:52.161] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[15:47:53.714] <TB1> INFO: DUT info:
[15:47:53.714] <TB1> INFO: The DUT currently contains the following objects:
[15:47:53.714] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:47:53.714] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:47:53.714] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:47:53.714] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:47:53.714] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.714] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.715] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:53.715] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:54.116] <TB1> INFO: enter 'restricted' command line mode
[15:47:54.116] <TB1> INFO: enter test to run
[15:47:54.116] <TB1> INFO: test: delay setting parameters: ->5<-
[15:47:54.116] <TB1> INFO: delay test by 5 seconds...
[15:47:59.116] <TB1> INFO: enter test to run
[15:47:59.116] <TB1> INFO: test: Xray no parameter change
[15:47:59.116] <TB1> INFO: running: xray
[15:47:59.116] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//005_HRData_150//phCalibrationFitErr35_C15.dat
[15:47:59.285] <TB1> INFO: ######################################################################
[15:47:59.285] <TB1> INFO: PixTestXray::doTest()
[15:47:59.285] <TB1> INFO: ######################################################################
[15:47:59.285] <TB1> INFO: ----------------------------------------------------------------------
[15:47:59.285] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:47:59.285] <TB1> INFO: ----------------------------------------------------------------------
[15:48:00.009] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:48:04.057] <TB1> INFO: run duration 4 seconds, buffer almost full (81%), pausing triggers.
[15:48:28.681] <TB1> INFO: Resuming triggers.
[15:48:32.738] <TB1> INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[15:48:58.150] <TB1> INFO: Resuming triggers.
[15:49:02.204] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[15:49:28.517] <TB1> INFO: Resuming triggers.
[15:49:32.573] <TB1> INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[15:49:59.466] <TB1> INFO: Resuming triggers.
[15:50:03.519] <TB1> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[15:50:29.778] <TB1> INFO: Resuming triggers.
[15:50:33.834] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[15:51:01.262] <TB1> INFO: Resuming triggers.
[15:51:05.313] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[15:51:33.036] <TB1> INFO: Resuming triggers.
[15:51:37.088] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[15:52:04.389] <TB1> INFO: Resuming triggers.
[15:52:08.445] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[15:52:35.789] <TB1> INFO: Resuming triggers.
[15:52:39.844] <TB1> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[15:53:07.001] <TB1> INFO: Resuming triggers.
[15:53:11.052] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[15:53:38.382] <TB1> INFO: Resuming triggers.
[15:53:42.436] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[15:54:10.346] <TB1> INFO: Resuming triggers.
[15:54:14.398] <TB1> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[15:54:40.921] <TB1> INFO: Resuming triggers.
[15:54:44.972] <TB1> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[15:55:12.380] <TB1> INFO: Resuming triggers.
[15:55:16.432] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[15:55:43.206] <TB1> INFO: Resuming triggers.
[15:55:47.257] <TB1> INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[15:56:13.935] <TB1> INFO: Resuming triggers.
[15:56:17.983] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[15:56:44.246] <TB1> INFO: Resuming triggers.
[15:56:48.293] <TB1> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[15:57:15.771] <TB1> INFO: Resuming triggers.
[15:57:19.819] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[15:57:47.589] <TB1> INFO: Resuming triggers.
[15:57:51.637] <TB1> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[15:58:18.551] <TB1> INFO: Resuming triggers.
[15:58:22.598] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[15:58:50.401] <TB1> INFO: Resuming triggers.
[15:58:54.443] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[15:59:19.970] <TB1> INFO: Resuming triggers.
[15:59:24.015] <TB1> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[15:59:48.612] <TB1> INFO: Resuming triggers.
[15:59:52.654] <TB1> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[16:00:19.311] <TB1> INFO: Resuming triggers.
[16:00:22.182] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[16:00:41.085] <TB1> INFO: PixTest:: pg_setup set to default.
[16:00:41.086] <TB1> INFO: PixTestXray::doPhRun() done
[16:00:41.086] <TB1> INFO: PixTestXray::doTest() done
[16:00:41.272] <TB1> INFO: enter test to run
[16:00:41.272] <TB1> INFO: test: no parameter change
[16:00:41.563] <TB1> QUIET: Connection to board 147 closed.
[16:00:41.643] <TB1> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[16:01:43.300] <TB1> INFO: *** Welcome to pxar ***
[16:01:43.300] <TB1> INFO: *** Today: 2016/09/27
[16:01:43.365] <TB1> INFO: *** Version: f5d3-dirty
[16:01:43.365] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//dacParameters35_C15.dat
[16:01:43.366] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//tbmParameters_C0b.dat
[16:01:43.366] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//defaultMaskFile.dat
[16:01:43.366] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//trimParameters35_C15.dat
[16:01:43.443] <TB1> INFO: clk: 4
[16:01:43.443] <TB1> INFO: ctr: 4
[16:01:43.443] <TB1> INFO: sda: 19
[16:01:43.443] <TB1> INFO: tin: 9
[16:01:43.443] <TB1> INFO: level: 15
[16:01:43.443] <TB1> INFO: triggerdelay: 0
[16:01:43.443] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:01:43.443] <TB1> INFO: Log level: INFO
[16:01:43.456] <TB1> INFO: Found DTB DTB_WWXTQT
[16:01:43.465] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:01:43.467] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:01:43.469] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:01:45.012] <TB1> INFO: DUT info:
[16:01:45.012] <TB1> INFO: The DUT currently contains the following objects:
[16:01:45.012] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:01:45.012] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:01:45.012] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:01:45.012] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:01:45.012] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.012] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.013] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.013] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.013] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.013] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.013] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.013] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:45.414] <TB1> INFO: enter 'restricted' command line mode
[16:01:45.414] <TB1> INFO: enter test to run
[16:01:45.414] <TB1> INFO: test: Highrate no parameter change
[16:01:45.414] <TB1> INFO: running: highrate
[16:01:45.414] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[16:01:45.588] <TB1> INFO: ----------------------------------------------------------------------
[16:01:45.588] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[16:01:45.588] <TB1> INFO: ----------------------------------------------------------------------
[16:01:45.593] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[16:01:45.607] <TB1> INFO: dacScan step from 15 .. 34
[16:01:45.607] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[16:01:45.607] <TB1> INFO: run 1 of 1
[16:01:46.147] <TB1> INFO: Expecting 4160000 events.
[16:02:12.519] <TB1> INFO: 450100 events read in total (25969ms).
[16:02:38.456] <TB1> INFO: 901300 events read in total (51906ms).
[16:03:03.886] <TB1> INFO: 1352500 events read in total (77336ms).
[16:03:29.093] <TB1> INFO: 1803900 events read in total (102543ms).
[16:03:55.275] <TB1> INFO: 2255200 events read in total (128725ms).
[16:04:21.203] <TB1> INFO: 2706100 events read in total (154653ms).
[16:04:47.160] <TB1> INFO: 3157550 events read in total (180610ms).
[16:05:12.934] <TB1> INFO: 3608650 events read in total (206384ms).
[16:05:38.650] <TB1> INFO: 4059250 events read in total (232100ms).
[16:05:44.622] <TB1> INFO: 4160000 events read in total (238072ms).
[16:05:44.886] <TB1> INFO: Test took 239278ms.
[16:05:53.152] <TB1> INFO: dacScan step from 35 .. 54
[16:05:53.152] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[16:05:53.152] <TB1> INFO: run 1 of 1
[16:05:53.651] <TB1> INFO: Expecting 4160000 events.
[16:06:18.968] <TB1> INFO: 382850 events read in total (24916ms).
[16:06:44.088] <TB1> INFO: 766350 events read in total (50036ms).
[16:07:00.094] <TB1> ERROR: <datapipe.cc/CheckEventValidity:L523> Channel 1 Number of ROCs (5) != Token Chain Length (4)

[16:07:00.094] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:07:00.094] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a181 80c0 40e1 499 2a60 51c 2461 84d 2045 40e1 40e1 113 286f 282 2848 51c 2262 40e1 745 244a 843 284b e002 c000

[16:07:00.094] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a17b 8040 40e0 258 2042 843 224a 40e0 22 2a42 515 2a4e 40e0 4b 2662 2c9 2a6a 40e0 45a 2a2f 500 264a 6c3 2660 6c4 264a 758 264d e002 c000

[16:07:00.094] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a17c 80b0 40e0 40e0 84 2a46 40e1 253 2a63 31b 2a64 689 2068 6cb 2a46 842 2227 40e1 e002 c000

[16:07:00.094] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a17d 80c0 40e1 488 2262 49b 2669 40e1 c8 244f 40e0 204 2641 80a 2664 40e1 1 264f 309 2266 412 2a67 748 224f e002 c000

[16:07:00.094] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a17e 8000 40e0 241 2862 644 2a47 80c 2241 40e0 40e3 9e0 2180 ca4 20a0 984 2008 d48 2820 8ec 2b24 c50 29a8 40e1 c9 2642 214 2444 68a 2466 40e0 74b 2043 e002 c000

[16:07:00.094] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a17f 8040 40e3 200 2846 28c 264a 620 2845 40e3 12 2080 45 2446 310 242e 310 2640 4db 284f 61b 2062 40e0 352 224c 40e3 220 264f 459 248c 695 2464 701 2049 e002 c000

[16:07:00.094] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a180 80b0 40e0 205 204c 812 224a 40e0 c2 2865 2c0 242e 40e1 761 206f 821 288b 40e1 e002 c000

[16:07:08.904] <TB1> INFO: 1148800 events read in total (74853ms).
[16:07:34.073] <TB1> INFO: 1530350 events read in total (100021ms).
[16:07:59.179] <TB1> INFO: 1910500 events read in total (125127ms).
[16:08:24.290] <TB1> INFO: 2288350 events read in total (150238ms).
[16:08:48.788] <TB1> INFO: 2663700 events read in total (174736ms).
[16:09:14.123] <TB1> INFO: 3035850 events read in total (200071ms).
[16:09:39.019] <TB1> INFO: 3404900 events read in total (224967ms).
[16:10:03.772] <TB1> INFO: 3771950 events read in total (249720ms).
[16:10:28.581] <TB1> INFO: 4138700 events read in total (274529ms).
[16:10:30.275] <TB1> INFO: 4160000 events read in total (276223ms).
[16:10:30.494] <TB1> INFO: Test took 277342ms.
[16:10:38.227] <TB1> INFO: dacScan step from 55 .. 74
[16:10:38.227] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[16:10:38.227] <TB1> INFO: run 1 of 1
[16:10:38.709] <TB1> INFO: Expecting 4160000 events.
[16:11:03.543] <TB1> INFO: 334950 events read in total (24433ms).
[16:11:27.017] <TB1> INFO: 670350 events read in total (47907ms).
[16:11:51.115] <TB1> INFO: 1005700 events read in total (72005ms).
[16:12:15.351] <TB1> INFO: 1341350 events read in total (96241ms).
[16:12:39.410] <TB1> INFO: 1676750 events read in total (120300ms).
[16:13:02.889] <TB1> INFO: 2012200 events read in total (143779ms).
[16:13:26.459] <TB1> INFO: 2347600 events read in total (167349ms).
[16:13:50.238] <TB1> INFO: 2682900 events read in total (191128ms).
[16:14:14.686] <TB1> INFO: 3018250 events read in total (215576ms).
[16:14:38.412] <TB1> INFO: 3353300 events read in total (239302ms).
[16:15:01.815] <TB1> INFO: 3688650 events read in total (262705ms).
[16:15:25.061] <TB1> INFO: 4023850 events read in total (285951ms).
[16:15:35.168] <TB1> INFO: 4160000 events read in total (296058ms).
[16:15:35.349] <TB1> INFO: Test took 297121ms.
[16:15:42.252] <TB1> INFO: dacScan step from 75 .. 75
[16:15:42.252] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[16:15:42.252] <TB1> INFO: run 1 of 1
[16:15:42.767] <TB1> INFO: Expecting 208000 events.
[16:15:58.623] <TB1> INFO: 208000 events read in total (15454ms).
[16:15:58.631] <TB1> INFO: Test took 16378ms.
[16:15:58.980] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:00.162] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:01.179] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:02.194] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:03.237] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:04.290] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:05.371] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:06.475] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:07.557] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:08.641] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:09.712] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:10.782] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:11.844] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:12.899] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:13.936] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:14.961] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[16:16:15.993] <TB1> INFO: PixTest:: pg_setup set to default.
[16:16:15.994] <TB1> INFO: vcal mean: 38.85 39.16 38.24 41.64 41.22 43.26 42.60 43.22 42.58 42.37 42.18 41.29 41.81 38.72 38.60 39.20
[16:16:15.994] <TB1> INFO: vcal RMS: 1.13 1.28 1.02 1.51 1.17 1.45 1.46 1.45 1.45 1.38 1.40 1.45 1.27 1.17 0.97 1.11
[16:16:15.994] <TB1> INFO: number of X-ray hits detected: 209058 223175 200800 345830 343864 432598 393732 454117 417735 389941 384022 330964 356143 195846 197205 204465
[16:16:15.994] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:16:15.995] <TB1> INFO: X-ray hit rate [MHz/cm2]: 61.3 65.4 58.9 101.4 100.8 126.8 115.4 133.1 122.4 114.3 112.6 97.0 104.4 57.4 57.8 59.9
[16:16:15.995] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[16:16:16.093] <TB1> INFO: enter test to run
[16:16:16.093] <TB1> INFO: test: no parameter change
[16:16:16.359] <TB1> QUIET: Connection to board 147 closed.
[16:16:16.438] <TB1> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[16:35:45.235] <TB1> INFO: *** Welcome to pxar ***
[16:35:45.235] <TB1> INFO: *** Today: 2016/09/27
[16:35:45.305] <TB1> INFO: *** Version: f5d3-dirty
[16:35:45.306] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:35:45.306] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[16:35:45.306] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[16:35:45.306] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[16:35:45.380] <TB1> INFO: clk: 4
[16:35:45.380] <TB1> INFO: ctr: 4
[16:35:45.380] <TB1> INFO: sda: 19
[16:35:45.380] <TB1> INFO: tin: 9
[16:35:45.380] <TB1> INFO: level: 15
[16:35:45.380] <TB1> INFO: triggerdelay: 0
[16:35:45.380] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:35:45.380] <TB1> INFO: Log level: INFO
[16:35:45.392] <TB1> INFO: Found DTB DTB_WWXTQT
[16:35:45.402] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:35:45.404] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:35:45.405] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:35:46.952] <TB1> INFO: DUT info:
[16:35:46.952] <TB1> INFO: The DUT currently contains the following objects:
[16:35:46.953] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:35:46.953] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:35:46.953] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:35:46.953] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:35:46.953] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:46.953] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:35:47.354] <TB1> INFO: enter 'restricted' command line mode
[16:35:47.354] <TB1> INFO: enter test to run
[16:35:47.354] <TB1> INFO: test: HighRate no parameter change
[16:35:47.354] <TB1> INFO: running: highrate
[16:35:47.355] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[16:35:47.517] <TB1> INFO: ----------------------------------------------------------------------
[16:35:47.517] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[16:35:47.518] <TB1> INFO: ----------------------------------------------------------------------
[16:35:47.611] <TB1> INFO: Expecting 768 events.
[16:35:48.603] <TB1> INFO: 768 events read in total (434ms).
[16:35:48.666] <TB1> INFO: Test took 1144ms.
[16:35:49.150] <TB1> INFO: Expecting 41600 events.
[16:35:52.381] <TB1> INFO: 41600 events read in total (2829ms).
[16:35:52.383] <TB1> INFO: Test took 3712ms.
[16:35:53.025] <TB1> INFO: Expecting 41600 events.
[16:35:56.049] <TB1> INFO: 41600 events read in total (2622ms).
[16:35:56.050] <TB1> INFO: Test took 3539ms.
[16:35:56.662] <TB1> INFO: Expecting 41600 events.
[16:35:59.597] <TB1> INFO: 41600 events read in total (2534ms).
[16:35:59.599] <TB1> INFO: Test took 3435ms.
[16:36:00.207] <TB1> INFO: Expecting 41600 events.
[16:36:03.144] <TB1> INFO: 41600 events read in total (2536ms).
[16:36:03.145] <TB1> INFO: Test took 3440ms.
[16:36:03.757] <TB1> INFO: Expecting 41600 events.
[16:36:06.801] <TB1> INFO: 41600 events read in total (2642ms).
[16:36:06.802] <TB1> INFO: Test took 3551ms.
[16:36:07.416] <TB1> INFO: Expecting 41600 events.
[16:36:10.514] <TB1> INFO: 41600 events read in total (2696ms).
[16:36:10.516] <TB1> INFO: Test took 3594ms.
[16:36:11.113] <TB1> INFO: Expecting 41600 events.
[16:36:14.091] <TB1> INFO: 41600 events read in total (2577ms).
[16:36:14.093] <TB1> INFO: Test took 3466ms.
[16:36:14.682] <TB1> INFO: Expecting 41600 events.
[16:36:17.720] <TB1> INFO: 41600 events read in total (2637ms).
[16:36:17.722] <TB1> INFO: Test took 3523ms.
[16:36:18.307] <TB1> INFO: Expecting 41600 events.
[16:36:21.330] <TB1> INFO: 41600 events read in total (2622ms).
[16:36:21.331] <TB1> INFO: Test took 3503ms.
[16:36:21.930] <TB1> INFO: Expecting 41600 events.
[16:36:24.924] <TB1> INFO: 41600 events read in total (2593ms).
[16:36:24.926] <TB1> INFO: Test took 3485ms.
[16:36:25.511] <TB1> INFO: Expecting 41600 events.
[16:36:28.570] <TB1> INFO: 41600 events read in total (2657ms).
[16:36:28.571] <TB1> INFO: Test took 3539ms.
[16:36:29.162] <TB1> INFO: Expecting 41600 events.
[16:36:32.285] <TB1> INFO: 41600 events read in total (2721ms).
[16:36:32.287] <TB1> INFO: Test took 3608ms.
[16:36:32.889] <TB1> INFO: Expecting 41600 events.
[16:36:35.909] <TB1> INFO: 41600 events read in total (2618ms).
[16:36:35.911] <TB1> INFO: Test took 3516ms.
[16:36:36.504] <TB1> INFO: Expecting 41600 events.
[16:36:39.491] <TB1> INFO: 41600 events read in total (2586ms).
[16:36:39.493] <TB1> INFO: Test took 3473ms.
[16:36:40.079] <TB1> INFO: Expecting 41600 events.
[16:36:43.124] <TB1> INFO: 41600 events read in total (2644ms).
[16:36:43.126] <TB1> INFO: Test took 3526ms.
[16:36:43.721] <TB1> INFO: Expecting 41600 events.
[16:36:46.815] <TB1> INFO: 41600 events read in total (2692ms).
[16:36:46.818] <TB1> INFO: Test took 3582ms.
[16:36:47.468] <TB1> INFO: Expecting 41600 events.
[16:36:50.562] <TB1> INFO: 41600 events read in total (2693ms).
[16:36:50.564] <TB1> INFO: Test took 3611ms.
[16:36:51.184] <TB1> INFO: Expecting 41600 events.
[16:36:54.318] <TB1> INFO: 41600 events read in total (2733ms).
[16:36:54.320] <TB1> INFO: Test took 3631ms.
[16:36:54.916] <TB1> INFO: Expecting 41600 events.
[16:36:57.904] <TB1> INFO: 41600 events read in total (2587ms).
[16:36:57.906] <TB1> INFO: Test took 3476ms.
[16:36:58.493] <TB1> INFO: Expecting 41600 events.
[16:37:01.340] <TB1> INFO: 41600 events read in total (2445ms).
[16:37:01.342] <TB1> INFO: Test took 3328ms.
[16:37:01.701] <TB1> INFO: enter test to run
[16:37:01.701] <TB1> INFO: test: Pretest no parameter change
[16:37:01.701] <TB1> INFO: running: pretest
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[16:37:01.702] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[16:37:01.703] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[16:37:01.703] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[16:37:01.703] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[16:37:01.703] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[16:37:01.703] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[16:37:01.703] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[16:37:01.703] <TB1> INFO: write dac parameters into /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:37:01.703] <TB1> INFO: enter test to run
[16:37:01.703] <TB1> INFO: test: no parameter change
[16:37:01.919] <TB1> QUIET: Connection to board 147 closed.
[16:37:01.999] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:37:46.425] <TB1> INFO: *** Welcome to pxar ***
[16:37:46.425] <TB1> INFO: *** Today: 2016/09/27
[16:37:46.494] <TB1> INFO: *** Version: f5d3-dirty
[16:37:46.494] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//dacParameters35_C15.dat
[16:37:46.495] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//tbmParameters_C0b.dat
[16:37:46.495] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//defaultMaskFile.dat
[16:37:46.495] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//trimParameters35_C15.dat
[16:37:46.568] <TB1> INFO: clk: 4
[16:37:46.568] <TB1> INFO: ctr: 4
[16:37:46.568] <TB1> INFO: sda: 19
[16:37:46.568] <TB1> INFO: tin: 9
[16:37:46.568] <TB1> INFO: level: 15
[16:37:46.568] <TB1> INFO: triggerdelay: 0
[16:37:46.568] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:37:46.568] <TB1> INFO: Log level: INFO
[16:37:46.581] <TB1> INFO: Found DTB DTB_WWXTQT
[16:37:46.591] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:37:46.593] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:37:46.594] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:37:48.132] <TB1> INFO: DUT info:
[16:37:48.132] <TB1> INFO: The DUT currently contains the following objects:
[16:37:48.132] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:37:48.133] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:37:48.133] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:37:48.133] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:37:48.133] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.133] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.534] <TB1> INFO: enter 'restricted' command line mode
[16:37:48.534] <TB1> INFO: enter test to run
[16:37:48.534] <TB1> INFO: test: PixelAlive no parameter change
[16:37:48.534] <TB1> INFO: running: pixelalive
[16:37:48.540] <TB1> INFO: ######################################################################
[16:37:48.540] <TB1> INFO: PixTestAlive::doTest()
[16:37:48.540] <TB1> INFO: ######################################################################
[16:37:48.541] <TB1> INFO: ----------------------------------------------------------------------
[16:37:48.541] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:37:48.541] <TB1> INFO: ----------------------------------------------------------------------
[16:37:48.810] <TB1> INFO: Expecting 208000 events.
[16:37:58.333] <TB1> INFO: 208000 events read in total (8964ms).
[16:37:58.335] <TB1> INFO: Test took 9792ms.
[16:37:58.559] <TB1> INFO: PixTestAlive::aliveTest() done
[16:37:58.559] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:37:58.560] <TB1> INFO: ----------------------------------------------------------------------
[16:37:58.560] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:37:58.560] <TB1> INFO: ----------------------------------------------------------------------
[16:37:58.851] <TB1> INFO: Expecting 208000 events.
[16:38:05.133] <TB1> INFO: 208000 events read in total (5725ms).
[16:38:05.133] <TB1> INFO: Test took 6572ms.
[16:38:05.133] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:38:05.344] <TB1> INFO: PixTestAlive::maskTest() done
[16:38:05.344] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:38:05.346] <TB1> INFO: ----------------------------------------------------------------------
[16:38:05.346] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:38:05.346] <TB1> INFO: ----------------------------------------------------------------------
[16:38:05.613] <TB1> INFO: Expecting 208000 events.
[16:38:14.969] <TB1> INFO: 208000 events read in total (8800ms).
[16:38:14.970] <TB1> INFO: Test took 9622ms.
[16:38:15.170] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:38:15.170] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:38:15.170] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[16:38:15.201] <TB1> INFO: enter test to run
[16:38:15.201] <TB1> INFO: test: delay setting parameters: ->2<-
[16:38:15.201] <TB1> INFO: delay test by 2 seconds...
[16:38:17.201] <TB1> INFO: enter test to run
[16:38:17.201] <TB1> INFO: test: HighRate no parameter change
[16:38:17.201] <TB1> INFO: running: highrate
[16:38:17.201] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[16:38:17.389] <TB1> INFO: ----------------------------------------------------------------------
[16:38:17.389] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:38:17.389] <TB1> INFO: ----------------------------------------------------------------------
[16:38:17.902] <TB1> INFO: Expecting 208000 events.
[16:38:29.733] <TB1> INFO: 208000 events read in total (11429ms).
[16:38:29.739] <TB1> INFO: Test took 12347ms.
[16:38:30.319] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:38:30.319] <TB1> INFO: number of red-efficiency pixels: 153 148 146 265 275 407 360 449 352 331 338 243 269 121 132 120
[16:38:30.319] <TB1> INFO: number of X-ray hits detected: 103432 109312 97733 172471 169975 216771 195951 227648 206696 193146 190817 163700 176347 93678 94822 100112
[16:38:30.319] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:38:30.319] <TB1> INFO: number of Vcal hits detected: 207838 207845 207849 207722 207714 207556 207606 207520 207627 207648 207625 207744 207723 207879 207866 207880
[16:38:30.319] <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
[16:38:30.319] <TB1> INFO: Vcal hit overall 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
[16:38:30.319] <TB1> INFO: X-ray hit rate [MHz/cm2]: 30.3 32.0 28.6 50.6 49.8 63.5 57.4 66.7 60.6 56.6 55.9 48.0 51.7 27.5 27.8 29.3
[16:38:30.319] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:38:30.355] <TB1> INFO: PixTest:: pg_setup set to default.
[16:38:30.371] <TB1> INFO: enter test to run
[16:38:30.371] <TB1> INFO: test: no parameter change
[16:38:30.665] <TB1> QUIET: Connection to board 147 closed.
[16:38:30.745] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:39:15.682] <TB1> INFO: *** Welcome to pxar ***
[16:39:15.682] <TB1> INFO: *** Today: 2016/09/27
[16:39:15.764] <TB1> INFO: *** Version: f5d3-dirty
[16:39:15.764] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//dacParameters35_C15.dat
[16:39:15.765] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//tbmParameters_C0b.dat
[16:39:15.765] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//defaultMaskFile.dat
[16:39:15.765] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//trimParameters35_C15.dat
[16:39:15.838] <TB1> INFO: clk: 4
[16:39:15.838] <TB1> INFO: ctr: 4
[16:39:15.838] <TB1> INFO: sda: 19
[16:39:15.838] <TB1> INFO: tin: 9
[16:39:15.838] <TB1> INFO: level: 15
[16:39:15.838] <TB1> INFO: triggerdelay: 0
[16:39:15.838] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:39:15.838] <TB1> INFO: Log level: INFO
[16:39:15.850] <TB1> INFO: Found DTB DTB_WWXTQT
[16:39:15.860] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:39:15.862] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:39:15.864] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:39:17.405] <TB1> INFO: DUT info:
[16:39:17.405] <TB1> INFO: The DUT currently contains the following objects:
[16:39:17.405] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:39:17.405] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:39:17.405] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:39:17.405] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:39:17.405] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.405] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.406] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.406] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.406] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.406] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.406] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.406] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:17.806] <TB1> INFO: enter 'restricted' command line mode
[16:39:17.806] <TB1> INFO: enter test to run
[16:39:17.806] <TB1> INFO: test: PixelAlive no parameter change
[16:39:17.806] <TB1> INFO: running: pixelalive
[16:39:17.813] <TB1> INFO: ######################################################################
[16:39:17.813] <TB1> INFO: PixTestAlive::doTest()
[16:39:17.813] <TB1> INFO: ######################################################################
[16:39:17.815] <TB1> INFO: ----------------------------------------------------------------------
[16:39:17.815] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:39:17.815] <TB1> INFO: ----------------------------------------------------------------------
[16:39:18.083] <TB1> INFO: Expecting 208000 events.
[16:39:27.429] <TB1> INFO: 208000 events read in total (8788ms).
[16:39:27.431] <TB1> INFO: Test took 9614ms.
[16:39:27.669] <TB1> INFO: PixTestAlive::aliveTest() done
[16:39:27.669] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:39:27.670] <TB1> INFO: ----------------------------------------------------------------------
[16:39:27.670] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:39:27.670] <TB1> INFO: ----------------------------------------------------------------------
[16:39:27.931] <TB1> INFO: Expecting 208000 events.
[16:39:34.213] <TB1> INFO: 208000 events read in total (5726ms).
[16:39:34.215] <TB1> INFO: Test took 6544ms.
[16:39:34.215] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:39:34.419] <TB1> INFO: PixTestAlive::maskTest() done
[16:39:34.419] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:39:34.420] <TB1> INFO: ----------------------------------------------------------------------
[16:39:34.420] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:39:34.420] <TB1> INFO: ----------------------------------------------------------------------
[16:39:34.682] <TB1> INFO: Expecting 208000 events.
[16:39:44.217] <TB1> INFO: 208000 events read in total (8979ms).
[16:39:44.218] <TB1> INFO: Test took 9796ms.
[16:39:44.423] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:39:44.423] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:39:44.424] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[16:39:44.455] <TB1> INFO: enter test to run
[16:39:44.455] <TB1> INFO: test: delay setting parameters: ->2<-
[16:39:44.455] <TB1> INFO: delay test by 2 seconds...
[16:39:46.455] <TB1> INFO: enter test to run
[16:39:46.456] <TB1> INFO: test: HighRate no parameter change
[16:39:46.456] <TB1> INFO: running: highrate
[16:39:46.456] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[16:39:46.644] <TB1> INFO: ----------------------------------------------------------------------
[16:39:46.644] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:39:46.644] <TB1> INFO: ----------------------------------------------------------------------
[16:39:47.135] <TB1> INFO: Expecting 208000 events.
[16:40:00.787] <TB1> INFO: 208000 events read in total (13250ms).
[16:40:00.793] <TB1> INFO: Test took 14146ms.
[16:40:01.502] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:40:01.502] <TB1> INFO: number of red-efficiency pixels: 238 281 317 520 530 793 683 918 757 680 573 433 503 232 199 217
[16:40:01.502] <TB1> INFO: number of X-ray hits detected: 152359 161651 144992 251763 249632 317592 288728 331192 305768 282976 279626 241751 260009 139681 141733 148669
[16:40:01.502] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:40:01.502] <TB1> INFO: number of Vcal hits detected: 207745 207703 207642 207414 207419 207054 207211 206900 207127 207183 207350 207528 207447 207745 207794 207773
[16:40:01.502] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.6 99.7 99.5 99.6 99.6 99.7 99.8 99.8 99.9 99.9 99.9
[16:40:01.502] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.5 99.6 99.5 99.6 99.6 99.7 99.8 99.7 99.9 99.9 99.9
[16:40:01.502] <TB1> INFO: X-ray hit rate [MHz/cm2]: 44.7 47.4 42.5 73.8 73.2 93.1 84.6 97.1 89.6 82.9 82.0 70.9 76.2 40.9 41.5 43.6
[16:40:01.502] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:40:01.532] <TB1> INFO: PixTest:: pg_setup set to default.
[16:40:01.542] <TB1> INFO: enter test to run
[16:40:01.542] <TB1> INFO: test: no parameter change
[16:40:01.812] <TB1> QUIET: Connection to board 147 closed.
[16:40:01.891] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:40:45.338] <TB1> INFO: *** Welcome to pxar ***
[16:40:45.338] <TB1> INFO: *** Today: 2016/09/27
[16:40:45.407] <TB1> INFO: *** Version: f5d3-dirty
[16:40:45.407] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//dacParameters35_C15.dat
[16:40:45.408] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//tbmParameters_C0b.dat
[16:40:45.408] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//defaultMaskFile.dat
[16:40:45.408] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//trimParameters35_C15.dat
[16:40:45.481] <TB1> INFO: clk: 4
[16:40:45.481] <TB1> INFO: ctr: 4
[16:40:45.481] <TB1> INFO: sda: 19
[16:40:45.481] <TB1> INFO: tin: 9
[16:40:45.481] <TB1> INFO: level: 15
[16:40:45.481] <TB1> INFO: triggerdelay: 0
[16:40:45.482] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:40:45.482] <TB1> INFO: Log level: INFO
[16:40:45.495] <TB1> INFO: Found DTB DTB_WWXTQT
[16:40:45.505] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:40:45.507] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:40:45.508] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:40:47.047] <TB1> INFO: DUT info:
[16:40:47.047] <TB1> INFO: The DUT currently contains the following objects:
[16:40:47.047] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:40:47.047] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:40:47.047] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:40:47.047] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:40:47.047] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.047] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:40:47.448] <TB1> INFO: enter 'restricted' command line mode
[16:40:47.448] <TB1> INFO: enter test to run
[16:40:47.448] <TB1> INFO: test: PixelAlive no parameter change
[16:40:47.448] <TB1> INFO: running: pixelalive
[16:40:47.457] <TB1> INFO: ######################################################################
[16:40:47.457] <TB1> INFO: PixTestAlive::doTest()
[16:40:47.457] <TB1> INFO: ######################################################################
[16:40:47.458] <TB1> INFO: ----------------------------------------------------------------------
[16:40:47.458] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:40:47.458] <TB1> INFO: ----------------------------------------------------------------------
[16:40:47.725] <TB1> INFO: Expecting 208000 events.
[16:40:57.419] <TB1> INFO: 208000 events read in total (9135ms).
[16:40:57.420] <TB1> INFO: Test took 9960ms.
[16:40:57.650] <TB1> INFO: PixTestAlive::aliveTest() done
[16:40:57.650] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:40:57.652] <TB1> INFO: ----------------------------------------------------------------------
[16:40:57.652] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:40:57.652] <TB1> INFO: ----------------------------------------------------------------------
[16:40:57.915] <TB1> INFO: Expecting 208000 events.
[16:41:04.337] <TB1> INFO: 208000 events read in total (5866ms).
[16:41:04.338] <TB1> INFO: Test took 6685ms.
[16:41:04.339] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:41:04.546] <TB1> INFO: PixTestAlive::maskTest() done
[16:41:04.546] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:41:04.547] <TB1> INFO: ----------------------------------------------------------------------
[16:41:04.547] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:41:04.547] <TB1> INFO: ----------------------------------------------------------------------
[16:41:04.808] <TB1> INFO: Expecting 208000 events.
[16:41:14.120] <TB1> INFO: 208000 events read in total (8756ms).
[16:41:14.120] <TB1> INFO: Test took 9571ms.
[16:41:14.316] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:41:14.316] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:41:14.316] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[16:41:14.360] <TB1> INFO: enter test to run
[16:41:14.360] <TB1> INFO: test: delay setting parameters: ->2<-
[16:41:14.360] <TB1> INFO: delay test by 2 seconds...
[16:41:16.360] <TB1> INFO: enter test to run
[16:41:16.360] <TB1> INFO: test: HighRate no parameter change
[16:41:16.360] <TB1> INFO: running: highrate
[16:41:16.360] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[16:41:16.507] <TB1> INFO: ----------------------------------------------------------------------
[16:41:16.507] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:41:16.507] <TB1> INFO: ----------------------------------------------------------------------
[16:41:16.994] <TB1> INFO: Expecting 208000 events.
[16:41:32.548] <TB1> INFO: 208000 events read in total (15153ms).
[16:41:32.557] <TB1> INFO: Test took 16047ms.
[16:41:33.489] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:41:33.489] <TB1> INFO: number of red-efficiency pixels: 419 442 569 976 1016 1505 1246 1677 1446 1307 1181 892 1003 425 364 357
[16:41:33.489] <TB1> INFO: number of X-ray hits detected: 211021 224151 201316 345250 343988 433681 395165 454314 417839 388352 384048 331237 355774 196084 197423 205022
[16:41:33.489] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:41:33.489] <TB1> INFO: number of Vcal hits detected: 207535 207529 207236 206787 206753 205798 206254 205644 206098 206142 206463 206889 206747 207463 207606 207615
[16:41:33.489] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.5 99.5 99.1 99.3 99.0 99.2 99.2 99.3 99.5 99.5 99.8 99.8 99.8
[16:41:33.489] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.6 99.4 99.4 98.9 99.2 98.9 99.1 99.1 99.3 99.5 99.4 99.7 99.8 99.8
[16:41:33.489] <TB1> INFO: X-ray hit rate [MHz/cm2]: 61.9 65.7 59.0 101.2 100.8 127.1 115.8 133.2 122.5 113.8 112.6 97.1 104.3 57.5 57.9 60.1
[16:41:33.489] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:41:33.512] <TB1> INFO: PixTest:: pg_setup set to default.
[16:41:33.522] <TB1> INFO: enter test to run
[16:41:33.522] <TB1> INFO: test: no parameter change
[16:41:33.812] <TB1> QUIET: Connection to board 147 closed.
[16:41:33.893] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:42:21.039] <TB1> INFO: *** Welcome to pxar ***
[16:42:21.039] <TB1> INFO: *** Today: 2016/09/27
[16:42:21.104] <TB1> INFO: *** Version: f5d3-dirty
[16:42:21.104] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//dacParameters35_C15.dat
[16:42:21.104] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//tbmParameters_C0b.dat
[16:42:21.104] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//defaultMaskFile.dat
[16:42:21.104] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//trimParameters35_C15.dat
[16:42:21.179] <TB1> INFO: clk: 4
[16:42:21.179] <TB1> INFO: ctr: 4
[16:42:21.179] <TB1> INFO: sda: 19
[16:42:21.179] <TB1> INFO: tin: 9
[16:42:21.179] <TB1> INFO: level: 15
[16:42:21.179] <TB1> INFO: triggerdelay: 0
[16:42:21.179] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:42:21.179] <TB1> INFO: Log level: INFO
[16:42:21.192] <TB1> INFO: Found DTB DTB_WWXTQT
[16:42:21.202] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:42:21.204] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:42:21.206] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:42:22.745] <TB1> INFO: DUT info:
[16:42:22.745] <TB1> INFO: The DUT currently contains the following objects:
[16:42:22.745] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:42:22.745] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:42:22.745] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:42:22.745] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:42:22.745] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.745] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.745] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:22.746] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:42:23.147] <TB1> INFO: enter 'restricted' command line mode
[16:42:23.147] <TB1> INFO: enter test to run
[16:42:23.147] <TB1> INFO: test: PixelAlive no parameter change
[16:42:23.147] <TB1> INFO: running: pixelalive
[16:42:23.155] <TB1> INFO: ######################################################################
[16:42:23.155] <TB1> INFO: PixTestAlive::doTest()
[16:42:23.155] <TB1> INFO: ######################################################################
[16:42:23.157] <TB1> INFO: ----------------------------------------------------------------------
[16:42:23.157] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:42:23.157] <TB1> INFO: ----------------------------------------------------------------------
[16:42:23.436] <TB1> INFO: Expecting 208000 events.
[16:42:32.966] <TB1> INFO: 208000 events read in total (8971ms).
[16:42:32.968] <TB1> INFO: Test took 9809ms.
[16:42:33.197] <TB1> INFO: PixTestAlive::aliveTest() done
[16:42:33.197] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:42:33.198] <TB1> INFO: ----------------------------------------------------------------------
[16:42:33.198] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:42:33.198] <TB1> INFO: ----------------------------------------------------------------------
[16:42:33.496] <TB1> INFO: Expecting 208000 events.
[16:42:39.885] <TB1> INFO: 208000 events read in total (5833ms).
[16:42:39.886] <TB1> INFO: Test took 6687ms.
[16:42:39.887] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:42:40.094] <TB1> INFO: PixTestAlive::maskTest() done
[16:42:40.094] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:42:40.096] <TB1> INFO: ----------------------------------------------------------------------
[16:42:40.096] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:42:40.096] <TB1> INFO: ----------------------------------------------------------------------
[16:42:40.356] <TB1> INFO: Expecting 208000 events.
[16:42:49.557] <TB1> INFO: 208000 events read in total (8645ms).
[16:42:49.557] <TB1> INFO: Test took 9460ms.
[16:42:49.759] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:42:49.759] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:42:49.759] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[16:42:49.788] <TB1> INFO: enter test to run
[16:42:49.788] <TB1> INFO: test: delay setting parameters: ->2<-
[16:42:49.788] <TB1> INFO: delay test by 2 seconds...
[16:42:51.788] <TB1> INFO: enter test to run
[16:42:51.788] <TB1> INFO: test: HighRate no parameter change
[16:42:51.788] <TB1> INFO: running: highrate
[16:42:51.788] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[16:42:51.924] <TB1> INFO: ----------------------------------------------------------------------
[16:42:51.924] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:42:51.924] <TB1> INFO: ----------------------------------------------------------------------
[16:42:52.406] <TB1> INFO: Expecting 208000 events.
[16:42:56.322] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"

[16:42:56.322] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"

[16:42:56.322] <TB1> ERROR: <datapipe.cc/CheckEventID:L485> Channel 2 Event ID mismatch: local ID (218) != TBM ID (219)

[16:42:56.322] <TB1> ERROR: <datapipe.cc/CheckEventID:L485> Channel 3 Event ID mismatch: local ID (218) != TBM ID (219)

[16:42:56.322] <TB1> WARNING: Channel 2 ROC 1: Readback start marker after 15 readouts!

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3de 8001 40e0 55 26a1 e2 2063 713 2065 41c0 a 282d 55 268a 10a 246a 41c0 5a 2082 55 268a 862 266d 40c0 55 268d 24c 2041 24c 2226 800 282b e002 c000

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3d8 80b1 40e1 55 2aa2 521 286e 84a 204f 40c1 55 2aa8 29c 2241 40e1 55 2a89 45b 244e 75b 244a 41c1 55 2a85 e002 c000

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3d9 80c1 40c1 18 282f 55 26aa 108 2647 2dc 228a 6d3 2a64 40c1 55 268f 41c1 55 268a 40c1 55 26a3 e002 c000

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3da 8001 40e0 55 26a0 91 2046 489 2044 54b 26a3 41c0 55 2689 102 244f 41c0 55 268f 40c0 55 2687 fff 2fad fc00 dc00

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3db 8041 40e0 55 26c0 8c 284d 11c 266a 40e0 d 2442 55 26a6 89 226e 41c0 55 268e 41e0 55 2688 419 226b e002 c000

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3dc 80b1 40e1 55 26a2 514 2a4f 61b 2266 40e1 55 2685 c5 204a 562 266f 720 2446 41e1 55 26a4 6da 222e 712 202f 40e1 1 2424 55 268f 304 2261 e002 c000

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3dd 80c1 40e0 55 2687 55c 206f 40e0 55 268d e1 204b 40c0 55 2689 322 2066 51b 2262 41e0 55 2688 510 2448 821 224a 861 2249 e002 c000

[16:42:56.322] <TB1> WARNING: Channel 2 ROC 0: Readback start marker after 15 readouts!

[16:42:56.322] <TB1> WARNING: Channel 3 ROC 0: Readback start marker after 15 readouts!

[16:42:56.322] <TB1> WARNING: Channel 3 ROC 1: Readback start marker after 15 readouts!

[16:42:56.322] <TB1> WARNING: Channel 3 ROC 2: Readback start marker after 15 readouts!

[16:42:56.322] <TB1> WARNING: Channel 3 ROC 3: Readback start marker after 15 readouts!

[16:42:56.322] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e2 8000 40c0 54 224e 55 26a6 da 2444 240 2844 2c0 2446 652 2442 6c3 282e 41c1 55 26a8 2c4 2a4e 311 2462 354 226c 4cc 2a4c 682 204f 40c1 2 264f 55 268e 24b 2068 401 2466 41c0 55 26af 40b 2486 48a 2485 70c 222d e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2dc 80b0 40e1 55 26ae 611 2826 81c 2245 40e0 48 2a4d 55 26ad 5d 2262 495 2264 600 2a28 41e0 13 2646 55 26a4 512 2862 68b 2a47 41c0 55 26a9 60 2a85 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2dd 80c0 40e0 55 26c6 71d 2645 40e0 61 2861 55 26a8 21d 286e 482 2046 762 264f 41e0 55 268f 29a 2a85 2c3 204f 503 2264 40c1 55 268f e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2de 8000 40e0 4 2840 55 26c2 29b 2a6e 602 2047 752 2640 40c2 55 2689 142 202a 283 2261 41e1 55 26a9 543 2462 40c1 b 2068 55 26ab e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2df 8040 40c2 55 26a1 493 2661 40c1 55 26a0 84a 266d 40e1 55 26af 203 2449 814 2a45 41c0 55 26a5 4d4 2861 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e0 80b0 40e1 55 26aa 41e0 11 2462 50 2641 55 26a2 a2 2a6e 659 244c 698 2a46 751 2040 850 2a4a 40c0 55 268a 6d3 2a6d 40c0 55 26af e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e1 80c0 40e0 55 26c0 283 2266 40b 2462 40e0 55 2688 214 2062 251 288c 543 2a6f 41e0 55 26ac 304 2448 61c 2042 743 266a 40c0 55 268f 6d0 2a65 84c 2841 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e2 8001 40c0 55 268e 290 2049 499 226a 40c0 55 268a 688 2449 40e1 55 26a6 10b 204f 654 2a45 40c1 58 2027 55 2685 820 2442 85b 2a43 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3dc 80b1 40e1 55 26a2 514 2a4f 61b 2266 40e1 55 2685 c5 204a 562 266f 720 2446 41e1 55 26a4 6da 222e 712 202f 40e1 1 2424 55 268f 304 2261 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3dd 80c1 40e0 55 2687 55c 206f 40e0 55 268d e1 204b 40c0 55 2689 322 2066 51b 2262 41e0 55 2688 510 2448 821 224a 861 2249 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3de 8001 40e0 55 26a1 e2 2063 713 2065 41c0 a 282d 55 268a 10a 246a 41c0 5a 2082 55 268a 862 266d 40c0 55 268d 24c 2041 24c 2226 800 282b e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3df 8041 40c2 60 244e 5b 2464 55 26a6 820 2449 40e2 55 268f 544 284a 41c2 55 268f 619 2645 41c2 55 2045 55 268f e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e0 80b1 40e1 55 26a8 614 2847 614 2648 41c1 5 2022 55 26a1 600 242a 40c1 55 26a2 41c1 55 2689 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a3e1 80c1 40e1 55 26a2 659 2068 84a 2264 40e1 55 26a2 41e1 55 2688 758 2242 40c1 55 2688 615 264f e002 c000

[16:42:56.323] <TB1> WARNING: Channel 2 ROC 2: Readback start marker after 15 readouts!

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e8 80b0 40e1 55 26a2 148 2a47 208 2842 214 2244 348 2640 442 224a 481 2a4e 40c1 55 26a3 2d1 224e 31a 2268 40c1 4 2a42 55 26aa c0 2440 e1 2a82 55a 206d 40c0 55 26aa e2 2868 812 2241 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e2 8000 40c0 54 224e 55 26a6 da 2444 240 2844 2c0 2446 652 2442 6c3 282e 41c1 55 26a8 2c4 2a4e 311 2462 354 226c 4cc 2a4c 682 204f 40c1 2 264f 55 268e 24b 2068 401 2466 41c0 55 26af 40b 2486 48a 2485 70c 222d e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e3 8040 40e0 55 26c0 542 2448 6d2 2a2c 41c0 55 26a8 e2 2a80 45b 2a6a 705 2064 41e0 41 2a64 55 26a8 30b 206a 853 2865 84c 2649 41e1 55 268f 55 2a66 40c 2a65 605 284e 6c9 2885 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e4 80b0 40e0 55 26c4 a1 244f 41c0 55 2685 482 2262 858 2466 845 266d 858 2249 40c0 55 268a 41c1 55 268a 854 2a23 861 2a4b e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e5 80c0 40e0 55 26a8 721 2a2a 81d 2647 41c0 0 2a4e 55 26a8 4c8 2a6b 54a 244f 643 2865 41c2 44 2045 55 26a9 40c0 55 26a5 413 208b 405 226e 684 2a45 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e6 8000 40e0 55 26ac 562 2a61 40e0 54 2448 55 26a8 d2 284c 40c1 55 2686 492 2646 40c0 55 26a8 100 264b e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e7 8040 40c0 d 2a4a 55 26af 40b 266c 44b 2a44 64a 2241 653 2a6d 41c1 55 2686 214 2068 34a 2065 40c0 55 26a9 408 2465 562 286a 40c1 55 26c8 494 2069 e002 c000

[16:42:56.323] <TB1> WARNING: Channel 2 ROC 3: Readback start marker after 31 readouts!

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2ed 80c0 40c0 c 204a 5 2263 55 26c6 719 2a42 812 262c 40e0 3 2463 55 26aa 11d 2a6c 211 206b 453 288c 659 2448 40c0 13 244f 55 268f 41e1 55 26a3 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e7 8040 40c0 d 2a4a 55 26af 40b 266c 44b 2a44 64a 2241 653 2a6d 41c1 55 2686 214 2068 34a 2065 40c0 55 26a9 408 2465 562 286a 40c1 55 26c8 494 2069 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e8 80b0 40e1 55 26a2 148 2a47 208 2842 214 2244 348 2640 442 224a 481 2a4e 40c1 55 26a3 2d1 224e 31a 2268 40c1 4 2a42 55 26aa c0 2440 e1 2a82 55a 206d 40c0 55 26aa e2 2868 812 2241 e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2e9 80c0 40e1 9 2064 55 26e0 84c 2849 40c0 55 26a5 291 2a69 41c0 55 26aa 34d 2245 49b 2889 41e0 55 268f 322 226f e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2ea 8000 40e0 43 2a66 55 26c2 110 2069 24c 2626 608 2222 752 2427 40e0 55 2688 41c0 22 284e 55 268f 615 2a4c 645 2469 40c2 55 26a8 118 2a4f e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2eb 8040 40c0 55 26a8 d1 262e 300 284a 40b 246e 4c4 2a6f 522 2046 40c1 3 2848 55 268a 24a 2a4c 50b 2a4f 40c0 55 26a6 618 2a43 41c1 55 26aa 105 224c 35d 2684 50d 244f e002 c000

[16:42:56.323] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a2ec 80b0 40c1 40c0 55 26ac 203 2480 40e0 4c 2a4d 55 268f 41e0 14 2044 55 26a8 6c2 226b 6db 2689 e002 c000

[16:43:09.261] <TB1> INFO: 208000 events read in total (16454ms).
[16:43:09.273] <TB1> INFO: Test took 17346ms.
[16:43:10.367] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:43:10.367] <TB1> INFO: number of red-efficiency pixels: 549 677 809 1398 1438 2160 1771 2378 2092 1875 1718 1307 1531 586 552 526
[16:43:10.367] <TB1> INFO: number of X-ray hits detected: 257358 270950 245930 417972 418568 525720 481085 551666 507419 471166 464669 403360 432869 238305 241553 250112
[16:43:10.368] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:43:10.368] <TB1> INFO: number of Vcal hits detected: 207351 207209 206704 206046 206005 204182 204973 203888 204728 204828 205367 206122 205809 207164 207397 207412
[16:43:10.368] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.5 99.2 99.2 98.4 98.8 98.2 98.6 98.7 98.9 99.2 99.1 99.7 99.7 99.8
[16:43:10.368] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.6 99.4 99.1 99.0 98.2 98.5 98.0 98.4 98.5 98.7 99.1 98.9 99.6 99.7 99.7
[16:43:10.368] <TB1> INFO: X-ray hit rate [MHz/cm2]: 75.4 79.4 72.1 122.5 122.7 154.1 141.0 161.7 148.7 138.1 136.2 118.2 126.9 69.8 70.8 73.3
[16:43:10.368] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:43:10.397] <TB1> INFO: PixTest:: pg_setup set to default.
[16:43:10.408] <TB1> INFO: enter test to run
[16:43:10.408] <TB1> INFO: test: no parameter change
[16:43:10.691] <TB1> QUIET: Connection to board 147 closed.
[16:43:10.771] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:43:57.809] <TB1> INFO: *** Welcome to pxar ***
[16:43:57.809] <TB1> INFO: *** Today: 2016/09/27
[16:43:57.885] <TB1> INFO: *** Version: f5d3-dirty
[16:43:57.885] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//dacParameters35_C15.dat
[16:43:57.886] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//tbmParameters_C0b.dat
[16:43:57.886] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//defaultMaskFile.dat
[16:43:57.886] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//trimParameters35_C15.dat
[16:43:57.972] <TB1> INFO: clk: 4
[16:43:57.972] <TB1> INFO: ctr: 4
[16:43:57.972] <TB1> INFO: sda: 19
[16:43:57.972] <TB1> INFO: tin: 9
[16:43:57.972] <TB1> INFO: level: 15
[16:43:57.972] <TB1> INFO: triggerdelay: 0
[16:43:57.972] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:43:57.972] <TB1> INFO: Log level: INFO
[16:43:57.985] <TB1> INFO: Found DTB DTB_WWXTQT
[16:43:57.995] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:43:57.997] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:43:57.999] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:43:59.532] <TB1> INFO: DUT info:
[16:43:59.532] <TB1> INFO: The DUT currently contains the following objects:
[16:43:59.532] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:43:59.532] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:43:59.532] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:43:59.532] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:43:59.532] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.532] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:43:59.933] <TB1> INFO: enter 'restricted' command line mode
[16:43:59.933] <TB1> INFO: enter test to run
[16:43:59.933] <TB1> INFO: test: PixelAlive no parameter change
[16:43:59.933] <TB1> INFO: running: pixelalive
[16:43:59.939] <TB1> INFO: ######################################################################
[16:43:59.939] <TB1> INFO: PixTestAlive::doTest()
[16:43:59.939] <TB1> INFO: ######################################################################
[16:43:59.940] <TB1> INFO: ----------------------------------------------------------------------
[16:43:59.940] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:43:59.940] <TB1> INFO: ----------------------------------------------------------------------
[16:44:00.223] <TB1> INFO: Expecting 208000 events.
[16:44:09.357] <TB1> INFO: 208000 events read in total (8576ms).
[16:44:09.358] <TB1> INFO: Test took 9416ms.
[16:44:09.590] <TB1> INFO: PixTestAlive::aliveTest() done
[16:44:09.590] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:44:09.591] <TB1> INFO: ----------------------------------------------------------------------
[16:44:09.591] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:44:09.591] <TB1> INFO: ----------------------------------------------------------------------
[16:44:09.882] <TB1> INFO: Expecting 208000 events.
[16:44:16.213] <TB1> INFO: 208000 events read in total (5774ms).
[16:44:16.215] <TB1> INFO: Test took 6622ms.
[16:44:16.215] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:44:16.396] <TB1> INFO: PixTestAlive::maskTest() done
[16:44:16.396] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:44:16.397] <TB1> INFO: ----------------------------------------------------------------------
[16:44:16.397] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:44:16.397] <TB1> INFO: ----------------------------------------------------------------------
[16:44:16.679] <TB1> INFO: Expecting 208000 events.
[16:44:25.887] <TB1> INFO: 208000 events read in total (8652ms).
[16:44:25.887] <TB1> INFO: Test took 9489ms.
[16:44:26.086] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:44:26.086] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:44:26.086] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[16:44:26.118] <TB1> INFO: enter test to run
[16:44:26.118] <TB1> INFO: test: delay setting parameters: ->2<-
[16:44:26.118] <TB1> INFO: delay test by 2 seconds...
[16:44:28.118] <TB1> INFO: enter test to run
[16:44:28.118] <TB1> INFO: test: HighRate no parameter change
[16:44:28.118] <TB1> INFO: running: highrate
[16:44:28.118] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[16:44:28.296] <TB1> INFO: ----------------------------------------------------------------------
[16:44:28.296] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:44:28.296] <TB1> INFO: ----------------------------------------------------------------------
[16:44:28.809] <TB1> INFO: Expecting 208000 events.
[16:44:47.260] <TB1> INFO: 208000 events read in total (18050ms).
[16:44:47.271] <TB1> INFO: Test took 18972ms.
[16:44:48.493] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:44:48.493] <TB1> INFO: number of red-efficiency pixels: 802 1058 1075 1957 1991 2895 2403 3131 2782 2411 2360 1852 2082 805 777 719
[16:44:48.493] <TB1> INFO: number of X-ray hits detected: 305925 325449 294481 494799 496805 623765 571694 653981 600761 561891 552947 480788 516609 285810 289178 298980
[16:44:48.493] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:44:48.493] <TB1> INFO: number of Vcal hits detected: 207016 206733 205996 204678 204614 201616 202964 201089 202598 202871 203636 204884 204432 206591 207104 207154
[16:44:48.493] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.4 99.2 98.6 98.6 97.3 97.9 97.0 97.7 97.8 98.2 98.7 98.5 99.5 99.6 99.6
[16:44:48.493] <TB1> INFO: Vcal hit overall efficiency (%): 99.5 99.4 99.0 98.4 98.4 96.9 97.6 96.7 97.4 97.5 97.9 98.5 98.3 99.3 99.6 99.6
[16:44:48.493] <TB1> INFO: X-ray hit rate [MHz/cm2]: 89.7 95.4 86.3 145.0 145.6 182.8 167.6 191.7 176.1 164.7 162.1 140.9 151.4 83.8 84.8 87.6
[16:44:48.493] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:44:48.523] <TB1> INFO: PixTest:: pg_setup set to default.
[16:44:48.537] <TB1> INFO: enter test to run
[16:44:48.537] <TB1> INFO: test: no parameter change
[16:44:48.848] <TB1> QUIET: Connection to board 147 closed.
[16:44:48.929] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:45:35.841] <TB1> INFO: *** Welcome to pxar ***
[16:45:35.841] <TB1> INFO: *** Today: 2016/09/27
[16:45:35.931] <TB1> INFO: *** Version: f5d3-dirty
[16:45:35.931] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//dacParameters35_C15.dat
[16:45:35.933] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//tbmParameters_C0b.dat
[16:45:35.933] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//defaultMaskFile.dat
[16:45:35.933] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//trimParameters35_C15.dat
[16:45:36.012] <TB1> INFO: clk: 4
[16:45:36.012] <TB1> INFO: ctr: 4
[16:45:36.012] <TB1> INFO: sda: 19
[16:45:36.012] <TB1> INFO: tin: 9
[16:45:36.012] <TB1> INFO: level: 15
[16:45:36.012] <TB1> INFO: triggerdelay: 0
[16:45:36.012] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:45:36.012] <TB1> INFO: Log level: INFO
[16:45:36.029] <TB1> INFO: Found DTB DTB_WWXTQT
[16:45:36.039] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:45:36.041] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:45:36.042] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:45:37.582] <TB1> INFO: DUT info:
[16:45:37.582] <TB1> INFO: The DUT currently contains the following objects:
[16:45:37.582] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:45:37.582] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:45:37.582] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:45:37.582] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:45:37.582] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.582] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:45:37.983] <TB1> INFO: enter 'restricted' command line mode
[16:45:37.983] <TB1> INFO: enter test to run
[16:45:37.983] <TB1> INFO: test: PixelAlive no parameter change
[16:45:37.983] <TB1> INFO: running: pixelalive
[16:45:37.987] <TB1> INFO: ######################################################################
[16:45:37.987] <TB1> INFO: PixTestAlive::doTest()
[16:45:37.987] <TB1> INFO: ######################################################################
[16:45:37.988] <TB1> INFO: ----------------------------------------------------------------------
[16:45:37.988] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:45:37.988] <TB1> INFO: ----------------------------------------------------------------------
[16:45:38.251] <TB1> INFO: Expecting 208000 events.
[16:45:47.505] <TB1> INFO: 208000 events read in total (8696ms).
[16:45:47.507] <TB1> INFO: Test took 9518ms.
[16:45:47.731] <TB1> INFO: PixTestAlive::aliveTest() done
[16:45:47.731] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:45:47.732] <TB1> INFO: ----------------------------------------------------------------------
[16:45:47.732] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:45:47.732] <TB1> INFO: ----------------------------------------------------------------------
[16:45:47.989] <TB1> INFO: Expecting 208000 events.
[16:45:54.426] <TB1> INFO: 208000 events read in total (5880ms).
[16:45:54.429] <TB1> INFO: Test took 6695ms.
[16:45:54.429] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:45:54.635] <TB1> INFO: PixTestAlive::maskTest() done
[16:45:54.635] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:45:54.636] <TB1> INFO: ----------------------------------------------------------------------
[16:45:54.636] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:45:54.636] <TB1> INFO: ----------------------------------------------------------------------
[16:45:54.905] <TB1> INFO: Expecting 208000 events.
[16:46:04.267] <TB1> INFO: 208000 events read in total (8806ms).
[16:46:04.267] <TB1> INFO: Test took 9629ms.
[16:46:04.465] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:46:04.465] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:46:04.465] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[16:46:04.497] <TB1> INFO: enter test to run
[16:46:04.497] <TB1> INFO: test: delay setting parameters: ->2<-
[16:46:04.497] <TB1> INFO: delay test by 2 seconds...
[16:46:06.497] <TB1> INFO: enter test to run
[16:46:06.497] <TB1> INFO: test: HighRate no parameter change
[16:46:06.497] <TB1> INFO: running: highrate
[16:46:06.497] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[16:46:06.634] <TB1> INFO: ----------------------------------------------------------------------
[16:46:06.634] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:46:06.634] <TB1> INFO: ----------------------------------------------------------------------
[16:46:07.118] <TB1> INFO: Expecting 208000 events.
[16:46:30.565] <TB1> INFO: 208000 events read in total (23046ms).
[16:46:30.589] <TB1> INFO: Test took 23951ms.
[16:46:32.179] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:46:32.179] <TB1> INFO: number of red-efficiency pixels: 1435 1858 1680 3122 3137 3853 3561 4024 3844 3590 3563 3017 3308 1296 1389 1363
[16:46:32.179] <TB1> INFO: number of X-ray hits detected: 415743 442802 402632 668636 670642 844847 776313 888282 814808 757681 749294 652041 701018 393164 395640 407615
[16:46:32.179] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:46:32.179] <TB1> INFO: number of Vcal hits detected: 205878 205291 203406 200030 199835 192652 195641 190897 194553 195311 197281 200634 199117 204703 206105 206087
[16:46:32.179] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.1 98.8 98.2 96.6 96.6 93.4 94.8 92.4 94.2 94.6 95.4 96.9 96.2 98.7 99.2 99.2
[16:46:32.179] <TB1> INFO: Vcal hit overall efficiency (%): 99.0 98.7 97.8 96.2 96.1 92.6 94.1 91.8 93.5 93.9 94.8 96.5 95.7 98.4 99.1 99.1
[16:46:32.179] <TB1> INFO: X-ray hit rate [MHz/cm2]: 121.9 129.8 118.0 196.0 196.6 247.6 227.5 260.4 238.8 222.1 219.6 191.1 205.5 115.2 116.0 119.5
[16:46:32.179] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:46:32.207] <TB1> INFO: PixTest:: pg_setup set to default.
[16:46:32.219] <TB1> INFO: enter test to run
[16:46:32.219] <TB1> INFO: test: no parameter change
[16:46:32.493] <TB1> QUIET: Connection to board 147 closed.
[16:46:32.573] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:47:15.209] <TB1> INFO: *** Welcome to pxar ***
[16:47:15.209] <TB1> INFO: *** Today: 2016/09/27
[16:47:15.274] <TB1> INFO: *** Version: f5d3-dirty
[16:47:15.274] <TB1> INFO: readRocDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//dacParameters35_C15.dat
[16:47:15.275] <TB1> INFO: readTbmDacs: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//tbmParameters_C0b.dat
[16:47:15.275] <TB1> INFO: readMaskFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//defaultMaskFile.dat
[16:47:15.275] <TB1> INFO: readTrimFile: /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//trimParameters35_C15.dat
[16:47:15.345] <TB1> INFO: clk: 4
[16:47:15.345] <TB1> INFO: ctr: 4
[16:47:15.345] <TB1> INFO: sda: 19
[16:47:15.345] <TB1> INFO: tin: 9
[16:47:15.345] <TB1> INFO: level: 15
[16:47:15.345] <TB1> INFO: triggerdelay: 0
[16:47:15.345] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[16:47:15.345] <TB1> INFO: Log level: INFO
[16:47:15.358] <TB1> INFO: Found DTB DTB_WWXTQT
[16:47:15.367] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[16:47:15.369] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[16:47:15.371] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[16:47:16.936] <TB1> INFO: DUT info:
[16:47:16.936] <TB1> INFO: The DUT currently contains the following objects:
[16:47:16.936] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[16:47:16.936] <TB1> INFO: TBM Core alpha (0): 7 registers set
[16:47:16.936] <TB1> INFO: TBM Core beta (1): 7 registers set
[16:47:16.936] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:47:16.936] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:16.936] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:47:17.337] <TB1> INFO: enter 'restricted' command line mode
[16:47:17.337] <TB1> INFO: enter test to run
[16:47:17.337] <TB1> INFO: test: PixelAlive no parameter change
[16:47:17.337] <TB1> INFO: running: pixelalive
[16:47:17.342] <TB1> INFO: ######################################################################
[16:47:17.342] <TB1> INFO: PixTestAlive::doTest()
[16:47:17.342] <TB1> INFO: ######################################################################
[16:47:17.344] <TB1> INFO: ----------------------------------------------------------------------
[16:47:17.344] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:47:17.344] <TB1> INFO: ----------------------------------------------------------------------
[16:47:17.605] <TB1> INFO: Expecting 208000 events.
[16:47:27.044] <TB1> INFO: 208000 events read in total (8880ms).
[16:47:27.045] <TB1> INFO: Test took 9700ms.
[16:47:27.273] <TB1> INFO: PixTestAlive::aliveTest() done
[16:47:27.273] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:47:27.275] <TB1> INFO: ----------------------------------------------------------------------
[16:47:27.275] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:47:27.275] <TB1> INFO: ----------------------------------------------------------------------
[16:47:27.542] <TB1> INFO: Expecting 208000 events.
[16:47:33.963] <TB1> INFO: 208000 events read in total (5865ms).
[16:47:33.964] <TB1> INFO: Test took 6687ms.
[16:47:33.964] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:47:34.174] <TB1> INFO: PixTestAlive::maskTest() done
[16:47:34.174] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:47:34.175] <TB1> INFO: ----------------------------------------------------------------------
[16:47:34.175] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[16:47:34.175] <TB1> INFO: ----------------------------------------------------------------------
[16:47:34.438] <TB1> INFO: Expecting 208000 events.
[16:47:43.398] <TB1> INFO: 208000 events read in total (8404ms).
[16:47:43.398] <TB1> INFO: Test took 9222ms.
[16:47:43.598] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[16:47:43.598] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:47:43.598] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[16:47:43.630] <TB1> INFO: enter test to run
[16:47:43.630] <TB1> INFO: test: delay setting parameters: ->2<-
[16:47:43.630] <TB1> INFO: delay test by 2 seconds...
[16:47:45.630] <TB1> INFO: enter test to run
[16:47:45.630] <TB1> INFO: test: HighRate no parameter change
[16:47:45.630] <TB1> INFO: running: highrate
[16:47:45.630] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2339_XrayQualification_2016-09-27_17h30m_1474990249//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[16:47:45.776] <TB1> INFO: ----------------------------------------------------------------------
[16:47:45.776] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:47:45.776] <TB1> INFO: ----------------------------------------------------------------------
[16:47:46.295] <TB1> INFO: Expecting 208000 events.
[16:47:50.498] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"

[16:47:50.498] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"

[16:47:50.498] <TB1> ERROR: <datapipe.cc/CheckEventID:L485> Channel 0 Event ID mismatch: local ID (19) != TBM ID (20)

[16:47:50.498] <TB1> ERROR: <datapipe.cc/CheckEventID:L485> Channel 1 Event ID mismatch: local ID (19) != TBM ID (20)

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a017 8040 40e0 9b 28a6 51a 2842 552 244e 651 244c 40e0 52 202e 9b 28af 41c 244d 40c0 5 284d 9b 288d 40e0 9b 28ce 209 206a 302 226d 6e0 206a 6d0 244f 855 262c 85b 2269 e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a011 80c0 40e0 9b 28a1 2c0 2647 71a 2046 40e0 9b 28c2 e1 2263 40c0 18 2825 0 2449 9b 28a6 812 2a69 40c0 9b 28c1 262 244f 412 2886 448 2a6b e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a012 8000 40e0 9b 28ac 160 284e 4c3 2664 40e0 9b 288f 602 264e 40e1 9b 288f 6d1 2842 749 2045 40e1 4a 2a6b e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a013 8040 40c0 9b 28a8 282 2a2a 2c2 2822 4c9 244f 554 284f 60a 284e 40c1 9b 28c1 219 2062 312 2862 41c0 9b 288a 202 244d 41c1 9b 2ffe 41c0 82d 2be8 fc00 dc00

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a014 80b0 40c0 9d 204e 9b 28c6 160 286b 21d 2864 601 244f 40e0 9b 28a2 258 284a 445 246e 6d8 2066 40c0 9b 28a6 11c 2046 41c0 9b 28c0 244 2224 292 2048 704 2a46 860 2265 e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a015 80c0 40e0 9b 28a8 108 262e 108 2a4f 44c 2822 445 2a4a 548 242c 61a 2846 858 240a 40c0 88 2846 88 244b 562 2aa0 40c0 9b 288c 101 264a 714 2a23 41c0 9b 28a8 352 2849 4c1 264a 714 284f e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a016 8000 40e0 60 204c 9b 28c3 94 286a 252 2a62 349 2842 411 286b 40c0 9b 28c2 95 224e 241 288e 2c9 2480 6cc 266b 40e0 9b 2882 298 2a63 68a 2243 40c0 9b 28c8 99 2a68 30c 264d e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a117 8040 40e0 9b 28ac 8b 2664 8c 2a66 15d 2044 15c 2a62 30a 264e 40a 2263 681 2448 6c8 204a 708 2244 850 2842 40c0 9b 28c3 6db 2486 40c0 8 284f 9b 28c6 cb 2487 24a 2882 40c0 9b 288f 2d8 224c 2d8 2681 e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a111 80c0 40e1 50 2a60 5c 2268 9b 288e 30a 2a63 322 2667 858 244e 40c1 9b 28af 95 2062 93 2882 94 228f 2c1 2688 30a 224d 314 2249 499 2282 6ca 2868 40c1 24d 266d 6d3 2468 40e1 354 208a 34b 2083 340 264f 6c8 2a62 6ca 2a4f e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a112 8000 40e0 9b 28a5 442 2883 68c 2a43 6c3 2468 40e0 9b 28cd 291 2062 519 2462 559 224d 854 244d 850 2245 851 2a63 41c1 9b 28ac 2d1 268d 2dd 266d 410 286c 419 2269 422 266e 4da 2866 65d 284e 41c1 20d 2465 21d 226d 24b 2a89 285 2aa2 51d 2a65 6c0 244e 701 286f e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a113 8040 40c0 9b 28a6 692 2062 6d0 204a 842 264a 40e1 10 2444 5b 206f 9b 28c6 90 24ac c0 2663 20a 2a6f 614 266e 748 286f 41c0 77f 277b 93d 227f 72f 27fc 56f 29ef ff1 2e6f 40c1 9b 288f 85 244f db 2084 2d1 2862 2c9 2046 705 2a6d fc00 dc00

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a114 80b0 40c0 22 204f 8 262e 9b 28c2 24b 266e 81b 2a62 840 262f 40e0 9b 28c6 24a 2082 34b 2662 4d5 228b 704 2869 41c0 5d 2667 9b 28a4 d4 2a83 741 226e 40c0 9b 288c 8b 268b 241 2280 285 2082 299 2a8a 2c1 206f 6c3 248a 6ca 2a83 e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a115 80c0 40e0 9b 288e 284 2460 603 2044 70b 244a 703 204c 713 224f 714 2242 822 2849 40c0 9b 28e6 9a 20ab 448 2068 44c 2a66 545 206e 40c0 9b 2889 83 266f 452 288c 55b 2685 814 244a 801 204f 40c0 9b 28a4 2c8 2049 322 24a5 312 2684 419 2068 44d 2084 6c5 2088 6ca 266b e002 c000

[16:47:50.498] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a116 8000 40e0 1c 2228 9b 28a0 99 2a4f 24c 2a66 44d 2486 4d4 2446 54c 242f 861 2262 40e0 9b 28ce 84 2083 415 206f 400 2a68 4c3 2884 4c4 266f 540 284f 548 224e 6d4 2447 41c0 9b 28aa 92 2862 90 2062 9a 2a6d 452 206e 759 2a86 761 2266 40c0 362 2a6a 54c 26a3 e002 c000

[16:47:50.499] <TB1> WARNING: Channel 0 ROC 0: Readback start marker after 15 readouts!

[16:47:50.499] <TB1> WARNING: Channel 0 ROC 1: Readback start marker after 15 readouts!

[16:47:50.499] <TB1> WARNING: Channel 0 ROC 2: Readback start marker after 15 readouts!

[16:47:50.499] <TB1> WARNING: Channel 0 ROC 3: Readback start marker after 15 readouts!

[16:47:50.499] <TB1> WARNING: Channel 1 ROC 0: Readback start marker after 15 readouts!

[16:47:50.499] <TB1> WARNING: Channel 1 ROC 1: Readback start marker after 15 readouts!

[16:47:50.499] <TB1> WARNING: Channel 1 ROC 2: Readback start marker after 15 readouts!

[16:47:50.499] <TB1> WARNING: Channel 1 ROC 3: Readback start marker after 15 readouts!

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a022 8000 40e0 20 244f 60 264a 9b 24af 45d 2862 444 2a2b 50c 2444 740 244c 40e0 9b 24a5 d4 224d 114 2064 24b 2662 40c1 9b 24a5 6c9 2a6e 41e1 a 2043 5 2664 498 284c 4c2 2465 e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01c 80b0 40e1 20 2a28 9b 28a6 483 224f 4dc 2a42 608 2866 6c4 2641 41c1 9b 28af 40c1 9b 288d 98 2843 113 2842 2db 2668 321 2a4e 65b 2069 815 2084 41c1 9b 28af 20d 2a6c 310 244f 302 24a1 305 228a 340 244f 69b 2267 e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01d 80c0 40c0 9b 28a6 54c 2042 685 2441 40c0 9b 28c2 e0 2465 40e0 9b 286f 741 2440 40c0 9b 28c3 84b 226f e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01e 8000 40c0 9b 28c2 11b 2662 35a 226e 362 268f 40c0 9b 28c6 21b 286c 64c 2081 40c0 9b 288d 40c0 9b 28c0 14c 2a6c 20b 2480 54b 2a6a 704 2048 74c 2463 e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01f 8040 40e2 9b 28a0 25c 2845 25c 2a49 6c0 284e 6d0 2648 40e2 9b 28af 680 2440 71c 2a46 75a 2a69 41c2 1d 2229 9b 286f 40e2 9b 28a8 75c 2241 e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a020 80b0 40e0 9b 28a4 213 264a 50c 222e 40e0 9b 28ad 401 2081 4c0 2869 4dd 228e 555 2069 620 204c 61c 284a 40c0 9b 28a2 99 226f 291 2062 49b 226f 40c0 60 2442 9b 28af 693 264d e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a021 80c0 40e0 9b 24c0 40e0 21 244f 9b 24c9 645 246e 6dc 286e 6c1 246a 40c0 9b 24a0 2a2 2463 40e0 9b 24c2 20b 2669 508 2261 e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a122 8000 40e0 9b 24ae 250 2846 642 284b 40c0 9b 24cd 118 266c 449 224f 489 268f 489 2aa2 50b 244e 40e1 9b 24ad d3 248f c2 2a8b c5 2a64 291 286d 29b 2a6e 2c0 266c 34c 2466 681 224e 761 26a5 41c1 9b 24a8 690 204a 68d 2263 e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a11c 80b0 40e1 4b 2464 9d 2466 9b 28af 90 284b 662 2840 40e1 1b 248a 9b 28ee 412 2883 40c1 2d1 2266 702 2062 41c1 9b 28a7 253 246e 493 286a 681 206b e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a11d 80c0 40c0 60 226a 9b 28c0 245 2468 688 2269 699 2a8b 741 2448 40e0 51 2866 50 246f 42 286f 61 226d 9b 28cf 64b 206f 64a 248a 64a 226f 744 226a 759 2664 41c0 59 2086 60 2283 9b 28c1 98 224e 714 2444 40c0 9b 288f 259 246a 408 2262 493 288b e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a11e 8000 40c0 9b 2884 203 2888 641 264f 40c0 9b 28e1 803 204f 40e0 9b 28a0 2da 2489 2cd 2288 310 206f 309 2285 499 2868 561 28a4 710 2067 708 284a 800 264c 808 2a62 40c0 59 286d 9b 28af 80 244f 215 286f 282 2048 29b 22a2 643 224f 751 2245 e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a11f 8040 40e2 59 226d 9b 28a0 219 206f 202 2a62 2c3 284e 320 2a4e 813 2069 40c2 9b 28af 98 246b 93 2085 82 288c 505 2a6e 6c3 2a85 41e2 9b 288a 244 2663 245 2a85 291 2462 41d 224f 69a 2262 74b 2081 740 2645 41c2 48 264f 49 2263 9b 28c3 a1 2a6f 4c8 284f 760 244b e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a120 80b0 40e0 19 2248 9b 28ae 24a 266a 28a 244c 415 286d 40e0 14 2069 9b 28ea 85 2685 40e0 9b 28af 69d 2067 69c 284b 708 2666 40c0 9b 288d e002 c000

[16:47:50.499] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a121 80c0 40e1 9b 248e 253 288a 419 2064 48b 2883 643 244a 643 2043 40e1 15b 268f 294 286a 754 2a63 40e1 55 2866 9b 24ca 14b 286e 2d9 248b 492 2262 613 2068 60d 2664 715 226b 41c1 11 246f 1b 266b 299 24a6 298 2467 285 2288 74d 2a6f e002 c000

[16:48:13.032] <TB1> INFO: 196100 events read in total (26336ms).
[16:48:14.864] <TB1> INFO: 208000 events read in total (28168ms).
[16:48:14.881] <TB1> INFO: Test took 29102ms.
[16:48:16.795] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:48:16.795] <TB1> INFO: number of red-efficiency pixels: 2212 2703 2228 3809 3841 4128 4014 4152 4109 4060 4023 3719 3923 1721 2114 2048
[16:48:16.795] <TB1> INFO: number of X-ray hits detected: 514492 550058 498483 823887 830513 1042901 960192 1093958 1005576 934621 920548 800319 867354 488094 490413 504236
[16:48:16.795] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:48:16.795] <TB1> INFO: number of Vcal hits detected: 204133 202997 199884 193293 192673 179382 185118 176507 183580 184988 188019 194448 191314 201988 204653 204529
[16:48:16.795] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.4 97.8 96.8 93.7 93.5 87.5 90.2 85.8 89.1 90.0 91.4 94.3 92.7 97.7 98.5 98.6
[16:48:16.795] <TB1> INFO: Vcal hit overall efficiency (%): 98.1 97.6 96.1 92.9 92.6 86.2 89.0 84.9 88.3 88.9 90.4 93.5 92.0 97.1 98.4 98.3
[16:48:16.795] <TB1> INFO: X-ray hit rate [MHz/cm2]: 150.8 161.2 146.1 241.5 243.4 305.7 281.4 320.6 294.7 273.9 269.8 234.6 254.2 143.1 143.7 147.8
[16:48:16.795] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[16:48:16.819] <TB1> INFO: PixTest:: pg_setup set to default.
[16:48:16.832] <TB1> INFO: enter test to run
[16:48:16.832] <TB1> INFO: test: no parameter change
[16:48:17.106] <TB1> QUIET: Connection to board 147 closed.
[16:48:17.186] <TB1> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.4-4-g297680c on branch psi46master