[14:16:31.576] INFO: *** Welcome to pxar ***
[14:16:31.576] INFO: *** Today: 2016/07/26
[14:16:31.596] INFO: *** Version: v1.9.0-818-g96727
[14:16:31.596] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//dacParameters35_C15.dat
[14:16:31.596] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//tbmParameters_C0b.dat
[14:16:31.597] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//defaultMaskFile.dat
[14:16:31.597] INFO: MASKED Roc 0 col/row: 1 1
[14:16:31.597] INFO: MASKED Roc 0 col/row: 1 2
[14:16:31.597] INFO: MASKED Roc 0 col/row: 1 3
[14:16:31.597] INFO: MASKED Roc 0 col/row: 2 2
[14:16:31.597] INFO: MASKED Roc 0 col/row: 2 13
[14:16:31.597] INFO: MASKED Roc 0 col/row: 3 36
[14:16:31.597] INFO: MASKED Roc 0 col/row: 9 24
[14:16:31.597] INFO: MASKED Roc 0 col/row: 10 34
[14:16:31.597] INFO: MASKED Roc 0 col/row: 33 17
[14:16:31.597] INFO: MASKED Roc 1 col/row: 3 15
[14:16:31.597] INFO: MASKED Roc 1 col/row: 4 26
[14:16:31.597] INFO: MASKED Roc 2 col/row: 40 43
[14:16:31.597] INFO: MASKED Roc 2 col/row: 40 51
[14:16:31.597] INFO: MASKED Roc 3 col/row: 7 19
[14:16:31.597] INFO: MASKED Roc 3 col/row: 7 20
[14:16:31.597] INFO: MASKED Roc 3 col/row: 28 55
[14:16:31.597] INFO: MASKED Roc 4 col/row: 26 36
[14:16:31.597] INFO: MASKED Roc 5 col/row: 2 17
[14:16:31.597] INFO: MASKED Roc 5 col/row: 3 49
[14:16:31.597] INFO: MASKED Roc 5 col/row: 6 49
[14:16:31.597] INFO: MASKED Roc 5 col/row: 6 53
[14:16:31.597] INFO: MASKED Roc 5 col/row: 20 57
[14:16:31.597] INFO: MASKED Roc 6 col/row: 11 61
[14:16:31.597] INFO: MASKED Roc 6 col/row: 29 51
[14:16:31.597] INFO: MASKED Roc 6 col/row: 38 55
[14:16:31.597] INFO: MASKED Roc 6 col/row: 50 53
[14:16:31.597] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C15.dat
[14:16:31.597] INFO: masking Roc 0 col/row: 1 1
[14:16:31.597] INFO: masking Roc 0 col/row: 1 2
[14:16:31.597] INFO: masking Roc 0 col/row: 1 3
[14:16:31.597] INFO: masking Roc 0 col/row: 2 2
[14:16:31.597] INFO: masking Roc 0 col/row: 2 13
[14:16:31.597] INFO: masking Roc 0 col/row: 3 36
[14:16:31.597] INFO: masking Roc 0 col/row: 9 24
[14:16:31.597] INFO: masking Roc 0 col/row: 10 34
[14:16:31.597] INFO: masking Roc 0 col/row: 33 17
[14:16:31.602] INFO: masking Roc 1 col/row: 3 15
[14:16:31.602] INFO: masking Roc 1 col/row: 4 26
[14:16:31.606] INFO: masking Roc 2 col/row: 40 43
[14:16:31.606] INFO: masking Roc 2 col/row: 40 51
[14:16:31.611] INFO: masking Roc 3 col/row: 7 19
[14:16:31.611] INFO: masking Roc 3 col/row: 7 20
[14:16:31.611] INFO: masking Roc 3 col/row: 28 55
[14:16:31.615] INFO: masking Roc 4 col/row: 26 36
[14:16:31.620] INFO: masking Roc 5 col/row: 2 17
[14:16:31.620] INFO: masking Roc 5 col/row: 3 49
[14:16:31.620] INFO: masking Roc 5 col/row: 6 49
[14:16:31.620] INFO: masking Roc 5 col/row: 6 53
[14:16:31.620] INFO: masking Roc 5 col/row: 20 57
[14:16:31.625] INFO: masking Roc 6 col/row: 11 61
[14:16:31.625] INFO: masking Roc 6 col/row: 29 51
[14:16:31.625] INFO: masking Roc 6 col/row: 38 55
[14:16:31.625] INFO: masking Roc 6 col/row: 50 53
[14:16:31.668] INFO: clk: 4
[14:16:31.668] INFO: ctr: 4
[14:16:31.668] INFO: sda: 19
[14:16:31.669] INFO: tin: 9
[14:16:31.669] INFO: level: 15
[14:16:31.669] INFO: triggerdelay: 0
[14:16:31.669] QUIET: Instanciating API for pxar v1.9.0+814~g74979a6
[14:16:31.669] INFO: Log level: INFO
[14:16:31.684] QUIET: Connection to board DTB_WREKRL opened.
[14:16:31.688] 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:16:31.690] INFO: RPC call hashes of host and DTB match: 398089610
[14:16:33.223] INFO: DUT info:
[14:16:33.223] INFO: The DUT currently contains the following objects:
[14:16:33.223] INFO: 2 TBM Cores tbm08c (2 ON)
[14:16:33.223] INFO: TBM Core alpha (0): 7 registers set
[14:16:33.223] INFO: TBM Core beta (1): 7 registers set
[14:16:33.223] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:16:33.223] INFO: ROC 0: 19 DACs set, Pixels: 9 masked, 0 active.
[14:16:33.223] INFO: ROC 1: 19 DACs set, Pixels: 2 masked, 0 active.
[14:16:33.223] INFO: ROC 2: 19 DACs set, Pixels: 2 masked, 0 active.
[14:16:33.223] INFO: ROC 3: 19 DACs set, Pixels: 3 masked, 0 active.
[14:16:33.223] INFO: ROC 4: 19 DACs set, Pixels: 1 masked, 0 active.
[14:16:33.223] INFO: ROC 5: 19 DACs set, Pixels: 5 masked, 0 active.
[14:16:33.223] INFO: ROC 6: 19 DACs set, Pixels: 4 masked, 0 active.
[14:16:33.223] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.223] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.224] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.224] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.224] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.224] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.224] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.224] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.224] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:16:33.627] INFO: enter 'restricted' command line mode
[14:16:33.627] INFO: enter test to run
[14:17:19.000] INFO: test: PixelAlive no parameter change
[14:17:19.000] INFO: running: pixelalive
[14:17:20.009] INFO: ----------------------------------------------------------------------
[14:17:20.009] 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:17:20.009] INFO: ----------------------------------------------------------------------
[14:17:20.012] INFO: ROC 0 masking pixel 1/1
[14:17:20.012] INFO: ROC 0 masking pixel 1/2
[14:17:20.012] INFO: ROC 0 masking pixel 1/3
[14:17:20.012] INFO: ROC 0 masking pixel 2/2
[14:17:20.012] INFO: ROC 0 masking pixel 2/13
[14:17:20.012] INFO: ROC 0 masking pixel 3/36
[14:17:20.012] INFO: ROC 0 masking pixel 9/24
[14:17:20.012] INFO: ROC 0 masking pixel 10/34
[14:17:20.012] INFO: ROC 0 masking pixel 33/17
[14:17:20.012] INFO: ROC 1 masking pixel 3/15
[14:17:20.012] INFO: ROC 1 masking pixel 4/26
[14:17:20.012] INFO: ROC 2 masking pixel 40/43
[14:17:20.012] INFO: ROC 2 masking pixel 40/51
[14:17:20.012] INFO: ROC 3 masking pixel 7/19
[14:17:20.012] INFO: ROC 3 masking pixel 7/20
[14:17:20.012] INFO: ROC 3 masking pixel 28/55
[14:17:20.012] INFO: ROC 4 masking pixel 26/36
[14:17:20.012] INFO: ROC 5 masking pixel 2/17
[14:17:20.012] INFO: ROC 5 masking pixel 3/49
[14:17:20.012] INFO: ROC 5 masking pixel 6/49
[14:17:20.012] INFO: ROC 5 masking pixel 6/53
[14:17:20.012] INFO: ROC 5 masking pixel 20/57
[14:17:20.012] INFO: ROC 6 masking pixel 11/61
[14:17:20.012] INFO: ROC 6 masking pixel 29/51
[14:17:20.012] INFO: ROC 6 masking pixel 38/55
[14:17:20.012] INFO: ROC 6 masking pixel 50/53
[14:17:20.338] INFO: Expecting 41600 events.
[14:17:24.700] INFO: 41600 events read in total (3644ms).
[14:17:24.868] INFO: Test took 4856ms.
[14:17:24.882] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:17:25.152] INFO: PixTestAlive::aliveTest() done
[14:17:25.152] INFO: number of dead pixels (per ROC): 9 2 2 3 1 5 4 0 0 0 0 0 0 1 0 0
[14:17:25.152] INFO: ROC 0 masking pixel 1/1
[14:17:25.152] INFO: ROC 0 masking pixel 1/2
[14:17:25.152] INFO: ROC 0 masking pixel 1/3
[14:17:25.152] INFO: ROC 0 masking pixel 2/2
[14:17:25.152] INFO: ROC 0 masking pixel 2/13
[14:17:25.153] INFO: ROC 0 masking pixel 3/36
[14:17:25.153] INFO: ROC 0 masking pixel 9/24
[14:17:25.153] INFO: ROC 0 masking pixel 10/34
[14:17:25.153] INFO: ROC 0 masking pixel 33/17
[14:17:25.153] INFO: ROC 1 masking pixel 3/15
[14:17:25.153] INFO: ROC 1 masking pixel 4/26
[14:17:25.153] INFO: ROC 2 masking pixel 40/43
[14:17:25.153] INFO: ROC 2 masking pixel 40/51
[14:17:25.153] INFO: ROC 3 masking pixel 7/19
[14:17:25.153] INFO: ROC 3 masking pixel 7/20
[14:17:25.153] INFO: ROC 3 masking pixel 28/55
[14:17:25.153] INFO: ROC 4 masking pixel 26/36
[14:17:25.153] INFO: ROC 5 masking pixel 2/17
[14:17:25.153] INFO: ROC 5 masking pixel 3/49
[14:17:25.153] INFO: ROC 5 masking pixel 6/49
[14:17:25.153] INFO: ROC 5 masking pixel 6/53
[14:17:25.153] INFO: ROC 5 masking pixel 20/57
[14:17:25.153] INFO: ROC 6 masking pixel 11/61
[14:17:25.153] INFO: ROC 6 masking pixel 29/51
[14:17:25.153] INFO: ROC 6 masking pixel 38/55
[14:17:25.153] INFO: ROC 6 masking pixel 50/53
[14:17:25.186] INFO: enter test to run
[14:18:42.543] INFO: test: timing no parameter change
[14:18:42.543] INFO: running: timing
[14:18:42.547] INFO: ######################################################################
[14:18:42.547] INFO: PixTestTiming::doTest()
[14:18:42.547] INFO: ######################################################################
[14:18:42.547] INFO: ----------------------------------------------------------------------
[14:18:42.547] INFO: PixTestTiming::TBMPhaseScan()
[14:18:42.547] INFO: ----------------------------------------------------------------------
[14:24:32.853] INFO: TBM Phase Settings: 200
[14:24:32.853] INFO: 400MHz Phase: 2
[14:24:32.853] INFO: 160MHz Phase: 6
[14:24:32.853] INFO: Functional Phase Area: 3
[14:24:32.856] INFO: Test took 350309 ms.
[14:24:32.856] INFO: PixTestTiming::TBMPhaseScan() done.
[14:24:32.856] INFO: ROC 0 masking pixel 1/1
[14:24:32.856] INFO: ROC 0 masking pixel 1/2
[14:24:32.856] INFO: ROC 0 masking pixel 1/3
[14:24:32.856] INFO: ROC 0 masking pixel 2/2
[14:24:32.856] INFO: ROC 0 masking pixel 2/13
[14:24:32.856] INFO: ROC 0 masking pixel 3/36
[14:24:32.856] INFO: ROC 0 masking pixel 9/24
[14:24:32.856] INFO: ROC 0 masking pixel 10/34
[14:24:32.856] INFO: ROC 0 masking pixel 33/17
[14:24:32.856] INFO: ROC 1 masking pixel 3/15
[14:24:32.856] INFO: ROC 1 masking pixel 4/26
[14:24:32.856] INFO: ROC 2 masking pixel 40/43
[14:24:32.856] INFO: ROC 2 masking pixel 40/51
[14:24:32.856] INFO: ROC 3 masking pixel 7/19
[14:24:32.857] INFO: ROC 3 masking pixel 7/20
[14:24:32.857] INFO: ROC 3 masking pixel 28/55
[14:24:32.857] INFO: ROC 4 masking pixel 26/36
[14:24:32.857] INFO: ROC 5 masking pixel 2/17
[14:24:32.857] INFO: ROC 5 masking pixel 3/49
[14:24:32.857] INFO: ROC 5 masking pixel 6/49
[14:24:32.857] INFO: ROC 5 masking pixel 6/53
[14:24:32.857] INFO: ROC 5 masking pixel 20/57
[14:24:32.857] INFO: ROC 6 masking pixel 11/61
[14:24:32.857] INFO: ROC 6 masking pixel 29/51
[14:24:32.857] INFO: ROC 6 masking pixel 38/55
[14:24:32.857] INFO: ROC 6 masking pixel 50/53
[14:24:32.857] INFO: ----------------------------------------------------------------------
[14:24:32.857] INFO: PixTestTiming::ROCDelayScan()
[14:24:32.857] INFO: ----------------------------------------------------------------------
[14:26:28.548] INFO: ROC Delay Settings: 219
[14:26:28.548] INFO: ROC Header-Trailer/Token Delay: 11
[14:26:28.548] INFO: ROC Port 0 Delay: 3
[14:26:28.548] INFO: ROC Port 1 Delay: 3
[14:26:28.548] INFO: Functional ROC Area: 4
[14:26:28.551] INFO: Test took 115694 ms.
[14:26:28.551] INFO: PixTestTiming::ROCDelayScan() done.
[14:26:28.551] INFO: ROC 0 masking pixel 1/1
[14:26:28.551] INFO: ROC 0 masking pixel 1/2
[14:26:28.551] INFO: ROC 0 masking pixel 1/3
[14:26:28.551] INFO: ROC 0 masking pixel 2/2
[14:26:28.551] INFO: ROC 0 masking pixel 2/13
[14:26:28.551] INFO: ROC 0 masking pixel 3/36
[14:26:28.551] INFO: ROC 0 masking pixel 9/24
[14:26:28.551] INFO: ROC 0 masking pixel 10/34
[14:26:28.551] INFO: ROC 0 masking pixel 33/17
[14:26:28.551] INFO: ROC 1 masking pixel 3/15
[14:26:28.551] INFO: ROC 1 masking pixel 4/26
[14:26:28.551] INFO: ROC 2 masking pixel 40/43
[14:26:28.551] INFO: ROC 2 masking pixel 40/51
[14:26:28.551] INFO: ROC 3 masking pixel 7/19
[14:26:28.551] INFO: ROC 3 masking pixel 7/20
[14:26:28.551] INFO: ROC 3 masking pixel 28/55
[14:26:28.552] INFO: ROC 4 masking pixel 26/36
[14:26:28.552] INFO: ROC 5 masking pixel 2/17
[14:26:28.552] INFO: ROC 5 masking pixel 3/49
[14:26:28.552] INFO: ROC 5 masking pixel 6/49
[14:26:28.552] INFO: ROC 5 masking pixel 6/53
[14:26:28.552] INFO: ROC 5 masking pixel 20/57
[14:26:28.552] INFO: ROC 6 masking pixel 11/61
[14:26:28.552] INFO: ROC 6 masking pixel 29/51
[14:26:28.552] INFO: ROC 6 masking pixel 38/55
[14:26:28.552] INFO: ROC 6 masking pixel 50/53
[14:26:28.552] INFO: ----------------------------------------------------------------------
[14:26:28.552] INFO: PixTestTiming::TimingTest()
[14:26:28.552] INFO: ----------------------------------------------------------------------
[14:26:44.687] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:26:59.638] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:27:14.912] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:27:29.971] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:27:45.224] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:28:00.198] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:28:15.439] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:28:30.538] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:28:45.762] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:29:00.692] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:29:01.073] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:29:01.092] INFO: ----------------------------------------------------------------------
[14:29:01.092] INFO: The fraction of properly decoded events is 100.00%: 10000000/10000000
[14:29:01.092] INFO: ----------------------------------------------------------------------
[14:29:01.092] INFO: ----------------------------------------------------------------------
[14:29:01.092] INFO: Read back bit status: 1
[14:29:01.092] INFO: ----------------------------------------------------------------------
[14:29:01.092] INFO: ----------------------------------------------------------------------
[14:29:01.092] INFO: Timings are good!
[14:29:01.092] INFO: ----------------------------------------------------------------------
[14:29:01.092] INFO: Test took 152540 ms.
[14:29:01.092] INFO: PixTestTiming::TimingTest() done.
[14:29:01.092] INFO: ROC 0 masking pixel 1/1
[14:29:01.092] INFO: ROC 0 masking pixel 1/2
[14:29:01.092] INFO: ROC 0 masking pixel 1/3
[14:29:01.092] INFO: ROC 0 masking pixel 2/2
[14:29:01.092] INFO: ROC 0 masking pixel 2/13
[14:29:01.092] INFO: ROC 0 masking pixel 3/36
[14:29:01.092] INFO: ROC 0 masking pixel 9/24
[14:29:01.092] INFO: ROC 0 masking pixel 10/34
[14:29:01.092] INFO: ROC 0 masking pixel 33/17
[14:29:01.092] INFO: ROC 1 masking pixel 3/15
[14:29:01.092] INFO: ROC 1 masking pixel 4/26
[14:29:01.092] INFO: ROC 2 masking pixel 40/43
[14:29:01.092] INFO: ROC 2 masking pixel 40/51
[14:29:01.092] INFO: ROC 3 masking pixel 7/19
[14:29:01.092] INFO: ROC 3 masking pixel 7/20
[14:29:01.092] INFO: ROC 3 masking pixel 28/55
[14:29:01.092] INFO: ROC 4 masking pixel 26/36
[14:29:01.092] INFO: ROC 5 masking pixel 2/17
[14:29:01.092] INFO: ROC 5 masking pixel 3/49
[14:29:01.092] INFO: ROC 5 masking pixel 6/49
[14:29:01.092] INFO: ROC 5 masking pixel 6/53
[14:29:01.092] INFO: ROC 5 masking pixel 20/57
[14:29:01.092] INFO: ROC 6 masking pixel 11/61
[14:29:01.092] INFO: ROC 6 masking pixel 29/51
[14:29:01.092] INFO: ROC 6 masking pixel 38/55
[14:29:01.092] INFO: ROC 6 masking pixel 50/53
[14:29:01.092] INFO: write tbm parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//tbmParameters_C0a.dat
[14:29:01.092] INFO: write tbm parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//tbmParameters_C0b.dat
[14:29:01.092] INFO: PixTestTiming::doTest took 618548 ms.
[14:29:01.092] INFO: PixTestTiming::doTest() done
[14:29:01.093] INFO: ROC 0 masking pixel 1/1
[14:29:01.093] INFO: ROC 0 masking pixel 1/2
[14:29:01.093] INFO: ROC 0 masking pixel 1/3
[14:29:01.093] INFO: ROC 0 masking pixel 2/2
[14:29:01.093] INFO: ROC 0 masking pixel 2/13
[14:29:01.093] INFO: ROC 0 masking pixel 3/36
[14:29:01.093] INFO: ROC 0 masking pixel 9/24
[14:29:01.093] INFO: ROC 0 masking pixel 10/34
[14:29:01.093] INFO: ROC 0 masking pixel 33/17
[14:29:01.093] INFO: ROC 1 masking pixel 3/15
[14:29:01.093] INFO: ROC 1 masking pixel 4/26
[14:29:01.093] INFO: ROC 2 masking pixel 40/43
[14:29:01.093] INFO: ROC 2 masking pixel 40/51
[14:29:01.093] INFO: ROC 3 masking pixel 7/19
[14:29:01.093] INFO: ROC 3 masking pixel 7/20
[14:29:01.093] INFO: ROC 3 masking pixel 28/55
[14:29:01.093] INFO: ROC 4 masking pixel 26/36
[14:29:01.093] INFO: ROC 5 masking pixel 2/17
[14:29:01.093] INFO: ROC 5 masking pixel 3/49
[14:29:01.093] INFO: ROC 5 masking pixel 6/49
[14:29:01.093] INFO: ROC 5 masking pixel 6/53
[14:29:01.093] INFO: ROC 5 masking pixel 20/57
[14:29:01.093] INFO: ROC 6 masking pixel 11/61
[14:29:01.093] INFO: ROC 6 masking pixel 29/51
[14:29:01.093] INFO: ROC 6 masking pixel 38/55
[14:29:01.093] INFO: ROC 6 masking pixel 50/53
[14:29:01.093] INFO: Write out TBMPhaseScan_0_V0
[14:29:01.093] INFO: Write out TBMPhaseScan_1_V0
[14:29:01.093] INFO: Write out CombinedTBMPhaseScan_V0
[14:29:01.094] INFO: Write out ROCDelayScan3_V0
[14:29:01.095] INFO: enter test to run
[14:29:53.507] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[14:29:53.507] INFO: running: highrate
[14:29:53.508] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[14:29:53.671] INFO: ----------------------------------------------------------------------
[14:29:53.671] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[14:29:53.671] INFO: ----------------------------------------------------------------------
[14:29:53.671] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[14:29:53.671] INFO: edge/corner pixel THR is adjusted
[14:29:53.671] INFO: PixTestHighRate::trimHotPixels: step 0...
[14:29:54.628] INFO: Collecting data for 5 seconds...
[14:29:59.648] INFO: Done with hot pixel readout
[14:30:11.811] INFO: PixTest:: pg_setup set to default.
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.811] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:11.812] INFO: 22 hot pixels found in step 0
[14:30:12.807] INFO: Collecting data for 5 seconds...
[14:30:17.826] INFO: Done with hot pixel readout
[14:30:23.931] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[14:30:23.931] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:30:23.931] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f0 8040 43ca d3 2a2e 342 2a4d 6a1 284f 43ca 2cb 2a4d 43ca 43ca 43ca 688 2841 43ca 43c9 43ca e000 c000
[14:30:23.931] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ea 80c0 4388 4388 4388 4388 91 284c 4388 4388 4388 4388 e000 c000
[14:30:23.931] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1eb 8000 4388 154 2a42 4388 4388 4388 4388 2e0 2261 4388 4388 4388 e000 c000
[14:30:23.931] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ec 8040 4388 519 2268 4388 4388 4388 4388 4388 4388 4388 e000 c000
[14:30:23.931] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ed 80b1 4388 845 2244 4388 4388 699 2048 4388 4388 4a 2262 c9 284f 43c8 6a6 e000 c000
[14:30:23.931] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ee 80c0 43c8 43c8 88 2065 43c8 43c8 43c8 43c8 294 2a48 43c8 43c8 58 282c e000 c000
[14:30:23.931] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ef 8000 43c8 43c8 43c8 92 2a27 30a 224c 43c8 43c8 43c8 43ca 43c8 e000 c000
[14:30:30.265] INFO: PixTest:: pg_setup set to default.
[14:30:30.265] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.265] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.265] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.265] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.265] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.265] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.266] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.266] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.266] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.266] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.266] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:30.266] INFO: 22 hot pixels found in step 1
[14:30:31.261] INFO: Collecting data for 5 seconds...
[14:30:36.279] INFO: Done with hot pixel readout
[14:30:48.459] INFO: PixTest:: pg_setup set to default.
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.459] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:30:48.460] INFO: 22 hot pixels found in step 2
[14:30:49.456] INFO: Collecting data for 5 seconds...
[14:30:54.476] INFO: Done with hot pixel readout
[14:31:06.664] INFO: PixTest:: pg_setup set to default.
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.664] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:06.665] INFO: 18 hot pixels found in step 3
[14:31:07.660] INFO: Collecting data for 5 seconds...
[14:31:12.680] INFO: Done with hot pixel readout
[14:31:24.828] INFO: PixTest:: pg_setup set to default.
[14:31:24.828] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.828] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.828] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.828] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.828] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.828] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.828] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.829] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.829] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.829] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.829] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.829] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.829] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:24.829] INFO: 23 hot pixels found in step 4
[14:31:25.825] INFO: Collecting data for 5 seconds...
[14:31:30.843] INFO: Done with hot pixel readout
[14:31:42.876] INFO: PixTest:: pg_setup set to default.
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.876] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:31:42.877] INFO: 27 hot pixels found in step 5
[14:31:43.872] INFO: Collecting data for 5 seconds...
[14:31:48.888] INFO: Done with hot pixel readout
[14:32:00.907] INFO: PixTest:: pg_setup set to default.
[14:32:00.907] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.907] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.907] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.907] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.907] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.908] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.908] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.908] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.908] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:00.908] INFO: 16 hot pixels found in step 6
[14:32:01.903] INFO: Collecting data for 5 seconds...
[14:32:06.920] INFO: Done with hot pixel readout
[14:32:18.943] INFO: PixTest:: pg_setup set to default.
[14:32:18.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.944] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.944] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.944] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.944] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.944] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.944] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:18.944] INFO: 22 hot pixels found in step 7
[14:32:19.939] INFO: Collecting data for 5 seconds...
[14:32:24.956] INFO: Done with hot pixel readout
[14:32:36.000] INFO: PixTest:: pg_setup set to default.
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.000] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.001] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.001] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.001] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.001] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:36.001] INFO: 16 hot pixels found in step 8
[14:32:37.995] INFO: Collecting data for 5 seconds...
[14:32:43.013] INFO: Done with hot pixel readout
[14:32:55.018] INFO: PixTest:: pg_setup set to default.
[14:32:55.018] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.019] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:32:55.020] INFO: 26 hot pixels found in step 9
[14:32:56.014] INFO: Collecting data for 5 seconds...
[14:33:01.031] INFO: Done with hot pixel readout
[14:33:13.067] INFO: PixTest:: pg_setup set to default.
[14:33:13.067] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.067] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.067] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.067] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.067] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:13.068] INFO: 24 hot pixels found in step 10
[14:33:14.064] INFO: Collecting data for 5 seconds...
[14:33:19.081] INFO: Done with hot pixel readout
[14:33:31.111] INFO: PixTest:: pg_setup set to default.
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.111] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.112] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.112] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.112] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:31.112] INFO: 21 hot pixels found in step 11
[14:33:32.107] INFO: Collecting data for 5 seconds...
[14:33:37.124] INFO: Done with hot pixel readout
[14:33:49.157] INFO: PixTest:: pg_setup set to default.
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.157] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:33:49.158] INFO: 21 hot pixels found in step 12
[14:33:50.152] INFO: Collecting data for 5 seconds...
[14:33:55.170] INFO: Done with hot pixel readout
[14:34:07.232] INFO: PixTest:: pg_setup set to default.
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.232] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:07.233] INFO: 20 hot pixels found in step 13
[14:34:08.228] INFO: Collecting data for 5 seconds...
[14:34:13.246] INFO: Done with hot pixel readout
[14:34:25.281] INFO: PixTest:: pg_setup set to default.
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.281] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.282] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:34:25.282] INFO: 23 hot pixels found in step 14
[14:34:25.321] INFO: 23 hot pixels could not be trimmed and have been masked.
[14:34:25.324] INFO: PixTest::trimHotPixels() done
[14:34:25.324] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C0.dat
[14:34:25.330] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C1.dat
[14:34:25.336] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C2.dat
[14:34:25.341] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C3.dat
[14:34:25.346] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C4.dat
[14:34:25.351] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C5.dat
[14:34:25.356] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C6.dat
[14:34:25.362] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C7.dat
[14:34:25.367] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C8.dat
[14:34:25.372] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C9.dat
[14:34:25.377] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C10.dat
[14:34:25.383] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C11.dat
[14:34:25.388] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C12.dat
[14:34:25.393] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C13.dat
[14:34:25.398] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C14.dat
[14:34:25.404] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C15.dat
[14:34:25.409] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//defaultMaskFile.dat
[14:34:25.427] INFO: enter test to run
[14:35:03.025] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[14:35:03.025] INFO: running: highrate
[14:35:03.029] INFO: ----------------------------------------------------------------------
[14:35:03.029] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[14:35:03.030] INFO: ----------------------------------------------------------------------
[14:35:03.030] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[14:35:03.030] INFO: edge/corner pixel THR is adjusted
[14:35:03.030] INFO: PixTestHighRate::trimHotPixels: step 0...
[14:35:03.987] INFO: Collecting data for 1 seconds...
[14:35:04.991] INFO: Done with hot pixel readout
[14:35:09.077] INFO: PixTest:: pg_setup set to default.
[14:35:09.078] INFO: 0 hot pixels found in step 0
[14:35:09.083] INFO: 0 hot pixels could not be trimmed and have been masked.
[14:35:09.168] INFO: PixTest::trimHotPixels() done
[14:35:09.169] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C0.dat
[14:35:09.182] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C1.dat
[14:35:09.187] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C2.dat
[14:35:09.193] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C3.dat
[14:35:09.199] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C4.dat
[14:35:09.204] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C5.dat
[14:35:09.210] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C6.dat
[14:35:09.215] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C7.dat
[14:35:09.220] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C8.dat
[14:35:09.225] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C9.dat
[14:35:09.232] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C10.dat
[14:35:09.237] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C11.dat
[14:35:09.242] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C12.dat
[14:35:09.247] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C13.dat
[14:35:09.253] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C14.dat
[14:35:09.258] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//trimParameters35_C15.dat
[14:35:09.264] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-P-2-35_FPIXTest-17C-FNAL-160615-1339_2016-06-15_13h39m_1466015983/000_FPIXTest_p17//defaultMaskFile.dat
[14:35:09.274] INFO: enter test to run
[14:36:00.008] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[14:36:00.008] INFO: running: xray
[14:36:00.018] INFO: ----------------------------------------------------------------------
[14:36:00.018] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[14:36:00.018] INFO: ----------------------------------------------------------------------
[14:36:00.022] INFO: ROC 0 masking hot pixel 1/1
[14:36:00.022] INFO: ROC 0 masking hot pixel 1/2
[14:36:00.022] INFO: ROC 0 masking hot pixel 1/3
[14:36:00.022] INFO: ROC 0 masking hot pixel 2/2
[14:36:00.022] INFO: ROC 0 masking hot pixel 2/13
[14:36:00.022] INFO: ROC 0 masking hot pixel 3/36
[14:36:00.022] INFO: ROC 0 masking hot pixel 9/24
[14:36:00.022] INFO: ROC 0 masking hot pixel 10/34
[14:36:00.022] INFO: ROC 0 masking hot pixel 33/17
[14:36:00.022] INFO: ROC 1 masking hot pixel 3/15
[14:36:00.022] INFO: ROC 1 masking hot pixel 4/26
[14:36:00.022] INFO: ROC 2 masking hot pixel 40/43
[14:36:00.022] INFO: ROC 2 masking hot pixel 40/51
[14:36:00.022] INFO: ROC 3 masking hot pixel 7/19
[14:36:00.022] INFO: ROC 3 masking hot pixel 7/20
[14:36:00.022] INFO: ROC 3 masking hot pixel 28/55
[14:36:00.022] INFO: ROC 4 masking hot pixel 26/36
[14:36:00.022] INFO: ROC 5 masking hot pixel 2/17
[14:36:00.022] INFO: ROC 5 masking hot pixel 3/49
[14:36:00.022] INFO: ROC 5 masking hot pixel 6/49
[14:36:00.022] INFO: ROC 5 masking hot pixel 6/53
[14:36:00.022] INFO: ROC 5 masking hot pixel 20/57
[14:36:00.022] INFO: ROC 6 masking hot pixel 11/61
[14:36:00.022] INFO: ROC 6 masking hot pixel 29/51
[14:36:00.022] INFO: ROC 6 masking hot pixel 38/55
[14:36:00.022] INFO: ROC 6 masking hot pixel 50/53
[14:36:00.022] INFO: ROC 0 masking pixel 1/1
[14:36:00.022] INFO: ROC 0 masking pixel 1/2
[14:36:00.022] INFO: ROC 0 masking pixel 1/3
[14:36:00.022] INFO: ROC 0 masking pixel 2/2
[14:36:00.022] INFO: ROC 0 masking pixel 2/13
[14:36:00.022] INFO: ROC 0 masking pixel 3/36
[14:36:00.022] INFO: ROC 0 masking pixel 9/24
[14:36:00.022] INFO: ROC 0 masking pixel 10/34
[14:36:00.022] INFO: ROC 0 masking pixel 33/17
[14:36:00.022] INFO: ROC 1 masking pixel 3/15
[14:36:00.022] INFO: ROC 1 masking pixel 4/26
[14:36:00.022] INFO: ROC 2 masking pixel 40/43
[14:36:00.022] INFO: ROC 2 masking pixel 40/51
[14:36:00.022] INFO: ROC 3 masking pixel 7/19
[14:36:00.022] INFO: ROC 3 masking pixel 7/20
[14:36:00.022] INFO: ROC 3 masking pixel 28/55
[14:36:00.022] INFO: ROC 4 masking pixel 26/36
[14:36:00.022] INFO: ROC 5 masking pixel 2/17
[14:36:00.022] INFO: ROC 5 masking pixel 3/49
[14:36:00.022] INFO: ROC 5 masking pixel 6/49
[14:36:00.022] INFO: ROC 5 masking pixel 6/53
[14:36:00.022] INFO: ROC 5 masking pixel 20/57
[14:36:00.023] INFO: ROC 6 masking pixel 11/61
[14:36:00.023] INFO: ROC 6 masking pixel 29/51
[14:36:00.023] INFO: ROC 6 masking pixel 38/55
[14:36:00.023] INFO: ROC 6 masking pixel 50/53
[14:36:00.997] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[14:36:12.167] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[14:36:12.276] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[14:36:12.276] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e4 8000 43c8 43c8 43ca 43c8 658 2648 43c8 43c8 43c8 60d 2648 43ca 319 284f e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0de 80b1 4388 4388 4388 9c 2a2d 4388 4388 4d0 2040 4388 201 284b 4388 4388 e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0df 80c0 4388 4388 4388 4388 4388 4388 454 224d 4388 4388 e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e0 8000 4388 4388 1a 2a62 4388 4388 148 2844 155 2a4e 215 2865 4388 4388 4388 4388 24a 244a e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e1 8040 4388 4388 4388 4388 53c8 10c 2628 250 2f3f 43c8 18 2a4f 203 2848 43c8 43c8 e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e2 80b1 43c8 43c8 43c8 43c8 88 2446 43c8 43c8 43c8 43c8 142 282f e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e3 80c0 43c8 43c8 554 242f 43c8 2c9 2262 43c8 43c8 43c8 43c8 310 2a41 43c8 2a0 2265 e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e4 8040 43c8 43c9 24b 2646 43c8 553 284d 43c9 85c 2229 43c8 43c9 43c8 43c9 e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1de 80c0 4388 4388 4388 4388 51a 2a45 4388 554 2a46 4388 9c 2a49 4388 4388 e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1df 8000 4388 4388 4388 4388 4388 4388 438a 4388 e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e0 8040 438a 44b 204c 438a 89 2449 438a 438a 438a 438a 4389 60c 222f 438a e000 c000
[14:36:12.276] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e1 80b1 4389 4389 4389 4389 53c9 43c9 db 286a 80 e000 c000
[14:36:12.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e2 80c0 43c8 11 2868 43c8 114 2840 43c8 43c8 358 2646 43c9 548 2628 43c9 43c9 43c9 e000 c000
[14:36:12.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e3 8000 43c8 43c8 43c9 21 2461 43c9 43c8 491 2046 43c8 43c8 45b 2a4f 43c9 e000 c000
[14:36:41.646] INFO: Resuming triggers.
[14:36:52.818] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[14:37:22.259] INFO: Resuming triggers.
[14:37:33.424] INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[14:38:02.892] INFO: Resuming triggers.
[14:38:14.057] INFO: run duration 44 seconds, buffer almost full (81%), pausing triggers.
[14:38:43.469] INFO: Resuming triggers.
[14:38:54.633] INFO: run duration 55 seconds, buffer almost full (81%), pausing triggers.
[14:39:24.149] INFO: Resuming triggers.
[14:39:35.313] INFO: run duration 66 seconds, buffer almost full (81%), pausing triggers.
[14:40:04.851] INFO: Resuming triggers.
[14:40:16.021] INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[14:40:45.695] INFO: Resuming triggers.
[14:40:56.860] INFO: run duration 89 seconds, buffer almost full (81%), pausing triggers.
[14:41:26.394] INFO: Resuming triggers.
[14:41:37.430] INFO: data taking finished, elapsed time: 100 seconds.
[14:42:07.634] INFO: PixTest:: pg_setup set to default.
[14:42:07.637] INFO: PixTestXray::doPhRun() done
[14:42:07.777] INFO: enter test to run
[14:43:10.301] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[14:43:10.302] INFO: running: xray
[14:43:10.303] INFO: ----------------------------------------------------------------------
[14:43:10.303] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[14:43:10.303] INFO: ----------------------------------------------------------------------
[14:43:10.314] INFO: ROC 0 masking hot pixel 1/1
[14:43:10.314] INFO: ROC 0 masking hot pixel 1/2
[14:43:10.314] INFO: ROC 0 masking hot pixel 1/3
[14:43:10.314] INFO: ROC 0 masking hot pixel 2/2
[14:43:10.314] INFO: ROC 0 masking hot pixel 2/13
[14:43:10.314] INFO: ROC 0 masking hot pixel 3/36
[14:43:10.314] INFO: ROC 0 masking hot pixel 9/24
[14:43:10.314] INFO: ROC 0 masking hot pixel 10/34
[14:43:10.314] INFO: ROC 0 masking hot pixel 33/17
[14:43:10.314] INFO: ROC 1 masking hot pixel 3/15
[14:43:10.314] INFO: ROC 1 masking hot pixel 4/26
[14:43:10.315] INFO: ROC 2 masking hot pixel 40/43
[14:43:10.315] INFO: ROC 2 masking hot pixel 40/51
[14:43:10.315] INFO: ROC 3 masking hot pixel 7/19
[14:43:10.315] INFO: ROC 3 masking hot pixel 7/20
[14:43:10.315] INFO: ROC 3 masking hot pixel 28/55
[14:43:10.315] INFO: ROC 4 masking hot pixel 26/36
[14:43:10.315] INFO: ROC 5 masking hot pixel 2/17
[14:43:10.315] INFO: ROC 5 masking hot pixel 3/49
[14:43:10.315] INFO: ROC 5 masking hot pixel 6/49
[14:43:10.315] INFO: ROC 5 masking hot pixel 6/53
[14:43:10.315] INFO: ROC 5 masking hot pixel 20/57
[14:43:10.315] INFO: ROC 6 masking hot pixel 11/61
[14:43:10.315] INFO: ROC 6 masking hot pixel 29/51
[14:43:10.315] INFO: ROC 6 masking hot pixel 38/55
[14:43:10.315] INFO: ROC 6 masking hot pixel 50/53
[14:43:10.315] INFO: ROC 0 masking pixel 1/1
[14:43:10.315] INFO: ROC 0 masking pixel 1/2
[14:43:10.315] INFO: ROC 0 masking pixel 1/3
[14:43:10.315] INFO: ROC 0 masking pixel 2/2
[14:43:10.315] INFO: ROC 0 masking pixel 2/13
[14:43:10.315] INFO: ROC 0 masking pixel 3/36
[14:43:10.315] INFO: ROC 0 masking pixel 9/24
[14:43:10.315] INFO: ROC 0 masking pixel 10/34
[14:43:10.315] INFO: ROC 0 masking pixel 33/17
[14:43:10.315] INFO: ROC 1 masking pixel 3/15
[14:43:10.315] INFO: ROC 1 masking pixel 4/26
[14:43:10.315] INFO: ROC 2 masking pixel 40/43
[14:43:10.315] INFO: ROC 2 masking pixel 40/51
[14:43:10.315] INFO: ROC 3 masking pixel 7/19
[14:43:10.315] INFO: ROC 3 masking pixel 7/20
[14:43:10.315] INFO: ROC 3 masking pixel 28/55
[14:43:10.315] INFO: ROC 4 masking pixel 26/36
[14:43:10.315] INFO: ROC 5 masking pixel 2/17
[14:43:10.315] INFO: ROC 5 masking pixel 3/49
[14:43:10.315] INFO: ROC 5 masking pixel 6/49
[14:43:10.315] INFO: ROC 5 masking pixel 6/53
[14:43:10.315] INFO: ROC 5 masking pixel 20/57
[14:43:10.315] INFO: ROC 6 masking pixel 11/61
[14:43:10.315] INFO: ROC 6 masking pixel 29/51
[14:43:10.315] INFO: ROC 6 masking pixel 38/55
[14:43:10.315] INFO: ROC 6 masking pixel 50/53
[14:43:11.287] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[14:43:17.768] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[14:43:48.094] INFO: Resuming triggers.
[14:43:54.576] INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[14:44:06.586] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 6 ROCs were found
[14:44:06.586] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:44:06.586] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a135 80b1 4388 4388 513 2644 4388 262 244a 490 284e 80a 2642 4388 4388 4388 c 2648 4388 4388 e000 c000
[14:44:06.586] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a12f 8000 43c8 61d 2648 43c8 84c 2641 43c8 2cc 2842 410 2881 41a 2663 43c8 43c8 a 2046 65a 2245 43c8 dd 2062 614 266c 43ca 43c8 e000 c000
[14:44:06.586] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a130 8040 43ca 29a 2048 50b 284b 43ca 43ca 18 202d 2c0 2a69 43ca 43ca 1d 284f 15a 204a 149 2865 43ca 20b 266a 299 2063 43c9 43ca e000 c000
[14:44:06.586] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a131 80b1 43c9 48a 224a 43c9 43c9 43c9 d9 2841 43c9 43c9 c 222d 43c9 860 2443 43c9 15 2842 e000 c000
[14:44:06.586] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a132 80c0 43c8 43c8 15c 222f 74c 222e 43c8 289 204d 483 2a4e 43c8 490 204f 55d 2a46 613 2a2e 84b 2a49 43c9 4389 158 204e 7c0 2154 61 2000 7f 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff
[14:44:06.586] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a133 8000 4388 84c 2a2c 4388 4389 4389 a1 244f 689 244f 6c1 224c 4388 115 2242 2c8 204f 4388 84 2849 6db 2a66 4388 4389 e000 c000
[14:44:06.586] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a134 8040 4388 694 2660 4389 100 2842 20b 2642 2c8 204a 65b 2868 4388 6d5 2a41 4389 291 2463 44b 2a49 4d2 266c 4388 18 2862 4 2841 410 2663 4389 52 2262 c0 244c 4388 4389 283 2642 359 2a45 51b 2842 e000 c000
[14:44:14.165] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (7) != Token Chain Length (8)
[14:44:14.165] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 5 ROCs were found
[14:44:14.165] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:44:14.165] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04d 8040 43c8 4d1 204f 43c8 43c8 109 2061 812 2429 43c8 4c5 2645 43c8 20a 224f 445 204a 488 2246 850 2a49 43c8 14b 2042 48a 2842 715 2248 759 2848 43c8 840 2a25 43c8 4d4 2241 4d5 224f e000 c000
[14:44:14.165] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a047 80c0 4388 495 2647 4388 54 2827 4389 609 2240 840 2a69 849 2a8b 4388 58 2a64 2c4 2442 69a 284a 4389 4d8 280f 6d1 284f 4389 91 2045 4389 50c 2049 4389 2d0 2441 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a048 8000 4388 51c 2240 4388 151 286e 4388 65b 244a 4389 141 2a4f 449 2463 805 284c 4388 242 2849 511 2462 719 2663 719 2a42 740 262d 755 2a4f 4388 249 284f 34b 2666 413 206c 690 2845 4389 444 2245 4389 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a049 8040 4388 4389 4388 4389 54a 244f 4388 1a 2482 55 264f cc 2445 859 264a 4389 108 2a2d 4388 508 2045 4388 4db 246a 685 2042 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04a 80b1 4388 153 2a4a 4388 4388 61b 2042 84d 266c 4388 4388 1d 266c 4388 4388 13 3849 2d0 2a25 500 2707 e56 2b7c 7f7 2fd9 72e e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04b 80c0 43c8 9c 2a49 49c 262d 43c8 4e2 2028 43c8 62 2040 310 2849 43c8 2c1 264d 750 2042 43c8 843 222b 43c8 118 262f 290 2a4f 6d1 264f 43c8 309 2a6c 35a 2069 852 2440 845 284d 43c8 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04c 8000 43c8 758 2826 43c8 9c 2842 43c8 43c8 43c8 415 2262 443 2245 43c8 311 2262 65a 2462 850 2844 43c8 2cc 2442 405 2665 85b 264c 43c8 90 264e 108 202a 455 2649 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14d 80b1 43c8 43c8 612 2040 43c8 354 2845 810 2629 43c8 43c8 43c8 41d 244f 43c8 48d 284e 43c8 420 2848 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a147 8000 4388 4388 db 2a68 321 264e 75d 204f 4388 4388 4388 4388 93 206c 221 224e 4388 4388 61b 2849 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a148 8040 4388 4388 a 206c 451 2865 4388 10c 2244 50d 206a 4388 31d 2862 448 204f 4388 4388 4388 6d2 2846 4388 4dc 2025 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a149 80b1 4388 74c 2622 4388 48a 2249 68a 2040 4388 4388 d1 2a48 659 2869 4388 350 2242 4388 4388 4388 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a14a 80c0 4388 658 222e 4388 113 2465 2d0 2249 4388 75b 2241 4388 91 2642 310 242f 53c8 2 2a45 6aa 28a7 3 2fea 803 207f ff6 201c 0 21ff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14b 8000 43c8 43c8 43c8 409 2245 652 204c 6e2 222e 43c8 41b 246c 6d2 242c 43c8 208 204a 4d0 2042 509 246d 6d5 2048 43c8 35b 2884 43c8 43c8 e000 c000
[14:44:14.166] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14c 8040 43c8 43c8 43c8 51 2628 51d 244e 853 2a40 43c8 43c8 9a 2a68 21b 266d 43c8 43c8 43c8 80a 2042 e000 c000
[14:44:24.581] INFO: Resuming triggers.
[14:44:31.061] INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[14:44:31.423] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:44:31.423] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:44:31.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a012 80b1 43c8 94 2846 29a 2045 43c8 43c8 6cc 2044 43c8 20b 246b 43c8 158 2446 74d 2468 43c8 288 224d 43c8 43c8 13 224f 45c 244f 620 242e e000 c000
[14:44:31.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00c 8000 4388 144 2044 4388 4388 68a 2240 4388 42 2044 548 2a43 4388 85c 202f 84c 2a24 85a 2249 85a 262a 4388 91 284f 313 206b 84c 262f 4388 60c 244e 4388 92 2642 512 284f e000 c000
[14:44:31.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00d 8040 4388 75a 2240 4388 4388 50b 2a4e 4388 4388 4388 61d 284a 4388 1c 2440 59 2265 75b 2462 859 2061 4388 e000 c000
[14:44:31.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00e 80b1 4388 45c 2042 4388 5b 264f db 202a 343 2244 4388 4388 14b 2262 511 2865 4388 4388 40b 2a4f 4c9 2462 660 2060 80a 284a 4388 758 2446 4388 e000 c000
[14:44:31.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00f 80c0 4388 4388 152 2463 212 264f 4388 4388 4388 158 2840 353 2a8a 853 2a2f 4388 dc 2a49 2cc 2248 50d 262d 180c 284c 819 2656 38 22d9 24f 2481 262 2803 445 43c8 213 224d 35c 2a4e e000 c000
[14:44:31.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a010 8000 43c8 21 2861 43c8 43c8 549 2466 558 2246 43c8 43c8 6d4 2242 859 262f 43c8 149 2440 204 2242 703 2669 43c8 43c8 e000 c000
[14:44:31.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a011 8040 43c8 219 264f 43c8 415 2445 43c8 43c8 151 224e 43c8 10d 2625 45c 2049 43c8 213 264d 60b 264c 43c8 212 2a4d 2cc 2644 43c8 291 226c e000 c000
[14:45:01.051] INFO: Resuming triggers.
[14:45:07.534] INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[14:45:37.460] INFO: Resuming triggers.
[14:45:43.940] INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[14:46:13.898] INFO: Resuming triggers.
[14:46:20.375] INFO: run duration 38 seconds, buffer almost full (81%), pausing triggers.
[14:46:50.344] INFO: Resuming triggers.
[14:46:56.819] INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[14:47:26.761] INFO: Resuming triggers.
[14:47:33.235] INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[14:47:33.453] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:47:33.454] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 8 ROCs were found
[14:47:33.454] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b6 80b1 43c8 43c8 43c8 61b 2043 43c8 d 264c 24d 2844 43c8 43c8 4dd 224c 85a 2865 43c8 14c 2665 858 224a 43c9 e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b0 8000 4388 51d 204f 4388 4388 4388 35c 2a4e 4c8 242e 4388 360 2447 553 264a 4388 2d5 2a49 4388 85 2824 2da 2046 4388 4d 244f e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b1 8040 4388 21 2460 12 204f 4388 660 284f 4388 4c8 2a42 4d5 264a 845 244c 4388 159 2844 20c 2248 24b 226e 4388 4388 101 2644 4d0 2265 4388 a 2848 b 2662 4d1 2263 4388 e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b2 80b1 4388 4388 2d5 2242 414 2241 4388 4388 321 226a 504 2265 4388 13 2266 1b 2a8a 4388 75c 2242 4388 153 2465 550 2a2f 4388 98 2848 15a 2a81 e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b3 80c0 4388 4388 4a2 2aa9 4388 4388 98 264f 202 2482 43c8 55 344f 43c8 d6 2fff f0e e055 c00f
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b4 8000 43c8 859 244f 43c8 318 264c 43ca 43c8 289 2244 43c8 98 2662 685 2849 43c8 30c 2840 4a2 2867 43c8 40b 2462 41b 2a6e 850 2047 43ca 148 204e 31b 286f 685 2041 e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b5 8040 43ca 15 2864 158 2242 359 2864 499 2242 43ca 43c8 614 2a25 43ca 554 282a 43ca 452 2045 4db 2046 619 2a66 43ca 8b 2663 648 242f 43ca 10 2043 14b 2284 681 2661 43c8 2d3 2a4c e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b6 80c0 43c8 43c8 759 2644 43c8 43c8 14 202a 95 266f 6d0 242c 43c8 8a 2243 549 2261 43c8 43c8 75a 224f 43c8 19 282d e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b0 8040 438a 4ca 264c 438a 613 202a 809 264d 438a dd 2280 651 2a4a 438a 5 2a4d 438a 258 2041 438a 614 226c 4389 438a e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b1 80b1 4389 da 2a4e 31c 2a2a 4389 4389 35d 284f 4389 440 2a2e 610 264d 815 2847 4389 9 2265 69a 2a6b 4389 35a 2684 519 2068 4389 4389 e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b2 80c0 4388 2d8 264c 54c 2464 542 2042 4388 4388 155 2663 4388 302 2247 522 2846 621 2642 4389 6c5 2a4a 4389 54 2a48 4389 4389 e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a1b3 8000 4388 4388 2d1 284f 4389 4389 35b 2240 4388 559 222c 43c8 53c8 43c9 ae6 2a30 a7 2ffe 1f 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b4 8040 43c8 6cb 224f 43c9 4d1 2240 559 266f 43c8 d5 2049 115 2649 43c9 43c8 19 284f 93 2882 50a 226a 69d 224d 43c9 43c8 6c2 2242 43c9 e000 c000
[14:47:33.454] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b5 80b1 43c8 43c8 14d 2a45 258 2846 43c8 43c8 5a 2a47 43c8 43c8 43c8 522 244f 43c8 dd 264f e000 c000
[14:48:03.119] INFO: Resuming triggers.
[14:48:09.593] INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[14:48:39.534] INFO: Resuming triggers.
[14:48:46.011] INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[14:49:15.892] INFO: Resuming triggers.
[14:49:22.372] INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[14:49:22.692] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:49:22.692] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (5) != Token Chain Length (8)
[14:49:22.692] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00e 80b1 43c8 43c8 5d 264c 43c8 50a 284e 43c8 43c8 10 224f 10b 2642 84b 2248 43c8 484 2046 6d9 204e 43c8 9 264a 74c 2863 43c8 41c 284e 509 2a80 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a008 8000 4388 515 2468 4388 212 244c 4388 418 2261 4389 812 2a4a 4388 684 284c 684 2a47 713 286a 4388 359 2861 4389 c4 2864 6d8 2a45 4389 8d 204b 453 264a e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a009 8040 4388 35c 2a24 41c 2843 4389 4388 a1 2848 da 2864 4389 455 2240 4c5 204f 4388 4d1 242a 4389 694 2866 4388 6d3 2066 6cc 284c 4388 45a 286d e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00a 80b1 4388 15 204c 515 2a2e 4388 4388 4388 d8 2445 210 206f 4388 a 248f 153 226e 155 224a 4388 19 2889 19 2486 810 2a4d 4388 9c 2a4e 419 246f 4388 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00b 90c0 43c8 1358 2a3f 1059 25f0 70b 2f95 555 27c3 ddc 2295 7da 262c 43c8 6d8 2667 43c8 34c 2a64 410 2a46 48d 2064 71c 2441 43c8 104 204d 442 2669 4d3 2485 43c8 dd 2a6a 11a 2069 43c8 10a 2449 158 2061 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00c 8000 43c8 43c8 43c8 43c8 88 224e 41b 2882 43c8 2d2 2048 618 2061 840 2629 43c8 11c 264f 43c8 43c8 69c 2449 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00d 8040 43c8 43c8 43c8 43c8 512 2a4f 43c8 59 2a65 5b 2a6d 9c 2a4f 43c8 84 244f 30a 264f 315 2265 43c8 c9 2886 342 2644 643 2649 850 2a42 43c8 251 244d e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10e 80c0 43c8 43c8 c1 286c db 2a4f 20b 2262 43c8 162 2064 650 2442 43c8 43c8 43c8 24c 2448 43c8 43c8 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a108 8040 4388 695 2084 4388 54d 2a4d 4388 30b 2a65 4388 4388 c0 2649 41b 2083 4388 4388 71c 2244 4388 459 2468 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a109 80b1 4388 28a 2848 4388 8c 2044 720 2641 752 224a 4388 31b 2663 4388 9b 2249 649 2460 4388 59 2263 4388 9 2a43 340 2a68 4388 4388 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10a 80c0 4388 248 284a 4388 4388 11a 2849 4388 c3 2660 4388 4388 8a 224d 21a 264e 4388 4388 10c 2622 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10b 9000 43c8 14c4 242a 17be 2a65 8af 53c8 1070 257e cf8 21c0 600 2600 3c0 2098 43c8 209b 461 43c8 499 246c 43c8 61a 284c 43c8 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10c 8040 43c8 361 2062 804 222f 43c8 65a 2680 43c8 43c8 340 2648 43c8 21 226c 43c8 43c8 55a 2644 75c 2449 43c8 e000 c000
[14:49:22.692] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10d 80b1 43c8 4a2 2a4f 692 2a46 43c8 8 2440 141 2a41 15d 266d 315 204a 80a 2a62 43c8 c 2648 43c8 6d4 2640 43c8 41a 204b 43c8 43c8 701 2a66 43c8 e000 c000
[14:49:52.332] INFO: Resuming triggers.
[14:49:58.810] INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[14:50:28.685] INFO: Resuming triggers.
[14:50:35.162] INFO: run duration 83 seconds, buffer almost full (81%), pausing triggers.
[14:51:05.115] INFO: Resuming triggers.
[14:51:11.595] INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[14:51:42.590] INFO: Resuming triggers.
[14:51:49.074] INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[14:52:19.621] INFO: Resuming triggers.
[14:52:22.791] INFO: data taking finished, elapsed time: 100 seconds.
[14:52:23.250] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:52:23.250] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a008 8000 43c8 43c8 155 264f 43c8 a2 204c 48b 2267 55d 2468 55d 2667 755 2045 43c9 dd 2846 43c8 280 262a 70c 2446 43c8 310 2040 455 2862 43c9 85 2a41 658 2061 43c9 515 2a65 e000 c000
[14:52:23.250] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a002 80b1 4388 60 264c 4dc 2a4f 4388 4388 502 2a44 4388 20c 224e 4388 91 224d 313 2667 4388 74d 2440 749 204f 4388 359 284b 34d 266a 480 244f 4388 e000 c000
[14:52:23.250] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a003 80c0 4388 4388 4388 35b 24a5 4388 2 2262 11b 224d 24d 286a 4388 4388 410 2448 4c9 2662 60b 2864 4388 25a 2461 35b 2661 759 2041 4388 e000 c000
[14:52:23.250] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a004 8000 4388 4388 438a 84b 284f 850 2a4c 4388 362 286f 4388 4388 85b 2845 4388 689 264f 438a e000 c000
[14:52:23.250] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a005 8040 438a 14a 264f 438a 4388 60 2a24 51b 226a 438a 11d 2848 151 204f 659 2a66 438a 649 2448 438a 2db 2269 689 2a4f 438a 4388 f000 c000
[14:52:23.250] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a006 80b1 43c8 213 2a44 29b 2a65 31b 2642 43c8 43c8 4c9 2445 681 204f 43c8 49 2863 45 2286 210 248a 4c8 2240 43c8 54 284d 350 2441 519 246b 808 224b 43c8 400 2649 43c8 350 2a4f 43c9 51 224e 352 244c 40a 224d e000 c000
[14:52:23.250] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a007 80c0 43c8 43c8 43c9 649 2042 842 284c 43c8 21b 2865 81b 284c 43c9 15a 2464 205 2665 205 2a67 40c 2249 548 224a 618 284f 615 2066 6cc 282e 43c9 143 2265 611 2245 43c9 15 2446 15d 2469 482 224d 71d 2842 751 2a4d 43c9 e000 c000
[14:52:38.213] INFO: PixTest:: pg_setup set to default.
[14:52:38.216] INFO: PixTestXray::doPhRun() done
[14:52:38.369] INFO: enter test to run
[14:53:32.185] INFO: test: HighRate no parameter change
[14:53:32.185] INFO: running: highrate
[14:53:32.202] INFO: ----------------------------------------------------------------------
[14:53:32.202] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[14:53:32.202] INFO: ----------------------------------------------------------------------
[14:53:32.356] INFO: Expecting 768 events.
[14:53:33.489] INFO: 768 events read in total (418ms).
[14:53:33.490] INFO: Test took 1268ms.
[14:53:33.493] INFO: ROC 0 masking pixel 1/1
[14:53:33.493] INFO: ROC 0 masking pixel 1/2
[14:53:33.493] INFO: ROC 0 masking pixel 1/3
[14:53:33.493] INFO: ROC 0 masking pixel 2/2
[14:53:33.493] INFO: ROC 0 masking pixel 2/13
[14:53:33.493] INFO: ROC 0 masking pixel 3/36
[14:53:33.493] INFO: ROC 0 masking pixel 9/24
[14:53:33.493] INFO: ROC 0 masking pixel 10/34
[14:53:33.493] INFO: ROC 0 masking pixel 33/17
[14:53:33.493] INFO: ROC 1 masking pixel 3/15
[14:53:33.493] INFO: ROC 1 masking pixel 4/26
[14:53:33.493] INFO: ROC 2 masking pixel 40/43
[14:53:33.493] INFO: ROC 2 masking pixel 40/51
[14:53:33.494] INFO: ROC 3 masking pixel 7/19
[14:53:33.494] INFO: ROC 3 masking pixel 7/20
[14:53:33.494] INFO: ROC 3 masking pixel 28/55
[14:53:33.494] INFO: ROC 4 masking pixel 26/36
[14:53:33.494] INFO: ROC 5 masking pixel 2/17
[14:53:33.494] INFO: ROC 5 masking pixel 3/49
[14:53:33.494] INFO: ROC 5 masking pixel 6/49
[14:53:33.494] INFO: ROC 5 masking pixel 6/53
[14:53:33.494] INFO: ROC 5 masking pixel 20/57
[14:53:33.494] INFO: ROC 6 masking pixel 11/61
[14:53:33.494] INFO: ROC 6 masking pixel 29/51
[14:53:33.494] INFO: ROC 6 masking pixel 38/55
[14:53:33.494] INFO: ROC 6 masking pixel 50/53
[14:53:34.293] INFO: Expecting 41600 events.
[14:53:37.412] INFO: 41600 events read in total (2593ms).
[14:53:37.413] INFO: Test took 3917ms.
[14:53:37.450] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:38.166] INFO: Expecting 41600 events.
[14:53:41.544] INFO: 41600 events read in total (2851ms).
[14:53:41.545] INFO: Test took 4077ms.
[14:53:41.582] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:42.299] INFO: Expecting 41600 events.
[14:53:45.519] INFO: 41600 events read in total (2694ms).
[14:53:45.519] INFO: Test took 3919ms.
[14:53:45.556] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:46.273] INFO: Expecting 41600 events.
[14:53:49.563] INFO: 41600 events read in total (2763ms).
[14:53:49.564] INFO: Test took 3989ms.
[14:53:49.601] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:50.318] INFO: Expecting 41600 events.
[14:53:53.631] INFO: 41600 events read in total (2786ms).
[14:53:53.632] INFO: Test took 4013ms.
[14:53:53.669] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:54.388] INFO: Expecting 41600 events.
[14:53:57.628] INFO: 41600 events read in total (2713ms).
[14:53:57.629] INFO: Test took 3941ms.
[14:53:57.666] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:58.378] INFO: Expecting 41600 events.
[14:54:01.960] INFO: 41600 events read in total (3055ms).
[14:54:01.961] INFO: Test took 4277ms.
[14:54:01.999] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:02.717] INFO: Expecting 41600 events.
[14:54:06.021] INFO: 41600 events read in total (2778ms).
[14:54:06.023] INFO: Test took 4006ms.
[14:54:06.062] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:06.772] INFO: Expecting 41600 events.
[14:54:10.080] INFO: 41600 events read in total (2781ms).
[14:54:10.081] INFO: Test took 3998ms.
[14:54:10.118] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:10.834] INFO: Expecting 41600 events.
[14:54:14.127] INFO: 41600 events read in total (2767ms).
[14:54:14.128] INFO: Test took 3992ms.
[14:54:14.164] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:14.885] INFO: Expecting 41600 events.
[14:54:18.183] INFO: 41600 events read in total (2771ms).
[14:54:18.184] INFO: Test took 4001ms.
[14:54:18.221] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:18.938] INFO: Expecting 41600 events.
[14:54:22.224] INFO: 41600 events read in total (2759ms).
[14:54:22.225] INFO: Test took 3986ms.
[14:54:22.262] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:22.977] INFO: Expecting 41600 events.
[14:54:26.271] INFO: 41600 events read in total (2767ms).
[14:54:26.272] INFO: Test took 3992ms.
[14:54:26.309] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:27.025] INFO: Expecting 41600 events.
[14:54:30.287] INFO: 41600 events read in total (2735ms).
[14:54:30.288] INFO: Test took 3961ms.
[14:54:30.324] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:31.038] INFO: Expecting 41600 events.
[14:54:34.396] INFO: 41600 events read in total (2831ms).
[14:54:34.397] INFO: Test took 4054ms.
[14:54:34.434] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:35.153] INFO: Expecting 41600 events.
[14:54:38.451] INFO: 41600 events read in total (2771ms).
[14:54:38.452] INFO: Test took 4000ms.
[14:54:38.490] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:39.206] INFO: Expecting 41600 events.
[14:54:42.506] INFO: 41600 events read in total (2773ms).
[14:54:42.507] INFO: Test took 3999ms.
[14:54:42.543] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:43.260] INFO: Expecting 41600 events.
[14:54:46.550] INFO: 41600 events read in total (2764ms).
[14:54:46.551] INFO: Test took 3989ms.
[14:54:46.588] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:47.299] INFO: Expecting 41600 events.
[14:54:50.564] INFO: 41600 events read in total (2738ms).
[14:54:50.565] INFO: Test took 3959ms.
[14:54:50.612] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:51.299] INFO: Expecting 41600 events.
[14:54:54.492] INFO: 41600 events read in total (2667ms).
[14:54:54.493] INFO: Test took 3854ms.
[14:54:54.530] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:54:54.897] INFO: enter test to run
[14:55:31.376] INFO: test: HighRate no parameter change
[14:55:31.377] INFO: running: highrate
[14:55:31.378] INFO: ----------------------------------------------------------------------
[14:55:31.378] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:55:31.378] INFO: ----------------------------------------------------------------------
[14:55:31.386] INFO: ROC 0 masking pixel 1/1
[14:55:31.387] INFO: ROC 0 masking pixel 1/2
[14:55:31.387] INFO: ROC 0 masking pixel 1/3
[14:55:31.387] INFO: ROC 0 masking pixel 2/2
[14:55:31.387] INFO: ROC 0 masking pixel 2/13
[14:55:31.387] INFO: ROC 0 masking pixel 3/36
[14:55:31.387] INFO: ROC 0 masking pixel 9/24
[14:55:31.387] INFO: ROC 0 masking pixel 10/34
[14:55:31.387] INFO: ROC 0 masking pixel 33/17
[14:55:31.387] INFO: ROC 1 masking pixel 3/15
[14:55:31.387] INFO: ROC 1 masking pixel 4/26
[14:55:31.387] INFO: ROC 2 masking pixel 40/43
[14:55:31.387] INFO: ROC 2 masking pixel 40/51
[14:55:31.387] INFO: ROC 3 masking pixel 7/19
[14:55:31.387] INFO: ROC 3 masking pixel 7/20
[14:55:31.387] INFO: ROC 3 masking pixel 28/55
[14:55:31.387] INFO: ROC 4 masking pixel 26/36
[14:55:31.387] INFO: ROC 5 masking pixel 2/17
[14:55:31.387] INFO: ROC 5 masking pixel 3/49
[14:55:31.387] INFO: ROC 5 masking pixel 6/49
[14:55:31.387] INFO: ROC 5 masking pixel 6/53
[14:55:31.387] INFO: ROC 5 masking pixel 20/57
[14:55:31.387] INFO: ROC 6 masking pixel 11/61
[14:55:31.387] INFO: ROC 6 masking pixel 29/51
[14:55:31.387] INFO: ROC 6 masking pixel 38/55
[14:55:31.387] INFO: ROC 6 masking pixel 50/53
[14:55:31.997] INFO: Expecting 208000 events.
[14:55:43.004] INFO: 208000 events read in total (11480ms).
[14:55:44.008] INFO: Test took 12620ms.
[14:55:44.166] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:55:44.422] INFO: number of dead pixels (per ROC): 9 2 2 3 1 5 4 0 0 0 0 0 0 1 0 0
[14:55:44.422] INFO: number of red-efficiency pixels: 91 52 81 117 131 153 203 126 74 107 88 112 85 64 19 38
[14:55:44.422] INFO: number of X-ray hits detected: 68013 44637 72224 117571 125863 131803 132903 93270 83140 101726 99866 87102 89056 55458 23022 31105
[14:55:44.422] 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:55:44.423] INFO: number of Vcal hits detected: 207465 207848 207821 207734 207816 207597 207596 207851 207925 207890 207910 207883 207914 207884 207981 207962
[14:55:44.423] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 100.0 100.0 100.0 99.9 100.0 100.0 100.0 100.0
[14:55:44.423] INFO: Vcal hit overall efficiency (%): 99.7 99.9 99.9 99.9 99.9 99.8 99.8 99.9 100.0 99.9 100.0 99.9 100.0 99.9 100.0 100.0
[14:55:44.423] INFO: X-ray hit rate [MHz/cm2]: 19.9 13.1 21.2 34.5 36.9 38.6 39.0 27.3 24.4 29.8 29.3 25.5 26.1 16.3 6.7 9.1
[14:55:44.423] INFO: PixTestHighRate::doXPixelAlive() done
[14:55:44.475] INFO: PixTest:: pg_setup set to default.
[14:55:44.489] INFO: enter test to run
[14:56:08.008] INFO: test: HighRate no parameter change
[14:56:08.008] INFO: running: highrate
[14:56:08.009] INFO: ----------------------------------------------------------------------
[14:56:08.009] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:56:08.009] INFO: ----------------------------------------------------------------------
[14:56:08.020] INFO: ROC 0 masking pixel 1/1
[14:56:08.020] INFO: ROC 0 masking pixel 1/2
[14:56:08.020] INFO: ROC 0 masking pixel 1/3
[14:56:08.020] INFO: ROC 0 masking pixel 2/2
[14:56:08.020] INFO: ROC 0 masking pixel 2/13
[14:56:08.020] INFO: ROC 0 masking pixel 3/36
[14:56:08.020] INFO: ROC 0 masking pixel 9/24
[14:56:08.020] INFO: ROC 0 masking pixel 10/34
[14:56:08.020] INFO: ROC 0 masking pixel 33/17
[14:56:08.020] INFO: ROC 1 masking pixel 3/15
[14:56:08.020] INFO: ROC 1 masking pixel 4/26
[14:56:08.020] INFO: ROC 2 masking pixel 40/43
[14:56:08.020] INFO: ROC 2 masking pixel 40/51
[14:56:08.020] INFO: ROC 3 masking pixel 7/19
[14:56:08.020] INFO: ROC 3 masking pixel 7/20
[14:56:08.020] INFO: ROC 3 masking pixel 28/55
[14:56:08.020] INFO: ROC 4 masking pixel 26/36
[14:56:08.020] INFO: ROC 5 masking pixel 2/17
[14:56:08.020] INFO: ROC 5 masking pixel 3/49
[14:56:08.020] INFO: ROC 5 masking pixel 6/49
[14:56:08.020] INFO: ROC 5 masking pixel 6/53
[14:56:08.020] INFO: ROC 5 masking pixel 20/57
[14:56:08.020] INFO: ROC 6 masking pixel 11/61
[14:56:08.020] INFO: ROC 6 masking pixel 29/51
[14:56:08.020] INFO: ROC 6 masking pixel 38/55
[14:56:08.020] INFO: ROC 6 masking pixel 50/53
[14:56:08.625] INFO: Expecting 208000 events.
[14:56:22.507] INFO: 208000 events read in total (13355ms).
[14:56:22.512] INFO: Test took 14491ms.
[14:56:22.822] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:56:23.128] INFO: number of dead pixels (per ROC): 9 2 2 3 1 5 4 0 0 0 0 0 0 1 0 0
[14:56:23.128] INFO: number of red-efficiency pixels: 226 101 308 423 480 506 696 336 225 396 298 335 270 231 53 54
[14:56:23.128] INFO: number of X-ray hits detected: 136980 90404 144834 236385 254442 265508 266463 189295 168338 204940 202389 174639 181249 112919 46866 63155
[14:56:23.128] 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:56:23.128] INFO: number of Vcal hits detected: 207321 207791 207559 207409 207428 207179 207013 207573 207771 207567 207683 207641 207714 207703 207947 207945
[14:56:23.128] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.8 99.7 99.8 99.9 99.8 99.9 99.8 99.9 99.9 100.0 100.0
[14:56:23.128] INFO: Vcal hit overall efficiency (%): 99.7 99.9 99.8 99.7 99.7 99.6 99.5 99.8 99.9 99.8 99.8 99.8 99.9 99.9 100.0 100.0
[14:56:23.128] INFO: X-ray hit rate [MHz/cm2]: 40.1 26.5 42.5 69.3 74.6 77.8 78.1 55.5 49.3 60.1 59.3 51.2 53.1 33.1 13.7 18.5
[14:56:23.128] INFO: PixTestHighRate::doXPixelAlive() done
[14:56:23.177] INFO: PixTest:: pg_setup set to default.
[14:56:23.191] INFO: enter test to run
[14:56:50.296] INFO: test: HighRate no parameter change
[14:56:50.296] INFO: running: highrate
[14:56:50.297] INFO: ----------------------------------------------------------------------
[14:56:50.297] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:56:50.297] INFO: ----------------------------------------------------------------------
[14:56:50.306] INFO: ROC 0 masking pixel 1/1
[14:56:50.306] INFO: ROC 0 masking pixel 1/2
[14:56:50.306] INFO: ROC 0 masking pixel 1/3
[14:56:50.306] INFO: ROC 0 masking pixel 2/2
[14:56:50.306] INFO: ROC 0 masking pixel 2/13
[14:56:50.306] INFO: ROC 0 masking pixel 3/36
[14:56:50.306] INFO: ROC 0 masking pixel 9/24
[14:56:50.306] INFO: ROC 0 masking pixel 10/34
[14:56:50.306] INFO: ROC 0 masking pixel 33/17
[14:56:50.306] INFO: ROC 1 masking pixel 3/15
[14:56:50.306] INFO: ROC 1 masking pixel 4/26
[14:56:50.306] INFO: ROC 2 masking pixel 40/43
[14:56:50.306] INFO: ROC 2 masking pixel 40/51
[14:56:50.306] INFO: ROC 3 masking pixel 7/19
[14:56:50.306] INFO: ROC 3 masking pixel 7/20
[14:56:50.306] INFO: ROC 3 masking pixel 28/55
[14:56:50.307] INFO: ROC 4 masking pixel 26/36
[14:56:50.307] INFO: ROC 5 masking pixel 2/17
[14:56:50.307] INFO: ROC 5 masking pixel 3/49
[14:56:50.307] INFO: ROC 5 masking pixel 6/49
[14:56:50.307] INFO: ROC 5 masking pixel 6/53
[14:56:50.307] INFO: ROC 5 masking pixel 20/57
[14:56:50.307] INFO: ROC 6 masking pixel 11/61
[14:56:50.307] INFO: ROC 6 masking pixel 29/51
[14:56:50.307] INFO: ROC 6 masking pixel 38/55
[14:56:50.307] INFO: ROC 6 masking pixel 50/53
[14:56:50.914] INFO: Expecting 208000 events.
[14:57:06.748] INFO: 208000 events read in total (15307ms).
[14:57:06.756] INFO: Test took 16448ms.
[14:57:07.222] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:57:07.576] INFO: number of dead pixels (per ROC): 9 2 2 3 1 5 4 0 0 0 0 0 0 1 0 0
[14:57:07.576] INFO: number of red-efficiency pixels: 471 232 736 947 1132 1158 1603 772 485 948 714 724 551 465 98 114
[14:57:07.576] INFO: number of X-ray hits detected: 206029 136123 217093 355757 380602 399548 399549 285819 252589 307557 303096 263953 271653 168847 69811 95143
[14:57:07.576] 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:57:07.576] INFO: number of Vcal hits detected: 206989 207643 206922 206681 206516 206191 205499 206854 207466 206869 207172 207161 207391 207378 207897 207885
[14:57:07.576] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.6 99.5 99.4 99.3 99.0 99.5 99.8 99.5 99.7 99.6 99.7 99.8 100.0 99.9
[14:57:07.576] INFO: Vcal hit overall efficiency (%): 99.5 99.8 99.5 99.4 99.3 99.1 98.8 99.4 99.7 99.5 99.6 99.6 99.7 99.7 100.0 99.9
[14:57:07.576] INFO: X-ray hit rate [MHz/cm2]: 60.4 39.9 63.6 104.3 111.6 117.1 117.1 83.8 74.0 90.1 88.8 77.4 79.6 49.5 20.5 27.9
[14:57:07.576] INFO: PixTestHighRate::doXPixelAlive() done
[14:57:07.627] INFO: PixTest:: pg_setup set to default.
[14:57:07.647] INFO: enter test to run
[14:57:31.040] INFO: test: exit no parameter change
[14:57:31.497] QUIET: Connection to board 33 closed.
[14:57:31.499] INFO: pXar: this is the end, my friend