Test Date: 2016-09-29 13:35
Analysis date: 2016-09-29 14:53
Logfile
commander_PixelAlive.log
[11:36:13.748] <TB1> INFO: *** Welcome to pxar ***
[11:36:13.748] <TB1> INFO: *** Today: 2016/09/29
[11:36:16.743] <TB1> INFO: *** Version: f5d3-dirty
[11:36:16.743] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//000_PixelAlive_p17//dacParameters35_C15.dat
[11:36:16.744] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//000_PixelAlive_p17//tbmParameters_C0b.dat
[11:36:16.744] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//000_PixelAlive_p17//defaultMaskFile.dat
[11:36:16.744] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//000_PixelAlive_p17//trimParameters35_C15.dat
[11:36:16.813] <TB1> INFO: clk: 4
[11:36:16.813] <TB1> INFO: ctr: 4
[11:36:16.813] <TB1> INFO: sda: 19
[11:36:16.813] <TB1> INFO: tin: 9
[11:36:16.813] <TB1> INFO: level: 15
[11:36:16.813] <TB1> INFO: triggerdelay: 0
[11:36:16.813] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[11:36:16.813] <TB1> INFO: Log level: INFO
[11:36:16.826] <TB1> INFO: Found DTB DTB_WWXTQT
[11:36:16.835] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:36:16.837] <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:
------------------------------------------------------
[11:36:16.839] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[11:36:18.367] <TB1> INFO: DUT info:
[11:36:18.367] <TB1> INFO: The DUT currently contains the following objects:
[11:36:18.367] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:36:18.367] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:36:18.367] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:36:18.367] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:36:18.367] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.367] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.368] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:36:18.768] <TB1> INFO: enter 'restricted' command line mode
[11:36:18.768] <TB1> INFO: enter test to run
[11:36:18.768] <TB1> INFO: test: PixelAlive no parameter change
[11:36:18.768] <TB1> INFO: running: pixelalive
[11:36:18.772] <TB1> INFO: ######################################################################
[11:36:18.772] <TB1> INFO: PixTestAlive::doTest()
[11:36:18.772] <TB1> INFO: ######################################################################
[11:36:18.773] <TB1> INFO: ----------------------------------------------------------------------
[11:36:18.773] <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)
[11:36:18.773] <TB1> INFO: ----------------------------------------------------------------------
[11:36:19.030] <TB1> INFO: Expecting 41600 events.
[11:36:22.230] <TB1> INFO: 41600 events read in total (2643ms).
[11:36:22.270] <TB1> INFO: Test took 3496ms.
[11:36:22.664] <TB1> INFO: PixTestAlive::aliveTest() done
[11:36:22.664] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:36:22.665] <TB1> INFO: ----------------------------------------------------------------------
[11:36:22.665] <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)
[11:36:22.665] <TB1> INFO: ----------------------------------------------------------------------
[11:36:22.957] <TB1> INFO: Expecting 41600 events.
[11:36:25.593] <TB1> INFO: 41600 events read in total (2080ms).
[11:36:25.594] <TB1> INFO: Test took 2927ms.
[11:36:25.595] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:36:25.831] <TB1> INFO: PixTestAlive::maskTest() done
[11:36:25.831] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:36:25.832] <TB1> INFO: ----------------------------------------------------------------------
[11:36:25.832] <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)
[11:36:25.832] <TB1> INFO: ----------------------------------------------------------------------
[11:36:26.095] <TB1> INFO: Expecting 41600 events.
[11:36:29.360] <TB1> INFO: 41600 events read in total (2709ms).
[11:36:29.360] <TB1> INFO: Test took 3527ms.
[11:36:29.584] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:36:29.584] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:36:29.584] <TB1> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[11:36:29.627] <TB1> INFO: enter test to run
[11:36:29.627] <TB1> INFO: test: no parameter change
[11:36:29.761] <TB1> QUIET: Connection to board 147 closed.
[11:36:29.841] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[11:40:53.771] <TB1> INFO: *** Welcome to pxar ***
[11:40:53.771] <TB1> INFO: *** Today: 2016/09/29
[11:40:54.097] <TB1> INFO: *** Version: f5d3-dirty
[11:40:54.097] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//dacParameters35_C15.dat
[11:40:54.097] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[11:40:54.097] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//defaultMaskFile.dat
[11:40:54.097] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C15.dat
[11:40:54.168] <TB1> INFO: clk: 4
[11:40:54.168] <TB1> INFO: ctr: 4
[11:40:54.168] <TB1> INFO: sda: 19
[11:40:54.168] <TB1> INFO: tin: 9
[11:40:54.168] <TB1> INFO: level: 15
[11:40:54.168] <TB1> INFO: triggerdelay: 0
[11:40:54.168] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[11:40:54.168] <TB1> INFO: Log level: INFO
[11:40:54.182] <TB1> INFO: Found DTB DTB_WWXTQT
[11:40:54.190] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:40:54.192] <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:
------------------------------------------------------
[11:40:54.194] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[11:40:55.717] <TB1> INFO: DUT info:
[11:40:55.717] <TB1> INFO: The DUT currently contains the following objects:
[11:40:55.717] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:40:55.717] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:40:55.717] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:40:55.717] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:40:55.717] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:56.118] <TB1> INFO: enter 'restricted' command line mode
[11:40:56.118] <TB1> INFO: enter test to run
[11:40:56.118] <TB1> INFO: test: delay setting parameters: ->5<-
[11:40:56.118] <TB1> INFO: delay test by 5 seconds...
[11:41:01.118] <TB1> INFO: enter test to run
[11:41:01.118] <TB1> INFO: test: highrate no parameter change
[11:41:01.119] <TB1> INFO: running: highrate
[11:41:01.119] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[11:41:01.250] <TB1> INFO: ----------------------------------------------------------------------
[11:41:01.250] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[11:41:01.250] <TB1> INFO: ----------------------------------------------------------------------
[11:41:01.250] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[11:41:01.250] <TB1> INFO: edge/corner pixel THR is adjusted
[11:41:01.250] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[11:41:01.967] <TB1> INFO: Collecting data for 1 seconds...
[11:41:02.968] <TB1> INFO: Done with hot pixel readout
[11:41:07.897] <TB1> INFO: PixTest:: pg_setup set to default.
[11:41:07.899] <TB1> INFO: 0 hot pixels found in step 0
[11:41:07.920] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[11:41:07.948] <TB1> INFO: PixTest::trimHotPixels() done
[11:41:07.948] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C0.dat
[11:41:07.955] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C1.dat
[11:41:07.961] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C2.dat
[11:41:07.967] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C3.dat
[11:41:07.973] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C4.dat
[11:41:07.980] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C5.dat
[11:41:07.986] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C6.dat
[11:41:07.992] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C7.dat
[11:41:07.998] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C8.dat
[11:41:08.005] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C9.dat
[11:41:08.011] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C10.dat
[11:41:08.017] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C11.dat
[11:41:08.023] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C12.dat
[11:41:08.029] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C13.dat
[11:41:08.035] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C14.dat
[11:41:08.041] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C15.dat
[11:41:08.048] <TB1> INFO: write masked pixels into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//defaultMaskFile.dat
[11:41:08.087] <TB1> INFO: enter test to run
[11:41:08.087] <TB1> INFO: test: no parameter change
[11:41:08.619] <TB1> QUIET: Connection to board 147 closed.
[11:41:08.698] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[11:40:53.771] <TB1> INFO: *** Welcome to pxar ***
[11:40:53.771] <TB1> INFO: *** Today: 2016/09/29
[11:40:54.097] <TB1> INFO: *** Version: f5d3-dirty
[11:40:54.097] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//dacParameters35_C15.dat
[11:40:54.097] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[11:40:54.097] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//defaultMaskFile.dat
[11:40:54.097] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C15.dat
[11:40:54.168] <TB1> INFO: clk: 4
[11:40:54.168] <TB1> INFO: ctr: 4
[11:40:54.168] <TB1> INFO: sda: 19
[11:40:54.168] <TB1> INFO: tin: 9
[11:40:54.168] <TB1> INFO: level: 15
[11:40:54.168] <TB1> INFO: triggerdelay: 0
[11:40:54.168] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[11:40:54.168] <TB1> INFO: Log level: INFO
[11:40:54.182] <TB1> INFO: Found DTB DTB_WWXTQT
[11:40:54.190] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:40:54.192] <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:
------------------------------------------------------
[11:40:54.194] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[11:40:55.717] <TB1> INFO: DUT info:
[11:40:55.717] <TB1> INFO: The DUT currently contains the following objects:
[11:40:55.717] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:40:55.717] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:40:55.717] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:40:55.717] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:40:55.717] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:55.717] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:40:56.118] <TB1> INFO: enter 'restricted' command line mode
[11:40:56.118] <TB1> INFO: enter test to run
[11:40:56.118] <TB1> INFO: test: delay setting parameters: ->5<-
[11:40:56.118] <TB1> INFO: delay test by 5 seconds...
[11:41:01.118] <TB1> INFO: enter test to run
[11:41:01.118] <TB1> INFO: test: highrate no parameter change
[11:41:01.119] <TB1> INFO: running: highrate
[11:41:01.119] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[11:41:01.250] <TB1> INFO: ----------------------------------------------------------------------
[11:41:01.250] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[11:41:01.250] <TB1> INFO: ----------------------------------------------------------------------
[11:41:01.250] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[11:41:01.250] <TB1> INFO: edge/corner pixel THR is adjusted
[11:41:01.250] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[11:41:01.967] <TB1> INFO: Collecting data for 1 seconds...
[11:41:02.968] <TB1> INFO: Done with hot pixel readout
[11:41:07.897] <TB1> INFO: PixTest:: pg_setup set to default.
[11:41:07.899] <TB1> INFO: 0 hot pixels found in step 0
[11:41:07.920] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[11:41:07.948] <TB1> INFO: PixTest::trimHotPixels() done
[11:41:07.948] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C0.dat
[11:41:07.955] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C1.dat
[11:41:07.961] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C2.dat
[11:41:07.967] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C3.dat
[11:41:07.973] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C4.dat
[11:41:07.980] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C5.dat
[11:41:07.986] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C6.dat
[11:41:07.992] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C7.dat
[11:41:07.998] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C8.dat
[11:41:08.005] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C9.dat
[11:41:08.011] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C10.dat
[11:41:08.017] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C11.dat
[11:41:08.023] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C12.dat
[11:41:08.029] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C13.dat
[11:41:08.035] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C14.dat
[11:41:08.041] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//trimParameters35_C15.dat
[11:41:08.048] <TB1> INFO: write masked pixels into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//002_RetrimHotPixels_150//defaultMaskFile.dat
[11:41:08.087] <TB1> INFO: enter test to run
[11:41:08.087] <TB1> INFO: test: no parameter change
[11:41:08.619] <TB1> QUIET: Connection to board 147 closed.
[11:41:08.698] <TB1> INFO: pXar: this is the end, my friend
[11:41:30.322] <TB1> INFO: *** Welcome to pxar ***
[11:41:30.322] <TB1> INFO: *** Today: 2016/09/29
[11:41:30.594] <TB1> INFO: *** Version: f5d3-dirty
[11:41:30.594] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//dacParameters35_C15.dat
[11:41:30.594] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[11:41:30.594] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//defaultMaskFile.dat
[11:41:30.594] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C15.dat
[11:41:30.667] <TB1> INFO: clk: 4
[11:41:30.667] <TB1> INFO: ctr: 4
[11:41:30.667] <TB1> INFO: sda: 19
[11:41:30.667] <TB1> INFO: tin: 9
[11:41:30.667] <TB1> INFO: level: 15
[11:41:30.667] <TB1> INFO: triggerdelay: 0
[11:41:30.667] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[11:41:30.667] <TB1> INFO: Log level: INFO
[11:41:30.680] <TB1> INFO: Found DTB DTB_WWXTQT
[11:41:30.689] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:41:30.691] <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:
------------------------------------------------------
[11:41:30.692] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[11:41:32.216] <TB1> INFO: DUT info:
[11:41:32.216] <TB1> INFO: The DUT currently contains the following objects:
[11:41:32.216] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:41:32.216] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:41:32.216] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:41:32.216] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:41:32.216] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.216] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.217] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:41:32.617] <TB1> INFO: enter 'restricted' command line mode
[11:41:32.617] <TB1> INFO: enter test to run
[11:41:32.617] <TB1> INFO: test: delay setting parameters: ->5<-
[11:41:32.617] <TB1> INFO: delay test by 5 seconds...
[11:41:37.618] <TB1> INFO: enter test to run
[11:41:37.618] <TB1> INFO: test: highrate no parameter change
[11:41:37.618] <TB1> INFO: running: highrate
[11:41:37.618] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[11:41:37.749] <TB1> INFO: ----------------------------------------------------------------------
[11:41:37.749] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[11:41:37.749] <TB1> INFO: ----------------------------------------------------------------------
[11:41:37.749] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[11:41:37.749] <TB1> INFO: edge/corner pixel THR is adjusted
[11:41:37.749] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[11:41:38.466] <TB1> INFO: Collecting data for 1 seconds...
[11:41:39.466] <TB1> INFO: Done with hot pixel readout
[11:41:42.456] <TB1> INFO: PixTest:: pg_setup set to default.
[11:41:42.457] <TB1> INFO: 0 hot pixels found in step 0
[11:41:42.465] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[11:41:42.535] <TB1> INFO: PixTest::trimHotPixels() done
[11:41:42.535] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C0.dat
[11:41:42.541] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C1.dat
[11:41:42.547] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C2.dat
[11:41:42.554] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C3.dat
[11:41:42.560] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C4.dat
[11:41:42.566] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C5.dat
[11:41:42.572] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C6.dat
[11:41:42.579] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C7.dat
[11:41:42.585] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C8.dat
[11:41:42.591] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C9.dat
[11:41:42.597] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C10.dat
[11:41:42.603] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C11.dat
[11:41:42.610] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C12.dat
[11:41:42.616] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C13.dat
[11:41:42.622] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C14.dat
[11:41:42.628] <TB1> INFO: write trim parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//trimParameters35_C15.dat
[11:41:42.634] <TB1> INFO: write masked pixels into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//003_RetrimHotPixels_50//defaultMaskFile.dat
[11:41:42.664] <TB1> INFO: enter test to run
[11:41:42.664] <TB1> INFO: test: no parameter change
[11:41:42.913] <TB1> QUIET: Connection to board 147 closed.
[11:41:42.992] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[11:42:06.865] <TB1> INFO: *** Welcome to pxar ***
[11:42:06.865] <TB1> INFO: *** Today: 2016/09/29
[11:42:06.972] <TB1> INFO: *** Version: f5d3-dirty
[11:42:06.972] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//dacParameters35_C15.dat
[11:42:06.972] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//tbmParameters_C0b.dat
[11:42:06.972] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//defaultMaskFile.dat
[11:42:06.972] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//trimParameters35_C15.dat
[11:42:07.041] <TB1> INFO: clk: 4
[11:42:07.041] <TB1> INFO: ctr: 4
[11:42:07.041] <TB1> INFO: sda: 19
[11:42:07.041] <TB1> INFO: tin: 9
[11:42:07.041] <TB1> INFO: level: 15
[11:42:07.041] <TB1> INFO: triggerdelay: 0
[11:42:07.041] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[11:42:07.041] <TB1> INFO: Log level: INFO
[11:42:07.055] <TB1> INFO: Found DTB DTB_WWXTQT
[11:42:07.063] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:42:07.065] <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:
------------------------------------------------------
[11:42:07.067] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[11:42:08.593] <TB1> INFO: DUT info:
[11:42:08.593] <TB1> INFO: The DUT currently contains the following objects:
[11:42:08.593] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:42:08.593] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:42:08.593] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:42:08.593] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:42:08.593] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.593] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:42:08.994] <TB1> INFO: enter 'restricted' command line mode
[11:42:08.994] <TB1> INFO: enter test to run
[11:42:08.994] <TB1> INFO: test: delay setting parameters: ->5<-
[11:42:08.994] <TB1> INFO: delay test by 5 seconds...
[11:42:13.994] <TB1> INFO: enter test to run
[11:42:13.994] <TB1> INFO: test: Xray no parameter change
[11:42:13.994] <TB1> INFO: running: xray
[11:42:13.994] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//004_HRData_50//phCalibrationFitErr35_C15.dat
[11:42:14.123] <TB1> INFO: ######################################################################
[11:42:14.123] <TB1> INFO: PixTestXray::doTest()
[11:42:14.123] <TB1> INFO: ######################################################################
[11:42:14.123] <TB1> INFO: ----------------------------------------------------------------------
[11:42:14.123] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[11:42:14.123] <TB1> INFO: ----------------------------------------------------------------------
[11:42:14.846] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[11:42:22.269] <TB1> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[11:42:47.911] <TB1> INFO: Resuming triggers.
[11:42:55.341] <TB1> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[11:43:21.124] <TB1> INFO: Resuming triggers.
[11:43:28.557] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[11:43:53.458] <TB1> INFO: Resuming triggers.
[11:44:00.894] <TB1> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[11:44:28.804] <TB1> INFO: Resuming triggers.
[11:44:36.238] <TB1> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[11:45:02.371] <TB1> INFO: Resuming triggers.
[11:45:09.804] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[11:45:35.119] <TB1> INFO: Resuming triggers.
[11:45:42.547] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[11:46:06.727] <TB1> INFO: Resuming triggers.
[11:46:14.151] <TB1> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[11:46:38.771] <TB1> INFO: Resuming triggers.
[11:46:46.192] <TB1> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[11:47:10.517] <TB1> INFO: Resuming triggers.
[11:47:17.940] <TB1> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[11:47:42.713] <TB1> INFO: Resuming triggers.
[11:47:50.136] <TB1> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[11:48:13.610] <TB1> INFO: Resuming triggers.
[11:48:21.029] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[11:48:46.308] <TB1> INFO: Resuming triggers.
[11:48:53.731] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[11:49:19.730] <TB1> INFO: Resuming triggers.
[11:49:23.290] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[11:49:34.923] <TB1> INFO: PixTest:: pg_setup set to default.
[11:49:34.925] <TB1> INFO: PixTestXray::doPhRun() done
[11:49:34.925] <TB1> INFO: PixTestXray::doTest() done
[11:49:35.112] <TB1> INFO: enter test to run
[11:49:35.112] <TB1> INFO: test: no parameter change
[11:49:35.381] <TB1> QUIET: Connection to board 147 closed.
[11:49:35.460] <TB1> INFO: pXar: this is the end, my friend
commander_HRData.log
[11:49:57.305] <TB1> INFO: *** Welcome to pxar ***
[11:49:57.305] <TB1> INFO: *** Today: 2016/09/29
[11:49:57.895] <TB1> INFO: *** Version: f5d3-dirty
[11:49:57.895] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//dacParameters35_C15.dat
[11:49:57.895] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//tbmParameters_C0b.dat
[11:49:57.896] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//defaultMaskFile.dat
[11:49:57.896] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//trimParameters35_C15.dat
[11:49:57.964] <TB1> INFO: clk: 4
[11:49:57.964] <TB1> INFO: ctr: 4
[11:49:57.964] <TB1> INFO: sda: 19
[11:49:57.964] <TB1> INFO: tin: 9
[11:49:57.964] <TB1> INFO: level: 15
[11:49:57.964] <TB1> INFO: triggerdelay: 0
[11:49:57.964] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[11:49:57.964] <TB1> INFO: Log level: INFO
[11:49:57.978] <TB1> INFO: Found DTB DTB_WWXTQT
[11:49:57.987] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:49:57.989] <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:
------------------------------------------------------
[11:49:57.990] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[11:49:59.519] <TB1> INFO: DUT info:
[11:49:59.519] <TB1> INFO: The DUT currently contains the following objects:
[11:49:59.519] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:49:59.519] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:49:59.519] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:49:59.519] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:49:59.519] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.519] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:59.920] <TB1> INFO: enter 'restricted' command line mode
[11:49:59.920] <TB1> INFO: enter test to run
[11:49:59.920] <TB1> INFO: test: delay setting parameters: ->5<-
[11:49:59.920] <TB1> INFO: delay test by 5 seconds...
[11:50:04.920] <TB1> INFO: enter test to run
[11:50:04.921] <TB1> INFO: test: Xray no parameter change
[11:50:04.921] <TB1> INFO: running: xray
[11:50:04.922] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//005_HRData_150//phCalibrationFitErr35_C15.dat
[11:50:05.050] <TB1> INFO: ######################################################################
[11:50:05.050] <TB1> INFO: PixTestXray::doTest()
[11:50:05.050] <TB1> INFO: ######################################################################
[11:50:05.050] <TB1> INFO: ----------------------------------------------------------------------
[11:50:05.050] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[11:50:05.050] <TB1> INFO: ----------------------------------------------------------------------
[11:50:05.774] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[11:50:09.827] <TB1> INFO: run duration 4 seconds, buffer almost full (81%), pausing triggers.
[11:50:34.807] <TB1> INFO: Resuming triggers.
[11:50:38.865] <TB1> INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[11:51:04.730] <TB1> INFO: Resuming triggers.
[11:51:08.792] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[11:51:32.770] <TB1> INFO: Resuming triggers.
[11:51:36.829] <TB1> INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[11:52:02.117] <TB1> INFO: Resuming triggers.
[11:52:06.173] <TB1> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[11:52:32.810] <TB1> INFO: Resuming triggers.
[11:52:36.868] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[11:53:01.612] <TB1> INFO: Resuming triggers.
[11:53:05.667] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[11:53:31.399] <TB1> INFO: Resuming triggers.
[11:53:35.455] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[11:54:01.397] <TB1> INFO: Resuming triggers.
[11:54:05.452] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[11:54:32.139] <TB1> INFO: Resuming triggers.
[11:54:36.193] <TB1> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[11:55:01.406] <TB1> INFO: Resuming triggers.
[11:55:05.459] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[11:55:31.608] <TB1> INFO: Resuming triggers.
[11:55:35.659] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[11:56:01.211] <TB1> INFO: Resuming triggers.
[11:56:05.261] <TB1> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[11:56:30.849] <TB1> INFO: Resuming triggers.
[11:56:34.904] <TB1> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[11:57:01.694] <TB1> INFO: Resuming triggers.
[11:57:05.743] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[11:57:30.410] <TB1> INFO: Resuming triggers.
[11:57:34.461] <TB1> INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[11:57:59.024] <TB1> INFO: Resuming triggers.
[11:58:03.073] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[11:58:28.490] <TB1> INFO: Resuming triggers.
[11:58:32.539] <TB1> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[11:58:58.411] <TB1> INFO: Resuming triggers.
[11:59:02.459] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[11:59:12.847] <TB1> WARNING: Channel 2 ROC 3: Readback start marker after 14 readouts!

[11:59:12.847] <TB1> ERROR: <datapipe.cc/CheckEventValidity:L523> Channel 2 Number of ROCs (5) != Token Chain Length (4)

[11:59:12.847] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[11:59:12.847] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a20f 8041 41e2 31b 204f 320 2a4f 402 2664 4da 284c 520 2845 652 2240 6d5 204f 41c2 60c 2029 41c2 cc 2646 2d8 2a88 61c 204f 859 2062 41c1 18 2848 b 246f e000 c000

[11:59:12.847] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a209 80c1 40e0 ca 264f ca 2a6a 2c2 244a 2c0 264b 4dc 2646 61a 2460 41c0 6ca 2062 6c0 240f 41c0 2d1 286d 855 2883 41c1 e000 c000

[11:59:12.847] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a20a 8001 40c0 92 2064 104 244a 41c0 83 2862 41c0 202 264a 2ca 2a89 30d 288c 558 244a 698 2264 41c0 48 2226 4d9 264e 709 202f 812 20a3 e000 c000

[11:59:12.847] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a20b 8041 40e0 145 244c 28c 2040 605 2460 40c0 21c 2640 31c 2829 349 264f 64a 2447 6db 2a4a 41c0 55c 244a 709 224f 41c0 1d 2047 e000 c000

[11:59:12.847] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a20c 80b1 40e0 211 264e 41c0 c0 262a 45a 2a4f 690 2242 71d 2440 752 284e 40c0 40c3 840 2390 da1 2435 108 20b0 da8 2988 c2e 2b29 40c0 e000 c000

[11:59:12.847] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a20d 80c1 40c0 618 2227 40e0 54a 2040 40c0 202 2863 349 206d 341 2a4e 484 224f 509 246a 41e1 e000 c000

[11:59:12.847] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a20e 8001 40c0 31d 2240 511 244a 41c0 41c0 dd 2868 cc 242f 559 224f 41c2 2db 2a66 4c1 2649 708 2a2b e000 c000

[11:59:27.041] <TB1> INFO: Resuming triggers.
[11:59:31.089] <TB1> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[11:59:57.990] <TB1> INFO: Resuming triggers.
[12:00:02.039] <TB1> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[12:00:27.223] <TB1> INFO: Resuming triggers.
[12:00:31.270] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[12:00:56.170] <TB1> INFO: Resuming triggers.
[12:01:00.218] <TB1> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[12:01:27.268] <TB1> INFO: Resuming triggers.
[12:01:31.314] <TB1> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[12:01:56.632] <TB1> INFO: Resuming triggers.
[12:01:59.468] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[12:02:17.027] <TB1> INFO: PixTest:: pg_setup set to default.
[12:02:17.028] <TB1> INFO: PixTestXray::doPhRun() done
[12:02:17.028] <TB1> INFO: PixTestXray::doTest() done
[12:02:17.234] <TB1> INFO: enter test to run
[12:02:17.235] <TB1> INFO: test: no parameter change
[12:02:17.535] <TB1> QUIET: Connection to board 147 closed.
[12:02:17.614] <TB1> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[12:02:41.936] <TB1> INFO: *** Welcome to pxar ***
[12:02:41.936] <TB1> INFO: *** Today: 2016/09/29
[12:02:42.301] <TB1> INFO: *** Version: f5d3-dirty
[12:02:42.301] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//dacParameters35_C15.dat
[12:02:42.302] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//tbmParameters_C0b.dat
[12:02:42.302] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//defaultMaskFile.dat
[12:02:42.302] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//trimParameters35_C15.dat
[12:02:42.376] <TB1> INFO: clk: 4
[12:02:42.376] <TB1> INFO: ctr: 4
[12:02:42.376] <TB1> INFO: sda: 19
[12:02:42.376] <TB1> INFO: tin: 9
[12:02:42.376] <TB1> INFO: level: 15
[12:02:42.376] <TB1> INFO: triggerdelay: 0
[12:02:42.376] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:02:42.376] <TB1> INFO: Log level: INFO
[12:02:42.390] <TB1> INFO: Found DTB DTB_WWXTQT
[12:02:42.398] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:02:42.400] <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:
------------------------------------------------------
[12:02:42.402] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:02:43.929] <TB1> INFO: DUT info:
[12:02:43.929] <TB1> INFO: The DUT currently contains the following objects:
[12:02:43.929] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:02:43.929] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:02:43.929] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:02:43.929] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:02:43.929] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:43.929] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:02:44.330] <TB1> INFO: enter 'restricted' command line mode
[12:02:44.330] <TB1> INFO: enter test to run
[12:02:44.330] <TB1> INFO: test: Highrate no parameter change
[12:02:44.330] <TB1> INFO: running: highrate
[12:02:44.330] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[12:02:44.457] <TB1> INFO: ----------------------------------------------------------------------
[12:02:44.457] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[12:02:44.457] <TB1> INFO: ----------------------------------------------------------------------
[12:02:44.462] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[12:02:44.473] <TB1> INFO: dacScan step from 15 .. 34
[12:02:44.473] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[12:02:44.473] <TB1> INFO: run 1 of 1
[12:02:44.947] <TB1> INFO: Expecting 4160000 events.
[12:03:11.308] <TB1> INFO: 448000 events read in total (25957ms).
[12:03:36.617] <TB1> INFO: 898150 events read in total (51266ms).
[12:04:03.005] <TB1> INFO: 1348250 events read in total (77654ms).
[12:04:29.151] <TB1> INFO: 1797750 events read in total (103800ms).
[12:04:54.865] <TB1> INFO: 2246950 events read in total (129514ms).
[12:05:19.552] <TB1> INFO: 2696250 events read in total (154201ms).
[12:05:44.514] <TB1> INFO: 3145350 events read in total (179163ms).
[12:06:10.008] <TB1> INFO: 3594350 events read in total (204657ms).
[12:06:34.569] <TB1> INFO: 4043100 events read in total (229218ms).
[12:06:41.168] <TB1> INFO: 4160000 events read in total (235817ms).
[12:06:41.462] <TB1> INFO: Test took 236988ms.
[12:06:49.213] <TB1> INFO: dacScan step from 35 .. 54
[12:06:49.213] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[12:06:49.213] <TB1> INFO: run 1 of 1
[12:06:49.692] <TB1> INFO: Expecting 4160000 events.
[12:07:14.627] <TB1> INFO: 381000 events read in total (24534ms).
[12:07:38.896] <TB1> INFO: 763000 events read in total (48803ms).
[12:08:04.435] <TB1> INFO: 1143800 events read in total (74342ms).
[12:08:28.967] <TB1> INFO: 1524000 events read in total (98874ms).
[12:08:54.488] <TB1> INFO: 1902700 events read in total (124395ms).
[12:09:18.268] <TB1> INFO: 2279400 events read in total (148176ms).
[12:09:42.439] <TB1> INFO: 2653700 events read in total (172346ms).
[12:10:07.578] <TB1> INFO: 3024700 events read in total (197485ms).
[12:10:32.398] <TB1> INFO: 3392800 events read in total (222305ms).
[12:10:57.061] <TB1> INFO: 3758650 events read in total (246968ms).
[12:11:21.480] <TB1> INFO: 4124300 events read in total (271387ms).
[12:11:23.947] <TB1> INFO: 4160000 events read in total (273854ms).
[12:11:24.127] <TB1> INFO: Test took 274913ms.
[12:11:32.939] <TB1> INFO: dacScan step from 55 .. 74
[12:11:32.939] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[12:11:32.939] <TB1> INFO: run 1 of 1
[12:11:33.419] <TB1> INFO: Expecting 4160000 events.
[12:11:56.726] <TB1> INFO: 334250 events read in total (22906ms).
[12:12:19.499] <TB1> INFO: 668850 events read in total (45679ms).
[12:12:42.322] <TB1> INFO: 1003550 events read in total (68502ms).
[12:13:05.961] <TB1> INFO: 1338200 events read in total (92141ms).
[12:13:30.081] <TB1> INFO: 1672950 events read in total (116261ms).
[12:13:52.991] <TB1> INFO: 2007450 events read in total (139171ms).
[12:14:16.306] <TB1> INFO: 2342150 events read in total (162486ms).
[12:14:41.036] <TB1> INFO: 2676500 events read in total (187216ms).
[12:15:05.013] <TB1> INFO: 3010750 events read in total (211193ms).
[12:15:28.811] <TB1> INFO: 3345000 events read in total (234991ms).
[12:15:53.273] <TB1> INFO: 3679300 events read in total (259453ms).
[12:16:16.235] <TB1> INFO: 4013500 events read in total (282415ms).
[12:16:26.547] <TB1> INFO: 4160000 events read in total (292727ms).
[12:16:26.709] <TB1> INFO: Test took 293770ms.
[12:16:34.459] <TB1> INFO: dacScan step from 75 .. 75
[12:16:34.459] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[12:16:34.469] <TB1> INFO: run 1 of 1
[12:16:34.955] <TB1> INFO: Expecting 208000 events.
[12:16:50.940] <TB1> INFO: 208000 events read in total (15583ms).
[12:16:50.947] <TB1> INFO: Test took 16477ms.
[12:16:51.304] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:16:52.647] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:16:53.707] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:16:54.763] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:16:55.840] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:16:56.903] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:16:57.947] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:16:58.999] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:00.240] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:01.642] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:02.812] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:03.895] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:04.956] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:05.991] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:06.998] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:08.021] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[12:17:09.040] <TB1> INFO: PixTest:: pg_setup set to default.
[12:17:09.042] <TB1> INFO: vcal mean: 38.09 38.71 38.18 41.71 41.61 42.03 42.39 44.12 41.51 42.01 42.42 41.19 40.63 38.95 38.72 38.18
[12:17:09.042] <TB1> INFO: vcal RMS: 1.10 1.12 0.94 1.50 1.25 1.35 1.39 1.56 1.43 1.40 1.45 1.52 1.24 1.23 1.01 1.01
[12:17:09.042] <TB1> INFO: number of X-ray hits detected: 192367 207390 195445 348365 349792 407591 407547 470699 398793 384538 403854 346384 326657 201497 216713 199516
[12:17:09.042] <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
[12:17:09.042] <TB1> INFO: X-ray hit rate [MHz/cm2]: 56.4 60.8 57.3 102.1 102.5 119.5 119.5 138.0 116.9 112.7 118.4 101.5 95.7 59.1 63.5 58.5
[12:17:09.042] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[12:17:09.180] <TB1> INFO: enter test to run
[12:17:09.180] <TB1> INFO: test: no parameter change
[12:17:09.396] <TB1> QUIET: Connection to board 147 closed.
[12:17:09.500] <TB1> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[12:34:54.395] <TB1> INFO: *** Welcome to pxar ***
[12:34:54.395] <TB1> INFO: *** Today: 2016/09/29
[12:34:54.757] <TB1> INFO: *** Version: f5d3-dirty
[12:34:54.757] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[12:34:54.758] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[12:34:54.758] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[12:34:54.758] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[12:34:54.829] <TB1> INFO: clk: 4
[12:34:54.829] <TB1> INFO: ctr: 4
[12:34:54.829] <TB1> INFO: sda: 19
[12:34:54.829] <TB1> INFO: tin: 9
[12:34:54.829] <TB1> INFO: level: 15
[12:34:54.829] <TB1> INFO: triggerdelay: 0
[12:34:54.829] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:34:54.829] <TB1> INFO: Log level: INFO
[12:34:54.843] <TB1> INFO: Found DTB DTB_WWXTQT
[12:34:54.852] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:34:54.854] <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:
------------------------------------------------------
[12:34:54.855] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:34:56.384] <TB1> INFO: DUT info:
[12:34:56.384] <TB1> INFO: The DUT currently contains the following objects:
[12:34:56.384] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:34:56.384] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:34:56.384] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:34:56.384] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:34:56.384] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.384] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:56.785] <TB1> INFO: enter 'restricted' command line mode
[12:34:56.785] <TB1> INFO: enter test to run
[12:34:56.785] <TB1> INFO: test: HighRate no parameter change
[12:34:56.785] <TB1> INFO: running: highrate
[12:34:56.785] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[12:34:56.915] <TB1> INFO: ----------------------------------------------------------------------
[12:34:56.915] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[12:34:56.915] <TB1> INFO: ----------------------------------------------------------------------
[12:34:57.010] <TB1> INFO: Expecting 768 events.
[12:34:57.999] <TB1> INFO: 768 events read in total (431ms).
[12:34:58.063] <TB1> INFO: Test took 1143ms.
[12:34:58.541] <TB1> INFO: Expecting 41600 events.
[12:35:01.286] <TB1> INFO: 41600 events read in total (2343ms).
[12:35:01.288] <TB1> INFO: Test took 3222ms.
[12:35:01.868] <TB1> INFO: Expecting 41600 events.
[12:35:04.705] <TB1> INFO: 41600 events read in total (2436ms).
[12:35:04.707] <TB1> INFO: Test took 3314ms.
[12:35:05.297] <TB1> INFO: Expecting 41600 events.
[12:35:08.509] <TB1> INFO: 41600 events read in total (2810ms).
[12:35:08.511] <TB1> INFO: Test took 3696ms.
[12:35:09.098] <TB1> INFO: Expecting 41600 events.
[12:35:12.173] <TB1> INFO: 41600 events read in total (2674ms).
[12:35:12.175] <TB1> INFO: Test took 3555ms.
[12:35:12.763] <TB1> INFO: Expecting 41600 events.
[12:35:15.708] <TB1> INFO: 41600 events read in total (2544ms).
[12:35:15.710] <TB1> INFO: Test took 3426ms.
[12:35:16.294] <TB1> INFO: Expecting 41600 events.
[12:35:17.669] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"

[12:35:17.670] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"

[12:35:17.670] <TB1> ERROR: <datapipe.cc/CheckEventID:L485> Channel 2 Event ID mismatch: local ID (126) != TBM ID (127)

[12:35:17.670] <TB1> WARNING: Channel 2 ROC 0: Readback start marker after 15 readouts!

[12:35:17.670] <TB1> WARNING: Channel 2 ROC 1: Readback start marker after 15 readouts!

[12:35:17.670] <TB1> WARNING: Channel 2 ROC 2: Readback start marker after 15 readouts!

[12:35:17.670] <TB1> ERROR: <datapipe.cc/CheckEventID:L485> Channel 3 Event ID mismatch: local ID (126) != TBM ID (127)

[12:35:17.670] <TB1> WARNING: Channel 3 ROC 0: Readback start marker after 15 readouts!

[12:35:17.670] <TB1> WARNING: Channel 3 ROC 1: Readback start marker after 15 readouts!

[12:35:17.670] <TB1> WARNING: Channel 3 ROC 2: Readback start marker after 15 readouts!

[12:35:17.670] <TB1> WARNING: Channel 3 ROC 3: Readback start marker after 15 readouts!

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a282 8001 40e0 151 22a8 40c0 151 228c 74d 2247 40e1 151 22ad 41c0 151 2288 559 284b e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a27c 80b1 40e0 4c 2442 151 22aa 41c0 b 2840 d 2a45 151 228c 41e0 151 22af 28c 2449 40c0 4b 204d 151 2288 354 224f 542 284f e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a27d 80c1 40c1 151 22a8 41e0 151 228d 162 2648 745 204e 40c1 1a 2862 14d 206c 14c 2886 151 22c3 41c3 15c 2040 151 228f e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a27e 8001 40e1 15b 286a 151 22a6 41b 2286 41c0 151 2283 84d 262e 653 2bfb 800 2000 688 27f9 151 2287 680 282f fc00 dc00

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a27f 8041 40e3 151 22ae 40c3 151 228a 4d3 2a2f 719 2449 40e3 82 2a6d 151 22c5 202 224f 41c0 151 2285 6cb 2681 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a280 80b1 40e1 151 22a8 620 244e 41c1 151 2285 742 246a 41c1 5c 244f 151 22c2 2d0 2465 40e1 151 228a 291 2461 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a281 80c1 40e0 151 22a5 40e0 51 2662 151 2289 41e0 151 22c0 41e1 151 228e 445 224f e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a382 8000 40e0 151 228e 848 204b 40c0 151 22c4 35c 202d 41c1 151 228a 41c1 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a37c 80b0 40e0 151 228e 41e0 151 22af 41c1 151 2288 41e0 151 2283 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a37d 80c0 40c0 151 228f 501 2a4e 41c0 151 22af 40c1 151 2286 522 2865 41e0 151 2281 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a37e 8000 40e0 151 22a4 31d 2061 41c0 151 22ad 41c1 151 2283 41c1 5 2de5 aad 2353 fc00 dc00

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a37f 8040 40e2 c 2a4a 151 228a 41c3 c3 224f 151 22c1 40e3 151 2288 40e2 151 2283 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a380 80b0 40e1 151 228f 600 2642 41c1 151 22af 40c1 151 228a 2cd 2868 514 2a46 41c1 151 2280 692 2443 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a381 80c0 40e1 151 228c 2cc 2243 4c3 2460 55b 2260 41e1 c5 204a 151 22af 40e1 151 2288 41e1 151 2285 e002 c000

[12:35:17.670] <TB1> WARNING: Channel 2 ROC 3: Readback start marker after 15 readouts!

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a290 80b1 40e1 150 2684 41c1 a 2040 8 202f 150 2686 41c1 150 26a4 505 244f 41c1 18 264f 150 268d 25b 2068 354 2665 413 224f e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a28a 8001 40e0 150 2a82 40e0 150 2a6c 41e0 150 2aa9 40c1 44 2207 150 2a82 801 2a69 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a28b 8041 40e0 150 2a8c 253 2aa0 41c0 1d 2426 18 2849 150 2a80 543 2446 850 2042 40e0 93 2488 150 2ac1 855 264a 40c0 150 2a6f e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a28c 80b1 40e0 4c 202a 150 2a8f 50c 262e 510 2a2a 60b 2042 40e0 150 2a6e 209 2a28 441 222f 6cc 2a22 759 264c 40c0 150 2aa9 698 2862 41e0 150 2a81 205 2829 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a28d 80c1 41e1 158 244f 150 2aa1 34b 264a 861 224f 40e0 15a 284c 150 2a85 682 2a22 40c1 15 266a 150 2ac1 40c3 150 2a6f 49a 244a 699 2a4d e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a28e 8001 40e1 110 2446 150 2a8c 445 2065 40e0 150 2a65 480 2642 4da 242e 40e1 109 282f 150 2aa7 28c 286f 281 2a4a 40e1 150 2a6f 299 284f 754 2065 e002 c000

[12:35:17.670] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a28f 8041 40c3 150 268c 4c1 284a 40e3 150 266d 41e3 150 26af 41c0 150 266d e002 c000

[12:35:19.327] <TB1> INFO: 41600 events read in total (2631ms).
[12:35:19.330] <TB1> INFO: Test took 3513ms.
[12:35:19.923] <TB1> INFO: Expecting 41600 events.
[12:35:22.925] <TB1> INFO: 41600 events read in total (2600ms).
[12:35:22.928] <TB1> INFO: Test took 3481ms.
[12:35:23.514] <TB1> INFO: Expecting 41600 events.
[12:35:26.459] <TB1> INFO: 41600 events read in total (2543ms).
[12:35:26.462] <TB1> INFO: Test took 3423ms.
[12:35:27.082] <TB1> INFO: Expecting 41600 events.
[12:35:30.354] <TB1> INFO: 41600 events read in total (2870ms).
[12:35:30.356] <TB1> INFO: Test took 3763ms.
[12:35:30.948] <TB1> INFO: Expecting 41600 events.
[12:35:33.851] <TB1> INFO: 41600 events read in total (2501ms).
[12:35:33.853] <TB1> INFO: Test took 3386ms.
[12:35:34.437] <TB1> INFO: Expecting 41600 events.
[12:35:37.370] <TB1> INFO: 41600 events read in total (2531ms).
[12:35:37.372] <TB1> INFO: Test took 3412ms.
[12:35:37.959] <TB1> INFO: Expecting 41600 events.
[12:35:40.913] <TB1> INFO: 41600 events read in total (2552ms).
[12:35:40.915] <TB1> INFO: Test took 3434ms.
[12:35:41.500] <TB1> INFO: Expecting 41600 events.
[12:35:44.553] <TB1> INFO: 41600 events read in total (2651ms).
[12:35:44.555] <TB1> INFO: Test took 3533ms.
[12:35:45.143] <TB1> INFO: Expecting 41600 events.
[12:35:48.073] <TB1> INFO: 41600 events read in total (2528ms).
[12:35:48.076] <TB1> INFO: Test took 3411ms.
[12:35:48.697] <TB1> INFO: Expecting 41600 events.
[12:35:51.870] <TB1> INFO: 41600 events read in total (2772ms).
[12:35:51.872] <TB1> INFO: Test took 3671ms.
[12:35:52.494] <TB1> INFO: Expecting 41600 events.
[12:35:55.455] <TB1> INFO: 41600 events read in total (2559ms).
[12:35:55.457] <TB1> INFO: Test took 3464ms.
[12:35:56.044] <TB1> INFO: Expecting 41600 events.
[12:35:58.987] <TB1> INFO: 41600 events read in total (2541ms).
[12:35:58.990] <TB1> INFO: Test took 3423ms.
[12:35:59.598] <TB1> INFO: Expecting 41600 events.
[12:36:02.616] <TB1> INFO: 41600 events read in total (2616ms).
[12:36:02.618] <TB1> INFO: Test took 3502ms.
[12:36:03.213] <TB1> INFO: Expecting 41600 events.
[12:36:06.154] <TB1> INFO: 41600 events read in total (2539ms).
[12:36:06.156] <TB1> INFO: Test took 3423ms.
[12:36:06.748] <TB1> INFO: Expecting 41600 events.
[12:36:09.759] <TB1> INFO: 41600 events read in total (2610ms).
[12:36:09.762] <TB1> INFO: Test took 3496ms.
[12:36:10.159] <TB1> INFO: enter test to run
[12:36:10.159] <TB1> INFO: test: Pretest no parameter change
[12:36:10.159] <TB1> INFO: running: pretest
[12:36:10.159] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[12:36:10.159] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[12:36:10.159] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[12:36:10.159] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[12:36:10.159] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[12:36:10.160] <TB1> INFO: write dac parameters into /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[12:36:10.161] <TB1> INFO: enter test to run
[12:36:10.161] <TB1> INFO: test: no parameter change
[12:36:10.437] <TB1> QUIET: Connection to board 147 closed.
[12:36:10.517] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:36:30.437] <TB1> INFO: *** Welcome to pxar ***
[12:36:30.438] <TB1> INFO: *** Today: 2016/09/29
[12:36:30.797] <TB1> INFO: *** Version: f5d3-dirty
[12:36:30.797] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//dacParameters35_C15.dat
[12:36:30.798] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//tbmParameters_C0b.dat
[12:36:30.798] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//defaultMaskFile.dat
[12:36:30.798] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//trimParameters35_C15.dat
[12:36:30.866] <TB1> INFO: clk: 4
[12:36:30.866] <TB1> INFO: ctr: 4
[12:36:30.866] <TB1> INFO: sda: 19
[12:36:30.866] <TB1> INFO: tin: 9
[12:36:30.866] <TB1> INFO: level: 15
[12:36:30.866] <TB1> INFO: triggerdelay: 0
[12:36:30.866] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:36:30.866] <TB1> INFO: Log level: INFO
[12:36:30.880] <TB1> INFO: Found DTB DTB_WWXTQT
[12:36:30.888] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:36:30.890] <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:
------------------------------------------------------
[12:36:30.892] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:36:32.417] <TB1> INFO: DUT info:
[12:36:32.417] <TB1> INFO: The DUT currently contains the following objects:
[12:36:32.417] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:36:32.417] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:36:32.417] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:36:32.417] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:36:32.417] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.417] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:32.818] <TB1> INFO: enter 'restricted' command line mode
[12:36:32.818] <TB1> INFO: enter test to run
[12:36:32.818] <TB1> INFO: test: PixelAlive no parameter change
[12:36:32.818] <TB1> INFO: running: pixelalive
[12:36:32.821] <TB1> INFO: ######################################################################
[12:36:32.821] <TB1> INFO: PixTestAlive::doTest()
[12:36:32.821] <TB1> INFO: ######################################################################
[12:36:32.822] <TB1> INFO: ----------------------------------------------------------------------
[12:36:32.822] <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)
[12:36:32.822] <TB1> INFO: ----------------------------------------------------------------------
[12:36:33.077] <TB1> INFO: Expecting 208000 events.
[12:36:42.204] <TB1> INFO: 208000 events read in total (8568ms).
[12:36:42.206] <TB1> INFO: Test took 9382ms.
[12:36:42.440] <TB1> INFO: PixTestAlive::aliveTest() done
[12:36:42.440] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:36:42.441] <TB1> INFO: ----------------------------------------------------------------------
[12:36:42.441] <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)
[12:36:42.441] <TB1> INFO: ----------------------------------------------------------------------
[12:36:42.723] <TB1> INFO: Expecting 208000 events.
[12:36:49.405] <TB1> INFO: 208000 events read in total (6126ms).
[12:36:49.408] <TB1> INFO: Test took 6965ms.
[12:36:49.408] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:36:49.603] <TB1> INFO: PixTestAlive::maskTest() done
[12:36:49.603] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:36:49.604] <TB1> INFO: ----------------------------------------------------------------------
[12:36:49.604] <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)
[12:36:49.604] <TB1> INFO: ----------------------------------------------------------------------
[12:36:49.882] <TB1> INFO: Expecting 208000 events.
[12:36:59.207] <TB1> INFO: 208000 events read in total (8769ms).
[12:36:59.208] <TB1> INFO: Test took 9602ms.
[12:36:59.408] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:36:59.408] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:36:59.408] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[12:36:59.438] <TB1> INFO: enter test to run
[12:36:59.438] <TB1> INFO: test: delay setting parameters: ->2<-
[12:36:59.438] <TB1> INFO: delay test by 2 seconds...
[12:37:01.438] <TB1> INFO: enter test to run
[12:37:01.438] <TB1> INFO: test: HighRate no parameter change
[12:37:01.438] <TB1> INFO: running: highrate
[12:37:01.438] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[12:37:01.575] <TB1> INFO: ----------------------------------------------------------------------
[12:37:01.575] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:37:01.575] <TB1> INFO: ----------------------------------------------------------------------
[12:37:02.076] <TB1> INFO: Expecting 208000 events.
[12:37:14.482] <TB1> INFO: 208000 events read in total (12005ms).
[12:37:14.489] <TB1> INFO: Test took 12911ms.
[12:37:15.033] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:37:15.033] <TB1> INFO: number of red-efficiency pixels: 133 130 140 320 279 353 340 530 326 307 347 285 242 166 144 136
[12:37:15.033] <TB1> INFO: number of X-ray hits detected: 94635 101501 94617 172673 174529 203718 203282 234535 198588 189527 202195 172171 161612 97417 106790 98072
[12:37:15.033] <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
[12:37:15.033] <TB1> INFO: number of Vcal hits detected: 207864 207866 207857 207664 207704 207617 207638 207428 207664 207675 207637 207703 207753 207827 207853 207862
[12:37:15.033] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.9 99.8 99.8 99.7 99.9 99.9 99.8 99.9 99.9 99.9 99.9 99.9
[12:37:15.033] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.9 99.8 99.8 99.7 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[12:37:15.033] <TB1> INFO: X-ray hit rate [MHz/cm2]: 27.7 29.8 27.7 50.6 51.2 59.7 59.6 68.7 58.2 55.6 59.3 50.5 47.4 28.6 31.3 28.7
[12:37:15.033] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:37:15.065] <TB1> INFO: PixTest:: pg_setup set to default.
[12:37:15.078] <TB1> INFO: enter test to run
[12:37:15.078] <TB1> INFO: test: no parameter change
[12:37:15.343] <TB1> QUIET: Connection to board 147 closed.
[12:37:15.423] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:37:36.136] <TB1> INFO: *** Welcome to pxar ***
[12:37:36.136] <TB1> INFO: *** Today: 2016/09/29
[12:37:36.490] <TB1> INFO: *** Version: f5d3-dirty
[12:37:36.490] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//dacParameters35_C15.dat
[12:37:36.491] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//tbmParameters_C0b.dat
[12:37:36.491] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//defaultMaskFile.dat
[12:37:36.491] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//trimParameters35_C15.dat
[12:37:36.561] <TB1> INFO: clk: 4
[12:37:36.561] <TB1> INFO: ctr: 4
[12:37:36.561] <TB1> INFO: sda: 19
[12:37:36.561] <TB1> INFO: tin: 9
[12:37:36.561] <TB1> INFO: level: 15
[12:37:36.561] <TB1> INFO: triggerdelay: 0
[12:37:36.561] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:37:36.561] <TB1> INFO: Log level: INFO
[12:37:36.574] <TB1> INFO: Found DTB DTB_WWXTQT
[12:37:36.583] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:37:36.585] <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:
------------------------------------------------------
[12:37:36.587] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:37:38.113] <TB1> INFO: DUT info:
[12:37:38.113] <TB1> INFO: The DUT currently contains the following objects:
[12:37:38.113] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:37:38.113] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:37:38.113] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:37:38.113] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:37:38.113] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.113] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:38.514] <TB1> INFO: enter 'restricted' command line mode
[12:37:38.514] <TB1> INFO: enter test to run
[12:37:38.514] <TB1> INFO: test: PixelAlive no parameter change
[12:37:38.514] <TB1> INFO: running: pixelalive
[12:37:38.517] <TB1> INFO: ######################################################################
[12:37:38.517] <TB1> INFO: PixTestAlive::doTest()
[12:37:38.517] <TB1> INFO: ######################################################################
[12:37:38.518] <TB1> INFO: ----------------------------------------------------------------------
[12:37:38.518] <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)
[12:37:38.518] <TB1> INFO: ----------------------------------------------------------------------
[12:37:38.775] <TB1> INFO: Expecting 208000 events.
[12:37:47.536] <TB1> INFO: 208000 events read in total (8203ms).
[12:37:47.538] <TB1> INFO: Test took 9018ms.
[12:37:47.782] <TB1> INFO: PixTestAlive::aliveTest() done
[12:37:47.782] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:37:47.783] <TB1> INFO: ----------------------------------------------------------------------
[12:37:47.783] <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)
[12:37:47.784] <TB1> INFO: ----------------------------------------------------------------------
[12:37:48.058] <TB1> INFO: Expecting 208000 events.
[12:37:54.972] <TB1> INFO: 208000 events read in total (6358ms).
[12:37:54.973] <TB1> INFO: Test took 7189ms.
[12:37:54.974] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:37:55.165] <TB1> INFO: PixTestAlive::maskTest() done
[12:37:55.165] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:37:55.167] <TB1> INFO: ----------------------------------------------------------------------
[12:37:55.167] <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)
[12:37:55.167] <TB1> INFO: ----------------------------------------------------------------------
[12:37:55.430] <TB1> INFO: Expecting 208000 events.
[12:38:04.442] <TB1> INFO: 208000 events read in total (8456ms).
[12:38:04.442] <TB1> INFO: Test took 9274ms.
[12:38:04.642] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:38:04.642] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:38:04.642] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[12:38:04.671] <TB1> INFO: enter test to run
[12:38:04.671] <TB1> INFO: test: delay setting parameters: ->2<-
[12:38:04.671] <TB1> INFO: delay test by 2 seconds...
[12:38:06.671] <TB1> INFO: enter test to run
[12:38:06.671] <TB1> INFO: test: HighRate no parameter change
[12:38:06.671] <TB1> INFO: running: highrate
[12:38:06.671] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[12:38:06.811] <TB1> INFO: ----------------------------------------------------------------------
[12:38:06.811] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:38:06.811] <TB1> INFO: ----------------------------------------------------------------------
[12:38:07.292] <TB1> INFO: Expecting 208000 events.
[12:38:21.002] <TB1> INFO: 208000 events read in total (13309ms).
[12:38:21.008] <TB1> INFO: Test took 14194ms.
[12:38:21.706] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:38:21.706] <TB1> INFO: number of red-efficiency pixels: 252 215 294 639 563 744 733 973 697 645 686 562 503 284 285 236
[12:38:21.706] <TB1> INFO: number of X-ray hits detected: 140274 149596 141439 255034 254276 299212 297896 343742 290864 278903 295050 252318 236990 144685 157963 144614
[12:38:21.706] <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
[12:38:21.706] <TB1> INFO: number of Vcal hits detected: 207735 207777 207673 207283 207360 207128 207136 206850 207212 207279 207224 207366 207465 207681 207703 207755
[12:38:21.706] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.6 99.6 99.5 99.6 99.7 99.7 99.7 99.8 99.9 99.9 99.9
[12:38:21.706] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.6 99.6 99.4 99.6 99.7 99.6 99.7 99.7 99.8 99.9 99.9
[12:38:21.706] <TB1> INFO: X-ray hit rate [MHz/cm2]: 41.1 43.8 41.5 74.8 74.5 87.7 87.3 100.8 85.3 81.7 86.5 74.0 69.5 42.4 46.3 42.4
[12:38:21.706] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:38:21.735] <TB1> INFO: PixTest:: pg_setup set to default.
[12:38:21.745] <TB1> INFO: enter test to run
[12:38:21.745] <TB1> INFO: test: no parameter change
[12:38:22.037] <TB1> QUIET: Connection to board 147 closed.
[12:38:22.118] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:38:42.727] <TB1> INFO: *** Welcome to pxar ***
[12:38:42.727] <TB1> INFO: *** Today: 2016/09/29
[12:38:43.081] <TB1> INFO: *** Version: f5d3-dirty
[12:38:43.081] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//dacParameters35_C15.dat
[12:38:43.082] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//tbmParameters_C0b.dat
[12:38:43.082] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//defaultMaskFile.dat
[12:38:43.082] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//trimParameters35_C15.dat
[12:38:43.150] <TB1> INFO: clk: 4
[12:38:43.150] <TB1> INFO: ctr: 4
[12:38:43.150] <TB1> INFO: sda: 19
[12:38:43.150] <TB1> INFO: tin: 9
[12:38:43.150] <TB1> INFO: level: 15
[12:38:43.150] <TB1> INFO: triggerdelay: 0
[12:38:43.150] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:38:43.150] <TB1> INFO: Log level: INFO
[12:38:43.163] <TB1> INFO: Found DTB DTB_WWXTQT
[12:38:43.171] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:38:43.173] <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:
------------------------------------------------------
[12:38:43.175] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:38:44.698] <TB1> INFO: DUT info:
[12:38:44.698] <TB1> INFO: The DUT currently contains the following objects:
[12:38:44.698] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:38:44.699] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:38:44.699] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:38:44.699] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:38:44.699] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:44.699] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:38:45.099] <TB1> INFO: enter 'restricted' command line mode
[12:38:45.099] <TB1> INFO: enter test to run
[12:38:45.099] <TB1> INFO: test: PixelAlive no parameter change
[12:38:45.099] <TB1> INFO: running: pixelalive
[12:38:45.103] <TB1> INFO: ######################################################################
[12:38:45.103] <TB1> INFO: PixTestAlive::doTest()
[12:38:45.103] <TB1> INFO: ######################################################################
[12:38:45.104] <TB1> INFO: ----------------------------------------------------------------------
[12:38:45.104] <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)
[12:38:45.104] <TB1> INFO: ----------------------------------------------------------------------
[12:38:45.358] <TB1> INFO: Expecting 208000 events.
[12:38:54.197] <TB1> INFO: 208000 events read in total (8281ms).
[12:38:54.198] <TB1> INFO: Test took 9093ms.
[12:38:54.423] <TB1> INFO: PixTestAlive::aliveTest() done
[12:38:54.423] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:38:54.424] <TB1> INFO: ----------------------------------------------------------------------
[12:38:54.424] <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)
[12:38:54.424] <TB1> INFO: ----------------------------------------------------------------------
[12:38:54.716] <TB1> INFO: Expecting 208000 events.
[12:39:01.268] <TB1> INFO: 208000 events read in total (5996ms).
[12:39:01.269] <TB1> INFO: Test took 6843ms.
[12:39:01.270] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:39:01.477] <TB1> INFO: PixTestAlive::maskTest() done
[12:39:01.477] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:39:01.478] <TB1> INFO: ----------------------------------------------------------------------
[12:39:01.478] <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)
[12:39:01.478] <TB1> INFO: ----------------------------------------------------------------------
[12:39:01.745] <TB1> INFO: Expecting 208000 events.
[12:39:11.112] <TB1> INFO: 208000 events read in total (8811ms).
[12:39:11.113] <TB1> INFO: Test took 9634ms.
[12:39:11.313] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:39:11.313] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:39:11.313] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[12:39:11.343] <TB1> INFO: enter test to run
[12:39:11.343] <TB1> INFO: test: delay setting parameters: ->2<-
[12:39:11.343] <TB1> INFO: delay test by 2 seconds...
[12:39:13.343] <TB1> INFO: enter test to run
[12:39:13.343] <TB1> INFO: test: HighRate no parameter change
[12:39:13.343] <TB1> INFO: running: highrate
[12:39:13.343] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[12:39:13.497] <TB1> INFO: ----------------------------------------------------------------------
[12:39:13.497] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:39:13.497] <TB1> INFO: ----------------------------------------------------------------------
[12:39:13.978] <TB1> INFO: Expecting 208000 events.
[12:39:28.602] <TB1> INFO: 208000 events read in total (14222ms).
[12:39:28.610] <TB1> INFO: Test took 15110ms.
[12:39:29.534] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:39:29.534] <TB1> INFO: number of red-efficiency pixels: 393 372 498 1228 957 1343 1363 1830 1310 1221 1351 1014 902 509 538 448
[12:39:29.534] <TB1> INFO: number of X-ray hits detected: 193731 207823 196403 348012 351322 408405 409488 471984 399436 383848 404733 348559 327070 200187 218210 199521
[12:39:29.534] <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
[12:39:29.534] <TB1> INFO: number of Vcal hits detected: 207578 207606 207370 206378 206800 206152 206113 205353 206315 206387 206142 206700 206934 207346 207419 207513
[12:39:29.534] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.3 99.5 99.2 99.2 98.8 99.3 99.3 99.2 99.5 99.5 99.7 99.7 99.8
[12:39:29.534] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.7 99.2 99.4 99.1 99.1 98.7 99.2 99.2 99.1 99.4 99.5 99.7 99.7 99.8
[12:39:29.534] <TB1> INFO: X-ray hit rate [MHz/cm2]: 56.8 60.9 57.6 102.0 103.0 119.7 120.0 138.3 117.1 112.5 118.6 102.2 95.9 58.7 64.0 58.5
[12:39:29.534] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:39:29.564] <TB1> INFO: PixTest:: pg_setup set to default.
[12:39:29.574] <TB1> INFO: enter test to run
[12:39:29.574] <TB1> INFO: test: no parameter change
[12:39:29.854] <TB1> QUIET: Connection to board 147 closed.
[12:39:29.934] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:39:54.161] <TB1> INFO: *** Welcome to pxar ***
[12:39:54.161] <TB1> INFO: *** Today: 2016/09/29
[12:39:54.493] <TB1> INFO: *** Version: f5d3-dirty
[12:39:54.493] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//dacParameters35_C15.dat
[12:39:54.494] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//tbmParameters_C0b.dat
[12:39:54.494] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//defaultMaskFile.dat
[12:39:54.494] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//trimParameters35_C15.dat
[12:39:54.566] <TB1> INFO: clk: 4
[12:39:54.566] <TB1> INFO: ctr: 4
[12:39:54.566] <TB1> INFO: sda: 19
[12:39:54.566] <TB1> INFO: tin: 9
[12:39:54.566] <TB1> INFO: level: 15
[12:39:54.566] <TB1> INFO: triggerdelay: 0
[12:39:54.566] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:39:54.566] <TB1> INFO: Log level: INFO
[12:39:54.578] <TB1> INFO: Found DTB DTB_WWXTQT
[12:39:54.586] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:39:54.588] <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:
------------------------------------------------------
[12:39:54.590] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:39:56.118] <TB1> INFO: DUT info:
[12:39:56.118] <TB1> INFO: The DUT currently contains the following objects:
[12:39:56.118] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:39:56.118] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:39:56.118] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:39:56.118] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:39:56.118] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.118] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:39:56.519] <TB1> INFO: enter 'restricted' command line mode
[12:39:56.519] <TB1> INFO: enter test to run
[12:39:56.519] <TB1> INFO: test: PixelAlive no parameter change
[12:39:56.519] <TB1> INFO: running: pixelalive
[12:39:56.522] <TB1> INFO: ######################################################################
[12:39:56.522] <TB1> INFO: PixTestAlive::doTest()
[12:39:56.522] <TB1> INFO: ######################################################################
[12:39:56.523] <TB1> INFO: ----------------------------------------------------------------------
[12:39:56.523] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:39:56.523] <TB1> INFO: ----------------------------------------------------------------------
[12:39:56.781] <TB1> INFO: Expecting 208000 events.
[12:40:05.566] <TB1> INFO: 208000 events read in total (8228ms).
[12:40:05.568] <TB1> INFO: Test took 9043ms.
[12:40:05.803] <TB1> INFO: PixTestAlive::aliveTest() done
[12:40:05.803] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:40:05.805] <TB1> INFO: ----------------------------------------------------------------------
[12:40:05.805] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:40:05.805] <TB1> INFO: ----------------------------------------------------------------------
[12:40:06.083] <TB1> INFO: Expecting 208000 events.
[12:40:13.290] <TB1> INFO: 208000 events read in total (6650ms).
[12:40:13.293] <TB1> INFO: Test took 7486ms.
[12:40:13.294] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:40:13.484] <TB1> INFO: PixTestAlive::maskTest() done
[12:40:13.484] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:40:13.485] <TB1> INFO: ----------------------------------------------------------------------
[12:40:13.485] <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)
[12:40:13.485] <TB1> INFO: ----------------------------------------------------------------------
[12:40:13.776] <TB1> INFO: Expecting 208000 events.
[12:40:22.946] <TB1> INFO: 208000 events read in total (8614ms).
[12:40:22.947] <TB1> INFO: Test took 9460ms.
[12:40:23.152] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:40:23.152] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:40:23.152] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[12:40:23.182] <TB1> INFO: enter test to run
[12:40:23.182] <TB1> INFO: test: delay setting parameters: ->2<-
[12:40:23.182] <TB1> INFO: delay test by 2 seconds...
[12:40:25.182] <TB1> INFO: enter test to run
[12:40:25.182] <TB1> INFO: test: HighRate no parameter change
[12:40:25.182] <TB1> INFO: running: highrate
[12:40:25.183] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[12:40:25.320] <TB1> INFO: ----------------------------------------------------------------------
[12:40:25.320] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:40:25.320] <TB1> INFO: ----------------------------------------------------------------------
[12:40:25.806] <TB1> INFO: Expecting 208000 events.
[12:40:43.414] <TB1> INFO: 208000 events read in total (17206ms).
[12:40:43.425] <TB1> INFO: Test took 18102ms.
[12:40:44.506] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:40:44.506] <TB1> INFO: number of red-efficiency pixels: 604 534 695 1733 1481 2004 1960 2595 1891 1826 1857 1540 1305 672 784 663
[12:40:44.506] <TB1> INFO: number of X-ray hits detected: 236524 253785 241262 423334 427061 495807 495613 573467 486302 468161 490211 422755 397893 246244 266503 243436
[12:40:44.506] <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
[12:40:44.506] <TB1> INFO: number of Vcal hits detected: 207316 207426 206962 205336 205825 204758 204648 203425 205157 205107 204967 205656 206284 207052 207115 207258
[12:40:44.506] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.6 98.9 99.1 98.6 98.6 98.0 98.8 98.8 98.7 99.0 99.3 99.6 99.6 99.7
[12:40:44.506] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.5 98.7 99.0 98.4 98.4 97.8 98.6 98.6 98.5 98.9 99.2 99.5 99.6 99.6
[12:40:44.506] <TB1> INFO: X-ray hit rate [MHz/cm2]: 69.3 74.4 70.7 124.1 125.2 145.3 145.3 168.1 142.5 137.2 143.7 123.9 116.6 72.2 78.1 71.4
[12:40:44.506] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:40:44.536] <TB1> INFO: PixTest:: pg_setup set to default.
[12:40:44.549] <TB1> INFO: enter test to run
[12:40:44.549] <TB1> INFO: test: no parameter change
[12:40:44.826] <TB1> QUIET: Connection to board 147 closed.
[12:40:44.906] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:41:05.228] <TB1> INFO: *** Welcome to pxar ***
[12:41:05.228] <TB1> INFO: *** Today: 2016/09/29
[12:41:05.584] <TB1> INFO: *** Version: f5d3-dirty
[12:41:05.584] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//dacParameters35_C15.dat
[12:41:05.585] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//tbmParameters_C0b.dat
[12:41:05.586] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//defaultMaskFile.dat
[12:41:05.586] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//trimParameters35_C15.dat
[12:41:05.659] <TB1> INFO: clk: 4
[12:41:05.659] <TB1> INFO: ctr: 4
[12:41:05.659] <TB1> INFO: sda: 19
[12:41:05.659] <TB1> INFO: tin: 9
[12:41:05.659] <TB1> INFO: level: 15
[12:41:05.659] <TB1> INFO: triggerdelay: 0
[12:41:05.659] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:41:05.659] <TB1> INFO: Log level: INFO
[12:41:05.672] <TB1> INFO: Found DTB DTB_WWXTQT
[12:41:05.681] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:41:05.683] <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:
------------------------------------------------------
[12:41:05.685] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:41:07.213] <TB1> INFO: DUT info:
[12:41:07.213] <TB1> INFO: The DUT currently contains the following objects:
[12:41:07.213] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:41:07.213] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:41:07.213] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:41:07.213] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:41:07.213] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.213] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:41:07.614] <TB1> INFO: enter 'restricted' command line mode
[12:41:07.614] <TB1> INFO: enter test to run
[12:41:07.614] <TB1> INFO: test: PixelAlive no parameter change
[12:41:07.614] <TB1> INFO: running: pixelalive
[12:41:07.617] <TB1> INFO: ######################################################################
[12:41:07.617] <TB1> INFO: PixTestAlive::doTest()
[12:41:07.617] <TB1> INFO: ######################################################################
[12:41:07.618] <TB1> INFO: ----------------------------------------------------------------------
[12:41:07.618] <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)
[12:41:07.618] <TB1> INFO: ----------------------------------------------------------------------
[12:41:07.876] <TB1> INFO: Expecting 208000 events.
[12:41:16.705] <TB1> INFO: 208000 events read in total (8270ms).
[12:41:16.707] <TB1> INFO: Test took 9087ms.
[12:41:16.932] <TB1> INFO: PixTestAlive::aliveTest() done
[12:41:16.932] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:41:16.933] <TB1> INFO: ----------------------------------------------------------------------
[12:41:16.933] <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)
[12:41:16.933] <TB1> INFO: ----------------------------------------------------------------------
[12:41:17.194] <TB1> INFO: Expecting 208000 events.
[12:41:24.263] <TB1> INFO: 208000 events read in total (6512ms).
[12:41:24.266] <TB1> INFO: Test took 7332ms.
[12:41:24.266] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:41:24.457] <TB1> INFO: PixTestAlive::maskTest() done
[12:41:24.457] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:41:24.458] <TB1> INFO: ----------------------------------------------------------------------
[12:41:24.458] <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)
[12:41:24.458] <TB1> INFO: ----------------------------------------------------------------------
[12:41:24.730] <TB1> INFO: Expecting 208000 events.
[12:41:33.587] <TB1> INFO: 208000 events read in total (8301ms).
[12:41:33.588] <TB1> INFO: Test took 9128ms.
[12:41:33.788] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:41:33.788] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:41:33.788] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[12:41:33.817] <TB1> INFO: enter test to run
[12:41:33.817] <TB1> INFO: test: delay setting parameters: ->2<-
[12:41:33.817] <TB1> INFO: delay test by 2 seconds...
[12:41:35.817] <TB1> INFO: enter test to run
[12:41:35.817] <TB1> INFO: test: HighRate no parameter change
[12:41:35.817] <TB1> INFO: running: highrate
[12:41:35.818] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[12:41:35.945] <TB1> INFO: ----------------------------------------------------------------------
[12:41:35.945] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:41:35.945] <TB1> INFO: ----------------------------------------------------------------------
[12:41:36.423] <TB1> INFO: Expecting 208000 events.
[12:41:55.008] <TB1> INFO: 208000 events read in total (18183ms).
[12:41:55.019] <TB1> INFO: Test took 19070ms.
[12:41:56.217] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:41:56.217] <TB1> INFO: number of red-efficiency pixels: 859 719 915 2328 1987 2647 2500 3349 2556 2409 2554 2107 1888 891 1131 922
[12:41:56.217] <TB1> INFO: number of X-ray hits detected: 283499 302980 287384 503445 508680 588139 590978 684313 580382 557925 583810 504368 476226 296454 318736 290404
[12:41:56.217] <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
[12:41:56.217] <TB1> INFO: number of Vcal hits detected: 206988 207171 206400 203580 204465 202632 202592 200019 203255 203167 202812 204254 205067 206470 206600 206892
[12:41:56.217] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.6 99.4 98.2 98.5 97.7 97.8 96.5 97.9 98.0 97.8 98.4 98.7 99.4 99.4 99.5
[12:41:56.217] <TB1> INFO: Vcal hit overall efficiency (%): 99.5 99.6 99.2 97.9 98.3 97.4 97.4 96.2 97.7 97.7 97.5 98.2 98.6 99.3 99.3 99.5
[12:41:56.217] <TB1> INFO: X-ray hit rate [MHz/cm2]: 83.1 88.8 84.2 147.6 149.1 172.4 173.2 200.6 170.1 163.5 171.1 147.8 139.6 86.9 93.4 85.1
[12:41:56.217] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:41:56.247] <TB1> INFO: PixTest:: pg_setup set to default.
[12:41:56.263] <TB1> INFO: enter test to run
[12:41:56.263] <TB1> INFO: test: no parameter change
[12:41:56.554] <TB1> QUIET: Connection to board 147 closed.
[12:41:56.634] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:42:21.958] <TB1> INFO: *** Welcome to pxar ***
[12:42:21.958] <TB1> INFO: *** Today: 2016/09/29
[12:42:22.326] <TB1> INFO: *** Version: f5d3-dirty
[12:42:22.326] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//dacParameters35_C15.dat
[12:42:22.327] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//tbmParameters_C0b.dat
[12:42:22.327] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//defaultMaskFile.dat
[12:42:22.327] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//trimParameters35_C15.dat
[12:42:22.398] <TB1> INFO: clk: 4
[12:42:22.398] <TB1> INFO: ctr: 4
[12:42:22.398] <TB1> INFO: sda: 19
[12:42:22.398] <TB1> INFO: tin: 9
[12:42:22.398] <TB1> INFO: level: 15
[12:42:22.398] <TB1> INFO: triggerdelay: 0
[12:42:22.398] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:42:22.398] <TB1> INFO: Log level: INFO
[12:42:22.411] <TB1> INFO: Found DTB DTB_WWXTQT
[12:42:22.419] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:42:22.421] <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:
------------------------------------------------------
[12:42:22.423] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:42:23.950] <TB1> INFO: DUT info:
[12:42:23.950] <TB1> INFO: The DUT currently contains the following objects:
[12:42:23.950] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:42:23.950] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:42:23.950] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:42:23.950] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:42:23.950] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:23.950] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:42:24.351] <TB1> INFO: enter 'restricted' command line mode
[12:42:24.351] <TB1> INFO: enter test to run
[12:42:24.351] <TB1> INFO: test: PixelAlive no parameter change
[12:42:24.351] <TB1> INFO: running: pixelalive
[12:42:24.354] <TB1> INFO: ######################################################################
[12:42:24.354] <TB1> INFO: PixTestAlive::doTest()
[12:42:24.354] <TB1> INFO: ######################################################################
[12:42:24.356] <TB1> INFO: ----------------------------------------------------------------------
[12:42:24.356] <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)
[12:42:24.356] <TB1> INFO: ----------------------------------------------------------------------
[12:42:24.613] <TB1> INFO: Expecting 208000 events.
[12:42:33.421] <TB1> INFO: 208000 events read in total (8249ms).
[12:42:33.423] <TB1> INFO: Test took 9066ms.
[12:42:33.664] <TB1> INFO: PixTestAlive::aliveTest() done
[12:42:33.664] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:42:33.665] <TB1> INFO: ----------------------------------------------------------------------
[12:42:33.665] <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)
[12:42:33.665] <TB1> INFO: ----------------------------------------------------------------------
[12:42:33.931] <TB1> INFO: Expecting 208000 events.
[12:42:40.293] <TB1> INFO: 208000 events read in total (5806ms).
[12:42:40.294] <TB1> INFO: Test took 6627ms.
[12:42:40.294] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:42:40.505] <TB1> INFO: PixTestAlive::maskTest() done
[12:42:40.505] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:42:40.506] <TB1> INFO: ----------------------------------------------------------------------
[12:42:40.506] <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)
[12:42:40.506] <TB1> INFO: ----------------------------------------------------------------------
[12:42:40.783] <TB1> INFO: Expecting 208000 events.
[12:42:50.233] <TB1> INFO: 208000 events read in total (8894ms).
[12:42:50.234] <TB1> INFO: Test took 9726ms.
[12:42:50.434] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:42:50.434] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:42:50.434] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[12:42:50.463] <TB1> INFO: enter test to run
[12:42:50.463] <TB1> INFO: test: delay setting parameters: ->2<-
[12:42:50.463] <TB1> INFO: delay test by 2 seconds...
[12:42:52.463] <TB1> INFO: enter test to run
[12:42:52.463] <TB1> INFO: test: HighRate no parameter change
[12:42:52.463] <TB1> INFO: running: highrate
[12:42:52.464] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[12:42:52.610] <TB1> INFO: ----------------------------------------------------------------------
[12:42:52.610] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:42:52.610] <TB1> INFO: ----------------------------------------------------------------------
[12:42:53.089] <TB1> INFO: Expecting 208000 events.
[12:43:16.071] <TB1> INFO: 208000 events read in total (22580ms).
[12:43:16.087] <TB1> INFO: Test took 23474ms.
[12:43:17.671] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:43:17.671] <TB1> INFO: number of red-efficiency pixels: 1608 1449 1506 3480 3162 3701 3654 4077 3734 3546 3717 3221 3086 1440 2063 1690
[12:43:17.671] <TB1> INFO: number of X-ray hits detected: 385839 413328 393001 681117 688179 793427 796390 931867 781290 753457 791097 685119 647218 403904 435418 395018
[12:43:17.671] <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
[12:43:17.671] <TB1> INFO: number of Vcal hits detected: 205681 206078 204095 197621 199317 194557 194548 188297 195785 196256 195137 198932 200851 204447 204948 205445
[12:43:17.671] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.0 99.2 98.5 95.6 96.4 94.2 94.4 91.2 94.6 95.0 94.5 96.2 96.9 98.6 98.6 98.9
[12:43:17.671] <TB1> INFO: Vcal hit overall efficiency (%): 98.9 99.1 98.1 95.0 95.8 93.5 93.5 90.5 94.1 94.4 93.8 95.6 96.6 98.3 98.5 98.8
[12:43:17.671] <TB1> INFO: X-ray hit rate [MHz/cm2]: 113.1 121.1 115.2 199.6 201.7 232.6 233.4 273.1 229.0 220.8 231.9 200.8 189.7 118.4 127.6 115.8
[12:43:17.671] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:43:17.700] <TB1> INFO: PixTest:: pg_setup set to default.
[12:43:17.713] <TB1> INFO: enter test to run
[12:43:17.713] <TB1> INFO: test: no parameter change
[12:43:18.049] <TB1> QUIET: Connection to board 147 closed.
[12:43:18.129] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:43:44.786] <TB1> INFO: *** Welcome to pxar ***
[12:43:44.786] <TB1> INFO: *** Today: 2016/09/29
[12:43:45.159] <TB1> INFO: *** Version: f5d3-dirty
[12:43:45.159] <TB1> INFO: readRocDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//dacParameters35_C15.dat
[12:43:45.159] <TB1> INFO: readTbmDacs: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//tbmParameters_C0b.dat
[12:43:45.159] <TB1> INFO: readMaskFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//defaultMaskFile.dat
[12:43:45.159] <TB1> INFO: readTrimFile: /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//trimParameters35_C15.dat
[12:43:45.229] <TB1> INFO: clk: 4
[12:43:45.229] <TB1> INFO: ctr: 4
[12:43:45.229] <TB1> INFO: sda: 19
[12:43:45.229] <TB1> INFO: tin: 9
[12:43:45.229] <TB1> INFO: level: 15
[12:43:45.229] <TB1> INFO: triggerdelay: 0
[12:43:45.229] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:43:45.229] <TB1> INFO: Log level: INFO
[12:43:45.241] <TB1> INFO: Found DTB DTB_WWXTQT
[12:43:45.250] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:43:45.252] <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:
------------------------------------------------------
[12:43:45.254] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:43:46.780] <TB1> INFO: DUT info:
[12:43:46.780] <TB1> INFO: The DUT currently contains the following objects:
[12:43:46.780] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:43:46.780] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:43:46.780] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:43:46.780] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:43:46.780] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.780] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.780] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:46.781] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:43:47.181] <TB1> INFO: enter 'restricted' command line mode
[12:43:47.181] <TB1> INFO: enter test to run
[12:43:47.181] <TB1> INFO: test: PixelAlive no parameter change
[12:43:47.181] <TB1> INFO: running: pixelalive
[12:43:47.185] <TB1> INFO: ######################################################################
[12:43:47.185] <TB1> INFO: PixTestAlive::doTest()
[12:43:47.185] <TB1> INFO: ######################################################################
[12:43:47.186] <TB1> INFO: ----------------------------------------------------------------------
[12:43:47.186] <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)
[12:43:47.186] <TB1> INFO: ----------------------------------------------------------------------
[12:43:47.444] <TB1> INFO: Expecting 208000 events.
[12:43:56.514] <TB1> INFO: 208000 events read in total (8512ms).
[12:43:56.516] <TB1> INFO: Test took 9329ms.
[12:43:56.744] <TB1> INFO: PixTestAlive::aliveTest() done
[12:43:56.744] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:43:56.746] <TB1> INFO: ----------------------------------------------------------------------
[12:43:56.746] <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)
[12:43:56.746] <TB1> INFO: ----------------------------------------------------------------------
[12:43:57.013] <TB1> INFO: Expecting 208000 events.
[12:44:03.682] <TB1> INFO: 208000 events read in total (6113ms).
[12:44:03.682] <TB1> INFO: Test took 6935ms.
[12:44:03.683] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:44:03.891] <TB1> INFO: PixTestAlive::maskTest() done
[12:44:03.891] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:44:03.892] <TB1> INFO: ----------------------------------------------------------------------
[12:44:03.892] <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)
[12:44:03.892] <TB1> INFO: ----------------------------------------------------------------------
[12:44:04.173] <TB1> INFO: Expecting 208000 events.
[12:44:13.477] <TB1> INFO: 208000 events read in total (8748ms).
[12:44:13.478] <TB1> INFO: Test took 9584ms.
[12:44:13.678] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:44:13.678] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:44:13.678] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[12:44:13.707] <TB1> INFO: enter test to run
[12:44:13.707] <TB1> INFO: test: delay setting parameters: ->2<-
[12:44:13.707] <TB1> INFO: delay test by 2 seconds...
[12:44:15.707] <TB1> INFO: enter test to run
[12:44:15.707] <TB1> INFO: test: HighRate no parameter change
[12:44:15.707] <TB1> INFO: running: highrate
[12:44:15.707] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2335_XrayQualification_2016-09-29_13h35m_1475148923//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[12:44:15.897] <TB1> INFO: ----------------------------------------------------------------------
[12:44:15.897] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:44:15.897] <TB1> INFO: ----------------------------------------------------------------------
[12:44:16.437] <TB1> INFO: Expecting 208000 events.
[12:44:21.750] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"

[12:44:21.750] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"

[12:44:21.750] <TB1> ERROR: <datapipe.cc/CheckEventID:L485> Channel 0 Event ID mismatch: local ID (26) != TBM ID (27)

[12:44:21.750] <TB1> ERROR: <datapipe.cc/CheckEventID:L485> Channel 1 Event ID mismatch: local ID (26) != TBM ID (27)

[12:44:21.750] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[12:44:21.750] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01e 8000 40e0 54 2a2c 119 20a5 114 266f 122 2a62 251 2a4d 349 2682 544 222a 615 226e 698 244d 41c0 119 2084 350 2a49 4d4 222f 65a 2049 40e0 ca 246f 11a 2863 119 20a6 220 204c 753 284d 762 266b 40e0 119 208b 118 2264 4cc 2883 812 2a41 e002 c000

[12:44:21.750] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a018 80b0 40c1 119 208f 2d3 2a4f 4a0 264d 40c1 119 208c 64c 2a2d 40e1 119 2086 10a 2060 121 2662 64b 2a65 6db 2064 40c1 84 286b 119 20c5 2c2 2465 65d 2488 641 2065 e002 c000

[12:44:21.750] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a019 80c0 40e1 84 2049 119 20c9 321 2486 642 2262 40e1 119 20a6 851 2a47 40e1 61 2481 305 2669 45b 2268 505 2247 519 2a69 812 2a4e 40c1 3 2462 11 2a6f 119 20a7 4e0 26a8 51d 26a7 620 222d e002 c000

[12:44:21.750] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01a 8000 40e0 1a 2445 119 20a4 21a 284e 51d 2a62 613 2067 608 204d 40c0 2 224f 119 20a2 40a 2040 41c0 119 20a4 10c 2240 4e0 2261 6c9 2685 841 224c 85b 2a84 40c0 d2 2482 14a 2a69 fc00 dc00

[12:44:21.750] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01b 8040 40e0 119 20a0 344 2044 40c0 119 20a3 722 2a6a 40e0 119 20a4 41c0 119 20c0 248 2869 2a0 20c2 44a 2a4b e002 c000

[12:44:21.750] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01c 80b0 40e1 119 20a5 40e1 cd 2a4a 119 2083 40e1 4b 226c 4c 2665 85 204f 119 2081 55a 2048 64d 246d 702 2469 40c1 119 20c2 414 2685 e002 c000

[12:44:21.750] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01d 80c0 40e0 119 20a5 21b 2a69 519 2466 40e0 43 266b 119 20a5 2d5 224f 458 2862 4d9 2a45 40e0 119 2088 14b 2083 14a 2862 84d 224f 853 266a 41e0 119 20c2 28b 24c6 2d9 208f 343 2287 490 2440 50d 284a 503 2289 50a 2a64 65c 266f 69c 2441 e002 c000

[12:44:21.750] <TB1> WARNING: Channel 1 ROC 3: Readback start marker after 15 readouts!

[12:44:21.750] <TB1> WARNING: Channel 0 ROC 0: Readback start marker after 15 readouts!

[12:44:21.750] <TB1> WARNING: Channel 0 ROC 1: Readback start marker after 15 readouts!

[12:44:21.751] <TB1> WARNING: Channel 0 ROC 2: Readback start marker after 15 readouts!

[12:44:21.751] <TB1> WARNING: Channel 0 ROC 3: Readback start marker after 15 readouts!

[12:44:21.751] <TB1> WARNING: Channel 1 ROC 0: Readback start marker after 15 readouts!

[12:44:21.751] <TB1> WARNING: Channel 1 ROC 1: Readback start marker after 15 readouts!

[12:44:21.751] <TB1> WARNING: Channel 1 ROC 2: Readback start marker after 15 readouts!

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a022 8000 40e0 119 20a0 255 2842 2d9 2261 40e0 18 282c 119 20a5 152 2a6d 40c1 22 226c 119 20a2 291 2046 800 2429 40e1 4c8 2a69 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01c 80b0 40e1 119 20a5 40e1 cd 2a4a 119 2083 40e1 4b 226c 4c 2665 85 204f 119 2081 55a 2048 64d 246d 702 2469 40c1 119 20c2 414 2685 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01d 80c0 40e0 119 20a5 21b 2a69 519 2466 40e0 43 266b 119 20a5 2d5 224f 458 2862 4d9 2a45 40e0 119 2088 14b 2083 14a 2862 84d 224f 853 266a 41e0 119 20c2 28b 24c6 2d9 208f 343 2287 490 2440 50d 284a 503 2289 50a 2a64 65c 266f 69c 2441 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01e 8000 40e0 54 2a2c 119 20a5 114 266f 122 2a62 251 2a4d 349 2682 544 222a 615 226e 698 244d 41c0 119 2084 350 2a49 4d4 222f 65a 2049 40e0 ca 246f 11a 2863 119 20a6 220 204c 753 284d 762 266b 40e0 119 208b 118 2264 4cc 2883 812 2a41 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a01f 8040 40e2 119 20aa 70a 202c 70c 2247 40e2 119 2089 2a0 264a 50c 244d 41c2 119 2081 2d9 2865 64d 2683 84b 2069 841 2a64 41c2 119 208f 84d 226f e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a020 80b0 40c0 119 208f 100 244a 2d2 2a4e 2d8 2a42 40e0 119 2087 350 2640 75c 2028 75d 2664 40e0 119 20a1 4db 286d 693 286f 40c0 1c 246e 11 246f 119 20c5 14a 2284 441 2688 51a 2045 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a021 80c0 40e0 b 2445 62 2a42 d9 2a6c 119 208b 119 264c 6d9 2a6a 40c0 18 202a 119 208e 55d 2249 741 2640 40c0 119 2082 209 228d 40c0 48 248b 403 2482 4ca 288e 4cc 224f 722 22a0 809 2065 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L170> Dumping the flawed event +- 3 events:

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a122 8000 40e0 119 20a2 351 2868 495 286c 482 2a6e 41e0 119 2086 10a 226e 34d 284e 64b 224f 6d1 2468 701 2a2f 719 2222 40e1 d4 262c 45a 284f 849 2483 858 2a40 40c1 119 2485 119 20cc 688 2082 805 228f e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a11c 80b0 40e1 119 2084 4d2 228a 511 2249 6a2 2a65 6c5 284c 6c2 2647 755 286f 74d 226e 750 2240 40c1 a 2a88 119 20af 40c1 119 208c 449 2880 50d 2285 40c0 1a 2465 c 206f b 208e 4 2a67 a 266a 1d 2682 119 20ae 251 2a85 705 2241 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a11d 80c0 40e0 1d 284f 1d 204d 1a 244d 20 264f d3 266e 119 208c 141 2867 40b 2a4c 692 206e 40e0 252 284d 25c 2a8f 34d 2a6f 55a 2865 6cc 284f 41e0 119 20ad 24b 2286 2c5 2265 2c5 2684 4d9 2068 4d1 206d 720 2263 40c0 58 286f 85 2289 119 20e2 105 24c0 104 2a6f 160 2062 2d8 2485 4a0 2266 680 264e 803 224d e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a11e 8000 40e0 240 2a6c 6c2 2440 741 286f 40e0 13 284c 8 2462 d 264f 8c 2465 119 20ac 2d1 246a 34d 282c 41a 2a6a 492 206f 613 2a6e 743 244e 743 2643 813 2442 854 264e 41c0 43 2a6e 119 20af 40e2 50 224e e0 2662 119 20cd 154 2866 351 2089 343 2688 498 208f e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a11f 8040 40e2 119 2089 850 2046 84a 2665 850 2245 855 224f 85d 266a 40e2 85 206e 155 2a85 41c2 11d 204b 119 20ad 160 2484 322 208c 35b 2a89 40c0 119 20cd 148 286a 14d 2a84 154 2685 25b 2882 255 20a5 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a120 80b0 40c0 60 246f 119 20a7 145 226b 284 284c 400 2644 44a 226f 754 2266 40e0 8c 2444 119 20aa 45b 2086 40c0 80 242d 119 2086 11a 2286 11a 2668 41c 2a6a 695 2a4e 6c2 2a4a 41e1 119 20c2 819 244f 809 246a 809 206d 808 2449 e002 c000

[12:44:21.751] <TB1> ERROR: <datapipe.cc/Read:L172> ====== 0 ====== a121 80c0 40e1 119 20ac 104 2865 34c 2262 821 2862 819 2686 40c1 121 2869 119 20ac 20c 2664 315 2680 4c0 262f 40c1 cd 2286 119 20a3 2d1 2281 40c1 11 2468 119 20e4 34b 286d 35a 2689 65d 2661 e002 c000

[12:44:43.005] <TB1> INFO: 194800 events read in total (26166ms).
[12:44:44.979] <TB1> INFO: 208000 events read in total (28140ms).
[12:44:44.995] <TB1> INFO: Test took 29095ms.
[12:44:47.012] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:44:47.012] <TB1> INFO: number of red-efficiency pixels: 2341 2143 1962 3946 3826 4094 4067 4160 4079 4025 4068 3805 3793 1878 2890 2482
[12:44:47.012] <TB1> INFO: number of X-ray hits detected: 477516 508510 486686 838644 849999 976411 984659 1153863 963625 931893 970924 843738 801732 499606 539493 488196
[12:44:47.012] <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
[12:44:47.012] <TB1> INFO: number of Vcal hits detected: 203822 204568 201370 189343 191647 183322 183947 172384 185468 186337 184956 191753 194296 201402 202179 203370
[12:44:47.012] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.2 98.5 97.4 92.0 93.1 89.2 89.7 83.8 90.0 90.7 90.0 93.1 94.1 97.4 97.4 98.0
[12:44:47.012] <TB1> INFO: Vcal hit overall efficiency (%): 98.0 98.4 96.8 91.0 92.1 88.1 88.4 82.9 89.2 89.6 88.9 92.2 93.4 96.8 97.2 97.8
[12:44:47.012] <TB1> INFO: X-ray hit rate [MHz/cm2]: 140.0 149.0 142.7 245.8 249.1 286.2 288.6 338.2 282.4 273.1 284.6 247.3 235.0 146.4 158.1 143.1
[12:44:47.012] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:44:47.042] <TB1> INFO: PixTest:: pg_setup set to default.
[12:44:47.059] <TB1> INFO: enter test to run
[12:44:47.059] <TB1> INFO: test: no parameter change
[12:44:47.332] <TB1> QUIET: Connection to board 147 closed.
[12:44:47.411] <TB1> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.4-4-g297680c on branch psi46master