[10:40:43.109]     INFO: *** Welcome to pxar ***
[10:40:43.109]     INFO: *** Today: 2016/08/19
[10:40:43.521]     INFO: *** Version: v1.9.0-818-g96727
[10:40:43.521]     INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/dacParameters35_C15.dat
[10:40:43.532]     INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/tbmParameters_C0b.dat
[10:40:43.532]     INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/defaultMaskFile.dat
[10:40:43.537]     INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C15.dat
[10:40:43.620]     INFO:         clk: 4
[10:40:43.620]     INFO:         ctr: 4
[10:40:43.620]     INFO:         sda: 19
[10:40:43.620]     INFO:         tin: 9
[10:40:43.620]     INFO:         level: 15
[10:40:43.620]     INFO:         triggerdelay: 0
[10:40:43.620]    QUIET: Instanciating API for pxar v1.9.0+814~g74979a6
[10:40:43.620]     INFO: Log level: INFO
[10:40:43.638]    QUIET: Connection to board DTB_WREKRL opened.
[10:40:43.642]     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:     
------------------------------------------------------
[10:40:43.644]     INFO: RPC call hashes of host and DTB match: 398089610
[10:40:45.176]     INFO: DUT info: 
[10:40:45.176]     INFO: The DUT currently contains the following objects:
[10:40:45.176]     INFO:  2 TBM Cores tbm08c (2 ON)
[10:40:45.176]     INFO: 	TBM Core alpha (0): 7 registers set
[10:40:45.176]     INFO: 	TBM Core beta  (1): 7 registers set
[10:40:45.176]     INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:40:45.176]     INFO: 	ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.177]     INFO: 	ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:40:45.580]     INFO: enter 'restricted' command line mode
[10:40:45.580]     INFO: enter test to run
[10:40:51.353]     INFO:   test: PixelAlive no parameter change
[10:40:51.353]     INFO:   running: pixelalive
[10:40:51.362]     INFO:    ----------------------------------------------------------------------
[10:40:51.362]     INFO:    PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:40:51.362]     INFO:    ----------------------------------------------------------------------
[10:40:51.674]     INFO: Expecting 41600 events.
[10:40:55.997]     INFO: 41600 events read in total (3604ms).
[10:40:56.166]     INFO: Test took 4802ms.
[10:40:56.177]     INFO: Fetched DAQ statistics. Counters are being reset now.
[10:40:56.440]     INFO: PixTestAlive::aliveTest() done
[10:40:56.440]     INFO: number of dead pixels (per ROC):     0    0    0    0    1    0    0    0    0    0    0    0    0    0    0    0
[10:40:56.470]     INFO: enter test to run
[10:43:30.304]     INFO:   test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[10:43:30.304]     INFO:   running: highrate
[10:43:30.304]     INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/phCalibrationFitErr35_C15.dat
[10:43:30.578]     INFO:    ----------------------------------------------------------------------
[10:43:30.578]     INFO:    PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[10:43:30.578]     INFO:    ----------------------------------------------------------------------
[10:43:30.578]     INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[10:43:30.578]     INFO: edge/corner pixel THR is adjusted
[10:43:30.578]     INFO: PixTestHighRate::trimHotPixels: step 0...
[10:43:31.537]     INFO: Collecting data for 5 seconds...
[10:43:36.555]     INFO: Done with hot pixel readout
[10:43:47.350]     INFO: PixTest::       pg_setup set to default.
[10:43:47.351]     INFO: 21 hot pixels found in step 0
[10:43:48.338]     INFO: Collecting data for 5 seconds...
[10:43:53.354]     INFO: Done with hot pixel readout
[10:44:04.384]     INFO: PixTest::       pg_setup set to default.
[10:44:04.385]     INFO: 23 hot pixels found in step 1
[10:44:05.376]     INFO: Collecting data for 5 seconds...
[10:44:10.394]     INFO: Done with hot pixel readout
[10:44:21.341]     INFO: PixTest::       pg_setup set to default.
[10:44:21.341]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:44:21.342]     INFO: 20 hot pixels found in step 2
[10:44:22.333]     INFO: Collecting data for 5 seconds...
[10:44:27.347]     INFO: Done with hot pixel readout
[10:44:38.303]     INFO: PixTest::       pg_setup set to default.
[10:44:38.304]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:44:38.304]     INFO: 21 hot pixels found in step 3
[10:44:39.295]     INFO: Collecting data for 5 seconds...
[10:44:44.311]     INFO: Done with hot pixel readout
[10:44:55.296]     INFO: PixTest::       pg_setup set to default.
[10:44:55.296]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:44:55.296]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:44:55.297]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:44:55.297]     INFO: 23 hot pixels found in step 4
[10:44:56.288]     INFO: Collecting data for 5 seconds...
[10:45:01.301]     INFO: Done with hot pixel readout
[10:45:11.826]     INFO: PixTest::       pg_setup set to default.
[10:45:11.826]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:11.826]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:11.826]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:11.826]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:11.826]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:11.826]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:11.826]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:11.827]     INFO: 22 hot pixels found in step 5
[10:45:12.818]     INFO: Collecting data for 5 seconds...
[10:45:17.835]     INFO: Done with hot pixel readout
[10:45:28.734]     INFO: PixTest::       pg_setup set to default.
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.734]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:28.735]     INFO: 21 hot pixels found in step 6
[10:45:29.727]     INFO: Collecting data for 5 seconds...
[10:45:34.744]     INFO: Done with hot pixel readout
[10:45:45.807]     INFO: PixTest::       pg_setup set to default.
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.807]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:45:45.808]     INFO: 20 hot pixels found in step 7
[10:45:46.799]     INFO: Collecting data for 5 seconds...
[10:45:51.818]     INFO: Done with hot pixel readout
[10:46:02.624]     INFO: PixTest::       pg_setup set to default.
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.624]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:02.625]     INFO: 18 hot pixels found in step 8
[10:46:03.616]     INFO: Collecting data for 5 seconds...
[10:46:08.638]     INFO: Done with hot pixel readout
[10:46:20.349]     INFO: PixTest::       pg_setup set to default.
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.349]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:20.350]     INFO: 20 hot pixels found in step 9
[10:46:21.341]     INFO: Collecting data for 5 seconds...
[10:46:26.358]     INFO: Done with hot pixel readout
[10:46:37.998]     INFO: PixTest::       pg_setup set to default.
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.998]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:37.999]     INFO: 18 hot pixels found in step 10
[10:46:38.991]     INFO: Collecting data for 5 seconds...
[10:46:44.010]     INFO: Done with hot pixel readout
[10:46:55.217]     INFO: PixTest::       pg_setup set to default.
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.217]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:46:55.218]     INFO: 18 hot pixels found in step 11
[10:46:56.210]     INFO: Collecting data for 5 seconds...
[10:47:01.230]     INFO: Done with hot pixel readout
[10:47:12.415]     INFO: PixTest::       pg_setup set to default.
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.415]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.416]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.416]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.416]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.416]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.416]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.416]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[10:47:12.416]     INFO: 17 hot pixels found in step 12
[10:47:12.452]     INFO: 17 hot pixels could not be trimmed and have been masked.
[10:47:12.456]     INFO: PixTest::trimHotPixels() done
[10:47:12.475]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C0.dat
[10:47:12.481]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C1.dat
[10:47:12.487]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C2.dat
[10:47:12.492]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C3.dat
[10:47:12.498]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C4.dat
[10:47:12.503]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C5.dat
[10:47:12.509]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C6.dat
[10:47:12.514]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C7.dat
[10:47:12.519]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C8.dat
[10:47:12.525]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C9.dat
[10:47:12.530]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C10.dat
[10:47:12.536]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C11.dat
[10:47:12.541]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C12.dat
[10:47:12.546]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C13.dat
[10:47:12.552]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C14.dat
[10:47:12.557]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C15.dat
[10:47:12.562]     INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/defaultMaskFile.dat
[10:47:12.572]     INFO: enter test to run
[10:47:39.278]     INFO:   test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[10:47:39.278]     INFO:   running: highrate
[10:47:39.283]     INFO:    ----------------------------------------------------------------------
[10:47:39.283]     INFO:    PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[10:47:39.283]     INFO:    ----------------------------------------------------------------------
[10:47:39.283]     INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[10:47:39.283]     INFO: edge/corner pixel THR is adjusted
[10:47:39.283]     INFO: PixTestHighRate::trimHotPixels: step 0...
[10:47:40.240]     INFO: Collecting data for 1 seconds...
[10:47:41.243]     INFO: Done with hot pixel readout
[10:47:45.185]     INFO: PixTest::       pg_setup set to default.
[10:47:45.186]     INFO: 0 hot pixels found in step 0
[10:47:45.191]     INFO: 0 hot pixels could not be trimmed and have been masked.
[10:47:45.274]     INFO: PixTest::trimHotPixels() done
[10:47:45.274]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C0.dat
[10:47:45.281]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C1.dat
[10:47:45.287]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C2.dat
[10:47:45.292]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C3.dat
[10:47:45.298]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C4.dat
[10:47:45.304]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C5.dat
[10:47:45.310]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C6.dat
[10:47:45.315]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C7.dat
[10:47:45.320]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C8.dat
[10:47:45.326]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C9.dat
[10:47:45.331]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C10.dat
[10:47:45.337]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C11.dat
[10:47:45.343]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C12.dat
[10:47:45.348]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C13.dat
[10:47:45.354]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C14.dat
[10:47:45.359]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/trimParameters35_C15.dat
[10:47:45.366]     INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Q-9-30_FPIXTest-17C-FNAL-160817-1209-300V_2016-08-17_12h09m_1471453783/000_FPIXTest_p17/defaultMaskFile.dat
[10:47:45.375]     INFO: enter test to run
[10:48:07.974]     INFO:   test: Xray setting parameters: ->source=DCLowRate<-
[10:48:07.974]     INFO:   running: xray
[10:48:07.975]     INFO:    ----------------------------------------------------------------------
[10:48:07.975]     INFO:    PixTestXray::doPhRun() fParRunSeconds = 100
[10:48:07.975]     INFO:    ----------------------------------------------------------------------
[10:48:08.938]     INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds,  fEventsMax = 10000000
[10:48:20.749]     INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[10:48:49.617]     INFO: Resuming triggers.
[10:49:01.429]     INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[10:49:29.793]     INFO: Resuming triggers.
[10:49:41.606]     INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[10:50:10.376]     INFO: Resuming triggers.
[10:50:22.190]     INFO: run duration 47 seconds, buffer almost full (81%), pausing triggers.
[10:50:50.825]     INFO: Resuming triggers.
[10:51:02.637]     INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[10:51:31.346]     INFO: Resuming triggers.
[10:51:43.159]     INFO: run duration 70 seconds, buffer almost full (81%), pausing triggers.
[10:52:12.254]     INFO: Resuming triggers.
[10:52:24.070]     INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[10:52:52.339]     INFO: Resuming triggers.
[10:53:04.153]     INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[10:53:33.020]     INFO: Resuming triggers.
[10:53:38.830]     INFO: data taking finished, elapsed time: 100 seconds.
[10:53:53.488]     INFO: PixTest::       pg_setup set to default.
[10:53:53.491]     INFO: PixTestXray::doPhRun() done
[10:53:53.660]     INFO: enter test to run
[10:54:25.547]     INFO:   test: Xray setting parameters: ->source=DCHighRate<-
[10:54:25.547]     INFO:   running: xray
[10:54:25.548]     INFO:    ----------------------------------------------------------------------
[10:54:25.548]     INFO:    PixTestXray::doPhRun() fParRunSeconds = 100
[10:54:25.548]     INFO:    ----------------------------------------------------------------------
[10:54:26.517]     INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds,  fEventsMax = 10000000
[10:54:33.218]     INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[10:55:02.936]     INFO: Resuming triggers.
[10:55:09.637]     INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[10:55:39.675]     INFO: Resuming triggers.
[10:55:46.379]     INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[10:56:16.658]     INFO: Resuming triggers.
[10:56:23.365]     INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[10:56:54.091]     INFO: Resuming triggers.
[10:57:00.792]     INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[10:57:30.808]     INFO: Resuming triggers.
[10:57:37.514]     INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[10:58:07.740]     INFO: Resuming triggers.
[10:58:14.444]     INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[10:58:45.456]     INFO: Resuming triggers.
[10:58:52.160]     INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[10:59:22.643]     INFO: Resuming triggers.
[10:59:29.346]     INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[10:59:59.753]     INFO: Resuming triggers.
[11:00:06.457]     INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[11:00:36.011]     INFO: Resuming triggers.
[11:00:42.721]     INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[11:01:12.708]     INFO: Resuming triggers.
[11:01:19.413]     INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[11:01:48.714]     INFO: Resuming triggers.
[11:01:55.419]     INFO: run duration 86 seconds, buffer almost full (81%), pausing triggers.
[11:02:25.281]     INFO: Resuming triggers.
[11:02:31.988]     INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[11:03:01.435]     INFO: Resuming triggers.
[11:03:07.915]     INFO: data taking finished, elapsed time: 100 seconds.
[11:03:37.075]     INFO: PixTest::       pg_setup set to default.
[11:03:37.078]     INFO: PixTestXray::doPhRun() done
[11:03:37.227]     INFO: enter test to run
[11:05:18.623]     INFO:   test: HighRate no parameter change
[11:05:18.623]     INFO:   running: highrate
[11:05:18.636]     INFO:    ----------------------------------------------------------------------
[11:05:18.636]     INFO:    PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[11:05:18.636]     INFO:    ----------------------------------------------------------------------
[11:05:18.792]     INFO: Expecting 768 events.
[11:05:19.932]     INFO: 768 events read in total (418ms).
[11:05:19.932]     INFO: Test took 1275ms.
[11:05:20.736]     INFO: Expecting 41600 events.
[11:05:23.842]     INFO: 41600 events read in total (2579ms).
[11:05:23.843]     INFO: Test took 3892ms.
[11:05:23.878]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:24.603]     INFO: Expecting 41600 events.
[11:05:27.807]     INFO: 41600 events read in total (2677ms).
[11:05:27.808]     INFO: Test took 3912ms.
[11:05:27.844]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:28.567]     INFO: Expecting 41600 events.
[11:05:31.800]     INFO: 41600 events read in total (2706ms).
[11:05:31.801]     INFO: Test took 3939ms.
[11:05:31.835]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:32.556]     INFO: Expecting 41600 events.
[11:05:35.762]     INFO: 41600 events read in total (2679ms).
[11:05:35.763]     INFO: Test took 3909ms.
[11:05:35.799]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:36.522]     INFO: Expecting 41600 events.
[11:05:39.768]     INFO: 41600 events read in total (2719ms).
[11:05:39.769]     INFO: Test took 3952ms.
[11:05:39.804]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:40.524]     INFO: Expecting 41600 events.
[11:05:43.764]     INFO: 41600 events read in total (2713ms).
[11:05:43.765]     INFO: Test took 3944ms.
[11:05:43.801]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:44.520]     INFO: Expecting 41600 events.
[11:05:47.760]     INFO: 41600 events read in total (2713ms).
[11:05:47.761]     INFO: Test took 3941ms.
[11:05:47.797]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:48.516]     INFO: Expecting 41600 events.
[11:05:51.780]     INFO: 41600 events read in total (2737ms).
[11:05:51.782]     INFO: Test took 3967ms.
[11:05:51.825]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:52.536]     INFO: Expecting 41600 events.
[11:05:55.780]     INFO: 41600 events read in total (2717ms).
[11:05:55.781]     INFO: Test took 3937ms.
[11:05:55.816]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:05:56.538]     INFO: Expecting 41600 events.
[11:05:59.788]     INFO: 41600 events read in total (2723ms).
[11:05:59.789]     INFO: Test took 3954ms.
[11:05:59.825]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:00.548]     INFO: Expecting 41600 events.
[11:06:03.792]     INFO: 41600 events read in total (2717ms).
[11:06:03.793]     INFO: Test took 3949ms.
[11:06:03.829]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:04.548]     INFO: Expecting 41600 events.
[11:06:07.812]     INFO: 41600 events read in total (2737ms).
[11:06:07.813]     INFO: Test took 3966ms.
[11:06:07.848]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:08.566]     INFO: Expecting 41600 events.
[11:06:11.819]     INFO: 41600 events read in total (2726ms).
[11:06:11.820]     INFO: Test took 3952ms.
[11:06:11.855]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:12.575]     INFO: Expecting 41600 events.
[11:06:15.816]     INFO: 41600 events read in total (2714ms).
[11:06:15.817]     INFO: Test took 3943ms.
[11:06:15.853]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:16.573]     INFO: Expecting 41600 events.
[11:06:19.816]     INFO: 41600 events read in total (2716ms).
[11:06:19.817]     INFO: Test took 3945ms.
[11:06:19.851]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:20.576]     INFO: Expecting 41600 events.
[11:06:23.832]     INFO: 41600 events read in total (2729ms).
[11:06:23.833]     INFO: Test took 3963ms.
[11:06:23.868]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:24.589]     INFO: Expecting 41600 events.
[11:06:27.843]     INFO: 41600 events read in total (2727ms).
[11:06:27.844]     INFO: Test took 3958ms.
[11:06:27.879]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:28.602]     INFO: Expecting 41600 events.
[11:06:31.839]     INFO: 41600 events read in total (2710ms).
[11:06:31.840]     INFO: Test took 3942ms.
[11:06:31.875]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:32.597]     INFO: Expecting 41600 events.
[11:06:35.856]     INFO: 41600 events read in total (2732ms).
[11:06:35.857]     INFO: Test took 3964ms.
[11:06:35.892]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:36.612]     INFO: Expecting 41600 events.
[11:06:39.730]     INFO: 41600 events read in total (2591ms).
[11:06:39.731]     INFO: Test took 3821ms.
[11:06:39.766]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:06:40.128]     INFO: enter test to run
[11:07:14.550]     INFO:   test: HighRate no parameter change
[11:07:14.550]     INFO:   running: highrate
[11:07:14.551]     INFO:    ----------------------------------------------------------------------
[11:07:14.551]     INFO:    PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:07:14.551]     INFO:    ----------------------------------------------------------------------
[11:07:15.165]     INFO: Expecting 208000 events.
[11:07:27.038]     INFO: 208000 events read in total (11346ms).
[11:07:27.041]     INFO: Test took 12480ms.
[11:07:27.193]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:07:27.448]     INFO: number of dead pixels (per ROC):     0    0    0    0    1    0    0    0    0    0    0    0    0    0    0    0
[11:07:27.448]     INFO: number of red-efficiency pixels:    81   40   89  138  141  175  144   93   74  107  139  132   95   66   21   31
[11:07:27.448]     INFO: number of X-ray hits detected:    70827 44343 71553 111451 122601 121293 121493 83662 71940 100463 101229 88633 93248 53669 22518 28600
[11:07:27.448]     INFO: number of triggers sent (total per ROC):  208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:07:27.448]     INFO: number of Vcal hits detected:  207916 207959 207907 207857 207807 207819 207852 207903 207926 207892 207857 207864 207901 207933 207979 207969
[11:07:27.449]     INFO: Vcal hit fiducial efficiency (%):  100.0 100.0 100.0 99.9 99.9 99.9 99.9 100.0 100.0 99.9 99.9 99.9 100.0 100.0 100.0 100.0
[11:07:27.449]     INFO: Vcal hit overall efficiency (%):  100.0 100.0 100.0 99.9 99.9 99.9 99.9 100.0 100.0 99.9 99.9 99.9 100.0 100.0 100.0 100.0
[11:07:27.449]     INFO: X-ray hit rate [MHz/cm2]:  20.8 13.0 21.0 32.7 35.9 35.6 35.6 24.5 21.1 29.4 29.7 26.0 27.3 15.7 6.6 8.4
[11:07:27.449]     INFO: PixTestHighRate::doXPixelAlive() done
[11:07:27.500]     INFO: PixTest::       pg_setup set to default.
[11:07:27.517]     INFO: enter test to run
[11:07:44.990]     INFO:   test: HighRate no parameter change
[11:07:44.990]     INFO:   running: highrate
[11:07:44.991]     INFO:    ----------------------------------------------------------------------
[11:07:44.991]     INFO:    PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:07:44.991]     INFO:    ----------------------------------------------------------------------
[11:07:45.608]     INFO: Expecting 208000 events.
[11:07:59.235]     INFO: 208000 events read in total (13100ms).
[11:07:59.241]     INFO: Test took 14240ms.
[11:07:59.556]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:07:59.859]     INFO: number of dead pixels (per ROC):     0    0    0    0    1    0    0    0    0    0    0    0    0    0    0    0
[11:07:59.859]     INFO: number of red-efficiency pixels:   239  146  235  509  503  535  465  345  232  390  437  343  384  187   57   55
[11:07:59.859]     INFO: number of X-ray hits detected:    143583 89352 145934 227270 247811 246382 246541 171321 147674 205139 203923 180532 191725 109944 46128 58445
[11:07:59.859]     INFO: number of triggers sent (total per ROC):  208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:07:59.859]     INFO: number of Vcal hits detected:  207736 207845 207750 207444 207397 207404 207473 207629 207752 207585 207534 207636 207586 207802 207941 207943
[11:07:59.859]     INFO: Vcal hit fiducial efficiency (%):  99.9 99.9 99.9 99.8 99.8 99.7 99.8 99.8 99.9 99.8 99.8 99.8 99.8 99.9 100.0 100.0
[11:07:59.859]     INFO: Vcal hit overall efficiency (%):  99.9 99.9 99.9 99.7 99.7 99.7 99.7 99.8 99.9 99.8 99.8 99.8 99.8 99.9 100.0 100.0
[11:07:59.859]     INFO: X-ray hit rate [MHz/cm2]:  42.1 26.2 42.8 66.6 72.6 72.2 72.3 50.2 43.3 60.1 59.8 52.9 56.2 32.2 13.5 17.1
[11:07:59.860]     INFO: PixTestHighRate::doXPixelAlive() done
[11:07:59.908]     INFO: PixTest::       pg_setup set to default.
[11:07:59.922]     INFO: enter test to run
[11:08:16.358]     INFO:   test: HighRate no parameter change
[11:08:16.358]     INFO:   running: highrate
[11:08:16.359]     INFO:    ----------------------------------------------------------------------
[11:08:16.359]     INFO:    PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[11:08:16.359]     INFO:    ----------------------------------------------------------------------
[11:08:16.979]     INFO: Expecting 208000 events.
[11:08:32.923]     INFO: 208000 events read in total (15417ms).
[11:08:32.931]     INFO: Test took 16563ms.
[11:08:33.406]     INFO: Fetched DAQ statistics. Counters are being reset now.
[11:08:33.762]     INFO: number of dead pixels (per ROC):     0    0    0    0    1    0    0    0    0    0    0    0    0    0    0    0
[11:08:33.763]     INFO: number of red-efficiency pixels:   442  300  560 1152 1107 1218 1112  796  516  842 1036  819  798  445   91   94
[11:08:33.763]     INFO: number of X-ray hits detected:    214935 134148 217226 338819 368985 367262 366395 255798 221984 306947 305423 270071 285472 163966 68727 87147
[11:08:33.763]     INFO: number of triggers sent (total per ROC):  208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[11:08:33.763]     INFO: number of Vcal hits detected:  207440 207651 207292 206540 206539 206443 206554 206976 207399 206992 206728 207023 207054 207474 207907 207905
[11:08:33.763]     INFO: Vcal hit fiducial efficiency (%):  99.8 99.9 99.7 99.4 99.4 99.3 99.4 99.6 99.7 99.6 99.4 99.6 99.6 99.8 100.0 100.0
[11:08:33.763]     INFO: Vcal hit overall efficiency (%):  99.7 99.8 99.7 99.3 99.3 99.3 99.3 99.5 99.7 99.5 99.4 99.5 99.5 99.7 100.0 100.0
[11:08:33.763]     INFO: X-ray hit rate [MHz/cm2]:  63.0 39.3 63.7 99.3 108.2 107.6 107.4 75.0 65.1 90.0 89.5 79.2 83.7 48.1 20.1 25.5
[11:08:33.763]     INFO: PixTestHighRate::doXPixelAlive() done
[11:08:33.810]     INFO: PixTest::       pg_setup set to default.
[11:08:33.824]     INFO: enter test to run
[11:08:38.877]     INFO:   test: exit no parameter change
[11:08:39.376]    QUIET: Connection to board 33 closed.
[11:08:39.390]     INFO: pXar: this is the end, my friend