[13:06:54.300] INFO: *** Welcome to pxar ***
[13:06:54.300] INFO: *** Today: 2016/09/20
[13:06:55.492] INFO: *** Version: v1.9.0-818-g96727
[13:06:55.492] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//dacParameters35_C15.dat
[13:06:55.548] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//tbmParameters_C0b.dat
[13:06:55.548] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//defaultMaskFile.dat
[13:06:55.555] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C15.dat
[13:06:55.664] INFO: clk: 4
[13:06:55.664] INFO: ctr: 4
[13:06:55.664] INFO: sda: 19
[13:06:55.664] INFO: tin: 9
[13:06:55.664] INFO: level: 15
[13:06:55.664] INFO: triggerdelay: 0
[13:06:55.664] QUIET: Instanciating API for pxar v1.9.0+814~g74979a6
[13:06:55.664] INFO: Log level: INFO
[13:06:55.682] QUIET: Connection to board DTB_WREKRL opened.
[13:06:55.685] 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:
------------------------------------------------------
[13:06:55.688] INFO: RPC call hashes of host and DTB match: 398089610
[13:06:57.220] INFO: DUT info:
[13:06:57.220] INFO: The DUT currently contains the following objects:
[13:06:57.220] INFO: 2 TBM Cores tbm08c (2 ON)
[13:06:57.221] INFO: TBM Core alpha (0): 7 registers set
[13:06:57.221] INFO: TBM Core beta (1): 7 registers set
[13:06:57.221] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:06:57.221] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.221] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:06:57.650] INFO: enter 'restricted' command line mode
[13:06:57.650] INFO: enter test to run
[13:08:14.967] INFO: test: PixelAlive no parameter change
[13:08:14.967] INFO: running: pixelalive
[13:08:15.019] INFO: ----------------------------------------------------------------------
[13:08:15.019] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:08:15.019] INFO: ----------------------------------------------------------------------
[13:08:15.342] INFO: Expecting 41600 events.
[13:08:19.647] INFO: 41600 events read in total (3587ms).
[13:08:19.812] INFO: Test took 4789ms.
[13:08:19.825] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:08:20.433] INFO: PixTestAlive::aliveTest() done
[13:08:20.433] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[13:08:20.610] INFO: enter test to run
[13:08:53.455] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[13:08:53.455] INFO: running: highrate
[13:08:53.465] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[13:08:53.733] INFO: ----------------------------------------------------------------------
[13:08:53.733] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[13:08:53.733] INFO: ----------------------------------------------------------------------
[13:08:53.733] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[13:08:53.733] INFO: edge/corner pixel THR is adjusted
[13:08:53.733] INFO: PixTestHighRate::trimHotPixels: step 0...
[13:08:54.694] INFO: Collecting data for 5 seconds...
[13:08:59.710] INFO: Done with hot pixel readout
[13:09:11.349] INFO: PixTest:: pg_setup set to default.
[13:09:11.350] INFO: 16 hot pixels found in step 0
[13:09:12.369] INFO: Collecting data for 5 seconds...
[13:09:17.385] INFO: Done with hot pixel readout
[13:09:29.238] INFO: PixTest:: pg_setup set to default.
[13:09:29.239] INFO: 13 hot pixels found in step 1
[13:09:30.232] INFO: Collecting data for 5 seconds...
[13:09:35.249] INFO: Done with hot pixel readout
[13:09:47.127] INFO: PixTest:: pg_setup set to default.
[13:09:47.128] INFO: 15 hot pixels found in step 2
[13:09:48.121] INFO: Collecting data for 5 seconds...
[13:09:53.138] INFO: Done with hot pixel readout
[13:10:04.980] INFO: PixTest:: pg_setup set to default.
[13:10:04.981] INFO: 16 hot pixels found in step 3
[13:10:05.975] INFO: Collecting data for 5 seconds...
[13:10:10.994] INFO: Done with hot pixel readout
[13:10:22.696] INFO: PixTest:: pg_setup set to default.
[13:10:22.697] INFO: 10 hot pixels found in step 4
[13:10:23.690] INFO: Collecting data for 5 seconds...
[13:10:28.708] INFO: Done with hot pixel readout
[13:10:40.670] INFO: PixTest:: pg_setup set to default.
[13:10:40.671] INFO: 11 hot pixels found in step 5
[13:10:41.665] INFO: Collecting data for 5 seconds...
[13:10:46.683] INFO: Done with hot pixel readout
[13:10:58.355] INFO: PixTest:: pg_setup set to default.
[13:10:58.356] INFO: 8 hot pixels found in step 6
[13:10:59.357] INFO: Collecting data for 5 seconds...
[13:11:04.375] INFO: Done with hot pixel readout
[13:11:16.299] INFO: PixTest:: pg_setup set to default.
[13:11:16.300] INFO: 11 hot pixels found in step 7
[13:11:17.295] INFO: Collecting data for 5 seconds...
[13:11:22.314] INFO: Done with hot pixel readout
[13:11:34.327] INFO: PixTest:: pg_setup set to default.
[13:11:34.328] INFO: 14 hot pixels found in step 8
[13:11:35.321] INFO: Collecting data for 5 seconds...
[13:11:40.340] INFO: Done with hot pixel readout
[13:11:52.556] INFO: PixTest:: pg_setup set to default.
[13:11:52.557] INFO: 9 hot pixels found in step 9
[13:11:53.558] INFO: Collecting data for 5 seconds...
[13:11:58.576] INFO: Done with hot pixel readout
[13:12:10.618] INFO: PixTest:: pg_setup set to default.
[13:12:10.619] INFO: 9 hot pixels found in step 10
[13:12:11.613] INFO: Collecting data for 5 seconds...
[13:12:16.633] INFO: Done with hot pixel readout
[13:12:28.663] INFO: PixTest:: pg_setup set to default.
[13:12:28.663] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[13:12:28.665] INFO: 12 hot pixels found in step 11
[13:12:29.659] INFO: Collecting data for 5 seconds...
[13:12:34.678] INFO: Done with hot pixel readout
[13:12:46.622] INFO: PixTest:: pg_setup set to default.
[13:12:46.623] INFO: 3 hot pixels found in step 12
[13:12:47.617] INFO: Collecting data for 5 seconds...
[13:12:52.636] INFO: Done with hot pixel readout
[13:13:04.540] INFO: PixTest:: pg_setup set to default.
[13:13:04.541] INFO: 5 hot pixels found in step 13
[13:13:05.535] INFO: Collecting data for 5 seconds...
[13:13:10.553] INFO: Done with hot pixel readout
[13:13:22.625] INFO: PixTest:: pg_setup set to default.
[13:13:22.626] INFO: 10 hot pixels found in step 14
[13:13:22.665] INFO: 10 hot pixels could not be trimmed and have been masked.
[13:13:22.685] INFO: PixTest::trimHotPixels() done
[13:13:22.686] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C0.dat
[13:13:22.698] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C1.dat
[13:13:22.726] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C2.dat
[13:13:22.736] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C3.dat
[13:13:22.746] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C4.dat
[13:13:22.754] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C5.dat
[13:13:22.761] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C6.dat
[13:13:22.766] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C7.dat
[13:13:22.771] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C8.dat
[13:13:22.777] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C9.dat
[13:13:22.786] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C10.dat
[13:13:22.795] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C11.dat
[13:13:22.803] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C12.dat
[13:13:22.810] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C13.dat
[13:13:22.816] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C14.dat
[13:13:22.821] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C15.dat
[13:13:22.827] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//defaultMaskFile.dat
[13:13:22.840] INFO: enter test to run
[13:13:57.181] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[13:13:57.181] INFO: running: highrate
[13:13:57.186] INFO: ----------------------------------------------------------------------
[13:13:57.186] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[13:13:57.186] INFO: ----------------------------------------------------------------------
[13:13:57.186] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[13:13:57.186] INFO: edge/corner pixel THR is adjusted
[13:13:57.186] INFO: PixTestHighRate::trimHotPixels: step 0...
[13:13:58.143] INFO: Collecting data for 1 seconds...
[13:13:59.147] INFO: Done with hot pixel readout
[13:14:03.381] INFO: PixTest:: pg_setup set to default.
[13:14:03.382] INFO: 0 hot pixels found in step 0
[13:14:03.387] INFO: 0 hot pixels could not be trimmed and have been masked.
[13:14:03.468] INFO: PixTest::trimHotPixels() done
[13:14:03.468] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C0.dat
[13:14:03.480] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C1.dat
[13:14:03.487] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C2.dat
[13:14:03.493] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C3.dat
[13:14:03.498] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C4.dat
[13:14:03.504] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C5.dat
[13:14:03.510] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C6.dat
[13:14:03.515] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C7.dat
[13:14:03.521] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C8.dat
[13:14:03.526] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C9.dat
[13:14:03.532] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C10.dat
[13:14:03.537] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C11.dat
[13:14:03.544] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C12.dat
[13:14:03.549] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C13.dat
[13:14:03.554] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C14.dat
[13:14:03.560] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//trimParameters35_C15.dat
[13:14:03.565] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-Q-7-41_FPIXTest-17C-FNAL-160916-1156-150V_2016-09-16_11h56m_1474044985/000_FPIXTest_p17//defaultMaskFile.dat
[13:14:03.575] INFO: enter test to run
[13:14:29.909] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[13:14:29.909] INFO: running: xray
[13:14:29.910] INFO: ----------------------------------------------------------------------
[13:14:29.910] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[13:14:29.910] INFO: ----------------------------------------------------------------------
[13:14:30.887] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[13:14:42.190] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[13:15:12.848] INFO: Resuming triggers.
[13:15:24.151] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[13:15:54.763] INFO: Resuming triggers.
[13:16:06.071] INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[13:16:36.564] INFO: Resuming triggers.
[13:16:47.867] INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[13:16:47.884] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[13:16:47.884] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[13:16:47.884] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a07b 8040 43c8 43c8 43c8 43c8 43c8 43c8 43c8 43c8 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a075 80c0 4388 4388 494 2067 4388 4388 659 2444 4388 4388 340 2641 4388 4388 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a076 8000 4388 4388 4388 4388 4388 4388 20b 2a40 4388 13 244f 4388 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a077 8040 4388 4388 561 2849 4388 4388 4388 4388 9b 204a 404 2a6a 4388 4388 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a078 80b1 4388 12 2a45 4388 43c8 43c8 43c8 43ca 56e 43c8 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a079 80c0 43c8 43c8 43c8 4c8 2424 43c8 43c8 2c9 2449 43c8 51a 204f 43c8 248 2866 549 2a42 43c8 109 282f e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a07a 8000 43c8 43c8 43c8 43c8 19 204d 448 222f 43c8 43c9 45b 2640 43c8 43c8 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a17b 8040 43c8 43c8 43c8 64c 204a 43c8 d1 264d 43c8 43c8 43c8 43c8 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a175 80c0 4388 4388 821 242f 4388 4388 4388 319 2064 4388 4388 4388 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a176 8000 4388 4388 4388 4388 4388 4388 4388 4388 55c 2a2b e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a177 8040 4388 4388 4388 2d8 264f 4388 4388 250 2a26 4388 4388 4388 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a178 80b1 4388 438a 4388 4388 43c8 43c8 43c8 819 254e e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a179 80c0 43c8 4d9 2046 43c9 43c8 43c8 43c8 90 202c 43c8 43c8 43c8 e000 c000
[13:16:47.884] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a17a 8000 43c8 43c8 4c3 2046 43c8 43c8 43c8 43c8 43c8 43c8 e000 c000
[13:17:17.593] INFO: Resuming triggers.
[13:17:28.895] INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[13:17:58.576] INFO: Resuming triggers.
[13:18:09.877] INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[13:18:39.545] INFO: Resuming triggers.
[13:18:50.846] INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[13:19:20.683] INFO: Resuming triggers.
[13:19:31.984] INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[13:20:01.679] INFO: Resuming triggers.
[13:20:11.613] INFO: data taking finished, elapsed time: 100 seconds.
[13:20:37.841] INFO: PixTest:: pg_setup set to default.
[13:20:37.844] INFO: PixTestXray::doPhRun() done
[13:20:38.045] INFO: enter test to run
[13:21:52.314] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[13:21:52.314] INFO: running: xray
[13:21:52.315] INFO: ----------------------------------------------------------------------
[13:21:52.316] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[13:21:52.316] INFO: ----------------------------------------------------------------------
[13:21:53.280] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[13:21:59.804] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[13:22:30.266] INFO: Resuming triggers.
[13:22:36.792] INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[13:23:07.382] INFO: Resuming triggers.
[13:23:13.903] INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[13:23:14.277] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:23:14.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c5 80c0 43c8 6d8 2826 6d8 2a45 43c8 94 222a 43c8 43c8 1d 2a4e 51b 244f 43c8 444 2229 54c 284a 743 2269 809 2042 81a 2a4a 43c8 4b 2668 353 266e 43c8 43c8 c 246a 24b 2664 25b 226a 515 2669 68b 2a4d e000 c000
[13:23:14.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0bf 8040 438a 2db 2846 355 2666 438a 152 204f 4388 4388 45a 2046 4388 414 242a 4388 14a 2247 61c 284f 4389 652 2040 70c 284c 85c 2649 438a e000 c000
[13:23:14.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c0 80b1 4388 615 2a44 4388 54d 2068 4388 4388 4389 4388 412 2665 618 2846 618 204a 759 2a44 4389 294 2264 44a 242c 4388 e000 c000
[13:23:14.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c1 80c0 4388 258 222e 4388 4389 4389 220 2242 2c3 2645 650 2664 759 2066 4388 2d1 2a4f 4388 4388 159 204e 31c 2a41 84c 264c 85d 2241 4389 419 2a65 e000 c000
[13:23:14.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c2 8000 4388 498 202e 4388 4388 690 282c 6e1 244c 4389 18 2849 4388 418 2646 6d3 2063 4388 2d1 246b 48d 2245 4388 4389 59 2064 95 2482 30c 2a41 519 2068 510 244f f000 c000
[13:23:14.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c3 8040 43c8 43c9 43c8 49a 2a46 43c8 8 204f 43c8 cc 204a 84a 2260 43c8 9a 244f 50c 284e 6cc 262e 755 2240 43c8 2d3 2269 850 2665 43c9 e000 c000
[13:23:14.277] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c4 80b1 43c8 75a 244c 43c8 43c8 43c8 4d5 2048 618 2245 43c8 43c8 44d 2662 74d 2642 43c8 43c8 24a 284d 251 2268 319 2a62 e000 c000
[13:23:44.913] INFO: Resuming triggers.
[13:23:51.434] INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[13:24:22.357] INFO: Resuming triggers.
[13:24:28.881] INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[13:25:00.606] INFO: Resuming triggers.
[13:25:07.132] INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[13:25:37.590] INFO: Resuming triggers.
[13:25:44.121] INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[13:26:14.000] INFO: Resuming triggers.
[13:26:21.531] INFO: run duration 52 seconds, buffer almost full (81%), pausing triggers.
[13:26:21.815] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (7) != Token Chain Length (8)
[13:26:21.815] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[13:26:21.815] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:26:21.815] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00a 8000 43c8 1c 2a6d 43c8 458 264b 43c8 43c8 11 206d 549 2261 43c8 62 2a88 cd 2a65 151 2847 43c9 34a 2a4e 50d 2845 43c8 85a 226f 43c8 289 2466 e000 c000
[13:26:21.815] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a004 80b1 4388 93 204f 4388 4388 2d9 2461 618 2846 70b 2044 703 2466 754 2641 4388 4388 408 2443 4388 4388 18 2845 4b 286b 4388 e000 c000
[13:26:21.815] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a005 80c0 4388 4388 4388 40c 2642 4388 4388 9a 282e 253 2068 288 206a 4388 4388 4388 e000 c000
[13:26:21.815] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a006 8000 4388 4388 4388 655 2a4d 4388 114 244e 151 246f 144 2a44 819 2668 4388 4388 158 2a40 4388 55 266a 48c 2441 4388 855 2865 e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a007 8040 4388 610 2440 859 2241 4388 35b 204d 455 284d 4388 4388 21d 282e 4e2 2063 4388 88 2429 85c 244f 4388 848 2826 43c8 140b 2648 69e 2315 3f1 e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a008 80b1 43c8 119 264a 20d 244e 61d 284a 43c8 43c8 43c8 4dd 262f 500 2a45 744 206d 752 2661 43c8 2da 204a 43ca c9 2443 28a 2a42 4d5 204d 43c8 10b 226f 408 202e 4d0 2a4f 651 2a4c 43c8 548 264a 608 244a e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a009 80c0 43c8 c9 2869 61d 282d 612 2240 43c8 43c8 43c8 245 244f 4d9 2643 43c8 43c8 655 2265 715 2646 43c8 245 2a62 709 2a4e 43c8 e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10a 8000 43c8 43c8 711 2868 43c8 50a 246a 559 2a4f 660 204f 43c8 52 242e 43c8 43c8 4a2 2845 43c8 43c8 59 2046 9b 244f e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a104 80b1 4388 54 2862 202 2048 4388 849 2a69 4388 60c 284f 681 244c 849 284f 4388 121 2265 155 264f 455 206f 71c 244f 4388 11a 284a 84d 204f 4388 4388 4388 811 286d e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a105 80c0 4388 84b 2860 4388 202 206a 4cd 2048 4388 d1 2642 11c 228e 308 224c 708 2047 4388 4388 34d 204d 412 2862 4388 4388 4388 9c 262d 9d 2649 e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a106 8000 4388 4388 e0 2a2f 4388 35a 266d 4388 31b 204a 443 208a 4388 21 204f 222 2469 35c 2261 4388 358 2a45 4388 4388 e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a107 8040 4388 422 244f 519 2260 621 224e 84b 2265 4388 65c 202e 71a 2443 4388 19 2848 11c 2a4f 649 2661 841 2664 43c8 5 302f 105 268e 7ea 2f22 2f20 220 285e 49a 43c8 43c8 3 2460 e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a108 80b1 43c8 43ca 352 264f 818 2047 43c8 43c8 35d 206d 43c8 43c8 43c8 622 224d 43c8 e000 c000
[13:26:21.816] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a109 80c0 43c8 43c9 43c8 14d 204a 71b 2668 71c 2265 85a 244f 43c8 43 284f 289 268f 84c 2a24 43c8 2cb 284a 43c8 409 224c 43c8 29b 284a 43c8 49b 226d e000 c000
[13:26:51.978] INFO: Resuming triggers.
[13:26:58.509] INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[13:27:30.657] INFO: Resuming triggers.
[13:27:37.183] INFO: run duration 65 seconds, buffer almost full (81%), pausing triggers.
[13:28:09.077] INFO: Resuming triggers.
[13:28:15.606] INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[13:28:47.311] INFO: Resuming triggers.
[13:28:53.842] INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[13:28:53.938] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (4) != Token Chain Length (8)
[13:28:53.938] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (3) != Token Chain Length (8)
[13:28:53.938] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a090 80b1 43c8 9b 244a 2a0 2045 43c8 43c8 43c8 c9 2240 4c8 2429 43c9 43c8 640 2620 43c9 43c8 e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08a 8000 4388 d5 264c 4388 99 282f 4388 11d 204a 54b 264f 61c 262c 704 2a26 4388 619 2440 4388 4389 12 2440 41c 2246 4388 94 2a49 4388 211 2840 302 284e 650 2a4e e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08b 8040 4388 4388 18 2a46 4388 702 2643 4388 c 2247 4d8 224c 688 284d 4388 554 2a48 4388 12 246b 4388 4388 15a 224f 49a 2a2d e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08c 80b1 4388 6d2 264e 4388 109 2645 655 266f 4388 494 2861 4388 4388 40b 2462 4389 205 2242 70a 204f 4388 88 284c 4388 e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08d 80c0 4388 dd 2848 4388 d2 2640 35a 204e 43c8 53c8 7ff 2eab f30 22ab c4e 33f2 11f4 2f3b eaa 3ab5 50a 2e55 2e03 e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08e 8000 43c8 43c8 43ca 600 2648 43ca 5d 264d 150 286a 43ca 809 264f 815 2642 43c8 21a 204d 300 2864 6d2 242e 43c8 cc 240f 248 204e 71b 204e 43c8 e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08f 8040 43ca 43ca 159 2445 43c8 35a 2241 459 2a41 6d5 2048 43c8 b 244f 9a 2661 43c8 249 2643 4d9 2665 43c8 615 2a4a 43c9 c 2062 4da 2a85 548 2a42 43ca 4b 266b 692 204e e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a190 80b1 43c9 155 2842 55a 2062 43c8 5a 2260 61 224b 35c 2240 43c9 11c 2866 43c9 dc 2a6c 51b 2864 660 2a6f 43c9 85a 244f 43c9 43c9 6cd 204c 43c9 e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a18a 8000 4388 4d 2066 4388 41d 2862 75c 264e 4388 4388 11c 246d 855 2846 4388 2dd 246f 4388 4388 4388 e0 2461 e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a18b 8040 4388 4388 74a 284a 4388 461 2064 4388 308 2240 4388 53 2662 8a 264f 4388 152 2649 4388 4388 e000 c000
[13:28:53.938] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a18c 80b1 4388 4389 4388 11a 284d 4388 4388 4388 45c 2a61 4388 4388 e000 c000
[13:28:53.939] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a18d 80c0 4388 104 2046 851 2460 853 2a6e 43c8 14a 3a2f 259 2eab 85 2001 780 3326 1151 209f 0 3fe5 aa9 2003 6b0 20a6 43c8 e000 c000
[13:28:53.939] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a18e 8000 43c8 19 224a 43c8 85b 2083 43c8 b 204d 43c8 55 284a 6d3 2445 43c8 9b 206d 43c8 43c8 43ca 421 2049 e000 c000
[13:28:53.939] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a18f 8040 43ca 455 284f 43c8 8 2046 24b 244e 259 2a49 748 2042 43ca 351 204f 43ca 6d9 244f 43ca 693 2662 860 2a4a 43ca 43ca 43c9 499 2a2f 4a2 2a6a e000 c000
[13:29:25.419] INFO: Resuming triggers.
[13:29:31.947] INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[13:30:02.446] INFO: Resuming triggers.
[13:30:08.976] INFO: run duration 91 seconds, buffer almost full (81%), pausing triggers.
[13:30:09.231] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (4) != Token Chain Length (8)
[13:30:09.231] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 2 ROCs were found
[13:30:09.231] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a7 8040 43c8 551 2840 43c8 43c8 681 244f 815 2243 43c8 698 262f 710 2246 813 2062 43c8 43c8 30d 226a 358 2042 34a 244f 4cb 2866 43c8 689 204a 43c8 d4 2a4a 419 228a e000 c000
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a1 80c0 4388 6da 2642 4388 4389 840 262a 851 262d 4389 4388 4d1 244c 60a 226a 4388 410 2248 41c 2a68 45d 2042 61d 224f 4388 1d 264c 148 2045 219 2864 254 2a6a 354 2080 6c4 2040 4389 e000 c000
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a2 8000 4388 4388 112 2a44 4388 4d3 2846 4389 51c 2862 748 2a2e 4388 20 202e 9 2045 85 2641 208 204c 612 2a6e 4388 4388 111 2262 4389 e000 c000
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a3 8040 4388 d 2a4a 69d 204f 4389 35b 2aa1 4388 855 264d 4388 449 224f 4388 4388 4388 80b 204c 858 222f 4389 59 2a64 e000 c000
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a4 80b1 4388 4388 4388 220 202d 459 264a 64b 2a6f 43c8 6ab 27d6 1166 24c3 2d8 33fa 1f0d 2d56 7ef 23e5 ea8 235b 65 2350 a44 268a 640 26e0 240 43c8 308 2a23 e000 c000
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a5 80c0 43c8 5c 2840 45a 286a 55d 2849 55d 2048 43c8 43c8 9b 2048 43c8 c2 222a 44c 2841 688 2a42 43c8 844 222d 43c8 118 2a4f 43c8 13 2864 550 2443 542 284c 551 2665 718 2042 43c8 e000 c000
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a6 8000 43c8 452 224f 43c8 250 2844 43c8 45c 2843 43c8 21a 2242 488 2265 6cd 2486 711 2062 43c8 9b 2a46 654 280f 43c8 51d 2865 6cc 2829 43c8 458 2041 43c8 93 2a69 e000 c000
[13:30:09.231] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a7 8040 43c8 712 2860 43c8 153 264f 61a 2642 43c8 43c8 308 2025 804 224a 43c8 254 2a2c 414 224e 441 224a 43c8 10b 2249 340 240f 43c8 75a 2065 741 264c 43c8 e000 c000
[13:30:09.231] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a1 80c0 4388 4388 320 2049 442 2046 68d 2a6e 74b 266f 858 2660 4388 20d 2441 208 2a4b 50b 2a6a 4388 759 2840 4389 51 2045 6cc 242e 85b 2681 4389 4389 4389 e000 c000
[13:30:09.232] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a2 8000 4388 4388 4db 2229 4389 18 2640 28c 266b 321 2a6a 34b 2262 520 2068 710 2669 4389 493 264f 610 2842 4388 2d1 2245 4388 110 2445 4389 6cd 284f 859 2645 4389 e000 c000
[13:30:09.232] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a3 8040 4388 512 2a48 4388 34b 284c 4388 4b 266a 805 248e 4389 4388 119 2446 821 224f 4389 284 2226 4388 4388 e000 c000
[13:30:09.232] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a4 80b1 4388 71b 224f 4388 4d2 204e 70d 202e 81c 2829 e0b6 c080
[13:30:09.232] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a5 80c0 43c8 68b 246a 43c8 41a 204a 419 2868 71b 2462 750 2282 43c8 409 224f 54c 284b 43c8 43c8 749 2664 43c8 43c8 43c8 5d 2848 e000 c000
[13:30:09.232] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a6 8000 43c8 43c8 422 2048 43c8 114 206f 43c8 61b 2a84 660 2a68 43c8 43c8 150 2242 210 204f 43c8 43c8 e000 c000
[13:30:39.802] INFO: Resuming triggers.
[13:30:46.326] INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[13:31:16.653] INFO: Resuming triggers.
[13:31:19.101] INFO: data taking finished, elapsed time: 100 seconds.
[13:31:30.792] INFO: PixTest:: pg_setup set to default.
[13:31:30.795] INFO: PixTestXray::doPhRun() done
[13:31:31.053] INFO: enter test to run
[13:31:57.326] INFO: test: HighRate no parameter change
[13:31:57.326] INFO: running: highrate
[13:31:57.336] INFO: ----------------------------------------------------------------------
[13:31:57.336] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:31:57.336] INFO: ----------------------------------------------------------------------
[13:31:57.491] INFO: Expecting 768 events.
[13:31:58.623] INFO: 768 events read in total (416ms).
[13:31:58.624] INFO: Test took 1268ms.
[13:31:59.427] INFO: Expecting 41600 events.
[13:32:00.832] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[13:32:00.832] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[13:32:00.832] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a047 8040 43c8 4d8 2a4f 43c8 5b 226e 43c8 850 2a2d 43c8 1d 24a1 43c8 43c9 1d 2488 43c9 44b 2043 43c8 e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a041 80c0 4388 4388 1d 2889 214 2a6b 4389 4389 1d 28a2 514 2a48 4388 2c3 2049 54a 222d 4388 1d 288a 14 2042 4388 4389 53 2869 e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a042 8000 4388 4388 1d 288b 4388 29a 2049 4389 1d 28a4 653 2269 4388 4389 1d 2885 4388 304 2846 60d 2a64 4389 512 204e e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a043 8040 4388 1d 248f 45b 264f 4389 1d 2489 4388 4388 1d 24a1 4388 4389 4388 d1 2222 4389 1d 248d e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a044 80b1 4388 1d 248d 4388 1d 2489 4388 1d 248a 415 2a46 4388 1d 248f 4388 240 2a81 315 206d 71d 2858 2a9 27a4 fff 43c8 43c8 1d 248a 4db 246e e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a045 80c0 43c8 1d 24a2 290 2446 61b 2047 43c8 1d 248a d4 284f 43c8 1d 2484 43c8 1d 248f 43c8 43c8 83 2868 74b 2042 43c8 98 2049 43c8 e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a046 8000 43c8 1d 248a 215 202f 43c8 98 2a2e 43c8 43c8 1d 248f 43c8 683 2065 43c9 1d 2485 43c8 51a 2848 43c8 e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a147 8040 43c8 1d 2488 43c8 43c8 212 2643 60b 2263 43c8 1d 248c 43c8 410 2649 43c8 43c8 1d 248a 43c8 861 286e e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a141 80c0 4388 1d 288c 4388 1d 288a 6cd 2241 4388 5a 264e 4388 1d 2887 449 2665 4389 1d 28a2 4389 4389 1d 288d 4389 1d 2889 e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a142 8000 4388 1d 28a4 4389 1d 288d 4389 30b 2065 6c1 2864 71c 284a 4389 1d 288f 4388 1d 288c 4388 4389 1d 288c 4389 1d 288b e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a143 8040 4388 1d 248c 4389 1d 248c 64a 222f 4388 81c 2a6c 4389 1d 248f 48d 2264 4388 1d 248f 11a 266f 4389 1d 24a8 4388 1d 248f 4388 e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a144 80b1 4388 81a 2848 4388 1d 248d 4388 4388 1d 248a 4388 645 204a 4388 1d 24ac 10 2268 1a 224f 7ff e020 c004
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a145 80c0 43c8 43c8 43c8 43c8 1d 248f 43c8 1d 248f 43c8 1d 24a2 43c8 1d 248d 43c8 e002 c000
[13:32:00.832] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a146 8000 43c8 43c9 43c8 711 2a4f 43c8 43c8 1d 248a 43c8 1d 24a7 43c8 1d 248f 43c8 e002 c000
[13:32:02.515] INFO: 41600 events read in total (2561ms).
[13:32:02.516] INFO: Test took 3873ms.
[13:32:02.551] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:03.274] INFO: Expecting 41600 events.
[13:32:06.469] INFO: 41600 events read in total (2668ms).
[13:32:06.470] INFO: Test took 3901ms.
[13:32:06.505] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:07.226] INFO: Expecting 41600 events.
[13:32:10.453] INFO: 41600 events read in total (2700ms).
[13:32:10.453] INFO: Test took 3931ms.
[13:32:10.489] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:11.211] INFO: Expecting 41600 events.
[13:32:12.733] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 1 ROCs were found
[13:32:12.733] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (4) != Token Chain Length (8)
[13:32:12.733] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:32:12.733] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f9 80c0 43c9 a2 208f 29a 224a 43c9 a2 208d 43c9 a2 208a 43c9 a2 208f 43c8 a2 208d 43c8 a2 20a7 8b 2662 43c9 a2 20a1 43c8 a2 208f e002 c000
[13:32:12.733] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f3 8040 4388 a2 20a2 494 282d 4389 a2 208d 4388 a2 2087 4388 a2 208f 4388 a2 2089 4389 a2 20ad 80b 2269 4388 a2 20a7 4389 a2 208f 543 2a82 e002 c000
[13:32:12.733] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f4 80b1 4388 a2 20a4 812 2645 4388 a2 2089 4388 a2 208c 4388 a2 20a5 74d 2a68 4388 a2 20a2 4388 a2 20aa 2d2 2244 4388 a2 20a8 818 282e 4388 a2 20a2 e002 c000
[13:32:12.733] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f5 80c0 4388 a2 20a4 4388 a2 208d 4388 a2 208a 4388 a2 208f 4388 a2 2082 4389 a2 20aa 10b 2244 4388 a2 20a4 54a 242f 81a 2447 4388 a2 208d e002 c000
[13:32:12.733] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f6 8000 43c8 bf 2fff 2a9 3a79 7f7 2e5e fa5 2fbf bf5 3fd9 6aa 53cb 1f75 2e97 1fff 2fea eab 3f5f e0a5 c0ef
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f7 8040 43c8 a2 20a2 43c8 a2 208b 43c8 a2 208a 43c8 a2 20a9 43c9 55 284f a2 2088 43c9 a2 20c2 43c9 a2 20a7 43c8 a2 208b e002 c000
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f8 80b1 43c8 a2 208f 43c8 a2 208d 43c9 a2 20a3 43c9 a2 20a3 43c8 a2 2085 43cb a2 20ab 43c9 a2 20aa 43c9 a2 20a1 e002 c000
[13:32:12.734] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f9 80c0 43c9 a2 20a4 43c9 a2 208f 89 2248 43c9 a2 20a8 43c9 a2 20a5 48d 2a48 43c9 a2 20aa 422 2864 752 2246 85d 284c 43c9 a2 208d d0 202a 43c9 a2 20ac 43c8 41 2640 a2 20a2 e002 c000
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f3 8040 4388 a2 208c 844 266c 4389 252 242d 4388 a2 20a5 4389 a2 20a9 4388 a2 20ad 4389 a2 208a 4388 a2 20af 4388 a2 208f e002 c000
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f4 80b1 4388 a2 208a 4388 a2 208d 4388 a2 20a5 4388 a2 20a6 70b 2681 4388 a2 20aa 11b 2269 708 2a27 858 2a62 4388 a2 2083 4388 a2 20a9 4388 a2 20a5 e002 c000
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f5 80c0 4388 a2 208f 84d 264a 4389 a2 20aa 4388 a2 20a4 8b 2668 842 2a42 844 2242 4388 a2 20a7 4388 a2 20a6 14a 2864 6c9 224a 4388 a2 2083 4388 a2 20ad 70d 204a 4388 a2 208f 4ca 2a49 e002 c000
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f6 8000 43c8 ba 2eaa 3 3ebb 805 240f faa 2fa9 ebb 3ea1 403 380b 1ee0 2003 1eaa 2eaa 1 3eaa 801 240f eaa 28ae 1003 280b 1ee9 2400 43c8 1 2482 a2 208f 43c8 a2 20af 43c8 a2 208f e002 c000
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f7 8040 43c8 a2 2085 43c8 a2 20a5 43c8 a2 208f 43c8 a2 20ae 50b 284f 43c8 a2 20a4 9d 244b 68b 2467 851 244c 43c8 a2 208d 43c8 a2 20af 43c9 a2 208f e002 c000
[13:32:12.734] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f8 80b1 43c8 a2 208f 31a 264d 43ca a2 20ab 43c8 a2 20af 43c8 a2 20aa 450 2686 43c8 a2 20a2 43c8 a2 208b 43c8 a2 20af 43c8 a2 20a3 9d 2a4f e002 c000
[13:32:14.447] INFO: 41600 events read in total (2709ms).
[13:32:14.448] INFO: Test took 3942ms.
[13:32:14.483] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:15.203] INFO: Expecting 41600 events.
[13:32:18.459] INFO: 41600 events read in total (2729ms).
[13:32:18.460] INFO: Test took 3959ms.
[13:32:18.496] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:19.219] INFO: Expecting 41600 events.
[13:32:22.454] INFO: 41600 events read in total (2708ms).
[13:32:22.455] INFO: Test took 3940ms.
[13:32:22.490] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:23.213] INFO: Expecting 41600 events.
[13:32:26.452] INFO: 41600 events read in total (2712ms).
[13:32:26.453] INFO: Test took 3944ms.
[13:32:26.488] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:27.213] INFO: Expecting 41600 events.
[13:32:30.467] INFO: 41600 events read in total (2728ms).
[13:32:30.468] INFO: Test took 3961ms.
[13:32:30.502] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:31.221] INFO: Expecting 41600 events.
[13:32:34.468] INFO: 41600 events read in total (2720ms).
[13:32:34.469] INFO: Test took 3949ms.
[13:32:34.503] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:35.228] INFO: Expecting 41600 events.
[13:32:38.460] INFO: 41600 events read in total (2705ms).
[13:32:38.461] INFO: Test took 3940ms.
[13:32:38.497] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:39.217] INFO: Expecting 41600 events.
[13:32:40.727] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (4) != Token Chain Length (8)
[13:32:40.727] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (3) != Token Chain Length (8)
[13:32:40.727] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c8 80b1 43c8 51 2a8a 43c9 51 2aa7 43c9 51 2a8c 615 2064 43c8 51 2aa6 43c8 51 2aa2 6d8 284e 43ca 51 2a8a 43c8 51 2aa2 43c9 51 2aa8 e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c2 8000 4388 52 2286 4388 1c 242d 52 22ab 4388 52 2289 4389 52 228d 4388 52 22ad 4388 52 2285 64b 264b 4388 52 228f 4389 52 228d 511 2263 e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c3 8040 4388 52 228c 6da 2642 4389 52 22a3 4388 52 2289 4388 52 22a6 d4 2240 559 2a45 4388 52 22aa 20a 204f 4388 52 226f 4388 52 22a5 4389 52 22a5 e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c4 80b1 4388 52 2286 4388 52 228f 4388 52 2288 4388 52 228d 4388 52 22aa 15a 2a42 212 2a82 44c 242f 71a 2a28 4388 52 226f 748 222c 4388 52 228d 154 2a4b 4388 52 228d e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c5 90c0 43c8 51 2a95 e55 26fc 553 2ead a0f 2573 ead 2a0c 553 2ead a0f 2950 2a2 2863 43c8 51 2a8e 113 244d 43c8 51 2aa6 709 2a4f 43c8 51 2aa2 60d 2866 e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c6 8000 43c8 51 2a8a 43c8 51 2aa7 43c8 51 2a8a 43c8 51 2aa4 4d2 2449 43c8 51 2aaf 43c9 51 2a8a 43c9 51 2aa5 43c8 51 2aa6 e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c7 8040 43c8 51 2a8e 43c8 51 2aa8 214 264d 43c8 51 2a8b 43c9 51 2aaa 290 2649 6d2 244f 43c9 51 2aa9 811 2645 43c8 51 2a8d 43c8 51 2aa2 43c8 51 2aa6 e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c8 80b1 43c9 51 2aaa 61b 206e 43cb 51 2a8e 43c8 51 2aa5 43c9 51 2a88 43c9 51 2a8d 43c9 51 2a8e 43c9 51 2a6d 512 2646 43c8 51 2a8f e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c2 8000 4388 52 22aa 4388 52 2283 4c2 2245 4389 52 22a0 512 224e 4389 52 228f 4388 52 2281 4388 52 2285 4389 52 226f 4389 52 228f e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c3 8040 4388 52 22a4 4388 52 228e 4388 52 22a5 254 2a65 459 224b 4389 52 228b 4388 52 228d 4389 52 226f 4388 52 226d 4388 52 228d e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c4 80b1 4388 52 22a8 2d4 2842 4388 52 228d 4388 52 22ac 11d 244f 4388 52 228f db 2088 4388 52 2288 4388 52 226f 4388 52 226b 659 2868 4388 52 228f e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c5 90c0 43c8 51 2a80 3 2f52 aa3 2c0f e54 2a87 c0f 2e18 aa7 2c0f e55 2530 a3 251e 682 43c8 51 2aa2 43c8 51 2a6a 64a 204b 43c8 51 2a8f e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c6 8000 43c8 51 2aa8 43c8 51 2aa9 43c8 51 2aa4 43c8 51 2a8a 43c8 51 2a8a 21a 286a 43c8 51 2a8a 43c8 51 2a6e 43c8 51 2a89 e002 c000
[13:32:40.727] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c7 8040 43c8 51 2aa2 43c8 51 2a8e 31c 2443 43c8 51 2aa6 14b 224f 43c8 51 2a8e 43c8 51 2a8e 43c8 51 2a8f 43c8 51 2a6d 51d 264f 43c9 51 2a8d e002 c000
[13:32:42.467] INFO: 41600 events read in total (2723ms).
[13:32:42.468] INFO: Test took 3952ms.
[13:32:42.503] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:43.224] INFO: Expecting 41600 events.
[13:32:46.478] INFO: 41600 events read in total (2727ms).
[13:32:46.479] INFO: Test took 3959ms.
[13:32:46.514] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:47.237] INFO: Expecting 41600 events.
[13:32:50.485] INFO: 41600 events read in total (2721ms).
[13:32:50.486] INFO: Test took 3953ms.
[13:32:50.522] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:51.241] INFO: Expecting 41600 events.
[13:32:52.815] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[13:32:52.815] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[13:32:52.818] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c9 80c0 43c9 8d 2a8d dc 2442 608 2224 859 2843 43c8 8d 2a89 43c8 8d 2a86 43c8 8d 2aa2 351 244d 85c 284f 43c9 8d 2a6f 43c8 8d 2a86 43c8 91 2864 8d 2aa1 43c8 8d 2a8c 360 2046 e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c3 8040 4388 8d 2a8c 292 2847 4389 8d 2a87 4388 8d 2a82 4388 8d 2a8c 4388 8d 2a6e 81b 2880 858 284e 4388 8d 2a8d 4388 8d 2aa9 4389 8d 2a85 514 2846 e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c4 80b1 4388 62 224a 8d 2a8a 4388 8d 2a87 4388 8d 2a82 4388 8d 2a8d 4388 8d 2a68 4388 b 2842 8d 2aa5 4388 8d 2aa1 4388 8d 2a85 e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c5 80c0 4388 8d 2a8f 4388 8d 2a83 4388 8d 2a86 313 2a68 4388 8d 2a87 4388 8d 2a6d 4389 8d 2a8e 560 2440 4388 8d 2a8e 64a 224a 4388 8d 2a87 e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c6 8003 ff8 208d a8d 43c8 8d 2a8a 43c8 8d 2a82 48c 2642 544 286a 43c8 8d 2a8a 293 264d 43c8 8d 2a6f 840 244d 43c9 8d 2a8f d9 204a 43c9 43c8 8d 2a8a 318 262a e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c7 8040 43c8 8d 2a85 43c8 8d 2a8b 43c9 8d 2a85 43c9 8d 2a8a 245 2a4a 41c 204a 43c9 8d 2a68 642 262d 43c8 8d 2a8e 43c8 8d 2aa0 43c8 8d 2a87 e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c8 80b1 43c8 8d 2a8f 43c9 8d 2a85 93 2245 462 2466 43c8 8d 2a82 43c8 8d 2a8a 854 2669 43c8 8d 2a6f 43cb 8d 2aa5 43c8 8d 2a8f 43c9 8d 2a8a e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c9 80c0 43c8 8d 2a88 401 2a4d 43c9 90 2445 8d 2aa6 68a 2464 43c9 8d 2aa4 43c8 8d 2a88 43c8 8d 2a8e 24a 2029 43c8 8d 2a8f 43c8 8d 2a8f 43c9 8d 2a88 e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c3 8040 4388 8d 2a8c 4388 8d 2aa0 a1 226a 610 2a4e 4388 8d 2aa2 505 2466 4389 8d 2a8e 4388 8d 2aa8 4389 8d 2a8b 4388 8d 2a8b 4388 8d 2a8c e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c4 80b1 4388 8d 2a88 4388 8d 2a8f 80b 2045 4388 8d 2aaa 502 264e 60b 2866 4388 8d 2a8f 4388 8d 2a89 4388 c 224f 8d 2aa1 4388 8d 2a8f 4388 8d 2a89 e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c5 80c0 4388 8d 2a82 4389 8d 2a8f 4388 8d 2aa6 20d 284f 4388 8d 2a8c 4388 8d 2a8f 4388 8d 2a8a 4388 8d 2a8d 4388 8d 2a8e e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c6 8004 70 211b 2110 11b 43c8 8d 2aaa 43c8 8d 2a8f 202 2242 43c8 8d 2a8f 43c8 8d 2a8e 43c8 8d 2a8e 43c8 8d 2a8e e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c7 8040 43c8 8d 2a8a 43c9 8d 2a8f 43c8 8d 2aa6 43c8 8d 2a8c 31d 2263 43c8 3 246f 8d 2aa2 43c8 8d 2a8b 289 202c 43c8 8d 2a8e 43c9 8d 2a8a e002 c000
[13:32:52.818] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c8 80b1 43c9 8d 2a84 43ca 8d 2aa5 43c8 8d 2aad 43c9 8d 2a8d 660 2488 43c9 8d 2a8d 43c9 8d 2aa2 43c9 8d 2a8f 43c8 8d 2a8f e002 c000
[13:32:54.480] INFO: 41600 events read in total (2712ms).
[13:32:54.481] INFO: Test took 3940ms.
[13:32:54.518] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:55.237] INFO: Expecting 41600 events.
[13:32:58.489] INFO: 41600 events read in total (2725ms).
[13:32:58.490] INFO: Test took 3954ms.
[13:32:58.525] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:59.247] INFO: Expecting 41600 events.
[13:33:02.498] INFO: 41600 events read in total (2724ms).
[13:33:02.499] INFO: Test took 3955ms.
[13:33:02.535] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:03.256] INFO: Expecting 41600 events.
[13:33:06.513] INFO: 41600 events read in total (2730ms).
[13:33:06.514] INFO: Test took 3961ms.
[13:33:06.548] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:07.267] INFO: Expecting 41600 events.
[13:33:10.514] INFO: 41600 events read in total (2720ms).
[13:33:10.515] INFO: Test took 3949ms.
[13:33:10.550] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:11.273] INFO: Expecting 41600 events.
[13:33:14.437] INFO: 41600 events read in total (2637ms).
[13:33:14.438] INFO: Test took 3868ms.
[13:33:14.474] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:15.196] INFO: Expecting 41600 events.
[13:33:18.300] INFO: 41600 events read in total (2577ms).
[13:33:18.301] INFO: Test took 3808ms.
[13:33:18.336] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:18.696] INFO: enter test to run
[13:33:28.061] INFO: test: HighRate no parameter change
[13:33:28.061] INFO: running: highrate
[13:33:28.063] INFO: ----------------------------------------------------------------------
[13:33:28.063] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:33:28.063] INFO: ----------------------------------------------------------------------
[13:33:28.675] INFO: Expecting 208000 events.
[13:33:40.622] INFO: 208000 events read in total (11420ms).
[13:33:40.625] INFO: Test took 12556ms.
[13:33:40.775] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:41.038] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[13:33:41.038] INFO: number of red-efficiency pixels: 94 46 95 122 155 158 135 106 96 141 120 104 118 67 22 36
[13:33:41.038] INFO: number of X-ray hits detected: 71644 45791 67965 103976 109324 114286 113335 84566 78455 107606 102257 91179 95407 57678 23616 26966
[13:33:41.038] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:33:41.038] INFO: number of Vcal hits detected: 207902 207954 207903 207878 207841 207839 207863 207892 207901 207858 207878 207893 207881 207933 207929 207964
[13:33:41.038] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 100.0 100.0 99.9 99.9 100.0 99.9 100.0 100.0 100.0
[13:33:41.038] INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 99.9 99.9 99.9 99.9 99.9 100.0 99.9 99.9 99.9 99.9 100.0 100.0 100.0
[13:33:41.038] INFO: X-ray hit rate [MHz/cm2]: 21.0 13.4 19.9 30.5 32.0 33.5 33.2 24.8 23.0 31.5 30.0 26.7 28.0 16.9 6.9 7.9
[13:33:41.038] INFO: PixTestHighRate::doXPixelAlive() done
[13:33:41.094] INFO: PixTest:: pg_setup set to default.
[13:33:41.104] INFO: enter test to run
[13:34:14.165] INFO: test: HighRate no parameter change
[13:34:14.165] INFO: running: highrate
[13:34:14.166] INFO: ----------------------------------------------------------------------
[13:34:14.166] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:34:14.166] INFO: ----------------------------------------------------------------------
[13:34:14.779] INFO: Expecting 208000 events.
[13:34:28.520] INFO: 208000 events read in total (13214ms).
[13:34:28.525] INFO: Test took 14350ms.
[13:34:28.825] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:34:29.130] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[13:34:29.130] INFO: number of red-efficiency pixels: 286 162 245 477 510 577 487 303 244 543 411 398 436 265 67 62
[13:34:29.130] INFO: number of X-ray hits detected: 148008 95468 140743 215023 227649 238883 235595 175859 162104 221409 211438 189166 197940 119523 48861 56608
[13:34:29.130] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:34:29.130] INFO: number of Vcal hits detected: 207698 207830 207730 207473 207445 207353 207480 207665 207741 207397 207556 207566 207532 207708 207883 207938
[13:34:29.130] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.8 99.7 99.8 99.9 99.9 99.7 99.8 99.8 99.8 99.9 100.0 100.0
[13:34:29.130] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.7 99.7 99.7 99.8 99.8 99.9 99.7 99.8 99.8 99.8 99.9 99.9 100.0
[13:34:29.130] INFO: X-ray hit rate [MHz/cm2]: 43.4 28.0 41.3 63.0 66.7 70.0 69.1 51.5 47.5 64.9 62.0 55.4 58.0 35.0 14.3 16.6
[13:34:29.130] INFO: PixTestHighRate::doXPixelAlive() done
[13:34:29.180] INFO: PixTest:: pg_setup set to default.
[13:34:29.192] INFO: enter test to run
[13:34:49.357] INFO: test: HighRate no parameter change
[13:34:49.357] INFO: running: highrate
[13:34:49.358] INFO: ----------------------------------------------------------------------
[13:34:49.358] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:34:49.358] INFO: ----------------------------------------------------------------------
[13:34:49.977] INFO: Expecting 208000 events.
[13:35:05.652] INFO: 208000 events read in total (15148ms).
[13:35:05.659] INFO: Test took 16290ms.
[13:35:06.116] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:35:06.470] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[13:35:06.470] INFO: number of red-efficiency pixels: 638 326 643 1138 1305 1359 1031 704 459 1243 1109 864 1009 541 105 105
[13:35:06.470] INFO: number of X-ray hits detected: 222853 143920 213773 325255 344732 359069 354785 266710 245392 337029 320289 285437 299528 180862 74463 85941
[13:35:06.470] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[13:35:06.470] INFO: number of Vcal hits detected: 207199 207623 207173 206523 206331 206178 206669 207134 207475 206372 206609 206936 206788 207285 207841 207891
[13:35:06.470] INFO: Vcal hit fiducial efficiency (%): 99.7 99.8 99.6 99.4 99.3 99.2 99.4 99.6 99.8 99.3 99.4 99.6 99.5 99.7 99.9 99.9
[13:35:06.470] INFO: Vcal hit overall efficiency (%): 99.6 99.8 99.6 99.3 99.2 99.1 99.4 99.6 99.7 99.2 99.3 99.5 99.4 99.7 99.9 99.9
[13:35:06.470] INFO: X-ray hit rate [MHz/cm2]: 65.3 42.2 62.7 95.3 101.0 105.2 104.0 78.2 71.9 98.8 93.9 83.7 87.8 53.0 21.8 25.2
[13:35:06.470] INFO: PixTestHighRate::doXPixelAlive() done
[13:35:06.516] INFO: PixTest:: pg_setup set to default.
[13:35:06.534] INFO: enter test to run
[13:35:11.373] INFO: test: exit no parameter change
[13:35:11.774] QUIET: Connection to board 33 closed.
[13:35:11.790] INFO: pXar: this is the end, my friend