[12:12:45.703] INFO: *** Welcome to pxar ***
[12:12:45.703] INFO: *** Today: 2016/10/03
[12:12:45.949] INFO: *** Version: v1.9.0-818-g96727
[12:12:45.949] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//dacParameters35_C15.dat
[12:12:45.987] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//tbmParameters_C0b.dat
[12:12:45.987] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//defaultMaskFile.dat
[12:12:45.987] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C15.dat
[12:12:46.074] INFO: clk: 4
[12:12:46.074] INFO: ctr: 4
[12:12:46.074] INFO: sda: 19
[12:12:46.074] INFO: tin: 9
[12:12:46.074] INFO: level: 15
[12:12:46.074] INFO: triggerdelay: 0
[12:12:46.074] QUIET: Instanciating API for pxar v1.9.0+814~g74979a6
[12:12:46.074] INFO: Log level: INFO
[12:12:46.092] QUIET: Connection to board DTB_WREKRL opened.
[12:12:46.096] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 33
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WREKRL
MAC address: 40D855118021
Hostname: pixelDTB033
Comment:
------------------------------------------------------
[12:12:46.099] INFO: RPC call hashes of host and DTB match: 398089610
[12:12:47.630] INFO: DUT info:
[12:12:47.630] INFO: The DUT currently contains the following objects:
[12:12:47.630] INFO: 2 TBM Cores tbm08c (2 ON)
[12:12:47.630] INFO: TBM Core alpha (0): 7 registers set
[12:12:47.630] INFO: TBM Core beta (1): 7 registers set
[12:12:47.630] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:12:47.630] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.630] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.631] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:47.631] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:12:48.034] INFO: enter 'restricted' command line mode
[12:12:48.034] INFO: enter test to run
[12:12:56.063] INFO: test: PixelAlive no parameter change
[12:12:56.063] INFO: running: pixelalive
[12:12:56.072] INFO: ----------------------------------------------------------------------
[12:12:56.072] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:12:56.072] INFO: ----------------------------------------------------------------------
[12:12:56.392] INFO: Expecting 41600 events.
[12:13:00.740] INFO: 41600 events read in total (3629ms).
[12:13:00.897] INFO: Test took 4823ms.
[12:13:00.906] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:13:01.196] INFO: PixTestAlive::aliveTest() done
[12:13:01.196] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:13:01.224] INFO: enter test to run
[12:13:35.830] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[12:13:35.830] INFO: running: highrate
[12:13:35.830] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[12:13:36.026] INFO: ----------------------------------------------------------------------
[12:13:36.026] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[12:13:36.026] INFO: ----------------------------------------------------------------------
[12:13:36.026] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[12:13:36.027] INFO: edge/corner pixel THR is adjusted
[12:13:36.027] INFO: PixTestHighRate::trimHotPixels: step 0...
[12:13:36.985] INFO: Collecting data for 5 seconds...
[12:13:41.002] INFO: Done with hot pixel readout
[12:13:53.786] INFO: PixTest:: pg_setup set to default.
[12:13:53.787] INFO: 1 hot pixels found in step 0
[12:13:54.777] INFO: Collecting data for 5 seconds...
[12:13:59.793] INFO: Done with hot pixel readout
[12:14:11.502] INFO: PixTest:: pg_setup set to default.
[12:14:11.503] INFO: 1 hot pixels found in step 1
[12:14:12.499] INFO: Collecting data for 5 seconds...
[12:14:17.515] INFO: Done with hot pixel readout
[12:14:29.216] INFO: PixTest:: pg_setup set to default.
[12:14:29.217] INFO: 0 hot pixels found in step 2
[12:14:29.254] INFO: 0 hot pixels could not be trimmed and have been masked.
[12:14:29.257] INFO: PixTest::trimHotPixels() done
[12:14:29.257] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C0.dat
[12:14:29.264] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C1.dat
[12:14:29.270] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C2.dat
[12:14:29.275] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C3.dat
[12:14:29.281] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C4.dat
[12:14:29.286] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C5.dat
[12:14:29.291] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C6.dat
[12:14:29.297] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C7.dat
[12:14:29.302] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C8.dat
[12:14:29.307] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C9.dat
[12:14:29.313] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C10.dat
[12:14:29.318] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C11.dat
[12:14:29.323] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C12.dat
[12:14:29.328] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C13.dat
[12:14:29.333] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C14.dat
[12:14:29.339] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C15.dat
[12:14:29.344] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//defaultMaskFile.dat
[12:14:29.361] INFO: enter test to run
[12:14:58.542] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[12:14:58.542] INFO: running: highrate
[12:14:58.546] INFO: ----------------------------------------------------------------------
[12:14:58.546] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[12:14:58.546] INFO: ----------------------------------------------------------------------
[12:14:58.546] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[12:14:58.546] INFO: edge/corner pixel THR is adjusted
[12:14:58.546] INFO: PixTestHighRate::trimHotPixels: step 0...
[12:14:59.504] INFO: Collecting data for 1 seconds...
[12:15:00.507] INFO: Done with hot pixel readout
[12:15:04.579] INFO: PixTest:: pg_setup set to default.
[12:15:04.580] INFO: 0 hot pixels found in step 0
[12:15:04.585] INFO: 0 hot pixels could not be trimmed and have been masked.
[12:15:04.670] INFO: PixTest::trimHotPixels() done
[12:15:04.671] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C0.dat
[12:15:04.682] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C1.dat
[12:15:04.688] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C2.dat
[12:15:04.693] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C3.dat
[12:15:04.698] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C4.dat
[12:15:04.704] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C5.dat
[12:15:04.709] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C6.dat
[12:15:04.714] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C7.dat
[12:15:04.720] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C8.dat
[12:15:04.725] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C9.dat
[12:15:04.730] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C10.dat
[12:15:04.736] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C11.dat
[12:15:04.741] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C12.dat
[12:15:04.746] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C13.dat
[12:15:04.752] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C14.dat
[12:15:04.757] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//trimParameters35_C15.dat
[12:15:04.763] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Q-A-30_FPIXTest-17C-FNAL-160927-1211-150V_2016-09-27_12h11m_1474996287/000_FPIXTest_p17//defaultMaskFile.dat
[12:15:04.773] INFO: enter test to run
[12:15:26.045] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[12:15:26.046] INFO: running: xray
[12:15:26.060] INFO: ----------------------------------------------------------------------
[12:15:26.060] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:15:26.060] INFO: ----------------------------------------------------------------------
[12:15:27.039] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:15:38.273] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[12:16:07.651] INFO: Resuming triggers.
[12:16:18.887] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[12:16:47.667] INFO: Resuming triggers.
[12:16:58.902] INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[12:17:28.779] INFO: Resuming triggers.
[12:17:40.012] INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[12:18:09.456] INFO: Resuming triggers.
[12:18:20.689] INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[12:18:50.646] INFO: Resuming triggers.
[12:19:01.884] INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[12:19:31.539] INFO: Resuming triggers.
[12:19:42.770] INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[12:20:12.585] INFO: Resuming triggers.
[12:20:23.817] INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[12:20:54.329] INFO: Resuming triggers.
[12:21:04.822] INFO: data taking finished, elapsed time: 100 seconds.
[12:21:33.085] INFO: PixTest:: pg_setup set to default.
[12:21:33.088] INFO: PixTestXray::doPhRun() done
[12:21:33.403] INFO: enter test to run
[12:22:08.571] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[12:22:08.571] INFO: running: xray
[12:22:08.572] INFO: ----------------------------------------------------------------------
[12:22:08.572] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[12:22:08.572] INFO: ----------------------------------------------------------------------
[12:22:09.535] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[12:22:15.937] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[12:22:47.503] INFO: Resuming triggers.
[12:22:53.911] INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[12:23:24.902] INFO: Resuming triggers.
[12:23:31.308] INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[12:24:01.551] INFO: Resuming triggers.
[12:24:07.963] INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[12:24:38.167] INFO: Resuming triggers.
[12:24:44.574] INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[12:25:14.728] INFO: Resuming triggers.
[12:25:21.139] INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[12:25:51.332] INFO: Resuming triggers.
[12:25:57.741] INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[12:26:28.075] INFO: Resuming triggers.
[12:26:34.482] INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[12:27:04.152] INFO: Resuming triggers.
[12:27:10.561] INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[12:27:40.480] INFO: Resuming triggers.
[12:27:46.887] INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[12:28:17.034] INFO: Resuming triggers.
[12:28:23.443] INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[12:28:53.821] INFO: Resuming triggers.
[12:29:00.227] INFO: run duration 76 seconds, buffer almost full (81%), pausing triggers.
[12:29:30.912] INFO: Resuming triggers.
[12:29:37.322] INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[12:30:07.722] INFO: Resuming triggers.
[12:30:14.127] INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[12:30:44.744] INFO: Resuming triggers.
[12:30:51.152] INFO: run duration 95 seconds, buffer almost full (81%), pausing triggers.
[12:31:21.001] INFO: Resuming triggers.
[12:31:26.228] INFO: data taking finished, elapsed time: 100 seconds.
[12:31:46.904] INFO: PixTest:: pg_setup set to default.
[12:31:46.907] INFO: PixTestXray::doPhRun() done
[12:31:47.079] INFO: enter test to run
[12:32:06.759] INFO: test: HighRate no parameter change
[12:32:06.759] INFO: running: highrate
[12:32:06.841] INFO: ----------------------------------------------------------------------
[12:32:06.841] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[12:32:06.841] INFO: ----------------------------------------------------------------------
[12:32:06.002] INFO: Expecting 768 events.
[12:32:08.134] INFO: 768 events read in total (416ms).
[12:32:08.134] INFO: Test took 1268ms.
[12:32:08.937] INFO: Expecting 41600 events.
[12:32:12.036] INFO: 41600 events read in total (2572ms).
[12:32:12.037] INFO: Test took 3876ms.
[12:32:12.093] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:12.801] INFO: Expecting 41600 events.
[12:32:16.031] INFO: 41600 events read in total (2704ms).
[12:32:16.032] INFO: Test took 3911ms.
[12:32:16.067] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:16.786] INFO: Expecting 41600 events.
[12:32:20.018] INFO: 41600 events read in total (2705ms).
[12:32:20.019] INFO: Test took 3934ms.
[12:32:20.053] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:20.776] INFO: Expecting 41600 events.
[12:32:24.063] INFO: 41600 events read in total (2760ms).
[12:32:24.064] INFO: Test took 3994ms.
[12:32:24.100] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:24.819] INFO: Expecting 41600 events.
[12:32:28.081] INFO: 41600 events read in total (2735ms).
[12:32:28.082] INFO: Test took 3964ms.
[12:32:28.116] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:28.837] INFO: Expecting 41600 events.
[12:32:32.028] INFO: 41600 events read in total (2664ms).
[12:32:32.029] INFO: Test took 3895ms.
[12:32:32.063] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:32.784] INFO: Expecting 41600 events.
[12:32:36.072] INFO: 41600 events read in total (2761ms).
[12:32:36.073] INFO: Test took 3992ms.
[12:32:36.108] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:36.828] INFO: Expecting 41600 events.
[12:32:40.108] INFO: 41600 events read in total (2753ms).
[12:32:40.110] INFO: Test took 3984ms.
[12:32:40.145] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:40.868] INFO: Expecting 41600 events.
[12:32:44.135] INFO: 41600 events read in total (2740ms).
[12:32:44.136] INFO: Test took 3973ms.
[12:32:44.172] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:44.889] INFO: Expecting 41600 events.
[12:32:48.196] INFO: 41600 events read in total (2780ms).
[12:32:48.197] INFO: Test took 4008ms.
[12:32:48.233] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:48.951] INFO: Expecting 41600 events.
[12:32:52.199] INFO: 41600 events read in total (2721ms).
[12:32:52.200] INFO: Test took 3949ms.
[12:32:52.235] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:52.955] INFO: Expecting 41600 events.
[12:32:56.255] INFO: 41600 events read in total (2774ms).
[12:32:56.256] INFO: Test took 4003ms.
[12:32:56.292] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:32:57.008] INFO: Expecting 41600 events.
[12:33:00.290] INFO: 41600 events read in total (2755ms).
[12:33:00.290] INFO: Test took 3980ms.
[12:33:00.326] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:01.045] INFO: Expecting 41600 events.
[12:33:04.322] INFO: 41600 events read in total (2750ms).
[12:33:04.323] INFO: Test took 3980ms.
[12:33:04.359] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:05.082] INFO: Expecting 41600 events.
[12:33:08.340] INFO: 41600 events read in total (2731ms).
[12:33:08.341] INFO: Test took 3964ms.
[12:33:08.375] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:09.095] INFO: Expecting 41600 events.
[12:33:12.385] INFO: 41600 events read in total (2763ms).
[12:33:12.386] INFO: Test took 3992ms.
[12:33:12.422] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:13.141] INFO: Expecting 41600 events.
[12:33:16.405] INFO: 41600 events read in total (2737ms).
[12:33:16.405] INFO: Test took 3964ms.
[12:33:16.441] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:17.161] INFO: Expecting 41600 events.
[12:33:20.390] INFO: 41600 events read in total (2702ms).
[12:33:20.391] INFO: Test took 3932ms.
[12:33:20.425] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:21.147] INFO: Expecting 41600 events.
[12:33:24.432] INFO: 41600 events read in total (2758ms).
[12:33:24.433] INFO: Test took 3990ms.
[12:33:24.468] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:25.189] INFO: Expecting 41600 events.
[12:33:28.354] INFO: 41600 events read in total (2639ms).
[12:33:28.355] INFO: Test took 3868ms.
[12:33:28.390] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:28.761] INFO: enter test to run
[12:33:31.526] INFO: test: HighRate no parameter change
[12:33:31.526] INFO: running: highrate
[12:33:31.527] INFO: ----------------------------------------------------------------------
[12:33:31.527] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:33:31.527] INFO: ----------------------------------------------------------------------
[12:33:32.140] INFO: Expecting 208000 events.
[12:33:44.230] INFO: 208000 events read in total (11563ms).
[12:33:44.233] INFO: Test took 12699ms.
[12:33:44.384] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:33:44.637] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:33:44.637] INFO: number of red-efficiency pixels: 87 60 82 110 140 124 130 113 100 113 136 120 149 75 23 28
[12:33:44.637] INFO: number of X-ray hits detected: 65739 42611 66997 102187 109987 110406 111554 81287 77703 103053 104833 90626 94069 55867 22090 24408
[12:33:44.637] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:33:44.637] INFO: number of Vcal hits detected: 207910 207939 207916 207886 207855 207873 207867 207884 207899 207884 207860 207878 207849 207925 207977 207972
[12:33:44.637] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 100.0 100.0 99.9 99.9 99.9 100.0 100.0 100.0
[12:33:44.637] INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 100.0 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[12:33:44.637] INFO: X-ray hit rate [MHz/cm2]: 19.3 12.5 19.6 30.0 32.2 32.4 32.7 23.8 22.8 30.2 30.7 26.6 27.6 16.4 6.5 7.2
[12:33:44.637] INFO: PixTestHighRate::doXPixelAlive() done
[12:33:44.683] INFO: PixTest:: pg_setup set to default.
[12:33:44.695] INFO: enter test to run
[12:33:59.006] INFO: test: HighRate no parameter change
[12:33:59.006] INFO: running: highrate
[12:34:00.007] INFO: ----------------------------------------------------------------------
[12:34:00.007] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:34:00.007] INFO: ----------------------------------------------------------------------
[12:34:00.626] INFO: Expecting 208000 events.
[12:34:14.729] INFO: 208000 events read in total (13576ms).
[12:34:14.735] INFO: Test took 14719ms.
[12:34:15.044] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:34:15.351] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:34:15.351] INFO: number of red-efficiency pixels: 241 149 231 382 433 413 477 389 249 417 541 424 397 239 45 54
[12:34:15.351] INFO: number of X-ray hits detected: 138210 89154 141651 214084 231385 232529 236067 170582 163147 216273 220514 189515 198809 117525 46386 51428
[12:34:15.351] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:34:15.352] INFO: number of Vcal hits detected: 207737 207842 207743 207597 207521 207552 207467 207570 207730 207545 207404 207540 207577 207748 207954 207946
[12:34:15.352] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.9 99.8 99.7 99.8 99.8 99.9 100.0 100.0
[12:34:15.352] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.7 99.8 99.9 99.8 99.7 99.8 99.8 99.9 100.0 100.0
[12:34:15.352] INFO: X-ray hit rate [MHz/cm2]: 40.5 26.1 41.5 62.7 67.8 68.2 69.2 50.0 47.8 63.4 64.6 55.5 58.3 34.4 13.6 15.1
[12:34:15.352] INFO: PixTestHighRate::doXPixelAlive() done
[12:34:15.398] INFO: PixTest:: pg_setup set to default.
[12:34:15.413] INFO: enter test to run
[12:34:32.294] INFO: test: HighRate no parameter change
[12:34:32.294] INFO: running: highrate
[12:34:32.295] INFO: ----------------------------------------------------------------------
[12:34:32.295] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[12:34:32.295] INFO: ----------------------------------------------------------------------
[12:34:32.917] INFO: Expecting 208000 events.
[12:34:49.621] INFO: 208000 events read in total (16178ms).
[12:34:49.628] INFO: Test took 17325ms.
[12:34:50.124] INFO: Fetched DAQ statistics. Counters are being reset now.
[12:34:50.489] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:34:50.490] INFO: number of red-efficiency pixels: 596 331 625 907 1086 1105 1221 949 646 1014 1337 1053 1023 586 103 90
[12:34:50.490] INFO: number of X-ray hits detected: 218475 140907 225706 341162 365386 367767 371837 271262 259248 342564 348697 300553 315530 185665 73174 81921
[12:34:50.490] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[12:34:50.490] INFO: number of Vcal hits detected: 207248 207611 207185 206915 206650 206585 206383 206673 207263 206767 206239 206688 206772 207258 207894 207909
[12:34:50.490] INFO: Vcal hit fiducial efficiency (%): 99.7 99.8 99.6 99.5 99.4 99.4 99.3 99.4 99.7 99.5 99.2 99.4 99.5 99.7 100.0 100.0
[12:34:50.490] INFO: Vcal hit overall efficiency (%): 99.6 99.8 99.6 99.5 99.4 99.3 99.2 99.4 99.6 99.4 99.2 99.4 99.4 99.6 99.9 100.0
[12:34:50.490] INFO: X-ray hit rate [MHz/cm2]: 64.0 41.3 66.2 100.0 107.1 107.8 109.0 79.5 76.0 100.4 102.2 88.1 92.5 54.4 21.4 24.0
[12:34:50.490] INFO: PixTestHighRate::doXPixelAlive() done
[12:34:50.535] INFO: PixTest:: pg_setup set to default.
[12:34:50.551] INFO: enter test to run
[12:34:54.957] INFO: test: exit no parameter change
[12:34:55.444] QUIET: Connection to board 33 closed.
[12:34:55.567] INFO: pXar: this is the end, my friend