Test Date: 2015-09-04 17:08
Analysis date: 2016-05-26 04:27
Logfile
commander_PixelAlive.log
[15:09:35.352] <TB3> INFO: *** Welcome to pxar ***
[15:09:35.352] <TB3> INFO: *** Today: 2015/09/04
[15:09:35.352] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//000_PixelAlive_p17//dacParameters35_C15.dat
[15:09:35.354] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//000_PixelAlive_p17//tbmParameters_C0b.dat
[15:09:35.354] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//000_PixelAlive_p17//defaultMaskFile.dat
[15:09:35.354] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//000_PixelAlive_p17//trimParameters35_C15.dat
[15:09:35.434] <TB3> INFO: clk: 4
[15:09:35.434] <TB3> INFO: ctr: 4
[15:09:35.434] <TB3> INFO: sda: 19
[15:09:35.434] <TB3> INFO: tin: 9
[15:09:35.434] <TB3> INFO: level: 15
[15:09:35.434] <TB3> INFO: triggerdelay: 0
[15:09:35.434] <TB3> QUIET: Instanciating API for pxar prod-10
[15:09:35.434] <TB3> INFO: Log level: INFO
[15:09:35.446] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:09:35.464] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:09:35.467] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:09:35.470] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[15:09:37.003] <TB3> INFO: DUT info:
[15:09:37.003] <TB3> INFO: The DUT currently contains the following objects:
[15:09:37.003] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:09:37.003] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:09:37.003] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:09:37.003] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:09:37.003] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.003] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:09:37.404] <TB3> INFO: enter 'restricted' command line mode
[15:09:37.404] <TB3> INFO: enter test to run
[15:09:37.404] <TB3> INFO: test: PixelAlive no parameter change
[15:09:37.404] <TB3> INFO: running: pixelalive
[15:09:37.409] <TB3> INFO: ######################################################################
[15:09:37.409] <TB3> INFO: PixTestAlive::doTest()
[15:09:37.409] <TB3> INFO: ######################################################################
[15:09:37.411] <TB3> INFO: ----------------------------------------------------------------------
[15:09:37.411] <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:09:37.411] <TB3> INFO: ----------------------------------------------------------------------
[15:09:37.744] <TB3> INFO: Expecting 41600 events.
[15:09:42.416] <TB3> INFO: 41600 events read in total (3954ms).
[15:09:42.497] <TB3> INFO: Test took 5084ms.
[15:09:42.503] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:09:42.751] <TB3> INFO: PixTestAlive::aliveTest() done
[15:09:42.751] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2
[15:09:42.753] <TB3> INFO: ----------------------------------------------------------------------
[15:09:42.753] <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:09:42.753] <TB3> INFO: ----------------------------------------------------------------------
[15:09:43.052] <TB3> INFO: Expecting 41600 events.
[15:09:46.396] <TB3> INFO: 41600 events read in total (2628ms).
[15:09:46.396] <TB3> INFO: Test took 3642ms.
[15:09:46.396] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:09:46.396] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:09:46.706] <TB3> INFO: PixTestAlive::maskTest() done
[15:09:46.706] <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:09:46.708] <TB3> INFO: ----------------------------------------------------------------------
[15:09:46.708] <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:09:46.708] <TB3> INFO: ----------------------------------------------------------------------
[15:09:47.008] <TB3> INFO: Expecting 41600 events.
[15:09:51.664] <TB3> INFO: 41600 events read in total (3940ms).
[15:09:51.665] <TB3> INFO: Test took 4956ms.
[15:09:51.671] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:09:51.960] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[15:09:51.960] <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:09:51.960] <TB3> INFO: PixTestAlive::doTest() done, duration: 14 seconds
[15:09:51.990] <TB3> INFO: enter test to run
[15:09:51.990] <TB3> INFO: test: no parameter change
[15:09:52.146] <TB3> QUIET: Connection to board 121 closed.
[15:09:52.226] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[15:15:09.902] <TB3> INFO: *** Welcome to pxar ***
[15:15:09.902] <TB3> INFO: *** Today: 2015/09/04
[15:15:09.902] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:15:09.903] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:15:09.903] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:15:09.903] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:15:09.984] <TB3> INFO: clk: 4
[15:15:09.984] <TB3> INFO: ctr: 4
[15:15:09.984] <TB3> INFO: sda: 19
[15:15:09.984] <TB3> INFO: tin: 9
[15:15:09.984] <TB3> INFO: level: 15
[15:15:09.984] <TB3> INFO: triggerdelay: 0
[15:15:09.984] <TB3> QUIET: Instanciating API for pxar prod-10
[15:15:09.984] <TB3> INFO: Log level: INFO
[15:15:10.000] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:15:10.019] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:15:10.022] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:15:10.025] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[15:15:11.588] <TB3> INFO: DUT info:
[15:15:11.588] <TB3> INFO: The DUT currently contains the following objects:
[15:15:11.588] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:15:11.588] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:15:11.588] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:15:11.588] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:15:11.589] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.589] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:15:11.990] <TB3> INFO: enter 'restricted' command line mode
[15:15:11.990] <TB3> INFO: enter test to run
[15:15:11.990] <TB3> INFO: test: delay setting parameters: ->5<-
[15:15:11.991] <TB3> INFO: delay test by 5 seconds...
[15:15:16.991] <TB3> INFO: enter test to run
[15:15:16.991] <TB3> INFO: test: highrate no parameter change
[15:15:16.991] <TB3> INFO: running: highrate
[15:15:16.991] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:15:17.159] <TB3> INFO: ----------------------------------------------------------------------
[15:15:17.159] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:15:17.159] <TB3> INFO: ----------------------------------------------------------------------
[15:15:17.159] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:15:17.159] <TB3> INFO: edge/corner pixel THR is adjusted
[15:15:17.159] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:15:18.121] <TB3> INFO: Collecting data for 1 seconds...
[15:15:19.123] <TB3> INFO: Done with hot pixel readout
[15:15:25.623] <TB3> INFO: PixTest:: pg_setup set to default.
[15:15:25.624] <TB3> INFO: 0 hot pixels found in step 0
[15:15:25.632] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[15:15:25.670] <TB3> INFO: PixTest::trimHotPixels() done
[15:15:25.670] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:15:25.679] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:15:25.687] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:15:25.696] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:15:25.705] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:15:25.713] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:15:25.721] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:15:25.730] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:15:25.739] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:15:25.748] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:15:25.756] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:15:25.765] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:15:25.774] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:15:25.783] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:15:25.791] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:15:25.800] <TB3> INFO: write trim parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:15:25.808] <TB3> INFO: write masked pixels into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:15:25.852] <TB3> INFO: enter test to run
[15:15:25.852] <TB3> INFO: test: no parameter change
[15:15:26.030] <TB3> QUIET: Connection to board 121 closed.
[15:15:26.111] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[15:16:26.934] <TB3> INFO: *** Welcome to pxar ***
[15:16:26.934] <TB3> INFO: *** Today: 2015/09/04
[15:16:26.934] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//dacParameters35_C15.dat
[15:16:26.935] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//tbmParameters_C0b.dat
[15:16:26.935] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//defaultMaskFile.dat
[15:16:26.935] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//trimParameters35_C15.dat
[15:16:27.011] <TB3> INFO: clk: 4
[15:16:27.011] <TB3> INFO: ctr: 4
[15:16:27.011] <TB3> INFO: sda: 19
[15:16:27.011] <TB3> INFO: tin: 9
[15:16:27.011] <TB3> INFO: level: 15
[15:16:27.011] <TB3> INFO: triggerdelay: 0
[15:16:27.011] <TB3> QUIET: Instanciating API for pxar prod-10
[15:16:27.011] <TB3> INFO: Log level: INFO
[15:16:27.025] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:16:27.043] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:16:27.046] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:16:27.049] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[15:16:28.573] <TB3> INFO: DUT info:
[15:16:28.573] <TB3> INFO: The DUT currently contains the following objects:
[15:16:28.573] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:16:28.573] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:16:28.573] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:16:28.574] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:16:28.574] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.574] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:16:28.975] <TB3> INFO: enter 'restricted' command line mode
[15:16:28.975] <TB3> INFO: enter test to run
[15:16:28.975] <TB3> INFO: test: delay setting parameters: ->5<-
[15:16:28.975] <TB3> INFO: delay test by 5 seconds...
[15:16:33.975] <TB3> INFO: enter test to run
[15:16:33.975] <TB3> INFO: test: Xray no parameter change
[15:16:33.975] <TB3> INFO: running: xray
[15:16:33.976] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//003_HRData_50//phCalibrationFitErr35_C15.dat
[15:16:34.135] <TB3> INFO: ######################################################################
[15:16:34.135] <TB3> INFO: PixTestXray::doTest()
[15:16:34.135] <TB3> INFO: ######################################################################
[15:16:34.135] <TB3> INFO: ----------------------------------------------------------------------
[15:16:34.135] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:16:34.135] <TB3> INFO: ----------------------------------------------------------------------
[15:16:35.104] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:16:41.822] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[15:17:07.522] <TB3> INFO: Resuming triggers.
[15:17:14.236] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[15:17:39.834] <TB3> INFO: Resuming triggers.
[15:17:46.553] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[15:18:12.111] <TB3> INFO: Resuming triggers.
[15:18:18.833] <TB3> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[15:18:43.771] <TB3> INFO: Resuming triggers.
[15:18:50.483] <TB3> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[15:19:15.707] <TB3> INFO: Resuming triggers.
[15:19:22.421] <TB3> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[15:19:47.382] <TB3> INFO: Resuming triggers.
[15:19:54.098] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[15:20:20.342] <TB3> INFO: Resuming triggers.
[15:20:27.056] <TB3> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[15:20:53.107] <TB3> INFO: Resuming triggers.
[15:20:59.820] <TB3> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[15:21:26.358] <TB3> INFO: Resuming triggers.
[15:21:33.073] <TB3> INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[15:22:00.560] <TB3> INFO: Resuming triggers.
[15:22:07.278] <TB3> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[15:22:34.141] <TB3> INFO: Resuming triggers.
[15:22:40.857] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[15:23:06.127] <TB3> INFO: Resuming triggers.
[15:23:12.837] <TB3> INFO: run duration 87 seconds, buffer almost full (81%), pausing triggers.
[15:23:38.197] <TB3> INFO: Resuming triggers.
[15:23:44.909] <TB3> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[15:24:10.281] <TB3> INFO: Resuming triggers.
[15:24:16.384] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[15:24:39.126] <TB3> INFO: PixTest:: pg_setup set to default.
[15:24:39.127] <TB3> INFO: PixTestXray::doPhRun() done
[15:24:39.127] <TB3> INFO: PixTestXray::doTest() done
[15:24:39.305] <TB3> INFO: enter test to run
[15:24:39.305] <TB3> INFO: test: no parameter change
[15:24:39.534] <TB3> QUIET: Connection to board 121 closed.
[15:24:39.615] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[15:26:25.565] <TB3> INFO: *** Welcome to pxar ***
[15:26:25.565] <TB3> INFO: *** Today: 2015/09/04
[15:26:25.565] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//dacParameters35_C15.dat
[15:26:25.567] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//tbmParameters_C0b.dat
[15:26:25.567] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//defaultMaskFile.dat
[15:26:25.567] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//trimParameters35_C15.dat
[15:26:25.655] <TB3> INFO: clk: 4
[15:26:25.655] <TB3> INFO: ctr: 4
[15:26:25.655] <TB3> INFO: sda: 19
[15:26:25.655] <TB3> INFO: tin: 9
[15:26:25.655] <TB3> INFO: level: 15
[15:26:25.655] <TB3> INFO: triggerdelay: 0
[15:26:25.655] <TB3> QUIET: Instanciating API for pxar prod-10
[15:26:25.655] <TB3> INFO: Log level: INFO
[15:26:25.668] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:26:25.686] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:26:25.690] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:26:25.692] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[15:26:27.228] <TB3> INFO: DUT info:
[15:26:27.228] <TB3> INFO: The DUT currently contains the following objects:
[15:26:27.228] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:26:27.228] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:26:27.228] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:26:27.228] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:26:27.228] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.228] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.228] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.228] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.228] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.228] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.228] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.228] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.229] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.229] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.229] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.229] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.229] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.229] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.229] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.229] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:26:27.632] <TB3> INFO: enter 'restricted' command line mode
[15:26:27.632] <TB3> INFO: enter test to run
[15:26:27.632] <TB3> INFO: test: delay setting parameters: ->5<-
[15:26:27.633] <TB3> INFO: delay test by 5 seconds...
[15:26:32.633] <TB3> INFO: enter test to run
[15:26:32.633] <TB3> INFO: test: Xray no parameter change
[15:26:32.633] <TB3> INFO: running: xray
[15:26:32.633] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//004_HRData_150//phCalibrationFitErr35_C15.dat
[15:26:32.808] <TB3> INFO: ######################################################################
[15:26:32.808] <TB3> INFO: PixTestXray::doTest()
[15:26:32.808] <TB3> INFO: ######################################################################
[15:26:32.808] <TB3> INFO: ----------------------------------------------------------------------
[15:26:32.808] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:26:32.808] <TB3> INFO: ----------------------------------------------------------------------
[15:26:33.777] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:26:37.482] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[15:27:04.606] <TB3> INFO: Resuming triggers.
[15:27:08.320] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[15:27:35.882] <TB3> INFO: Resuming triggers.
[15:27:39.593] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[15:28:07.432] <TB3> INFO: Resuming triggers.
[15:28:11.141] <TB3> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[15:28:36.681] <TB3> INFO: Resuming triggers.
[15:28:40.392] <TB3> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[15:29:07.475] <TB3> INFO: Resuming triggers.
[15:29:11.184] <TB3> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[15:29:38.615] <TB3> INFO: Resuming triggers.
[15:29:42.322] <TB3> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[15:30:08.873] <TB3> INFO: Resuming triggers.
[15:30:12.582] <TB3> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[15:30:39.875] <TB3> INFO: Resuming triggers.
[15:30:43.583] <TB3> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[15:31:11.423] <TB3> INFO: Resuming triggers.
[15:31:15.131] <TB3> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[15:31:42.654] <TB3> INFO: Resuming triggers.
[15:31:46.360] <TB3> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[15:32:15.012] <TB3> INFO: Resuming triggers.
[15:32:18.721] <TB3> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[15:32:47.423] <TB3> INFO: Resuming triggers.
[15:32:51.131] <TB3> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[15:33:18.096] <TB3> INFO: Resuming triggers.
[15:33:21.804] <TB3> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[15:33:49.030] <TB3> INFO: Resuming triggers.
[15:33:52.738] <TB3> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[15:34:21.002] <TB3> INFO: Resuming triggers.
[15:34:24.708] <TB3> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[15:34:52.015] <TB3> INFO: Resuming triggers.
[15:34:55.721] <TB3> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[15:35:21.479] <TB3> INFO: Resuming triggers.
[15:35:25.182] <TB3> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[15:35:52.479] <TB3> INFO: Resuming triggers.
[15:35:56.187] <TB3> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[15:36:23.051] <TB3> INFO: Resuming triggers.
[15:36:26.754] <TB3> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[15:36:54.915] <TB3> INFO: Resuming triggers.
[15:36:58.623] <TB3> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[15:37:26.523] <TB3> INFO: Resuming triggers.
[15:37:30.225] <TB3> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[15:37:58.370] <TB3> INFO: Resuming triggers.
[15:38:02.074] <TB3> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[15:38:30.223] <TB3> INFO: Resuming triggers.
[15:38:33.928] <TB3> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[15:39:04.106] <TB3> INFO: Resuming triggers.
[15:39:07.808] <TB3> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[15:39:36.111] <TB3> INFO: Resuming triggers.
[15:39:39.815] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[15:40:07.001] <TB3> INFO: Resuming triggers.
[15:40:10.703] <TB3> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[15:40:37.923] <TB3> INFO: Resuming triggers.
[15:40:37.954] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[15:40:38.687] <TB3> INFO: PixTest:: pg_setup set to default.
[15:40:38.688] <TB3> INFO: PixTestXray::doPhRun() done
[15:40:38.688] <TB3> INFO: PixTestXray::doTest() done
[15:40:38.909] <TB3> INFO: enter test to run
[15:40:38.909] <TB3> INFO: test: no parameter change
[15:40:39.108] <TB3> QUIET: Connection to board 121 closed.
[15:40:39.195] <TB3> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[15:44:15.424] <TB3> INFO: *** Welcome to pxar ***
[15:44:15.424] <TB3> INFO: *** Today: 2015/09/04
[15:44:15.424] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//dacParameters35_C15.dat
[15:44:15.425] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//tbmParameters_C0b.dat
[15:44:15.425] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//defaultMaskFile.dat
[15:44:15.425] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//trimParameters35_C15.dat
[15:44:15.499] <TB3> INFO: clk: 4
[15:44:15.499] <TB3> INFO: ctr: 4
[15:44:15.499] <TB3> INFO: sda: 19
[15:44:15.499] <TB3> INFO: tin: 9
[15:44:15.499] <TB3> INFO: level: 15
[15:44:15.499] <TB3> INFO: triggerdelay: 0
[15:44:15.499] <TB3> QUIET: Instanciating API for pxar prod-10
[15:44:15.499] <TB3> INFO: Log level: INFO
[15:44:15.514] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:44:15.533] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:44:15.537] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:44:15.540] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[15:44:17.060] <TB3> INFO: DUT info:
[15:44:17.060] <TB3> INFO: The DUT currently contains the following objects:
[15:44:17.060] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:44:17.060] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:44:17.060] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:44:17.060] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:44:17.060] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.060] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:17.461] <TB3> INFO: enter 'restricted' command line mode
[15:44:17.461] <TB3> INFO: enter test to run
[15:44:17.461] <TB3> INFO: test: Highrate no parameter change
[15:44:17.461] <TB3> INFO: running: highrate
[15:44:17.462] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[15:44:17.635] <TB3> INFO: ----------------------------------------------------------------------
[15:44:17.635] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[15:44:17.635] <TB3> INFO: ----------------------------------------------------------------------
[15:44:17.641] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 384 (plus default)
[15:44:17.654] <TB3> INFO: dacScan step from 15 .. 34
[15:44:17.654] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[15:44:17.654] <TB3> INFO: run 1 of 1
[15:44:18.261] <TB3> INFO: Expecting 4160000 events.
[15:44:49.513] <TB3> INFO: 464500 events read in total (30722ms).
[15:45:20.295] <TB3> INFO: 930300 events read in total (61504ms).
[15:45:50.999] <TB3> INFO: 1396350 events read in total (92208ms).
[15:46:21.155] <TB3> INFO: 1861900 events read in total (122364ms).
[15:46:51.192] <TB3> INFO: 2327400 events read in total (152401ms).
[15:47:21.684] <TB3> INFO: 2792750 events read in total (182893ms).
[15:47:52.147] <TB3> INFO: 3257850 events read in total (213356ms).
[15:48:22.639] <TB3> INFO: 3722600 events read in total (243848ms).
[15:48:30.494] <TB3> WARNING: Channel 3 ROC 2: Readback start marker after 3 readouts!

[15:48:33.592] <TB3> WARNING: Channel 3 ROC 2: Readback start marker after 13 readouts!

[15:49:05.920] <TB3> INFO: 4160000 events read in total (287129ms).
[15:49:09.214] <TB3> INFO: Test took 291560ms.
[15:49:11.578] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:16.339] <TB3> INFO: dacScan step from 35 .. 54
[15:49:16.339] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[15:49:16.339] <TB3> INFO: run 1 of 1
[15:49:16.969] <TB3> INFO: Expecting 4160000 events.
[15:49:46.655] <TB3> INFO: 384850 events read in total (29142ms).
[15:50:15.774] <TB3> INFO: 770450 events read in total (58261ms).
[15:50:44.804] <TB3> INFO: 1154950 events read in total (87291ms).
[15:51:14.634] <TB3> INFO: 1538500 events read in total (117121ms).
[15:51:43.005] <TB3> INFO: 1920650 events read in total (145492ms).
[15:52:12.157] <TB3> INFO: 2301300 events read in total (174644ms).
[15:52:41.443] <TB3> INFO: 2678900 events read in total (203930ms).
[15:53:11.448] <TB3> INFO: 3053800 events read in total (233935ms).
[15:53:41.297] <TB3> INFO: 3425800 events read in total (263784ms).
[15:54:10.506] <TB3> INFO: 3795850 events read in total (292993ms).
[15:54:39.334] <TB3> INFO: 4160000 events read in total (321821ms).
[15:54:39.517] <TB3> INFO: Test took 323153ms.
[15:54:41.417] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:46.499] <TB3> INFO: dacScan step from 55 .. 74
[15:54:46.499] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[15:54:46.499] <TB3> INFO: run 1 of 1
[15:54:47.133] <TB3> INFO: Expecting 4160000 events.
[15:55:16.520] <TB3> INFO: 342800 events read in total (28846ms).
[15:55:44.970] <TB3> INFO: 686200 events read in total (57296ms).
[15:56:13.144] <TB3> INFO: 1029900 events read in total (85470ms).
[15:56:41.222] <TB3> INFO: 1373700 events read in total (113548ms).
[15:57:09.347] <TB3> INFO: 1717300 events read in total (141673ms).
[15:57:37.727] <TB3> INFO: 2061100 events read in total (170053ms).
[15:58:06.215] <TB3> INFO: 2404950 events read in total (198541ms).
[15:58:34.793] <TB3> INFO: 2748450 events read in total (227119ms).
[15:59:02.999] <TB3> INFO: 3092050 events read in total (255325ms).
[15:59:31.322] <TB3> INFO: 3435600 events read in total (283648ms).
[15:59:58.669] <TB3> INFO: 3779150 events read in total (310995ms).
[16:00:27.559] <TB3> INFO: 4122550 events read in total (339885ms).
[16:00:31.046] <TB3> INFO: 4160000 events read in total (343372ms).
[16:00:31.256] <TB3> INFO: Test took 344756ms.
[16:00:33.347] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:00:38.236] <TB3> INFO: dacScan step from 75 .. 75
[16:00:38.236] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[16:00:38.236] <TB3> INFO: run 1 of 1
[16:00:38.835] <TB3> INFO: Expecting 208000 events.
[16:00:57.254] <TB3> INFO: 208000 events read in total (17892ms).
[16:00:57.261] <TB3> INFO: Test took 19025ms.
[16:00:57.336] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:00:57.565] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:00:58.720] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:00:59.797] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:00.874] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:01.992] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:03.118] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:04.260] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:05.353] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:06.446] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:07.535] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:08.625] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:09.737] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:10.813] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:11.935] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:13.060] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:14.180] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:01:15.320] <TB3> INFO: PixTest:: pg_setup set to default.
[16:01:15.321] <TB3> INFO: vcal mean: 37.15 37.33 36.81 39.44 40.37 42.20 41.55 41.73 42.49 41.53 42.67 41.84 40.55 37.56 38.16 37.91
[16:01:15.321] <TB3> INFO: vcal RMS: 1.20 1.00 0.79 1.18 1.18 1.35 1.29 1.38 1.43 1.35 1.45 1.54 1.24 0.95 0.97 1.29
[16:01:15.321] <TB3> INFO: number of X-ray hits detected: 150906 158453 132595 251031 284220 375197 321556 359187 382970 360338 400355 337976 296745 159963 179963 174318
[16:01:15.321] <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:01:15.321] <TB3> INFO: X-ray hit rate [MHz/cm2]: 44.2 46.4 38.9 73.6 83.3 110.0 94.3 105.3 112.3 105.6 117.3 99.1 87.0 46.9 52.7 51.1
[16:01:15.321] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[16:01:15.455] <TB3> INFO: enter test to run
[16:01:15.455] <TB3> INFO: test: no parameter change
[16:01:15.627] <TB3> QUIET: Connection to board 121 closed.
[16:01:15.706] <TB3> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[16:21:15.805] <TB3> INFO: *** Welcome to pxar ***
[16:21:15.805] <TB3> INFO: *** Today: 2015/09/04
[16:21:15.805] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:21:15.807] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[16:21:15.807] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[16:21:15.807] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[16:21:15.891] <TB3> INFO: clk: 4
[16:21:15.891] <TB3> INFO: ctr: 4
[16:21:15.891] <TB3> INFO: sda: 19
[16:21:15.891] <TB3> INFO: tin: 9
[16:21:15.891] <TB3> INFO: level: 15
[16:21:15.891] <TB3> INFO: triggerdelay: 0
[16:21:15.891] <TB3> QUIET: Instanciating API for pxar prod-10
[16:21:15.891] <TB3> INFO: Log level: INFO
[16:21:15.906] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:21:15.924] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:21:15.927] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:21:15.930] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[16:21:17.458] <TB3> INFO: DUT info:
[16:21:17.458] <TB3> INFO: The DUT currently contains the following objects:
[16:21:17.458] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:21:17.458] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:21:17.458] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:21:17.458] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:21:17.458] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.458] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.458] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.458] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.459] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:21:17.860] <TB3> INFO: enter 'restricted' command line mode
[16:21:17.860] <TB3> INFO: enter test to run
[16:21:17.860] <TB3> INFO: test: HighRate no parameter change
[16:21:17.860] <TB3> INFO: running: highrate
[16:21:17.860] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[16:21:17.997] <TB3> INFO: ----------------------------------------------------------------------
[16:21:17.997] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[16:21:17.997] <TB3> INFO: ----------------------------------------------------------------------
[16:21:18.136] <TB3> INFO: Expecting 768 events.
[16:21:19.366] <TB3> INFO: 768 events read in total (512ms).
[16:21:19.461] <TB3> INFO: Test took 1459ms.
[16:21:20.099] <TB3> INFO: Expecting 41600 events.
[16:21:23.705] <TB3> INFO: 41600 events read in total (3079ms).
[16:21:23.707] <TB3> INFO: Test took 4241ms.
[16:21:23.781] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:24.419] <TB3> INFO: Expecting 41600 events.
[16:21:28.278] <TB3> INFO: 41600 events read in total (3332ms).
[16:21:28.281] <TB3> INFO: Test took 4475ms.
[16:21:28.353] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:29.003] <TB3> INFO: Expecting 41600 events.
[16:21:32.920] <TB3> INFO: 41600 events read in total (3390ms).
[16:21:32.921] <TB3> INFO: Test took 4539ms.
[16:21:32.989] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:33.630] <TB3> INFO: Expecting 41600 events.
[16:21:37.491] <TB3> INFO: 41600 events read in total (3334ms).
[16:21:37.492] <TB3> INFO: Test took 4475ms.
[16:21:37.567] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:38.223] <TB3> INFO: Expecting 41600 events.
[16:21:42.243] <TB3> INFO: 41600 events read in total (3493ms).
[16:21:42.245] <TB3> INFO: Test took 4645ms.
[16:21:42.320] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:42.979] <TB3> INFO: Expecting 41600 events.
[16:21:46.813] <TB3> INFO: 41600 events read in total (3306ms).
[16:21:46.814] <TB3> INFO: Test took 4461ms.
[16:21:46.885] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:47.526] <TB3> INFO: Expecting 41600 events.
[16:21:51.366] <TB3> INFO: 41600 events read in total (3313ms).
[16:21:51.367] <TB3> INFO: Test took 4455ms.
[16:21:51.454] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:52.133] <TB3> INFO: Expecting 41600 events.
[16:21:56.163] <TB3> INFO: 41600 events read in total (3503ms).
[16:21:56.164] <TB3> INFO: Test took 4670ms.
[16:21:56.235] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:21:56.902] <TB3> INFO: Expecting 41600 events.
[16:22:00.736] <TB3> INFO: 41600 events read in total (3306ms).
[16:22:00.737] <TB3> INFO: Test took 4470ms.
[16:22:00.805] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:01.446] <TB3> INFO: Expecting 41600 events.
[16:22:05.334] <TB3> INFO: 41600 events read in total (3361ms).
[16:22:05.336] <TB3> INFO: Test took 4504ms.
[16:22:05.423] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:06.075] <TB3> INFO: Expecting 41600 events.
[16:22:10.059] <TB3> INFO: 41600 events read in total (3457ms).
[16:22:10.061] <TB3> INFO: Test took 4599ms.
[16:22:10.148] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:10.791] <TB3> INFO: Expecting 41600 events.
[16:22:14.819] <TB3> INFO: 41600 events read in total (3501ms).
[16:22:14.820] <TB3> INFO: Test took 4642ms.
[16:22:14.892] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:15.554] <TB3> INFO: Expecting 41600 events.
[16:22:19.552] <TB3> INFO: 41600 events read in total (3471ms).
[16:22:19.553] <TB3> INFO: Test took 4628ms.
[16:22:19.629] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:20.295] <TB3> INFO: Expecting 41600 events.
[16:22:24.146] <TB3> INFO: 41600 events read in total (3324ms).
[16:22:24.148] <TB3> INFO: Test took 4484ms.
[16:22:24.228] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:24.892] <TB3> INFO: Expecting 41600 events.
[16:22:28.740] <TB3> INFO: 41600 events read in total (3321ms).
[16:22:28.742] <TB3> INFO: Test took 4478ms.
[16:22:28.817] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:29.474] <TB3> INFO: Expecting 41600 events.
[16:22:33.454] <TB3> INFO: 41600 events read in total (3453ms).
[16:22:33.456] <TB3> INFO: Test took 4607ms.
[16:22:33.527] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:34.175] <TB3> INFO: Expecting 41600 events.
[16:22:37.974] <TB3> INFO: 41600 events read in total (3272ms).
[16:22:37.976] <TB3> INFO: Test took 4423ms.
[16:22:38.042] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:38.681] <TB3> INFO: Expecting 41600 events.
[16:22:42.252] <TB3> INFO: 41600 events read in total (3044ms).
[16:22:42.253] <TB3> INFO: Test took 4185ms.
[16:22:42.317] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:42.954] <TB3> INFO: Expecting 41600 events.
[16:22:46.631] <TB3> INFO: 41600 events read in total (3150ms).
[16:22:46.633] <TB3> INFO: Test took 4292ms.
[16:22:46.698] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:47.336] <TB3> INFO: Expecting 41600 events.
[16:22:51.010] <TB3> INFO: 41600 events read in total (3147ms).
[16:22:51.012] <TB3> INFO: Test took 4289ms.
[16:22:51.075] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:22:51.371] <TB3> INFO: enter test to run
[16:22:51.371] <TB3> INFO: test: Pretest no parameter change
[16:22:51.371] <TB3> INFO: running: pretest
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[16:22:51.372] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[16:22:51.373] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[16:22:51.373] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[16:22:51.373] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[16:22:51.373] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[16:22:51.373] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[16:22:51.373] <TB3> INFO: write dac parameters into /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:22:51.373] <TB3> INFO: enter test to run
[16:22:51.373] <TB3> INFO: test: no parameter change
[16:22:51.580] <TB3> QUIET: Connection to board 121 closed.
[16:22:51.660] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:23:26.402] <TB3> INFO: *** Welcome to pxar ***
[16:23:26.402] <TB3> INFO: *** Today: 2015/09/04
[16:23:26.402] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//dacParameters35_C15.dat
[16:23:26.404] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//tbmParameters_C0b.dat
[16:23:26.404] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//defaultMaskFile.dat
[16:23:26.404] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//trimParameters35_C15.dat
[16:23:26.473] <TB3> INFO: clk: 4
[16:23:26.473] <TB3> INFO: ctr: 4
[16:23:26.473] <TB3> INFO: sda: 19
[16:23:26.473] <TB3> INFO: tin: 9
[16:23:26.473] <TB3> INFO: level: 15
[16:23:26.473] <TB3> INFO: triggerdelay: 0
[16:23:26.473] <TB3> QUIET: Instanciating API for pxar prod-10
[16:23:26.473] <TB3> INFO: Log level: INFO
[16:23:26.486] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:23:26.503] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:23:26.506] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:23:26.509] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[16:23:28.070] <TB3> INFO: DUT info:
[16:23:28.071] <TB3> INFO: The DUT currently contains the following objects:
[16:23:28.071] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:23:28.071] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:23:28.071] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:23:28.071] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:23:28.071] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.071] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:23:28.472] <TB3> INFO: enter 'restricted' command line mode
[16:23:28.472] <TB3> INFO: enter test to run
[16:23:28.472] <TB3> INFO: test: HighRate no parameter change
[16:23:28.472] <TB3> INFO: running: highrate
[16:23:28.472] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[16:23:28.630] <TB3> INFO: ----------------------------------------------------------------------
[16:23:28.630] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:23:28.630] <TB3> INFO: ----------------------------------------------------------------------
[16:23:29.245] <TB3> INFO: Expecting 208000 events.
[16:23:42.695] <TB3> INFO: 208000 events read in total (12920ms).
[16:23:42.701] <TB3> INFO: Test took 14065ms.
[16:23:42.937] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:23:43.233] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2
[16:23:43.233] <TB3> INFO: number of red-efficiency pixels: 89 101 82 153 209 307 224 286 319 268 325 262 199 103 109 110
[16:23:43.233] <TB3> INFO: number of X-ray hits detected: 74021 77131 63953 125147 142195 189427 160170 182238 194785 180953 204358 169898 148938 77687 88853 86813
[16:23:43.233] <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:23:43.233] <TB3> INFO: number of Vcal hits detected: 207812 207898 207918 207843 207779 207683 207770 207695 207667 207718 207651 207728 207796 207892 207888 207791
[16:23:43.233] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.9 99.9 99.9 100.0 99.9 100.0
[16:23:43.233] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 100.0 100.0 99.9 99.9 99.8 99.9 99.9 99.8 99.9 99.8 99.9 99.9 99.9 99.9 99.9
[16:23:43.233] <TB3> INFO: X-ray hit rate [MHz/cm2]: 21.7 22.6 18.7 36.7 41.7 55.5 46.9 53.4 57.1 53.0 59.9 49.8 43.7 22.8 26.0 25.4
[16:23:43.233] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:23:43.259] <TB3> INFO: PixTest:: pg_setup set to default.
[16:23:43.289] <TB3> INFO: enter test to run
[16:23:43.289] <TB3> INFO: test: no parameter change
[16:23:43.457] <TB3> QUIET: Connection to board 121 closed.
[16:23:43.537] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:24:17.601] <TB3> INFO: *** Welcome to pxar ***
[16:24:17.601] <TB3> INFO: *** Today: 2015/09/04
[16:24:17.601] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//dacParameters35_C15.dat
[16:24:17.602] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//tbmParameters_C0b.dat
[16:24:17.602] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//defaultMaskFile.dat
[16:24:17.602] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//trimParameters35_C15.dat
[16:24:17.714] <TB3> INFO: clk: 4
[16:24:17.714] <TB3> INFO: ctr: 4
[16:24:17.714] <TB3> INFO: sda: 19
[16:24:17.714] <TB3> INFO: tin: 9
[16:24:17.714] <TB3> INFO: level: 15
[16:24:17.714] <TB3> INFO: triggerdelay: 0
[16:24:17.714] <TB3> QUIET: Instanciating API for pxar prod-10
[16:24:17.714] <TB3> INFO: Log level: INFO
[16:24:17.728] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:24:17.746] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:24:17.749] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:24:17.751] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[16:24:19.296] <TB3> INFO: DUT info:
[16:24:19.296] <TB3> INFO: The DUT currently contains the following objects:
[16:24:19.296] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:24:19.296] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:24:19.296] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:24:19.296] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:24:19.296] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.296] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:24:19.697] <TB3> INFO: enter 'restricted' command line mode
[16:24:19.697] <TB3> INFO: enter test to run
[16:24:19.697] <TB3> INFO: test: HighRate no parameter change
[16:24:19.697] <TB3> INFO: running: highrate
[16:24:19.698] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[16:24:19.871] <TB3> INFO: ----------------------------------------------------------------------
[16:24:19.871] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:24:19.871] <TB3> INFO: ----------------------------------------------------------------------
[16:24:20.490] <TB3> INFO: Expecting 208000 events.
[16:24:37.390] <TB3> INFO: 208000 events read in total (16370ms).
[16:24:37.399] <TB3> INFO: Test took 17522ms.
[16:24:37.852] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:24:38.220] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2
[16:24:38.220] <TB3> INFO: number of red-efficiency pixels: 258 208 290 504 649 1056 787 983 1197 1016 1175 868 693 344 282 312
[16:24:38.220] <TB3> INFO: number of X-ray hits detected: 151099 158804 132565 251633 285812 374468 319122 362048 386918 359775 401453 338398 296774 160066 180940 175358
[16:24:38.220] <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:24:38.220] <TB3> INFO: number of Vcal hits detected: 207633 207787 207675 207455 207241 206657 207085 206804 206478 206738 206508 206942 207213 207624 207700 207574
[16:24:38.220] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.4 99.6 99.5 99.3 99.5 99.4 99.6 99.7 99.8 99.9 99.9
[16:24:38.220] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.8 99.7 99.6 99.4 99.6 99.4 99.3 99.4 99.3 99.5 99.6 99.8 99.9 99.8
[16:24:38.220] <TB3> INFO: X-ray hit rate [MHz/cm2]: 44.3 46.5 38.9 73.8 83.8 109.8 93.5 106.1 113.4 105.5 117.7 99.2 87.0 46.9 53.0 51.4
[16:24:38.220] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:24:38.245] <TB3> INFO: PixTest:: pg_setup set to default.
[16:24:38.277] <TB3> INFO: enter test to run
[16:24:38.277] <TB3> INFO: test: no parameter change
[16:24:38.629] <TB3> QUIET: Connection to board 121 closed.
[16:24:38.709] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:25:14.525] <TB3> INFO: *** Welcome to pxar ***
[16:25:14.525] <TB3> INFO: *** Today: 2015/09/04
[16:25:14.525] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//dacParameters35_C15.dat
[16:25:14.526] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//tbmParameters_C0b.dat
[16:25:14.526] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//defaultMaskFile.dat
[16:25:14.526] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//trimParameters35_C15.dat
[16:25:14.599] <TB3> INFO: clk: 4
[16:25:14.599] <TB3> INFO: ctr: 4
[16:25:14.599] <TB3> INFO: sda: 19
[16:25:14.599] <TB3> INFO: tin: 9
[16:25:14.599] <TB3> INFO: level: 15
[16:25:14.599] <TB3> INFO: triggerdelay: 0
[16:25:14.599] <TB3> QUIET: Instanciating API for pxar prod-10
[16:25:14.599] <TB3> INFO: Log level: INFO
[16:25:14.613] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:25:14.630] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:25:14.633] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:25:14.636] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[16:25:16.165] <TB3> INFO: DUT info:
[16:25:16.165] <TB3> INFO: The DUT currently contains the following objects:
[16:25:16.165] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:25:16.165] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:25:16.165] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:25:16.165] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:25:16.165] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.165] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:16.566] <TB3> INFO: enter 'restricted' command line mode
[16:25:16.566] <TB3> INFO: enter test to run
[16:25:16.566] <TB3> INFO: test: HighRate no parameter change
[16:25:16.566] <TB3> INFO: running: highrate
[16:25:16.567] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[16:25:16.700] <TB3> INFO: ----------------------------------------------------------------------
[16:25:16.700] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:25:16.700] <TB3> INFO: ----------------------------------------------------------------------
[16:25:17.301] <TB3> INFO: Expecting 208000 events.
[16:25:37.557] <TB3> INFO: 208000 events read in total (19726ms).
[16:25:37.569] <TB3> INFO: Test took 20863ms.
[16:25:38.223] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:25:38.655] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2
[16:25:38.655] <TB3> INFO: number of red-efficiency pixels: 494 425 527 1076 1333 2169 1582 2109 2427 2084 2365 1749 1393 584 691 642
[16:25:38.655] <TB3> INFO: number of X-ray hits detected: 220304 232995 195130 364245 410700 536518 456736 518207 554379 517110 574422 487253 425889 233263 263104 253968
[16:25:38.655] <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:25:38.655] <TB3> INFO: number of Vcal hits detected: 207362 207539 207305 206643 206038 204375 205635 204764 203811 204581 203721 205096 206207 207177 207223 207183
[16:25:38.655] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.4 99.2 98.5 99.0 98.6 98.2 98.5 98.2 98.8 99.2 99.7 99.7 99.7
[16:25:38.655] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.8 99.7 99.3 99.1 98.3 98.9 98.4 98.0 98.4 97.9 98.6 99.1 99.6 99.6 99.6
[16:25:38.655] <TB3> INFO: X-ray hit rate [MHz/cm2]: 64.6 68.3 57.2 106.8 120.4 157.3 133.9 151.9 162.5 151.6 168.4 142.8 124.8 68.4 77.1 74.4
[16:25:38.655] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:25:38.681] <TB3> INFO: PixTest:: pg_setup set to default.
[16:25:38.714] <TB3> INFO: enter test to run
[16:25:38.715] <TB3> INFO: test: no parameter change
[16:25:38.846] <TB3> QUIET: Connection to board 121 closed.
[16:25:38.927] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:26:14.982] <TB3> INFO: *** Welcome to pxar ***
[16:26:14.983] <TB3> INFO: *** Today: 2015/09/04
[16:26:14.983] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//dacParameters35_C15.dat
[16:26:14.983] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//tbmParameters_C0b.dat
[16:26:14.984] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//defaultMaskFile.dat
[16:26:14.984] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//trimParameters35_C15.dat
[16:26:15.088] <TB3> INFO: clk: 4
[16:26:15.088] <TB3> INFO: ctr: 4
[16:26:15.088] <TB3> INFO: sda: 19
[16:26:15.088] <TB3> INFO: tin: 9
[16:26:15.088] <TB3> INFO: level: 15
[16:26:15.088] <TB3> INFO: triggerdelay: 0
[16:26:15.088] <TB3> QUIET: Instanciating API for pxar prod-10
[16:26:15.088] <TB3> INFO: Log level: INFO
[16:26:15.100] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:26:15.118] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:26:15.121] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:26:15.124] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[16:26:16.662] <TB3> INFO: DUT info:
[16:26:16.662] <TB3> INFO: The DUT currently contains the following objects:
[16:26:16.662] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:26:16.662] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:26:16.662] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:26:16.662] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:26:16.662] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.662] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.662] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.662] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.662] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.662] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:16.663] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:26:17.064] <TB3> INFO: enter 'restricted' command line mode
[16:26:17.064] <TB3> INFO: enter test to run
[16:26:17.064] <TB3> INFO: test: HighRate no parameter change
[16:26:17.064] <TB3> INFO: running: highrate
[16:26:17.065] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[16:26:17.220] <TB3> INFO: ----------------------------------------------------------------------
[16:26:17.220] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:26:17.220] <TB3> INFO: ----------------------------------------------------------------------
[16:26:17.835] <TB3> INFO: Expecting 208000 events.
[16:26:43.074] <TB3> INFO: 208000 events read in total (24709ms).
[16:26:43.090] <TB3> INFO: Test took 25864ms.
[16:26:43.980] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:26:44.489] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2
[16:26:44.489] <TB3> INFO: number of red-efficiency pixels: 966 760 917 1784 2237 3316 2602 3300 3618 3250 3494 2972 2359 1021 1234 1218
[16:26:44.489] <TB3> INFO: number of X-ray hits detected: 299288 316406 267219 489857 551303 717918 615011 697483 748367 696959 770090 654950 573761 318227 358295 345051
[16:26:44.489] <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:26:44.489] <TB3> INFO: number of Vcal hits detected: 206748 207132 206471 205133 203713 199051 202409 200289 197433 199489 197627 200902 203741 206088 206469 206350
[16:26:44.489] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.6 99.4 98.8 98.3 96.2 97.7 96.6 95.4 96.4 95.6 97.0 98.2 99.3 99.3 99.3
[16:26:44.489] <TB3> INFO: Vcal hit overall efficiency (%): 99.4 99.6 99.3 98.6 97.9 95.7 97.3 96.3 94.9 95.9 95.0 96.6 98.0 99.1 99.3 99.2
[16:26:44.489] <TB3> INFO: X-ray hit rate [MHz/cm2]: 87.7 92.7 78.3 143.6 161.6 210.4 180.3 204.4 219.4 204.3 225.7 192.0 168.2 93.3 105.0 101.1
[16:26:44.489] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:26:44.515] <TB3> INFO: PixTest:: pg_setup set to default.
[16:26:44.551] <TB3> INFO: enter test to run
[16:26:44.551] <TB3> INFO: test: no parameter change
[16:26:44.709] <TB3> QUIET: Connection to board 121 closed.
[16:26:44.792] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:27:19.012] <TB3> INFO: *** Welcome to pxar ***
[16:27:19.012] <TB3> INFO: *** Today: 2015/09/04
[16:27:19.012] <TB3> INFO: readRocDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//dacParameters35_C15.dat
[16:27:19.013] <TB3> INFO: readTbmDacs: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//tbmParameters_C0b.dat
[16:27:19.013] <TB3> INFO: readMaskFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//defaultMaskFile.dat
[16:27:19.013] <TB3> INFO: readTrimFile: /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//trimParameters35_C15.dat
[16:27:19.093] <TB3> INFO: clk: 4
[16:27:19.093] <TB3> INFO: ctr: 4
[16:27:19.093] <TB3> INFO: sda: 19
[16:27:19.093] <TB3> INFO: tin: 9
[16:27:19.093] <TB3> INFO: level: 15
[16:27:19.093] <TB3> INFO: triggerdelay: 0
[16:27:19.093] <TB3> QUIET: Instanciating API for pxar prod-10
[16:27:19.093] <TB3> INFO: Log level: INFO
[16:27:19.107] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:27:19.125] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:27:19.128] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:27:19.130] <TB3> INFO: RPC call hashes of host and DTB match: 397073690
[16:27:20.659] <TB3> INFO: DUT info:
[16:27:20.659] <TB3> INFO: The DUT currently contains the following objects:
[16:27:20.659] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:27:20.659] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:27:20.659] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:27:20.659] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:27:20.659] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.659] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.660] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.660] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:20.660] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:27:21.061] <TB3> INFO: enter 'restricted' command line mode
[16:27:21.061] <TB3> INFO: enter test to run
[16:27:21.061] <TB3> INFO: test: HighRate no parameter change
[16:27:21.061] <TB3> INFO: running: highrate
[16:27:21.061] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2102_XrayQualification_2015-09-04_17h08m_1441379300//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[16:27:21.223] <TB3> INFO: ----------------------------------------------------------------------
[16:27:21.223] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:27:21.223] <TB3> INFO: ----------------------------------------------------------------------
[16:27:21.831] <TB3> INFO: Expecting 208000 events.
[16:27:47.369] <TB3> INFO: 208000 events read in total (25008ms).
[16:27:47.386] <TB3> INFO: Test took 26157ms.
[16:27:48.282] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:48.790] <TB3> INFO: number of dead pixels (per ROC): 2 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2
[16:27:48.790] <TB3> INFO: number of red-efficiency pixels: 1064 812 983 1979 2380 3423 2789 3448 3698 3354 3614 2991 2512 1080 1365 1290
[16:27:48.790] <TB3> INFO: number of X-ray hits detected: 310897 330293 280559 505482 568007 735528 634281 717341 771678 718851 787957 673704 588988 333364 371287 355550
[16:27:48.790] <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:27:48.790] <TB3> INFO: number of Vcal hits detected: 206624 207073 206277 204782 203397 198647 201859 199565 196741 198707 196808 200686 203364 205988 206277 206234
[16:27:48.790] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.4 99.6 99.3 98.7 98.1 96.1 97.4 96.3 95.1 96.1 95.2 96.9 98.0 99.2 99.2 99.3
[16:27:48.790] <TB3> INFO: Vcal hit overall efficiency (%): 99.3 99.6 99.2 98.5 97.8 95.5 97.0 95.9 94.6 95.5 94.6 96.5 97.8 99.0 99.2 99.2
[16:27:48.790] <TB3> INFO: X-ray hit rate [MHz/cm2]: 91.1 96.8 82.2 148.2 166.5 215.6 185.9 210.3 226.2 210.7 231.0 197.5 172.6 97.7 108.8 104.2
[16:27:48.790] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:27:48.815] <TB3> INFO: PixTest:: pg_setup set to default.
[16:27:48.850] <TB3> INFO: enter test to run
[16:27:48.850] <TB3> INFO: test: no parameter change
[16:27:49.013] <TB3> QUIET: Connection to board 121 closed.
[16:27:49.092] <TB3> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master