[17:05:21.723] INFO: *** Welcome to pxar ***
[17:05:21.723] INFO: *** Today: 2016/06/06
[17:05:21.738] INFO: *** Version: v1.9.0-814-g7497
[17:05:21.738] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//dacParameters35_C15.dat
[17:05:21.753] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//tbmParameters_C0b.dat
[17:05:21.753] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//defaultMaskFile.dat
[17:05:21.753] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C15.dat
[17:05:21.885] INFO: clk: 4
[17:05:21.885] INFO: ctr: 4
[17:05:21.885] INFO: sda: 19
[17:05:21.885] INFO: tin: 9
[17:05:21.885] INFO: level: 15
[17:05:21.885] INFO: triggerdelay: 0
[17:05:21.885] QUIET: Instanciating API for pxar v1.9.0+814~g74979a6
[17:05:21.885] INFO: Log level: INFO
[17:05:21.902] QUIET: Connection to board DTB_WREK4U opened.
[17:05:21.905] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 32
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WREK4U
MAC address: 40D855118020
Hostname: pixelDTB032
Comment:
------------------------------------------------------
[17:05:21.908] INFO: RPC call hashes of host and DTB match: 398089610
[17:05:23.437] INFO: DUT info:
[17:05:23.437] INFO: The DUT currently contains the following objects:
[17:05:23.437] INFO: 2 TBM Cores tbm08c (2 ON)
[17:05:23.437] INFO: TBM Core alpha (0): 7 registers set
[17:05:23.437] INFO: TBM Core beta (1): 7 registers set
[17:05:23.437] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:05:23.437] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.437] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.438] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.438] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.438] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:23.841] INFO: enter 'restricted' command line mode
[17:05:23.841] INFO: enter test to run
[17:05:28.794] INFO: test: PixelAlive no parameter change
[17:05:28.794] INFO: running: pixelalive
[17:05:28.803] INFO: ----------------------------------------------------------------------
[17:05:28.803] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[17:05:28.803] INFO: ----------------------------------------------------------------------
[17:05:29.147] INFO: Expecting 41600 events.
[17:05:33.525] INFO: 41600 events read in total (3660ms).
[17:05:33.690] INFO: Test took 4885ms.
[17:05:33.697] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:05:33.963] INFO: PixTestAlive::aliveTest() done
[17:05:33.963] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[17:05:33.998] INFO: enter test to run
[17:05:43.065] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[17:05:43.065] INFO: running: highrate
[17:05:43.065] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[17:05:43.278] INFO: ----------------------------------------------------------------------
[17:05:43.278] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[17:05:43.278] INFO: ----------------------------------------------------------------------
[17:05:43.278] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[17:05:43.278] INFO: edge/corner pixel THR is adjusted
[17:05:43.278] INFO: PixTestHighRate::trimHotPixels: step 0...
[17:05:44.236] INFO: Collecting data for 5 seconds...
[17:05:49.255] INFO: Done with hot pixel readout
[17:06:00.354] INFO: PixTest:: pg_setup set to default.
[17:06:00.355] INFO: 1 hot pixels found in step 0
[17:06:01.341] INFO: Collecting data for 5 seconds...
[17:06:06.359] INFO: Done with hot pixel readout
[17:06:17.573] INFO: PixTest:: pg_setup set to default.
[17:06:17.574] INFO: 1 hot pixels found in step 1
[17:06:18.567] INFO: Collecting data for 5 seconds...
[17:06:23.584] INFO: Done with hot pixel readout
[17:06:34.797] INFO: PixTest:: pg_setup set to default.
[17:06:34.798] INFO: 0 hot pixels found in step 2
[17:06:34.833] INFO: 0 hot pixels could not be trimmed and have been masked.
[17:06:34.837] INFO: PixTest::trimHotPixels() done
[17:06:34.837] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C0.dat
[17:06:34.843] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C1.dat
[17:06:34.850] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C2.dat
[17:06:34.858] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C3.dat
[17:06:34.866] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C4.dat
[17:06:34.873] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C5.dat
[17:06:34.880] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C6.dat
[17:06:34.887] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C7.dat
[17:06:34.894] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C8.dat
[17:06:34.900] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C9.dat
[17:06:34.907] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C10.dat
[17:06:34.914] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C11.dat
[17:06:34.920] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C12.dat
[17:06:34.926] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C13.dat
[17:06:34.931] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C14.dat
[17:06:34.937] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//trimParameters35_C15.dat
[17:06:34.943] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-I-4-02_FPIXTest-17C-FNAL-160602-1223_2016-06-02_12h23m_1464888229/000_FPIXTest_p17//defaultMaskFile.dat
[17:06:34.953] INFO: enter test to run
[17:08:07.528] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[17:08:07.528] INFO: running: xray
[17:08:07.529] INFO: ----------------------------------------------------------------------
[17:08:07.529] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[17:08:07.529] INFO: ----------------------------------------------------------------------
[17:08:08.492] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[17:08:20.062] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[17:08:49.100] INFO: Resuming triggers.
[17:09:00.670] INFO: run duration 23 seconds, buffer almost full (81%), pausing triggers.
[17:09:29.595] INFO: Resuming triggers.
[17:09:41.160] INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[17:10:10.357] INFO: Resuming triggers.
[17:10:21.926] INFO: run duration 46 seconds, buffer almost full (81%), pausing triggers.
[17:10:51.081] INFO: Resuming triggers.
[17:11:02.646] INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[17:11:31.883] INFO: Resuming triggers.
[17:11:43.448] INFO: run duration 69 seconds, buffer almost full (81%), pausing triggers.
[17:12:12.623] INFO: Resuming triggers.
[17:12:24.190] INFO: run duration 80 seconds, buffer almost full (81%), pausing triggers.
[17:12:53.378] INFO: Resuming triggers.
[17:13:04.944] INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[17:13:34.286] INFO: Resuming triggers.
[17:13:42.093] INFO: data taking finished, elapsed time: 100 seconds.
[17:14:02.099] INFO: PixTest:: pg_setup set to default.
[17:14:02.102] INFO: PixTestXray::doPhRun() done
[17:14:02.239] INFO: enter test to run
[17:14:29.677] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[17:14:29.677] INFO: running: xray
[17:14:29.678] INFO: ----------------------------------------------------------------------
[17:14:29.678] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[17:14:29.678] INFO: ----------------------------------------------------------------------
[17:14:30.643] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[17:14:37.551] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[17:15:07.607] INFO: Resuming triggers.
[17:15:14.517] INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[17:15:44.518] INFO: Resuming triggers.
[17:15:51.432] INFO: run duration 20 seconds, buffer almost full (81%), pausing triggers.
[17:16:21.455] INFO: Resuming triggers.
[17:16:28.366] INFO: run duration 27 seconds, buffer almost full (81%), pausing triggers.
[17:16:58.393] INFO: Resuming triggers.
[17:17:05.310] INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[17:17:36.316] INFO: Resuming triggers.
[17:17:43.234] INFO: run duration 41 seconds, buffer almost full (81%), pausing triggers.
[17:18:14.129] INFO: Resuming triggers.
[17:18:21.045] INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[17:18:51.922] INFO: Resuming triggers.
[17:18:58.836] INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[17:19:29.574] INFO: Resuming triggers.
[17:19:36.489] INFO: run duration 62 seconds, buffer almost full (81%), pausing triggers.
[17:20:06.833] INFO: Resuming triggers.
[17:20:13.749] INFO: run duration 68 seconds, buffer almost full (81%), pausing triggers.
[17:20:44.140] INFO: Resuming triggers.
[17:20:51.060] INFO: run duration 75 seconds, buffer almost full (81%), pausing triggers.
[17:21:21.996] INFO: Resuming triggers.
[17:21:28.910] INFO: run duration 82 seconds, buffer almost full (81%), pausing triggers.
[17:21:58.755] INFO: Resuming triggers.
[17:22:05.668] INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[17:22:35.682] INFO: Resuming triggers.
[17:22:42.590] INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[17:23:12.532] INFO: Resuming triggers.
[17:23:16.083] INFO: data taking finished, elapsed time: 100 seconds.
[17:23:31.739] INFO: PixTest:: pg_setup set to default.
[17:23:31.743] INFO: PixTestXray::doPhRun() done
[17:23:31.889] INFO: enter test to run
[17:23:41.649] INFO: test: HighRate no parameter change
[17:23:41.649] INFO: running: highrate
[17:23:41.663] INFO: ----------------------------------------------------------------------
[17:23:41.663] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[17:23:41.663] INFO: ----------------------------------------------------------------------
[17:23:41.818] INFO: Expecting 768 events.
[17:23:42.952] INFO: 768 events read in total (418ms).
[17:23:42.952] INFO: Test took 1268ms.
[17:23:43.756] INFO: Expecting 41600 events.
[17:23:46.779] INFO: 41600 events read in total (2496ms).
[17:23:46.780] INFO: Test took 3821ms.
[17:23:46.813] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:23:47.545] INFO: Expecting 41600 events.
[17:23:50.693] INFO: 41600 events read in total (2621ms).
[17:23:50.694] INFO: Test took 3864ms.
[17:23:50.727] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:23:51.454] INFO: Expecting 41600 events.
[17:23:54.634] INFO: 41600 events read in total (2653ms).
[17:23:54.635] INFO: Test took 3889ms.
[17:23:54.668] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:23:55.396] INFO: Expecting 41600 events.
[17:23:58.616] INFO: 41600 events read in total (2693ms).
[17:23:58.617] INFO: Test took 3932ms.
[17:23:58.650] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:23:59.377] INFO: Expecting 41600 events.
[17:24:02.589] INFO: 41600 events read in total (2685ms).
[17:24:02.590] INFO: Test took 3922ms.
[17:24:02.623] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:03.351] INFO: Expecting 41600 events.
[17:24:06.580] INFO: 41600 events read in total (2704ms).
[17:24:06.581] INFO: Test took 3940ms.
[17:24:06.615] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:07.337] INFO: Expecting 41600 events.
[17:24:10.567] INFO: 41600 events read in total (2703ms).
[17:24:10.568] INFO: Test took 3935ms.
[17:24:10.601] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:11.327] INFO: Expecting 41600 events.
[17:24:14.551] INFO: 41600 events read in total (2697ms).
[17:24:14.552] INFO: Test took 3933ms.
[17:24:14.585] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:15.313] INFO: Expecting 41600 events.
[17:24:18.534] INFO: 41600 events read in total (2694ms).
[17:24:18.534] INFO: Test took 3931ms.
[17:24:18.567] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:19.293] INFO: Expecting 41600 events.
[17:24:22.528] INFO: 41600 events read in total (2708ms).
[17:24:22.529] INFO: Test took 3944ms.
[17:24:22.562] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:23.285] INFO: Expecting 41600 events.
[17:24:26.515] INFO: 41600 events read in total (2703ms).
[17:24:26.516] INFO: Test took 3935ms.
[17:24:26.549] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:27.275] INFO: Expecting 41600 events.
[17:24:30.495] INFO: 41600 events read in total (2693ms).
[17:24:30.496] INFO: Test took 3930ms.
[17:24:30.529] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:31.259] INFO: Expecting 41600 events.
[17:24:34.496] INFO: 41600 events read in total (2710ms).
[17:24:34.497] INFO: Test took 3950ms.
[17:24:34.530] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:35.257] INFO: Expecting 41600 events.
[17:24:38.478] INFO: 41600 events read in total (2694ms).
[17:24:38.479] INFO: Test took 3931ms.
[17:24:38.511] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:39.236] INFO: Expecting 41600 events.
[17:24:42.461] INFO: 41600 events read in total (2698ms).
[17:24:42.462] INFO: Test took 3932ms.
[17:24:42.495] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:43.220] INFO: Expecting 41600 events.
[17:24:46.457] INFO: 41600 events read in total (2710ms).
[17:24:46.458] INFO: Test took 3944ms.
[17:24:46.491] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:47.218] INFO: Expecting 41600 events.
[17:24:50.441] INFO: 41600 events read in total (2696ms).
[17:24:50.442] INFO: Test took 3934ms.
[17:24:50.475] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:51.203] INFO: Expecting 41600 events.
[17:24:54.426] INFO: 41600 events read in total (2696ms).
[17:24:54.427] INFO: Test took 3933ms.
[17:24:54.460] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:55.186] INFO: Expecting 41600 events.
[17:24:58.375] INFO: 41600 events read in total (2662ms).
[17:24:58.376] INFO: Test took 3899ms.
[17:24:58.410] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:24:59.137] INFO: Expecting 41600 events.
[17:25:02.258] INFO: 41600 events read in total (2594ms).
[17:25:02.258] INFO: Test took 3831ms.
[17:25:02.292] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:25:02.647] INFO: enter test to run
[17:25:57.120] INFO: test: HighRate no parameter change
[17:25:57.120] INFO: running: highrate
[17:25:57.121] INFO: ----------------------------------------------------------------------
[17:25:57.121] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:25:57.121] INFO: ----------------------------------------------------------------------
[17:25:57.738] INFO: Expecting 208000 events.
[17:26:09.549] INFO: 208000 events read in total (11284ms).
[17:26:09.553] INFO: Test took 12422ms.
[17:26:09.697] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:26:09.947] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[17:26:09.947] INFO: number of red-efficiency pixels: 80 49 75 148 133 128 110 128 95 110 113 84 88 60 21 22
[17:26:09.947] INFO: number of X-ray hits detected: 66314 42029 64018 103121 108562 112546 114553 82568 82783 92110 90300 74513 80520 47202 21115 23133
[17:26:09.947] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[17:26:09.947] INFO: number of Vcal hits detected: 207920 207949 207923 207851 207858 207872 207889 207871 207905 207889 207882 207914 207912 207938 207979 207977
[17:26:09.947] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 100.0 99.9 99.9 100.0 100.0 100.0 100.0 100.0
[17:26:09.947] INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 100.0 99.9 99.9 100.0 100.0 100.0 100.0 100.0
[17:26:09.947] INFO: X-ray hit rate [MHz/cm2]: 19.4 12.3 18.8 30.2 31.8 33.0 33.6 24.2 24.3 27.0 26.5 21.8 23.6 13.8 6.2 6.8
[17:26:09.947] INFO: PixTestHighRate::doXPixelAlive() done
[17:26:09.998] INFO: PixTest:: pg_setup set to default.
[17:26:10.008] INFO: enter test to run
[17:26:49.632] INFO: test: HighRate no parameter change
[17:26:49.632] INFO: running: highrate
[17:26:49.633] INFO: ----------------------------------------------------------------------
[17:26:49.633] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:26:49.633] INFO: ----------------------------------------------------------------------
[17:26:50.247] INFO: Expecting 208000 events.
[17:27:03.700] INFO: 208000 events read in total (12926ms).
[17:27:03.705] INFO: Test took 14062ms.
[17:27:03.979] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:27:04.275] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[17:27:04.275] INFO: number of red-efficiency pixels: 206 112 189 463 379 376 389 325 227 271 324 195 212 159 48 64
[17:27:04.275] INFO: number of X-ray hits detected: 135669 86293 131771 210965 221925 229474 232761 168885 169215 189274 185491 152513 163396 96524 43683 47768
[17:27:04.275] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[17:27:04.275] INFO: number of Vcal hits detected: 207784 207883 207797 207512 207586 207597 207583 207652 207766 207717 207657 207798 207777 207836 207952 207935
[17:27:04.275] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.8 99.9 99.9 99.9 100.0 100.0
[17:27:04.275] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.9 99.9 99.8 99.9 99.9 99.9 100.0 100.0
[17:27:04.275] INFO: X-ray hit rate [MHz/cm2]: 39.8 25.3 38.6 61.8 65.0 67.3 68.2 49.5 49.6 55.5 54.4 44.7 47.9 28.3 12.8 14.0
[17:27:04.275] INFO: PixTestHighRate::doXPixelAlive() done
[17:27:04.324] INFO: PixTest:: pg_setup set to default.
[17:27:04.335] INFO: enter test to run
[17:27:17.911] INFO: test: HighRate no parameter change
[17:27:17.912] INFO: running: highrate
[17:27:17.913] INFO: ----------------------------------------------------------------------
[17:27:17.913] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[17:27:17.913] INFO: ----------------------------------------------------------------------
[17:27:18.529] INFO: Expecting 208000 events.
[17:27:33.705] INFO: 208000 events read in total (14649ms).
[17:27:33.712] INFO: Test took 15788ms.
[17:27:34.138] INFO: Fetched DAQ statistics. Counters are being reset now.
[17:27:34.480] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[17:27:34.480] INFO: number of red-efficiency pixels: 390 256 451 1041 811 810 914 690 478 602 799 417 419 321 89 87
[17:27:34.480] INFO: number of X-ray hits detected: 203465 128489 196495 314214 332288 342720 348506 254262 254019 283340 276843 228638 243853 144791 65197 71750
[17:27:34.480] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[17:27:34.480] INFO: number of Vcal hits detected: 207554 207721 207467 206729 207028 207039 206889 207142 207481 207308 207070 207547 207551 207633 207907 207910
[17:27:34.480] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.8 99.4 99.6 99.6 99.5 99.6 99.8 99.7 99.6 99.8 99.8 99.8 100.0 100.0
[17:27:34.480] INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.7 99.4 99.5 99.5 99.5 99.6 99.8 99.7 99.6 99.8 99.8 99.8 100.0 100.0
[17:27:34.480] INFO: X-ray hit rate [MHz/cm2]: 59.6 37.7 57.6 92.1 97.4 100.5 102.1 74.5 74.5 83.0 81.1 67.0 71.5 42.4 19.1 21.0
[17:27:34.480] INFO: PixTestHighRate::doXPixelAlive() done
[17:27:34.529] INFO: PixTest:: pg_setup set to default.
[17:27:34.541] INFO: enter test to run
[17:27:40.279] INFO: test: exit no parameter change
[17:27:40.743] QUIET: Connection to board 32 closed.
[17:27:40.759] INFO: pXar: this is the end, my friend