[12:53:58.829] <TB1> INFO: *** Welcome to pxar ***
[12:53:58.829] <TB1> INFO: *** Today: 2016/01/22
[12:53:59.181] <TB1> INFO: *** Version: 9751
[12:53:59.181] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//dacParameters35_C15.dat
[12:53:59.181] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//tbmParameters_C0b.dat
[12:53:59.181] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//defaultMaskFile.dat
[12:53:59.181] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//trimParameters35_C15.dat
[12:53:59.249] <TB1> INFO: clk: 4
[12:53:59.249] <TB1> INFO: ctr: 4
[12:53:59.249] <TB1> INFO: sda: 19
[12:53:59.249] <TB1> INFO: tin: 9
[12:53:59.249] <TB1> INFO: level: 15
[12:53:59.249] <TB1> INFO: triggerdelay: 0
[12:53:59.249] <TB1> QUIET: Instanciating API for pxar prod-12
[12:53:59.249] <TB1> INFO: Log level: INFO
[12:53:59.261] <TB1> INFO: Found DTB DTB_WWXTQT
[12:53:59.271] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:53:59.274] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:53:59.276] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:54:00.811] <TB1> INFO: DUT info:
[12:54:00.811] <TB1> INFO: The DUT currently contains the following objects:
[12:54:00.811] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:54:00.811] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:54:00.811] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:54:00.811] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:54:00.811] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:00.811] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:01.212] <TB1> INFO: enter 'restricted' command line mode
[12:54:01.212] <TB1> INFO: enter test to run
[12:54:01.212] <TB1> INFO: test: PixelAlive no parameter change
[12:54:01.212] <TB1> INFO: running: pixelalive
[12:54:01.216] <TB1> INFO: ######################################################################
[12:54:01.216] <TB1> INFO: PixTestAlive::doTest()
[12:54:01.216] <TB1> INFO: ######################################################################
[12:54:01.217] <TB1> INFO: ----------------------------------------------------------------------
[12:54:01.217] <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:54:01.217] <TB1> INFO: ----------------------------------------------------------------------
[12:54:01.515] <TB1> INFO: Expecting 41600 events.
[12:54:05.655] <TB1> INFO: 41600 events read in total (3422ms).
[12:54:05.735] <TB1> INFO: Test took 4516ms.
[12:54:05.741] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:05.992] <TB1> INFO: PixTestAlive::aliveTest() done
[12:54:05.992] <TB1> INFO: number of dead pixels (per ROC): 0 1 1 0 1 0 0 0 1 0 1 0 0 0 0 2
[12:54:05.994] <TB1> INFO: ----------------------------------------------------------------------
[12:54:05.994] <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:54:05.994] <TB1> INFO: ----------------------------------------------------------------------
[12:54:06.292] <TB1> INFO: Expecting 41600 events.
[12:54:09.370] <TB1> INFO: 41600 events read in total (2362ms).
[12:54:09.370] <TB1> INFO: Test took 3375ms.
[12:54:09.370] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:09.370] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:54:09.689] <TB1> INFO: PixTestAlive::maskTest() done
[12:54:09.689] <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:54:09.690] <TB1> INFO: ----------------------------------------------------------------------
[12:54:09.690] <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:54:09.690] <TB1> INFO: ----------------------------------------------------------------------
[12:54:10.002] <TB1> INFO: Expecting 41600 events.
[12:54:14.213] <TB1> INFO: 41600 events read in total (3495ms).
[12:54:14.214] <TB1> INFO: Test took 4522ms.
[12:54:14.220] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:14.503] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:54:14.503] <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:54:14.503] <TB1> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[12:54:14.542] <TB1> INFO: enter test to run
[12:54:14.542] <TB1> INFO: test: no parameter change
[12:54:14.709] <TB1> QUIET: Connection to board 147 closed.
[12:54:14.789] <TB1> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[12:58:45.933] <TB1> INFO: *** Welcome to pxar ***
[12:58:45.933] <TB1> INFO: *** Today: 2016/01/22
[12:58:46.279] <TB1> INFO: *** Version: 9751
[12:58:46.280] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//dacParameters35_C15.dat
[12:58:46.280] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[12:58:46.280] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:58:46.280] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:58:46.348] <TB1> INFO: clk: 4
[12:58:46.348] <TB1> INFO: ctr: 4
[12:58:46.348] <TB1> INFO: sda: 19
[12:58:46.348] <TB1> INFO: tin: 9
[12:58:46.348] <TB1> INFO: level: 15
[12:58:46.348] <TB1> INFO: triggerdelay: 0
[12:58:46.348] <TB1> QUIET: Instanciating API for pxar prod-12
[12:58:46.348] <TB1> INFO: Log level: INFO
[12:58:46.362] <TB1> INFO: Found DTB DTB_WWXTQT
[12:58:46.372] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:58:46.375] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:58:46.378] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:58:47.914] <TB1> INFO: DUT info:
[12:58:47.914] <TB1> INFO: The DUT currently contains the following objects:
[12:58:47.914] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:58:47.914] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:58:47.914] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:58:47.914] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:58:47.914] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:47.914] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:48.315] <TB1> INFO: enter 'restricted' command line mode
[12:58:48.315] <TB1> INFO: enter test to run
[12:58:48.315] <TB1> INFO: test: delay setting parameters: ->5<-
[12:58:48.315] <TB1> INFO: delay test by 5 seconds...
[12:58:53.315] <TB1> INFO: enter test to run
[12:58:53.315] <TB1> INFO: test: highrate no parameter change
[12:58:53.315] <TB1> INFO: running: highrate
[12:58:53.315] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[12:58:53.448] <TB1> INFO: ----------------------------------------------------------------------
[12:58:53.448] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:58:53.448] <TB1> INFO: ----------------------------------------------------------------------
[12:58:53.448] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:58:53.448] <TB1> INFO: edge/corner pixel THR is adjusted
[12:58:53.448] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:58:54.408] <TB1> INFO: Collecting data for 1 seconds...
[12:58:55.409] <TB1> INFO: Done with hot pixel readout
[12:59:01.943] <TB1> INFO: PixTest:: pg_setup set to default.
[12:59:01.944] <TB1> INFO: 3 hot pixels found in step 0
[12:59:02.909] <TB1> INFO: Collecting data for 1 seconds...
[12:59:03.910] <TB1> INFO: Done with hot pixel readout
[12:59:10.870] <TB1> INFO: PixTest:: pg_setup set to default.
[12:59:10.872] <TB1> INFO: 3 hot pixels found in step 1
[12:59:11.833] <TB1> INFO: Collecting data for 1 seconds...
[12:59:12.835] <TB1> INFO: Done with hot pixel readout
[12:59:19.235] <TB1> INFO: PixTest:: pg_setup set to default.
[12:59:19.236] <TB1> INFO: 2 hot pixels found in step 2
[12:59:20.198] <TB1> INFO: Collecting data for 1 seconds...
[12:59:21.200] <TB1> INFO: Done with hot pixel readout
[12:59:28.241] <TB1> INFO: PixTest:: pg_setup set to default.
[12:59:28.242] <TB1> INFO: 0 hot pixels found in step 3
[12:59:28.250] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[12:59:28.278] <TB1> INFO: PixTest::trimHotPixels() done
[12:59:28.278] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C0.dat
[12:59:28.285] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C1.dat
[12:59:28.292] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C2.dat
[12:59:28.298] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C3.dat
[12:59:28.304] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C4.dat
[12:59:28.311] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C5.dat
[12:59:28.317] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C6.dat
[12:59:28.324] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C7.dat
[12:59:28.330] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C8.dat
[12:59:28.336] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C9.dat
[12:59:28.343] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C10.dat
[12:59:28.350] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C11.dat
[12:59:28.356] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C12.dat
[12:59:28.363] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C13.dat
[12:59:28.369] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C14.dat
[12:59:28.376] <TB1> INFO: write trim parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:59:28.382] <TB1> INFO: write masked pixels into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:59:28.414] <TB1> INFO: enter test to run
[12:59:28.414] <TB1> INFO: test: no parameter change
[12:59:28.570] <TB1> QUIET: Connection to board 147 closed.
[12:59:28.650] <TB1> INFO: pXar: this is the end, my friend
[14:54:12.377] <TB1> INFO: *** Welcome to pxar ***
[14:54:12.377] <TB1> INFO: *** Today: 2016/01/22
[14:54:12.723] <TB1> INFO: *** Version: 9751
[14:54:12.723] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//dacParameters35_C15.dat
[14:54:12.723] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//tbmParameters_C0b.dat
[14:54:12.723] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//defaultMaskFile.dat
[14:54:12.723] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//trimParameters35_C15.dat
[14:54:12.793] <TB1> INFO: clk: 4
[14:54:12.793] <TB1> INFO: ctr: 4
[14:54:12.793] <TB1> INFO: sda: 19
[14:54:12.793] <TB1> INFO: tin: 9
[14:54:12.793] <TB1> INFO: level: 15
[14:54:12.793] <TB1> INFO: triggerdelay: 0
[14:54:12.793] <TB1> QUIET: Instanciating API for pxar prod-12
[14:54:12.793] <TB1> INFO: Log level: INFO
[14:54:12.805] <TB1> INFO: Found DTB DTB_WWXTQT
[14:54:12.815] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[14:54:12.818] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[14:54:12.820] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[14:54:14.355] <TB1> INFO: DUT info:
[14:54:14.355] <TB1> INFO: The DUT currently contains the following objects:
[14:54:14.355] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[14:54:14.355] <TB1> INFO: TBM Core alpha (0): 7 registers set
[14:54:14.355] <TB1> INFO: TBM Core beta (1): 7 registers set
[14:54:14.355] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:54:14.356] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.356] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:14.756] <TB1> INFO: enter 'restricted' command line mode
[14:54:14.756] <TB1> INFO: enter test to run
[14:54:14.757] <TB1> INFO: test: delay setting parameters: ->5<-
[14:54:14.757] <TB1> INFO: delay test by 5 seconds...
[14:54:19.757] <TB1> INFO: enter test to run
[14:54:19.757] <TB1> INFO: test: Xray no parameter change
[14:54:19.757] <TB1> INFO: running: xray
[14:54:19.757] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//phCalibrationFitErr35_C15.dat
[14:54:19.889] <TB1> INFO: ######################################################################
[14:54:19.889] <TB1> INFO: PixTestXray::doTest()
[14:54:19.889] <TB1> INFO: ######################################################################
[14:54:19.889] <TB1> INFO: ----------------------------------------------------------------------
[14:54:19.889] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[14:54:19.889] <TB1> INFO: ----------------------------------------------------------------------
[14:54:20.855] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[14:54:26.914] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[14:54:51.138] <TB1> INFO: Resuming triggers.
[14:54:57.205] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[14:55:22.981] <TB1> INFO: Resuming triggers.
[14:55:29.046] <TB1> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[14:55:54.309] <TB1> INFO: Resuming triggers.
[14:56:00.372] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[14:56:25.806] <TB1> INFO: Resuming triggers.
[14:56:31.870] <TB1> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[14:56:56.920] <TB1> INFO: Resuming triggers.
[14:57:02.986] <TB1> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[14:57:28.556] <TB1> INFO: Resuming triggers.
[14:57:34.619] <TB1> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[14:57:58.439] <TB1> INFO: Resuming triggers.
[14:58:04.498] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[14:58:29.071] <TB1> INFO: Resuming triggers.
[14:58:35.132] <TB1> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[14:58:59.427] <TB1> INFO: Resuming triggers.
[14:59:05.483] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[14:59:30.532] <TB1> INFO: Resuming triggers.
[14:59:36.587] <TB1> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[15:00:00.136] <TB1> INFO: Resuming triggers.
[15:00:06.190] <TB1> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[15:00:30.400] <TB1> INFO: Resuming triggers.
[15:00:36.454] <TB1> INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[15:01:01.159] <TB1> INFO: Resuming triggers.
[15:01:07.214] <TB1> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[15:01:33.156] <TB1> INFO: Resuming triggers.
[15:01:39.209] <TB1> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[15:02:04.048] <TB1> INFO: Resuming triggers.
[15:02:10.102] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[15:02:35.109] <TB1> INFO: Resuming triggers.
[15:02:38.256] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[15:02:51.228] <TB1> INFO: PixTest:: pg_setup set to default.
[15:02:51.229] <TB1> INFO: PixTestXray::doPhRun() done
[15:02:51.230] <TB1> INFO: PixTestXray::doTest() done
[15:02:51.405] <TB1> INFO: enter test to run
[15:02:51.405] <TB1> INFO: test: no parameter change
[15:02:51.629] <TB1> QUIET: Connection to board 147 closed.
[15:02:51.709] <TB1> INFO: pXar: this is the end, my friend
[15:02:59.884] <TB1> INFO: *** Welcome to pxar ***
[15:02:59.884] <TB1> INFO: *** Today: 2016/01/22
[15:03:00.242] <TB1> INFO: *** Version: 9751
[15:03:00.242] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//dacParameters35_C15.dat
[15:03:00.243] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//tbmParameters_C0b.dat
[15:03:00.243] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//defaultMaskFile.dat
[15:03:00.243] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//trimParameters35_C15.dat
[15:03:00.311] <TB1> INFO: clk: 4
[15:03:00.311] <TB1> INFO: ctr: 4
[15:03:00.311] <TB1> INFO: sda: 19
[15:03:00.311] <TB1> INFO: tin: 9
[15:03:00.311] <TB1> INFO: level: 15
[15:03:00.311] <TB1> INFO: triggerdelay: 0
[15:03:00.311] <TB1> QUIET: Instanciating API for pxar prod-12
[15:03:00.311] <TB1> INFO: Log level: INFO
[15:03:00.324] <TB1> INFO: Found DTB DTB_WWXTQT
[15:03:00.334] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[15:03:00.337] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[15:03:00.340] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[15:03:01.876] <TB1> INFO: DUT info:
[15:03:01.876] <TB1> INFO: The DUT currently contains the following objects:
[15:03:01.876] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[15:03:01.876] <TB1> INFO: TBM Core alpha (0): 7 registers set
[15:03:01.876] <TB1> INFO: TBM Core beta (1): 7 registers set
[15:03:01.876] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:03:01.876] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:01.876] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:02.277] <TB1> INFO: enter 'restricted' command line mode
[15:03:02.277] <TB1> INFO: enter test to run
[15:03:02.277] <TB1> INFO: test: delay setting parameters: ->5<-
[15:03:02.277] <TB1> INFO: delay test by 5 seconds...
[15:03:07.277] <TB1> INFO: enter test to run
[15:03:07.277] <TB1> INFO: test: Xray no parameter change
[15:03:07.277] <TB1> INFO: running: xray
[15:03:07.277] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//phCalibrationFitErr35_C15.dat
[15:03:07.409] <TB1> INFO: ######################################################################
[15:03:07.409] <TB1> INFO: PixTestXray::doTest()
[15:03:07.409] <TB1> INFO: ######################################################################
[15:03:07.409] <TB1> INFO: ----------------------------------------------------------------------
[15:03:07.409] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:03:07.409] <TB1> INFO: ----------------------------------------------------------------------
[15:03:08.376] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:03:11.574] <TB1> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[15:03:37.385] <TB1> INFO: Resuming triggers.
[15:03:40.593] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[15:04:05.947] <TB1> INFO: Resuming triggers.
[15:04:09.156] <TB1> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[15:04:34.658] <TB1> INFO: Resuming triggers.
[15:04:37.866] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[15:05:03.769] <TB1> INFO: Resuming triggers.
[15:05:06.977] <TB1> INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[15:05:32.103] <TB1> INFO: Resuming triggers.
[15:05:35.310] <TB1> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[15:06:01.178] <TB1> INFO: Resuming triggers.
[15:06:04.384] <TB1> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[15:06:30.493] <TB1> INFO: Resuming triggers.
[15:06:33.701] <TB1> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[15:06:58.541] <TB1> INFO: Resuming triggers.
[15:07:01.746] <TB1> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[15:07:26.888] <TB1> INFO: Resuming triggers.
[15:07:30.093] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[15:07:55.321] <TB1> INFO: Resuming triggers.
[15:07:58.527] <TB1> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[15:08:24.544] <TB1> INFO: Resuming triggers.
[15:08:27.752] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[15:08:52.248] <TB1> INFO: Resuming triggers.
[15:08:55.455] <TB1> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[15:09:19.939] <TB1> INFO: Resuming triggers.
[15:09:23.142] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[15:09:48.434] <TB1> INFO: Resuming triggers.
[15:09:51.636] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[15:10:17.509] <TB1> INFO: Resuming triggers.
[15:10:20.712] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[15:10:48.377] <TB1> INFO: Resuming triggers.
[15:10:51.580] <TB1> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[15:11:16.689] <TB1> INFO: Resuming triggers.
[15:11:19.892] <TB1> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[15:11:45.834] <TB1> INFO: Resuming triggers.
[15:11:49.036] <TB1> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[15:12:15.409] <TB1> INFO: Resuming triggers.
[15:12:18.610] <TB1> INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[15:12:44.394] <TB1> INFO: Resuming triggers.
[15:12:47.591] <TB1> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[15:13:13.309] <TB1> INFO: Resuming triggers.
[15:13:16.507] <TB1> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[15:13:42.456] <TB1> INFO: Resuming triggers.
[15:13:45.656] <TB1> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[15:14:12.112] <TB1> INFO: Resuming triggers.
[15:14:15.312] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[15:14:41.933] <TB1> INFO: Resuming triggers.
[15:14:45.133] <TB1> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[15:15:11.267] <TB1> INFO: Resuming triggers.
[15:15:14.466] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[15:15:41.514] <TB1> INFO: Resuming triggers.
[15:15:44.715] <TB1> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[15:16:11.321] <TB1> INFO: Resuming triggers.
[15:16:14.519] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[15:16:39.534] <TB1> INFO: Resuming triggers.
[15:16:42.730] <TB1> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[15:17:08.324] <TB1> INFO: Resuming triggers.
[15:17:11.523] <TB1> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[15:17:37.710] <TB1> INFO: Resuming triggers.
[15:17:40.908] <TB1> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[15:18:05.404] <TB1> INFO: Resuming triggers.
[15:18:06.211] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[15:18:12.352] <TB1> INFO: PixTest:: pg_setup set to default.
[15:18:12.353] <TB1> INFO: PixTestXray::doPhRun() done
[15:18:12.353] <TB1> INFO: PixTestXray::doTest() done
[15:18:12.528] <TB1> INFO: enter test to run
[15:18:12.528] <TB1> INFO: test: no parameter change
[15:18:12.762] <TB1> QUIET: Connection to board 147 closed.
[15:18:12.844] <TB1> INFO: pXar: this is the end, my friend
[13:03:23.439] <TB1> INFO: *** Welcome to pxar ***
[13:03:23.439] <TB1> INFO: *** Today: 2016/01/22
[13:03:23.792] <TB1> INFO: *** Version: 9751
[13:03:23.792] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//dacParameters35_C15.dat
[13:03:23.793] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//tbmParameters_C0b.dat
[13:03:23.793] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//defaultMaskFile.dat
[13:03:23.793] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//trimParameters35_C15.dat
[13:03:23.864] <TB1> INFO: clk: 4
[13:03:23.864] <TB1> INFO: ctr: 4
[13:03:23.864] <TB1> INFO: sda: 19
[13:03:23.864] <TB1> INFO: tin: 9
[13:03:23.864] <TB1> INFO: level: 15
[13:03:23.864] <TB1> INFO: triggerdelay: 0
[13:03:23.864] <TB1> QUIET: Instanciating API for pxar prod-12
[13:03:23.864] <TB1> INFO: Log level: INFO
[13:03:23.876] <TB1> INFO: Found DTB DTB_WWXTQT
[13:03:23.886] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:03:23.889] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:03:23.891] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:03:25.424] <TB1> INFO: DUT info:
[13:03:25.424] <TB1> INFO: The DUT currently contains the following objects:
[13:03:25.424] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:03:25.424] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:03:25.424] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:03:25.424] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:03:25.424] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.424] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:25.825] <TB1> INFO: enter 'restricted' command line mode
[13:03:25.825] <TB1> INFO: enter test to run
[13:03:25.825] <TB1> INFO: test: Highrate no parameter change
[13:03:25.825] <TB1> INFO: running: highrate
[13:03:25.825] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[13:03:25.953] <TB1> INFO: ----------------------------------------------------------------------
[13:03:25.953] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[13:03:25.953] <TB1> INFO: ----------------------------------------------------------------------
[13:03:25.959] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[13:03:25.969] <TB1> INFO: dacScan step from 15 .. 34
[13:03:25.969] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:03:25.969] <TB1> INFO: run 1 of 1
[13:03:26.557] <TB1> INFO: Expecting 4160000 events.
[13:03:57.331] <TB1> INFO: 410900 events read in total (30244ms).
[13:04:27.963] <TB1> INFO: 824150 events read in total (60876ms).
[13:04:56.373] <TB1> INFO: 1237450 events read in total (89286ms).
[13:05:25.034] <TB1> INFO: 1650300 events read in total (117947ms).
[13:05:54.193] <TB1> INFO: 2062650 events read in total (147106ms).
[13:06:23.206] <TB1> INFO: 2474800 events read in total (176119ms).
[13:06:52.629] <TB1> INFO: 2887050 events read in total (205542ms).
[13:07:22.931] <TB1> INFO: 3299150 events read in total (235844ms).
[13:07:53.355] <TB1> INFO: 3711500 events read in total (266268ms).
[13:08:22.995] <TB1> INFO: 4123800 events read in total (295908ms).
[13:08:25.629] <TB1> INFO: 4160000 events read in total (298542ms).
[13:08:25.888] <TB1> INFO: Test took 299919ms.
[13:08:29.034] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:08:34.545] <TB1> INFO: dacScan step from 35 .. 54
[13:08:34.545] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:08:34.545] <TB1> INFO: run 1 of 1
[13:08:35.136] <TB1> INFO: Expecting 4160000 events.
[13:09:03.986] <TB1> INFO: 356600 events read in total (28311ms).
[13:09:31.922] <TB1> INFO: 714150 events read in total (56247ms).
[13:10:00.468] <TB1> INFO: 1070800 events read in total (84793ms).
[13:10:29.113] <TB1> INFO: 1426300 events read in total (113438ms).
[13:10:57.634] <TB1> INFO: 1781000 events read in total (141959ms).
[13:11:25.852] <TB1> INFO: 2134550 events read in total (170177ms).
[13:11:54.019] <TB1> INFO: 2485750 events read in total (198344ms).
[13:12:22.668] <TB1> INFO: 2834700 events read in total (226993ms).
[13:12:50.856] <TB1> INFO: 3181200 events read in total (255181ms).
[13:13:19.513] <TB1> INFO: 3525400 events read in total (283838ms).
[13:13:48.032] <TB1> INFO: 3868250 events read in total (312357ms).
[13:14:11.784] <TB1> INFO: 4160000 events read in total (336109ms).
[13:14:12.007] <TB1> INFO: Test took 337462ms.
[13:14:15.491] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:14:22.030] <TB1> INFO: dacScan step from 55 .. 74
[13:14:22.030] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:14:22.030] <TB1> INFO: run 1 of 1
[13:14:22.625] <TB1> INFO: Expecting 4160000 events.
[13:14:50.418] <TB1> INFO: 312100 events read in total (27266ms).
[13:15:18.042] <TB1> INFO: 625200 events read in total (54890ms).
[13:15:45.210] <TB1> INFO: 938450 events read in total (82058ms).
[13:16:12.537] <TB1> INFO: 1251550 events read in total (109385ms).
[13:16:39.484] <TB1> INFO: 1564400 events read in total (136332ms).
[13:17:07.747] <TB1> INFO: 1877200 events read in total (164595ms).
[13:17:36.203] <TB1> INFO: 2190250 events read in total (193051ms).
[13:18:04.479] <TB1> INFO: 2502900 events read in total (221327ms).
[13:18:31.253] <TB1> INFO: 2815900 events read in total (248101ms).
[13:18:57.633] <TB1> INFO: 3128850 events read in total (274481ms).
[13:19:24.958] <TB1> INFO: 3442150 events read in total (301806ms).
[13:19:51.645] <TB1> INFO: 3755150 events read in total (328493ms).
[13:20:18.978] <TB1> INFO: 4067900 events read in total (355826ms).
[13:20:26.729] <TB1> INFO: 4160000 events read in total (363577ms).
[13:20:26.947] <TB1> INFO: Test took 364917ms.
[13:20:29.511] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:20:35.089] <TB1> INFO: dacScan step from 75 .. 75
[13:20:35.089] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:20:35.089] <TB1> INFO: run 1 of 1
[13:20:35.681] <TB1> INFO: Expecting 208000 events.
[13:20:53.335] <TB1> INFO: 208000 events read in total (17127ms).
[13:20:53.344] <TB1> INFO: Test took 18255ms.
[13:20:53.433] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:20:53.709] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:54.810] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:55.825] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:56.828] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:57.874] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:58.912] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:59.990] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:01.078] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:02.152] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:03.222] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:04.285] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:05.334] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:06.368] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:07.400] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:08.383] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:09.384] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[13:21:10.385] <TB1> INFO: PixTest:: pg_setup set to default.
[13:21:10.387] <TB1> INFO: vcal mean: 39.32 40.20 39.32 42.88 43.32 43.35 44.55 45.32 43.60 43.07 43.56 42.94 41.93 39.70 39.77 39.08
[13:21:10.387] <TB1> INFO: vcal RMS: 1.12 1.40 1.06 1.49 1.32 1.39 1.38 1.58 1.71 1.42 1.63 1.56 1.32 1.68 1.10 1.27
[13:21:10.387] <TB1> INFO: number of X-ray hits detected: 228721 246586 222883 375131 407089 421222 447655 502958 431875 396035 451658 382457 332903 220415 217843 203279
[13:21:10.387] <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:21:10.387] <TB1> INFO: X-ray hit rate [MHz/cm2]: 67.0 72.3 65.3 110.0 119.3 123.5 131.2 147.4 126.6 116.1 132.4 112.1 97.6 64.6 63.9 59.6
[13:21:10.387] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[13:21:10.480] <TB1> INFO: enter test to run
[13:21:10.480] <TB1> INFO: test: no parameter change
[13:21:10.661] <TB1> QUIET: Connection to board 147 closed.
[13:21:10.743] <TB1> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[13:38:08.106] <TB1> INFO: *** Welcome to pxar ***
[13:38:08.106] <TB1> INFO: *** Today: 2016/01/22
[13:38:08.465] <TB1> INFO: *** Version: 9751
[13:38:08.465] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:38:08.465] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[13:38:08.466] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[13:38:08.466] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[13:38:08.534] <TB1> INFO: clk: 4
[13:38:08.534] <TB1> INFO: ctr: 4
[13:38:08.534] <TB1> INFO: sda: 19
[13:38:08.534] <TB1> INFO: tin: 9
[13:38:08.534] <TB1> INFO: level: 15
[13:38:08.534] <TB1> INFO: triggerdelay: 0
[13:38:08.534] <TB1> QUIET: Instanciating API for pxar prod-12
[13:38:08.534] <TB1> INFO: Log level: INFO
[13:38:08.548] <TB1> INFO: Found DTB DTB_WWXTQT
[13:38:08.558] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:38:08.561] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:38:08.563] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:38:10.096] <TB1> INFO: DUT info:
[13:38:10.096] <TB1> INFO: The DUT currently contains the following objects:
[13:38:10.096] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:38:10.097] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:38:10.097] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:38:10.097] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:38:10.097] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.097] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:10.497] <TB1> INFO: enter 'restricted' command line mode
[13:38:10.497] <TB1> INFO: enter test to run
[13:38:10.498] <TB1> INFO: test: HighRate no parameter change
[13:38:10.498] <TB1> INFO: running: highrate
[13:38:10.498] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[13:38:10.626] <TB1> INFO: ----------------------------------------------------------------------
[13:38:10.626] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:38:10.626] <TB1> INFO: ----------------------------------------------------------------------
[13:38:10.764] <TB1> INFO: Expecting 768 events.
[13:38:11.991] <TB1> INFO: 768 events read in total (509ms).
[13:38:12.086] <TB1> INFO: Test took 1455ms.
[13:38:12.700] <TB1> INFO: Expecting 41600 events.
[13:38:16.194] <TB1> INFO: 41600 events read in total (2967ms).
[13:38:16.195] <TB1> INFO: Test took 4106ms.
[13:38:16.274] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:16.914] <TB1> INFO: Expecting 41600 events.
[13:38:20.543] <TB1> INFO: 41600 events read in total (3102ms).
[13:38:20.545] <TB1> INFO: Test took 4242ms.
[13:38:20.626] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:21.268] <TB1> INFO: Expecting 41600 events.
[13:38:25.265] <TB1> INFO: 41600 events read in total (3470ms).
[13:38:25.266] <TB1> INFO: Test took 4610ms.
[13:38:25.348] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:25.990] <TB1> INFO: Expecting 41600 events.
[13:38:29.893] <TB1> INFO: 41600 events read in total (3375ms).
[13:38:29.895] <TB1> INFO: Test took 4516ms.
[13:38:29.975] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:30.618] <TB1> INFO: Expecting 41600 events.
[13:38:34.668] <TB1> INFO: 41600 events read in total (3523ms).
[13:38:34.669] <TB1> INFO: Test took 4662ms.
[13:38:34.751] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:35.403] <TB1> INFO: Expecting 41600 events.
[13:38:39.547] <TB1> INFO: 41600 events read in total (3617ms).
[13:38:39.549] <TB1> INFO: Test took 4767ms.
[13:38:39.647] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:40.307] <TB1> INFO: Expecting 41600 events.
[13:38:44.310] <TB1> INFO: 41600 events read in total (3476ms).
[13:38:44.312] <TB1> INFO: Test took 4617ms.
[13:38:44.398] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:45.040] <TB1> INFO: Expecting 41600 events.
[13:38:49.088] <TB1> INFO: 41600 events read in total (3521ms).
[13:38:49.090] <TB1> INFO: Test took 4661ms.
[13:38:49.185] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:49.850] <TB1> INFO: Expecting 41600 events.
[13:38:53.869] <TB1> INFO: 41600 events read in total (3491ms).
[13:38:53.871] <TB1> INFO: Test took 4653ms.
[13:38:53.954] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:54.596] <TB1> INFO: Expecting 41600 events.
[13:38:58.497] <TB1> INFO: 41600 events read in total (3373ms).
[13:38:58.499] <TB1> INFO: Test took 4514ms.
[13:38:58.581] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:59.224] <TB1> INFO: Expecting 41600 events.
[13:39:03.085] <TB1> INFO: 41600 events read in total (3334ms).
[13:39:03.088] <TB1> INFO: Test took 4476ms.
[13:39:03.180] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:03.829] <TB1> INFO: Expecting 41600 events.
[13:39:07.816] <TB1> INFO: 41600 events read in total (3460ms).
[13:39:07.818] <TB1> INFO: Test took 4600ms.
[13:39:07.914] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:08.581] <TB1> INFO: Expecting 41600 events.
[13:39:12.804] <TB1> INFO: 41600 events read in total (3696ms).
[13:39:12.806] <TB1> INFO: Test took 4847ms.
[13:39:12.908] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:13.597] <TB1> INFO: Expecting 41600 events.
[13:39:17.596] <TB1> INFO: 41600 events read in total (3472ms).
[13:39:17.597] <TB1> INFO: Test took 4640ms.
[13:39:17.683] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:18.326] <TB1> INFO: Expecting 41600 events.
[13:39:22.417] <TB1> INFO: 41600 events read in total (3564ms).
[13:39:22.419] <TB1> INFO: Test took 4704ms.
[13:39:22.499] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:23.142] <TB1> INFO: Expecting 41600 events.
[13:39:27.053] <TB1> INFO: 41600 events read in total (3384ms).
[13:39:27.055] <TB1> INFO: Test took 4525ms.
[13:39:27.135] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:27.776] <TB1> INFO: Expecting 41600 events.
[13:39:31.843] <TB1> INFO: 41600 events read in total (3540ms).
[13:39:31.845] <TB1> INFO: Test took 4680ms.
[13:39:31.939] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:32.588] <TB1> INFO: Expecting 41600 events.
[13:39:36.510] <TB1> INFO: 41600 events read in total (3395ms).
[13:39:36.512] <TB1> INFO: Test took 4535ms.
[13:39:36.595] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:37.237] <TB1> INFO: Expecting 41600 events.
[13:39:41.006] <TB1> INFO: 41600 events read in total (3242ms).
[13:39:41.008] <TB1> INFO: Test took 4382ms.
[13:39:41.091] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:41.735] <TB1> INFO: Expecting 41600 events.
[13:39:45.500] <TB1> INFO: 41600 events read in total (3238ms).
[13:39:45.502] <TB1> INFO: Test took 4380ms.
[13:39:45.584] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:45.915] <TB1> INFO: enter test to run
[13:39:45.915] <TB1> INFO: test: Pretest no parameter change
[13:39:45.915] <TB1> INFO: running: pretest
[13:39:45.915] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[13:39:45.915] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[13:39:45.915] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[13:39:45.915] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[13:39:45.915] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[13:39:45.915] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[13:39:45.915] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[13:39:45.916] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[13:39:45.916] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[13:39:45.916] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[13:39:45.916] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[13:39:45.916] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[13:39:45.916] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[13:39:45.916] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[13:39:45.916] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[13:39:45.917] <TB1> INFO: write dac parameters into /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:39:45.917] <TB1> INFO: enter test to run
[13:39:45.917] <TB1> INFO: test: no parameter change
[13:39:46.107] <TB1> QUIET: Connection to board 147 closed.
[13:39:46.187] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:39:57.269] <TB1> INFO: *** Welcome to pxar ***
[13:39:57.269] <TB1> INFO: *** Today: 2016/01/22
[13:39:57.628] <TB1> INFO: *** Version: 9751
[13:39:57.628] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//dacParameters35_C15.dat
[13:39:57.629] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//tbmParameters_C0b.dat
[13:39:57.629] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//defaultMaskFile.dat
[13:39:57.629] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//trimParameters35_C15.dat
[13:39:57.695] <TB1> INFO: clk: 4
[13:39:57.695] <TB1> INFO: ctr: 4
[13:39:57.695] <TB1> INFO: sda: 19
[13:39:57.695] <TB1> INFO: tin: 9
[13:39:57.695] <TB1> INFO: level: 15
[13:39:57.695] <TB1> INFO: triggerdelay: 0
[13:39:57.695] <TB1> QUIET: Instanciating API for pxar prod-12
[13:39:57.695] <TB1> INFO: Log level: INFO
[13:39:57.708] <TB1> INFO: Found DTB DTB_WWXTQT
[13:39:57.718] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:39:57.721] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:39:57.724] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:39:59.256] <TB1> INFO: DUT info:
[13:39:59.256] <TB1> INFO: The DUT currently contains the following objects:
[13:39:59.256] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:39:59.256] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:39:59.256] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:39:59.257] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:39:59.257] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.257] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:39:59.657] <TB1> INFO: enter 'restricted' command line mode
[13:39:59.657] <TB1> INFO: enter test to run
[13:39:59.657] <TB1> INFO: test: PixelAlive no parameter change
[13:39:59.657] <TB1> INFO: running: pixelalive
[13:39:59.661] <TB1> INFO: ######################################################################
[13:39:59.661] <TB1> INFO: PixTestAlive::doTest()
[13:39:59.661] <TB1> INFO: ######################################################################
[13:39:59.663] <TB1> INFO: ----------------------------------------------------------------------
[13:39:59.663] <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:59.663] <TB1> INFO: ----------------------------------------------------------------------
[13:39:59.960] <TB1> INFO: Expecting 208000 events.
[13:40:10.249] <TB1> INFO: 208000 events read in total (9570ms).
[13:40:10.262] <TB1> INFO: Test took 10598ms.
[13:40:10.268] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:40:10.525] <TB1> INFO: PixTestAlive::aliveTest() done
[13:40:10.525] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:40:10.527] <TB1> INFO: ----------------------------------------------------------------------
[13:40:10.527] <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:40:10.527] <TB1> INFO: ----------------------------------------------------------------------
[13:40:10.868] <TB1> INFO: Expecting 208000 events.
[13:40:17.829] <TB1> INFO: 208000 events read in total (6245ms).
[13:40:17.830] <TB1> INFO: Test took 7302ms.
[13:40:17.830] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:40:17.831] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:40:18.139] <TB1> INFO: PixTestAlive::maskTest() done
[13:40:18.139] <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:40:18.141] <TB1> INFO: ----------------------------------------------------------------------
[13:40:18.141] <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:40:18.141] <TB1> INFO: ----------------------------------------------------------------------
[13:40:18.472] <TB1> INFO: Expecting 208000 events.
[13:40:29.051] <TB1> INFO: 208000 events read in total (9863ms).
[13:40:29.052] <TB1> INFO: Test took 10910ms.
[13:40:29.062] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:40:29.292] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:40:29.292] <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:40:29.292] <TB1> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[13:40:29.336] <TB1> INFO: enter test to run
[13:40:29.336] <TB1> INFO: test: delay setting parameters: ->2<-
[13:40:29.336] <TB1> INFO: delay test by 2 seconds...
[13:40:31.336] <TB1> INFO: enter test to run
[13:40:31.336] <TB1> INFO: test: HighRate no parameter change
[13:40:31.336] <TB1> INFO: running: highrate
[13:40:31.336] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[13:40:31.495] <TB1> INFO: ----------------------------------------------------------------------
[13:40:31.495] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:40:31.495] <TB1> INFO: ----------------------------------------------------------------------
[13:40:32.094] <TB1> INFO: Expecting 208000 events.
[13:40:46.713] <TB1> INFO: 208000 events read in total (14092ms).
[13:40:46.720] <TB1> INFO: Test took 15222ms.
[13:40:47.034] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:40:47.331] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:40:47.331] <TB1> INFO: number of red-efficiency pixels: 161 154 182 301 314 342 412 434 343 309 371 318 247 190 148 153
[13:40:47.331] <TB1> INFO: number of X-ray hits detected: 113447 122871 109664 191030 205834 212534 229514 254695 217662 197867 228833 191241 168149 107963 107348 101418
[13:40:47.331] <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:47.331] <TB1> INFO: number of Vcal hits detected: 207835 207796 207806 207677 207670 207638 207554 207535 207589 207673 207601 207667 207746 207415 207847 207779
[13:40:47.331] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.9 99.8 99.9 99.9 99.8 99.9 99.9
[13:40:47.331] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.7 99.9 99.9
[13:40:47.331] <TB1> INFO: X-ray hit rate [MHz/cm2]: 33.3 36.0 32.1 56.0 60.3 62.3 67.3 74.7 63.8 58.0 67.1 56.1 49.3 31.6 31.5 29.7
[13:40:47.331] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:40:47.361] <TB1> INFO: PixTest:: pg_setup set to default.
[13:40:47.370] <TB1> INFO: enter test to run
[13:40:47.370] <TB1> INFO: test: no parameter change
[13:40:47.577] <TB1> QUIET: Connection to board 147 closed.
[13:40:47.657] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:41:02.874] <TB1> INFO: *** Welcome to pxar ***
[13:41:02.874] <TB1> INFO: *** Today: 2016/01/22
[13:41:03.222] <TB1> INFO: *** Version: 9751
[13:41:03.222] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//dacParameters35_C15.dat
[13:41:03.223] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//tbmParameters_C0b.dat
[13:41:03.223] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//defaultMaskFile.dat
[13:41:03.223] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//trimParameters35_C15.dat
[13:41:03.289] <TB1> INFO: clk: 4
[13:41:03.289] <TB1> INFO: ctr: 4
[13:41:03.289] <TB1> INFO: sda: 19
[13:41:03.289] <TB1> INFO: tin: 9
[13:41:03.289] <TB1> INFO: level: 15
[13:41:03.289] <TB1> INFO: triggerdelay: 0
[13:41:03.289] <TB1> QUIET: Instanciating API for pxar prod-12
[13:41:03.289] <TB1> INFO: Log level: INFO
[13:41:03.303] <TB1> INFO: Found DTB DTB_WWXTQT
[13:41:03.313] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:41:03.316] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:41:03.318] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:41:04.856] <TB1> INFO: DUT info:
[13:41:04.856] <TB1> INFO: The DUT currently contains the following objects:
[13:41:04.856] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:41:04.856] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:41:04.856] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:41:04.856] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:41:04.856] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:04.856] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:05.256] <TB1> INFO: enter 'restricted' command line mode
[13:41:05.256] <TB1> INFO: enter test to run
[13:41:05.257] <TB1> INFO: test: PixelAlive no parameter change
[13:41:05.257] <TB1> INFO: running: pixelalive
[13:41:05.261] <TB1> INFO: ######################################################################
[13:41:05.261] <TB1> INFO: PixTestAlive::doTest()
[13:41:05.261] <TB1> INFO: ######################################################################
[13:41:05.262] <TB1> INFO: ----------------------------------------------------------------------
[13:41:05.262] <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:05.262] <TB1> INFO: ----------------------------------------------------------------------
[13:41:05.563] <TB1> INFO: Expecting 208000 events.
[13:41:15.665] <TB1> INFO: 208000 events read in total (9384ms).
[13:41:15.688] <TB1> INFO: Test took 10424ms.
[13:41:15.696] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:41:15.954] <TB1> INFO: PixTestAlive::aliveTest() done
[13:41:15.954] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:41:15.955] <TB1> INFO: ----------------------------------------------------------------------
[13:41:15.955] <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:15.955] <TB1> INFO: ----------------------------------------------------------------------
[13:41:16.264] <TB1> INFO: Expecting 208000 events.
[13:41:23.358] <TB1> INFO: 208000 events read in total (6379ms).
[13:41:23.358] <TB1> INFO: Test took 7401ms.
[13:41:23.358] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:41:23.359] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:41:23.670] <TB1> INFO: PixTestAlive::maskTest() done
[13:41:23.670] <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:23.672] <TB1> INFO: ----------------------------------------------------------------------
[13:41:23.672] <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:23.672] <TB1> INFO: ----------------------------------------------------------------------
[13:41:24.014] <TB1> INFO: Expecting 208000 events.
[13:41:34.950] <TB1> INFO: 208000 events read in total (10220ms).
[13:41:34.950] <TB1> INFO: Test took 11277ms.
[13:41:34.957] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:41:35.188] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:41:35.188] <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:35.188] <TB1> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[13:41:35.218] <TB1> INFO: enter test to run
[13:41:35.218] <TB1> INFO: test: delay setting parameters: ->2<-
[13:41:35.218] <TB1> INFO: delay test by 2 seconds...
[13:41:37.218] <TB1> INFO: enter test to run
[13:41:37.218] <TB1> INFO: test: HighRate no parameter change
[13:41:37.218] <TB1> INFO: running: highrate
[13:41:37.218] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//phCalibrationFitErr35_C15.dat
[13:41:37.484] <TB1> INFO: ----------------------------------------------------------------------
[13:41:37.484] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:41:37.484] <TB1> INFO: ----------------------------------------------------------------------
[13:41:38.082] <TB1> INFO: Expecting 208000 events.
[13:41:54.517] <TB1> INFO: 208000 events read in total (15907ms).
[13:41:54.531] <TB1> INFO: Test took 17043ms.
[13:41:55.074] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:41:55.423] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:41:55.423] <TB1> INFO: number of red-efficiency pixels: 279 247 363 627 705 702 903 975 720 567 777 606 465 343 253 279
[13:41:55.423] <TB1> INFO: number of X-ray hits detected: 166690 180573 161382 277023 298982 309156 332473 369877 318267 289568 331139 278635 245924 159885 159583 149050
[13:41:55.423] <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:55.423] <TB1> INFO: number of Vcal hits detected: 207712 207697 207580 207303 207183 207165 206923 206827 207136 207347 207064 207303 207486 207247 207737 207630
[13:41:55.423] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.6 99.6 99.5 99.5 99.6 99.7 99.6 99.7 99.8 99.8 99.9 99.9
[13:41:55.423] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.6 99.6 99.5 99.4 99.6 99.7 99.6 99.7 99.8 99.6 99.9 99.8
[13:41:55.423] <TB1> INFO: X-ray hit rate [MHz/cm2]: 48.9 52.9 47.3 81.2 87.6 90.6 97.5 108.4 93.3 84.9 97.1 81.7 72.1 46.9 46.8 43.7
[13:41:55.423] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:41:55.453] <TB1> INFO: PixTest:: pg_setup set to default.
[13:41:55.462] <TB1> INFO: enter test to run
[13:41:55.462] <TB1> INFO: test: no parameter change
[13:41:55.740] <TB1> QUIET: Connection to board 147 closed.
[13:41:55.820] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:42:09.459] <TB1> INFO: *** Welcome to pxar ***
[13:42:09.459] <TB1> INFO: *** Today: 2016/01/22
[13:42:09.805] <TB1> INFO: *** Version: 9751
[13:42:09.805] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//dacParameters35_C15.dat
[13:42:09.806] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//tbmParameters_C0b.dat
[13:42:09.806] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//defaultMaskFile.dat
[13:42:09.806] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//trimParameters35_C15.dat
[13:42:09.877] <TB1> INFO: clk: 4
[13:42:09.877] <TB1> INFO: ctr: 4
[13:42:09.877] <TB1> INFO: sda: 19
[13:42:09.877] <TB1> INFO: tin: 9
[13:42:09.877] <TB1> INFO: level: 15
[13:42:09.877] <TB1> INFO: triggerdelay: 0
[13:42:09.877] <TB1> QUIET: Instanciating API for pxar prod-12
[13:42:09.877] <TB1> INFO: Log level: INFO
[13:42:09.890] <TB1> INFO: Found DTB DTB_WWXTQT
[13:42:09.900] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:42:09.903] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:42:09.905] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:42:11.439] <TB1> INFO: DUT info:
[13:42:11.439] <TB1> INFO: The DUT currently contains the following objects:
[13:42:11.439] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:42:11.439] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:42:11.439] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:42:11.439] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:42:11.439] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.439] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:11.840] <TB1> INFO: enter 'restricted' command line mode
[13:42:11.840] <TB1> INFO: enter test to run
[13:42:11.840] <TB1> INFO: test: PixelAlive no parameter change
[13:42:11.840] <TB1> INFO: running: pixelalive
[13:42:11.844] <TB1> INFO: ######################################################################
[13:42:11.844] <TB1> INFO: PixTestAlive::doTest()
[13:42:11.844] <TB1> INFO: ######################################################################
[13:42:11.845] <TB1> INFO: ----------------------------------------------------------------------
[13:42:11.845] <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:42:11.845] <TB1> INFO: ----------------------------------------------------------------------
[13:42:12.143] <TB1> INFO: Expecting 208000 events.
[13:42:23.076] <TB1> INFO: 208000 events read in total (10214ms).
[13:42:23.078] <TB1> INFO: Test took 11231ms.
[13:42:23.086] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:42:23.338] <TB1> INFO: PixTestAlive::aliveTest() done
[13:42:23.338] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0 1
[13:42:23.339] <TB1> INFO: ----------------------------------------------------------------------
[13:42:23.339] <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:42:23.339] <TB1> INFO: ----------------------------------------------------------------------
[13:42:23.698] <TB1> INFO: Expecting 208000 events.
[13:42:30.957] <TB1> INFO: 208000 events read in total (6543ms).
[13:42:30.957] <TB1> INFO: Test took 7616ms.
[13:42:30.957] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:42:30.957] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:42:31.263] <TB1> INFO: PixTestAlive::maskTest() done
[13:42:31.263] <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:42:31.265] <TB1> INFO: ----------------------------------------------------------------------
[13:42:31.265] <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:42:31.265] <TB1> INFO: ----------------------------------------------------------------------
[13:42:31.611] <TB1> INFO: Expecting 208000 events.
[13:42:42.233] <TB1> INFO: 208000 events read in total (9906ms).
[13:42:42.233] <TB1> INFO: Test took 10967ms.
[13:42:42.243] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:42:42.474] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:42:42.474] <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:42:42.474] <TB1> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[13:42:42.520] <TB1> INFO: enter test to run
[13:42:42.520] <TB1> INFO: test: delay setting parameters: ->2<-
[13:42:42.520] <TB1> INFO: delay test by 2 seconds...
[13:42:44.520] <TB1> INFO: enter test to run
[13:42:44.521] <TB1> INFO: test: HighRate no parameter change
[13:42:44.521] <TB1> INFO: running: highrate
[13:42:44.521] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//phCalibrationFitErr35_C15.dat
[13:42:44.653] <TB1> INFO: ----------------------------------------------------------------------
[13:42:44.653] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:42:44.653] <TB1> INFO: ----------------------------------------------------------------------
[13:42:45.254] <TB1> INFO: Expecting 208000 events.
[13:43:04.991] <TB1> INFO: 208000 events read in total (19210ms).
[13:43:04.999] <TB1> INFO: Test took 20342ms.
[13:43:05.686] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:43:06.134] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:43:06.134] <TB1> INFO: number of red-efficiency pixels: 516 439 606 1141 1343 1298 1555 1953 1413 1153 1480 1086 886 591 475 461
[13:43:06.134] <TB1> INFO: number of X-ray hits detected: 227829 247312 224585 377910 408599 419952 449697 501606 432749 396675 449740 380608 336538 221322 218497 204471
[13:43:06.134] <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:43:06.134] <TB1> INFO: number of Vcal hits detected: 207438 207485 207158 206535 206146 206267 205740 205163 206093 206522 205919 206599 206956 206895 207495 207420
[13:43:06.134] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.4 99.2 99.2 99.0 98.8 99.2 99.4 99.1 99.4 99.6 99.6 99.8 99.8
[13:43:06.134] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.8 99.6 99.3 99.1 99.2 98.9 98.6 99.1 99.3 99.0 99.3 99.5 99.5 99.8 99.7
[13:43:06.134] <TB1> INFO: X-ray hit rate [MHz/cm2]: 66.8 72.5 65.8 110.8 119.8 123.1 131.8 147.0 126.8 116.3 131.8 111.6 98.6 64.9 64.0 59.9
[13:43:06.134] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:43:06.164] <TB1> INFO: PixTest:: pg_setup set to default.
[13:43:06.175] <TB1> INFO: enter test to run
[13:43:06.175] <TB1> INFO: test: no parameter change
[13:43:06.418] <TB1> QUIET: Connection to board 147 closed.
[13:43:06.497] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:43:21.351] <TB1> INFO: *** Welcome to pxar ***
[13:43:21.351] <TB1> INFO: *** Today: 2016/01/22
[13:43:21.703] <TB1> INFO: *** Version: 9751
[13:43:21.703] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//dacParameters35_C15.dat
[13:43:21.703] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//tbmParameters_C0b.dat
[13:43:21.703] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//defaultMaskFile.dat
[13:43:21.703] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//trimParameters35_C15.dat
[13:43:21.773] <TB1> INFO: clk: 4
[13:43:21.773] <TB1> INFO: ctr: 4
[13:43:21.773] <TB1> INFO: sda: 19
[13:43:21.773] <TB1> INFO: tin: 9
[13:43:21.773] <TB1> INFO: level: 15
[13:43:21.773] <TB1> INFO: triggerdelay: 0
[13:43:21.773] <TB1> QUIET: Instanciating API for pxar prod-12
[13:43:21.773] <TB1> INFO: Log level: INFO
[13:43:21.786] <TB1> INFO: Found DTB DTB_WWXTQT
[13:43:21.796] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:43:21.799] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:43:21.801] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:43:23.338] <TB1> INFO: DUT info:
[13:43:23.338] <TB1> INFO: The DUT currently contains the following objects:
[13:43:23.338] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:43:23.338] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:43:23.338] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:43:23.338] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:43:23.338] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.338] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:23.739] <TB1> INFO: enter 'restricted' command line mode
[13:43:23.739] <TB1> INFO: enter test to run
[13:43:23.739] <TB1> INFO: test: PixelAlive no parameter change
[13:43:23.739] <TB1> INFO: running: pixelalive
[13:43:23.743] <TB1> INFO: ######################################################################
[13:43:23.743] <TB1> INFO: PixTestAlive::doTest()
[13:43:23.743] <TB1> INFO: ######################################################################
[13:43:23.745] <TB1> INFO: ----------------------------------------------------------------------
[13:43:23.745] <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:43:23.745] <TB1> INFO: ----------------------------------------------------------------------
[13:43:24.046] <TB1> INFO: Expecting 208000 events.
[13:43:34.289] <TB1> INFO: 208000 events read in total (9525ms).
[13:43:34.311] <TB1> INFO: Test took 10565ms.
[13:43:34.320] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:43:34.572] <TB1> INFO: PixTestAlive::aliveTest() done
[13:43:34.572] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:43:34.574] <TB1> INFO: ----------------------------------------------------------------------
[13:43:34.574] <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:43:34.574] <TB1> INFO: ----------------------------------------------------------------------
[13:43:34.897] <TB1> INFO: Expecting 208000 events.
[13:43:41.666] <TB1> INFO: 208000 events read in total (6053ms).
[13:43:41.666] <TB1> INFO: Test took 7091ms.
[13:43:41.666] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:43:41.667] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:43:41.977] <TB1> INFO: PixTestAlive::maskTest() done
[13:43:41.977] <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:43:41.978] <TB1> INFO: ----------------------------------------------------------------------
[13:43:41.978] <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:43:41.978] <TB1> INFO: ----------------------------------------------------------------------
[13:43:42.294] <TB1> INFO: Expecting 208000 events.
[13:43:52.905] <TB1> INFO: 208000 events read in total (9895ms).
[13:43:52.906] <TB1> INFO: Test took 10926ms.
[13:43:52.912] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:43:53.144] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:43:53.144] <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:43:53.144] <TB1> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[13:43:53.183] <TB1> INFO: enter test to run
[13:43:53.183] <TB1> INFO: test: delay setting parameters: ->2<-
[13:43:53.183] <TB1> INFO: delay test by 2 seconds...
[13:43:55.183] <TB1> INFO: enter test to run
[13:43:55.183] <TB1> INFO: test: HighRate no parameter change
[13:43:55.183] <TB1> INFO: running: highrate
[13:43:55.184] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//phCalibrationFitErr35_C15.dat
[13:43:55.318] <TB1> INFO: ----------------------------------------------------------------------
[13:43:55.318] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:43:55.318] <TB1> INFO: ----------------------------------------------------------------------
[13:43:55.916] <TB1> INFO: Expecting 208000 events.
[13:44:16.817] <TB1> INFO: 208000 events read in total (20374ms).
[13:44:16.830] <TB1> INFO: Test took 21509ms.
[13:44:17.578] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:44:18.008] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:44:18.008] <TB1> INFO: number of red-efficiency pixels: 725 631 820 1701 1877 1890 2205 2700 2058 1754 2063 1569 1249 789 692 641
[13:44:18.008] <TB1> INFO: number of X-ray hits detected: 276881 301156 272397 456435 493374 509240 544061 606442 522247 479511 543701 459563 404104 268296 265674 249324
[13:44:18.008] <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:44:18.008] <TB1> INFO: number of Vcal hits detected: 207155 207254 206657 205514 204915 205104 204207 202953 204824 205446 204532 205677 206392 206426 207218 207214
[13:44:18.008] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.7 99.5 98.9 98.7 98.7 98.4 97.8 98.6 98.9 98.5 99.0 99.3 99.4 99.7 99.7
[13:44:18.008] <TB1> INFO: Vcal hit overall efficiency (%): 99.6 99.6 99.4 98.8 98.5 98.6 98.2 97.6 98.5 98.8 98.3 98.9 99.2 99.2 99.6 99.6
[13:44:18.008] <TB1> INFO: X-ray hit rate [MHz/cm2]: 81.2 88.3 79.8 133.8 144.6 149.3 159.5 177.8 153.1 140.5 159.4 134.7 118.4 78.6 77.9 73.1
[13:44:18.008] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:44:18.038] <TB1> INFO: PixTest:: pg_setup set to default.
[13:44:18.049] <TB1> INFO: enter test to run
[13:44:18.049] <TB1> INFO: test: no parameter change
[13:44:18.278] <TB1> QUIET: Connection to board 147 closed.
[13:44:18.358] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:44:33.259] <TB1> INFO: *** Welcome to pxar ***
[13:44:33.259] <TB1> INFO: *** Today: 2016/01/22
[13:44:33.612] <TB1> INFO: *** Version: 9751
[13:44:33.612] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//dacParameters35_C15.dat
[13:44:33.612] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//tbmParameters_C0b.dat
[13:44:33.613] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//defaultMaskFile.dat
[13:44:33.613] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//trimParameters35_C15.dat
[13:44:33.683] <TB1> INFO: clk: 4
[13:44:33.683] <TB1> INFO: ctr: 4
[13:44:33.683] <TB1> INFO: sda: 19
[13:44:33.683] <TB1> INFO: tin: 9
[13:44:33.683] <TB1> INFO: level: 15
[13:44:33.683] <TB1> INFO: triggerdelay: 0
[13:44:33.683] <TB1> QUIET: Instanciating API for pxar prod-12
[13:44:33.683] <TB1> INFO: Log level: INFO
[13:44:33.695] <TB1> INFO: Found DTB DTB_WWXTQT
[13:44:33.705] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:44:33.708] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:44:33.711] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:44:35.244] <TB1> INFO: DUT info:
[13:44:35.244] <TB1> INFO: The DUT currently contains the following objects:
[13:44:35.244] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:44:35.244] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:44:35.244] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:44:35.244] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:44:35.244] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.244] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:35.645] <TB1> INFO: enter 'restricted' command line mode
[13:44:35.645] <TB1> INFO: enter test to run
[13:44:35.645] <TB1> INFO: test: PixelAlive no parameter change
[13:44:35.645] <TB1> INFO: running: pixelalive
[13:44:35.650] <TB1> INFO: ######################################################################
[13:44:35.650] <TB1> INFO: PixTestAlive::doTest()
[13:44:35.650] <TB1> INFO: ######################################################################
[13:44:35.651] <TB1> INFO: ----------------------------------------------------------------------
[13:44:35.651] <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:44:35.651] <TB1> INFO: ----------------------------------------------------------------------
[13:44:35.953] <TB1> INFO: Expecting 208000 events.
[13:44:45.986] <TB1> INFO: 208000 events read in total (9314ms).
[13:44:46.012] <TB1> INFO: Test took 10359ms.
[13:44:46.021] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:44:46.271] <TB1> INFO: PixTestAlive::aliveTest() done
[13:44:46.272] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:44:46.273] <TB1> INFO: ----------------------------------------------------------------------
[13:44:46.273] <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:44:46.273] <TB1> INFO: ----------------------------------------------------------------------
[13:44:46.575] <TB1> INFO: Expecting 208000 events.
[13:44:53.489] <TB1> INFO: 208000 events read in total (6198ms).
[13:44:53.491] <TB1> INFO: Test took 7217ms.
[13:44:53.499] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:44:53.500] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:44:53.809] <TB1> INFO: PixTestAlive::maskTest() done
[13:44:53.810] <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:44:53.812] <TB1> INFO: ----------------------------------------------------------------------
[13:44:53.812] <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:44:53.812] <TB1> INFO: ----------------------------------------------------------------------
[13:44:54.116] <TB1> INFO: Expecting 208000 events.
[13:45:04.689] <TB1> INFO: 208000 events read in total (9857ms).
[13:45:04.690] <TB1> INFO: Test took 10877ms.
[13:45:04.698] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:45:04.929] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:45:04.929] <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:45:04.929] <TB1> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[13:45:04.969] <TB1> INFO: enter test to run
[13:45:04.969] <TB1> INFO: test: delay setting parameters: ->2<-
[13:45:04.969] <TB1> INFO: delay test by 2 seconds...
[13:45:06.969] <TB1> INFO: enter test to run
[13:45:06.969] <TB1> INFO: test: HighRate no parameter change
[13:45:06.969] <TB1> INFO: running: highrate
[13:45:06.969] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//phCalibrationFitErr35_C15.dat
[13:45:07.153] <TB1> INFO: ----------------------------------------------------------------------
[13:45:07.153] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:45:07.153] <TB1> INFO: ----------------------------------------------------------------------
[13:45:07.777] <TB1> INFO: Expecting 208000 events.
[13:45:31.541] <TB1> INFO: 208000 events read in total (23237ms).
[13:45:31.560] <TB1> INFO: Test took 24403ms.
[13:45:32.447] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:45:32.962] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:45:32.962] <TB1> INFO: number of red-efficiency pixels: 1119 944 1139 2253 2509 2549 2916 3408 2709 2318 2814 2164 1760 1056 979 920
[13:45:32.962] <TB1> INFO: number of X-ray hits detected: 329778 358247 325354 538140 583568 601020 641279 719222 620618 568379 641065 543920 484441 321039 317677 296469
[13:45:32.962] <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:45:32.962] <TB1> INFO: number of Vcal hits detected: 206600 206833 205826 203998 203115 203061 201646 199706 202821 203864 202083 204284 205401 205745 206831 206813
[13:45:32.962] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.4 99.5 99.2 98.3 98.0 97.9 97.3 96.4 97.8 98.2 97.5 98.4 98.9 99.2 99.5 99.5
[13:45:32.962] <TB1> INFO: Vcal hit overall efficiency (%): 99.3 99.4 99.0 98.1 97.7 97.6 96.9 96.0 97.5 98.0 97.2 98.2 98.8 98.9 99.4 99.4
[13:45:32.962] <TB1> INFO: X-ray hit rate [MHz/cm2]: 96.7 105.0 95.4 157.7 171.0 176.2 188.0 210.8 181.9 166.6 187.9 159.4 142.0 94.1 93.1 86.9
[13:45:32.962] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:45:32.992] <TB1> INFO: PixTest:: pg_setup set to default.
[13:45:33.004] <TB1> INFO: enter test to run
[13:45:33.004] <TB1> INFO: test: no parameter change
[13:45:33.191] <TB1> QUIET: Connection to board 147 closed.
[13:45:33.271] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:45:50.868] <TB1> INFO: *** Welcome to pxar ***
[13:45:50.868] <TB1> INFO: *** Today: 2016/01/22
[13:45:51.225] <TB1> INFO: *** Version: 9751
[13:45:51.225] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//dacParameters35_C15.dat
[13:45:51.226] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//tbmParameters_C0b.dat
[13:45:51.226] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//defaultMaskFile.dat
[13:45:51.226] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//trimParameters35_C15.dat
[13:45:51.295] <TB1> INFO: clk: 4
[13:45:51.295] <TB1> INFO: ctr: 4
[13:45:51.295] <TB1> INFO: sda: 19
[13:45:51.295] <TB1> INFO: tin: 9
[13:45:51.295] <TB1> INFO: level: 15
[13:45:51.295] <TB1> INFO: triggerdelay: 0
[13:45:51.295] <TB1> QUIET: Instanciating API for pxar prod-12
[13:45:51.295] <TB1> INFO: Log level: INFO
[13:45:51.307] <TB1> INFO: Found DTB DTB_WWXTQT
[13:45:51.318] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:45:51.321] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:45:51.323] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:45:52.857] <TB1> INFO: DUT info:
[13:45:52.857] <TB1> INFO: The DUT currently contains the following objects:
[13:45:52.857] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:45:52.857] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:45:52.857] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:45:52.857] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:45:52.857] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:52.857] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:53.258] <TB1> INFO: enter 'restricted' command line mode
[13:45:53.258] <TB1> INFO: enter test to run
[13:45:53.258] <TB1> INFO: test: PixelAlive no parameter change
[13:45:53.258] <TB1> INFO: running: pixelalive
[13:45:53.262] <TB1> INFO: ######################################################################
[13:45:53.262] <TB1> INFO: PixTestAlive::doTest()
[13:45:53.262] <TB1> INFO: ######################################################################
[13:45:53.263] <TB1> INFO: ----------------------------------------------------------------------
[13:45:53.264] <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:45:53.264] <TB1> INFO: ----------------------------------------------------------------------
[13:45:53.560] <TB1> INFO: Expecting 208000 events.
[13:46:03.836] <TB1> INFO: 208000 events read in total (9558ms).
[13:46:03.844] <TB1> INFO: Test took 10579ms.
[13:46:03.850] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:46:04.112] <TB1> INFO: PixTestAlive::aliveTest() done
[13:46:04.112] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:46:04.114] <TB1> INFO: ----------------------------------------------------------------------
[13:46:04.114] <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:46:04.114] <TB1> INFO: ----------------------------------------------------------------------
[13:46:04.441] <TB1> INFO: Expecting 208000 events.
[13:46:11.968] <TB1> INFO: 208000 events read in total (6811ms).
[13:46:11.968] <TB1> INFO: Test took 7852ms.
[13:46:11.968] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:46:11.969] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:46:12.279] <TB1> INFO: PixTestAlive::maskTest() done
[13:46:12.279] <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:46:12.281] <TB1> INFO: ----------------------------------------------------------------------
[13:46:12.281] <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:46:12.281] <TB1> INFO: ----------------------------------------------------------------------
[13:46:12.632] <TB1> INFO: Expecting 208000 events.
[13:46:23.699] <TB1> INFO: 208000 events read in total (10351ms).
[13:46:23.699] <TB1> INFO: Test took 11417ms.
[13:46:23.705] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:46:23.937] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:46:23.937] <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:46:23.938] <TB1> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[13:46:23.970] <TB1> INFO: enter test to run
[13:46:23.970] <TB1> INFO: test: delay setting parameters: ->2<-
[13:46:23.970] <TB1> INFO: delay test by 2 seconds...
[13:46:25.970] <TB1> INFO: enter test to run
[13:46:25.970] <TB1> INFO: test: HighRate no parameter change
[13:46:25.970] <TB1> INFO: running: highrate
[13:46:25.970] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//phCalibrationFitErr35_C15.dat
[13:46:26.170] <TB1> INFO: ----------------------------------------------------------------------
[13:46:26.170] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:46:26.170] <TB1> INFO: ----------------------------------------------------------------------
[13:46:26.776] <TB1> INFO: Expecting 208000 events.
[13:46:56.530] <TB1> INFO: 208000 events read in total (29227ms).
[13:46:56.552] <TB1> INFO: Test took 30378ms.
[13:46:57.779] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:46:58.334] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:46:58.334] <TB1> INFO: number of red-efficiency pixels: 2020 1744 1789 3415 3612 3692 3846 4098 3834 3485 3871 3325 2955 1636 1813 1738
[13:46:58.334] <TB1> INFO: number of X-ray hits detected: 446244 486594 441839 720694 781560 808721 855932 961002 830031 760603 855852 729555 650803 435108 430090 402716
[13:46:58.334] <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:46:58.334] <TB1> INFO: number of Vcal hits detected: 204838 205502 202894 198598 196193 195902 193078 187589 195156 197911 193570 198995 201660 203363 205401 205423
[13:46:58.334] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.6 98.9 98.0 96.0 95.0 94.8 93.6 90.9 94.4 95.7 93.8 96.1 97.3 98.3 98.9 98.9
[13:46:58.334] <TB1> INFO: Vcal hit overall efficiency (%): 98.5 98.8 97.5 95.5 94.3 94.2 92.8 90.2 93.8 95.1 93.1 95.7 97.0 97.8 98.8 98.8
[13:46:58.334] <TB1> INFO: X-ray hit rate [MHz/cm2]: 130.8 142.6 129.5 211.2 229.1 237.0 250.9 281.7 243.3 222.9 250.9 213.8 190.8 127.5 126.1 118.0
[13:46:58.334] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:46:58.364] <TB1> INFO: PixTest:: pg_setup set to default.
[13:46:58.376] <TB1> INFO: enter test to run
[13:46:58.376] <TB1> INFO: test: no parameter change
[13:46:58.616] <TB1> QUIET: Connection to board 147 closed.
[13:46:58.696] <TB1> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[13:47:09.685] <TB1> INFO: *** Welcome to pxar ***
[13:47:09.685] <TB1> INFO: *** Today: 2016/01/22
[13:47:10.036] <TB1> INFO: *** Version: 9751
[13:47:10.036] <TB1> INFO: readRocDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//dacParameters35_C15.dat
[13:47:10.037] <TB1> INFO: readTbmDacs: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//tbmParameters_C0b.dat
[13:47:10.037] <TB1> INFO: readMaskFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//defaultMaskFile.dat
[13:47:10.037] <TB1> INFO: readTrimFile: /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//trimParameters35_C15.dat
[13:47:10.104] <TB1> INFO: clk: 4
[13:47:10.104] <TB1> INFO: ctr: 4
[13:47:10.104] <TB1> INFO: sda: 19
[13:47:10.104] <TB1> INFO: tin: 9
[13:47:10.105] <TB1> INFO: level: 15
[13:47:10.105] <TB1> INFO: triggerdelay: 0
[13:47:10.105] <TB1> QUIET: Instanciating API for pxar prod-12
[13:47:10.105] <TB1> INFO: Log level: INFO
[13:47:10.118] <TB1> INFO: Found DTB DTB_WWXTQT
[13:47:10.128] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[13:47:10.131] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[13:47:10.134] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[13:47:11.668] <TB1> INFO: DUT info:
[13:47:11.668] <TB1> INFO: The DUT currently contains the following objects:
[13:47:11.668] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:47:11.668] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:47:11.668] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:47:11.668] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:47:11.668] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:11.668] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:12.069] <TB1> INFO: enter 'restricted' command line mode
[13:47:12.069] <TB1> INFO: enter test to run
[13:47:12.069] <TB1> INFO: test: PixelAlive no parameter change
[13:47:12.069] <TB1> INFO: running: pixelalive
[13:47:12.073] <TB1> INFO: ######################################################################
[13:47:12.073] <TB1> INFO: PixTestAlive::doTest()
[13:47:12.073] <TB1> INFO: ######################################################################
[13:47:12.074] <TB1> INFO: ----------------------------------------------------------------------
[13:47:12.074] <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:47:12.074] <TB1> INFO: ----------------------------------------------------------------------
[13:47:12.375] <TB1> INFO: Expecting 208000 events.
[13:47:22.718] <TB1> INFO: 208000 events read in total (9625ms).
[13:47:22.735] <TB1> INFO: Test took 10659ms.
[13:47:22.744] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:22.986] <TB1> INFO: PixTestAlive::aliveTest() done
[13:47:22.986] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:47:22.987] <TB1> INFO: ----------------------------------------------------------------------
[13:47:22.987] <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:47:22.987] <TB1> INFO: ----------------------------------------------------------------------
[13:47:23.293] <TB1> INFO: Expecting 208000 events.
[13:47:30.347] <TB1> INFO: 208000 events read in total (6339ms).
[13:47:30.347] <TB1> INFO: Test took 7359ms.
[13:47:30.347] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:30.348] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:47:30.657] <TB1> INFO: PixTestAlive::maskTest() done
[13:47:30.657] <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:47:30.659] <TB1> INFO: ----------------------------------------------------------------------
[13:47:30.659] <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:47:30.659] <TB1> INFO: ----------------------------------------------------------------------
[13:47:30.966] <TB1> INFO: Expecting 208000 events.
[13:47:41.353] <TB1> INFO: 208000 events read in total (9672ms).
[13:47:41.354] <TB1> INFO: Test took 10694ms.
[13:47:41.363] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:41.593] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:47:41.593] <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:47:41.593] <TB1> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[13:47:41.633] <TB1> INFO: enter test to run
[13:47:41.633] <TB1> INFO: test: delay setting parameters: ->2<-
[13:47:41.633] <TB1> INFO: delay test by 2 seconds...
[13:47:43.633] <TB1> INFO: enter test to run
[13:47:43.633] <TB1> INFO: test: HighRate no parameter change
[13:47:43.633] <TB1> INFO: running: highrate
[13:47:43.633] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2116_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//phCalibrationFitErr35_C15.dat
[13:47:43.867] <TB1> INFO: ----------------------------------------------------------------------
[13:47:43.867] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:47:43.867] <TB1> INFO: ----------------------------------------------------------------------
[13:47:44.471] <TB1> INFO: Expecting 208000 events.
[13:48:16.495] <TB1> INFO: 184400 events read in total (31497ms).
[13:48:21.052] <TB1> INFO: 208000 events read in total (36054ms).
[13:48:21.072] <TB1> INFO: Test took 37202ms.
[13:48:22.416] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:23.047] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 1 0 0 0 0 0 0 1
[13:48:23.047] <TB1> INFO: number of red-efficiency pixels: 2877 2612 2326 3939 4048 4090 4116 4159 4112 4020 4133 3934 3720 2071 2651 2452
[13:48:23.047] <TB1> INFO: number of X-ray hits detected: 551094 602674 546060 883265 956876 993077 1047236 1180472 1022585 937876 1052933 895620 800748 535301 527065 496652
[13:48:23.047] <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:48:23.047] <TB1> INFO: number of Vcal hits detected: 202263 203411 199048 190192 186910 185800 181262 171313 183956 188808 180916 191196 196145 200100 203245 203557
[13:48:23.047] <TB1> INFO: Vcal hit fiducial efficiency (%): 97.5 98.0 96.5 92.2 90.9 90.3 88.3 83.4 89.3 91.7 88.0 92.7 94.9 96.9 97.9 98.1
[13:48:23.047] <TB1> INFO: Vcal hit overall efficiency (%): 97.2 97.8 95.7 91.4 89.9 89.3 87.1 82.4 88.4 90.8 87.0 91.9 94.3 96.2 97.7 97.9
[13:48:23.047] <TB1> INFO: X-ray hit rate [MHz/cm2]: 161.5 176.6 160.1 258.9 280.5 291.1 307.0 346.0 299.7 274.9 308.6 262.5 234.7 156.9 154.5 145.6
[13:48:23.047] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[13:48:23.076] <TB1> INFO: PixTest:: pg_setup set to default.
[13:48:23.090] <TB1> INFO: enter test to run
[13:48:23.090] <TB1> INFO: test: no parameter change
[13:48:23.286] <TB1> QUIET: Connection to board 147 closed.
[13:48:23.366] <TB1> INFO: pXar: this is the end, my friend