[13:12:06.866] <TB2> INFO: *** Welcome to pxar ***
[13:12:06.866] <TB2> INFO: *** Today: 2016/01/18
[13:12:06.923] <TB2> INFO: *** Version: b2d3
[13:12:06.923] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//000_PixelAlive_p17//dacParameters35_C15.dat
[13:12:06.924] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//000_PixelAlive_p17//tbmParameters_C0b.dat
[13:12:06.924] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//000_PixelAlive_p17//defaultMaskFile.dat
[13:12:06.924] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//000_PixelAlive_p17//trimParameters35_C15.dat
[13:12:06.995] <TB2> INFO: clk: 4
[13:12:06.995] <TB2> INFO: ctr: 4
[13:12:06.995] <TB2> INFO: sda: 19
[13:12:06.995] <TB2> INFO: tin: 9
[13:12:06.995] <TB2> INFO: level: 15
[13:12:06.995] <TB2> INFO: triggerdelay: 0
[13:12:06.995] <TB2> QUIET: Instanciating API for pxar prod-12
[13:12:06.995] <TB2> INFO: Log level: INFO
[13:12:07.007] <TB2> INFO: Found DTB DTB_WXENWR
[13:12:07.016] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:12:07.020] <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:12:07.022] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:12:08.562] <TB2> INFO: DUT info:
[13:12:08.562] <TB2> INFO: The DUT currently contains the following objects:
[13:12:08.562] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:12:08.562] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:12:08.562] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:12:08.562] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:12:08.562] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.562] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:12:08.963] <TB2> INFO: enter 'restricted' command line mode
[13:12:08.963] <TB2> INFO: enter test to run
[13:12:08.963] <TB2> INFO: test: PixelAlive no parameter change
[13:12:08.963] <TB2> INFO: running: pixelalive
[13:12:08.968] <TB2> INFO: ######################################################################
[13:12:08.968] <TB2> INFO: PixTestAlive::doTest()
[13:12:08.968] <TB2> INFO: ######################################################################
[13:12:08.969] <TB2> INFO: ----------------------------------------------------------------------
[13:12:08.969] <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)
[13:12:08.969] <TB2> INFO: ----------------------------------------------------------------------
[13:12:09.274] <TB2> INFO: Expecting 41600 events.
[13:12:13.542] <TB2> INFO: 41600 events read in total (3548ms).
[13:12:13.622] <TB2> INFO: Test took 4650ms.
[13:12:13.628] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:12:13.893] <TB2> INFO: PixTestAlive::aliveTest() done
[13:12:13.893] <TB2> INFO: number of dead pixels (per ROC): 6 0 0 2 1 1 0 0 0 0 1 0 0 0 0 0
[13:12:13.894] <TB2> INFO: ----------------------------------------------------------------------
[13:12:13.894] <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)
[13:12:13.894] <TB2> INFO: ----------------------------------------------------------------------
[13:12:14.192] <TB2> INFO: Expecting 41600 events.
[13:12:17.287] <TB2> INFO: 41600 events read in total (2379ms).
[13:12:17.287] <TB2> INFO: Test took 3391ms.
[13:12:17.287] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:12:17.288] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:12:17.617] <TB2> INFO: PixTestAlive::maskTest() done
[13:12:17.617] <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:12:17.619] <TB2> INFO: ----------------------------------------------------------------------
[13:12:17.619] <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)
[13:12:17.619] <TB2> INFO: ----------------------------------------------------------------------
[13:12:17.927] <TB2> INFO: Expecting 41600 events.
[13:12:22.110] <TB2> INFO: 41600 events read in total (3466ms).
[13:12:22.111] <TB2> INFO: Test took 4490ms.
[13:12:22.120] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:12:22.425] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:12:22.425] <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:12:22.425] <TB2> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[13:12:22.454] <TB2> INFO: enter test to run
[13:12:22.454] <TB2> INFO: test: no parameter change
[13:12:22.581] <TB2> QUIET: Connection to board 162 closed.
[13:12:22.660] <TB2> INFO: pXar: this is the end, my friend

[13:17:39.669] <TB2> INFO: *** Welcome to pxar ***
[13:17:39.669] <TB2> INFO: *** Today: 2016/01/18
[13:17:39.730] <TB2> INFO: *** Version: b2d3
[13:17:39.730] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//dacParameters35_C15.dat
[13:17:39.730] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[13:17:39.730] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//defaultMaskFile.dat
[13:17:39.731] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C15.dat
[13:17:39.814] <TB2> INFO: clk: 4
[13:17:39.814] <TB2> INFO: ctr: 4
[13:17:39.814] <TB2> INFO: sda: 19
[13:17:39.814] <TB2> INFO: tin: 9
[13:17:39.814] <TB2> INFO: level: 15
[13:17:39.814] <TB2> INFO: triggerdelay: 0
[13:17:39.814] <TB2> QUIET: Instanciating API for pxar prod-12
[13:17:39.815] <TB2> INFO: Log level: INFO
[13:17:39.827] <TB2> INFO: Found DTB DTB_WXENWR
[13:17:39.836] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:17:39.839] <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:17:39.842] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:17:41.390] <TB2> INFO: DUT info:
[13:17:41.391] <TB2> INFO: The DUT currently contains the following objects:
[13:17:41.391] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:17:41.391] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:17:41.391] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:17:41.391] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:17:41.391] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.391] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:17:41.792] <TB2> INFO: enter 'restricted' command line mode
[13:17:41.792] <TB2> INFO: enter test to run
[13:17:41.792] <TB2> INFO: test: delay setting parameters: ->5<-
[13:17:41.792] <TB2> INFO: delay test by 5 seconds...
[13:17:46.792] <TB2> INFO: enter test to run
[13:17:46.792] <TB2> INFO: test: highrate no parameter change
[13:17:46.792] <TB2> INFO: running: highrate
[13:17:46.792] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[13:17:46.942] <TB2> INFO: ----------------------------------------------------------------------
[13:17:46.942] <TB2> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[13:17:46.942] <TB2> INFO: ----------------------------------------------------------------------
[13:17:46.943] <TB2> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[13:17:46.943] <TB2> INFO: edge/corner pixel THR is adjusted
[13:17:46.943] <TB2> INFO: PixTestHighRate::trimHotPixels: step 0...
[13:17:47.905] <TB2> INFO: Collecting data for 1 seconds...
[13:17:48.906] <TB2> INFO: Done with hot pixel readout
[13:17:55.479] <TB2> INFO: PixTest:: pg_setup set to default.

[13:17:55.480] <TB2> INFO: 15 hot pixels found in step 0
[13:17:56.447] <TB2> INFO: Collecting data for 1 seconds...
[13:17:57.448] <TB2> INFO: Done with hot pixel readout
[13:18:03.958] <TB2> INFO: PixTest:: pg_setup set to default.

[13:18:03.959] <TB2> INFO: 15 hot pixels found in step 1
[13:18:04.925] <TB2> INFO: Collecting data for 1 seconds...
[13:18:05.926] <TB2> INFO: Done with hot pixel readout
[13:18:12.503] <TB2> INFO: PixTest:: pg_setup set to default.

[13:18:12.504] <TB2> INFO: 13 hot pixels found in step 2
[13:18:13.471] <TB2> INFO: Collecting data for 1 seconds...
[13:18:14.472] <TB2> INFO: Done with hot pixel readout
[13:18:21.058] <TB2> INFO: PixTest:: pg_setup set to default.


[13:18:21.059] <TB2> INFO: 11 hot pixels found in step 3
[13:18:22.026] <TB2> INFO: Collecting data for 1 seconds...
[13:18:23.028] <TB2> INFO: Done with hot pixel readout
[13:18:29.275] <TB2> INFO: PixTest:: pg_setup set to default.



[13:18:29.276] <TB2> INFO: 11 hot pixels found in step 4
[13:18:30.242] <TB2> INFO: Collecting data for 1 seconds...
[13:18:31.243] <TB2> INFO: Done with hot pixel readout
[13:18:37.478] <TB2> INFO: PixTest:: pg_setup set to default.



[13:18:37.478] <TB2> INFO: 10 hot pixels found in step 5
[13:18:38.444] <TB2> INFO: Collecting data for 1 seconds...
[13:18:39.445] <TB2> INFO: Done with hot pixel readout
[13:18:45.705] <TB2> INFO: PixTest:: pg_setup set to default.





[13:18:45.706] <TB2> INFO: 10 hot pixels found in step 6
[13:18:46.673] <TB2> INFO: Collecting data for 1 seconds...
[13:18:47.674] <TB2> INFO: Done with hot pixel readout
[13:18:53.936] <TB2> INFO: PixTest:: pg_setup set to default.






[13:18:53.937] <TB2> INFO: 10 hot pixels found in step 7
[13:18:54.902] <TB2> INFO: Collecting data for 1 seconds...
[13:18:55.903] <TB2> INFO: Done with hot pixel readout
[13:19:02.183] <TB2> INFO: PixTest:: pg_setup set to default.






[13:19:02.184] <TB2> INFO: 10 hot pixels found in step 8
[13:19:03.149] <TB2> INFO: Collecting data for 1 seconds...
[13:19:04.150] <TB2> INFO: Done with hot pixel readout
[13:19:10.412] <TB2> INFO: PixTest:: pg_setup set to default.








[13:19:10.413] <TB2> INFO: 10 hot pixels found in step 9
[13:19:11.381] <TB2> INFO: Collecting data for 1 seconds...
[13:19:12.381] <TB2> INFO: Done with hot pixel readout
[13:19:18.650] <TB2> INFO: PixTest:: pg_setup set to default.









[13:19:18.652] <TB2> INFO: 10 hot pixels found in step 10
[13:19:19.619] <TB2> INFO: Collecting data for 1 seconds...
[13:19:20.620] <TB2> INFO: Done with hot pixel readout
[13:19:26.900] <TB2> INFO: PixTest:: pg_setup set to default.









[13:19:26.901] <TB2> INFO: 10 hot pixels found in step 11
[13:19:27.868] <TB2> INFO: Collecting data for 1 seconds...
[13:19:28.869] <TB2> INFO: Done with hot pixel readout
[13:19:35.105] <TB2> INFO: PixTest:: pg_setup set to default.









[13:19:35.106] <TB2> INFO: 10 hot pixels found in step 12
[13:19:36.073] <TB2> INFO: Collecting data for 1 seconds...
[13:19:37.074] <TB2> INFO: Done with hot pixel readout
[13:19:43.336] <TB2> INFO: PixTest:: pg_setup set to default.










[13:19:43.337] <TB2> INFO: 10 hot pixels found in step 13
[13:19:43.346] <TB2> INFO: 10 hot pixels could not be trimmed and have been masked.
[13:19:43.375] <TB2> INFO: PixTest::trimHotPixels() done
[13:19:43.375] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C0.dat
[13:19:43.382] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C1.dat
[13:19:43.388] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C2.dat
[13:19:43.394] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C3.dat
[13:19:43.400] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C4.dat
[13:19:43.406] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C5.dat
[13:19:43.412] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C6.dat
[13:19:43.418] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C7.dat
[13:19:43.424] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C8.dat
[13:19:43.430] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C9.dat
[13:19:43.436] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C10.dat
[13:19:43.442] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C11.dat
[13:19:43.448] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C12.dat
[13:19:43.454] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C13.dat
[13:19:43.460] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C14.dat
[13:19:43.466] <TB2> INFO: write trim parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//trimParameters35_C15.dat
[13:19:43.472] <TB2> INFO: write masked pixels into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//002_RetrimHotPixels_150//defaultMaskFile.dat
[13:19:43.506] <TB2> INFO: enter test to run
[13:19:43.506] <TB2> INFO: test: no parameter change
[13:19:43.663] <TB2> QUIET: Connection to board 162 closed.
[13:19:43.743] <TB2> INFO: pXar: this is the end, my friend

[13:20:07.487] <TB2> INFO: *** Welcome to pxar ***
[13:20:07.487] <TB2> INFO: *** Today: 2016/01/18
[13:20:07.552] <TB2> INFO: *** Version: b2d3
[13:20:07.552] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//dacParameters35_C15.dat
[13:20:07.553] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//tbmParameters_C0b.dat
[13:20:07.553] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//defaultMaskFile.dat
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[13:20:07.553] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[13:20:07.553] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//trimParameters35_C15.dat
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 28 26
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 28 27
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 29 25
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 29 26
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 29 27
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 29 28
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 30 25
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 30 26
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 30 27
[13:20:07.553] <TB2> INFO: masking Roc 0 col/row: 30 28
[13:20:07.631] <TB2> INFO: clk: 4
[13:20:07.631] <TB2> INFO: ctr: 4
[13:20:07.631] <TB2> INFO: sda: 19
[13:20:07.631] <TB2> INFO: tin: 9
[13:20:07.631] <TB2> INFO: level: 15
[13:20:07.631] <TB2> INFO: triggerdelay: 0
[13:20:07.631] <TB2> QUIET: Instanciating API for pxar prod-12
[13:20:07.631] <TB2> INFO: Log level: INFO
[13:20:07.644] <TB2> INFO: Found DTB DTB_WXENWR
[13:20:07.653] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:20:07.656] <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:20:07.659] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:20:09.226] <TB2> INFO: DUT info:
[13:20:09.226] <TB2> INFO: The DUT currently contains the following objects:
[13:20:09.226] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:20:09.226] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:20:09.226] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:20:09.226] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:20:09.226] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[13:20:09.226] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.226] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.226] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.226] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.227] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:20:09.627] <TB2> INFO: enter 'restricted' command line mode
[13:20:09.627] <TB2> INFO: enter test to run
[13:20:09.628] <TB2> INFO: test: delay setting parameters: ->5<-
[13:20:09.628] <TB2> INFO: delay test by 5 seconds...
[13:20:14.628] <TB2> INFO: enter test to run
[13:20:14.628] <TB2> INFO: test: Xray no parameter change
[13:20:14.628] <TB2> INFO: running: xray
[13:20:14.628] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//003_HRData_50//phCalibrationFitErr35_C15.dat
[13:20:14.817] <TB2> INFO: ######################################################################
[13:20:14.817] <TB2> INFO: PixTestXray::doTest()
[13:20:14.817] <TB2> INFO: ######################################################################
[13:20:14.817] <TB2> INFO: ----------------------------------------------------------------------
[13:20:14.817] <TB2> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[13:20:14.817] <TB2> INFO: ----------------------------------------------------------------------
[13:20:14.821] <TB2> INFO: ROC 0 masking pixel 28/26
[13:20:14.821] <TB2> INFO: ROC 0 masking pixel 28/27
[13:20:14.821] <TB2> INFO: ROC 0 masking pixel 29/25
[13:20:14.821] <TB2> INFO: ROC 0 masking pixel 29/26
[13:20:14.821] <TB2> INFO: ROC 0 masking pixel 29/27
[13:20:14.822] <TB2> INFO: ROC 0 masking pixel 29/28
[13:20:14.822] <TB2> INFO: ROC 0 masking pixel 30/25
[13:20:14.822] <TB2> INFO: ROC 0 masking pixel 30/26
[13:20:14.822] <TB2> INFO: ROC 0 masking pixel 30/27
[13:20:14.822] <TB2> INFO: ROC 0 masking pixel 30/28
[13:20:15.788] <TB2> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[13:20:21.538] <TB2> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[13:20:45.664] <TB2> INFO: Resuming triggers.
[13:20:51.424] <TB2> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[13:21:16.420] <TB2> INFO: Resuming triggers.
[13:21:22.179] <TB2> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[13:21:46.268] <TB2> INFO: Resuming triggers.
[13:21:52.024] <TB2> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[13:22:15.852] <TB2> INFO: Resuming triggers.
[13:22:21.611] <TB2> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[13:22:46.749] <TB2> INFO: Resuming triggers.
[13:22:52.509] <TB2> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[13:23:17.154] <TB2> INFO: Resuming triggers.
[13:23:22.911] <TB2> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[13:23:47.812] <TB2> INFO: Resuming triggers.
[13:23:53.567] <TB2> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[13:24:18.220] <TB2> INFO: Resuming triggers.
[13:24:23.977] <TB2> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[13:24:48.989] <TB2> INFO: Resuming triggers.
[13:24:54.744] <TB2> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[13:25:19.046] <TB2> INFO: Resuming triggers.
[13:25:24.792] <TB2> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[13:25:50.133] <TB2> INFO: Resuming triggers.
[13:25:55.885] <TB2> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[13:26:20.122] <TB2> INFO: Resuming triggers.
[13:26:25.875] <TB2> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[13:26:50.268] <TB2> INFO: Resuming triggers.
[13:26:56.015] <TB2> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[13:27:20.823] <TB2> INFO: Resuming triggers.
[13:27:26.567] <TB2> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[13:27:51.862] <TB2> INFO: Resuming triggers.
[13:27:57.610] <TB2> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[13:28:22.860] <TB2> INFO: Resuming triggers.
[13:28:28.606] <TB2> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[13:28:52.154] <TB2> INFO: Resuming triggers.
[13:28:54.408] <TB2> INFO: data taking finished, elapsed time: 100 seconds.
[13:29:04.026] <TB2> INFO: PixTest:: pg_setup set to default.
[13:29:04.027] <TB2> INFO: PixTestXray::doPhRun() done
[13:29:04.027] <TB2> INFO: PixTestXray::doTest() done
[13:29:04.216] <TB2> INFO: enter test to run
[13:29:04.216] <TB2> INFO: test: no parameter change
[13:29:04.473] <TB2> QUIET: Connection to board 162 closed.
[13:29:04.553] <TB2> INFO: pXar: this is the end, my friend

[13:30:51.263] <TB2> INFO: *** Welcome to pxar ***
[13:30:51.263] <TB2> INFO: *** Today: 2016/01/18
[13:30:51.326] <TB2> INFO: *** Version: b2d3
[13:30:51.326] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//dacParameters35_C15.dat
[13:30:51.327] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//tbmParameters_C0b.dat
[13:30:51.327] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//defaultMaskFile.dat
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[13:30:51.328] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[13:30:51.328] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//trimParameters35_C15.dat
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 28 26
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 28 27
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 29 25
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 29 26
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 29 27
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 29 28
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 30 25
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 30 26
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 30 27
[13:30:51.328] <TB2> INFO: masking Roc 0 col/row: 30 28
[13:30:51.414] <TB2> INFO: clk: 4
[13:30:51.414] <TB2> INFO: ctr: 4
[13:30:51.414] <TB2> INFO: sda: 19
[13:30:51.414] <TB2> INFO: tin: 9
[13:30:51.414] <TB2> INFO: level: 15
[13:30:51.414] <TB2> INFO: triggerdelay: 0
[13:30:51.414] <TB2> QUIET: Instanciating API for pxar prod-12
[13:30:51.414] <TB2> INFO: Log level: INFO
[13:30:51.428] <TB2> INFO: Found DTB DTB_WXENWR
[13:30:51.437] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:30:51.440] <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:30:51.442] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:30:52.986] <TB2> INFO: DUT info:
[13:30:52.986] <TB2> INFO: The DUT currently contains the following objects:
[13:30:52.986] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:30:52.987] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:30:52.987] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:30:52.987] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:30:52.987] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:52.987] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:30:53.389] <TB2> INFO: enter 'restricted' command line mode
[13:30:53.389] <TB2> INFO: enter test to run
[13:30:53.389] <TB2> INFO: test: delay setting parameters: ->5<-
[13:30:53.389] <TB2> INFO: delay test by 5 seconds...
[13:30:58.389] <TB2> INFO: enter test to run
[13:30:58.389] <TB2> INFO: test: Xray no parameter change
[13:30:58.389] <TB2> INFO: running: xray
[13:30:58.389] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//004_HRData_150//phCalibrationFitErr35_C15.dat
[13:30:58.596] <TB2> INFO: ######################################################################
[13:30:58.596] <TB2> INFO: PixTestXray::doTest()
[13:30:58.596] <TB2> INFO: ######################################################################
[13:30:58.596] <TB2> INFO: ----------------------------------------------------------------------
[13:30:58.596] <TB2> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[13:30:58.596] <TB2> INFO: ----------------------------------------------------------------------
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 28/26
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 28/27
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 29/25
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 29/26
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 29/27
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 29/28
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 30/25
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 30/26
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 30/27
[13:30:58.601] <TB2> INFO: ROC 0 masking pixel 30/28
[13:30:59.567] <TB2> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[13:31:02.549] <TB2> INFO: run duration 2 seconds, buffer almost full (81%), pausing triggers.
[13:31:27.953] <TB2> INFO: Resuming triggers.
[13:31:30.944] <TB2> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[13:31:56.406] <TB2> INFO: Resuming triggers.
[13:31:59.397] <TB2> INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[13:32:24.889] <TB2> INFO: Resuming triggers.
[13:32:27.881] <TB2> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[13:32:53.697] <TB2> INFO: Resuming triggers.
[13:32:56.690] <TB2> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[13:33:22.132] <TB2> INFO: Resuming triggers.
[13:33:25.125] <TB2> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[13:33:50.740] <TB2> INFO: Resuming triggers.
[13:33:53.732] <TB2> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[13:34:20.093] <TB2> INFO: Resuming triggers.
[13:34:23.082] <TB2> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[13:34:48.883] <TB2> INFO: Resuming triggers.
[13:34:51.870] <TB2> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[13:35:16.863] <TB2> INFO: Resuming triggers.
[13:35:19.853] <TB2> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[13:35:44.581] <TB2> INFO: Resuming triggers.
[13:35:47.571] <TB2> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[13:36:12.790] <TB2> INFO: Resuming triggers.
[13:36:15.781] <TB2> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[13:36:41.230] <TB2> INFO: Resuming triggers.
[13:36:44.217] <TB2> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[13:37:09.123] <TB2> INFO: Resuming triggers.
[13:37:12.115] <TB2> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[13:37:37.222] <TB2> INFO: Resuming triggers.
[13:37:40.210] <TB2> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[13:38:05.239] <TB2> INFO: Resuming triggers.
[13:38:08.226] <TB2> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[13:38:34.250] <TB2> INFO: Resuming triggers.
[13:38:37.238] <TB2> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[13:39:02.366] <TB2> INFO: Resuming triggers.
[13:39:05.354] <TB2> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[13:39:30.334] <TB2> INFO: Resuming triggers.
[13:39:33.323] <TB2> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[13:39:58.784] <TB2> INFO: Resuming triggers.
[13:40:01.774] <TB2> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[13:40:27.547] <TB2> INFO: Resuming triggers.
[13:40:30.534] <TB2> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[13:40:55.944] <TB2> INFO: Resuming triggers.
[13:40:58.928] <TB2> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[13:41:23.734] <TB2> INFO: Resuming triggers.
[13:41:26.720] <TB2> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[13:41:51.754] <TB2> INFO: Resuming triggers.
[13:41:54.742] <TB2> INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[13:42:20.605] <TB2> INFO: Resuming triggers.
[13:42:23.593] <TB2> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[13:42:50.763] <TB2> INFO: Resuming triggers.
[13:42:53.749] <TB2> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[13:43:19.464] <TB2> INFO: Resuming triggers.
[13:43:22.449] <TB2> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[13:43:48.329] <TB2> INFO: Resuming triggers.
[13:43:51.315] <TB2> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[13:44:16.774] <TB2> INFO: Resuming triggers.
[13:44:19.758] <TB2> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[13:44:44.739] <TB2> INFO: Resuming triggers.
[13:44:47.725] <TB2> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[13:45:13.927] <TB2> INFO: Resuming triggers.
[13:45:16.911] <TB2> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[13:45:41.342] <TB2> INFO: Resuming triggers.
[13:45:44.325] <TB2> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[13:46:08.519] <TB2> INFO: Resuming triggers.
[13:46:11.503] <TB2> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[13:46:35.512] <TB2> INFO: Resuming triggers.
[13:46:36.970] <TB2> INFO: data taking finished, elapsed time: 100 seconds.
[13:46:50.051] <TB2> INFO: PixTest:: pg_setup set to default.
[13:46:50.052] <TB2> INFO: PixTestXray::doPhRun() done
[13:46:50.052] <TB2> INFO: PixTestXray::doTest() done
[13:46:50.270] <TB2> INFO: enter test to run
[13:46:50.270] <TB2> INFO: test: no parameter change
[13:46:50.488] <TB2> QUIET: Connection to board 162 closed.
[13:46:50.572] <TB2> INFO: pXar: this is the end, my friend

[13:49:21.192] <TB2> INFO: *** Welcome to pxar ***
[13:49:21.192] <TB2> INFO: *** Today: 2016/01/18
[13:49:21.251] <TB2> INFO: *** Version: b2d3
[13:49:21.251] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//dacParameters35_C15.dat
[13:49:21.251] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//tbmParameters_C0b.dat
[13:49:21.251] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//defaultMaskFile.dat
[13:49:21.251] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[13:49:21.251] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[13:49:21.251] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[13:49:21.251] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[13:49:21.251] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[13:49:21.251] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[13:49:21.252] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[13:49:21.252] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[13:49:21.252] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[13:49:21.252] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[13:49:21.252] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//trimParameters35_C15.dat
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 28 26
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 28 27
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 29 25
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 29 26
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 29 27
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 29 28
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 30 25
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 30 26
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 30 27
[13:49:21.252] <TB2> INFO: masking Roc 0 col/row: 30 28
[13:49:21.325] <TB2> INFO: clk: 4
[13:49:21.325] <TB2> INFO: ctr: 4
[13:49:21.325] <TB2> INFO: sda: 19
[13:49:21.325] <TB2> INFO: tin: 9
[13:49:21.325] <TB2> INFO: level: 15
[13:49:21.325] <TB2> INFO: triggerdelay: 0
[13:49:21.325] <TB2> QUIET: Instanciating API for pxar prod-12
[13:49:21.325] <TB2> INFO: Log level: INFO
[13:49:21.338] <TB2> INFO: Found DTB DTB_WXENWR
[13:49:21.347] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[13:49:21.350] <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:49:21.353] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:49:22.913] <TB2> INFO: DUT info:
[13:49:22.913] <TB2> INFO: The DUT currently contains the following objects:
[13:49:22.913] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:49:22.913] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:49:22.913] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:49:22.913] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:49:22.913] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:22.913] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:49:23.314] <TB2> INFO: enter 'restricted' command line mode
[13:49:23.314] <TB2> INFO: enter test to run
[13:49:23.314] <TB2> INFO: test: Highrate no parameter change
[13:49:23.314] <TB2> INFO: running: highrate
[13:49:23.314] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[13:49:23.479] <TB2> INFO: ----------------------------------------------------------------------
[13:49:23.479] <TB2> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[13:49:23.479] <TB2> INFO: ----------------------------------------------------------------------
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 28/26
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 28/27
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 29/25
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 29/26
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 29/27
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 29/28
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 30/25
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 30/26
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 30/27
[13:49:23.486] <TB2> INFO: ROC 0 masking pixel 30/28
[13:49:23.487] <TB2> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[13:49:23.500] <TB2> INFO: dacScan step from 15 .. 34
[13:49:23.500] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[13:49:23.500] <TB2> INFO: run 1 of 1
[13:49:24.117] <TB2> INFO: Expecting 4160000 events.
[13:49:53.088] <TB2> INFO: 388000 events read in total (28440ms).
[13:50:20.904] <TB2> INFO: 777000 events read in total (56256ms).
[13:50:49.071] <TB2> INFO: 1166000 events read in total (84423ms).
[13:51:17.195] <TB2> INFO: 1554900 events read in total (112547ms).
[13:51:45.634] <TB2> INFO: 1944150 events read in total (140986ms).
[13:52:15.078] <TB2> INFO: 2333400 events read in total (170430ms).
[13:52:43.707] <TB2> INFO: 2722600 events read in total (199059ms).
[13:53:12.157] <TB2> INFO: 3111650 events read in total (227509ms).
[13:53:40.612] <TB2> INFO: 3500550 events read in total (255964ms).
[13:54:09.647] <TB2> INFO: 3889150 events read in total (284999ms).
[13:54:30.205] <TB2> INFO: 4160000 events read in total (305557ms).
[13:54:30.554] <TB2> INFO: Test took 307054ms.
[13:54:34.575] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:54:41.351] <TB2> INFO: dacScan step from 35 .. 54
[13:54:41.351] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[13:54:41.351] <TB2> INFO: run 1 of 1
[13:54:41.948] <TB2> INFO: Expecting 4160000 events.
[13:55:10.412] <TB2> INFO: 342750 events read in total (27937ms).
[13:55:38.063] <TB2> INFO: 685700 events read in total (55588ms).
[13:56:05.583] <TB2> INFO: 1028150 events read in total (83108ms).
[13:56:32.714] <TB2> INFO: 1369750 events read in total (110239ms).
[13:57:00.839] <TB2> INFO: 1709750 events read in total (138364ms).
[13:57:27.937] <TB2> INFO: 2048550 events read in total (165462ms).
[13:57:54.571] <TB2> INFO: 2385600 events read in total (192096ms).
[13:58:21.967] <TB2> INFO: 2720300 events read in total (219492ms).
[13:58:49.154] <TB2> INFO: 3052900 events read in total (246679ms).
[13:59:15.958] <TB2> INFO: 3383000 events read in total (273483ms).
[13:59:42.994] <TB2> INFO: 3711650 events read in total (300519ms).
[14:00:10.090] <TB2> INFO: 4039200 events read in total (327615ms).
[14:00:20.155] <TB2> INFO: 4160000 events read in total (337680ms).
[14:00:20.435] <TB2> INFO: Test took 339083ms.
[14:00:23.041] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:00:30.289] <TB2> INFO: dacScan step from 55 .. 74
[14:00:30.289] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[14:00:30.289] <TB2> INFO: run 1 of 1
[14:00:30.885] <TB2> INFO: Expecting 4160000 events.
[14:00:58.211] <TB2> INFO: 299150 events read in total (26798ms).
[14:01:24.942] <TB2> INFO: 598700 events read in total (53529ms).
[14:01:50.977] <TB2> INFO: 898250 events read in total (79564ms).
[14:02:17.171] <TB2> INFO: 1197950 events read in total (105758ms).
[14:02:42.914] <TB2> INFO: 1497550 events read in total (131501ms).
[14:03:09.508] <TB2> INFO: 1797100 events read in total (158096ms).
[14:03:35.665] <TB2> INFO: 2096650 events read in total (184252ms).
[14:04:01.501] <TB2> INFO: 2396200 events read in total (210088ms).
[14:04:28.082] <TB2> INFO: 2695700 events read in total (236669ms).
[14:04:54.004] <TB2> INFO: 2995050 events read in total (262591ms).
[14:05:20.311] <TB2> INFO: 3294500 events read in total (288898ms).
[14:05:46.688] <TB2> INFO: 3594250 events read in total (315275ms).
[14:06:13.506] <TB2> INFO: 3893900 events read in total (342093ms).
[14:06:37.263] <TB2> INFO: 4160000 events read in total (365850ms).
[14:06:37.504] <TB2> INFO: Test took 367215ms.
[14:06:39.610] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:06:46.391] <TB2> INFO: dacScan step from 75 .. 75
[14:06:46.391] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[14:06:46.391] <TB2> INFO: run 1 of 1
[14:06:46.988] <TB2> INFO: Expecting 208000 events.
[14:07:06.589] <TB2> INFO: 208000 events read in total (19073ms).
[14:07:06.597] <TB2> INFO: Test took 20206ms.
[14:07:06.696] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:07:07.008] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:08.183] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:09.246] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:10.343] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:11.476] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:12.597] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:13.723] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:14.853] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:15.990] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:17.160] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:18.365] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:19.476] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:20.567] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:21.653] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:22.732] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:23.904] <TB2> INFO: dumping ASCII scurve output file: XSCurveData
[14:07:24.986] <TB2> INFO: PixTest:: pg_setup set to default.
[14:07:24.988] <TB2> INFO: vcal mean: 39.10 39.76 39.01 43.39 42.92 44.36 43.90 44.61 44.99 44.98 45.03 43.56 42.74 40.27 39.82 39.49
[14:07:24.988] <TB2> INFO: vcal RMS: 2.38 1.18 1.10 1.60 1.31 1.50 1.43 1.56 1.59 1.54 1.74 1.58 1.34 1.35 1.21 1.11
[14:07:24.988] <TB2> INFO: number of X-ray hits detected: 233351 240238 226427 412175 403235 491619 461799 506928 500149 505762 520251 421879 390497 243971 242852 230969
[14:07:24.988] <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
[14:07:24.988] <TB2> INFO: X-ray hit rate [MHz/cm2]: 68.4 70.4 66.4 120.8 118.2 144.1 135.4 148.6 146.6 148.2 152.5 123.7 114.5 71.5 71.2 67.7
[14:07:24.988] <TB2> INFO: PixTestHighRate::doXNoiseMaps() done
[14:07:25.114] <TB2> INFO: enter test to run
[14:07:25.114] <TB2> INFO: test: no parameter change
[14:07:25.343] <TB2> QUIET: Connection to board 162 closed.
[14:07:25.433] <TB2> INFO: pXar: this is the end, my friend

[14:31:14.904] <TB2> INFO: *** Welcome to pxar ***
[14:31:14.904] <TB2> INFO: *** Today: 2016/01/18
[14:31:14.965] <TB2> INFO: *** Version: b2d3
[14:31:14.965] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[14:31:14.966] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[14:31:14.966] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[14:31:14.966] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[14:31:14.966] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 28 26
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 28 27
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 29 25
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 29 26
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 29 27
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 29 28
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 30 25
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 30 26
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 30 27
[14:31:14.966] <TB2> INFO: masking Roc 0 col/row: 30 28
[14:31:15.041] <TB2> INFO: clk: 4
[14:31:15.041] <TB2> INFO: ctr: 4
[14:31:15.041] <TB2> INFO: sda: 19
[14:31:15.041] <TB2> INFO: tin: 9
[14:31:15.041] <TB2> INFO: level: 15
[14:31:15.041] <TB2> INFO: triggerdelay: 0
[14:31:15.041] <TB2> QUIET: Instanciating API for pxar prod-12
[14:31:15.041] <TB2> INFO: Log level: INFO
[14:31:15.054] <TB2> INFO: Found DTB DTB_WXENWR
[14:31:15.063] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:31:15.066] <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:31:15.069] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:31:16.633] <TB2> INFO: DUT info:
[14:31:16.633] <TB2> INFO: The DUT currently contains the following objects:
[14:31:16.633] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:31:16.633] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:31:16.633] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:31:16.633] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:31:16.633] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.633] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.634] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.634] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.634] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.634] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:16.634] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:31:17.034] <TB2> INFO: enter 'restricted' command line mode
[14:31:17.034] <TB2> INFO: enter test to run
[14:31:17.035] <TB2> INFO: test: HighRate no parameter change
[14:31:17.035] <TB2> INFO: running: highrate
[14:31:17.035] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[14:31:17.178] <TB2> INFO: ----------------------------------------------------------------------
[14:31:17.178] <TB2> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[14:31:17.178] <TB2> INFO: ----------------------------------------------------------------------
[14:31:17.318] <TB2> INFO: Expecting 768 events.
[14:31:18.547] <TB2> INFO: 768 events read in total (510ms).
[14:31:18.643] <TB2> INFO: Test took 1459ms.
[14:31:18.645] <TB2> INFO: ROC 0 masking pixel 28/26
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 28/27
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 29/25
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 29/26
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 29/27
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 29/28
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 30/25
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 30/26
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 30/27
[14:31:18.646] <TB2> INFO: ROC 0 masking pixel 30/28
[14:31:19.261] <TB2> INFO: Expecting 41600 events.
[14:31:22.934] <TB2> INFO: 41600 events read in total (3146ms).
[14:31:22.936] <TB2> INFO: Test took 4288ms.
[14:31:23.026] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:23.672] <TB2> INFO: Expecting 41600 events.
[14:31:27.401] <TB2> INFO: 41600 events read in total (3201ms).
[14:31:27.403] <TB2> INFO: Test took 4344ms.
[14:31:27.504] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:28.167] <TB2> INFO: Expecting 41600 events.
[14:31:31.920] <TB2> INFO: 41600 events read in total (3225ms).
[14:31:31.922] <TB2> INFO: Test took 4377ms.
[14:31:32.018] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:32.667] <TB2> INFO: Expecting 41600 events.
[14:31:36.441] <TB2> INFO: 41600 events read in total (3246ms).
[14:31:36.443] <TB2> INFO: Test took 4389ms.
[14:31:36.535] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:37.184] <TB2> INFO: Expecting 41600 events.
[14:31:40.946] <TB2> INFO: 41600 events read in total (3234ms).
[14:31:40.948] <TB2> INFO: Test took 4378ms.
[14:31:41.048] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:41.695] <TB2> INFO: Expecting 41600 events.
[14:31:45.531] <TB2> INFO: 41600 events read in total (3308ms).
[14:31:45.533] <TB2> INFO: Test took 4451ms.
[14:31:45.621] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:46.267] <TB2> INFO: Expecting 41600 events.
[14:31:50.125] <TB2> INFO: 41600 events read in total (3330ms).
[14:31:50.127] <TB2> INFO: Test took 4472ms.
[14:31:50.226] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:50.881] <TB2> INFO: Expecting 41600 events.
[14:31:54.725] <TB2> INFO: 41600 events read in total (3316ms).
[14:31:54.727] <TB2> INFO: Test took 4462ms.
[14:31:54.818] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:55.466] <TB2> INFO: Expecting 41600 events.
[14:31:59.269] <TB2> INFO: 41600 events read in total (3275ms).
[14:31:59.271] <TB2> INFO: Test took 4418ms.
[14:31:59.359] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:00.006] <TB2> INFO: Expecting 41600 events.
[14:32:03.839] <TB2> INFO: 41600 events read in total (3305ms).
[14:32:03.841] <TB2> INFO: Test took 4449ms.
[14:32:03.941] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:04.607] <TB2> INFO: Expecting 41600 events.
[14:32:08.511] <TB2> INFO: 41600 events read in total (3376ms).
[14:32:08.513] <TB2> INFO: Test took 4534ms.
[14:32:08.611] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:09.270] <TB2> INFO: Expecting 41600 events.
[14:32:13.236] <TB2> INFO: 41600 events read in total (3438ms).
[14:32:13.240] <TB2> INFO: Test took 4591ms.
[14:32:13.340] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:14.011] <TB2> INFO: Expecting 41600 events.
[14:32:17.790] <TB2> INFO: 41600 events read in total (3251ms).
[14:32:17.792] <TB2> INFO: Test took 4410ms.
[14:32:17.881] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:18.529] <TB2> INFO: Expecting 41600 events.
[14:32:22.371] <TB2> INFO: 41600 events read in total (3314ms).
[14:32:22.373] <TB2> INFO: Test took 4457ms.
[14:32:22.469] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:23.124] <TB2> INFO: Expecting 41600 events.
[14:32:27.035] <TB2> INFO: 41600 events read in total (3384ms).
[14:32:27.038] <TB2> INFO: Test took 4527ms.
[14:32:27.128] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:27.776] <TB2> INFO: Expecting 41600 events.
[14:32:31.634] <TB2> INFO: 41600 events read in total (3331ms).
[14:32:31.638] <TB2> INFO: Test took 4475ms.
[14:32:31.739] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:32.402] <TB2> INFO: Expecting 41600 events.
[14:32:36.204] <TB2> INFO: 41600 events read in total (3274ms).
[14:32:36.206] <TB2> INFO: Test took 4425ms.
[14:32:36.315] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:36.996] <TB2> INFO: Expecting 41600 events.
[14:32:40.763] <TB2> INFO: 41600 events read in total (3239ms).
[14:32:40.765] <TB2> INFO: Test took 4402ms.
[14:32:40.857] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:41.504] <TB2> INFO: Expecting 41600 events.
[14:32:45.234] <TB2> INFO: 41600 events read in total (3202ms).
[14:32:45.237] <TB2> INFO: Test took 4346ms.
[14:32:45.329] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:45.977] <TB2> INFO: Expecting 41600 events.
[14:32:49.581] <TB2> INFO: 41600 events read in total (3076ms).
[14:32:49.583] <TB2> INFO: Test took 4219ms.
[14:32:49.674] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:50.032] <TB2> INFO: enter test to run
[14:32:50.032] <TB2> INFO: test: Pretest no parameter change
[14:32:50.032] <TB2> INFO: running: pretest
[14:32:50.032] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[14:32:50.032] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[14:32:50.032] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[14:32:50.032] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[14:32:50.032] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[14:32:50.033] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[14:32:50.034] <TB2> INFO: write dac parameters into /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[14:32:50.034] <TB2> INFO: enter test to run
[14:32:50.034] <TB2> INFO: test: no parameter change
[14:32:50.243] <TB2> QUIET: Connection to board 162 closed.
[14:32:50.323] <TB2> INFO: pXar: this is the end, my friend

[14:33:25.892] <TB2> INFO: *** Welcome to pxar ***
[14:33:25.892] <TB2> INFO: *** Today: 2016/01/18
[14:33:25.956] <TB2> INFO: *** Version: b2d3
[14:33:25.957] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//dacParameters35_C15.dat
[14:33:25.957] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//tbmParameters_C0b.dat
[14:33:25.957] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//defaultMaskFile.dat
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[14:33:25.957] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[14:33:25.957] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//trimParameters35_C15.dat
[14:33:25.957] <TB2> INFO: masking Roc 0 col/row: 28 26
[14:33:25.957] <TB2> INFO: masking Roc 0 col/row: 28 27
[14:33:25.957] <TB2> INFO: masking Roc 0 col/row: 29 25
[14:33:25.957] <TB2> INFO: masking Roc 0 col/row: 29 26
[14:33:25.957] <TB2> INFO: masking Roc 0 col/row: 29 27
[14:33:25.958] <TB2> INFO: masking Roc 0 col/row: 29 28
[14:33:25.958] <TB2> INFO: masking Roc 0 col/row: 30 25
[14:33:25.958] <TB2> INFO: masking Roc 0 col/row: 30 26
[14:33:25.958] <TB2> INFO: masking Roc 0 col/row: 30 27
[14:33:25.958] <TB2> INFO: masking Roc 0 col/row: 30 28
[14:33:26.040] <TB2> INFO: clk: 4
[14:33:26.040] <TB2> INFO: ctr: 4
[14:33:26.040] <TB2> INFO: sda: 19
[14:33:26.040] <TB2> INFO: tin: 9
[14:33:26.040] <TB2> INFO: level: 15
[14:33:26.040] <TB2> INFO: triggerdelay: 0
[14:33:26.040] <TB2> QUIET: Instanciating API for pxar prod-12
[14:33:26.040] <TB2> INFO: Log level: INFO
[14:33:26.058] <TB2> INFO: Found DTB DTB_WXENWR
[14:33:26.067] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:33:26.070] <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:33:26.072] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:33:27.650] <TB2> INFO: DUT info:
[14:33:27.650] <TB2> INFO: The DUT currently contains the following objects:
[14:33:27.650] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:33:27.650] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:33:27.650] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:33:27.651] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:33:27.651] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:27.651] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:28.052] <TB2> INFO: enter 'restricted' command line mode
[14:33:28.052] <TB2> INFO: enter test to run
[14:33:28.052] <TB2> INFO: test: PixelAlive no parameter change
[14:33:28.052] <TB2> INFO: running: pixelalive
[14:33:28.057] <TB2> INFO: ######################################################################
[14:33:28.057] <TB2> INFO: PixTestAlive::doTest()
[14:33:28.057] <TB2> INFO: ######################################################################
[14:33:28.058] <TB2> INFO: ----------------------------------------------------------------------
[14:33:28.058] <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)
[14:33:28.058] <TB2> INFO: ----------------------------------------------------------------------
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 28/26
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 28/27
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 29/25
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 29/26
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 29/27
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 29/28
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 30/25
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 30/26
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 30/27
[14:33:28.061] <TB2> INFO: ROC 0 masking pixel 30/28
[14:33:28.402] <TB2> INFO: Expecting 208000 events.
[14:33:38.531] <TB2> INFO: 208000 events read in total (9410ms).
[14:33:38.556] <TB2> INFO: Test took 10495ms.
[14:33:38.562] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:33:38.830] <TB2> INFO: PixTestAlive::aliveTest() done
[14:33:38.830] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 28/26
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 28/27
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 29/25
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 29/26
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 29/27
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 29/28
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 30/25
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 30/26
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 30/27
[14:33:38.830] <TB2> INFO: ROC 0 masking pixel 30/28
[14:33:38.831] <TB2> INFO: ----------------------------------------------------------------------
[14:33:38.831] <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)
[14:33:38.831] <TB2> INFO: ----------------------------------------------------------------------
[14:33:39.138] <TB2> INFO: Expecting 208000 events.
[14:33:45.959] <TB2> INFO: 208000 events read in total (6104ms).
[14:33:45.959] <TB2> INFO: Test took 7125ms.
[14:33:45.959] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 28/26
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 28/27
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 29/25
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 29/26
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 29/27
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 29/28
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 30/25
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 30/26
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 30/27
[14:33:45.959] <TB2> INFO: ROC 0 masking pixel 30/28
[14:33:45.960] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:33:46.285] <TB2> INFO: PixTestAlive::maskTest() done
[14:33:46.285] <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
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 28/26
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 28/27
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 29/25
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 29/26
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 29/27
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 29/28
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 30/25
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 30/26
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 30/27
[14:33:46.285] <TB2> INFO: ROC 0 masking pixel 30/28
[14:33:46.287] <TB2> INFO: ----------------------------------------------------------------------
[14:33:46.287] <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)
[14:33:46.287] <TB2> INFO: ----------------------------------------------------------------------
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 28/26
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 28/27
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 29/25
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 29/26
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 29/27
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 29/28
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 30/25
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 30/26
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 30/27
[14:33:46.289] <TB2> INFO: ROC 0 masking pixel 30/28
[14:33:46.630] <TB2> INFO: Expecting 208000 events.
[14:33:56.706] <TB2> INFO: 208000 events read in total (9359ms).
[14:33:56.706] <TB2> INFO: Test took 10417ms.
[14:33:56.715] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:33:56.961] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[14:33:56.961] <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
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 28/26
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 28/27
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 29/25
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 29/26
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 29/27
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 29/28
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 30/25
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 30/26
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 30/27
[14:33:56.961] <TB2> INFO: ROC 0 masking pixel 30/28
[14:33:56.961] <TB2> INFO: PixTestAlive::doTest() done, duration: 28 seconds
[14:33:56.992] <TB2> INFO: enter test to run
[14:33:56.992] <TB2> INFO: test: delay setting parameters: ->2<-
[14:33:56.992] <TB2> INFO: delay test by 2 seconds...
[14:33:58.992] <TB2> INFO: enter test to run
[14:33:58.992] <TB2> INFO: test: HighRate no parameter change
[14:33:58.992] <TB2> INFO: running: highrate
[14:33:58.993] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[14:33:59.154] <TB2> INFO: ----------------------------------------------------------------------
[14:33:59.154] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:33:59.154] <TB2> INFO: ----------------------------------------------------------------------
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 28/26
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 28/27
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 29/25
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 29/26
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 29/27
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 29/28
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 30/25
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 30/26
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 30/27
[14:33:59.158] <TB2> INFO: ROC 0 masking pixel 30/28
[14:33:59.784] <TB2> INFO: Expecting 208000 events.
[14:34:14.057] <TB2> INFO: 208000 events read in total (13745ms).
[14:34:14.063] <TB2> INFO: Test took 14905ms.
[14:34:14.405] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:34:14.714] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:34:14.714] <TB2> INFO: number of red-efficiency pixels: 181 167 179 341 339 462 419 488 443 584 557 367 317 186 154 185
[14:34:14.714] <TB2> INFO: number of X-ray hits detected: 116928 119640 112489 209249 206451 254268 235066 259113 256023 258928 266749 213633 198429 120618 120883 115191
[14:34:14.714] <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
[14:34:14.714] <TB2> INFO: number of Vcal hits detected: 207274 207829 207805 207646 207646 207489 207550 207483 207524 207361 207388 207555 207662 207808 207840 207809
[14:34:14.714] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.7 99.8 99.9 99.9 99.9 99.9
[14:34:14.714] <TB2> INFO: Vcal hit overall efficiency (%): 99.7 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.7 99.7 99.8 99.8 99.9 99.9 99.9
[14:34:14.714] <TB2> INFO: X-ray hit rate [MHz/cm2]: 34.3 35.1 33.0 61.3 60.5 74.5 68.9 75.9 75.0 75.9 78.2 62.6 58.2 35.4 35.4 33.8
[14:34:14.714] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[14:34:14.758] <TB2> INFO: PixTest:: pg_setup set to default.
[14:34:14.770] <TB2> INFO: enter test to run
[14:34:14.770] <TB2> INFO: test: no parameter change
[14:34:14.974] <TB2> QUIET: Connection to board 162 closed.
[14:34:15.054] <TB2> INFO: pXar: this is the end, my friend

[14:34:52.054] <TB2> INFO: *** Welcome to pxar ***
[14:34:52.054] <TB2> INFO: *** Today: 2016/01/18
[14:34:52.115] <TB2> INFO: *** Version: b2d3
[14:34:52.115] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//dacParameters35_C15.dat
[14:34:52.116] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//tbmParameters_C0b.dat
[14:34:52.116] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//defaultMaskFile.dat
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[14:34:52.116] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[14:34:52.116] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//trimParameters35_C15.dat
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 28 26
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 28 27
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 29 25
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 29 26
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 29 27
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 29 28
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 30 25
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 30 26
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 30 27
[14:34:52.116] <TB2> INFO: masking Roc 0 col/row: 30 28
[14:34:52.189] <TB2> INFO: clk: 4
[14:34:52.189] <TB2> INFO: ctr: 4
[14:34:52.189] <TB2> INFO: sda: 19
[14:34:52.189] <TB2> INFO: tin: 9
[14:34:52.189] <TB2> INFO: level: 15
[14:34:52.189] <TB2> INFO: triggerdelay: 0
[14:34:52.189] <TB2> QUIET: Instanciating API for pxar prod-12
[14:34:52.189] <TB2> INFO: Log level: INFO
[14:34:52.202] <TB2> INFO: Found DTB DTB_WXENWR
[14:34:52.211] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:34:52.214] <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:34:52.216] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:34:53.791] <TB2> INFO: DUT info:
[14:34:53.791] <TB2> INFO: The DUT currently contains the following objects:
[14:34:53.791] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:34:53.791] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:34:53.791] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:34:53.791] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:34:53.791] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:53.791] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:34:54.192] <TB2> INFO: enter 'restricted' command line mode
[14:34:54.192] <TB2> INFO: enter test to run
[14:34:54.192] <TB2> INFO: test: PixelAlive no parameter change
[14:34:54.192] <TB2> INFO: running: pixelalive
[14:34:54.198] <TB2> INFO: ######################################################################
[14:34:54.198] <TB2> INFO: PixTestAlive::doTest()
[14:34:54.198] <TB2> INFO: ######################################################################
[14:34:54.199] <TB2> INFO: ----------------------------------------------------------------------
[14:34:54.199] <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)
[14:34:54.199] <TB2> INFO: ----------------------------------------------------------------------
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 28/26
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 28/27
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 29/25
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 29/26
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 29/27
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 29/28
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 30/25
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 30/26
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 30/27
[14:34:54.202] <TB2> INFO: ROC 0 masking pixel 30/28
[14:34:54.538] <TB2> INFO: Expecting 208000 events.
[14:35:04.790] <TB2> INFO: 208000 events read in total (9533ms).
[14:35:04.814] <TB2> INFO: Test took 10612ms.
[14:35:04.824] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:35:05.096] <TB2> INFO: PixTestAlive::aliveTest() done
[14:35:05.096] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 28/26
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 28/27
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 29/25
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 29/26
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 29/27
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 29/28
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 30/25
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 30/26
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 30/27
[14:35:05.096] <TB2> INFO: ROC 0 masking pixel 30/28
[14:35:05.098] <TB2> INFO: ----------------------------------------------------------------------
[14:35:05.098] <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)
[14:35:05.098] <TB2> INFO: ----------------------------------------------------------------------
[14:35:05.411] <TB2> INFO: Expecting 208000 events.
[14:35:12.267] <TB2> INFO: 208000 events read in total (6140ms).
[14:35:12.267] <TB2> INFO: Test took 7167ms.
[14:35:12.267] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:35:12.267] <TB2> INFO: ROC 0 masking pixel 28/26
[14:35:12.267] <TB2> INFO: ROC 0 masking pixel 28/27
[14:35:12.267] <TB2> INFO: ROC 0 masking pixel 29/25
[14:35:12.267] <TB2> INFO: ROC 0 masking pixel 29/26
[14:35:12.267] <TB2> INFO: ROC 0 masking pixel 29/27
[14:35:12.268] <TB2> INFO: ROC 0 masking pixel 29/28
[14:35:12.268] <TB2> INFO: ROC 0 masking pixel 30/25
[14:35:12.268] <TB2> INFO: ROC 0 masking pixel 30/26
[14:35:12.268] <TB2> INFO: ROC 0 masking pixel 30/27
[14:35:12.268] <TB2> INFO: ROC 0 masking pixel 30/28
[14:35:12.268] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:35:12.594] <TB2> INFO: PixTestAlive::maskTest() done
[14:35:12.594] <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
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 28/26
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 28/27
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 29/25
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 29/26
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 29/27
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 29/28
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 30/25
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 30/26
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 30/27
[14:35:12.594] <TB2> INFO: ROC 0 masking pixel 30/28
[14:35:12.596] <TB2> INFO: ----------------------------------------------------------------------
[14:35:12.596] <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)
[14:35:12.596] <TB2> INFO: ----------------------------------------------------------------------
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 28/26
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 28/27
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 29/25
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 29/26
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 29/27
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 29/28
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 30/25
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 30/26
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 30/27
[14:35:12.598] <TB2> INFO: ROC 0 masking pixel 30/28
[14:35:12.928] <TB2> INFO: Expecting 208000 events.
[14:35:23.041] <TB2> INFO: 208000 events read in total (9397ms).
[14:35:23.041] <TB2> INFO: Test took 10443ms.
[14:35:23.047] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:35:23.299] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[14:35:23.299] <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
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 28/26
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 28/27
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 29/25
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 29/26
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 29/27
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 29/28
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 30/25
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 30/26
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 30/27
[14:35:23.299] <TB2> INFO: ROC 0 masking pixel 30/28
[14:35:23.299] <TB2> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[14:35:23.330] <TB2> INFO: enter test to run
[14:35:23.330] <TB2> INFO: test: delay setting parameters: ->2<-
[14:35:23.330] <TB2> INFO: delay test by 2 seconds...
[14:35:25.330] <TB2> INFO: enter test to run
[14:35:25.330] <TB2> INFO: test: HighRate no parameter change
[14:35:25.330] <TB2> INFO: running: highrate
[14:35:25.330] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//012_HREfficiency_75//phCalibrationFitErr35_C15.dat
[14:35:25.498] <TB2> INFO: ----------------------------------------------------------------------
[14:35:25.498] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:35:25.499] <TB2> INFO: ----------------------------------------------------------------------
[14:35:25.502] <TB2> INFO: ROC 0 masking pixel 28/26
[14:35:25.502] <TB2> INFO: ROC 0 masking pixel 28/27
[14:35:25.502] <TB2> INFO: ROC 0 masking pixel 29/25
[14:35:25.503] <TB2> INFO: ROC 0 masking pixel 29/26
[14:35:25.503] <TB2> INFO: ROC 0 masking pixel 29/27
[14:35:25.503] <TB2> INFO: ROC 0 masking pixel 29/28
[14:35:25.503] <TB2> INFO: ROC 0 masking pixel 30/25
[14:35:25.503] <TB2> INFO: ROC 0 masking pixel 30/26
[14:35:25.503] <TB2> INFO: ROC 0 masking pixel 30/27
[14:35:25.503] <TB2> INFO: ROC 0 masking pixel 30/28
[14:35:26.120] <TB2> INFO: Expecting 208000 events.
[14:35:42.304] <TB2> INFO: 208000 events read in total (15657ms).
[14:35:42.313] <TB2> INFO: Test took 16810ms.
[14:35:42.838] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:35:43.199] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:35:43.199] <TB2> INFO: number of red-efficiency pixels: 322 285 311 683 725 1018 870 1021 1023 1157 1160 802 669 354 263 312
[14:35:43.199] <TB2> INFO: number of X-ray hits detected: 170710 175121 165405 303813 297621 365356 341693 374803 368600 373670 384970 312102 288400 177265 176229 168719
[14:35:43.199] <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
[14:35:43.199] <TB2> INFO: number of Vcal hits detected: 207122 207704 207640 207215 207179 206770 206963 206791 206795 206523 206549 207027 207241 207598 207714 207671
[14:35:43.199] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.6 99.5 99.6 99.5 99.5 99.4 99.4 99.6 99.7 99.8 99.9 99.9
[14:35:43.199] <TB2> INFO: Vcal hit overall efficiency (%): 99.6 99.9 99.8 99.6 99.6 99.4 99.5 99.4 99.4 99.3 99.3 99.5 99.6 99.8 99.9 99.8
[14:35:43.199] <TB2> INFO: X-ray hit rate [MHz/cm2]: 50.0 51.3 48.5 89.0 87.2 107.1 100.2 109.9 108.0 109.5 112.8 91.5 84.5 52.0 51.7 49.5
[14:35:43.199] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[14:35:43.243] <TB2> INFO: PixTest:: pg_setup set to default.
[14:35:43.255] <TB2> INFO: enter test to run
[14:35:43.255] <TB2> INFO: test: no parameter change
[14:35:43.505] <TB2> QUIET: Connection to board 162 closed.
[14:35:43.584] <TB2> INFO: pXar: this is the end, my friend

[14:36:18.715] <TB2> INFO: *** Welcome to pxar ***
[14:36:18.715] <TB2> INFO: *** Today: 2016/01/18
[14:36:18.777] <TB2> INFO: *** Version: b2d3
[14:36:18.777] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//dacParameters35_C15.dat
[14:36:18.778] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//tbmParameters_C0b.dat
[14:36:18.778] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//defaultMaskFile.dat
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[14:36:18.778] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[14:36:18.778] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//trimParameters35_C15.dat
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 28 26
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 28 27
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 29 25
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 29 26
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 29 27
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 29 28
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 30 25
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 30 26
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 30 27
[14:36:18.778] <TB2> INFO: masking Roc 0 col/row: 30 28
[14:36:18.860] <TB2> INFO: clk: 4
[14:36:18.860] <TB2> INFO: ctr: 4
[14:36:18.860] <TB2> INFO: sda: 19
[14:36:18.860] <TB2> INFO: tin: 9
[14:36:18.860] <TB2> INFO: level: 15
[14:36:18.860] <TB2> INFO: triggerdelay: 0
[14:36:18.860] <TB2> QUIET: Instanciating API for pxar prod-12
[14:36:18.860] <TB2> INFO: Log level: INFO
[14:36:18.873] <TB2> INFO: Found DTB DTB_WXENWR
[14:36:18.881] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:36:18.885] <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:36:18.887] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:36:20.463] <TB2> INFO: DUT info:
[14:36:20.463] <TB2> INFO: The DUT currently contains the following objects:
[14:36:20.463] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:36:20.463] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:36:20.463] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:36:20.463] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:36:20.463] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.463] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:36:20.864] <TB2> INFO: enter 'restricted' command line mode
[14:36:20.864] <TB2> INFO: enter test to run
[14:36:20.864] <TB2> INFO: test: PixelAlive no parameter change
[14:36:20.864] <TB2> INFO: running: pixelalive
[14:36:20.870] <TB2> INFO: ######################################################################
[14:36:20.870] <TB2> INFO: PixTestAlive::doTest()
[14:36:20.870] <TB2> INFO: ######################################################################
[14:36:20.872] <TB2> INFO: ----------------------------------------------------------------------
[14:36:20.872] <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)
[14:36:20.872] <TB2> INFO: ----------------------------------------------------------------------
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 28/26
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 28/27
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 29/25
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 29/26
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 29/27
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 29/28
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 30/25
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 30/26
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 30/27
[14:36:20.874] <TB2> INFO: ROC 0 masking pixel 30/28
[14:36:21.201] <TB2> INFO: Expecting 208000 events.
[14:36:31.523] <TB2> INFO: 208000 events read in total (9603ms).
[14:36:31.544] <TB2> INFO: Test took 10670ms.
[14:36:31.550] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:36:31.817] <TB2> INFO: PixTestAlive::aliveTest() done
[14:36:31.817] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 1 0 0 0 0
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 28/26
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 28/27
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 29/25
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 29/26
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 29/27
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 29/28
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 30/25
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 30/26
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 30/27
[14:36:31.817] <TB2> INFO: ROC 0 masking pixel 30/28
[14:36:31.819] <TB2> INFO: ----------------------------------------------------------------------
[14:36:31.819] <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)
[14:36:31.819] <TB2> INFO: ----------------------------------------------------------------------
[14:36:32.131] <TB2> INFO: Expecting 208000 events.
[14:36:38.918] <TB2> INFO: 208000 events read in total (6070ms).
[14:36:38.919] <TB2> INFO: Test took 7098ms.
[14:36:38.919] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 28/26
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 28/27
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 29/25
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 29/26
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 29/27
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 29/28
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 30/25
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 30/26
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 30/27
[14:36:38.919] <TB2> INFO: ROC 0 masking pixel 30/28
[14:36:38.919] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:36:39.245] <TB2> INFO: PixTestAlive::maskTest() done
[14:36:39.245] <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
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 28/26
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 28/27
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 29/25
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 29/26
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 29/27
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 29/28
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 30/25
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 30/26
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 30/27
[14:36:39.245] <TB2> INFO: ROC 0 masking pixel 30/28
[14:36:39.247] <TB2> INFO: ----------------------------------------------------------------------
[14:36:39.247] <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)
[14:36:39.247] <TB2> INFO: ----------------------------------------------------------------------
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 28/26
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 28/27
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 29/25
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 29/26
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 29/27
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 29/28
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 30/25
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 30/26
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 30/27
[14:36:39.249] <TB2> INFO: ROC 0 masking pixel 30/28
[14:36:39.555] <TB2> INFO: Expecting 208000 events.
[14:36:49.682] <TB2> INFO: 208000 events read in total (9410ms).
[14:36:49.682] <TB2> INFO: Test took 10433ms.
[14:36:49.689] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:36:49.938] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[14:36:49.938] <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
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 28/26
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 28/27
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 29/25
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 29/26
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 29/27
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 29/28
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 30/25
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 30/26
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 30/27
[14:36:49.938] <TB2> INFO: ROC 0 masking pixel 30/28
[14:36:49.938] <TB2> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[14:36:49.967] <TB2> INFO: enter test to run
[14:36:49.967] <TB2> INFO: test: delay setting parameters: ->2<-
[14:36:49.967] <TB2> INFO: delay test by 2 seconds...
[14:36:51.967] <TB2> INFO: enter test to run
[14:36:51.967] <TB2> INFO: test: HighRate no parameter change
[14:36:51.967] <TB2> INFO: running: highrate
[14:36:51.967] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//013_HREfficiency_100//phCalibrationFitErr35_C15.dat
[14:36:52.124] <TB2> INFO: ----------------------------------------------------------------------
[14:36:52.124] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:36:52.124] <TB2> INFO: ----------------------------------------------------------------------
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 28/26
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 28/27
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 29/25
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 29/26
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 29/27
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 29/28
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 30/25
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 30/26
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 30/27
[14:36:52.128] <TB2> INFO: ROC 0 masking pixel 30/28
[14:36:52.740] <TB2> INFO: Expecting 208000 events.
[14:37:11.659] <TB2> INFO: 208000 events read in total (18391ms).
[14:37:11.670] <TB2> INFO: Test took 19541ms.
[14:37:12.413] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:37:12.871] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:37:12.871] <TB2> INFO: number of red-efficiency pixels: 561 530 552 1312 1277 1805 1612 1839 1910 2051 2097 1377 1231 630 458 520
[14:37:12.871] <TB2> INFO: number of X-ray hits detected: 233923 239979 227171 412326 406118 494212 464029 506847 500378 508539 521614 423629 391021 244364 243580 230080
[14:37:12.871] <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
[14:37:12.871] <TB2> INFO: number of Vcal hits detected: 206839 207434 207269 206264 206262 205332 205633 205343 205178 204679 204618 206086 206459 207159 207495 207414
[14:37:12.871] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.7 99.3 99.3 98.9 99.0 98.8 98.8 98.6 98.5 99.2 99.3 99.7 99.8 99.7
[14:37:12.871] <TB2> INFO: Vcal hit overall efficiency (%): 99.4 99.7 99.6 99.2 99.2 98.7 98.9 98.7 98.6 98.4 98.4 99.1 99.3 99.6 99.8 99.7
[14:37:12.871] <TB2> INFO: X-ray hit rate [MHz/cm2]: 68.6 70.3 66.6 120.9 119.0 144.9 136.0 148.6 146.7 149.1 152.9 124.2 114.6 71.6 71.4 67.4
[14:37:12.871] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[14:37:12.915] <TB2> INFO: PixTest:: pg_setup set to default.
[14:37:12.926] <TB2> INFO: enter test to run
[14:37:12.926] <TB2> INFO: test: no parameter change
[14:37:13.123] <TB2> QUIET: Connection to board 162 closed.
[14:37:13.204] <TB2> INFO: pXar: this is the end, my friend

[14:37:49.824] <TB2> INFO: *** Welcome to pxar ***
[14:37:49.824] <TB2> INFO: *** Today: 2016/01/18
[14:37:49.881] <TB2> INFO: *** Version: b2d3
[14:37:49.881] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//dacParameters35_C15.dat
[14:37:49.882] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//tbmParameters_C0b.dat
[14:37:49.882] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//defaultMaskFile.dat
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[14:37:49.882] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[14:37:49.882] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//trimParameters35_C15.dat
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 28 26
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 28 27
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 29 25
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 29 26
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 29 27
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 29 28
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 30 25
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 30 26
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 30 27
[14:37:49.883] <TB2> INFO: masking Roc 0 col/row: 30 28
[14:37:49.967] <TB2> INFO: clk: 4
[14:37:49.967] <TB2> INFO: ctr: 4
[14:37:49.967] <TB2> INFO: sda: 19
[14:37:49.967] <TB2> INFO: tin: 9
[14:37:49.967] <TB2> INFO: level: 15
[14:37:49.968] <TB2> INFO: triggerdelay: 0
[14:37:49.968] <TB2> QUIET: Instanciating API for pxar prod-12
[14:37:49.968] <TB2> INFO: Log level: INFO
[14:37:49.984] <TB2> INFO: Found DTB DTB_WXENWR
[14:37:49.992] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:37:49.996] <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:37:49.998] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:37:51.578] <TB2> INFO: DUT info:
[14:37:51.578] <TB2> INFO: The DUT currently contains the following objects:
[14:37:51.578] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:37:51.578] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:37:51.578] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:37:51.578] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:37:51.578] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.578] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:37:51.979] <TB2> INFO: enter 'restricted' command line mode
[14:37:51.979] <TB2> INFO: enter test to run
[14:37:51.979] <TB2> INFO: test: PixelAlive no parameter change
[14:37:51.979] <TB2> INFO: running: pixelalive
[14:37:51.985] <TB2> INFO: ######################################################################
[14:37:51.985] <TB2> INFO: PixTestAlive::doTest()
[14:37:51.985] <TB2> INFO: ######################################################################
[14:37:51.986] <TB2> INFO: ----------------------------------------------------------------------
[14:37:51.986] <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)
[14:37:51.986] <TB2> INFO: ----------------------------------------------------------------------
[14:37:51.988] <TB2> INFO: ROC 0 masking pixel 28/26
[14:37:51.988] <TB2> INFO: ROC 0 masking pixel 28/27
[14:37:51.989] <TB2> INFO: ROC 0 masking pixel 29/25
[14:37:51.989] <TB2> INFO: ROC 0 masking pixel 29/26
[14:37:51.989] <TB2> INFO: ROC 0 masking pixel 29/27
[14:37:51.989] <TB2> INFO: ROC 0 masking pixel 29/28
[14:37:51.989] <TB2> INFO: ROC 0 masking pixel 30/25
[14:37:51.989] <TB2> INFO: ROC 0 masking pixel 30/26
[14:37:51.989] <TB2> INFO: ROC 0 masking pixel 30/27
[14:37:51.989] <TB2> INFO: ROC 0 masking pixel 30/28
[14:37:52.294] <TB2> INFO: Expecting 208000 events.
[14:38:02.596] <TB2> INFO: 208000 events read in total (9582ms).
[14:38:02.598] <TB2> INFO: Test took 10609ms.
[14:38:02.607] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:38:02.873] <TB2> INFO: PixTestAlive::aliveTest() done
[14:38:02.873] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 28/26
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 28/27
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 29/25
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 29/26
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 29/27
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 29/28
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 30/25
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 30/26
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 30/27
[14:38:02.873] <TB2> INFO: ROC 0 masking pixel 30/28
[14:38:02.875] <TB2> INFO: ----------------------------------------------------------------------
[14:38:02.875] <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)
[14:38:02.875] <TB2> INFO: ----------------------------------------------------------------------
[14:38:03.183] <TB2> INFO: Expecting 208000 events.
[14:38:09.925] <TB2> INFO: 208000 events read in total (6026ms).
[14:38:09.925] <TB2> INFO: Test took 7047ms.
[14:38:09.925] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 28/26
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 28/27
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 29/25
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 29/26
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 29/27
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 29/28
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 30/25
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 30/26
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 30/27
[14:38:09.926] <TB2> INFO: ROC 0 masking pixel 30/28
[14:38:09.926] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:38:10.249] <TB2> INFO: PixTestAlive::maskTest() done
[14:38:10.249] <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
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 28/26
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 28/27
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 29/25
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 29/26
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 29/27
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 29/28
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 30/25
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 30/26
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 30/27
[14:38:10.249] <TB2> INFO: ROC 0 masking pixel 30/28
[14:38:10.251] <TB2> INFO: ----------------------------------------------------------------------
[14:38:10.251] <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)
[14:38:10.251] <TB2> INFO: ----------------------------------------------------------------------
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 28/26
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 28/27
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 29/25
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 29/26
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 29/27
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 29/28
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 30/25
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 30/26
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 30/27
[14:38:10.253] <TB2> INFO: ROC 0 masking pixel 30/28
[14:38:10.557] <TB2> INFO: Expecting 208000 events.
[14:38:20.798] <TB2> INFO: 208000 events read in total (9525ms).
[14:38:20.799] <TB2> INFO: Test took 10546ms.
[14:38:20.807] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:38:21.056] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[14:38:21.056] <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
[14:38:21.056] <TB2> INFO: ROC 0 masking pixel 28/26
[14:38:21.056] <TB2> INFO: ROC 0 masking pixel 28/27
[14:38:21.056] <TB2> INFO: ROC 0 masking pixel 29/25
[14:38:21.056] <TB2> INFO: ROC 0 masking pixel 29/26
[14:38:21.056] <TB2> INFO: ROC 0 masking pixel 29/27
[14:38:21.056] <TB2> INFO: ROC 0 masking pixel 29/28
[14:38:21.057] <TB2> INFO: ROC 0 masking pixel 30/25
[14:38:21.057] <TB2> INFO: ROC 0 masking pixel 30/26
[14:38:21.057] <TB2> INFO: ROC 0 masking pixel 30/27
[14:38:21.057] <TB2> INFO: ROC 0 masking pixel 30/28
[14:38:21.057] <TB2> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[14:38:21.088] <TB2> INFO: enter test to run
[14:38:21.088] <TB2> INFO: test: delay setting parameters: ->2<-
[14:38:21.088] <TB2> INFO: delay test by 2 seconds...
[14:38:23.088] <TB2> INFO: enter test to run
[14:38:23.088] <TB2> INFO: test: HighRate no parameter change
[14:38:23.088] <TB2> INFO: running: highrate
[14:38:23.088] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//014_HREfficiency_125//phCalibrationFitErr35_C15.dat
[14:38:23.250] <TB2> INFO: ----------------------------------------------------------------------
[14:38:23.250] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:38:23.250] <TB2> INFO: ----------------------------------------------------------------------
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 28/26
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 28/27
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 29/25
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 29/26
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 29/27
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 29/28
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 30/25
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 30/26
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 30/27
[14:38:23.255] <TB2> INFO: ROC 0 masking pixel 30/28
[14:38:23.873] <TB2> INFO: Expecting 208000 events.
[14:38:45.211] <TB2> INFO: 208000 events read in total (20810ms).
[14:38:45.224] <TB2> INFO: Test took 21969ms.
[14:38:46.023] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:38:46.502] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:38:46.502] <TB2> INFO: number of red-efficiency pixels: 835 711 735 1919 1887 2475 2265 2685 2764 2831 2816 1970 1744 900 690 823
[14:38:46.502] <TB2> INFO: number of X-ray hits detected: 284933 291234 277409 498122 488964 594002 558904 612538 602959 610407 627810 510215 472200 297509 294287 279661
[14:38:46.502] <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
[14:38:46.502] <TB2> INFO: number of Vcal hits detected: 206502 207200 206887 204983 205034 203349 203833 203187 202922 202180 202221 204725 205463 206577 207207 207032
[14:38:46.502] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.6 99.6 99.6 98.7 98.8 98.0 98.3 97.9 97.8 97.5 97.5 98.6 98.9 99.4 99.6 99.6
[14:38:46.502] <TB2> INFO: Vcal hit overall efficiency (%): 99.3 99.6 99.5 98.5 98.6 97.8 98.0 97.7 97.6 97.2 97.2 98.4 98.8 99.3 99.6 99.5
[14:38:46.502] <TB2> INFO: X-ray hit rate [MHz/cm2]: 83.5 85.4 81.3 146.0 143.3 174.1 163.8 179.5 176.7 178.9 184.0 149.5 138.4 87.2 86.3 82.0
[14:38:46.502] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[14:38:46.546] <TB2> INFO: PixTest:: pg_setup set to default.
[14:38:46.563] <TB2> INFO: enter test to run
[14:38:46.563] <TB2> INFO: test: no parameter change
[14:38:46.765] <TB2> QUIET: Connection to board 162 closed.
[14:38:46.845] <TB2> INFO: pXar: this is the end, my friend

[14:39:21.788] <TB2> INFO: *** Welcome to pxar ***
[14:39:21.789] <TB2> INFO: *** Today: 2016/01/18
[14:39:21.850] <TB2> INFO: *** Version: b2d3
[14:39:21.850] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//dacParameters35_C15.dat
[14:39:21.851] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//tbmParameters_C0b.dat
[14:39:21.851] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//defaultMaskFile.dat
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[14:39:21.851] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[14:39:21.851] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//trimParameters35_C15.dat
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 28 26
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 28 27
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 29 25
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 29 26
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 29 27
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 29 28
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 30 25
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 30 26
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 30 27
[14:39:21.851] <TB2> INFO: masking Roc 0 col/row: 30 28
[14:39:21.943] <TB2> INFO: clk: 4
[14:39:21.943] <TB2> INFO: ctr: 4
[14:39:21.943] <TB2> INFO: sda: 19
[14:39:21.943] <TB2> INFO: tin: 9
[14:39:21.943] <TB2> INFO: level: 15
[14:39:21.943] <TB2> INFO: triggerdelay: 0
[14:39:21.943] <TB2> QUIET: Instanciating API for pxar prod-12
[14:39:21.943] <TB2> INFO: Log level: INFO
[14:39:21.957] <TB2> INFO: Found DTB DTB_WXENWR
[14:39:21.965] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:39:21.969] <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:39:21.971] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:39:23.536] <TB2> INFO: DUT info:
[14:39:23.536] <TB2> INFO: The DUT currently contains the following objects:
[14:39:23.536] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:39:23.536] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:39:23.536] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:39:23.536] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:39:23.537] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.537] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:39:23.937] <TB2> INFO: enter 'restricted' command line mode
[14:39:23.938] <TB2> INFO: enter test to run
[14:39:23.938] <TB2> INFO: test: PixelAlive no parameter change
[14:39:23.938] <TB2> INFO: running: pixelalive
[14:39:23.945] <TB2> INFO: ######################################################################
[14:39:23.945] <TB2> INFO: PixTestAlive::doTest()
[14:39:23.945] <TB2> INFO: ######################################################################
[14:39:23.947] <TB2> INFO: ----------------------------------------------------------------------
[14:39:23.947] <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)
[14:39:23.947] <TB2> INFO: ----------------------------------------------------------------------
[14:39:23.949] <TB2> INFO: ROC 0 masking pixel 28/26
[14:39:23.949] <TB2> INFO: ROC 0 masking pixel 28/27
[14:39:23.949] <TB2> INFO: ROC 0 masking pixel 29/25
[14:39:23.950] <TB2> INFO: ROC 0 masking pixel 29/26
[14:39:23.950] <TB2> INFO: ROC 0 masking pixel 29/27
[14:39:23.950] <TB2> INFO: ROC 0 masking pixel 29/28
[14:39:23.950] <TB2> INFO: ROC 0 masking pixel 30/25
[14:39:23.950] <TB2> INFO: ROC 0 masking pixel 30/26
[14:39:23.950] <TB2> INFO: ROC 0 masking pixel 30/27
[14:39:23.950] <TB2> INFO: ROC 0 masking pixel 30/28
[14:39:24.268] <TB2> INFO: Expecting 208000 events.
[14:39:34.710] <TB2> INFO: 208000 events read in total (9723ms).
[14:39:34.729] <TB2> INFO: Test took 10779ms.
[14:39:34.737] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:39:35.007] <TB2> INFO: PixTestAlive::aliveTest() done
[14:39:35.007] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 28/26
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 28/27
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 29/25
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 29/26
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 29/27
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 29/28
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 30/25
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 30/26
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 30/27
[14:39:35.007] <TB2> INFO: ROC 0 masking pixel 30/28
[14:39:35.009] <TB2> INFO: ----------------------------------------------------------------------
[14:39:35.009] <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)
[14:39:35.009] <TB2> INFO: ----------------------------------------------------------------------
[14:39:35.324] <TB2> INFO: Expecting 208000 events.
[14:39:42.158] <TB2> INFO: 208000 events read in total (6118ms).
[14:39:42.159] <TB2> INFO: Test took 7148ms.
[14:39:42.159] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 28/26
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 28/27
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 29/25
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 29/26
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 29/27
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 29/28
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 30/25
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 30/26
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 30/27
[14:39:42.160] <TB2> INFO: ROC 0 masking pixel 30/28
[14:39:42.160] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:39:42.483] <TB2> INFO: PixTestAlive::maskTest() done
[14:39:42.483] <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
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 28/26
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 28/27
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 29/25
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 29/26
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 29/27
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 29/28
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 30/25
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 30/26
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 30/27
[14:39:42.484] <TB2> INFO: ROC 0 masking pixel 30/28
[14:39:42.486] <TB2> INFO: ----------------------------------------------------------------------
[14:39:42.486] <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)
[14:39:42.486] <TB2> INFO: ----------------------------------------------------------------------
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 28/26
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 28/27
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 29/25
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 29/26
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 29/27
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 29/28
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 30/25
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 30/26
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 30/27
[14:39:42.488] <TB2> INFO: ROC 0 masking pixel 30/28
[14:39:42.797] <TB2> INFO: Expecting 208000 events.
[14:39:53.126] <TB2> INFO: 208000 events read in total (9613ms).
[14:39:53.127] <TB2> INFO: Test took 10639ms.
[14:39:53.136] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:39:53.381] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[14:39:53.381] <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
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 28/26
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 28/27
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 29/25
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 29/26
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 29/27
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 29/28
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 30/25
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 30/26
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 30/27
[14:39:53.381] <TB2> INFO: ROC 0 masking pixel 30/28
[14:39:53.381] <TB2> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[14:39:53.412] <TB2> INFO: enter test to run
[14:39:53.412] <TB2> INFO: test: delay setting parameters: ->2<-
[14:39:53.413] <TB2> INFO: delay test by 2 seconds...
[14:39:55.413] <TB2> INFO: enter test to run
[14:39:55.413] <TB2> INFO: test: HighRate no parameter change
[14:39:55.413] <TB2> INFO: running: highrate
[14:39:55.413] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//015_HREfficiency_150//phCalibrationFitErr35_C15.dat
[14:39:55.544] <TB2> INFO: ----------------------------------------------------------------------
[14:39:55.544] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:39:55.544] <TB2> INFO: ----------------------------------------------------------------------
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 28/26
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 28/27
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 29/25
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 29/26
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 29/27
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 29/28
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 30/25
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 30/26
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 30/27
[14:39:55.548] <TB2> INFO: ROC 0 masking pixel 30/28
[14:39:56.166] <TB2> INFO: Expecting 208000 events.
[14:40:21.064] <TB2> INFO: 208000 events read in total (24371ms).
[14:40:21.080] <TB2> INFO: Test took 25531ms.
[14:40:22.118] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:40:22.610] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:40:22.610] <TB2> INFO: number of red-efficiency pixels: 1284 1020 981 2527 2478 3252 3029 3398 3417 3382 3493 2692 2380 1242 947 1141
[14:40:22.610] <TB2> INFO: number of X-ray hits detected: 337244 347191 331102 589081 578388 701245 659396 723399 714197 724243 743263 603062 558521 354696 351067 331362
[14:40:22.610] <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
[14:40:22.610] <TB2> INFO: number of Vcal hits detected: 205911 206786 206207 203222 203316 200140 201037 199969 199744 198620 198443 202535 203834 205512 206868 206562
[14:40:22.610] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.3 99.5 99.3 98.0 98.0 96.6 97.1 96.4 96.4 96.0 95.9 97.7 98.2 99.0 99.5 99.4
[14:40:22.610] <TB2> INFO: Vcal hit overall efficiency (%): 99.0 99.4 99.1 97.7 97.7 96.2 96.7 96.1 96.0 95.5 95.4 97.4 98.0 98.8 99.5 99.3
[14:40:22.610] <TB2> INFO: X-ray hit rate [MHz/cm2]: 98.8 101.8 97.0 172.7 169.5 205.5 193.3 212.0 209.3 212.3 217.9 176.8 163.7 104.0 102.9 97.1
[14:40:22.610] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[14:40:22.655] <TB2> INFO: PixTest:: pg_setup set to default.
[14:40:22.673] <TB2> INFO: enter test to run
[14:40:22.673] <TB2> INFO: test: no parameter change
[14:40:22.984] <TB2> QUIET: Connection to board 162 closed.
[14:40:23.068] <TB2> INFO: pXar: this is the end, my friend

[14:40:55.773] <TB2> INFO: *** Welcome to pxar ***
[14:40:55.773] <TB2> INFO: *** Today: 2016/01/18
[14:40:55.831] <TB2> INFO: *** Version: b2d3
[14:40:55.831] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//dacParameters35_C15.dat
[14:40:55.832] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//tbmParameters_C0b.dat
[14:40:55.832] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//defaultMaskFile.dat
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[14:40:55.832] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[14:40:55.832] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//trimParameters35_C15.dat
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 28 26
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 28 27
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 29 25
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 29 26
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 29 27
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 29 28
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 30 25
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 30 26
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 30 27
[14:40:55.832] <TB2> INFO: masking Roc 0 col/row: 30 28
[14:40:55.907] <TB2> INFO: clk: 4
[14:40:55.907] <TB2> INFO: ctr: 4
[14:40:55.907] <TB2> INFO: sda: 19
[14:40:55.907] <TB2> INFO: tin: 9
[14:40:55.907] <TB2> INFO: level: 15
[14:40:55.907] <TB2> INFO: triggerdelay: 0
[14:40:55.907] <TB2> QUIET: Instanciating API for pxar prod-12
[14:40:55.907] <TB2> INFO: Log level: INFO
[14:40:55.920] <TB2> INFO: Found DTB DTB_WXENWR
[14:40:55.928] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:40:55.931] <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:40:55.934] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:40:57.479] <TB2> INFO: DUT info:
[14:40:57.479] <TB2> INFO: The DUT currently contains the following objects:
[14:40:57.479] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:40:57.479] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:40:57.479] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:40:57.479] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:40:57.479] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.479] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:40:57.881] <TB2> INFO: enter 'restricted' command line mode
[14:40:57.881] <TB2> INFO: enter test to run
[14:40:57.881] <TB2> INFO: test: PixelAlive no parameter change
[14:40:57.881] <TB2> INFO: running: pixelalive
[14:40:57.885] <TB2> INFO: ######################################################################
[14:40:57.885] <TB2> INFO: PixTestAlive::doTest()
[14:40:57.885] <TB2> INFO: ######################################################################
[14:40:57.887] <TB2> INFO: ----------------------------------------------------------------------
[14:40:57.887] <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)
[14:40:57.887] <TB2> INFO: ----------------------------------------------------------------------
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 28/26
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 28/27
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 29/25
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 29/26
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 29/27
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 29/28
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 30/25
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 30/26
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 30/27
[14:40:57.889] <TB2> INFO: ROC 0 masking pixel 30/28
[14:40:58.196] <TB2> INFO: Expecting 208000 events.
[14:41:08.320] <TB2> INFO: 208000 events read in total (9405ms).
[14:41:08.324] <TB2> INFO: Test took 10435ms.
[14:41:08.333] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:41:08.605] <TB2> INFO: PixTestAlive::aliveTest() done
[14:41:08.605] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 28/26
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 28/27
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 29/25
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 29/26
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 29/27
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 29/28
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 30/25
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 30/26
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 30/27
[14:41:08.605] <TB2> INFO: ROC 0 masking pixel 30/28
[14:41:08.607] <TB2> INFO: ----------------------------------------------------------------------
[14:41:08.607] <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)
[14:41:08.607] <TB2> INFO: ----------------------------------------------------------------------
[14:41:08.924] <TB2> INFO: Expecting 208000 events.
[14:41:15.676] <TB2> INFO: 208000 events read in total (6035ms).
[14:41:15.677] <TB2> INFO: Test took 7068ms.
[14:41:15.677] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 28/26
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 28/27
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 29/25
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 29/26
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 29/27
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 29/28
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 30/25
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 30/26
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 30/27
[14:41:15.678] <TB2> INFO: ROC 0 masking pixel 30/28
[14:41:15.678] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:41:16.001] <TB2> INFO: PixTestAlive::maskTest() done
[14:41:16.001] <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
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 28/26
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 28/27
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 29/25
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 29/26
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 29/27
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 29/28
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 30/25
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 30/26
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 30/27
[14:41:16.001] <TB2> INFO: ROC 0 masking pixel 30/28
[14:41:16.003] <TB2> INFO: ----------------------------------------------------------------------
[14:41:16.003] <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)
[14:41:16.003] <TB2> INFO: ----------------------------------------------------------------------
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 28/26
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 28/27
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 29/25
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 29/26
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 29/27
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 29/28
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 30/25
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 30/26
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 30/27
[14:41:16.006] <TB2> INFO: ROC 0 masking pixel 30/28
[14:41:16.310] <TB2> INFO: Expecting 208000 events.
[14:41:26.521] <TB2> INFO: 208000 events read in total (9495ms).
[14:41:26.522] <TB2> INFO: Test took 10516ms.
[14:41:26.531] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:41:26.777] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[14:41:26.777] <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
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 28/26
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 28/27
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 29/25
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 29/26
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 29/27
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 29/28
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 30/25
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 30/26
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 30/27
[14:41:26.777] <TB2> INFO: ROC 0 masking pixel 30/28
[14:41:26.777] <TB2> INFO: PixTestAlive::doTest() done, duration: 28 seconds
[14:41:26.813] <TB2> INFO: enter test to run
[14:41:26.813] <TB2> INFO: test: delay setting parameters: ->2<-
[14:41:26.813] <TB2> INFO: delay test by 2 seconds...
[14:41:28.813] <TB2> INFO: enter test to run
[14:41:28.813] <TB2> INFO: test: HighRate no parameter change
[14:41:28.813] <TB2> INFO: running: highrate
[14:41:28.813] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//016_HREfficiency_200//phCalibrationFitErr35_C15.dat
[14:41:28.945] <TB2> INFO: ----------------------------------------------------------------------
[14:41:28.945] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:41:28.945] <TB2> INFO: ----------------------------------------------------------------------
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 28/26
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 28/27
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 29/25
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 29/26
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 29/27
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 29/28
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 30/25
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 30/26
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 30/27
[14:41:28.950] <TB2> INFO: ROC 0 masking pixel 30/28
[14:41:29.547] <TB2> INFO: Expecting 208000 events.
[14:41:59.331] <TB2> INFO: 201150 events read in total (29256ms).
[14:42:00.774] <TB2> INFO: 208000 events read in total (30699ms).
[14:42:00.792] <TB2> INFO: Test took 31842ms.
[14:42:02.003] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:42:02.594] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:42:02.594] <TB2> INFO: number of red-efficiency pixels: 2202 1886 1580 3672 3631 4046 3907 4097 4076 4090 4104 3732 3523 1736 1824 2088
[14:42:02.594] <TB2> INFO: number of X-ray hits detected: 455418 467902 447647 788776 772729 927794 884073 968513 949911 966837 990945 807549 748421 480213 473748 447245
[14:42:02.594] <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
[14:42:02.594] <TB2> INFO: number of Vcal hits detected: 204035 205248 203736 196374 196435 189548 191689 188520 188398 186070 185624 195173 198270 202533 205369 204711
[14:42:02.594] <TB2> INFO: Vcal hit fiducial efficiency (%): 98.5 98.8 98.3 95.0 95.1 91.9 93.0 91.3 91.2 90.4 90.2 94.5 95.8 97.9 98.8 98.6
[14:42:02.595] <TB2> INFO: Vcal hit overall efficiency (%): 98.1 98.7 98.0 94.4 94.4 91.1 92.2 90.6 90.6 89.5 89.2 93.8 95.3 97.4 98.7 98.4
[14:42:02.595] <TB2> INFO: X-ray hit rate [MHz/cm2]: 133.5 137.1 131.2 231.2 226.5 271.9 259.1 283.9 278.4 283.4 290.5 236.7 219.4 140.8 138.9 131.1
[14:42:02.595] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[14:42:02.639] <TB2> INFO: PixTest:: pg_setup set to default.
[14:42:02.651] <TB2> INFO: enter test to run
[14:42:02.651] <TB2> INFO: test: no parameter change
[14:42:02.912] <TB2> QUIET: Connection to board 162 closed.
[14:42:02.992] <TB2> INFO: pXar: this is the end, my friend

[14:42:35.970] <TB2> INFO: *** Welcome to pxar ***
[14:42:35.970] <TB2> INFO: *** Today: 2016/01/18
[14:42:36.028] <TB2> INFO: *** Version: b2d3
[14:42:36.028] <TB2> INFO: readRocDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//dacParameters35_C15.dat
[14:42:36.029] <TB2> INFO: readTbmDacs: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//tbmParameters_C0b.dat
[14:42:36.029] <TB2> INFO: readMaskFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//defaultMaskFile.dat
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 28 26
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 28 27
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 29 25
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 29 26
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 29 27
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 29 28
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 30 25
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 30 26
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 30 27
[14:42:36.029] <TB2> INFO: MASKED Roc 0 col/row: 30 28
[14:42:36.029] <TB2> INFO: readTrimFile: /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//trimParameters35_C15.dat
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 28 26
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 28 27
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 29 25
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 29 26
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 29 27
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 29 28
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 30 25
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 30 26
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 30 27
[14:42:36.029] <TB2> INFO: masking Roc 0 col/row: 30 28
[14:42:36.105] <TB2> INFO: clk: 4
[14:42:36.105] <TB2> INFO: ctr: 4
[14:42:36.105] <TB2> INFO: sda: 19
[14:42:36.105] <TB2> INFO: tin: 9
[14:42:36.105] <TB2> INFO: level: 15
[14:42:36.105] <TB2> INFO: triggerdelay: 0
[14:42:36.105] <TB2> QUIET: Instanciating API for pxar prod-12
[14:42:36.105] <TB2> INFO: Log level: INFO
[14:42:36.118] <TB2> INFO: Found DTB DTB_WXENWR
[14:42:36.127] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[14:42:36.130] <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:42:36.133] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[14:42:37.708] <TB2> INFO: DUT info:
[14:42:37.708] <TB2> INFO: The DUT currently contains the following objects:
[14:42:37.708] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[14:42:37.708] <TB2> INFO: TBM Core alpha (0): 7 registers set
[14:42:37.708] <TB2> INFO: TBM Core beta (1): 7 registers set
[14:42:37.708] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:42:37.708] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 10 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:37.708] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:42:38.109] <TB2> INFO: enter 'restricted' command line mode
[14:42:38.109] <TB2> INFO: enter test to run
[14:42:38.109] <TB2> INFO: test: PixelAlive no parameter change
[14:42:38.109] <TB2> INFO: running: pixelalive
[14:42:38.114] <TB2> INFO: ######################################################################
[14:42:38.114] <TB2> INFO: PixTestAlive::doTest()
[14:42:38.114] <TB2> INFO: ######################################################################
[14:42:38.115] <TB2> INFO: ----------------------------------------------------------------------
[14:42:38.115] <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)
[14:42:38.115] <TB2> INFO: ----------------------------------------------------------------------
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 28/26
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 28/27
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 29/25
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 29/26
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 29/27
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 29/28
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 30/25
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 30/26
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 30/27
[14:42:38.118] <TB2> INFO: ROC 0 masking pixel 30/28
[14:42:38.445] <TB2> INFO: Expecting 208000 events.
[14:42:48.596] <TB2> INFO: 208000 events read in total (9431ms).
[14:42:48.612] <TB2> INFO: Test took 10494ms.
[14:42:48.625] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:42:48.896] <TB2> INFO: PixTestAlive::aliveTest() done
[14:42:48.896] <TB2> INFO: number of dead pixels (per ROC): 11 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 28/26
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 28/27
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 29/25
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 29/26
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 29/27
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 29/28
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 30/25
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 30/26
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 30/27
[14:42:48.896] <TB2> INFO: ROC 0 masking pixel 30/28
[14:42:48.898] <TB2> INFO: ----------------------------------------------------------------------
[14:42:48.898] <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)
[14:42:48.898] <TB2> INFO: ----------------------------------------------------------------------
[14:42:49.203] <TB2> INFO: Expecting 208000 events.
[14:42:55.974] <TB2> INFO: 208000 events read in total (6054ms).
[14:42:55.975] <TB2> INFO: Test took 7075ms.
[14:42:55.975] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:42:55.975] <TB2> INFO: ROC 0 masking pixel 28/26
[14:42:55.975] <TB2> INFO: ROC 0 masking pixel 28/27
[14:42:55.976] <TB2> INFO: ROC 0 masking pixel 29/25
[14:42:55.976] <TB2> INFO: ROC 0 masking pixel 29/26
[14:42:55.976] <TB2> INFO: ROC 0 masking pixel 29/27
[14:42:55.976] <TB2> INFO: ROC 0 masking pixel 29/28
[14:42:55.976] <TB2> INFO: ROC 0 masking pixel 30/25
[14:42:55.976] <TB2> INFO: ROC 0 masking pixel 30/26
[14:42:55.976] <TB2> INFO: ROC 0 masking pixel 30/27
[14:42:55.976] <TB2> INFO: ROC 0 masking pixel 30/28
[14:42:55.976] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:42:56.299] <TB2> INFO: PixTestAlive::maskTest() done
[14:42:56.299] <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
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 28/26
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 28/27
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 29/25
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 29/26
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 29/27
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 29/28
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 30/25
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 30/26
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 30/27
[14:42:56.299] <TB2> INFO: ROC 0 masking pixel 30/28
[14:42:56.301] <TB2> INFO: ----------------------------------------------------------------------
[14:42:56.301] <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)
[14:42:56.301] <TB2> INFO: ----------------------------------------------------------------------
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 28/26
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 28/27
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 29/25
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 29/26
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 29/27
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 29/28
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 30/25
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 30/26
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 30/27
[14:42:56.303] <TB2> INFO: ROC 0 masking pixel 30/28
[14:42:56.607] <TB2> INFO: Expecting 208000 events.
[14:43:06.864] <TB2> INFO: 208000 events read in total (9540ms).
[14:43:06.865] <TB2> INFO: Test took 10562ms.
[14:43:06.874] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:07.115] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[14:43:07.115] <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
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 28/26
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 28/27
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 29/25
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 29/26
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 29/27
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 29/28
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 30/25
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 30/26
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 30/27
[14:43:07.115] <TB2> INFO: ROC 0 masking pixel 30/28
[14:43:07.115] <TB2> INFO: PixTestAlive::doTest() done, duration: 29 seconds
[14:43:07.151] <TB2> INFO: enter test to run
[14:43:07.151] <TB2> INFO: test: delay setting parameters: ->2<-
[14:43:07.152] <TB2> INFO: delay test by 2 seconds...
[14:43:09.152] <TB2> INFO: enter test to run
[14:43:09.152] <TB2> INFO: test: HighRate no parameter change
[14:43:09.152] <TB2> INFO: running: highrate
[14:43:09.152] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2130_XrayQualification_2016-01-18_14h11m_1453122689//017_HREfficiency_250//phCalibrationFitErr35_C15.dat
[14:43:09.319] <TB2> INFO: ----------------------------------------------------------------------
[14:43:09.319] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:43:09.319] <TB2> INFO: ----------------------------------------------------------------------
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 28/26
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 28/27
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 29/25
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 29/26
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 29/27
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 29/28
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 30/25
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 30/26
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 30/27
[14:43:09.323] <TB2> INFO: ROC 0 masking pixel 30/28
[14:43:09.952] <TB2> INFO: Expecting 208000 events.
[14:43:41.954] <TB2> INFO: 174000 events read in total (31474ms).
[14:43:48.712] <TB2> INFO: 208000 events read in total (38232ms).
[14:43:48.732] <TB2> INFO: Test took 39409ms.
[14:43:50.217] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:50.923] <TB2> INFO: number of dead pixels (per ROC): 10 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:43:50.923] <TB2> INFO: number of red-efficiency pixels: 3086 2718 2111 4073 4068 4151 4128 4158 4157 4154 4160 4054 4037 2217 2608 2935
[14:43:50.923] <TB2> INFO: number of X-ray hits detected: 563644 576576 552619 972726 945529 1136706 1082493 1186048 1166035 1177760 1216005 988406 921925 592153 584500 550905
[14:43:50.923] <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
[14:43:50.923] <TB2> INFO: number of Vcal hits detected: 201071 202944 200340 186644 187354 175286 178608 172689 172657 169501 168082 184686 189638 198598 203207 201926
[14:43:50.923] <TB2> INFO: Vcal hit fiducial efficiency (%): 97.1 97.8 97.0 90.7 91.0 85.5 87.1 84.0 83.9 82.8 82.1 89.9 91.9 96.2 97.9 97.4
[14:43:50.923] <TB2> INFO: Vcal hit overall efficiency (%): 96.7 97.6 96.3 89.7 90.1 84.3 85.9 83.0 83.0 81.5 80.8 88.8 91.2 95.5 97.7 97.1
[14:43:50.923] <TB2> INFO: X-ray hit rate [MHz/cm2]: 165.2 169.0 162.0 285.1 277.1 333.2 317.3 347.6 341.8 345.2 356.4 289.7 270.2 173.6 171.3 161.5
[14:43:50.923] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[14:43:50.968] <TB2> INFO: PixTest:: pg_setup set to default.
[14:43:50.981] <TB2> INFO: enter test to run
[14:43:50.981] <TB2> INFO: test: no parameter change
[14:43:51.175] <TB2> QUIET: Connection to board 162 closed.
[14:43:51.256] <TB2> INFO: pXar: this is the end, my friend