[09:28:17.650] <TB1> INFO: *** Welcome to pxar ***
[09:28:17.650] <TB1> INFO: *** Today: 2015/12/16
[09:28:17.712] <TB1> INFO: *** Version: b2d3
[09:28:17.712] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//dacParameters35_C15.dat
[09:28:17.713] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//tbmParameters_C0b.dat
[09:28:17.713] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//defaultMaskFile.dat
[09:28:17.713] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//000_PixelAlive_p17//trimParameters35_C15.dat
[09:28:17.787] <TB1> INFO: clk: 4
[09:28:17.787] <TB1> INFO: ctr: 4
[09:28:17.787] <TB1> INFO: sda: 19
[09:28:17.787] <TB1> INFO: tin: 9
[09:28:17.787] <TB1> INFO: level: 15
[09:28:17.787] <TB1> INFO: triggerdelay: 0
[09:28:17.787] <TB1> QUIET: Instanciating API for pxar prod-12
[09:28:17.787] <TB1> INFO: Log level: INFO
[09:28:17.799] <TB1> INFO: Found DTB DTB_WWXTQT
[09:28:17.811] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[09:28:17.814] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[09:28:17.817] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[09:28:19.343] <TB1> INFO: DUT info:
[09:28:19.343] <TB1> INFO: The DUT currently contains the following objects:
[09:28:19.343] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:28:19.343] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:28:19.343] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:28:19.343] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:28:19.343] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.343] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:28:19.745] <TB1> INFO: enter 'restricted' command line mode
[09:28:19.745] <TB1> INFO: enter test to run
[09:28:19.745] <TB1> INFO: test: PixelAlive no parameter change
[09:28:19.745] <TB1> INFO: running: pixelalive
[09:28:19.752] <TB1> INFO: ######################################################################
[09:28:19.752] <TB1> INFO: PixTestAlive::doTest()
[09:28:19.752] <TB1> INFO: ######################################################################
[09:28:19.753] <TB1> INFO: ----------------------------------------------------------------------
[09:28:19.754] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:28:19.754] <TB1> INFO: ----------------------------------------------------------------------
[09:28:20.073] <TB1> INFO: Expecting 41600 events.
[09:28:24.770] <TB1> INFO: 41600 events read in total (3979ms).
[09:28:24.850] <TB1> INFO: Test took 5095ms.
[09:28:24.856] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:28:25.108] <TB1> INFO: PixTestAlive::aliveTest() done
[09:28:25.108] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 2 0 2 0
[09:28:25.109] <TB1> INFO: ----------------------------------------------------------------------
[09:28:25.109] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:28:25.109] <TB1> INFO: ----------------------------------------------------------------------
[09:28:25.408] <TB1> INFO: Expecting 41600 events.
[09:28:28.699] <TB1> INFO: 41600 events read in total (2575ms).
[09:28:28.699] <TB1> INFO: Test took 3588ms.
[09:28:28.699] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:28:28.700] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:28:29.018] <TB1> INFO: PixTestAlive::maskTest() done
[09:28:29.018] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:28:29.020] <TB1> INFO: ----------------------------------------------------------------------
[09:28:29.020] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:28:29.020] <TB1> INFO: ----------------------------------------------------------------------
[09:28:29.324] <TB1> INFO: Expecting 41600 events.
[09:28:33.768] <TB1> INFO: 41600 events read in total (3728ms).
[09:28:33.769] <TB1> INFO: Test took 4747ms.
[09:28:33.775] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:28:34.070] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[09:28:34.070] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:28:34.070] <TB1> INFO: PixTestAlive::doTest() done, duration: 14 seconds
[09:28:34.112] <TB1> INFO: enter test to run
[09:28:34.112] <TB1> INFO: test: no parameter change
[09:28:34.154] <TB1> QUIET: Connection to board 147 closed.
[09:28:34.233] <TB1> INFO: pXar: this is the end, my friend

[09:33:58.952] <TB1> INFO: *** Welcome to pxar ***
[09:33:58.952] <TB1> INFO: *** Today: 2015/12/16
[09:33:59.017] <TB1> INFO: *** Version: b2d3
[09:33:59.017] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//dacParameters35_C15.dat
[09:33:59.018] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[09:33:59.018] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:33:59.018] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:33:59.088] <TB1> INFO: clk: 4
[09:33:59.088] <TB1> INFO: ctr: 4
[09:33:59.088] <TB1> INFO: sda: 19
[09:33:59.088] <TB1> INFO: tin: 9
[09:33:59.088] <TB1> INFO: level: 15
[09:33:59.088] <TB1> INFO: triggerdelay: 0
[09:33:59.088] <TB1> QUIET: Instanciating API for pxar prod-12
[09:33:59.088] <TB1> INFO: Log level: INFO
[09:33:59.102] <TB1> INFO: Found DTB DTB_WWXTQT
[09:33:59.113] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[09:33:59.117] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[09:33:59.119] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[09:34:00.645] <TB1> INFO: DUT info:
[09:34:00.645] <TB1> INFO: The DUT currently contains the following objects:
[09:34:00.645] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:34:00.645] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:34:00.645] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:34:00.645] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:34:00.645] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:00.645] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:01.046] <TB1> INFO: enter 'restricted' command line mode
[09:34:01.046] <TB1> INFO: enter test to run
[09:34:01.046] <TB1> INFO: test: delay setting parameters: ->5<-
[09:34:01.046] <TB1> INFO: delay test by 5 seconds...
[09:34:06.046] <TB1> INFO: enter test to run
[09:34:06.046] <TB1> INFO: test: highrate no parameter change
[09:34:06.046] <TB1> INFO: running: highrate
[09:34:06.050] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[09:34:06.199] <TB1> INFO: ----------------------------------------------------------------------
[09:34:06.199] <TB1> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[09:34:06.199] <TB1> INFO: ----------------------------------------------------------------------
[09:34:06.199] <TB1> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[09:34:06.199] <TB1> INFO: edge/corner pixel THR is adjusted
[09:34:06.199] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:34:07.159] <TB1> INFO: Collecting data for 1 seconds...
[09:34:08.161] <TB1> INFO: Done with hot pixel readout
[09:34:17.309] <TB1> INFO: PixTest:: pg_setup set to default.
[09:34:17.310] <TB1> INFO: 2 hot pixels found in step 0
[09:34:18.273] <TB1> INFO: Collecting data for 1 seconds...
[09:34:19.274] <TB1> INFO: Done with hot pixel readout
[09:34:27.889] <TB1> INFO: PixTest:: pg_setup set to default.
[09:34:27.890] <TB1> INFO: 2 hot pixels found in step 1
[09:34:28.853] <TB1> INFO: Collecting data for 1 seconds...
[09:34:29.854] <TB1> INFO: Done with hot pixel readout
[09:34:38.438] <TB1> INFO: PixTest:: pg_setup set to default.
[09:34:38.439] <TB1> INFO: 2 hot pixels found in step 2
[09:34:39.401] <TB1> INFO: Collecting data for 1 seconds...
[09:34:40.403] <TB1> INFO: Done with hot pixel readout
[09:34:48.861] <TB1> INFO: PixTest:: pg_setup set to default.
[09:34:48.862] <TB1> INFO: 0 hot pixels found in step 3
[09:34:48.870] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[09:34:48.901] <TB1> INFO: PixTest::trimHotPixels() done
[09:34:48.902] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C0.dat
[09:34:48.911] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C1.dat
[09:34:48.918] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C2.dat
[09:34:48.925] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C3.dat
[09:34:48.931] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C4.dat
[09:34:48.938] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C5.dat
[09:34:48.945] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C6.dat
[09:34:48.952] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C7.dat
[09:34:48.958] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C8.dat
[09:34:48.965] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C9.dat
[09:34:48.972] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C10.dat
[09:34:48.978] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C11.dat
[09:34:48.985] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C12.dat
[09:34:48.992] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C13.dat
[09:34:48.998] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C14.dat
[09:34:49.005] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//trimParameters35_C15.dat
[09:34:49.011] <TB1> INFO: write masked pixels into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//002_RetrimHotPixels_150//defaultMaskFile.dat
[09:34:49.051] <TB1> INFO: enter test to run
[09:34:49.051] <TB1> INFO: test: no parameter change
[09:34:49.150] <TB1> QUIET: Connection to board 147 closed.
[09:34:49.230] <TB1> INFO: pXar: this is the end, my friend

[09:35:21.591] <TB1> INFO: *** Welcome to pxar ***
[09:35:21.591] <TB1> INFO: *** Today: 2015/12/16
[09:35:21.662] <TB1> INFO: *** Version: b2d3
[09:35:21.662] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//dacParameters35_C15.dat
[09:35:21.663] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0b.dat
[09:35:21.663] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[09:35:21.663] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[09:35:21.732] <TB1> INFO: clk: 4
[09:35:21.732] <TB1> INFO: ctr: 4
[09:35:21.732] <TB1> INFO: sda: 19
[09:35:21.732] <TB1> INFO: tin: 9
[09:35:21.732] <TB1> INFO: level: 15
[09:35:21.732] <TB1> INFO: triggerdelay: 0
[09:35:21.732] <TB1> QUIET: Instanciating API for pxar prod-12
[09:35:21.732] <TB1> INFO: Log level: INFO
[09:35:21.745] <TB1> INFO: Found DTB DTB_WWXTQT
[09:35:21.758] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[09:35:21.761] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[09:35:21.763] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[09:35:23.317] <TB1> INFO: DUT info:
[09:35:23.317] <TB1> INFO: The DUT currently contains the following objects:
[09:35:23.317] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:35:23.317] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:35:23.317] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:35:23.317] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:35:23.318] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.318] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:35:23.720] <TB1> INFO: enter 'restricted' command line mode
[09:35:23.720] <TB1> INFO: enter test to run
[09:35:23.720] <TB1> INFO: test: delay setting parameters: ->5<-
[09:35:23.720] <TB1> INFO: delay test by 5 seconds...
[09:35:28.720] <TB1> INFO: enter test to run
[09:35:28.720] <TB1> INFO: test: highrate no parameter change
[09:35:28.720] <TB1> INFO: running: highrate
[09:35:28.727] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C15.dat
[09:35:28.958] <TB1> INFO: ----------------------------------------------------------------------
[09:35:28.958] <TB1> INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[09:35:28.958] <TB1> INFO: ----------------------------------------------------------------------
[09:35:28.958] <TB1> INFO: THR = 10, corresponding to ~ 5.33333 MHz/cm2
[09:35:28.958] <TB1> INFO: edge/corner pixel THR is adjusted
[09:35:28.958] <TB1> INFO: PixTestHighRate::trimHotPixels: step 0...
[09:35:29.919] <TB1> INFO: Collecting data for 5 seconds...
[09:35:34.924] <TB1> INFO: Done with hot pixel readout
[09:35:47.363] <TB1> INFO: PixTest:: pg_setup set to default.
[09:35:47.364] <TB1> INFO: 1 hot pixels found in step 0
[09:35:48.404] <TB1> INFO: Collecting data for 5 seconds...
[09:35:53.409] <TB1> INFO: Done with hot pixel readout
[09:36:02.999] <TB1> INFO: PixTest:: pg_setup set to default.
[09:36:03.000] <TB1> INFO: 0 hot pixels found in step 1
[09:36:03.002] <TB1> INFO: 0 hot pixels could not be trimmed and have been masked.
[09:36:03.088] <TB1> INFO: PixTest::trimHotPixels() done
[09:36:03.088] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat
[09:36:03.100] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C1.dat
[09:36:03.109] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C2.dat
[09:36:03.115] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C3.dat
[09:36:03.122] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C4.dat
[09:36:03.128] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C5.dat
[09:36:03.133] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C6.dat
[09:36:03.140] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C7.dat
[09:36:03.146] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C8.dat
[09:36:03.152] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C9.dat
[09:36:03.158] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C10.dat
[09:36:03.164] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C11.dat
[09:36:03.170] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C12.dat
[09:36:03.175] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C13.dat
[09:36:03.181] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C14.dat
[09:36:03.187] <TB1> INFO: write trim parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[09:36:03.193] <TB1> INFO: write masked pixels into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[09:36:03.222] <TB1> INFO: enter test to run
[09:36:03.222] <TB1> INFO: test: no parameter change
[09:36:03.298] <TB1> QUIET: Connection to board 147 closed.
[09:36:03.378] <TB1> INFO: pXar: this is the end, my friend

[09:36:37.076] <TB1> INFO: *** Welcome to pxar ***
[09:36:37.076] <TB1> INFO: *** Today: 2015/12/16
[09:36:37.147] <TB1> INFO: *** Version: b2d3
[09:36:37.147] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//dacParameters35_C15.dat
[09:36:37.148] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//tbmParameters_C0b.dat
[09:36:37.148] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//defaultMaskFile.dat
[09:36:37.148] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//trimParameters35_C15.dat
[09:36:37.228] <TB1> INFO: clk: 4
[09:36:37.228] <TB1> INFO: ctr: 4
[09:36:37.228] <TB1> INFO: sda: 19
[09:36:37.228] <TB1> INFO: tin: 9
[09:36:37.228] <TB1> INFO: level: 15
[09:36:37.228] <TB1> INFO: triggerdelay: 0
[09:36:37.228] <TB1> QUIET: Instanciating API for pxar prod-12
[09:36:37.228] <TB1> INFO: Log level: INFO
[09:36:37.242] <TB1> INFO: Found DTB DTB_WWXTQT
[09:36:37.255] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[09:36:37.258] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[09:36:37.261] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[09:36:38.796] <TB1> INFO: DUT info:
[09:36:38.796] <TB1> INFO: The DUT currently contains the following objects:
[09:36:38.796] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:36:38.796] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:36:38.796] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:36:38.796] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:36:38.796] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.796] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.796] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.796] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.796] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.796] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.796] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.796] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.796] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.797] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.797] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.797] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.797] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.797] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.797] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:38.797] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:36:39.198] <TB1> INFO: enter 'restricted' command line mode
[09:36:39.198] <TB1> INFO: enter test to run
[09:36:39.198] <TB1> INFO: test: delay setting parameters: ->5<-
[09:36:39.198] <TB1> INFO: delay test by 5 seconds...
[09:36:44.198] <TB1> INFO: enter test to run
[09:36:44.198] <TB1> INFO: test: Xray no parameter change
[09:36:44.198] <TB1> INFO: running: xray
[09:36:44.201] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//004_HRData_50//phCalibrationFitErr35_C15.dat
[09:36:44.352] <TB1> INFO: ######################################################################
[09:36:44.352] <TB1> INFO: PixTestXray::doTest()
[09:36:44.352] <TB1> INFO: ######################################################################
[09:36:44.352] <TB1> INFO: ----------------------------------------------------------------------
[09:36:44.352] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:36:44.352] <TB1> INFO: ----------------------------------------------------------------------
[09:36:45.316] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:36:51.735] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[09:37:26.545] <TB1> INFO: Resuming triggers.
[09:37:32.971] <TB1> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[09:38:05.644] <TB1> INFO: Resuming triggers.
[09:38:12.071] <TB1> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[09:38:45.521] <TB1> INFO: Resuming triggers.
[09:38:51.944] <TB1> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[09:39:25.571] <TB1> INFO: Resuming triggers.
[09:39:31.998] <TB1> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[09:40:05.654] <TB1> INFO: Resuming triggers.
[09:40:12.076] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[09:40:44.826] <TB1> INFO: Resuming triggers.
[09:40:51.249] <TB1> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[09:41:24.154] <TB1> INFO: Resuming triggers.
[09:41:30.579] <TB1> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[09:42:03.248] <TB1> INFO: Resuming triggers.
[09:42:09.672] <TB1> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[09:42:41.660] <TB1> INFO: Resuming triggers.
[09:42:48.078] <TB1> INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[09:43:22.923] <TB1> INFO: Resuming triggers.
[09:43:29.344] <TB1> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[09:44:02.385] <TB1> INFO: Resuming triggers.
[09:44:08.802] <TB1> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[09:44:42.688] <TB1> INFO: Resuming triggers.
[09:44:49.103] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[09:45:23.408] <TB1> INFO: Resuming triggers.
[09:45:29.829] <TB1> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[09:46:05.126] <TB1> INFO: Resuming triggers.
[09:46:11.542] <TB1> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[09:46:40.610] <TB1> INFO: Resuming triggers.
[09:46:44.381] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[09:46:57.577] <TB1> INFO: PixTest:: pg_setup set to default.
[09:46:57.579] <TB1> INFO: PixTestXray::doPhRun() done
[09:46:57.579] <TB1> INFO: PixTestXray::doTest() done
[09:46:57.829] <TB1> INFO: enter test to run
[09:46:57.829] <TB1> INFO: test: no parameter change
[09:46:57.978] <TB1> QUIET: Connection to board 147 closed.
[09:46:58.058] <TB1> INFO: pXar: this is the end, my friend

[09:47:12.101] <TB1> INFO: *** Welcome to pxar ***
[09:47:12.101] <TB1> INFO: *** Today: 2015/12/16
[09:47:12.171] <TB1> INFO: *** Version: b2d3
[09:47:12.171] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//dacParameters35_C15.dat
[09:47:12.172] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//tbmParameters_C0b.dat
[09:47:12.172] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//defaultMaskFile.dat
[09:47:12.172] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//trimParameters35_C15.dat
[09:47:12.287] <TB1> INFO: clk: 4
[09:47:12.287] <TB1> INFO: ctr: 4
[09:47:12.287] <TB1> INFO: sda: 19
[09:47:12.287] <TB1> INFO: tin: 9
[09:47:12.287] <TB1> INFO: level: 15
[09:47:12.287] <TB1> INFO: triggerdelay: 0
[09:47:12.287] <TB1> QUIET: Instanciating API for pxar prod-12
[09:47:12.287] <TB1> INFO: Log level: INFO
[09:47:12.301] <TB1> INFO: Found DTB DTB_WWXTQT
[09:47:12.314] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[09:47:12.317] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[09:47:12.319] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[09:47:13.871] <TB1> INFO: DUT info:
[09:47:13.871] <TB1> INFO: The DUT currently contains the following objects:
[09:47:13.871] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:47:13.871] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:47:13.871] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:47:13.871] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:47:13.871] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.871] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:13.872] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:47:14.274] <TB1> INFO: enter 'restricted' command line mode
[09:47:14.274] <TB1> INFO: enter test to run
[09:47:14.274] <TB1> INFO: test: delay setting parameters: ->5<-
[09:47:14.274] <TB1> INFO: delay test by 5 seconds...
[09:47:19.274] <TB1> INFO: enter test to run
[09:47:19.274] <TB1> INFO: test: Xray no parameter change
[09:47:19.274] <TB1> INFO: running: xray
[09:47:19.278] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//005_HRData_150//phCalibrationFitErr35_C15.dat
[09:47:19.413] <TB1> INFO: ######################################################################
[09:47:19.413] <TB1> INFO: PixTestXray::doTest()
[09:47:19.413] <TB1> INFO: ######################################################################
[09:47:19.413] <TB1> INFO: ----------------------------------------------------------------------
[09:47:19.413] <TB1> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[09:47:19.413] <TB1> INFO: ----------------------------------------------------------------------
[09:47:20.378] <TB1> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[09:47:23.839] <TB1> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[09:47:57.847] <TB1> INFO: Resuming triggers.
[09:48:01.322] <TB1> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[09:48:34.435] <TB1> INFO: Resuming triggers.
[09:48:37.909] <TB1> INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[09:49:11.401] <TB1> INFO: Resuming triggers.
[09:49:14.876] <TB1> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[09:49:48.286] <TB1> INFO: Resuming triggers.
[09:49:51.760] <TB1> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[09:50:25.404] <TB1> INFO: Resuming triggers.
[09:50:28.879] <TB1> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[09:51:02.294] <TB1> INFO: Resuming triggers.
[09:51:05.768] <TB1> INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[09:51:39.330] <TB1> INFO: Resuming triggers.
[09:51:42.804] <TB1> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[09:52:14.635] <TB1> INFO: Resuming triggers.
[09:52:18.107] <TB1> INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[09:52:51.778] <TB1> INFO: Resuming triggers.
[09:52:55.255] <TB1> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[09:53:28.045] <TB1> INFO: Resuming triggers.
[09:53:31.517] <TB1> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[09:54:05.174] <TB1> INFO: Resuming triggers.
[09:54:08.647] <TB1> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[09:54:41.457] <TB1> INFO: Resuming triggers.
[09:54:44.930] <TB1> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[09:55:18.447] <TB1> INFO: Resuming triggers.
[09:55:21.921] <TB1> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[09:55:55.347] <TB1> INFO: Resuming triggers.
[09:55:58.821] <TB1> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[09:56:32.132] <TB1> INFO: Resuming triggers.
[09:56:35.605] <TB1> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[09:57:08.510] <TB1> INFO: Resuming triggers.
[09:57:11.984] <TB1> INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[09:57:44.464] <TB1> INFO: Resuming triggers.
[09:57:47.937] <TB1> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[09:58:21.300] <TB1> INFO: Resuming triggers.
[09:58:24.772] <TB1> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[09:58:58.157] <TB1> INFO: Resuming triggers.
[09:59:01.630] <TB1> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[09:59:35.969] <TB1> INFO: Resuming triggers.
[09:59:39.441] <TB1> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[10:00:13.418] <TB1> INFO: Resuming triggers.
[10:00:16.888] <TB1> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[10:00:53.868] <TB1> INFO: Resuming triggers.
[10:00:57.340] <TB1> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[10:01:32.979] <TB1> INFO: Resuming triggers.
[10:01:36.451] <TB1> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[10:02:10.528] <TB1> INFO: Resuming triggers.
[10:02:13.998] <TB1> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[10:02:49.680] <TB1> INFO: Resuming triggers.
[10:02:53.150] <TB1> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[10:03:20.960] <TB1> INFO: Resuming triggers.
[10:03:24.430] <TB1> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[10:03:46.498] <TB1> INFO: Resuming triggers.
[10:03:49.969] <TB1> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[10:04:12.079] <TB1> INFO: Resuming triggers.
[10:04:14.930] <TB1> INFO: data taking finished, elapsed time: 100 seconds.
[10:04:33.457] <TB1> INFO: PixTest:: pg_setup set to default.
[10:04:33.459] <TB1> INFO: PixTestXray::doPhRun() done
[10:04:33.459] <TB1> INFO: PixTestXray::doTest() done
[10:04:33.642] <TB1> INFO: enter test to run
[10:04:33.642] <TB1> INFO: test: no parameter change
[10:04:33.769] <TB1> QUIET: Connection to board 147 closed.
[10:04:33.849] <TB1> INFO: pXar: this is the end, my friend

[10:04:47.508] <TB1> INFO: *** Welcome to pxar ***
[10:04:47.508] <TB1> INFO: *** Today: 2015/12/16
[10:04:47.571] <TB1> INFO: *** Version: b2d3
[10:04:47.571] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//dacParameters35_C15.dat
[10:04:47.572] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//tbmParameters_C0b.dat
[10:04:47.572] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//defaultMaskFile.dat
[10:04:47.572] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//trimParameters35_C15.dat
[10:04:47.640] <TB1> INFO: clk: 4
[10:04:47.640] <TB1> INFO: ctr: 4
[10:04:47.640] <TB1> INFO: sda: 19
[10:04:47.640] <TB1> INFO: tin: 9
[10:04:47.640] <TB1> INFO: level: 15
[10:04:47.640] <TB1> INFO: triggerdelay: 0
[10:04:47.640] <TB1> QUIET: Instanciating API for pxar prod-12
[10:04:47.640] <TB1> INFO: Log level: INFO
[10:04:47.653] <TB1> INFO: Found DTB DTB_WWXTQT
[10:04:47.664] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[10:04:47.668] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[10:04:47.670] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[10:04:49.188] <TB1> INFO: DUT info:
[10:04:49.188] <TB1> INFO: The DUT currently contains the following objects:
[10:04:49.188] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[10:04:49.188] <TB1> INFO: TBM Core alpha (0): 7 registers set
[10:04:49.188] <TB1> INFO: TBM Core beta (1): 7 registers set
[10:04:49.188] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:04:49.188] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.188] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:04:49.589] <TB1> INFO: enter 'restricted' command line mode
[10:04:49.589] <TB1> INFO: enter test to run
[10:04:49.589] <TB1> INFO: test: Highrate no parameter change
[10:04:49.590] <TB1> INFO: running: highrate
[10:04:49.593] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[10:04:49.758] <TB1> INFO: ----------------------------------------------------------------------
[10:04:49.758] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[10:04:49.758] <TB1> INFO: ----------------------------------------------------------------------
[10:04:49.763] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[10:04:49.774] <TB1> INFO: dacScan step from 15 .. 34
[10:04:49.774] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[10:04:49.774] <TB1> INFO: run 1 of 1
[10:04:50.366] <TB1> INFO: Expecting 4160000 events.
[10:05:29.669] <TB1> INFO: 448700 events read in total (38773ms).
[10:06:08.952] <TB1> INFO: 900050 events read in total (78056ms).
[10:06:47.832] <TB1> INFO: 1351350 events read in total (116936ms).
[10:07:26.443] <TB1> INFO: 1802700 events read in total (155547ms).
[10:08:05.071] <TB1> INFO: 2254250 events read in total (194175ms).
[10:08:41.956] <TB1> INFO: 2705050 events read in total (231060ms).
[10:09:18.475] <TB1> INFO: 3156250 events read in total (267579ms).
[10:09:56.935] <TB1> INFO: 3607300 events read in total (306039ms).
[10:10:38.055] <TB1> INFO: 4058050 events read in total (347159ms).
[10:10:46.690] <TB1> INFO: 4160000 events read in total (355794ms).
[10:10:46.986] <TB1> INFO: Test took 357212ms.
[10:10:48.768] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:10:54.808] <TB1> INFO: dacScan step from 35 .. 54
[10:10:54.808] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[10:10:54.808] <TB1> INFO: run 1 of 1
[10:10:55.423] <TB1> INFO: Expecting 4160000 events.
[10:11:33.904] <TB1> INFO: 376050 events read in total (37949ms).
[10:12:10.822] <TB1> INFO: 752750 events read in total (74867ms).
[10:12:48.118] <TB1> INFO: 1128650 events read in total (112163ms).
[10:13:26.104] <TB1> INFO: 1503850 events read in total (150149ms).
[10:14:06.032] <TB1> INFO: 1877850 events read in total (190077ms).
[10:14:44.195] <TB1> INFO: 2249850 events read in total (228240ms).
[10:15:22.743] <TB1> INFO: 2619650 events read in total (266788ms).
[10:15:59.567] <TB1> INFO: 2986550 events read in total (303612ms).
[10:16:34.766] <TB1> INFO: 3351050 events read in total (338811ms).
[10:17:12.492] <TB1> INFO: 3713500 events read in total (376537ms).
[10:17:49.249] <TB1> INFO: 4075250 events read in total (413294ms).
[10:17:58.096] <TB1> INFO: 4160000 events read in total (422141ms).
[10:17:58.289] <TB1> INFO: Test took 423481ms.
[10:18:00.108] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:18:05.823] <TB1> INFO: dacScan step from 55 .. 74
[10:18:05.823] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[10:18:05.823] <TB1> INFO: run 1 of 1
[10:18:06.417] <TB1> INFO: Expecting 4160000 events.
[10:18:44.929] <TB1> INFO: 334450 events read in total (37981ms).
[10:19:23.260] <TB1> INFO: 669550 events read in total (76312ms).
[10:20:01.127] <TB1> INFO: 1005000 events read in total (114179ms).
[10:20:38.140] <TB1> INFO: 1340650 events read in total (151192ms).
[10:21:14.944] <TB1> INFO: 1676100 events read in total (187996ms).
[10:21:51.794] <TB1> INFO: 2011500 events read in total (224846ms).
[10:22:26.684] <TB1> INFO: 2346950 events read in total (259736ms).









[10:23:03.232] <TB1> INFO: 2682300 events read in total (296284ms).
[10:23:37.491] <TB1> INFO: 3017400 events read in total (330544ms).
[10:24:09.918] <TB1> INFO: 3352650 events read in total (362970ms).
[10:24:41.415] <TB1> INFO: 3688100 events read in total (394467ms).
[10:25:12.497] <TB1> INFO: 4023100 events read in total (425549ms).
[10:25:25.658] <TB1> INFO: 4160000 events read in total (438710ms).
[10:25:25.867] <TB1> INFO: Test took 440044ms.
[10:25:27.684] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:33.767] <TB1> INFO: dacScan step from 75 .. 75
[10:25:33.767] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[10:25:33.767] <TB1> INFO: run 1 of 1
[10:25:34.393] <TB1> INFO: Expecting 208000 events.
[10:25:55.577] <TB1> INFO: 208000 events read in total (20657ms).
[10:25:55.585] <TB1> INFO: Test took 21817ms.
[10:25:55.681] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:25:56.034] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:25:57.143] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:25:58.197] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:25:59.252] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:00.311] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:01.367] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:02.431] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:03.524] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:04.603] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:05.690] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:06.794] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:07.909] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:09.001] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:10.080] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:11.126] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:12.152] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[10:26:13.185] <TB1> INFO: PixTest:: pg_setup set to default.
[10:26:13.187] <TB1> INFO: vcal mean: 39.03 38.89 38.44 41.53 41.32 42.78 42.45 42.84 43.71 42.10 43.02 41.10 41.35 38.81 39.00 38.64
[10:26:13.187] <TB1> INFO: vcal RMS: 1.11 1.23 0.94 1.43 1.17 1.42 1.57 1.57 1.51 1.37 1.45 1.38 1.41 1.19 1.41 1.17
[10:26:13.187] <TB1> INFO: number of X-ray hits detected: 220829 214543 203274 345256 337161 410662 371182 407157 428870 377962 408361 318611 332766 189498 225813 215263
[10:26:13.187] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:26:13.187] <TB1> INFO: X-ray hit rate [MHz/cm2]: 64.7 62.9 59.6 101.2 98.8 120.4 108.8 119.3 125.7 110.8 119.7 93.4 97.5 55.5 66.2 63.1
[10:26:13.187] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[10:26:13.323] <TB1> INFO: enter test to run
[10:26:13.323] <TB1> INFO: test: no parameter change
[10:26:13.420] <TB1> QUIET: Connection to board 147 closed.
[10:26:13.499] <TB1> INFO: pXar: this is the end, my friend

[11:47:13.235] <TB1> INFO: *** Welcome to pxar ***
[11:47:13.235] <TB1> INFO: *** Today: 2015/12/16
[11:47:13.301] <TB1> INFO: *** Version: b2d3
[11:47:13.301] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:47:13.302] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[11:47:13.302] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[11:47:13.302] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[11:47:13.376] <TB1> INFO: clk: 4
[11:47:13.376] <TB1> INFO: ctr: 4
[11:47:13.376] <TB1> INFO: sda: 19
[11:47:13.376] <TB1> INFO: tin: 9
[11:47:13.376] <TB1> INFO: level: 15
[11:47:13.376] <TB1> INFO: triggerdelay: 0
[11:47:13.376] <TB1> QUIET: Instanciating API for pxar prod-12
[11:47:13.376] <TB1> INFO: Log level: INFO
[11:47:13.388] <TB1> INFO: Found DTB DTB_WWXTQT
[11:47:13.400] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:47:13.404] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:47:13.406] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:47:14.922] <TB1> INFO: DUT info:
[11:47:14.922] <TB1> INFO: The DUT currently contains the following objects:
[11:47:14.922] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:47:14.922] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:47:14.922] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:47:14.922] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:47:14.922] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.922] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.922] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.922] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.922] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.922] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.922] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.922] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.922] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.923] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.923] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.923] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.923] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.923] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.923] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:14.923] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:47:15.324] <TB1> INFO: enter 'restricted' command line mode
[11:47:15.324] <TB1> INFO: enter test to run
[11:47:15.324] <TB1> INFO: test: HighRate no parameter change
[11:47:15.324] <TB1> INFO: running: highrate
[11:47:15.327] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[11:47:15.464] <TB1> INFO: ----------------------------------------------------------------------
[11:47:15.464] <TB1> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:47:15.464] <TB1> INFO: ----------------------------------------------------------------------
[11:47:15.600] <TB1> INFO: Expecting 768 events.
[11:47:16.834] <TB1> INFO: 768 events read in total (516ms).
[11:47:16.929] <TB1> INFO: Test took 1461ms.
[11:47:17.570] <TB1> INFO: Expecting 41600 events.
[11:47:22.152] <TB1> INFO: 41600 events read in total (4055ms).
[11:47:22.154] <TB1> INFO: Test took 5221ms.
[11:47:22.233] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:22.874] <TB1> INFO: Expecting 41600 events.
[11:47:27.482] <TB1> INFO: 41600 events read in total (4081ms).
[11:47:27.483] <TB1> INFO: Test took 5221ms.
[11:47:27.569] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:28.220] <TB1> INFO: Expecting 41600 events.
[11:47:32.813] <TB1> INFO: 41600 events read in total (4066ms).
[11:47:32.815] <TB1> INFO: Test took 5215ms.
[11:47:32.893] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:33.534] <TB1> INFO: Expecting 41600 events.
[11:47:38.225] <TB1> INFO: 41600 events read in total (4163ms).
[11:47:38.227] <TB1> INFO: Test took 5305ms.
[11:47:38.313] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:38.977] <TB1> INFO: Expecting 41600 events.
[11:47:43.487] <TB1> INFO: 41600 events read in total (3982ms).
[11:47:43.489] <TB1> INFO: Test took 5137ms.
[11:47:43.571] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:44.214] <TB1> INFO: Expecting 41600 events.
[11:47:48.881] <TB1> INFO: 41600 events read in total (4140ms).
[11:47:48.883] <TB1> INFO: Test took 5281ms.
[11:47:48.973] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:49.638] <TB1> INFO: Expecting 41600 events.
[11:47:54.229] <TB1> INFO: 41600 events read in total (4064ms).
[11:47:54.231] <TB1> INFO: Test took 5220ms.
[11:47:54.323] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:54.984] <TB1> INFO: Expecting 41600 events.
[11:47:59.418] <TB1> INFO: 41600 events read in total (3907ms).
[11:47:59.420] <TB1> INFO: Test took 5061ms.
[11:47:59.510] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:00.167] <TB1> INFO: Expecting 41600 events.
[11:48:04.987] <TB1> INFO: 41600 events read in total (4293ms).
[11:48:04.989] <TB1> INFO: Test took 5446ms.
[11:48:05.076] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:05.721] <TB1> INFO: Expecting 41600 events.
[11:48:10.315] <TB1> INFO: 41600 events read in total (4067ms).
[11:48:10.317] <TB1> INFO: Test took 5208ms.
[11:48:10.397] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:11.039] <TB1> INFO: Expecting 41600 events.
[11:48:15.570] <TB1> INFO: 41600 events read in total (4003ms).
[11:48:15.572] <TB1> INFO: Test took 5145ms.
[11:48:15.656] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:16.299] <TB1> INFO: Expecting 41600 events.
[11:48:20.890] <TB1> INFO: 41600 events read in total (4063ms).
[11:48:20.892] <TB1> INFO: Test took 5205ms.
[11:48:20.974] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:21.616] <TB1> INFO: Expecting 41600 events.
[11:48:26.461] <TB1> INFO: 41600 events read in total (4318ms).
[11:48:26.463] <TB1> INFO: Test took 5459ms.
[11:48:26.553] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:27.197] <TB1> INFO: Expecting 41600 events.
[11:48:32.284] <TB1> INFO: 41600 events read in total (4560ms).
[11:48:32.286] <TB1> INFO: Test took 5703ms.
[11:48:32.372] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:33.019] <TB1> INFO: Expecting 41600 events.
[11:48:37.950] <TB1> INFO: 41600 events read in total (4404ms).
[11:48:37.953] <TB1> INFO: Test took 5546ms.
[11:48:38.059] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:38.749] <TB1> INFO: Expecting 41600 events.
[11:48:43.518] <TB1> INFO: 41600 events read in total (4242ms).
[11:48:43.519] <TB1> INFO: Test took 5413ms.
[11:48:43.610] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:44.254] <TB1> INFO: Expecting 41600 events.
[11:48:48.897] <TB1> INFO: 41600 events read in total (4116ms).
[11:48:48.900] <TB1> INFO: Test took 5257ms.
[11:48:48.991] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:49.633] <TB1> INFO: Expecting 41600 events.
[11:48:53.607] <TB1> INFO: 41600 events read in total (3447ms).
[11:48:53.609] <TB1> INFO: Test took 4588ms.
[11:48:53.699] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:54.370] <TB1> INFO: Expecting 41600 events.
[11:48:58.325] <TB1> INFO: 41600 events read in total (3428ms).
[11:48:58.327] <TB1> INFO: Test took 4594ms.
[11:48:58.417] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:59.068] <TB1> INFO: Expecting 41600 events.
[11:49:02.880] <TB1> INFO: 41600 events read in total (3285ms).
[11:49:02.881] <TB1> INFO: Test took 4425ms.
[11:49:02.962] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:03.297] <TB1> INFO: enter test to run
[11:49:03.297] <TB1> INFO: test: Pretest no parameter change
[11:49:03.297] <TB1> INFO: running: pretest
[11:49:03.297] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[11:49:03.297] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[11:49:03.297] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[11:49:03.297] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[11:49:03.297] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[11:49:03.298] <TB1> INFO: write dac parameters into /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:49:03.298] <TB1> INFO: enter test to run
[11:49:03.298] <TB1> INFO: test: no parameter change
[11:49:03.390] <TB1> QUIET: Connection to board 147 closed.
[11:49:03.469] <TB1> INFO: pXar: this is the end, my friend

[11:49:27.437] <TB1> INFO: *** Welcome to pxar ***
[11:49:27.437] <TB1> INFO: *** Today: 2015/12/16
[11:49:27.504] <TB1> INFO: *** Version: b2d3
[11:49:27.504] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//dacParameters35_C15.dat
[11:49:27.505] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//tbmParameters_C0b.dat
[11:49:27.505] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//defaultMaskFile.dat
[11:49:27.505] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//trimParameters35_C15.dat
[11:49:27.577] <TB1> INFO: clk: 4
[11:49:27.577] <TB1> INFO: ctr: 4
[11:49:27.577] <TB1> INFO: sda: 19
[11:49:27.577] <TB1> INFO: tin: 9
[11:49:27.577] <TB1> INFO: level: 15
[11:49:27.577] <TB1> INFO: triggerdelay: 0
[11:49:27.577] <TB1> QUIET: Instanciating API for pxar prod-12
[11:49:27.577] <TB1> INFO: Log level: INFO
[11:49:27.590] <TB1> INFO: Found DTB DTB_WWXTQT
[11:49:27.602] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:49:27.605] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:49:27.608] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:49:29.129] <TB1> INFO: DUT info:
[11:49:29.129] <TB1> INFO: The DUT currently contains the following objects:
[11:49:29.129] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:49:29.129] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:49:29.129] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:49:29.129] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:49:29.129] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.129] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:49:29.530] <TB1> INFO: enter 'restricted' command line mode
[11:49:29.530] <TB1> INFO: enter test to run
[11:49:29.530] <TB1> INFO: test: PixelAlive no parameter change
[11:49:29.530] <TB1> INFO: running: pixelalive
[11:49:29.537] <TB1> INFO: ######################################################################
[11:49:29.537] <TB1> INFO: PixTestAlive::doTest()
[11:49:29.537] <TB1> INFO: ######################################################################
[11:49:29.538] <TB1> INFO: ----------------------------------------------------------------------
[11:49:29.538] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:49:29.538] <TB1> INFO: ----------------------------------------------------------------------
[11:49:29.855] <TB1> INFO: Expecting 208000 events.
[11:49:42.564] <TB1> INFO: 208000 events read in total (11991ms).
[11:49:42.571] <TB1> INFO: Test took 13031ms.
[11:49:42.582] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:42.850] <TB1> INFO: PixTestAlive::aliveTest() done
[11:49:42.850] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:49:42.851] <TB1> INFO: ----------------------------------------------------------------------
[11:49:42.851] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:49:42.851] <TB1> INFO: ----------------------------------------------------------------------
[11:49:43.181] <TB1> INFO: Expecting 208000 events.
[11:49:51.795] <TB1> INFO: 208000 events read in total (7898ms).
[11:49:51.796] <TB1> INFO: Test took 8943ms.
[11:49:51.796] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:51.796] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:49:52.107] <TB1> INFO: PixTestAlive::maskTest() done
[11:49:52.107] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:49:52.109] <TB1> INFO: ----------------------------------------------------------------------
[11:49:52.109] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:49:52.109] <TB1> INFO: ----------------------------------------------------------------------
[11:49:52.432] <TB1> INFO: Expecting 208000 events.
[11:50:05.312] <TB1> INFO: 208000 events read in total (12164ms).
[11:50:05.312] <TB1> INFO: Test took 13201ms.
[11:50:05.321] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:05.556] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:50:05.556] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:50:05.556] <TB1> INFO: PixTestAlive::doTest() done, duration: 36 seconds
[11:50:05.595] <TB1> INFO: enter test to run
[11:50:05.595] <TB1> INFO: test: delay setting parameters: ->2<-
[11:50:05.595] <TB1> INFO: delay test by 2 seconds...
[11:50:07.595] <TB1> INFO: enter test to run
[11:50:07.595] <TB1> INFO: test: HighRate no parameter change
[11:50:07.595] <TB1> INFO: running: highrate
[11:50:07.595] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[11:50:07.744] <TB1> INFO: ----------------------------------------------------------------------
[11:50:07.744] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:50:07.744] <TB1> INFO: ----------------------------------------------------------------------
[11:50:08.358] <TB1> INFO: Expecting 208000 events.
[11:50:23.665] <TB1> INFO: 208000 events read in total (14780ms).
[11:50:23.671] <TB1> INFO: Test took 15923ms.
[11:50:23.995] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:24.303] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:50:24.304] <TB1> INFO: number of red-efficiency pixels: 155 150 152 245 231 351 280 369 297 301 313 202 277 111 151 110
[11:50:24.304] <TB1> INFO: number of X-ray hits detected: 110992 104948 99722 174516 168701 206976 184707 205356 217109 190920 206560 158858 168474 92530 112152 107587
[11:50:24.304] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:50:24.304] <TB1> INFO: number of Vcal hits detected: 207843 207847 207844 207745 207759 207611 207663 207555 207682 207690 207670 207791 207709 207885 207749 207885
[11:50:24.304] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.8 99.9 99.9 99.9 99.9 99.9 100.0 99.9 99.9
[11:50:24.304] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.9 99.8 99.9 99.9 99.9 99.9 99.9
[11:50:24.304] <TB1> INFO: X-ray hit rate [MHz/cm2]: 32.5 30.8 29.2 51.2 49.4 60.7 54.1 60.2 63.6 56.0 60.5 46.6 49.4 27.1 32.9 31.5
[11:50:24.304] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:50:24.339] <TB1> INFO: PixTest:: pg_setup set to default.
[11:50:24.351] <TB1> INFO: enter test to run
[11:50:24.351] <TB1> INFO: test: no parameter change
[11:50:24.438] <TB1> QUIET: Connection to board 147 closed.
[11:50:24.521] <TB1> INFO: pXar: this is the end, my friend

[11:50:54.135] <TB1> INFO: *** Welcome to pxar ***
[11:50:54.135] <TB1> INFO: *** Today: 2015/12/16
[11:50:54.199] <TB1> INFO: *** Version: b2d3
[11:50:54.199] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//dacParameters35_C15.dat
[11:50:54.200] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//tbmParameters_C0b.dat
[11:50:54.200] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//defaultMaskFile.dat
[11:50:54.200] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//trimParameters35_C15.dat
[11:50:54.272] <TB1> INFO: clk: 4
[11:50:54.272] <TB1> INFO: ctr: 4
[11:50:54.272] <TB1> INFO: sda: 19
[11:50:54.272] <TB1> INFO: tin: 9
[11:50:54.272] <TB1> INFO: level: 15
[11:50:54.272] <TB1> INFO: triggerdelay: 0
[11:50:54.272] <TB1> QUIET: Instanciating API for pxar prod-12
[11:50:54.272] <TB1> INFO: Log level: INFO
[11:50:54.285] <TB1> INFO: Found DTB DTB_WWXTQT
[11:50:54.296] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:50:54.299] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:50:54.302] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:50:55.821] <TB1> INFO: DUT info:
[11:50:55.821] <TB1> INFO: The DUT currently contains the following objects:
[11:50:55.821] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:50:55.821] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:50:55.821] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:50:55.821] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:50:55.821] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.821] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.822] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.822] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.822] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.822] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:55.822] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:50:56.223] <TB1> INFO: enter 'restricted' command line mode
[11:50:56.223] <TB1> INFO: enter test to run
[11:50:56.223] <TB1> INFO: test: PixelAlive no parameter change
[11:50:56.223] <TB1> INFO: running: pixelalive
[11:50:56.229] <TB1> INFO: ######################################################################
[11:50:56.229] <TB1> INFO: PixTestAlive::doTest()
[11:50:56.229] <TB1> INFO: ######################################################################
[11:50:56.231] <TB1> INFO: ----------------------------------------------------------------------
[11:50:56.231] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:50:56.231] <TB1> INFO: ----------------------------------------------------------------------
[11:50:56.559] <TB1> INFO: Expecting 208000 events.
[11:51:09.448] <TB1> INFO: 208000 events read in total (12171ms).
[11:51:09.465] <TB1> INFO: Test took 13233ms.
[11:51:09.475] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:09.735] <TB1> INFO: PixTestAlive::aliveTest() done
[11:51:09.735] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:51:09.737] <TB1> INFO: ----------------------------------------------------------------------
[11:51:09.737] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:51:09.737] <TB1> INFO: ----------------------------------------------------------------------
[11:51:10.050] <TB1> INFO: Expecting 208000 events.
[11:51:18.435] <TB1> INFO: 208000 events read in total (7669ms).
[11:51:18.436] <TB1> INFO: Test took 8697ms.
[11:51:18.436] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:18.437] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:51:18.749] <TB1> INFO: PixTestAlive::maskTest() done
[11:51:18.749] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:51:18.751] <TB1> INFO: ----------------------------------------------------------------------
[11:51:18.751] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:51:18.751] <TB1> INFO: ----------------------------------------------------------------------
[11:51:19.065] <TB1> INFO: Expecting 208000 events.
[11:51:32.140] <TB1> INFO: 208000 events read in total (12359ms).
[11:51:32.141] <TB1> INFO: Test took 13388ms.
[11:51:32.149] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:32.377] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:51:32.377] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:51:32.377] <TB1> INFO: PixTestAlive::doTest() done, duration: 36 seconds
[11:51:32.415] <TB1> INFO: enter test to run
[11:51:32.415] <TB1> INFO: test: delay setting parameters: ->2<-
[11:51:32.415] <TB1> INFO: delay test by 2 seconds...
[11:51:34.416] <TB1> INFO: enter test to run
[11:51:34.416] <TB1> INFO: test: HighRate no parameter change
[11:51:34.416] <TB1> INFO: running: highrate
[11:51:34.416] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[11:51:34.587] <TB1> INFO: ----------------------------------------------------------------------
[11:51:34.587] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:51:34.587] <TB1> INFO: ----------------------------------------------------------------------
[11:51:35.221] <TB1> INFO: Expecting 208000 events.
[11:51:52.533] <TB1> INFO: 208000 events read in total (16785ms).
[11:51:52.542] <TB1> INFO: Test took 17951ms.
[11:51:52.963] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:53.295] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:51:53.295] <TB1> INFO: number of red-efficiency pixels: 250 265 328 536 517 683 616 616 735 566 656 420 567 218 213 217
[11:51:53.295] <TB1> INFO: number of X-ray hits detected: 162180 156064 148035 253894 248419 302997 272135 300108 317326 278561 302247 232905 245874 137190 165237 156991
[11:51:53.295] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:51:53.295] <TB1> INFO: number of Vcal hits detected: 207743 207726 207622 207399 207426 207196 207245 207252 207161 207370 207252 207546 207369 207769 207680 207770
[11:51:53.295] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.8 99.7 99.7 99.7 99.6 99.7 99.7 99.8 99.7 99.9 99.9 99.9
[11:51:53.295] <TB1> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.6 99.6 99.6 99.6 99.7 99.6 99.8 99.7 99.9 99.8 99.9
[11:51:53.295] <TB1> INFO: X-ray hit rate [MHz/cm2]: 47.5 45.7 43.4 74.4 72.8 88.8 79.8 88.0 93.0 81.6 88.6 68.3 72.1 40.2 48.4 46.0
[11:51:53.295] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:51:53.327] <TB1> INFO: PixTest:: pg_setup set to default.
[11:51:53.339] <TB1> INFO: enter test to run
[11:51:53.339] <TB1> INFO: test: no parameter change
[11:51:53.409] <TB1> QUIET: Connection to board 147 closed.
[11:51:53.489] <TB1> INFO: pXar: this is the end, my friend

[11:52:59.413] <TB1> INFO: *** Welcome to pxar ***
[11:52:59.413] <TB1> INFO: *** Today: 2015/12/16
[11:52:59.476] <TB1> INFO: *** Version: b2d3
[11:52:59.476] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//dacParameters35_C15.dat
[11:52:59.477] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//tbmParameters_C0b.dat
[11:52:59.477] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//defaultMaskFile.dat
[11:52:59.477] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//trimParameters35_C15.dat
[11:52:59.549] <TB1> INFO: clk: 4
[11:52:59.549] <TB1> INFO: ctr: 4
[11:52:59.549] <TB1> INFO: sda: 19
[11:52:59.549] <TB1> INFO: tin: 9
[11:52:59.549] <TB1> INFO: level: 15
[11:52:59.549] <TB1> INFO: triggerdelay: 0
[11:52:59.549] <TB1> QUIET: Instanciating API for pxar prod-12
[11:52:59.549] <TB1> INFO: Log level: INFO
[11:52:59.562] <TB1> INFO: Found DTB DTB_WWXTQT
[11:52:59.574] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:52:59.577] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:52:59.580] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:53:01.095] <TB1> INFO: DUT info:
[11:53:01.095] <TB1> INFO: The DUT currently contains the following objects:
[11:53:01.095] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:53:01.095] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:53:01.095] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:53:01.095] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:53:01.095] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.095] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.095] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.095] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.095] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.095] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.096] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.096] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.096] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.096] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.096] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.096] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.097] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.097] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.097] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.097] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:53:01.498] <TB1> INFO: enter 'restricted' command line mode
[11:53:01.498] <TB1> INFO: enter test to run
[11:53:01.498] <TB1> INFO: test: PixelAlive no parameter change
[11:53:01.498] <TB1> INFO: running: pixelalive
[11:53:01.507] <TB1> INFO: ######################################################################
[11:53:01.507] <TB1> INFO: PixTestAlive::doTest()
[11:53:01.507] <TB1> INFO: ######################################################################
[11:53:01.509] <TB1> INFO: ----------------------------------------------------------------------
[11:53:01.509] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:53:01.509] <TB1> INFO: ----------------------------------------------------------------------
[11:53:01.824] <TB1> INFO: Expecting 208000 events.
[11:53:15.205] <TB1> INFO: 208000 events read in total (12663ms).
[11:53:15.207] <TB1> INFO: Test took 13697ms.
[11:53:15.215] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:15.473] <TB1> INFO: PixTestAlive::aliveTest() done
[11:53:15.473] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:53:15.475] <TB1> INFO: ----------------------------------------------------------------------
[11:53:15.475] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:53:15.475] <TB1> INFO: ----------------------------------------------------------------------
[11:53:15.813] <TB1> INFO: Expecting 208000 events.
[11:53:24.362] <TB1> INFO: 208000 events read in total (7834ms).
[11:53:24.362] <TB1> INFO: Test took 8885ms.
[11:53:24.372] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:24.373] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:53:24.673] <TB1> INFO: PixTestAlive::maskTest() done
[11:53:24.673] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:53:24.675] <TB1> INFO: ----------------------------------------------------------------------
[11:53:24.675] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:53:24.675] <TB1> INFO: ----------------------------------------------------------------------
[11:53:24.986] <TB1> INFO: Expecting 208000 events.
[11:53:38.623] <TB1> INFO: 208000 events read in total (12921ms).
[11:53:38.623] <TB1> INFO: Test took 13947ms.
[11:53:38.631] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:53:38.858] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:53:38.858] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:53:38.858] <TB1> INFO: PixTestAlive::doTest() done, duration: 37 seconds
[11:53:38.891] <TB1> INFO: enter test to run
[11:53:38.892] <TB1> INFO: test: delay setting parameters: ->2<-
[11:53:38.892] <TB1> INFO: delay test by 2 seconds...
[11:53:40.892] <TB1> INFO: enter test to run
[11:53:40.892] <TB1> INFO: test: HighRate no parameter change
[11:53:40.892] <TB1> INFO: running: highrate
[11:53:40.892] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[11:53:41.048] <TB1> INFO: ----------------------------------------------------------------------
[11:53:41.048] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:53:41.048] <TB1> INFO: ----------------------------------------------------------------------
[11:53:41.657] <TB1> INFO: Expecting 208000 events.
[11:54:02.115] <TB1> INFO: 208000 events read in total (19931ms).
[11:54:02.124] <TB1> INFO: Test took 21072ms.
[11:54:02.716] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:54:03.135] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:54:03.135] <TB1> INFO: number of red-efficiency pixels: 410 400 586 938 863 1305 1047 1329 1293 1099 1269 809 1050 371 408 330
[11:54:03.135] <TB1> INFO: number of X-ray hits detected: 221918 214410 205356 346460 340142 413133 371562 412020 433331 381525 412523 320139 337621 189927 227801 215478
[11:54:03.135] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:54:03.135] <TB1> INFO: number of Vcal hits detected: 207562 207570 207198 206869 206928 206173 206559 206190 206327 206534 206268 207038 206716 207561 207470 207652
[11:54:03.135] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.5 99.6 99.2 99.4 99.2 99.3 99.4 99.3 99.6 99.4 99.8 99.8 99.8
[11:54:03.135] <TB1> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.6 99.5 99.5 99.1 99.3 99.1 99.2 99.3 99.2 99.5 99.4 99.8 99.7 99.8
[11:54:03.135] <TB1> INFO: X-ray hit rate [MHz/cm2]: 65.0 62.8 60.2 101.5 99.7 121.1 108.9 120.8 127.0 111.8 120.9 93.8 99.0 55.7 66.8 63.2
[11:54:03.135] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:54:03.164] <TB1> INFO: PixTest:: pg_setup set to default.
[11:54:03.178] <TB1> INFO: enter test to run
[11:54:03.178] <TB1> INFO: test: no parameter change
[11:54:03.265] <TB1> QUIET: Connection to board 147 closed.
[11:54:03.345] <TB1> INFO: pXar: this is the end, my friend

[11:55:25.418] <TB1> INFO: *** Welcome to pxar ***
[11:55:25.418] <TB1> INFO: *** Today: 2015/12/16
[11:55:25.483] <TB1> INFO: *** Version: b2d3
[11:55:25.483] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//dacParameters35_C15.dat
[11:55:25.484] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//tbmParameters_C0b.dat
[11:55:25.484] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//defaultMaskFile.dat
[11:55:25.484] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//trimParameters35_C15.dat
[11:55:25.553] <TB1> INFO: clk: 4
[11:55:25.553] <TB1> INFO: ctr: 4
[11:55:25.553] <TB1> INFO: sda: 19
[11:55:25.553] <TB1> INFO: tin: 9
[11:55:25.553] <TB1> INFO: level: 15
[11:55:25.553] <TB1> INFO: triggerdelay: 0
[11:55:25.553] <TB1> QUIET: Instanciating API for pxar prod-12
[11:55:25.553] <TB1> INFO: Log level: INFO
[11:55:25.567] <TB1> INFO: Found DTB DTB_WWXTQT
[11:55:25.579] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:55:25.582] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:55:25.584] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:55:27.130] <TB1> INFO: DUT info:
[11:55:27.130] <TB1> INFO: The DUT currently contains the following objects:
[11:55:27.130] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:55:27.130] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:55:27.130] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:55:27.130] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:55:27.130] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.130] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:55:27.531] <TB1> INFO: enter 'restricted' command line mode
[11:55:27.531] <TB1> INFO: enter test to run
[11:55:27.531] <TB1> INFO: test: PixelAlive no parameter change
[11:55:27.531] <TB1> INFO: running: pixelalive
[11:55:27.537] <TB1> INFO: ######################################################################
[11:55:27.537] <TB1> INFO: PixTestAlive::doTest()
[11:55:27.537] <TB1> INFO: ######################################################################
[11:55:27.538] <TB1> INFO: ----------------------------------------------------------------------
[11:55:27.538] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:55:27.538] <TB1> INFO: ----------------------------------------------------------------------
[11:55:27.842] <TB1> INFO: Expecting 208000 events.
[11:55:40.960] <TB1> INFO: 208000 events read in total (12400ms).
[11:55:40.978] <TB1> INFO: Test took 13438ms.
[11:55:40.989] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:55:41.248] <TB1> INFO: PixTestAlive::aliveTest() done
[11:55:41.248] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:55:41.250] <TB1> INFO: ----------------------------------------------------------------------
[11:55:41.250] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:55:41.250] <TB1> INFO: ----------------------------------------------------------------------
[11:55:41.555] <TB1> INFO: Expecting 208000 events.
[11:55:50.113] <TB1> INFO: 208000 events read in total (7842ms).
[11:55:50.113] <TB1> INFO: Test took 8861ms.
[11:55:50.113] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:55:50.114] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:55:50.428] <TB1> INFO: PixTestAlive::maskTest() done
[11:55:50.428] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:55:50.429] <TB1> INFO: ----------------------------------------------------------------------
[11:55:50.429] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:55:50.429] <TB1> INFO: ----------------------------------------------------------------------
[11:55:50.739] <TB1> INFO: Expecting 208000 events.
[11:56:04.145] <TB1> INFO: 208000 events read in total (12690ms).
[11:56:04.146] <TB1> INFO: Test took 13715ms.
[11:56:04.152] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:04.380] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:56:04.380] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:56:04.380] <TB1> INFO: PixTestAlive::doTest() done, duration: 36 seconds
[11:56:04.416] <TB1> INFO: enter test to run
[11:56:04.416] <TB1> INFO: test: delay setting parameters: ->2<-
[11:56:04.416] <TB1> INFO: delay test by 2 seconds...
[11:56:06.416] <TB1> INFO: enter test to run
[11:56:06.416] <TB1> INFO: test: HighRate no parameter change
[11:56:06.416] <TB1> INFO: running: highrate
[11:56:06.416] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[11:56:06.604] <TB1> INFO: ----------------------------------------------------------------------
[11:56:06.604] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:56:06.604] <TB1> INFO: ----------------------------------------------------------------------
[11:56:07.241] <TB1> INFO: Expecting 208000 events.
[11:56:30.545] <TB1> INFO: 208000 events read in total (22777ms).
[11:56:30.556] <TB1> INFO: Test took 23948ms.
[11:56:31.212] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:56:31.624] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:56:31.624] <TB1> INFO: number of red-efficiency pixels: 570 659 794 1396 1352 1940 1553 1918 1996 1605 1853 1191 1426 538 589 501
[11:56:31.624] <TB1> INFO: number of X-ray hits detected: 270688 261214 249726 420678 414587 498468 452778 499106 523048 462931 497015 390783 408077 232271 276258 262645
[11:56:31.624] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:56:31.624] <TB1> INFO: number of Vcal hits detected: 207365 207259 206765 206020 206107 204877 205545 205030 204995 205552 205126 206370 206041 207306 207261 207453
[11:56:31.624] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.5 99.2 99.2 98.7 99.0 98.7 98.7 99.0 98.8 99.3 99.2 99.7 99.7 99.8
[11:56:31.624] <TB1> INFO: Vcal hit overall efficiency (%): 99.7 99.6 99.4 99.0 99.1 98.5 98.8 98.6 98.6 98.8 98.6 99.2 99.1 99.7 99.6 99.7
[11:56:31.624] <TB1> INFO: X-ray hit rate [MHz/cm2]: 79.3 76.6 73.2 123.3 121.5 146.1 132.7 146.3 153.3 135.7 145.7 114.5 119.6 68.1 81.0 77.0
[11:56:31.624] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:56:31.661] <TB1> INFO: PixTest:: pg_setup set to default.
[11:56:31.673] <TB1> INFO: enter test to run
[11:56:31.673] <TB1> INFO: test: no parameter change
[11:56:31.735] <TB1> QUIET: Connection to board 147 closed.
[11:56:31.817] <TB1> INFO: pXar: this is the end, my friend

[11:57:24.175] <TB1> INFO: *** Welcome to pxar ***
[11:57:24.175] <TB1> INFO: *** Today: 2015/12/16
[11:57:24.241] <TB1> INFO: *** Version: b2d3
[11:57:24.241] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//dacParameters35_C15.dat
[11:57:24.242] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//tbmParameters_C0b.dat
[11:57:24.242] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//defaultMaskFile.dat
[11:57:24.242] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//trimParameters35_C15.dat
[11:57:24.311] <TB1> INFO: clk: 4
[11:57:24.311] <TB1> INFO: ctr: 4
[11:57:24.311] <TB1> INFO: sda: 19
[11:57:24.311] <TB1> INFO: tin: 9
[11:57:24.311] <TB1> INFO: level: 15
[11:57:24.311] <TB1> INFO: triggerdelay: 0
[11:57:24.311] <TB1> QUIET: Instanciating API for pxar prod-12
[11:57:24.311] <TB1> INFO: Log level: INFO
[11:57:24.324] <TB1> INFO: Found DTB DTB_WWXTQT
[11:57:24.340] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[11:57:24.343] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[11:57:24.345] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[11:57:25.862] <TB1> INFO: DUT info:
[11:57:25.862] <TB1> INFO: The DUT currently contains the following objects:
[11:57:25.862] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[11:57:25.862] <TB1> INFO: TBM Core alpha (0): 7 registers set
[11:57:25.862] <TB1> INFO: TBM Core beta (1): 7 registers set
[11:57:25.862] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:57:25.862] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:25.863] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:57:26.264] <TB1> INFO: enter 'restricted' command line mode
[11:57:26.264] <TB1> INFO: enter test to run
[11:57:26.264] <TB1> INFO: test: PixelAlive no parameter change
[11:57:26.264] <TB1> INFO: running: pixelalive
[11:57:26.268] <TB1> INFO: ######################################################################
[11:57:26.268] <TB1> INFO: PixTestAlive::doTest()
[11:57:26.268] <TB1> INFO: ######################################################################
[11:57:26.270] <TB1> INFO: ----------------------------------------------------------------------
[11:57:26.270] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:57:26.270] <TB1> INFO: ----------------------------------------------------------------------
[11:57:26.613] <TB1> INFO: Expecting 208000 events.
[11:57:39.775] <TB1> INFO: 208000 events read in total (12444ms).
[11:57:39.777] <TB1> INFO: Test took 13506ms.
[11:57:39.797] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:57:40.071] <TB1> INFO: PixTestAlive::aliveTest() done
[11:57:40.071] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[11:57:40.073] <TB1> INFO: ----------------------------------------------------------------------
[11:57:40.073] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:57:40.073] <TB1> INFO: ----------------------------------------------------------------------
[11:57:40.405] <TB1> INFO: Expecting 208000 events.
[11:57:49.322] <TB1> INFO: 208000 events read in total (8201ms).
[11:57:49.323] <TB1> INFO: Test took 9248ms.
[11:57:49.329] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:57:49.330] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:57:49.631] <TB1> INFO: PixTestAlive::maskTest() done
[11:57:49.631] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:57:49.633] <TB1> INFO: ----------------------------------------------------------------------
[11:57:49.633] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[11:57:49.633] <TB1> INFO: ----------------------------------------------------------------------
[11:57:49.949] <TB1> INFO: Expecting 208000 events.
[11:58:02.931] <TB1> INFO: 208000 events read in total (12266ms).
[11:58:02.931] <TB1> INFO: Test took 13296ms.
[11:58:02.940] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:58:03.169] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[11:58:03.169] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[11:58:03.169] <TB1> INFO: PixTestAlive::doTest() done, duration: 36 seconds
[11:58:03.209] <TB1> INFO: enter test to run
[11:58:03.209] <TB1> INFO: test: delay setting parameters: ->2<-
[11:58:03.209] <TB1> INFO: delay test by 2 seconds...
[11:58:05.209] <TB1> INFO: enter test to run
[11:58:05.209] <TB1> INFO: test: HighRate no parameter change
[11:58:05.209] <TB1> INFO: running: highrate
[11:58:05.209] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[11:58:05.376] <TB1> INFO: ----------------------------------------------------------------------
[11:58:05.376] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:58:05.376] <TB1> INFO: ----------------------------------------------------------------------
[11:58:06.009] <TB1> INFO: Expecting 208000 events.
[11:58:32.060] <TB1> INFO: 208000 events read in total (25523ms).
[11:58:32.076] <TB1> INFO: Test took 26697ms.
[11:58:32.891] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:58:33.423] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 1 0
[11:58:33.423] <TB1> INFO: number of red-efficiency pixels: 850 903 1039 2025 1918 2533 2158 2649 2647 2228 2485 1694 2001 802 831 744
[11:58:33.423] <TB1> INFO: number of X-ray hits detected: 320970 313460 299141 501253 489807 590177 539796 590266 621163 548580 591114 466050 483275 278940 328774 313888
[11:58:33.423] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:58:33.423] <TB1> INFO: number of Vcal hits detected: 207024 206914 206023 204678 204823 202889 203986 202964 203093 203823 203267 205318 204765 206772 206959 207156
[11:58:33.423] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.6 99.5 99.2 98.6 98.7 97.8 98.4 97.8 97.9 98.2 98.0 98.9 98.6 99.5 99.6 99.6
[11:58:33.424] <TB1> INFO: Vcal hit overall efficiency (%): 99.5 99.5 99.0 98.4 98.5 97.5 98.1 97.6 97.6 98.0 97.7 98.7 98.4 99.4 99.5 99.6
[11:58:33.424] <TB1> INFO: X-ray hit rate [MHz/cm2]: 94.1 91.9 87.7 146.9 143.6 173.0 158.2 173.0 182.1 160.8 173.3 136.6 141.7 81.8 96.4 92.0
[11:58:33.424] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[11:58:33.461] <TB1> INFO: PixTest:: pg_setup set to default.
[11:58:33.482] <TB1> INFO: enter test to run
[11:58:33.482] <TB1> INFO: test: no parameter change
[11:58:33.547] <TB1> QUIET: Connection to board 147 closed.
[11:58:33.627] <TB1> INFO: pXar: this is the end, my friend

[12:00:04.642] <TB1> INFO: *** Welcome to pxar ***
[12:00:04.642] <TB1> INFO: *** Today: 2015/12/16
[12:00:04.708] <TB1> INFO: *** Version: b2d3
[12:00:04.708] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//dacParameters35_C15.dat
[12:00:04.709] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//tbmParameters_C0b.dat
[12:00:04.709] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//defaultMaskFile.dat
[12:00:04.709] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//trimParameters35_C15.dat
[12:00:04.785] <TB1> INFO: clk: 4
[12:00:04.785] <TB1> INFO: ctr: 4
[12:00:04.785] <TB1> INFO: sda: 19
[12:00:04.785] <TB1> INFO: tin: 9
[12:00:04.785] <TB1> INFO: level: 15
[12:00:04.785] <TB1> INFO: triggerdelay: 0
[12:00:04.785] <TB1> QUIET: Instanciating API for pxar prod-12
[12:00:04.785] <TB1> INFO: Log level: INFO
[12:00:04.799] <TB1> INFO: Found DTB DTB_WWXTQT
[12:00:04.811] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:00:04.814] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:00:04.816] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:00:06.343] <TB1> INFO: DUT info:
[12:00:06.343] <TB1> INFO: The DUT currently contains the following objects:
[12:00:06.343] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:00:06.343] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:00:06.343] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:00:06.343] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:00:06.343] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.343] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:00:06.744] <TB1> INFO: enter 'restricted' command line mode
[12:00:06.744] <TB1> INFO: enter test to run
[12:00:06.744] <TB1> INFO: test: PixelAlive no parameter change
[12:00:06.744] <TB1> INFO: running: pixelalive
[12:00:06.751] <TB1> INFO: ######################################################################
[12:00:06.751] <TB1> INFO: PixTestAlive::doTest()
[12:00:06.751] <TB1> INFO: ######################################################################
[12:00:06.753] <TB1> INFO: ----------------------------------------------------------------------
[12:00:06.753] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:00:06.753] <TB1> INFO: ----------------------------------------------------------------------
[12:00:07.070] <TB1> INFO: Expecting 208000 events.
[12:00:20.294] <TB1> INFO: 208000 events read in total (12506ms).
[12:00:20.309] <TB1> INFO: Test took 13555ms.
[12:00:20.319] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:20.590] <TB1> INFO: PixTestAlive::aliveTest() done
[12:00:20.590] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[12:00:20.591] <TB1> INFO: ----------------------------------------------------------------------
[12:00:20.591] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:00:20.591] <TB1> INFO: ----------------------------------------------------------------------
[12:00:20.912] <TB1> INFO: Expecting 208000 events.
[12:00:29.463] <TB1> INFO: 208000 events read in total (7835ms).
[12:00:29.465] <TB1> INFO: Test took 8872ms.
[12:00:29.465] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:29.465] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:00:29.772] <TB1> INFO: PixTestAlive::maskTest() done
[12:00:29.772] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:00:29.773] <TB1> INFO: ----------------------------------------------------------------------
[12:00:29.773] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:00:29.773] <TB1> INFO: ----------------------------------------------------------------------
[12:00:30.082] <TB1> INFO: Expecting 208000 events.
[12:00:43.223] <TB1> INFO: 208000 events read in total (12426ms).
[12:00:43.223] <TB1> INFO: Test took 13448ms.
[12:00:43.232] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:00:43.462] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:00:43.462] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:00:43.463] <TB1> INFO: PixTestAlive::doTest() done, duration: 36 seconds
[12:00:43.500] <TB1> INFO: enter test to run
[12:00:43.500] <TB1> INFO: test: delay setting parameters: ->2<-
[12:00:43.500] <TB1> INFO: delay test by 2 seconds...
[12:00:45.500] <TB1> INFO: enter test to run
[12:00:45.500] <TB1> INFO: test: HighRate no parameter change
[12:00:45.500] <TB1> INFO: running: highrate
[12:00:45.500] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[12:00:45.635] <TB1> INFO: ----------------------------------------------------------------------
[12:00:45.635] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:00:45.635] <TB1> INFO: ----------------------------------------------------------------------
[12:00:46.234] <TB1> INFO: Expecting 208000 events.
[12:01:19.048] <TB1> INFO: 208000 events read in total (32287ms).
[12:01:19.067] <TB1> INFO: Test took 33428ms.
[12:01:20.134] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:01:20.682] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[12:01:20.682] <TB1> INFO: number of red-efficiency pixels: 1541 1738 1712 3174 2966 3688 3295 3783 3740 3357 3658 2719 3149 1291 1520 1295
[12:01:20.682] <TB1> INFO: number of X-ray hits detected: 436404 426681 406757 672595 663394 795336 724171 793270 832047 736629 790623 629151 650304 379405 448571 422836
[12:01:20.682] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:01:20.682] <TB1> INFO: number of Vcal hits detected: 205788 205536 203450 200065 200586 195413 198380 195472 195596 197897 196295 201861 200122 205243 205905 206250
[12:01:20.682] <TB1> INFO: Vcal hit fiducial efficiency (%): 99.1 98.9 98.2 96.7 96.9 94.7 96.1 94.5 94.6 95.7 95.1 97.5 96.7 98.9 99.1 99.2
[12:01:20.682] <TB1> INFO: Vcal hit overall efficiency (%): 98.9 98.8 97.8 96.2 96.4 93.9 95.4 94.0 94.0 95.1 94.4 97.0 96.2 98.7 99.0 99.2
[12:01:20.682] <TB1> INFO: X-ray hit rate [MHz/cm2]: 127.9 125.1 119.2 197.1 194.4 233.1 212.3 232.5 243.9 215.9 231.7 184.4 190.6 111.2 131.5 123.9
[12:01:20.682] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:01:20.711] <TB1> INFO: PixTest:: pg_setup set to default.
[12:01:20.723] <TB1> INFO: enter test to run
[12:01:20.723] <TB1> INFO: test: no parameter change
[12:01:20.832] <TB1> QUIET: Connection to board 147 closed.
[12:01:20.911] <TB1> INFO: pXar: this is the end, my friend

[12:01:45.810] <TB1> INFO: *** Welcome to pxar ***
[12:01:45.810] <TB1> INFO: *** Today: 2015/12/16
[12:01:45.873] <TB1> INFO: *** Version: b2d3
[12:01:45.873] <TB1> INFO: readRocDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//dacParameters35_C15.dat
[12:01:45.874] <TB1> INFO: readTbmDacs: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//tbmParameters_C0b.dat
[12:01:45.874] <TB1> INFO: readMaskFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//defaultMaskFile.dat
[12:01:45.874] <TB1> INFO: readTrimFile: /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//trimParameters35_C15.dat
[12:01:45.942] <TB1> INFO: clk: 4
[12:01:45.942] <TB1> INFO: ctr: 4
[12:01:45.942] <TB1> INFO: sda: 19
[12:01:45.942] <TB1> INFO: tin: 9
[12:01:45.942] <TB1> INFO: level: 15
[12:01:45.942] <TB1> INFO: triggerdelay: 0
[12:01:45.942] <TB1> QUIET: Instanciating API for pxar prod-12
[12:01:45.942] <TB1> INFO: Log level: INFO
[12:01:45.954] <TB1> INFO: Found DTB DTB_WWXTQT
[12:01:45.966] <TB1> QUIET: Connection to board DTB_WWXTQT opened.
[12:01:45.969] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 147
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWXTQT
MAC address: 40D855118093
Hostname: pixelDTB147
Comment:
------------------------------------------------------
[12:01:45.972] <TB1> INFO: RPC call hashes of host and DTB match: 398089610
[12:01:47.487] <TB1> INFO: DUT info:
[12:01:47.487] <TB1> INFO: The DUT currently contains the following objects:
[12:01:47.487] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[12:01:47.487] <TB1> INFO: TBM Core alpha (0): 7 registers set
[12:01:47.487] <TB1> INFO: TBM Core beta (1): 7 registers set
[12:01:47.487] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:01:47.487] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.487] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.488] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.488] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.488] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.488] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.488] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.488] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:01:47.888] <TB1> INFO: enter 'restricted' command line mode
[12:01:47.888] <TB1> INFO: enter test to run
[12:01:47.888] <TB1> INFO: test: PixelAlive no parameter change
[12:01:47.888] <TB1> INFO: running: pixelalive
[12:01:47.895] <TB1> INFO: ######################################################################
[12:01:47.895] <TB1> INFO: PixTestAlive::doTest()
[12:01:47.895] <TB1> INFO: ######################################################################
[12:01:47.897] <TB1> INFO: ----------------------------------------------------------------------
[12:01:47.897] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:01:47.897] <TB1> INFO: ----------------------------------------------------------------------
[12:01:48.234] <TB1> INFO: Expecting 208000 events.
[12:02:01.056] <TB1> INFO: 208000 events read in total (12104ms).
[12:02:01.063] <TB1> INFO: Test took 13165ms.
[12:02:01.072] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:01.331] <TB1> INFO: PixTestAlive::aliveTest() done
[12:02:01.331] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 2 0
[12:02:01.333] <TB1> INFO: ----------------------------------------------------------------------
[12:02:01.333] <TB1> INFO: PixTestAlive::maskTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:02:01.333] <TB1> INFO: ----------------------------------------------------------------------
[12:02:01.639] <TB1> INFO: Expecting 208000 events.
[12:02:10.219] <TB1> INFO: 208000 events read in total (7864ms).
[12:02:10.220] <TB1> INFO: Test took 8886ms.
[12:02:10.220] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:10.220] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:02:10.535] <TB1> INFO: PixTestAlive::maskTest() done
[12:02:10.535] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:02:10.537] <TB1> INFO: ----------------------------------------------------------------------
[12:02:10.537] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 50, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:02:10.537] <TB1> INFO: ----------------------------------------------------------------------
[12:02:10.863] <TB1> INFO: Expecting 208000 events.
[12:02:23.667] <TB1> INFO: 208000 events read in total (12088ms).
[12:02:23.668] <TB1> INFO: Test took 13130ms.
[12:02:23.677] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:02:23.902] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[12:02:23.902] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:02:23.902] <TB1> INFO: PixTestAlive::doTest() done, duration: 36 seconds
[12:02:23.940] <TB1> INFO: enter test to run
[12:02:23.940] <TB1> INFO: test: delay setting parameters: ->2<-
[12:02:23.940] <TB1> INFO: delay test by 2 seconds...
[12:02:25.940] <TB1> INFO: enter test to run
[12:02:25.941] <TB1> INFO: test: HighRate no parameter change
[12:02:25.941] <TB1> INFO: running: highrate
[12:02:25.941] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2126_XrayQualification_2015-12-16_10h27m_1450258068//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[12:02:26.109] <TB1> INFO: ----------------------------------------------------------------------
[12:02:26.109] <TB1> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:02:26.109] <TB1> INFO: ----------------------------------------------------------------------
[12:02:26.714] <TB1> INFO: Expecting 208000 events.
[12:03:05.321] <TB1> INFO: 201300 events read in total (38080ms).
[12:03:06.803] <TB1> INFO: 208000 events read in total (39562ms).
[12:03:06.822] <TB1> INFO: Test took 40709ms.
[12:03:08.099] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:03:08.763] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 1 1 0 0 0 0 0 0 1 0
[12:03:08.763] <TB1> INFO: number of red-efficiency pixels: 2305 2533 2255 3793 3690 4049 3877 4112 4094 3923 4035 3536 3812 1703 2339 2060
[12:03:08.763] <TB1> INFO: number of X-ray hits detected: 540360 525705 501039 828991 818701 978170 891664 973042 1021489 902966 969106 773572 799034 469750 555053 522165
[12:03:08.763] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:03:08.763] <TB1> INFO: number of Vcal hits detected: 204023 203486 200096 193518 194047 185201 190290 184839 185385 189125 187051 196235 193752 203060 204153 204699
[12:03:08.763] <TB1> INFO: Vcal hit fiducial efficiency (%): 98.3 98.0 96.8 93.8 94.1 90.1 92.6 89.6 90.1 91.9 91.0 95.1 93.9 98.1 98.3 98.6
[12:03:08.763] <TB1> INFO: Vcal hit overall efficiency (%): 98.1 97.8 96.2 93.0 93.3 89.0 91.5 88.9 89.1 90.9 89.9 94.3 93.2 97.6 98.2 98.4
[12:03:08.763] <TB1> INFO: X-ray hit rate [MHz/cm2]: 158.4 154.1 146.9 243.0 240.0 286.7 261.4 285.2 299.4 264.7 284.1 226.7 234.2 137.7 162.7 153.1
[12:03:08.763] <TB1> INFO: PixTestHighRate::doXPixelAlive() done
[12:03:08.789] <TB1> INFO: PixTest:: pg_setup set to default.
[12:03:08.802] <TB1> INFO: enter test to run
[12:03:08.802] <TB1> INFO: test: no parameter change
[12:03:08.893] <TB1> QUIET: Connection to board 147 closed.
[12:03:08.975] <TB1> INFO: pXar: this is the end, my friend