Test Date: 2015-08-13 17:13
Analysis date: 2016-05-26 01:41
Logfile
commander_PixelAlive.log
[15:14:02.987] <TB3> INFO: *** Welcome to pxar ***
[15:14:02.987] <TB3> INFO: *** Today: 2015/08/13
[15:14:02.987] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//000_PixelAlive_p17//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//000_PixelAlive_p17//dacParameters35_C15.dat
[15:14:02.988] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//000_PixelAlive_p17//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//000_PixelAlive_p17//tbmParameters_C0b.dat
[15:14:02.988] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//000_PixelAlive_p17//defaultMaskFile.dat
[15:14:02.988] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//000_PixelAlive_p17//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//000_PixelAlive_p17//trimParameters35_C15.dat
[15:14:03.056] <TB3> INFO: clk: 4
[15:14:03.056] <TB3> INFO: ctr: 4
[15:14:03.056] <TB3> INFO: sda: 19
[15:14:03.056] <TB3> INFO: tin: 9
[15:14:03.056] <TB3> INFO: level: 15
[15:14:03.056] <TB3> INFO: triggerdelay: 0
[15:14:03.056] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:14:03.056] <TB3> INFO: Log level: INFO
[15:14:03.070] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:14:03.082] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:14:03.085] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:14:03.088] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[15:14:04.635] <TB3> INFO: DUT info:
[15:14:04.635] <TB3> INFO: The DUT currently contains the following objects:
[15:14:04.635] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:14:04.635] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:14:04.635] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:14:04.635] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:14:04.636] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:04.636] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:14:05.038] <TB3> INFO: enter 'restricted' command line mode
[15:14:05.038] <TB3> INFO: enter test to run
[15:14:05.038] <TB3> INFO: test: PixelAlive no parameter change
[15:14:05.038] <TB3> INFO: running: pixelalive
[15:14:05.045] <TB3> INFO: ######################################################################
[15:14:05.045] <TB3> INFO: PixTestAlive::doTest()
[15:14:05.045] <TB3> INFO: ######################################################################
[15:14:05.047] <TB3> INFO: ----------------------------------------------------------------------
[15:14:05.047] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:14:05.047] <TB3> INFO: ----------------------------------------------------------------------
[15:14:07.575] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 7 readouts!

[15:14:07.575] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 9 readouts!

[15:14:08.708] <TB3> INFO: Test took 3658ms.
[15:14:08.725] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:14:08.970] <TB3> INFO: PixTestAlive::aliveTest() done with 7 decoding errors
[15:14:08.971] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0
[15:14:08.972] <TB3> INFO: ----------------------------------------------------------------------
[15:14:08.972] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:14:08.972] <TB3> INFO: ----------------------------------------------------------------------
[15:14:11.696] <TB3> INFO: Test took 2722ms.
[15:14:11.697] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:14:11.698] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:14:11.917] <TB3> INFO: PixTestAlive::maskTest() done
[15:14:11.917] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:14:11.918] <TB3> INFO: ----------------------------------------------------------------------
[15:14:11.918] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:14:11.918] <TB3> INFO: ----------------------------------------------------------------------
[15:14:15.299] <TB3> INFO: Test took 3380ms.
[15:14:15.316] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:14:15.538] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[15:14:15.538] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:14:15.538] <TB3> INFO: PixTestAlive::doTest() done, duration: 10 seconds
[15:14:15.565] <TB3> INFO: enter test to run
[15:14:15.565] <TB3> INFO: test: no parameter change
[15:14:15.736] <TB3> QUIET: Connection to board 121 closed.
[15:14:15.816] <TB3> INFO: pXar: this is the end, my friend
commander_RetrimHotPixels.log
[15:19:26.754] <TB3> INFO: *** Welcome to pxar ***
[15:19:26.754] <TB3> INFO: *** Today: 2015/08/13
[15:19:26.755] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//dacParameters35_C15.dat
[15:19:26.756] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//tbmParameters_C0b.dat
[15:19:26.756] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:19:26.756] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:19:26.829] <TB3> INFO: clk: 4
[15:19:26.829] <TB3> INFO: ctr: 4
[15:19:26.829] <TB3> INFO: sda: 19
[15:19:26.829] <TB3> INFO: tin: 9
[15:19:26.829] <TB3> INFO: level: 15
[15:19:26.829] <TB3> INFO: triggerdelay: 0
[15:19:26.829] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:19:26.829] <TB3> INFO: Log level: INFO
[15:19:26.843] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:19:26.854] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:19:26.857] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:19:26.860] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[15:19:28.384] <TB3> INFO: DUT info:
[15:19:28.384] <TB3> INFO: The DUT currently contains the following objects:
[15:19:28.384] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:19:28.384] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:19:28.384] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:19:28.384] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:19:28.385] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.385] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:28.786] <TB3> INFO: enter 'restricted' command line mode
[15:19:28.786] <TB3> INFO: enter test to run
[15:19:28.787] <TB3> INFO: test: delay setting parameters: ->5<-
[15:19:28.787] <TB3> INFO: delay test by 5 seconds...
[15:19:33.787] <TB3> INFO: enter test to run
[15:19:33.787] <TB3> INFO: test: highrate no parameter change
[15:19:33.787] <TB3> INFO: running: highrate
[15:19:33.787] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//phCalibrationFitErr35_C15.dat
[15:19:33.937] <TB3> INFO: ----------------------------------------------------------------------
[15:19:33.937] <TB3> INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:19:33.937] <TB3> INFO: ----------------------------------------------------------------------
[15:19:33.937] <TB3> INFO: THR = 150, corresponding to ~ 400 MHz/cm2
[15:19:33.937] <TB3> INFO: edge/corner pixel THR is adjusted
[15:19:33.937] <TB3> INFO: PixTestHighRate::trimHotPixels: step 0...
[15:19:34.899] <TB3> INFO: Collecting data for 1 seconds...
[15:19:35.901] <TB3> INFO: Done with hot pixel readout
[15:19:41.868] <TB3> INFO: PixTest:: pg_setup set to default.
[15:19:41.869] <TB3> INFO: 2 hot pixels found in step 0
[15:19:42.833] <TB3> INFO: Collecting data for 1 seconds...
[15:19:43.835] <TB3> INFO: Done with hot pixel readout
[15:19:50.039] <TB3> INFO: PixTest:: pg_setup set to default.
[15:19:50.040] <TB3> INFO: 2 hot pixels found in step 1
[15:19:51.003] <TB3> INFO: Collecting data for 1 seconds...
[15:19:52.005] <TB3> INFO: Done with hot pixel readout
[15:19:58.273] <TB3> INFO: PixTest:: pg_setup set to default.
[15:19:58.274] <TB3> INFO: 0 hot pixels found in step 2
[15:19:58.281] <TB3> INFO: 0 hot pixels could not be trimmed and have been masked.
[15:19:58.309] <TB3> INFO: PixTest::trimHotPixels() done
[15:19:58.310] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C0.dat
[15:19:58.316] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C1.dat
[15:19:58.322] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C2.dat
[15:19:58.328] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C3.dat
[15:19:58.335] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C4.dat
[15:19:58.341] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C5.dat
[15:19:58.347] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C6.dat
[15:19:58.353] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C7.dat
[15:19:58.359] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C8.dat
[15:19:58.366] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C9.dat
[15:19:58.372] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C10.dat
[15:19:58.378] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C11.dat
[15:19:58.384] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C12.dat
[15:19:58.391] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C13.dat
[15:19:58.397] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C14.dat
[15:19:58.404] <TB3> INFO: write trim parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//trimParameters35_C15.dat
[15:19:58.410] <TB3> INFO: write masked pixels into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//002_RetrimHotPixels_150//defaultMaskFile.dat
[15:19:58.445] <TB3> INFO: enter test to run
[15:19:58.445] <TB3> INFO: test: no parameter change
[15:19:58.613] <TB3> QUIET: Connection to board 121 closed.
[15:19:58.693] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[15:21:07.458] <TB3> INFO: *** Welcome to pxar ***
[15:21:07.458] <TB3> INFO: *** Today: 2015/08/13
[15:21:07.458] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//dacParameters35_C15.dat
[15:21:07.460] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//tbmParameters_C0b.dat
[15:21:07.460] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//defaultMaskFile.dat
[15:21:07.460] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//trimParameters35_C15.dat
[15:21:07.535] <TB3> INFO: clk: 4
[15:21:07.535] <TB3> INFO: ctr: 4
[15:21:07.535] <TB3> INFO: sda: 19
[15:21:07.535] <TB3> INFO: tin: 9
[15:21:07.535] <TB3> INFO: level: 15
[15:21:07.535] <TB3> INFO: triggerdelay: 0
[15:21:07.535] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:21:07.535] <TB3> INFO: Log level: INFO
[15:21:07.547] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:21:07.560] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:21:07.563] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:21:07.566] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[15:21:09.091] <TB3> INFO: DUT info:
[15:21:09.091] <TB3> INFO: The DUT currently contains the following objects:
[15:21:09.091] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:21:09.091] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:21:09.091] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:21:09.091] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:21:09.091] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.091] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.091] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.091] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.091] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.092] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:09.494] <TB3> INFO: enter 'restricted' command line mode
[15:21:09.494] <TB3> INFO: enter test to run
[15:21:09.495] <TB3> INFO: test: delay setting parameters: ->5<-
[15:21:09.495] <TB3> INFO: delay test by 5 seconds...
[15:21:14.495] <TB3> INFO: enter test to run
[15:21:14.495] <TB3> INFO: test: Xray no parameter change
[15:21:14.495] <TB3> INFO: running: xray
[15:21:14.495] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//003_HRData_50//phCalibrationFitErr35_C15.dat
[15:21:14.658] <TB3> INFO: ######################################################################
[15:21:14.658] <TB3> INFO: PixTestXray::doTest()
[15:21:14.658] <TB3> INFO: ######################################################################
[15:21:14.658] <TB3> INFO: ----------------------------------------------------------------------
[15:21:14.658] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:21:14.658] <TB3> INFO: ----------------------------------------------------------------------
[15:21:15.629] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:21:22.259] <TB3> INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[15:21:46.768] <TB3> INFO: Resuming triggers.
[15:21:53.399] <TB3> INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[15:21:56.762] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 3 Number of ROCs (3) != Token Chain Length (4)

[15:21:56.762] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (158) != TBM ID (137)

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

[15:21:56.762] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (138) != TBM ID (158)

[15:22:15.656] <TB3> INFO: Resuming triggers.
[15:22:22.288] <TB3> INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[15:22:41.852] <TB3> INFO: Resuming triggers.
[15:22:48.486] <TB3> INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[15:23:09.483] <TB3> INFO: Resuming triggers.
[15:23:16.111] <TB3> INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[15:23:38.514] <TB3> INFO: Resuming triggers.
[15:23:45.143] <TB3> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[15:24:07.747] <TB3> INFO: Resuming triggers.
[15:24:14.375] <TB3> INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[15:24:36.042] <TB3> INFO: Resuming triggers.
[15:24:42.667] <TB3> INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[15:25:03.364] <TB3> INFO: Resuming triggers.
[15:25:09.990] <TB3> INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[15:25:34.556] <TB3> INFO: Resuming triggers.
[15:25:41.182] <TB3> INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[15:26:01.191] <TB3> INFO: Resuming triggers.
[15:26:07.816] <TB3> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[15:26:29.457] <TB3> INFO: Resuming triggers.
[15:26:36.081] <TB3> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[15:26:59.963] <TB3> INFO: Resuming triggers.
[15:27:06.586] <TB3> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[15:27:29.119] <TB3> INFO: Resuming triggers.
[15:27:35.745] <TB3> INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[15:28:00.255] <TB3> INFO: Resuming triggers.
[15:28:06.877] <TB3> INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[15:28:29.484] <TB3> INFO: Resuming triggers.
[15:28:30.184] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[15:28:33.018] <TB3> INFO: PixTest:: pg_setup set to default.
[15:28:33.019] <TB3> INFO: PixTestXray::doPhRun() done
[15:28:33.019] <TB3> INFO: PixTestXray::doTest() done
[15:28:33.232] <TB3> INFO: enter test to run
[15:28:33.232] <TB3> INFO: test: no parameter change
[15:28:33.398] <TB3> QUIET: Connection to board 121 closed.
[15:28:33.477] <TB3> INFO: pXar: this is the end, my friend
commander_HRData.log
[15:29:42.225] <TB3> INFO: *** Welcome to pxar ***
[15:29:42.225] <TB3> INFO: *** Today: 2015/08/13
[15:29:42.225] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//dacParameters35_C15.dat
[15:29:42.226] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//tbmParameters_C0b.dat
[15:29:42.227] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//defaultMaskFile.dat
[15:29:42.227] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//trimParameters35_C15.dat
[15:29:42.301] <TB3> INFO: clk: 4
[15:29:42.301] <TB3> INFO: ctr: 4
[15:29:42.301] <TB3> INFO: sda: 19
[15:29:42.301] <TB3> INFO: tin: 9
[15:29:42.301] <TB3> INFO: level: 15
[15:29:42.301] <TB3> INFO: triggerdelay: 0
[15:29:42.301] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:29:42.301] <TB3> INFO: Log level: INFO
[15:29:42.314] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:29:42.326] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:29:42.329] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:29:42.332] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[15:29:43.866] <TB3> INFO: DUT info:
[15:29:43.866] <TB3> INFO: The DUT currently contains the following objects:
[15:29:43.866] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:29:43.866] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:29:43.866] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:29:43.866] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:29:43.866] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:43.867] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:44.269] <TB3> INFO: enter 'restricted' command line mode
[15:29:44.269] <TB3> INFO: enter test to run
[15:29:44.269] <TB3> INFO: test: delay setting parameters: ->5<-
[15:29:44.269] <TB3> INFO: delay test by 5 seconds...
[15:29:49.269] <TB3> INFO: enter test to run
[15:29:49.269] <TB3> INFO: test: Xray no parameter change
[15:29:49.269] <TB3> INFO: running: xray
[15:29:49.269] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//004_HRData_150//phCalibrationFitErr35_C15.dat
[15:29:49.410] <TB3> INFO: ######################################################################
[15:29:49.410] <TB3> INFO: PixTestXray::doTest()
[15:29:49.410] <TB3> INFO: ######################################################################
[15:29:49.410] <TB3> INFO: ----------------------------------------------------------------------
[15:29:49.410] <TB3> INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:29:49.410] <TB3> INFO: ----------------------------------------------------------------------
[15:29:50.377] <TB3> INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:29:54.002] <TB3> INFO: run duration 3 seconds, buffer almost full (81%), pausing triggers.
[15:30:20.711] <TB3> INFO: Resuming triggers.
[15:30:24.339] <TB3> INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[15:30:27.274] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (57) != TBM ID (255)

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

[15:30:27.274] <TB3> ERROR: <datapipe.cc/CheckEventID:L420> Channel 3 Event ID mismatch: local ID (256) != TBM ID (57)

[15:30:48.600] <TB3> INFO: Resuming triggers.
[15:30:52.229] <TB3> INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[15:31:17.830] <TB3> INFO: Resuming triggers.
[15:31:21.457] <TB3> INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[15:31:47.047] <TB3> INFO: Resuming triggers.
[15:31:50.672] <TB3> INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[15:32:16.359] <TB3> INFO: Resuming triggers.
[15:32:19.987] <TB3> INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[15:32:42.697] <TB3> INFO: Resuming triggers.
[15:32:46.322] <TB3> INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[15:33:10.641] <TB3> INFO: Resuming triggers.
[15:33:14.270] <TB3> INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[15:33:36.690] <TB3> INFO: Resuming triggers.
[15:33:40.316] <TB3> INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[15:34:05.121] <TB3> INFO: Resuming triggers.
[15:34:08.747] <TB3> INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[15:34:29.475] <TB3> INFO: Resuming triggers.
[15:34:33.099] <TB3> INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[15:34:53.689] <TB3> INFO: Resuming triggers.
[15:34:57.316] <TB3> INFO: run duration 43 seconds, buffer almost full (81%), pausing triggers.
[15:35:22.568] <TB3> INFO: Resuming triggers.
[15:35:26.192] <TB3> INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[15:35:51.407] <TB3> INFO: Resuming triggers.
[15:35:55.032] <TB3> INFO: run duration 50 seconds, buffer almost full (81%), pausing triggers.
[15:36:19.791] <TB3> INFO: Resuming triggers.
[15:36:23.418] <TB3> INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[15:36:36.806] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L437> Channel 0 Number of ROCs (5) != Token Chain Length (4)

[15:36:46.468] <TB3> INFO: Resuming triggers.
[15:36:50.092] <TB3> INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[15:37:14.195] <TB3> INFO: Resuming triggers.
[15:37:17.824] <TB3> INFO: run duration 61 seconds, buffer almost full (81%), pausing triggers.
[15:37:41.260] <TB3> INFO: Resuming triggers.
[15:37:44.883] <TB3> INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[15:38:09.308] <TB3> INFO: Resuming triggers.
[15:38:12.937] <TB3> INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[15:38:41.711] <TB3> INFO: Resuming triggers.
[15:38:45.338] <TB3> INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[15:39:11.783] <TB3> INFO: Resuming triggers.
[15:39:15.413] <TB3> INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[15:39:40.047] <TB3> INFO: Resuming triggers.
[15:39:43.671] <TB3> INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[15:40:06.053] <TB3> INFO: Resuming triggers.
[15:40:09.679] <TB3> INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[15:40:35.972] <TB3> INFO: Resuming triggers.
[15:40:39.595] <TB3> INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[15:41:04.079] <TB3> INFO: Resuming triggers.
[15:41:07.702] <TB3> INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[15:41:32.752] <TB3> INFO: Resuming triggers.
[15:41:36.376] <TB3> INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[15:42:02.081] <TB3> INFO: Resuming triggers.
[15:42:05.709] <TB3> INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[15:42:31.358] <TB3> INFO: Resuming triggers.
[15:42:33.551] <TB3> INFO: data taking finished, elapsed time: 100 seconds.
[15:42:46.493] <TB3> INFO: PixTest:: pg_setup set to default.
[15:42:46.494] <TB3> INFO: PixTestXray::doPhRun() done
[15:42:46.494] <TB3> INFO: PixTestXray::doTest() done
[15:42:46.718] <TB3> INFO: enter test to run
[15:42:46.718] <TB3> INFO: test: no parameter change
[15:42:46.914] <TB3> QUIET: Connection to board 121 closed.
[15:42:46.994] <TB3> INFO: pXar: this is the end, my friend
commander_HRSCurves.log
[15:44:28.432] <TB3> INFO: *** Welcome to pxar ***
[15:44:28.432] <TB3> INFO: *** Today: 2015/08/13
[15:44:28.432] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//dacParameters35_C15.dat
[15:44:28.433] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//tbmParameters_C0b.dat
[15:44:28.433] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//defaultMaskFile.dat
[15:44:28.433] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//trimParameters35_C15.dat
[15:44:28.532] <TB3> INFO: clk: 4
[15:44:28.532] <TB3> INFO: ctr: 4
[15:44:28.532] <TB3> INFO: sda: 19
[15:44:28.532] <TB3> INFO: tin: 9
[15:44:28.532] <TB3> INFO: level: 15
[15:44:28.532] <TB3> INFO: triggerdelay: 0
[15:44:28.532] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[15:44:28.532] <TB3> INFO: Log level: INFO
[15:44:28.545] <TB3> INFO: Found DTB DTB_WWV6Z5
[15:44:28.556] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[15:44:28.559] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[15:44:28.561] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[15:44:30.201] <TB3> INFO: DUT info:
[15:44:30.201] <TB3> INFO: The DUT currently contains the following objects:
[15:44:30.201] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[15:44:30.201] <TB3> INFO: TBM Core alpha (0): 7 registers set
[15:44:30.201] <TB3> INFO: TBM Core beta (1): 7 registers set
[15:44:30.201] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:44:30.201] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.201] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.202] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.202] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:44:30.603] <TB3> INFO: enter 'restricted' command line mode
[15:44:30.603] <TB3> INFO: enter test to run
[15:44:30.603] <TB3> INFO: test: Highrate no parameter change
[15:44:30.603] <TB3> INFO: running: highrate
[15:44:30.604] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//005_HRSCurves_100//phCalibrationFitErr35_C15.dat
[15:44:30.756] <TB3> INFO: ----------------------------------------------------------------------
[15:44:30.756] <TB3> INFO: PixTestHighRate::xNoiseMaps() ntrig = 50, vcal = 200
[15:44:30.756] <TB3> INFO: ----------------------------------------------------------------------
[15:44:30.762] <TB3> INFO: ---> dac: vcal name: xNoiseMap ntrig: 50 dacrange: 0 .. 100 (1) hits flags = 384 (plus default)
[15:44:30.773] <TB3> INFO: dacScan step from 0 .. 0
[15:44:44.879] <TB3> INFO: Test took 14105ms.
[15:44:46.360] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:44:46.612] <TB3> INFO: dacScan step from 1 .. 1
[15:45:00.667] <TB3> INFO: Test took 14055ms.
[15:45:02.185] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:02.468] <TB3> INFO: dacScan step from 2 .. 2
[15:45:16.405] <TB3> INFO: Test took 13937ms.
[15:45:17.825] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:18.055] <TB3> INFO: dacScan step from 3 .. 3
[15:45:31.803] <TB3> INFO: Test took 13747ms.
[15:45:33.372] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:33.610] <TB3> INFO: dacScan step from 4 .. 4
[15:45:47.134] <TB3> INFO: Test took 13523ms.
[15:45:48.788] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:45:49.068] <TB3> INFO: dacScan step from 5 .. 5
[15:46:02.637] <TB3> INFO: Test took 13568ms.
[15:46:04.162] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:04.435] <TB3> INFO: dacScan step from 6 .. 6
[15:46:18.169] <TB3> INFO: Test took 13734ms.
[15:46:19.886] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:20.169] <TB3> INFO: dacScan step from 7 .. 7
[15:46:33.856] <TB3> INFO: Test took 13687ms.
[15:46:35.261] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:35.495] <TB3> INFO: dacScan step from 8 .. 8
[15:46:49.181] <TB3> INFO: Test took 13686ms.
[15:46:50.858] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:46:51.086] <TB3> INFO: dacScan step from 9 .. 9
[15:47:04.722] <TB3> INFO: Test took 13635ms.
[15:47:06.358] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:06.595] <TB3> INFO: dacScan step from 10 .. 10
[15:47:20.151] <TB3> INFO: Test took 13555ms.
[15:47:21.751] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:22.033] <TB3> INFO: dacScan step from 11 .. 11
[15:47:35.752] <TB3> INFO: Test took 13719ms.
[15:47:37.692] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:37.924] <TB3> INFO: dacScan step from 12 .. 12
[15:47:51.297] <TB3> INFO: Test took 13373ms.
[15:47:52.971] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:53.221] <TB3> INFO: dacScan step from 13 .. 13
[15:48:06.534] <TB3> INFO: Test took 13313ms.
[15:48:08.058] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:08.290] <TB3> INFO: dacScan step from 14 .. 14
[15:48:21.615] <TB3> INFO: Test took 13324ms.
[15:48:23.046] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:23.299] <TB3> INFO: dacScan step from 15 .. 15
[15:48:36.305] <TB3> INFO: Test took 13006ms.
[15:48:38.126] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:38.415] <TB3> INFO: dacScan step from 16 .. 16
[15:48:52.284] <TB3> INFO: Test took 13869ms.
[15:48:53.817] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:54.070] <TB3> INFO: dacScan step from 17 .. 17
[15:49:07.928] <TB3> INFO: Test took 13858ms.
[15:49:10.034] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:10.262] <TB3> INFO: dacScan step from 18 .. 18
[15:49:24.105] <TB3> INFO: Test took 13842ms.
[15:49:25.701] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:25.976] <TB3> INFO: dacScan step from 19 .. 19
[15:49:40.021] <TB3> INFO: Test took 14044ms.
[15:49:41.746] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:41.986] <TB3> INFO: dacScan step from 20 .. 20
[15:49:55.693] <TB3> INFO: Test took 13707ms.
[15:49:57.131] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:57.358] <TB3> INFO: dacScan step from 21 .. 21
[15:50:10.799] <TB3> INFO: Test took 13441ms.
[15:50:12.524] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:12.813] <TB3> INFO: dacScan step from 22 .. 22
[15:50:26.448] <TB3> INFO: Test took 13635ms.
[15:50:28.166] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:28.444] <TB3> INFO: dacScan step from 23 .. 23
[15:50:41.932] <TB3> INFO: Test took 13488ms.
[15:50:43.605] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:43.893] <TB3> INFO: dacScan step from 24 .. 24
[15:50:56.776] <TB3> INFO: Test took 12883ms.
[15:50:58.379] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:58.625] <TB3> INFO: dacScan step from 25 .. 25
[15:51:12.510] <TB3> INFO: Test took 13885ms.
[15:51:14.218] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:14.476] <TB3> INFO: dacScan step from 26 .. 26
[15:51:28.038] <TB3> INFO: Test took 13561ms.
[15:51:29.762] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:30.044] <TB3> INFO: dacScan step from 27 .. 27
[15:51:44.139] <TB3> INFO: Test took 14095ms.
[15:51:45.623] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:45.874] <TB3> INFO: dacScan step from 28 .. 28
[15:51:59.487] <TB3> INFO: Test took 13613ms.
[15:52:01.131] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:01.398] <TB3> INFO: dacScan step from 29 .. 29
[15:52:14.934] <TB3> INFO: Test took 13535ms.
[15:52:16.436] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:16.665] <TB3> INFO: dacScan step from 30 .. 30
[15:52:30.053] <TB3> INFO: Test took 13387ms.
[15:52:31.772] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:32.038] <TB3> INFO: dacScan step from 31 .. 31
[15:52:45.739] <TB3> INFO: Test took 13701ms.
[15:52:47.226] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:52:47.469] <TB3> INFO: dacScan step from 32 .. 32
[15:53:01.115] <TB3> INFO: Test took 13645ms.
[15:53:02.840] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:53:03.111] <TB3> INFO: dacScan step from 33 .. 33
[15:53:17.294] <TB3> INFO: Test took 14182ms.
[15:53:18.786] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:53:19.033] <TB3> INFO: dacScan step from 34 .. 34
[15:53:32.553] <TB3> INFO: Test took 13519ms.
[15:53:34.062] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:53:34.301] <TB3> INFO: dacScan step from 35 .. 35
[15:53:47.999] <TB3> INFO: Test took 13698ms.
[15:53:49.561] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:53:49.809] <TB3> INFO: dacScan step from 36 .. 36
[15:54:03.588] <TB3> INFO: Test took 13779ms.
[15:54:05.493] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:05.796] <TB3> INFO: dacScan step from 37 .. 37
[15:54:20.028] <TB3> INFO: Test took 14231ms.
[15:54:21.523] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:21.788] <TB3> INFO: dacScan step from 38 .. 38
[15:54:36.376] <TB3> INFO: Test took 14587ms.
[15:54:38.133] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:38.426] <TB3> INFO: dacScan step from 39 .. 39
[15:54:53.550] <TB3> INFO: Test took 15124ms.
[15:54:55.298] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:55.534] <TB3> INFO: dacScan step from 40 .. 40
[15:55:10.520] <TB3> INFO: Test took 14986ms.
[15:55:12.208] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:12.475] <TB3> INFO: dacScan step from 41 .. 41
[15:55:27.826] <TB3> INFO: Test took 15350ms.
[15:55:29.499] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:29.775] <TB3> INFO: dacScan step from 42 .. 42
[15:55:44.888] <TB3> INFO: Test took 15113ms.
[15:55:46.747] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:47.009] <TB3> INFO: dacScan step from 43 .. 43
[15:56:02.580] <TB3> INFO: Test took 15570ms.
[15:56:04.402] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:04.658] <TB3> INFO: dacScan step from 44 .. 44
[15:56:20.497] <TB3> INFO: Test took 15838ms.
[15:56:22.228] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:22.468] <TB3> INFO: dacScan step from 45 .. 45
[15:56:38.141] <TB3> INFO: Test took 15673ms.
[15:56:39.922] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:40.195] <TB3> INFO: dacScan step from 46 .. 46
[15:56:56.148] <TB3> INFO: Test took 15952ms.
[15:56:57.713] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:56:57.972] <TB3> INFO: dacScan step from 47 .. 47
[15:57:14.183] <TB3> INFO: Test took 16210ms.
[15:57:15.981] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:57:16.279] <TB3> INFO: dacScan step from 48 .. 48
[15:57:33.639] <TB3> INFO: Test took 17359ms.
[15:57:35.397] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:57:35.658] <TB3> INFO: dacScan step from 49 .. 49
[15:57:52.699] <TB3> INFO: Test took 17041ms.
[15:57:54.312] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:57:54.552] <TB3> INFO: dacScan step from 50 .. 50
[15:58:10.885] <TB3> INFO: Test took 16332ms.
[15:58:12.609] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:58:12.873] <TB3> INFO: dacScan step from 51 .. 51
[15:58:29.140] <TB3> INFO: Test took 16267ms.
[15:58:30.882] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:58:31.139] <TB3> INFO: dacScan step from 52 .. 52
[15:58:47.818] <TB3> INFO: Test took 16679ms.
[15:58:49.524] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:58:49.803] <TB3> INFO: dacScan step from 53 .. 53
[15:59:06.652] <TB3> INFO: Test took 16848ms.
[15:59:08.252] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:59:08.499] <TB3> INFO: dacScan step from 54 .. 54
[15:59:25.697] <TB3> INFO: Test took 17198ms.
[15:59:27.845] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:59:28.156] <TB3> INFO: dacScan step from 55 .. 55
[15:59:45.760] <TB3> INFO: Test took 17604ms.
[15:59:47.643] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:59:47.918] <TB3> INFO: dacScan step from 56 .. 56
[16:00:05.158] <TB3> INFO: Test took 17239ms.
[16:00:06.928] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:00:07.193] <TB3> INFO: dacScan step from 57 .. 57
[16:00:24.038] <TB3> INFO: Test took 16845ms.
[16:00:25.866] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:00:26.135] <TB3> INFO: dacScan step from 58 .. 58
[16:00:42.714] <TB3> INFO: Test took 16578ms.
[16:00:44.511] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:00:44.781] <TB3> INFO: dacScan step from 59 .. 59
[16:01:01.542] <TB3> INFO: Test took 16760ms.
[16:01:03.204] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:01:03.452] <TB3> INFO: dacScan step from 60 .. 60
[16:01:20.311] <TB3> INFO: Test took 16858ms.
[16:01:22.293] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:01:22.582] <TB3> INFO: dacScan step from 61 .. 61
[16:01:39.044] <TB3> INFO: Test took 16461ms.
[16:01:40.797] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:01:41.073] <TB3> INFO: dacScan step from 62 .. 62
[16:01:57.856] <TB3> INFO: Test took 16782ms.
[16:01:59.600] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:01:59.888] <TB3> INFO: dacScan step from 63 .. 63
[16:02:16.941] <TB3> INFO: Test took 17052ms.
[16:02:18.788] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:02:19.067] <TB3> INFO: dacScan step from 64 .. 64
[16:02:36.910] <TB3> INFO: Test took 17842ms.
[16:02:39.370] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:02:39.662] <TB3> INFO: dacScan step from 65 .. 65
[16:02:57.021] <TB3> INFO: Test took 17358ms.
[16:02:58.630] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:02:58.865] <TB3> INFO: dacScan step from 66 .. 66
[16:03:15.790] <TB3> INFO: Test took 16924ms.
[16:03:17.787] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:03:18.081] <TB3> INFO: dacScan step from 67 .. 67
[16:03:34.790] <TB3> INFO: Test took 16708ms.
[16:03:36.669] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:03:36.904] <TB3> INFO: dacScan step from 68 .. 68
[16:03:54.053] <TB3> INFO: Test took 17149ms.
[16:03:55.705] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:03:55.979] <TB3> INFO: dacScan step from 69 .. 69
[16:04:12.665] <TB3> INFO: Test took 16685ms.
[16:04:14.382] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:04:14.642] <TB3> INFO: dacScan step from 70 .. 70
[16:04:31.374] <TB3> INFO: Test took 16732ms.
[16:04:33.313] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:04:33.550] <TB3> INFO: dacScan step from 71 .. 71
[16:04:50.154] <TB3> INFO: Test took 16604ms.
[16:04:52.081] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:04:52.390] <TB3> INFO: dacScan step from 72 .. 72
[16:05:08.969] <TB3> INFO: Test took 16578ms.
[16:05:10.700] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:05:10.965] <TB3> INFO: dacScan step from 73 .. 73
[16:05:28.042] <TB3> INFO: Test took 17076ms.
[16:05:29.793] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:05:30.060] <TB3> INFO: dacScan step from 74 .. 74
[16:05:47.273] <TB3> INFO: Test took 17212ms.
[16:05:49.192] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:05:49.489] <TB3> INFO: dacScan step from 75 .. 75
[16:06:06.744] <TB3> INFO: Test took 17254ms.
[16:06:08.467] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:06:08.724] <TB3> INFO: dacScan step from 76 .. 76
[16:06:25.917] <TB3> INFO: Test took 17192ms.
[16:06:27.565] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:06:27.853] <TB3> INFO: dacScan step from 77 .. 77
[16:06:44.665] <TB3> INFO: Test took 16810ms.
[16:06:46.392] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:06:46.658] <TB3> INFO: dacScan step from 78 .. 78
[16:07:03.602] <TB3> INFO: Test took 16943ms.
[16:07:05.359] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:07:05.616] <TB3> INFO: dacScan step from 79 .. 79
[16:07:22.137] <TB3> INFO: Test took 16520ms.
[16:07:23.710] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:07:23.946] <TB3> INFO: dacScan step from 80 .. 80
[16:07:40.796] <TB3> INFO: Test took 16849ms.
[16:07:42.395] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:07:42.641] <TB3> INFO: dacScan step from 81 .. 81
[16:07:58.947] <TB3> INFO: Test took 16305ms.
[16:08:00.744] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:08:01.000] <TB3> INFO: dacScan step from 82 .. 82
[16:08:17.951] <TB3> INFO: Test took 16950ms.
[16:08:19.597] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:08:19.846] <TB3> INFO: dacScan step from 83 .. 83
[16:08:36.949] <TB3> INFO: Test took 17103ms.
[16:08:38.516] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:08:38.751] <TB3> INFO: dacScan step from 84 .. 84
[16:08:55.985] <TB3> INFO: Test took 17233ms.
[16:08:57.742] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:08:58.039] <TB3> INFO: dacScan step from 85 .. 85
[16:09:15.607] <TB3> INFO: Test took 17567ms.
[16:09:17.271] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:09:17.521] <TB3> INFO: dacScan step from 86 .. 86
[16:09:34.339] <TB3> INFO: Test took 16817ms.
[16:09:36.256] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:09:36.550] <TB3> INFO: dacScan step from 87 .. 87
[16:09:53.532] <TB3> INFO: Test took 16981ms.
[16:09:55.392] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:09:55.637] <TB3> INFO: dacScan step from 88 .. 88
[16:10:12.604] <TB3> INFO: Test took 16966ms.
[16:10:14.283] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:10:14.527] <TB3> INFO: dacScan step from 89 .. 89
[16:10:31.196] <TB3> INFO: Test took 16667ms.
[16:10:33.116] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:10:33.413] <TB3> INFO: dacScan step from 90 .. 90
[16:10:50.111] <TB3> INFO: Test took 16697ms.
[16:10:51.914] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:10:52.221] <TB3> INFO: dacScan step from 91 .. 91
[16:11:09.010] <TB3> INFO: Test took 16787ms.
[16:11:11.005] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:11:11.308] <TB3> INFO: dacScan step from 92 .. 92
[16:11:28.421] <TB3> INFO: Test took 17111ms.
[16:11:30.306] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:11:30.551] <TB3> INFO: dacScan step from 93 .. 93
[16:11:46.930] <TB3> INFO: Test took 16378ms.
[16:11:48.675] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:11:48.968] <TB3> INFO: dacScan step from 94 .. 94
[16:12:05.180] <TB3> INFO: Test took 16211ms.
[16:12:06.790] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:12:07.021] <TB3> INFO: dacScan step from 95 .. 95
[16:12:24.610] <TB3> INFO: Test took 17588ms.
[16:12:26.487] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:12:26.754] <TB3> INFO: dacScan step from 96 .. 96
[16:12:44.513] <TB3> INFO: Test took 17757ms.
[16:12:46.233] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:12:46.464] <TB3> INFO: dacScan step from 97 .. 97
[16:13:03.430] <TB3> INFO: Test took 16965ms.
[16:13:04.952] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:13:05.184] <TB3> INFO: dacScan step from 98 .. 98
[16:13:21.614] <TB3> INFO: Test took 16429ms.
[16:13:23.432] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:13:23.678] <TB3> INFO: dacScan step from 99 .. 99
[16:13:39.670] <TB3> INFO: Test took 15991ms.
[16:13:41.322] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:13:41.553] <TB3> INFO: dacScan step from 100 .. 100
[16:13:58.579] <TB3> INFO: Test took 17025ms.
[16:14:00.272] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:14:00.504] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:01.988] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:03.265] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:04.515] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:05.812] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:07.131] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:08.488] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:09.818] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:11.145] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:12.506] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:13.868] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:15.255] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:16.595] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:17.911] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:19.157] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:20.409] <TB3> INFO: dumping ASCII scurve output file: XSCurveData
[16:14:21.664] <TB3> INFO: PixTest:: pg_setup set to default.
[16:14:21.665] <TB3> INFO: vcal mean: 37.75 38.00 37.74 40.80 40.62 42.31 41.98 41.73 42.97 42.23 43.15 41.46 40.75 38.41 38.64 38.60
[16:14:21.665] <TB3> INFO: vcal RMS: 1.26 1.20 1.12 1.52 1.43 1.43 1.50 1.56 1.54 1.52 1.65 1.56 1.40 1.36 1.23 1.23
[16:14:21.665] <TB3> INFO: number of X-ray hits detected: 169991 167278 146251 285956 293568 367965 348515 352792 406809 385968 423407 315515 286518 172124 180369 180970
[16:14:21.665] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:14:21.665] <TB3> INFO: X-ray hit rate [MHz/cm2]: 49.8 49.0 42.9 83.8 86.0 107.9 102.2 103.4 119.2 113.1 124.1 92.5 84.0 50.5 52.9 53.0
[16:14:21.665] <TB3> INFO: PixTestHighRate::doXNoiseMaps() done
[16:14:21.763] <TB3> INFO: enter test to run
[16:14:21.763] <TB3> INFO: test: no parameter change
[16:14:21.934] <TB3> QUIET: Connection to board 121 closed.
[16:14:22.013] <TB3> INFO: pXar: this is the end, my friend
commander_CalDelScanAndSaveDacs.log
[16:33:58.396] <TB3> INFO: *** Welcome to pxar ***
[16:33:58.396] <TB3> INFO: *** Today: 2015/08/13
[16:33:58.396] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:33:58.397] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//tbmParameters_C0b.dat
[16:33:58.398] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//defaultMaskFile.dat
[16:33:58.398] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//trimParameters35_C15.dat
[16:33:58.478] <TB3> INFO: clk: 4
[16:33:58.478] <TB3> INFO: ctr: 4
[16:33:58.478] <TB3> INFO: sda: 19
[16:33:58.478] <TB3> INFO: tin: 9
[16:33:58.478] <TB3> INFO: level: 15
[16:33:58.478] <TB3> INFO: triggerdelay: 0
[16:33:58.478] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:33:58.478] <TB3> INFO: Log level: INFO
[16:33:58.490] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:33:58.502] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:33:58.505] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:33:58.508] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:34:00.036] <TB3> INFO: DUT info:
[16:34:00.036] <TB3> INFO: The DUT currently contains the following objects:
[16:34:00.036] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:34:00.036] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:34:00.037] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:34:00.037] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:34:00.037] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.037] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:34:00.438] <TB3> INFO: enter 'restricted' command line mode
[16:34:00.438] <TB3> INFO: enter test to run
[16:34:00.439] <TB3> INFO: test: HighRate no parameter change
[16:34:00.439] <TB3> INFO: running: highrate
[16:34:00.439] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//phCalibrationFitErr35_C15.dat
[16:34:00.636] <TB3> INFO: ----------------------------------------------------------------------
[16:34:00.636] <TB3> INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[16:34:00.636] <TB3> INFO: ----------------------------------------------------------------------
[16:34:01.722] <TB3> INFO: Test took 1079ms.
[16:34:05.480] <TB3> INFO: Test took 3753ms.
[16:34:05.616] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:09.421] <TB3> INFO: Test took 3778ms.
[16:34:09.569] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:13.455] <TB3> INFO: Test took 3853ms.
[16:34:13.618] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:17.502] <TB3> INFO: Test took 3851ms.
[16:34:17.665] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:21.621] <TB3> INFO: Test took 3930ms.
[16:34:21.792] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:25.778] <TB3> INFO: Test took 3953ms.
[16:34:25.917] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:29.799] <TB3> INFO: Test took 3856ms.
[16:34:29.945] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:33.957] <TB3> INFO: Test took 3978ms.
[16:34:34.119] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:38.106] <TB3> INFO: Test took 3952ms.
[16:34:38.252] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:42.190] <TB3> INFO: Test took 3912ms.
[16:34:42.348] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:46.384] <TB3> INFO: Test took 4005ms.
[16:34:46.555] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:50.647] <TB3> INFO: Test took 4057ms.
[16:34:50.791] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:55.103] <TB3> INFO: Test took 4284ms.
[16:34:55.299] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:34:59.379] <TB3> INFO: Test took 4045ms.
[16:34:59.518] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:03.475] <TB3> INFO: Test took 3931ms.
[16:35:03.662] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:07.620] <TB3> INFO: Test took 3918ms.
[16:35:07.752] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:11.505] <TB3> INFO: Test took 3728ms.
[16:35:11.636] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:15.476] <TB3> INFO: Test took 3815ms.
[16:35:15.609] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:19.378] <TB3> INFO: Test took 3743ms.
[16:35:19.506] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:23.223] <TB3> INFO: Test took 3692ms.
[16:35:23.349] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:35:23.645] <TB3> INFO: enter test to run
[16:35:23.645] <TB3> INFO: test: Pretest no parameter change
[16:35:23.645] <TB3> INFO: running: pretest
[16:35:23.645] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C0.dat
[16:35:23.646] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C1.dat
[16:35:23.646] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C2.dat
[16:35:23.646] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C3.dat
[16:35:23.646] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C4.dat
[16:35:23.646] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C5.dat
[16:35:23.646] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C6.dat
[16:35:23.646] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C7.dat
[16:35:23.647] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C8.dat
[16:35:23.647] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C9.dat
[16:35:23.647] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C10.dat
[16:35:23.647] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C11.dat
[16:35:23.647] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C12.dat
[16:35:23.647] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C13.dat
[16:35:23.647] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C14.dat
[16:35:23.647] <TB3> INFO: write dac parameters into /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//010_CalDelScanAndSaveDacs_4mA25kV//dacParameters35_C15.dat
[16:35:23.647] <TB3> INFO: enter test to run
[16:35:23.647] <TB3> INFO: test: no parameter change
[16:35:23.832] <TB3> QUIET: Connection to board 121 closed.
[16:35:23.911] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:35:58.354] <TB3> INFO: *** Welcome to pxar ***
[16:35:58.354] <TB3> INFO: *** Today: 2015/08/13
[16:35:58.354] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//dacParameters35_C15.dat
[16:35:58.355] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//tbmParameters_C0b.dat
[16:35:58.355] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//defaultMaskFile.dat
[16:35:58.355] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//trimParameters35_C15.dat
[16:35:58.424] <TB3> INFO: clk: 4
[16:35:58.424] <TB3> INFO: ctr: 4
[16:35:58.424] <TB3> INFO: sda: 19
[16:35:58.424] <TB3> INFO: tin: 9
[16:35:58.424] <TB3> INFO: level: 15
[16:35:58.424] <TB3> INFO: triggerdelay: 0
[16:35:58.424] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:35:58.424] <TB3> INFO: Log level: INFO
[16:35:58.437] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:35:58.449] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:35:58.452] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:35:58.455] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:36:00.036] <TB3> INFO: DUT info:
[16:36:00.036] <TB3> INFO: The DUT currently contains the following objects:
[16:36:00.036] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:36:00.036] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:36:00.036] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:36:00.036] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:36:00.036] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.036] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.037] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:00.438] <TB3> INFO: enter 'restricted' command line mode
[16:36:00.438] <TB3> INFO: enter test to run
[16:36:00.438] <TB3> INFO: test: HighRate no parameter change
[16:36:00.438] <TB3> INFO: running: highrate
[16:36:00.438] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//011_HREfficiency_50//phCalibrationFitErr35_C15.dat
[16:36:00.581] <TB3> INFO: ----------------------------------------------------------------------
[16:36:00.581] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:36:00.581] <TB3> INFO: ----------------------------------------------------------------------
[16:36:13.458] <TB3> INFO: Test took 12871ms.
[16:36:14.168] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:36:14.468] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0
[16:36:14.468] <TB3> INFO: number of red-efficiency pixels: 96 94 95 205 188 284 254 303 364 331 357 244 205 112 122 133
[16:36:14.468] <TB3> INFO: number of X-ray hits detected: 83320 81778 70565 143662 145743 185880 175989 177894 204523 194900 215207 159333 143056 83517 88845 89955
[16:36:14.468] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:36:14.468] <TB3> INFO: number of Vcal hits detected: 207903 207906 207903 207741 207758 207693 207735 207681 207609 207648 207621 207741 207787 207884 207876 207860
[16:36:14.468] <TB3> INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[16:36:14.468] <TB3> INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.9 99.9 99.9 99.9 99.9
[16:36:14.468] <TB3> INFO: X-ray hit rate [MHz/cm2]: 24.4 24.0 20.7 42.1 42.7 54.5 51.6 52.1 59.9 57.1 63.1 46.7 41.9 24.5 26.0 26.4
[16:36:14.468] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:36:14.494] <TB3> INFO: PixTest:: pg_setup set to default.
[16:36:14.525] <TB3> INFO: enter test to run
[16:36:14.525] <TB3> INFO: test: no parameter change
[16:36:14.693] <TB3> QUIET: Connection to board 121 closed.
[16:36:14.774] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:36:49.121] <TB3> INFO: *** Welcome to pxar ***
[16:36:49.121] <TB3> INFO: *** Today: 2015/08/13
[16:36:49.121] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//dacParameters35_C15.dat
[16:36:49.122] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//tbmParameters_C0b.dat
[16:36:49.122] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//defaultMaskFile.dat
[16:36:49.122] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//trimParameters35_C15.dat
[16:36:49.190] <TB3> INFO: clk: 4
[16:36:49.190] <TB3> INFO: ctr: 4
[16:36:49.190] <TB3> INFO: sda: 19
[16:36:49.190] <TB3> INFO: tin: 9
[16:36:49.190] <TB3> INFO: level: 15
[16:36:49.190] <TB3> INFO: triggerdelay: 0
[16:36:49.190] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:36:49.190] <TB3> INFO: Log level: INFO
[16:36:49.202] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:36:49.213] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:36:49.216] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:36:49.219] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:36:50.739] <TB3> INFO: DUT info:
[16:36:50.739] <TB3> INFO: The DUT currently contains the following objects:
[16:36:50.739] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:36:50.739] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:36:50.739] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:36:50.739] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:36:50.739] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:50.739] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:36:51.141] <TB3> INFO: enter 'restricted' command line mode
[16:36:51.141] <TB3> INFO: enter test to run
[16:36:51.141] <TB3> INFO: test: HighRate no parameter change
[16:36:51.141] <TB3> INFO: running: highrate
[16:36:51.141] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//012_HREfficiency_100//phCalibrationFitErr35_C15.dat
[16:36:51.321] <TB3> INFO: ----------------------------------------------------------------------
[16:36:51.321] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:36:51.322] <TB3> INFO: ----------------------------------------------------------------------
[16:37:07.146] <TB3> INFO: Test took 15819ms.
[16:37:09.050] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:37:09.427] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0
[16:37:09.427] <TB3> INFO: number of red-efficiency pixels: 276 248 307 658 717 1068 911 1071 1353 1207 1450 879 646 430 337 336
[16:37:09.427] <TB3> INFO: number of X-ray hits detected: 169608 167466 145402 286926 294800 368446 349539 354355 408655 388225 425142 320301 287113 171829 181739 182612
[16:37:09.427] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:37:09.427] <TB3> INFO: number of Vcal hits detected: 207711 207741 207648 207202 207107 206635 206888 206691 206225 206408 205962 206902 207271 207459 207648 207649
[16:37:09.427] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.7 99.6 99.4 99.5 99.4 99.2 99.3 99.2 99.5 99.7 99.8 99.8 99.8
[16:37:09.427] <TB3> INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.6 99.6 99.3 99.5 99.4 99.1 99.2 99.0 99.5 99.6 99.7 99.8 99.8
[16:37:09.427] <TB3> INFO: X-ray hit rate [MHz/cm2]: 49.7 49.1 42.6 84.1 86.4 108.0 102.5 103.9 119.8 113.8 124.6 93.9 84.2 50.4 53.3 53.5
[16:37:09.427] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:37:09.454] <TB3> INFO: PixTest:: pg_setup set to default.
[16:37:09.486] <TB3> INFO: enter test to run
[16:37:09.486] <TB3> INFO: test: no parameter change
[16:37:09.630] <TB3> QUIET: Connection to board 121 closed.
[16:37:09.710] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:37:43.660] <TB3> INFO: *** Welcome to pxar ***
[16:37:43.660] <TB3> INFO: *** Today: 2015/08/13
[16:37:43.660] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//dacParameters35_C15.dat
[16:37:43.662] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//tbmParameters_C0b.dat
[16:37:43.662] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//defaultMaskFile.dat
[16:37:43.662] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//trimParameters35_C15.dat
[16:37:43.747] <TB3> INFO: clk: 4
[16:37:43.747] <TB3> INFO: ctr: 4
[16:37:43.747] <TB3> INFO: sda: 19
[16:37:43.747] <TB3> INFO: tin: 9
[16:37:43.747] <TB3> INFO: level: 15
[16:37:43.747] <TB3> INFO: triggerdelay: 0
[16:37:43.747] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:37:43.747] <TB3> INFO: Log level: INFO
[16:37:43.760] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:37:43.772] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:37:43.775] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:37:43.778] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:37:45.313] <TB3> INFO: DUT info:
[16:37:45.313] <TB3> INFO: The DUT currently contains the following objects:
[16:37:45.313] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:37:45.313] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:37:45.313] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:37:45.313] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:37:45.313] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.313] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:37:45.714] <TB3> INFO: enter 'restricted' command line mode
[16:37:45.714] <TB3> INFO: enter test to run
[16:37:45.714] <TB3> INFO: test: HighRate no parameter change
[16:37:45.714] <TB3> INFO: running: highrate
[16:37:45.715] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//013_HREfficiency_150//phCalibrationFitErr35_C15.dat
[16:37:45.854] <TB3> INFO: ----------------------------------------------------------------------
[16:37:45.854] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:37:45.854] <TB3> INFO: ----------------------------------------------------------------------
[16:38:03.863] <TB3> INFO: Test took 18003ms.
[16:38:07.234] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:38:07.669] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0
[16:38:07.669] <TB3> INFO: number of red-efficiency pixels: 513 492 632 1359 1421 2180 1919 2285 2596 2284 2771 1850 1477 831 741 713
[16:38:07.669] <TB3> INFO: number of X-ray hits detected: 246516 244428 214436 413657 427320 530716 504220 510215 587254 556192 609207 458885 414895 250806 265339 263374
[16:38:07.669] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:38:07.669] <TB3> INFO: number of Vcal hits detected: 207440 207452 207098 206108 205890 204186 204856 204198 203014 203724 202087 204988 205976 206693 207178 207194
[16:38:07.669] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.7 99.8 99.7 99.2 99.1 98.4 98.7 98.4 97.9 98.2 97.5 98.8 99.2 99.5 99.6 99.6
[16:38:07.669] <TB3> INFO: Vcal hit overall efficiency (%): 99.7 99.7 99.6 99.1 99.0 98.2 98.5 98.2 97.6 97.9 97.2 98.6 99.0 99.4 99.6 99.6
[16:38:07.669] <TB3> INFO: X-ray hit rate [MHz/cm2]: 72.3 71.6 62.9 121.2 125.3 155.6 147.8 149.5 172.1 163.0 178.6 134.5 121.6 73.5 77.8 77.2
[16:38:07.669] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:38:07.695] <TB3> INFO: PixTest:: pg_setup set to default.
[16:38:07.728] <TB3> INFO: enter test to run
[16:38:07.728] <TB3> INFO: test: no parameter change
[16:38:07.890] <TB3> QUIET: Connection to board 121 closed.
[16:38:07.969] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:38:43.951] <TB3> INFO: *** Welcome to pxar ***
[16:38:43.951] <TB3> INFO: *** Today: 2015/08/13
[16:38:43.951] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//dacParameters35_C15.dat
[16:38:43.956] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//tbmParameters_C0b.dat
[16:38:43.956] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//defaultMaskFile.dat
[16:38:43.956] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//trimParameters35_C15.dat
[16:38:44.036] <TB3> INFO: clk: 4
[16:38:44.036] <TB3> INFO: ctr: 4
[16:38:44.036] <TB3> INFO: sda: 19
[16:38:44.036] <TB3> INFO: tin: 9
[16:38:44.036] <TB3> INFO: level: 15
[16:38:44.036] <TB3> INFO: triggerdelay: 0
[16:38:44.036] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:38:44.036] <TB3> INFO: Log level: INFO
[16:38:44.049] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:38:44.061] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:38:44.065] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:38:44.068] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:38:45.599] <TB3> INFO: DUT info:
[16:38:45.599] <TB3> INFO: The DUT currently contains the following objects:
[16:38:45.599] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:38:45.599] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:38:45.599] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:38:45.599] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:38:45.599] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.599] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:45.600] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:38:46.001] <TB3> INFO: enter 'restricted' command line mode
[16:38:46.001] <TB3> INFO: enter test to run
[16:38:46.001] <TB3> INFO: test: HighRate no parameter change
[16:38:46.001] <TB3> INFO: running: highrate
[16:38:46.002] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//014_HREfficiency_200//phCalibrationFitErr35_C15.dat
[16:38:46.145] <TB3> INFO: ----------------------------------------------------------------------
[16:38:46.145] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:38:46.145] <TB3> INFO: ----------------------------------------------------------------------
[16:39:06.749] <TB3> INFO: Test took 20599ms.
[16:39:12.545] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:39:13.060] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 1 1 0 0 0 0 0 0 0 0 0 0 0
[16:39:13.060] <TB3> INFO: number of red-efficiency pixels: 924 902 1018 2361 2519 3372 3071 3512 3765 3467 3799 2937 2468 1301 1344 1364
[16:39:13.060] <TB3> INFO: number of X-ray hits detected: 336022 333295 292045 559554 576136 712760 677120 687245 795553 750394 820827 618371 559839 342392 361474 358416
[16:39:13.060] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:39:13.060] <TB3> INFO: number of Vcal hits detected: 206887 206946 206096 203535 202896 198773 200228 198728 195775 197569 194233 201071 203336 204984 206263 206240
[16:39:13.060] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.5 99.3 98.2 97.9 96.0 96.7 96.0 94.7 95.6 94.2 97.1 98.0 98.8 99.2 99.2
[16:39:13.060] <TB3> INFO: Vcal hit overall efficiency (%): 99.5 99.5 99.1 97.9 97.5 95.6 96.3 95.5 94.1 95.0 93.4 96.7 97.8 98.6 99.2 99.2
[16:39:13.060] <TB3> INFO: X-ray hit rate [MHz/cm2]: 98.5 97.7 85.6 164.0 168.9 208.9 198.5 201.4 233.2 219.9 240.6 181.2 164.1 100.4 106.0 105.1
[16:39:13.060] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:39:13.086] <TB3> INFO: PixTest:: pg_setup set to default.
[16:39:13.120] <TB3> INFO: enter test to run
[16:39:13.120] <TB3> INFO: test: no parameter change
[16:39:13.277] <TB3> QUIET: Connection to board 121 closed.
[16:39:13.357] <TB3> INFO: pXar: this is the end, my friend
commander_HREfficiency.log
[16:39:47.853] <TB3> INFO: *** Welcome to pxar ***
[16:39:47.853] <TB3> INFO: *** Today: 2015/08/13
[16:39:47.853] <TB3> INFO: readRocDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//dacParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//dacParameters35_C15.dat
[16:39:47.854] <TB3> INFO: readTbmDacs: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//tbmParameters_C0a.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//tbmParameters_C0b.dat
[16:39:47.854] <TB3> INFO: readMaskFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//defaultMaskFile.dat
[16:39:47.854] <TB3> INFO: readTrimFile: /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//trimParameters35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//trimParameters35_C15.dat
[16:39:47.926] <TB3> INFO: clk: 4
[16:39:47.926] <TB3> INFO: ctr: 4
[16:39:47.926] <TB3> INFO: sda: 19
[16:39:47.926] <TB3> INFO: tin: 9
[16:39:47.926] <TB3> INFO: level: 15
[16:39:47.926] <TB3> INFO: triggerdelay: 0
[16:39:47.926] <TB3> QUIET: Instanciating API for pxar v2.2.5+88~g694c14c
[16:39:47.926] <TB3> INFO: Log level: INFO
[16:39:47.940] <TB3> INFO: Found DTB DTB_WWV6Z5
[16:39:47.952] <TB3> QUIET: Connection to board DTB_WWV6Z5 opened.
[16:39:47.955] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 121
HW version: DTB1.2
FW version: 4.0
SW version: 4.0
USB id: DTB_WWV6Z5
MAC address: 40D855118079
Hostname: pixelDTB121
Comment:
------------------------------------------------------
[16:39:47.957] <TB3> INFO: RPC call hashes of host and DTB match: 447413373
[16:39:49.485] <TB3> INFO: DUT info:
[16:39:49.485] <TB3> INFO: The DUT currently contains the following objects:
[16:39:49.485] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[16:39:49.485] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:39:49.485] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:39:49.485] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:39:49.485] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.485] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:39:49.886] <TB3> INFO: enter 'restricted' command line mode
[16:39:49.886] <TB3> INFO: enter test to run
[16:39:49.886] <TB3> INFO: test: HighRate no parameter change
[16:39:49.886] <TB3> INFO: running: highrate
[16:39:49.886] <TB3> INFO: readGainPedestalParameters /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//phCalibrationFitErr35_C0.dat .. /usr/local/data/M2073_XrayQualification_2015-08-13_17h13m_1439478799//015_HREfficiency_250//phCalibrationFitErr35_C15.dat
[16:39:50.022] <TB3> INFO: ----------------------------------------------------------------------
[16:39:50.022] <TB3> INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[16:39:50.022] <TB3> INFO: ----------------------------------------------------------------------
[16:40:11.632] <TB3> INFO: Test took 21604ms.
[16:40:17.653] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[16:40:18.168] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 1 1 0 0 0 0 0 0 0 0 0 0 0
[16:40:18.168] <TB3> INFO: number of red-efficiency pixels: 974 984 1053 2438 2611 3468 3206 3578 3839 3537 3874 3041 2636 1445 1481 1405
[16:40:18.168] <TB3> INFO: number of X-ray hits detected: 349016 346777 306331 573237 592426 731653 698837 708927 818206 768450 838905 636397 575178 358087 377997 367775
[16:40:18.168] <TB3> INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[16:40:18.168] <TB3> INFO: number of Vcal hits detected: 206807 206824 206052 203249 202507 198138 199415 197957 194747 196712 193353 200413 202883 204797 206064 206147
[16:40:18.168] <TB3> INFO: Vcal hit fiducial efficiency (%): 99.5 99.5 99.2 98.0 97.7 95.8 96.4 95.6 94.2 95.2 93.8 96.8 97.8 98.7 99.1 99.2
[16:40:18.168] <TB3> INFO: Vcal hit overall efficiency (%): 99.4 99.4 99.1 97.7 97.4 95.3 95.9 95.2 93.6 94.6 93.0 96.4 97.5 98.5 99.1 99.1
[16:40:18.168] <TB3> INFO: X-ray hit rate [MHz/cm2]: 102.3 101.6 89.8 168.0 173.6 214.5 204.8 207.8 239.8 225.2 245.9 186.5 168.6 105.0 110.8 107.8
[16:40:18.168] <TB3> INFO: PixTestHighRate::doXPixelAlive() done
[16:40:18.194] <TB3> INFO: PixTest:: pg_setup set to default.
[16:40:18.229] <TB3> INFO: enter test to run
[16:40:18.229] <TB3> INFO: test: no parameter change
[16:40:18.373] <TB3> QUIET: Connection to board 121 closed.
[16:40:18.453] <TB3> INFO: pXar: this is the end, my friend
MoReWeb-v1.0.0-5-g82d9ff6 on branch psi46master