Test Date: 2015-07-07 08:06
Analysis date: 2016-05-25 21:25
Logfile
commander_PixelAlive.log
[06:06:45.811] <TB2> INFO: *** Welcome to pxar ***
[06:06:45.811] <TB2> INFO: *** Today: 2015/07/07
[06:06:45.811] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//000_PixelAlive_p17//dacParameters35_C15.dat
[06:06:45.812] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//000_PixelAlive_p17//tbmParameters_C0b.dat
[06:06:45.812] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//000_PixelAlive_p17//defaultMaskFile.dat
[06:06:45.812] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//000_PixelAlive_p17//trimParameters35_C15.dat
[06:06:45.924] <TB2> INFO: clk: 4
[06:06:45.924] <TB2> INFO: ctr: 4
[06:06:45.924] <TB2> INFO: sda: 19
[06:06:45.924] <TB2> INFO: tin: 9
[06:06:45.924] <TB2> INFO: level: 15
[06:06:45.924] <TB2> INFO: triggerdelay: 0
[06:06:45.924] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[06:06:45.924] <TB2> INFO: Log level: INFO
[06:06:45.938] <TB2> INFO: Found DTB DTB_WXENWR
[06:06:45.955] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[06:06:45.958] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[06:06:45.961] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[06:06:47.521] <TB2> INFO: DUT info:
[06:06:47.521] <TB2> INFO: The DUT currently contains the following objects:
[06:06:47.521] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:06:47.521] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:06:47.521] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:06:47.521] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:06:47.521] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.521] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.521] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.522] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:06:47.923] <TB2> INFO: enter 'restricted' command line mode
[06:06:47.923] <TB2> INFO: enter test to run
[06:06:47.923] <TB2> INFO: test: PixelAlive no parameter change
[06:06:47.923] <TB2> INFO: running: pixelalive
[06:06:47.930] <TB2> INFO: ######################################################################
[06:06:47.930] <TB2> INFO: PixTestAlive::doTest()
[06:06:47.930] <TB2> INFO: ######################################################################
[06:06:47.932] <TB2> INFO: ----------------------------------------------------------------------
[06:06:47.932] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:06:47.932] <TB2> INFO: ----------------------------------------------------------------------
[06:06:51.410] <TB2> INFO: Test took 3476ms.
[06:06:51.437] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:06:51.709] <TB2> INFO: PixTestAlive::aliveTest() done
[06:06:51.709] <TB2> INFO: number of dead pixels (per ROC): 1 0 0 1 0 0 0 2 0 0 1 0 1 0 0 0
[06:06:51.711] <TB2> INFO: ----------------------------------------------------------------------
[06:06:51.711] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:06:51.711] <TB2> INFO: ----------------------------------------------------------------------
[06:06:54.377] <TB2> INFO: Test took 2664ms.
[06:06:54.378] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:06:54.378] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[06:06:54.617] <TB2> INFO: PixTestAlive::maskTest() done
[06:06:54.617] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[06:06:54.618] <TB2> INFO: ----------------------------------------------------------------------
[06:06:54.618] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[06:06:54.618] <TB2> INFO: ----------------------------------------------------------------------
[06:06:58.055] <TB2> INFO: Test took 3435ms.
[06:06:58.079] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:06:58.322] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[06:06:58.322] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[06:06:58.322] <TB2> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[06:06:58.361] <TB2> INFO: enter test to run
[06:06:58.362] <TB2> INFO: test: no parameter change
[06:06:58.463] <TB2> QUIET: Connection to board 162 closed.
[06:06:58.543] <TB2> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[06:07:10.715] <TB2> INFO: *** Welcome to pxar ***
[06:07:10.715] <TB2> INFO: *** Today: 2015/07/07
[06:07:10.715] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//dacParameters35_C15.dat
[06:07:10.716] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//tbmParameters_C0b.dat
[06:07:10.716] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//defaultMaskFile.dat
[06:07:10.716] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C15.dat
[06:07:10.798] <TB2> INFO: clk: 4
[06:07:10.798] <TB2> INFO: ctr: 4
[06:07:10.798] <TB2> INFO: sda: 19
[06:07:10.798] <TB2> INFO: tin: 9
[06:07:10.798] <TB2> INFO: level: 15
[06:07:10.798] <TB2> INFO: triggerdelay: 0
[06:07:10.798] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[06:07:10.798] <TB2> INFO: Log level: INFO
[06:07:10.813] <TB2> INFO: Found DTB DTB_WXENWR
[06:07:10.829] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[06:07:10.833] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[06:07:10.835] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[06:07:12.381] <TB2> INFO: DUT info:
[06:07:12.381] <TB2> INFO: The DUT currently contains the following objects:
[06:07:12.381] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:07:12.381] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:07:12.381] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:07:12.381] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:07:12.381] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.381] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:07:12.782] <TB2> INFO: enter 'restricted' command line mode
[06:07:12.782] <TB2> INFO: enter test to run
[06:07:12.783] <TB2> INFO: test: delay setting parameters: ->5<-
[06:07:12.783] <TB2> INFO: delay test by 5 seconds...
[06:07:17.783] <TB2> INFO: enter test to run
[06:07:17.783] <TB2> INFO: test: highrate no parameter change
[06:07:17.783] <TB2> INFO: running: highrate
[06:07:17.783] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//phCalibrationFitErr35_C15.dat
[06:07:17.932] <TB2> INFO: ----------------------------------------------------------------------
[06:07:17.932] <TB2> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[06:07:17.932] <TB2> INFO: ----------------------------------------------------------------------
[06:07:17.932] <TB2> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[06:07:17.932] <TB2> INFO: edge/corner pixel THR is adjusted
[06:07:17.932] <TB2> INFO: PixTestHighRate::trimHotPixels: step 0...
[06:07:18.899] <TB2> INFO: Collecting data for 1 seconds...
[06:07:19.901] <TB2> INFO: Done with hot pixel readout
[06:07:25.434] <TB2> INFO: PixTest:: pg_setup set to default.
[06:07:25.435] <TB2> INFO: 9 hot pixels found in step 0
[06:07:26.402] <TB2> INFO: Collecting data for 1 seconds...
[06:07:27.403] <TB2> INFO: Done with hot pixel readout
[06:07:32.965] <TB2> INFO: PixTest:: pg_setup set to default.
[06:07:32.966] <TB2> INFO: 7 hot pixels found in step 1
[06:07:33.936] <TB2> INFO: Collecting data for 1 seconds...
[06:07:34.938] <TB2> INFO: Done with hot pixel readout
[06:07:40.537] <TB2> INFO: PixTest:: pg_setup set to default.
[06:07:40.538] <TB2> INFO: 5 hot pixels found in step 2
[06:07:41.505] <TB2> INFO: Collecting data for 1 seconds...
[06:07:42.507] <TB2> INFO: Done with hot pixel readout
[06:07:48.110] <TB2> INFO: PixTest:: pg_setup set to default.
[06:07:48.111] <TB2> INFO: 4 hot pixels found in step 3
[06:07:49.079] <TB2> INFO: Collecting data for 1 seconds...
[06:07:50.081] <TB2> INFO: Done with hot pixel readout
[06:07:55.626] <TB2> INFO: PixTest:: pg_setup set to default.
[06:07:55.627] <TB2> INFO: 2 hot pixels found in step 4
[06:07:56.598] <TB2> INFO: Collecting data for 1 seconds...
[06:07:57.598] <TB2> INFO: Done with hot pixel readout
[06:08:02.383] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:02.384] <TB2> INFO: 3 hot pixels found in step 5
[06:08:03.350] <TB2> INFO: Collecting data for 1 seconds...
[06:08:04.351] <TB2> INFO: Done with hot pixel readout
[06:08:09.154] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:09.154] <TB2> INFO: 3 hot pixels found in step 6
[06:08:10.121] <TB2> INFO: Collecting data for 1 seconds...
[06:08:11.123] <TB2> INFO: Done with hot pixel readout
[06:08:15.966] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:15.967] <TB2> INFO: 3 hot pixels found in step 7
[06:08:16.934] <TB2> INFO: Collecting data for 1 seconds...
[06:08:17.935] <TB2> INFO: Done with hot pixel readout
[06:08:22.719] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:22.720] <TB2> INFO: 3 hot pixels found in step 8
[06:08:23.687] <TB2> INFO: Collecting data for 1 seconds...
[06:08:24.687] <TB2> INFO: Done with hot pixel readout
[06:08:29.509] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:29.510] <TB2> INFO: 1 hot pixels found in step 9
[06:08:30.476] <TB2> INFO: Collecting data for 1 seconds...
[06:08:31.477] <TB2> INFO: Done with hot pixel readout
[06:08:36.239] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:36.241] <TB2> INFO: 1 hot pixels found in step 10
[06:08:37.206] <TB2> INFO: Collecting data for 1 seconds...
[06:08:38.207] <TB2> INFO: Done with hot pixel readout
[06:08:43.002] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:43.003] <TB2> INFO: 1 hot pixels found in step 11
[06:08:43.968] <TB2> INFO: Collecting data for 1 seconds...
[06:08:44.969] <TB2> INFO: Done with hot pixel readout
[06:08:49.748] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:49.749] <TB2> INFO: 1 hot pixels found in step 12
[06:08:50.715] <TB2> INFO: Collecting data for 1 seconds...
[06:08:51.716] <TB2> INFO: Done with hot pixel readout
[06:08:56.506] <TB2> INFO: PixTest:: pg_setup set to default.
[06:08:56.507] <TB2> INFO: 2 hot pixels found in step 13
[06:08:57.473] <TB2> INFO: Collecting data for 1 seconds...
[06:08:58.474] <TB2> INFO: Done with hot pixel readout
[06:09:03.255] <TB2> INFO: PixTest:: pg_setup set to default.
[06:09:03.256] <TB2> INFO: 2 hot pixels found in step 14
[06:09:03.263] <TB2> INFO: 2 hot pixels could not be trimmed and have been masked.
[06:09:03.291] <TB2> INFO: PixTest::trimHotPixels() done
[06:09:03.292] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C0.dat
[06:09:03.298] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C1.dat
[06:09:03.305] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C2.dat
[06:09:03.311] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C3.dat
[06:09:03.318] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C4.dat
[06:09:03.324] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C5.dat
[06:09:03.331] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C6.dat
[06:09:03.338] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C7.dat
[06:09:03.344] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C8.dat
[06:09:03.350] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C9.dat
[06:09:03.357] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C10.dat
[06:09:03.363] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C11.dat
[06:09:03.370] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C12.dat
[06:09:03.376] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C13.dat
[06:09:03.383] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C14.dat
[06:09:03.389] <TB2> INFO: write trim parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//trimParameters35_C15.dat
[06:09:03.396] <TB2> INFO: write masked pixels into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//001_RetrimHotPixels_p17//defaultMaskFile.dat
[06:09:03.429] <TB2> INFO: enter test to run
[06:09:03.429] <TB2> INFO: test: no parameter change
[06:09:03.554] <TB2> QUIET: Connection to board 162 closed.
[06:09:03.633] <TB2> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[06:09:10.245] <TB2> INFO: *** Welcome to pxar ***
[06:09:10.245] <TB2> INFO: *** Today: 2015/07/07
[06:09:10.245] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C15.dat
[06:09:10.247] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//tbmParameters_C0b.dat
[06:09:10.247] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//defaultMaskFile.dat
[06:09:10.247] <TB2> INFO: MASKED Roc 7 col/row: 47 79
[06:09:10.247] <TB2> INFO: MASKED Roc 8 col/row: 7 78
[06:09:10.247] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//trimParameters35_C15.dat
[06:09:10.282] <TB2> INFO: masking Roc 7 col/row: 47 79
[06:09:10.299] <TB2> INFO: masking Roc 8 col/row: 7 78
[06:09:10.362] <TB2> INFO: clk: 4
[06:09:10.362] <TB2> INFO: ctr: 4
[06:09:10.362] <TB2> INFO: sda: 19
[06:09:10.362] <TB2> INFO: tin: 9
[06:09:10.362] <TB2> INFO: level: 15
[06:09:10.362] <TB2> INFO: triggerdelay: 0
[06:09:10.362] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[06:09:10.362] <TB2> INFO: Log level: INFO
[06:09:10.374] <TB2> INFO: Found DTB DTB_WXENWR
[06:09:10.391] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[06:09:10.394] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[06:09:10.397] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[06:09:12.061] <TB2> INFO: DUT info:
[06:09:12.061] <TB2> INFO: The DUT currently contains the following objects:
[06:09:12.061] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:09:12.061] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:09:12.061] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:09:12.061] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:09:12.061] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 1 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.061] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:09:12.463] <TB2> INFO: enter 'restricted' command line mode
[06:09:12.463] <TB2> INFO: enter test to run
[06:09:12.463] <TB2> INFO: test: HighRate no parameter change
[06:09:12.463] <TB2> INFO: running: highrate
[06:09:12.463] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//phCalibrationFitErr35_C15.dat
[06:09:12.662] <TB2> INFO: ----------------------------------------------------------------------
[06:09:12.662] <TB2> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[06:09:12.662] <TB2> INFO: ----------------------------------------------------------------------
[06:09:13.749] <TB2> INFO: Test took 1080ms.
[06:09:13.752] <TB2> INFO: ROC 7 masking pixel 47/79
[06:09:13.752] <TB2> INFO: ROC 8 masking pixel 7/78
[06:09:17.059] <TB2> INFO: Test took 3305ms.
[06:09:17.289] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:20.949] <TB2> INFO: Test took 3608ms.
[06:09:21.140] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:24.774] <TB2> INFO: Test took 3599ms.
[06:09:24.964] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:28.590] <TB2> INFO: Test took 3589ms.
[06:09:28.775] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:32.388] <TB2> INFO: Test took 3579ms.
[06:09:32.574] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:36.157] <TB2> INFO: Test took 3550ms.
[06:09:36.344] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:39.957] <TB2> INFO: Test took 3577ms.
[06:09:40.155] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:43.753] <TB2> INFO: Test took 3564ms.
[06:09:43.941] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:47.534] <TB2> INFO: Test took 3559ms.
[06:09:47.723] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:51.284] <TB2> INFO: Test took 3526ms.
[06:09:51.482] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:55.063] <TB2> INFO: Test took 3545ms.
[06:09:55.247] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:09:58.850] <TB2> INFO: Test took 3570ms.
[06:09:59.041] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:02.638] <TB2> INFO: Test took 3563ms.
[06:10:02.830] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:06.425] <TB2> INFO: Test took 3559ms.
[06:10:06.625] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:10.177] <TB2> INFO: Test took 3516ms.
[06:10:10.362] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:13.847] <TB2> INFO: Test took 3450ms.
[06:10:14.034] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:17.612] <TB2> INFO: Test took 3544ms.
[06:10:17.789] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:21.443] <TB2> INFO: Test took 3617ms.
[06:10:21.636] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:25.319] <TB2> INFO: Test took 3649ms.
[06:10:25.516] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:29.155] <TB2> INFO: Test took 3603ms.
[06:10:29.348] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:10:29.696] <TB2> INFO: enter test to run
[06:10:29.696] <TB2> INFO: test: Pretest no parameter change
[06:10:29.696] <TB2> INFO: running: pretest
[06:10:29.696] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C0.dat
[06:10:29.697] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C1.dat
[06:10:29.697] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C2.dat
[06:10:29.697] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C3.dat
[06:10:29.697] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C4.dat
[06:10:29.697] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C5.dat
[06:10:29.697] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C6.dat
[06:10:29.697] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C7.dat
[06:10:29.697] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C8.dat
[06:10:29.698] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C9.dat
[06:10:29.698] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C10.dat
[06:10:29.698] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C11.dat
[06:10:29.698] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C12.dat
[06:10:29.698] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C13.dat
[06:10:29.698] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C14.dat
[06:10:29.698] <TB2> INFO: write dac parameters into /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//002_CalDelScanAndSaveDacs_p17//dacParameters35_C15.dat
[06:10:29.698] <TB2> INFO: enter test to run
[06:10:29.698] <TB2> INFO: test: no parameter change
[06:10:29.933] <TB2> QUIET: Connection to board 162 closed.
[06:10:30.012] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[06:10:59.034] <TB2> INFO: *** Welcome to pxar ***
[06:10:59.034] <TB2> INFO: *** Today: 2015/07/07
[06:10:59.034] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//dacParameters35_C15.dat
[06:10:59.035] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//tbmParameters_C0b.dat
[06:10:59.035] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//defaultMaskFile.dat
[06:10:59.035] <TB2> INFO: MASKED Roc 7 col/row: 47 79
[06:10:59.035] <TB2> INFO: MASKED Roc 8 col/row: 7 78
[06:10:59.035] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//trimParameters35_C15.dat
[06:10:59.090] <TB2> INFO: masking Roc 7 col/row: 47 79
[06:10:59.097] <TB2> INFO: masking Roc 8 col/row: 7 78
[06:10:59.160] <TB2> INFO: clk: 4
[06:10:59.160] <TB2> INFO: ctr: 4
[06:10:59.160] <TB2> INFO: sda: 19
[06:10:59.160] <TB2> INFO: tin: 9
[06:10:59.160] <TB2> INFO: level: 15
[06:10:59.160] <TB2> INFO: triggerdelay: 0
[06:10:59.160] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[06:10:59.160] <TB2> INFO: Log level: INFO
[06:10:59.177] <TB2> INFO: Found DTB DTB_WXENWR
[06:10:59.193] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[06:10:59.196] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[06:10:59.200] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[06:11:00.823] <TB2> INFO: DUT info:
[06:11:00.823] <TB2> INFO: The DUT currently contains the following objects:
[06:11:00.823] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:11:00.823] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:11:00.823] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:11:00.823] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:11:00.823] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.823] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.823] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 1 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:00.824] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:01.225] <TB2> INFO: enter 'restricted' command line mode
[06:11:01.225] <TB2> INFO: enter test to run
[06:11:01.225] <TB2> INFO: test: delay setting parameters: ->10<-
[06:11:01.225] <TB2> INFO: delay test by 10 seconds...
[06:11:11.225] <TB2> INFO: enter test to run
[06:11:11.225] <TB2> INFO: test: HighRate no parameter change
[06:11:11.225] <TB2> INFO: running: highrate
[06:11:11.226] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//003_HREfficiency_p17//phCalibrationFitErr35_C15.dat
[06:11:11.455] <TB2> INFO: ----------------------------------------------------------------------
[06:11:11.455] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[06:11:11.456] <TB2> INFO: ----------------------------------------------------------------------
[06:11:11.463] <TB2> INFO: ROC 7 masking pixel 47/79
[06:11:11.463] <TB2> INFO: ROC 8 masking pixel 7/78
[06:11:23.792] <TB2> INFO: Test took 12328ms.
[06:11:24.973] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:11:25.389] <TB2> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 0 1 1 0 0 0 0 0 0 0
[06:11:25.389] <TB2> INFO: number of red-efficiency pixels: 144 128 157 386 313 503 433 491 503 518 591 335 358 167 155 129
[06:11:25.389] <TB2> INFO: number of X-ray hits detected: 101076 107900 97699 203883 192094 260331 231933 254115 257989 256855 255473 208199 206784 117366 113262 103584
[06:11:25.389] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[06:11:25.389] <TB2> INFO: number of Vcal hits detected: 207804 207870 207837 207589 207664 207449 207494 207418 207416 207414 207346 207633 207618 207824 207843 207869
[06:11:25.389] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.9 99.8 99.8 99.8 99.8 99.7 99.7 99.8 99.8 99.9 99.9 99.9
[06:11:25.389] <TB2> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.7 99.8 99.7 99.7 99.7 99.7 99.8 99.8 99.9 99.9 99.9
[06:11:25.389] <TB2> INFO: X-ray hit rate [MHz/cm2]: 29.6 31.6 28.6 59.8 56.3 76.3 68.0 74.5 75.6 75.3 74.9 61.0 60.6 34.4 33.2 30.4
[06:11:25.389] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[06:11:25.435] <TB2> INFO: PixTest:: pg_setup set to default.
[06:11:25.472] <TB2> INFO: enter test to run
[06:11:25.472] <TB2> INFO: test: no parameter change
[06:11:25.648] <TB2> QUIET: Connection to board 162 closed.
[06:11:25.728] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[06:11:38.886] <TB2> INFO: *** Welcome to pxar ***
[06:11:38.886] <TB2> INFO: *** Today: 2015/07/07
[06:11:38.886] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//dacParameters35_C15.dat
[06:11:38.887] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//tbmParameters_C0b.dat
[06:11:38.888] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//defaultMaskFile.dat
[06:11:38.888] <TB2> INFO: MASKED Roc 7 col/row: 47 79
[06:11:38.888] <TB2> INFO: MASKED Roc 8 col/row: 7 78
[06:11:38.888] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//trimParameters35_C15.dat
[06:11:38.925] <TB2> INFO: masking Roc 7 col/row: 47 79
[06:11:38.930] <TB2> INFO: masking Roc 8 col/row: 7 78
[06:11:38.971] <TB2> INFO: clk: 4
[06:11:38.971] <TB2> INFO: ctr: 4
[06:11:38.971] <TB2> INFO: sda: 19
[06:11:38.971] <TB2> INFO: tin: 9
[06:11:38.971] <TB2> INFO: level: 15
[06:11:38.971] <TB2> INFO: triggerdelay: 0
[06:11:38.971] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[06:11:38.971] <TB2> INFO: Log level: INFO
[06:11:38.984] <TB2> INFO: Found DTB DTB_WXENWR
[06:11:39.002] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[06:11:39.005] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[06:11:39.008] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[06:11:40.556] <TB2> INFO: DUT info:
[06:11:40.556] <TB2> INFO: The DUT currently contains the following objects:
[06:11:40.557] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:11:40.557] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:11:40.557] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:11:40.557] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:11:40.557] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 1 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.557] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:11:40.959] <TB2> INFO: enter 'restricted' command line mode
[06:11:40.959] <TB2> INFO: enter test to run
[06:11:40.959] <TB2> INFO: test: delay setting parameters: ->10<-
[06:11:40.959] <TB2> INFO: delay test by 10 seconds...
[06:11:50.959] <TB2> INFO: enter test to run
[06:11:50.959] <TB2> INFO: test: HighRate no parameter change
[06:11:50.959] <TB2> INFO: running: highrate
[06:11:50.959] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//004_HREfficiency_p17//phCalibrationFitErr35_C15.dat
[06:11:51.098] <TB2> INFO: ----------------------------------------------------------------------
[06:11:51.098] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[06:11:51.098] <TB2> INFO: ----------------------------------------------------------------------
[06:11:51.105] <TB2> INFO: ROC 7 masking pixel 47/79
[06:11:51.105] <TB2> INFO: ROC 8 masking pixel 7/78
[06:12:06.222] <TB2> INFO: Test took 15118ms.
[06:12:09.535] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:12:09.985] <TB2> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 0 1 1 0 0 0 0 0 0 0
[06:12:09.985] <TB2> INFO: number of red-efficiency pixels: 400 432 529 1310 1155 2045 1655 1955 1977 2069 2229 1318 1380 626 440 317
[06:12:09.985] <TB2> INFO: number of X-ray hits detected: 203667 217083 200288 401356 380176 508802 458578 503300 511122 508275 500945 411119 406598 239139 228518 209388
[06:12:09.985] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[06:12:09.985] <TB2> INFO: number of Vcal hits detected: 207522 207536 207303 206289 206471 204725 205502 205108 204983 204637 204253 206082 206171 207100 207535 207662
[06:12:09.985] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.8 99.8 99.7 99.3 99.3 98.6 98.9 98.7 98.7 98.5 98.4 99.2 99.2 99.6 99.8 99.8
[06:12:09.985] <TB2> INFO: Vcal hit overall efficiency (%): 99.8 99.8 99.7 99.2 99.3 98.4 98.8 98.6 98.5 98.4 98.2 99.1 99.1 99.6 99.8 99.8
[06:12:09.985] <TB2> INFO: X-ray hit rate [MHz/cm2]: 59.7 63.6 58.7 117.6 111.4 149.1 134.4 147.5 149.8 149.0 146.8 120.5 119.2 70.1 67.0 61.4
[06:12:09.985] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[06:12:10.030] <TB2> INFO: PixTest:: pg_setup set to default.
[06:12:10.073] <TB2> INFO: enter test to run
[06:12:10.073] <TB2> INFO: test: no parameter change
[06:12:10.232] <TB2> QUIET: Connection to board 162 closed.
[06:12:10.311] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[06:12:24.239] <TB2> INFO: *** Welcome to pxar ***
[06:12:24.239] <TB2> INFO: *** Today: 2015/07/07
[06:12:24.239] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//dacParameters35_C15.dat
[06:12:24.240] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//tbmParameters_C0b.dat
[06:12:24.241] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//defaultMaskFile.dat
[06:12:24.241] <TB2> INFO: MASKED Roc 7 col/row: 47 79
[06:12:24.241] <TB2> INFO: MASKED Roc 8 col/row: 7 78
[06:12:24.241] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//trimParameters35_C15.dat
[06:12:24.283] <TB2> INFO: masking Roc 7 col/row: 47 79
[06:12:24.288] <TB2> INFO: masking Roc 8 col/row: 7 78
[06:12:24.323] <TB2> INFO: clk: 4
[06:12:24.323] <TB2> INFO: ctr: 4
[06:12:24.323] <TB2> INFO: sda: 19
[06:12:24.323] <TB2> INFO: tin: 9
[06:12:24.323] <TB2> INFO: level: 15
[06:12:24.323] <TB2> INFO: triggerdelay: 0
[06:12:24.323] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[06:12:24.323] <TB2> INFO: Log level: INFO
[06:12:24.336] <TB2> INFO: Found DTB DTB_WXENWR
[06:12:24.352] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[06:12:24.355] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[06:12:24.358] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[06:12:26.001] <TB2> INFO: DUT info:
[06:12:26.001] <TB2> INFO: The DUT currently contains the following objects:
[06:12:26.001] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:12:26.001] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:12:26.001] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:12:26.001] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:12:26.001] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.001] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.001] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.001] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 1 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.002] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:12:26.403] <TB2> INFO: enter 'restricted' command line mode
[06:12:26.403] <TB2> INFO: enter test to run
[06:12:26.403] <TB2> INFO: test: delay setting parameters: ->10<-
[06:12:26.403] <TB2> INFO: delay test by 10 seconds...
[06:12:36.403] <TB2> INFO: enter test to run
[06:12:36.403] <TB2> INFO: test: HighRate no parameter change
[06:12:36.404] <TB2> INFO: running: highrate
[06:12:36.404] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//005_HREfficiency_p17//phCalibrationFitErr35_C15.dat
[06:12:36.538] <TB2> INFO: ----------------------------------------------------------------------
[06:12:36.538] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[06:12:36.538] <TB2> INFO: ----------------------------------------------------------------------
[06:12:36.545] <TB2> INFO: ROC 7 masking pixel 47/79
[06:12:36.545] <TB2> INFO: ROC 8 masking pixel 7/78
[06:12:54.151] <TB2> INFO: Test took 17606ms.
[06:13:00.306] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:13:00.824] <TB2> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 0 1 1 0 0 0 0 0 0 0
[06:13:00.824] <TB2> INFO: number of red-efficiency pixels: 895 844 956 2520 2236 3354 2944 3501 3484 3497 3640 2549 2607 1138 854 693
[06:13:00.824] <TB2> INFO: number of X-ray hits detected: 293893 314689 291914 572353 545431 728138 653939 721798 731473 730766 711544 591619 581529 347172 331673 304101
[06:13:00.824] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[06:13:00.824] <TB2> INFO: number of Vcal hits detected: 206891 207030 206146 203341 203788 198665 201030 199579 199077 197883 197141 202741 203169 205600 207015 207232
[06:13:00.824] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.5 99.6 99.3 98.0 98.2 96.0 97.0 96.3 96.1 95.6 95.3 97.8 97.9 99.1 99.6 99.7
[06:13:00.824] <TB2> INFO: Vcal hit overall efficiency (%): 99.5 99.5 99.1 97.8 98.0 95.5 96.6 96.0 95.7 95.1 94.8 97.5 97.7 98.8 99.5 99.6
[06:13:00.824] <TB2> INFO: X-ray hit rate [MHz/cm2]: 86.1 92.2 85.6 167.8 159.9 213.4 191.7 211.6 214.4 214.2 208.6 173.4 170.5 101.8 97.2 89.1
[06:13:00.824] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[06:13:00.868] <TB2> INFO: PixTest:: pg_setup set to default.
[06:13:00.906] <TB2> INFO: enter test to run
[06:13:00.906] <TB2> INFO: test: no parameter change
[06:13:01.098] <TB2> QUIET: Connection to board 162 closed.
[06:13:01.178] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[06:13:15.730] <TB2> INFO: *** Welcome to pxar ***
[06:13:15.730] <TB2> INFO: *** Today: 2015/07/07
[06:13:15.730] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//dacParameters35_C15.dat
[06:13:15.730] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//tbmParameters_C0b.dat
[06:13:15.731] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//defaultMaskFile.dat
[06:13:15.731] <TB2> INFO: MASKED Roc 7 col/row: 47 79
[06:13:15.731] <TB2> INFO: MASKED Roc 8 col/row: 7 78
[06:13:15.731] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//trimParameters35_C15.dat
[06:13:15.764] <TB2> INFO: masking Roc 7 col/row: 47 79
[06:13:15.768] <TB2> INFO: masking Roc 8 col/row: 7 78
[06:13:15.810] <TB2> INFO: clk: 4
[06:13:15.810] <TB2> INFO: ctr: 4
[06:13:15.810] <TB2> INFO: sda: 19
[06:13:15.810] <TB2> INFO: tin: 9
[06:13:15.810] <TB2> INFO: level: 15
[06:13:15.810] <TB2> INFO: triggerdelay: 0
[06:13:15.810] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[06:13:15.810] <TB2> INFO: Log level: INFO
[06:13:15.824] <TB2> INFO: Found DTB DTB_WXENWR
[06:13:15.841] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[06:13:15.844] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[06:13:15.847] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[06:13:17.395] <TB2> INFO: DUT info:
[06:13:17.395] <TB2> INFO: The DUT currently contains the following objects:
[06:13:17.395] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:13:17.395] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:13:17.395] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:13:17.395] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:13:17.395] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 1 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.395] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:13:17.797] <TB2> INFO: enter 'restricted' command line mode
[06:13:17.797] <TB2> INFO: enter test to run
[06:13:17.797] <TB2> INFO: test: delay setting parameters: ->10<-
[06:13:17.797] <TB2> INFO: delay test by 10 seconds...
[06:13:27.797] <TB2> INFO: enter test to run
[06:13:27.810] <TB2> INFO: test: HighRate no parameter change
[06:13:27.810] <TB2> INFO: running: highrate
[06:13:27.810] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//006_HREfficiency_p17//phCalibrationFitErr35_C15.dat
[06:13:27.964] <TB2> INFO: ----------------------------------------------------------------------
[06:13:27.964] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[06:13:27.964] <TB2> INFO: ----------------------------------------------------------------------
[06:13:27.971] <TB2> INFO: ROC 7 masking pixel 47/79
[06:13:27.971] <TB2> INFO: ROC 8 masking pixel 7/78
[06:13:48.325] <TB2> INFO: Test took 20353ms.
[06:13:59.467] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:14:00.106] <TB2> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 0 1 1 0 0 0 0 0 0 0
[06:14:00.106] <TB2> INFO: number of red-efficiency pixels: 1687 1581 1606 3542 3361 4066 3901 4085 4094 4095 4118 3597 3702 1707 1607 1322
[06:14:00.106] <TB2> INFO: number of X-ray hits detected: 399008 425688 395965 768049 730424 977761 875572 970515 986506 981671 952520 795528 782956 471788 449227 411035
[06:14:00.106] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[06:14:00.106] <TB2> INFO: number of Vcal hits detected: 205632 205859 203670 196996 198153 185846 191698 187318 186335 183921 183189 195582 196070 202585 205916 206308
[06:14:00.106] <TB2> INFO: Vcal hit fiducial efficiency (%): 99.0 99.0 98.3 95.2 95.8 90.4 92.9 90.7 90.3 89.3 89.1 94.7 94.8 97.9 99.1 99.3
[06:14:00.106] <TB2> INFO: Vcal hit overall efficiency (%): 98.9 99.0 97.9 94.7 95.3 89.3 92.2 90.1 89.6 88.4 88.1 94.0 94.3 97.4 99.0 99.2
[06:14:00.106] <TB2> INFO: X-ray hit rate [MHz/cm2]: 117.0 124.8 116.1 225.1 214.1 286.6 256.6 284.5 289.2 287.7 279.2 233.2 229.5 138.3 131.7 120.5
[06:14:00.106] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[06:14:00.150] <TB2> INFO: PixTest:: pg_setup set to default.
[06:14:00.209] <TB2> INFO: enter test to run
[06:14:00.209] <TB2> INFO: test: no parameter change
[06:14:00.386] <TB2> QUIET: Connection to board 162 closed.
[06:14:00.472] <TB2> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[06:14:15.130] <TB2> INFO: *** Welcome to pxar ***
[06:14:15.130] <TB2> INFO: *** Today: 2015/07/07
[06:14:15.130] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//dacParameters35_C15.dat
[06:14:15.131] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//tbmParameters_C0b.dat
[06:14:15.131] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//defaultMaskFile.dat
[06:14:15.131] <TB2> INFO: MASKED Roc 7 col/row: 47 79
[06:14:15.131] <TB2> INFO: MASKED Roc 8 col/row: 7 78
[06:14:15.131] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//trimParameters35_C15.dat
[06:14:15.164] <TB2> INFO: masking Roc 7 col/row: 47 79
[06:14:15.168] <TB2> INFO: masking Roc 8 col/row: 7 78
[06:14:15.203] <TB2> INFO: clk: 4
[06:14:15.203] <TB2> INFO: ctr: 4
[06:14:15.203] <TB2> INFO: sda: 19
[06:14:15.203] <TB2> INFO: tin: 9
[06:14:15.203] <TB2> INFO: level: 15
[06:14:15.203] <TB2> INFO: triggerdelay: 0
[06:14:15.203] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[06:14:15.203] <TB2> INFO: Log level: INFO
[06:14:15.215] <TB2> INFO: Found DTB DTB_WXENWR
[06:14:15.232] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[06:14:15.235] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[06:14:15.238] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[06:14:16.820] <TB2> INFO: DUT info:
[06:14:16.820] <TB2> INFO: The DUT currently contains the following objects:
[06:14:16.820] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:14:16.820] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:14:16.820] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:14:16.820] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:14:16.820] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 1 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 1 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.820] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:16.821] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:14:17.222] <TB2> INFO: enter 'restricted' command line mode
[06:14:17.222] <TB2> INFO: enter test to run
[06:14:17.222] <TB2> INFO: test: delay setting parameters: ->10<-
[06:14:17.222] <TB2> INFO: delay test by 10 seconds...
[06:14:27.222] <TB2> INFO: enter test to run
[06:14:27.222] <TB2> INFO: test: HighRate no parameter change
[06:14:27.222] <TB2> INFO: running: highrate
[06:14:27.223] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_08h06m_1436249186//007_HREfficiency_p17//phCalibrationFitErr35_C15.dat
[06:14:27.465] <TB2> INFO: ----------------------------------------------------------------------
[06:14:27.465] <TB2> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[06:14:27.465] <TB2> INFO: ----------------------------------------------------------------------
[06:14:27.473] <TB2> INFO: ROC 7 masking pixel 47/79
[06:14:27.473] <TB2> INFO: ROC 8 masking pixel 7/78
[06:14:48.094] <TB2> INFO: Test took 20621ms.
[06:14:59.038] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[06:14:59.663] <TB2> INFO: number of dead pixels (per ROC): 1 0 0 0 0 0 0 1 1 0 0 0 0 0 0 0
[06:14:59.663] <TB2> INFO: number of red-efficiency pixels: 1793 1674 1668 3677 3477 4084 3974 4121 4100 4109 4115 3697 3764 1777 1775 1426
[06:14:59.663] <TB2> INFO: number of X-ray hits detected: 410914 441692 413291 783019 750375 996365 900958 996432 1009312 1006485 971917 813015 800569 488561 463412 422401
[06:14:59.663] <TB2> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[06:14:59.663] <TB2> INFO: number of Vcal hits detected: 205370 205662 203561 196180 197447 184493 189975 185650 184735 182513 182239 194572 195397 202260 205560 206119
[06:14:59.663] <TB2> INFO: Vcal hit fiducial efficiency (%): 98.9 99.0 98.3 94.9 95.5 89.8 92.1 90.0 89.6 88.6 88.7 94.2 94.5 97.7 98.9 99.2
[06:14:59.663] <TB2> INFO: Vcal hit overall efficiency (%): 98.7 98.9 97.9 94.3 94.9 88.7 91.3 89.3 88.8 87.7 87.6 93.5 93.9 97.2 98.8 99.1
[06:14:59.663] <TB2> INFO: X-ray hit rate [MHz/cm2]: 120.4 129.5 121.1 229.5 219.9 292.0 264.1 292.1 295.8 295.0 284.9 238.3 234.7 143.2 135.8 123.8
[06:14:59.663] <TB2> INFO: PixTestHighRate::doXPixelAlive() done
[06:14:59.707] <TB2> INFO: PixTest:: pg_setup set to default.
[06:14:59.769] <TB2> INFO: enter test to run
[06:14:59.769] <TB2> INFO: test: no parameter change
[06:14:59.926] <TB2> QUIET: Connection to board 162 closed.
[06:15:00.006] <TB2> INFO: pXar: this is the end, my friend
commander_HRData.log
[07:31:48.106] <TB2> INFO: *** Welcome to pxar ***
[07:31:48.106] <TB2> INFO: *** Today: 2015/07/07
[07:31:48.106] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//dacParameters35_C15.dat
[07:31:48.108] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//tbmParameters_C0b.dat
[07:31:48.108] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//defaultMaskFile.dat
[07:31:48.108] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//trimParameters35_C15.dat
[07:31:48.221] <TB2> INFO: clk: 4
[07:31:48.221] <TB2> INFO: ctr: 4
[07:31:48.221] <TB2> INFO: sda: 19
[07:31:48.221] <TB2> INFO: tin: 9
[07:31:48.221] <TB2> INFO: level: 15
[07:31:48.221] <TB2> INFO: triggerdelay: 0
[07:31:48.221] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[07:31:48.221] <TB2> INFO: Log level: INFO
[07:31:48.234] <TB2> INFO: Found DTB DTB_WXENWR
[07:31:48.252] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[07:31:48.255] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[07:31:48.258] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[07:31:49.811] <TB2> INFO: DUT info:
[07:31:49.811] <TB2> INFO: The DUT currently contains the following objects:
[07:31:49.811] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[07:31:49.811] <TB2> INFO: TBM Core alpha (0): 7 registers set
[07:31:49.812] <TB2> INFO: TBM Core beta (1): 7 registers set
[07:31:49.812] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:31:49.812] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:49.812] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:31:50.213] <TB2> INFO: enter 'restricted' command line mode
[07:31:50.213] <TB2> INFO: enter test to run
[07:31:50.214] <TB2> INFO: test: delay setting parameters: ->5<-
[07:31:50.214] <TB2> INFO: delay test by 5 seconds...
[07:31:55.214] <TB2> INFO: enter test to run
[07:31:55.214] <TB2> INFO: test: Xray no parameter change
[07:31:55.214] <TB2> INFO: running: xray
[07:31:55.214] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//003_HRData_p17//phCalibrationFitErr35_C15.dat
[07:31:55.379] <TB2> INFO: ######################################################################
[07:31:55.379] <TB2> INFO: PixTestXray::doTest()
[07:31:55.379] <TB2> INFO: ######################################################################
[07:31:55.379] <TB2> INFO: ----------------------------------------------------------------------
[07:31:55.379] <TB2> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[07:31:55.380] <TB2> INFO: ----------------------------------------------------------------------
[07:31:56.357] <TB2> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[07:32:02.123] <TB2> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[07:32:22.897] <TB2> INFO: Resuming triggers.
[07:32:28.668] <TB2> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[07:32:31.917] <TB2> ERROR: <datapipe.cc/CheckEventValidity:L437> Number of ROCs (6) != Token Chain Length (4)

[07:32:49.339] <TB2> INFO: Resuming triggers.
[07:32:55.109] <TB2> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[07:33:14.268] <TB2> INFO: Resuming triggers.
[07:33:20.037] <TB2> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[07:33:38.795] <TB2> INFO: Resuming triggers.
[07:33:44.563] <TB2> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[07:34:05.270] <TB2> INFO: Resuming triggers.
[07:34:11.038] <TB2> INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[07:34:32.132] <TB2> INFO: Resuming triggers.
[07:34:37.897] <TB2> INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[07:34:59.044] <TB2> INFO: Resuming triggers.
[07:35:04.809] <TB2> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[07:35:26.114] <TB2> INFO: Resuming triggers.
[07:35:31.883] <TB2> INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[07:35:53.107] <TB2> INFO: Resuming triggers.
[07:35:58.872] <TB2> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[07:36:18.943] <TB2> INFO: Resuming triggers.
[07:36:24.709] <TB2> INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[07:36:44.928] <TB2> INFO: Resuming triggers.
[07:36:50.692] <TB2> INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[07:37:11.026] <TB2> INFO: Resuming triggers.
[07:37:16.794] <TB2> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[07:37:37.889] <TB2> INFO: Resuming triggers.
[07:37:43.658] <TB2> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[07:38:04.652] <TB2> INFO: Resuming triggers.
[07:38:10.419] <TB2> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[07:38:30.112] <TB2> INFO: Resuming triggers.
[07:38:35.879] <TB2> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[07:38:55.598] <TB2> INFO: Resuming triggers.
[07:39:01.363] <TB2> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[07:39:23.299] <TB2> INFO: Resuming triggers.
[07:39:25.338] <TB2> INFO: data taking finished, elapsed time: 100 seconds.
[07:39:32.969] <TB2> INFO: PixTest:: pg_setup set to default.
[07:39:32.971] <TB2> INFO: PixTestXray::doPhRun() done
[07:39:32.971] <TB2> INFO: PixTestXray::doTest() done
[07:39:33.165] <TB2> INFO: enter test to run
[07:39:33.165] <TB2> INFO: test: no parameter change
[07:39:33.406] <TB2> QUIET: Connection to board 162 closed.
[07:39:33.486] <TB2> INFO: pXar: this is the end, my friend
commander_HRData.log
[07:39:37.261] <TB2> INFO: *** Welcome to pxar ***
[07:39:37.261] <TB2> INFO: *** Today: 2015/07/07
[07:39:37.261] <TB2> INFO: readRocDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//dacParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//dacParameters35_C15.dat
[07:39:37.261] <TB2> INFO: readTbmDacs: /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//tbmParameters_C0a.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//tbmParameters_C0b.dat
[07:39:37.261] <TB2> INFO: readMaskFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//defaultMaskFile.dat
[07:39:37.261] <TB2> INFO: readTrimFile: /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//trimParameters35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//trimParameters35_C15.dat
[07:39:37.338] <TB2> INFO: clk: 4
[07:39:37.338] <TB2> INFO: ctr: 4
[07:39:37.338] <TB2> INFO: sda: 19
[07:39:37.338] <TB2> INFO: tin: 9
[07:39:37.338] <TB2> INFO: level: 15
[07:39:37.338] <TB2> INFO: triggerdelay: 0
[07:39:37.338] <TB2> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[07:39:37.338] <TB2> INFO: Log level: INFO
[07:39:37.352] <TB2> INFO: Found DTB DTB_WXENWR
[07:39:37.369] <TB2> QUIET: Connection to board DTB_WXENWR opened.
[07:39:37.373] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 162
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WXENWR
MAC address: 40D8551180A2
Hostname: pixelDTB162
Comment:
------------------------------------------------------
[07:39:37.376] <TB2> INFO: RPC call hashes of host and DTB match: 447413373
[07:39:38.929] <TB2> INFO: DUT info:
[07:39:38.929] <TB2> INFO: The DUT currently contains the following objects:
[07:39:38.929] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[07:39:38.929] <TB2> INFO: TBM Core alpha (0): 7 registers set
[07:39:38.929] <TB2> INFO: TBM Core beta (1): 7 registers set
[07:39:38.929] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:39:38.929] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.929] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.930] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.930] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.930] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.930] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.930] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:38.930] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:39:39.331] <TB2> INFO: enter 'restricted' command line mode
[07:39:39.331] <TB2> INFO: enter test to run
[07:39:39.331] <TB2> INFO: test: delay setting parameters: ->5<-
[07:39:39.331] <TB2> INFO: delay test by 5 seconds...
[07:39:44.332] <TB2> INFO: enter test to run
[07:39:44.332] <TB2> INFO: test: Xray no parameter change
[07:39:44.332] <TB2> INFO: running: xray
[07:39:44.332] <TB2> INFO: readGainPedestalParameters /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XRayHRQualification_2015-07-07_09h27m_1436254057//004_HRData_p17//phCalibrationFitErr35_C15.dat
[07:39:44.524] <TB2> INFO: ######################################################################
[07:39:44.524] <TB2> INFO: PixTestXray::doTest()
[07:39:44.524] <TB2> INFO: ######################################################################
[07:39:44.524] <TB2> INFO: ----------------------------------------------------------------------
[07:39:44.524] <TB2> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[07:39:44.524] <TB2> INFO: ----------------------------------------------------------------------
[07:39:45.497] <TB2> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[07:39:48.465] <TB2> INFO: run duration 2 seconds, buffer almost full (81%), pausing triggers.
[07:40:10.380] <TB2> INFO: Resuming triggers.
[07:40:13.357] <TB2> INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[07:40:16.387] <TB2> ERROR: <datapipe.cc/CheckEventID:L420> Event ID mismatch: local ID (114) != TBM ID (21)

[07:40:16.387] <TB2> ERROR: <datapipe.cc/CheckEventValidity:L437> Number of ROCs (1) != Token Chain Length (4)

[07:40:16.387] <TB2> ERROR: <datapipe.cc/CheckEventID:L420> Event ID mismatch: local ID (22) != TBM ID (114)

[07:40:16.387] <TB2> WARNING: ROC 0: Readback start marker after 17 readouts!

[07:40:34.308] <TB2> INFO: Resuming triggers.
[07:40:37.287] <TB2> INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[07:40:58.127] <TB2> INFO: Resuming triggers.
[07:41:01.101] <TB2> INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[07:41:22.352] <TB2> INFO: Resuming triggers.
[07:41:25.326] <TB2> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[07:41:46.373] <TB2> INFO: Resuming triggers.
[07:41:49.350] <TB2> INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[07:42:09.858] <TB2> INFO: Resuming triggers.
[07:42:12.835] <TB2> INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[07:42:34.081] <TB2> INFO: Resuming triggers.
[07:42:37.057] <TB2> INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[07:42:58.856] <TB2> INFO: Resuming triggers.
[07:43:01.830] <TB2> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[07:43:22.360] <TB2> INFO: Resuming triggers.
[07:43:25.333] <TB2> INFO: run duration 29 seconds, buffer almost full (81%), pausing triggers.
[07:43:45.288] <TB2> INFO: Resuming triggers.
[07:43:48.261] <TB2> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[07:44:08.397] <TB2> INFO: Resuming triggers.
[07:44:11.370] <TB2> INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[07:44:31.832] <TB2> INFO: Resuming triggers.
[07:44:34.812] <TB2> INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[07:44:55.836] <TB2> INFO: Resuming triggers.
[07:44:58.810] <TB2> INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[07:45:20.527] <TB2> INFO: Resuming triggers.
[07:45:23.496] <TB2> INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[07:45:46.118] <TB2> INFO: Resuming triggers.
[07:45:49.089] <TB2> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[07:46:11.199] <TB2> INFO: Resuming triggers.
[07:46:14.168] <TB2> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[07:46:36.326] <TB2> INFO: Resuming triggers.
[07:46:39.296] <TB2> INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[07:47:01.326] <TB2> INFO: Resuming triggers.
[07:47:04.294] <TB2> INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[07:47:25.398] <TB2> INFO: Resuming triggers.
[07:47:28.369] <TB2> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[07:47:49.253] <TB2> INFO: Resuming triggers.
[07:47:52.227] <TB2> INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[07:48:13.406] <TB2> INFO: Resuming triggers.
[07:48:16.379] <TB2> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[07:48:37.883] <TB2> INFO: Resuming triggers.
[07:48:40.857] <TB2> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[07:49:03.058] <TB2> INFO: Resuming triggers.
[07:49:06.026] <TB2> INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[07:49:28.012] <TB2> INFO: Resuming triggers.
[07:49:30.985] <TB2> INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[07:49:53.158] <TB2> INFO: Resuming triggers.
[07:49:56.126] <TB2> INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[07:50:17.669] <TB2> INFO: Resuming triggers.
[07:50:20.640] <TB2> INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[07:50:42.450] <TB2> INFO: Resuming triggers.
[07:50:45.423] <TB2> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[07:51:05.046] <TB2> INFO: Resuming triggers.
[07:51:08.014] <TB2> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[07:51:27.513] <TB2> INFO: Resuming triggers.
[07:51:30.485] <TB2> INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[07:51:49.484] <TB2> INFO: Resuming triggers.
[07:51:52.450] <TB2> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[07:52:11.129] <TB2> INFO: Resuming triggers.
[07:52:14.099] <TB2> INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[07:52:32.717] <TB2> INFO: Resuming triggers.
[07:52:35.689] <TB2> INFO: run duration 98 seconds, buffer almost full (81%), pausing triggers.
[07:52:54.686] <TB2> INFO: Resuming triggers.
[07:52:56.675] <TB2> INFO: data taking finished, elapsed time: 100 seconds.
[07:53:09.603] <TB2> INFO: PixTest:: pg_setup set to default.
[07:53:09.605] <TB2> INFO: PixTestXray::doPhRun() done
[07:53:09.605] <TB2> INFO: PixTestXray::doTest() done
[07:53:09.788] <TB2> INFO: enter test to run
[07:53:09.788] <TB2> INFO: test: no parameter change
[07:53:09.960] <TB2> QUIET: Connection to board 162 closed.
[07:53:10.040] <TB2> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[08:25:33.381] <TB1> INFO: *** Welcome to pxar ***
[08:25:33.381] <TB1> INFO: *** Today: 2015/07/17
[08:25:33.381] <TB1> INFO: readRocDacs: /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//dacParameters35_C15.dat
[08:25:33.382] <TB1> INFO: readTbmDacs: /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//tbmParameters_C0b.dat
[08:25:33.382] <TB1> INFO: readMaskFile: /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//defaultMaskFile.dat
[08:25:33.382] <TB1> INFO: MASKED Roc 8 col/row: 3 77
[08:25:33.382] <TB1> INFO: MASKED Roc 8 col/row: 5 77
[08:25:33.382] <TB1> INFO: MASKED Roc 8 col/row: 5 79
[08:25:33.382] <TB1> INFO: readTrimFile: /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//trimParameters35_C15.dat
[08:25:33.422] <TB1> INFO: masking Roc 8 col/row: 3 77
[08:25:33.422] <TB1> INFO: masking Roc 8 col/row: 5 77
[08:25:33.422] <TB1> INFO: masking Roc 8 col/row: 5 79
[08:25:33.460] <TB1> INFO: clk: 4
[08:25:33.460] <TB1> INFO: ctr: 4
[08:25:33.460] <TB1> INFO: sda: 19
[08:25:33.460] <TB1> INFO: tin: 9
[08:25:33.460] <TB1> INFO: level: 15
[08:25:33.460] <TB1> INFO: triggerdelay: 0
[08:25:33.460] <TB1> QUIET: Instanciating API for pxar v2.2.5+45~gbf85984
[08:25:33.460] <TB1> INFO: Log level: INFO
[08:25:33.473] <TB1> INFO: Found DTB DTB_WWXJGB
[08:25:33.485] <TB1> QUIET: Connection to board DTB_WWXJGB opened.
[08:25:33.488] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 137
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWXJGB
MAC address: 40D855118089
Hostname: pixelDTB137
Comment:
------------------------------------------------------
[08:25:33.491] <TB1> INFO: RPC call hashes of host and DTB match: 447413373
[08:25:35.041] <TB1> INFO: DUT info:
[08:25:35.041] <TB1> INFO: The DUT currently contains the following objects:
[08:25:35.041] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[08:25:35.041] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:25:35.041] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:25:35.041] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:25:35.041] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 3 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.041] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:25:35.442] <TB1> INFO: enter 'restricted' command line mode
[08:25:35.442] <TB1> INFO: enter test to run
[08:25:35.442] <TB1> INFO: test: Highrate no parameter change
[08:25:35.442] <TB1> INFO: running: highrate
[08:25:35.443] <TB1> INFO: readGainPedestalParameters /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2030_XrayQualification_2015-07-17_10h22m_1437121363//001_HRSCurves_100//phCalibrationFitErr35_C15.dat
[08:25:35.577] <TB1> INFO: ----------------------------------------------------------------------
[08:25:35.577] <TB1> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[08:25:35.577] <TB1> INFO: ----------------------------------------------------------------------
[08:25:35.583] <TB1> INFO: ROC 8 masking pixel 3/77
[08:25:35.583] <TB1> INFO: ROC 8 masking pixel 5/77
[08:25:35.583] <TB1> INFO: ROC 8 masking pixel 5/79
[08:25:35.583] <TB1> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 150 (1) hits flags = 384 (plus default)
[08:25:35.595] <TB1> INFO: dacScan step from 0 .. 0
[08:25:52.453] <TB1> INFO: Test took 16857ms.
[08:25:54.877] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:25:55.198] <TB1> INFO: dacScan step from 1 .. 1
[08:26:11.889] <TB1> INFO: Test took 16691ms.
[08:26:14.391] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:26:14.707] <TB1> INFO: dacScan step from 2 .. 2
[08:26:30.106] <TB1> INFO: Test took 15399ms.
[08:26:32.553] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:26:32.861] <TB1> INFO: dacScan step from 3 .. 3
[08:26:47.802] <TB1> INFO: Test took 14940ms.
[08:26:50.340] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:26:50.667] <TB1> INFO: dacScan step from 4 .. 4
[08:27:06.208] <TB1> INFO: Test took 15540ms.
[08:27:08.562] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:27:08.868] <TB1> INFO: dacScan step from 5 .. 5
[08:27:25.927] <TB1> INFO: Test took 17059ms.
[08:27:28.298] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:27:28.616] <TB1> INFO: dacScan step from 6 .. 6
[08:27:44.159] <TB1> INFO: Test took 15543ms.
[08:27:46.602] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:27:46.930] <TB1> INFO: dacScan step from 7 .. 7
[08:28:01.882] <TB1> INFO: Test took 14952ms.
[08:28:04.456] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:28:04.780] <TB1> INFO: dacScan step from 8 .. 8
[08:28:20.359] <TB1> INFO: Test took 15579ms.
[08:28:22.895] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:28:23.256] <TB1> INFO: dacScan step from 9 .. 9
[08:28:39.928] <TB1> INFO: Test took 16671ms.
[08:28:42.743] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:28:43.045] <TB1> INFO: dacScan step from 10 .. 10
[08:28:59.472] <TB1> INFO: Test took 16426ms.
[08:29:01.942] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:29:02.276] <TB1> INFO: dacScan step from 11 .. 11
[08:29:18.031] <TB1> INFO: Test took 15755ms.
[08:29:20.579] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:29:20.890] <TB1> INFO: dacScan step from 12 .. 12
[08:29:36.537] <TB1> INFO: Test took 15646ms.
[08:29:39.091] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:29:39.481] <TB1> INFO: dacScan step from 13 .. 13
[08:29:56.014] <TB1> INFO: Test took 16533ms.
[08:29:58.598] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:29:58.926] <TB1> INFO: dacScan step from 14 .. 14
[08:30:14.710] <TB1> INFO: Test took 15784ms.
[08:30:17.170] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:30:17.473] <TB1> INFO: dacScan step from 15 .. 15
[08:30:32.751] <TB1> INFO: Test took 15278ms.
[08:30:35.250] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:30:35.588] <TB1> INFO: dacScan step from 16 .. 16
[08:30:51.262] <TB1> INFO: Test took 15674ms.
[08:30:53.719] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:30:54.025] <TB1> INFO: dacScan step from 17 .. 17
[08:31:10.062] <TB1> INFO: Test took 16036ms.
[08:31:12.537] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:31:12.849] <TB1> INFO: dacScan step from 18 .. 18
[08:31:29.003] <TB1> INFO: Test took 16153ms.
[08:31:31.517] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:31:31.845] <TB1> INFO: dacScan step from 19 .. 19
[08:31:47.655] <TB1> INFO: Test took 15809ms.
[08:31:50.118] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:31:50.458] <TB1> INFO: dacScan step from 20 .. 20
[08:32:05.436] <TB1> INFO: Test took 14978ms.
[08:32:07.971] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:32:08.280] <TB1> INFO: dacScan step from 21 .. 21
[08:32:23.899] <TB1> INFO: Test took 15618ms.
[08:32:26.355] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:32:26.679] <TB1> INFO: dacScan step from 22 .. 22
[08:32:43.430] <TB1> INFO: Test took 16751ms.
[08:32:45.880] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:32:46.191] <TB1> INFO: dacScan step from 23 .. 23
[08:33:01.705] <TB1> INFO: Test took 15514ms.
[08:33:04.248] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:33:04.576] <TB1> INFO: dacScan step from 24 .. 24
[08:33:19.882] <TB1> INFO: Test took 15306ms.
[08:33:22.489] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:33:22.794] <TB1> INFO: dacScan step from 25 .. 25
[08:33:38.386] <TB1> INFO: Test took 15591ms.
[08:33:40.818] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:33:41.124] <TB1> INFO: dacScan step from 26 .. 26
[08:33:57.595] <TB1> INFO: Test took 16471ms.
[08:34:00.073] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:34:00.440] <TB1> INFO: dacScan step from 27 .. 27
[08:34:15.884] <TB1> INFO: Test took 15444ms.
[08:34:18.383] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:34:18.703] <TB1> INFO: dacScan step from 28 .. 28
[08:34:33.840] <TB1> INFO: Test took 15137ms.
[08:34:36.208] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:34:36.515] <TB1> INFO: dacScan step from 29 .. 29
[08:34:52.495] <TB1> INFO: Test took 15980ms.
[08:34:55.239] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:34:55.603] <TB1> INFO: dacScan step from 30 .. 30
[08:35:12.338] <TB1> INFO: Test took 16734ms.
[08:35:14.744] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:35:15.054] <TB1> INFO: dacScan step from 31 .. 31
[08:35:31.104] <TB1> INFO: Test took 16049ms.
[08:35:33.604] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:35:33.932] <TB1> INFO: dacScan step from 32 .. 32
[08:35:49.394] <TB1> INFO: Test took 15461ms.
[08:35:51.926] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:35:52.245] <TB1> INFO: dacScan step from 33 .. 33
[08:36:07.278] <TB1> INFO: Test took 15033ms.
[08:36:09.748] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:36:10.059] <TB1> INFO: dacScan step from 34 .. 34
[08:36:25.038] <TB1> INFO: Test took 14979ms.
[08:36:27.848] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:36:28.186] <TB1> INFO: dacScan step from 35 .. 35
[08:36:43.441] <TB1> INFO: Test took 15254ms.
[08:36:46.105] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:36:46.448] <TB1> INFO: dacScan step from 36 .. 36
[08:37:01.839] <TB1> INFO: Test took 15390ms.
[08:37:04.301] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:37:04.616] <TB1> INFO: dacScan step from 37 .. 37
[08:37:20.023] <TB1> INFO: Test took 15406ms.
[08:37:22.521] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:37:22.861] <TB1> INFO: dacScan step from 38 .. 38
[08:37:38.311] <TB1> INFO: Test took 15449ms.
[08:37:40.901] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:37:41.237] <TB1> INFO: dacScan step from 39 .. 39
[08:37:56.788] <TB1> INFO: Test took 15550ms.
[08:37:59.488] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:37:59.830] <TB1> INFO: dacScan step from 40 .. 40
[08:38:16.479] <TB1> INFO: Test took 16649ms.
[08:38:19.354] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:38:19.692] <TB1> INFO: dacScan step from 41 .. 41
[08:38:37.955] <TB1> INFO: Test took 18262ms.
[08:38:40.562] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:38:40.873] <TB1> INFO: dacScan step from 42 .. 42
[08:38:58.725] <TB1> INFO: Test took 17852ms.
[08:39:01.480] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:39:01.879] <TB1> INFO: dacScan step from 43 .. 43
[08:39:19.805] <TB1> INFO: Test took 17926ms.
[08:39:22.474] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:39:22.817] <TB1> INFO: dacScan step from 44 .. 44
[08:39:40.342] <TB1> INFO: Test took 17525ms.
[08:39:42.999] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:39:43.339] <TB1> INFO: dacScan step from 45 .. 45
[08:40:00.923] <TB1> INFO: Test took 17584ms.
[08:40:03.536] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:40:03.852] <TB1> INFO: dacScan step from 46 .. 46
[08:40:21.197] <TB1> INFO: Test took 17345ms.
[08:40:24.037] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:40:24.379] <TB1> INFO: dacScan step from 47 .. 47
[08:40:42.002] <TB1> INFO: Test took 17622ms.
[08:40:44.610] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:40:44.932] <TB1> INFO: dacScan step from 48 .. 48
[08:41:04.570] <TB1> INFO: Test took 19637ms.
[08:41:07.398] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:41:07.737] <TB1> INFO: dacScan step from 49 .. 49
[08:41:27.020] <TB1> INFO: Test took 19283ms.
[08:41:29.778] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:41:30.116] <TB1> INFO: dacScan step from 50 .. 50
[08:41:49.720] <TB1> INFO: Test took 19604ms.
[08:41:52.415] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:41:52.743] <TB1> INFO: dacScan step from 51 .. 51
[08:42:10.934] <TB1> INFO: Test took 18191ms.
[08:42:13.764] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:42:14.089] <TB1> INFO: dacScan step from 52 .. 52
[08:42:32.125] <TB1> INFO: Test took 18036ms.
[08:42:35.005] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:42:35.349] <TB1> INFO: dacScan step from 53 .. 53
[08:42:53.516] <TB1> INFO: Test took 18166ms.
[08:42:56.293] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:42:56.634] <TB1> INFO: dacScan step from 54 .. 54
[08:43:16.439] <TB1> INFO: Test took 19805ms.
[08:43:19.300] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:43:19.629] <TB1> INFO: dacScan step from 55 .. 55
[08:43:39.386] <TB1> INFO: Test took 19756ms.
[08:43:42.154] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:43:42.472] <TB1> INFO: dacScan step from 56 .. 56
[08:44:02.054] <TB1> INFO: Test took 19581ms.
[08:44:04.752] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:44:05.081] <TB1> INFO: dacScan step from 57 .. 57
[08:44:24.201] <TB1> INFO: Test took 19120ms.
[08:44:26.929] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:44:27.252] <TB1> INFO: dacScan step from 58 .. 58
[08:44:44.725] <TB1> INFO: Test took 17473ms.
[08:44:47.513] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:44:47.848] <TB1> INFO: dacScan step from 59 .. 59
[08:45:06.397] <TB1> INFO: Test took 18548ms.
[08:45:09.211] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:45:09.526] <TB1> INFO: dacScan step from 60 .. 60
[08:45:28.888] <TB1> INFO: Test took 19361ms.
[08:45:31.560] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:45:31.874] <TB1> INFO: dacScan step from 61 .. 61
[08:45:51.674] <TB1> INFO: Test took 19799ms.
[08:45:54.380] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:45:54.699] <TB1> INFO: dacScan step from 62 .. 62
[08:46:14.326] <TB1> INFO: Test took 19626ms.
[08:46:17.056] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:46:17.374] <TB1> INFO: dacScan step from 63 .. 63
[08:46:36.505] <TB1> INFO: Test took 19130ms.
[08:46:39.199] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:46:39.525] <TB1> INFO: dacScan step from 64 .. 64
[08:46:58.175] <TB1> INFO: Test took 18649ms.
[08:47:00.981] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:47:01.323] <TB1> INFO: dacScan step from 65 .. 65
[08:47:20.244] <TB1> INFO: Test took 18920ms.
[08:47:23.082] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:47:23.408] <TB1> INFO: dacScan step from 66 .. 66
[08:47:43.156] <TB1> INFO: Test took 19747ms.
[08:47:45.878] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:47:46.208] <TB1> INFO: dacScan step from 67 .. 67
[08:48:05.882] <TB1> INFO: Test took 19673ms.
[08:48:08.577] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:48:08.899] <TB1> INFO: dacScan step from 68 .. 68
[08:48:28.272] <TB1> INFO: Test took 19372ms.
[08:48:31.064] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:48:31.389] <TB1> INFO: dacScan step from 69 .. 69
[08:48:49.853] <TB1> INFO: Test took 18463ms.
[08:48:52.715] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:48:53.062] <TB1> INFO: dacScan step from 70 .. 70
[08:49:10.675] <TB1> INFO: Test took 17613ms.
[08:49:13.508] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:49:13.847] <TB1> INFO: dacScan step from 71 .. 71
[08:49:32.137] <TB1> INFO: Test took 18289ms.
[08:49:35.041] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:49:35.377] <TB1> INFO: dacScan step from 72 .. 72
[08:49:55.645] <TB1> INFO: Test took 20268ms.
[08:49:58.430] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:49:58.748] <TB1> INFO: dacScan step from 73 .. 73
[08:50:18.341] <TB1> INFO: Test took 19592ms.
[08:50:21.083] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:50:21.415] <TB1> INFO: dacScan step from 74 .. 74
[08:50:39.634] <TB1> INFO: Test took 18218ms.
[08:50:42.327] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:50:42.651] <TB1> INFO: dacScan step from 75 .. 75
[08:51:01.188] <TB1> INFO: Test took 18536ms.
[08:51:03.911] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:04.236] <TB1> INFO: dacScan step from 76 .. 76
[08:51:23.099] <TB1> INFO: Test took 18862ms.
[08:51:25.800] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:26.126] <TB1> INFO: dacScan step from 77 .. 77
[08:51:46.622] <TB1> INFO: Test took 20496ms.
[08:51:49.275] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:51:49.616] <TB1> INFO: dacScan step from 78 .. 78
[08:52:08.465] <TB1> INFO: Test took 18848ms.
[08:52:11.151] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:52:11.475] <TB1> INFO: dacScan step from 79 .. 79
[08:52:30.912] <TB1> INFO: Test took 19436ms.
[08:52:33.940] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:52:34.264] <TB1> INFO: dacScan step from 80 .. 80
[08:52:52.738] <TB1> INFO: Test took 18474ms.
[08:52:55.439] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:52:55.774] <TB1> INFO: dacScan step from 81 .. 81
[08:53:13.854] <TB1> INFO: Test took 18079ms.
[08:53:16.686] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:53:17.029] <TB1> INFO: dacScan step from 82 .. 82
[08:53:36.833] <TB1> INFO: Test took 19803ms.
[08:53:39.654] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:53:40.006] <TB1> INFO: dacScan step from 83 .. 83
[08:54:00.277] <TB1> INFO: Test took 20270ms.
[08:54:02.923] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:54:03.236] <TB1> INFO: dacScan step from 84 .. 84
[08:54:22.192] <TB1> INFO: Test took 18955ms.
[08:54:24.861] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:54:25.181] <TB1> INFO: dacScan step from 85 .. 85
[08:54:43.801] <TB1> INFO: Test took 18619ms.
[08:54:46.593] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:54:46.914] <TB1> INFO: dacScan step from 86 .. 86
[08:55:05.815] <TB1> INFO: Test took 18900ms.
[08:55:08.575] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:55:08.916] <TB1> INFO: dacScan step from 87 .. 87
[08:55:29.382] <TB1> INFO: Test took 20466ms.
[08:55:32.100] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:55:32.426] <TB1> INFO: dacScan step from 88 .. 88
[08:55:52.491] <TB1> INFO: Test took 20064ms.
[08:55:55.157] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:55:55.473] <TB1> INFO: dacScan step from 89 .. 89
[08:56:13.520] <TB1> INFO: Test took 18046ms.
[08:56:16.312] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:56:16.652] <TB1> INFO: dacScan step from 90 .. 90
[08:56:35.259] <TB1> INFO: Test took 18606ms.
[08:56:38.145] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:56:38.487] <TB1> INFO: dacScan step from 91 .. 91
[08:56:56.580] <TB1> INFO: Test took 18092ms.
[08:56:59.336] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:56:59.684] <TB1> INFO: dacScan step from 92 .. 92
[08:57:18.444] <TB1> INFO: Test took 18759ms.
[08:57:21.276] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:57:21.604] <TB1> INFO: dacScan step from 93 .. 93
[08:57:42.198] <TB1> INFO: Test took 20593ms.
[08:57:45.489] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:57:45.829] <TB1> INFO: dacScan step from 94 .. 94
[08:58:05.064] <TB1> INFO: Test took 19234ms.
[08:58:07.705] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:58:08.038] <TB1> INFO: dacScan step from 95 .. 95
[08:58:26.524] <TB1> INFO: Test took 18485ms.
[08:58:29.275] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:58:29.609] <TB1> INFO: dacScan step from 96 .. 96
[08:58:46.994] <TB1> INFO: Test took 17384ms.
[08:58:49.886] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:58:50.233] <TB1> INFO: dacScan step from 97 .. 97
[08:59:09.679] <TB1> INFO: Test took 19445ms.
[08:59:12.418] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:12.733] <TB1> INFO: dacScan step from 98 .. 98
[08:59:32.816] <TB1> INFO: Test took 20082ms.
[08:59:35.515] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:35.860] <TB1> INFO: dacScan step from 99 .. 99
[08:59:55.745] <TB1> INFO: Test took 19884ms.
[08:59:58.603] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[08:59:58.952] <TB1> INFO: dacScan step from 100 .. 100
[09:00:17.344] <TB1> INFO: Test took 18391ms.
[09:00:20.041] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:00:20.381] <TB1> INFO: dacScan step from 101 .. 101
[09:00:38.090] <TB1> INFO: Test took 17708ms.
[09:00:40.755] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:00:41.077] <TB1> INFO: dacScan step from 102 .. 102
[09:00:59.440] <TB1> INFO: Test took 18362ms.
[09:01:02.282] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:01:02.626] <TB1> INFO: dacScan step from 103 .. 103
[09:01:21.718] <TB1> INFO: Test took 19091ms.
[09:01:24.424] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:01:24.771] <TB1> INFO: dacScan step from 104 .. 104
[09:01:45.264] <TB1> INFO: Test took 20492ms.
[09:01:47.969] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:01:48.300] <TB1> INFO: dacScan step from 105 .. 105
[09:02:07.004] <TB1> INFO: Test took 18703ms.
[09:02:09.853] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:02:10.202] <TB1> INFO: dacScan step from 106 .. 106
[09:02:28.605] <TB1> INFO: Test took 18402ms.
[09:02:31.330] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:02:31.662] <TB1> INFO: dacScan step from 107 .. 107
[09:02:50.243] <TB1> INFO: Test took 18580ms.
[09:02:53.071] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:02:53.400] <TB1> INFO: dacScan step from 108 .. 108
[09:03:13.003] <TB1> INFO: Test took 19602ms.
[09:03:16.009] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:03:16.336] <TB1> INFO: dacScan step from 109 .. 109
[09:03:36.803] <TB1> INFO: Test took 20466ms.
[09:03:39.663] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:03:40.009] <TB1> INFO: dacScan step from 110 .. 110
[09:03:59.339] <TB1> INFO: Test took 19328ms.
[09:04:02.097] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:04:02.440] <TB1> INFO: dacScan step from 111 .. 111
[09:04:21.138] <TB1> INFO: Test took 18697ms.
[09:04:24.706] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:04:25.051] <TB1> INFO: dacScan step from 112 .. 112
[09:04:43.972] <TB1> INFO: Test took 18920ms.
[09:04:46.714] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:04:47.049] <TB1> INFO: dacScan step from 113 .. 113
[09:05:06.960] <TB1> INFO: Test took 19910ms.
[09:05:09.909] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:05:10.309] <TB1> INFO: dacScan step from 114 .. 114
[09:05:29.724] <TB1> INFO: Test took 19414ms.
[09:05:32.797] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:05:33.120] <TB1> INFO: dacScan step from 115 .. 115
[09:05:51.700] <TB1> INFO: Test took 18579ms.
[09:05:54.545] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:05:54.892] <TB1> INFO: dacScan step from 116 .. 116
[09:06:13.500] <TB1> INFO: Test took 18607ms.
[09:06:16.261] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:06:16.601] <TB1> INFO: dacScan step from 117 .. 117
[09:06:34.502] <TB1> INFO: Test took 17900ms.
[09:06:37.934] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:06:38.319] <TB1> INFO: dacScan step from 118 .. 118
[09:06:58.201] <TB1> INFO: Test took 19881ms.
[09:07:01.158] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:07:01.526] <TB1> INFO: dacScan step from 119 .. 119
[09:07:21.475] <TB1> INFO: Test took 19948ms.
[09:07:24.242] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:07:24.589] <TB1> INFO: dacScan step from 120 .. 120
[09:07:42.390] <TB1> INFO: Test took 17799ms.
[09:07:45.160] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:07:45.491] <TB1> INFO: dacScan step from 121 .. 121
[09:08:03.320] <TB1> INFO: Test took 17828ms.
[09:08:05.986] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:08:06.300] <TB1> INFO: dacScan step from 122 .. 122
[09:08:24.822] <TB1> INFO: Test took 18521ms.
[09:08:28.013] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:08:28.356] <TB1> INFO: dacScan step from 123 .. 123
[09:08:48.151] <TB1> INFO: Test took 19794ms.
[09:08:50.778] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:08:51.092] <TB1> INFO: dacScan step from 124 .. 124
[09:09:10.392] <TB1> INFO: Test took 19299ms.
[09:09:13.194] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:09:13.564] <TB1> INFO: dacScan step from 125 .. 125
[09:09:32.842] <TB1> INFO: Test took 19276ms.
[09:09:35.583] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:09:35.901] <TB1> INFO: dacScan step from 126 .. 126
[09:09:52.254] <TB1> INFO: Test took 16352ms.
[09:09:54.932] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:09:55.254] <TB1> INFO: dacScan step from 127 .. 127
[09:10:10.974] <TB1> INFO: Test took 15719ms.
[09:10:13.693] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:10:14.022] <TB1> INFO: dacScan step from 128 .. 128
[09:10:28.410] <TB1> INFO: Test took 14387ms.
[09:10:30.949] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:10:31.254] <TB1> INFO: dacScan step from 129 .. 129
[09:10:45.311] <TB1> INFO: Test took 14055ms.
[09:10:47.907] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:10:48.213] <TB1> INFO: dacScan step from 130 .. 130
[09:11:02.182] <TB1> INFO: Test took 13968ms.
[09:11:04.726] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:11:05.038] <TB1> INFO: dacScan step from 131 .. 131
[09:11:19.188] <TB1> INFO: Test took 14149ms.
[09:11:21.727] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:11:22.033] <TB1> INFO: dacScan step from 132 .. 132
[09:11:36.231] <TB1> INFO: Test took 14196ms.
[09:11:38.765] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:11:39.071] <TB1> INFO: dacScan step from 133 .. 133
[09:11:53.233] <TB1> INFO: Test took 14161ms.
[09:11:55.749] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:11:56.056] <TB1> INFO: dacScan step from 134 .. 134
[09:12:10.095] <TB1> INFO: Test took 14038ms.
[09:12:12.602] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:12:12.908] <TB1> INFO: dacScan step from 135 .. 135
[09:12:27.160] <TB1> INFO: Test took 14251ms.
[09:12:29.669] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:12:29.977] <TB1> INFO: dacScan step from 136 .. 136
[09:12:44.217] <TB1> INFO: Test took 14238ms.
[09:12:46.732] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:12:47.041] <TB1> INFO: dacScan step from 137 .. 137
[09:13:01.190] <TB1> INFO: Test took 14148ms.
[09:13:03.695] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:13:03.999] <TB1> INFO: dacScan step from 138 .. 138
[09:13:18.214] <TB1> INFO: Test took 14214ms.
[09:13:20.716] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:13:21.018] <TB1> INFO: dacScan step from 139 .. 139
[09:13:35.156] <TB1> INFO: Test took 14136ms.
[09:13:37.697] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:13:38.008] <TB1> INFO: dacScan step from 140 .. 140
[09:13:52.202] <TB1> INFO: Test took 14193ms.
[09:13:54.705] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:13:55.009] <TB1> INFO: dacScan step from 141 .. 141
[09:14:09.078] <TB1> INFO: Test took 14067ms.
[09:14:11.632] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:14:11.942] <TB1> INFO: dacScan step from 142 .. 142
[09:14:25.938] <TB1> INFO: Test took 13994ms.
[09:14:28.482] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:14:28.794] <TB1> INFO: dacScan step from 143 .. 143
[09:14:42.896] <TB1> INFO: Test took 14101ms.
[09:14:45.425] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:14:45.733] <TB1> INFO: dacScan step from 144 .. 144
[09:14:59.908] <TB1> INFO: Test took 14174ms.
[09:15:02.458] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:15:02.768] <TB1> INFO: dacScan step from 145 .. 145
[09:15:16.901] <TB1> INFO: Test took 14131ms.
[09:15:19.456] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:15:19.767] <TB1> INFO: dacScan step from 146 .. 146
[09:15:33.992] <TB1> INFO: Test took 14223ms.
[09:15:36.543] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:15:36.855] <TB1> INFO: dacScan step from 147 .. 147
[09:15:50.963] <TB1> INFO: Test took 14107ms.
[09:15:53.489] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:15:53.795] <TB1> INFO: dacScan step from 148 .. 148
[09:16:07.988] <TB1> INFO: Test took 14191ms.
[09:16:10.495] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:16:10.801] <TB1> INFO: dacScan step from 149 .. 149
[09:16:24.832] <TB1> INFO: Test took 14029ms.
[09:16:27.337] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:16:27.642] <TB1> INFO: dacScan step from 150 .. 150
[09:16:41.633] <TB1> INFO: Test took 13989ms.
[09:16:44.170] <TB1> INFO: Fetched DAQ statistics. Counters are being reset now.
[09:16:44.478] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:46.114] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:47.732] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:49.325] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:51.057] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:52.785] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:54.602] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:56.383] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:58.173] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:16:59.962] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:17:01.758] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:17:03.538] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:17:05.266] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:17:06.985] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:17:08.583] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:17:10.196] <TB1> INFO: dumping ASCII scurve output file: XSCurveData
[09:17:11.810] <TB1> INFO: PixTest:: pg_setup set to default.
[09:17:11.812] <TB1> INFO: vcal mean: 38.20 38.98 38.41 42.89 42.77 44.39 44.01 44.69 44.47 44.09 43.89 42.49 43.07 39.73 39.06 38.55
[09:17:11.812] <TB1> INFO: vcal RMS: 1.38 1.35 1.08 1.61 1.39 1.49 1.68 1.76 2.07 1.67 1.83 1.81 1.57 1.52 1.33 1.25
[09:17:11.812] <TB1> INFO: number of X-ray hits detected: 210561 230523 212874 416001 399971 531211 486509 531880 516889 511544 509504 416463 403959 235652 231257 206907
[09:17:11.812] <TB1> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[09:17:11.812] <TB1> INFO: X-ray hit rate [MHz/cm2]: 61.7 67.6 62.4 121.9 117.2 155.7 142.6 155.9 151.5 149.9 149.3 122.1 118.4 69.1 67.8 60.6
[09:17:11.812] <TB1> INFO: PixTestHighRate::doXNoiseMaps() done
[09:17:11.906] <TB1> INFO: enter test to run
[09:17:11.906] <TB1> INFO: test: no parameter change
[09:17:12.087] <TB1> QUIET: Connection to board 137 closed.
[09:17:12.167] <TB1> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master