Test Date: 2015-08-21 17:53
Analysis date: 2016-05-26 00:31
Logfile
commander_PixelAlive.log
[15:54:21.808] <TB3> INFO: *** Welcome to pxar ***
[15:54:21.808] <TB3> INFO: *** Today: 2015/08/21
[15:54:21.808] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//dacParameters35_C15.dat
[15:54:21.808] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//tbmParameters_C0b.dat
[15:54:21.808] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//defaultMaskFile.dat
[15:54:21.808] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//000_PixelAlive_p17//trimParameters35_C15.dat
[15:54:21.878] <TB3> INFO: clk: 4
[15:54:21.878] <TB3> INFO: ctr: 4
[15:54:21.878] <TB3> INFO: sda: 19
[15:54:21.878] <TB3> INFO: tin: 9
[15:54:21.878] <TB3> INFO: level: 15
[15:54:21.878] <TB3> INFO: triggerdelay: 0
[15:54:21.878] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:54:21.878] <TB3> INFO: Log level: INFO
[15:54:21.892] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:54:21.901] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:54:21.904] <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:
------------------------------------------------------
[15:54:21.907] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[15:54:23.431] <TB3> INFO: DUT info:
[15:54:23.431] <TB3> INFO: The DUT currently contains the following objects:
[15:54:23.431] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:54:23.431] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:54:23.431] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:54:23.431] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:54:23.431] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.431] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.432] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.432] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.432] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:54:23.833] <TB3> INFO: enter 'restricted' command line mode
[15:54:23.833] <TB3> INFO: enter test to run
[15:54:23.833] <TB3> INFO: test: PixelAlive no parameter change
[15:54:23.833] <TB3> INFO: running: pixelalive
[15:54:23.840] <TB3> INFO: ######################################################################
[15:54:23.840] <TB3> INFO: PixTestAlive::doTest()
[15:54:23.840] <TB3> INFO: ######################################################################
[15:54:23.842] <TB3> INFO: ----------------------------------------------------------------------
[15:54:23.842] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:23.842] <TB3> INFO: ----------------------------------------------------------------------
[15:54:27.498] <TB3> INFO: Test took 3654ms.
[15:54:27.515] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:27.760] <TB3> INFO: PixTestAlive::aliveTest() done
[15:54:27.760] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 1 0 1 0 12 0 1 0 0 0 0
[15:54:27.761] <TB3> INFO: ----------------------------------------------------------------------
[15:54:27.761] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:27.761] <TB3> INFO: ----------------------------------------------------------------------
[15:54:30.530] <TB3> INFO: Test took 2767ms.
[15:54:30.531] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:30.531] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:54:30.751] <TB3> INFO: PixTestAlive::maskTest() done
[15:54:30.751] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:54:30.752] <TB3> INFO: ----------------------------------------------------------------------
[15:54:30.752] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:54:30.752] <TB3> INFO: ----------------------------------------------------------------------
[15:54:34.285] <TB3> INFO: Test took 3531ms.
[15:54:34.302] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:34.524] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[15:54:34.524] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:54:34.524] <TB3> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[15:54:34.552] <TB3> INFO: enter test to run
[15:54:34.552] <TB3> INFO: test: no parameter change
[15:54:34.665] <TB3> QUIET: Connection to board 121 closed.
[15:54:34.745] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[15:59:45.429] <TB3> INFO: *** Welcome to pxar ***
[15:59:45.429] <TB3> INFO: *** Today: 2015/08/21
[15:59:45.429] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:59:45.430] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:59:45.431] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:59:45.431] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:59:45.504] <TB3> INFO: clk: 4
[15:59:45.504] <TB3> INFO: ctr: 4
[15:59:45.504] <TB3> INFO: sda: 19
[15:59:45.504] <TB3> INFO: tin: 9
[15:59:45.504] <TB3> INFO: level: 15
[15:59:45.504] <TB3> INFO: triggerdelay: 0
[15:59:45.504] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:59:45.504] <TB3> INFO: Log level: INFO
[15:59:45.516] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:59:45.524] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:59:45.528] <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:
------------------------------------------------------
[15:59:45.530] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[15:59:47.092] <TB3> INFO: DUT info:
[15:59:47.092] <TB3> INFO: The DUT currently contains the following objects:
[15:59:47.092] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:59:47.092] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:59:47.092] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:59:47.092] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:59:47.092] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.092] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:59:47.493] <TB3> INFO: enter 'restricted' command line mode
[15:59:47.493] <TB3> INFO: enter test to run
[15:59:47.493] <TB3> INFO: test: delay setting parameters: ->5<-
[15:59:47.493] <TB3> INFO: delay test by 5 seconds...
[15:59:52.493] <TB3> INFO: enter test to run
[15:59:52.493] <TB3> INFO: test: highrate no parameter change
[15:59:52.493] <TB3> INFO: running: highrate
[15:59:52.494] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:59:52.644] <TB3> INFO: ----------------------------------------------------------------------
[15:59:52.644] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:59:52.644] <TB3> INFO: ----------------------------------------------------------------------
[15:59:52.644] <TB3> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[15:59:52.644] <TB3> INFO: edge/corner pixel THR is adjusted
[15:59:52.644] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:59:53.606] <TB3> INFO: Collecting data for 1 seconds...
[15:59:54.609] <TB3> INFO: Done with hot pixel readout
[16:00:00.296] <TB3> INFO: PixTest:: pg_setup set to default.
[16:00:00.297] <TB3> INFO: 26 hot pixels found in step 0
[16:00:01.260] <TB3> INFO: Collecting data for 1 seconds...
[16:00:02.262] <TB3> INFO: Done with hot pixel readout
[16:00:08.183] <TB3> INFO: PixTest:: pg_setup set to default.
[16:00:08.184] <TB3> INFO: 15 hot pixels found in step 1
[16:00:09.149] <TB3> INFO: Collecting data for 1 seconds...
[16:00:10.151] <TB3> INFO: Done with hot pixel readout
[16:00:16.177] <TB3> INFO: PixTest:: pg_setup set to default.
[16:00:16.178] <TB3> INFO: 4 hot pixels found in step 2
[16:00:17.141] <TB3> INFO: Collecting data for 1 seconds...
[16:00:18.142] <TB3> INFO: Done with hot pixel readout
[16:00:23.841] <TB3> INFO: PixTest:: pg_setup set to default.
[16:00:23.842] <TB3> INFO: 0 hot pixels found in step 3
[16:00:23.853] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[16:00:23.885] <TB3> INFO: PixTest::trimHotPixels() done
[16:00:23.885] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C0.dat
[16:00:23.892] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C1.dat
[16:00:23.899] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C2.dat
[16:00:23.906] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C3.dat
[16:00:23.913] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C4.dat
[16:00:23.920] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C5.dat
[16:00:23.927] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C6.dat
[16:00:23.933] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C7.dat
[16:00:23.940] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C8.dat
[16:00:23.947] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C9.dat
[16:00:23.954] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C10.dat
[16:00:23.961] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C11.dat
[16:00:23.967] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C12.dat
[16:00:23.974] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C13.dat
[16:00:23.981] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C14.dat
[16:00:23.988] <TB3> INFO: write trim parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//trimParameters35_C15.dat
[16:00:23.995] <TB3> INFO: write masked pixels into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//002_RetrimHotPixels_150//defaultMaskFile.dat
[16:00:24.034] <TB3> INFO: enter test to run
[16:00:24.034] <TB3> INFO: test: no parameter change
[16:00:24.213] <TB3> QUIET: Connection to board 121 closed.
[16:00:24.244] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[16:01:39.026] <TB3> INFO: *** Welcome to pxar ***
[16:01:39.026] <TB3> INFO: *** Today: 2015/08/21
[16:01:39.026] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//dacParameters35_C15.dat
[16:01:39.027] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//tbmParameters_C0b.dat
[16:01:39.028] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//defaultMaskFile.dat
[16:01:39.028] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//trimParameters35_C15.dat
[16:01:39.100] <TB3> INFO: clk: 4
[16:01:39.100] <TB3> INFO: ctr: 4
[16:01:39.100] <TB3> INFO: sda: 19
[16:01:39.100] <TB3> INFO: tin: 9
[16:01:39.100] <TB3> INFO: level: 15
[16:01:39.100] <TB3> INFO: triggerdelay: 0
[16:01:39.100] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:01:39.100] <TB3> INFO: Log level: INFO
[16:01:39.113] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:01:39.122] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:01:39.125] <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:
------------------------------------------------------
[16:01:39.128] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:01:40.662] <TB3> INFO: DUT info:
[16:01:40.662] <TB3> INFO: The DUT currently contains the following objects:
[16:01:40.662] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:01:40.662] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:01:40.662] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:01:40.662] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:01:40.662] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.662] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.662] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.662] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:40.663] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:01:41.064] <TB3> INFO: enter 'restricted' command line mode
[16:01:41.064] <TB3> INFO: enter test to run
[16:01:41.064] <TB3> INFO: test: delay setting parameters: ->5<-
[16:01:41.064] <TB3> INFO: delay test by 5 seconds...
[16:01:46.064] <TB3> INFO: enter test to run
[16:01:46.064] <TB3> INFO: test: Xray no parameter change
[16:01:46.064] <TB3> INFO: running: xray
[16:01:46.065] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//003_HRData_50//phCalibrationFitErr35_C15.dat
[16:01:46.224] <TB3> INFO: ######################################################################
[16:01:46.224] <TB3> INFO: PixTestXray::doTest()
[16:01:46.224] <TB3> INFO: ######################################################################
[16:01:46.224] <TB3> INFO: ----------------------------------------------------------------------
[16:01:46.224] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[16:01:46.224] <TB3> INFO: ----------------------------------------------------------------------
[16:01:47.194] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[16:01:54.062] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[16:02:18.557] <TB3> INFO: Resuming triggers.
[16:02:25.445] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[16:02:28.812] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (0) != Token Chain Length (4)

[16:02:28.812] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (26) != TBM ID (87)

[16:02:28.812] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (2) != Token Chain Length (4)

[16:02:28.812] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (88) != TBM ID (27)

[16:02:28.812] <TB3> WARNING: Channel 3 ROC 3: Readback start marker after 15 readouts!

[16:02:45.271] <TB3> INFO: Resuming triggers.
[16:02:52.148] <TB3> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[16:03:12.035] <TB3> INFO: Resuming triggers.
[16:03:18.909] <TB3> INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[16:03:40.004] <TB3> INFO: Resuming triggers.
[16:03:46.875] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[16:04:09.895] <TB3> INFO: Resuming triggers.
[16:04:16.763] <TB3> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[16:04:39.152] <TB3> INFO: Resuming triggers.
[16:04:46.021] <TB3> INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[16:05:08.708] <TB3> INFO: Resuming triggers.
[16:05:15.575] <TB3> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[16:05:37.832] <TB3> INFO: Resuming triggers.
[16:05:44.699] <TB3> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[16:06:07.022] <TB3> INFO: Resuming triggers.
[16:06:13.888] <TB3> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[16:06:34.306] <TB3> INFO: Resuming triggers.
[16:06:41.171] <TB3> INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[16:07:02.851] <TB3> INFO: Resuming triggers.
[16:07:09.716] <TB3> INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[16:07:30.230] <TB3> INFO: Resuming triggers.
[16:07:37.093] <TB3> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[16:07:58.797] <TB3> INFO: Resuming triggers.
[16:08:05.661] <TB3> INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[16:08:25.806] <TB3> INFO: Resuming triggers.
[16:08:29.770] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[16:08:42.810] <TB3> INFO: PixTest:: pg_setup set to default.
[16:08:42.811] <TB3> INFO: PixTestXray::doPhRun() done
[16:08:42.811] <TB3> INFO: PixTestXray::doTest() done
[16:08:43.026] <TB3> INFO: enter test to run
[16:08:43.026] <TB3> INFO: test: no parameter change
[16:08:43.298] <TB3> QUIET: Connection to board 121 closed.
[16:08:43.378] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[16:10:34.823] <TB3> INFO: *** Welcome to pxar ***
[16:10:34.823] <TB3> INFO: *** Today: 2015/08/21
[16:10:34.823] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//dacParameters35_C15.dat
[16:10:34.824] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//tbmParameters_C0b.dat
[16:10:34.825] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//defaultMaskFile.dat
[16:10:34.825] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//trimParameters35_C15.dat
[16:10:34.900] <TB3> INFO: clk: 4
[16:10:34.900] <TB3> INFO: ctr: 4
[16:10:34.900] <TB3> INFO: sda: 19
[16:10:34.900] <TB3> INFO: tin: 9
[16:10:34.900] <TB3> INFO: level: 15
[16:10:34.900] <TB3> INFO: triggerdelay: 0
[16:10:34.900] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:10:34.900] <TB3> INFO: Log level: INFO
[16:10:34.912] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:10:34.921] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:10:34.924] <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:
------------------------------------------------------
[16:10:34.929] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:10:36.462] <TB3> INFO: DUT info:
[16:10:36.462] <TB3> INFO: The DUT currently contains the following objects:
[16:10:36.462] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:10:36.462] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:10:36.462] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:10:36.462] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:10:36.462] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.462] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.462] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.463] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:10:36.864] <TB3> INFO: enter 'restricted' command line mode
[16:10:36.864] <TB3> INFO: enter test to run
[16:10:36.864] <TB3> INFO: test: delay setting parameters: ->5<-
[16:10:36.864] <TB3> INFO: delay test by 5 seconds...
[16:10:41.864] <TB3> INFO: enter test to run
[16:10:41.864] <TB3> INFO: test: Xray no parameter change
[16:10:41.864] <TB3> INFO: running: xray
[16:10:41.865] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//004_HRData_150//phCalibrationFitErr35_C15.dat
[16:10:42.017] <TB3> INFO: ######################################################################
[16:10:42.017] <TB3> INFO: PixTestXray::doTest()
[16:10:42.017] <TB3> INFO: ######################################################################
[16:10:42.017] <TB3> INFO: ----------------------------------------------------------------------
[16:10:42.017] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[16:10:42.017] <TB3> INFO: ----------------------------------------------------------------------
[16:10:42.985] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[16:10:46.817] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[16:11:13.731] <TB3> INFO: Resuming triggers.
[16:11:17.575] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[16:11:21.089] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (1) != Token Chain Length (4)

[16:11:21.089] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (105) != TBM ID (94)

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

[16:11:21.089] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (95) != TBM ID (105)

[16:11:21.089] <TB3> WARNING: Channel 3 ROC 2: Readback start marker after 15 readouts!

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

[16:11:41.258] <TB3> INFO: Resuming triggers.
[16:11:45.102] <TB3> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[16:12:06.975] <TB3> INFO: Resuming triggers.
[16:12:10.819] <TB3> INFO: run duration 15 seconds, buffer almost full (81%), pausing triggers.
[16:12:37.075] <TB3> INFO: Resuming triggers.
[16:12:40.915] <TB3> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[16:13:04.282] <TB3> INFO: Resuming triggers.
[16:13:08.125] <TB3> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[16:13:30.344] <TB3> INFO: Resuming triggers.
[16:13:34.188] <TB3> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[16:13:56.219] <TB3> INFO: Resuming triggers.
[16:14:00.061] <TB3> INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[16:14:24.835] <TB3> INFO: Resuming triggers.
[16:14:28.678] <TB3> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[16:14:53.437] <TB3> INFO: Resuming triggers.
[16:14:57.279] <TB3> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[16:15:21.743] <TB3> INFO: Resuming triggers.
[16:15:25.588] <TB3> INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[16:15:50.093] <TB3> INFO: Resuming triggers.
[16:15:53.934] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[16:16:18.142] <TB3> INFO: Resuming triggers.
[16:16:21.983] <TB3> INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[16:16:43.938] <TB3> INFO: Resuming triggers.
[16:16:47.780] <TB3> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[16:17:12.907] <TB3> INFO: Resuming triggers.
[16:17:16.750] <TB3> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[16:17:38.751] <TB3> INFO: Resuming triggers.
[16:17:42.593] <TB3> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[16:18:06.922] <TB3> INFO: Resuming triggers.
[16:18:10.764] <TB3> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[16:18:34.718] <TB3> INFO: Resuming triggers.
[16:18:38.560] <TB3> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[16:19:05.665] <TB3> INFO: Resuming triggers.
[16:19:09.506] <TB3> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[16:19:34.656] <TB3> INFO: Resuming triggers.
[16:19:38.498] <TB3> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[16:20:02.907] <TB3> INFO: Resuming triggers.
[16:20:06.747] <TB3> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[16:20:28.396] <TB3> INFO: Resuming triggers.
[16:20:32.235] <TB3> INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[16:20:55.531] <TB3> INFO: Resuming triggers.
[16:20:59.373] <TB3> INFO: run duration 88 seconds, buffer almost full (81%), pausing triggers.
[16:21:21.118] <TB3> INFO: Resuming triggers.
[16:21:24.959] <TB3> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[16:21:47.671] <TB3> INFO: Resuming triggers.
[16:21:51.507] <TB3> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[16:22:14.258] <TB3> INFO: Resuming triggers.
[16:22:18.096] <TB3> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[16:22:40.264] <TB3> INFO: Resuming triggers.
[16:22:40.479] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[16:22:41.969] <TB3> INFO: PixTest:: pg_setup set to default.
[16:22:41.970] <TB3> INFO: PixTestXray::doPhRun() done
[16:22:41.970] <TB3> INFO: PixTestXray::doTest() done
[16:22:42.172] <TB3> INFO: enter test to run
[16:22:42.172] <TB3> INFO: test: no parameter change
[16:22:42.364] <TB3> QUIET: Connection to board 121 closed.
[16:22:42.443] <TB3> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[16:25:16.004] <TB3> INFO: *** Welcome to pxar ***
[16:25:16.004] <TB3> INFO: *** Today: 2015/08/21
[16:25:16.004] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//dacParameters35_C15.dat
[16:25:16.005] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//tbmParameters_C0b.dat
[16:25:16.005] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//defaultMaskFile.dat
[16:25:16.005] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//trimParameters35_C15.dat
[16:25:16.079] <TB3> INFO: clk: 4
[16:25:16.079] <TB3> INFO: ctr: 4
[16:25:16.079] <TB3> INFO: sda: 19
[16:25:16.079] <TB3> INFO: tin: 9
[16:25:16.079] <TB3> INFO: level: 15
[16:25:16.079] <TB3> INFO: triggerdelay: 0
[16:25:16.079] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:25:16.079] <TB3> INFO: Log level: INFO
[16:25:16.092] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:25:16.102] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:25:16.106] <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:
------------------------------------------------------
[16:25:16.108] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:25:17.629] <TB3> INFO: DUT info:
[16:25:17.629] <TB3> INFO: The DUT currently contains the following objects:
[16:25:17.629] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:25:17.629] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:25:17.629] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:25:17.629] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:25:17.629] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:17.629] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:25:18.030] <TB3> INFO: enter 'restricted' command line mode
[16:25:18.030] <TB3> INFO: enter test to run
[16:25:18.030] <TB3> INFO: test: Highrate no parameter change
[16:25:18.030] <TB3> INFO: running: highrate
[16:25:18.030] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[16:25:18.169] <TB3> INFO: ----------------------------------------------------------------------
[16:25:18.169] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[16:25:18.169] <TB3> INFO: ----------------------------------------------------------------------
[16:25:18.175] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 100 (1) hits flags = 384 (plus default)
[16:25:18.197] <TB3> INFO: dacScan step from 0 .. 0
[16:25:31.939] <TB3> INFO: Test took 13742ms.
[16:25:33.343] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:25:33.566] <TB3> INFO: dacScan step from 1 .. 1
[16:25:47.238] <TB3> INFO: Test took 13671ms.
[16:25:48.517] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:25:48.779] <TB3> INFO: dacScan step from 2 .. 2
[16:26:02.309] <TB3> INFO: Test took 13529ms.
[16:26:03.702] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:26:03.957] <TB3> INFO: dacScan step from 3 .. 3
[16:26:17.114] <TB3> INFO: Test took 13157ms.
[16:26:18.391] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:26:18.626] <TB3> INFO: dacScan step from 4 .. 4
[16:26:32.074] <TB3> INFO: Test took 13448ms.
[16:26:33.437] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:26:33.676] <TB3> INFO: dacScan step from 5 .. 5
[16:26:46.613] <TB3> INFO: Test took 12937ms.
[16:26:48.086] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:26:48.317] <TB3> INFO: dacScan step from 6 .. 6
[16:27:01.323] <TB3> INFO: Test took 13006ms.
[16:27:02.679] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:02.939] <TB3> INFO: dacScan step from 7 .. 7
[16:27:16.755] <TB3> INFO: Test took 13816ms.
[16:27:18.543] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:18.763] <TB3> INFO: dacScan step from 8 .. 8
[16:27:31.957] <TB3> INFO: Test took 13194ms.
[16:27:33.334] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:33.548] <TB3> INFO: dacScan step from 9 .. 9
[16:27:46.631] <TB3> INFO: Test took 13083ms.
[16:27:47.902] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:27:48.146] <TB3> INFO: dacScan step from 10 .. 10
[16:28:01.118] <TB3> INFO: Test took 12972ms.
[16:28:02.402] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:28:02.624] <TB3> INFO: dacScan step from 11 .. 11
[16:28:15.340] <TB3> INFO: Test took 12716ms.
[16:28:16.657] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:28:16.925] <TB3> INFO: dacScan step from 12 .. 12
[16:28:30.306] <TB3> INFO: Test took 13380ms.
[16:28:31.543] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:28:31.776] <TB3> INFO: dacScan step from 13 .. 13
[16:28:44.979] <TB3> INFO: Test took 13202ms.
[16:28:46.388] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:28:46.619] <TB3> INFO: dacScan step from 14 .. 14
[16:29:00.005] <TB3> INFO: Test took 13385ms.
[16:29:01.293] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:29:01.520] <TB3> INFO: dacScan step from 15 .. 15
[16:29:14.893] <TB3> INFO: Test took 13373ms.
[16:29:16.335] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:29:16.596] <TB3> INFO: dacScan step from 16 .. 16
[16:29:29.464] <TB3> INFO: Test took 12868ms.
[16:29:30.985] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:29:31.239] <TB3> INFO: dacScan step from 17 .. 17
[16:29:44.094] <TB3> INFO: Test took 12854ms.
[16:29:45.641] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:29:45.896] <TB3> INFO: dacScan step from 18 .. 18
[16:29:58.963] <TB3> INFO: Test took 13067ms.
[16:30:00.283] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:30:00.516] <TB3> INFO: dacScan step from 19 .. 19
[16:30:13.659] <TB3> INFO: Test took 13142ms.
[16:30:14.910] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:30:15.144] <TB3> INFO: dacScan step from 20 .. 20
[16:30:28.288] <TB3> INFO: Test took 13144ms.
[16:30:29.625] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:30:29.867] <TB3> INFO: dacScan step from 21 .. 21
[16:30:43.307] <TB3> INFO: Test took 13440ms.
[16:30:44.629] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:30:44.860] <TB3> INFO: dacScan step from 22 .. 22
[16:30:58.061] <TB3> INFO: Test took 13200ms.
[16:30:59.546] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:30:59.796] <TB3> INFO: dacScan step from 23 .. 23
[16:31:13.412] <TB3> INFO: Test took 13616ms.
[16:31:14.707] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:31:14.932] <TB3> INFO: dacScan step from 24 .. 24
[16:31:28.087] <TB3> INFO: Test took 13154ms.
[16:31:29.516] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:31:29.752] <TB3> INFO: dacScan step from 25 .. 25
[16:31:42.669] <TB3> INFO: Test took 12917ms.
[16:31:44.058] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:31:44.298] <TB3> INFO: dacScan step from 26 .. 26
[16:31:57.425] <TB3> INFO: Test took 13126ms.
[16:31:58.725] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:31:58.944] <TB3> INFO: dacScan step from 27 .. 27
[16:32:11.985] <TB3> INFO: Test took 13040ms.
[16:32:13.364] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:32:13.603] <TB3> INFO: dacScan step from 28 .. 28
[16:32:26.914] <TB3> INFO: Test took 13311ms.
[16:32:28.344] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:32:28.580] <TB3> INFO: dacScan step from 29 .. 29
[16:32:41.622] <TB3> INFO: Test took 13041ms.
[16:32:42.911] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:32:43.154] <TB3> INFO: dacScan step from 30 .. 30
[16:32:56.536] <TB3> INFO: Test took 13381ms.
[16:32:57.912] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:32:58.153] <TB3> INFO: dacScan step from 31 .. 31
[16:33:11.245] <TB3> INFO: Test took 13091ms.
[16:33:12.522] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:33:12.767] <TB3> INFO: dacScan step from 32 .. 32
[16:33:25.992] <TB3> INFO: Test took 13224ms.
[16:33:27.254] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:33:27.473] <TB3> INFO: dacScan step from 33 .. 33
[16:33:40.491] <TB3> INFO: Test took 13017ms.
[16:33:41.804] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:33:42.019] <TB3> INFO: dacScan step from 34 .. 34
[16:33:55.156] <TB3> INFO: Test took 13137ms.
[16:33:56.512] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:33:56.746] <TB3> INFO: dacScan step from 35 .. 35
[16:34:10.093] <TB3> INFO: Test took 13346ms.
[16:34:11.552] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:11.791] <TB3> INFO: dacScan step from 36 .. 36
[16:34:25.189] <TB3> INFO: Test took 13397ms.
[16:34:26.814] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:27.083] <TB3> INFO: dacScan step from 37 .. 37
[16:34:41.161] <TB3> INFO: Test took 14078ms.
[16:34:42.530] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:42.757] <TB3> INFO: dacScan step from 38 .. 38
[16:34:57.046] <TB3> INFO: Test took 14289ms.
[16:34:58.520] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:58.771] <TB3> INFO: dacScan step from 39 .. 39
[16:35:13.322] <TB3> INFO: Test took 14551ms.
[16:35:14.856] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:15.084] <TB3> INFO: dacScan step from 40 .. 40
[16:35:29.746] <TB3> INFO: Test took 14662ms.
[16:35:31.112] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:31.358] <TB3> INFO: dacScan step from 41 .. 41
[16:35:46.125] <TB3> INFO: Test took 14767ms.
[16:35:47.506] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:47.734] <TB3> INFO: dacScan step from 42 .. 42
[16:36:02.822] <TB3> INFO: Test took 15087ms.
[16:36:04.679] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:04.904] <TB3> INFO: dacScan step from 43 .. 43
[16:36:20.244] <TB3> INFO: Test took 15339ms.
[16:36:21.800] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:22.043] <TB3> INFO: dacScan step from 44 .. 44
[16:36:37.817] <TB3> INFO: Test took 15773ms.
[16:36:39.521] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:39.789] <TB3> INFO: dacScan step from 45 .. 45
[16:36:55.834] <TB3> INFO: Test took 16044ms.
[16:36:57.359] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:57.578] <TB3> INFO: dacScan step from 46 .. 46
[16:37:13.885] <TB3> INFO: Test took 16307ms.
[16:37:15.560] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:37:15.834] <TB3> INFO: dacScan step from 47 .. 47
[16:37:32.304] <TB3> INFO: Test took 16469ms.
[16:37:34.032] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:37:34.293] <TB3> INFO: dacScan step from 48 .. 48
[16:37:50.878] <TB3> INFO: Test took 16585ms.
[16:37:52.610] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:37:52.872] <TB3> INFO: dacScan step from 49 .. 49
[16:38:09.345] <TB3> INFO: Test took 16472ms.
[16:38:10.973] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:38:11.206] <TB3> INFO: dacScan step from 50 .. 50
[16:38:27.501] <TB3> INFO: Test took 16295ms.
[16:38:28.924] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:38:29.158] <TB3> INFO: dacScan step from 51 .. 51
[16:38:45.155] <TB3> INFO: Test took 15997ms.
[16:38:46.838] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:38:47.078] <TB3> INFO: dacScan step from 52 .. 52
[16:39:03.671] <TB3> INFO: Test took 16592ms.
[16:39:05.134] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:39:05.380] <TB3> INFO: dacScan step from 53 .. 53
[16:39:21.313] <TB3> INFO: Test took 15932ms.
[16:39:23.098] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:39:23.329] <TB3> INFO: dacScan step from 54 .. 54
[16:39:39.938] <TB3> INFO: Test took 16609ms.
[16:39:41.352] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:39:41.596] <TB3> INFO: dacScan step from 55 .. 55
[16:39:58.488] <TB3> INFO: Test took 16891ms.
[16:39:59.975] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:00.206] <TB3> INFO: dacScan step from 56 .. 56
[16:40:17.111] <TB3> INFO: Test took 16904ms.
[16:40:18.562] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:18.799] <TB3> INFO: dacScan step from 57 .. 57
[16:40:35.862] <TB3> INFO: Test took 17063ms.
[16:40:37.493] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:37.739] <TB3> INFO: dacScan step from 58 .. 58
[16:40:54.290] <TB3> INFO: Test took 16551ms.
[16:40:55.868] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:56.099] <TB3> INFO: dacScan step from 59 .. 59
[16:41:12.740] <TB3> INFO: Test took 16640ms.
[16:41:14.742] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:41:14.975] <TB3> INFO: dacScan step from 60 .. 60
[16:41:31.201] <TB3> INFO: Test took 16225ms.
[16:41:32.832] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:41:33.118] <TB3> INFO: dacScan step from 61 .. 61
[16:41:49.632] <TB3> INFO: Test took 16513ms.
[16:41:51.261] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:41:51.519] <TB3> INFO: dacScan step from 62 .. 62
[16:42:07.591] <TB3> INFO: Test took 16071ms.
[16:42:09.345] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:42:09.587] <TB3> INFO: dacScan step from 63 .. 63
[16:42:26.546] <TB3> INFO: Test took 16958ms.
[16:42:28.036] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:42:28.279] <TB3> INFO: dacScan step from 64 .. 64
[16:42:44.839] <TB3> INFO: Test took 16559ms.
[16:42:46.376] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:42:46.618] <TB3> INFO: dacScan step from 65 .. 65
[16:43:03.386] <TB3> INFO: Test took 16768ms.
[16:43:05.097] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:43:05.371] <TB3> INFO: dacScan step from 66 .. 66
[16:43:21.674] <TB3> INFO: Test took 16302ms.
[16:43:23.302] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:43:23.532] <TB3> INFO: dacScan step from 67 .. 67
[16:43:39.614] <TB3> INFO: Test took 16081ms.
[16:43:41.327] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:43:41.568] <TB3> INFO: dacScan step from 68 .. 68
[16:43:58.206] <TB3> INFO: Test took 16637ms.
[16:43:59.963] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:44:00.216] <TB3> INFO: dacScan step from 69 .. 69
[16:44:16.661] <TB3> INFO: Test took 16444ms.
[16:44:18.460] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:44:18.704] <TB3> INFO: dacScan step from 70 .. 70
[16:44:35.227] <TB3> INFO: Test took 16522ms.
[16:44:37.613] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:44:37.980] <TB3> INFO: dacScan step from 71 .. 71
[16:44:54.643] <TB3> INFO: Test took 16663ms.
[16:44:56.263] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:44:56.502] <TB3> INFO: dacScan step from 72 .. 72
[16:45:13.220] <TB3> INFO: Test took 16717ms.
[16:45:15.042] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:45:15.283] <TB3> INFO: dacScan step from 73 .. 73
[16:45:31.655] <TB3> INFO: Test took 16371ms.
[16:45:33.338] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:45:33.621] <TB3> INFO: dacScan step from 74 .. 74
[16:45:49.527] <TB3> INFO: Test took 15905ms.
[16:45:51.345] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:45:51.612] <TB3> INFO: dacScan step from 75 .. 75
[16:46:08.001] <TB3> INFO: Test took 16388ms.
[16:46:09.437] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:46:09.669] <TB3> INFO: dacScan step from 76 .. 76
[16:46:25.583] <TB3> INFO: Test took 15913ms.
[16:46:27.413] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:46:27.668] <TB3> INFO: dacScan step from 77 .. 77
[16:46:43.973] <TB3> INFO: Test took 16304ms.
[16:46:45.648] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:46:45.876] <TB3> INFO: dacScan step from 78 .. 78
[16:47:02.519] <TB3> INFO: Test took 16642ms.
[16:47:04.156] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:47:04.402] <TB3> INFO: dacScan step from 79 .. 79
[16:47:21.309] <TB3> INFO: Test took 16906ms.
[16:47:22.818] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:47:23.054] <TB3> INFO: dacScan step from 80 .. 80
[16:47:39.782] <TB3> INFO: Test took 16728ms.
[16:47:41.612] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:47:41.849] <TB3> INFO: dacScan step from 81 .. 81
[16:47:58.435] <TB3> INFO: Test took 16585ms.
[16:48:00.077] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:48:00.304] <TB3> INFO: dacScan step from 82 .. 82
[16:48:16.640] <TB3> INFO: Test took 16335ms.
[16:48:18.408] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:48:18.681] <TB3> INFO: dacScan step from 83 .. 83
[16:48:35.163] <TB3> INFO: Test took 16481ms.
[16:48:37.154] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:48:37.441] <TB3> INFO: dacScan step from 84 .. 84
[16:48:53.994] <TB3> INFO: Test took 16552ms.
[16:48:55.510] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:48:55.732] <TB3> INFO: dacScan step from 85 .. 85
[16:49:11.797] <TB3> INFO: Test took 16065ms.
[16:49:13.470] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:49:13.734] <TB3> INFO: dacScan step from 86 .. 86
[16:49:30.261] <TB3> INFO: Test took 16526ms.
[16:49:31.772] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:49:32.028] <TB3> INFO: dacScan step from 87 .. 87
[16:49:48.157] <TB3> INFO: Test took 16128ms.
[16:49:49.988] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:49:50.264] <TB3> INFO: dacScan step from 88 .. 88
[16:50:06.570] <TB3> INFO: Test took 16305ms.
[16:50:08.401] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:50:08.663] <TB3> INFO: dacScan step from 89 .. 89
[16:50:24.943] <TB3> INFO: Test took 16279ms.
[16:50:26.725] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:50:26.981] <TB3> INFO: dacScan step from 90 .. 90
[16:50:43.494] <TB3> INFO: Test took 16512ms.
[16:50:45.106] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:50:45.349] <TB3> INFO: dacScan step from 91 .. 91
[16:51:01.630] <TB3> INFO: Test took 16280ms.
[16:51:03.443] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:51:03.692] <TB3> INFO: dacScan step from 92 .. 92
[16:51:19.798] <TB3> INFO: Test took 16104ms.
[16:51:21.450] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:51:21.672] <TB3> INFO: dacScan step from 93 .. 93
[16:51:38.103] <TB3> INFO: Test took 16430ms.
[16:51:39.717] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:51:39.954] <TB3> INFO: dacScan step from 94 .. 94
[16:51:56.682] <TB3> INFO: Test took 16727ms.
[16:51:58.431] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:51:58.680] <TB3> INFO: dacScan step from 95 .. 95
[16:52:14.378] <TB3> INFO: Test took 15697ms.
[16:52:16.084] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:52:16.329] <TB3> INFO: dacScan step from 96 .. 96
[16:52:32.428] <TB3> INFO: Test took 16098ms.
[16:52:34.159] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:52:34.434] <TB3> INFO: dacScan step from 97 .. 97
[16:52:50.801] <TB3> INFO: Test took 16366ms.
[16:52:52.398] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:52:52.655] <TB3> INFO: dacScan step from 98 .. 98
[16:53:09.215] <TB3> INFO: Test took 16559ms.
[16:53:10.934] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:53:11.178] <TB3> INFO: dacScan step from 99 .. 99
[16:53:27.441] <TB3> INFO: Test took 16262ms.
[16:53:28.905] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:53:29.156] <TB3> INFO: dacScan step from 100 .. 100
[16:53:45.948] <TB3> INFO: Test took 16790ms.
[16:53:47.403] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:53:47.648] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:53:49.006] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:53:50.398] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:53:51.898] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:53:53.470] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:53:54.920] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:53:56.477] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:53:58.007] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:53:59.612] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:54:01.229] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:54:02.666] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:54:04.160] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:54:05.764] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:54:07.132] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:54:08.458] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:54:09.867] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:54:11.182] <TB3> INFO: PixTest:: pg_setup set to default.
[16:54:11.184] <TB3> INFO: vcal mean: 37.89 37.76 36.97 40.00 40.31 41.65 41.25 39.40 40.48 40.49 42.06 40.86 40.59 37.58 38.62 37.73
[16:54:11.184] <TB3> INFO: vcal RMS: 1.26 1.23 1.08 1.49 1.35 1.48 1.49 8.03 1.42 1.94 1.58 1.60 1.48 1.20 1.14 1.11
[16:54:11.184] <TB3> INFO: number of X-ray hits detected: 168137 173534 147348 276524 291473 347569 340539 315489 322604 332068 375193 317757 297526 158730 189308 157684
[16:54:11.184] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:54:11.184] <TB3> INFO: X-ray hit rate [MHz/cm2]: 49.3 50.9 43.2 81.1 85.4 101.9 99.8 92.5 94.6 97.3 110.0 93.1 87.2 46.5 55.5 46.2
[16:54:11.184] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[16:54:11.281] <TB3> INFO: enter test to run
[16:54:11.281] <TB3> INFO: test: no parameter change
[16:54:11.480] <TB3> QUIET: Connection to board 121 closed.
[16:54:11.559] <TB3> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[17:14:26.791] <TB3> INFO: *** Welcome to pxar ***
[17:14:26.791] <TB3> INFO: *** Today: 2015/08/21
[17:14:26.791] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[17:14:26.792] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[17:14:26.792] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[17:14:26.792] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[17:14:26.869] <TB3> INFO: clk: 4
[17:14:26.869] <TB3> INFO: ctr: 4
[17:14:26.869] <TB3> INFO: sda: 19
[17:14:26.869] <TB3> INFO: tin: 9
[17:14:26.869] <TB3> INFO: level: 15
[17:14:26.869] <TB3> INFO: triggerdelay: 0
[17:14:26.869] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:14:26.869] <TB3> INFO: Log level: INFO
[17:14:26.883] <TB3> INFO: Found DTB DTB_WWV6Z5
[17:14:26.891] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[17:14:26.894] <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:
------------------------------------------------------
[17:14:26.897] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[17:14:28.483] <TB3> INFO: DUT info:
[17:14:28.483] <TB3> INFO: The DUT currently contains the following objects:
[17:14:28.483] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[17:14:28.483] <TB3> INFO: TBM Core alpha (0): 7 registers set
[17:14:28.483] <TB3> INFO: TBM Core beta (1): 7 registers set
[17:14:28.483] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:14:28.483] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.483] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.483] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.483] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.484] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:14:28.885] <TB3> INFO: enter 'restricted' command line mode
[17:14:28.885] <TB3> INFO: enter test to run
[17:14:28.885] <TB3> INFO: test: HighRate no parameter change
[17:14:28.885] <TB3> INFO: running: highrate
[17:14:28.886] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[17:14:29.052] <TB3> INFO: ----------------------------------------------------------------------
[17:14:29.052] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[17:14:29.052] <TB3> INFO: ----------------------------------------------------------------------
[17:14:30.136] <TB3> INFO: Test took 1079ms.
[17:14:33.848] <TB3> INFO: Test took 3707ms.
[17:14:33.996] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:37.843] <TB3> INFO: Test took 3816ms.
[17:14:37.985] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:41.920] <TB3> INFO: Test took 3909ms.
[17:14:42.073] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:45.925] <TB3> INFO: Test took 3821ms.
[17:14:46.060] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:49.864] <TB3> INFO: Test took 3778ms.
[17:14:50.014] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:53.948] <TB3> INFO: Test took 3903ms.
[17:14:54.081] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:14:57.899] <TB3> INFO: Test took 3792ms.
[17:14:58.054] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:01.932] <TB3> INFO: Test took 3846ms.
[17:15:02.077] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:05.985] <TB3> INFO: Test took 3882ms.
[17:15:06.129] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:09.884] <TB3> INFO: Test took 3728ms.
[17:15:10.045] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:13.840] <TB3> INFO: Test took 3764ms.
[17:15:13.998] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:17.952] <TB3> INFO: Test took 3927ms.
[17:15:18.100] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:22.229] <TB3> INFO: Test took 4103ms.
[17:15:22.371] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:26.413] <TB3> INFO: Test took 4015ms.
[17:15:26.549] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:30.355] <TB3> INFO: Test took 3781ms.
[17:15:30.512] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:34.409] <TB3> INFO: Test took 3864ms.
[17:15:34.545] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:38.175] <TB3> INFO: Test took 3594ms.
[17:15:38.307] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:41.929] <TB3> INFO: Test took 3597ms.
[17:15:42.058] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:45.852] <TB3> INFO: Test took 3769ms.
[17:15:45.979] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:49.558] <TB3> INFO: Test took 3554ms.
[17:15:49.679] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:15:49.974] <TB3> INFO: enter test to run
[17:15:49.974] <TB3> INFO: test: Pretest no parameter change
[17:15:49.974] <TB3> INFO: running: pretest
[17:15:49.975] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[17:15:49.975] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[17:15:49.975] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[17:15:49.975] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[17:15:49.975] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[17:15:49.975] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[17:15:49.975] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[17:15:49.975] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[17:15:49.976] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[17:15:49.976] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[17:15:49.976] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[17:15:49.976] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[17:15:49.976] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[17:15:49.976] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[17:15:49.976] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[17:15:49.976] <TB3> INFO: write dac parameters into /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[17:15:49.976] <TB3> INFO: enter test to run
[17:15:49.976] <TB3> INFO: test: no parameter change
[17:15:50.157] <TB3> QUIET: Connection to board 121 closed.
[17:15:50.237] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[17:16:26.311] <TB3> INFO: *** Welcome to pxar ***
[17:16:26.311] <TB3> INFO: *** Today: 2015/08/21
[17:16:26.311] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//dacParameters35_C15.dat
[17:16:26.311] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//tbmParameters_C0b.dat
[17:16:26.311] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//defaultMaskFile.dat
[17:16:26.311] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//trimParameters35_C15.dat
[17:16:26.378] <TB3> INFO: clk: 4
[17:16:26.378] <TB3> INFO: ctr: 4
[17:16:26.379] <TB3> INFO: sda: 19
[17:16:26.379] <TB3> INFO: tin: 9
[17:16:26.379] <TB3> INFO: level: 15
[17:16:26.379] <TB3> INFO: triggerdelay: 0
[17:16:26.379] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:16:26.379] <TB3> INFO: Log level: INFO
[17:16:26.392] <TB3> INFO: Found DTB DTB_WWV6Z5
[17:16:26.401] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[17:16:26.404] <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:
------------------------------------------------------
[17:16:26.407] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[17:16:27.933] <TB3> INFO: DUT info:
[17:16:27.933] <TB3> INFO: The DUT currently contains the following objects:
[17:16:27.933] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[17:16:27.934] <TB3> INFO: TBM Core alpha (0): 7 registers set
[17:16:27.934] <TB3> INFO: TBM Core beta (1): 7 registers set
[17:16:27.934] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:16:27.934] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:27.934] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:16:28.335] <TB3> INFO: enter 'restricted' command line mode
[17:16:28.335] <TB3> INFO: enter test to run
[17:16:28.335] <TB3> INFO: test: HighRate no parameter change
[17:16:28.335] <TB3> INFO: running: highrate
[17:16:28.336] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[17:16:28.530] <TB3> INFO: ----------------------------------------------------------------------
[17:16:28.530] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:16:28.530] <TB3> INFO: ----------------------------------------------------------------------
[17:16:41.232] <TB3> INFO: Test took 12696ms.
[17:16:41.889] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:16:42.185] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 160 0 1 0 0 0 0 0 0
[17:16:42.185] <TB3> INFO: number of red-efficiency pixels: 93 120 88 209 271 277 257 385 211 213 284 236 245 98 111 111
[17:16:42.185] <TB3> INFO: number of X-ray hits detected: 83422 85680 71927 139986 145777 175994 171903 159108 161498 167396 189954 158632 149672 77549 93268 77571
[17:16:42.185] <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
[17:16:42.185] <TB3> INFO: number of Vcal hits detected: 207906 207876 207910 207780 207716 207685 207739 199769 207782 207733 207704 207758 207750 207902 207886 207887
[17:16:42.185] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 99.9 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 99.9 100.0
[17:16:42.185] <TB3> INFO: Vcal hit overall efficiency (%): 100.0 99.9 100.0 99.9 99.9 99.8 99.9 96.0 99.9 99.9 99.9 99.9 99.9 100.0 99.9 99.9
[17:16:42.185] <TB3> INFO: X-ray hit rate [MHz/cm2]: 24.5 25.1 21.1 41.0 42.7 51.6 50.4 46.6 47.3 49.1 55.7 46.5 43.9 22.7 27.3 22.7
[17:16:42.185] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[17:16:42.211] <TB3> INFO: PixTest:: pg_setup set to default.
[17:16:42.246] <TB3> INFO: enter test to run
[17:16:42.246] <TB3> INFO: test: no parameter change
[17:16:42.398] <TB3> QUIET: Connection to board 121 closed.
[17:16:42.478] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[17:17:17.185] <TB3> INFO: *** Welcome to pxar ***
[17:17:17.185] <TB3> INFO: *** Today: 2015/08/21
[17:17:17.185] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//dacParameters35_C15.dat
[17:17:17.186] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//tbmParameters_C0b.dat
[17:17:17.186] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//defaultMaskFile.dat
[17:17:17.186] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//trimParameters35_C15.dat
[17:17:17.257] <TB3> INFO: clk: 4
[17:17:17.257] <TB3> INFO: ctr: 4
[17:17:17.257] <TB3> INFO: sda: 19
[17:17:17.257] <TB3> INFO: tin: 9
[17:17:17.257] <TB3> INFO: level: 15
[17:17:17.257] <TB3> INFO: triggerdelay: 0
[17:17:17.257] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:17:17.257] <TB3> INFO: Log level: INFO
[17:17:17.269] <TB3> INFO: Found DTB DTB_WWV6Z5
[17:17:17.277] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[17:17:17.280] <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:
------------------------------------------------------
[17:17:17.283] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[17:17:18.852] <TB3> INFO: DUT info:
[17:17:18.852] <TB3> INFO: The DUT currently contains the following objects:
[17:17:18.852] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[17:17:18.852] <TB3> INFO: TBM Core alpha (0): 7 registers set
[17:17:18.852] <TB3> INFO: TBM Core beta (1): 7 registers set
[17:17:18.853] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:17:18.853] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:18.853] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:17:19.254] <TB3> INFO: enter 'restricted' command line mode
[17:17:19.255] <TB3> INFO: enter test to run
[17:17:19.255] <TB3> INFO: test: HighRate no parameter change
[17:17:19.255] <TB3> INFO: running: highrate
[17:17:19.255] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[17:17:19.406] <TB3> INFO: ----------------------------------------------------------------------
[17:17:19.406] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:17:19.406] <TB3> INFO: ----------------------------------------------------------------------
[17:17:34.581] <TB3> INFO: Test took 15169ms.
[17:17:36.288] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:17:36.654] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 160 0 1 0 0 0 0 0 0
[17:17:36.654] <TB3> INFO: number of red-efficiency pixels: 233 332 301 728 872 963 918 950 851 821 1052 814 783 271 270 302
[17:17:36.654] <TB3> INFO: number of X-ray hits detected: 168152 174972 148061 281254 292389 347634 341734 317748 324154 333974 375435 317794 299498 159361 190208 158631
[17:17:36.654] <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
[17:17:36.654] <TB3> INFO: number of Vcal hits detected: 207752 207654 207662 207174 206920 206760 206883 199100 207007 206974 206696 207028 207091 207696 207710 207673
[17:17:36.654] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.8 99.9 99.6 99.5 99.5 99.5 99.6 99.6 99.6 99.4 99.6 99.6 99.9 99.9 99.9
[17:17:36.654] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.8 99.8 99.6 99.5 99.4 99.5 95.7 99.5 99.5 99.4 99.5 99.6 99.9 99.9 99.8
[17:17:36.654] <TB3> INFO: X-ray hit rate [MHz/cm2]: 49.3 51.3 43.4 82.4 85.7 101.9 100.2 93.1 95.0 97.9 110.0 93.1 87.8 46.7 55.8 46.5
[17:17:36.654] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[17:17:36.680] <TB3> INFO: PixTest:: pg_setup set to default.
[17:17:36.714] <TB3> INFO: enter test to run
[17:17:36.714] <TB3> INFO: test: no parameter change
[17:17:36.871] <TB3> QUIET: Connection to board 121 closed.
[17:17:36.951] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[17:18:11.373] <TB3> INFO: *** Welcome to pxar ***
[17:18:11.373] <TB3> INFO: *** Today: 2015/08/21
[17:18:11.373] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//dacParameters35_C15.dat
[17:18:11.374] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//tbmParameters_C0b.dat
[17:18:11.374] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//defaultMaskFile.dat
[17:18:11.374] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//trimParameters35_C15.dat
[17:18:11.451] <TB3> INFO: clk: 4
[17:18:11.451] <TB3> INFO: ctr: 4
[17:18:11.451] <TB3> INFO: sda: 19
[17:18:11.451] <TB3> INFO: tin: 9
[17:18:11.451] <TB3> INFO: level: 15
[17:18:11.451] <TB3> INFO: triggerdelay: 0
[17:18:11.451] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:18:11.451] <TB3> INFO: Log level: INFO
[17:18:11.464] <TB3> INFO: Found DTB DTB_WWV6Z5
[17:18:11.472] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[17:18:11.476] <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:
------------------------------------------------------
[17:18:11.481] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[17:18:13.002] <TB3> INFO: DUT info:
[17:18:13.002] <TB3> INFO: The DUT currently contains the following objects:
[17:18:13.002] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[17:18:13.002] <TB3> INFO: TBM Core alpha (0): 7 registers set
[17:18:13.002] <TB3> INFO: TBM Core beta (1): 7 registers set
[17:18:13.002] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:18:13.002] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.002] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.002] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.002] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.002] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.002] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.003] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:18:13.403] <TB3> INFO: enter 'restricted' command line mode
[17:18:13.403] <TB3> INFO: enter test to run
[17:18:13.404] <TB3> INFO: test: HighRate no parameter change
[17:18:13.404] <TB3> INFO: running: highrate
[17:18:13.404] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[17:18:13.536] <TB3> INFO: ----------------------------------------------------------------------
[17:18:13.536] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:18:13.536] <TB3> INFO: ----------------------------------------------------------------------
[17:18:30.898] <TB3> INFO: Test took 17356ms.
[17:18:33.975] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:18:34.407] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 160 0 0 0 0 0 0 0 0
[17:18:34.407] <TB3> INFO: number of red-efficiency pixels: 476 621 504 1446 1750 1945 1841 1733 1674 1750 2088 1600 1626 589 600 588
[17:18:34.407] <TB3> INFO: number of X-ray hits detected: 244518 253600 216124 404372 422745 500298 491829 458921 467595 480126 538194 455283 429975 233061 274483 231134
[17:18:34.407] <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
[17:18:34.407] <TB3> INFO: number of Vcal hits detected: 207479 207302 207326 205972 205234 204681 204937 197759 205655 205282 204486 205598 205697 207230 207342 207341
[17:18:34.407] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.8 99.7 99.7 99.1 98.8 98.6 98.8 99.0 99.0 98.9 98.5 99.0 99.0 99.7 99.7 99.7
[17:18:34.407] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.7 99.0 98.7 98.4 98.5 95.1 98.9 98.7 98.3 98.8 98.9 99.6 99.7 99.7
[17:18:34.407] <TB3> INFO: X-ray hit rate [MHz/cm2]: 71.7 74.3 63.3 118.5 123.9 146.6 144.2 134.5 137.1 140.7 157.7 133.4 126.0 68.3 80.5 67.7
[17:18:34.407] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[17:18:34.433] <TB3> INFO: PixTest:: pg_setup set to default.
[17:18:34.468] <TB3> INFO: enter test to run
[17:18:34.468] <TB3> INFO: test: no parameter change
[17:18:34.631] <TB3> QUIET: Connection to board 121 closed.
[17:18:34.710] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[17:19:08.818] <TB3> INFO: *** Welcome to pxar ***
[17:19:08.818] <TB3> INFO: *** Today: 2015/08/21
[17:19:08.818] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//dacParameters35_C15.dat
[17:19:08.820] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//tbmParameters_C0b.dat
[17:19:08.820] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//defaultMaskFile.dat
[17:19:08.820] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//trimParameters35_C15.dat
[17:19:08.894] <TB3> INFO: clk: 4
[17:19:08.894] <TB3> INFO: ctr: 4
[17:19:08.894] <TB3> INFO: sda: 19
[17:19:08.894] <TB3> INFO: tin: 9
[17:19:08.894] <TB3> INFO: level: 15
[17:19:08.894] <TB3> INFO: triggerdelay: 0
[17:19:08.894] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:19:08.894] <TB3> INFO: Log level: INFO
[17:19:08.908] <TB3> INFO: Found DTB DTB_WWV6Z5
[17:19:08.917] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[17:19:08.920] <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:
------------------------------------------------------
[17:19:08.923] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[17:19:10.455] <TB3> INFO: DUT info:
[17:19:10.455] <TB3> INFO: The DUT currently contains the following objects:
[17:19:10.455] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[17:19:10.456] <TB3> INFO: TBM Core alpha (0): 7 registers set
[17:19:10.456] <TB3> INFO: TBM Core beta (1): 7 registers set
[17:19:10.456] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:19:10.456] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.456] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.456] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.456] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.456] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.456] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.456] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.456] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.457] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.457] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.457] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.457] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.457] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.457] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.457] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.457] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:19:10.858] <TB3> INFO: enter 'restricted' command line mode
[17:19:10.858] <TB3> INFO: enter test to run
[17:19:10.858] <TB3> INFO: test: HighRate no parameter change
[17:19:10.858] <TB3> INFO: running: highrate
[17:19:10.859] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[17:19:11.015] <TB3> INFO: ----------------------------------------------------------------------
[17:19:11.015] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:19:11.015] <TB3> INFO: ----------------------------------------------------------------------
[17:19:30.750] <TB3> INFO: Test took 19730ms.
[17:19:35.925] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:19:36.427] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 160 0 1 0 0 0 0 0 0
[17:19:36.427] <TB3> INFO: number of red-efficiency pixels: 913 1231 832 2502 2829 3110 2992 2964 2857 2868 3304 2653 2720 911 1078 1055
[17:19:36.427] <TB3> INFO: number of X-ray hits detected: 331694 346607 296464 547663 570203 673491 665933 618112 632366 648173 720905 615424 583990 317815 373977 314892
[17:19:36.427] <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
[17:19:36.427] <TB3> INFO: number of Vcal hits detected: 206923 206405 206616 203183 201388 200044 200503 194436 202088 201453 199347 202236 202564 206417 206673 206677
[17:19:36.427] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.3 99.5 98.0 97.2 96.6 96.9 97.5 97.5 97.3 96.3 97.6 97.7 99.4 99.4 99.4
[17:19:36.427] <TB3> INFO: Vcal hit overall efficiency (%): 99.5 99.2 99.3 97.7 96.8 96.2 96.4 93.5 97.2 96.9 95.8 97.2 97.4 99.2 99.4 99.4
[17:19:36.427] <TB3> INFO: X-ray hit rate [MHz/cm2]: 97.2 101.6 86.9 160.5 167.1 197.4 195.2 181.2 185.4 190.0 211.3 180.4 171.2 93.2 109.6 92.3
[17:19:36.427] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[17:19:36.453] <TB3> INFO: PixTest:: pg_setup set to default.
[17:19:36.489] <TB3> INFO: enter test to run
[17:19:36.489] <TB3> INFO: test: no parameter change
[17:19:36.629] <TB3> QUIET: Connection to board 121 closed.
[17:19:36.711] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[17:20:12.939] <TB3> INFO: *** Welcome to pxar ***
[17:20:12.939] <TB3> INFO: *** Today: 2015/08/21
[17:20:12.939] <TB3> INFO: readRocDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//dacParameters35_C15.dat
[17:20:12.940] <TB3> INFO: readTbmDacs: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//tbmParameters_C0b.dat
[17:20:12.940] <TB3> INFO: readMaskFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//defaultMaskFile.dat
[17:20:12.940] <TB3> INFO: readTrimFile: /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//trimParameters35_C15.dat
[17:20:13.017] <TB3> INFO: clk: 4
[17:20:13.017] <TB3> INFO: ctr: 4
[17:20:13.017] <TB3> INFO: sda: 19
[17:20:13.017] <TB3> INFO: tin: 9
[17:20:13.017] <TB3> INFO: level: 15
[17:20:13.017] <TB3> INFO: triggerdelay: 0
[17:20:13.017] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[17:20:13.017] <TB3> INFO: Log level: INFO
[17:20:13.031] <TB3> INFO: Found DTB DTB_WWV6Z5
[17:20:13.039] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[17:20:13.043] <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:
------------------------------------------------------
[17:20:13.045] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[17:20:14.579] <TB3> INFO: DUT info:
[17:20:14.579] <TB3> INFO: The DUT currently contains the following objects:
[17:20:14.579] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[17:20:14.579] <TB3> INFO: TBM Core alpha (0): 7 registers set
[17:20:14.579] <TB3> INFO: TBM Core beta (1): 7 registers set
[17:20:14.579] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:20:14.579] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.579] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:20:14.980] <TB3> INFO: enter 'restricted' command line mode
[17:20:14.981] <TB3> INFO: enter test to run
[17:20:14.981] <TB3> INFO: test: HighRate no parameter change
[17:20:14.981] <TB3> INFO: running: highrate
[17:20:14.981] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2062_XrayQualification_2015-08-21_17h53m_1440172414//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[17:20:15.133] <TB3> INFO: ----------------------------------------------------------------------
[17:20:15.133] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:20:15.133] <TB3> INFO: ----------------------------------------------------------------------
[17:20:36.153] <TB3> INFO: Test took 21014ms.
[17:20:41.699] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[17:20:42.216] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 160 0 1 0 0 0 0 0 0
[17:20:42.216] <TB3> INFO: number of red-efficiency pixels: 885 1342 908 2653 3007 3281 3153 3120 3041 3036 3377 2759 2731 962 1162 1149
[17:20:42.216] <TB3> INFO: number of X-ray hits detected: 342147 358105 309266 561119 587917 690650 685141 637643 654843 671808 739708 633206 598512 331641 387853 326379
[17:20:42.216] <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
[17:20:42.216] <TB3> INFO: number of Vcal hits detected: 206954 206321 206443 202736 200739 199190 199956 193905 201564 200748 198574 201808 202295 206330 206585 206540
[17:20:42.216] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.3 99.4 97.8 96.9 96.2 96.7 97.2 97.2 96.9 96.0 97.4 97.6 99.4 99.4 99.4
[17:20:42.216] <TB3> INFO: Vcal hit overall efficiency (%): 99.5 99.2 99.3 97.5 96.5 95.8 96.1 93.2 96.9 96.5 95.5 97.0 97.3 99.2 99.3 99.3
[17:20:42.216] <TB3> INFO: X-ray hit rate [MHz/cm2]: 100.3 105.0 90.6 164.5 172.3 202.4 200.8 186.9 191.9 196.9 216.8 185.6 175.4 97.2 113.7 95.7
[17:20:42.216] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[17:20:42.241] <TB3> INFO: PixTest:: pg_setup set to default.
[17:20:42.278] <TB3> INFO: enter test to run
[17:20:42.278] <TB3> INFO: test: no parameter change
[17:20:42.424] <TB3> QUIET: Connection to board 121 closed.
[17:20:42.503] <TB3> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master