[14:31:38.651] <TB1> INFO: *** Welcome to pxar ***
[14:31:38.651] <TB1> INFO: *** Today: 2016/08/10
[14:31:38.720] <TB1> INFO: *** Version: f5d3-dirty
[14:31:38.720] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//000_PixelAlive_p17//dacParameters35_C15.dat
[14:31:38.721] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//000_PixelAlive_p17//tbmParameters_C0b.dat
[14:31:38.721] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//000_PixelAlive_p17//defaultMaskFile.dat
[14:31:38.721] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//000_PixelAlive_p17//trimParameters35_C15.dat
[14:31:38.789] <TB1> INFO: clk: 4
[14:31:38.789] <TB1> INFO: ctr: 4
[14:31:38.789] <TB1> INFO: sda: 19
[14:31:38.789] <TB1> INFO: tin: 9
[14:31:38.789] <TB1> INFO: level: 15
[14:31:38.789] <TB1> INFO: triggerdelay: 0
[14:31:38.789] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:31:38.789] <TB1> INFO: Log level: INFO
[14:31:38.803] <TB1> INFO: Found DTB DTB_WWXTQT
[14:31:38.817] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[14:31:38.819] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[14:31:38.821] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[14:31:40.353] <TB1> INFO: DUT info:
[14:31:40.353] <TB1> INFO: The DUT currently contains the following objects:
[14:31:40.353] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[14:31:40.353] <TB1> INFO: TBM Core alpha (0): 7 registers set
[14:31:40.353] <TB1> INFO: TBM Core beta (1): 7 registers set
[14:31:40.353] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:31:40.353] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.353] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.354] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:40.754] <TB1> INFO: enter 'restricted' command line mode
[14:31:40.754] <TB1> INFO: enter test to run
[14:31:40.754] <TB1> INFO: test: PixelAlive no parameter change
[14:31:40.755] <TB1> INFO: running: pixelalive
[14:31:40.760] <TB1> INFO: ######################################################################
[14:31:40.760] <TB1> INFO: PixTestAlive::doTest()
[14:31:40.760] <TB1> INFO: ######################################################################
[14:31:40.761] <TB1> INFO: ----------------------------------------------------------------------
[14:31:40.761] <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)
[14:31:40.761] <TB1> INFO: ----------------------------------------------------------------------
[14:31:41.067] <TB1> INFO: Expecting 41600 events.
[14:31:44.809] <TB1> INFO: 41600 events read in total (3183ms).
[14:31:44.858] <TB1> INFO: Test took 4095ms.
[14:31:45.080] <TB1> INFO: PixTestAlive::aliveTest() done
[14:31:45.080] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[14:31:45.081] <TB1> INFO: ----------------------------------------------------------------------
[14:31:45.081] <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)
[14:31:45.081] <TB1> INFO: ----------------------------------------------------------------------
[14:31:45.339] <TB1> INFO: Expecting 41600 events.
[14:31:48.273] <TB1> INFO: 41600 events read in total (2378ms).
[14:31:48.273] <TB1> INFO: Test took 3191ms.
[14:31:48.273] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:31:48.520] <TB1> INFO: PixTestAlive::maskTest() done
[14:31:48.520] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:31:48.521] <TB1> INFO: ----------------------------------------------------------------------
[14:31:48.521] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:31:48.521] <TB1> INFO: ----------------------------------------------------------------------
[14:31:48.789] <TB1> INFO: Expecting 41600 events.
[14:31:52.527] <TB1> INFO: 41600 events read in total (3182ms).
[14:31:52.529] <TB1> INFO: Test took 4006ms.
[14:31:52.758] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[14:31:52.758] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:31:52.758] <TB1> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[14:31:52.791] <TB1> INFO: enter test to run
[14:31:52.791] <TB1> INFO: test: no parameter change
[14:31:52.987] <TB1> QUIET: Connection to board 147 closed.
[14:31:53.067] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[14:36:57.935] <TB1> INFO: *** Welcome to pxar ***
[14:36:57.935] <TB1> INFO: *** Today: 2016/08/10
[14:36:58.003] <TB1> INFO: *** Version: f5d3-dirty
[14:36:58.003] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//dacParameters35_C15.dat
[14:36:58.003] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[14:36:58.003] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//defaultMaskFile.dat
[14:36:58.003] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C15.dat
[14:36:58.104] <TB1> INFO: clk: 4
[14:36:58.104] <TB1> INFO: ctr: 4
[14:36:58.104] <TB1> INFO: sda: 19
[14:36:58.104] <TB1> INFO: tin: 9
[14:36:58.104] <TB1> INFO: level: 15
[14:36:58.104] <TB1> INFO: triggerdelay: 0
[14:36:58.104] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:36:58.104] <TB1> INFO: Log level: INFO
[14:36:58.119] <TB1> INFO: Found DTB DTB_WWXTQT
[14:36:58.133] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[14:36:58.135] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[14:36:58.137] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[14:36:59.715] <TB1> INFO: DUT info:
[14:36:59.715] <TB1> INFO: The DUT currently contains the following objects:
[14:36:59.715] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[14:36:59.715] <TB1> INFO: TBM Core alpha (0): 7 registers set
[14:36:59.715] <TB1> INFO: TBM Core beta (1): 7 registers set
[14:36:59.715] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:36:59.715] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:00.116] <TB1> INFO: enter 'restricted' command line mode
[14:37:00.116] <TB1> INFO: enter test to run
[14:37:00.116] <TB1> INFO: test: delay setting parameters: ->5<-
[14:37:00.116] <TB1> INFO: delay test by 5 seconds...
[14:37:05.116] <TB1> INFO: enter test to run
[14:37:05.116] <TB1> INFO: test: highrate no parameter change
[14:37:05.116] <TB1> INFO: running: highrate
[14:37:05.117] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[14:37:05.381] <TB1> INFO: ----------------------------------------------------------------------
[14:37:05.381] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[14:37:05.381] <TB1> INFO: ----------------------------------------------------------------------
[14:37:05.381] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[14:37:05.381] <TB1> INFO: edge/corner pixel THR is adjusted
[14:37:05.381] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[14:37:06.098] <TB1> INFO: Collecting data for 1 seconds...
[14:37:07.099] <TB1> INFO: Done with hot pixel readout
[14:37:14.277] <TB1> INFO: PixTest:: pg_setup set to default.
[14:37:14.278] <TB1> INFO: 0 hot pixels found in step 0
[14:37:14.286] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[14:37:14.316] <TB1> INFO: PixTest::trimHotPixels() done
[14:37:14.316] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C0.dat
[14:37:14.323] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C1.dat
[14:37:14.329] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C2.dat
[14:37:14.335] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C3.dat
[14:37:14.341] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C4.dat
[14:37:14.347] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C5.dat
[14:37:14.353] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C6.dat
[14:37:14.359] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C7.dat
[14:37:14.365] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C8.dat
[14:37:14.372] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C9.dat
[14:37:14.378] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C10.dat
[14:37:14.384] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C11.dat
[14:37:14.390] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C12.dat
[14:37:14.396] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C13.dat
[14:37:14.402] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C14.dat
[14:37:14.408] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C15.dat
[14:37:14.414] <TB1> INFO: write masked pixels into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//defaultMaskFile.dat
[14:37:14.446] <TB1> INFO: enter test to run
[14:37:14.446] <TB1> INFO: test: no parameter change
[14:37:14.718] <TB1> QUIET: Connection to board 147 closed.
[14:37:14.798] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[14:36:57.935] <TB1> INFO: *** Welcome to pxar ***
[14:36:57.935] <TB1> INFO: *** Today: 2016/08/10
[14:36:58.003] <TB1> INFO: *** Version: f5d3-dirty
[14:36:58.003] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//dacParameters35_C15.dat
[14:36:58.003] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[14:36:58.003] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//defaultMaskFile.dat
[14:36:58.003] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C15.dat
[14:36:58.104] <TB1> INFO: clk: 4
[14:36:58.104] <TB1> INFO: ctr: 4
[14:36:58.104] <TB1> INFO: sda: 19
[14:36:58.104] <TB1> INFO: tin: 9
[14:36:58.104] <TB1> INFO: level: 15
[14:36:58.104] <TB1> INFO: triggerdelay: 0
[14:36:58.104] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:36:58.104] <TB1> INFO: Log level: INFO
[14:36:58.119] <TB1> INFO: Found DTB DTB_WWXTQT
[14:36:58.133] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[14:36:58.135] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[14:36:58.137] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[14:36:59.715] <TB1> INFO: DUT info:
[14:36:59.715] <TB1> INFO: The DUT currently contains the following objects:
[14:36:59.715] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[14:36:59.715] <TB1> INFO: TBM Core alpha (0): 7 registers set
[14:36:59.715] <TB1> INFO: TBM Core beta (1): 7 registers set
[14:36:59.715] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:36:59.715] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:59.715] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:00.116] <TB1> INFO: enter 'restricted' command line mode
[14:37:00.116] <TB1> INFO: enter test to run
[14:37:00.116] <TB1> INFO: test: delay setting parameters: ->5<-
[14:37:00.116] <TB1> INFO: delay test by 5 seconds...
[14:37:05.116] <TB1> INFO: enter test to run
[14:37:05.116] <TB1> INFO: test: highrate no parameter change
[14:37:05.116] <TB1> INFO: running: highrate
[14:37:05.117] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[14:37:05.381] <TB1> INFO: ----------------------------------------------------------------------
[14:37:05.381] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[14:37:05.381] <TB1> INFO: ----------------------------------------------------------------------
[14:37:05.381] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[14:37:05.381] <TB1> INFO: edge/corner pixel THR is adjusted
[14:37:05.381] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[14:37:06.098] <TB1> INFO: Collecting data for 1 seconds...
[14:37:07.099] <TB1> INFO: Done with hot pixel readout
[14:37:14.277] <TB1> INFO: PixTest:: pg_setup set to default.
[14:37:14.278] <TB1> INFO: 0 hot pixels found in step 0
[14:37:14.286] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[14:37:14.316] <TB1> INFO: PixTest::trimHotPixels() done
[14:37:14.316] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C0.dat
[14:37:14.323] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C1.dat
[14:37:14.329] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C2.dat
[14:37:14.335] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C3.dat
[14:37:14.341] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C4.dat
[14:37:14.347] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C5.dat
[14:37:14.353] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C6.dat
[14:37:14.359] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C7.dat
[14:37:14.365] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C8.dat
[14:37:14.372] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C9.dat
[14:37:14.378] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C10.dat
[14:37:14.384] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C11.dat
[14:37:14.390] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C12.dat
[14:37:14.396] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C13.dat
[14:37:14.402] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C14.dat
[14:37:14.408] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//trimParameters35_C15.dat
[14:37:14.414] <TB1> INFO: write masked pixels into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//002_RetrimHotPixels_150//defaultMaskFile.dat
[14:37:14.446] <TB1> INFO: enter test to run
[14:37:14.446] <TB1> INFO: test: no parameter change
[14:37:14.718] <TB1> QUIET: Connection to board 147 closed.
[14:37:14.798] <TB1> INFO: pXar: this is the end, my friend
[14:37:59.845] <TB1> INFO: *** Welcome to pxar ***
[14:37:59.845] <TB1> INFO: *** Today: 2016/08/10
[14:37:59.913] <TB1> INFO: *** Version: f5d3-dirty
[14:37:59.913] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//dacParameters35_C15.dat
[14:37:59.913] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[14:37:59.914] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//defaultMaskFile.dat
[14:37:59.914] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C15.dat
[14:37:59.984] <TB1> INFO: clk: 4
[14:37:59.984] <TB1> INFO: ctr: 4
[14:37:59.984] <TB1> INFO: sda: 19
[14:37:59.984] <TB1> INFO: tin: 9
[14:37:59.984] <TB1> INFO: level: 15
[14:37:59.984] <TB1> INFO: triggerdelay: 0
[14:37:59.984] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:37:59.984] <TB1> INFO: Log level: INFO
[14:37:59.998] <TB1> INFO: Found DTB DTB_WWXTQT
[14:38:00.012] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[14:38:00.014] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[14:38:00.016] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[14:38:01.560] <TB1> INFO: DUT info:
[14:38:01.560] <TB1> INFO: The DUT currently contains the following objects:
[14:38:01.560] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[14:38:01.560] <TB1> INFO: TBM Core alpha (0): 7 registers set
[14:38:01.560] <TB1> INFO: TBM Core beta (1): 7 registers set
[14:38:01.560] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:38:01.560] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.560] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.561] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.561] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.561] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:01.961] <TB1> INFO: enter 'restricted' command line mode
[14:38:01.961] <TB1> INFO: enter test to run
[14:38:01.961] <TB1> INFO: test: delay setting parameters: ->5<-
[14:38:01.961] <TB1> INFO: delay test by 5 seconds...
[14:38:06.961] <TB1> INFO: enter test to run
[14:38:06.961] <TB1> INFO: test: highrate no parameter change
[14:38:06.961] <TB1> INFO: running: highrate
[14:38:06.962] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[14:38:07.091] <TB1> INFO: ----------------------------------------------------------------------
[14:38:07.091] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[14:38:07.091] <TB1> INFO: ----------------------------------------------------------------------
[14:38:07.091] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[14:38:07.091] <TB1> INFO: edge/corner pixel THR is adjusted
[14:38:07.091] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[14:38:07.809] <TB1> INFO: Collecting data for 1 seconds...
[14:38:08.810] <TB1> INFO: Done with hot pixel readout
[14:38:13.062] <TB1> INFO: PixTest:: pg_setup set to default.
[14:38:13.063] <TB1> INFO: 0 hot pixels found in step 0
[14:38:13.067] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[14:38:13.106] <TB1> INFO: PixTest::trimHotPixels() done
[14:38:13.107] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C0.dat
[14:38:13.118] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C1.dat
[14:38:13.124] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C2.dat
[14:38:13.130] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C3.dat
[14:38:13.136] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C4.dat
[14:38:13.142] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C5.dat
[14:38:13.148] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C6.dat
[14:38:13.154] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C7.dat
[14:38:13.160] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C8.dat
[14:38:13.166] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C9.dat
[14:38:13.172] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C10.dat
[14:38:13.178] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C11.dat
[14:38:13.184] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C12.dat
[14:38:13.190] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C13.dat
[14:38:13.196] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C14.dat
[14:38:13.202] <TB1> INFO: write trim parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//trimParameters35_C15.dat
[14:38:13.208] <TB1> INFO: write masked pixels into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//003_RetrimHotPixels_50//defaultMaskFile.dat
[14:38:13.239] <TB1> INFO: enter test to run
[14:38:13.239] <TB1> INFO: test: no parameter change
[14:38:13.438] <TB1> QUIET: Connection to board 147 closed.
[14:38:13.518] <TB1> INFO: pXar: this is the end, my friend
[14:38:50.691] <TB1> INFO: *** Welcome to pxar ***
[14:38:50.691] <TB1> INFO: *** Today: 2016/08/10
[14:38:51.086] <TB1> INFO: *** Version: f5d3-dirty
[14:38:51.086] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//dacParameters35_C15.dat
[14:38:51.087] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//tbmParameters_C0b.dat
[14:38:51.087] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//defaultMaskFile.dat
[14:38:51.087] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//trimParameters35_C15.dat
[14:38:51.159] <TB1> INFO: clk: 4
[14:38:51.159] <TB1> INFO: ctr: 4
[14:38:51.159] <TB1> INFO: sda: 19
[14:38:51.159] <TB1> INFO: tin: 9
[14:38:51.159] <TB1> INFO: level: 15
[14:38:51.159] <TB1> INFO: triggerdelay: 0
[14:38:51.159] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:38:51.159] <TB1> INFO: Log level: INFO
[14:38:51.172] <TB1> INFO: Found DTB DTB_WWXTQT
[14:38:51.187] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[14:38:51.189] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[14:38:51.191] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[14:38:52.781] <TB1> INFO: DUT info:
[14:38:52.781] <TB1> INFO: The DUT currently contains the following objects:
[14:38:52.781] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[14:38:52.781] <TB1> INFO: TBM Core alpha (0): 7 registers set
[14:38:52.781] <TB1> INFO: TBM Core beta (1): 7 registers set
[14:38:52.781] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:38:52.781] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:52.781] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:38:53.182] <TB1> INFO: enter 'restricted' command line mode
[14:38:53.182] <TB1> INFO: enter test to run
[14:38:53.182] <TB1> INFO: test: delay setting parameters: ->5<-
[14:38:53.182] <TB1> INFO: delay test by 5 seconds...
[14:38:58.182] <TB1> INFO: enter test to run
[14:38:58.182] <TB1> INFO: test: Xray no parameter change
[14:38:58.182] <TB1> INFO: running: xray
[14:38:58.182] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//004_HRData_50//phCalibrationFitErr35_C15.dat
[14:38:58.322] <TB1> INFO: ######################################################################
[14:38:58.322] <TB1> INFO: PixTestXray::doTest()
[14:38:58.322] <TB1> INFO: ######################################################################
[14:38:58.322] <TB1> INFO: ----------------------------------------------------------------------
[14:38:58.322] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[14:38:58.322] <TB1> INFO: ----------------------------------------------------------------------
[14:38:59.045] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[14:39:05.510] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[14:39:33.475] <TB1> INFO: Resuming triggers.
[14:39:39.947] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[14:40:08.305] <TB1> INFO: Resuming triggers.
[14:40:14.777] <TB1> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[14:40:42.943] <TB1> INFO: Resuming triggers.
[14:40:49.417] <TB1> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[14:41:17.101] <TB1> INFO: Resuming triggers.
[14:41:23.573] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[14:41:51.501] <TB1> INFO: Resuming triggers.
[14:41:57.972] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[14:42:25.956] <TB1> INFO: Resuming triggers.
[14:42:32.427] <TB1> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[14:43:00.209] <TB1> INFO: Resuming triggers.
[14:43:06.673] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[14:43:35.227] <TB1> INFO: Resuming triggers.
[14:43:41.690] <TB1> INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[14:44:10.415] <TB1> INFO: Resuming triggers.
[14:44:16.879] <TB1> INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[14:44:46.034] <TB1> INFO: Resuming triggers.
[14:44:52.495] <TB1> INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[14:45:20.886] <TB1> INFO: Resuming triggers.
[14:45:27.345] <TB1> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[14:45:55.477] <TB1> INFO: Resuming triggers.
[14:46:01.936] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[14:46:30.637] <TB1> INFO: Resuming triggers.
[14:46:37.093] <TB1> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[14:47:05.578] <TB1> INFO: Resuming triggers.
[14:47:12.034] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[14:47:40.824] <TB1> INFO: Resuming triggers.
[14:47:43.945] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[14:47:58.828] <TB1> INFO: PixTest:: pg_setup set to default.
[14:47:58.829] <TB1> INFO: PixTestXray::doPhRun() done
[14:47:58.829] <TB1> INFO: PixTestXray::doTest() done
[14:47:59.005] <TB1> INFO: enter test to run
[14:47:59.005] <TB1> INFO: test: no parameter change
[14:47:59.244] <TB1> QUIET: Connection to board 147 closed.
[14:47:59.323] <TB1> INFO: pXar: this is the end, my friend
[14:48:42.491] <TB1> INFO: *** Welcome to pxar ***
[14:48:42.491] <TB1> INFO: *** Today: 2016/08/10
[14:48:42.566] <TB1> INFO: *** Version: f5d3-dirty
[14:48:42.566] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//dacParameters35_C15.dat
[14:48:42.567] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//tbmParameters_C0b.dat
[14:48:42.567] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//defaultMaskFile.dat
[14:48:42.567] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//trimParameters35_C15.dat
[14:48:42.651] <TB1> INFO: clk: 4
[14:48:42.651] <TB1> INFO: ctr: 4
[14:48:42.651] <TB1> INFO: sda: 19
[14:48:42.651] <TB1> INFO: tin: 9
[14:48:42.651] <TB1> INFO: level: 15
[14:48:42.651] <TB1> INFO: triggerdelay: 0
[14:48:42.651] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[14:48:42.651] <TB1> INFO: Log level: INFO
[14:48:42.663] <TB1> INFO: Found DTB DTB_WWXTQT
[14:48:42.680] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[14:48:42.682] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[14:48:42.684] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[14:48:44.219] <TB1> INFO: DUT info:
[14:48:44.219] <TB1> INFO: The DUT currently contains the following objects:
[14:48:44.219] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[14:48:44.219] <TB1> INFO: TBM Core alpha (0): 7 registers set
[14:48:44.219] <TB1> INFO: TBM Core beta (1): 7 registers set
[14:48:44.219] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:48:44.219] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.219] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:48:44.620] <TB1> INFO: enter 'restricted' command line mode
[14:48:44.620] <TB1> INFO: enter test to run
[14:48:44.620] <TB1> INFO: test: delay setting parameters: ->5<-
[14:48:44.620] <TB1> INFO: delay test by 5 seconds...
[14:48:49.620] <TB1> INFO: enter test to run
[14:48:49.620] <TB1> INFO: test: Xray no parameter change
[14:48:49.620] <TB1> INFO: running: xray
[14:48:49.621] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//005_HRData_150//phCalibrationFitErr35_C15.dat
[14:48:49.804] <TB1> INFO: ######################################################################
[14:48:49.804] <TB1> INFO: PixTestXray::doTest()
[14:48:49.804] <TB1> INFO: ######################################################################
[14:48:49.804] <TB1> INFO: ----------------------------------------------------------------------
[14:48:49.804] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[14:48:49.804] <TB1> INFO: ----------------------------------------------------------------------
[14:48:50.527] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[14:48:53.969] <TB1> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[14:49:22.027] <TB1> INFO: Resuming triggers.
[14:49:25.481] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[14:49:53.899] <TB1> INFO: Resuming triggers.
[14:49:57.349] <TB1> INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[14:50:26.367] <TB1> INFO: Resuming triggers.
[14:50:29.818] <TB1> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[14:50:58.790] <TB1> INFO: Resuming triggers.
[14:51:02.241] <TB1> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[14:51:30.945] <TB1> INFO: Resuming triggers.
[14:51:34.392] <TB1> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[14:52:02.747] <TB1> INFO: Resuming triggers.
[14:52:06.195] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[14:52:35.130] <TB1> INFO: Resuming triggers.
[14:52:38.577] <TB1> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[14:53:07.215] <TB1> INFO: Resuming triggers.
[14:53:10.663] <TB1> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[14:53:39.045] <TB1> INFO: Resuming triggers.
[14:53:42.491] <TB1> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[14:54:11.754] <TB1> INFO: Resuming triggers.
[14:54:15.201] <TB1> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[14:54:44.004] <TB1> INFO: Resuming triggers.
[14:54:47.449] <TB1> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[14:55:17.130] <TB1> INFO: Resuming triggers.
[14:55:20.575] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[14:55:49.265] <TB1> INFO: Resuming triggers.
[14:55:52.709] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[14:56:21.587] <TB1> INFO: Resuming triggers.
[14:56:25.030] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[14:56:54.280] <TB1> INFO: Resuming triggers.
[14:56:57.724] <TB1> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[14:57:27.113] <TB1> INFO: Resuming triggers.
[14:57:30.556] <TB1> INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[14:57:59.412] <TB1> INFO: Resuming triggers.
[14:58:02.854] <TB1> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[14:58:32.212] <TB1> INFO: Resuming triggers.
[14:58:35.657] <TB1> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[14:59:04.919] <TB1> INFO: Resuming triggers.
[14:59:08.361] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[14:59:37.633] <TB1> INFO: Resuming triggers.
[14:59:41.073] <TB1> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[15:00:10.617] <TB1> INFO: Resuming triggers.
[15:00:14.060] <TB1> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[15:00:43.195] <TB1> INFO: Resuming triggers.
[15:00:46.637] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[15:01:15.341] <TB1> INFO: Resuming triggers.
[15:01:18.782] <TB1> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[15:01:47.945] <TB1> INFO: Resuming triggers.
[15:01:51.386] <TB1> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[15:02:20.533] <TB1> INFO: Resuming triggers.
[15:02:23.974] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[15:02:52.915] <TB1> INFO: Resuming triggers.
[15:02:56.351] <TB1> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[15:03:25.098] <TB1> INFO: Resuming triggers.
[15:03:28.537] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[15:03:57.314] <TB1> INFO: Resuming triggers.
[15:04:00.751] <TB1> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[15:04:31.134] <TB1> INFO: Resuming triggers.
[15:04:31.337] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[15:04:33.376] <TB1> INFO: PixTest:: pg_setup set to default.
[15:04:33.377] <TB1> INFO: PixTestXray::doPhRun() done
[15:04:33.377] <TB1> INFO: PixTestXray::doTest() done
[15:04:33.582] <TB1> INFO: enter test to run
[15:04:33.582] <TB1> INFO: test: no parameter change
[15:04:33.831] <TB1> QUIET: Connection to board 147 closed.
[15:04:33.863] <TB1> INFO: pXar: this is the end, my friend
[15:05:52.421] <TB1> INFO: *** Welcome to pxar ***
[15:05:52.421] <TB1> INFO: *** Today: 2016/08/10
[15:05:52.494] <TB1> INFO: *** Version: f5d3-dirty
[15:05:52.494] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//dacParameters35_C15.dat
[15:05:52.495] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//tbmParameters_C0b.dat
[15:05:52.495] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//defaultMaskFile.dat
[15:05:52.495] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//trimParameters35_C15.dat
[15:05:52.572] <TB1> INFO: clk: 4
[15:05:52.572] <TB1> INFO: ctr: 4
[15:05:52.572] <TB1> INFO: sda: 19
[15:05:52.572] <TB1> INFO: tin: 9
[15:05:52.572] <TB1> INFO: level: 15
[15:05:52.572] <TB1> INFO: triggerdelay: 0
[15:05:52.572] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:05:52.572] <TB1> INFO: Log level: INFO
[15:05:52.585] <TB1> INFO: Found DTB DTB_WWXTQT
[15:05:52.599] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:05:52.601] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:05:52.603] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:05:54.138] <TB1> INFO: DUT info:
[15:05:54.138] <TB1> INFO: The DUT currently contains the following objects:
[15:05:54.138] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:05:54.138] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:05:54.138] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:05:54.138] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:05:54.138] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.138] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:05:54.539] <TB1> INFO: enter 'restricted' command line mode
[15:05:54.539] <TB1> INFO: enter test to run
[15:05:54.539] <TB1> INFO: test: Highrate no parameter change
[15:05:54.539] <TB1> INFO: running: highrate
[15:05:54.539] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[15:05:54.673] <TB1> INFO: ----------------------------------------------------------------------
[15:05:54.673] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[15:05:54.673] <TB1> INFO: ----------------------------------------------------------------------
[15:05:54.678] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[15:05:54.689] <TB1> INFO: dacScan step from 15 .. 34
[15:05:54.689] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[15:05:54.689] <TB1> INFO: run 1 of 1
[15:05:55.170] <TB1> INFO: Expecting 4160000 events.
[15:06:30.738] <TB1> INFO: 448600 events read in total (35165ms).
[15:07:04.679] <TB1> INFO: 898300 events read in total (69106ms).
[15:07:38.921] <TB1> INFO: 1347900 events read in total (103348ms).
[15:08:13.714] <TB1> INFO: 1797700 events read in total (138141ms).
[15:08:48.036] <TB1> INFO: 2247300 events read in total (172463ms).
[15:09:22.787] <TB1> INFO: 2696800 events read in total (207214ms).
[15:09:56.969] <TB1> INFO: 3146150 events read in total (241396ms).
[15:10:30.921] <TB1> INFO: 3595350 events read in total (275348ms).
[15:11:05.481] <TB1> INFO: 4044050 events read in total (309908ms).
[15:11:14.369] <TB1> INFO: 4160000 events read in total (318796ms).
[15:11:14.655] <TB1> INFO: Test took 319965ms.
[15:11:21.415] <TB1> INFO: dacScan step from 35 .. 54
[15:11:21.415] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[15:11:21.415] <TB1> INFO: run 1 of 1
[15:11:21.894] <TB1> INFO: Expecting 4160000 events.
[15:11:55.029] <TB1> INFO: 372300 events read in total (32728ms).
[15:12:27.737] <TB1> INFO: 745200 events read in total (65436ms).
[15:12:59.969] <TB1> INFO: 1117200 events read in total (97668ms).
[15:13:33.351] <TB1> INFO: 1488250 events read in total (131050ms).
[15:14:05.534] <TB1> INFO: 1858100 events read in total (163233ms).
[15:14:38.018] <TB1> INFO: 2226600 events read in total (195717ms).
[15:15:10.983] <TB1> INFO: 2592950 events read in total (228682ms).
[15:15:43.432] <TB1> INFO: 2956550 events read in total (261131ms).
[15:16:15.534] <TB1> INFO: 3317300 events read in total (293233ms).
[15:16:47.647] <TB1> INFO: 3676300 events read in total (325346ms).
[15:17:19.786] <TB1> INFO: 4034450 events read in total (357486ms).
[15:17:31.204] <TB1> INFO: 4160000 events read in total (368903ms).
[15:17:31.405] <TB1> INFO: Test took 369990ms.
[15:17:38.520] <TB1> INFO: dacScan step from 55 .. 74
[15:17:38.521] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[15:17:38.521] <TB1> INFO: run 1 of 1
[15:17:39.002] <TB1> INFO: Expecting 4160000 events.
[15:18:11.581] <TB1> INFO: 333750 events read in total (32177ms).
[15:18:43.165] <TB1> INFO: 668200 events read in total (63761ms).
[15:19:14.827] <TB1> INFO: 1002700 events read in total (95423ms).
[15:19:46.531] <TB1> INFO: 1337200 events read in total (127127ms).
[15:20:18.237] <TB1> INFO: 1671850 events read in total (158833ms).
[15:20:49.781] <TB1> INFO: 2006400 events read in total (190377ms).
[15:21:21.923] <TB1> INFO: 2340850 events read in total (222519ms).
[15:21:53.535] <TB1> INFO: 2675350 events read in total (254131ms).
[15:22:25.043] <TB1> INFO: 3009650 events read in total (285639ms).
[15:22:57.040] <TB1> INFO: 3344000 events read in total (317636ms).
[15:23:28.269] <TB1> INFO: 3678550 events read in total (348865ms).
[15:24:00.259] <TB1> INFO: 4012750 events read in total (380855ms).
[15:24:14.709] <TB1> INFO: 4160000 events read in total (395305ms).
[15:24:14.889] <TB1> INFO: Test took 396368ms.
[15:24:21.895] <TB1> INFO: dacScan step from 75 .. 75
[15:24:21.895] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[15:24:21.895] <TB1> INFO: run 1 of 1
[15:24:22.374] <TB1> INFO: Expecting 208000 events.
[15:24:43.698] <TB1> INFO: 208000 events read in total (20922ms).
[15:24:43.706] <TB1> INFO: Test took 21810ms.
[15:24:44.124] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:45.357] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:46.538] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:47.644] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:48.725] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:49.801] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:50.906] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:51.944] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:52.985] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:54.032] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:55.092] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:56.166] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:57.191] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:58.221] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:24:59.228] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:25:00.242] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[15:25:01.263] <TB1> INFO: PixTest:: pg_setup set to default.
[15:25:01.265] <TB1> INFO: vcal mean: 38.54 38.81 37.54 40.20 40.81 42.22 41.64 42.68 40.94 43.00 43.31 40.23 40.30 38.13 38.96 39.09
[15:25:01.265] <TB1> INFO: vcal RMS: 1.20 1.23 0.99 1.36 1.20 1.44 1.45 1.48 1.30 1.43 1.51 1.45 1.22 1.15 1.29 1.09
[15:25:01.265] <TB1> INFO: number of X-ray hits detected: 213975 230866 186634 311714 340685 422196 383067 402023 348736 414907 428437 314977 301693 196359 229171 223041
[15:25:01.265] <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
[15:25:01.265] <TB1> INFO: X-ray hit rate [MHz/cm2]: 62.7 67.7 54.7 91.4 99.9 123.7 112.3 117.8 102.2 121.6 125.6 92.3 88.4 57.6 67.2 65.4
[15:25:01.265] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[15:25:01.363] <TB1> INFO: enter test to run
[15:25:01.363] <TB1> INFO: test: no parameter change
[15:25:01.593] <TB1> QUIET: Connection to board 147 closed.
[15:25:01.673] <TB1> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[15:44:52.377] <TB1> INFO: *** Welcome to pxar ***
[15:44:52.377] <TB1> INFO: *** Today: 2016/08/10
[15:44:52.443] <TB1> INFO: *** Version: f5d3-dirty
[15:44:52.444] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[15:44:52.444] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[15:44:52.445] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[15:44:52.445] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[15:44:52.521] <TB1> INFO: clk: 4
[15:44:52.521] <TB1> INFO: ctr: 4
[15:44:52.521] <TB1> INFO: sda: 19
[15:44:52.521] <TB1> INFO: tin: 9
[15:44:52.521] <TB1> INFO: level: 15
[15:44:52.521] <TB1> INFO: triggerdelay: 0
[15:44:52.521] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:44:52.521] <TB1> INFO: Log level: INFO
[15:44:52.535] <TB1> INFO: Found DTB DTB_WWXTQT
[15:44:52.549] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:44:52.551] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:44:52.553] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:44:54.106] <TB1> INFO: DUT info:
[15:44:54.106] <TB1> INFO: The DUT currently contains the following objects:
[15:44:54.106] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:44:54.106] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:44:54.106] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:44:54.106] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:44:54.106] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.106] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.107] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.107] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.107] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.107] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.107] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:54.507] <TB1> INFO: enter 'restricted' command line mode
[15:44:54.507] <TB1> INFO: enter test to run
[15:44:54.507] <TB1> INFO: test: HighRate no parameter change
[15:44:54.507] <TB1> INFO: running: highrate
[15:44:54.508] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[15:44:54.642] <TB1> INFO: ----------------------------------------------------------------------
[15:44:54.642] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:44:54.642] <TB1> INFO: ----------------------------------------------------------------------
[15:44:54.735] <TB1> INFO: Expecting 768 events.
[15:44:55.727] <TB1> INFO: 768 events read in total (434ms).
[15:44:55.791] <TB1> INFO: Test took 1144ms.
[15:44:56.276] <TB1> INFO: Expecting 41600 events.
[15:44:59.837] <TB1> INFO: 41600 events read in total (3159ms).
[15:44:59.839] <TB1> INFO: Test took 4045ms.
[15:45:00.438] <TB1> INFO: Expecting 41600 events.
[15:45:04.282] <TB1> INFO: 41600 events read in total (3443ms).
[15:45:04.284] <TB1> INFO: Test took 4338ms.
[15:45:04.883] <TB1> INFO: Expecting 41600 events.
[15:45:08.654] <TB1> INFO: 41600 events read in total (3370ms).
[15:45:08.657] <TB1> INFO: Test took 4267ms.
[15:45:09.259] <TB1> INFO: Expecting 41600 events.
[15:45:13.034] <TB1> INFO: 41600 events read in total (3374ms).
[15:45:13.036] <TB1> INFO: Test took 4267ms.
[15:45:13.631] <TB1> INFO: Expecting 41600 events.
[15:45:17.412] <TB1> INFO: 41600 events read in total (3379ms).
[15:45:17.414] <TB1> INFO: Test took 4268ms.
[15:45:18.038] <TB1> INFO: Expecting 41600 events.
[15:45:21.805] <TB1> INFO: 41600 events read in total (3367ms).
[15:45:21.807] <TB1> INFO: Test took 4278ms.
[15:45:22.397] <TB1> INFO: Expecting 41600 events.
[15:45:26.247] <TB1> INFO: 41600 events read in total (3448ms).
[15:45:26.249] <TB1> INFO: Test took 4334ms.
[15:45:26.836] <TB1> INFO: Expecting 41600 events.
[15:45:30.625] <TB1> INFO: 41600 events read in total (3387ms).
[15:45:30.627] <TB1> INFO: Test took 4271ms.
[15:45:31.219] <TB1> INFO: Expecting 41600 events.
[15:45:35.044] <TB1> INFO: 41600 events read in total (3423ms).
[15:45:35.047] <TB1> INFO: Test took 4309ms.
[15:45:35.643] <TB1> INFO: Expecting 41600 events.
[15:45:39.450] <TB1> INFO: 41600 events read in total (3406ms).
[15:45:39.452] <TB1> INFO: Test took 4290ms.
[15:45:40.039] <TB1> INFO: Expecting 41600 events.
[15:45:43.765] <TB1> INFO: 41600 events read in total (3325ms).
[15:45:43.767] <TB1> INFO: Test took 4207ms.
[15:45:44.357] <TB1> INFO: Expecting 41600 events.
[15:45:48.224] <TB1> INFO: 41600 events read in total (3465ms).
[15:45:48.226] <TB1> INFO: Test took 4351ms.
[15:45:48.821] <TB1> INFO: Expecting 41600 events.
[15:45:52.631] <TB1> INFO: 41600 events read in total (3408ms).
[15:45:52.633] <TB1> INFO: Test took 4290ms.
[15:45:53.225] <TB1> INFO: Expecting 41600 events.
[15:45:56.984] <TB1> INFO: 41600 events read in total (3358ms).
[15:45:56.986] <TB1> INFO: Test took 4243ms.
[15:45:57.575] <TB1> INFO: Expecting 41600 events.
[15:46:01.363] <TB1> INFO: 41600 events read in total (3387ms).
[15:46:01.365] <TB1> INFO: Test took 4269ms.
[15:46:01.950] <TB1> INFO: Expecting 41600 events.
[15:46:05.800] <TB1> INFO: 41600 events read in total (3449ms).
[15:46:05.802] <TB1> INFO: Test took 4332ms.
[15:46:06.390] <TB1> INFO: Expecting 41600 events.
[15:46:10.116] <TB1> INFO: 41600 events read in total (3324ms).
[15:46:10.118] <TB1> INFO: Test took 4210ms.
[15:46:10.745] <TB1> INFO: Expecting 41600 events.
[15:46:14.478] <TB1> INFO: 41600 events read in total (3332ms).
[15:46:14.480] <TB1> INFO: Test took 4240ms.
[15:46:15.078] <TB1> INFO: Expecting 41600 events.
[15:46:18.829] <TB1> INFO: 41600 events read in total (3349ms).
[15:46:18.831] <TB1> INFO: Test took 4238ms.
[15:46:19.409] <TB1> INFO: Expecting 41600 events.
[15:46:22.962] <TB1> INFO: 41600 events read in total (3152ms).
[15:46:22.963] <TB1> INFO: Test took 4030ms.
[15:46:23.328] <TB1> INFO: enter test to run
[15:46:23.328] <TB1> INFO: test: Pretest no parameter change
[15:46:23.328] <TB1> INFO: running: pretest
[15:46:23.328] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[15:46:23.328] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[15:46:23.328] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[15:46:23.328] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[15:46:23.328] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[15:46:23.329] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[15:46:23.330] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[15:46:23.330] <TB1> INFO: write dac parameters into /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[15:46:23.330] <TB1> INFO: enter test to run
[15:46:23.330] <TB1> INFO: test: no parameter change
[15:46:23.560] <TB1> QUIET: Connection to board 147 closed.
[15:46:23.640] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[15:47:01.253] <TB1> INFO: *** Welcome to pxar ***
[15:47:01.253] <TB1> INFO: *** Today: 2016/08/10
[15:47:01.314] <TB1> INFO: *** Version: f5d3-dirty
[15:47:01.314] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//dacParameters35_C15.dat
[15:47:01.314] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//tbmParameters_C0b.dat
[15:47:01.314] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//defaultMaskFile.dat
[15:47:01.314] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//trimParameters35_C15.dat
[15:47:01.385] <TB1> INFO: clk: 4
[15:47:01.385] <TB1> INFO: ctr: 4
[15:47:01.385] <TB1> INFO: sda: 19
[15:47:01.385] <TB1> INFO: tin: 9
[15:47:01.385] <TB1> INFO: level: 15
[15:47:01.385] <TB1> INFO: triggerdelay: 0
[15:47:01.385] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:47:01.385] <TB1> INFO: Log level: INFO
[15:47:01.399] <TB1> INFO: Found DTB DTB_WWXTQT
[15:47:01.413] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:47:01.415] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:47:01.417] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:47:02.969] <TB1> INFO: DUT info:
[15:47:02.969] <TB1> INFO: The DUT currently contains the following objects:
[15:47:02.969] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:47:02.969] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:47:02.969] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:47:02.969] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:47:02.969] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:02.969] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:47:03.370] <TB1> INFO: enter 'restricted' command line mode
[15:47:03.370] <TB1> INFO: enter test to run
[15:47:03.370] <TB1> INFO: test: PixelAlive no parameter change
[15:47:03.370] <TB1> INFO: running: pixelalive
[15:47:03.375] <TB1> INFO: ######################################################################
[15:47:03.375] <TB1> INFO: PixTestAlive::doTest()
[15:47:03.375] <TB1> INFO: ######################################################################
[15:47:03.376] <TB1> INFO: ----------------------------------------------------------------------
[15:47:03.376] <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)
[15:47:03.376] <TB1> INFO: ----------------------------------------------------------------------
[15:47:03.635] <TB1> INFO: Expecting 208000 events.
[15:47:15.047] <TB1> INFO: 208000 events read in total (10854ms).
[15:47:15.049] <TB1> INFO: Test took 11671ms.
[15:47:15.274] <TB1> INFO: PixTestAlive::aliveTest() done
[15:47:15.274] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:47:15.275] <TB1> INFO: ----------------------------------------------------------------------
[15:47:15.275] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:47:15.275] <TB1> INFO: ----------------------------------------------------------------------
[15:47:15.535] <TB1> INFO: Expecting 208000 events.
[15:47:22.907] <TB1> INFO: 208000 events read in total (6815ms).
[15:47:22.908] <TB1> INFO: Test took 7631ms.
[15:47:22.908] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:47:23.153] <TB1> INFO: PixTestAlive::maskTest() done
[15:47:23.153] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:47:23.154] <TB1> INFO: ----------------------------------------------------------------------
[15:47:23.154] <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)
[15:47:23.154] <TB1> INFO: ----------------------------------------------------------------------
[15:47:23.418] <TB1> INFO: Expecting 208000 events.
[15:47:34.488] <TB1> INFO: 208000 events read in total (10514ms).
[15:47:34.489] <TB1> INFO: Test took 11333ms.
[15:47:34.687] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:47:34.687] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:47:34.687] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[15:47:34.724] <TB1> INFO: enter test to run
[15:47:34.724] <TB1> INFO: test: delay setting parameters: ->2<-
[15:47:34.724] <TB1> INFO: delay test by 2 seconds...
[15:47:36.724] <TB1> INFO: enter test to run
[15:47:36.724] <TB1> INFO: test: HighRate no parameter change
[15:47:36.724] <TB1> INFO: running: highrate
[15:47:36.724] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[15:47:36.895] <TB1> INFO: ----------------------------------------------------------------------
[15:47:36.895] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:47:36.895] <TB1> INFO: ----------------------------------------------------------------------
[15:47:37.405] <TB1> INFO: Expecting 208000 events.
[15:47:53.273] <TB1> INFO: 208000 events read in total (15467ms).
[15:47:53.279] <TB1> INFO: Test took 16381ms.
[15:47:53.830] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:47:53.830] <TB1> INFO: number of red-efficiency pixels: 111 162 102 220 274 363 314 324 230 334 412 275 237 115 136 188
[15:47:53.830] <TB1> INFO: number of X-ray hits detected: 104820 112580 89503 151340 167079 210323 188846 199938 171637 205170 215707 153800 147289 94367 112272 108522
[15:47:53.830] <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
[15:47:53.830] <TB1> INFO: number of Vcal hits detected: 207887 207834 207893 207769 207708 207615 207669 207662 207757 207650 207554 207714 207749 207879 207812 207809
[15:47:53.830] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 100.0 99.9 99.9 99.8 99.9 99.9 99.9 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[15:47:53.830] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.9 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[15:47:53.830] <TB1> INFO: X-ray hit rate [MHz/cm2]: 30.7 33.0 26.2 44.4 49.0 61.6 55.4 58.6 50.3 60.1 63.2 45.1 43.2 27.7 32.9 31.8
[15:47:53.830] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[15:47:53.860] <TB1> INFO: PixTest:: pg_setup set to default.
[15:47:53.868] <TB1> INFO: enter test to run
[15:47:53.868] <TB1> INFO: test: no parameter change
[15:47:54.130] <TB1> QUIET: Connection to board 147 closed.
[15:47:54.210] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[15:48:28.662] <TB1> INFO: *** Welcome to pxar ***
[15:48:28.662] <TB1> INFO: *** Today: 2016/08/10
[15:48:28.728] <TB1> INFO: *** Version: f5d3-dirty
[15:48:28.728] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//dacParameters35_C15.dat
[15:48:28.728] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//tbmParameters_C0b.dat
[15:48:28.728] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//defaultMaskFile.dat
[15:48:28.728] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//trimParameters35_C15.dat
[15:48:28.801] <TB1> INFO: clk: 4
[15:48:28.801] <TB1> INFO: ctr: 4
[15:48:28.801] <TB1> INFO: sda: 19
[15:48:28.801] <TB1> INFO: tin: 9
[15:48:28.801] <TB1> INFO: level: 15
[15:48:28.801] <TB1> INFO: triggerdelay: 0
[15:48:28.801] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:48:28.801] <TB1> INFO: Log level: INFO
[15:48:28.814] <TB1> INFO: Found DTB DTB_WWXTQT
[15:48:28.827] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:48:28.829] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:48:28.830] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:48:30.361] <TB1> INFO: DUT info:
[15:48:30.361] <TB1> INFO: The DUT currently contains the following objects:
[15:48:30.361] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:48:30.361] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:48:30.361] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:48:30.361] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:48:30.361] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.361] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.361] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.361] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.361] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.361] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.361] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.361] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.362] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.362] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.362] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.362] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.362] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.362] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.362] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.362] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:48:30.762] <TB1> INFO: enter 'restricted' command line mode
[15:48:30.762] <TB1> INFO: enter test to run
[15:48:30.762] <TB1> INFO: test: PixelAlive no parameter change
[15:48:30.762] <TB1> INFO: running: pixelalive
[15:48:30.766] <TB1> INFO: ######################################################################
[15:48:30.766] <TB1> INFO: PixTestAlive::doTest()
[15:48:30.766] <TB1> INFO: ######################################################################
[15:48:30.767] <TB1> INFO: ----------------------------------------------------------------------
[15:48:30.767] <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)
[15:48:30.767] <TB1> INFO: ----------------------------------------------------------------------
[15:48:31.030] <TB1> INFO: Expecting 208000 events.
[15:48:42.228] <TB1> INFO: 208000 events read in total (10640ms).
[15:48:42.229] <TB1> INFO: Test took 11461ms.
[15:48:42.460] <TB1> INFO: PixTestAlive::aliveTest() done
[15:48:42.460] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:48:42.461] <TB1> INFO: ----------------------------------------------------------------------
[15:48:42.461] <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)
[15:48:42.461] <TB1> INFO: ----------------------------------------------------------------------
[15:48:42.755] <TB1> INFO: Expecting 208000 events.
[15:48:50.108] <TB1> INFO: 208000 events read in total (6797ms).
[15:48:50.108] <TB1> INFO: Test took 7644ms.
[15:48:50.108] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:48:50.354] <TB1> INFO: PixTestAlive::maskTest() done
[15:48:50.354] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:48:50.355] <TB1> INFO: ----------------------------------------------------------------------
[15:48:50.355] <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)
[15:48:50.355] <TB1> INFO: ----------------------------------------------------------------------
[15:48:50.617] <TB1> INFO: Expecting 208000 events.
[15:49:01.631] <TB1> INFO: 208000 events read in total (10458ms).
[15:49:01.631] <TB1> INFO: Test took 11275ms.
[15:49:01.832] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:49:01.832] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:49:01.832] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[15:49:01.867] <TB1> INFO: enter test to run
[15:49:01.867] <TB1> INFO: test: delay setting parameters: ->2<-
[15:49:01.867] <TB1> INFO: delay test by 2 seconds...
[15:49:03.867] <TB1> INFO: enter test to run
[15:49:03.867] <TB1> INFO: test: HighRate no parameter change
[15:49:03.867] <TB1> INFO: running: highrate
[15:49:03.867] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[15:49:04.001] <TB1> INFO: ----------------------------------------------------------------------
[15:49:04.001] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:49:04.001] <TB1> INFO: ----------------------------------------------------------------------
[15:49:04.486] <TB1> INFO: Expecting 208000 events.
[15:49:22.179] <TB1> INFO: 208000 events read in total (17291ms).
[15:49:22.186] <TB1> INFO: Test took 18182ms.
[15:49:22.872] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:49:22.872] <TB1> INFO: number of red-efficiency pixels: 244 293 193 444 535 804 656 608 531 730 799 545 424 231 251 286
[15:49:22.872] <TB1> INFO: number of X-ray hits detected: 155398 165744 134398 224794 245658 309226 278211 294173 254013 302519 314597 227946 217421 141419 165900 161257
[15:49:22.872] <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
[15:49:22.872] <TB1> INFO: number of Vcal hits detected: 207750 207691 207804 207520 207395 207064 207253 207320 207423 207145 207053 207395 207542 207749 207691 207700
[15:49:22.872] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.6 99.7 99.7 99.7 99.6 99.6 99.7 99.8 99.9 99.9 99.9
[15:49:22.872] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.6 99.6 99.7 99.7 99.6 99.5 99.7 99.8 99.9 99.9 99.9
[15:49:22.872] <TB1> INFO: X-ray hit rate [MHz/cm2]: 45.5 48.6 39.4 65.9 72.0 90.6 81.5 86.2 74.5 88.7 92.2 66.8 63.7 41.5 48.6 47.3
[15:49:22.872] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[15:49:22.901] <TB1> INFO: PixTest:: pg_setup set to default.
[15:49:22.914] <TB1> INFO: enter test to run
[15:49:22.914] <TB1> INFO: test: no parameter change
[15:49:23.245] <TB1> QUIET: Connection to board 147 closed.
[15:49:23.324] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[15:49:57.349] <TB1> INFO: *** Welcome to pxar ***
[15:49:57.349] <TB1> INFO: *** Today: 2016/08/10
[15:49:57.420] <TB1> INFO: *** Version: f5d3-dirty
[15:49:57.420] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//dacParameters35_C15.dat
[15:49:57.421] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//tbmParameters_C0b.dat
[15:49:57.421] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//defaultMaskFile.dat
[15:49:57.421] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//trimParameters35_C15.dat
[15:49:57.496] <TB1> INFO: clk: 4
[15:49:57.496] <TB1> INFO: ctr: 4
[15:49:57.496] <TB1> INFO: sda: 19
[15:49:57.496] <TB1> INFO: tin: 9
[15:49:57.496] <TB1> INFO: level: 15
[15:49:57.496] <TB1> INFO: triggerdelay: 0
[15:49:57.496] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:49:57.496] <TB1> INFO: Log level: INFO
[15:49:57.509] <TB1> INFO: Found DTB DTB_WWXTQT
[15:49:57.524] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:49:57.526] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:49:57.528] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:49:59.105] <TB1> INFO: DUT info:
[15:49:59.105] <TB1> INFO: The DUT currently contains the following objects:
[15:49:59.105] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:49:59.105] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:49:59.105] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:49:59.105] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:49:59.105] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.105] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:59.506] <TB1> INFO: enter 'restricted' command line mode
[15:49:59.506] <TB1> INFO: enter test to run
[15:49:59.506] <TB1> INFO: test: PixelAlive no parameter change
[15:49:59.506] <TB1> INFO: running: pixelalive
[15:49:59.511] <TB1> INFO: ######################################################################
[15:49:59.511] <TB1> INFO: PixTestAlive::doTest()
[15:49:59.511] <TB1> INFO: ######################################################################
[15:49:59.512] <TB1> INFO: ----------------------------------------------------------------------
[15:49:59.512] <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)
[15:49:59.512] <TB1> INFO: ----------------------------------------------------------------------
[15:49:59.783] <TB1> INFO: Expecting 208000 events.
[15:50:10.832] <TB1> INFO: 208000 events read in total (10490ms).
[15:50:10.834] <TB1> INFO: Test took 11320ms.
[15:50:11.064] <TB1> INFO: PixTestAlive::aliveTest() done
[15:50:11.064] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:50:11.066] <TB1> INFO: ----------------------------------------------------------------------
[15:50:11.066] <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)
[15:50:11.066] <TB1> INFO: ----------------------------------------------------------------------
[15:50:11.331] <TB1> INFO: Expecting 208000 events.
[15:50:18.767] <TB1> INFO: 208000 events read in total (6880ms).
[15:50:18.767] <TB1> INFO: Test took 7699ms.
[15:50:18.768] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:50:19.012] <TB1> INFO: PixTestAlive::maskTest() done
[15:50:19.012] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:50:19.014] <TB1> INFO: ----------------------------------------------------------------------
[15:50:19.014] <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)
[15:50:19.014] <TB1> INFO: ----------------------------------------------------------------------
[15:50:19.274] <TB1> INFO: Expecting 208000 events.
[15:50:30.520] <TB1> INFO: 208000 events read in total (10690ms).
[15:50:30.521] <TB1> INFO: Test took 11506ms.
[15:50:30.723] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:50:30.723] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:50:30.723] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[15:50:30.757] <TB1> INFO: enter test to run
[15:50:30.757] <TB1> INFO: test: delay setting parameters: ->2<-
[15:50:30.757] <TB1> INFO: delay test by 2 seconds...
[15:50:32.757] <TB1> INFO: enter test to run
[15:50:32.757] <TB1> INFO: test: HighRate no parameter change
[15:50:32.757] <TB1> INFO: running: highrate
[15:50:32.757] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[15:50:32.916] <TB1> INFO: ----------------------------------------------------------------------
[15:50:32.916] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:50:32.916] <TB1> INFO: ----------------------------------------------------------------------
[15:50:33.428] <TB1> INFO: Expecting 208000 events.
[15:50:52.894] <TB1> INFO: 208000 events read in total (19065ms).
[15:50:52.903] <TB1> INFO: Test took 19984ms.
[15:50:53.786] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:50:53.786] <TB1> INFO: number of red-efficiency pixels: 358 518 340 815 1024 1547 1246 1344 1011 1404 1582 989 828 411 407 543
[15:50:53.786] <TB1> INFO: number of X-ray hits detected: 214213 230078 186482 309794 340622 422840 382883 404086 348168 415897 429930 315242 301116 196593 228494 222473
[15:50:53.786] <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
[15:50:53.786] <TB1> INFO: number of Vcal hits detected: 207614 207434 207615 207039 206649 205759 206243 206274 206762 206054 205825 206722 207009 207535 207515 207397
[15:50:53.786] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.7 99.8 99.6 99.4 99.1 99.3 99.3 99.5 99.2 99.1 99.5 99.6 99.8 99.8 99.7
[15:50:53.786] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.8 99.5 99.4 98.9 99.2 99.2 99.4 99.1 99.0 99.4 99.5 99.8 99.8 99.7
[15:50:53.786] <TB1> INFO: X-ray hit rate [MHz/cm2]: 62.8 67.4 54.7 90.8 99.8 123.9 112.2 118.4 102.1 121.9 126.0 92.4 88.3 57.6 67.0 65.2
[15:50:53.786] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[15:50:53.816] <TB1> INFO: PixTest:: pg_setup set to default.
[15:50:53.832] <TB1> INFO: enter test to run
[15:50:53.832] <TB1> INFO: test: no parameter change
[15:50:54.076] <TB1> QUIET: Connection to board 147 closed.
[15:50:54.156] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[15:51:32.480] <TB1> INFO: *** Welcome to pxar ***
[15:51:32.480] <TB1> INFO: *** Today: 2016/08/10
[15:51:32.550] <TB1> INFO: *** Version: f5d3-dirty
[15:51:32.550] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//dacParameters35_C15.dat
[15:51:32.551] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//tbmParameters_C0b.dat
[15:51:32.551] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//defaultMaskFile.dat
[15:51:32.551] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//trimParameters35_C15.dat
[15:51:32.622] <TB1> INFO: clk: 4
[15:51:32.622] <TB1> INFO: ctr: 4
[15:51:32.622] <TB1> INFO: sda: 19
[15:51:32.622] <TB1> INFO: tin: 9
[15:51:32.622] <TB1> INFO: level: 15
[15:51:32.622] <TB1> INFO: triggerdelay: 0
[15:51:32.622] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:51:32.622] <TB1> INFO: Log level: INFO
[15:51:32.635] <TB1> INFO: Found DTB DTB_WWXTQT
[15:51:32.649] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:51:32.651] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:51:32.653] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:51:34.201] <TB1> INFO: DUT info:
[15:51:34.201] <TB1> INFO: The DUT currently contains the following objects:
[15:51:34.201] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:51:34.201] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:51:34.201] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:51:34.201] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:51:34.201] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.201] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.201] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.201] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.201] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.202] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:51:34.602] <TB1> INFO: enter 'restricted' command line mode
[15:51:34.602] <TB1> INFO: enter test to run
[15:51:34.602] <TB1> INFO: test: PixelAlive no parameter change
[15:51:34.602] <TB1> INFO: running: pixelalive
[15:51:34.606] <TB1> INFO: ######################################################################
[15:51:34.606] <TB1> INFO: PixTestAlive::doTest()
[15:51:34.606] <TB1> INFO: ######################################################################
[15:51:34.608] <TB1> INFO: ----------------------------------------------------------------------
[15:51:34.608] <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)
[15:51:34.608] <TB1> INFO: ----------------------------------------------------------------------
[15:51:34.867] <TB1> INFO: Expecting 208000 events.
[15:51:46.021] <TB1> INFO: 208000 events read in total (10596ms).
[15:51:46.022] <TB1> INFO: Test took 11413ms.
[15:51:46.254] <TB1> INFO: PixTestAlive::aliveTest() done
[15:51:46.254] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:51:46.256] <TB1> INFO: ----------------------------------------------------------------------
[15:51:46.256] <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)
[15:51:46.256] <TB1> INFO: ----------------------------------------------------------------------
[15:51:46.526] <TB1> INFO: Expecting 208000 events.
[15:51:53.797] <TB1> INFO: 208000 events read in total (6714ms).
[15:51:53.798] <TB1> INFO: Test took 7541ms.
[15:51:53.798] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:51:54.041] <TB1> INFO: PixTestAlive::maskTest() done
[15:51:54.041] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:51:54.043] <TB1> INFO: ----------------------------------------------------------------------
[15:51:54.043] <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)
[15:51:54.043] <TB1> INFO: ----------------------------------------------------------------------
[15:51:54.304] <TB1> INFO: Expecting 208000 events.
[15:52:05.309] <TB1> INFO: 208000 events read in total (10449ms).
[15:52:05.309] <TB1> INFO: Test took 11265ms.
[15:52:05.511] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:52:05.512] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:52:05.512] <TB1> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[15:52:05.541] <TB1> INFO: enter test to run
[15:52:05.541] <TB1> INFO: test: delay setting parameters: ->2<-
[15:52:05.541] <TB1> INFO: delay test by 2 seconds...
[15:52:07.541] <TB1> INFO: enter test to run
[15:52:07.541] <TB1> INFO: test: HighRate no parameter change
[15:52:07.541] <TB1> INFO: running: highrate
[15:52:07.541] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[15:52:07.672] <TB1> INFO: ----------------------------------------------------------------------
[15:52:07.672] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:52:07.672] <TB1> INFO: ----------------------------------------------------------------------
[15:52:08.155] <TB1> INFO: Expecting 208000 events.
[15:52:31.161] <TB1> INFO: 208000 events read in total (22605ms).
[15:52:31.175] <TB1> INFO: Test took 23500ms.
[15:52:32.443] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:52:32.443] <TB1> INFO: number of red-efficiency pixels: 547 822 491 1200 1488 2173 1778 1913 1461 1957 2125 1477 1210 575 605 787
[15:52:32.443] <TB1> INFO: number of X-ray hits detected: 260681 281715 230349 377995 413977 513651 464030 491516 425938 504132 522087 384839 366203 240815 279107 271115
[15:52:32.443] <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
[15:52:32.443] <TB1> INFO: number of Vcal hits detected: 207393 207058 207405 206378 205799 204225 204993 205232 206009 204685 204471 205852 206405 207267 207295 207094
[15:52:32.443] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.7 99.6 99.8 99.3 99.1 98.4 98.8 98.8 99.1 98.6 98.5 99.1 99.3 99.7 99.7 99.6
[15:52:32.443] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.5 99.7 99.2 98.9 98.2 98.6 98.7 99.0 98.4 98.3 99.0 99.2 99.6 99.7 99.6
[15:52:32.443] <TB1> INFO: X-ray hit rate [MHz/cm2]: 76.4 82.6 67.5 110.8 121.3 150.6 136.0 144.1 124.8 147.8 153.0 112.8 107.3 70.6 81.8 79.5
[15:52:32.443] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[15:52:32.473] <TB1> INFO: PixTest:: pg_setup set to default.
[15:52:32.489] <TB1> INFO: enter test to run
[15:52:32.489] <TB1> INFO: test: no parameter change
[15:52:32.807] <TB1> QUIET: Connection to board 147 closed.
[15:52:32.887] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[15:53:07.422] <TB1> INFO: *** Welcome to pxar ***
[15:53:07.422] <TB1> INFO: *** Today: 2016/08/10
[15:53:07.493] <TB1> INFO: *** Version: f5d3-dirty
[15:53:07.493] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//dacParameters35_C15.dat
[15:53:07.493] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//tbmParameters_C0b.dat
[15:53:07.493] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//defaultMaskFile.dat
[15:53:07.494] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//trimParameters35_C15.dat
[15:53:07.568] <TB1> INFO: clk: 4
[15:53:07.568] <TB1> INFO: ctr: 4
[15:53:07.568] <TB1> INFO: sda: 19
[15:53:07.568] <TB1> INFO: tin: 9
[15:53:07.568] <TB1> INFO: level: 15
[15:53:07.568] <TB1> INFO: triggerdelay: 0
[15:53:07.568] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:53:07.568] <TB1> INFO: Log level: INFO
[15:53:07.582] <TB1> INFO: Found DTB DTB_WWXTQT
[15:53:07.596] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:53:07.598] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:53:07.600] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:53:09.177] <TB1> INFO: DUT info:
[15:53:09.177] <TB1> INFO: The DUT currently contains the following objects:
[15:53:09.177] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:53:09.177] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:53:09.177] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:53:09.177] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:53:09.177] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.177] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.177] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.177] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.178] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:09.578] <TB1> INFO: enter 'restricted' command line mode
[15:53:09.579] <TB1> INFO: enter test to run
[15:53:09.579] <TB1> INFO: test: PixelAlive no parameter change
[15:53:09.579] <TB1> INFO: running: pixelalive
[15:53:09.583] <TB1> INFO: ######################################################################
[15:53:09.583] <TB1> INFO: PixTestAlive::doTest()
[15:53:09.583] <TB1> INFO: ######################################################################
[15:53:09.585] <TB1> INFO: ----------------------------------------------------------------------
[15:53:09.585] <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)
[15:53:09.585] <TB1> INFO: ----------------------------------------------------------------------
[15:53:09.865] <TB1> INFO: Expecting 208000 events.
[15:53:21.658] <TB1> INFO: 208000 events read in total (11235ms).
[15:53:21.660] <TB1> INFO: Test took 12073ms.
[15:53:21.892] <TB1> INFO: PixTestAlive::aliveTest() done
[15:53:21.892] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:53:21.894] <TB1> INFO: ----------------------------------------------------------------------
[15:53:21.894] <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)
[15:53:21.894] <TB1> INFO: ----------------------------------------------------------------------
[15:53:22.166] <TB1> INFO: Expecting 208000 events.
[15:53:29.686] <TB1> INFO: 208000 events read in total (6964ms).
[15:53:29.687] <TB1> INFO: Test took 7791ms.
[15:53:29.687] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:53:29.930] <TB1> INFO: PixTestAlive::maskTest() done
[15:53:29.930] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:53:29.931] <TB1> INFO: ----------------------------------------------------------------------
[15:53:29.931] <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)
[15:53:29.931] <TB1> INFO: ----------------------------------------------------------------------
[15:53:30.192] <TB1> INFO: Expecting 208000 events.
[15:53:41.459] <TB1> INFO: 208000 events read in total (10711ms).
[15:53:41.459] <TB1> INFO: Test took 11526ms.
[15:53:41.660] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:53:41.660] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:53:41.660] <TB1> INFO: PixTestAlive::doTest() done, duration: 32 seconds
[15:53:41.698] <TB1> INFO: enter test to run
[15:53:41.698] <TB1> INFO: test: delay setting parameters: ->2<-
[15:53:41.699] <TB1> INFO: delay test by 2 seconds...
[15:53:43.699] <TB1> INFO: enter test to run
[15:53:43.699] <TB1> INFO: test: HighRate no parameter change
[15:53:43.699] <TB1> INFO: running: highrate
[15:53:43.699] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[15:53:43.840] <TB1> INFO: ----------------------------------------------------------------------
[15:53:43.841] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:53:43.841] <TB1> INFO: ----------------------------------------------------------------------
[15:53:44.338] <TB1> INFO: Expecting 208000 events.
[15:54:08.651] <TB1> INFO: 208000 events read in total (23912ms).
[15:54:08.667] <TB1> INFO: Test took 24823ms.
[15:54:09.853] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:54:09.853] <TB1> INFO: number of red-efficiency pixels: 788 1206 691 1732 2082 2834 2429 2608 2061 2668 2836 2051 1663 763 931 1070
[15:54:09.853] <TB1> INFO: number of X-ray hits detected: 310802 335562 275847 451123 494979 611204 553136 585394 507971 601667 619478 458924 436535 286323 333880 323885
[15:54:09.853] <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
[15:54:09.853] <TB1> INFO: number of Vcal hits detected: 207088 206482 207031 205318 204368 201716 203035 203454 204696 202521 201859 204380 205543 206899 206882 206670
[15:54:09.853] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.3 99.6 98.9 98.5 97.4 98.0 98.0 98.6 97.7 97.4 98.5 99.0 99.5 99.5 99.4
[15:54:09.853] <TB1> INFO: Vcal hit overall efficiency (%): 99.6 99.3 99.5 98.7 98.3 97.0 97.6 97.8 98.4 97.4 97.0 98.3 98.8 99.5 99.5 99.4
[15:54:09.853] <TB1> INFO: X-ray hit rate [MHz/cm2]: 91.1 98.4 80.9 132.2 145.1 179.1 162.1 171.6 148.9 176.4 181.6 134.5 128.0 83.9 97.9 94.9
[15:54:09.853] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[15:54:09.882] <TB1> INFO: PixTest:: pg_setup set to default.
[15:54:09.894] <TB1> INFO: enter test to run
[15:54:09.894] <TB1> INFO: test: no parameter change
[15:54:10.139] <TB1> QUIET: Connection to board 147 closed.
[15:54:10.219] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[15:54:48.185] <TB1> INFO: *** Welcome to pxar ***
[15:54:48.185] <TB1> INFO: *** Today: 2016/08/10
[15:54:48.269] <TB1> INFO: *** Version: f5d3-dirty
[15:54:48.269] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//dacParameters35_C15.dat
[15:54:48.270] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//tbmParameters_C0b.dat
[15:54:48.270] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//defaultMaskFile.dat
[15:54:48.270] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//trimParameters35_C15.dat
[15:54:48.341] <TB1> INFO: clk: 4
[15:54:48.341] <TB1> INFO: ctr: 4
[15:54:48.341] <TB1> INFO: sda: 19
[15:54:48.341] <TB1> INFO: tin: 9
[15:54:48.341] <TB1> INFO: level: 15
[15:54:48.341] <TB1> INFO: triggerdelay: 0
[15:54:48.341] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:54:48.341] <TB1> INFO: Log level: INFO
[15:54:48.353] <TB1> INFO: Found DTB DTB_WWXTQT
[15:54:48.368] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:54:48.370] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:54:48.372] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:54:49.924] <TB1> INFO: DUT info:
[15:54:49.924] <TB1> INFO: The DUT currently contains the following objects:
[15:54:49.924] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:54:49.924] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:54:49.924] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:54:49.924] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:54:49.924] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:49.924] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:50.325] <TB1> INFO: enter 'restricted' command line mode
[15:54:50.325] <TB1> INFO: enter test to run
[15:54:50.325] <TB1> INFO: test: PixelAlive no parameter change
[15:54:50.325] <TB1> INFO: running: pixelalive
[15:54:50.328] <TB1> INFO: ######################################################################
[15:54:50.328] <TB1> INFO: PixTestAlive::doTest()
[15:54:50.328] <TB1> INFO: ######################################################################
[15:54:50.329] <TB1> INFO: ----------------------------------------------------------------------
[15:54:50.329] <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)
[15:54:50.329] <TB1> INFO: ----------------------------------------------------------------------
[15:54:50.592] <TB1> INFO: Expecting 208000 events.
[15:55:02.317] <TB1> INFO: 208000 events read in total (11166ms).
[15:55:02.319] <TB1> INFO: Test took 11988ms.
[15:55:02.558] <TB1> INFO: PixTestAlive::aliveTest() done
[15:55:02.558] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:55:02.560] <TB1> INFO: ----------------------------------------------------------------------
[15:55:02.560] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:55:02.560] <TB1> INFO: ----------------------------------------------------------------------
[15:55:02.856] <TB1> INFO: Expecting 208000 events.
[15:55:10.369] <TB1> INFO: 208000 events read in total (6956ms).
[15:55:10.370] <TB1> INFO: Test took 7808ms.
[15:55:10.370] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:55:10.615] <TB1> INFO: PixTestAlive::maskTest() done
[15:55:10.615] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:55:10.616] <TB1> INFO: ----------------------------------------------------------------------
[15:55:10.616] <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)
[15:55:10.616] <TB1> INFO: ----------------------------------------------------------------------
[15:55:10.910] <TB1> INFO: Expecting 208000 events.
[15:55:22.105] <TB1> INFO: 208000 events read in total (10639ms).
[15:55:22.106] <TB1> INFO: Test took 11489ms.
[15:55:22.309] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:55:22.309] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:55:22.309] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[15:55:22.348] <TB1> INFO: enter test to run
[15:55:22.348] <TB1> INFO: test: delay setting parameters: ->2<-
[15:55:22.348] <TB1> INFO: delay test by 2 seconds...
[15:55:24.348] <TB1> INFO: enter test to run
[15:55:24.348] <TB1> INFO: test: HighRate no parameter change
[15:55:24.348] <TB1> INFO: running: highrate
[15:55:24.348] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[15:55:24.541] <TB1> INFO: ----------------------------------------------------------------------
[15:55:24.541] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:55:24.541] <TB1> INFO: ----------------------------------------------------------------------
[15:55:25.027] <TB1> INFO: Expecting 208000 events.
[15:55:56.127] <TB1> INFO: 208000 events read in total (30698ms).
[15:55:56.145] <TB1> INFO: Test took 31601ms.
[15:55:57.678] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:55:57.678] <TB1> INFO: number of red-efficiency pixels: 1470 2215 1188 2844 3212 3866 3537 3784 3313 3750 3867 3267 2866 1351 1697 1970
[15:55:57.678] <TB1> INFO: number of X-ray hits detected: 424754 459400 376603 616009 673823 828701 750267 793857 688821 817785 834297 625185 593052 395613 454860 443731
[15:55:57.678] <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
[15:55:57.678] <TB1> INFO: number of Vcal hits detected: 205945 204498 205807 201606 199105 192697 196175 196360 199692 193950 193223 199293 201795 205202 205630 204892
[15:55:57.678] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.1 98.4 99.1 97.3 96.3 93.5 95.1 94.8 96.4 94.0 93.7 96.3 97.4 98.9 99.0 98.7
[15:55:57.678] <TB1> INFO: Vcal hit overall efficiency (%): 99.0 98.3 98.9 96.9 95.7 92.6 94.3 94.4 96.0 93.2 92.9 95.8 97.0 98.7 98.9 98.5
[15:55:57.679] <TB1> INFO: X-ray hit rate [MHz/cm2]: 124.5 134.7 110.4 180.6 197.5 242.9 219.9 232.7 201.9 239.7 244.5 183.2 173.8 116.0 133.3 130.1
[15:55:57.679] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[15:55:57.709] <TB1> INFO: PixTest:: pg_setup set to default.
[15:55:57.727] <TB1> INFO: enter test to run
[15:55:57.727] <TB1> INFO: test: no parameter change
[15:55:58.101] <TB1> QUIET: Connection to board 147 closed.
[15:55:58.182] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[15:56:30.806] <TB1> INFO: *** Welcome to pxar ***
[15:56:30.806] <TB1> INFO: *** Today: 2016/08/10
[15:56:30.866] <TB1> INFO: *** Version: f5d3-dirty
[15:56:30.866] <TB1> INFO: readRocDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//dacParameters35_C15.dat
[15:56:30.867] <TB1> INFO: readTbmDacs: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//tbmParameters_C0b.dat
[15:56:30.867] <TB1> INFO: readMaskFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//defaultMaskFile.dat
[15:56:30.867] <TB1> INFO: readTrimFile: /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//trimParameters35_C15.dat
[15:56:30.939] <TB1> INFO: clk: 4
[15:56:30.939] <TB1> INFO: ctr: 4
[15:56:30.939] <TB1> INFO: sda: 19
[15:56:30.939] <TB1> INFO: tin: 9
[15:56:30.939] <TB1> INFO: level: 15
[15:56:30.939] <TB1> INFO: triggerdelay: 0
[15:56:30.939] <TB1> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:56:30.939] <TB1> INFO: Log level: INFO
[15:56:30.952] <TB1> INFO: Found DTB DTB_WWXTQT
[15:56:30.966] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:56:30.968] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:56:30.970] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[15:56:32.514] <TB1> INFO: DUT info:
[15:56:32.514] <TB1> INFO: The DUT currently contains the following objects:
[15:56:32.514] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:56:32.515] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:56:32.515] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:56:32.515] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:56:32.515] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.515] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:56:32.916] <TB1> INFO: enter 'restricted' command line mode
[15:56:32.916] <TB1> INFO: enter test to run
[15:56:32.916] <TB1> INFO: test: PixelAlive no parameter change
[15:56:32.916] <TB1> INFO: running: pixelalive
[15:56:32.919] <TB1> INFO: ######################################################################
[15:56:32.919] <TB1> INFO: PixTestAlive::doTest()
[15:56:32.919] <TB1> INFO: ######################################################################
[15:56:32.921] <TB1> INFO: ----------------------------------------------------------------------
[15:56:32.921] <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)
[15:56:32.921] <TB1> INFO: ----------------------------------------------------------------------
[15:56:33.182] <TB1> INFO: Expecting 208000 events.
[15:56:44.392] <TB1> INFO: 208000 events read in total (10652ms).
[15:56:44.394] <TB1> INFO: Test took 11472ms.
[15:56:44.619] <TB1> INFO: PixTestAlive::aliveTest() done
[15:56:44.619] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:56:44.620] <TB1> INFO: ----------------------------------------------------------------------
[15:56:44.620] <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)
[15:56:44.620] <TB1> INFO: ----------------------------------------------------------------------
[15:56:44.881] <TB1> INFO: Expecting 208000 events.
[15:56:52.504] <TB1> INFO: 208000 events read in total (7067ms).
[15:56:52.504] <TB1> INFO: Test took 7883ms.
[15:56:52.504] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:56:52.749] <TB1> INFO: PixTestAlive::maskTest() done
[15:56:52.749] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:56:52.750] <TB1> INFO: ----------------------------------------------------------------------
[15:56:52.750] <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)
[15:56:52.750] <TB1> INFO: ----------------------------------------------------------------------
[15:56:53.056] <TB1> INFO: Expecting 208000 events.
[15:57:04.225] <TB1> INFO: 208000 events read in total (10613ms).
[15:57:04.226] <TB1> INFO: Test took 11474ms.
[15:57:04.425] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[15:57:04.425] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:57:04.425] <TB1> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[15:57:04.458] <TB1> INFO: enter test to run
[15:57:04.458] <TB1> INFO: test: delay setting parameters: ->2<-
[15:57:04.458] <TB1> INFO: delay test by 2 seconds...
[15:57:06.458] <TB1> INFO: enter test to run
[15:57:06.458] <TB1> INFO: test: HighRate no parameter change
[15:57:06.458] <TB1> INFO: running: highrate
[15:57:06.459] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2280_XrayQualification_2016-08-10_16h30m_1470839456//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[15:57:06.613] <TB1> INFO: ----------------------------------------------------------------------
[15:57:06.613] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:57:06.613] <TB1> INFO: ----------------------------------------------------------------------
[15:57:07.110] <TB1> INFO: Expecting 208000 events.
[15:57:42.563] <TB1> INFO: 198650 events read in total (35052ms).
[15:57:44.572] <TB1> INFO: 208000 events read in total (37061ms).
[15:57:44.591] <TB1> INFO: Test took 37975ms.
[15:57:46.482] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[15:57:46.482] <TB1> INFO: number of red-efficiency pixels: 2225 3083 1665 3604 3820 4126 3994 4110 3927 4102 4112 3861 3611 1743 2536 2721
[15:57:46.482] <TB1> INFO: number of X-ray hits detected: 525822 568440 467018 764258 831777 1026252 923432 979526 849757 1008223 1026853 772365 732509 487917 564645 547347
[15:57:46.482] <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
[15:57:46.482] <TB1> INFO: number of Vcal hits detected: 204138 201476 203972 195910 191423 180048 186445 185786 192061 182789 181636 192492 196650 203017 203588 202403
[15:57:46.482] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.4 97.1 98.4 94.8 92.9 87.8 90.8 90.0 93.0 89.1 88.4 93.4 95.2 98.0 98.0 97.6
[15:57:46.482] <TB1> INFO: Vcal hit overall efficiency (%): 98.1 96.9 98.1 94.2 92.0 86.6 89.6 89.3 92.3 87.9 87.3 92.5 94.5 97.6 97.9 97.3
[15:57:46.482] <TB1> INFO: X-ray hit rate [MHz/cm2]: 154.1 166.6 136.9 224.0 243.8 300.8 270.7 287.1 249.1 295.5 301.0 226.4 214.7 143.0 165.5 160.4
[15:57:46.482] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[15:57:46.511] <TB1> INFO: PixTest:: pg_setup set to default.
[15:57:46.524] <TB1> INFO: enter test to run
[15:57:46.524] <TB1> INFO: test: no parameter change
[15:57:46.779] <TB1> QUIET: Connection to board 147 closed.
[15:57:46.859] <TB1> INFO: pXar: this is the end, my friend