[15:14:14.668] <TB3> INFO: *** Welcome to pxar ***
[15:14:14.668] <TB3> INFO: *** Today: 2016/09/19
[15:14:14.739] <TB3> INFO: *** Version: f5d3-dirty
[15:14:14.739] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//000_PixelAlive_p17//dacParameters35_C15.dat
[15:14:14.740] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//000_PixelAlive_p17//tbmParameters_C0b.dat
[15:14:14.740] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//000_PixelAlive_p17//defaultMaskFile.dat
[15:14:14.740] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//000_PixelAlive_p17//trimParameters35_C15.dat
[15:14:14.810] <TB3> INFO: clk: 4
[15:14:14.810] <TB3> INFO: ctr: 4
[15:14:14.810] <TB3> INFO: sda: 19
[15:14:14.810] <TB3> INFO: tin: 9
[15:14:14.810] <TB3> INFO: level: 15
[15:14:14.810] <TB3> INFO: triggerdelay: 0
[15:14:14.810] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:14:14.810] <TB3> INFO: Log level: INFO
[15:14:14.824] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:14:14.833] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:14:14.835] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:14:14.837] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[15:14:16.398] <TB3> INFO: DUT info:
[15:14:16.398] <TB3> INFO: The DUT currently contains the following objects:
[15:14:16.398] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:14:16.398] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:14:16.398] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:14:16.398] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:14:16.398] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.398] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:16.799] <TB3> INFO: enter 'restricted' command line mode
[15:14:16.799] <TB3> INFO: enter test to run
[15:14:16.799] <TB3> INFO: test: PixelAlive no parameter change
[15:14:16.799] <TB3> INFO: running: pixelalive
[15:14:16.802] <TB3> INFO: ######################################################################
[15:14:16.802] <TB3> INFO: PixTestAlive::doTest()
[15:14:16.802] <TB3> INFO: ######################################################################
[15:14:16.804] <TB3> INFO: ----------------------------------------------------------------------
[15:14:16.804] <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)
[15:14:16.804] <TB3> INFO: ----------------------------------------------------------------------
[15:14:17.064] <TB3> INFO: Expecting 41600 events.
[15:14:20.782] <TB3> INFO: 41600 events read in total (3159ms).
[15:14:20.831] <TB3> INFO: Test took 4025ms.
[15:14:21.067] <TB3> INFO: PixTestAlive::aliveTest() done
[15:14:21.067] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 1 0 0 0 0
[15:14:21.068] <TB3> INFO: ----------------------------------------------------------------------
[15:14:21.068] <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)
[15:14:21.068] <TB3> INFO: ----------------------------------------------------------------------
[15:14:21.324] <TB3> INFO: Expecting 41600 events.
[15:14:24.266] <TB3> INFO: 41600 events read in total (2385ms).
[15:14:24.266] <TB3> INFO: Test took 3196ms.
[15:14:24.266] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:14:24.529] <TB3> INFO: PixTestAlive::maskTest() done
[15:14:24.529] <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
[15:14:24.531] <TB3> INFO: ----------------------------------------------------------------------
[15:14:24.531] <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)
[15:14:24.531] <TB3> INFO: ----------------------------------------------------------------------
[15:14:24.797] <TB3> INFO: Expecting 41600 events.
[15:14:28.527] <TB3> INFO: 41600 events read in total (3173ms).
[15:14:28.528] <TB3> INFO: Test took 3995ms.
[15:14:28.775] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[15:14:28.775] <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
[15:14:28.775] <TB3> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[15:14:28.806] <TB3> INFO: enter test to run
[15:14:28.806] <TB3> INFO: test: no parameter change
[15:14:29.041] <TB3> QUIET: Connection to board 121 closed.
[15:14:29.121] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[15:20:06.925] <TB3> INFO: *** Welcome to pxar ***
[15:20:06.925] <TB3> INFO: *** Today: 2016/09/19
[15:20:06.999] <TB3> INFO: *** Version: f5d3-dirty
[15:20:06.999] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:20:06.999] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:20:06.999] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:20:06.999] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:20:07.069] <TB3> INFO: clk: 4
[15:20:07.069] <TB3> INFO: ctr: 4
[15:20:07.069] <TB3> INFO: sda: 19
[15:20:07.069] <TB3> INFO: tin: 9
[15:20:07.069] <TB3> INFO: level: 15
[15:20:07.069] <TB3> INFO: triggerdelay: 0
[15:20:07.069] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:20:07.069] <TB3> INFO: Log level: INFO
[15:20:07.082] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:20:07.091] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:20:07.093] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:20:07.095] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[15:20:08.649] <TB3> INFO: DUT info:
[15:20:08.649] <TB3> INFO: The DUT currently contains the following objects:
[15:20:08.649] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:20:08.649] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:20:08.649] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:20:08.649] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:20:08.649] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:09.050] <TB3> INFO: enter 'restricted' command line mode
[15:20:09.050] <TB3> INFO: enter test to run
[15:20:09.050] <TB3> INFO: test: delay setting parameters: ->5<-
[15:20:09.050] <TB3> INFO: delay test by 5 seconds...
[15:20:14.050] <TB3> INFO: enter test to run
[15:20:14.050] <TB3> INFO: test: highrate no parameter change
[15:20:14.050] <TB3> INFO: running: highrate
[15:20:14.051] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:20:14.193] <TB3> INFO: ----------------------------------------------------------------------
[15:20:14.193] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:20:14.193] <TB3> INFO: ----------------------------------------------------------------------
[15:20:14.193] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:20:14.194] <TB3> INFO: edge/corner pixel THR is adjusted
[15:20:14.194] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:20:14.914] <TB3> INFO: Collecting data for 1 seconds...
[15:20:15.916] <TB3> INFO: Done with hot pixel readout
[15:20:21.830] <TB3> INFO: PixTest:: pg_setup set to default.
[15:20:21.830] <TB3> INFO: 7 hot pixels found in step 0
[15:20:22.554] <TB3> INFO: Collecting data for 1 seconds...
[15:20:23.555] <TB3> INFO: Done with hot pixel readout
[15:20:29.257] <TB3> INFO: PixTest:: pg_setup set to default.
[15:20:29.258] <TB3> INFO: 5 hot pixels found in step 1
[15:20:29.982] <TB3> INFO: Collecting data for 1 seconds...
[15:20:30.983] <TB3> INFO: Done with hot pixel readout
[15:20:36.706] <TB3> INFO: PixTest:: pg_setup set to default.
[15:20:36.707] <TB3> INFO: 3 hot pixels found in step 2
[15:20:37.430] <TB3> INFO: Collecting data for 1 seconds...
[15:20:38.431] <TB3> INFO: Done with hot pixel readout
[15:20:44.158] <TB3> INFO: PixTest:: pg_setup set to default.
[15:20:44.159] <TB3> INFO: 0 hot pixels found in step 3
[15:20:44.166] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:20:44.195] <TB3> INFO: PixTest::trimHotPixels() done
[15:20:44.195] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:20:44.201] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:20:44.208] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:20:44.214] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:20:44.220] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:20:44.226] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:20:44.232] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:20:44.238] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:20:44.244] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:20:44.250] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:20:44.256] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:20:44.262] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:20:44.269] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:20:44.275] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:20:44.281] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:20:44.287] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:20:44.293] <TB3> INFO: write masked pixels into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:20:44.326] <TB3> INFO: enter test to run
[15:20:44.326] <TB3> INFO: test: no parameter change
[15:20:44.525] <TB3> QUIET: Connection to board 121 closed.
[15:20:44.841] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[15:20:06.925] <TB3> INFO: *** Welcome to pxar ***
[15:20:06.925] <TB3> INFO: *** Today: 2016/09/19
[15:20:06.999] <TB3> INFO: *** Version: f5d3-dirty
[15:20:06.999] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:20:06.999] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:20:06.999] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:20:06.999] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:20:07.069] <TB3> INFO: clk: 4
[15:20:07.069] <TB3> INFO: ctr: 4
[15:20:07.069] <TB3> INFO: sda: 19
[15:20:07.069] <TB3> INFO: tin: 9
[15:20:07.069] <TB3> INFO: level: 15
[15:20:07.069] <TB3> INFO: triggerdelay: 0
[15:20:07.069] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:20:07.069] <TB3> INFO: Log level: INFO
[15:20:07.082] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:20:07.091] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:20:07.093] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:20:07.095] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[15:20:08.649] <TB3> INFO: DUT info:
[15:20:08.649] <TB3> INFO: The DUT currently contains the following objects:
[15:20:08.649] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:20:08.649] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:20:08.649] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:20:08.649] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:20:08.649] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:08.649] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:20:09.050] <TB3> INFO: enter 'restricted' command line mode
[15:20:09.050] <TB3> INFO: enter test to run
[15:20:09.050] <TB3> INFO: test: delay setting parameters: ->5<-
[15:20:09.050] <TB3> INFO: delay test by 5 seconds...
[15:20:14.050] <TB3> INFO: enter test to run
[15:20:14.050] <TB3> INFO: test: highrate no parameter change
[15:20:14.050] <TB3> INFO: running: highrate
[15:20:14.051] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:20:14.193] <TB3> INFO: ----------------------------------------------------------------------
[15:20:14.193] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:20:14.193] <TB3> INFO: ----------------------------------------------------------------------
[15:20:14.193] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:20:14.194] <TB3> INFO: edge/corner pixel THR is adjusted
[15:20:14.194] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:20:14.914] <TB3> INFO: Collecting data for 1 seconds...
[15:20:15.916] <TB3> INFO: Done with hot pixel readout
[15:20:21.830] <TB3> INFO: PixTest:: pg_setup set to default.
[15:20:21.830] <TB3> INFO: 7 hot pixels found in step 0
[15:20:22.554] <TB3> INFO: Collecting data for 1 seconds...
[15:20:23.555] <TB3> INFO: Done with hot pixel readout
[15:20:29.257] <TB3> INFO: PixTest:: pg_setup set to default.
[15:20:29.258] <TB3> INFO: 5 hot pixels found in step 1
[15:20:29.982] <TB3> INFO: Collecting data for 1 seconds...
[15:20:30.983] <TB3> INFO: Done with hot pixel readout
[15:20:36.706] <TB3> INFO: PixTest:: pg_setup set to default.
[15:20:36.707] <TB3> INFO: 3 hot pixels found in step 2
[15:20:37.430] <TB3> INFO: Collecting data for 1 seconds...
[15:20:38.431] <TB3> INFO: Done with hot pixel readout
[15:20:44.158] <TB3> INFO: PixTest:: pg_setup set to default.
[15:20:44.159] <TB3> INFO: 0 hot pixels found in step 3
[15:20:44.166] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:20:44.195] <TB3> INFO: PixTest::trimHotPixels() done
[15:20:44.195] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:20:44.201] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:20:44.208] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:20:44.214] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:20:44.220] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:20:44.226] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:20:44.232] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:20:44.238] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:20:44.244] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:20:44.250] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:20:44.256] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:20:44.262] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:20:44.269] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:20:44.275] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:20:44.281] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:20:44.287] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:20:44.293] <TB3> INFO: write masked pixels into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:20:44.326] <TB3> INFO: enter test to run
[15:20:44.326] <TB3> INFO: test: no parameter change
[15:20:44.525] <TB3> QUIET: Connection to board 121 closed.
[15:20:44.841] <TB3> INFO: pXar: this is the end, my friend
[15:21:32.144] <TB3> INFO: *** Welcome to pxar ***
[15:21:32.144] <TB3> INFO: *** Today: 2016/09/19
[15:21:32.217] <TB3> INFO: *** Version: f5d3-dirty
[15:21:32.217] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//dacParameters35_C15.dat
[15:21:32.217] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//tbmParameters_C0b.dat
[15:21:32.217] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//defaultMaskFile.dat
[15:21:32.217] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C15.dat
[15:21:32.288] <TB3> INFO: clk: 4
[15:21:32.288] <TB3> INFO: ctr: 4
[15:21:32.288] <TB3> INFO: sda: 19
[15:21:32.288] <TB3> INFO: tin: 9
[15:21:32.288] <TB3> INFO: level: 15
[15:21:32.288] <TB3> INFO: triggerdelay: 0
[15:21:32.288] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:21:32.288] <TB3> INFO: Log level: INFO
[15:21:32.301] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:21:32.310] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:21:32.312] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:21:32.314] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[15:21:33.855] <TB3> INFO: DUT info:
[15:21:33.855] <TB3> INFO: The DUT currently contains the following objects:
[15:21:33.855] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:21:33.855] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:21:33.855] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:21:33.855] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:21:33.855] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:33.855] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:34.256] <TB3> INFO: enter 'restricted' command line mode
[15:21:34.256] <TB3> INFO: enter test to run
[15:21:34.256] <TB3> INFO: test: delay setting parameters: ->5<-
[15:21:34.256] <TB3> INFO: delay test by 5 seconds...
[15:21:39.256] <TB3> INFO: enter test to run
[15:21:39.256] <TB3> INFO: test: highrate no parameter change
[15:21:39.256] <TB3> INFO: running: highrate
[15:21:39.256] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//phCalibrationFitErr35_C15.dat
[15:21:39.389] <TB3> INFO: ----------------------------------------------------------------------
[15:21:39.389] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:21:39.389] <TB3> INFO: ----------------------------------------------------------------------
[15:21:39.389] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:21:39.389] <TB3> INFO: edge/corner pixel THR is adjusted
[15:21:39.389] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:21:40.110] <TB3> INFO: Collecting data for 1 seconds...
[15:21:41.111] <TB3> INFO: Done with hot pixel readout
[15:21:44.711] <TB3> INFO: PixTest:: pg_setup set to default.
[15:21:44.712] <TB3> INFO: 0 hot pixels found in step 0
[15:21:44.715] <TB3> INFO: In total 0 additional hot pixels could not be trimmed and have been masked.
[15:21:44.744] <TB3> INFO: PixTest::trimHotPixels() done
[15:21:44.744] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C0.dat
[15:21:44.750] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C1.dat
[15:21:44.756] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C2.dat
[15:21:44.762] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C3.dat
[15:21:44.768] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C4.dat
[15:21:44.774] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C5.dat
[15:21:44.780] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C6.dat
[15:21:44.786] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C7.dat
[15:21:44.791] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C8.dat
[15:21:44.797] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C9.dat
[15:21:44.803] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C10.dat
[15:21:44.809] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C11.dat
[15:21:44.815] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C12.dat
[15:21:44.820] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C13.dat
[15:21:44.826] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C14.dat
[15:21:44.832] <TB3> INFO: write trim parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//trimParameters35_C15.dat
[15:21:44.838] <TB3> INFO: write masked pixels into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//003_RetrimHotPixels_50//defaultMaskFile.dat
[15:21:44.867] <TB3> INFO: enter test to run
[15:21:44.867] <TB3> INFO: test: no parameter change
[15:21:45.092] <TB3> QUIET: Connection to board 121 closed.
[15:21:45.172] <TB3> INFO: pXar: this is the end, my friend
[15:22:36.861] <TB3> INFO: *** Welcome to pxar ***
[15:22:36.861] <TB3> INFO: *** Today: 2016/09/19
[15:22:36.927] <TB3> INFO: *** Version: f5d3-dirty
[15:22:36.927] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//dacParameters35_C15.dat
[15:22:36.927] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//tbmParameters_C0b.dat
[15:22:36.927] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//defaultMaskFile.dat
[15:22:36.927] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//trimParameters35_C15.dat
[15:22:36.997] <TB3> INFO: clk: 4
[15:22:36.997] <TB3> INFO: ctr: 4
[15:22:36.997] <TB3> INFO: sda: 19
[15:22:36.997] <TB3> INFO: tin: 9
[15:22:36.997] <TB3> INFO: level: 15
[15:22:36.997] <TB3> INFO: triggerdelay: 0
[15:22:36.997] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:22:36.997] <TB3> INFO: Log level: INFO
[15:22:37.010] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:22:37.019] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:22:37.021] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:22:37.023] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[15:22:38.584] <TB3> INFO: DUT info:
[15:22:38.584] <TB3> INFO: The DUT currently contains the following objects:
[15:22:38.584] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:22:38.584] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:22:38.584] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:22:38.584] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:22:38.584] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.584] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.585] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.585] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.585] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.585] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.585] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.585] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:22:38.985] <TB3> INFO: enter 'restricted' command line mode
[15:22:38.985] <TB3> INFO: enter test to run
[15:22:38.985] <TB3> INFO: test: delay setting parameters: ->5<-
[15:22:38.985] <TB3> INFO: delay test by 5 seconds...
[15:22:43.985] <TB3> INFO: enter test to run
[15:22:43.985] <TB3> INFO: test: Xray no parameter change
[15:22:43.985] <TB3> INFO: running: xray
[15:22:43.986] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//004_HRData_50//phCalibrationFitErr35_C15.dat
[15:22:44.167] <TB3> INFO: ######################################################################
[15:22:44.167] <TB3> INFO: PixTestXray::doTest()
[15:22:44.167] <TB3> INFO: ######################################################################
[15:22:44.167] <TB3> INFO: ----------------------------------------------------------------------
[15:22:44.167] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:22:44.167] <TB3> INFO: ----------------------------------------------------------------------
[15:22:44.895] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:22:52.301] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[15:23:21.000] <TB3> INFO: Resuming triggers.
[15:23:28.415] <TB3> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[15:23:57.128] <TB3> INFO: Resuming triggers.
[15:24:04.542] <TB3> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[15:24:33.144] <TB3> INFO: Resuming triggers.
[15:24:40.558] <TB3> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[15:25:09.704] <TB3> INFO: Resuming triggers.
[15:25:17.120] <TB3> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[15:25:45.581] <TB3> INFO: Resuming triggers.
[15:25:52.996] <TB3> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[15:26:21.417] <TB3> INFO: Resuming triggers.
[15:26:28.829] <TB3> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[15:26:58.041] <TB3> INFO: Resuming triggers.
[15:27:05.454] <TB3> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[15:27:33.753] <TB3> INFO: Resuming triggers.
[15:27:41.167] <TB3> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[15:28:09.756] <TB3> INFO: Resuming triggers.
[15:28:17.170] <TB3> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[15:28:46.154] <TB3> INFO: Resuming triggers.
[15:28:53.565] <TB3> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[15:29:22.172] <TB3> INFO: Resuming triggers.
[15:29:29.580] <TB3> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[15:29:58.358] <TB3> INFO: Resuming triggers.
[15:30:05.765] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[15:30:34.630] <TB3> INFO: Resuming triggers.
[15:30:38.326] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[15:30:52.040] <TB3> INFO: PixTest:: pg_setup set to default.
[15:30:52.041] <TB3> INFO: PixTestXray::doPhRun() done
[15:30:52.041] <TB3> INFO: PixTestXray::doTest() done
[15:30:52.215] <TB3> INFO: enter test to run
[15:30:52.215] <TB3> INFO: test: no parameter change
[15:30:52.470] <TB3> QUIET: Connection to board 121 closed.
[15:30:52.551] <TB3> INFO: pXar: this is the end, my friend
[15:32:21.117] <TB3> INFO: *** Welcome to pxar ***
[15:32:21.117] <TB3> INFO: *** Today: 2016/09/19
[15:32:21.225] <TB3> INFO: *** Version: f5d3-dirty
[15:32:21.225] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//dacParameters35_C15.dat
[15:32:21.225] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//tbmParameters_C0b.dat
[15:32:21.225] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//defaultMaskFile.dat
[15:32:21.225] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//trimParameters35_C15.dat
[15:32:21.298] <TB3> INFO: clk: 4
[15:32:21.298] <TB3> INFO: ctr: 4
[15:32:21.298] <TB3> INFO: sda: 19
[15:32:21.298] <TB3> INFO: tin: 9
[15:32:21.298] <TB3> INFO: level: 15
[15:32:21.298] <TB3> INFO: triggerdelay: 0
[15:32:21.298] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:32:21.298] <TB3> INFO: Log level: INFO
[15:32:21.312] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:32:21.320] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:32:21.322] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:32:21.325] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[15:32:22.870] <TB3> INFO: DUT info:
[15:32:22.870] <TB3> INFO: The DUT currently contains the following objects:
[15:32:22.870] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:32:22.871] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:32:22.871] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:32:22.871] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:32:22.871] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:22.871] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:32:23.271] <TB3> INFO: enter 'restricted' command line mode
[15:32:23.272] <TB3> INFO: enter test to run
[15:32:23.272] <TB3> INFO: test: delay setting parameters: ->5<-
[15:32:23.272] <TB3> INFO: delay test by 5 seconds...
[15:32:28.272] <TB3> INFO: enter test to run
[15:32:28.272] <TB3> INFO: test: Xray no parameter change
[15:32:28.272] <TB3> INFO: running: xray
[15:32:28.272] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//005_HRData_150//phCalibrationFitErr35_C15.dat
[15:32:28.442] <TB3> INFO: ######################################################################
[15:32:28.442] <TB3> INFO: PixTestXray::doTest()
[15:32:28.442] <TB3> INFO: ######################################################################
[15:32:28.442] <TB3> INFO: ----------------------------------------------------------------------
[15:32:28.442] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:32:28.442] <TB3> INFO: ----------------------------------------------------------------------
[15:32:29.171] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:32:33.431] <TB3> INFO: run duration 4 seconds, buffer almost full (81%), pausing triggers.
[15:33:03.341] <TB3> INFO: Resuming triggers.
[15:33:07.611] <TB3> INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[15:33:37.770] <TB3> INFO: Resuming triggers.
[15:33:42.040] <TB3> INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[15:34:12.284] <TB3> INFO: Resuming triggers.
[15:34:16.555] <TB3> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[15:34:46.672] <TB3> INFO: Resuming triggers.
[15:34:50.942] <TB3> INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[15:35:21.642] <TB3> INFO: Resuming triggers.
[15:35:25.913] <TB3> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[15:35:57.407] <TB3> INFO: Resuming triggers.
[15:36:01.676] <TB3> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[15:36:32.596] <TB3> INFO: Resuming triggers.
[15:36:36.863] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[15:37:07.679] <TB3> INFO: Resuming triggers.
[15:37:11.946] <TB3> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[15:37:42.430] <TB3> INFO: Resuming triggers.
[15:37:46.696] <TB3> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[15:38:18.047] <TB3> INFO: Resuming triggers.
[15:38:22.314] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[15:38:52.388] <TB3> INFO: Resuming triggers.
[15:38:56.652] <TB3> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[15:39:27.669] <TB3> INFO: Resuming triggers.
[15:39:31.936] <TB3> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[15:40:03.292] <TB3> INFO: Resuming triggers.
[15:40:07.556] <TB3> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[15:40:38.357] <TB3> INFO: Resuming triggers.
[15:40:42.623] <TB3> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[15:41:13.583] <TB3> INFO: Resuming triggers.
[15:41:17.848] <TB3> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[15:41:47.839] <TB3> INFO: Resuming triggers.
[15:41:52.103] <TB3> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[15:42:22.206] <TB3> INFO: Resuming triggers.
[15:42:26.470] <TB3> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[15:42:55.840] <TB3> INFO: Resuming triggers.
[15:43:00.103] <TB3> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[15:43:29.923] <TB3> INFO: Resuming triggers.
[15:43:34.194] <TB3> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[15:44:04.391] <TB3> INFO: Resuming triggers.
[15:44:08.654] <TB3> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[15:44:38.489] <TB3> INFO: Resuming triggers.
[15:44:42.753] <TB3> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[15:45:12.552] <TB3> INFO: Resuming triggers.
[15:45:16.813] <TB3> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[15:45:46.784] <TB3> INFO: Resuming triggers.
[15:45:48.715] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[15:46:02.127] <TB3> INFO: PixTest:: pg_setup set to default.
[15:46:02.129] <TB3> INFO: PixTestXray::doPhRun() done
[15:46:02.129] <TB3> INFO: PixTestXray::doTest() done
[15:46:02.312] <TB3> INFO: enter test to run
[15:46:02.312] <TB3> INFO: test: no parameter change
[15:46:02.582] <TB3> QUIET: Connection to board 121 closed.
[15:46:02.674] <TB3> INFO: pXar: this is the end, my friend
[15:49:12.308] <TB3> INFO: *** Welcome to pxar ***
[15:49:12.308] <TB3> INFO: *** Today: 2016/09/19
[15:49:12.377] <TB3> INFO: *** Version: f5d3-dirty
[15:49:12.377] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//dacParameters35_C15.dat
[15:49:12.378] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//tbmParameters_C0b.dat
[15:49:12.378] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//defaultMaskFile.dat
[15:49:12.378] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//trimParameters35_C15.dat
[15:49:12.457] <TB3> INFO: clk: 4
[15:49:12.457] <TB3> INFO: ctr: 4
[15:49:12.457] <TB3> INFO: sda: 19
[15:49:12.457] <TB3> INFO: tin: 9
[15:49:12.457] <TB3> INFO: level: 15
[15:49:12.457] <TB3> INFO: triggerdelay: 0
[15:49:12.457] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[15:49:12.457] <TB3> INFO: Log level: INFO
[15:49:12.470] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:49:12.479] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:49:12.481] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:49:12.483] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[15:49:14.050] <TB3> INFO: DUT info:
[15:49:14.050] <TB3> INFO: The DUT currently contains the following objects:
[15:49:14.050] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:49:14.050] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:49:14.050] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:49:14.050] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:49:14.050] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.050] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:49:14.451] <TB3> INFO: enter 'restricted' command line mode
[15:49:14.451] <TB3> INFO: enter test to run
[15:49:14.451] <TB3> INFO: test: Highrate no parameter change
[15:49:14.451] <TB3> INFO: running: highrate
[15:49:14.451] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//006_HRSCurves_100//phCalibrationFitErr35_C15.dat
[15:49:14.607] <TB3> INFO: ----------------------------------------------------------------------
[15:49:14.607] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[15:49:14.608] <TB3> INFO: ----------------------------------------------------------------------
[15:49:14.614] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[15:49:14.625] <TB3> INFO: dacScan step from 15 .. 34
[15:49:14.625] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[15:49:14.625] <TB3> INFO: run 1 of 1
[15:49:15.126] <TB3> INFO: Expecting 4160000 events.
[15:49:48.873] <TB3> INFO: 527100 events read in total (33342ms).
[15:50:22.365] <TB3> INFO: 1056050 events read in total (66834ms).
[15:50:56.135] <TB3> INFO: 1584850 events read in total (100604ms).
[15:51:29.603] <TB3> INFO: 2114050 events read in total (134072ms).
[15:52:03.131] <TB3> INFO: 2642550 events read in total (167600ms).
[15:52:36.749] <TB3> INFO: 3170400 events read in total (201218ms).
[15:53:10.673] <TB3> INFO: 3698250 events read in total (235142ms).
[15:53:40.456] <TB3> INFO: 4160000 events read in total (264925ms).
[15:53:40.640] <TB3> INFO: Test took 266015ms.
[15:53:46.116] <TB3> INFO: dacScan step from 35 .. 54
[15:53:46.116] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[15:53:46.116] <TB3> INFO: run 1 of 1
[15:53:46.605] <TB3> INFO: Expecting 4160000 events.
[15:54:18.687] <TB3> INFO: 417950 events read in total (31679ms).
[15:54:50.359] <TB3> INFO: 836600 events read in total (63351ms).
[15:55:22.137] <TB3> INFO: 1254600 events read in total (95129ms).
[15:55:53.443] <TB3> INFO: 1671300 events read in total (126435ms).
[15:56:25.443] <TB3> INFO: 2086750 events read in total (158435ms).
[15:56:56.892] <TB3> INFO: 2500000 events read in total (189884ms).
[15:57:28.335] <TB3> INFO: 2910150 events read in total (221327ms).
[15:57:59.508] <TB3> INFO: 3317350 events read in total (252501ms).
[15:58:30.706] <TB3> INFO: 3722550 events read in total (283698ms).
[15:59:01.840] <TB3> INFO: 4127600 events read in total (314832ms).
[15:59:04.475] <TB3> INFO: 4160000 events read in total (317467ms).
[15:59:04.603] <TB3> INFO: Test took 318486ms.
[15:59:10.555] <TB3> INFO: dacScan step from 55 .. 74
[15:59:10.555] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[15:59:10.555] <TB3> INFO: run 1 of 1
[15:59:11.041] <TB3> INFO: Expecting 4160000 events.
[15:59:42.268] <TB3> INFO: 376200 events read in total (30825ms).
[16:00:13.100] <TB3> INFO: 753150 events read in total (61657ms).
[16:00:44.183] <TB3> INFO: 1130100 events read in total (92740ms).
[16:01:15.663] <TB3> INFO: 1507450 events read in total (124220ms).
[16:01:46.555] <TB3> INFO: 1884600 events read in total (155112ms).
[16:02:17.365] <TB3> INFO: 2261800 events read in total (185922ms).
[16:02:48.565] <TB3> INFO: 2638700 events read in total (217122ms).
[16:03:19.365] <TB3> INFO: 3015500 events read in total (247922ms).
[16:03:50.443] <TB3> INFO: 3392400 events read in total (279000ms).
[16:04:21.224] <TB3> INFO: 3769300 events read in total (309781ms).
[16:04:52.274] <TB3> INFO: 4145900 events read in total (340831ms).
[16:04:53.634] <TB3> INFO: 4160000 events read in total (342191ms).
[16:04:53.752] <TB3> INFO: Test took 343196ms.
[16:04:59.583] <TB3> INFO: dacScan step from 75 .. 75
[16:04:59.584] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[16:04:59.584] <TB3> INFO: run 1 of 1
[16:05:00.086] <TB3> INFO: Expecting 208000 events.
[16:05:18.031] <TB3> INFO: 208000 events read in total (17543ms).
[16:05:18.037] <TB3> INFO: Test took 18453ms.
[16:05:18.337] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:19.495] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:20.552] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:21.630] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:22.730] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:23.909] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:25.032] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:26.291] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:27.532] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:28.739] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:29.982] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:31.243] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:32.459] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:33.728] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:34.862] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:35.903] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:05:36.993] <TB3> INFO: PixTest:: pg_setup set to default.
[16:05:36.996] <TB3> INFO: vcal mean: 37.61 38.06 37.05 39.11 38.96 40.99 39.98 39.95 40.52 41.47 40.13 41.22 39.92 38.07 38.72 38.01
[16:05:36.996] <TB3> INFO: vcal RMS: 0.96 0.98 0.83 1.25 1.26 1.35 1.19 1.24 1.28 1.24 1.20 1.44 1.03 0.99 0.99 0.97
[16:05:36.996] <TB3> INFO: number of X-ray hits detected: 140388 148726 123293 210626 225370 305737 254846 263458 295708 304997 286269 288259 234478 150922 174220 162824
[16:05:36.996] <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
[16:05:36.996] <TB3> INFO: X-ray hit rate [MHz/cm2]: 41.1 43.6 36.1 61.7 66.1 89.6 74.7 77.2 86.7 89.4 83.9 84.5 68.7 44.2 51.1 47.7
[16:05:36.996] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[16:05:37.107] <TB3> INFO: enter test to run
[16:05:37.107] <TB3> INFO: test: no parameter change
[16:05:37.370] <TB3> QUIET: Connection to board 121 closed.
[16:05:37.477] <TB3> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[16:28:40.451] <TB3> INFO: *** Welcome to pxar ***
[16:28:40.451] <TB3> INFO: *** Today: 2016/09/19
[16:28:40.516] <TB3> INFO: *** Version: f5d3-dirty
[16:28:40.516] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:28:40.516] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[16:28:40.516] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[16:28:40.517] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[16:28:40.610] <TB3> INFO: clk: 4
[16:28:40.610] <TB3> INFO: ctr: 4
[16:28:40.610] <TB3> INFO: sda: 19
[16:28:40.610] <TB3> INFO: tin: 9
[16:28:40.610] <TB3> INFO: level: 15
[16:28:40.610] <TB3> INFO: triggerdelay: 0
[16:28:40.610] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:28:40.610] <TB3> INFO: Log level: INFO
[16:28:40.624] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:28:40.632] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:28:40.634] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:28:40.636] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:28:42.177] <TB3> INFO: DUT info:
[16:28:42.177] <TB3> INFO: The DUT currently contains the following objects:
[16:28:42.178] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:28:42.178] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:28:42.178] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:28:42.178] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:28:42.178] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.178] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:28:42.579] <TB3> INFO: enter 'restricted' command line mode
[16:28:42.579] <TB3> INFO: enter test to run
[16:28:42.579] <TB3> INFO: test: HighRate no parameter change
[16:28:42.579] <TB3> INFO: running: highrate
[16:28:42.579] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[16:28:42.716] <TB3> INFO: ----------------------------------------------------------------------
[16:28:42.716] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[16:28:42.716] <TB3> INFO: ----------------------------------------------------------------------
[16:28:42.815] <TB3> INFO: Expecting 768 events.
[16:28:43.807] <TB3> INFO: 768 events read in total (433ms).
[16:28:43.870] <TB3> INFO: Test took 1149ms.
[16:28:44.386] <TB3> INFO: Expecting 41600 events.
[16:28:47.837] <TB3> INFO: 41600 events read in total (3048ms).
[16:28:47.839] <TB3> INFO: Test took 3963ms.
[16:28:48.406] <TB3> INFO: Expecting 41600 events.
[16:28:51.977] <TB3> INFO: 41600 events read in total (3169ms).
[16:28:51.979] <TB3> INFO: Test took 4059ms.
[16:28:52.571] <TB3> INFO: Expecting 41600 events.
[16:28:56.183] <TB3> INFO: 41600 events read in total (3209ms).
[16:28:56.185] <TB3> INFO: Test took 4117ms.
[16:28:56.772] <TB3> INFO: Expecting 41600 events.
[16:29:00.297] <TB3> INFO: 41600 events read in total (3122ms).
[16:29:00.299] <TB3> INFO: Test took 4031ms.
[16:29:00.911] <TB3> INFO: Expecting 41600 events.
[16:29:04.491] <TB3> INFO: 41600 events read in total (3178ms).
[16:29:04.493] <TB3> INFO: Test took 4094ms.
[16:29:05.070] <TB3> INFO: Expecting 41600 events.
[16:29:08.643] <TB3> INFO: 41600 events read in total (3171ms).
[16:29:08.646] <TB3> INFO: Test took 4068ms.
[16:29:09.215] <TB3> INFO: Expecting 41600 events.
[16:29:12.726] <TB3> INFO: 41600 events read in total (3109ms).
[16:29:12.728] <TB3> INFO: Test took 3998ms.
[16:29:13.312] <TB3> INFO: Expecting 41600 events.
[16:29:16.894] <TB3> INFO: 41600 events read in total (3179ms).
[16:29:16.895] <TB3> INFO: Test took 4085ms.
[16:29:17.479] <TB3> INFO: Expecting 41600 events.
[16:29:20.989] <TB3> INFO: 41600 events read in total (3107ms).
[16:29:20.991] <TB3> INFO: Test took 4010ms.
[16:29:21.554] <TB3> INFO: Expecting 41600 events.
[16:29:25.125] <TB3> INFO: 41600 events read in total (3168ms).
[16:29:25.126] <TB3> INFO: Test took 4054ms.
[16:29:25.691] <TB3> INFO: Expecting 41600 events.
[16:29:29.227] <TB3> INFO: 41600 events read in total (3134ms).
[16:29:29.228] <TB3> INFO: Test took 4020ms.
[16:29:29.830] <TB3> INFO: Expecting 41600 events.
[16:29:33.472] <TB3> INFO: 41600 events read in total (3239ms).
[16:29:33.473] <TB3> INFO: Test took 4151ms.
[16:29:34.035] <TB3> INFO: Expecting 41600 events.
[16:29:37.629] <TB3> INFO: 41600 events read in total (3191ms).
[16:29:37.631] <TB3> INFO: Test took 4077ms.
[16:29:38.209] <TB3> INFO: Expecting 41600 events.
[16:29:41.835] <TB3> INFO: 41600 events read in total (3224ms).
[16:29:41.837] <TB3> INFO: Test took 4118ms.
[16:29:42.402] <TB3> INFO: Expecting 41600 events.
[16:29:46.095] <TB3> INFO: 41600 events read in total (3290ms).
[16:29:46.096] <TB3> INFO: Test took 4177ms.
[16:29:46.669] <TB3> INFO: Expecting 41600 events.
[16:29:50.298] <TB3> INFO: 41600 events read in total (3227ms).
[16:29:50.300] <TB3> INFO: Test took 4120ms.
[16:29:50.872] <TB3> INFO: Expecting 41600 events.
[16:29:54.535] <TB3> INFO: 41600 events read in total (3260ms).
[16:29:54.537] <TB3> INFO: Test took 4155ms.
[16:29:55.117] <TB3> INFO: Expecting 41600 events.
[16:29:58.613] <TB3> INFO: 41600 events read in total (3093ms).
[16:29:58.615] <TB3> INFO: Test took 3993ms.
[16:29:59.177] <TB3> INFO: Expecting 41600 events.
[16:30:02.694] <TB3> INFO: 41600 events read in total (3115ms).
[16:30:02.696] <TB3> INFO: Test took 3999ms.
[16:30:03.255] <TB3> INFO: Expecting 41600 events.
[16:30:06.518] <TB3> INFO: 41600 events read in total (2861ms).
[16:30:06.520] <TB3> INFO: Test took 3744ms.
[16:30:06.855] <TB3> INFO: enter test to run
[16:30:06.855] <TB3> INFO: test: Pretest no parameter change
[16:30:06.855] <TB3> INFO: running: pretest
[16:30:06.855] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[16:30:06.856] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[16:30:06.857] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[16:30:06.857] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[16:30:06.857] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[16:30:06.857] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[16:30:06.857] <TB3> INFO: write dac parameters into /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//011_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:30:06.857] <TB3> INFO: enter test to run
[16:30:06.857] <TB3> INFO: test: no parameter change
[16:30:07.191] <TB3> QUIET: Connection to board 121 closed.
[16:30:07.272] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:30:57.663] <TB3> INFO: *** Welcome to pxar ***
[16:30:57.663] <TB3> INFO: *** Today: 2016/09/19
[16:30:57.729] <TB3> INFO: *** Version: f5d3-dirty
[16:30:57.729] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//dacParameters35_C15.dat
[16:30:57.730] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//tbmParameters_C0b.dat
[16:30:57.730] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//defaultMaskFile.dat
[16:30:57.730] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//trimParameters35_C15.dat
[16:30:57.801] <TB3> INFO: clk: 4
[16:30:57.801] <TB3> INFO: ctr: 4
[16:30:57.801] <TB3> INFO: sda: 19
[16:30:57.801] <TB3> INFO: tin: 9
[16:30:57.801] <TB3> INFO: level: 15
[16:30:57.801] <TB3> INFO: triggerdelay: 0
[16:30:57.801] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:30:57.801] <TB3> INFO: Log level: INFO
[16:30:57.815] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:30:57.824] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:30:57.826] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:30:57.828] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:30:59.391] <TB3> INFO: DUT info:
[16:30:59.391] <TB3> INFO: The DUT currently contains the following objects:
[16:30:59.391] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:30:59.391] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:30:59.391] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:30:59.391] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:30:59.391] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.391] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:30:59.792] <TB3> INFO: enter 'restricted' command line mode
[16:30:59.792] <TB3> INFO: enter test to run
[16:30:59.792] <TB3> INFO: test: PixelAlive no parameter change
[16:30:59.792] <TB3> INFO: running: pixelalive
[16:30:59.798] <TB3> INFO: ######################################################################
[16:30:59.798] <TB3> INFO: PixTestAlive::doTest()
[16:30:59.798] <TB3> INFO: ######################################################################
[16:30:59.800] <TB3> INFO: ----------------------------------------------------------------------
[16:30:59.800] <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)
[16:30:59.800] <TB3> INFO: ----------------------------------------------------------------------
[16:31:00.069] <TB3> INFO: Expecting 208000 events.
[16:31:11.336] <TB3> INFO: 208000 events read in total (10708ms).
[16:31:11.338] <TB3> INFO: Test took 11536ms.
[16:31:11.586] <TB3> INFO: PixTestAlive::aliveTest() done
[16:31:11.586] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:31:11.587] <TB3> INFO: ----------------------------------------------------------------------
[16:31:11.587] <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)
[16:31:11.587] <TB3> INFO: ----------------------------------------------------------------------
[16:31:11.850] <TB3> INFO: Expecting 208000 events.
[16:31:19.307] <TB3> INFO: 208000 events read in total (6900ms).
[16:31:19.308] <TB3> INFO: Test took 7719ms.
[16:31:19.308] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:31:19.566] <TB3> INFO: PixTestAlive::maskTest() done
[16:31:19.566] <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
[16:31:19.567] <TB3> INFO: ----------------------------------------------------------------------
[16:31:19.567] <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)
[16:31:19.568] <TB3> INFO: ----------------------------------------------------------------------
[16:31:19.833] <TB3> INFO: Expecting 208000 events.
[16:31:31.103] <TB3> INFO: 208000 events read in total (10713ms).
[16:31:31.104] <TB3> INFO: Test took 11534ms.
[16:31:31.319] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[16:31:31.319] <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
[16:31:31.319] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:31:31.351] <TB3> INFO: enter test to run
[16:31:31.351] <TB3> INFO: test: delay setting parameters: ->2<-
[16:31:31.351] <TB3> INFO: delay test by 2 seconds...
[16:31:33.351] <TB3> INFO: enter test to run
[16:31:33.351] <TB3> INFO: test: HighRate no parameter change
[16:31:33.352] <TB3> INFO: running: highrate
[16:31:33.352] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//012_HREfficiency_50//phCalibrationFitErr35_C15.dat
[16:31:33.499] <TB3> INFO: ----------------------------------------------------------------------
[16:31:33.499] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:31:33.499] <TB3> INFO: ----------------------------------------------------------------------
[16:31:33.984] <TB3> INFO: Expecting 208000 events.
[16:31:47.814] <TB3> INFO: 208000 events read in total (13428ms).
[16:31:47.819] <TB3> INFO: Test took 14316ms.
[16:31:48.240] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:31:48.240] <TB3> INFO: number of red-efficiency pixels: 70 88 78 125 138 235 166 171 222 206 180 212 141 91 98 110
[16:31:48.240] <TB3> INFO: number of X-ray hits detected: 67104 72612 58513 102288 108935 151435 124248 128119 144688 150403 140928 141520 113855 72931 85092 80182
[16:31:48.240] <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
[16:31:48.240] <TB3> INFO: number of Vcal hits detected: 207929 207910 207919 207871 207808 207755 207832 207824 207721 207791 207811 207776 207857 207904 207902 207889
[16:31:48.240] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[16:31:48.240] <TB3> INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0 99.9
[16:31:48.240] <TB3> INFO: X-ray hit rate [MHz/cm2]: 19.7 21.3 17.2 30.0 31.9 44.4 36.4 37.6 42.4 44.1 41.3 41.5 33.4 21.4 24.9 23.5
[16:31:48.240] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:31:48.284] <TB3> INFO: PixTest:: pg_setup set to default.
[16:31:48.293] <TB3> INFO: enter test to run
[16:31:48.293] <TB3> INFO: test: no parameter change
[16:31:48.559] <TB3> QUIET: Connection to board 121 closed.
[16:31:48.639] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:32:35.464] <TB3> INFO: *** Welcome to pxar ***
[16:32:35.464] <TB3> INFO: *** Today: 2016/09/19
[16:32:35.530] <TB3> INFO: *** Version: f5d3-dirty
[16:32:35.530] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//dacParameters35_C15.dat
[16:32:35.531] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//tbmParameters_C0b.dat
[16:32:35.531] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//defaultMaskFile.dat
[16:32:35.531] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//trimParameters35_C15.dat
[16:32:35.620] <TB3> INFO: clk: 4
[16:32:35.620] <TB3> INFO: ctr: 4
[16:32:35.620] <TB3> INFO: sda: 19
[16:32:35.620] <TB3> INFO: tin: 9
[16:32:35.620] <TB3> INFO: level: 15
[16:32:35.620] <TB3> INFO: triggerdelay: 0
[16:32:35.620] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:32:35.620] <TB3> INFO: Log level: INFO
[16:32:35.633] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:32:35.642] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:32:35.644] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:32:35.646] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:32:37.211] <TB3> INFO: DUT info:
[16:32:37.211] <TB3> INFO: The DUT currently contains the following objects:
[16:32:37.211] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:32:37.211] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:32:37.211] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:32:37.211] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:32:37.211] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.211] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:32:37.612] <TB3> INFO: enter 'restricted' command line mode
[16:32:37.612] <TB3> INFO: enter test to run
[16:32:37.612] <TB3> INFO: test: PixelAlive no parameter change
[16:32:37.612] <TB3> INFO: running: pixelalive
[16:32:37.616] <TB3> INFO: ######################################################################
[16:32:37.616] <TB3> INFO: PixTestAlive::doTest()
[16:32:37.616] <TB3> INFO: ######################################################################
[16:32:37.617] <TB3> INFO: ----------------------------------------------------------------------
[16:32:37.617] <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)
[16:32:37.617] <TB3> INFO: ----------------------------------------------------------------------
[16:32:37.895] <TB3> INFO: Expecting 208000 events.
[16:32:49.215] <TB3> INFO: 208000 events read in total (10761ms).
[16:32:49.217] <TB3> INFO: Test took 11598ms.
[16:32:49.465] <TB3> INFO: PixTestAlive::aliveTest() done
[16:32:49.465] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:32:49.467] <TB3> INFO: ----------------------------------------------------------------------
[16:32:49.467] <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)
[16:32:49.467] <TB3> INFO: ----------------------------------------------------------------------
[16:32:49.733] <TB3> INFO: Expecting 208000 events.
[16:32:57.203] <TB3> INFO: 208000 events read in total (6913ms).
[16:32:57.204] <TB3> INFO: Test took 7735ms.
[16:32:57.205] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:32:57.462] <TB3> INFO: PixTestAlive::maskTest() done
[16:32:57.462] <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
[16:32:57.464] <TB3> INFO: ----------------------------------------------------------------------
[16:32:57.464] <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)
[16:32:57.464] <TB3> INFO: ----------------------------------------------------------------------
[16:32:57.755] <TB3> INFO: Expecting 208000 events.
[16:33:08.957] <TB3> INFO: 208000 events read in total (10645ms).
[16:33:08.958] <TB3> INFO: Test took 11492ms.
[16:33:09.173] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[16:33:09.173] <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
[16:33:09.173] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:33:09.208] <TB3> INFO: enter test to run
[16:33:09.208] <TB3> INFO: test: delay setting parameters: ->2<-
[16:33:09.208] <TB3> INFO: delay test by 2 seconds...
[16:33:11.208] <TB3> INFO: enter test to run
[16:33:11.208] <TB3> INFO: test: HighRate no parameter change
[16:33:11.208] <TB3> INFO: running: highrate
[16:33:11.208] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//013_HREfficiency_75//phCalibrationFitErr35_C15.dat
[16:33:11.338] <TB3> INFO: ----------------------------------------------------------------------
[16:33:11.338] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:33:11.338] <TB3> INFO: ----------------------------------------------------------------------
[16:33:11.822] <TB3> INFO: Expecting 208000 events.
[16:33:27.207] <TB3> INFO: 208000 events read in total (14982ms).
[16:33:27.213] <TB3> INFO: Test took 15871ms.
[16:33:27.745] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0
[16:33:27.745] <TB3> INFO: number of red-efficiency pixels: 134 166 148 243 262 387 304 324 368 416 341 380 316 175 156 163
[16:33:27.745] <TB3> INFO: number of X-ray hits detected: 100509 106510 88947 152108 161114 222036 183170 190659 212315 221879 208787 206791 169810 108484 126121 118114
[16:33:27.745] <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
[16:33:27.745] <TB3> INFO: number of Vcal hits detected: 207864 207828 207849 207747 207674 207567 207675 207658 207569 207553 207632 207583 207664 207817 207842 207834
[16:33:27.745] <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.9 99.9 99.9 99.9
[16:33:27.745] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.9
[16:33:27.745] <TB3> INFO: X-ray hit rate [MHz/cm2]: 29.5 31.2 26.1 44.6 47.2 65.1 53.7 55.9 62.2 65.0 61.2 60.6 49.8 31.8 37.0 34.6
[16:33:27.745] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:33:27.789] <TB3> INFO: PixTest:: pg_setup set to default.
[16:33:27.798] <TB3> INFO: enter test to run
[16:33:27.798] <TB3> INFO: test: no parameter change
[16:33:28.049] <TB3> QUIET: Connection to board 121 closed.
[16:33:28.129] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:34:18.123] <TB3> INFO: *** Welcome to pxar ***
[16:34:18.123] <TB3> INFO: *** Today: 2016/09/19
[16:34:18.190] <TB3> INFO: *** Version: f5d3-dirty
[16:34:18.190] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//dacParameters35_C15.dat
[16:34:18.190] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//tbmParameters_C0b.dat
[16:34:18.190] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//defaultMaskFile.dat
[16:34:18.190] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//trimParameters35_C15.dat
[16:34:18.264] <TB3> INFO: clk: 4
[16:34:18.264] <TB3> INFO: ctr: 4
[16:34:18.264] <TB3> INFO: sda: 19
[16:34:18.264] <TB3> INFO: tin: 9
[16:34:18.264] <TB3> INFO: level: 15
[16:34:18.264] <TB3> INFO: triggerdelay: 0
[16:34:18.264] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:34:18.264] <TB3> INFO: Log level: INFO
[16:34:18.278] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:34:18.287] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:34:18.289] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:34:18.291] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:34:19.860] <TB3> INFO: DUT info:
[16:34:19.860] <TB3> INFO: The DUT currently contains the following objects:
[16:34:19.860] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:34:19.860] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:34:19.860] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:34:19.860] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:34:19.860] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.860] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.861] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.861] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.861] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.861] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.861] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:19.861] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:20.261] <TB3> INFO: enter 'restricted' command line mode
[16:34:20.261] <TB3> INFO: enter test to run
[16:34:20.261] <TB3> INFO: test: PixelAlive no parameter change
[16:34:20.261] <TB3> INFO: running: pixelalive
[16:34:20.266] <TB3> INFO: ######################################################################
[16:34:20.266] <TB3> INFO: PixTestAlive::doTest()
[16:34:20.266] <TB3> INFO: ######################################################################
[16:34:20.267] <TB3> INFO: ----------------------------------------------------------------------
[16:34:20.267] <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)
[16:34:20.267] <TB3> INFO: ----------------------------------------------------------------------
[16:34:20.562] <TB3> INFO: Expecting 208000 events.
[16:34:31.976] <TB3> INFO: 208000 events read in total (10855ms).
[16:34:31.978] <TB3> INFO: Test took 11709ms.
[16:34:32.217] <TB3> INFO: PixTestAlive::aliveTest() done
[16:34:32.217] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:34:32.218] <TB3> INFO: ----------------------------------------------------------------------
[16:34:32.218] <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)
[16:34:32.218] <TB3> INFO: ----------------------------------------------------------------------
[16:34:32.486] <TB3> INFO: Expecting 208000 events.
[16:34:39.951] <TB3> INFO: 208000 events read in total (6907ms).
[16:34:39.952] <TB3> INFO: Test took 7731ms.
[16:34:39.952] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:34:40.210] <TB3> INFO: PixTestAlive::maskTest() done
[16:34:40.210] <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
[16:34:40.211] <TB3> INFO: ----------------------------------------------------------------------
[16:34:40.211] <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)
[16:34:40.211] <TB3> INFO: ----------------------------------------------------------------------
[16:34:40.499] <TB3> INFO: Expecting 208000 events.
[16:34:51.778] <TB3> INFO: 208000 events read in total (10722ms).
[16:34:51.778] <TB3> INFO: Test took 11564ms.
[16:34:51.993] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[16:34:51.993] <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
[16:34:51.993] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:34:52.025] <TB3> INFO: enter test to run
[16:34:52.025] <TB3> INFO: test: delay setting parameters: ->2<-
[16:34:52.025] <TB3> INFO: delay test by 2 seconds...
[16:34:54.025] <TB3> INFO: enter test to run
[16:34:54.025] <TB3> INFO: test: HighRate no parameter change
[16:34:54.025] <TB3> INFO: running: highrate
[16:34:54.025] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//014_HREfficiency_100//phCalibrationFitErr35_C15.dat
[16:34:54.161] <TB3> INFO: ----------------------------------------------------------------------
[16:34:54.161] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:34:54.161] <TB3> INFO: ----------------------------------------------------------------------
[16:34:54.653] <TB3> INFO: Expecting 208000 events.
[16:35:11.891] <TB3> INFO: 208000 events read in total (16835ms).
[16:35:11.899] <TB3> INFO: Test took 17734ms.
[16:35:12.573] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:35:12.573] <TB3> INFO: number of red-efficiency pixels: 198 276 242 490 405 749 562 590 732 726 681 710 617 292 280 291
[16:35:12.573] <TB3> INFO: number of X-ray hits detected: 139731 149891 124278 210165 224869 305888 254315 264554 293783 306477 287359 286697 235392 150786 175083 163502
[16:35:12.573] <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
[16:35:12.573] <TB3> INFO: number of Vcal hits detected: 207796 207714 207740 207474 207510 207130 207376 207347 207123 207164 207224 207156 207324 207677 207709 207693
[16:35:12.573] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.6 99.7 99.7 99.6 99.6 99.7 99.6 99.7 99.9 99.9 99.9
[16:35:12.573] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.7 99.8 99.6 99.7 99.7 99.6 99.6 99.6 99.6 99.7 99.8 99.9 99.9
[16:35:12.573] <TB3> INFO: X-ray hit rate [MHz/cm2]: 41.0 43.9 36.4 61.6 65.9 89.7 74.5 77.5 86.1 89.8 84.2 84.0 69.0 44.2 51.3 47.9
[16:35:12.573] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:35:12.617] <TB3> INFO: PixTest:: pg_setup set to default.
[16:35:12.626] <TB3> INFO: enter test to run
[16:35:12.627] <TB3> INFO: test: no parameter change
[16:35:12.929] <TB3> QUIET: Connection to board 121 closed.
[16:35:13.008] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:36:01.656] <TB3> INFO: *** Welcome to pxar ***
[16:36:01.656] <TB3> INFO: *** Today: 2016/09/19
[16:36:01.723] <TB3> INFO: *** Version: f5d3-dirty
[16:36:01.723] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//dacParameters35_C15.dat
[16:36:01.723] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//tbmParameters_C0b.dat
[16:36:01.723] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//defaultMaskFile.dat
[16:36:01.723] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//trimParameters35_C15.dat
[16:36:01.814] <TB3> INFO: clk: 4
[16:36:01.814] <TB3> INFO: ctr: 4
[16:36:01.814] <TB3> INFO: sda: 19
[16:36:01.814] <TB3> INFO: tin: 9
[16:36:01.814] <TB3> INFO: level: 15
[16:36:01.814] <TB3> INFO: triggerdelay: 0
[16:36:01.814] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:36:01.814] <TB3> INFO: Log level: INFO
[16:36:01.827] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:36:01.836] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:36:01.838] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:36:01.840] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:36:03.400] <TB3> INFO: DUT info:
[16:36:03.400] <TB3> INFO: The DUT currently contains the following objects:
[16:36:03.400] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:36:03.400] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:36:03.400] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:36:03.400] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:36:03.400] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.400] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:03.801] <TB3> INFO: enter 'restricted' command line mode
[16:36:03.801] <TB3> INFO: enter test to run
[16:36:03.801] <TB3> INFO: test: PixelAlive no parameter change
[16:36:03.801] <TB3> INFO: running: pixelalive
[16:36:03.805] <TB3> INFO: ######################################################################
[16:36:03.805] <TB3> INFO: PixTestAlive::doTest()
[16:36:03.805] <TB3> INFO: ######################################################################
[16:36:03.807] <TB3> INFO: ----------------------------------------------------------------------
[16:36:03.807] <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)
[16:36:03.807] <TB3> INFO: ----------------------------------------------------------------------
[16:36:04.116] <TB3> INFO: Expecting 208000 events.
[16:36:15.328] <TB3> INFO: 208000 events read in total (10653ms).
[16:36:15.330] <TB3> INFO: Test took 11512ms.
[16:36:15.578] <TB3> INFO: PixTestAlive::aliveTest() done
[16:36:15.578] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:36:15.579] <TB3> INFO: ----------------------------------------------------------------------
[16:36:15.579] <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)
[16:36:15.579] <TB3> INFO: ----------------------------------------------------------------------
[16:36:15.851] <TB3> INFO: Expecting 208000 events.
[16:36:23.344] <TB3> INFO: 208000 events read in total (6935ms).
[16:36:23.346] <TB3> INFO: Test took 7765ms.
[16:36:23.346] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:36:23.602] <TB3> INFO: PixTestAlive::maskTest() done
[16:36:23.602] <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
[16:36:23.604] <TB3> INFO: ----------------------------------------------------------------------
[16:36:23.604] <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)
[16:36:23.604] <TB3> INFO: ----------------------------------------------------------------------
[16:36:23.875] <TB3> INFO: Expecting 208000 events.
[16:36:34.945] <TB3> INFO: 208000 events read in total (10514ms).
[16:36:34.946] <TB3> INFO: Test took 11340ms.
[16:36:35.161] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[16:36:35.161] <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
[16:36:35.161] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:36:35.197] <TB3> INFO: enter test to run
[16:36:35.197] <TB3> INFO: test: delay setting parameters: ->2<-
[16:36:35.197] <TB3> INFO: delay test by 2 seconds...
[16:36:37.197] <TB3> INFO: enter test to run
[16:36:37.197] <TB3> INFO: test: HighRate no parameter change
[16:36:37.197] <TB3> INFO: running: highrate
[16:36:37.197] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//015_HREfficiency_125//phCalibrationFitErr35_C15.dat
[16:36:37.357] <TB3> INFO: ----------------------------------------------------------------------
[16:36:37.357] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:36:37.357] <TB3> INFO: ----------------------------------------------------------------------
[16:36:37.843] <TB3> INFO: Expecting 208000 events.
[16:36:56.846] <TB3> INFO: 208000 events read in total (18601ms).
[16:36:56.854] <TB3> INFO: Test took 19493ms.
[16:36:57.635] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:36:57.635] <TB3> INFO: number of red-efficiency pixels: 291 341 369 719 614 1137 759 828 1067 1068 1024 1090 884 436 395 405
[16:36:57.635] <TB3> INFO: number of X-ray hits detected: 172251 183252 152054 258432 274929 372620 310456 320951 358067 371558 350800 350967 286274 185372 214774 200020
[16:36:57.635] <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
[16:36:57.635] <TB3> INFO: number of Vcal hits detected: 207698 207637 207566 207171 207256 206552 207101 207070 206637 206649 206723 206600 206940 207481 207583 207557
[16:36:57.635] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.8 99.8 99.6 99.7 99.4 99.6 99.6 99.4 99.4 99.5 99.4 99.6 99.8 99.8 99.8
[16:36:57.635] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.8 99.8 99.6 99.6 99.3 99.6 99.6 99.3 99.4 99.4 99.3 99.5 99.8 99.8 99.8
[16:36:57.635] <TB3> INFO: X-ray hit rate [MHz/cm2]: 50.5 53.7 44.6 75.7 80.6 109.2 91.0 94.1 105.0 108.9 102.8 102.9 83.9 54.3 63.0 58.6
[16:36:57.635] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:36:57.679] <TB3> INFO: PixTest:: pg_setup set to default.
[16:36:57.688] <TB3> INFO: enter test to run
[16:36:57.688] <TB3> INFO: test: no parameter change
[16:36:57.963] <TB3> QUIET: Connection to board 121 closed.
[16:36:58.043] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:37:46.624] <TB3> INFO: *** Welcome to pxar ***
[16:37:46.624] <TB3> INFO: *** Today: 2016/09/19
[16:37:46.693] <TB3> INFO: *** Version: f5d3-dirty
[16:37:46.693] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//dacParameters35_C15.dat
[16:37:46.693] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//tbmParameters_C0b.dat
[16:37:46.693] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//defaultMaskFile.dat
[16:37:46.693] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//trimParameters35_C15.dat
[16:37:46.764] <TB3> INFO: clk: 4
[16:37:46.764] <TB3> INFO: ctr: 4
[16:37:46.764] <TB3> INFO: sda: 19
[16:37:46.764] <TB3> INFO: tin: 9
[16:37:46.764] <TB3> INFO: level: 15
[16:37:46.764] <TB3> INFO: triggerdelay: 0
[16:37:46.764] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:37:46.764] <TB3> INFO: Log level: INFO
[16:37:46.776] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:37:46.785] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:37:46.787] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:37:46.788] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:37:48.328] <TB3> INFO: DUT info:
[16:37:48.328] <TB3> INFO: The DUT currently contains the following objects:
[16:37:48.328] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:37:48.328] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:37:48.328] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:37:48.328] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:37:48.328] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.328] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:48.729] <TB3> INFO: enter 'restricted' command line mode
[16:37:48.729] <TB3> INFO: enter test to run
[16:37:48.729] <TB3> INFO: test: PixelAlive no parameter change
[16:37:48.729] <TB3> INFO: running: pixelalive
[16:37:48.733] <TB3> INFO: ######################################################################
[16:37:48.733] <TB3> INFO: PixTestAlive::doTest()
[16:37:48.733] <TB3> INFO: ######################################################################
[16:37:48.734] <TB3> INFO: ----------------------------------------------------------------------
[16:37:48.734] <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)
[16:37:48.734] <TB3> INFO: ----------------------------------------------------------------------
[16:37:49.009] <TB3> INFO: Expecting 208000 events.
[16:38:00.230] <TB3> INFO: 208000 events read in total (10662ms).
[16:38:00.232] <TB3> INFO: Test took 11496ms.
[16:38:00.477] <TB3> INFO: PixTestAlive::aliveTest() done
[16:38:00.477] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:38:00.478] <TB3> INFO: ----------------------------------------------------------------------
[16:38:00.478] <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)
[16:38:00.478] <TB3> INFO: ----------------------------------------------------------------------
[16:38:00.745] <TB3> INFO: Expecting 208000 events.
[16:38:08.308] <TB3> INFO: 208000 events read in total (7006ms).
[16:38:08.309] <TB3> INFO: Test took 7829ms.
[16:38:08.310] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:38:08.571] <TB3> INFO: PixTestAlive::maskTest() done
[16:38:08.571] <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
[16:38:08.572] <TB3> INFO: ----------------------------------------------------------------------
[16:38:08.572] <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)
[16:38:08.572] <TB3> INFO: ----------------------------------------------------------------------
[16:38:08.864] <TB3> INFO: Expecting 208000 events.
[16:38:20.056] <TB3> INFO: 208000 events read in total (10635ms).
[16:38:20.057] <TB3> INFO: Test took 11482ms.
[16:38:20.272] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[16:38:20.272] <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
[16:38:20.273] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:38:20.304] <TB3> INFO: enter test to run
[16:38:20.304] <TB3> INFO: test: delay setting parameters: ->2<-
[16:38:20.304] <TB3> INFO: delay test by 2 seconds...
[16:38:22.304] <TB3> INFO: enter test to run
[16:38:22.304] <TB3> INFO: test: HighRate no parameter change
[16:38:22.304] <TB3> INFO: running: highrate
[16:38:22.304] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//016_HREfficiency_150//phCalibrationFitErr35_C15.dat
[16:38:22.487] <TB3> INFO: ----------------------------------------------------------------------
[16:38:22.487] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:38:22.487] <TB3> INFO: ----------------------------------------------------------------------
[16:38:22.998] <TB3> INFO: Expecting 208000 events.
[16:38:43.907] <TB3> INFO: 208000 events read in total (20507ms).
[16:38:43.916] <TB3> INFO: Test took 21425ms.
[16:38:44.823] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:38:44.823] <TB3> INFO: number of red-efficiency pixels: 358 497 487 1069 855 1542 1128 1212 1502 1593 1414 1378 1261 553 518 515
[16:38:44.823] <TB3> INFO: number of X-ray hits detected: 205477 220543 182763 308344 329015 445732 371422 385008 426378 441857 419064 417887 342955 221455 255901 238715
[16:38:44.823] <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
[16:38:44.823] <TB3> INFO: number of Vcal hits detected: 207625 207462 207370 206684 206893 205729 206507 206480 205855 205633 206013 205935 206328 207272 207427 207435
[16:38:44.823] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.8 99.4 99.6 99.1 99.4 99.3 99.1 99.0 99.2 99.2 99.3 99.7 99.7 99.8
[16:38:44.823] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.7 99.4 99.5 98.9 99.3 99.3 99.0 98.9 99.0 99.0 99.2 99.7 99.7 99.7
[16:38:44.823] <TB3> INFO: X-ray hit rate [MHz/cm2]: 60.2 64.6 53.6 90.4 96.4 130.6 108.9 112.8 125.0 129.5 122.8 122.5 100.5 64.9 75.0 70.0
[16:38:44.823] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:38:44.867] <TB3> INFO: PixTest:: pg_setup set to default.
[16:38:44.878] <TB3> INFO: enter test to run
[16:38:44.878] <TB3> INFO: test: no parameter change
[16:38:45.187] <TB3> QUIET: Connection to board 121 closed.
[16:38:45.267] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:39:32.603] <TB3> INFO: *** Welcome to pxar ***
[16:39:32.603] <TB3> INFO: *** Today: 2016/09/19
[16:39:32.670] <TB3> INFO: *** Version: f5d3-dirty
[16:39:32.670] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//dacParameters35_C15.dat
[16:39:32.671] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//tbmParameters_C0b.dat
[16:39:32.672] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//defaultMaskFile.dat
[16:39:32.672] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//trimParameters35_C15.dat
[16:39:32.781] <TB3> INFO: clk: 4
[16:39:32.781] <TB3> INFO: ctr: 4
[16:39:32.781] <TB3> INFO: sda: 19
[16:39:32.781] <TB3> INFO: tin: 9
[16:39:32.781] <TB3> INFO: level: 15
[16:39:32.781] <TB3> INFO: triggerdelay: 0
[16:39:32.781] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:39:32.781] <TB3> INFO: Log level: INFO
[16:39:32.793] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:39:32.802] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:39:32.804] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:39:32.806] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:39:34.376] <TB3> INFO: DUT info:
[16:39:34.376] <TB3> INFO: The DUT currently contains the following objects:
[16:39:34.376] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:39:34.376] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:39:34.376] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:39:34.376] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:39:34.376] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.376] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.376] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.376] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.377] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:34.777] <TB3> INFO: enter 'restricted' command line mode
[16:39:34.777] <TB3> INFO: enter test to run
[16:39:34.778] <TB3> INFO: test: PixelAlive no parameter change
[16:39:34.778] <TB3> INFO: running: pixelalive
[16:39:34.781] <TB3> INFO: ######################################################################
[16:39:34.781] <TB3> INFO: PixTestAlive::doTest()
[16:39:34.781] <TB3> INFO: ######################################################################
[16:39:34.782] <TB3> INFO: ----------------------------------------------------------------------
[16:39:34.782] <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)
[16:39:34.782] <TB3> INFO: ----------------------------------------------------------------------
[16:39:35.053] <TB3> INFO: Expecting 208000 events.
[16:39:46.471] <TB3> INFO: 208000 events read in total (10859ms).
[16:39:46.473] <TB3> INFO: Test took 11688ms.
[16:39:46.714] <TB3> INFO: PixTestAlive::aliveTest() done
[16:39:46.714] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:39:46.715] <TB3> INFO: ----------------------------------------------------------------------
[16:39:46.715] <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)
[16:39:46.715] <TB3> INFO: ----------------------------------------------------------------------
[16:39:46.982] <TB3> INFO: Expecting 208000 events.
[16:39:54.478] <TB3> INFO: 208000 events read in total (6939ms).
[16:39:54.478] <TB3> INFO: Test took 7761ms.
[16:39:54.479] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:39:54.738] <TB3> INFO: PixTestAlive::maskTest() done
[16:39:54.738] <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
[16:39:54.739] <TB3> INFO: ----------------------------------------------------------------------
[16:39:54.739] <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)
[16:39:54.739] <TB3> INFO: ----------------------------------------------------------------------
[16:39:55.029] <TB3> INFO: Expecting 208000 events.
[16:40:06.367] <TB3> INFO: 208000 events read in total (10781ms).
[16:40:06.368] <TB3> INFO: Test took 11626ms.
[16:40:06.587] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[16:40:06.587] <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
[16:40:06.587] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:40:06.621] <TB3> INFO: enter test to run
[16:40:06.621] <TB3> INFO: test: delay setting parameters: ->2<-
[16:40:06.621] <TB3> INFO: delay test by 2 seconds...
[16:40:08.621] <TB3> INFO: enter test to run
[16:40:08.621] <TB3> INFO: test: HighRate no parameter change
[16:40:08.621] <TB3> INFO: running: highrate
[16:40:08.621] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//017_HREfficiency_200//phCalibrationFitErr35_C15.dat
[16:40:08.755] <TB3> INFO: ----------------------------------------------------------------------
[16:40:08.755] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:40:08.755] <TB3> INFO: ----------------------------------------------------------------------
[16:40:09.241] <TB3> INFO: Expecting 208000 events.
[16:40:33.524] <TB3> INFO: 208000 events read in total (23881ms).
[16:40:33.540] <TB3> INFO: Test took 24781ms.
[16:40:34.701] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 1 0 0 0 0 0 0 0
[16:40:34.701] <TB3> INFO: number of red-efficiency pixels: 626 954 863 1898 1658 2689 2020 2248 2619 2635 2490 2401 2270 988 1029 968
[16:40:34.701] <TB3> INFO: number of X-ray hits detected: 282814 302287 252198 422635 449043 605230 507051 525059 580496 602108 569581 568886 465006 304704 351260 325132
[16:40:34.701] <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
[16:40:34.701] <TB3> INFO: number of Vcal hits detected: 207292 206886 206581 204988 205311 202379 204478 204371 202984 202330 203113 203195 204043 206372 206769 206793
[16:40:34.701] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.5 99.5 98.7 98.9 97.6 98.5 98.4 97.8 97.6 97.9 98.0 98.3 99.4 99.5 99.5
[16:40:34.701] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.5 99.3 98.6 98.7 97.3 98.3 98.3 97.6 97.3 97.7 97.7 98.1 99.2 99.4 99.4
[16:40:34.701] <TB3> INFO: X-ray hit rate [MHz/cm2]: 82.9 88.6 73.9 123.9 131.6 177.4 148.6 153.9 170.1 176.5 166.9 166.7 136.3 89.3 103.0 95.3
[16:40:34.701] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:40:34.745] <TB3> INFO: PixTest:: pg_setup set to default.
[16:40:34.756] <TB3> INFO: enter test to run
[16:40:34.756] <TB3> INFO: test: no parameter change
[16:40:35.088] <TB3> QUIET: Connection to board 121 closed.
[16:40:35.167] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:41:25.287] <TB3> INFO: *** Welcome to pxar ***
[16:41:25.287] <TB3> INFO: *** Today: 2016/09/19
[16:41:25.352] <TB3> INFO: *** Version: f5d3-dirty
[16:41:25.352] <TB3> INFO: readRocDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//dacParameters35_C15.dat
[16:41:25.353] <TB3> INFO: readTbmDacs: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//tbmParameters_C0b.dat
[16:41:25.353] <TB3> INFO: readMaskFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//defaultMaskFile.dat
[16:41:25.353] <TB3> INFO: readTrimFile: /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//trimParameters35_C15.dat
[16:41:25.453] <TB3> INFO: clk: 4
[16:41:25.453] <TB3> INFO: ctr: 4
[16:41:25.453] <TB3> INFO: sda: 19
[16:41:25.453] <TB3> INFO: tin: 9
[16:41:25.453] <TB3> INFO: level: 15
[16:41:25.453] <TB3> INFO: triggerdelay: 0
[16:41:25.453] <TB3> QUIET: Instanciating API for pxar v2.7.5+30~g833b08f
[16:41:25.453] <TB3> INFO: Log level: INFO
[16:41:25.466] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:41:25.475] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:41:25.477] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:41:25.479] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:41:27.035] <TB3> INFO: DUT info:
[16:41:27.035] <TB3> INFO: The DUT currently contains the following objects:
[16:41:27.035] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:41:27.035] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:41:27.035] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:41:27.035] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:41:27.035] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.035] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:41:27.436] <TB3> INFO: enter 'restricted' command line mode
[16:41:27.436] <TB3> INFO: enter test to run
[16:41:27.436] <TB3> INFO: test: PixelAlive no parameter change
[16:41:27.436] <TB3> INFO: running: pixelalive
[16:41:27.440] <TB3> INFO: ######################################################################
[16:41:27.440] <TB3> INFO: PixTestAlive::doTest()
[16:41:27.440] <TB3> INFO: ######################################################################
[16:41:27.441] <TB3> INFO: ----------------------------------------------------------------------
[16:41:27.441] <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)
[16:41:27.441] <TB3> INFO: ----------------------------------------------------------------------
[16:41:27.724] <TB3> INFO: Expecting 208000 events.
[16:41:38.894] <TB3> INFO: 208000 events read in total (10611ms).
[16:41:38.896] <TB3> INFO: Test took 11453ms.
[16:41:39.132] <TB3> INFO: PixTestAlive::aliveTest() done
[16:41:39.132] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0
[16:41:39.133] <TB3> INFO: ----------------------------------------------------------------------
[16:41:39.133] <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)
[16:41:39.133] <TB3> INFO: ----------------------------------------------------------------------
[16:41:39.400] <TB3> INFO: Expecting 208000 events.
[16:41:46.814] <TB3> INFO: 208000 events read in total (6858ms).
[16:41:46.815] <TB3> INFO: Test took 7679ms.
[16:41:46.815] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:41:47.074] <TB3> INFO: PixTestAlive::maskTest() done
[16:41:47.074] <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
[16:41:47.075] <TB3> INFO: ----------------------------------------------------------------------
[16:41:47.075] <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)
[16:41:47.075] <TB3> INFO: ----------------------------------------------------------------------
[16:41:47.344] <TB3> INFO: Expecting 208000 events.
[16:41:58.473] <TB3> INFO: 208000 events read in total (10572ms).
[16:41:58.474] <TB3> INFO: Test took 11397ms.
[16:41:58.688] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[16:41:58.688] <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
[16:41:58.688] <TB3> INFO: PixTestAlive::doTest() done, duration: 31 seconds
[16:41:58.719] <TB3> INFO: enter test to run
[16:41:58.719] <TB3> INFO: test: delay setting parameters: ->2<-
[16:41:58.719] <TB3> INFO: delay test by 2 seconds...
[16:42:00.719] <TB3> INFO: enter test to run
[16:42:00.719] <TB3> INFO: test: HighRate no parameter change
[16:42:00.720] <TB3> INFO: running: highrate
[16:42:00.720] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2323_XrayQualification_2016-09-19_17h13m_1474297994//018_HREfficiency_250//phCalibrationFitErr35_C15.dat
[16:42:00.910] <TB3> INFO: ----------------------------------------------------------------------
[16:42:00.910] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:42:00.910] <TB3> INFO: ----------------------------------------------------------------------
[16:42:01.403] <TB3> INFO: Expecting 208000 events.
[16:42:29.933] <TB3> INFO: 208000 events read in total (28128ms).
[16:42:29.949] <TB3> INFO: Test took 29035ms.
[16:42:31.333] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0
[16:42:31.333] <TB3> INFO: number of red-efficiency pixels: 1016 1320 1234 2686 2345 3507 2836 3055 3525 3451 3281 3266 3118 1350 1581 1461
[16:42:31.333] <TB3> INFO: number of X-ray hits detected: 350891 375424 312902 521923 554328 749364 625646 646248 719975 739205 702208 706102 576679 377728 435081 403158
[16:42:31.333] <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
[16:42:31.333] <TB3> INFO: number of Vcal hits detected: 206750 206325 205502 202626 203136 197148 201328 201503 198179 197613 199153 198771 200758 204988 205875 205947
[16:42:31.333] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.3 99.0 97.7 98.0 95.4 97.2 97.2 95.7 95.6 96.3 96.2 96.9 98.8 99.1 99.2
[16:42:31.333] <TB3> INFO: Vcal hit overall efficiency (%): 99.4 99.2 98.8 97.4 97.7 94.8 96.8 96.9 95.3 95.0 95.7 95.6 96.5 98.6 99.0 99.0
[16:42:31.333] <TB3> INFO: X-ray hit rate [MHz/cm2]: 102.8 110.0 91.7 153.0 162.5 219.6 183.4 189.4 211.0 216.7 205.8 207.0 169.0 110.7 127.5 118.2
[16:42:31.333] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:42:31.378] <TB3> INFO: PixTest:: pg_setup set to default.
[16:42:31.389] <TB3> INFO: enter test to run
[16:42:31.389] <TB3> INFO: test: no parameter change
[16:42:31.703] <TB3> QUIET: Connection to board 121 closed.
[16:42:31.782] <TB3> INFO: pXar: this is the end, my friend