Test Date: 2015-08-11 12:52
Analysis date: 2016-05-26 00:47
Logfile
commander_PixelAlive.log
[10:54:12.019] <TB3> INFO: *** Welcome to pxar ***
[10:54:12.019] <TB3> INFO: *** Today: 2015/08/11
[10:54:12.019] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//000_PixelAlive_p17//dacParameters35_C15.dat
[10:54:12.019] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//000_PixelAlive_p17//tbmParameters_C0b.dat
[10:54:12.020] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//000_PixelAlive_p17//defaultMaskFile.dat
[10:54:12.020] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//000_PixelAlive_p17//trimParameters35_C15.dat
[10:54:12.091] <TB3> INFO: clk: 4
[10:54:12.091] <TB3> INFO: ctr: 4
[10:54:12.091] <TB3> INFO: sda: 19
[10:54:12.091] <TB3> INFO: tin: 9
[10:54:12.091] <TB3> INFO: level: 15
[10:54:12.091] <TB3> INFO: triggerdelay: 0
[10:54:12.091] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[10:54:12.091] <TB3> INFO: Log level: INFO
[10:54:13.104] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:54:16.126] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:54:16.129] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:54:16.132] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[10:54:17.661] <TB3> INFO: DUT info:
[10:54:17.661] <TB3> INFO: The DUT currently contains the following objects:
[10:54:17.661] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:54:17.661] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:54:17.661] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:54:17.661] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:54:17.661] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.661] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.662] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.662] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.662] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.662] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:17.662] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:54:18.074] <TB3> INFO: enter 'restricted' command line mode
[10:54:18.074] <TB3> INFO: enter test to run
[10:54:18.074] <TB3> INFO: test: PixelAlive no parameter change
[10:54:18.074] <TB3> INFO: running: pixelalive
[10:54:18.079] <TB3> INFO: ######################################################################
[10:54:18.079] <TB3> INFO: PixTestAlive::doTest()
[10:54:18.079] <TB3> INFO: ######################################################################
[10:54:18.080] <TB3> INFO: ----------------------------------------------------------------------
[10:54:18.080] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:54:18.080] <TB3> INFO: ----------------------------------------------------------------------
[10:54:20.604] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 0 Number of ROCs (3) != Token Chain Length (4)

[10:54:20.604] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 1 Number of ROCs (2) != Token Chain Length (4)

[10:54:20.604] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 15 readouts!

[10:54:21.692] <TB3> INFO: Test took 3610ms.
[10:54:21.709] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:54:21.955] <TB3> INFO: PixTestAlive::aliveTest() done with 3 decoding errors
[10:54:21.955] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 3 0 0 0 2 0 0 0 11 0 0 0 0
[10:54:21.956] <TB3> INFO: ----------------------------------------------------------------------
[10:54:21.956] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:54:21.956] <TB3> INFO: ----------------------------------------------------------------------
[10:54:24.751] <TB3> INFO: Test took 2793ms.
[10:54:24.752] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:54:24.753] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:54:24.973] <TB3> INFO: PixTestAlive::maskTest() done
[10:54:24.973] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:54:24.974] <TB3> INFO: ----------------------------------------------------------------------
[10:54:24.974] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:54:24.974] <TB3> INFO: ----------------------------------------------------------------------
[10:54:28.554] <TB3> INFO: Test took 3579ms.
[10:54:28.572] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[10:54:28.794] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[10:54:28.794] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:54:28.794] <TB3> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[10:54:28.826] <TB3> INFO: enter test to run
[10:54:28.826] <TB3> INFO: test: no parameter change
[10:54:28.965] <TB3> QUIET: Connection to board 121 closed.
[10:54:29.045] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[10:59:38.295] <TB3> INFO: *** Welcome to pxar ***
[10:59:38.295] <TB3> INFO: *** Today: 2015/08/11
[10:59:38.295] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//dacParameters35_C15.dat
[10:59:38.297] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[10:59:38.297] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//defaultMaskFile.dat
[10:59:38.297] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C15.dat
[10:59:38.377] <TB3> INFO: clk: 4
[10:59:38.377] <TB3> INFO: ctr: 4
[10:59:38.377] <TB3> INFO: sda: 19
[10:59:38.377] <TB3> INFO: tin: 9
[10:59:38.377] <TB3> INFO: level: 15
[10:59:38.377] <TB3> INFO: triggerdelay: 0
[10:59:38.377] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[10:59:38.377] <TB3> INFO: Log level: INFO
[10:59:39.387] <TB3> INFO: Found DTB DTB_WWV6Z5
[10:59:42.410] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[10:59:42.413] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[10:59:42.416] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[10:59:43.961] <TB3> INFO: DUT info:
[10:59:43.961] <TB3> INFO: The DUT currently contains the following objects:
[10:59:43.961] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[10:59:43.961] <TB3> INFO: TBM Core alpha (0): 7 registers set
[10:59:43.961] <TB3> INFO: TBM Core beta (1): 7 registers set
[10:59:43.961] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:59:43.961] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.961] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.961] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.961] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.961] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.961] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.961] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.961] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.962] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.962] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.962] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.962] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.962] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.962] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.962] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:43.962] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:59:44.363] <TB3> INFO: enter 'restricted' command line mode
[10:59:44.363] <TB3> INFO: enter test to run
[10:59:44.363] <TB3> INFO: test: delay setting parameters: ->5<-
[10:59:44.363] <TB3> INFO: delay test by 5 seconds...
[10:59:49.363] <TB3> INFO: enter test to run
[10:59:49.363] <TB3> INFO: test: highrate no parameter change
[10:59:49.363] <TB3> INFO: running: highrate
[10:59:49.364] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[10:59:49.562] <TB3> INFO: ----------------------------------------------------------------------
[10:59:49.562] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[10:59:49.562] <TB3> INFO: ----------------------------------------------------------------------
[10:59:49.562] <TB3> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[10:59:49.562] <TB3> INFO: edge/corner pixel THR is adjusted
[10:59:49.562] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[10:59:50.525] <TB3> INFO: Collecting data for 1 seconds...
[10:59:51.526] <TB3> INFO: Done with hot pixel readout
[10:59:57.460] <TB3> INFO: PixTest:: pg_setup set to default.
[10:59:57.462] <TB3> INFO: 15 hot pixels found in step 0
[10:59:58.425] <TB3> INFO: Collecting data for 1 seconds...
[10:59:59.426] <TB3> INFO: Done with hot pixel readout
[11:00:05.318] <TB3> INFO: PixTest:: pg_setup set to default.
[11:00:05.319] <TB3> INFO: 8 hot pixels found in step 1
[11:00:06.282] <TB3> INFO: Collecting data for 1 seconds...
[11:00:07.284] <TB3> INFO: Done with hot pixel readout
[11:00:13.009] <TB3> INFO: PixTest:: pg_setup set to default.
[11:00:13.010] <TB3> INFO: 1 hot pixels found in step 2
[11:00:13.973] <TB3> INFO: Collecting data for 1 seconds...
[11:00:14.975] <TB3> INFO: Done with hot pixel readout
[11:00:20.818] <TB3> INFO: PixTest:: pg_setup set to default.
[11:00:20.819] <TB3> INFO: 0 hot pixels found in step 3
[11:00:20.829] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[11:00:20.869] <TB3> INFO: PixTest::trimHotPixels() done
[11:00:20.869] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C0.dat
[11:00:20.879] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C1.dat
[11:00:20.890] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C2.dat
[11:00:20.900] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C3.dat
[11:00:20.911] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C4.dat
[11:00:20.920] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C5.dat
[11:00:20.930] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C6.dat
[11:00:20.940] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C7.dat
[11:00:20.950] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C8.dat
[11:00:20.960] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C9.dat
[11:00:20.971] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C10.dat
[11:00:20.981] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C11.dat
[11:00:20.988] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C12.dat
[11:00:20.997] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C13.dat
[11:00:21.004] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C14.dat
[11:00:21.012] <TB3> INFO: write trim parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//trimParameters35_C15.dat
[11:00:21.022] <TB3> INFO: write masked pixels into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//002_RetrimHotPixels_150//defaultMaskFile.dat
[11:00:21.054] <TB3> INFO: enter test to run
[11:00:21.054] <TB3> INFO: test: no parameter change
[11:00:21.232] <TB3> QUIET: Connection to board 121 closed.
[11:00:21.311] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[11:00:58.784] <TB3> INFO: *** Welcome to pxar ***
[11:00:58.784] <TB3> INFO: *** Today: 2015/08/11
[11:00:58.784] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//dacParameters35_C15.dat
[11:00:58.785] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//tbmParameters_C0b.dat
[11:00:58.785] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//defaultMaskFile.dat
[11:00:58.785] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//trimParameters35_C15.dat
[11:00:58.855] <TB3> INFO: clk: 4
[11:00:58.855] <TB3> INFO: ctr: 4
[11:00:58.855] <TB3> INFO: sda: 19
[11:00:58.855] <TB3> INFO: tin: 9
[11:00:58.855] <TB3> INFO: level: 15
[11:00:58.855] <TB3> INFO: triggerdelay: 0
[11:00:58.855] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[11:00:58.855] <TB3> INFO: Log level: INFO
[11:00:59.865] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:01:02.888] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:01:02.896] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:01:02.899] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[11:01:04.460] <TB3> INFO: DUT info:
[11:01:04.460] <TB3> INFO: The DUT currently contains the following objects:
[11:01:04.460] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:01:04.460] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:01:04.460] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:01:04.460] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:01:04.460] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.460] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.461] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:01:04.862] <TB3> INFO: enter 'restricted' command line mode
[11:01:04.862] <TB3> INFO: enter test to run
[11:01:04.862] <TB3> INFO: test: delay setting parameters: ->5<-
[11:01:04.862] <TB3> INFO: delay test by 5 seconds...
[11:01:09.862] <TB3> INFO: enter test to run
[11:01:09.862] <TB3> INFO: test: Xray no parameter change
[11:01:09.862] <TB3> INFO: running: xray
[11:01:09.863] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//003_HRData_50//phCalibrationFitErr35_C15.dat
[11:01:10.019] <TB3> INFO: ######################################################################
[11:01:10.019] <TB3> INFO: PixTestXray::doTest()
[11:01:10.019] <TB3> INFO: ######################################################################
[11:01:10.020] <TB3> INFO: ----------------------------------------------------------------------
[11:01:10.020] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[11:01:10.020] <TB3> INFO: ----------------------------------------------------------------------
[11:01:10.989] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[11:01:17.838] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[11:01:42.279] <TB3> INFO: Resuming triggers.
[11:01:49.140] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[11:01:51.954] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[11:01:51.954] <TB3> WARNING: Channel 3 ROC 3: Readback start marker after 15 readouts!

[11:02:09.042] <TB3> INFO: Resuming triggers.
[11:02:15.900] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[11:02:36.259] <TB3> INFO: Resuming triggers.
[11:02:43.118] <TB3> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[11:03:04.406] <TB3> INFO: Resuming triggers.
[11:03:11.269] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[11:03:34.601] <TB3> INFO: Resuming triggers.
[11:03:41.460] <TB3> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[11:04:02.788] <TB3> INFO: Resuming triggers.
[11:04:09.654] <TB3> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[11:04:31.503] <TB3> INFO: Resuming triggers.
[11:04:38.367] <TB3> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[11:05:01.098] <TB3> INFO: Resuming triggers.
[11:05:07.959] <TB3> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[11:05:27.039] <TB3> INFO: Resuming triggers.
[11:05:33.904] <TB3> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[11:05:53.319] <TB3> INFO: Resuming triggers.
[11:06:00.184] <TB3> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[11:06:23.336] <TB3> INFO: Resuming triggers.
[11:06:30.200] <TB3> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[11:06:52.877] <TB3> INFO: Resuming triggers.
[11:06:59.742] <TB3> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[11:07:22.733] <TB3> INFO: Resuming triggers.
[11:07:29.595] <TB3> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[11:07:54.975] <TB3> INFO: Resuming triggers.
[11:07:59.041] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[11:08:11.802] <TB3> INFO: PixTest:: pg_setup set to default.
[11:08:11.803] <TB3> INFO: PixTestXray::doPhRun() done
[11:08:11.803] <TB3> INFO: PixTestXray::doTest() done
[11:08:11.995] <TB3> INFO: enter test to run
[11:08:11.995] <TB3> INFO: test: no parameter change
[11:08:12.213] <TB3> QUIET: Connection to board 121 closed.
[11:08:12.293] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[11:09:36.352] <TB3> INFO: *** Welcome to pxar ***
[11:09:36.352] <TB3> INFO: *** Today: 2015/08/11
[11:09:36.352] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//dacParameters35_C15.dat
[11:09:36.353] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//tbmParameters_C0b.dat
[11:09:36.353] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//defaultMaskFile.dat
[11:09:36.353] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//trimParameters35_C15.dat
[11:09:36.435] <TB3> INFO: clk: 4
[11:09:36.435] <TB3> INFO: ctr: 4
[11:09:36.435] <TB3> INFO: sda: 19
[11:09:36.435] <TB3> INFO: tin: 9
[11:09:36.435] <TB3> INFO: level: 15
[11:09:36.435] <TB3> INFO: triggerdelay: 0
[11:09:36.435] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[11:09:36.435] <TB3> INFO: Log level: INFO
[11:09:37.446] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:09:40.469] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:09:40.472] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:09:40.475] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[11:09:42.034] <TB3> INFO: DUT info:
[11:09:42.034] <TB3> INFO: The DUT currently contains the following objects:
[11:09:42.034] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:09:42.034] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:09:42.034] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:09:42.034] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:09:42.034] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.034] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.034] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.034] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.035] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:09:42.436] <TB3> INFO: enter 'restricted' command line mode
[11:09:42.436] <TB3> INFO: enter test to run
[11:09:42.437] <TB3> INFO: test: delay setting parameters: ->5<-
[11:09:42.437] <TB3> INFO: delay test by 5 seconds...
[11:09:47.437] <TB3> INFO: enter test to run
[11:09:47.437] <TB3> INFO: test: Xray no parameter change
[11:09:47.437] <TB3> INFO: running: xray
[11:09:47.437] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//004_HRData_150//phCalibrationFitErr35_C15.dat
[11:09:47.671] <TB3> INFO: ######################################################################
[11:09:47.671] <TB3> INFO: PixTestXray::doTest()
[11:09:47.671] <TB3> INFO: ######################################################################
[11:09:47.671] <TB3> INFO: ----------------------------------------------------------------------
[11:09:47.671] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[11:09:47.671] <TB3> INFO: ----------------------------------------------------------------------
[11:09:48.641] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[11:09:52.463] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[11:10:20.091] <TB3> INFO: Resuming triggers.
[11:10:23.926] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[11:10:26.752] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (3) != Token Chain Length (4)

[11:10:26.752] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (144) != TBM ID (255)

[11:10:26.752] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (0) != Token Chain Length (4)

[11:10:26.752] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (256) != TBM ID (144)

[11:10:50.076] <TB3> INFO: Resuming triggers.
[11:10:53.904] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[11:11:19.187] <TB3> INFO: Resuming triggers.
[11:11:23.017] <TB3> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[11:11:49.180] <TB3> INFO: Resuming triggers.
[11:11:53.015] <TB3> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[11:12:17.198] <TB3> INFO: Resuming triggers.
[11:12:21.027] <TB3> INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[11:12:47.147] <TB3> INFO: Resuming triggers.
[11:12:50.980] <TB3> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[11:13:16.958] <TB3> INFO: Resuming triggers.
[11:13:20.794] <TB3> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[11:13:45.173] <TB3> INFO: Resuming triggers.
[11:13:49.006] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[11:14:14.935] <TB3> INFO: Resuming triggers.
[11:14:18.766] <TB3> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[11:14:44.127] <TB3> INFO: Resuming triggers.
[11:14:47.957] <TB3> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[11:15:10.238] <TB3> INFO: Resuming triggers.
[11:15:14.065] <TB3> INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[11:15:37.780] <TB3> INFO: Resuming triggers.
[11:15:41.613] <TB3> INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[11:16:03.344] <TB3> INFO: Resuming triggers.
[11:16:07.174] <TB3> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[11:16:29.323] <TB3> INFO: Resuming triggers.
[11:16:33.153] <TB3> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[11:16:41.181] <TB3> WARNING: Channel 2 ROC 2: Readback start marker after 7 readouts!

[11:16:41.181] <TB3> WARNING: Channel 2 ROC 2: Readback start marker after 9 readouts!

[11:16:54.009] <TB3> INFO: Resuming triggers.
[11:16:57.840] <TB3> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[11:17:23.005] <TB3> INFO: Resuming triggers.
[11:17:26.836] <TB3> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[11:17:51.354] <TB3> INFO: Resuming triggers.
[11:17:55.180] <TB3> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[11:18:15.758] <TB3> INFO: Resuming triggers.
[11:18:19.592] <TB3> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[11:18:42.681] <TB3> INFO: Resuming triggers.
[11:18:46.513] <TB3> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[11:19:10.853] <TB3> INFO: Resuming triggers.
[11:19:14.678] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[11:19:37.167] <TB3> INFO: Resuming triggers.
[11:19:40.997] <TB3> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[11:20:05.567] <TB3> INFO: Resuming triggers.
[11:20:09.397] <TB3> INFO: run duration 87 seconds, buffer almost full (81%), pausing triggers.
[11:20:33.310] <TB3> INFO: Resuming triggers.
[11:20:37.142] <TB3> INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[11:21:04.222] <TB3> INFO: Resuming triggers.
[11:21:08.048] <TB3> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[11:21:33.651] <TB3> INFO: Resuming triggers.
[11:21:37.477] <TB3> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[11:22:01.195] <TB3> INFO: Resuming triggers.
[11:22:01.740] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[11:22:04.908] <TB3> INFO: PixTest:: pg_setup set to default.
[11:22:04.909] <TB3> INFO: PixTestXray::doPhRun() done
[11:22:04.909] <TB3> INFO: PixTestXray::doTest() done
[11:22:05.095] <TB3> INFO: enter test to run
[11:22:05.095] <TB3> INFO: test: no parameter change
[11:22:05.303] <TB3> QUIET: Connection to board 121 closed.
[11:22:05.382] <TB3> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[11:24:21.431] <TB3> INFO: *** Welcome to pxar ***
[11:24:21.431] <TB3> INFO: *** Today: 2015/08/11
[11:24:21.431] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//dacParameters35_C15.dat
[11:24:21.433] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//tbmParameters_C0b.dat
[11:24:21.434] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//defaultMaskFile.dat
[11:24:21.434] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//trimParameters35_C15.dat
[11:24:21.511] <TB3> INFO: clk: 4
[11:24:21.511] <TB3> INFO: ctr: 4
[11:24:21.511] <TB3> INFO: sda: 19
[11:24:21.511] <TB3> INFO: tin: 9
[11:24:21.511] <TB3> INFO: level: 15
[11:24:21.511] <TB3> INFO: triggerdelay: 0
[11:24:21.511] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[11:24:21.511] <TB3> INFO: Log level: INFO
[11:24:22.524] <TB3> INFO: Found DTB DTB_WWV6Z5
[11:24:25.546] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[11:24:25.550] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[11:24:25.552] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[11:24:27.080] <TB3> INFO: DUT info:
[11:24:27.080] <TB3> INFO: The DUT currently contains the following objects:
[11:24:27.080] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[11:24:27.080] <TB3> INFO: TBM Core alpha (0): 7 registers set
[11:24:27.080] <TB3> INFO: TBM Core beta (1): 7 registers set
[11:24:27.080] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[11:24:27.080] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.080] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.081] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.081] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.081] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.081] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.081] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.081] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[11:24:27.481] <TB3> INFO: enter 'restricted' command line mode
[11:24:27.482] <TB3> INFO: enter test to run
[11:24:27.482] <TB3> INFO: test: Highrate no parameter change
[11:24:27.482] <TB3> INFO: running: highrate
[11:24:27.482] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[11:24:27.720] <TB3> INFO: ----------------------------------------------------------------------
[11:24:27.720] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[11:24:27.720] <TB3> INFO: ----------------------------------------------------------------------
[11:24:27.727] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 100 (1) hits flags = 384 (plus default)
[11:24:27.742] <TB3> INFO: dacScan step from 0 .. 0
[11:24:41.291] <TB3> INFO: Test took 13549ms.
[11:24:42.639] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:24:42.914] <TB3> INFO: dacScan step from 1 .. 1
[11:24:56.302] <TB3> INFO: Test took 13388ms.
[11:24:57.801] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:24:58.067] <TB3> INFO: dacScan step from 2 .. 2
[11:25:11.549] <TB3> INFO: Test took 13481ms.
[11:25:12.801] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:25:13.049] <TB3> INFO: dacScan step from 3 .. 3
[11:25:26.419] <TB3> INFO: Test took 13370ms.
[11:25:27.730] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:25:27.968] <TB3> INFO: dacScan step from 4 .. 4
[11:25:41.008] <TB3> INFO: Test took 13040ms.
[11:25:42.549] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:25:42.826] <TB3> INFO: dacScan step from 5 .. 5
[11:25:55.748] <TB3> INFO: Test took 12922ms.
[11:25:57.296] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:25:57.572] <TB3> INFO: dacScan step from 6 .. 6
[11:26:10.436] <TB3> INFO: Test took 12863ms.
[11:26:11.813] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:26:12.081] <TB3> INFO: dacScan step from 7 .. 7
[11:26:25.206] <TB3> INFO: Test took 13124ms.
[11:26:26.422] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:26:26.700] <TB3> INFO: dacScan step from 8 .. 8
[11:26:39.932] <TB3> INFO: Test took 13232ms.
[11:26:41.391] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:26:41.616] <TB3> INFO: dacScan step from 9 .. 9
[11:26:54.654] <TB3> INFO: Test took 13037ms.
[11:26:56.174] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:26:56.440] <TB3> INFO: dacScan step from 10 .. 10
[11:27:09.807] <TB3> INFO: Test took 13367ms.
[11:27:11.191] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:11.440] <TB3> INFO: dacScan step from 11 .. 11
[11:27:24.538] <TB3> INFO: Test took 13098ms.
[11:27:25.952] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:26.217] <TB3> INFO: dacScan step from 12 .. 12
[11:27:39.241] <TB3> INFO: Test took 13024ms.
[11:27:40.596] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:40.843] <TB3> INFO: dacScan step from 13 .. 13
[11:27:53.818] <TB3> INFO: Test took 12975ms.
[11:27:55.099] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:27:55.340] <TB3> INFO: dacScan step from 14 .. 14
[11:28:08.310] <TB3> INFO: Test took 12969ms.
[11:28:09.612] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:09.850] <TB3> INFO: dacScan step from 15 .. 15
[11:28:22.751] <TB3> INFO: Test took 12900ms.
[11:28:24.403] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:24.647] <TB3> INFO: dacScan step from 16 .. 16
[11:28:37.538] <TB3> INFO: Test took 12890ms.
[11:28:38.840] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:39.105] <TB3> INFO: dacScan step from 17 .. 17
[11:28:51.797] <TB3> INFO: Test took 12691ms.
[11:28:53.114] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:28:53.348] <TB3> INFO: dacScan step from 18 .. 18
[11:29:06.075] <TB3> INFO: Test took 12727ms.
[11:29:07.344] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:07.579] <TB3> INFO: dacScan step from 19 .. 19
[11:29:20.613] <TB3> INFO: Test took 13034ms.
[11:29:21.896] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:22.127] <TB3> INFO: dacScan step from 20 .. 20
[11:29:35.512] <TB3> INFO: Test took 13386ms.
[11:29:36.775] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:37.052] <TB3> INFO: dacScan step from 21 .. 21
[11:29:50.230] <TB3> INFO: Test took 13177ms.
[11:29:51.759] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:29:52.028] <TB3> INFO: dacScan step from 22 .. 22
[11:30:05.085] <TB3> INFO: Test took 13057ms.
[11:30:06.357] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:06.586] <TB3> INFO: dacScan step from 23 .. 23
[11:30:19.948] <TB3> INFO: Test took 13361ms.
[11:30:21.189] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:21.443] <TB3> INFO: dacScan step from 24 .. 24
[11:30:34.349] <TB3> INFO: Test took 12906ms.
[11:30:35.838] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:36.077] <TB3> INFO: dacScan step from 25 .. 25
[11:30:48.715] <TB3> INFO: Test took 12638ms.
[11:30:50.179] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:30:50.418] <TB3> INFO: dacScan step from 26 .. 26
[11:31:03.316] <TB3> INFO: Test took 12898ms.
[11:31:04.602] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:04.839] <TB3> INFO: dacScan step from 27 .. 27
[11:31:17.967] <TB3> INFO: Test took 13127ms.
[11:31:19.285] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:19.505] <TB3> INFO: dacScan step from 28 .. 28
[11:31:32.935] <TB3> INFO: Test took 13430ms.
[11:31:34.362] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:34.630] <TB3> INFO: dacScan step from 29 .. 29
[11:31:48.441] <TB3> INFO: Test took 13811ms.
[11:31:49.951] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:31:50.221] <TB3> INFO: dacScan step from 30 .. 30
[11:32:03.550] <TB3> INFO: Test took 13328ms.
[11:32:04.918] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:05.138] <TB3> INFO: dacScan step from 31 .. 31
[11:32:18.221] <TB3> INFO: Test took 13082ms.
[11:32:19.787] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:20.053] <TB3> INFO: dacScan step from 32 .. 32
[11:32:33.225] <TB3> INFO: Test took 13171ms.
[11:32:34.630] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:34.852] <TB3> INFO: dacScan step from 33 .. 33
[11:32:48.348] <TB3> INFO: Test took 13496ms.
[11:32:49.666] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:32:49.948] <TB3> INFO: dacScan step from 34 .. 34
[11:33:03.315] <TB3> INFO: Test took 13367ms.
[11:33:04.866] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:33:05.124] <TB3> INFO: dacScan step from 35 .. 35
[11:33:18.412] <TB3> INFO: Test took 13287ms.
[11:33:20.007] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:33:20.229] <TB3> INFO: dacScan step from 36 .. 36
[11:33:34.239] <TB3> INFO: Test took 14010ms.
[11:33:35.959] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:33:36.196] <TB3> INFO: dacScan step from 37 .. 37
[11:33:50.363] <TB3> INFO: Test took 14167ms.
[11:33:51.842] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:33:52.089] <TB3> INFO: dacScan step from 38 .. 38
[11:34:06.617] <TB3> INFO: Test took 14527ms.
[11:34:08.042] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:34:08.281] <TB3> INFO: dacScan step from 39 .. 39
[11:34:22.597] <TB3> INFO: Test took 14315ms.
[11:34:24.175] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:34:24.442] <TB3> INFO: dacScan step from 40 .. 40
[11:34:38.860] <TB3> INFO: Test took 14418ms.
[11:34:40.430] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:34:40.700] <TB3> INFO: dacScan step from 41 .. 41
[11:34:55.250] <TB3> INFO: Test took 14549ms.
[11:34:56.711] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:34:56.942] <TB3> INFO: dacScan step from 42 .. 42
[11:35:12.092] <TB3> INFO: Test took 15150ms.
[11:35:13.699] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:35:13.996] <TB3> INFO: dacScan step from 43 .. 43
[11:35:29.115] <TB3> INFO: Test took 15119ms.
[11:35:30.786] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:35:31.024] <TB3> INFO: dacScan step from 44 .. 44
[11:35:45.938] <TB3> INFO: Test took 14914ms.
[11:35:47.414] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:35:47.700] <TB3> INFO: dacScan step from 45 .. 45
[11:36:03.479] <TB3> INFO: Test took 15778ms.
[11:36:05.157] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:05.388] <TB3> INFO: dacScan step from 46 .. 46
[11:36:21.320] <TB3> INFO: Test took 15931ms.
[11:36:22.942] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:23.173] <TB3> INFO: dacScan step from 47 .. 47
[11:36:39.341] <TB3> INFO: Test took 16168ms.
[11:36:40.771] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:41.002] <TB3> INFO: dacScan step from 48 .. 48
[11:36:57.399] <TB3> INFO: Test took 16397ms.
[11:36:58.798] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:36:59.046] <TB3> INFO: dacScan step from 49 .. 49
[11:37:15.823] <TB3> INFO: Test took 16776ms.
[11:37:17.299] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:37:17.528] <TB3> INFO: dacScan step from 50 .. 50
[11:37:34.228] <TB3> INFO: Test took 16700ms.
[11:37:35.841] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:37:36.082] <TB3> INFO: dacScan step from 51 .. 51
[11:37:52.511] <TB3> INFO: Test took 16426ms.
[11:37:54.169] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:37:54.436] <TB3> INFO: dacScan step from 52 .. 52
[11:38:10.988] <TB3> INFO: Test took 16551ms.
[11:38:12.420] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:38:12.661] <TB3> INFO: dacScan step from 53 .. 53
[11:38:28.997] <TB3> INFO: Test took 16335ms.
[11:38:30.407] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:38:30.648] <TB3> INFO: dacScan step from 54 .. 54
[11:38:46.997] <TB3> INFO: Test took 16349ms.
[11:38:48.430] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:38:48.666] <TB3> INFO: dacScan step from 55 .. 55
[11:39:04.810] <TB3> INFO: Test took 16143ms.
[11:39:06.344] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:39:06.590] <TB3> INFO: dacScan step from 56 .. 56
[11:39:22.171] <TB3> INFO: Test took 15580ms.
[11:39:23.609] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:39:23.845] <TB3> INFO: dacScan step from 57 .. 57
[11:39:40.020] <TB3> INFO: Test took 16174ms.
[11:39:41.563] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:39:41.803] <TB3> INFO: dacScan step from 58 .. 58
[11:39:58.245] <TB3> INFO: Test took 16441ms.
[11:39:59.755] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:39:59.980] <TB3> INFO: dacScan step from 59 .. 59
[11:40:16.000] <TB3> INFO: Test took 16021ms.
[11:40:17.512] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:40:17.749] <TB3> INFO: dacScan step from 60 .. 60
[11:40:34.059] <TB3> INFO: Test took 16309ms.
[11:40:35.764] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:40:36.038] <TB3> INFO: dacScan step from 61 .. 61
[11:40:52.473] <TB3> INFO: Test took 16435ms.
[11:40:53.849] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:40:54.070] <TB3> INFO: dacScan step from 62 .. 62
[11:41:10.429] <TB3> INFO: Test took 16358ms.
[11:41:11.810] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:41:12.048] <TB3> INFO: dacScan step from 63 .. 63
[11:41:27.832] <TB3> INFO: Test took 15783ms.
[11:41:29.555] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:41:29.785] <TB3> INFO: dacScan step from 64 .. 64
[11:41:46.200] <TB3> INFO: Test took 16414ms.
[11:41:47.774] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:41:48.050] <TB3> INFO: dacScan step from 65 .. 65
[11:42:04.598] <TB3> INFO: Test took 16547ms.
[11:42:06.227] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:42:06.467] <TB3> INFO: dacScan step from 66 .. 66
[11:42:22.958] <TB3> INFO: Test took 16490ms.
[11:42:24.412] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:42:24.690] <TB3> INFO: dacScan step from 67 .. 67
[11:42:40.885] <TB3> INFO: Test took 16194ms.
[11:42:42.424] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:42:42.643] <TB3> INFO: dacScan step from 68 .. 68
[11:42:58.826] <TB3> INFO: Test took 16182ms.
[11:43:00.554] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:43:00.804] <TB3> INFO: dacScan step from 69 .. 69
[11:43:16.495] <TB3> INFO: Test took 15690ms.
[11:43:18.192] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:43:18.441] <TB3> INFO: dacScan step from 70 .. 70
[11:43:34.854] <TB3> INFO: Test took 16412ms.
[11:43:36.526] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:43:36.778] <TB3> INFO: dacScan step from 71 .. 71
[11:43:52.846] <TB3> INFO: Test took 16067ms.
[11:43:54.516] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:43:54.801] <TB3> INFO: dacScan step from 72 .. 72
[11:44:11.250] <TB3> INFO: Test took 16449ms.
[11:44:12.933] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:44:13.189] <TB3> INFO: dacScan step from 73 .. 73
[11:44:29.941] <TB3> INFO: Test took 16751ms.
[11:44:31.543] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:44:31.822] <TB3> INFO: dacScan step from 74 .. 74
[11:44:48.554] <TB3> INFO: Test took 16731ms.
[11:44:49.979] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:44:50.216] <TB3> INFO: dacScan step from 75 .. 75
[11:45:06.623] <TB3> INFO: Test took 16406ms.
[11:45:08.085] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:45:08.320] <TB3> INFO: dacScan step from 76 .. 76
[11:45:24.235] <TB3> INFO: Test took 15915ms.
[11:45:25.669] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:45:25.907] <TB3> INFO: dacScan step from 77 .. 77
[11:45:42.326] <TB3> INFO: Test took 16418ms.
[11:45:43.820] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:45:44.063] <TB3> INFO: dacScan step from 78 .. 78
[11:46:00.499] <TB3> INFO: Test took 16435ms.
[11:46:01.943] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:46:02.175] <TB3> INFO: dacScan step from 79 .. 79
[11:46:18.673] <TB3> INFO: Test took 16497ms.
[11:46:20.302] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:46:20.535] <TB3> INFO: dacScan step from 80 .. 80
[11:46:37.193] <TB3> INFO: Test took 16657ms.
[11:46:38.627] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:46:38.852] <TB3> INFO: dacScan step from 81 .. 81
[11:46:55.420] <TB3> INFO: Test took 16567ms.
[11:46:56.972] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:46:57.226] <TB3> INFO: dacScan step from 82 .. 82
[11:47:13.681] <TB3> INFO: Test took 16454ms.
[11:47:15.146] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:15.387] <TB3> INFO: dacScan step from 83 .. 83
[11:47:31.731] <TB3> INFO: Test took 16343ms.
[11:47:33.205] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:33.448] <TB3> INFO: dacScan step from 84 .. 84
[11:47:49.668] <TB3> INFO: Test took 16219ms.
[11:47:51.138] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:47:51.384] <TB3> INFO: dacScan step from 85 .. 85
[11:48:07.840] <TB3> INFO: Test took 16455ms.
[11:48:09.322] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:09.563] <TB3> INFO: dacScan step from 86 .. 86
[11:48:25.717] <TB3> INFO: Test took 16153ms.
[11:48:27.239] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:27.477] <TB3> INFO: dacScan step from 87 .. 87
[11:48:43.879] <TB3> INFO: Test took 16401ms.
[11:48:46.143] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:48:46.382] <TB3> INFO: dacScan step from 88 .. 88
[11:49:02.865] <TB3> INFO: Test took 16482ms.
[11:49:04.314] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:04.571] <TB3> INFO: dacScan step from 89 .. 89
[11:49:20.903] <TB3> INFO: Test took 16330ms.
[11:49:22.384] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:22.637] <TB3> INFO: dacScan step from 90 .. 90
[11:49:38.780] <TB3> INFO: Test took 16142ms.
[11:49:40.488] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:40.710] <TB3> INFO: dacScan step from 91 .. 91
[11:49:56.457] <TB3> INFO: Test took 15746ms.
[11:49:57.893] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:49:58.127] <TB3> INFO: dacScan step from 92 .. 92
[11:50:14.097] <TB3> INFO: Test took 15969ms.
[11:50:15.536] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:15.779] <TB3> INFO: dacScan step from 93 .. 93
[11:50:32.338] <TB3> INFO: Test took 16558ms.
[11:50:33.772] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:34.007] <TB3> INFO: dacScan step from 94 .. 94
[11:50:50.531] <TB3> INFO: Test took 16523ms.
[11:50:51.919] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:50:52.143] <TB3> INFO: dacScan step from 95 .. 95
[11:51:08.779] <TB3> INFO: Test took 16635ms.
[11:51:10.259] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:10.507] <TB3> INFO: dacScan step from 96 .. 96
[11:51:26.927] <TB3> INFO: Test took 16419ms.
[11:51:28.405] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:28.645] <TB3> INFO: dacScan step from 97 .. 97
[11:51:45.217] <TB3> INFO: Test took 16571ms.
[11:51:46.659] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:51:46.903] <TB3> INFO: dacScan step from 98 .. 98
[11:52:02.962] <TB3> INFO: Test took 16058ms.
[11:52:04.389] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:52:04.622] <TB3> INFO: dacScan step from 99 .. 99
[11:52:20.925] <TB3> INFO: Test took 16302ms.
[11:52:22.414] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:52:22.655] <TB3> INFO: dacScan step from 100 .. 100
[11:52:38.886] <TB3> INFO: Test took 16230ms.
[11:52:40.408] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[11:52:40.651] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:41.988] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:43.249] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:44.638] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:46.105] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:47.572] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:49.087] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:50.582] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:52.067] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:53.472] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:55.105] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:56.841] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:58.182] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:52:59.733] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:53:01.079] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:53:02.421] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[11:53:03.728] <TB3> INFO: PixTest:: pg_setup set to default.
[11:53:03.730] <TB3> INFO: vcal mean: 37.85 37.98 37.95 40.13 40.48 41.31 41.52 40.10 41.32 41.92 42.68 41.78 40.49 38.32 38.35 38.40
[11:53:03.730] <TB3> INFO: vcal RMS: 1.22 1.22 1.11 1.74 1.33 1.37 1.45 1.65 1.44 1.53 1.57 2.02 1.39 1.34 1.17 1.22
[11:53:03.730] <TB3> INFO: number of X-ray hits detected: 165345 167131 149767 255556 286492 332411 327538 282199 339744 355235 397456 334496 289041 174842 180829 189128
[11:53:03.730] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:53:03.730] <TB3> INFO: X-ray hit rate [MHz/cm2]: 48.5 49.0 43.9 74.9 84.0 97.4 96.0 82.7 99.6 104.1 116.5 98.0 84.7 51.2 53.0 55.4
[11:53:03.730] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[11:53:03.833] <TB3> INFO: enter test to run
[11:53:03.833] <TB3> INFO: test: no parameter change
[11:53:04.100] <TB3> QUIET: Connection to board 121 closed.
[11:53:04.179] <TB3> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[12:13:44.803] <TB3> INFO: *** Welcome to pxar ***
[12:13:44.803] <TB3> INFO: *** Today: 2015/08/11
[12:13:44.803] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[12:13:44.804] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[12:13:44.804] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[12:13:44.804] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[12:13:44.912] <TB3> INFO: clk: 4
[12:13:44.912] <TB3> INFO: ctr: 4
[12:13:44.912] <TB3> INFO: sda: 19
[12:13:44.912] <TB3> INFO: tin: 9
[12:13:44.912] <TB3> INFO: level: 15
[12:13:44.912] <TB3> INFO: triggerdelay: 0
[12:13:44.912] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:13:44.912] <TB3> INFO: Log level: INFO
[12:13:45.922] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:13:48.943] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:13:48.947] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:13:48.949] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:13:50.483] <TB3> INFO: DUT info:
[12:13:50.483] <TB3> INFO: The DUT currently contains the following objects:
[12:13:50.483] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:13:50.483] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:13:50.483] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:13:50.483] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:13:50.483] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.483] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:13:50.884] <TB3> INFO: enter 'restricted' command line mode
[12:13:50.884] <TB3> INFO: enter test to run
[12:13:50.884] <TB3> INFO: test: HighRate no parameter change
[12:13:50.884] <TB3> INFO: running: highrate
[12:13:50.885] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[12:13:51.026] <TB3> INFO: ----------------------------------------------------------------------
[12:13:51.026] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[12:13:51.026] <TB3> INFO: ----------------------------------------------------------------------
[12:13:52.110] <TB3> INFO: Test took 1078ms.
[12:13:55.917] <TB3> INFO: Test took 3802ms.
[12:13:56.052] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:59.897] <TB3> INFO: Test took 3818ms.
[12:14:00.037] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:03.750] <TB3> INFO: Test took 3685ms.
[12:14:03.891] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:07.792] <TB3> INFO: Test took 3873ms.
[12:14:07.925] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:11.763] <TB3> INFO: Test took 3813ms.
[12:14:11.920] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:15.829] <TB3> INFO: Test took 3884ms.
[12:14:15.967] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:19.837] <TB3> INFO: Test took 3845ms.
[12:14:20.027] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:24.034] <TB3> INFO: Test took 3970ms.
[12:14:24.177] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:28.107] <TB3> INFO: Test took 3904ms.
[12:14:28.296] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:32.211] <TB3> INFO: Test took 3875ms.
[12:14:32.344] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:36.411] <TB3> INFO: Test took 4042ms.
[12:14:36.562] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:40.318] <TB3> INFO: Test took 3725ms.
[12:14:40.454] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:44.294] <TB3> INFO: Test took 3814ms.
[12:14:44.427] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:48.436] <TB3> INFO: Test took 3984ms.
[12:14:48.570] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:52.435] <TB3> INFO: Test took 3840ms.
[12:14:52.582] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:14:56.583] <TB3> INFO: Test took 3974ms.
[12:14:56.736] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:00.413] <TB3> INFO: Test took 3649ms.
[12:15:00.541] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:04.138] <TB3> INFO: Test took 3572ms.
[12:15:04.264] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:08.018] <TB3> INFO: Test took 3730ms.
[12:15:08.145] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:11.613] <TB3> INFO: Test took 3443ms.
[12:15:11.736] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:15:12.032] <TB3> INFO: enter test to run
[12:15:12.032] <TB3> INFO: test: Pretest no parameter change
[12:15:12.032] <TB3> INFO: running: pretest
[12:15:12.032] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[12:15:12.032] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[12:15:12.032] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[12:15:12.032] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[12:15:12.032] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[12:15:12.032] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[12:15:12.032] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[12:15:12.033] <TB3> INFO: write dac parameters into /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[12:15:12.033] <TB3> INFO: enter test to run
[12:15:12.033] <TB3> INFO: test: no parameter change
[12:15:12.204] <TB3> QUIET: Connection to board 121 closed.
[12:15:12.283] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:15:46.336] <TB3> INFO: *** Welcome to pxar ***
[12:15:46.336] <TB3> INFO: *** Today: 2015/08/11
[12:15:46.336] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//dacParameters35_C15.dat
[12:15:46.337] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//tbmParameters_C0b.dat
[12:15:46.337] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//defaultMaskFile.dat
[12:15:46.337] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//trimParameters35_C15.dat
[12:15:46.417] <TB3> INFO: clk: 4
[12:15:46.417] <TB3> INFO: ctr: 4
[12:15:46.417] <TB3> INFO: sda: 19
[12:15:46.417] <TB3> INFO: tin: 9
[12:15:46.417] <TB3> INFO: level: 15
[12:15:46.417] <TB3> INFO: triggerdelay: 0
[12:15:46.417] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:15:46.417] <TB3> INFO: Log level: INFO
[12:15:47.429] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:15:50.451] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:15:50.455] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:15:50.458] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:15:51.983] <TB3> INFO: DUT info:
[12:15:51.983] <TB3> INFO: The DUT currently contains the following objects:
[12:15:51.983] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:15:51.983] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:15:51.983] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:15:51.983] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:15:51.983] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.983] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.984] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.984] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.984] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.984] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:51.984] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:15:52.385] <TB3> INFO: enter 'restricted' command line mode
[12:15:52.385] <TB3> INFO: enter test to run
[12:15:52.385] <TB3> INFO: test: HighRate no parameter change
[12:15:52.385] <TB3> INFO: running: highrate
[12:15:52.386] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[12:15:52.525] <TB3> INFO: ----------------------------------------------------------------------
[12:15:52.525] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:15:52.525] <TB3> INFO: ----------------------------------------------------------------------
[12:16:05.370] <TB3> INFO: Test took 12839ms.
[12:16:06.023] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:16:06.320] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 3 0 0 0 2 0 0 0 2 0 0 0 0
[12:16:06.320] <TB3> INFO: number of red-efficiency pixels: 107 96 119 161 186 271 266 182 231 281 358 299 188 121 114 127
[12:16:06.320] <TB3> INFO: number of X-ray hits detected: 81572 81903 73069 127553 141513 167643 164599 139181 169902 179203 200769 167514 144708 85235 89878 94343
[12:16:06.320] <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:16:06.320] <TB3> INFO: number of Vcal hits detected: 207889 207904 207878 207651 207806 207721 207722 207716 207762 207713 207616 207584 207803 207877 207882 207870
[12:16:06.320] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.8 99.9 99.9 100.0 99.9 99.9
[12:16:06.320] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 100.0 99.9 99.8 99.9 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.9 99.9 99.9 99.9
[12:16:06.320] <TB3> INFO: X-ray hit rate [MHz/cm2]: 23.9 24.0 21.4 37.4 41.5 49.1 48.2 40.8 49.8 52.5 58.8 49.1 42.4 25.0 26.3 27.7
[12:16:06.320] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:16:06.346] <TB3> INFO: PixTest:: pg_setup set to default.
[12:16:06.387] <TB3> INFO: enter test to run
[12:16:06.387] <TB3> INFO: test: no parameter change
[12:16:06.511] <TB3> QUIET: Connection to board 121 closed.
[12:16:06.594] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:16:40.199] <TB3> INFO: *** Welcome to pxar ***
[12:16:40.199] <TB3> INFO: *** Today: 2015/08/11
[12:16:40.199] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//dacParameters35_C15.dat
[12:16:40.201] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//tbmParameters_C0b.dat
[12:16:40.201] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//defaultMaskFile.dat
[12:16:40.201] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//trimParameters35_C15.dat
[12:16:40.276] <TB3> INFO: clk: 4
[12:16:40.276] <TB3> INFO: ctr: 4
[12:16:40.276] <TB3> INFO: sda: 19
[12:16:40.276] <TB3> INFO: tin: 9
[12:16:40.276] <TB3> INFO: level: 15
[12:16:40.276] <TB3> INFO: triggerdelay: 0
[12:16:40.276] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:16:40.276] <TB3> INFO: Log level: INFO
[12:16:41.289] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:16:44.310] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:16:44.313] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:16:44.316] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:16:45.878] <TB3> INFO: DUT info:
[12:16:45.878] <TB3> INFO: The DUT currently contains the following objects:
[12:16:45.878] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:16:45.878] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:16:45.878] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:16:45.878] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:16:45.878] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.878] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:45.879] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:16:46.280] <TB3> INFO: enter 'restricted' command line mode
[12:16:46.280] <TB3> INFO: enter test to run
[12:16:46.280] <TB3> INFO: test: HighRate no parameter change
[12:16:46.280] <TB3> INFO: running: highrate
[12:16:46.280] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[12:16:46.412] <TB3> INFO: ----------------------------------------------------------------------
[12:16:46.412] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:16:46.412] <TB3> INFO: ----------------------------------------------------------------------
[12:17:01.859] <TB3> INFO: Test took 15441ms.
[12:17:03.559] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:17:03.924] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 3 0 0 0 2 0 0 0 2 0 0 0 0
[12:17:03.924] <TB3> INFO: number of red-efficiency pixels: 304 335 334 512 613 864 869 622 838 981 1357 962 650 363 298 428
[12:17:03.924] <TB3> INFO: number of X-ray hits detected: 165789 168801 150549 257645 284738 332792 330421 283138 342560 357551 399308 334082 290014 174888 182235 190002
[12:17:03.924] <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:17:03.924] <TB3> INFO: number of Vcal hits detected: 207685 207645 207607 207256 207303 206990 206940 207200 207015 206755 206122 206701 207277 207580 207688 207536
[12:17:03.924] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.8 99.8 99.7 99.7 99.6 99.6 99.7 99.6 99.5 99.2 99.5 99.7 99.8 99.9 99.8
[12:17:03.924] <TB3> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.8 99.6 99.7 99.5 99.5 99.6 99.5 99.4 99.1 99.4 99.7 99.8 99.9 99.8
[12:17:03.924] <TB3> INFO: X-ray hit rate [MHz/cm2]: 48.6 49.5 44.1 75.5 83.5 97.5 96.8 83.0 100.4 104.8 117.0 97.9 85.0 51.3 53.4 55.7
[12:17:03.924] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:17:03.950] <TB3> INFO: PixTest:: pg_setup set to default.
[12:17:03.981] <TB3> INFO: enter test to run
[12:17:03.981] <TB3> INFO: test: no parameter change
[12:17:04.105] <TB3> QUIET: Connection to board 121 closed.
[12:17:04.184] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:17:40.383] <TB3> INFO: *** Welcome to pxar ***
[12:17:40.383] <TB3> INFO: *** Today: 2015/08/11
[12:17:40.383] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//dacParameters35_C15.dat
[12:17:40.384] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//tbmParameters_C0b.dat
[12:17:40.384] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//defaultMaskFile.dat
[12:17:40.384] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//trimParameters35_C15.dat
[12:17:40.454] <TB3> INFO: clk: 4
[12:17:40.454] <TB3> INFO: ctr: 4
[12:17:40.454] <TB3> INFO: sda: 19
[12:17:40.454] <TB3> INFO: tin: 9
[12:17:40.454] <TB3> INFO: level: 15
[12:17:40.454] <TB3> INFO: triggerdelay: 0
[12:17:40.454] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:17:40.454] <TB3> INFO: Log level: INFO
[12:17:41.466] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:17:44.489] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:17:44.492] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:17:44.495] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:17:46.048] <TB3> INFO: DUT info:
[12:17:46.048] <TB3> INFO: The DUT currently contains the following objects:
[12:17:46.048] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:17:46.048] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:17:46.048] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:17:46.048] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:17:46.049] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.049] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:46.450] <TB3> INFO: enter 'restricted' command line mode
[12:17:46.450] <TB3> INFO: enter test to run
[12:17:46.450] <TB3> INFO: test: HighRate no parameter change
[12:17:46.450] <TB3> INFO: running: highrate
[12:17:46.450] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[12:17:46.616] <TB3> INFO: ----------------------------------------------------------------------
[12:17:46.616] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:17:46.616] <TB3> INFO: ----------------------------------------------------------------------
[12:18:04.411] <TB3> INFO: Test took 17789ms.
[12:18:07.468] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:18:07.897] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 3 0 0 0 2 0 0 0 2 0 0 0 0
[12:18:07.897] <TB3> INFO: number of red-efficiency pixels: 602 626 697 1137 1300 1787 1741 1303 1863 1998 2456 1916 1345 697 631 874
[12:18:07.897] <TB3> INFO: number of X-ray hits detected: 242870 246499 220793 370381 411065 479475 476213 409074 492283 513739 571737 483670 419114 255524 264839 275418
[12:18:07.897] <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:18:07.897] <TB3> INFO: number of Vcal hits detected: 207343 207309 206976 206334 206154 205209 205178 206211 205245 204588 203143 204631 206182 207003 207310 206946
[12:18:07.897] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.7 99.6 99.4 99.2 98.9 98.8 99.3 98.8 98.6 97.9 98.6 99.2 99.6 99.7 99.5
[12:18:07.897] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.5 99.2 99.1 98.7 98.6 99.1 98.7 98.4 97.7 98.4 99.1 99.5 99.7 99.5
[12:18:07.897] <TB3> INFO: X-ray hit rate [MHz/cm2]: 71.2 72.3 64.7 108.6 120.5 140.5 139.6 119.9 144.3 150.6 167.6 141.8 122.8 74.9 77.6 80.7
[12:18:07.897] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:18:07.922] <TB3> INFO: PixTest:: pg_setup set to default.
[12:18:07.955] <TB3> INFO: enter test to run
[12:18:07.955] <TB3> INFO: test: no parameter change
[12:18:08.071] <TB3> QUIET: Connection to board 121 closed.
[12:18:08.151] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:18:42.016] <TB3> INFO: *** Welcome to pxar ***
[12:18:42.016] <TB3> INFO: *** Today: 2015/08/11
[12:18:42.017] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//dacParameters35_C15.dat
[12:18:42.017] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//tbmParameters_C0b.dat
[12:18:42.017] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//defaultMaskFile.dat
[12:18:42.017] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//trimParameters35_C15.dat
[12:18:42.091] <TB3> INFO: clk: 4
[12:18:42.091] <TB3> INFO: ctr: 4
[12:18:42.092] <TB3> INFO: sda: 19
[12:18:42.092] <TB3> INFO: tin: 9
[12:18:42.092] <TB3> INFO: level: 15
[12:18:42.092] <TB3> INFO: triggerdelay: 0
[12:18:42.092] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:18:42.092] <TB3> INFO: Log level: INFO
[12:18:43.101] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:18:46.124] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:18:46.127] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:18:46.130] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:18:47.680] <TB3> INFO: DUT info:
[12:18:47.680] <TB3> INFO: The DUT currently contains the following objects:
[12:18:47.680] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:18:47.680] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:18:47.680] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:18:47.680] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:18:47.680] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.680] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.681] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.681] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:47.681] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:18:48.082] <TB3> INFO: enter 'restricted' command line mode
[12:18:48.082] <TB3> INFO: enter test to run
[12:18:48.082] <TB3> INFO: test: HighRate no parameter change
[12:18:48.082] <TB3> INFO: running: highrate
[12:18:48.083] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[12:18:48.230] <TB3> INFO: ----------------------------------------------------------------------
[12:18:48.230] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:18:48.230] <TB3> INFO: ----------------------------------------------------------------------
[12:19:08.485] <TB3> INFO: Test took 20249ms.
[12:19:13.566] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:19:14.073] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 2 0 0 0 2 0 0 0 0
[12:19:14.073] <TB3> INFO: number of red-efficiency pixels: 1104 1189 1118 1978 2256 2983 2837 2288 3029 3113 3622 3093 2413 1124 1153 1537
[12:19:14.073] <TB3> INFO: number of X-ray hits detected: 328091 335537 300868 500518 555818 645732 640616 553253 665584 693270 767681 652139 565608 347608 360276 374575
[12:19:14.073] <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:19:14.073] <TB3> INFO: number of Vcal hits detected: 206651 206518 205844 204471 203705 201227 201236 203999 201437 199806 196065 200183 203621 205771 206550 205880
[12:19:14.073] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.4 99.3 99.2 98.6 98.2 97.2 97.2 98.3 97.2 96.5 94.9 96.8 98.1 99.1 99.4 99.1
[12:19:14.073] <TB3> INFO: Vcal hit overall efficiency (%): 99.4 99.3 99.0 98.3 97.9 96.7 96.7 98.1 96.8 96.1 94.3 96.2 97.9 98.9 99.3 99.0
[12:19:14.073] <TB3> INFO: X-ray hit rate [MHz/cm2]: 96.2 98.3 88.2 146.7 162.9 189.3 187.8 162.2 195.1 203.2 225.0 191.1 165.8 101.9 105.6 109.8
[12:19:14.073] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:19:14.099] <TB3> INFO: PixTest:: pg_setup set to default.
[12:19:14.136] <TB3> INFO: enter test to run
[12:19:14.136] <TB3> INFO: test: no parameter change
[12:19:14.274] <TB3> QUIET: Connection to board 121 closed.
[12:19:14.353] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[12:19:48.578] <TB3> INFO: *** Welcome to pxar ***
[12:19:48.578] <TB3> INFO: *** Today: 2015/08/11
[12:19:48.578] <TB3> INFO: readRocDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//dacParameters35_C15.dat
[12:19:48.579] <TB3> INFO: readTbmDacs: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//tbmParameters_C0b.dat
[12:19:48.579] <TB3> INFO: readMaskFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//defaultMaskFile.dat
[12:19:48.579] <TB3> INFO: readTrimFile: /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//trimParameters35_C15.dat
[12:19:48.660] <TB3> INFO: clk: 4
[12:19:48.660] <TB3> INFO: ctr: 4
[12:19:48.660] <TB3> INFO: sda: 19
[12:19:48.660] <TB3> INFO: tin: 9
[12:19:48.660] <TB3> INFO: level: 15
[12:19:48.660] <TB3> INFO: triggerdelay: 0
[12:19:48.660] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[12:19:48.660] <TB3> INFO: Log level: INFO
[12:19:49.669] <TB3> INFO: Found DTB DTB_WWV6Z5
[12:19:52.692] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[12:19:52.695] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[12:19:52.697] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[12:19:54.236] <TB3> INFO: DUT info:
[12:19:54.236] <TB3> INFO: The DUT currently contains the following objects:
[12:19:54.236] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[12:19:54.236] <TB3> INFO: TBM Core alpha (0): 7 registers set
[12:19:54.236] <TB3> INFO: TBM Core beta (1): 7 registers set
[12:19:54.236] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:19:54.236] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.236] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.236] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.236] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.236] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.236] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.236] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.237] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:19:54.638] <TB3> INFO: enter 'restricted' command line mode
[12:19:54.638] <TB3> INFO: enter test to run
[12:19:54.638] <TB3> INFO: test: HighRate no parameter change
[12:19:54.638] <TB3> INFO: running: highrate
[12:19:54.639] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2064_XrayQualification_2015-08-11_12h52m_1439290377//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[12:19:54.819] <TB3> INFO: ----------------------------------------------------------------------
[12:19:54.819] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:19:54.819] <TB3> INFO: ----------------------------------------------------------------------
[12:20:15.402] <TB3> INFO: Test took 20576ms.
[12:20:20.925] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[12:20:21.434] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 2 0 0 0 2 0 0 0 0
[12:20:21.434] <TB3> INFO: number of red-efficiency pixels: 1170 1301 1205 2096 2386 3070 2946 2516 3179 3234 3690 3143 2545 1174 1265 1646
[12:20:21.434] <TB3> INFO: number of X-ray hits detected: 339258 350089 313727 516285 574573 663530 662723 576512 689681 714607 788352 670974 582896 365411 374113 386037
[12:20:21.434] <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:20:21.434] <TB3> INFO: number of Vcal hits detected: 206531 206348 205650 204235 203268 200740 200776 203360 200547 199032 195359 199531 203142 205689 206421 205633
[12:20:21.434] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.4 99.3 99.1 98.4 98.1 97.0 97.0 98.0 96.8 96.2 94.6 96.5 98.0 99.1 99.3 99.0
[12:20:21.434] <TB3> INFO: Vcal hit overall efficiency (%): 99.3 99.2 98.9 98.2 97.7 96.5 96.5 97.8 96.4 95.7 93.9 95.9 97.7 98.9 99.2 98.9
[12:20:21.434] <TB3> INFO: X-ray hit rate [MHz/cm2]: 99.4 102.6 92.0 151.3 168.4 194.5 194.2 169.0 202.2 209.5 231.1 196.7 170.9 107.1 109.7 113.2
[12:20:21.434] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[12:20:21.459] <TB3> INFO: PixTest:: pg_setup set to default.
[12:20:21.494] <TB3> INFO: enter test to run
[12:20:21.494] <TB3> INFO: test: no parameter change
[12:20:21.735] <TB3> QUIET: Connection to board 121 closed.
[12:20:21.815] <TB3> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master