[10:15:12.190] <TB3> INFO: *** Welcome to pxar ***
[10:15:12.190] <TB3> INFO: *** Today: 2015/11/23
[10:15:12.268] <TB3> INFO: *** Version: 206d-dirty
[10:15:12.268] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//dacParameters35_C15.dat
[10:15:12.268] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//tbmParameters_C0b.dat
[10:15:12.268] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//defaultMaskFile.dat
[10:15:12.269] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//000_PixelAlive_p17//trimParameters35_C15.dat
[10:15:12.339] <TB3> INFO: clk: 4
[10:15:12.339] <TB3> INFO: ctr: 4
[10:15:12.339] <TB3> INFO: sda: 19
[10:15:12.339] <TB3> INFO: tin: 9
[10:15:12.339] <TB3> INFO: level: 15
[10:15:12.339] <TB3> INFO: triggerdelay: 0
[10:15:12.339] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:15:12.339] <TB3> INFO: Log level: INFO
[10:15:12.351] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:15:12.368] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:15:12.371] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:15:12.374] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:15:13.930] <TB3> INFO: DUT info:
[10:15:13.930] <TB3> INFO: The DUT currently contains the following objects:
[10:15:13.930] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:15:13.930] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:15:13.930] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:15:13.930] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:15:13.930] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.930] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.931] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.931] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.931] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.931] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:13.931] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:15:14.332] <TB3> INFO: enter 'restricted' command line mode
[10:15:14.332] <TB3> INFO: enter test to run
[10:15:14.332] <TB3> INFO: test: PixelAlive no parameter change
[10:15:14.332] <TB3> INFO: running: pixelalive
[10:15:14.337] <TB3> INFO: ######################################################################
[10:15:14.337] <TB3> INFO: PixTestAlive::doTest()
[10:15:14.337] <TB3> INFO: ######################################################################
[10:15:14.339] <TB3> INFO: ----------------------------------------------------------------------
[10:15:14.339] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:15:14.339] <TB3> INFO: ----------------------------------------------------------------------
[10:15:14.654] <TB3> INFO: Expecting 41600 events.
[10:15:18.966] <TB3> INFO: 41600 events read in total (3594ms).
[10:15:19.136] <TB3> INFO: Test took 4796ms.
[10:15:19.144] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:15:19.395] <TB3> INFO: PixTestAlive::aliveTest() done
[10:15:19.395] <TB3> INFO: number of dead pixels (per ROC): 0 4 0 1 0 1 0 0 0 1 0 0 2 0 0 0
[10:15:19.397] <TB3> INFO: ----------------------------------------------------------------------
[10:15:19.397] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:15:19.397] <TB3> INFO: ----------------------------------------------------------------------
[10:15:19.707] <TB3> INFO: Expecting 41600 events.
[10:15:22.702] <TB3> INFO: 41600 events read in total (2280ms).
[10:15:22.702] <TB3> INFO: Test took 3304ms.
[10:15:22.702] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:15:22.704] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:15:23.105] <TB3> INFO: PixTestAlive::maskTest() done
[10:15:23.105] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:15:23.107] <TB3> INFO: ----------------------------------------------------------------------
[10:15:23.107] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:15:23.107] <TB3> INFO: ----------------------------------------------------------------------
[10:15:23.425] <TB3> INFO: Expecting 41600 events.
[10:15:27.429] <TB3> INFO: 41600 events read in total (3289ms).
[10:15:27.430] <TB3> INFO: Test took 4321ms.
[10:15:27.436] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:15:27.819] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:15:27.819] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:15:27.819] <TB3> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[10:15:27.850] <TB3> INFO: enter test to run
[10:15:27.851] <TB3> INFO: test: no parameter change
[10:15:27.905] <TB3> QUIET: Connection to board 121 closed.
[10:15:27.984] <TB3> INFO: pXar: this is the end, my friend

[10:20:29.404] <TB3> INFO: *** Welcome to pxar ***
[10:20:29.404] <TB3> INFO: *** Today: 2015/11/23
[10:20:29.731] <TB3> INFO: *** Version: 206d-dirty
[10:20:29.731] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//dacParameters35_C15.dat
[10:20:29.732] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[10:20:29.733] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//defaultMaskFile.dat
[10:20:29.733] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C15.dat
[10:20:29.835] <TB3> INFO: clk: 4
[10:20:29.835] <TB3> INFO: ctr: 4
[10:20:29.835] <TB3> INFO: sda: 19
[10:20:29.835] <TB3> INFO: tin: 9
[10:20:29.835] <TB3> INFO: level: 15
[10:20:29.835] <TB3> INFO: triggerdelay: 0
[10:20:29.835] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:20:29.835] <TB3> INFO: Log level: INFO
[10:20:29.850] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:20:29.867] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:20:29.870] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:20:29.874] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:20:31.429] <TB3> INFO: DUT info:
[10:20:31.429] <TB3> INFO: The DUT currently contains the following objects:
[10:20:31.429] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:20:31.429] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:20:31.429] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:20:31.429] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:20:31.429] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.429] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:20:31.832] <TB3> INFO: enter 'restricted' command line mode
[10:20:31.832] <TB3> INFO: enter test to run
[10:20:31.832] <TB3> INFO: test: delay setting parameters: ->5<-
[10:20:31.832] <TB3> INFO: delay test by 5 seconds...
[10:20:36.832] <TB3> INFO: enter test to run
[10:20:36.832] <TB3> INFO: test: highrate no parameter change
[10:20:36.832] <TB3> INFO: running: highrate
[10:20:36.835] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[10:20:36.987] <TB3> INFO: ----------------------------------------------------------------------
[10:20:36.987] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[10:20:36.987] <TB3> INFO: ----------------------------------------------------------------------
[10:20:36.987] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[10:20:36.987] <TB3> INFO: edge/corner pixel THR is adjusted
[10:20:36.987] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[10:20:37.947] <TB3> INFO: Collecting data for 1 seconds...
[10:20:38.950] <TB3> INFO: Done with hot pixel readout
[10:20:43.115] <TB3> INFO: PixTest:: pg_setup set to default.
[10:20:43.116] <TB3> INFO: 7 hot pixels found in step 0
[10:20:44.169] <TB3> INFO: Collecting data for 1 seconds...
[10:20:45.172] <TB3> INFO: Done with hot pixel readout
[10:20:49.257] <TB3> INFO: PixTest:: pg_setup set to default.
[10:20:49.258] <TB3> INFO: 6 hot pixels found in step 1
[10:20:50.315] <TB3> INFO: Collecting data for 1 seconds...
[10:20:51.319] <TB3> INFO: Done with hot pixel readout
[10:20:55.678] <TB3> INFO: PixTest:: pg_setup set to default.
[10:20:55.679] <TB3> INFO: 6 hot pixels found in step 2
[10:20:56.735] <TB3> INFO: Collecting data for 1 seconds...
[10:20:57.738] <TB3> INFO: Done with hot pixel readout
[10:21:01.891] <TB3> INFO: PixTest:: pg_setup set to default.
[10:21:01.892] <TB3> INFO: 1 hot pixels found in step 3
[10:21:02.949] <TB3> INFO: Collecting data for 1 seconds...
[10:21:03.951] <TB3> INFO: Done with hot pixel readout
[10:21:07.285] <TB3> INFO: PixTest:: pg_setup set to default.
[10:21:07.286] <TB3> INFO: 0 hot pixels found in step 4
[10:21:07.292] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[10:21:07.394] <TB3> INFO: PixTest::trimHotPixels() done
[10:21:07.394] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C0.dat
[10:21:07.401] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C1.dat
[10:21:07.407] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C2.dat
[10:21:07.413] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C3.dat
[10:21:07.419] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C4.dat
[10:21:07.424] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C5.dat
[10:21:07.431] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C6.dat
[10:21:07.437] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C7.dat
[10:21:07.443] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C8.dat
[10:21:07.449] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C9.dat
[10:21:07.455] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C10.dat
[10:21:07.461] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C11.dat
[10:21:07.467] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C12.dat
[10:21:07.473] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C13.dat
[10:21:07.479] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C14.dat
[10:21:07.485] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//trimParameters35_C15.dat
[10:21:07.491] <TB3> INFO: write masked pixels into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//002_RetrimHotPixels_150//defaultMaskFile.dat
[10:21:07.521] <TB3> INFO: enter test to run
[10:21:07.521] <TB3> INFO: test: no parameter change
[10:21:07.621] <TB3> QUIET: Connection to board 121 closed.
[10:21:07.701] <TB3> INFO: pXar: this is the end, my friend

[10:21:34.508] <TB3> INFO: *** Welcome to pxar ***
[10:21:34.508] <TB3> INFO: *** Today: 2015/11/23
[10:21:34.604] <TB3> INFO: *** Version: 206d-dirty
[10:21:34.605] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//dacParameters35_C15.dat
[10:21:34.606] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//tbmParameters_C0b.dat
[10:21:34.606] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[10:21:34.606] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[10:21:34.681] <TB3> INFO: clk: 4
[10:21:34.681] <TB3> INFO: ctr: 4
[10:21:34.681] <TB3> INFO: sda: 19
[10:21:34.681] <TB3> INFO: tin: 9
[10:21:34.681] <TB3> INFO: level: 15
[10:21:34.681] <TB3> INFO: triggerdelay: 0
[10:21:34.681] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:21:34.681] <TB3> INFO: Log level: INFO
[10:21:34.694] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:21:34.710] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:21:34.713] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:21:34.715] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:21:36.285] <TB3> INFO: DUT info:
[10:21:36.285] <TB3> INFO: The DUT currently contains the following objects:
[10:21:36.285] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:21:36.285] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:21:36.286] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:21:36.286] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:21:36.286] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.286] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:21:36.687] <TB3> INFO: enter 'restricted' command line mode
[10:21:36.687] <TB3> INFO: enter test to run
[10:21:36.687] <TB3> INFO: test: delay setting parameters: ->5<-
[10:21:36.687] <TB3> INFO: delay test by 5 seconds...
[10:21:41.687] <TB3> INFO: enter test to run
[10:21:41.688] <TB3> INFO: test: highrate no parameter change
[10:21:41.688] <TB3> INFO: running: highrate
[10:21:41.694] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//phCalibrationFitErr35_C15.dat
[10:21:41.838] <TB3> INFO: ----------------------------------------------------------------------
[10:21:41.838] <TB3> INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[10:21:41.838] <TB3> INFO: ----------------------------------------------------------------------
[10:21:41.838] <TB3> INFO: THR = 10, corresponding to ~ 5.33333 MHz/cm2
[10:21:41.838] <TB3> INFO: edge/corner pixel THR is adjusted
[10:21:41.838] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[10:21:42.797] <TB3> INFO: Collecting data for 5 seconds...
[10:21:47.808] <TB3> INFO: Done with hot pixel readout
[10:21:55.345] <TB3> INFO: PixTest:: pg_setup set to default.
[10:21:55.346] <TB3> INFO: 5 hot pixels found in step 0
[10:21:56.475] <TB3> INFO: Collecting data for 5 seconds...
[10:22:01.485] <TB3> INFO: Done with hot pixel readout
[10:22:09.713] <TB3> INFO: PixTest:: pg_setup set to default.
[10:22:09.714] <TB3> INFO: 1 hot pixels found in step 1
[10:22:10.843] <TB3> INFO: Collecting data for 5 seconds...
[10:22:15.854] <TB3> INFO: Done with hot pixel readout
[10:22:23.628] <TB3> INFO: PixTest:: pg_setup set to default.
[10:22:23.630] <TB3> INFO: 0 hot pixels found in step 2
[10:22:23.634] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[10:22:23.801] <TB3> INFO: PixTest::trimHotPixels() done
[10:22:23.802] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C0.dat
[10:22:23.814] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C1.dat
[10:22:23.826] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C2.dat
[10:22:23.837] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C3.dat
[10:22:23.849] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C4.dat
[10:22:23.861] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C5.dat
[10:22:23.873] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C6.dat
[10:22:23.885] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C7.dat
[10:22:23.897] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C8.dat
[10:22:23.910] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C9.dat
[10:22:23.922] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C10.dat
[10:22:23.934] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C11.dat
[10:22:23.945] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C12.dat
[10:22:23.955] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C13.dat
[10:22:23.965] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C14.dat
[10:22:23.977] <TB3> INFO: write trim parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//trimParameters35_C15.dat
[10:22:23.989] <TB3> INFO: write masked pixels into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//003_RetrimHotPixelsNoRate_p17//defaultMaskFile.dat
[10:22:24.041] <TB3> INFO: enter test to run
[10:22:24.041] <TB3> INFO: test: no parameter change
[10:22:24.120] <TB3> QUIET: Connection to board 121 closed.
[10:22:24.200] <TB3> INFO: pXar: this is the end, my friend

[10:22:58.716] <TB3> INFO: *** Welcome to pxar ***
[10:22:58.716] <TB3> INFO: *** Today: 2015/11/23
[10:22:58.841] <TB3> INFO: *** Version: 206d-dirty
[10:22:58.842] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//dacParameters35_C15.dat
[10:22:58.843] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//tbmParameters_C0b.dat
[10:22:58.843] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//defaultMaskFile.dat
[10:22:58.843] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//trimParameters35_C15.dat
[10:22:58.921] <TB3> INFO: clk: 4
[10:22:58.921] <TB3> INFO: ctr: 4
[10:22:58.921] <TB3> INFO: sda: 19
[10:22:58.921] <TB3> INFO: tin: 9
[10:22:58.921] <TB3> INFO: level: 15
[10:22:58.921] <TB3> INFO: triggerdelay: 0
[10:22:58.921] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:22:58.921] <TB3> INFO: Log level: INFO
[10:22:58.934] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:22:58.955] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:22:58.958] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:22:58.960] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:23:00.536] <TB3> INFO: DUT info:
[10:23:00.536] <TB3> INFO: The DUT currently contains the following objects:
[10:23:00.536] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:23:00.536] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:23:00.536] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:23:00.536] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:23:00.536] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.536] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.537] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:23:00.938] <TB3> INFO: enter 'restricted' command line mode
[10:23:00.938] <TB3> INFO: enter test to run
[10:23:00.938] <TB3> INFO: test: delay setting parameters: ->5<-
[10:23:00.939] <TB3> INFO: delay test by 5 seconds...
[10:23:05.939] <TB3> INFO: enter test to run
[10:23:05.939] <TB3> INFO: test: Xray no parameter change
[10:23:05.939] <TB3> INFO: running: xray
[10:23:05.943] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//004_HRData_50//phCalibrationFitErr35_C15.dat
[10:23:06.096] <TB3> INFO: ######################################################################
[10:23:06.096] <TB3> INFO: PixTestXray::doTest()
[10:23:06.096] <TB3> INFO: ######################################################################
[10:23:06.096] <TB3> INFO: ----------------------------------------------------------------------
[10:23:06.096] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[10:23:06.097] <TB3> INFO: ----------------------------------------------------------------------
[10:23:07.061] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[10:23:18.739] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[10:23:45.804] <TB3> INFO: Resuming triggers.
[10:23:57.476] <TB3> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[10:24:26.751] <TB3> INFO: Resuming triggers.
[10:24:38.423] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[10:25:08.356] <TB3> INFO: Resuming triggers.
[10:25:20.035] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[10:25:49.153] <TB3> INFO: Resuming triggers.
[10:26:00.830] <TB3> INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[10:26:30.556] <TB3> INFO: Resuming triggers.
[10:26:42.222] <TB3> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[10:27:11.777] <TB3> INFO: Resuming triggers.
[10:27:23.446] <TB3> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[10:27:53.017] <TB3> INFO: Resuming triggers.
[10:28:04.680] <TB3> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[10:28:33.642] <TB3> INFO: Resuming triggers.
[10:28:40.487] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[10:28:56.966] <TB3> INFO: PixTest:: pg_setup set to default.
[10:28:56.967] <TB3> INFO: PixTestXray::doPhRun() done
[10:28:56.967] <TB3> INFO: PixTestXray::doTest() done
[10:28:57.148] <TB3> INFO: enter test to run
[10:28:57.148] <TB3> INFO: test: no parameter change
[10:28:57.260] <TB3> QUIET: Connection to board 121 closed.
[10:28:57.340] <TB3> INFO: pXar: this is the end, my friend

[10:30:10.990] <TB3> INFO: *** Welcome to pxar ***
[10:30:10.990] <TB3> INFO: *** Today: 2015/11/23
[10:30:11.053] <TB3> INFO: *** Version: 206d-dirty
[10:30:11.053] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//dacParameters35_C15.dat
[10:30:11.055] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//tbmParameters_C0b.dat
[10:30:11.055] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//defaultMaskFile.dat
[10:30:11.055] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//trimParameters35_C15.dat
[10:30:11.140] <TB3> INFO: clk: 4
[10:30:11.140] <TB3> INFO: ctr: 4
[10:30:11.140] <TB3> INFO: sda: 19
[10:30:11.140] <TB3> INFO: tin: 9
[10:30:11.140] <TB3> INFO: level: 15
[10:30:11.140] <TB3> INFO: triggerdelay: 0
[10:30:11.140] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:30:11.140] <TB3> INFO: Log level: INFO
[10:30:11.153] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:30:11.172] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:30:11.175] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:30:11.178] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:30:12.736] <TB3> INFO: DUT info:
[10:30:12.736] <TB3> INFO: The DUT currently contains the following objects:
[10:30:12.736] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:30:12.736] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:30:12.736] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:30:12.736] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:30:12.736] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.736] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.736] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.736] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.736] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.736] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.736] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.736] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.736] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.737] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.737] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.737] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.737] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.737] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.737] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:12.737] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:30:13.138] <TB3> INFO: enter 'restricted' command line mode
[10:30:13.138] <TB3> INFO: enter test to run
[10:30:13.138] <TB3> INFO: test: delay setting parameters: ->5<-
[10:30:13.138] <TB3> INFO: delay test by 5 seconds...
[10:30:18.138] <TB3> INFO: enter test to run
[10:30:18.138] <TB3> INFO: test: Xray no parameter change
[10:30:18.138] <TB3> INFO: running: xray
[10:30:18.141] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//005_HRData_150//phCalibrationFitErr35_C15.dat
[10:30:18.282] <TB3> INFO: ######################################################################
[10:30:18.283] <TB3> INFO: PixTestXray::doTest()
[10:30:18.283] <TB3> INFO: ######################################################################
[10:30:18.283] <TB3> INFO: ----------------------------------------------------------------------
[10:30:18.283] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[10:30:18.283] <TB3> INFO: ----------------------------------------------------------------------
[10:30:19.247] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[10:30:25.996] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[10:30:55.505] <TB3> INFO: Resuming triggers.
[10:31:02.248] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[10:31:34.407] <TB3> INFO: Resuming triggers.
[10:31:41.158] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[10:32:13.721] <TB3> INFO: Resuming triggers.
[10:32:20.472] <TB3> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[10:32:52.910] <TB3> INFO: Resuming triggers.
[10:32:59.650] <TB3> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[10:33:31.775] <TB3> INFO: Resuming triggers.
[10:33:38.525] <TB3> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[10:34:10.808] <TB3> INFO: Resuming triggers.
[10:34:17.547] <TB3> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[10:34:47.002] <TB3> INFO: Resuming triggers.
[10:34:53.742] <TB3> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[10:35:23.204] <TB3> INFO: Resuming triggers.
[10:35:29.945] <TB3> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[10:35:59.925] <TB3> INFO: Resuming triggers.
[10:36:06.664] <TB3> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[10:36:37.742] <TB3> INFO: Resuming triggers.
[10:36:44.479] <TB3> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[10:37:17.576] <TB3> INFO: Resuming triggers.
[10:37:24.315] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[10:37:57.422] <TB3> INFO: Resuming triggers.
[10:38:04.170] <TB3> INFO: run duration 87 seconds, buffer almost full (81%), pausing triggers.
[10:38:36.747] <TB3> INFO: Resuming triggers.
[10:38:43.485] <TB3> INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[10:39:14.956] <TB3> INFO: Resuming triggers.
[10:39:20.772] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[10:39:47.116] <TB3> INFO: PixTest:: pg_setup set to default.
[10:39:47.118] <TB3> INFO: PixTestXray::doPhRun() done
[10:39:47.118] <TB3> INFO: PixTestXray::doTest() done
[10:39:47.334] <TB3> INFO: enter test to run
[10:39:47.334] <TB3> INFO: test: no parameter change
[10:39:47.435] <TB3> QUIET: Connection to board 121 closed.
[10:39:47.517] <TB3> INFO: pXar: this is the end, my friend

[10:42:25.066] <TB3> INFO: *** Welcome to pxar ***
[10:42:25.066] <TB3> INFO: *** Today: 2015/11/23
[10:42:25.351] <TB3> INFO: *** Version: 206d-dirty
[10:42:25.351] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//dacParameters35_C15.dat
[10:42:25.352] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//tbmParameters_C0b.dat
[10:42:25.353] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//defaultMaskFile.dat
[10:42:25.353] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//trimParameters35_C15.dat
[10:42:25.431] <TB3> INFO: clk: 4
[10:42:25.431] <TB3> INFO: ctr: 4
[10:42:25.431] <TB3> INFO: sda: 19
[10:42:25.431] <TB3> INFO: tin: 9
[10:42:25.431] <TB3> INFO: level: 15
[10:42:25.431] <TB3> INFO: triggerdelay: 0
[10:42:25.431] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[10:42:25.431] <TB3> INFO: Log level: INFO
[10:42:25.445] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:42:25.462] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:42:25.465] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:42:25.467] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:42:27.027] <TB3> INFO: DUT info:
[10:42:27.027] <TB3> INFO: The DUT currently contains the following objects:
[10:42:27.027] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[10:42:27.027] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:42:27.027] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:42:27.027] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:42:27.027] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.027] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.027] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.027] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.027] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.028] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:42:27.429] <TB3> INFO: enter 'restricted' command line mode
[10:42:27.429] <TB3> INFO: enter test to run
[10:42:27.429] <TB3> INFO: test: Highrate no parameter change
[10:42:27.429] <TB3> INFO: running: highrate
[10:42:27.434] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[10:42:27.584] <TB3> INFO: ----------------------------------------------------------------------
[10:42:27.584] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[10:42:27.584] <TB3> INFO: ----------------------------------------------------------------------
[10:42:27.588] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[10:42:27.599] <TB3> INFO: dacScan step from 15 .. 34
[10:42:27.599] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:42:27.599] <TB3> INFO: run 1 of 1
[10:42:28.207] <TB3> INFO: Expecting 4160000 events.
[10:43:08.135] <TB3> INFO: 844350 events read in total (39399ms).
[10:43:46.864] <TB3> INFO: 1690450 events read in total (78128ms).
[10:44:26.772] <TB3> INFO: 2536450 events read in total (118036ms).
[10:45:06.034] <TB3> INFO: 3380050 events read in total (157298ms).
[10:45:41.814] <TB3> INFO: 4160000 events read in total (193078ms).
[10:45:41.918] <TB3> INFO: Test took 194318ms.
[10:45:45.388] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:45:48.281] <TB3> INFO: dacScan step from 35 .. 54
[10:45:48.281] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:45:48.281] <TB3> INFO: run 1 of 1
[10:45:48.883] <TB3> INFO: Expecting 4160000 events.
[10:46:22.432] <TB3> INFO: 572500 events read in total (33023ms).
[10:46:57.471] <TB3> INFO: 1144850 events read in total (68062ms).
[10:47:33.567] <TB3> INFO: 1715800 events read in total (104158ms).
[10:48:08.220] <TB3> INFO: 2284650 events read in total (138811ms).
[10:48:42.264] <TB3> INFO: 2849000 events read in total (172855ms).
[10:49:15.850] <TB3> INFO: 3407850 events read in total (206441ms).
[10:49:50.130] <TB3> INFO: 3963900 events read in total (240721ms).
[10:50:02.791] <TB3> INFO: 4160000 events read in total (253382ms).
[10:50:02.906] <TB3> INFO: Test took 254625ms.
[10:50:03.822] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:50:07.247] <TB3> INFO: dacScan step from 55 .. 74
[10:50:07.247] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:50:07.247] <TB3> INFO: run 1 of 1
[10:50:07.859] <TB3> INFO: Expecting 4160000 events.
[10:50:42.059] <TB3> INFO: 517600 events read in total (33674ms).
[10:51:15.817] <TB3> INFO: 1035650 events read in total (67432ms).
[10:51:47.470] <TB3> INFO: 1553850 events read in total (99085ms).
[10:52:21.838] <TB3> INFO: 2072050 events read in total (133453ms).
[10:52:55.515] <TB3> INFO: 2590300 events read in total (167130ms).
[10:53:29.934] <TB3> INFO: 3108400 events read in total (201549ms).
[10:54:03.726] <TB3> INFO: 3626450 events read in total (235341ms).
[10:54:36.947] <TB3> INFO: 4144150 events read in total (268562ms).
[10:54:38.136] <TB3> INFO: 4160000 events read in total (269751ms).
[10:54:38.278] <TB3> INFO: Test took 271030ms.
[10:54:39.360] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:54:42.834] <TB3> INFO: dacScan step from 75 .. 75
[10:54:42.834] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:54:42.834] <TB3> INFO: run 1 of 1
[10:54:43.430] <TB3> INFO: Expecting 208000 events.
[10:54:58.986] <TB3> INFO: 208000 events read in total (15030ms).
[10:54:58.991] <TB3> INFO: Test took 16157ms.
[10:54:59.042] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:54:59.205] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:00.448] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:01.503] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:02.563] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:03.631] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:04.706] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:05.882] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:07.085] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:08.264] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:09.392] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:10.557] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:11.693] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:12.718] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:13.731] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:14.747] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:15.836] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:55:16.966] <TB3> INFO: PixTest:: pg_setup set to default.
[10:55:16.969] <TB3> INFO: vcal mean: 36.28 36.61 35.65 38.29 38.28 38.81 38.84 37.99 39.21 38.97 39.19 38.34 38.26 36.26 36.84 36.95
[10:55:16.969] <TB3> INFO: vcal RMS: 0.82 1.12 0.90 1.06 1.08 1.20 1.18 1.22 1.11 1.42 1.10 1.05 1.11 0.94 0.96 0.91
[10:55:16.969] <TB3> INFO: number of X-ray hits detected: 95574 109315 93313 164245 176093 205827 194358 208542 220406 203778 225606 184749 180844 107125 117481 109691
[10:55:16.969] <TB3> 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:55:16.969] <TB3> INFO: X-ray hit rate [MHz/cm2]: 28.0 32.0 27.4 48.1 51.6 60.3 57.0 61.1 64.6 59.7 66.1 54.2 53.0 31.4 34.4 32.2
[10:55:16.969] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[10:55:17.083] <TB3> INFO: enter test to run
[10:55:17.083] <TB3> INFO: test: no parameter change
[10:55:17.185] <TB3> QUIET: Connection to board 121 closed.
[10:55:17.274] <TB3> INFO: pXar: this is the end, my friend

[11:14:20.454] <TB3> INFO: *** Welcome to pxar ***
[11:14:20.454] <TB3> INFO: *** Today: 2015/11/23
[11:14:20.514] <TB3> INFO: *** Version: 206d-dirty
[11:14:20.514] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:14:20.515] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[11:14:20.516] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[11:14:20.516] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[11:14:20.595] <TB3> INFO: clk: 4
[11:14:20.595] <TB3> INFO: ctr: 4
[11:14:20.595] <TB3> INFO: sda: 19
[11:14:20.595] <TB3> INFO: tin: 9
[11:14:20.595] <TB3> INFO: level: 15
[11:14:20.595] <TB3> INFO: triggerdelay: 0
[11:14:20.595] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:14:20.595] <TB3> INFO: Log level: INFO
[11:14:20.609] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:14:20.624] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:14:20.627] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:14:20.630] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:14:22.176] <TB3> INFO: DUT info:
[11:14:22.176] <TB3> INFO: The DUT currently contains the following objects:
[11:14:22.176] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:14:22.176] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:14:22.176] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:14:22.176] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:14:22.176] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.176] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.177] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:14:22.578] <TB3> INFO: enter 'restricted' command line mode
[11:14:22.578] <TB3> INFO: enter test to run
[11:14:22.578] <TB3> INFO: test: HighRate no parameter change
[11:14:22.578] <TB3> INFO: running: highrate
[11:14:22.581] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[11:14:22.787] <TB3> INFO: ----------------------------------------------------------------------
[11:14:22.787] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:14:22.787] <TB3> INFO: ----------------------------------------------------------------------
[11:14:22.924] <TB3> INFO: Expecting 768 events.
[11:14:24.062] <TB3> INFO: 768 events read in total (421ms).
[11:14:24.251] <TB3> INFO: Test took 1460ms.
[11:14:24.866] <TB3> INFO: Expecting 41600 events.
[11:14:28.325] <TB3> INFO: 41600 events read in total (2933ms).
[11:14:28.327] <TB3> INFO: Test took 4071ms.
[11:14:28.376] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:29.061] <TB3> INFO: Expecting 41600 events.
[11:14:32.405] <TB3> INFO: 41600 events read in total (2818ms).
[11:14:32.406] <TB3> INFO: Test took 4005ms.
[11:14:32.452] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:33.138] <TB3> INFO: Expecting 41600 events.
[11:14:36.623] <TB3> INFO: 41600 events read in total (2958ms).
[11:14:36.624] <TB3> INFO: Test took 4152ms.
[11:14:36.676] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:37.361] <TB3> INFO: Expecting 41600 events.
[11:14:41.009] <TB3> INFO: 41600 events read in total (3122ms).
[11:14:41.010] <TB3> INFO: Test took 4310ms.
[11:14:41.063] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:41.740] <TB3> INFO: Expecting 41600 events.
[11:14:45.466] <TB3> INFO: 41600 events read in total (3200ms).
[11:14:45.468] <TB3> INFO: Test took 4379ms.
[11:14:45.518] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:46.203] <TB3> INFO: Expecting 41600 events.
[11:14:49.831] <TB3> INFO: 41600 events read in total (3102ms).
[11:14:49.833] <TB3> INFO: Test took 4289ms.
[11:14:49.879] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:50.578] <TB3> INFO: Expecting 41600 events.
[11:14:54.251] <TB3> INFO: 41600 events read in total (3146ms).
[11:14:54.253] <TB3> INFO: Test took 4355ms.
[11:14:54.300] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:54.992] <TB3> INFO: Expecting 41600 events.
[11:14:58.654] <TB3> INFO: 41600 events read in total (3135ms).
[11:14:58.655] <TB3> INFO: Test took 4336ms.
[11:14:58.704] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:14:59.386] <TB3> INFO: Expecting 41600 events.
[11:15:03.025] <TB3> INFO: 41600 events read in total (3113ms).
[11:15:03.026] <TB3> INFO: Test took 4298ms.
[11:15:03.074] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:03.761] <TB3> INFO: Expecting 41600 events.
[11:15:07.447] <TB3> INFO: 41600 events read in total (3160ms).
[11:15:07.448] <TB3> INFO: Test took 4356ms.
[11:15:07.498] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:08.190] <TB3> INFO: Expecting 41600 events.
[11:15:11.762] <TB3> INFO: 41600 events read in total (3046ms).
[11:15:11.763] <TB3> INFO: Test took 4245ms.
[11:15:11.810] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:12.508] <TB3> INFO: Expecting 41600 events.
[11:15:16.005] <TB3> INFO: 41600 events read in total (2971ms).
[11:15:16.006] <TB3> INFO: Test took 4172ms.
[11:15:16.052] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:16.752] <TB3> INFO: Expecting 41600 events.
[11:15:20.263] <TB3> INFO: 41600 events read in total (2984ms).
[11:15:20.264] <TB3> INFO: Test took 4193ms.
[11:15:20.311] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:21.008] <TB3> INFO: Expecting 41600 events.
[11:15:24.258] <TB3> INFO: 41600 events read in total (2724ms).
[11:15:24.259] <TB3> INFO: Test took 3929ms.
[11:15:24.303] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:24.998] <TB3> INFO: Expecting 41600 events.
[11:15:28.397] <TB3> INFO: 41600 events read in total (2873ms).
[11:15:28.398] <TB3> INFO: Test took 4076ms.
[11:15:28.442] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:29.143] <TB3> INFO: Expecting 41600 events.
[11:15:32.749] <TB3> INFO: 41600 events read in total (3080ms).
[11:15:32.751] <TB3> INFO: Test took 4291ms.
[11:15:32.808] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:33.498] <TB3> INFO: Expecting 41600 events.
[11:15:36.950] <TB3> INFO: 41600 events read in total (2925ms).
[11:15:36.951] <TB3> INFO: Test took 4125ms.
[11:15:37.000] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:37.692] <TB3> INFO: Expecting 41600 events.
[11:15:41.056] <TB3> INFO: 41600 events read in total (2838ms).
[11:15:41.057] <TB3> INFO: Test took 4039ms.
[11:15:41.102] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:41.796] <TB3> INFO: Expecting 41600 events.
[11:15:45.074] <TB3> INFO: 41600 events read in total (2751ms).
[11:15:45.076] <TB3> INFO: Test took 3955ms.
[11:15:45.123] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:45.819] <TB3> INFO: Expecting 41600 events.
[11:15:48.708] <TB3> INFO: 41600 events read in total (2363ms).
[11:15:48.709] <TB3> INFO: Test took 3565ms.
[11:15:48.753] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:15:49.131] <TB3> INFO: enter test to run
[11:15:49.131] <TB3> INFO: test: Pretest no parameter change
[11:15:49.131] <TB3> INFO: running: pretest
[11:15:49.131] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[11:15:49.131] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[11:15:49.131] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[11:15:49.132] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[11:15:49.133] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[11:15:49.133] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[11:15:49.133] <TB3> INFO: write dac parameters into /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[11:15:49.133] <TB3> INFO: enter test to run
[11:15:49.133] <TB3> INFO: test: no parameter change
[11:15:49.221] <TB3> QUIET: Connection to board 121 closed.
[11:15:49.300] <TB3> INFO: pXar: this is the end, my friend

[11:16:15.207] <TB3> INFO: *** Welcome to pxar ***
[11:16:15.207] <TB3> INFO: *** Today: 2015/11/23
[11:16:15.303] <TB3> INFO: *** Version: 206d-dirty
[11:16:15.303] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//dacParameters35_C15.dat
[11:16:15.303] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//tbmParameters_C0b.dat
[11:16:15.304] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//defaultMaskFile.dat
[11:16:15.304] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//trimParameters35_C15.dat
[11:16:15.392] <TB3> INFO: clk: 4
[11:16:15.392] <TB3> INFO: ctr: 4
[11:16:15.392] <TB3> INFO: sda: 19
[11:16:15.392] <TB3> INFO: tin: 9
[11:16:15.392] <TB3> INFO: level: 15
[11:16:15.392] <TB3> INFO: triggerdelay: 0
[11:16:15.392] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:16:15.392] <TB3> INFO: Log level: INFO
[11:16:15.405] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:16:15.421] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:16:15.424] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:16:15.427] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:16:17.000] <TB3> INFO: DUT info:
[11:16:17.000] <TB3> INFO: The DUT currently contains the following objects:
[11:16:17.000] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:16:17.000] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:16:17.000] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:16:17.000] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:16:17.001] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.001] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:16:17.402] <TB3> INFO: enter 'restricted' command line mode
[11:16:17.402] <TB3> INFO: enter test to run
[11:16:17.402] <TB3> INFO: test: PixelAlive no parameter change
[11:16:17.402] <TB3> INFO: running: pixelalive
[11:16:17.410] <TB3> INFO: ######################################################################
[11:16:17.410] <TB3> INFO: PixTestAlive::doTest()
[11:16:17.410] <TB3> INFO: ######################################################################
[11:16:17.411] <TB3> INFO: ----------------------------------------------------------------------
[11:16:17.411] <TB3> 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:16:17.411] <TB3> INFO: ----------------------------------------------------------------------
[11:16:17.721] <TB3> INFO: Expecting 208000 events.
[11:16:29.044] <TB3> INFO: 208000 events read in total (10606ms).
[11:16:29.130] <TB3> INFO: Test took 11717ms.
[11:16:29.143] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:29.402] <TB3> INFO: PixTestAlive::aliveTest() done
[11:16:29.402] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:16:29.404] <TB3> INFO: ----------------------------------------------------------------------
[11:16:29.404] <TB3> 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:16:29.404] <TB3> INFO: ----------------------------------------------------------------------
[11:16:29.744] <TB3> INFO: Expecting 208000 events.
[11:16:36.541] <TB3> INFO: 208000 events read in total (6082ms).
[11:16:36.541] <TB3> INFO: Test took 7136ms.
[11:16:36.541] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:36.542] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:16:36.949] <TB3> INFO: PixTestAlive::maskTest() done
[11:16:36.949] <TB3> 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:16:36.950] <TB3> INFO: ----------------------------------------------------------------------
[11:16:36.950] <TB3> 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:16:36.950] <TB3> INFO: ----------------------------------------------------------------------
[11:16:37.296] <TB3> INFO: Expecting 208000 events.
[11:16:48.469] <TB3> INFO: 208000 events read in total (10458ms).
[11:16:48.471] <TB3> INFO: Test took 11519ms.
[11:16:48.479] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:16:48.797] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:16:48.797] <TB3> 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:16:48.797] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[11:16:48.842] <TB3> INFO: enter test to run
[11:16:48.842] <TB3> INFO: test: delay setting parameters: ->2<-
[11:16:48.842] <TB3> INFO: delay test by 2 seconds...
[11:16:50.842] <TB3> INFO: enter test to run
[11:16:50.842] <TB3> INFO: test: HighRate no parameter change
[11:16:50.842] <TB3> INFO: running: highrate
[11:16:50.843] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[11:16:51.020] <TB3> INFO: ----------------------------------------------------------------------
[11:16:51.020] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:16:51.020] <TB3> INFO: ----------------------------------------------------------------------
[11:16:51.646] <TB3> INFO: Expecting 208000 events.
[11:17:02.458] <TB3> INFO: 208000 events read in total (10286ms).
[11:17:02.461] <TB3> INFO: Test took 11438ms.
[11:17:02.594] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:02.835] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:17:02.835] <TB3> INFO: number of red-efficiency pixels: 52 76 49 104 97 117 97 108 117 127 138 118 128 62 66 68
[11:17:02.835] <TB3> INFO: number of X-ray hits detected: 43095 48778 41450 74646 80176 95494 89226 95966 100689 93276 105037 85287 83360 47692 52882 50045
[11:17:02.835] <TB3> 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:17:02.835] <TB3> INFO: number of Vcal hits detected: 207948 207776 207951 207895 207900 207881 207900 207889 207879 207823 207857 207881 207871 207937 207934 207932
[11:17:02.835] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 100.0 100.0 99.9 100.0 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[11:17:02.835] <TB3> INFO: Vcal hit overall efficiency (%): 100.0 99.9 100.0 99.9 100.0 99.9 100.0 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[11:17:02.835] <TB3> INFO: X-ray hit rate [MHz/cm2]: 12.6 14.3 12.1 21.9 23.5 28.0 26.2 28.1 29.5 27.3 30.8 25.0 24.4 14.0 15.5 14.7
[11:17:02.835] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:17:02.861] <TB3> INFO: PixTest:: pg_setup set to default.
[11:17:02.868] <TB3> INFO: enter test to run
[11:17:02.868] <TB3> INFO: test: no parameter change
[11:17:02.939] <TB3> QUIET: Connection to board 121 closed.
[11:17:03.018] <TB3> INFO: pXar: this is the end, my friend

[11:17:28.950] <TB3> INFO: *** Welcome to pxar ***
[11:17:28.950] <TB3> INFO: *** Today: 2015/11/23
[11:17:29.238] <TB3> INFO: *** Version: 206d-dirty
[11:17:29.238] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//dacParameters35_C15.dat
[11:17:29.239] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//tbmParameters_C0b.dat
[11:17:29.239] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//defaultMaskFile.dat
[11:17:29.239] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//trimParameters35_C15.dat
[11:17:29.312] <TB3> INFO: clk: 4
[11:17:29.312] <TB3> INFO: ctr: 4
[11:17:29.312] <TB3> INFO: sda: 19
[11:17:29.312] <TB3> INFO: tin: 9
[11:17:29.312] <TB3> INFO: level: 15
[11:17:29.312] <TB3> INFO: triggerdelay: 0
[11:17:29.312] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:17:29.312] <TB3> INFO: Log level: INFO
[11:17:29.326] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:17:29.342] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:17:29.345] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:17:29.347] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:17:30.891] <TB3> INFO: DUT info:
[11:17:30.891] <TB3> INFO: The DUT currently contains the following objects:
[11:17:30.891] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:17:30.891] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:17:30.891] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:17:30.891] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:17:30.891] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:30.891] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:17:31.292] <TB3> INFO: enter 'restricted' command line mode
[11:17:31.292] <TB3> INFO: enter test to run
[11:17:31.292] <TB3> INFO: test: PixelAlive no parameter change
[11:17:31.292] <TB3> INFO: running: pixelalive
[11:17:31.301] <TB3> INFO: ######################################################################
[11:17:31.301] <TB3> INFO: PixTestAlive::doTest()
[11:17:31.301] <TB3> INFO: ######################################################################
[11:17:31.303] <TB3> INFO: ----------------------------------------------------------------------
[11:17:31.303] <TB3> 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:17:31.303] <TB3> INFO: ----------------------------------------------------------------------
[11:17:31.653] <TB3> INFO: Expecting 208000 events.
[11:17:43.002] <TB3> INFO: 208000 events read in total (10632ms).
[11:17:43.116] <TB3> INFO: Test took 11811ms.
[11:17:43.127] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:43.392] <TB3> INFO: PixTestAlive::aliveTest() done
[11:17:43.392] <TB3> INFO: number of dead pixels (per ROC): 0 2 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:17:43.394] <TB3> INFO: ----------------------------------------------------------------------
[11:17:43.394] <TB3> 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:17:43.394] <TB3> INFO: ----------------------------------------------------------------------
[11:17:43.710] <TB3> INFO: Expecting 208000 events.
[11:17:50.379] <TB3> INFO: 208000 events read in total (5954ms).
[11:17:50.380] <TB3> INFO: Test took 6984ms.
[11:17:50.380] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:17:50.380] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:17:50.782] <TB3> INFO: PixTestAlive::maskTest() done
[11:17:50.782] <TB3> 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:17:50.784] <TB3> INFO: ----------------------------------------------------------------------
[11:17:50.784] <TB3> 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:17:50.784] <TB3> INFO: ----------------------------------------------------------------------
[11:17:51.111] <TB3> INFO: Expecting 208000 events.
[11:18:02.209] <TB3> INFO: 208000 events read in total (10383ms).
[11:18:02.210] <TB3> INFO: Test took 11425ms.
[11:18:02.216] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:02.545] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:18:02.545] <TB3> 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:18:02.546] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[11:18:02.588] <TB3> INFO: enter test to run
[11:18:02.588] <TB3> INFO: test: delay setting parameters: ->2<-
[11:18:02.588] <TB3> INFO: delay test by 2 seconds...
[11:18:04.588] <TB3> INFO: enter test to run
[11:18:04.588] <TB3> INFO: test: HighRate no parameter change
[11:18:04.588] <TB3> INFO: running: highrate
[11:18:04.589] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//013_HREfficiency_100//phCalibrationFitErr35_C15.dat
[11:18:04.827] <TB3> INFO: ----------------------------------------------------------------------
[11:18:04.827] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:18:04.827] <TB3> INFO: ----------------------------------------------------------------------
[11:18:05.442] <TB3> INFO: Expecting 208000 events.
[11:18:17.939] <TB3> INFO: 208000 events read in total (11971ms).
[11:18:17.944] <TB3> INFO: Test took 13113ms.
[11:18:18.230] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:18.518] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:18:18.518] <TB3> INFO: number of red-efficiency pixels: 137 163 129 265 319 404 305 367 401 430 438 404 361 181 190 170
[11:18:18.518] <TB3> INFO: number of X-ray hits detected: 95077 108601 93003 163749 174962 205274 193482 207924 218915 203687 224701 185215 180436 106939 117802 110129
[11:18:18.518] <TB3> 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:18:18.518] <TB3> INFO: number of Vcal hits detected: 207859 207687 207865 207715 207656 207560 207682 207613 207576 207472 207527 207575 207619 207810 207804 207826
[11:18:18.518] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[11:18:18.518] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.8 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.9 99.9 99.9
[11:18:18.518] <TB3> INFO: X-ray hit rate [MHz/cm2]: 27.9 31.8 27.3 48.0 51.3 60.2 56.7 60.9 64.2 59.7 65.9 54.3 52.9 31.3 34.5 32.3
[11:18:18.518] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:18:18.544] <TB3> INFO: PixTest:: pg_setup set to default.
[11:18:18.552] <TB3> INFO: enter test to run
[11:18:18.552] <TB3> INFO: test: no parameter change
[11:18:18.648] <TB3> QUIET: Connection to board 121 closed.
[11:18:18.728] <TB3> INFO: pXar: this is the end, my friend

[11:18:43.566] <TB3> INFO: *** Welcome to pxar ***
[11:18:43.566] <TB3> INFO: *** Today: 2015/11/23
[11:18:43.662] <TB3> INFO: *** Version: 206d-dirty
[11:18:43.662] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//dacParameters35_C15.dat
[11:18:43.664] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//tbmParameters_C0b.dat
[11:18:43.664] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//defaultMaskFile.dat
[11:18:43.664] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//trimParameters35_C15.dat
[11:18:43.748] <TB3> INFO: clk: 4
[11:18:43.748] <TB3> INFO: ctr: 4
[11:18:43.748] <TB3> INFO: sda: 19
[11:18:43.748] <TB3> INFO: tin: 9
[11:18:43.749] <TB3> INFO: level: 15
[11:18:43.749] <TB3> INFO: triggerdelay: 0
[11:18:43.749] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:18:43.749] <TB3> INFO: Log level: INFO
[11:18:43.761] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:18:43.777] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:18:43.780] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:18:43.782] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:18:45.341] <TB3> INFO: DUT info:
[11:18:45.341] <TB3> INFO: The DUT currently contains the following objects:
[11:18:45.341] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:18:45.341] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:18:45.341] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:18:45.341] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:18:45.341] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.341] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.342] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.342] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.342] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.342] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.342] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:18:45.743] <TB3> INFO: enter 'restricted' command line mode
[11:18:45.743] <TB3> INFO: enter test to run
[11:18:45.743] <TB3> INFO: test: PixelAlive no parameter change
[11:18:45.743] <TB3> INFO: running: pixelalive
[11:18:45.750] <TB3> INFO: ######################################################################
[11:18:45.750] <TB3> INFO: PixTestAlive::doTest()
[11:18:45.750] <TB3> INFO: ######################################################################
[11:18:45.752] <TB3> INFO: ----------------------------------------------------------------------
[11:18:45.752] <TB3> 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:18:45.752] <TB3> INFO: ----------------------------------------------------------------------
[11:18:46.068] <TB3> INFO: Expecting 208000 events.
[11:18:57.062] <TB3> INFO: 208000 events read in total (10276ms).
[11:18:57.153] <TB3> INFO: Test took 11399ms.
[11:18:57.167] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:18:57.417] <TB3> INFO: PixTestAlive::aliveTest() done
[11:18:57.417] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:18:57.419] <TB3> INFO: ----------------------------------------------------------------------
[11:18:57.419] <TB3> 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:18:57.419] <TB3> INFO: ----------------------------------------------------------------------
[11:18:57.732] <TB3> INFO: Expecting 208000 events.
[11:19:04.504] <TB3> INFO: 208000 events read in total (6058ms).
[11:19:04.504] <TB3> INFO: Test took 7083ms.
[11:19:04.504] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:04.505] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:19:04.912] <TB3> INFO: PixTestAlive::maskTest() done
[11:19:04.912] <TB3> 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:19:04.914] <TB3> INFO: ----------------------------------------------------------------------
[11:19:04.914] <TB3> 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:19:04.914] <TB3> INFO: ----------------------------------------------------------------------
[11:19:05.244] <TB3> INFO: Expecting 208000 events.
[11:19:16.585] <TB3> INFO: 208000 events read in total (10626ms).
[11:19:16.586] <TB3> INFO: Test took 11670ms.
[11:19:16.602] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:16.912] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:19:16.912] <TB3> 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:19:16.912] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[11:19:16.942] <TB3> INFO: enter test to run
[11:19:16.942] <TB3> INFO: test: delay setting parameters: ->2<-
[11:19:16.942] <TB3> INFO: delay test by 2 seconds...
[11:19:18.942] <TB3> INFO: enter test to run
[11:19:18.942] <TB3> INFO: test: HighRate no parameter change
[11:19:18.942] <TB3> INFO: running: highrate
[11:19:18.943] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//014_HREfficiency_150//phCalibrationFitErr35_C15.dat
[11:19:19.104] <TB3> INFO: ----------------------------------------------------------------------
[11:19:19.104] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:19:19.105] <TB3> INFO: ----------------------------------------------------------------------
[11:19:19.747] <TB3> INFO: Expecting 208000 events.
[11:19:34.305] <TB3> INFO: 208000 events read in total (14032ms).
[11:19:34.313] <TB3> INFO: Test took 15205ms.
[11:19:34.716] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:19:35.047] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:19:35.047] <TB3> INFO: number of red-efficiency pixels: 226 319 278 489 671 841 619 851 795 960 953 879 795 349 337 316
[11:19:35.047] <TB3> INFO: number of X-ray hits detected: 143982 165185 140333 243788 261505 303365 290108 310861 328214 302225 334948 275521 268029 161017 176607 164239
[11:19:35.047] <TB3> 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:19:35.047] <TB3> INFO: number of Vcal hits detected: 207761 207515 207703 207467 207240 207027 207306 207046 207092 206773 206878 206962 207082 207600 207647 207674
[11:19:35.047] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.8 99.9 99.8 99.7 99.6 99.7 99.6 99.6 99.5 99.5 99.5 99.6 99.8 99.8 99.9
[11:19:35.047] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.8 99.9 99.7 99.6 99.5 99.7 99.5 99.6 99.4 99.5 99.5 99.6 99.8 99.8 99.8
[11:19:35.047] <TB3> INFO: X-ray hit rate [MHz/cm2]: 42.2 48.4 41.1 71.5 76.6 88.9 85.0 91.1 96.2 88.6 98.2 80.8 78.6 47.2 51.8 48.1
[11:19:35.047] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:19:35.072] <TB3> INFO: PixTest:: pg_setup set to default.
[11:19:35.082] <TB3> INFO: enter test to run
[11:19:35.082] <TB3> INFO: test: no parameter change
[11:19:35.187] <TB3> QUIET: Connection to board 121 closed.
[11:19:35.266] <TB3> INFO: pXar: this is the end, my friend

[11:19:59.514] <TB3> INFO: *** Welcome to pxar ***
[11:19:59.514] <TB3> INFO: *** Today: 2015/11/23
[11:19:59.576] <TB3> INFO: *** Version: 206d-dirty
[11:19:59.576] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//dacParameters35_C15.dat
[11:19:59.577] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//tbmParameters_C0b.dat
[11:19:59.577] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//defaultMaskFile.dat
[11:19:59.577] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//trimParameters35_C15.dat
[11:19:59.648] <TB3> INFO: clk: 4
[11:19:59.648] <TB3> INFO: ctr: 4
[11:19:59.648] <TB3> INFO: sda: 19
[11:19:59.648] <TB3> INFO: tin: 9
[11:19:59.648] <TB3> INFO: level: 15
[11:19:59.648] <TB3> INFO: triggerdelay: 0
[11:19:59.648] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:19:59.648] <TB3> INFO: Log level: INFO
[11:19:59.660] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:19:59.677] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:19:59.680] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:19:59.683] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:20:01.241] <TB3> INFO: DUT info:
[11:20:01.241] <TB3> INFO: The DUT currently contains the following objects:
[11:20:01.241] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:20:01.241] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:20:01.241] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:20:01.241] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:20:01.241] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.241] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.241] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.241] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.241] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.242] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:20:01.643] <TB3> INFO: enter 'restricted' command line mode
[11:20:01.643] <TB3> INFO: enter test to run
[11:20:01.643] <TB3> INFO: test: PixelAlive no parameter change
[11:20:01.643] <TB3> INFO: running: pixelalive
[11:20:01.650] <TB3> INFO: ######################################################################
[11:20:01.650] <TB3> INFO: PixTestAlive::doTest()
[11:20:01.650] <TB3> INFO: ######################################################################
[11:20:01.652] <TB3> INFO: ----------------------------------------------------------------------
[11:20:01.652] <TB3> 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:20:01.652] <TB3> INFO: ----------------------------------------------------------------------
[11:20:01.991] <TB3> INFO: Expecting 208000 events.
[11:20:13.053] <TB3> INFO: 208000 events read in total (10344ms).
[11:20:13.159] <TB3> INFO: Test took 11505ms.
[11:20:13.167] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:13.424] <TB3> INFO: PixTestAlive::aliveTest() done
[11:20:13.424] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:20:13.426] <TB3> INFO: ----------------------------------------------------------------------
[11:20:13.426] <TB3> 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:20:13.426] <TB3> INFO: ----------------------------------------------------------------------
[11:20:13.771] <TB3> INFO: Expecting 208000 events.
[11:20:20.422] <TB3> INFO: 208000 events read in total (5935ms).
[11:20:20.423] <TB3> INFO: Test took 6995ms.
[11:20:20.423] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:20.423] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:20:20.830] <TB3> INFO: PixTestAlive::maskTest() done
[11:20:20.830] <TB3> 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:20:20.832] <TB3> INFO: ----------------------------------------------------------------------
[11:20:20.832] <TB3> 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:20:20.832] <TB3> INFO: ----------------------------------------------------------------------
[11:20:21.145] <TB3> INFO: Expecting 208000 events.
[11:20:32.798] <TB3> INFO: 208000 events read in total (10938ms).
[11:20:32.798] <TB3> INFO: Test took 11964ms.
[11:20:32.815] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:33.127] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:20:33.127] <TB3> 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:20:33.127] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[11:20:33.169] <TB3> INFO: enter test to run
[11:20:33.169] <TB3> INFO: test: delay setting parameters: ->2<-
[11:20:33.169] <TB3> INFO: delay test by 2 seconds...
[11:20:35.170] <TB3> INFO: enter test to run
[11:20:35.170] <TB3> INFO: test: HighRate no parameter change
[11:20:35.170] <TB3> INFO: running: highrate
[11:20:35.170] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//015_HREfficiency_200//phCalibrationFitErr35_C15.dat
[11:20:35.338] <TB3> INFO: ----------------------------------------------------------------------
[11:20:35.338] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:20:35.338] <TB3> INFO: ----------------------------------------------------------------------
[11:20:35.959] <TB3> INFO: Expecting 208000 events.
[11:20:54.202] <TB3> INFO: 208000 events read in total (17717ms).
[11:20:54.213] <TB3> INFO: Test took 18871ms.
[11:20:54.770] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:20:55.152] <TB3> INFO: number of dead pixels (per ROC): 0 2 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:20:55.152] <TB3> INFO: number of red-efficiency pixels: 404 526 454 996 1405 1506 1244 1641 1634 1824 1737 1512 1461 700 564 567
[11:20:55.152] <TB3> INFO: number of X-ray hits detected: 201222 231344 197692 337787 364068 422382 402378 431947 456533 419135 462552 381595 372874 226424 246420 229085
[11:20:55.152] <TB3> 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:20:55.152] <TB3> INFO: number of Vcal hits detected: 207572 207284 207455 206794 206036 205816 206303 205786 205759 205155 205402 205818 206044 207082 207376 207370
[11:20:55.152] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.7 99.8 99.5 99.2 99.1 99.3 99.0 99.0 98.8 98.9 99.1 99.2 99.6 99.7 99.7
[11:20:55.152] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.7 99.4 99.1 99.0 99.2 98.9 98.9 98.6 98.8 99.0 99.1 99.6 99.7 99.7
[11:20:55.152] <TB3> INFO: X-ray hit rate [MHz/cm2]: 59.0 67.8 57.9 99.0 106.7 123.8 117.9 126.6 133.8 122.9 135.6 111.8 109.3 66.4 72.2 67.1
[11:20:55.152] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:20:55.178] <TB3> INFO: PixTest:: pg_setup set to default.
[11:20:55.188] <TB3> INFO: enter test to run
[11:20:55.188] <TB3> INFO: test: no parameter change
[11:20:55.265] <TB3> QUIET: Connection to board 121 closed.
[11:20:55.345] <TB3> INFO: pXar: this is the end, my friend

[11:21:20.657] <TB3> INFO: *** Welcome to pxar ***
[11:21:20.657] <TB3> INFO: *** Today: 2015/11/23
[11:21:20.792] <TB3> INFO: *** Version: 206d-dirty
[11:21:20.792] <TB3> INFO: readRocDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//dacParameters35_C15.dat
[11:21:20.793] <TB3> INFO: readTbmDacs: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//tbmParameters_C0b.dat
[11:21:20.793] <TB3> INFO: readMaskFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//defaultMaskFile.dat
[11:21:20.793] <TB3> INFO: readTrimFile: /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//trimParameters35_C15.dat
[11:21:20.890] <TB3> INFO: clk: 4
[11:21:20.890] <TB3> INFO: ctr: 4
[11:21:20.890] <TB3> INFO: sda: 19
[11:21:20.890] <TB3> INFO: tin: 9
[11:21:20.890] <TB3> INFO: level: 15
[11:21:20.890] <TB3> INFO: triggerdelay: 0
[11:21:20.890] <TB3> QUIET: Instanciating API for pxar v2.6.0+26~g89693ff
[11:21:20.890] <TB3> INFO: Log level: INFO
[11:21:20.903] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:21:20.918] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:21:20.921] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:21:20.924] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[11:21:22.494] <TB3> INFO: DUT info:
[11:21:22.494] <TB3> INFO: The DUT currently contains the following objects:
[11:21:22.494] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[11:21:22.494] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:21:22.494] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:21:22.494] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:21:22.494] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.494] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:21:22.895] <TB3> INFO: enter 'restricted' command line mode
[11:21:22.895] <TB3> INFO: enter test to run
[11:21:22.895] <TB3> INFO: test: PixelAlive no parameter change
[11:21:22.895] <TB3> INFO: running: pixelalive
[11:21:22.905] <TB3> INFO: ######################################################################
[11:21:22.905] <TB3> INFO: PixTestAlive::doTest()
[11:21:22.905] <TB3> INFO: ######################################################################
[11:21:22.907] <TB3> INFO: ----------------------------------------------------------------------
[11:21:22.907] <TB3> 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:21:22.907] <TB3> INFO: ----------------------------------------------------------------------
[11:21:23.255] <TB3> INFO: Expecting 208000 events.
[11:21:34.067] <TB3> INFO: 208000 events read in total (10095ms).
[11:21:34.174] <TB3> INFO: Test took 11265ms.
[11:21:34.185] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:34.437] <TB3> INFO: PixTestAlive::aliveTest() done
[11:21:34.437] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:21:34.439] <TB3> INFO: ----------------------------------------------------------------------
[11:21:34.439] <TB3> 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:21:34.439] <TB3> INFO: ----------------------------------------------------------------------
[11:21:34.746] <TB3> INFO: Expecting 208000 events.
[11:21:41.335] <TB3> INFO: 208000 events read in total (5874ms).
[11:21:41.335] <TB3> INFO: Test took 6895ms.
[11:21:41.335] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:41.336] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[11:21:41.734] <TB3> INFO: PixTestAlive::maskTest() done
[11:21:41.734] <TB3> 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:21:41.736] <TB3> INFO: ----------------------------------------------------------------------
[11:21:41.736] <TB3> 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:21:41.736] <TB3> INFO: ----------------------------------------------------------------------
[11:21:42.066] <TB3> INFO: Expecting 208000 events.
[11:21:53.639] <TB3> INFO: 208000 events read in total (10858ms).
[11:21:53.639] <TB3> INFO: Test took 11901ms.
[11:21:53.654] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:21:53.985] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[11:21:53.985] <TB3> 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:21:53.986] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[11:21:54.026] <TB3> INFO: enter test to run
[11:21:54.026] <TB3> INFO: test: delay setting parameters: ->2<-
[11:21:54.026] <TB3> INFO: delay test by 2 seconds...
[11:21:56.026] <TB3> INFO: enter test to run
[11:21:56.026] <TB3> INFO: test: HighRate no parameter change
[11:21:56.026] <TB3> INFO: running: highrate
[11:21:56.027] <TB3> INFO: readGainPedestalParameters /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M4562_XrayQualification_2015-11-23_11h06m_1448273185//016_HREfficiency_250//phCalibrationFitErr35_C15.dat
[11:21:56.171] <TB3> INFO: ----------------------------------------------------------------------
[11:21:56.171] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:21:56.171] <TB3> INFO: ----------------------------------------------------------------------
[11:21:56.769] <TB3> INFO: Expecting 208000 events.
[11:22:17.113] <TB3> INFO: 208000 events read in total (19818ms).
[11:22:17.125] <TB3> INFO: Test took 20951ms.
[11:22:17.816] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:22:18.244] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 0 0 0 0 0 1 0 0 0 0 0 0
[11:22:18.244] <TB3> INFO: number of red-efficiency pixels: 643 856 669 1501 2005 2237 1885 2468 2446 2585 2541 2237 2252 985 893 860
[11:22:18.244] <TB3> INFO: number of X-ray hits detected: 249647 287531 245990 421403 452956 523284 498611 535494 567967 520549 572924 474533 462200 280098 307568 285080
[11:22:18.244] <TB3> 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:22:18.244] <TB3> INFO: number of Vcal hits detected: 207288 206861 207061 205929 204671 204010 204948 203797 203632 202644 203185 204000 204260 206438 206954 206991
[11:22:18.244] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.5 99.6 99.1 98.6 98.3 98.7 98.2 98.1 97.8 98.0 98.3 98.4 99.4 99.5 99.6
[11:22:18.244] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.5 99.5 99.0 98.4 98.1 98.5 98.0 97.9 97.4 97.7 98.1 98.2 99.2 99.5 99.5
[11:22:18.244] <TB3> INFO: X-ray hit rate [MHz/cm2]: 73.2 84.3 72.1 123.5 132.8 153.4 146.1 157.0 166.5 152.6 167.9 139.1 135.5 82.1 90.2 83.6
[11:22:18.244] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[11:22:18.270] <TB3> INFO: PixTest:: pg_setup set to default.
[11:22:18.281] <TB3> INFO: enter test to run
[11:22:18.281] <TB3> INFO: test: no parameter change
[11:22:18.347] <TB3> QUIET: Connection to board 121 closed.
[11:22:18.426] <TB3> INFO: pXar: this is the end, my friend