Test Date: 2015-09-10 11:57
Analysis date: 2016-05-26 04:01
Logfile
commander_PixelAlive.log
[09:58:20.872] <TB3> INFO: *** Welcome to pxar ***
[09:58:20.872] <TB3> INFO: *** Today: 2015/09/10
[09:58:20.872] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//000_PixelAlive_p17//dacParameters35_C15.dat
[09:58:20.874] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//000_PixelAlive_p17//tbmParameters_C0b.dat
[09:58:20.874] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//000_PixelAlive_p17//defaultMaskFile.dat
[09:58:20.874] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//000_PixelAlive_p17//trimParameters35_C15.dat
[09:58:20.949] <TB3> INFO: clk: 4
[09:58:20.949] <TB3> INFO: ctr: 4
[09:58:20.949] <TB3> INFO: sda: 19
[09:58:20.949] <TB3> INFO: tin: 9
[09:58:20.949] <TB3> INFO: level: 15
[09:58:20.949] <TB3> INFO: triggerdelay: 0
[09:58:20.949] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[09:58:20.949] <TB3> INFO: Log level: INFO
[09:58:20.962] <TB3> INFO: Found DTB DTB_WWV6Z5
[09:58:20.976] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[09:58:20.979] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[09:58:20.981] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[09:58:22.517] <TB3> INFO: DUT info:
[09:58:22.518] <TB3> INFO: The DUT currently contains the following objects:
[09:58:22.518] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:58:22.518] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:58:22.518] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:58:22.518] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:58:22.518] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.518] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:58:22.919] <TB3> INFO: enter 'restricted' command line mode
[09:58:22.919] <TB3> INFO: enter test to run
[09:58:22.919] <TB3> INFO: test: PixelAlive no parameter change
[09:58:22.919] <TB3> INFO: running: pixelalive
[09:58:22.926] <TB3> INFO: ######################################################################
[09:58:22.926] <TB3> INFO: PixTestAlive::doTest()
[09:58:22.926] <TB3> INFO: ######################################################################
[09:58:22.927] <TB3> INFO: ----------------------------------------------------------------------
[09:58:22.928] <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)
[09:58:22.928] <TB3> INFO: ----------------------------------------------------------------------
[09:58:23.237] <TB3> INFO: Expecting 41600 events.
[09:58:27.796] <TB3> INFO: 41600 events read in total (3840ms).
[09:58:27.876] <TB3> INFO: Test took 4948ms.
[09:58:27.883] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:58:28.128] <TB3> INFO: PixTestAlive::aliveTest() done
[09:58:28.128] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 1 1 0 1 0 0 0 1 0 0 1 0
[09:58:28.130] <TB3> INFO: ----------------------------------------------------------------------
[09:58:28.130] <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)
[09:58:28.130] <TB3> INFO: ----------------------------------------------------------------------
[09:58:28.430] <TB3> INFO: Expecting 41600 events.
[09:58:31.599] <TB3> INFO: 41600 events read in total (2453ms).
[09:58:31.599] <TB3> INFO: Test took 3468ms.
[09:58:31.599] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:58:31.600] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:58:31.909] <TB3> INFO: PixTestAlive::maskTest() done
[09:58:31.909] <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
[09:58:31.910] <TB3> INFO: ----------------------------------------------------------------------
[09:58:31.910] <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)
[09:58:31.910] <TB3> INFO: ----------------------------------------------------------------------
[09:58:32.206] <TB3> INFO: Expecting 41600 events.
[09:58:36.564] <TB3> INFO: 41600 events read in total (3643ms).
[09:58:36.565] <TB3> INFO: Test took 4653ms.
[09:58:36.571] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:58:36.859] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[09:58:36.859] <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
[09:58:36.859] <TB3> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[09:58:36.890] <TB3> INFO: enter test to run
[09:58:36.890] <TB3> INFO: test: no parameter change
[09:58:37.042] <TB3> QUIET: Connection to board 121 closed.
[09:58:37.122] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[12:13:32.486] <TB3> INFO: *** Welcome to pxar ***
[12:13:32.486] <TB3> INFO: *** Today: 2015/09/10
[12:13:32.486] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//dacParameters35_C15.dat
[12:13:32.487] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//tbmParameters_C0b.dat
[12:13:32.487] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//defaultMaskFile.dat
[12:13:32.487] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C15.dat
[12:13:32.564] <TB3> INFO: clk: 4
[12:13:32.564] <TB3> INFO: ctr: 4
[12:13:32.564] <TB3> INFO: sda: 19
[12:13:32.564] <TB3> INFO: tin: 9
[12:13:32.564] <TB3> INFO: level: 15
[12:13:32.564] <TB3> INFO: triggerdelay: 0
[12:13:32.564] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[12:13:32.564] <TB3> INFO: Log level: INFO
[12:13:33.574] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:13:36.587] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:13:36.590] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:13:36.593] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:13:38.114] <TB3> INFO: DUT info:
[12:13:38.114] <TB3> INFO: The DUT currently contains the following objects:
[12:13:38.114] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:13:38.114] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:13:38.114] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:13:38.114] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:13:38.115] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.115] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:38.516] <TB3> INFO: enter 'restricted' command line mode
[12:13:38.516] <TB3> INFO: enter test to run
[12:13:38.516] <TB3> INFO: test: delay setting parameters: ->5<-
[12:13:38.516] <TB3> INFO: delay test by 5 seconds...
[12:13:43.517] <TB3> INFO: enter test to run
[12:13:43.517] <TB3> INFO: test: highrate no parameter change
[12:13:43.517] <TB3> INFO: running: highrate
[12:13:43.517] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[12:13:43.683] <TB3> INFO: ----------------------------------------------------------------------
[12:13:43.683] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:13:43.683] <TB3> INFO: ----------------------------------------------------------------------
[12:13:43.683] <TB3> INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:13:43.683] <TB3> INFO: edge/corner pixel THR is adjusted
[12:13:43.683] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[12:13:44.644] <TB3> INFO: Collecting data for 1 seconds...
[12:13:45.646] <TB3> INFO: Done with hot pixel readout
[12:13:52.672] <TB3> INFO: PixTest:: pg_setup set to default.
[12:13:52.673] <TB3> INFO: 3 hot pixels found in step 0
[12:13:53.636] <TB3> INFO: Collecting data for 1 seconds...
[12:13:54.638] <TB3> INFO: Done with hot pixel readout
[12:14:01.750] <TB3> INFO: PixTest:: pg_setup set to default.
[12:14:01.751] <TB3> INFO: 3 hot pixels found in step 1
[12:14:02.713] <TB3> INFO: Collecting data for 1 seconds...
[12:14:03.714] <TB3> INFO: Done with hot pixel readout
[12:14:10.689] <TB3> INFO: PixTest:: pg_setup set to default.
[12:14:10.690] <TB3> INFO: 2 hot pixels found in step 2
[12:14:11.651] <TB3> INFO: Collecting data for 1 seconds...
[12:14:12.653] <TB3> INFO: Done with hot pixel readout
[12:14:18.757] <TB3> INFO: PixTest:: pg_setup set to default.
[12:14:18.758] <TB3> INFO: 1 hot pixels found in step 3
[12:14:19.720] <TB3> INFO: Collecting data for 1 seconds...
[12:14:20.721] <TB3> INFO: Done with hot pixel readout
[12:14:26.808] <TB3> INFO: PixTest:: pg_setup set to default.
[12:14:26.809] <TB3> INFO: 1 hot pixels found in step 4
[12:14:27.770] <TB3> INFO: Collecting data for 1 seconds...
[12:14:28.771] <TB3> INFO: Done with hot pixel readout
[12:14:35.112] <TB3> INFO: PixTest:: pg_setup set to default.
[12:14:35.113] <TB3> INFO: 1 hot pixels found in step 5
[12:14:36.075] <TB3> INFO: Collecting data for 1 seconds...
[12:14:37.076] <TB3> INFO: Done with hot pixel readout
[12:14:43.197] <TB3> INFO: PixTest:: pg_setup set to default.
[12:14:43.198] <TB3> INFO: 0 hot pixels found in step 6
[12:14:43.205] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[12:14:43.235] <TB3> INFO: PixTest::trimHotPixels() done
[12:14:43.235] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C0.dat
[12:14:43.241] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C1.dat
[12:14:43.247] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C2.dat
[12:14:43.254] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C3.dat
[12:14:43.261] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C4.dat
[12:14:43.267] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C5.dat
[12:14:43.273] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C6.dat
[12:14:43.279] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C7.dat
[12:14:43.285] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C8.dat
[12:14:43.291] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C9.dat
[12:14:43.297] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C10.dat
[12:14:43.305] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C11.dat
[12:14:43.311] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C12.dat
[12:14:43.317] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C13.dat
[12:14:43.323] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C14.dat
[12:14:43.329] <TB3> INFO: write trim parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//trimParameters35_C15.dat
[12:14:43.336] <TB3> INFO: write masked pixels into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//001_RetrimHotPixels_150//defaultMaskFile.dat
[12:14:43.367] <TB3> INFO: enter test to run
[12:14:43.367] <TB3> INFO: test: no parameter change
[12:14:43.521] <TB3> QUIET: Connection to board 121 closed.
[12:14:43.601] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[10:05:20.278] <TB3> INFO: *** Welcome to pxar ***
[10:05:20.278] <TB3> INFO: *** Today: 2015/09/10
[10:05:20.278] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//dacParameters35_C15.dat
[10:05:20.279] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//tbmParameters_C0b.dat
[10:05:20.279] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//defaultMaskFile.dat
[10:05:20.279] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//trimParameters35_C15.dat
[10:05:20.363] <TB3> INFO: clk: 4
[10:05:20.363] <TB3> INFO: ctr: 4
[10:05:20.363] <TB3> INFO: sda: 19
[10:05:20.363] <TB3> INFO: tin: 9
[10:05:20.363] <TB3> INFO: level: 15
[10:05:20.363] <TB3> INFO: triggerdelay: 0
[10:05:20.363] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[10:05:20.363] <TB3> INFO: Log level: INFO
[10:05:21.373] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:05:24.385] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:05:24.388] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:05:24.391] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:05:25.929] <TB3> INFO: DUT info:
[10:05:25.929] <TB3> INFO: The DUT currently contains the following objects:
[10:05:25.929] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:05:25.929] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:05:25.929] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:05:25.929] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:05:25.929] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.929] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:25.930] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:05:26.331] <TB3> INFO: enter 'restricted' command line mode
[10:05:26.331] <TB3> INFO: enter test to run
[10:05:26.331] <TB3> INFO: test: delay setting parameters: ->5<-
[10:05:26.331] <TB3> INFO: delay test by 5 seconds...
[10:05:31.331] <TB3> INFO: enter test to run
[10:05:31.331] <TB3> INFO: test: Xray no parameter change
[10:05:31.332] <TB3> INFO: running: xray
[10:05:31.332] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//003_HRData_50//phCalibrationFitErr35_C15.dat
[10:05:31.514] <TB3> INFO: ######################################################################
[10:05:31.514] <TB3> INFO: PixTestXray::doTest()
[10:05:31.514] <TB3> INFO: ######################################################################
[10:05:31.514] <TB3> INFO: ----------------------------------------------------------------------
[10:05:31.514] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[10:05:31.514] <TB3> INFO: ----------------------------------------------------------------------
[10:05:32.484] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[10:05:39.160] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[10:06:07.161] <TB3> INFO: Resuming triggers.
[10:06:13.843] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[10:06:43.179] <TB3> INFO: Resuming triggers.
[10:06:49.868] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[10:07:18.376] <TB3> INFO: Resuming triggers.
[10:07:25.062] <TB3> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[10:07:53.770] <TB3> INFO: Resuming triggers.
[10:08:00.456] <TB3> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[10:08:30.639] <TB3> INFO: Resuming triggers.
[10:08:37.322] <TB3> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[10:09:06.272] <TB3> INFO: Resuming triggers.
[10:09:12.953] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[10:09:41.176] <TB3> INFO: Resuming triggers.
[10:09:47.858] <TB3> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[10:10:16.519] <TB3> INFO: Resuming triggers.
[10:10:23.204] <TB3> INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[10:10:52.251] <TB3> INFO: Resuming triggers.
[10:10:58.934] <TB3> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[10:11:27.205] <TB3> INFO: Resuming triggers.
[10:11:33.886] <TB3> INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[10:12:02.181] <TB3> INFO: Resuming triggers.
[10:12:08.865] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[10:12:37.289] <TB3> INFO: Resuming triggers.
[10:12:43.970] <TB3> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[10:13:15.086] <TB3> INFO: Resuming triggers.
[10:13:21.765] <TB3> INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[10:13:50.892] <TB3> INFO: Resuming triggers.
[10:13:57.418] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[10:14:26.242] <TB3> INFO: PixTest:: pg_setup set to default.
[10:14:26.243] <TB3> INFO: PixTestXray::doPhRun() done
[10:14:26.244] <TB3> INFO: PixTestXray::doTest() done
[10:14:26.448] <TB3> INFO: enter test to run
[10:14:26.448] <TB3> INFO: test: no parameter change
[10:14:26.637] <TB3> QUIET: Connection to board 121 closed.
[10:14:26.720] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[10:16:50.853] <TB3> INFO: *** Welcome to pxar ***
[10:16:50.853] <TB3> INFO: *** Today: 2015/09/10
[10:16:50.853] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//dacParameters35_C15.dat
[10:16:50.854] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//tbmParameters_C0b.dat
[10:16:50.854] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//defaultMaskFile.dat
[10:16:50.854] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//trimParameters35_C15.dat
[10:16:50.946] <TB3> INFO: clk: 4
[10:16:50.946] <TB3> INFO: ctr: 4
[10:16:50.946] <TB3> INFO: sda: 19
[10:16:50.946] <TB3> INFO: tin: 9
[10:16:50.946] <TB3> INFO: level: 15
[10:16:50.946] <TB3> INFO: triggerdelay: 0
[10:16:50.947] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[10:16:50.947] <TB3> INFO: Log level: INFO
[10:16:51.958] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:16:54.970] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:16:54.973] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:16:54.976] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:16:56.515] <TB3> INFO: DUT info:
[10:16:56.515] <TB3> INFO: The DUT currently contains the following objects:
[10:16:56.515] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:16:56.515] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:16:56.515] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:16:56.515] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:16:56.515] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.515] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.515] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.516] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:16:56.917] <TB3> INFO: enter 'restricted' command line mode
[10:16:56.917] <TB3> INFO: enter test to run
[10:16:56.917] <TB3> INFO: test: delay setting parameters: ->5<-
[10:16:56.917] <TB3> INFO: delay test by 5 seconds...
[10:17:01.917] <TB3> INFO: enter test to run
[10:17:01.917] <TB3> INFO: test: Xray no parameter change
[10:17:01.918] <TB3> INFO: running: xray
[10:17:01.918] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//004_HRData_150//phCalibrationFitErr35_C15.dat
[10:17:02.071] <TB3> INFO: ######################################################################
[10:17:02.071] <TB3> INFO: PixTestXray::doTest()
[10:17:02.071] <TB3> INFO: ######################################################################
[10:17:02.071] <TB3> INFO: ----------------------------------------------------------------------
[10:17:02.071] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[10:17:02.071] <TB3> INFO: ----------------------------------------------------------------------
[10:17:03.038] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[10:17:06.735] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[10:17:35.207] <TB3> INFO: Resuming triggers.
[10:17:38.917] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[10:18:07.063] <TB3> INFO: Resuming triggers.
[10:18:10.777] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[10:18:39.745] <TB3> INFO: Resuming triggers.
[10:18:43.456] <TB3> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[10:19:12.344] <TB3> INFO: Resuming triggers.
[10:19:16.057] <TB3> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[10:19:44.990] <TB3> INFO: Resuming triggers.
[10:19:48.702] <TB3> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[10:20:19.695] <TB3> INFO: Resuming triggers.
[10:20:23.409] <TB3> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[10:20:52.941] <TB3> INFO: Resuming triggers.
[10:20:56.652] <TB3> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[10:21:26.144] <TB3> INFO: Resuming triggers.
[10:21:29.855] <TB3> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[10:21:58.939] <TB3> INFO: Resuming triggers.
[10:22:02.651] <TB3> INFO: run duration 37 seconds, buffer almost full (81%), pausing triggers.
[10:22:31.680] <TB3> INFO: Resuming triggers.
[10:22:35.391] <TB3> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[10:23:05.011] <TB3> INFO: Resuming triggers.
[10:23:08.721] <TB3> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[10:23:39.882] <TB3> INFO: Resuming triggers.
[10:23:43.594] <TB3> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[10:24:14.585] <TB3> INFO: Resuming triggers.
[10:24:18.295] <TB3> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[10:24:47.803] <TB3> INFO: Resuming triggers.
[10:24:51.513] <TB3> INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[10:25:19.947] <TB3> INFO: Resuming triggers.
[10:25:23.660] <TB3> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[10:25:52.388] <TB3> INFO: Resuming triggers.
[10:25:56.097] <TB3> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[10:26:24.855] <TB3> INFO: Resuming triggers.
[10:26:28.562] <TB3> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[10:26:55.998] <TB3> INFO: Resuming triggers.
[10:26:59.708] <TB3> INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[10:27:29.625] <TB3> INFO: Resuming triggers.
[10:27:33.334] <TB3> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[10:28:04.147] <TB3> INFO: Resuming triggers.
[10:28:07.858] <TB3> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[10:28:37.604] <TB3> INFO: Resuming triggers.
[10:28:41.311] <TB3> INFO: run duration 81 seconds, buffer almost full (81%), pausing triggers.
[10:29:11.442] <TB3> INFO: Resuming triggers.
[10:29:15.153] <TB3> INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[10:29:43.084] <TB3> INFO: Resuming triggers.
[10:29:46.793] <TB3> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[10:29:55.707] <TB3> WARNING: Channel 2 ROC 3: Readback start marker after 2 readouts!

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a233 8040 4e18 162 2844 28c 204d 310 2065 305 2a82 340 264d 689 2463 4e18 542 2a4c 61a 2044 60c 224e 753 242f 4e18 1b 2463 441 2263 848 2829 4e18 c4 2a6f 290 2869 685 2662 854 2a43 e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a22d 80c0 4e18 812 2241 4e18 415 2a4f 4e18 d9 2265 209 2a41 403 2867 50b 2864 759 244c 4e18 53 2481 14d 2448 2cd 286d 312 2268 615 266f e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a22e 8000 4e18 4e1a 611 262e 700 2843 858 2a48 4e1a 9c 2661 c5 202f c1 2a4f 35b 206f 69b 2480 680 2a4f 71c 2a49 4e1a cc 224f dd 2287 2d3 2880 65d 264f e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a22f 8040 4e1a 55a 2265 812 2041 4e19 c0 2840 351 204f 81b 246f 4e19 850 2a4c 4e19 319 2082 318 2880 35c 2a4f e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a230 80b0 4e19 818 2262 4e18 649 284e 4e18 4e1b 286f 543 2865 641 286c 4e18 451 2668 714 204d e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a231 80c0 4e18 60 2644 290 2042 64b 264f 750 224c 4e18 24b 2041 4e19 58 2064 14a 246c 30c 2644 648 2468 751 2845 749 2264 84a 282d 4e19 15 224d e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a232 8000 4e18 604 2628 4e19 d5 2a4c 14a 2081 14a 22a0 2cb 286f 482 2a2c 51d 2a6e 844 264f 4e18 4c8 264c 6da 284f 4e19 348 2645 e000 c000

[10:29:55.707] <TB3> WARNING: Channel 2 ROC 3: Readback start marker after 14 readouts!

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a241 80c0 4e18 e1 2a4d 452 2448 4e18 460 204c 4e19 819 284f 4e19 14b 244e 41b 264d fff 2fff e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a23b 8040 4e18 35b 2a69 753 2a4c 4e18 45 2864 315 2461 75d 2048 75d 224f 4e18 103 246a 34b 2068 44d 2a4f 4e19 e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a23c 80b0 4e18 28a 242c 512 222f 4e18 e0 2a69 2c3 246e 2c3 2664 408 2869 4e18 4e18 15 2068 551 2243 658 2a4f e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a23d 80c0 4e18 315 204c 4e18 11 2241 15c 2861 551 264e 6c5 2042 4e18 143 2488 6cc 222f 80d 2083 4e18 41b 2649 55d 262d e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a23e 8000 4e18 71a 2844 4e1a 653 2464 4e1a 489 202d 55a 2265 4e1a c8 2644 50d 2a4e 55c 2441 759 2461 e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a23f 8040 4e1a 0 284a 3 264d 650 284a 713 224c 4e19 c8 2847 4e19 120 2a88 654 2442 692 2a85 4e19 31a 286d fff 2fff e000 c000

[10:29:55.707] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a240 80b0 4e19 4 244a 114 2649 4e18 50b 2068 70c 260c 4e18 35d 2269 4e18 d 2461 45 2465 8c 2465 160 244f 514 2847 e000 c000

[10:30:15.540] <TB3> INFO: Resuming triggers.
[10:30:19.249] <TB3> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[10:30:47.726] <TB3> INFO: Resuming triggers.
[10:30:51.432] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[10:31:20.807] <TB3> INFO: Resuming triggers.
[10:31:24.428] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[10:31:52.970] <TB3> INFO: PixTest:: pg_setup set to default.
[10:31:52.971] <TB3> INFO: PixTestXray::doPhRun() done
[10:31:52.971] <TB3> INFO: PixTestXray::doTest() done
[10:31:53.164] <TB3> INFO: enter test to run
[10:31:53.164] <TB3> INFO: test: no parameter change
[10:31:53.343] <TB3> QUIET: Connection to board 121 closed.
[10:31:53.422] <TB3> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[10:36:06.096] <TB3> INFO: *** Welcome to pxar ***
[10:36:06.096] <TB3> INFO: *** Today: 2015/09/10
[10:36:06.096] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//dacParameters35_C15.dat
[10:36:06.097] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//tbmParameters_C0b.dat
[10:36:06.097] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//defaultMaskFile.dat
[10:36:06.097] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//trimParameters35_C15.dat
[10:36:06.171] <TB3> INFO: clk: 4
[10:36:06.171] <TB3> INFO: ctr: 4
[10:36:06.171] <TB3> INFO: sda: 19
[10:36:06.171] <TB3> INFO: tin: 9
[10:36:06.171] <TB3> INFO: level: 15
[10:36:06.171] <TB3> INFO: triggerdelay: 0
[10:36:06.171] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[10:36:06.171] <TB3> INFO: Log level: INFO
[10:36:07.180] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:36:10.193] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:36:10.196] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:36:10.199] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[10:36:11.717] <TB3> INFO: DUT info:
[10:36:11.717] <TB3> INFO: The DUT currently contains the following objects:
[10:36:11.717] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:36:11.717] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:36:11.717] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:36:11.717] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:36:11.717] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:11.717] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:36:12.124] <TB3> INFO: enter 'restricted' command line mode
[10:36:12.124] <TB3> INFO: enter test to run
[10:36:12.124] <TB3> INFO: test: Highrate no parameter change
[10:36:12.124] <TB3> INFO: running: highrate
[10:36:12.124] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualification_2015-09-10_11h57m_1441879041//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[10:36:12.293] <TB3> INFO: ----------------------------------------------------------------------
[10:36:12.293] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[10:36:12.293] <TB3> INFO: ----------------------------------------------------------------------
[10:36:12.299] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 15 .. 75 (20/-1) hits flags = 896 (plus default)
[10:36:12.311] <TB3> INFO: dacScan step from 15 .. 34
[10:36:12.311] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:36:12.311] <TB3> INFO: run 1 of 1
[10:36:12.926] <TB3> INFO: Expecting 4160000 events.
[10:36:47.613] <TB3> INFO: 465650 events read in total (34157ms).
[10:37:22.098] <TB3> INFO: 933050 events read in total (68642ms).
[10:37:56.663] <TB3> INFO: 1400500 events read in total (103207ms).
[10:38:30.963] <TB3> INFO: 1867950 events read in total (137507ms).
[10:39:04.489] <TB3> INFO: 2335200 events read in total (171033ms).
[10:39:38.410] <TB3> INFO: 2802200 events read in total (204954ms).
[10:40:11.503] <TB3> INFO: 3269450 events read in total (238047ms).
[10:40:45.792] <TB3> INFO: 3736650 events read in total (272336ms).
[10:41:15.151] <TB3> INFO: 4160000 events read in total (301695ms).
[10:41:15.366] <TB3> INFO: Test took 303055ms.
[10:41:17.392] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:41:22.780] <TB3> INFO: dacScan step from 35 .. 54
[10:41:22.780] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:41:22.780] <TB3> INFO: run 1 of 1
[10:41:23.384] <TB3> INFO: Expecting 4160000 events.
[10:41:56.369] <TB3> INFO: 386700 events read in total (32458ms).
[10:42:28.610] <TB3> INFO: 774300 events read in total (64699ms).
[10:43:01.659] <TB3> INFO: 1161150 events read in total (97748ms).
[10:43:33.228] <TB3> INFO: 1546700 events read in total (129317ms).
[10:44:06.515] <TB3> INFO: 1931400 events read in total (162604ms).
[10:44:38.686] <TB3> INFO: 2313950 events read in total (194775ms).
[10:45:10.608] <TB3> INFO: 2693850 events read in total (226697ms).
[10:45:42.035] <TB3> INFO: 3070650 events read in total (258124ms).
[10:46:13.772] <TB3> INFO: 3444750 events read in total (289861ms).
[10:46:46.036] <TB3> INFO: 3817150 events read in total (322125ms).
[10:47:14.969] <TB3> INFO: 4160000 events read in total (351058ms).
[10:47:15.148] <TB3> INFO: Test took 352367ms.
[10:47:16.685] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:47:22.300] <TB3> INFO: dacScan step from 55 .. 74
[10:47:22.300] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:47:22.300] <TB3> INFO: run 1 of 1
[10:47:22.903] <TB3> INFO: Expecting 4160000 events.
[10:47:55.331] <TB3> INFO: 343550 events read in total (31901ms).
[10:48:26.948] <TB3> INFO: 687800 events read in total (63518ms).
[10:48:58.553] <TB3> INFO: 1031950 events read in total (95123ms).
[10:49:29.693] <TB3> INFO: 1376100 events read in total (126263ms).
[10:50:00.603] <TB3> INFO: 1720350 events read in total (157173ms).
[10:50:31.390] <TB3> INFO: 2064700 events read in total (187960ms).
[10:51:02.367] <TB3> INFO: 2409150 events read in total (218938ms).
[10:51:33.233] <TB3> INFO: 2753550 events read in total (249803ms).
[10:52:05.218] <TB3> INFO: 3097750 events read in total (281788ms).
[10:52:37.620] <TB3> INFO: 3442100 events read in total (314190ms).
[10:53:08.993] <TB3> INFO: 3786500 events read in total (345563ms).
[10:53:39.592] <TB3> INFO: 4130600 events read in total (376162ms).
[10:53:42.531] <TB3> INFO: 4160000 events read in total (379101ms).
[10:53:42.710] <TB3> INFO: Test took 380410ms.
[10:53:44.604] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:53:49.884] <TB3> INFO: dacScan step from 75 .. 75
[10:53:49.884] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[10:53:49.884] <TB3> INFO: run 1 of 1
[10:53:50.484] <TB3> INFO: Expecting 208000 events.
[10:54:09.792] <TB3> INFO: 208000 events read in total (18781ms).
[10:54:09.799] <TB3> INFO: Test took 19914ms.
[10:54:09.878] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:54:10.128] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:11.319] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:12.360] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:13.417] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:14.576] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:15.788] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:16.967] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:18.082] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:19.149] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:20.212] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:21.309] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:22.384] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:23.438] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:24.505] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:25.575] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:26.619] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[10:54:27.710] <TB3> INFO: PixTest:: pg_setup set to default.
[10:54:27.713] <TB3> INFO: vcal mean: 37.90 37.96 38.13 40.64 40.24 42.80 41.67 41.67 42.49 42.05 43.26 41.25 41.61 38.46 38.97 38.62
[10:54:27.713] <TB3> INFO: vcal RMS: 1.12 1.36 0.87 1.36 1.29 1.41 1.38 1.51 1.34 1.32 1.46 1.52 1.28 1.15 1.11 0.99
[10:54:27.713] <TB3> INFO: number of X-ray hits detected: 157567 182859 158411 283439 293316 372858 329514 335797 360677 369092 414280 312668 312486 176854 199899 178594
[10:54:27.713] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:54:27.713] <TB3> INFO: X-ray hit rate [MHz/cm2]: 46.2 53.6 46.4 83.1 86.0 109.3 96.6 98.4 105.7 108.2 121.4 91.6 91.6 51.8 58.6 52.3
[10:54:27.713] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[10:54:27.815] <TB3> INFO: enter test to run
[10:54:27.815] <TB3> INFO: test: no parameter change
[10:54:27.981] <TB3> QUIET: Connection to board 121 closed.
[10:54:28.063] <TB3> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[12:20:23.900] <TB3> INFO: *** Welcome to pxar ***
[12:20:23.900] <TB3> INFO: *** Today: 2015/09/10
[12:20:23.900] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[12:20:23.901] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[12:20:23.901] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[12:20:23.901] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[12:20:23.987] <TB3> INFO: clk: 4
[12:20:23.987] <TB3> INFO: ctr: 4
[12:20:23.987] <TB3> INFO: sda: 19
[12:20:23.987] <TB3> INFO: tin: 9
[12:20:23.987] <TB3> INFO: level: 15
[12:20:23.987] <TB3> INFO: triggerdelay: 0
[12:20:23.987] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[12:20:23.987] <TB3> INFO: Log level: INFO
[12:20:24.997] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:20:28.008] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:20:28.012] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:20:28.014] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:20:29.542] <TB3> INFO: DUT info:
[12:20:29.542] <TB3> INFO: The DUT currently contains the following objects:
[12:20:29.542] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:20:29.542] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:20:29.542] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:20:29.542] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:20:29.542] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.542] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:20:29.950] <TB3> INFO: enter 'restricted' command line mode
[12:20:29.950] <TB3> INFO: enter test to run
[12:20:29.951] <TB3> INFO: test: HighRate no parameter change
[12:20:29.951] <TB3> INFO: running: highrate
[12:20:29.951] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[12:20:30.132] <TB3> INFO: ----------------------------------------------------------------------
[12:20:30.132] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[12:20:30.132] <TB3> INFO: ----------------------------------------------------------------------
[12:20:30.270] <TB3> INFO: Expecting 768 events.
[12:20:31.497] <TB3> INFO: 768 events read in total (509ms).
[12:20:31.592] <TB3> INFO: Test took 1454ms.
[12:20:32.207] <TB3> INFO: Expecting 41600 events.
[12:20:36.122] <TB3> INFO: 41600 events read in total (3388ms).
[12:20:36.124] <TB3> INFO: Test took 4527ms.
[12:20:36.198] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:20:36.837] <TB3> INFO: Expecting 41600 events.
[12:20:40.949] <TB3> INFO: 41600 events read in total (3586ms).
[12:20:40.951] <TB3> INFO: Test took 4727ms.
[12:20:41.027] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:20:41.682] <TB3> INFO: Expecting 41600 events.
[12:20:45.704] <TB3> INFO: 41600 events read in total (3494ms).
[12:20:45.706] <TB3> INFO: Test took 4652ms.
[12:20:45.786] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:20:46.429] <TB3> INFO: Expecting 41600 events.
[12:20:50.470] <TB3> INFO: 41600 events read in total (3514ms).
[12:20:50.472] <TB3> INFO: Test took 4655ms.
[12:20:50.542] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:20:51.197] <TB3> INFO: Expecting 41600 events.
[12:20:55.322] <TB3> INFO: 41600 events read in total (3598ms).
[12:20:55.324] <TB3> INFO: Test took 4750ms.
[12:20:55.400] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:20:56.059] <TB3> INFO: Expecting 41600 events.
[12:21:00.203] <TB3> INFO: 41600 events read in total (3617ms).
[12:21:00.204] <TB3> INFO: Test took 4769ms.
[12:21:00.277] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:00.918] <TB3> INFO: Expecting 41600 events.
[12:21:05.212] <TB3> INFO: 41600 events read in total (3766ms).
[12:21:05.214] <TB3> INFO: Test took 4908ms.
[12:21:05.285] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:05.930] <TB3> INFO: Expecting 41600 events.
[12:21:10.166] <TB3> INFO: 41600 events read in total (3709ms).
[12:21:10.168] <TB3> INFO: Test took 4849ms.
[12:21:10.237] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:10.876] <TB3> INFO: Expecting 41600 events.
[12:21:15.090] <TB3> INFO: 41600 events read in total (3687ms).
[12:21:15.092] <TB3> INFO: Test took 4829ms.
[12:21:15.164] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:15.804] <TB3> INFO: Expecting 41600 events.
[12:21:20.030] <TB3> INFO: 41600 events read in total (3699ms).
[12:21:20.032] <TB3> INFO: Test took 4840ms.
[12:21:20.101] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:20.748] <TB3> INFO: Expecting 41600 events.
[12:21:24.931] <TB3> INFO: 41600 events read in total (3656ms).
[12:21:24.933] <TB3> INFO: Test took 4804ms.
[12:21:25.010] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:25.667] <TB3> INFO: Expecting 41600 events.
[12:21:29.927] <TB3> INFO: 41600 events read in total (3733ms).
[12:21:29.928] <TB3> INFO: Test took 4886ms.
[12:21:30.001] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:30.640] <TB3> INFO: Expecting 41600 events.
[12:21:34.824] <TB3> INFO: 41600 events read in total (3656ms).
[12:21:34.826] <TB3> INFO: Test took 4798ms.
[12:21:34.897] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:35.539] <TB3> INFO: Expecting 41600 events.
[12:21:39.773] <TB3> INFO: 41600 events read in total (3707ms).
[12:21:39.774] <TB3> INFO: Test took 4847ms.
[12:21:39.855] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:40.508] <TB3> INFO: Expecting 41600 events.
[12:21:44.797] <TB3> INFO: 41600 events read in total (3762ms).
[12:21:44.799] <TB3> INFO: Test took 4913ms.
[12:21:44.877] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:45.518] <TB3> INFO: Expecting 41600 events.
[12:21:49.756] <TB3> INFO: 41600 events read in total (3711ms).
[12:21:49.758] <TB3> INFO: Test took 4853ms.
[12:21:49.842] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:50.489] <TB3> INFO: Expecting 41600 events.
[12:21:54.599] <TB3> INFO: 41600 events read in total (3583ms).
[12:21:54.601] <TB3> INFO: Test took 4726ms.
[12:21:54.673] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:21:55.327] <TB3> INFO: Expecting 41600 events.
[12:21:59.768] <TB3> INFO: 41600 events read in total (3914ms).
[12:21:59.770] <TB3> INFO: Test took 5070ms.
[12:21:59.846] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:22:00.488] <TB3> INFO: Expecting 41600 events.
[12:22:04.312] <TB3> INFO: 41600 events read in total (3297ms).
[12:22:04.314] <TB3> INFO: Test took 4441ms.
[12:22:04.387] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:22:05.024] <TB3> INFO: Expecting 41600 events.
[12:22:08.659] <TB3> INFO: 41600 events read in total (3107ms).
[12:22:08.661] <TB3> INFO: Test took 4248ms.
[12:22:08.730] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:22:09.032] <TB3> INFO: enter test to run
[12:22:09.032] <TB3> INFO: test: Pretest no parameter change
[12:22:09.032] <TB3> INFO: running: pretest
[12:22:09.033] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[12:22:09.033] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[12:22:09.033] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[12:22:09.033] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[12:22:09.033] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[12:22:09.033] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[12:22:09.033] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[12:22:09.033] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[12:22:09.034] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[12:22:09.034] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[12:22:09.034] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[12:22:09.034] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[12:22:09.034] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[12:22:09.034] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[12:22:09.034] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[12:22:09.034] <TB3> INFO: write dac parameters into /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//003_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[12:22:09.034] <TB3> INFO: enter test to run
[12:22:09.034] <TB3> INFO: test: no parameter change
[12:22:09.243] <TB3> QUIET: Connection to board 121 closed.
[12:22:09.323] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:22:42.673] <TB3> INFO: *** Welcome to pxar ***
[12:22:42.674] <TB3> INFO: *** Today: 2015/09/10
[12:22:42.674] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//dacParameters35_C15.dat
[12:22:42.675] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//tbmParameters_C0b.dat
[12:22:42.675] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//defaultMaskFile.dat
[12:22:42.675] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//trimParameters35_C15.dat
[12:22:42.765] <TB3> INFO: clk: 4
[12:22:42.765] <TB3> INFO: ctr: 4
[12:22:42.765] <TB3> INFO: sda: 19
[12:22:42.765] <TB3> INFO: tin: 9
[12:22:42.765] <TB3> INFO: level: 15
[12:22:42.765] <TB3> INFO: triggerdelay: 0
[12:22:42.765] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[12:22:42.765] <TB3> INFO: Log level: INFO
[12:22:43.775] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:22:46.788] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:22:46.791] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:22:46.793] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:22:48.335] <TB3> INFO: DUT info:
[12:22:48.335] <TB3> INFO: The DUT currently contains the following objects:
[12:22:48.335] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:22:48.335] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:22:48.335] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:22:48.335] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:22:48.335] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.335] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:22:48.736] <TB3> INFO: enter 'restricted' command line mode
[12:22:48.736] <TB3> INFO: enter test to run
[12:22:48.736] <TB3> INFO: test: HighRate no parameter change
[12:22:48.736] <TB3> INFO: running: highrate
[12:22:48.737] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//004_HREfficiency_50//phCalibrationFitErr35_C15.dat
[12:22:48.985] <TB3> INFO: ----------------------------------------------------------------------
[12:22:48.985] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:22:48.985] <TB3> INFO: ----------------------------------------------------------------------
[12:22:49.589] <TB3> INFO: Expecting 208000 events.
[12:23:04.082] <TB3> INFO: 208000 events read in total (13964ms).
[12:23:04.088] <TB3> INFO: Test took 15097ms.
[12:23:04.335] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:23:04.636] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 1 0 0 0 0 0 0 1 0 0 0 0
[12:23:04.636] <TB3> INFO: number of red-efficiency pixels: 116 119 86 178 225 281 232 233 315 345 374 222 229 145 133 126
[12:23:04.636] <TB3> INFO: number of X-ray hits detected: 77958 89827 78524 141912 148982 188558 167166 169952 183390 188765 212480 158079 159283 87583 99232 88481
[12:23:04.636] <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
[12:23:04.636] <TB3> INFO: number of Vcal hits detected: 207858 207730 207911 207817 207719 207706 207758 207754 207661 207634 207599 207712 207764 207848 207861 207873
[12:23:04.636] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 100.0 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[12:23:04.636] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 100.0 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[12:23:04.636] <TB3> INFO: X-ray hit rate [MHz/cm2]: 22.9 26.3 23.0 41.6 43.7 55.3 49.0 49.8 53.8 55.3 62.3 46.3 46.7 25.7 29.1 25.9
[12:23:04.636] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:23:04.662] <TB3> INFO: PixTest:: pg_setup set to default.
[12:23:04.693] <TB3> INFO: enter test to run
[12:23:04.693] <TB3> INFO: test: no parameter change
[12:23:04.823] <TB3> QUIET: Connection to board 121 closed.
[12:23:04.904] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:23:39.378] <TB3> INFO: *** Welcome to pxar ***
[12:23:39.378] <TB3> INFO: *** Today: 2015/09/10
[12:23:39.378] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//dacParameters35_C15.dat
[12:23:39.379] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//tbmParameters_C0b.dat
[12:23:39.380] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//defaultMaskFile.dat
[12:23:39.380] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//trimParameters35_C15.dat
[12:23:39.461] <TB3> INFO: clk: 4
[12:23:39.461] <TB3> INFO: ctr: 4
[12:23:39.461] <TB3> INFO: sda: 19
[12:23:39.461] <TB3> INFO: tin: 9
[12:23:39.461] <TB3> INFO: level: 15
[12:23:39.461] <TB3> INFO: triggerdelay: 0
[12:23:39.461] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[12:23:39.461] <TB3> INFO: Log level: INFO
[12:23:40.471] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:23:43.484] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:23:43.487] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:23:43.490] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:23:45.022] <TB3> INFO: DUT info:
[12:23:45.022] <TB3> INFO: The DUT currently contains the following objects:
[12:23:45.022] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:23:45.022] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:23:45.022] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:23:45.022] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:23:45.022] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.022] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:23:45.423] <TB3> INFO: enter 'restricted' command line mode
[12:23:45.423] <TB3> INFO: enter test to run
[12:23:45.423] <TB3> INFO: test: HighRate no parameter change
[12:23:45.423] <TB3> INFO: running: highrate
[12:23:45.423] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//005_HREfficiency_100//phCalibrationFitErr35_C15.dat
[12:23:45.580] <TB3> INFO: ----------------------------------------------------------------------
[12:23:45.580] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:23:45.580] <TB3> INFO: ----------------------------------------------------------------------
[12:23:46.189] <TB3> INFO: Expecting 208000 events.
[12:24:04.541] <TB3> INFO: 208000 events read in total (17822ms).
[12:24:04.551] <TB3> INFO: Test took 18965ms.
[12:24:05.031] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:24:05.408] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 1 0 0 0 0 0 0 1 0 0 0 0
[12:24:05.408] <TB3> INFO: number of red-efficiency pixels: 318 412 291 627 865 1028 876 820 1016 1105 1438 792 789 393 368 308
[12:24:05.408] <TB3> INFO: number of X-ray hits detected: 158258 183213 158768 282053 297192 373765 334281 339916 363518 374661 416333 315820 318976 176985 201032 178911
[12:24:05.408] <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
[12:24:05.408] <TB3> INFO: number of Vcal hits detected: 207641 207415 207674 207289 206883 206728 206977 207055 206735 206580 206014 207010 207077 207536 207604 207671
[12:24:05.408] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.9 99.7 99.6 99.5 99.6 99.6 99.4 99.4 99.2 99.6 99.6 99.8 99.8 99.9
[12:24:05.408] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.7 99.8 99.7 99.5 99.4 99.5 99.5 99.4 99.3 99.0 99.5 99.6 99.8 99.8 99.8
[12:24:05.408] <TB3> INFO: X-ray hit rate [MHz/cm2]: 46.4 53.7 46.5 82.7 87.1 109.6 98.0 99.6 106.5 109.8 122.0 92.6 93.5 51.9 58.9 52.4
[12:24:05.408] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:24:05.434] <TB3> INFO: PixTest:: pg_setup set to default.
[12:24:05.466] <TB3> INFO: enter test to run
[12:24:05.466] <TB3> INFO: test: no parameter change
[12:24:05.599] <TB3> QUIET: Connection to board 121 closed.
[12:24:05.679] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:24:41.062] <TB3> INFO: *** Welcome to pxar ***
[12:24:41.062] <TB3> INFO: *** Today: 2015/09/10
[12:24:41.062] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//dacParameters35_C15.dat
[12:24:41.062] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//tbmParameters_C0b.dat
[12:24:41.062] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//defaultMaskFile.dat
[12:24:41.062] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//trimParameters35_C15.dat
[12:24:41.132] <TB3> INFO: clk: 4
[12:24:41.132] <TB3> INFO: ctr: 4
[12:24:41.132] <TB3> INFO: sda: 19
[12:24:41.132] <TB3> INFO: tin: 9
[12:24:41.132] <TB3> INFO: level: 15
[12:24:41.132] <TB3> INFO: triggerdelay: 0
[12:24:41.132] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[12:24:41.132] <TB3> INFO: Log level: INFO
[12:24:42.141] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:24:45.154] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:24:45.157] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:24:45.159] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:24:46.682] <TB3> INFO: DUT info:
[12:24:46.682] <TB3> INFO: The DUT currently contains the following objects:
[12:24:46.682] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:24:46.682] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:24:46.682] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:24:46.682] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:24:46.682] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:46.682] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:24:47.083] <TB3> INFO: enter 'restricted' command line mode
[12:24:47.083] <TB3> INFO: enter test to run
[12:24:47.083] <TB3> INFO: test: HighRate no parameter change
[12:24:47.083] <TB3> INFO: running: highrate
[12:24:47.084] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//006_HREfficiency_150//phCalibrationFitErr35_C15.dat
[12:24:47.241] <TB3> INFO: ----------------------------------------------------------------------
[12:24:47.241] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:24:47.241] <TB3> INFO: ----------------------------------------------------------------------
[12:24:47.845] <TB3> INFO: Expecting 208000 events.
[12:25:09.864] <TB3> INFO: 208000 events read in total (21489ms).
[12:25:09.877] <TB3> INFO: Test took 22630ms.
[12:25:10.563] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:25:11.009] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 1 0 0 0 0 0 0 1 0 0 0 0
[12:25:11.009] <TB3> INFO: number of red-efficiency pixels: 617 755 556 1198 1763 2149 1761 1846 2084 2189 2677 1588 1583 679 718 666
[12:25:11.009] <TB3> INFO: number of X-ray hits detected: 231468 268965 231592 405512 427460 535714 477655 488891 520086 535977 593886 451741 455704 257432 290920 257622
[12:25:11.009] <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
[12:25:11.009] <TB3> INFO: number of Vcal hits detected: 207299 207004 207225 206397 205123 204365 205168 205330 204645 204203 202664 205486 205739 206950 207175 207232
[12:25:11.009] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.6 99.7 99.3 98.8 98.5 98.8 98.8 98.5 98.4 97.8 99.0 99.0 99.6 99.6 99.7
[12:25:11.009] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.5 99.6 99.2 98.6 98.3 98.6 98.7 98.4 98.2 97.4 98.8 98.9 99.5 99.6 99.6
[12:25:11.009] <TB3> INFO: X-ray hit rate [MHz/cm2]: 67.8 78.8 67.9 118.9 125.3 157.0 140.0 143.3 152.4 157.1 174.1 132.4 133.6 75.5 85.3 75.5
[12:25:11.009] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:25:11.038] <TB3> INFO: PixTest:: pg_setup set to default.
[12:25:11.083] <TB3> INFO: enter test to run
[12:25:11.083] <TB3> INFO: test: no parameter change
[12:25:11.244] <TB3> QUIET: Connection to board 121 closed.
[12:25:11.860] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:25:47.264] <TB3> INFO: *** Welcome to pxar ***
[12:25:47.264] <TB3> INFO: *** Today: 2015/09/10
[12:25:47.264] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//dacParameters35_C15.dat
[12:25:47.265] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//tbmParameters_C0b.dat
[12:25:47.265] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//defaultMaskFile.dat
[12:25:47.265] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//trimParameters35_C15.dat
[12:25:47.338] <TB3> INFO: clk: 4
[12:25:47.338] <TB3> INFO: ctr: 4
[12:25:47.338] <TB3> INFO: sda: 19
[12:25:47.338] <TB3> INFO: tin: 9
[12:25:47.338] <TB3> INFO: level: 15
[12:25:47.338] <TB3> INFO: triggerdelay: 0
[12:25:47.338] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[12:25:47.338] <TB3> INFO: Log level: INFO
[12:25:48.348] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:25:51.360] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:25:51.363] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:25:51.365] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:25:52.889] <TB3> INFO: DUT info:
[12:25:52.889] <TB3> INFO: The DUT currently contains the following objects:
[12:25:52.889] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:25:52.889] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:25:52.889] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:25:52.889] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:25:52.889] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:52.889] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:25:53.290] <TB3> INFO: enter 'restricted' command line mode
[12:25:53.290] <TB3> INFO: enter test to run
[12:25:53.290] <TB3> INFO: test: HighRate no parameter change
[12:25:53.290] <TB3> INFO: running: highrate
[12:25:53.290] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//007_HREfficiency_200//phCalibrationFitErr35_C15.dat
[12:25:53.447] <TB3> INFO: ----------------------------------------------------------------------
[12:25:53.447] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:25:53.447] <TB3> INFO: ----------------------------------------------------------------------
[12:25:54.064] <TB3> INFO: Expecting 208000 events.
[12:26:21.352] <TB3> INFO: 208000 events read in total (26759ms).
[12:26:21.368] <TB3> INFO: Test took 27916ms.
[12:26:22.275] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:26:22.786] <TB3> INFO: number of dead pixels (per ROC): 0 3 0 0 1 0 0 0 0 0 0 1 0 0 0 0
[12:26:22.786] <TB3> INFO: number of red-efficiency pixels: 1111 1406 917 2221 2794 3283 2777 3099 3361 3370 3720 2645 2696 1248 1272 1224
[12:26:22.786] <TB3> INFO: number of X-ray hits detected: 316024 366783 314463 546174 573289 715031 640898 658999 695363 718104 792916 605949 613360 349532 395554 348756
[12:26:22.786] <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
[12:26:22.786] <TB3> INFO: number of Vcal hits detected: 206624 206003 206357 204044 201666 199479 201648 201514 199691 198639 195511 202373 202529 205367 206349 206395
[12:26:22.786] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.4 99.2 99.4 98.3 97.4 96.4 97.4 97.2 96.3 96.0 94.7 97.7 97.7 99.0 99.3 99.3
[12:26:22.786] <TB3> INFO: Vcal hit overall efficiency (%): 99.3 99.0 99.2 98.1 97.0 95.9 96.9 96.9 96.0 95.5 94.0 97.3 97.4 98.7 99.2 99.2
[12:26:22.786] <TB3> INFO: X-ray hit rate [MHz/cm2]: 92.6 107.5 92.2 160.1 168.0 209.6 187.9 193.2 203.8 210.5 232.4 177.6 179.8 102.5 115.9 102.2
[12:26:22.786] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:26:22.811] <TB3> INFO: PixTest:: pg_setup set to default.
[12:26:22.846] <TB3> INFO: enter test to run
[12:26:22.846] <TB3> INFO: test: no parameter change
[12:26:22.994] <TB3> QUIET: Connection to board 121 closed.
[12:26:23.073] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:26:58.386] <TB3> INFO: *** Welcome to pxar ***
[12:26:58.386] <TB3> INFO: *** Today: 2015/09/10
[12:26:58.386] <TB3> INFO: readRocDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//dacParameters35_C15.dat
[12:26:58.387] <TB3> INFO: readTbmDacs: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//tbmParameters_C0b.dat
[12:26:58.387] <TB3> INFO: readMaskFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//defaultMaskFile.dat
[12:26:58.387] <TB3> INFO: readTrimFile: /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//trimParameters35_C15.dat
[12:26:58.478] <TB3> INFO: clk: 4
[12:26:58.478] <TB3> INFO: ctr: 4
[12:26:58.478] <TB3> INFO: sda: 19
[12:26:58.478] <TB3> INFO: tin: 9
[12:26:58.478] <TB3> INFO: level: 15
[12:26:58.478] <TB3> INFO: triggerdelay: 0
[12:26:58.478] <TB3> QUIET: Instanciating API for pxar prod-10+24~g09f6d2c
[12:26:58.478] <TB3> INFO: Log level: INFO
[12:26:59.489] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:27:02.501] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:27:02.505] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:27:02.507] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[12:27:04.047] <TB3> INFO: DUT info:
[12:27:04.047] <TB3> INFO: The DUT currently contains the following objects:
[12:27:04.047] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:27:04.047] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:27:04.047] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:27:04.047] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:27:04.047] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.047] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:27:04.448] <TB3> INFO: enter 'restricted' command line mode
[12:27:04.448] <TB3> INFO: enter test to run
[12:27:04.448] <TB3> INFO: test: HighRate no parameter change
[12:27:04.448] <TB3> INFO: running: highrate
[12:27:04.448] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2097_XrayQualificationPart2_2015-09-10_14h08m_1441886880//008_HREfficiency_250//phCalibrationFitErr35_C15.dat
[12:27:04.619] <TB3> INFO: ----------------------------------------------------------------------
[12:27:04.619] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:27:04.619] <TB3> INFO: ----------------------------------------------------------------------
[12:27:05.231] <TB3> INFO: Expecting 208000 events.
[12:27:33.063] <TB3> INFO: 208000 events read in total (27303ms).
[12:27:33.082] <TB3> INFO: Test took 28456ms.
[12:27:34.030] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:27:34.554] <TB3> INFO: number of dead pixels (per ROC): 0 2 0 0 1 0 0 0 0 0 0 1 0 0 0 0
[12:27:34.554] <TB3> INFO: number of red-efficiency pixels: 1189 1544 975 2339 2929 3368 2944 3197 3445 3438 3778 2719 2784 1302 1426 1308
[12:27:34.554] <TB3> INFO: number of X-ray hits detected: 326778 378655 326585 561360 592305 732452 663165 680368 717693 737951 814116 625619 631247 362505 409954 360128
[12:27:34.554] <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
[12:27:34.554] <TB3> INFO: number of Vcal hits detected: 206481 205815 206257 203701 200999 198693 200946 200912 198940 197979 194691 201857 202285 205269 206093 206260
[12:27:34.554] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.3 99.1 99.3 98.2 97.1 96.1 97.1 96.9 96.0 95.7 94.4 97.5 97.6 98.9 99.1 99.3
[12:27:34.554] <TB3> INFO: Vcal hit overall efficiency (%): 99.3 98.9 99.2 97.9 96.6 95.5 96.6 96.6 95.6 95.2 93.6 97.0 97.3 98.7 99.1 99.2
[12:27:34.554] <TB3> INFO: X-ray hit rate [MHz/cm2]: 95.8 111.0 95.7 164.5 173.6 214.7 194.4 199.4 210.4 216.3 238.6 183.4 185.0 106.3 120.2 105.6
[12:27:34.554] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:27:34.579] <TB3> INFO: PixTest:: pg_setup set to default.
[12:27:34.614] <TB3> INFO: enter test to run
[12:27:34.614] <TB3> INFO: test: no parameter change
[12:27:34.757] <TB3> QUIET: Connection to board 121 closed.
[12:27:34.837] <TB3> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master