[15:21:12.561] INFO: *** Welcome to pxar ***
[15:21:12.561] INFO: *** Today: 2016/04/14
[15:21:13.090] INFO: *** Version: v1.9.0-796-gef167-dirty
[15:21:13.090] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//dacParameters35_C15.dat
[15:21:13.148] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//tbmParameters_C0b.dat
[15:21:13.148] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//defaultMaskFile.dat
[15:21:13.156] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C15.dat
[15:21:13.292] INFO: clk: 4
[15:21:13.292] INFO: ctr: 4
[15:21:13.292] INFO: sda: 19
[15:21:13.292] INFO: tin: 9
[15:21:13.292] INFO: level: 15
[15:21:13.292] INFO: triggerdelay: 0
[15:21:13.292] QUIET: Instanciating API for pxar v1.9.0+796~gef16747
[15:21:13.292] INFO: Log level: INFO
[15:21:13.310] QUIET: Connection to board DTB_WREKRL opened.
[15:21:13.313] 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:
------------------------------------------------------
[15:21:13.316] INFO: RPC call hashes of host and DTB match: 398089610
[15:21:14.854] INFO: DUT info:
[15:21:14.854] INFO: The DUT currently contains the following objects:
[15:21:14.854] INFO: 2 TBM Cores tbm08c (2 ON)
[15:21:14.854] INFO: TBM Core alpha (0): 7 registers set
[15:21:14.854] INFO: TBM Core beta (1): 7 registers set
[15:21:14.854] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:21:14.854] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:14.855] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:21:15.304] INFO: enter 'restricted' command line mode
[15:21:15.304] INFO: enter test to run
[15:21:28.274] INFO: test: PixelAlive no parameter change
[15:21:28.274] INFO: running: pixelalive
[15:21:28.339] INFO: ----------------------------------------------------------------------
[15:21:28.339] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:21:28.339] INFO: ----------------------------------------------------------------------
[15:21:28.659] INFO: Expecting 41600 events.
[15:21:32.961] INFO: 41600 events read in total (3583ms).
[15:21:33.131] INFO: Test took 4788ms.
[15:21:33.141] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:21:33.740] INFO: PixTestAlive::aliveTest() done
[15:21:33.740] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:21:33.930] INFO: enter test to run
[15:22:39.402] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[15:22:39.402] INFO: running: highrate
[15:22:39.402] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[15:22:39.644] INFO: ----------------------------------------------------------------------
[15:22:39.644] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[15:22:39.644] INFO: ----------------------------------------------------------------------
[15:22:39.644] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[15:22:39.660] INFO: edge/corner pixel THR is adjusted
[15:22:39.660] INFO: PixTestHighRate::trimHotPixels: step 0...
[15:22:40.619] INFO: Collecting data for 5 seconds...
[15:22:45.636] INFO: Done with hot pixel readout
[15:22:58.271] INFO: PixTest:: pg_setup set to default.
[15:22:58.271] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:22:58.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:22:58.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:22:58.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:22:58.298] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:22:58.299] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:22:58.299] INFO: 106 hot pixels found in step 0
[15:22:59.294] INFO: Collecting data for 5 seconds...
[15:23:04.311] INFO: Done with hot pixel readout
[15:23:15.275] INFO: PixTest:: pg_setup set to default.
[15:23:15.275] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:15.275] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:15.275] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:15.276] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:15.276] INFO: 104 hot pixels found in step 1
[15:23:16.271] INFO: Collecting data for 5 seconds...
[15:23:21.281] INFO: Done with hot pixel readout
[15:23:33.825] INFO: PixTest:: pg_setup set to default.
[15:23:33.825] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:33.825] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:33.826] INFO: 90 hot pixels found in step 2
[15:23:34.825] INFO: Collecting data for 5 seconds...
[15:23:39.838] INFO: Done with hot pixel readout
[15:23:51.781] INFO: PixTest:: pg_setup set to default.
[15:23:51.781] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:51.781] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:51.781] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:51.781] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:51.782] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:23:51.782] INFO: 93 hot pixels found in step 3
[15:23:52.781] INFO: Collecting data for 5 seconds...
[15:23:57.797] INFO: Done with hot pixel readout
[15:24:10.462] INFO: PixTest:: pg_setup set to default.
[15:24:10.463] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:10.463] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:10.463] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:10.463] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:10.463] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:10.464] INFO: 83 hot pixels found in step 4
[15:24:11.463] INFO: Collecting data for 5 seconds...
[15:24:16.479] INFO: Done with hot pixel readout
[15:24:29.180] INFO: PixTest:: pg_setup set to default.
[15:24:29.180] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:29.180] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:29.180] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:29.180] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:29.180] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:29.180] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:29.181] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:29.181] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:29.181] INFO: 66 hot pixels found in step 5
[15:24:30.179] INFO: Collecting data for 5 seconds...
[15:24:35.195] INFO: Done with hot pixel readout
[15:24:47.683] INFO: PixTest:: pg_setup set to default.
[15:24:47.684] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:47.684] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:47.684] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:47.684] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:47.684] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:47.684] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:47.684] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:24:47.685] INFO: 74 hot pixels found in step 6
[15:24:48.683] INFO: Collecting data for 5 seconds...
[15:24:53.700] INFO: Done with hot pixel readout
[15:25:06.207] INFO: PixTest:: pg_setup set to default.
[15:25:06.207] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.207] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.207] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.207] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.207] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.207] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.207] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.208] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.208] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:06.208] INFO: 74 hot pixels found in step 7
[15:25:07.207] INFO: Collecting data for 5 seconds...
[15:25:12.224] INFO: Done with hot pixel readout
[15:25:24.561] INFO: PixTest:: pg_setup set to default.
[15:25:24.561] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:24.561] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:24.562] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:24.562] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:24.562] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:24.562] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:24.562] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:24.562] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:24.562] INFO: 65 hot pixels found in step 8
[15:25:25.560] INFO: Collecting data for 5 seconds...
[15:25:30.577] INFO: Done with hot pixel readout
[15:25:42.668] INFO: PixTest:: pg_setup set to default.
[15:25:42.669] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:42.669] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:42.669] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:42.669] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:42.669] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:42.669] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:25:42.670] INFO: 68 hot pixels found in step 9
[15:25:43.667] INFO: Collecting data for 5 seconds...
[15:25:48.684] INFO: Done with hot pixel readout
[15:26:01.363] INFO: PixTest:: pg_setup set to default.
[15:26:01.363] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.363] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.363] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.364] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.364] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.364] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.364] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.364] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.364] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:01.364] INFO: 67 hot pixels found in step 10
[15:26:02.363] INFO: Collecting data for 5 seconds...
[15:26:07.379] INFO: Done with hot pixel readout
[15:26:19.988] INFO: PixTest:: pg_setup set to default.
[15:26:19.988] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.988] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.988] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.988] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.989] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.989] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.989] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.989] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.989] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.989] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:19.989] INFO: 66 hot pixels found in step 11
[15:26:20.991] INFO: Collecting data for 5 seconds...
[15:26:26.007] INFO: Done with hot pixel readout
[15:26:38.578] INFO: PixTest:: pg_setup set to default.
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.578] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.579] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:38.579] INFO: 50 hot pixels found in step 12
[15:26:39.576] INFO: Collecting data for 5 seconds...
[15:26:44.593] INFO: Done with hot pixel readout
[15:26:57.282] INFO: PixTest:: pg_setup set to default.
[15:26:57.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.283] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.283] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.283] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.283] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:26:57.283] INFO: 48 hot pixels found in step 13
[15:26:58.281] INFO: Collecting data for 5 seconds...
[15:27:03.297] INFO: Done with hot pixel readout
[15:27:15.986] INFO: PixTest:: pg_setup set to default.
[15:27:15.986] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.986] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.986] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.986] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.986] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.986] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.987] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.987] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.987] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.987] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[15:27:15.987] INFO: 62 hot pixels found in step 14
[15:27:16.029] INFO: 62 hot pixels could not be trimmed and have been masked.
[15:27:16.046] INFO: PixTest::trimHotPixels() done
[15:27:16.046] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C0.dat
[15:27:16.058] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C1.dat
[15:27:16.066] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C2.dat
[15:27:16.071] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C3.dat
[15:27:16.077] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C4.dat
[15:27:16.082] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C5.dat
[15:27:16.088] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C6.dat
[15:27:16.094] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C7.dat
[15:27:16.100] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C8.dat
[15:27:16.105] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C9.dat
[15:27:16.111] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C10.dat
[15:27:16.117] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C11.dat
[15:27:16.122] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C12.dat
[15:27:16.128] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C13.dat
[15:27:16.133] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C14.dat
[15:27:16.139] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C15.dat
[15:27:16.145] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//defaultMaskFile.dat
[15:27:16.156] INFO: enter test to run
[15:28:02.071] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[15:28:02.071] INFO: running: highrate
[15:28:02.076] INFO: ----------------------------------------------------------------------
[15:28:02.076] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[15:28:02.076] INFO: ----------------------------------------------------------------------
[15:28:02.076] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[15:28:02.076] INFO: edge/corner pixel THR is adjusted
[15:28:02.076] INFO: PixTestHighRate::trimHotPixels: step 0...
[15:28:03.034] INFO: Collecting data for 1 seconds...
[15:28:04.038] INFO: Done with hot pixel readout
[15:28:08.543] INFO: PixTest:: pg_setup set to default.
[15:28:08.544] INFO: 0 hot pixels found in step 0
[15:28:08.549] INFO: 0 hot pixels could not be trimmed and have been masked.
[15:28:08.621] INFO: PixTest::trimHotPixels() done
[15:28:08.621] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C0.dat
[15:28:08.634] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C1.dat
[15:28:08.640] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C2.dat
[15:28:08.645] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C3.dat
[15:28:08.652] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C4.dat
[15:28:08.657] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C5.dat
[15:28:08.663] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C6.dat
[15:28:08.668] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C7.dat
[15:28:08.674] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C8.dat
[15:28:08.680] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C9.dat
[15:28:08.686] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C10.dat
[15:28:08.691] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C11.dat
[15:28:08.697] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C12.dat
[15:28:08.703] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C13.dat
[15:28:08.708] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C14.dat
[15:28:08.714] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//trimParameters35_C15.dat
[15:28:08.719] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-L-3-17_FPIXTest-17C-FNAL-160408-0921_2016-04-08_09h21m_1460125289/000_FPIXTest_p17//defaultMaskFile.dat
[15:28:08.729] INFO: enter test to run
[15:28:54.591] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[15:28:54.591] INFO: running: xray
[15:28:54.592] INFO: ----------------------------------------------------------------------
[15:28:54.592] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:28:54.592] INFO: ----------------------------------------------------------------------
[15:28:55.564] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:29:06.077] INFO: run duration 10 seconds, buffer almost full (81%), pausing triggers.
[15:29:35.670] INFO: Resuming triggers.
[15:29:46.184] INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[15:30:15.797] INFO: Resuming triggers.
[15:30:26.310] INFO: run duration 31 seconds, buffer almost full (81%), pausing triggers.
[15:30:55.980] INFO: Resuming triggers.
[15:31:06.494] INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[15:31:36.118] INFO: Resuming triggers.
[15:31:46.632] INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[15:32:16.360] INFO: Resuming triggers.
[15:32:26.873] INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[15:32:56.507] INFO: Resuming triggers.
[15:33:07.017] INFO: run duration 73 seconds, buffer almost full (81%), pausing triggers.
[15:33:32.850] INFO: Resuming triggers.
[15:33:43.361] INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[15:34:11.300] INFO: Resuming triggers.
[15:34:21.809] INFO: run duration 94 seconds, buffer almost full (81%), pausing triggers.
[15:34:51.431] INFO: Resuming triggers.
[15:34:57.153] INFO: data taking finished, elapsed time: 100 seconds.
[15:35:13.629] INFO: PixTest:: pg_setup set to default.
[15:35:13.632] INFO: PixTestXray::doPhRun() done
[15:35:13.773] INFO: enter test to run
[15:36:19.139] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[15:36:19.139] INFO: running: xray
[15:36:19.140] INFO: ----------------------------------------------------------------------
[15:36:19.140] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[15:36:19.141] INFO: ----------------------------------------------------------------------
[15:36:20.105] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[15:36:25.851] INFO: run duration 5 seconds, buffer almost full (81%), pausing triggers.
[15:36:56.028] INFO: Resuming triggers.
[15:37:01.779] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[15:37:31.973] INFO: Resuming triggers.
[15:37:37.725] INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[15:38:07.871] INFO: Resuming triggers.
[15:38:13.621] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[15:38:43.751] INFO: Resuming triggers.
[15:38:49.500] INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[15:39:19.734] INFO: Resuming triggers.
[15:39:25.486] INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[15:39:55.639] INFO: Resuming triggers.
[15:40:01.389] INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[15:40:31.582] INFO: Resuming triggers.
[15:40:37.330] INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[15:41:07.476] INFO: Resuming triggers.
[15:41:13.227] INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[15:41:43.224] INFO: Resuming triggers.
[15:41:48.972] INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[15:42:19.184] INFO: Resuming triggers.
[15:42:24.933] INFO: run duration 63 seconds, buffer almost full (81%), pausing triggers.
[15:42:55.188] INFO: Resuming triggers.
[15:43:00.935] INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[15:43:31.364] INFO: Resuming triggers.
[15:43:37.112] INFO: run duration 74 seconds, buffer almost full (81%), pausing triggers.
[15:44:05.828] INFO: Resuming triggers.
[15:44:11.572] INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[15:44:41.772] INFO: Resuming triggers.
[15:44:47.518] INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[15:45:17.727] INFO: Resuming triggers.
[15:45:23.473] INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[15:45:53.515] INFO: Resuming triggers.
[15:45:59.263] INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[15:46:29.409] INFO: Resuming triggers.
[15:46:32.009] INFO: data taking finished, elapsed time: 100 seconds.
[15:46:45.925] INFO: PixTest:: pg_setup set to default.
[15:46:45.929] INFO: PixTestXray::doPhRun() done
[15:46:46.080] INFO: enter test to run
[15:47:18.207] INFO: test: HighRate no parameter change
[15:47:18.207] INFO: running: highrate
[15:47:18.208] INFO: ----------------------------------------------------------------------
[15:47:18.208] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[15:47:18.208] INFO: ----------------------------------------------------------------------
[15:47:18.366] INFO: Expecting 768 events.
[15:47:19.508] INFO: 768 events read in total (418ms).
[15:47:19.509] INFO: Test took 1277ms.
[15:47:20.312] INFO: Expecting 41600 events.
[15:47:23.502] INFO: 41600 events read in total (2663ms).
[15:47:23.503] INFO: Test took 3987ms.
[15:47:23.544] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:24.260] INFO: Expecting 41600 events.
[15:47:27.539] INFO: 41600 events read in total (2752ms).
[15:47:27.540] INFO: Test took 3976ms.
[15:47:27.581] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:28.294] INFO: Expecting 41600 events.
[15:47:31.582] INFO: 41600 events read in total (2761ms).
[15:47:31.583] INFO: Test took 3982ms.
[15:47:31.624] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:32.337] INFO: Expecting 41600 events.
[15:47:35.637] INFO: 41600 events read in total (2773ms).
[15:47:35.638] INFO: Test took 3992ms.
[15:47:35.679] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:36.389] INFO: Expecting 41600 events.
[15:47:39.693] INFO: 41600 events read in total (2777ms).
[15:47:39.694] INFO: Test took 3995ms.
[15:47:39.736] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:40.450] INFO: Expecting 41600 events.
[15:47:43.763] INFO: 41600 events read in total (2786ms).
[15:47:43.764] INFO: Test took 4007ms.
[15:47:43.804] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:44.517] INFO: Expecting 41600 events.
[15:47:47.830] INFO: 41600 events read in total (2786ms).
[15:47:47.831] INFO: Test took 4007ms.
[15:47:47.872] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:48.581] INFO: Expecting 41600 events.
[15:47:51.911] INFO: 41600 events read in total (2803ms).
[15:47:51.912] INFO: Test took 4019ms.
[15:47:51.954] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:52.663] INFO: Expecting 41600 events.
[15:47:55.999] INFO: 41600 events read in total (2809ms).
[15:47:55.000] INFO: Test took 4024ms.
[15:47:56.041] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:56.749] INFO: Expecting 41600 events.
[15:48:00.060] INFO: 41600 events read in total (2784ms).
[15:48:00.061] INFO: Test took 4000ms.
[15:48:00.101] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:00.815] INFO: Expecting 41600 events.
[15:48:04.135] INFO: 41600 events read in total (2793ms).
[15:48:04.136] INFO: Test took 4014ms.
[15:48:04.177] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:04.886] INFO: Expecting 41600 events.
[15:48:08.206] INFO: 41600 events read in total (2793ms).
[15:48:08.207] INFO: Test took 4011ms.
[15:48:08.248] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:08.960] INFO: Expecting 41600 events.
[15:48:12.285] INFO: 41600 events read in total (2798ms).
[15:48:12.286] INFO: Test took 4018ms.
[15:48:12.328] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:13.036] INFO: Expecting 41600 events.
[15:48:16.340] INFO: 41600 events read in total (2777ms).
[15:48:16.341] INFO: Test took 3992ms.
[15:48:16.382] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:17.091] INFO: Expecting 41600 events.
[15:48:20.421] INFO: 41600 events read in total (2803ms).
[15:48:20.422] INFO: Test took 4019ms.
[15:48:20.463] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:21.173] INFO: Expecting 41600 events.
[15:48:24.489] INFO: 41600 events read in total (2790ms).
[15:48:24.490] INFO: Test took 4006ms.
[15:48:24.530] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:25.241] INFO: Expecting 41600 events.
[15:48:28.537] INFO: 41600 events read in total (2769ms).
[15:48:28.538] INFO: Test took 3986ms.
[15:48:28.578] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:29.292] INFO: Expecting 41600 events.
[15:48:32.616] INFO: 41600 events read in total (2797ms).
[15:48:32.617] INFO: Test took 4018ms.
[15:48:32.657] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:33.370] INFO: Expecting 41600 events.
[15:48:36.648] INFO: 41600 events read in total (2751ms).
[15:48:36.649] INFO: Test took 3972ms.
[15:48:36.689] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:37.404] INFO: Expecting 41600 events.
[15:48:40.527] INFO: 41600 events read in total (2597ms).
[15:48:40.528] INFO: Test took 3818ms.
[15:48:40.569] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:40.920] INFO: enter test to run
[15:48:58.302] INFO: test: HighRate no parameter change
[15:48:58.302] INFO: running: highrate
[15:48:58.303] INFO: ----------------------------------------------------------------------
[15:48:58.303] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:48:58.303] INFO: ----------------------------------------------------------------------
[15:48:58.919] INFO: Expecting 208000 events.
[15:49:11.199] INFO: 208000 events read in total (11753ms).
[15:49:11.203] INFO: Test took 12892ms.
[15:49:11.383] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:49:11.646] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:49:11.646] INFO: number of red-efficiency pixels: 76 68 129 175 226 148 192 113 146 176 184 152 153 74 30 32
[15:49:11.646] INFO: number of X-ray hits detected: 73369 51606 84980 134248 139398 137302 134498 99399 101342 128019 131814 108475 116059 69439 27619 29987
[15:49:11.647] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:49:11.647] INFO: number of Vcal hits detected: 207922 207932 207869 207825 207765 207849 207801 207886 207851 207818 207814 207835 207845 207926 207969 207968
[15:49:11.647] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 99.9 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
[15:49:11.647] INFO: Vcal hit overall efficiency (%): 100.0 100.0 99.9 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
[15:49:11.647] INFO: X-ray hit rate [MHz/cm2]: 21.5 15.1 24.9 39.3 40.9 40.2 39.4 29.1 29.7 37.5 38.6 31.8 34.0 20.4 8.1 8.8
[15:49:11.647] INFO: PixTestHighRate::doXPixelAlive() done
[15:49:11.696] INFO: PixTest:: pg_setup set to default.
[15:49:11.709] INFO: enter test to run
[15:49:45.070] INFO: test: HighRate no parameter change
[15:49:45.070] INFO: running: highrate
[15:49:45.071] INFO: ----------------------------------------------------------------------
[15:49:45.071] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:49:45.071] INFO: ----------------------------------------------------------------------
[15:49:45.685] INFO: Expecting 208000 events.
[15:50:00.241] INFO: 208000 events read in total (14029ms).
[15:50:00.247] INFO: Test took 15167ms.
[15:50:00.604] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:00.928] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:50:00.928] INFO: number of red-efficiency pixels: 249 172 478 642 796 601 719 386 460 722 770 552 589 261 64 56
[15:50:00.928] INFO: number of X-ray hits detected: 153371 107154 177786 281494 291688 286345 279585 206031 211016 265825 274378 226916 240547 145222 57971 61784
[15:50:00.928] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:50:00.928] INFO: number of Vcal hits detected: 207734 207817 207450 207283 207064 207333 207170 207582 207475 207186 207112 207388 207346 207717 207932 207944
[15:50:00.928] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.6 99.7 99.6 99.8 99.8 99.6 99.6 99.7 99.7 99.9 100.0 100.0
[15:50:00.928] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.7 99.7 99.6 99.7 99.6 99.8 99.7 99.6 99.6 99.7 99.7 99.9 100.0 100.0
[15:50:00.928] INFO: X-ray hit rate [MHz/cm2]: 45.0 31.4 52.1 82.5 85.5 83.9 81.9 60.4 61.9 77.9 80.4 66.5 70.5 42.6 17.0 18.1
[15:50:00.928] INFO: PixTestHighRate::doXPixelAlive() done
[15:50:00.975] INFO: PixTest:: pg_setup set to default.
[15:50:00.990] INFO: enter test to run
[15:50:30.485] INFO: test: HighRate no parameter change
[15:50:30.485] INFO: running: highrate
[15:50:30.486] INFO: ----------------------------------------------------------------------
[15:50:30.486] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[15:50:30.486] INFO: ----------------------------------------------------------------------
[15:50:31.103] INFO: Expecting 208000 events.
[15:50:48.353] INFO: 208000 events read in total (16723ms).
[15:50:48.363] INFO: Test took 17866ms.
[15:50:48.949] INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:49.336] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:50:49.337] INFO: number of red-efficiency pixels: 508 394 1056 1456 1940 1443 1795 936 1069 1694 1795 1282 1461 597 133 104
[15:50:49.337] INFO: number of X-ray hits detected: 233889 164694 270974 429060 444747 437127 427420 314418 321735 404399 420197 346898 367027 221996 89463 95807
[15:50:49.337] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[15:50:49.337] INFO: number of Vcal hits detected: 207409 207553 206316 206025 205010 206078 205295 206781 206604 205535 205270 206255 205991 207232 207866 207893
[15:50:49.337] INFO: Vcal hit fiducial efficiency (%): 99.7 99.8 99.3 99.2 98.7 99.2 98.8 99.5 99.4 98.9 98.8 99.3 99.1 99.7 99.9 99.9
[15:50:49.337] INFO: Vcal hit overall efficiency (%): 99.7 99.8 99.2 99.1 98.6 99.1 98.7 99.4 99.3 98.8 98.7 99.2 99.0 99.6 99.9 99.9
[15:50:49.337] INFO: X-ray hit rate [MHz/cm2]: 68.6 48.3 79.4 125.8 130.4 128.1 125.3 92.2 94.3 118.5 123.2 101.7 107.6 65.1 26.2 28.1
[15:50:49.337] INFO: PixTestHighRate::doXPixelAlive() done
[15:50:49.382] INFO: PixTest:: pg_setup set to default.
[15:50:49.401] INFO: enter test to run
[15:51:21.765] INFO: test: exit no parameter change
[15:51:22.213] QUIET: Connection to board 33 closed.
[15:51:22.223] INFO: pXar: this is the end, my friend