[07:41:07.459] INFO: *** Welcome to pxar ***
[07:41:07.459] INFO: *** Today: 2016/09/22
[07:41:08.502] INFO: *** Version: v1.9.0-818-g96727
[07:41:08.502] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//dacParameters35_C15.dat
[07:41:08.601] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//tbmParameters_C0b.dat
[07:41:08.601] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//defaultMaskFile.dat
[07:41:08.609] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C15.dat
[07:41:08.745] INFO: clk: 4
[07:41:08.745] INFO: ctr: 4
[07:41:08.745] INFO: sda: 19
[07:41:08.745] INFO: tin: 9
[07:41:08.745] INFO: level: 15
[07:41:08.745] INFO: triggerdelay: 0
[07:41:08.745] QUIET: Instanciating API for pxar v1.9.0+814~g74979a6
[07:41:08.745] INFO: Log level: INFO
[07:41:08.765] QUIET: Connection to board DTB_WREKRL opened.
[07:41:08.769] 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:
------------------------------------------------------
[07:41:08.772] INFO: RPC call hashes of host and DTB match: 398089610
[07:41:10.305] INFO: DUT info:
[07:41:10.305] INFO: The DUT currently contains the following objects:
[07:41:10.305] INFO: 2 TBM Cores tbm08c (2 ON)
[07:41:10.305] INFO: TBM Core alpha (0): 7 registers set
[07:41:10.305] INFO: TBM Core beta (1): 7 registers set
[07:41:10.305] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:41:10.305] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.305] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:41:10.740] INFO: enter 'restricted' command line mode
[07:41:10.740] INFO: enter test to run
[07:41:20.035] INFO: test: PixelAlive no parameter change
[07:41:20.035] INFO: running: pixelalive
[07:41:20.085] INFO: ----------------------------------------------------------------------
[07:41:20.085] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[07:41:20.085] INFO: ----------------------------------------------------------------------
[07:41:20.404] INFO: Expecting 41600 events.
[07:41:24.735] INFO: 41600 events read in total (3612ms).
[07:41:24.904] INFO: Test took 4815ms.
[07:41:24.916] INFO: Fetched DAQ statistics. Counters are being reset now.
[07:41:25.252] INFO: PixTestAlive::aliveTest() done
[07:41:25.252] INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 1 0 0 0
[07:41:25.283] INFO: enter test to run
[07:41:50.563] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[07:41:50.563] INFO: running: highrate
[07:41:50.563] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[07:41:50.801] INFO: ----------------------------------------------------------------------
[07:41:50.801] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[07:41:50.801] INFO: ----------------------------------------------------------------------
[07:41:50.801] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[07:41:50.801] INFO: edge/corner pixel THR is adjusted
[07:41:50.801] INFO: PixTestHighRate::trimHotPixels: step 0...
[07:41:51.761] INFO: Collecting data for 5 seconds...
[07:41:56.778] INFO: Done with hot pixel readout
[07:42:08.977] INFO: PixTest:: pg_setup set to default.
[07:42:08.977] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:08.977] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:08.978] INFO: 63 hot pixels found in step 0
[07:42:09.995] INFO: Collecting data for 5 seconds...
[07:42:15.012] INFO: Done with hot pixel readout
[07:42:27.142] INFO: PixTest:: pg_setup set to default.
[07:42:27.142] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:27.142] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:27.142] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:27.142] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:27.143] INFO: 76 hot pixels found in step 1
[07:42:28.135] INFO: Collecting data for 5 seconds...
[07:42:33.152] INFO: Done with hot pixel readout
[07:42:45.278] INFO: PixTest:: pg_setup set to default.
[07:42:45.278] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:45.278] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:45.278] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:45.279] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:42:45.279] INFO: 63 hot pixels found in step 2
[07:42:46.271] INFO: Collecting data for 5 seconds...
[07:42:51.288] INFO: Done with hot pixel readout
[07:43:03.447] INFO: PixTest:: pg_setup set to default.
[07:43:03.447] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:03.447] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:03.447] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:03.448] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:03.448] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:03.448] INFO: 54 hot pixels found in step 3
[07:43:04.440] INFO: Collecting data for 5 seconds...
[07:43:09.456] INFO: Done with hot pixel readout
[07:43:21.568] INFO: PixTest:: pg_setup set to default.
[07:43:21.568] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:21.568] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:21.568] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:21.569] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:21.569] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:21.569] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:21.569] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:21.569] INFO: 54 hot pixels found in step 4
[07:43:22.561] INFO: Collecting data for 5 seconds...
[07:43:27.578] INFO: Done with hot pixel readout
[07:43:39.722] INFO: PixTest:: pg_setup set to default.
[07:43:39.722] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:39.723] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:39.723] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:39.723] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:39.723] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:39.723] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:39.723] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:39.723] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:39.724] INFO: 42 hot pixels found in step 5
[07:43:40.714] INFO: Collecting data for 5 seconds...
[07:43:45.731] INFO: Done with hot pixel readout
[07:43:57.879] INFO: PixTest:: pg_setup set to default.
[07:43:57.879] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.879] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.879] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.879] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.879] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.879] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.879] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.879] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.880] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.880] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:43:57.880] INFO: 53 hot pixels found in step 6
[07:43:58.871] INFO: Collecting data for 5 seconds...
[07:44:03.888] INFO: Done with hot pixel readout
[07:44:16.022] INFO: PixTest:: pg_setup set to default.
[07:44:16.022] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:16.022] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:16.022] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:16.022] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:16.022] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:16.022] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:16.022] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:16.022] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:16.023] INFO: 35 hot pixels found in step 7
[07:44:17.013] INFO: Collecting data for 5 seconds...
[07:44:22.030] INFO: Done with hot pixel readout
[07:44:34.159] INFO: PixTest:: pg_setup set to default.
[07:44:34.159] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.159] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.159] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.159] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.159] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.159] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.160] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.160] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.160] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.160] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:34.160] INFO: 45 hot pixels found in step 8
[07:44:35.152] INFO: Collecting data for 5 seconds...
[07:44:40.170] INFO: Done with hot pixel readout
[07:44:52.297] INFO: PixTest:: pg_setup set to default.
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:44:52.299] INFO: 44 hot pixels found in step 9
[07:44:53.290] INFO: Collecting data for 5 seconds...
[07:44:58.307] INFO: Done with hot pixel readout
[07:45:10.384] INFO: PixTest:: pg_setup set to default.
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.384] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:10.385] INFO: 45 hot pixels found in step 10
[07:45:11.377] INFO: Collecting data for 5 seconds...
[07:45:16.394] INFO: Done with hot pixel readout
[07:45:28.547] INFO: PixTest:: pg_setup set to default.
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.547] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:28.548] INFO: 36 hot pixels found in step 11
[07:45:29.540] INFO: Collecting data for 5 seconds...
[07:45:34.556] INFO: Done with hot pixel readout
[07:45:46.706] INFO: PixTest:: pg_setup set to default.
[07:45:46.706] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.706] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.706] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.706] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.706] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.706] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.707] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.707] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.707] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:45:46.707] INFO: 32 hot pixels found in step 12
[07:45:47.699] INFO: Collecting data for 5 seconds...
[07:45:52.716] INFO: Done with hot pixel readout
[07:46:04.890] INFO: PixTest:: pg_setup set to default.
[07:46:04.890] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.890] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.890] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.890] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.890] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.890] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.890] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.891] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.891] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.891] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.891] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.891] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.891] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.891] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:04.892] INFO: 31 hot pixels found in step 13
[07:46:05.883] INFO: Collecting data for 5 seconds...
[07:46:10.900] INFO: Done with hot pixel readout
[07:46:23.330] INFO: PixTest:: pg_setup set to default.
[07:46:23.330] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.330] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.330] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.330] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.330] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.330] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.330] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.330] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.331] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.331] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.331] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[07:46:23.332] INFO: 33 hot pixels found in step 14
[07:46:23.375] INFO: 33 hot pixels could not be trimmed and have been masked.
[07:46:23.396] INFO: PixTest::trimHotPixels() done
[07:46:23.403] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C0.dat
[07:46:23.409] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C1.dat
[07:46:23.415] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C2.dat
[07:46:23.420] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C3.dat
[07:46:23.426] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C4.dat
[07:46:23.431] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C5.dat
[07:46:23.436] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C6.dat
[07:46:23.442] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C7.dat
[07:46:23.447] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C8.dat
[07:46:23.453] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C9.dat
[07:46:23.458] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C10.dat
[07:46:23.464] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C11.dat
[07:46:23.469] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C12.dat
[07:46:23.475] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C13.dat
[07:46:23.480] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C14.dat
[07:46:23.486] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C15.dat
[07:46:23.491] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//defaultMaskFile.dat
[07:46:23.501] INFO: enter test to run
[07:48:03.128] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[07:48:03.128] INFO: running: highrate
[07:48:03.133] INFO: ----------------------------------------------------------------------
[07:48:03.133] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[07:48:03.133] INFO: ----------------------------------------------------------------------
[07:48:03.133] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[07:48:03.133] INFO: edge/corner pixel THR is adjusted
[07:48:03.133] INFO: PixTestHighRate::trimHotPixels: step 0...
[07:48:04.090] INFO: Collecting data for 1 seconds...
[07:48:05.095] INFO: Done with hot pixel readout
[07:48:09.413] INFO: PixTest:: pg_setup set to default.
[07:48:09.414] INFO: 0 hot pixels found in step 0
[07:48:09.419] INFO: 0 hot pixels could not be trimmed and have been masked.
[07:48:09.493] INFO: PixTest::trimHotPixels() done
[07:48:09.493] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C0.dat
[07:48:09.508] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C1.dat
[07:48:09.519] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C2.dat
[07:48:09.524] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C3.dat
[07:48:09.529] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C4.dat
[07:48:09.535] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C5.dat
[07:48:09.540] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C6.dat
[07:48:09.546] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C7.dat
[07:48:09.551] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C8.dat
[07:48:09.557] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C9.dat
[07:48:09.562] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C10.dat
[07:48:09.568] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C11.dat
[07:48:09.573] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C12.dat
[07:48:09.579] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C13.dat
[07:48:09.584] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C14.dat
[07:48:09.589] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//trimParameters35_C15.dat
[07:48:09.595] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Q-3-32_FPIXTest-17C-FNAL-160915-1235-150V_2016-09-15_12h36m_1473960967/000_FPIXTest_p17//defaultMaskFile.dat
[07:48:09.607] INFO: enter test to run
[07:49:21.776] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[07:49:21.776] INFO: running: xray
[07:49:21.791] INFO: ----------------------------------------------------------------------
[07:49:21.791] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[07:49:21.791] INFO: ----------------------------------------------------------------------
[07:49:22.755] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[07:49:33.536] INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[07:50:04.330] INFO: Resuming triggers.
[07:50:15.114] INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[07:50:45.739] INFO: Resuming triggers.
[07:50:56.524] INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[07:51:26.452] INFO: Resuming triggers.
[07:51:37.237] INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[07:52:06.775] INFO: Resuming triggers.
[07:52:17.560] INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[07:52:47.206] INFO: Resuming triggers.
[07:52:57.991] INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[07:53:27.581] INFO: Resuming triggers.
[07:53:38.370] INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[07:54:07.979] INFO: Resuming triggers.
[07:54:18.767] INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[07:54:48.388] INFO: Resuming triggers.
[07:54:59.176] INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[07:55:28.808] INFO: Resuming triggers.
[07:55:32.091] INFO: data taking finished, elapsed time: 100 seconds.
[07:55:41.435] INFO: PixTest:: pg_setup set to default.
[07:55:41.438] INFO: PixTestXray::doPhRun() done
[07:55:41.637] INFO: enter test to run
[07:57:35.076] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[07:57:35.076] INFO: running: xray
[07:57:35.078] INFO: ----------------------------------------------------------------------
[07:57:35.078] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[07:57:35.078] INFO: ----------------------------------------------------------------------
[07:57:36.050] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[07:57:42.141] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[07:58:12.273] INFO: Resuming triggers.
[07:58:18.364] INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[07:58:48.454] INFO: Resuming triggers.
[07:58:54.546] INFO: run duration 18 seconds, buffer almost full (81%), pausing triggers.
[07:59:25.916] INFO: Resuming triggers.
[07:59:32.007] INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[08:00:02.807] INFO: Resuming triggers.
[08:00:08.901] INFO: run duration 30 seconds, buffer almost full (81%), pausing triggers.
[08:00:39.920] INFO: Resuming triggers.
[08:00:46.010] INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[08:01:17.013] INFO: Resuming triggers.
[08:01:23.105] INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[08:01:51.914] INFO: Resuming triggers.
[08:01:58.007] INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[08:02:27.937] INFO: Resuming triggers.
[08:02:34.030] INFO: run duration 54 seconds, buffer almost full (81%), pausing triggers.
[08:03:04.345] INFO: Resuming triggers.
[08:03:10.438] INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[08:03:40.929] INFO: Resuming triggers.
[08:03:47.024] INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[08:04:17.689] INFO: Resuming triggers.
[08:04:23.785] INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[08:04:54.321] INFO: Resuming triggers.
[08:05:00.417] INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[08:05:30.821] INFO: Resuming triggers.
[08:05:36.917] INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[08:06:07.448] INFO: Resuming triggers.
[08:06:13.546] INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[08:06:43.782] INFO: Resuming triggers.
[08:06:49.877] INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[08:07:20.366] INFO: Resuming triggers.
[08:07:23.220] INFO: data taking finished, elapsed time: 100 seconds.
[08:07:38.045] INFO: PixTest:: pg_setup set to default.
[08:07:38.048] INFO: PixTestXray::doPhRun() done
[08:07:38.369] INFO: enter test to run
[08:08:13.160] INFO: test: HighRate no parameter change
[08:08:13.160] INFO: running: highrate
[08:08:13.552] INFO: ----------------------------------------------------------------------
[08:08:13.552] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[08:08:13.552] INFO: ----------------------------------------------------------------------
[08:08:13.773] INFO: Expecting 768 events.
[08:08:14.911] INFO: 768 events read in total (418ms).
[08:08:14.911] INFO: Test took 1310ms.
[08:08:15.803] INFO: Expecting 41600 events.
[08:08:18.897] INFO: 41600 events read in total (2567ms).
[08:08:18.898] INFO: Test took 3698ms.
[08:08:18.933] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:19.656] INFO: Expecting 41600 events.
[08:08:22.887] INFO: 41600 events read in total (2704ms).
[08:08:22.888] INFO: Test took 3937ms.
[08:08:22.924] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:23.645] INFO: Expecting 41600 events.
[08:08:26.926] INFO: 41600 events read in total (2754ms).
[08:08:26.927] INFO: Test took 3985ms.
[08:08:26.963] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:27.674] INFO: Expecting 41600 events.
[08:08:30.926] INFO: 41600 events read in total (2725ms).
[08:08:30.927] INFO: Test took 3945ms.
[08:08:30.964] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:31.685] INFO: Expecting 41600 events.
[08:08:34.984] INFO: 41600 events read in total (2772ms).
[08:08:34.985] INFO: Test took 3972ms.
[08:08:35.023] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:35.739] INFO: Expecting 41600 events.
[08:08:38.990] INFO: 41600 events read in total (2724ms).
[08:08:38.991] INFO: Test took 3950ms.
[08:08:39.029] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:39.744] INFO: Expecting 41600 events.
[08:08:42.997] INFO: 41600 events read in total (2726ms).
[08:08:42.998] INFO: Test took 3949ms.
[08:08:43.041] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:43.750] INFO: Expecting 41600 events.
[08:08:46.984] INFO: 41600 events read in total (2707ms).
[08:08:46.985] INFO: Test took 3927ms.
[08:08:47.021] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:47.740] INFO: Expecting 41600 events.
[08:08:51.024] INFO: 41600 events read in total (2757ms).
[08:08:51.025] INFO: Test took 3986ms.
[08:08:51.061] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:51.778] INFO: Expecting 41600 events.
[08:08:55.066] INFO: 41600 events read in total (2761ms).
[08:08:55.067] INFO: Test took 3988ms.
[08:08:55.103] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:55.815] INFO: Expecting 41600 events.
[08:08:59.088] INFO: 41600 events read in total (2746ms).
[08:08:59.089] INFO: Test took 3966ms.
[08:08:59.125] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:08:59.842] INFO: Expecting 41600 events.
[08:09:03.084] INFO: 41600 events read in total (2715ms).
[08:09:03.085] INFO: Test took 3942ms.
[08:09:03.122] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:03.840] INFO: Expecting 41600 events.
[08:09:07.130] INFO: 41600 events read in total (2763ms).
[08:09:07.131] INFO: Test took 3991ms.
[08:09:07.167] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:07.886] INFO: Expecting 41600 events.
[08:09:11.161] INFO: 41600 events read in total (2749ms).
[08:09:11.162] INFO: Test took 3977ms.
[08:09:11.198] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:11.917] INFO: Expecting 41600 events.
[08:09:15.183] INFO: 41600 events read in total (2739ms).
[08:09:15.184] INFO: Test took 3966ms.
[08:09:15.220] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:15.940] INFO: Expecting 41600 events.
[08:09:19.223] INFO: 41600 events read in total (2756ms).
[08:09:19.224] INFO: Test took 3986ms.
[08:09:19.261] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:19.974] INFO: Expecting 41600 events.
[08:09:23.220] INFO: 41600 events read in total (2720ms).
[08:09:23.221] INFO: Test took 3942ms.
[08:09:23.258] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:23.972] INFO: Expecting 41600 events.
[08:09:27.232] INFO: 41600 events read in total (2733ms).
[08:09:27.233] INFO: Test took 3956ms.
[08:09:27.272] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:27.989] INFO: Expecting 41600 events.
[08:09:31.281] INFO: 41600 events read in total (2765ms).
[08:09:31.283] INFO: Test took 3992ms.
[08:09:31.321] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:32.029] INFO: Expecting 41600 events.
[08:09:35.204] INFO: 41600 events read in total (2648ms).
[08:09:35.205] INFO: Test took 3863ms.
[08:09:35.241] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:09:35.593] INFO: enter test to run
[08:09:54.887] INFO: test: HighRate no parameter change
[08:09:54.887] INFO: running: highrate
[08:09:54.889] INFO: ----------------------------------------------------------------------
[08:09:54.889] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:09:54.889] INFO: ----------------------------------------------------------------------
[08:09:55.510] INFO: Expecting 208000 events.
[08:10:07.620] INFO: 208000 events read in total (11583ms).
[08:10:07.623] INFO: Test took 12725ms.
[08:10:07.781] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:10:08.039] INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 1 0 0 0
[08:10:08.039] INFO: number of red-efficiency pixels: 85 44 95 124 138 202 214 135 113 127 121 112 114 79 21 21
[08:10:08.040] INFO: number of X-ray hits detected: 66253 43507 71860 113346 123353 130906 129827 94084 79891 101147 101313 88252 93802 57493 23358 25198
[08:10:08.040] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:10:08.040] INFO: number of Vcal hits detected: 207913 207907 207904 207874 207858 207790 207783 207857 207884 207869 207877 207887 207827 207921 207979 207979
[08:10:08.040] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 99.9 100.0 100.0 100.0
[08:10:08.040] INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[08:10:08.040] INFO: X-ray hit rate [MHz/cm2]: 19.4 12.8 21.1 33.2 36.2 38.4 38.1 27.6 23.4 29.6 29.7 25.9 27.5 16.9 6.8 7.4
[08:10:08.040] INFO: PixTestHighRate::doXPixelAlive() done
[08:10:08.084] INFO: PixTest:: pg_setup set to default.
[08:10:08.095] INFO: enter test to run
[08:10:33.047] INFO: test: HighRate no parameter change
[08:10:33.047] INFO: running: highrate
[08:10:33.048] INFO: ----------------------------------------------------------------------
[08:10:33.048] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:10:33.048] INFO: ----------------------------------------------------------------------
[08:10:33.666] INFO: Expecting 208000 events.
[08:10:47.929] INFO: 208000 events read in total (13736ms).
[08:10:47.935] INFO: Test took 14876ms.
[08:10:48.274] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:10:48.592] INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 1 0 0 0
[08:10:48.592] INFO: number of red-efficiency pixels: 269 140 319 604 601 930 907 508 362 516 552 330 379 282 61 63
[08:10:48.592] INFO: number of X-ray hits detected: 148322 97095 161885 255191 275803 294781 289864 211353 179734 228194 227591 197835 209353 129495 52469 56810
[08:10:48.592] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:10:48.592] INFO: number of Vcal hits detected: 207702 207804 207645 207324 207342 206884 206941 207415 207618 207430 207377 207650 207514 207693 207937 207935
[08:10:48.592] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.5 99.5 99.7 99.8 99.7 99.7 99.8 99.8 99.9 100.0 100.0
[08:10:48.592] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.5 99.5 99.7 99.8 99.7 99.7 99.8 99.8 99.9 100.0 100.0
[08:10:48.592] INFO: X-ray hit rate [MHz/cm2]: 43.5 28.5 47.4 74.8 80.8 86.4 85.0 61.9 52.7 66.9 66.7 58.0 61.4 38.0 15.4 16.7
[08:10:48.592] INFO: PixTestHighRate::doXPixelAlive() done
[08:10:48.643] INFO: PixTest:: pg_setup set to default.
[08:10:48.656] INFO: enter test to run
[08:11:14.039] INFO: test: HighRate no parameter change
[08:11:14.039] INFO: running: highrate
[08:11:14.040] INFO: ----------------------------------------------------------------------
[08:11:14.040] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[08:11:14.040] INFO: ----------------------------------------------------------------------
[08:11:14.658] INFO: Expecting 208000 events.
[08:11:31.164] INFO: 208000 events read in total (15979ms).
[08:11:31.172] INFO: Test took 17121ms.
[08:11:31.705] INFO: Fetched DAQ statistics. Counters are being reset now.
[08:11:32.079] INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 1 0 0 0
[08:11:32.079] INFO: number of red-efficiency pixels: 595 282 689 1316 1438 2031 2002 1201 806 1171 1235 661 828 675 90 105
[08:11:32.079] INFO: number of X-ray hits detected: 222908 146091 242833 381934 413139 438516 432331 317341 270480 341311 340926 297163 314277 194429 79148 85788
[08:11:32.079] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[08:11:32.079] INFO: number of Vcal hits detected: 207248 207635 207087 206220 206020 204671 204914 206276 207040 206518 206411 207205 206943 207114 207899 207892
[08:11:32.080] INFO: Vcal hit fiducial efficiency (%): 99.7 99.9 99.6 99.2 99.2 98.6 98.7 99.3 99.6 99.4 99.3 99.7 99.6 99.6 100.0 99.9
[08:11:32.080] INFO: Vcal hit overall efficiency (%): 99.6 99.8 99.6 99.1 99.0 98.4 98.5 99.2 99.5 99.3 99.2 99.6 99.5 99.6 100.0 99.9
[08:11:32.080] INFO: X-ray hit rate [MHz/cm2]: 65.3 42.8 71.2 111.9 121.1 128.5 126.7 93.0 79.3 100.0 99.9 87.1 92.1 57.0 23.2 25.1
[08:11:32.080] INFO: PixTestHighRate::doXPixelAlive() done
[08:11:32.125] INFO: PixTest:: pg_setup set to default.
[08:11:32.142] INFO: enter test to run
[08:11:35.974] INFO: test: exit no parameter change
[08:11:37.276] QUIET: Connection to board 33 closed.
[08:11:37.469] INFO: pXar: this is the end, my friend