[12:54:08.885] <TB2> INFO: *** Welcome to pxar ***
[12:54:08.885] <TB2> INFO: *** Today: 2016/01/22
[12:54:08.949] <TB2> INFO: *** Version: 9751
[12:54:08.949] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//dacParameters35_C15.dat
[12:54:08.949] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//tbmParameters_C0b.dat
[12:54:08.950] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//defaultMaskFile.dat
[12:54:08.950] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//000_PixelAlive_p17//trimParameters35_C15.dat
[12:54:09.024] <TB2> INFO: clk: 4
[12:54:09.024] <TB2> INFO: ctr: 4
[12:54:09.024] <TB2> INFO: sda: 19
[12:54:09.024] <TB2> INFO: tin: 9
[12:54:09.024] <TB2> INFO: level: 15
[12:54:09.024] <TB2> INFO: triggerdelay: 0
[12:54:09.024] <TB2> QUIET: Instanciating API for pxar prod-12
[12:54:09.024] <TB2> INFO: Log level: INFO
[12:54:09.036] <TB2> INFO: Found DTB DTB_WXENWR
[12:54:09.045] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[12:54:09.048] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[12:54:09.051] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[12:54:10.596] <TB2> INFO: DUT info:
[12:54:10.596] <TB2> INFO: The DUT currently contains the following objects:
[12:54:10.596] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[12:54:10.596] <TB2> INFO: TBM Core alpha (0): 7 registers set
[12:54:10.596] <TB2> INFO: TBM Core beta (1): 7 registers set
[12:54:10.596] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:54:10.596] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.596] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.596] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.596] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.596] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.596] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.596] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.597] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:54:10.998] <TB2> INFO: enter 'restricted' command line mode
[12:54:10.998] <TB2> INFO: enter test to run
[12:54:10.998] <TB2> INFO: test: PixelAlive no parameter change
[12:54:10.999] <TB2> INFO: running: pixelalive
[12:54:11.004] <TB2> INFO: ######################################################################
[12:54:11.004] <TB2> INFO: PixTestAlive::doTest()
[12:54:11.004] <TB2> INFO: ######################################################################
[12:54:11.006] <TB2> INFO: ----------------------------------------------------------------------
[12:54:11.006] <TB2> 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:11.006] <TB2> INFO: ----------------------------------------------------------------------
[12:54:11.317] <TB2> INFO: Expecting 41600 events.
[12:54:15.634] <TB2> INFO: 41600 events read in total (3596ms).
[12:54:15.714] <TB2> INFO: Test took 4706ms.
[12:54:15.720] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:15.986] <TB2> INFO: PixTestAlive::aliveTest() done
[12:54:15.986] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 2 0 0 0
[12:54:15.988] <TB2> INFO: ----------------------------------------------------------------------
[12:54:15.988] <TB2> 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:15.988] <TB2> INFO: ----------------------------------------------------------------------
[12:54:16.294] <TB2> INFO: Expecting 41600 events.
[12:54:19.376] <TB2> INFO: 41600 events read in total (2365ms).
[12:54:19.376] <TB2> INFO: Test took 3386ms.
[12:54:19.376] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:19.376] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:54:19.704] <TB2> INFO: PixTestAlive::maskTest() done
[12:54:19.704] <TB2> 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:19.706] <TB2> INFO: ----------------------------------------------------------------------
[12:54:19.706] <TB2> 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:19.706] <TB2> INFO: ----------------------------------------------------------------------
[12:54:20.007] <TB2> INFO: Expecting 41600 events.
[12:54:24.163] <TB2> INFO: 41600 events read in total (3439ms).
[12:54:24.164] <TB2> INFO: Test took 4456ms.
[12:54:24.170] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:54:24.477] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[12:54:24.477] <TB2> 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:24.477] <TB2> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[12:54:24.508] <TB2> INFO: enter test to run
[12:54:24.508] <TB2> INFO: test: no parameter change
[12:54:24.677] <TB2> QUIET: Connection to board 162 closed.
[12:54:24.756] <TB2> INFO: pXar: this is the end, my friend

[12:58:55.934] <TB2> INFO: *** Welcome to pxar ***
[12:58:55.934] <TB2> INFO: *** Today: 2016/01/22
[12:58:56.002] <TB2> INFO: *** Version: 9751
[12:58:56.002] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//dacParameters35_C15.dat
[12:58:56.002] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[12:58:56.003] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//defaultMaskFile.dat
[12:58:56.003] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C15.dat
[12:58:56.083] <TB2> INFO: clk: 4
[12:58:56.083] <TB2> INFO: ctr: 4
[12:58:56.083] <TB2> INFO: sda: 19
[12:58:56.083] <TB2> INFO: tin: 9
[12:58:56.083] <TB2> INFO: level: 15
[12:58:56.083] <TB2> INFO: triggerdelay: 0
[12:58:56.083] <TB2> QUIET: Instanciating API for pxar prod-12
[12:58:56.083] <TB2> INFO: Log level: INFO
[12:58:56.096] <TB2> INFO: Found DTB DTB_WXENWR
[12:58:56.104] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[12:58:56.108] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[12:58:56.110] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[12:58:57.654] <TB2> INFO: DUT info:
[12:58:57.654] <TB2> INFO: The DUT currently contains the following objects:
[12:58:57.654] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[12:58:57.654] <TB2> INFO: TBM Core alpha (0): 7 registers set
[12:58:57.654] <TB2> INFO: TBM Core beta (1): 7 registers set
[12:58:57.654] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:58:57.654] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.654] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.654] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.654] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.654] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.654] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:57.655] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:58:58.056] <TB2> INFO: enter 'restricted' command line mode
[12:58:58.056] <TB2> INFO: enter test to run
[12:58:58.056] <TB2> INFO: test: delay setting parameters: ->5<-
[12:58:58.056] <TB2> INFO: delay test by 5 seconds...
[12:59:03.057] <TB2> INFO: enter test to run
[12:59:03.057] <TB2> INFO: test: highrate no parameter change
[12:59:03.057] <TB2> INFO: running: highrate
[12:59:03.057] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[12:59:03.353] <TB2> INFO: ----------------------------------------------------------------------
[12:59:03.353] <TB2> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:59:03.353] <TB2> INFO: ----------------------------------------------------------------------
[12:59:03.353] <TB2> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:59:03.353] <TB2> INFO: edge/corner pixel THR is adjusted
[12:59:03.353] <TB2> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:59:04.318] <TB2> INFO: Collecting data for 1 seconds...
[12:59:05.319] <TB2> INFO: Done with hot pixel readout
[12:59:11.517] <TB2> INFO: PixTest:: pg_setup set to default.
[12:59:11.518] <TB2> INFO: 4 hot pixels found in step 0
[12:59:12.484] <TB2> INFO: Collecting data for 1 seconds...
[12:59:13.485] <TB2> INFO: Done with hot pixel readout
[12:59:20.396] <TB2> INFO: PixTest:: pg_setup set to default.
[12:59:20.397] <TB2> INFO: 3 hot pixels found in step 1
[12:59:21.364] <TB2> INFO: Collecting data for 1 seconds...
[12:59:22.366] <TB2> INFO: Done with hot pixel readout
[12:59:28.358] <TB2> INFO: PixTest:: pg_setup set to default.
[12:59:28.359] <TB2> INFO: 2 hot pixels found in step 2
[12:59:29.325] <TB2> INFO: Collecting data for 1 seconds...
[12:59:30.326] <TB2> INFO: Done with hot pixel readout
[12:59:36.135] <TB2> INFO: PixTest:: pg_setup set to default.
[12:59:36.136] <TB2> INFO: 1 hot pixels found in step 3
[12:59:37.102] <TB2> INFO: Collecting data for 1 seconds...
[12:59:38.103] <TB2> INFO: Done with hot pixel readout
[12:59:43.904] <TB2> INFO: PixTest:: pg_setup set to default.
[12:59:43.905] <TB2> INFO: 1 hot pixels found in step 4
[12:59:44.871] <TB2> INFO: Collecting data for 1 seconds...
[12:59:45.872] <TB2> INFO: Done with hot pixel readout
[12:59:51.641] <TB2> INFO: PixTest:: pg_setup set to default.
[12:59:51.642] <TB2> INFO: 1 hot pixels found in step 5
[12:59:52.608] <TB2> INFO: Collecting data for 1 seconds...
[12:59:53.608] <TB2> INFO: Done with hot pixel readout
[12:59:59.371] <TB2> INFO: PixTest:: pg_setup set to default.
[12:59:59.372] <TB2> INFO: 1 hot pixels found in step 6
[13:00:00.339] <TB2> INFO: Collecting data for 1 seconds...
[13:00:01.340] <TB2> INFO: Done with hot pixel readout
[13:00:07.080] <TB2> INFO: PixTest:: pg_setup set to default.
[13:00:07.081] <TB2> INFO: 1 hot pixels found in step 7
[13:00:08.048] <TB2> INFO: Collecting data for 1 seconds...
[13:00:09.048] <TB2> INFO: Done with hot pixel readout
[13:00:14.794] <TB2> INFO: PixTest:: pg_setup set to default.
[13:00:14.795] <TB2> INFO: 0 hot pixels found in step 8
[13:00:14.803] <TB2> INFO: 0 hot pixels could not be trimmed and have been masked.
[13:00:14.834] <TB2> INFO: PixTest::trimHotPixels() done
[13:00:14.834] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C0.dat
[13:00:14.840] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C1.dat
[13:00:14.846] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C2.dat
[13:00:14.853] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C3.dat
[13:00:14.859] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C4.dat
[13:00:14.865] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C5.dat
[13:00:14.872] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C6.dat
[13:00:14.878] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C7.dat
[13:00:14.884] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C8.dat
[13:00:14.891] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C9.dat
[13:00:14.897] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C10.dat
[13:00:14.904] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C11.dat
[13:00:14.910] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C12.dat
[13:00:14.917] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C13.dat
[13:00:14.923] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C14.dat
[13:00:14.929] <TB2> INFO: write trim parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//trimParameters35_C15.dat
[13:00:14.936] <TB2> INFO: write masked pixels into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//002_RetrimHotPixels_150//defaultMaskFile.dat
[13:00:14.969] <TB2> INFO: enter test to run
[13:00:14.970] <TB2> INFO: test: no parameter change
[13:00:15.159] <TB2> QUIET: Connection to board 162 closed.
[13:00:15.239] <TB2> INFO: pXar: this is the end, my friend

[14:54:22.422] <TB2> INFO: *** Welcome to pxar ***
[14:54:22.422] <TB2> INFO: *** Today: 2016/01/22
[14:54:22.485] <TB2> INFO: *** Version: 9751
[14:54:22.485] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//dacParameters35_C15.dat
[14:54:22.486] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//tbmParameters_C0b.dat
[14:54:22.486] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//defaultMaskFile.dat
[14:54:22.486] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//trimParameters35_C15.dat
[14:54:22.556] <TB2> INFO: clk: 4
[14:54:22.556] <TB2> INFO: ctr: 4
[14:54:22.556] <TB2> INFO: sda: 19
[14:54:22.556] <TB2> INFO: tin: 9
[14:54:22.556] <TB2> INFO: level: 15
[14:54:22.556] <TB2> INFO: triggerdelay: 0
[14:54:22.556] <TB2> QUIET: Instanciating API for pxar prod-12
[14:54:22.556] <TB2> INFO: Log level: INFO
[14:54:22.570] <TB2> INFO: Found DTB DTB_WXENWR
[14:54:22.579] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:54:22.582] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[14:54:22.585] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:54:24.186] <TB2> INFO: DUT info:
[14:54:24.186] <TB2> INFO: The DUT currently contains the following objects:
[14:54:24.186] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:54:24.186] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:54:24.186] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:54:24.186] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:54:24.186] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.186] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.187] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.187] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.187] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.187] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.187] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.187] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:54:24.588] <TB2> INFO: enter 'restricted' command line mode
[14:54:24.588] <TB2> INFO: enter test to run
[14:54:24.588] <TB2> INFO: test: delay setting parameters: ->5<-
[14:54:24.588] <TB2> INFO: delay test by 5 seconds...
[14:54:29.588] <TB2> INFO: enter test to run
[14:54:29.588] <TB2> INFO: test: Xray no parameter change
[14:54:29.588] <TB2> INFO: running: xray
[14:54:29.589] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//003_HRData_50//phCalibrationFitErr35_C15.dat
[14:54:29.771] <TB2> INFO: ######################################################################
[14:54:29.771] <TB2> INFO: PixTestXray::doTest()
[14:54:29.771] <TB2> INFO: ######################################################################
[14:54:29.771] <TB2> INFO: ----------------------------------------------------------------------
[14:54:29.771] <TB2> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[14:54:29.771] <TB2> INFO: ----------------------------------------------------------------------
[14:54:30.740] <TB2> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[14:54:36.937] <TB2> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[14:55:02.128] <TB2> INFO: Resuming triggers.
[14:55:08.329] <TB2> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[14:55:33.047] <TB2> INFO: Resuming triggers.
[14:55:39.250] <TB2> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[14:56:04.903] <TB2> INFO: Resuming triggers.
[14:56:11.102] <TB2> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[14:56:36.793] <TB2> INFO: Resuming triggers.
[14:56:42.992] <TB2> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[14:57:07.502] <TB2> INFO: Resuming triggers.
[14:57:13.699] <TB2> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[14:57:38.882] <TB2> INFO: Resuming triggers.
[14:57:45.075] <TB2> INFO: run duration 43 seconds, buffer almost full (81%), pausing triggers.
[14:58:09.693] <TB2> INFO: Resuming triggers.
[14:58:15.886] <TB2> INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[14:58:41.192] <TB2> INFO: Resuming triggers.
[14:58:47.385] <TB2> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[14:59:12.035] <TB2> INFO: Resuming triggers.
[14:59:18.226] <TB2> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[14:59:42.040] <TB2> INFO: Resuming triggers.
[14:59:48.235] <TB2> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[15:00:12.452] <TB2> INFO: Resuming triggers.
[15:00:18.646] <TB2> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[15:00:43.900] <TB2> INFO: Resuming triggers.
[15:00:50.091] <TB2> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[15:01:14.220] <TB2> INFO: Resuming triggers.
[15:01:20.404] <TB2> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[15:01:44.213] <TB2> INFO: Resuming triggers.
[15:01:50.404] <TB2> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[15:02:15.021] <TB2> INFO: Resuming triggers.
[15:02:21.210] <TB2> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[15:02:45.345] <TB2> INFO: Resuming triggers.
[15:02:46.293] <TB2> INFO: data taking finished, elapsed time: 100 seconds.
[15:02:50.471] <TB2> INFO: PixTest:: pg_setup set to default.
[15:02:50.473] <TB2> INFO: PixTestXray::doPhRun() done
[15:02:50.473] <TB2> INFO: PixTestXray::doTest() done
[15:02:50.653] <TB2> INFO: enter test to run
[15:02:50.653] <TB2> INFO: test: no parameter change
[15:02:50.851] <TB2> QUIET: Connection to board 162 closed.
[15:02:50.934] <TB2> INFO: pXar: this is the end, my friend

[15:03:09.925] <TB2> INFO: *** Welcome to pxar ***
[15:03:09.925] <TB2> INFO: *** Today: 2016/01/22
[15:03:09.987] <TB2> INFO: *** Version: 9751
[15:03:09.987] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//dacParameters35_C15.dat
[15:03:09.988] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//tbmParameters_C0b.dat
[15:03:09.988] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//defaultMaskFile.dat
[15:03:09.988] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//trimParameters35_C15.dat
[15:03:10.068] <TB2> INFO: clk: 4
[15:03:10.068] <TB2> INFO: ctr: 4
[15:03:10.068] <TB2> INFO: sda: 19
[15:03:10.068] <TB2> INFO: tin: 9
[15:03:10.068] <TB2> INFO: level: 15
[15:03:10.068] <TB2> INFO: triggerdelay: 0
[15:03:10.068] <TB2> QUIET: Instanciating API for pxar prod-12
[15:03:10.068] <TB2> INFO: Log level: INFO
[15:03:10.083] <TB2> INFO: Found DTB DTB_WXENWR
[15:03:10.092] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[15:03:10.095] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[15:03:10.098] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[15:03:11.643] <TB2> INFO: DUT info:
[15:03:11.643] <TB2> INFO: The DUT currently contains the following objects:
[15:03:11.643] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[15:03:11.643] <TB2> INFO: TBM Core alpha (0): 7 registers set
[15:03:11.643] <TB2> INFO: TBM Core beta (1): 7 registers set
[15:03:11.643] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:03:11.643] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:11.643] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:03:12.044] <TB2> INFO: enter 'restricted' command line mode
[15:03:12.044] <TB2> INFO: enter test to run
[15:03:12.044] <TB2> INFO: test: delay setting parameters: ->5<-
[15:03:12.044] <TB2> INFO: delay test by 5 seconds...
[15:03:17.044] <TB2> INFO: enter test to run
[15:03:17.044] <TB2> INFO: test: Xray no parameter change
[15:03:17.044] <TB2> INFO: running: xray
[15:03:17.045] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_HRData_2016-01-22_15h47m_1453474036//004_HRData_150//phCalibrationFitErr35_C15.dat
[15:03:17.191] <TB2> INFO: ######################################################################
[15:03:17.191] <TB2> INFO: PixTestXray::doTest()
[15:03:17.191] <TB2> INFO: ######################################################################
[15:03:17.191] <TB2> INFO: ----------------------------------------------------------------------
[15:03:17.191] <TB2> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:03:17.191] <TB2> INFO: ----------------------------------------------------------------------
[15:03:18.161] <TB2> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:03:21.430] <TB2> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[15:03:46.697] <TB2> INFO: Resuming triggers.
[15:03:49.981] <TB2> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[15:04:14.629] <TB2> INFO: Resuming triggers.
[15:04:17.913] <TB2> INFO: run duration 9 seconds, buffer almost full (81%), pausing triggers.
[15:04:42.766] <TB2> INFO: Resuming triggers.
[15:04:46.048] <TB2> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[15:05:11.413] <TB2> INFO: Resuming triggers.
[15:05:14.695] <TB2> INFO: run duration 16 seconds, buffer almost full (81%), pausing triggers.
[15:05:38.920] <TB2> INFO: Resuming triggers.
[15:05:42.202] <TB2> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[15:06:06.756] <TB2> INFO: Resuming triggers.
[15:06:10.037] <TB2> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[15:06:35.892] <TB2> INFO: Resuming triggers.
[15:06:39.173] <TB2> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[15:07:04.101] <TB2> INFO: Resuming triggers.
[15:07:07.381] <TB2> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[15:07:32.653] <TB2> INFO: Resuming triggers.
[15:07:35.933] <TB2> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[15:08:01.457] <TB2> INFO: Resuming triggers.
[15:08:04.736] <TB2> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[15:08:30.908] <TB2> INFO: Resuming triggers.
[15:08:34.186] <TB2> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[15:08:59.494] <TB2> INFO: Resuming triggers.
[15:09:02.774] <TB2> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[15:09:29.239] <TB2> INFO: Resuming triggers.
[15:09:32.517] <TB2> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[15:09:57.744] <TB2> INFO: Resuming triggers.
[15:10:01.023] <TB2> INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[15:10:26.150] <TB2> INFO: Resuming triggers.
[15:10:29.430] <TB2> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[15:10:54.041] <TB2> INFO: Resuming triggers.
[15:10:57.319] <TB2> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[15:11:22.429] <TB2> INFO: Resuming triggers.
[15:11:25.707] <TB2> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[15:11:50.872] <TB2> INFO: Resuming triggers.
[15:11:54.149] <TB2> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[15:12:19.591] <TB2> INFO: Resuming triggers.
[15:12:22.869] <TB2> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[15:12:48.373] <TB2> INFO: Resuming triggers.
[15:12:51.650] <TB2> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[15:13:16.937] <TB2> INFO: Resuming triggers.
[15:13:20.215] <TB2> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[15:13:45.584] <TB2> INFO: Resuming triggers.
[15:13:48.860] <TB2> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[15:14:14.178] <TB2> INFO: Resuming triggers.
[15:14:17.454] <TB2> INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[15:14:43.175] <TB2> INFO: Resuming triggers.
[15:14:46.453] <TB2> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[15:15:11.975] <TB2> INFO: Resuming triggers.
[15:15:15.250] <TB2> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[15:15:40.474] <TB2> INFO: Resuming triggers.
[15:15:43.749] <TB2> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[15:16:09.130] <TB2> INFO: Resuming triggers.
[15:16:12.404] <TB2> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[15:16:37.999] <TB2> INFO: Resuming triggers.
[15:16:41.273] <TB2> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[15:17:07.456] <TB2> INFO: Resuming triggers.
[15:17:10.730] <TB2> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[15:17:37.223] <TB2> INFO: Resuming triggers.
[15:17:38.942] <TB2> INFO: data taking finished, elapsed time: 100 seconds.
[15:17:52.584] <TB2> INFO: PixTest:: pg_setup set to default.
[15:17:52.585] <TB2> INFO: PixTestXray::doPhRun() done
[15:17:52.585] <TB2> INFO: PixTestXray::doTest() done
[15:17:52.777] <TB2> INFO: enter test to run
[15:17:52.777] <TB2> INFO: test: no parameter change
[15:17:53.039] <TB2> QUIET: Connection to board 162 closed.
[15:17:53.121] <TB2> INFO: pXar: this is the end, my friend

[13:03:33.368] <TB2> INFO: *** Welcome to pxar ***
[13:03:33.368] <TB2> INFO: *** Today: 2016/01/22
[13:03:33.433] <TB2> INFO: *** Version: 9751
[13:03:33.433] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//dacParameters35_C15.dat
[13:03:33.434] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//tbmParameters_C0b.dat
[13:03:33.434] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//defaultMaskFile.dat
[13:03:33.434] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//trimParameters35_C15.dat
[13:03:33.506] <TB2> INFO: clk: 4
[13:03:33.506] <TB2> INFO: ctr: 4
[13:03:33.506] <TB2> INFO: sda: 19
[13:03:33.506] <TB2> INFO: tin: 9
[13:03:33.506] <TB2> INFO: level: 15
[13:03:33.506] <TB2> INFO: triggerdelay: 0
[13:03:33.506] <TB2> QUIET: Instanciating API for pxar prod-12
[13:03:33.506] <TB2> INFO: Log level: INFO
[13:03:33.519] <TB2> INFO: Found DTB DTB_WXENWR
[13:03:33.528] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:03:33.531] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:03:33.534] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:03:35.078] <TB2> INFO: DUT info:
[13:03:35.078] <TB2> INFO: The DUT currently contains the following objects:
[13:03:35.078] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:03:35.078] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:03:35.078] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:03:35.078] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:03:35.078] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.078] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.079] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:03:35.480] <TB2> INFO: enter 'restricted' command line mode
[13:03:35.480] <TB2> INFO: enter test to run
[13:03:35.480] <TB2> INFO: test: Highrate no parameter change
[13:03:35.480] <TB2> INFO: running: highrate
[13:03:35.480] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[13:03:35.712] <TB2> INFO: ----------------------------------------------------------------------
[13:03:35.712] <TB2> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[13:03:35.712] <TB2> INFO: ----------------------------------------------------------------------
[13:03:35.719] <TB2> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[13:03:35.730] <TB2> INFO: dacScan step from 15 .. 34
[13:03:35.730] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[13:03:35.730] <TB2> INFO: run 1 of 1
[13:03:36.333] <TB2> INFO: Expecting 4160000 events.
[13:04:05.412] <TB2> INFO: 428100 events read in total (28548ms).
[13:04:34.578] <TB2> INFO: 857700 events read in total (57714ms).
[13:05:04.335] <TB2> INFO: 1287300 events read in total (87471ms).
[13:05:33.793] <TB2> INFO: 1716700 events read in total (116929ms).
[13:06:01.996] <TB2> INFO: 2146150 events read in total (145132ms).
[13:06:31.219] <TB2> INFO: 2575350 events read in total (174355ms).
[13:07:00.302] <TB2> INFO: 3004350 events read in total (203438ms).
[13:07:30.063] <TB2> INFO: 3433350 events read in total (233199ms).
[13:07:59.329] <TB2> INFO: 3861700 events read in total (262465ms).
[13:08:19.467] <TB2> INFO: 4160000 events read in total (282603ms).
[13:08:19.790] <TB2> INFO: Test took 284060ms.
[13:08:24.321] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:08:30.517] <TB2> INFO: dacScan step from 35 .. 54
[13:08:30.517] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[13:08:30.517] <TB2> INFO: run 1 of 1
[13:08:31.111] <TB2> INFO: Expecting 4160000 events.
[13:08:59.310] <TB2> INFO: 362600 events read in total (27672ms).
[13:09:26.949] <TB2> INFO: 726450 events read in total (55311ms).
[13:09:54.437] <TB2> INFO: 1089250 events read in total (82799ms).
[13:10:21.814] <TB2> INFO: 1450950 events read in total (110176ms).
[13:10:50.178] <TB2> INFO: 1811900 events read in total (138540ms).
[13:11:17.966] <TB2> INFO: 2171150 events read in total (166328ms).
[13:11:45.195] <TB2> INFO: 2528150 events read in total (193557ms).
[13:12:12.957] <TB2> INFO: 2882800 events read in total (221319ms).
[13:12:40.713] <TB2> INFO: 3234450 events read in total (249075ms).
[13:13:08.016] <TB2> INFO: 3583950 events read in total (276378ms).
[13:13:35.287] <TB2> INFO: 3932600 events read in total (303649ms).
[13:13:53.143] <TB2> INFO: 4160000 events read in total (321505ms).
[13:13:53.435] <TB2> INFO: Test took 322918ms.
[13:13:55.906] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:14:02.727] <TB2> INFO: dacScan step from 55 .. 74
[13:14:02.727] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[13:14:02.727] <TB2> INFO: run 1 of 1
[13:14:03.322] <TB2> INFO: Expecting 4160000 events.
[13:14:30.064] <TB2> INFO: 322000 events read in total (26214ms).
[13:14:56.879] <TB2> INFO: 644900 events read in total (53029ms).
[13:15:23.843] <TB2> INFO: 967700 events read in total (79993ms).
[13:15:51.654] <TB2> INFO: 1290700 events read in total (107804ms).
[13:16:18.948] <TB2> INFO: 1613500 events read in total (135098ms).
[13:16:46.332] <TB2> INFO: 1936200 events read in total (162482ms).
[13:17:12.584] <TB2> INFO: 2259150 events read in total (188734ms).
[13:17:38.721] <TB2> INFO: 2582000 events read in total (214871ms).
[13:18:05.996] <TB2> INFO: 2904650 events read in total (242146ms).
[13:18:33.790] <TB2> INFO: 3227500 events read in total (269940ms).
[13:19:00.889] <TB2> INFO: 3550350 events read in total (297039ms).
[13:19:27.299] <TB2> INFO: 3873000 events read in total (323449ms).
[13:19:51.349] <TB2> INFO: 4160000 events read in total (347499ms).
[13:19:51.649] <TB2> INFO: Test took 348922ms.
[13:19:53.681] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:19:59.699] <TB2> INFO: dacScan step from 75 .. 75
[13:19:59.699] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[13:19:59.699] <TB2> INFO: run 1 of 1
[13:20:00.295] <TB2> INFO: Expecting 208000 events.
[13:20:18.777] <TB2> INFO: 208000 events read in total (17946ms).
[13:20:18.785] <TB2> INFO: Test took 19085ms.
[13:20:18.875] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:20:19.249] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:20.582] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:21.613] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:22.692] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:23.791] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:24.894] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:26.025] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:27.084] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:28.159] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:29.235] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:30.299] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:31.362] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:32.421] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:33.461] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:34.501] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:35.541] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[13:20:36.569] <TB2> INFO: PixTest:: pg_setup set to default.
[13:20:36.570] <TB2> INFO: vcal mean: 39.13 39.09 38.60 42.40 41.53 43.70 42.82 43.24 42.74 42.95 42.38 42.54 42.40 39.41 39.26 39.33
[13:20:36.570] <TB2> INFO: vcal RMS: 1.79 1.13 1.13 1.66 1.26 1.38 1.41 1.44 1.61 1.57 1.37 1.50 1.47 1.30 1.14 1.14
[13:20:36.570] <TB2> INFO: number of X-ray hits detected: 213145 214382 192713 361913 338893 452970 405522 416237 446341 425033 406710 379166 384314 218250 233184 219067
[13:20:36.570] <TB2> 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:20:36.570] <TB2> INFO: X-ray hit rate [MHz/cm2]: 62.5 62.8 56.5 106.1 99.3 132.8 118.9 122.0 130.8 124.6 119.2 111.1 112.6 64.0 68.3 64.2
[13:20:36.570] <TB2> INFO: PixTestHighRate::doXNoiseMaps() done
[13:20:36.667] <TB2> INFO: enter test to run
[13:20:36.667] <TB2> INFO: test: no parameter change
[13:20:36.883] <TB2> QUIET: Connection to board 162 closed.
[13:20:36.973] <TB2> INFO: pXar: this is the end, my friend

[13:38:18.170] <TB2> INFO: *** Welcome to pxar ***
[13:38:18.170] <TB2> INFO: *** Today: 2016/01/22
[13:38:18.236] <TB2> INFO: *** Version: 9751
[13:38:18.236] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:38:18.237] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[13:38:18.237] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[13:38:18.237] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[13:38:18.316] <TB2> INFO: clk: 4
[13:38:18.316] <TB2> INFO: ctr: 4
[13:38:18.316] <TB2> INFO: sda: 19
[13:38:18.316] <TB2> INFO: tin: 9
[13:38:18.316] <TB2> INFO: level: 15
[13:38:18.316] <TB2> INFO: triggerdelay: 0
[13:38:18.316] <TB2> QUIET: Instanciating API for pxar prod-12
[13:38:18.316] <TB2> INFO: Log level: INFO
[13:38:18.329] <TB2> INFO: Found DTB DTB_WXENWR
[13:38:18.337] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:38:18.341] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:38:18.344] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:38:19.900] <TB2> INFO: DUT info:
[13:38:19.900] <TB2> INFO: The DUT currently contains the following objects:
[13:38:19.900] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:38:19.900] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:38:19.900] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:38:19.900] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:38:19.900] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:19.900] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:38:20.301] <TB2> INFO: enter 'restricted' command line mode
[13:38:20.301] <TB2> INFO: enter test to run
[13:38:20.301] <TB2> INFO: test: HighRate no parameter change
[13:38:20.301] <TB2> INFO: running: highrate
[13:38:20.301] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[13:38:20.443] <TB2> INFO: ----------------------------------------------------------------------
[13:38:20.443] <TB2> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:38:20.443] <TB2> INFO: ----------------------------------------------------------------------
[13:38:20.582] <TB2> INFO: Expecting 768 events.
[13:38:21.828] <TB2> INFO: 768 events read in total (526ms).
[13:38:21.924] <TB2> INFO: Test took 1475ms.
[13:38:22.548] <TB2> INFO: Expecting 41600 events.
[13:38:26.367] <TB2> INFO: 41600 events read in total (3291ms).
[13:38:26.369] <TB2> INFO: Test took 4440ms.
[13:38:26.450] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:27.092] <TB2> INFO: Expecting 41600 events.
[13:38:30.678] <TB2> INFO: 41600 events read in total (3058ms).
[13:38:30.680] <TB2> INFO: Test took 4200ms.
[13:38:30.758] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:31.416] <TB2> INFO: Expecting 41600 events.
[13:38:35.168] <TB2> INFO: 41600 events read in total (3224ms).
[13:38:35.170] <TB2> INFO: Test took 4367ms.
[13:38:35.262] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:35.906] <TB2> INFO: Expecting 41600 events.
[13:38:39.706] <TB2> INFO: 41600 events read in total (3272ms).
[13:38:39.708] <TB2> INFO: Test took 4415ms.
[13:38:39.804] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:40.466] <TB2> INFO: Expecting 41600 events.
[13:38:44.343] <TB2> INFO: 41600 events read in total (3349ms).
[13:38:44.345] <TB2> INFO: Test took 4492ms.
[13:38:44.426] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:45.070] <TB2> INFO: Expecting 41600 events.
[13:38:48.902] <TB2> INFO: 41600 events read in total (3305ms).
[13:38:48.904] <TB2> INFO: Test took 4447ms.
[13:38:48.989] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:49.633] <TB2> INFO: Expecting 41600 events.
[13:38:53.496] <TB2> INFO: 41600 events read in total (3335ms).
[13:38:53.498] <TB2> INFO: Test took 4478ms.
[13:38:53.576] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:54.219] <TB2> INFO: Expecting 41600 events.
[13:38:58.006] <TB2> INFO: 41600 events read in total (3259ms).
[13:38:58.009] <TB2> INFO: Test took 4403ms.
[13:38:58.090] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:38:58.764] <TB2> INFO: Expecting 41600 events.
[13:39:02.624] <TB2> INFO: 41600 events read in total (3332ms).
[13:39:02.626] <TB2> INFO: Test took 4505ms.
[13:39:02.725] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:03.380] <TB2> INFO: Expecting 41600 events.
[13:39:07.146] <TB2> INFO: 41600 events read in total (3238ms).
[13:39:07.148] <TB2> INFO: Test took 4380ms.
[13:39:07.237] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:07.919] <TB2> INFO: Expecting 41600 events.
[13:39:11.726] <TB2> INFO: 41600 events read in total (3279ms).
[13:39:11.729] <TB2> INFO: Test took 4447ms.
[13:39:11.811] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:12.455] <TB2> INFO: Expecting 41600 events.
[13:39:16.350] <TB2> INFO: 41600 events read in total (3367ms).
[13:39:16.352] <TB2> INFO: Test took 4510ms.
[13:39:16.432] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:17.111] <TB2> INFO: Expecting 41600 events.
[13:39:21.084] <TB2> INFO: 41600 events read in total (3445ms).
[13:39:21.086] <TB2> INFO: Test took 4623ms.
[13:39:21.183] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:21.862] <TB2> INFO: Expecting 41600 events.
[13:39:25.874] <TB2> INFO: 41600 events read in total (3484ms).
[13:39:25.876] <TB2> INFO: Test took 4648ms.
[13:39:25.976] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:26.663] <TB2> INFO: Expecting 41600 events.
[13:39:30.481] <TB2> INFO: 41600 events read in total (3290ms).
[13:39:30.482] <TB2> INFO: Test took 4458ms.
[13:39:30.561] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:31.206] <TB2> INFO: Expecting 41600 events.
[13:39:35.097] <TB2> INFO: 41600 events read in total (3363ms).
[13:39:35.099] <TB2> INFO: Test took 4506ms.
[13:39:35.184] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:35.830] <TB2> INFO: Expecting 41600 events.
[13:39:39.635] <TB2> INFO: 41600 events read in total (3278ms).
[13:39:39.637] <TB2> INFO: Test took 4421ms.
[13:39:39.716] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:40.362] <TB2> INFO: Expecting 41600 events.
[13:39:44.225] <TB2> INFO: 41600 events read in total (3336ms).
[13:39:44.227] <TB2> INFO: Test took 4479ms.
[13:39:44.329] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:44.977] <TB2> INFO: Expecting 41600 events.
[13:39:48.533] <TB2> INFO: 41600 events read in total (3028ms).
[13:39:48.535] <TB2> INFO: Test took 4171ms.
[13:39:48.614] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:49.258] <TB2> INFO: Expecting 41600 events.
[13:39:52.699] <TB2> INFO: 41600 events read in total (2914ms).
[13:39:52.701] <TB2> INFO: Test took 4056ms.
[13:39:52.782] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:39:53.101] <TB2> INFO: enter test to run
[13:39:53.101] <TB2> INFO: test: Pretest no parameter change
[13:39:53.101] <TB2> INFO: running: pretest
[13:39:53.101] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[13:39:53.101] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[13:39:53.101] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[13:39:53.101] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[13:39:53.101] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[13:39:53.102] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[13:39:53.103] <TB2> INFO: write dac parameters into /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[13:39:53.103] <TB2> INFO: enter test to run
[13:39:53.103] <TB2> INFO: test: no parameter change
[13:39:53.285] <TB2> QUIET: Connection to board 162 closed.
[13:39:53.365] <TB2> INFO: pXar: this is the end, my friend

[13:40:07.163] <TB2> INFO: *** Welcome to pxar ***
[13:40:07.163] <TB2> INFO: *** Today: 2016/01/22
[13:40:07.230] <TB2> INFO: *** Version: 9751
[13:40:07.230] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//dacParameters35_C15.dat
[13:40:07.230] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//tbmParameters_C0b.dat
[13:40:07.231] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//defaultMaskFile.dat
[13:40:07.231] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//trimParameters35_C15.dat
[13:40:07.306] <TB2> INFO: clk: 4
[13:40:07.306] <TB2> INFO: ctr: 4
[13:40:07.306] <TB2> INFO: sda: 19
[13:40:07.306] <TB2> INFO: tin: 9
[13:40:07.306] <TB2> INFO: level: 15
[13:40:07.306] <TB2> INFO: triggerdelay: 0
[13:40:07.306] <TB2> QUIET: Instanciating API for pxar prod-12
[13:40:07.306] <TB2> INFO: Log level: INFO
[13:40:07.319] <TB2> INFO: Found DTB DTB_WXENWR
[13:40:07.328] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:40:07.331] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:40:07.334] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:40:08.880] <TB2> INFO: DUT info:
[13:40:08.880] <TB2> INFO: The DUT currently contains the following objects:
[13:40:08.880] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:40:08.880] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:40:08.880] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:40:08.880] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:40:08.880] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:08.880] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:40:09.281] <TB2> INFO: enter 'restricted' command line mode
[13:40:09.281] <TB2> INFO: enter test to run
[13:40:09.281] <TB2> INFO: test: PixelAlive no parameter change
[13:40:09.281] <TB2> INFO: running: pixelalive
[13:40:09.286] <TB2> INFO: ######################################################################
[13:40:09.286] <TB2> INFO: PixTestAlive::doTest()
[13:40:09.286] <TB2> INFO: ######################################################################
[13:40:09.287] <TB2> INFO: ----------------------------------------------------------------------
[13:40:09.287] <TB2> 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:40:09.287] <TB2> INFO: ----------------------------------------------------------------------
[13:40:09.627] <TB2> INFO: Expecting 208000 events.
[13:40:20.188] <TB2> INFO: 208000 events read in total (9841ms).
[13:40:20.211] <TB2> INFO: Test took 10921ms.
[13:40:20.219] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:40:20.485] <TB2> INFO: PixTestAlive::aliveTest() done
[13:40:20.485] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:40:20.486] <TB2> INFO: ----------------------------------------------------------------------
[13:40:20.486] <TB2> 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:20.486] <TB2> INFO: ----------------------------------------------------------------------
[13:40:20.787] <TB2> INFO: Expecting 208000 events.
[13:40:27.791] <TB2> INFO: 208000 events read in total (6287ms).
[13:40:27.793] <TB2> INFO: Test took 7305ms.
[13:40:27.793] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:40:27.793] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:40:28.117] <TB2> INFO: PixTestAlive::maskTest() done
[13:40:28.117] <TB2> 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:28.119] <TB2> INFO: ----------------------------------------------------------------------
[13:40:28.119] <TB2> 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:28.119] <TB2> INFO: ----------------------------------------------------------------------
[13:40:28.425] <TB2> INFO: Expecting 208000 events.
[13:40:38.696] <TB2> INFO: 208000 events read in total (9555ms).
[13:40:38.697] <TB2> INFO: Test took 10576ms.
[13:40:38.707] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:40:38.953] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:40:38.953] <TB2> 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:38.953] <TB2> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[13:40:38.985] <TB2> INFO: enter test to run
[13:40:38.985] <TB2> INFO: test: delay setting parameters: ->2<-
[13:40:38.985] <TB2> INFO: delay test by 2 seconds...
[13:40:40.985] <TB2> INFO: enter test to run
[13:40:40.985] <TB2> INFO: test: HighRate no parameter change
[13:40:40.985] <TB2> INFO: running: highrate
[13:40:40.986] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[13:40:41.122] <TB2> INFO: ----------------------------------------------------------------------
[13:40:41.122] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:40:41.122] <TB2> INFO: ----------------------------------------------------------------------
[13:40:41.774] <TB2> INFO: Expecting 208000 events.
[13:40:55.326] <TB2> INFO: 208000 events read in total (13024ms).
[13:40:55.332] <TB2> INFO: Test took 14205ms.
[13:40:55.617] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:40:55.905] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[13:40:55.905] <TB2> INFO: number of red-efficiency pixels: 147 136 116 281 238 374 315 340 364 340 337 279 282 155 146 134
[13:40:55.905] <TB2> INFO: number of X-ray hits detected: 106019 105485 93933 181305 167856 229404 203224 209106 224412 212916 204301 189576 193250 106532 115990 107942
[13:40:55.905] <TB2> 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:55.905] <TB2> INFO: number of Vcal hits detected: 207605 207859 207880 207652 207744 207605 207659 207637 207616 207595 207645 207712 207703 207836 207850 207863
[13:40:55.905] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 100.0 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[13:40:55.905] <TB2> INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.9 99.8 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[13:40:55.905] <TB2> INFO: X-ray hit rate [MHz/cm2]: 31.1 30.9 27.5 53.1 49.2 67.2 59.6 61.3 65.8 62.4 59.9 55.6 56.6 31.2 34.0 31.6
[13:40:55.905] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[13:40:55.950] <TB2> INFO: PixTest:: pg_setup set to default.
[13:40:55.958] <TB2> INFO: enter test to run
[13:40:55.959] <TB2> INFO: test: no parameter change
[13:40:56.167] <TB2> QUIET: Connection to board 162 closed.
[13:40:56.247] <TB2> INFO: pXar: this is the end, my friend

[13:41:12.866] <TB2> INFO: *** Welcome to pxar ***
[13:41:12.866] <TB2> INFO: *** Today: 2016/01/22
[13:41:12.930] <TB2> INFO: *** Version: 9751
[13:41:12.930] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//dacParameters35_C15.dat
[13:41:12.930] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//tbmParameters_C0b.dat
[13:41:12.930] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//defaultMaskFile.dat
[13:41:12.930] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//trimParameters35_C15.dat
[13:41:13.037] <TB2> INFO: clk: 4
[13:41:13.037] <TB2> INFO: ctr: 4
[13:41:13.037] <TB2> INFO: sda: 19
[13:41:13.037] <TB2> INFO: tin: 9
[13:41:13.037] <TB2> INFO: level: 15
[13:41:13.037] <TB2> INFO: triggerdelay: 0
[13:41:13.037] <TB2> QUIET: Instanciating API for pxar prod-12
[13:41:13.037] <TB2> INFO: Log level: INFO
[13:41:13.050] <TB2> INFO: Found DTB DTB_WXENWR
[13:41:13.059] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:41:13.062] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:41:13.065] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:41:14.650] <TB2> INFO: DUT info:
[13:41:14.650] <TB2> INFO: The DUT currently contains the following objects:
[13:41:14.650] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:41:14.650] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:41:14.650] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:41:14.650] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:41:14.650] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:14.650] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:41:15.051] <TB2> INFO: enter 'restricted' command line mode
[13:41:15.051] <TB2> INFO: enter test to run
[13:41:15.051] <TB2> INFO: test: PixelAlive no parameter change
[13:41:15.051] <TB2> INFO: running: pixelalive
[13:41:15.057] <TB2> INFO: ######################################################################
[13:41:15.057] <TB2> INFO: PixTestAlive::doTest()
[13:41:15.057] <TB2> INFO: ######################################################################
[13:41:15.059] <TB2> INFO: ----------------------------------------------------------------------
[13:41:15.059] <TB2> 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:15.059] <TB2> INFO: ----------------------------------------------------------------------
[13:41:15.407] <TB2> INFO: Expecting 208000 events.
[13:41:26.655] <TB2> INFO: 208000 events read in total (10529ms).
[13:41:26.664] <TB2> INFO: Test took 11603ms.
[13:41:26.676] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:41:26.949] <TB2> INFO: PixTestAlive::aliveTest() done
[13:41:26.949] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:41:26.950] <TB2> INFO: ----------------------------------------------------------------------
[13:41:26.950] <TB2> 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:26.950] <TB2> INFO: ----------------------------------------------------------------------
[13:41:27.254] <TB2> INFO: Expecting 208000 events.
[13:41:34.340] <TB2> INFO: 208000 events read in total (6369ms).
[13:41:34.340] <TB2> INFO: Test took 7387ms.
[13:41:34.340] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:41:34.340] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:41:34.666] <TB2> INFO: PixTestAlive::maskTest() done
[13:41:34.666] <TB2> 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:34.668] <TB2> INFO: ----------------------------------------------------------------------
[13:41:34.668] <TB2> 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:34.668] <TB2> INFO: ----------------------------------------------------------------------
[13:41:34.972] <TB2> INFO: Expecting 208000 events.
[13:41:45.328] <TB2> INFO: 208000 events read in total (9640ms).
[13:41:45.329] <TB2> INFO: Test took 10659ms.
[13:41:45.341] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:41:45.586] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:41:45.586] <TB2> 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:45.586] <TB2> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[13:41:45.633] <TB2> INFO: enter test to run
[13:41:45.633] <TB2> INFO: test: delay setting parameters: ->2<-
[13:41:45.633] <TB2> INFO: delay test by 2 seconds...
[13:41:47.633] <TB2> INFO: enter test to run
[13:41:47.633] <TB2> INFO: test: HighRate no parameter change
[13:41:47.633] <TB2> INFO: running: highrate
[13:41:47.634] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//012_HREfficiency_75//phCalibrationFitErr35_C15.dat
[13:41:47.899] <TB2> INFO: ----------------------------------------------------------------------
[13:41:47.899] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:41:47.899] <TB2> INFO: ----------------------------------------------------------------------
[13:41:48.536] <TB2> INFO: Expecting 208000 events.
[13:42:03.580] <TB2> INFO: 208000 events read in total (14516ms).
[13:42:03.588] <TB2> INFO: Test took 15684ms.
[13:42:03.994] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:42:04.321] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[13:42:04.321] <TB2> INFO: number of red-efficiency pixels: 220 230 242 576 457 802 690 680 734 715 645 589 563 301 257 220
[13:42:04.321] <TB2> INFO: number of X-ray hits detected: 155275 155496 139443 264484 246458 333461 297010 306159 325920 310222 297964 278602 280683 157365 169319 158757
[13:42:04.321] <TB2> 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:42:04.321] <TB2> INFO: number of Vcal hits detected: 207530 207755 207732 207317 207513 207045 207211 207243 207172 207142 207270 207343 207378 207672 207739 207773
[13:42:04.321] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.8 99.6 99.7 99.7 99.6 99.6 99.7 99.7 99.7 99.9 99.9 99.9
[13:42:04.321] <TB2> INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.9 99.7 99.8 99.5 99.6 99.6 99.6 99.6 99.6 99.7 99.7 99.8 99.9 99.9
[13:42:04.321] <TB2> INFO: X-ray hit rate [MHz/cm2]: 45.5 45.6 40.9 77.5 72.2 97.7 87.1 89.7 95.5 90.9 87.3 81.7 82.3 46.1 49.6 46.5
[13:42:04.321] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[13:42:04.365] <TB2> INFO: PixTest:: pg_setup set to default.
[13:42:04.374] <TB2> INFO: enter test to run
[13:42:04.374] <TB2> INFO: test: no parameter change
[13:42:04.604] <TB2> QUIET: Connection to board 162 closed.
[13:42:04.684] <TB2> INFO: pXar: this is the end, my friend

[13:42:19.499] <TB2> INFO: *** Welcome to pxar ***
[13:42:19.499] <TB2> INFO: *** Today: 2016/01/22
[13:42:19.563] <TB2> INFO: *** Version: 9751
[13:42:19.563] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//dacParameters35_C15.dat
[13:42:19.563] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//tbmParameters_C0b.dat
[13:42:19.563] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//defaultMaskFile.dat
[13:42:19.563] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//trimParameters35_C15.dat
[13:42:19.640] <TB2> INFO: clk: 4
[13:42:19.640] <TB2> INFO: ctr: 4
[13:42:19.640] <TB2> INFO: sda: 19
[13:42:19.640] <TB2> INFO: tin: 9
[13:42:19.640] <TB2> INFO: level: 15
[13:42:19.640] <TB2> INFO: triggerdelay: 0
[13:42:19.640] <TB2> QUIET: Instanciating API for pxar prod-12
[13:42:19.640] <TB2> INFO: Log level: INFO
[13:42:19.653] <TB2> INFO: Found DTB DTB_WXENWR
[13:42:19.661] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:42:19.665] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:42:19.667] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:42:21.211] <TB2> INFO: DUT info:
[13:42:21.211] <TB2> INFO: The DUT currently contains the following objects:
[13:42:21.211] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:42:21.211] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:42:21.211] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:42:21.211] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:42:21.211] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.211] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:42:21.612] <TB2> INFO: enter 'restricted' command line mode
[13:42:21.612] <TB2> INFO: enter test to run
[13:42:21.612] <TB2> INFO: test: PixelAlive no parameter change
[13:42:21.612] <TB2> INFO: running: pixelalive
[13:42:21.616] <TB2> INFO: ######################################################################
[13:42:21.616] <TB2> INFO: PixTestAlive::doTest()
[13:42:21.616] <TB2> INFO: ######################################################################
[13:42:21.618] <TB2> INFO: ----------------------------------------------------------------------
[13:42:21.618] <TB2> 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:21.618] <TB2> INFO: ----------------------------------------------------------------------
[13:42:21.968] <TB2> INFO: Expecting 208000 events.
[13:42:32.524] <TB2> INFO: 208000 events read in total (9837ms).
[13:42:32.527] <TB2> INFO: Test took 10907ms.
[13:42:32.534] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:42:32.820] <TB2> INFO: PixTestAlive::aliveTest() done
[13:42:32.820] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:42:32.821] <TB2> INFO: ----------------------------------------------------------------------
[13:42:32.821] <TB2> 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:32.822] <TB2> INFO: ----------------------------------------------------------------------
[13:42:33.131] <TB2> INFO: Expecting 208000 events.
[13:42:40.470] <TB2> INFO: 208000 events read in total (6623ms).
[13:42:40.470] <TB2> INFO: Test took 7646ms.
[13:42:40.470] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:42:40.471] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:42:40.796] <TB2> INFO: PixTestAlive::maskTest() done
[13:42:40.796] <TB2> 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:40.798] <TB2> INFO: ----------------------------------------------------------------------
[13:42:40.798] <TB2> 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:40.798] <TB2> INFO: ----------------------------------------------------------------------
[13:42:41.156] <TB2> INFO: Expecting 208000 events.
[13:42:51.719] <TB2> INFO: 208000 events read in total (9847ms).
[13:42:51.720] <TB2> INFO: Test took 10920ms.
[13:42:51.728] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:42:51.969] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:42:51.969] <TB2> 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:51.969] <TB2> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[13:42:52.000] <TB2> INFO: enter test to run
[13:42:52.000] <TB2> INFO: test: delay setting parameters: ->2<-
[13:42:52.000] <TB2> INFO: delay test by 2 seconds...
[13:42:54.000] <TB2> INFO: enter test to run
[13:42:54.000] <TB2> INFO: test: HighRate no parameter change
[13:42:54.000] <TB2> INFO: running: highrate
[13:42:54.000] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//013_HREfficiency_100//phCalibrationFitErr35_C15.dat
[13:42:54.137] <TB2> INFO: ----------------------------------------------------------------------
[13:42:54.137] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:42:54.137] <TB2> INFO: ----------------------------------------------------------------------
[13:42:54.760] <TB2> INFO: Expecting 208000 events.
[13:43:12.284] <TB2> INFO: 208000 events read in total (16996ms).
[13:43:12.294] <TB2> INFO: Test took 18152ms.
[13:43:12.857] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:43:13.234] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[13:43:13.234] <TB2> INFO: number of red-efficiency pixels: 399 363 430 993 899 1582 1287 1309 1441 1341 1215 1031 1097 516 487 382
[13:43:13.234] <TB2> INFO: number of X-ray hits detected: 213466 215590 193640 362501 339190 456545 405979 418602 446808 424693 407908 380208 383960 219915 233953 218211
[13:43:13.234] <TB2> 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:13.234] <TB2> INFO: number of Vcal hits detected: 207337 207606 207445 206745 206851 205728 206217 206343 206096 206148 206408 206670 206584 207339 207472 207595
[13:43:13.234] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.5 99.5 99.0 99.3 99.3 99.2 99.2 99.3 99.4 99.4 99.7 99.8 99.8
[13:43:13.234] <TB2> INFO: Vcal hit overall efficiency (%): 99.7 99.8 99.7 99.4 99.4 98.9 99.1 99.2 99.1 99.1 99.2 99.4 99.3 99.7 99.7 99.8
[13:43:13.234] <TB2> INFO: X-ray hit rate [MHz/cm2]: 62.6 63.2 56.8 106.3 99.4 133.8 119.0 122.7 131.0 124.5 119.6 111.4 112.5 64.5 68.6 64.0
[13:43:13.234] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[13:43:13.279] <TB2> INFO: PixTest:: pg_setup set to default.
[13:43:13.288] <TB2> INFO: enter test to run
[13:43:13.288] <TB2> INFO: test: no parameter change
[13:43:13.540] <TB2> QUIET: Connection to board 162 closed.
[13:43:13.620] <TB2> INFO: pXar: this is the end, my friend

[13:43:31.398] <TB2> INFO: *** Welcome to pxar ***
[13:43:31.398] <TB2> INFO: *** Today: 2016/01/22
[13:43:31.464] <TB2> INFO: *** Version: 9751
[13:43:31.464] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//dacParameters35_C15.dat
[13:43:31.465] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//tbmParameters_C0b.dat
[13:43:31.465] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//defaultMaskFile.dat
[13:43:31.465] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//trimParameters35_C15.dat
[13:43:31.535] <TB2> INFO: clk: 4
[13:43:31.535] <TB2> INFO: ctr: 4
[13:43:31.535] <TB2> INFO: sda: 19
[13:43:31.535] <TB2> INFO: tin: 9
[13:43:31.535] <TB2> INFO: level: 15
[13:43:31.535] <TB2> INFO: triggerdelay: 0
[13:43:31.535] <TB2> QUIET: Instanciating API for pxar prod-12
[13:43:31.535] <TB2> INFO: Log level: INFO
[13:43:31.548] <TB2> INFO: Found DTB DTB_WXENWR
[13:43:31.556] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:43:31.560] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:43:31.562] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:43:33.144] <TB2> INFO: DUT info:
[13:43:33.145] <TB2> INFO: The DUT currently contains the following objects:
[13:43:33.145] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:43:33.145] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:43:33.145] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:43:33.145] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:43:33.145] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.145] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:43:33.546] <TB2> INFO: enter 'restricted' command line mode
[13:43:33.546] <TB2> INFO: enter test to run
[13:43:33.546] <TB2> INFO: test: PixelAlive no parameter change
[13:43:33.546] <TB2> INFO: running: pixelalive
[13:43:33.552] <TB2> INFO: ######################################################################
[13:43:33.552] <TB2> INFO: PixTestAlive::doTest()
[13:43:33.552] <TB2> INFO: ######################################################################
[13:43:33.554] <TB2> INFO: ----------------------------------------------------------------------
[13:43:33.554] <TB2> 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:33.554] <TB2> INFO: ----------------------------------------------------------------------
[13:43:33.915] <TB2> INFO: Expecting 208000 events.
[13:43:44.898] <TB2> INFO: 208000 events read in total (10264ms).
[13:43:44.917] <TB2> INFO: Test took 11361ms.
[13:43:44.926] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:43:45.194] <TB2> INFO: PixTestAlive::aliveTest() done
[13:43:45.194] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[13:43:45.195] <TB2> INFO: ----------------------------------------------------------------------
[13:43:45.195] <TB2> 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:45.196] <TB2> INFO: ----------------------------------------------------------------------
[13:43:45.504] <TB2> INFO: Expecting 208000 events.
[13:43:52.313] <TB2> INFO: 208000 events read in total (6093ms).
[13:43:52.313] <TB2> INFO: Test took 7115ms.
[13:43:52.313] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:43:52.313] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:43:52.639] <TB2> INFO: PixTestAlive::maskTest() done
[13:43:52.639] <TB2> 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:52.641] <TB2> INFO: ----------------------------------------------------------------------
[13:43:52.641] <TB2> 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:52.641] <TB2> INFO: ----------------------------------------------------------------------
[13:43:52.950] <TB2> INFO: Expecting 208000 events.
[13:44:03.885] <TB2> INFO: 208000 events read in total (10219ms).
[13:44:03.886] <TB2> INFO: Test took 11243ms.
[13:44:03.894] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:44:04.138] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:44:04.138] <TB2> 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:44:04.138] <TB2> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[13:44:04.179] <TB2> INFO: enter test to run
[13:44:04.179] <TB2> INFO: test: delay setting parameters: ->2<-
[13:44:04.179] <TB2> INFO: delay test by 2 seconds...
[13:44:06.180] <TB2> INFO: enter test to run
[13:44:06.180] <TB2> INFO: test: HighRate no parameter change
[13:44:06.180] <TB2> INFO: running: highrate
[13:44:06.180] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//014_HREfficiency_125//phCalibrationFitErr35_C15.dat
[13:44:06.367] <TB2> INFO: ----------------------------------------------------------------------
[13:44:06.367] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:44:06.367] <TB2> INFO: ----------------------------------------------------------------------
[13:44:06.970] <TB2> INFO: Expecting 208000 events.
[13:44:27.001] <TB2> INFO: 208000 events read in total (19503ms).
[13:44:27.013] <TB2> INFO: Test took 20642ms.
[13:44:27.673] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:44:28.083] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[13:44:28.083] <TB2> INFO: number of red-efficiency pixels: 544 530 601 1479 1296 2276 1841 1954 2066 1978 1852 1509 1579 718 743 546
[13:44:28.083] <TB2> INFO: number of X-ray hits detected: 260010 262089 237026 436921 412734 552932 491926 505170 540702 515044 492451 459549 466749 267159 286361 264761
[13:44:28.083] <TB2> 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:28.083] <TB2> INFO: number of Vcal hits detected: 207155 207386 207131 205861 206154 204007 204946 205124 204784 204694 205165 205659 205703 206969 207171 207389
[13:44:28.083] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.7 99.1 99.2 98.3 98.7 98.7 98.6 98.6 98.8 99.0 99.0 99.6 99.6 99.7
[13:44:28.083] <TB2> INFO: Vcal hit overall efficiency (%): 99.6 99.7 99.6 99.0 99.1 98.1 98.5 98.6 98.5 98.4 98.6 98.9 98.9 99.5 99.6 99.7
[13:44:28.083] <TB2> INFO: X-ray hit rate [MHz/cm2]: 76.2 76.8 69.5 128.1 121.0 162.1 144.2 148.1 158.5 151.0 144.3 134.7 136.8 78.3 83.9 77.6
[13:44:28.083] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[13:44:28.127] <TB2> INFO: PixTest:: pg_setup set to default.
[13:44:28.138] <TB2> INFO: enter test to run
[13:44:28.138] <TB2> INFO: test: no parameter change
[13:44:28.432] <TB2> QUIET: Connection to board 162 closed.
[13:44:28.512] <TB2> INFO: pXar: this is the end, my friend

[13:44:48.333] <TB2> INFO: *** Welcome to pxar ***
[13:44:48.333] <TB2> INFO: *** Today: 2016/01/22
[13:44:48.399] <TB2> INFO: *** Version: 9751
[13:44:48.400] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//dacParameters35_C15.dat
[13:44:48.400] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//tbmParameters_C0b.dat
[13:44:48.400] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//defaultMaskFile.dat
[13:44:48.400] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//trimParameters35_C15.dat
[13:44:48.473] <TB2> INFO: clk: 4
[13:44:48.473] <TB2> INFO: ctr: 4
[13:44:48.473] <TB2> INFO: sda: 19
[13:44:48.473] <TB2> INFO: tin: 9
[13:44:48.473] <TB2> INFO: level: 15
[13:44:48.473] <TB2> INFO: triggerdelay: 0
[13:44:48.473] <TB2> QUIET: Instanciating API for pxar prod-12
[13:44:48.473] <TB2> INFO: Log level: INFO
[13:44:48.486] <TB2> INFO: Found DTB DTB_WXENWR
[13:44:48.495] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:44:48.498] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:44:48.500] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:44:50.048] <TB2> INFO: DUT info:
[13:44:50.048] <TB2> INFO: The DUT currently contains the following objects:
[13:44:50.048] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:44:50.048] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:44:50.048] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:44:50.048] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:44:50.048] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.048] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.049] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.049] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:44:50.449] <TB2> INFO: enter 'restricted' command line mode
[13:44:50.449] <TB2> INFO: enter test to run
[13:44:50.449] <TB2> INFO: test: PixelAlive no parameter change
[13:44:50.449] <TB2> INFO: running: pixelalive
[13:44:50.454] <TB2> INFO: ######################################################################
[13:44:50.454] <TB2> INFO: PixTestAlive::doTest()
[13:44:50.454] <TB2> INFO: ######################################################################
[13:44:50.455] <TB2> INFO: ----------------------------------------------------------------------
[13:44:50.455] <TB2> 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:50.455] <TB2> INFO: ----------------------------------------------------------------------
[13:44:50.764] <TB2> INFO: Expecting 208000 events.
[13:45:01.514] <TB2> INFO: 208000 events read in total (10030ms).
[13:45:01.535] <TB2> INFO: Test took 11078ms.
[13:45:01.546] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:45:01.820] <TB2> INFO: PixTestAlive::aliveTest() done
[13:45:01.820] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:45:01.822] <TB2> INFO: ----------------------------------------------------------------------
[13:45:01.822] <TB2> 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:45:01.822] <TB2> INFO: ----------------------------------------------------------------------
[13:45:02.138] <TB2> INFO: Expecting 208000 events.
[13:45:09.672] <TB2> INFO: 208000 events read in total (6818ms).
[13:45:09.673] <TB2> INFO: Test took 7849ms.
[13:45:09.673] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:45:09.674] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:45:09.996] <TB2> INFO: PixTestAlive::maskTest() done
[13:45:09.997] <TB2> 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:45:09.999] <TB2> INFO: ----------------------------------------------------------------------
[13:45:09.999] <TB2> 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:45:09.999] <TB2> INFO: ----------------------------------------------------------------------
[13:45:10.308] <TB2> INFO: Expecting 208000 events.
[13:45:21.019] <TB2> INFO: 208000 events read in total (9994ms).
[13:45:21.020] <TB2> INFO: Test took 11019ms.
[13:45:21.029] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:45:21.278] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:45:21.278] <TB2> 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:21.278] <TB2> INFO: PixTestAlive::doTest() done, duration: 30 seconds
[13:45:21.328] <TB2> INFO: enter test to run
[13:45:21.328] <TB2> INFO: test: delay setting parameters: ->2<-
[13:45:21.328] <TB2> INFO: delay test by 2 seconds...
[13:45:23.328] <TB2> INFO: enter test to run
[13:45:23.328] <TB2> INFO: test: HighRate no parameter change
[13:45:23.328] <TB2> INFO: running: highrate
[13:45:23.329] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//015_HREfficiency_150//phCalibrationFitErr35_C15.dat
[13:45:23.467] <TB2> INFO: ----------------------------------------------------------------------
[13:45:23.467] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:45:23.467] <TB2> INFO: ----------------------------------------------------------------------
[13:45:24.071] <TB2> INFO: Expecting 208000 events.
[13:45:45.279] <TB2> INFO: 208000 events read in total (20681ms).
[13:45:45.293] <TB2> INFO: Test took 21821ms.
[13:45:46.080] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:45:46.529] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[13:45:46.529] <TB2> INFO: number of red-efficiency pixels: 771 759 797 2022 1849 2965 2449 2646 2802 2652 2472 2107 2184 976 1098 791
[13:45:46.529] <TB2> INFO: number of X-ray hits detected: 309003 314489 283555 520326 490440 654742 586628 600600 642588 612009 586076 545844 553405 320337 341322 317804
[13:45:46.529] <TB2> 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:46.529] <TB2> INFO: number of Vcal hits detected: 206858 207119 206642 204528 204903 201442 203060 203169 202501 202616 203302 204140 204095 206264 206662 207089
[13:45:46.529] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.6 99.6 99.5 98.6 98.7 97.2 98.0 97.9 97.6 97.7 98.0 98.4 98.4 99.3 99.4 99.6
[13:45:46.529] <TB2> INFO: Vcal hit overall efficiency (%): 99.5 99.6 99.3 98.3 98.5 96.8 97.6 97.7 97.4 97.4 97.7 98.1 98.1 99.2 99.4 99.6
[13:45:46.529] <TB2> INFO: X-ray hit rate [MHz/cm2]: 90.6 92.2 83.1 152.5 143.8 191.9 171.9 176.0 188.3 179.4 171.8 160.0 162.2 93.9 100.0 93.2
[13:45:46.529] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[13:45:46.574] <TB2> INFO: PixTest:: pg_setup set to default.
[13:45:46.585] <TB2> INFO: enter test to run
[13:45:46.585] <TB2> INFO: test: no parameter change
[13:45:46.781] <TB2> QUIET: Connection to board 162 closed.
[13:45:46.861] <TB2> INFO: pXar: this is the end, my friend

[13:46:00.922] <TB2> INFO: *** Welcome to pxar ***
[13:46:00.922] <TB2> INFO: *** Today: 2016/01/22
[13:46:00.985] <TB2> INFO: *** Version: 9751
[13:46:00.985] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//dacParameters35_C15.dat
[13:46:00.986] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//tbmParameters_C0b.dat
[13:46:00.986] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//defaultMaskFile.dat
[13:46:00.986] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//trimParameters35_C15.dat
[13:46:01.061] <TB2> INFO: clk: 4
[13:46:01.061] <TB2> INFO: ctr: 4
[13:46:01.061] <TB2> INFO: sda: 19
[13:46:01.061] <TB2> INFO: tin: 9
[13:46:01.061] <TB2> INFO: level: 15
[13:46:01.061] <TB2> INFO: triggerdelay: 0
[13:46:01.061] <TB2> QUIET: Instanciating API for pxar prod-12
[13:46:01.061] <TB2> INFO: Log level: INFO
[13:46:01.075] <TB2> INFO: Found DTB DTB_WXENWR
[13:46:01.083] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:46:01.087] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:46:01.089] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:46:02.635] <TB2> INFO: DUT info:
[13:46:02.635] <TB2> INFO: The DUT currently contains the following objects:
[13:46:02.635] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:46:02.635] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:46:02.635] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:46:02.635] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:46:02.635] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.635] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.635] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.635] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:02.636] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:46:03.037] <TB2> INFO: enter 'restricted' command line mode
[13:46:03.037] <TB2> INFO: enter test to run
[13:46:03.037] <TB2> INFO: test: PixelAlive no parameter change
[13:46:03.037] <TB2> INFO: running: pixelalive
[13:46:03.042] <TB2> INFO: ######################################################################
[13:46:03.042] <TB2> INFO: PixTestAlive::doTest()
[13:46:03.042] <TB2> INFO: ######################################################################
[13:46:03.044] <TB2> INFO: ----------------------------------------------------------------------
[13:46:03.044] <TB2> 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:46:03.044] <TB2> INFO: ----------------------------------------------------------------------
[13:46:03.399] <TB2> INFO: Expecting 208000 events.
[13:46:13.836] <TB2> INFO: 208000 events read in total (9718ms).
[13:46:13.853] <TB2> INFO: Test took 10806ms.
[13:46:13.863] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:46:14.140] <TB2> INFO: PixTestAlive::aliveTest() done
[13:46:14.140] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:46:14.142] <TB2> INFO: ----------------------------------------------------------------------
[13:46:14.142] <TB2> 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:14.142] <TB2> INFO: ----------------------------------------------------------------------
[13:46:14.483] <TB2> INFO: Expecting 208000 events.
[13:46:21.597] <TB2> INFO: 208000 events read in total (6398ms).
[13:46:21.598] <TB2> INFO: Test took 7453ms.
[13:46:21.598] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:46:21.599] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:46:21.923] <TB2> INFO: PixTestAlive::maskTest() done
[13:46:21.923] <TB2> 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:21.925] <TB2> INFO: ----------------------------------------------------------------------
[13:46:21.925] <TB2> 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:21.925] <TB2> INFO: ----------------------------------------------------------------------
[13:46:22.253] <TB2> INFO: Expecting 208000 events.
[13:46:32.760] <TB2> INFO: 208000 events read in total (9791ms).
[13:46:32.760] <TB2> INFO: Test took 10833ms.
[13:46:32.766] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:46:33.019] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:46:33.019] <TB2> 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:33.019] <TB2> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[13:46:33.069] <TB2> INFO: enter test to run
[13:46:33.069] <TB2> INFO: test: delay setting parameters: ->2<-
[13:46:33.069] <TB2> INFO: delay test by 2 seconds...
[13:46:35.069] <TB2> INFO: enter test to run
[13:46:35.069] <TB2> INFO: test: HighRate no parameter change
[13:46:35.069] <TB2> INFO: running: highrate
[13:46:35.069] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//016_HREfficiency_200//phCalibrationFitErr35_C15.dat
[13:46:35.206] <TB2> INFO: ----------------------------------------------------------------------
[13:46:35.206] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:46:35.206] <TB2> INFO: ----------------------------------------------------------------------
[13:46:35.808] <TB2> INFO: Expecting 208000 events.
[13:47:03.724] <TB2> INFO: 208000 events read in total (27388ms).
[13:47:03.742] <TB2> INFO: Test took 28532ms.
[13:47:04.798] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:05.339] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[13:47:05.339] <TB2> INFO: number of red-efficiency pixels: 1433 1399 1261 3196 3018 3914 3585 3807 3889 3742 3641 3333 3436 1541 2118 1507
[13:47:05.339] <TB2> INFO: number of X-ray hits detected: 418489 427625 385606 699126 661938 879685 787075 805452 869180 826376 790798 736104 747492 437585 464311 429823
[13:47:05.339] <TB2> 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:47:05.339] <TB2> INFO: number of Vcal hits detected: 205839 206137 205029 199690 200400 192017 195845 196181 193668 194730 196348 198353 198343 203917 204818 205959
[13:47:05.339] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.2 99.2 98.9 96.5 96.9 93.1 94.9 94.8 93.7 94.3 95.0 96.0 95.9 98.4 98.6 99.1
[13:47:05.339] <TB2> INFO: Vcal hit overall efficiency (%): 99.0 99.1 98.6 96.0 96.3 92.3 94.2 94.3 93.1 93.6 94.4 95.4 95.4 98.0 98.5 99.0
[13:47:05.339] <TB2> INFO: X-ray hit rate [MHz/cm2]: 122.7 125.3 113.0 204.9 194.0 257.8 230.7 236.1 254.8 242.2 231.8 215.8 219.1 128.3 136.1 126.0
[13:47:05.339] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[13:47:05.384] <TB2> INFO: PixTest:: pg_setup set to default.
[13:47:05.395] <TB2> INFO: enter test to run
[13:47:05.395] <TB2> INFO: test: no parameter change
[13:47:05.639] <TB2> QUIET: Connection to board 162 closed.
[13:47:05.718] <TB2> INFO: pXar: this is the end, my friend

[13:47:19.715] <TB2> INFO: *** Welcome to pxar ***
[13:47:19.715] <TB2> INFO: *** Today: 2016/01/22
[13:47:19.782] <TB2> INFO: *** Version: 9751
[13:47:19.782] <TB2> INFO: readRocDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//dacParameters35_C15.dat
[13:47:19.783] <TB2> INFO: readTbmDacs: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//tbmParameters_C0b.dat
[13:47:19.783] <TB2> INFO: readMaskFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//defaultMaskFile.dat
[13:47:19.783] <TB2> INFO: readTrimFile: /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//trimParameters35_C15.dat
[13:47:19.855] <TB2> INFO: clk: 4
[13:47:19.855] <TB2> INFO: ctr: 4
[13:47:19.855] <TB2> INFO: sda: 19
[13:47:19.855] <TB2> INFO: tin: 9
[13:47:19.855] <TB2> INFO: level: 15
[13:47:19.855] <TB2> INFO: triggerdelay: 0
[13:47:19.855] <TB2> QUIET: Instanciating API for pxar prod-12
[13:47:19.855] <TB2> INFO: Log level: INFO
[13:47:19.867] <TB2> INFO: Found DTB DTB_WXENWR
[13:47:19.876] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:47:19.879] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[13:47:19.882] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:47:21.424] <TB2> INFO: DUT info:
[13:47:21.424] <TB2> INFO: The DUT currently contains the following objects:
[13:47:21.424] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:47:21.424] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:47:21.424] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:47:21.424] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:47:21.424] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.424] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:47:21.826] <TB2> INFO: enter 'restricted' command line mode
[13:47:21.826] <TB2> INFO: enter test to run
[13:47:21.826] <TB2> INFO: test: PixelAlive no parameter change
[13:47:21.826] <TB2> INFO: running: pixelalive
[13:47:21.831] <TB2> INFO: ######################################################################
[13:47:21.831] <TB2> INFO: PixTestAlive::doTest()
[13:47:21.831] <TB2> INFO: ######################################################################
[13:47:21.833] <TB2> INFO: ----------------------------------------------------------------------
[13:47:21.833] <TB2> 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:21.833] <TB2> INFO: ----------------------------------------------------------------------
[13:47:22.146] <TB2> INFO: Expecting 208000 events.
[13:47:33.588] <TB2> INFO: 208000 events read in total (10723ms).
[13:47:33.596] <TB2> INFO: Test took 11760ms.
[13:47:33.651] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:33.918] <TB2> INFO: PixTestAlive::aliveTest() done
[13:47:33.918] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:47:33.920] <TB2> INFO: ----------------------------------------------------------------------
[13:47:33.920] <TB2> 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:33.920] <TB2> INFO: ----------------------------------------------------------------------
[13:47:34.242] <TB2> INFO: Expecting 208000 events.
[13:47:41.831] <TB2> INFO: 208000 events read in total (6872ms).
[13:47:41.832] <TB2> INFO: Test took 7910ms.
[13:47:41.832] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:41.832] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:47:42.160] <TB2> INFO: PixTestAlive::maskTest() done
[13:47:42.160] <TB2> 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:42.162] <TB2> INFO: ----------------------------------------------------------------------
[13:47:42.162] <TB2> 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:42.162] <TB2> INFO: ----------------------------------------------------------------------
[13:47:42.473] <TB2> INFO: Expecting 208000 events.
[13:47:53.481] <TB2> INFO: 208000 events read in total (10291ms).
[13:47:53.482] <TB2> INFO: Test took 11317ms.
[13:47:53.488] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:47:53.735] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:47:53.735] <TB2> 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:53.736] <TB2> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[13:47:53.776] <TB2> INFO: enter test to run
[13:47:53.776] <TB2> INFO: test: delay setting parameters: ->2<-
[13:47:53.776] <TB2> INFO: delay test by 2 seconds...
[13:47:55.776] <TB2> INFO: enter test to run
[13:47:55.777] <TB2> INFO: test: HighRate no parameter change
[13:47:55.777] <TB2> INFO: running: highrate
[13:47:55.777] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2143_XrayQualification_2016-01-22_13h53m_1453467220//017_HREfficiency_250//phCalibrationFitErr35_C15.dat
[13:47:55.923] <TB2> INFO: ----------------------------------------------------------------------
[13:47:55.923] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:47:55.923] <TB2> INFO: ----------------------------------------------------------------------
[13:47:56.525] <TB2> INFO: Expecting 208000 events.
[13:48:28.404] <TB2> INFO: 190450 events read in total (31351ms).
[13:48:31.439] <TB2> INFO: 208000 events read in total (34386ms).
[13:48:31.458] <TB2> INFO: Test took 35531ms.
[13:48:32.738] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:48:33.355] <TB2> INFO: number of dead pixels (per ROC): 5 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[13:48:33.355] <TB2> INFO: number of red-efficiency pixels: 2176 2151 1728 3820 3767 4133 4009 4119 4128 4080 4071 3889 3969 1954 2959 2195
[13:48:33.355] <TB2> INFO: number of X-ray hits detected: 516961 528031 475660 861328 812424 1082230 967130 987519 1067780 1015344 972886 905285 918957 543491 573806 532492
[13:48:33.355] <TB2> 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:33.355] <TB2> INFO: number of Vcal hits detected: 204190 204564 202581 192726 193929 178970 186223 185861 181143 183667 186420 190341 189862 200447 202176 204376
[13:48:33.355] <TB2> INFO: Vcal hit fiducial efficiency (%): 98.5 98.5 97.9 93.5 94.0 87.3 90.7 90.1 88.0 89.5 90.7 92.5 92.2 97.0 97.4 98.4
[13:48:33.355] <TB2> INFO: Vcal hit overall efficiency (%): 98.2 98.3 97.4 92.7 93.2 86.0 89.5 89.4 87.1 88.3 89.6 91.5 91.3 96.4 97.2 98.3
[13:48:33.355] <TB2> INFO: X-ray hit rate [MHz/cm2]: 151.5 154.8 139.4 252.5 238.1 317.2 283.5 289.4 313.0 297.6 285.2 265.3 269.4 159.3 168.2 156.1
[13:48:33.355] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[13:48:33.399] <TB2> INFO: PixTest:: pg_setup set to default.
[13:48:33.411] <TB2> INFO: enter test to run
[13:48:33.411] <TB2> INFO: test: no parameter change
[13:48:33.698] <TB2> QUIET: Connection to board 162 closed.
[13:48:33.777] <TB2> INFO: pXar: this is the end, my friend