[12:30:55.598] <TB1> INFO: *** Welcome to pxar ***
[12:30:55.598] <TB1> INFO: *** Today: 2016/09/22
[12:30:55.664] <TB1> INFO: *** Version: f5d3-dirty
[12:30:55.664] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//000_PixelAlive_p17//dacParameters35_C15.dat
[12:30:55.665] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//000_PixelAlive_p17//tbmParameters_C0b.dat
[12:30:55.665] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//000_PixelAlive_p17//defaultMaskFile.dat
[12:30:55.665] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//000_PixelAlive_p17//trimParameters35_C15.dat
[12:30:55.741] <TB1> INFO: clk: 4
[12:30:55.741] <TB1> INFO: ctr: 4
[12:30:55.741] <TB1> INFO: sda: 19
[12:30:55.741] <TB1> INFO: tin: 9
[12:30:55.741] <TB1> INFO: level: 15
[12:30:55.741] <TB1> INFO: triggerdelay: 0
[12:30:55.741] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:30:55.741] <TB1> INFO: Log level: INFO
[12:30:55.754] <TB1> INFO: Found DTB DTB_WWXTQT
[12:30:55.764] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:30:55.765] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:30:55.767] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:30:57.339] <TB1> INFO: DUT info:
[12:30:57.339] <TB1> INFO: The DUT currently contains the following objects:
[12:30:57.339] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:30:57.339] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:30:57.339] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:30:57.339] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:30:57.340] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.340] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:30:57.741] <TB1> INFO: enter 'restricted' command line mode
[12:30:57.741] <TB1> INFO: enter test to run
[12:30:57.741] <TB1> INFO: test: PixelAlive no parameter change
[12:30:57.741] <TB1> INFO: running: pixelalive
[12:30:57.745] <TB1> INFO: ######################################################################
[12:30:57.745] <TB1> INFO: PixTestAlive::doTest()
[12:30:57.745] <TB1> INFO: ######################################################################
[12:30:57.747] <TB1> INFO: ----------------------------------------------------------------------
[12:30:57.747] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:30:57.747] <TB1> INFO: ----------------------------------------------------------------------
[12:30:58.008] <TB1> INFO: Expecting 41600 events.
[12:31:01.204] <TB1> INFO: 41600 events read in total (2638ms).
[12:31:01.243] <TB1> INFO: Test took 3495ms.
[12:31:01.465] <TB1> INFO: PixTestAlive::aliveTest() done
[12:31:01.465] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:31:01.467] <TB1> INFO: ----------------------------------------------------------------------
[12:31:01.467] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:31:01.467] <TB1> INFO: ----------------------------------------------------------------------
[12:31:01.723] <TB1> INFO: Expecting 41600 events.
[12:31:04.340] <TB1> INFO: 41600 events read in total (2060ms).
[12:31:04.341] <TB1> INFO: Test took 2872ms.
[12:31:04.342] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:31:04.580] <TB1> INFO: PixTestAlive::maskTest() done
[12:31:04.580] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:31:04.582] <TB1> INFO: ----------------------------------------------------------------------
[12:31:04.582] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:31:04.582] <TB1> INFO: ----------------------------------------------------------------------
[12:31:04.838] <TB1> INFO: Expecting 41600 events.
[12:31:08.176] <TB1> INFO: 41600 events read in total (2782ms).
[12:31:08.178] <TB1> INFO: Test took 3595ms.
[12:31:08.385] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:31:08.385] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:31:08.385] <TB1> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[12:31:08.430] <TB1> INFO: enter test to run
[12:31:08.430] <TB1> INFO: test: no parameter change
[12:31:08.656] <TB1> QUIET: Connection to board 147 closed.
[12:31:08.736] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[12:36:05.616] <TB1> INFO: *** Welcome to pxar ***
[12:36:05.616] <TB1> INFO: *** Today: 2016/09/22
[12:36:05.684] <TB1> INFO: *** Version: f5d3-dirty
[12:36:05.684] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//dacParameters35_C15.dat
[12:36:05.685] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[12:36:05.685] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:36:05.685] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:36:05.793] <TB1> INFO: clk: 4
[12:36:05.793] <TB1> INFO: ctr: 4
[12:36:05.793] <TB1> INFO: sda: 19
[12:36:05.793] <TB1> INFO: tin: 9
[12:36:05.793] <TB1> INFO: level: 15
[12:36:05.793] <TB1> INFO: triggerdelay: 0
[12:36:05.793] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:36:05.793] <TB1> INFO: Log level: INFO
[12:36:05.806] <TB1> INFO: Found DTB DTB_WWXTQT
[12:36:05.816] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:36:05.817] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:36:05.819] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:36:07.350] <TB1> INFO: DUT info:
[12:36:07.350] <TB1> INFO: The DUT currently contains the following objects:
[12:36:07.351] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:36:07.351] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:36:07.351] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:36:07.351] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:36:07.351] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.752] <TB1> INFO: enter 'restricted' command line mode
[12:36:07.752] <TB1> INFO: enter test to run
[12:36:07.752] <TB1> INFO: test: delay setting parameters: ->5<-
[12:36:07.752] <TB1> INFO: delay test by 5 seconds...
[12:36:12.752] <TB1> INFO: enter test to run
[12:36:12.752] <TB1> INFO: test: highrate no parameter change
[12:36:12.752] <TB1> INFO: running: highrate
[12:36:12.752] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[12:36:12.899] <TB1> INFO: ----------------------------------------------------------------------
[12:36:12.899] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:36:12.899] <TB1> INFO: ----------------------------------------------------------------------
[12:36:12.899] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:36:12.899] <TB1> INFO: edge/corner pixel THR is adjusted
[12:36:12.899] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:36:13.616] <TB1> INFO: Collecting data for 1 seconds...
[12:36:14.617] <TB1> INFO: Done with hot pixel readout
[12:36:19.531] <TB1> INFO: PixTest:: pg_setup set to default.
[12:36:19.532] <TB1> INFO: 0 hot pixels found in step 0
[12:36:19.543] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[12:36:19.610] <TB1> INFO: PixTest::trimHotPixels() done
[12:36:19.610] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C0.dat
[12:36:19.617] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C1.dat
[12:36:19.623] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C2.dat
[12:36:19.630] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C3.dat
[12:36:19.636] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C4.dat
[12:36:19.643] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C5.dat
[12:36:19.650] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C6.dat
[12:36:19.656] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C7.dat
[12:36:19.663] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C8.dat
[12:36:19.669] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C9.dat
[12:36:19.676] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C10.dat
[12:36:19.682] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C11.dat
[12:36:19.688] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C12.dat
[12:36:19.695] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C13.dat
[12:36:19.701] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C14.dat
[12:36:19.708] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:36:19.714] <TB1> INFO: write masked pixels into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:36:19.745] <TB1> INFO: enter test to run
[12:36:19.745] <TB1> INFO: test: no parameter change
[12:36:19.987] <TB1> QUIET: Connection to board 147 closed.
[12:36:20.067] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[12:36:05.616] <TB1> INFO: *** Welcome to pxar ***
[12:36:05.616] <TB1> INFO: *** Today: 2016/09/22
[12:36:05.684] <TB1> INFO: *** Version: f5d3-dirty
[12:36:05.684] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//dacParameters35_C15.dat
[12:36:05.685] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[12:36:05.685] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:36:05.685] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:36:05.793] <TB1> INFO: clk: 4
[12:36:05.793] <TB1> INFO: ctr: 4
[12:36:05.793] <TB1> INFO: sda: 19
[12:36:05.793] <TB1> INFO: tin: 9
[12:36:05.793] <TB1> INFO: level: 15
[12:36:05.793] <TB1> INFO: triggerdelay: 0
[12:36:05.793] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:36:05.793] <TB1> INFO: Log level: INFO
[12:36:05.806] <TB1> INFO: Found DTB DTB_WWXTQT
[12:36:05.816] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:36:05.817] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:36:05.819] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:36:07.350] <TB1> INFO: DUT info:
[12:36:07.350] <TB1> INFO: The DUT currently contains the following objects:
[12:36:07.351] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:36:07.351] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:36:07.351] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:36:07.351] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:36:07.351] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.351] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:07.752] <TB1> INFO: enter 'restricted' command line mode
[12:36:07.752] <TB1> INFO: enter test to run
[12:36:07.752] <TB1> INFO: test: delay setting parameters: ->5<-
[12:36:07.752] <TB1> INFO: delay test by 5 seconds...
[12:36:12.752] <TB1> INFO: enter test to run
[12:36:12.752] <TB1> INFO: test: highrate no parameter change
[12:36:12.752] <TB1> INFO: running: highrate
[12:36:12.752] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[12:36:12.899] <TB1> INFO: ----------------------------------------------------------------------
[12:36:12.899] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:36:12.899] <TB1> INFO: ----------------------------------------------------------------------
[12:36:12.899] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:36:12.899] <TB1> INFO: edge/corner pixel THR is adjusted
[12:36:12.899] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:36:13.616] <TB1> INFO: Collecting data for 1 seconds...
[12:36:14.617] <TB1> INFO: Done with hot pixel readout
[12:36:19.531] <TB1> INFO: PixTest:: pg_setup set to default.
[12:36:19.532] <TB1> INFO: 0 hot pixels found in step 0
[12:36:19.543] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[12:36:19.610] <TB1> INFO: PixTest::trimHotPixels() done
[12:36:19.610] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C0.dat
[12:36:19.617] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C1.dat
[12:36:19.623] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C2.dat
[12:36:19.630] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C3.dat
[12:36:19.636] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C4.dat
[12:36:19.643] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C5.dat
[12:36:19.650] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C6.dat
[12:36:19.656] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C7.dat
[12:36:19.663] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C8.dat
[12:36:19.669] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C9.dat
[12:36:19.676] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C10.dat
[12:36:19.682] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C11.dat
[12:36:19.688] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C12.dat
[12:36:19.695] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C13.dat
[12:36:19.701] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C14.dat
[12:36:19.708] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:36:19.714] <TB1> INFO: write masked pixels into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:36:19.745] <TB1> INFO: enter test to run
[12:36:19.745] <TB1> INFO: test: no parameter change
[12:36:19.987] <TB1> QUIET: Connection to board 147 closed.
[12:36:20.067] <TB1> INFO: pXar: this is the end, my friend
[12:36:56.492] <TB1> INFO: *** Welcome to pxar ***
[12:36:56.492] <TB1> INFO: *** Today: 2016/09/22
[12:36:56.857] <TB1> INFO: *** Version: f5d3-dirty
[12:36:56.857] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//dacParameters35_C15.dat
[12:36:56.858] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[12:36:56.858] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//defaultMaskFile.dat
[12:36:56.858] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C15.dat
[12:36:56.928] <TB1> INFO: clk: 4
[12:36:56.928] <TB1> INFO: ctr: 4
[12:36:56.928] <TB1> INFO: sda: 19
[12:36:56.928] <TB1> INFO: tin: 9
[12:36:56.928] <TB1> INFO: level: 15
[12:36:56.928] <TB1> INFO: triggerdelay: 0
[12:36:56.928] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:36:56.928] <TB1> INFO: Log level: INFO
[12:36:56.942] <TB1> INFO: Found DTB DTB_WWXTQT
[12:36:56.951] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:36:56.953] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:36:56.955] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:36:58.512] <TB1> INFO: DUT info:
[12:36:58.512] <TB1> INFO: The DUT currently contains the following objects:
[12:36:58.512] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:36:58.512] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:36:58.512] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:36:58.512] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:36:58.512] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.513] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:36:58.914] <TB1> INFO: enter 'restricted' command line mode
[12:36:58.914] <TB1> INFO: enter test to run
[12:36:58.914] <TB1> INFO: test: delay setting parameters: ->5<-
[12:36:58.914] <TB1> INFO: delay test by 5 seconds...
[12:37:03.914] <TB1> INFO: enter test to run
[12:37:03.914] <TB1> INFO: test: highrate no parameter change
[12:37:03.915] <TB1> INFO: running: highrate
[12:37:03.916] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[12:37:04.049] <TB1> INFO: ----------------------------------------------------------------------
[12:37:04.049] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:37:04.049] <TB1> INFO: ----------------------------------------------------------------------
[12:37:04.049] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:37:04.049] <TB1> INFO: edge/corner pixel THR is adjusted
[12:37:04.049] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:37:04.765] <TB1> INFO: Collecting data for 1 seconds...
[12:37:05.765] <TB1> INFO: Done with hot pixel readout
[12:37:08.754] <TB1> INFO: PixTest:: pg_setup set to default.
[12:37:08.755] <TB1> INFO: 0 hot pixels found in step 0
[12:37:08.763] <TB1> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[12:37:08.812] <TB1> INFO: PixTest::trimHotPixels() done
[12:37:08.812] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C0.dat
[12:37:08.819] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C1.dat
[12:37:08.825] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C2.dat
[12:37:08.832] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C3.dat
[12:37:08.838] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C4.dat
[12:37:08.845] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C5.dat
[12:37:08.851] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C6.dat
[12:37:08.857] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C7.dat
[12:37:08.863] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C8.dat
[12:37:08.869] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C9.dat
[12:37:08.875] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C10.dat
[12:37:08.882] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C11.dat
[12:37:08.888] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C12.dat
[12:37:08.894] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C13.dat
[12:37:08.900] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C14.dat
[12:37:08.906] <TB1> INFO: write trim parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//trimParameters35_C15.dat
[12:37:08.912] <TB1> INFO: write masked pixels into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//003_RetrimHotPixels_50//defaultMaskFile.dat
[12:37:08.963] <TB1> INFO: enter test to run
[12:37:08.963] <TB1> INFO: test: no parameter change
[12:37:09.185] <TB1> QUIET: Connection to board 147 closed.
[12:37:09.265] <TB1> INFO: pXar: this is the end, my friend
[12:37:46.835] <TB1> INFO: *** Welcome to pxar ***
[12:37:46.835] <TB1> INFO: *** Today: 2016/09/22
[12:37:46.905] <TB1> INFO: *** Version: f5d3-dirty
[12:37:46.905] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//dacParameters35_C15.dat
[12:37:46.905] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//tbmParameters_C0b.dat
[12:37:46.905] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//defaultMaskFile.dat
[12:37:46.905] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//trimParameters35_C15.dat
[12:37:46.981] <TB1> INFO: clk: 4
[12:37:46.981] <TB1> INFO: ctr: 4
[12:37:46.981] <TB1> INFO: sda: 19
[12:37:46.981] <TB1> INFO: tin: 9
[12:37:46.981] <TB1> INFO: level: 15
[12:37:46.981] <TB1> INFO: triggerdelay: 0
[12:37:46.981] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:37:46.981] <TB1> INFO: Log level: INFO
[12:37:46.995] <TB1> INFO: Found DTB DTB_WWXTQT
[12:37:47.006] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:37:47.008] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:37:47.010] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:37:48.552] <TB1> INFO: DUT info:
[12:37:48.552] <TB1> INFO: The DUT currently contains the following objects:
[12:37:48.553] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:37:48.553] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:37:48.553] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:37:48.553] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:37:48.553] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.553] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:37:48.954] <TB1> INFO: enter 'restricted' command line mode
[12:37:48.954] <TB1> INFO: enter test to run
[12:37:48.955] <TB1> INFO: test: delay setting parameters: ->5<-
[12:37:48.955] <TB1> INFO: delay test by 5 seconds...
[12:37:53.955] <TB1> INFO: enter test to run
[12:37:53.955] <TB1> INFO: test: Xray no parameter change
[12:37:53.955] <TB1> INFO: running: xray
[12:37:53.955] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//004_HRData_50//phCalibrationFitErr35_C15.dat
[12:37:54.096] <TB1> INFO: ######################################################################
[12:37:54.096] <TB1> INFO: PixTestXray::doTest()
[12:37:54.096] <TB1> INFO: ######################################################################
[12:37:54.096] <TB1> INFO: ----------------------------------------------------------------------
[12:37:54.096] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:37:54.096] <TB1> INFO: ----------------------------------------------------------------------
[12:37:54.818] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:38:02.215] <TB1> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[12:38:25.986] <TB1> INFO: Resuming triggers.
[12:38:33.391] <TB1> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[12:38:57.865] <TB1> INFO: Resuming triggers.
[12:39:05.264] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[12:39:29.058] <TB1> INFO: Resuming triggers.
[12:39:36.454] <TB1> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[12:39:59.608] <TB1> INFO: Resuming triggers.
[12:40:07.004] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[12:40:30.677] <TB1> INFO: Resuming triggers.
[12:40:38.071] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[12:41:01.264] <TB1> INFO: Resuming triggers.
[12:41:08.661] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[12:41:33.172] <TB1> INFO: Resuming triggers.
[12:41:40.568] <TB1> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[12:42:04.649] <TB1> INFO: Resuming triggers.
[12:42:12.041] <TB1> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[12:42:36.869] <TB1> INFO: Resuming triggers.
[12:42:44.257] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[12:43:07.645] <TB1> INFO: Resuming triggers.
[12:43:15.038] <TB1> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[12:43:38.542] <TB1> INFO: Resuming triggers.
[12:43:45.929] <TB1> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[12:44:10.085] <TB1> INFO: Resuming triggers.
[12:44:17.476] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[12:44:42.363] <TB1> INFO: Resuming triggers.
[12:44:46.318] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[12:44:59.822] <TB1> INFO: PixTest:: pg_setup set to default.
[12:44:59.823] <TB1> INFO: PixTestXray::doPhRun() done
[12:44:59.823] <TB1> INFO: PixTestXray::doTest() done
[12:45:00.001] <TB1> INFO: enter test to run
[12:45:00.001] <TB1> INFO: test: no parameter change
[12:45:00.193] <TB1> QUIET: Connection to board 147 closed.
[12:45:00.272] <TB1> INFO: pXar: this is the end, my friend
[12:45:34.696] <TB1> INFO: *** Welcome to pxar ***
[12:45:34.696] <TB1> INFO: *** Today: 2016/09/22
[12:45:34.784] <TB1> INFO: *** Version: f5d3-dirty
[12:45:34.784] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//dacParameters35_C15.dat
[12:45:34.785] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//tbmParameters_C0b.dat
[12:45:34.785] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//defaultMaskFile.dat
[12:45:34.785] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//trimParameters35_C15.dat
[12:45:34.857] <TB1> INFO: clk: 4
[12:45:34.857] <TB1> INFO: ctr: 4
[12:45:34.857] <TB1> INFO: sda: 19
[12:45:34.857] <TB1> INFO: tin: 9
[12:45:34.857] <TB1> INFO: level: 15
[12:45:34.857] <TB1> INFO: triggerdelay: 0
[12:45:34.857] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:45:34.857] <TB1> INFO: Log level: INFO
[12:45:34.872] <TB1> INFO: Found DTB DTB_WWXTQT
[12:45:34.882] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:45:34.884] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:45:34.886] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:45:36.438] <TB1> INFO: DUT info:
[12:45:36.438] <TB1> INFO: The DUT currently contains the following objects:
[12:45:36.438] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:45:36.438] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:45:36.438] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:45:36.438] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:45:36.438] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.438] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:45:36.839] <TB1> INFO: enter 'restricted' command line mode
[12:45:36.839] <TB1> INFO: enter test to run
[12:45:36.839] <TB1> INFO: test: delay setting parameters: ->5<-
[12:45:36.839] <TB1> INFO: delay test by 5 seconds...
[12:45:41.839] <TB1> INFO: enter test to run
[12:45:41.839] <TB1> INFO: test: Xray no parameter change
[12:45:41.839] <TB1> INFO: running: xray
[12:45:41.840] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//005_HRData_150//phCalibrationFitErr35_C15.dat
[12:45:41.975] <TB1> INFO: ######################################################################
[12:45:41.975] <TB1> INFO: PixTestXray::doTest()
[12:45:41.975] <TB1> INFO: ######################################################################
[12:45:41.975] <TB1> INFO: ----------------------------------------------------------------------
[12:45:41.975] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:45:41.975] <TB1> INFO: ----------------------------------------------------------------------
[12:45:42.701] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:45:46.739] <TB1> INFO: run duration 4 seconds, buffer almost full (81%), pausing triggers.
[12:46:11.473] <TB1> INFO: Resuming triggers.
[12:46:15.519] <TB1> INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[12:46:40.012] <TB1> INFO: Resuming triggers.
[12:46:44.054] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[12:47:08.316] <TB1> INFO: Resuming triggers.
[12:47:12.356] <TB1> INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[12:47:37.076] <TB1> INFO: Resuming triggers.
[12:47:41.113] <TB1> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[12:48:05.851] <TB1> INFO: Resuming triggers.
[12:48:09.886] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[12:48:34.965] <TB1> INFO: Resuming triggers.
[12:48:38.997] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[12:49:04.081] <TB1> INFO: Resuming triggers.
[12:49:08.112] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[12:49:33.529] <TB1> INFO: Resuming triggers.
[12:49:37.556] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[12:50:03.145] <TB1> INFO: Resuming triggers.
[12:50:07.172] <TB1> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[12:50:32.016] <TB1> INFO: Resuming triggers.
[12:50:36.040] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[12:51:00.919] <TB1> INFO: Resuming triggers.
[12:51:04.943] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[12:51:29.663] <TB1> INFO: Resuming triggers.
[12:51:33.684] <TB1> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[12:51:58.938] <TB1> INFO: Resuming triggers.
[12:52:02.956] <TB1> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[12:52:28.514] <TB1> INFO: Resuming triggers.
[12:52:32.531] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[12:52:57.680] <TB1> INFO: Resuming triggers.
[12:53:01.694] <TB1> INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[12:53:27.038] <TB1> INFO: Resuming triggers.
[12:53:31.052] <TB1> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[12:53:56.209] <TB1> INFO: Resuming triggers.
[12:54:00.220] <TB1> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[12:54:25.488] <TB1> INFO: Resuming triggers.
[12:54:29.498] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[12:54:54.946] <TB1> INFO: Resuming triggers.
[12:54:58.955] <TB1> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[12:55:23.991] <TB1> INFO: Resuming triggers.
[12:55:28.000] <TB1> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[12:55:53.205] <TB1> INFO: Resuming triggers.
[12:55:57.210] <TB1> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[12:56:23.492] <TB1> INFO: Resuming triggers.
[12:56:27.499] <TB1> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[12:56:52.916] <TB1> INFO: Resuming triggers.
[12:56:56.923] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[12:57:21.997] <TB1> INFO: Resuming triggers.
[12:57:25.537] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[12:57:48.287] <TB1> INFO: PixTest:: pg_setup set to default.
[12:57:48.288] <TB1> INFO: PixTestXray::doPhRun() done
[12:57:48.288] <TB1> INFO: PixTestXray::doTest() done
[12:57:48.472] <TB1> INFO: enter test to run
[12:57:48.473] <TB1> INFO: test: no parameter change
[12:57:48.720] <TB1> QUIET: Connection to board 147 closed.
[12:57:48.800] <TB1> INFO: pXar: this is the end, my friend
[12:58:17.000] <TB1> INFO: *** Welcome to pxar ***
[12:58:17.000] <TB1> INFO: *** Today: 2016/09/22
[12:58:17.064] <TB1> INFO: *** Version: f5d3-dirty
[12:58:17.064] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//dacParameters35_C15.dat
[12:58:17.065] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//tbmParameters_C0b.dat
[12:58:17.065] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//defaultMaskFile.dat
[12:58:17.065] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//trimParameters35_C15.dat
[12:58:17.135] <TB1> INFO: clk: 4
[12:58:17.135] <TB1> INFO: ctr: 4
[12:58:17.135] <TB1> INFO: sda: 19
[12:58:17.135] <TB1> INFO: tin: 9
[12:58:17.135] <TB1> INFO: level: 15
[12:58:17.135] <TB1> INFO: triggerdelay: 0
[12:58:17.135] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[12:58:17.135] <TB1> INFO: Log level: INFO
[12:58:17.148] <TB1> INFO: Found DTB DTB_WWXTQT
[12:58:17.158] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:58:17.160] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:58:17.163] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[12:58:18.704] <TB1> INFO: DUT info:
[12:58:18.704] <TB1> INFO: The DUT currently contains the following objects:
[12:58:18.704] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:58:18.704] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:58:18.704] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:58:18.704] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:58:18.705] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:18.705] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:19.106] <TB1> INFO: enter 'restricted' command line mode
[12:58:19.106] <TB1> INFO: enter test to run
[12:58:19.106] <TB1> INFO: test: Highrate no parameter change
[12:58:19.106] <TB1> INFO: running: highrate
[12:58:19.106] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[12:58:19.246] <TB1> INFO: ----------------------------------------------------------------------
[12:58:19.246] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[12:58:19.246] <TB1> INFO: ----------------------------------------------------------------------
[12:58:19.251] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[12:58:19.262] <TB1> INFO: dacScan step from 15 .. 34
[12:58:19.262] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[12:58:19.262] <TB1> INFO: run 1 of 1
[12:58:19.770] <TB1> INFO: Expecting 4160000 events.
[12:58:45.452] <TB1> INFO: 443050 events read in total (25279ms).
[12:59:10.389] <TB1> INFO: 887600 events read in total (50216ms).
[12:59:35.715] <TB1> INFO: 1332350 events read in total (75542ms).
[13:00:00.826] <TB1> INFO: 1776450 events read in total (100653ms).
[13:00:25.782] <TB1> INFO: 2220850 events read in total (125609ms).
[13:00:50.933] <TB1> INFO: 2665100 events read in total (150760ms).
[13:01:16.032] <TB1> INFO: 3108950 events read in total (175859ms).
[13:01:40.771] <TB1> INFO: 3552800 events read in total (200598ms).
[13:02:06.054] <TB1> INFO: 3996500 events read in total (225881ms).
[13:02:15.542] <TB1> INFO: 4160000 events read in total (235369ms).
[13:02:15.811] <TB1> INFO: Test took 236548ms.
[13:02:23.061] <TB1> INFO: dacScan step from 35 .. 54
[13:02:23.061] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:02:23.061] <TB1> INFO: run 1 of 1
[13:02:23.544] <TB1> INFO: Expecting 4160000 events.
[13:02:48.488] <TB1> INFO: 380750 events read in total (24543ms).
[13:03:12.843] <TB1> INFO: 761550 events read in total (48897ms).
[13:03:36.995] <TB1> INFO: 1141200 events read in total (73049ms).
[13:04:01.269] <TB1> INFO: 1520350 events read in total (97323ms).
[13:04:25.477] <TB1> INFO: 1897600 events read in total (121531ms).
[13:04:49.556] <TB1> INFO: 2273250 events read in total (145610ms).
[13:05:13.824] <TB1> INFO: 2645900 events read in total (169878ms).
[13:05:37.576] <TB1> INFO: 3015250 events read in total (193630ms).
[13:06:01.879] <TB1> INFO: 3381850 events read in total (217933ms).
[13:06:25.445] <TB1> INFO: 3746200 events read in total (241499ms).
[13:06:49.638] <TB1> INFO: 4110100 events read in total (265692ms).
[13:06:53.015] <TB1> INFO: 4160000 events read in total (269069ms).
[13:06:53.229] <TB1> INFO: Test took 270167ms.
[13:07:02.184] <TB1> INFO: dacScan step from 55 .. 74
[13:07:02.184] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:07:02.184] <TB1> INFO: run 1 of 1
[13:07:02.665] <TB1> INFO: Expecting 4160000 events.
[13:07:25.902] <TB1> INFO: 330950 events read in total (22835ms).
[13:07:48.772] <TB1> INFO: 662500 events read in total (45705ms).
[13:08:11.614] <TB1> INFO: 993950 events read in total (68547ms).
[13:08:34.538] <TB1> INFO: 1325450 events read in total (91471ms).
[13:08:57.196] <TB1> INFO: 1657100 events read in total (114129ms).
[13:09:19.927] <TB1> INFO: 1988800 events read in total (136860ms).
[13:09:42.722] <TB1> INFO: 2320300 events read in total (159655ms).
[13:10:05.759] <TB1> INFO: 2651800 events read in total (182692ms).
[13:10:28.589] <TB1> INFO: 2983150 events read in total (205522ms).
[13:10:52.312] <TB1> INFO: 3314400 events read in total (229245ms).
[13:11:16.324] <TB1> INFO: 3645700 events read in total (253257ms).
[13:11:40.283] <TB1> INFO: 3976950 events read in total (277216ms).
[13:11:52.727] <TB1> INFO: 4160000 events read in total (289660ms).
[13:11:52.926] <TB1> INFO: Test took 290742ms.
[13:11:59.961] <TB1> INFO: dacScan step from 75 .. 75
[13:11:59.961] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:11:59.961] <TB1> INFO: run 1 of 1
[13:12:00.439] <TB1> INFO: Expecting 208000 events.
[13:12:16.530] <TB1> INFO: 208000 events read in total (15690ms).
[13:12:16.538] <TB1> INFO: Test took 16576ms.
[13:12:16.886] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:18.010] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:19.086] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:20.156] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:21.237] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:22.280] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:23.368] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:24.439] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:25.518] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:26.596] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:27.668] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:28.741] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:29.780] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:30.811] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:31.830] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:32.865] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:12:33.884] <TB1> INFO: PixTest:: pg_setup set to default.
[13:12:33.885] <TB1> INFO: vcal mean: 38.80 39.11 38.41 41.17 41.82 42.80 43.55 43.76 43.17 42.47 43.17 41.47 41.58 38.79 38.49 38.76
[13:12:33.885] <TB1> INFO: vcal RMS: 1.12 1.23 0.94 1.35 1.21 1.34 1.49 1.53 1.50 1.45 1.52 1.48 1.26 1.12 0.97 1.08
[13:12:33.885] <TB1> INFO: number of X-ray hits detected: 209201 230282 192354 328537 360976 409787 437052 455699 415149 394171 427881 336905 342268 195915 193883 199254
[13:12:33.885] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:12:33.885] <TB1> INFO: X-ray hit rate [MHz/cm2]: 61.3 67.5 56.4 96.3 105.8 120.1 128.1 133.6 121.7 115.5 125.4 98.7 100.3 57.4 56.8 58.4
[13:12:33.885] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[13:12:33.985] <TB1> INFO: enter test to run
[13:12:33.985] <TB1> INFO: test: no parameter change
[13:12:34.251] <TB1> QUIET: Connection to board 147 closed.
[13:12:34.330] <TB1> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[13:30:47.026] <TB1> INFO: *** Welcome to pxar ***
[13:30:47.026] <TB1> INFO: *** Today: 2016/09/22
[13:30:47.104] <TB1> INFO: *** Version: f5d3-dirty
[13:30:47.104] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:30:47.105] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[13:30:47.105] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[13:30:47.105] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[13:30:47.178] <TB1> INFO: clk: 4
[13:30:47.178] <TB1> INFO: ctr: 4
[13:30:47.178] <TB1> INFO: sda: 19
[13:30:47.178] <TB1> INFO: tin: 9
[13:30:47.178] <TB1> INFO: level: 15
[13:30:47.178] <TB1> INFO: triggerdelay: 0
[13:30:47.178] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[13:30:47.178] <TB1> INFO: Log level: INFO
[13:30:47.191] <TB1> INFO: Found DTB DTB_WWXTQT
[13:30:47.201] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:30:47.203] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:30:47.205] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[13:30:48.747] <TB1> INFO: DUT info:
[13:30:48.747] <TB1> INFO: The DUT currently contains the following objects:
[13:30:48.747] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:30:48.747] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:30:48.747] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:30:48.747] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:30:48.747] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.747] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.747] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.747] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.747] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.747] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.747] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.747] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.748] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.748] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.748] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.748] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.748] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.748] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.748] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:48.748] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:49.149] <TB1> INFO: enter 'restricted' command line mode
[13:30:49.149] <TB1> INFO: enter test to run
[13:30:49.149] <TB1> INFO: test: HighRate no parameter change
[13:30:49.149] <TB1> INFO: running: highrate
[13:30:49.149] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[13:30:49.303] <TB1> INFO: ----------------------------------------------------------------------
[13:30:49.303] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:30:49.303] <TB1> INFO: ----------------------------------------------------------------------
[13:30:49.397] <TB1> INFO: Expecting 768 events.
[13:30:50.387] <TB1> INFO: 768 events read in total (432ms).
[13:30:50.451] <TB1> INFO: Test took 1143ms.
[13:30:50.955] <TB1> INFO: Expecting 41600 events.
[13:30:53.856] <TB1> INFO: 41600 events read in total (2499ms).
[13:30:53.858] <TB1> INFO: Test took 3404ms.
[13:30:54.508] <TB1> INFO: Expecting 41600 events.
[13:30:57.582] <TB1> INFO: 41600 events read in total (2672ms).
[13:30:57.584] <TB1> INFO: Test took 3595ms.
[13:30:58.233] <TB1> INFO: Expecting 41600 events.
[13:31:01.208] <TB1> INFO: 41600 events read in total (2573ms).
[13:31:01.209] <TB1> INFO: Test took 3493ms.
[13:31:01.821] <TB1> INFO: Expecting 41600 events.
[13:31:04.775] <TB1> INFO: 41600 events read in total (2553ms).
[13:31:04.778] <TB1> INFO: Test took 3444ms.
[13:31:05.382] <TB1> INFO: Expecting 41600 events.
[13:31:08.346] <TB1> INFO: 41600 events read in total (2562ms).
[13:31:08.348] <TB1> INFO: Test took 3452ms.
[13:31:08.932] <TB1> INFO: Expecting 41600 events.
[13:31:11.942] <TB1> INFO: 41600 events read in total (2608ms).
[13:31:11.944] <TB1> INFO: Test took 3491ms.
[13:31:12.549] <TB1> INFO: Expecting 41600 events.
[13:31:15.490] <TB1> INFO: 41600 events read in total (2539ms).
[13:31:15.492] <TB1> INFO: Test took 3441ms.
[13:31:16.077] <TB1> INFO: Expecting 41600 events.
[13:31:18.994] <TB1> INFO: 41600 events read in total (2516ms).
[13:31:18.996] <TB1> INFO: Test took 3398ms.
[13:31:19.583] <TB1> INFO: Expecting 41600 events.
[13:31:22.509] <TB1> INFO: 41600 events read in total (2524ms).
[13:31:22.511] <TB1> INFO: Test took 3408ms.
[13:31:23.124] <TB1> INFO: Expecting 41600 events.
[13:31:26.213] <TB1> INFO: 41600 events read in total (2687ms).
[13:31:26.215] <TB1> INFO: Test took 3597ms.
[13:31:26.808] <TB1> INFO: Expecting 41600 events.
[13:31:29.885] <TB1> INFO: 41600 events read in total (2675ms).
[13:31:29.887] <TB1> INFO: Test took 3560ms.
[13:31:30.473] <TB1> INFO: Expecting 41600 events.
[13:31:33.429] <TB1> INFO: 41600 events read in total (2554ms).
[13:31:33.431] <TB1> INFO: Test took 3438ms.
[13:31:34.037] <TB1> INFO: Expecting 41600 events.
[13:31:36.975] <TB1> INFO: 41600 events read in total (2536ms).
[13:31:36.976] <TB1> INFO: Test took 3427ms.
[13:31:37.570] <TB1> INFO: Expecting 41600 events.
[13:31:40.659] <TB1> INFO: 41600 events read in total (2687ms).
[13:31:40.661] <TB1> INFO: Test took 3574ms.
[13:31:41.253] <TB1> INFO: Expecting 41600 events.
[13:31:44.205] <TB1> INFO: 41600 events read in total (2550ms).
[13:31:44.206] <TB1> INFO: Test took 3433ms.
[13:31:44.797] <TB1> INFO: Expecting 41600 events.
[13:31:47.748] <TB1> INFO: 41600 events read in total (2549ms).
[13:31:47.750] <TB1> INFO: Test took 3435ms.
[13:31:48.336] <TB1> INFO: Expecting 41600 events.
[13:31:51.333] <TB1> INFO: 41600 events read in total (2595ms).
[13:31:51.335] <TB1> INFO: Test took 3477ms.
[13:31:51.970] <TB1> INFO: Expecting 41600 events.
[13:31:55.028] <TB1> INFO: 41600 events read in total (2657ms).
[13:31:55.030] <TB1> INFO: Test took 3558ms.
[13:31:55.666] <TB1> INFO: Expecting 41600 events.
[13:31:58.986] <TB1> INFO: 41600 events read in total (2918ms).
[13:31:58.987] <TB1> INFO: Test took 3810ms.
[13:31:59.604] <TB1> INFO: Expecting 41600 events.
[13:32:02.565] <TB1> INFO: 41600 events read in total (2559ms).
[13:32:02.566] <TB1> INFO: Test took 3459ms.
[13:32:02.917] <TB1> INFO: enter test to run
[13:32:02.917] <TB1> INFO: test: Pretest no parameter change
[13:32:02.917] <TB1> INFO: running: pretest
[13:32:02.917] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[13:32:02.918] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[13:32:02.919] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[13:32:02.919] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[13:32:02.919] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[13:32:02.919] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[13:32:02.919] <TB1> INFO: write dac parameters into /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:32:02.919] <TB1> INFO: enter test to run
[13:32:02.919] <TB1> INFO: test: no parameter change
[13:32:03.144] <TB1> QUIET: Connection to board 147 closed.
[13:32:03.224] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:32:35.974] <TB1> INFO: *** Welcome to pxar ***
[13:32:35.974] <TB1> INFO: *** Today: 2016/09/22
[13:32:36.041] <TB1> INFO: *** Version: f5d3-dirty
[13:32:36.041] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//dacParameters35_C15.dat
[13:32:36.042] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//tbmParameters_C0b.dat
[13:32:36.042] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//defaultMaskFile.dat
[13:32:36.042] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//trimParameters35_C15.dat
[13:32:36.115] <TB1> INFO: clk: 4
[13:32:36.115] <TB1> INFO: ctr: 4
[13:32:36.115] <TB1> INFO: sda: 19
[13:32:36.115] <TB1> INFO: tin: 9
[13:32:36.115] <TB1> INFO: level: 15
[13:32:36.115] <TB1> INFO: triggerdelay: 0
[13:32:36.115] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[13:32:36.115] <TB1> INFO: Log level: INFO
[13:32:36.128] <TB1> INFO: Found DTB DTB_WWXTQT
[13:32:36.138] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:32:36.140] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:32:36.142] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[13:32:37.678] <TB1> INFO: DUT info:
[13:32:37.678] <TB1> INFO: The DUT currently contains the following objects:
[13:32:37.678] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:32:37.678] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:32:37.678] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:32:37.678] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:32:37.678] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:37.678] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:32:38.079] <TB1> INFO: enter 'restricted' command line mode
[13:32:38.079] <TB1> INFO: enter test to run
[13:32:38.079] <TB1> INFO: test: PixelAlive no parameter change
[13:32:38.079] <TB1> INFO: running: pixelalive
[13:32:38.082] <TB1> INFO: ######################################################################
[13:32:38.082] <TB1> INFO: PixTestAlive::doTest()
[13:32:38.082] <TB1> INFO: ######################################################################
[13:32:38.083] <TB1> INFO: ----------------------------------------------------------------------
[13:32:38.083] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:32:38.083] <TB1> INFO: ----------------------------------------------------------------------
[13:32:38.343] <TB1> INFO: Expecting 208000 events.
[13:32:47.340] <TB1> INFO: 208000 events read in total (8439ms).
[13:32:47.341] <TB1> INFO: Test took 9256ms.
[13:32:47.573] <TB1> INFO: PixTestAlive::aliveTest() done
[13:32:47.573] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:32:47.575] <TB1> INFO: ----------------------------------------------------------------------
[13:32:47.575] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:32:47.575] <TB1> INFO: ----------------------------------------------------------------------
[13:32:47.839] <TB1> INFO: Expecting 208000 events.
[13:32:54.113] <TB1> INFO: 208000 events read in total (5718ms).
[13:32:54.115] <TB1> INFO: Test took 6538ms.
[13:32:54.115] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:32:54.321] <TB1> INFO: PixTestAlive::maskTest() done
[13:32:54.321] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:32:54.322] <TB1> INFO: ----------------------------------------------------------------------
[13:32:54.322] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:32:54.322] <TB1> INFO: ----------------------------------------------------------------------
[13:32:54.633] <TB1> INFO: Expecting 208000 events.
[13:33:03.723] <TB1> INFO: 208000 events read in total (8534ms).
[13:33:03.724] <TB1> INFO: Test took 9400ms.
[13:33:03.924] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:33:03.924] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:33:03.924] <TB1> INFO: PixTestAlive::doTest() done, duration: 25 seconds
[13:33:03.953] <TB1> INFO: enter test to run
[13:33:03.953] <TB1> INFO: test: delay setting parameters: ->2<-
[13:33:03.953] <TB1> INFO: delay test by 2 seconds...
[13:33:05.953] <TB1> INFO: enter test to run
[13:33:05.953] <TB1> INFO: test: HighRate no parameter change
[13:33:05.953] <TB1> INFO: running: highrate
[13:33:05.953] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[13:33:06.137] <TB1> INFO: ----------------------------------------------------------------------
[13:33:06.137] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:33:06.137] <TB1> INFO: ----------------------------------------------------------------------
[13:33:06.670] <TB1> INFO: Expecting 208000 events.
[13:33:18.456] <TB1> INFO: 208000 events read in total (11384ms).
[13:33:18.462] <TB1> INFO: Test took 12322ms.
[13:33:19.000] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:33:19.000] <TB1> INFO: number of red-efficiency pixels: 151 137 114 258 304 347 403 363 321 323 417 226 274 137 128 148
[13:33:19.000] <TB1> INFO: number of X-ray hits detected: 103088 112704 92053 161278 177357 205281 216877 226098 205983 195797 215518 165816 169323 94620 93850 97984
[13:33:19.000] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:33:19.000] <TB1> INFO: number of Vcal hits detected: 207845 207860 207876 207730 207684 207612 207566 207614 207667 207651 207555 207762 207711 207859 207871 207847
[13:33:19.000] <TB1> INFO: Vcal hit fiducial 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
[13:33:19.000] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[13:33:19.000] <TB1> INFO: X-ray hit rate [MHz/cm2]: 30.2 33.0 27.0 47.3 52.0 60.2 63.6 66.3 60.4 57.4 63.2 48.6 49.6 27.7 27.5 28.7
[13:33:19.000] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:33:19.030] <TB1> INFO: PixTest:: pg_setup set to default.
[13:33:19.041] <TB1> INFO: enter test to run
[13:33:19.041] <TB1> INFO: test: no parameter change
[13:33:19.386] <TB1> QUIET: Connection to board 147 closed.
[13:33:19.466] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:33:56.613] <TB1> INFO: *** Welcome to pxar ***
[13:33:56.613] <TB1> INFO: *** Today: 2016/09/22
[13:33:56.678] <TB1> INFO: *** Version: f5d3-dirty
[13:33:56.678] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//dacParameters35_C15.dat
[13:33:56.678] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//tbmParameters_C0b.dat
[13:33:56.678] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//defaultMaskFile.dat
[13:33:56.678] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//trimParameters35_C15.dat
[13:33:56.749] <TB1> INFO: clk: 4
[13:33:56.749] <TB1> INFO: ctr: 4
[13:33:56.749] <TB1> INFO: sda: 19
[13:33:56.749] <TB1> INFO: tin: 9
[13:33:56.749] <TB1> INFO: level: 15
[13:33:56.749] <TB1> INFO: triggerdelay: 0
[13:33:56.749] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[13:33:56.749] <TB1> INFO: Log level: INFO
[13:33:56.762] <TB1> INFO: Found DTB DTB_WWXTQT
[13:33:56.772] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:33:56.774] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:33:56.776] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[13:33:58.307] <TB1> INFO: DUT info:
[13:33:58.307] <TB1> INFO: The DUT currently contains the following objects:
[13:33:58.307] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:33:58.307] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:33:58.307] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:33:58.307] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:33:58.307] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.307] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:33:58.708] <TB1> INFO: enter 'restricted' command line mode
[13:33:58.708] <TB1> INFO: enter test to run
[13:33:58.708] <TB1> INFO: test: PixelAlive no parameter change
[13:33:58.708] <TB1> INFO: running: pixelalive
[13:33:58.713] <TB1> INFO: ######################################################################
[13:33:58.713] <TB1> INFO: PixTestAlive::doTest()
[13:33:58.713] <TB1> INFO: ######################################################################
[13:33:58.715] <TB1> INFO: ----------------------------------------------------------------------
[13:33:58.715] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:33:58.715] <TB1> INFO: ----------------------------------------------------------------------
[13:33:59.001] <TB1> INFO: Expecting 208000 events.
[13:34:08.156] <TB1> INFO: 208000 events read in total (8597ms).
[13:34:08.157] <TB1> INFO: Test took 9440ms.
[13:34:08.388] <TB1> INFO: PixTestAlive::aliveTest() done
[13:34:08.388] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:34:08.389] <TB1> INFO: ----------------------------------------------------------------------
[13:34:08.389] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:34:08.389] <TB1> INFO: ----------------------------------------------------------------------
[13:34:08.665] <TB1> INFO: Expecting 208000 events.
[13:34:14.940] <TB1> INFO: 208000 events read in total (5719ms).
[13:34:14.942] <TB1> INFO: Test took 6550ms.
[13:34:14.942] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:34:15.151] <TB1> INFO: PixTestAlive::maskTest() done
[13:34:15.151] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:34:15.152] <TB1> INFO: ----------------------------------------------------------------------
[13:34:15.152] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:34:15.152] <TB1> INFO: ----------------------------------------------------------------------
[13:34:15.414] <TB1> INFO: Expecting 208000 events.
[13:34:24.633] <TB1> INFO: 208000 events read in total (8663ms).
[13:34:24.633] <TB1> INFO: Test took 9479ms.
[13:34:24.833] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:34:24.833] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:34:24.833] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[13:34:24.864] <TB1> INFO: enter test to run
[13:34:24.864] <TB1> INFO: test: delay setting parameters: ->2<-
[13:34:24.864] <TB1> INFO: delay test by 2 seconds...
[13:34:26.864] <TB1> INFO: enter test to run
[13:34:26.864] <TB1> INFO: test: HighRate no parameter change
[13:34:26.864] <TB1> INFO: running: highrate
[13:34:26.864] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[13:34:27.008] <TB1> INFO: ----------------------------------------------------------------------
[13:34:27.008] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:34:27.008] <TB1> INFO: ----------------------------------------------------------------------
[13:34:27.510] <TB1> INFO: Expecting 208000 events.
[13:34:41.381] <TB1> INFO: 208000 events read in total (13470ms).
[13:34:41.389] <TB1> INFO: Test took 14378ms.
[13:34:42.103] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:34:42.103] <TB1> INFO: number of red-efficiency pixels: 258 326 257 531 568 714 809 781 682 646 782 509 551 306 175 273
[13:34:42.103] <TB1> INFO: number of X-ray hits detected: 152134 166442 137649 237852 261869 300466 318701 331496 302563 286887 313182 243487 249191 141079 139930 145668
[13:34:42.103] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:34:42.103] <TB1> INFO: number of Vcal hits detected: 207730 207655 207714 207418 207349 207132 207041 207130 207227 207273 207106 207436 207389 207648 207817 207712
[13:34:42.103] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.8 99.9 99.8 99.7 99.6 99.6 99.6 99.7 99.7 99.6 99.8 99.7 99.9 99.9 99.9
[13:34:42.103] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.8 99.9 99.7 99.7 99.6 99.5 99.6 99.6 99.7 99.6 99.7 99.7 99.8 99.9 99.9
[13:34:42.103] <TB1> INFO: X-ray hit rate [MHz/cm2]: 44.6 48.8 40.3 69.7 76.8 88.1 93.4 97.2 88.7 84.1 91.8 71.4 73.0 41.4 41.0 42.7
[13:34:42.103] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:34:42.133] <TB1> INFO: PixTest:: pg_setup set to default.
[13:34:42.142] <TB1> INFO: enter test to run
[13:34:42.142] <TB1> INFO: test: no parameter change
[13:34:42.396] <TB1> QUIET: Connection to board 147 closed.
[13:34:42.476] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:35:17.066] <TB1> INFO: *** Welcome to pxar ***
[13:35:17.066] <TB1> INFO: *** Today: 2016/09/22
[13:35:17.132] <TB1> INFO: *** Version: f5d3-dirty
[13:35:17.132] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//dacParameters35_C15.dat
[13:35:17.133] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//tbmParameters_C0b.dat
[13:35:17.133] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//defaultMaskFile.dat
[13:35:17.133] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//trimParameters35_C15.dat
[13:35:17.203] <TB1> INFO: clk: 4
[13:35:17.203] <TB1> INFO: ctr: 4
[13:35:17.203] <TB1> INFO: sda: 19
[13:35:17.203] <TB1> INFO: tin: 9
[13:35:17.203] <TB1> INFO: level: 15
[13:35:17.203] <TB1> INFO: triggerdelay: 0
[13:35:17.203] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[13:35:17.203] <TB1> INFO: Log level: INFO
[13:35:17.216] <TB1> INFO: Found DTB DTB_WWXTQT
[13:35:17.226] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:35:17.228] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:35:17.230] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[13:35:18.761] <TB1> INFO: DUT info:
[13:35:18.761] <TB1> INFO: The DUT currently contains the following objects:
[13:35:18.761] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:35:18.761] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:35:18.761] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:35:18.761] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:35:18.761] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.761] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.761] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.761] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.761] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.761] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.761] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.761] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.761] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.762] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.762] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.762] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.762] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.762] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.762] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:18.762] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:35:19.162] <TB1> INFO: enter 'restricted' command line mode
[13:35:19.162] <TB1> INFO: enter test to run
[13:35:19.162] <TB1> INFO: test: PixelAlive no parameter change
[13:35:19.162] <TB1> INFO: running: pixelalive
[13:35:19.166] <TB1> INFO: ######################################################################
[13:35:19.166] <TB1> INFO: PixTestAlive::doTest()
[13:35:19.166] <TB1> INFO: ######################################################################
[13:35:19.167] <TB1> INFO: ----------------------------------------------------------------------
[13:35:19.167] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:35:19.167] <TB1> INFO: ----------------------------------------------------------------------
[13:35:19.429] <TB1> INFO: Expecting 208000 events.
[13:35:28.447] <TB1> INFO: 208000 events read in total (8460ms).
[13:35:28.449] <TB1> INFO: Test took 9281ms.
[13:35:28.679] <TB1> INFO: PixTestAlive::aliveTest() done
[13:35:28.679] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:35:28.680] <TB1> INFO: ----------------------------------------------------------------------
[13:35:28.681] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:35:28.681] <TB1> INFO: ----------------------------------------------------------------------
[13:35:28.983] <TB1> INFO: Expecting 208000 events.
[13:35:35.246] <TB1> INFO: 208000 events read in total (5706ms).
[13:35:35.247] <TB1> INFO: Test took 6564ms.
[13:35:35.247] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:35:35.455] <TB1> INFO: PixTestAlive::maskTest() done
[13:35:35.455] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:35:35.456] <TB1> INFO: ----------------------------------------------------------------------
[13:35:35.456] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:35:35.456] <TB1> INFO: ----------------------------------------------------------------------
[13:35:35.719] <TB1> INFO: Expecting 208000 events.
[13:35:44.725] <TB1> INFO: 208000 events read in total (8450ms).
[13:35:44.726] <TB1> INFO: Test took 9269ms.
[13:35:44.926] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:35:44.926] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:35:44.926] <TB1> INFO: PixTestAlive::doTest() done, duration: 25 seconds
[13:35:44.955] <TB1> INFO: enter test to run
[13:35:44.955] <TB1> INFO: test: delay setting parameters: ->2<-
[13:35:44.955] <TB1> INFO: delay test by 2 seconds...
[13:35:46.955] <TB1> INFO: enter test to run
[13:35:46.955] <TB1> INFO: test: HighRate no parameter change
[13:35:46.955] <TB1> INFO: running: highrate
[13:35:46.955] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[13:35:47.135] <TB1> INFO: ----------------------------------------------------------------------
[13:35:47.135] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:35:47.135] <TB1> INFO: ----------------------------------------------------------------------
[13:35:47.651] <TB1> INFO: Expecting 208000 events.
[13:36:03.380] <TB1> INFO: 208000 events read in total (15327ms).
[13:36:03.389] <TB1> INFO: Test took 16251ms.
[13:36:04.283] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:36:04.283] <TB1> INFO: number of red-efficiency pixels: 464 479 385 990 1084 1434 1439 1542 1350 1226 1466 924 964 508 359 436
[13:36:04.283] <TB1> INFO: number of X-ray hits detected: 209812 229491 192956 329361 361858 412324 435533 455955 415627 396031 427107 337124 343728 195766 194439 200407
[13:36:04.283] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:36:04.283] <TB1> INFO: number of Vcal hits detected: 207507 207477 207550 206776 206587 206020 205788 205986 206287 206379 205954 206852 206816 207331 207619 207537
[13:36:04.283] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.5 99.4 99.1 99.1 99.1 99.3 99.3 99.2 99.5 99.5 99.7 99.8 99.8
[13:36:04.283] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.8 99.4 99.3 99.0 98.9 99.0 99.2 99.2 99.0 99.4 99.4 99.7 99.8 99.8
[13:36:04.283] <TB1> INFO: X-ray hit rate [MHz/cm2]: 61.5 67.3 56.6 96.5 106.1 120.9 127.7 133.6 121.8 116.1 125.2 98.8 100.7 57.4 57.0 58.7
[13:36:04.283] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:36:04.317] <TB1> INFO: PixTest:: pg_setup set to default.
[13:36:04.332] <TB1> INFO: enter test to run
[13:36:04.332] <TB1> INFO: test: no parameter change
[13:36:04.683] <TB1> QUIET: Connection to board 147 closed.
[13:36:04.762] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:36:38.476] <TB1> INFO: *** Welcome to pxar ***
[13:36:38.476] <TB1> INFO: *** Today: 2016/09/22
[13:36:38.545] <TB1> INFO: *** Version: f5d3-dirty
[13:36:38.545] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//dacParameters35_C15.dat
[13:36:38.546] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//tbmParameters_C0b.dat
[13:36:38.546] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//defaultMaskFile.dat
[13:36:38.546] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//trimParameters35_C15.dat
[13:36:38.619] <TB1> INFO: clk: 4
[13:36:38.619] <TB1> INFO: ctr: 4
[13:36:38.619] <TB1> INFO: sda: 19
[13:36:38.619] <TB1> INFO: tin: 9
[13:36:38.619] <TB1> INFO: level: 15
[13:36:38.619] <TB1> INFO: triggerdelay: 0
[13:36:38.619] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[13:36:38.619] <TB1> INFO: Log level: INFO
[13:36:38.632] <TB1> INFO: Found DTB DTB_WWXTQT
[13:36:38.642] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:36:38.644] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:36:38.646] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[13:36:40.181] <TB1> INFO: DUT info:
[13:36:40.181] <TB1> INFO: The DUT currently contains the following objects:
[13:36:40.181] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:36:40.181] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:36:40.181] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:36:40.181] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:36:40.181] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.181] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.181] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.181] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.181] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.181] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.181] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.181] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.181] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.182] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.182] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.182] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.182] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.182] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.182] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.182] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:36:40.583] <TB1> INFO: enter 'restricted' command line mode
[13:36:40.583] <TB1> INFO: enter test to run
[13:36:40.583] <TB1> INFO: test: PixelAlive no parameter change
[13:36:40.583] <TB1> INFO: running: pixelalive
[13:36:40.587] <TB1> INFO: ######################################################################
[13:36:40.587] <TB1> INFO: PixTestAlive::doTest()
[13:36:40.587] <TB1> INFO: ######################################################################
[13:36:40.588] <TB1> INFO: ----------------------------------------------------------------------
[13:36:40.588] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:36:40.588] <TB1> INFO: ----------------------------------------------------------------------
[13:36:40.851] <TB1> INFO: Expecting 208000 events.
[13:36:49.784] <TB1> INFO: 208000 events read in total (8374ms).
[13:36:49.786] <TB1> INFO: Test took 9196ms.
[13:36:50.021] <TB1> INFO: PixTestAlive::aliveTest() done
[13:36:50.021] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:36:50.023] <TB1> INFO: ----------------------------------------------------------------------
[13:36:50.023] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:36:50.023] <TB1> INFO: ----------------------------------------------------------------------
[13:36:50.319] <TB1> INFO: Expecting 208000 events.
[13:36:56.597] <TB1> INFO: 208000 events read in total (5721ms).
[13:36:56.597] <TB1> INFO: Test took 6572ms.
[13:36:56.597] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:36:56.796] <TB1> INFO: PixTestAlive::maskTest() done
[13:36:56.796] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:36:56.797] <TB1> INFO: ----------------------------------------------------------------------
[13:36:56.797] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:36:56.797] <TB1> INFO: ----------------------------------------------------------------------
[13:36:57.060] <TB1> INFO: Expecting 208000 events.
[13:37:06.093] <TB1> INFO: 208000 events read in total (8476ms).
[13:37:06.093] <TB1> INFO: Test took 9293ms.
[13:37:06.295] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:37:06.295] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:37:06.295] <TB1> INFO: PixTestAlive::doTest() done, duration: 25 seconds
[13:37:06.344] <TB1> INFO: enter test to run
[13:37:06.344] <TB1> INFO: test: delay setting parameters: ->2<-
[13:37:06.344] <TB1> INFO: delay test by 2 seconds...
[13:37:08.344] <TB1> INFO: enter test to run
[13:37:08.344] <TB1> INFO: test: HighRate no parameter change
[13:37:08.344] <TB1> INFO: running: highrate
[13:37:08.344] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[13:37:08.483] <TB1> INFO: ----------------------------------------------------------------------
[13:37:08.483] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:37:08.483] <TB1> INFO: ----------------------------------------------------------------------
[13:37:08.969] <TB1> INFO: Expecting 208000 events.
[13:37:25.974] <TB1> INFO: 208000 events read in total (16604ms).
[13:37:25.985] <TB1> INFO: Test took 17499ms.
[13:37:27.117] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:37:27.117] <TB1> INFO: number of red-efficiency pixels: 702 754 605 1422 1590 1992 2115 2282 1936 1862 2124 1386 1475 737 523 619
[13:37:27.117] <TB1> INFO: number of X-ray hits detected: 256226 281110 236516 399354 439787 498803 531704 553698 504981 480688 518191 409989 415269 238247 238115 245079
[13:37:27.117] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:37:27.117] <TB1> INFO: number of Vcal hits detected: 207203 207161 207226 205943 205613 204661 204046 204383 205123 205112 204352 206014 205983 206884 207432 207298
[13:37:27.117] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.7 99.6 99.7 99.2 99.0 98.6 98.4 98.4 98.7 98.8 98.5 99.2 99.1 99.6 99.7 99.7
[13:37:27.117] <TB1> INFO: Vcal hit overall efficiency (%): 99.6 99.6 99.6 99.0 98.9 98.4 98.1 98.3 98.6 98.6 98.2 99.0 99.0 99.5 99.7 99.7
[13:37:27.117] <TB1> INFO: X-ray hit rate [MHz/cm2]: 75.1 82.4 69.3 117.1 128.9 146.2 155.8 162.3 148.0 140.9 151.9 120.2 121.7 69.8 69.8 71.8
[13:37:27.117] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:37:27.148] <TB1> INFO: PixTest:: pg_setup set to default.
[13:37:27.164] <TB1> INFO: enter test to run
[13:37:27.164] <TB1> INFO: test: no parameter change
[13:37:27.515] <TB1> QUIET: Connection to board 147 closed.
[13:37:27.595] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:38:01.207] <TB1> INFO: *** Welcome to pxar ***
[13:38:01.207] <TB1> INFO: *** Today: 2016/09/22
[13:38:01.279] <TB1> INFO: *** Version: f5d3-dirty
[13:38:01.279] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//dacParameters35_C15.dat
[13:38:01.280] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//tbmParameters_C0b.dat
[13:38:01.280] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//defaultMaskFile.dat
[13:38:01.280] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//trimParameters35_C15.dat
[13:38:01.353] <TB1> INFO: clk: 4
[13:38:01.354] <TB1> INFO: ctr: 4
[13:38:01.354] <TB1> INFO: sda: 19
[13:38:01.354] <TB1> INFO: tin: 9
[13:38:01.354] <TB1> INFO: level: 15
[13:38:01.354] <TB1> INFO: triggerdelay: 0
[13:38:01.354] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[13:38:01.354] <TB1> INFO: Log level: INFO
[13:38:01.366] <TB1> INFO: Found DTB DTB_WWXTQT
[13:38:01.376] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:38:01.378] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:38:01.379] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[13:38:02.947] <TB1> INFO: DUT info:
[13:38:02.947] <TB1> INFO: The DUT currently contains the following objects:
[13:38:02.947] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:38:02.947] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:38:02.947] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:38:02.947] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:38:02.947] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:02.947] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:03.348] <TB1> INFO: enter 'restricted' command line mode
[13:38:03.348] <TB1> INFO: enter test to run
[13:38:03.348] <TB1> INFO: test: PixelAlive no parameter change
[13:38:03.348] <TB1> INFO: running: pixelalive
[13:38:03.351] <TB1> INFO: ######################################################################
[13:38:03.351] <TB1> INFO: PixTestAlive::doTest()
[13:38:03.351] <TB1> INFO: ######################################################################
[13:38:03.352] <TB1> INFO: ----------------------------------------------------------------------
[13:38:03.352] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:38:03.352] <TB1> INFO: ----------------------------------------------------------------------
[13:38:03.611] <TB1> INFO: Expecting 208000 events.
[13:38:12.873] <TB1> INFO: 208000 events read in total (8703ms).
[13:38:12.875] <TB1> INFO: Test took 9521ms.
[13:38:13.114] <TB1> INFO: PixTestAlive::aliveTest() done
[13:38:13.114] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:38:13.116] <TB1> INFO: ----------------------------------------------------------------------
[13:38:13.116] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:38:13.116] <TB1> INFO: ----------------------------------------------------------------------
[13:38:13.392] <TB1> INFO: Expecting 208000 events.
[13:38:19.742] <TB1> INFO: 208000 events read in total (5794ms).
[13:38:19.743] <TB1> INFO: Test took 6625ms.
[13:38:19.744] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:38:19.952] <TB1> INFO: PixTestAlive::maskTest() done
[13:38:19.952] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:38:19.953] <TB1> INFO: ----------------------------------------------------------------------
[13:38:19.953] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:38:19.953] <TB1> INFO: ----------------------------------------------------------------------
[13:38:20.260] <TB1> INFO: Expecting 208000 events.
[13:38:29.488] <TB1> INFO: 208000 events read in total (8672ms).
[13:38:29.488] <TB1> INFO: Test took 9532ms.
[13:38:29.686] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:38:29.686] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:38:29.686] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[13:38:29.715] <TB1> INFO: enter test to run
[13:38:29.715] <TB1> INFO: test: delay setting parameters: ->2<-
[13:38:29.715] <TB1> INFO: delay test by 2 seconds...
[13:38:31.715] <TB1> INFO: enter test to run
[13:38:31.715] <TB1> INFO: test: HighRate no parameter change
[13:38:31.715] <TB1> INFO: running: highrate
[13:38:31.715] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[13:38:31.901] <TB1> INFO: ----------------------------------------------------------------------
[13:38:31.901] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:38:31.901] <TB1> INFO: ----------------------------------------------------------------------
[13:38:32.396] <TB1> INFO: Expecting 208000 events.
[13:38:50.967] <TB1> INFO: 208000 events read in total (18169ms).
[13:38:50.979] <TB1> INFO: Test took 19075ms.
[13:38:52.244] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:38:52.244] <TB1> INFO: number of red-efficiency pixels: 988 1077 811 1899 2166 2725 2756 3010 2659 2459 2826 1912 1984 1010 806 911
[13:38:52.244] <TB1> INFO: number of X-ray hits detected: 305585 336957 283588 476547 523858 592067 631740 662563 602005 570250 614988 488408 494947 285577 285403 291565
[13:38:52.244] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:38:52.244] <TB1> INFO: number of Vcal hits detected: 206764 206702 206745 204831 204035 202314 201623 201861 203072 203232 202023 204820 204862 206187 207097 206909
[13:38:52.244] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.5 99.4 99.5 98.7 98.4 97.6 97.4 97.3 97.9 98.0 97.5 98.7 98.7 99.3 99.6 99.5
[13:38:52.244] <TB1> INFO: Vcal hit overall efficiency (%): 99.4 99.4 99.4 98.5 98.1 97.3 96.9 97.0 97.6 97.7 97.1 98.5 98.5 99.1 99.6 99.5
[13:38:52.244] <TB1> INFO: X-ray hit rate [MHz/cm2]: 89.6 98.8 83.1 139.7 153.5 173.5 185.2 194.2 176.5 167.1 180.3 143.2 145.1 83.7 83.7 85.5
[13:38:52.244] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:38:52.274] <TB1> INFO: PixTest:: pg_setup set to default.
[13:38:52.290] <TB1> INFO: enter test to run
[13:38:52.290] <TB1> INFO: test: no parameter change
[13:38:52.601] <TB1> QUIET: Connection to board 147 closed.
[13:38:52.681] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:39:28.638] <TB1> INFO: *** Welcome to pxar ***
[13:39:28.638] <TB1> INFO: *** Today: 2016/09/22
[13:39:28.709] <TB1> INFO: *** Version: f5d3-dirty
[13:39:28.709] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//dacParameters35_C15.dat
[13:39:28.710] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//tbmParameters_C0b.dat
[13:39:28.710] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//defaultMaskFile.dat
[13:39:28.710] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//trimParameters35_C15.dat
[13:39:28.784] <TB1> INFO: clk: 4
[13:39:28.784] <TB1> INFO: ctr: 4
[13:39:28.784] <TB1> INFO: sda: 19
[13:39:28.784] <TB1> INFO: tin: 9
[13:39:28.784] <TB1> INFO: level: 15
[13:39:28.784] <TB1> INFO: triggerdelay: 0
[13:39:28.784] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[13:39:28.784] <TB1> INFO: Log level: INFO
[13:39:28.798] <TB1> INFO: Found DTB DTB_WWXTQT
[13:39:28.808] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:39:28.809] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:39:28.811] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[13:39:30.381] <TB1> INFO: DUT info:
[13:39:30.381] <TB1> INFO: The DUT currently contains the following objects:
[13:39:30.381] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:39:30.381] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:39:30.381] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:39:30.381] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:39:30.382] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.382] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:30.782] <TB1> INFO: enter 'restricted' command line mode
[13:39:30.782] <TB1> INFO: enter test to run
[13:39:30.782] <TB1> INFO: test: PixelAlive no parameter change
[13:39:30.782] <TB1> INFO: running: pixelalive
[13:39:30.788] <TB1> INFO: ######################################################################
[13:39:30.788] <TB1> INFO: PixTestAlive::doTest()
[13:39:30.788] <TB1> INFO: ######################################################################
[13:39:30.790] <TB1> INFO: ----------------------------------------------------------------------
[13:39:30.790] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:39:30.790] <TB1> INFO: ----------------------------------------------------------------------
[13:39:31.058] <TB1> INFO: Expecting 208000 events.
[13:39:40.208] <TB1> INFO: 208000 events read in total (8592ms).
[13:39:40.210] <TB1> INFO: Test took 9418ms.
[13:39:40.433] <TB1> INFO: PixTestAlive::aliveTest() done
[13:39:40.433] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:39:40.434] <TB1> INFO: ----------------------------------------------------------------------
[13:39:40.434] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:39:40.434] <TB1> INFO: ----------------------------------------------------------------------
[13:39:40.729] <TB1> INFO: Expecting 208000 events.
[13:39:47.083] <TB1> INFO: 208000 events read in total (5796ms).
[13:39:47.086] <TB1> INFO: Test took 6651ms.
[13:39:47.086] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:39:47.283] <TB1> INFO: PixTestAlive::maskTest() done
[13:39:47.283] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:39:47.284] <TB1> INFO: ----------------------------------------------------------------------
[13:39:47.284] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:39:47.284] <TB1> INFO: ----------------------------------------------------------------------
[13:39:47.546] <TB1> INFO: Expecting 208000 events.
[13:39:56.853] <TB1> INFO: 208000 events read in total (8750ms).
[13:39:56.854] <TB1> INFO: Test took 9568ms.
[13:39:57.054] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:39:57.054] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:39:57.054] <TB1> INFO: PixTestAlive::doTest() done, duration: 26 seconds
[13:39:57.085] <TB1> INFO: enter test to run
[13:39:57.085] <TB1> INFO: test: delay setting parameters: ->2<-
[13:39:57.085] <TB1> INFO: delay test by 2 seconds...
[13:39:59.085] <TB1> INFO: enter test to run
[13:39:59.085] <TB1> INFO: test: HighRate no parameter change
[13:39:59.085] <TB1> INFO: running: highrate
[13:39:59.085] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[13:39:59.222] <TB1> INFO: ----------------------------------------------------------------------
[13:39:59.222] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:39:59.222] <TB1> INFO: ----------------------------------------------------------------------
[13:39:59.744] <TB1> INFO: Expecting 208000 events.
[13:40:22.986] <TB1> INFO: 208000 events read in total (22840ms).
[13:40:23.005] <TB1> INFO: Test took 23780ms.
[13:40:24.583] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:40:24.583] <TB1> INFO: number of red-efficiency pixels: 1834 1957 1323 3069 3323 3782 3786 4023 3814 3597 3872 3102 3150 1566 1419 1788
[13:40:24.583] <TB1> INFO: number of X-ray hits detected: 417192 459027 388685 646859 711528 797929 854708 899844 813388 774530 829055 661827 670968 391007 391927 399154
[13:40:24.583] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:40:24.583] <TB1> INFO: number of Vcal hits detected: 205163 205091 205137 200169 198656 194492 192161 191916 195308 196090 193580 200084 200263 203942 206122 205289
[13:40:24.583] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.8 98.7 98.9 96.8 96.1 94.2 93.3 92.9 94.5 95.0 93.9 96.7 96.7 98.4 99.2 98.8
[13:40:24.583] <TB1> INFO: Vcal hit overall efficiency (%): 98.6 98.6 98.6 96.2 95.5 93.5 92.4 92.3 93.9 94.3 93.1 96.2 96.3 98.0 99.1 98.7
[13:40:24.583] <TB1> INFO: X-ray hit rate [MHz/cm2]: 122.3 134.5 113.9 189.6 208.6 233.9 250.5 263.8 238.4 227.0 243.0 194.0 196.7 114.6 114.9 117.0
[13:40:24.583] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:40:24.613] <TB1> INFO: PixTest:: pg_setup set to default.
[13:40:24.630] <TB1> INFO: enter test to run
[13:40:24.630] <TB1> INFO: test: no parameter change
[13:40:24.921] <TB1> QUIET: Connection to board 147 closed.
[13:40:25.002] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:40:58.124] <TB1> INFO: *** Welcome to pxar ***
[13:40:58.124] <TB1> INFO: *** Today: 2016/09/22
[13:40:58.191] <TB1> INFO: *** Version: f5d3-dirty
[13:40:58.191] <TB1> INFO: readRocDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//dacParameters35_C15.dat
[13:40:58.192] <TB1> INFO: readTbmDacs: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//tbmParameters_C0b.dat
[13:40:58.192] <TB1> INFO: readMaskFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//defaultMaskFile.dat
[13:40:58.192] <TB1> INFO: readTrimFile: /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//trimParameters35_C15.dat
[13:40:58.267] <TB1> INFO: clk: 4
[13:40:58.267] <TB1> INFO: ctr: 4
[13:40:58.267] <TB1> INFO: sda: 19
[13:40:58.267] <TB1> INFO: tin: 9
[13:40:58.267] <TB1> INFO: level: 15
[13:40:58.267] <TB1> INFO: triggerdelay: 0
[13:40:58.267] <TB1> QUIET: Instanciating API for pxar v2.7.6+55~gafdbfd9
[13:40:58.267] <TB1> INFO: Log level: INFO
[13:40:58.280] <TB1> INFO: Found DTB DTB_WWXTQT
[13:40:58.289] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:40:58.291] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:40:58.293] <TB1> INFO: RPC call hashes of host and DTB match: 486171790
[13:40:59.832] <TB1> INFO: DUT info:
[13:40:59.832] <TB1> INFO: The DUT currently contains the following objects:
[13:40:59.832] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:40:59.832] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:40:59.832] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:40:59.832] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:40:59.832] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.832] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.833] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.833] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.833] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.833] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:59.833] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:00.233] <TB1> INFO: enter 'restricted' command line mode
[13:41:00.233] <TB1> INFO: enter test to run
[13:41:00.233] <TB1> INFO: test: PixelAlive no parameter change
[13:41:00.233] <TB1> INFO: running: pixelalive
[13:41:00.237] <TB1> INFO: ######################################################################
[13:41:00.237] <TB1> INFO: PixTestAlive::doTest()
[13:41:00.237] <TB1> INFO: ######################################################################
[13:41:00.238] <TB1> INFO: ----------------------------------------------------------------------
[13:41:00.238] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:41:00.238] <TB1> INFO: ----------------------------------------------------------------------
[13:41:00.501] <TB1> INFO: Expecting 208000 events.
[13:41:09.445] <TB1> INFO: 208000 events read in total (8386ms).
[13:41:09.446] <TB1> INFO: Test took 9206ms.
[13:41:09.676] <TB1> INFO: PixTestAlive::aliveTest() done
[13:41:09.676] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:41:09.678] <TB1> INFO: ----------------------------------------------------------------------
[13:41:09.678] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:41:09.678] <TB1> INFO: ----------------------------------------------------------------------
[13:41:09.950] <TB1> INFO: Expecting 208000 events.
[13:41:16.298] <TB1> INFO: 208000 events read in total (5792ms).
[13:41:16.300] <TB1> INFO: Test took 6620ms.
[13:41:16.301] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:41:16.502] <TB1> INFO: PixTestAlive::maskTest() done
[13:41:16.502] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:41:16.504] <TB1> INFO: ----------------------------------------------------------------------
[13:41:16.504] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:41:16.504] <TB1> INFO: ----------------------------------------------------------------------
[13:41:16.782] <TB1> INFO: Expecting 208000 events.
[13:41:25.725] <TB1> INFO: 208000 events read in total (8387ms).
[13:41:25.726] <TB1> INFO: Test took 9221ms.
[13:41:25.931] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:41:25.931] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:41:25.931] <TB1> INFO: PixTestAlive::doTest() done, duration: 25 seconds
[13:41:25.966] <TB1> INFO: enter test to run
[13:41:25.966] <TB1> INFO: test: delay setting parameters: ->2<-
[13:41:25.966] <TB1> INFO: delay test by 2 seconds...
[13:41:27.966] <TB1> INFO: enter test to run
[13:41:27.967] <TB1> INFO: test: HighRate no parameter change
[13:41:27.967] <TB1> INFO: running: highrate
[13:41:27.967] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2342_XrayQualification_2016-09-22_14h30m_1474547419//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[13:41:28.106] <TB1> INFO: ----------------------------------------------------------------------
[13:41:28.106] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:41:28.106] <TB1> INFO: ----------------------------------------------------------------------
[13:41:28.602] <TB1> INFO: Expecting 208000 events.
[13:41:54.988] <TB1> INFO: 192250 events read in total (25984ms).
[13:41:57.467] <TB1> INFO: 208000 events read in total (28463ms).
[13:41:57.485] <TB1> INFO: Test took 29376ms.
[13:41:59.495] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:41:59.495] <TB1> INFO: number of red-efficiency pixels: 2559 2751 1822 3802 3926 4105 4092 4155 4115 4043 4125 3766 3832 2038 2171 2460
[13:41:59.495] <TB1> INFO: number of X-ray hits detected: 516041 570306 482438 799605 880614 986647 1055337 1113651 1007316 958145 1014066 818661 830624 481225 486249 491873
[13:41:59.495] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:41:59.495] <TB1> INFO: number of Vcal hits detected: 202910 202714 202533 193352 190116 183056 179772 177883 184220 186189 182055 193552 193693 200773 204543 203322
[13:41:59.495] <TB1> INFO: Vcal hit fiducial efficiency (%): 97.9 97.6 97.9 93.8 92.4 89.1 87.9 86.4 89.4 90.5 88.7 93.9 93.9 97.1 98.5 98.0
[13:41:59.495] <TB1> INFO: Vcal hit overall efficiency (%): 97.6 97.5 97.4 93.0 91.4 88.0 86.4 85.5 88.6 89.5 87.5 93.1 93.1 96.5 98.3 97.8
[13:41:59.495] <TB1> INFO: X-ray hit rate [MHz/cm2]: 151.3 167.2 141.4 234.4 258.1 289.2 309.3 326.4 295.3 280.8 297.2 240.0 243.5 141.1 142.5 144.2
[13:41:59.495] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:41:59.525] <TB1> INFO: PixTest:: pg_setup set to default.
[13:41:59.538] <TB1> INFO: enter test to run
[13:41:59.538] <TB1> INFO: test: no parameter change
[13:41:59.842] <TB1> QUIET: Connection to board 147 closed.
[13:41:59.922] <TB1> INFO: pXar: this is the end, my friend