[14:09:34.987]     INFO: *** Welcome to pxar ***
[14:09:34.987]     INFO: *** Today: 2016/07/20
[14:09:35.966]     INFO: *** Version: v1.9.0-814-g7497
[14:09:35.966]     INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//dacParameters35_C15.dat
[14:09:36.039]     INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//tbmParameters_C0b.dat
[14:09:36.039]     INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//defaultMaskFile.dat
[14:09:36.047]     INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C15.dat
[14:09:36.174]     INFO:         clk: 4
[14:09:36.174]     INFO:         ctr: 4
[14:09:36.174]     INFO:         sda: 19
[14:09:36.174]     INFO:         tin: 9
[14:09:36.174]     INFO:         level: 15
[14:09:36.174]     INFO:         triggerdelay: 0
[14:09:36.174]    QUIET: Instanciating API for pxar v1.9.0+814~g74979a6
[14:09:36.174]     INFO: Log level: INFO
[14:09:36.189]    QUIET: Connection to board DTB_WREKRL opened.
[14:09:36.193]     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:     
------------------------------------------------------
[14:09:36.195]     INFO: RPC call hashes of host and DTB match: 398089610
[14:09:37.736]     INFO: DUT info: 
[14:09:37.736]     INFO: The DUT currently contains the following objects:
[14:09:37.736]     INFO:  2 TBM Cores tbm08c (2 ON)
[14:09:37.736]     INFO: 	TBM Core alpha (0): 7 registers set
[14:09:37.736]     INFO: 	TBM Core beta  (1): 7 registers set
[14:09:37.736]     INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:09:37.736]     INFO: 	ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.736]     INFO: 	ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.737]     INFO: 	ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:37.738]     INFO: 	ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:09:38.169]     INFO: enter 'restricted' command line mode
[14:09:38.169]     INFO: enter test to run
[14:09:49.053]     INFO:   test:  setting parameters: ->	PixelAlive:alivetest<-
[14:09:49.053]     INFO:   running: 
[14:09:49.053]     INFO: command -><- not known, ignored
[14:09:49.053]     INFO: enter test to run
[14:09:52.821]     INFO:   test: PixelAlive no parameter change
[14:09:52.821]     INFO:   running: pixelalive
[14:09:52.889]     INFO:    ----------------------------------------------------------------------
[14:09:52.889]     INFO:    PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:09:52.889]     INFO:    ----------------------------------------------------------------------
[14:09:53.224]     INFO: Expecting 41600 events.
[14:09:57.570]     INFO: 41600 events read in total (3628ms).
[14:09:57.741]     INFO: Test took 4850ms.
[14:09:57.758]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:09:58.315]     INFO: PixTestAlive::aliveTest() done
[14:09:58.315]     INFO: number of dead pixels (per ROC):     0    0    0    1    0    0    0    0    0    0    0    4    0    0    0    0
[14:09:58.470]     INFO: enter test to run
[14:10:21.156]     INFO:   test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[14:10:21.156]     INFO:   running: highrate
[14:10:21.167]     INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[14:10:21.460]     INFO:    ----------------------------------------------------------------------
[14:10:21.460]     INFO:    PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[14:10:21.460]     INFO:    ----------------------------------------------------------------------
[14:10:21.460]     INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[14:10:21.460]     INFO: edge/corner pixel THR is adjusted
[14:10:21.460]     INFO: PixTestHighRate::trimHotPixels: step 0...
[14:10:22.418]     INFO: Collecting data for 5 seconds...
[14:10:27.436]     INFO: Done with hot pixel readout
[14:10:40.014]     INFO: PixTest::       pg_setup set to default.
[14:10:40.014]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:10:40.015]     INFO: 93 hot pixels found in step 0
[14:10:41.010]     INFO: Collecting data for 5 seconds...
[14:10:46.031]     INFO: Done with hot pixel readout
[14:10:58.320]     INFO: PixTest::       pg_setup set to default.
[14:10:58.320]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:10:58.320]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:10:58.320]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:10:58.320]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:10:58.320]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:10:58.321]     INFO: 84 hot pixels found in step 1
[14:10:59.323]     INFO: Collecting data for 5 seconds...
[14:11:04.341]     INFO: Done with hot pixel readout
[14:11:16.773]     INFO: PixTest::       pg_setup set to default.
[14:11:16.774]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:16.774]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:16.774]     INFO: 82 hot pixels found in step 2
[14:11:17.774]     INFO: Collecting data for 5 seconds...
[14:11:22.795]     INFO: Done with hot pixel readout
[14:11:35.553]     INFO: PixTest::       pg_setup set to default.
[14:11:35.554]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:35.554]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:35.554]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:35.554]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:35.555]     INFO: 80 hot pixels found in step 3
[14:11:36.554]     INFO: Collecting data for 5 seconds...
[14:11:41.573]     INFO: Done with hot pixel readout
[14:11:54.622]     INFO: PixTest::       pg_setup set to default.
[14:11:54.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:54.623]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:54.623]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:11:54.623]     INFO: 75 hot pixels found in step 4
[14:11:55.624]     INFO: Collecting data for 5 seconds...
[14:12:00.643]     INFO: Done with hot pixel readout
[14:12:13.463]     INFO: PixTest::       pg_setup set to default.
[14:12:13.463]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:13.463]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:13.463]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:13.463]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:13.463]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:13.464]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:13.464]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:13.464]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:13.464]     INFO: 68 hot pixels found in step 5
[14:12:14.464]     INFO: Collecting data for 5 seconds...
[14:12:19.484]     INFO: Done with hot pixel readout
[14:12:32.216]     INFO: PixTest::       pg_setup set to default.
[14:12:32.216]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:32.216]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:32.216]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:32.216]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:32.216]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:32.216]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:32.216]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:32.216]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:32.217]     INFO: 80 hot pixels found in step 6
[14:12:33.216]     INFO: Collecting data for 5 seconds...
[14:12:38.235]     INFO: Done with hot pixel readout
[14:12:51.200]     INFO: PixTest::       pg_setup set to default.
[14:12:51.200]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:51.200]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:51.201]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:51.201]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:12:51.201]     INFO: 55 hot pixels found in step 7
[14:12:52.202]     INFO: Collecting data for 5 seconds...
[14:12:57.222]     INFO: Done with hot pixel readout
[14:13:09.883]     INFO: PixTest::       pg_setup set to default.
[14:13:09.883]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:09.883]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:09.884]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:09.884]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:09.884]     INFO: 74 hot pixels found in step 8
[14:13:10.883]     INFO: Collecting data for 5 seconds...
[14:13:15.903]     INFO: Done with hot pixel readout
[14:13:28.682]     INFO: PixTest::       pg_setup set to default.
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.682]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:28.683]     INFO: 65 hot pixels found in step 9
[14:13:29.683]     INFO: Collecting data for 5 seconds...
[14:13:34.699]     INFO: Done with hot pixel readout
[14:13:47.403]     INFO: PixTest::       pg_setup set to default.
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.403]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:13:47.404]     INFO: 69 hot pixels found in step 10
[14:13:48.404]     INFO: Collecting data for 5 seconds...
[14:13:53.420]     INFO: Done with hot pixel readout
[14:14:06.122]     INFO: PixTest::       pg_setup set to default.
[14:14:06.122]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.122]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.122]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.122]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.122]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.122]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.122]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.122]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.123]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.123]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.123]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.123]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:06.123]     INFO: 58 hot pixels found in step 11
[14:14:07.121]     INFO: Collecting data for 5 seconds...
[14:14:12.138]     INFO: Done with hot pixel readout
[14:14:24.923]     INFO: PixTest::       pg_setup set to default.
[14:14:24.923]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:24.923]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:24.923]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:24.923]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:24.923]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:24.923]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:24.923]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:24.923]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:24.924]     INFO: 45 hot pixels found in step 12
[14:14:25.924]     INFO: Collecting data for 5 seconds...
[14:14:30.940]     INFO: Done with hot pixel readout
[14:14:43.621]     INFO: PixTest::       pg_setup set to default.
[14:14:43.621]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.621]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:14:43.622]     INFO: 43 hot pixels found in step 13
[14:14:44.621]     INFO: Collecting data for 5 seconds...
[14:14:49.638]     INFO: Done with hot pixel readout
[14:15:02.294]     INFO: PixTest::       pg_setup set to default.
[14:15:02.294]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.294]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.294]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.294]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.295]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.295]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.295]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.295]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.295]  WARNING:   => trimBits already at highest possible threshold, 'real' hot pixel found
[14:15:02.295]     INFO: 47 hot pixels found in step 14
[14:15:02.338]     INFO: 47 hot pixels could not be trimmed and have been masked.
[14:15:02.355]     INFO: PixTest::trimHotPixels() done
[14:15:02.355]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C0.dat
[14:15:02.387]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C1.dat
[14:15:02.392]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C2.dat
[14:15:02.398]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C3.dat
[14:15:02.404]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C4.dat
[14:15:02.409]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C5.dat
[14:15:02.415]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C6.dat
[14:15:02.420]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C7.dat
[14:15:02.426]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C8.dat
[14:15:02.432]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C9.dat
[14:15:02.437]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C10.dat
[14:15:02.443]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C11.dat
[14:15:02.448]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C12.dat
[14:15:02.454]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C13.dat
[14:15:02.460]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C14.dat
[14:15:02.465]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C15.dat
[14:15:02.471]     INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//defaultMaskFile.dat
[14:15:02.482]     INFO: enter test to run
[14:21:34.440]     INFO:   test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[14:21:34.440]     INFO:   running: highrate
[14:21:34.444]     INFO:    ----------------------------------------------------------------------
[14:21:34.444]     INFO:    PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[14:21:34.444]     INFO:    ----------------------------------------------------------------------
[14:21:34.444]     INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[14:21:34.444]     INFO: edge/corner pixel THR is adjusted
[14:21:34.444]     INFO: PixTestHighRate::trimHotPixels: step 0...
[14:21:35.401]     INFO: Collecting data for 1 seconds...
[14:21:36.405]     INFO: Done with hot pixel readout
[14:21:40.921]     INFO: PixTest::       pg_setup set to default.
[14:21:40.922]     INFO: 0 hot pixels found in step 0
[14:21:40.927]     INFO: 0 hot pixels could not be trimmed and have been masked.
[14:21:40.973]     INFO: PixTest::trimHotPixels() done
[14:21:40.973]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C0.dat
[14:21:40.982]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C1.dat
[14:21:40.988]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C2.dat
[14:21:40.994]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C3.dat
[14:21:40.999]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C4.dat
[14:21:41.005]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C5.dat
[14:21:41.011]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C6.dat
[14:21:41.016]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C7.dat
[14:21:41.022]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C8.dat
[14:21:41.027]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C9.dat
[14:21:41.033]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C10.dat
[14:21:41.039]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C11.dat
[14:21:41.044]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C12.dat
[14:21:41.050]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C13.dat
[14:21:41.055]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C14.dat
[14:21:41.061]     INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//trimParameters35_C15.dat
[14:21:41.067]     INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Y-H-NX_FPIXTest-17C-FNAL-160602-1447_2016-06-02_14h47m_1464896848/000_FPIXTest_p17//defaultMaskFile.dat
[14:21:41.076]     INFO: enter test to run
[14:23:08.895]     INFO:   test: Xray setting parameters: ->source=DCLowRate<-
[14:23:08.895]     INFO:   running: xray
[14:23:08.897]     INFO:    ----------------------------------------------------------------------
[14:23:08.897]     INFO:    PixTestXray::doPhRun() fParRunSeconds = 100
[14:23:08.897]     INFO:    ----------------------------------------------------------------------
[14:23:09.882]     INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds,  fEventsMax = 10000000
[14:23:20.312]     INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[14:23:48.854]     INFO: Resuming triggers.
[14:23:59.286]     INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[14:24:29.783]     INFO: Resuming triggers.
[14:24:40.216]     INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[14:25:10.603]     INFO: Resuming triggers.
[14:25:21.037]     INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[14:25:50.487]     INFO: Resuming triggers.
[14:26:00.918]     INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[14:26:30.517]     INFO: Resuming triggers.
[14:26:40.949]     INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[14:27:10.277]     INFO: Resuming triggers.
[14:27:20.708]     INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[14:27:50.231]     INFO: Resuming triggers.
[14:28:00.662]     INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[14:28:30.167]     INFO: Resuming triggers.
[14:28:40.599]     INFO: run duration 93 seconds, buffer almost full (81%), pausing triggers.
[14:29:10.170]     INFO: Resuming triggers.
[14:29:16.624]     INFO: data taking finished, elapsed time: 100 seconds.
[14:29:35.185]     INFO: PixTest::       pg_setup set to default.
[14:29:35.188]     INFO: PixTestXray::doPhRun() done
[14:29:35.327]     INFO: enter test to run
[14:30:30.108]     INFO:   test: Xray setting parameters: ->source=DCHighRate<-
[14:30:30.108]     INFO:   running: xray
[14:30:30.109]     INFO:    ----------------------------------------------------------------------
[14:30:30.109]     INFO:    PixTestXray::doPhRun() fParRunSeconds = 100
[14:30:30.109]     INFO:    ----------------------------------------------------------------------
[14:30:31.074]     INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds,  fEventsMax = 10000000
[14:30:36.823]     INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[14:31:06.801]     INFO: Resuming triggers.
[14:31:12.550]     INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[14:31:42.668]     INFO: Resuming triggers.
[14:31:48.416]     INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[14:32:18.472]     INFO: Resuming triggers.
[14:32:24.219]     INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[14:32:54.239]     INFO: Resuming triggers.
[14:32:59.984]     INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[14:33:30.594]     INFO: Resuming triggers.
[14:33:36.344]     INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[14:34:07.494]     INFO: Resuming triggers.
[14:34:13.243]     INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[14:34:44.267]     INFO: Resuming triggers.
[14:34:50.015]     INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[14:35:20.574]     INFO: Resuming triggers.
[14:35:26.322]     INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[14:35:57.469]     INFO: Resuming triggers.
[14:36:03.219]     INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[14:36:34.911]     INFO: Resuming triggers.
[14:36:40.660]     INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[14:37:11.278]     INFO: Resuming triggers.
[14:37:17.025]     INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[14:37:47.059]     INFO: Resuming triggers.
[14:37:52.806]     INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[14:38:22.852]     INFO: Resuming triggers.
[14:38:28.601]     INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[14:38:58.691]     INFO: Resuming triggers.
[14:39:04.437]     INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[14:39:34.523]     INFO: Resuming triggers.
[14:39:40.272]     INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[14:40:10.327]     INFO: Resuming triggers.
[14:40:16.073]     INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[14:40:46.202]     INFO: Resuming triggers.
[14:40:48.824]     INFO: data taking finished, elapsed time: 100 seconds.
[14:41:02.765]     INFO: PixTest::       pg_setup set to default.
[14:41:02.768]     INFO: PixTestXray::doPhRun() done
[14:41:02.916]     INFO: enter test to run
[14:43:07.199]     INFO:   test: HighRate no parameter change
[14:43:07.199]     INFO:   running: highrate
[14:43:07.200]     INFO:    ----------------------------------------------------------------------
[14:43:07.200]     INFO:    PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[14:43:07.200]     INFO:    ----------------------------------------------------------------------
[14:43:07.342]     INFO: Expecting 768 events.
[14:43:08.476]     INFO: 768 events read in total (419ms).
[14:43:08.476]     INFO: Test took 1268ms.
[14:43:09.279]     INFO: Expecting 41600 events.
[14:43:12.368]     INFO: 41600 events read in total (2562ms).
[14:43:12.369]     INFO: Test took 3886ms.
[14:43:12.412]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:13.122]     INFO: Expecting 41600 events.
[14:43:16.387]     INFO: 41600 events read in total (2738ms).
[14:43:16.388]     INFO: Test took 3954ms.
[14:43:16.430]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:17.143]     INFO: Expecting 41600 events.
[14:43:20.443]     INFO: 41600 events read in total (2773ms).
[14:43:20.444]     INFO: Test took 3994ms.
[14:43:20.486]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:21.195]     INFO: Expecting 41600 events.
[14:43:24.450]     INFO: 41600 events read in total (2728ms).
[14:43:24.451]     INFO: Test took 3945ms.
[14:43:24.492]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:25.204]     INFO: Expecting 41600 events.
[14:43:28.491]     INFO: 41600 events read in total (2760ms).
[14:43:28.493]     INFO: Test took 3981ms.
[14:43:28.539]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:29.235]     INFO: Expecting 41600 events.
[14:43:32.456]     INFO: 41600 events read in total (2694ms).
[14:43:32.456]     INFO: Test took 3895ms.
[14:43:32.499]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:33.206]     INFO: Expecting 41600 events.
[14:43:36.522]     INFO: 41600 events read in total (2789ms).
[14:43:36.523]     INFO: Test took 4002ms.
[14:43:36.565]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:37.276]     INFO: Expecting 41600 events.
[14:43:40.589]     INFO: 41600 events read in total (2786ms).
[14:43:40.591]     INFO: Test took 4007ms.
[14:43:40.632]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:41.341]     INFO: Expecting 41600 events.
[14:43:44.649]     INFO: 41600 events read in total (2781ms).
[14:43:44.650]     INFO: Test took 3998ms.
[14:43:44.691]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:45.403]     INFO: Expecting 41600 events.
[14:43:48.714]     INFO: 41600 events read in total (2784ms).
[14:43:48.715]     INFO: Test took 4004ms.
[14:43:48.756]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:49.466]     INFO: Expecting 41600 events.
[14:43:52.750]     INFO: 41600 events read in total (2757ms).
[14:43:52.751]     INFO: Test took 3974ms.
[14:43:52.792]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:53.504]     INFO: Expecting 41600 events.
[14:43:56.825]     INFO: 41600 events read in total (2794ms).
[14:43:56.827]     INFO: Test took 4013ms.
[14:43:56.867]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:43:57.576]     INFO: Expecting 41600 events.
[14:44:00.892]     INFO: 41600 events read in total (2789ms).
[14:44:00.893]     INFO: Test took 4005ms.
[14:44:00.935]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:01.642]     INFO: Expecting 41600 events.
[14:44:04.938]     INFO: 41600 events read in total (2769ms).
[14:44:04.939]     INFO: Test took 3983ms.
[14:44:04.982]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:05.690]     INFO: Expecting 41600 events.
[14:44:09.006]     INFO: 41600 events read in total (2789ms).
[14:44:09.007]     INFO: Test took 4004ms.
[14:44:09.049]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:09.759]     INFO: Expecting 41600 events.
[14:44:13.074]     INFO: 41600 events read in total (2788ms).
[14:44:13.075]     INFO: Test took 4006ms.
[14:44:13.116]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:13.825]     INFO: Expecting 41600 events.
[14:44:17.143]     INFO: 41600 events read in total (2791ms).
[14:44:17.144]     INFO: Test took 4006ms.
[14:44:17.186]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:17.896]     INFO: Expecting 41600 events.
[14:44:21.208]     INFO: 41600 events read in total (2785ms).
[14:44:21.209]     INFO: Test took 4002ms.
[14:44:21.250]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:21.957]     INFO: Expecting 41600 events.
[14:44:25.265]     INFO: 41600 events read in total (2781ms).
[14:44:25.266]     INFO: Test took 3994ms.
[14:44:25.307]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:26.014]     INFO: Expecting 41600 events.
[14:44:29.238]     INFO: 41600 events read in total (2697ms).
[14:44:29.239]     INFO: Test took 3910ms.
[14:44:29.280]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:29.631]     INFO: enter test to run
[14:44:37.054]     INFO:   test: HighRate no parameter change
[14:44:37.054]     INFO:   running: highrate
[14:44:37.056]     INFO:    ----------------------------------------------------------------------
[14:44:37.056]     INFO:    PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:44:37.056]     INFO:    ----------------------------------------------------------------------
[14:44:37.666]     INFO: Expecting 208000 events.
[14:44:50.012]     INFO: 208000 events read in total (11819ms).
[14:44:50.016]     INFO: Test took 12953ms.
[14:44:50.199]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:44:50.464]     INFO: number of dead pixels (per ROC):     0    0    0    1    0    0    0    0    0    0    0    4    0    0    0    0
[14:44:50.464]     INFO: number of red-efficiency pixels:   130   68  114  202  236  186  166  139  142  151  159  139  152   71   32   33
[14:44:50.464]     INFO: number of X-ray hits detected:    86895 58276 80971 145131 144840 154538 142957 107801 96472 124685 122308 106279 107842 63622 24782 27852
[14:44:50.464]     INFO: number of triggers sent (total per ROC):  208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:44:50.464]     INFO: number of Vcal hits detected:  207865 207930 207882 207744 207753 207804 207830 207860 207858 207847 207836 207662 207843 207927 207968 207967
[14:44:50.464]     INFO: Vcal hit fiducial efficiency (%):  99.9 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
[14:44:50.464]     INFO: Vcal hit overall efficiency (%):  99.9 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.8 99.9 100.0 100.0 100.0
[14:44:50.464]     INFO: X-ray hit rate [MHz/cm2]:  25.5 17.1 23.7 42.5 42.5 45.3 41.9 31.6 28.3 36.5 35.8 31.2 31.6 18.6 7.3 8.2
[14:44:50.464]     INFO: PixTestHighRate::doXPixelAlive() done
[14:44:50.514]     INFO: PixTest::       pg_setup set to default.
[14:44:50.527]     INFO: enter test to run
[14:45:33.462]     INFO:   test: HighRate no parameter change
[14:45:33.463]     INFO:   running: highrate
[14:45:33.464]     INFO:    ----------------------------------------------------------------------
[14:45:33.464]     INFO:    PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:45:33.464]     INFO:    ----------------------------------------------------------------------
[14:45:34.091]     INFO: Expecting 208000 events.
[14:45:48.840]     INFO: 208000 events read in total (14222ms).
[14:45:48.847]     INFO: Test took 15370ms.
[14:45:49.223]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:45:49.556]     INFO: number of dead pixels (per ROC):     0    0    0    1    0    0    0    0    0    0    0    4    0    0    0    0
[14:45:49.556]     INFO: number of red-efficiency pixels:   352  225  400  784  911  771  675  570  496  592  621  383  413  289   64   68
[14:45:49.556]     INFO: number of X-ray hits detected:    181754 121118 168901 302341 302261 321053 297760 224717 202375 259084 255721 221018 225093 131571 52207 58968
[14:45:49.556]     INFO: number of triggers sent (total per ROC):  208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:45:49.556]     INFO: number of Vcal hits detected:  207614 207762 207530 207052 206909 207126 207224 207332 207465 207348 207300 207393 207557 207676 207932 207931
[14:45:49.556]     INFO: Vcal hit fiducial efficiency (%):  99.8 99.9 99.8 99.6 99.5 99.6 99.7 99.7 99.8 99.7 99.7 99.8 99.8 99.9 100.0 100.0
[14:45:49.556]     INFO: Vcal hit overall efficiency (%):  99.8 99.9 99.8 99.5 99.5 99.6 99.6 99.7 99.7 99.7 99.7 99.7 99.8 99.8 100.0 100.0
[14:45:49.556]     INFO: X-ray hit rate [MHz/cm2]:  53.3 35.5 49.5 88.6 88.6 94.1 87.3 65.9 59.3 75.9 75.0 64.8 66.0 38.6 15.3 17.3
[14:45:49.556]     INFO: PixTestHighRate::doXPixelAlive() done
[14:45:49.603]     INFO: PixTest::       pg_setup set to default.
[14:45:49.613]     INFO: enter test to run
[14:47:36.533]     INFO:   test: HighRate no parameter change
[14:47:36.533]     INFO:   running: highrate
[14:47:36.535]     INFO:    ----------------------------------------------------------------------
[14:47:36.535]     INFO:    PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:47:36.535]     INFO:    ----------------------------------------------------------------------
[14:47:37.164]     INFO: Expecting 208000 events.
[14:47:55.054]     INFO: 208000 events read in total (17363ms).
[14:47:55.063]     INFO: Test took 18517ms.
[14:47:55.653]     INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:56.047]     INFO: number of dead pixels (per ROC):     0    0    0    1    0    0    0    0    0    0    0    4    0    0    0    0
[14:47:56.047]     INFO: number of red-efficiency pixels:   763  524  879 1673 2066 1738 1540 1350  954 1301 1424  886  958  656  110  109
[14:47:56.047]     INFO: number of X-ray hits detected:    271169 180488 252295 449573 449545 479243 442044 336516 303426 387526 380247 331696 335171 196930 78226 88361
[14:47:56.047]     INFO: number of triggers sent (total per ROC):  208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:47:56.047]     INFO: number of Vcal hits detected:  207002 207385 206649 205552 204726 205504 205891 206083 206816 206246 206095 206737 206807 207184 207885 207891
[14:47:56.047]     INFO: Vcal hit fiducial efficiency (%):  99.6 99.7 99.4 99.0 98.6 98.9 99.1 99.2 99.5 99.2 99.2 99.5 99.5 99.6 99.9 99.9
[14:47:56.048]     INFO: Vcal hit overall efficiency (%):  99.5 99.7 99.4 98.8 98.4 98.8 99.0 99.1 99.4 99.2 99.1 99.4 99.4 99.6 99.9 99.9
[14:47:56.048]     INFO: X-ray hit rate [MHz/cm2]:  79.5 52.9 73.9 131.8 131.8 140.5 129.6 98.6 88.9 113.6 111.5 97.2 98.2 57.7 22.9 25.9
[14:47:56.048]     INFO: PixTestHighRate::doXPixelAlive() done
[14:47:56.093]     INFO: PixTest::       pg_setup set to default.
[14:47:56.108]     INFO: enter test to run
[14:49:13.525]     INFO:   test: exit no parameter change
[14:49:13.836]    QUIET: Connection to board 33 closed.
[14:49:13.837]     INFO: pXar: this is the end, my friend