Test Date: 2016-09-13 19:27
Analysis date: 2016-09-19 15:13
Logfile
hrData_40.log
[13:11:02.111] INFO: *** Welcome to pxar ***
[13:11:02.111] INFO: *** Today: 2016/09/19
[13:11:04.480] INFO: *** Version: v1.9.0-818-g96727
[13:11:04.480] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//dacParameters35_C15.dat
[13:11:04.600] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//tbmParameters_C0b.dat
[13:11:04.600] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//defaultMaskFile.dat
[13:11:04.605] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C15.dat
[13:11:05.206] INFO: clk: 4
[13:11:05.206] INFO: ctr: 4
[13:11:05.206] INFO: sda: 19
[13:11:05.206] INFO: tin: 9
[13:11:05.206] INFO: level: 15
[13:11:05.206] INFO: triggerdelay: 0
[13:11:05.206] QUIET: Instanciating API for pxar v1.9.0+814~g74979a6
[13:11:05.206] INFO: Log level: INFO
[13:11:05.223] QUIET: Connection to board DTB_WREKRL opened.
[13:11:05.227] 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:11:05.229] INFO: RPC call hashes of host and DTB match: 398089610
[13:11:06.767] INFO: DUT info:
[13:11:06.767] INFO: The DUT currently contains the following objects:
[13:11:06.767] INFO: 2 TBM Cores tbm08c (2 ON)
[13:11:06.781] INFO: TBM Core alpha (0): 7 registers set
[13:11:06.782] INFO: TBM Core beta (1): 7 registers set
[13:11:06.782] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:11:06.782] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:06.782] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:11:07.242] INFO: enter 'restricted' command line mode
[13:11:07.242] INFO: enter test to run
[13:11:15.555] INFO: test: PixelAlive no parameter change
[13:11:15.555] INFO: running: pixelalive
[13:11:15.612] INFO: ----------------------------------------------------------------------
[13:11:15.612] 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:11:15.612] INFO: ----------------------------------------------------------------------
[13:11:15.930] INFO: Expecting 41600 events.
[13:11:20.153] INFO: 41600 events read in total (3505ms).
[13:11:20.322] INFO: Test took 4708ms.
[13:11:20.329] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:11:20.824] INFO: PixTestAlive::aliveTest() done
[13:11:20.824] INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 3 0 0 0 0 0
[13:11:20.985] INFO: enter test to run
[13:12:02.010] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[13:12:02.010] INFO: running: highrate
[13:12:02.024] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[13:12:03.478] INFO: ----------------------------------------------------------------------
[13:12:03.479] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[13:12:03.479] INFO: ----------------------------------------------------------------------
[13:12:03.479] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[13:12:03.479] INFO: edge/corner pixel THR is adjusted
[13:12:03.479] INFO: PixTestHighRate::trimHotPixels: step 0...
[13:12:04.437] INFO: Collecting data for 5 seconds...
[13:12:09.454] INFO: Done with hot pixel readout
[13:12:20.594] INFO: PixTest:: pg_setup set to default.
[13:12:20.595] INFO: 4 hot pixels found in step 0
[13:12:21.583] INFO: Collecting data for 5 seconds...
[13:12:26.600] INFO: Done with hot pixel readout
[13:12:37.746] INFO: PixTest:: pg_setup set to default.
[13:12:37.747] INFO: 5 hot pixels found in step 1
[13:12:38.741] INFO: Collecting data for 5 seconds...
[13:12:43.759] INFO: Done with hot pixel readout
[13:12:54.353] INFO: PixTest:: pg_setup set to default.
[13:12:54.354] INFO: 3 hot pixels found in step 2
[13:12:55.346] INFO: Collecting data for 5 seconds...
[13:13:00.363] INFO: Done with hot pixel readout
[13:13:11.309] INFO: PixTest:: pg_setup set to default.
[13:13:11.310] INFO: 5 hot pixels found in step 3
[13:13:12.302] INFO: Collecting data for 5 seconds...
[13:13:17.319] INFO: Done with hot pixel readout
[13:13:28.179] INFO: PixTest:: pg_setup set to default.
[13:13:28.180] INFO: 7 hot pixels found in step 4
[13:13:29.172] INFO: Collecting data for 5 seconds...
[13:13:34.190] INFO: Done with hot pixel readout
[13:13:45.040] INFO: PixTest:: pg_setup set to default.
[13:13:45.040] INFO: 5 hot pixels found in step 5
[13:13:46.032] INFO: Collecting data for 5 seconds...
[13:13:51.048] INFO: Done with hot pixel readout
[13:14:01.972] INFO: PixTest:: pg_setup set to default.
[13:14:01.973] INFO: 2 hot pixels found in step 6
[13:14:02.964] INFO: Collecting data for 5 seconds...
[13:14:07.981] INFO: Done with hot pixel readout
[13:14:18.759] INFO: PixTest:: pg_setup set to default.
[13:14:18.760] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found

[13:14:18.760] INFO: 4 hot pixels found in step 7
[13:14:19.753] INFO: Collecting data for 5 seconds...
[13:14:24.771] INFO: Done with hot pixel readout
[13:14:35.704] INFO: PixTest:: pg_setup set to default.
[13:14:35.705] INFO: 0 hot pixels found in step 8
[13:14:35.740] INFO: 0 hot pixels could not be trimmed and have been masked.
[13:14:35.913] INFO: PixTest::trimHotPixels() done
[13:14:35.963] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C0.dat
[13:14:35.990] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C1.dat
[13:14:35.001] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C2.dat
[13:14:36.007] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C3.dat
[13:14:36.012] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C4.dat
[13:14:36.018] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C5.dat
[13:14:36.023] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C6.dat
[13:14:36.046] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C7.dat
[13:14:36.052] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C8.dat
[13:14:36.057] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C9.dat
[13:14:36.063] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C10.dat
[13:14:36.068] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C11.dat
[13:14:36.073] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C12.dat
[13:14:36.079] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C13.dat
[13:14:36.084] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C14.dat
[13:14:36.089] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C15.dat
[13:14:36.095] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//defaultMaskFile.dat
[13:14:36.111] INFO: enter test to run
[13:15:09.713] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[13:15:09.713] INFO: running: highrate
[13:15:09.717] INFO: ----------------------------------------------------------------------
[13:15:09.718] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[13:15:09.718] INFO: ----------------------------------------------------------------------
[13:15:09.718] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[13:15:09.718] INFO: edge/corner pixel THR is adjusted
[13:15:09.718] INFO: PixTestHighRate::trimHotPixels: step 0...
[13:15:10.675] INFO: Collecting data for 1 seconds...
[13:15:11.678] INFO: Done with hot pixel readout
[13:15:15.653] INFO: PixTest:: pg_setup set to default.
[13:15:15.654] INFO: 0 hot pixels found in step 0
[13:15:15.659] INFO: 0 hot pixels could not be trimmed and have been masked.
[13:15:15.744] INFO: PixTest::trimHotPixels() done
[13:15:15.744] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C0.dat
[13:15:15.757] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C1.dat
[13:15:15.763] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C2.dat
[13:15:15.768] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C3.dat
[13:15:15.773] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C4.dat
[13:15:15.778] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C5.dat
[13:15:15.784] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C6.dat
[13:15:15.789] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C7.dat
[13:15:15.794] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C8.dat
[13:15:15.800] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C9.dat
[13:15:15.805] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C10.dat
[13:15:15.810] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C11.dat
[13:15:15.816] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C12.dat
[13:15:15.821] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C13.dat
[13:15:15.826] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C14.dat
[13:15:15.831] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//trimParameters35_C15.dat
[13:15:15.837] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-P-6-29_FPIXTest-17C-FNAL-160913-1810-300V_2016-09-13_18h23m_1473808983/000_FPIXTest_p17//defaultMaskFile.dat
[13:15:15.847] INFO: enter test to run
[13:15:49.417] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[13:15:49.417] INFO: running: xray
[13:15:49.430] INFO: ----------------------------------------------------------------------
[13:15:49.430] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[13:15:49.430] INFO: ----------------------------------------------------------------------
[13:15:50.418] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[13:16:01.770] INFO: run duration 11 seconds, buffer almost full (81%), pausing triggers.
[13:16:30.772] INFO: Resuming triggers.
[13:16:42.126] INFO: run duration 22 seconds, buffer almost full (81%), pausing triggers.
[13:17:10.211] INFO: Resuming triggers.
[13:17:21.568] INFO: run duration 33 seconds, buffer almost full (81%), pausing triggers.
[13:17:50.343] INFO: Resuming triggers.
[13:18:01.696] INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[13:18:30.042] INFO: Resuming triggers.
[13:18:41.394] INFO: run duration 56 seconds, buffer almost full (81%), pausing triggers.
[13:19:09.953] INFO: Resuming triggers.
[13:19:21.308] INFO: run duration 67 seconds, buffer almost full (81%), pausing triggers.
[13:19:48.548] INFO: Resuming triggers.
[13:19:59.908] INFO: run duration 79 seconds, buffer almost full (81%), pausing triggers.
[13:20:27.774] INFO: Resuming triggers.
[13:20:39.132] INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[13:21:06.657] INFO: Resuming triggers.
[13:21:16.135] INFO: data taking finished, elapsed time: 100 seconds.
[13:21:39.231] INFO: PixTest:: pg_setup set to default.
[13:21:39.235] INFO: PixTestXray::doPhRun() done
[13:21:39.506] INFO: enter test to run
[13:22:22.814] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[13:22:22.814] INFO: running: xray
[13:22:22.815] INFO: ----------------------------------------------------------------------
[13:22:22.815] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[13:22:22.815] INFO: ----------------------------------------------------------------------
[13:22:23.779] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[13:22:30.301] INFO: run duration 6 seconds, buffer almost full (81%), pausing triggers.
[13:22:59.868] INFO: Resuming triggers.
[13:23:06.393] INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[13:23:06.664] WARNING: Channel 0 ROC 5: Readback start marker after 11 readouts!

[13:23:06.664] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (2) != Token Chain Length (8)

[13:23:06.664] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:23:06.664] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00d 80c0 43c8 359 2848 43c8 ca 2866 43c8 43c8 43c8 43c8 4cc 244f 742 244a 43c8 43c8 30d 284f 492 2860 e000 c000

[13:23:06.664] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a007 8040 4388 50 2825 4d9 2041 4388 354 284d 4388 643 284f 4388 40c 2a47 4388 412 2440 493 2264 4d4 2645 51d 204a 6d4 2844 4388 2dd 2061 692 2a45 4388 4d9 222f 4388 410 222d 410 2624 e000 c000

[13:23:06.664] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a008 80b1 4388 159 264c 4388 4388 48c 2048 4388 649 2444 4388 754 284c 4388 4d 2865 51c 284d 61b 2467 750 264a 4388 111 202c 35b 2a4f 4ca 224f 74d 2847 4388 19 224d e000 c000

[13:23:06.664] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a009 80c0 4388 15 2644 db 2460 749 224f 4388 4388 dd 2a61 4388 1a 204f 70b 2442 70b 204f 70c 2248 4388 4388 da 2a4f 320 2242 4c9 2063 4388 12 2a44 35a 284f 34b 286f 809 264b 4388 c8 222c 112 2442 349 284d 35a 224f e000 c000

[13:23:06.664] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00a 8000 4388 119 2844 4388 15c 2049 53c8 43c8 43c8 c5 250b 170d 2ef0 2ae 2f7f f34 2f28 43cb 2734 700 43c8 13 286d 11d 264f 43c8 19 2442 d 244f 49 2040 552 284d e000 c000

[13:23:06.664] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00b 8040 43c8 91 206b 43c8 43c8 43c8 43c8 15 264a 251 284f 312 2842 692 2a40 75c 2a09 850 222e 43c8 8 244b 4cc 284b 548 264f 43c8 54d 264a 6d5 2443 43c8 2dc 2441 e000 c000

[13:23:06.664] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00c 80b1 43c8 1a 204a 43c8 43c8 43c8 411 2042 43c8 420 2445 43c8 68a 206a 43c8 35b 224e 43c8 9a 284d 112 2847 60a 2061 e000 c000

[13:23:06.664] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:23:06.664] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10d 80c0 43c8 54 2446 4c0 2449 43c8 48 284b 43ca 10 2241 43c8 6c9 282b 43c8 2c3 244f 43c8 43c8 29c 2444 43c8 11b 224d e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a107 8040 4388 4d4 2464 4388 14 284d 8 264f 809 284a 4388 814 2243 4388 4388 30a 2a4f 691 206d 4388 4388 6e1 204c 4388 e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a108 80b1 4388 118 2042 410 242c 4388 4388 2d3 2685 4388 252 222c 549 2845 4388 2cd 2064 509 2884 4388 4388 4388 e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a109 80c0 4388 20d 2848 4388 545 2a61 748 2a2a 819 204f 4388 4388 4388 d4 286d 4388 4388 4388 e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10a 8000 4388 4388 11d 2445 48a 2a85 14cb 266f 748 259a aae 3fff f6a 200f aea 2087 3e7 2f2f 87 28a6 28a0 9b4 e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10b 8040 43c8 602 264d 43c8 109 2829 43c8 2dc 204c 604 2861 690 2a42 43c8 6d9 2841 43c8 455 244e 688 2449 43c8 485 2a4d 43c8 43c8 708 284d e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10c 80b1 43c8 80d 2a4a 43c8 15 2868 559 2a2b 43c8 90 284f 43c8 55a 2a44 858 204b 43c8 5a 204a 43c8 43c8 312 222f 43c8 49a 2861 e000 c000

[13:23:06.665] WARNING: Channel 0 ROC 5: Readback start marker after 5 readouts!

[13:23:06.665] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a012 8000 43c8 21c 2a48 813 244d 43c8 43c8 43c9 43c8 1c 2843 660 284f 43c8 213 248d 6ca 2062 75a 2a68 43c9 48 2829 43c9 15a 2460 2d5 2649 354 242a 40b 224a e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00c 80b1 43c8 1a 204a 43c8 43c8 43c8 411 2042 43c8 420 2445 43c8 68a 206a 43c8 35b 224e 43c8 9a 284d 112 2847 60a 2061 e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00d 80c0 43c8 359 2848 43c8 ca 2866 43c8 43c8 43c8 43c8 4cc 244f 742 244a 43c8 43c8 30d 284f 492 2860 e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00e 8000 43c8 94 2a40 419 2484 43c8 43ca 2d8 2644 43ca 5a 2842 4d1 226f 43ca 704 2a66 43c8 dc 284f 43c8 0 2440 403 284d 813 2a81 43ca 112 2444 359 224f e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00f 8040 43ca 690 2044 43ca 1b 2a42 43c8 43c8 43c8 51d 2a4d 43ca 70b 2a63 43ca 60 204b 458 2a47 70b 2a49 43c8 299 2a47 e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a010 80b1 43c8 21a 204c 43c8 1a 2848 43c8 43c8 18 284c 21c 2a49 308 2a2d 609 2242 752 2661 43c9 5d 2a60 81a 2641 43c8 43c8 44c 2860 688 2a2c 43c9 40 2822 252 2447 459 244c 650 2868 e000 c000

[13:23:06.665] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a011 80c0 43c8 43c8 43c9 68b 2049 43c9 10b 2a44 851 2a4d 43c8 43c9 c8 222f 520 2085 555 2066 43c9 43c9 314 2464 e000 c000

[13:23:35.647] INFO: Resuming triggers.
[13:23:42.169] INFO: run duration 19 seconds, buffer almost full (81%), pausing triggers.
[13:24:11.668] INFO: Resuming triggers.
[13:24:18.187] INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[13:24:47.516] INFO: Resuming triggers.
[13:24:54.037] INFO: run duration 32 seconds, buffer almost full (81%), pausing triggers.
[13:25:23.554] INFO: Resuming triggers.
[13:25:30.079] INFO: run duration 39 seconds, buffer almost full (81%), pausing triggers.
[13:26:00.179] INFO: Resuming triggers.
[13:26:06.698] INFO: run duration 45 seconds, buffer almost full (81%), pausing triggers.
[13:26:37.047] INFO: Resuming triggers.
[13:26:43.566] INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[13:27:14.097] INFO: Resuming triggers.
[13:27:20.617] INFO: run duration 58 seconds, buffer almost full (81%), pausing triggers.
[13:27:50.040] INFO: Resuming triggers.
[13:27:56.557] INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[13:28:26.203] INFO: Resuming triggers.
[13:28:32.722] INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[13:29:02.425] INFO: Resuming triggers.
[13:29:08.944] INFO: run duration 77 seconds, buffer almost full (81%), pausing triggers.
[13:29:38.648] INFO: Resuming triggers.
[13:29:45.168] INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[13:30:14.796] INFO: Resuming triggers.
[13:30:21.317] INFO: run duration 90 seconds, buffer almost full (81%), pausing triggers.
[13:30:50.004] INFO: Resuming triggers.
[13:30:57.530] INFO: run duration 97 seconds, buffer almost full (81%), pausing triggers.
[13:30:57.766] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 4 ROCs were found

[13:30:57.766] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (2) != Token Chain Length (8)

[13:30:57.766] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (145) != TBM ID (143)

[13:30:57.766] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (1) != Token Chain Length (8)

[13:30:57.766] ERROR: <datapipe.cc/CheckEventID:L463> Channel 1 Event ID mismatch: local ID (145) != TBM ID (252)

[13:30:57.766] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (5) != Token Chain Length (8)

[13:30:57.766] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (144) != TBM ID (145)

[13:30:57.766] ERROR: <datapipe.cc/CheckEventID:L463> Channel 1 Event ID mismatch: local ID (253) != TBM ID (145)

[13:30:57.766] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a094 80b1 43c8 313 2669 43c8 d8 2464 43c8 43c8 5 2462 28a 2869 61b 244a 43c8 9a 2460 2dd 2649 814 262b 43c8 43c8 d 2a44 45c 2645 55b 284a 43c8 114 202d 510 264a 6a1 2445 e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08f 8040 438a 155 202c 51a 2064 438a 4388 4388 98 244c 21d 246e 61b 224b 4388 58 2a45 2cb 224d 611 2647 85d 282d 438a 21d 2a44 550 2662 81d 2666 438a d5 2a4d 25d 206b 45a 244d 4c3 2247 4388 99 246e e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a090 80b1 4388 43c8 53c8 43c8 95 27ff

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08f 80f5 72f 22d4 5d5 356c 54d 21df dda 2a09 859 2a90 559 2b59 689 43c8 213 2264 352 2644 659 244f 43c9 461 2a88 4c3 244d e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a091 80c0 43c8 15b 2844 44a 2466 4db 2a47 43c8 292 264f 43c9 4d5 2061 642 2a4c 43c9 284 2844 43c8 db 284d d1 2246 31b 204f 414 224c 459 2a47 43c9 4 2a44 db 286f 43c9 11 2840 25a 2488 74a 2a46 43c9 49 2a4c 20b 2480 e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a092 8000 43c8 43c8 43c8 261 204e 653 2a85 43c9 485 2240 43c8 10b 224e 849 222f 85c 224e 43c8 415 286f 43c9 d 2462 da 2862 43c9 e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a093 8040 43c8 43c9 43c8 801 2a4b 43c8 218 2841 43c8 209 2a4f 604 262a 688 2645 43c9 61c 2a69 43c8 11 2464 204 2a48 43c8 e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a194 80b1 43c8 2c8 224e 2d2 2661 4d0 2047 71b 206a 43c8 dd 2868 2d1 2465 40c 2668 54d 264b 43c8 602 2067 849 2662 43c8 293 284d 45b 2865 442 2264 43c8 89 2442 45c 282a 43c8 43c8 762 2442 43c8 e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a18f 8040 438a 438a 254 2045 48a 224f 650 2a6f 65a 2a82 4388 60 244e 6c4 2642 438a 6d5 2a40 84a 2644 438a 15 2461 68a 204a 438a 438a 438a e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a190 80b1 4389 43c9 110c 2044 212 2b6a 140 266b 9 2abf

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1fc 90df 514 23c0 200 2524 d68 2146 43c9 2109 d06 43c9 43c9 43c9 43c9 e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a191 80c0 43c8 48a 2067 43c8 80c 2a41 43c8 210 2261 64a 244e 43c8 493 2847 43c9 311 2066 43c9 43c9 43c9 103 2843 e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a192 8000 43c8 258 264e 712 2664 849 282f 43c8 4d 244f 43c8 105 2262 43c9 61c 242c 6c5 244f 43c8 4da 2a4f 43c8 43c9 43c9 e000 c000

[13:30:57.766] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a193 8040 43c8 43c9 75a 2449 43c8 358 2247 4d1 288a 43c9 562 206c 43c8 4c9 204c 43c9 43c8 65c 2829 43c9 e000 c000

[13:31:27.272] INFO: Resuming triggers.
[13:31:29.785] INFO: data taking finished, elapsed time: 100 seconds.
[13:31:41.574] INFO: PixTest:: pg_setup set to default.
[13:31:41.578] INFO: PixTestXray::doPhRun() done
[13:31:41.749] INFO: enter test to run
[13:32:00.538] INFO: test: HighRate no parameter change
[13:32:00.538] INFO: running: highrate
[13:32:00.557] INFO: ----------------------------------------------------------------------
[13:32:00.557] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[13:32:00.557] INFO: ----------------------------------------------------------------------
[13:32:00.723] INFO: Expecting 768 events.
[13:32:01.874] INFO: 768 events read in total (436ms).
[13:32:01.874] INFO: Test took 1290ms.
[13:32:02.678] INFO: Expecting 41600 events.
[13:32:05.661] INFO: 41600 events read in total (2457ms).
[13:32:05.663] INFO: Test took 3598ms.
[13:32:05.710] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:06.424] INFO: Expecting 41600 events.
[13:32:09.575] INFO: 41600 events read in total (2624ms).
[13:32:09.576] INFO: Test took 3848ms.
[13:32:09.610] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:10.333] INFO: Expecting 41600 events.
[13:32:13.505] INFO: 41600 events read in total (2645ms).
[13:32:13.506] INFO: Test took 3877ms.
[13:32:13.540] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:14.267] INFO: Expecting 41600 events.
[13:32:17.437] INFO: 41600 events read in total (2644ms).
[13:32:17.438] INFO: Test took 3879ms.
[13:32:17.472] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:18.196] INFO: Expecting 41600 events.
[13:32:21.384] INFO: 41600 events read in total (2661ms).
[13:32:21.385] INFO: Test took 3895ms.
[13:32:21.420] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:22.140] INFO: Expecting 41600 events.
[13:32:25.347] INFO: 41600 events read in total (2680ms).
[13:32:25.348] INFO: Test took 3911ms.
[13:32:25.383] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:26.107] INFO: Expecting 41600 events.
[13:32:27.637] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 5 ROCs were found

[13:32:27.637] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 6 ROCs were found

[13:32:27.637] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:32:27.637] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ca 8000 43c8 43 2688 43c9 43 268f 43c8 43 26a3 43c8 43 2681 43c8 43 26a2 43c8 43 26a2 4a 2a44 24b 2269 43c9 43 268c 43c9 43 2687 694 2a25 e002 c000

[13:32:27.637] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c4 80b1 4388 43 268a 4388 43 268f 4388 43 268f 4388 43 2685 4388 43 268f 4388 43 26a7 4388 43 268d 342 2245 4388 43 2685 e002 c000

[13:32:27.637] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c5 80c0 4388 43 2689 4388 43 268c 4388 43 268f 4388 43 2685 4388 43 26a1 4388 43 268f 4388 43 2685 351 2645 4388 43 2682 e002 c000

[13:32:27.637] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c6 8000 4388 43 2688 113 262f 4388 43 268b 4388 43 268b 505 282a 855 2a42 4388 10a 2242 4388 43 268e 4388 43 26a2 10a 244d 4388 43 268b 54c 2424 4388 43 2687 4cb 2044 e002 c000

[13:32:27.637] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a0c7 8040 4388 59 202d 43 268f 94 2447 4388 43 268f 4d8 284b 4389 43 268f 4389 43 2682 41a 2446 459 2849 43c9 42 3977 d5d 273a 1b7f 2d5d 73a 2b7f d55 273d 7e8 43c9 901 2f01 7 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

[13:32:27.637] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c8 80b1 43c9 43 268c 43c9 43 268b 43c8 43 26a2 6d0 2242 43c8 2 2a41 43 266e 490 282d 43c8 43 268f 35c 266e 43c9 43 26a5 43c8 43 268f 43c9 43 2682 4d5 2845 e002 c000

[13:32:27.638] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c9 80c0 43c8 43 2686 6d8 2a41 43c8 43 268d 113 246a 43c8 43 268f 43c8 43 2681 650 2844 81b 2a4d 43c8 43 268d 53 2264 43c8 43 26aa 43c9 43 268f 43c9 43 2683 e002 c000

[13:32:27.638] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:32:27.638] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ca 8000 43c9 43 268a 400 2621 43c8 43 268d 74a 2442 43c9 43 2681 9a 2a65 43c8 43 268d 2d9 2648 43c8 43 26ae 43c8 43 26a4 43c9 43 26a5 9b 2883 43c8 43 26ab e002 c000

[13:32:27.638] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c4 80b1 4388 43 268c 654 2443 4388 43 268f 154 2a4c 40b 226d 6cd 2642 4388 43 266f 4388 43 268d 4388 43 26a5 4388 43 26a7 4388 43 26a1 4388 43 26ad e002 c000

[13:32:27.638] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c5 80c0 4388 43 268b 4388 43 26a1 4388 43 266f 4388 43 26a1 31c 2642 4388 43 26a9 443 2049 4388 43 268f 2cb 2862 4388 43 26a4 4388 43 26a7 e002 c000

[13:32:27.638] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c6 8000 4388 43 268a 4388 43 268f 349 2662 4389 43 2683 4388 43 26a5 744 2a68 4388 43 26a5 4388 43 268c 4388 43 26a1 4388 43 26ad e002 c000

[13:32:27.638] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a1c7 8040 4388 43 2685 560 244c 4388 d 224f 43 26a7 4388 43 2682 4388 43 26a9 4388 43 26a9 114 2a45 43c8 43 26a7 1eed 200f 899 36bf f 2899 6ba 2003 881 26e7 aa0 208f 57f 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

[13:32:27.638] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c8 80b1 43c8 43 2685 43c9 43 268f 43c8 43 2680 34b 2a4c 4dc 2a4f 43c9 43 26a3 43c9 43 26aa 9c 264d 28a 284d 43c9 43 26a2 43c9 43 26a5 43c9 43 26a9 e002 c000

[13:32:27.638] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c9 80c0 43c9 43 268c 152 2265 43c8 43 268f 43c9 43 2681 43c8 43 26a2 43c8 43 26a5 51d 2a62 43c8 43 26a2 43c8 43 26a1 43c8 43 26a9 e002 c000

[13:32:29.299] INFO: 41600 events read in total (2665ms).
[13:32:29.300] INFO: Test took 3898ms.
[13:32:29.334] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:30.057] INFO: Expecting 41600 events.
[13:32:33.293] INFO: 41600 events read in total (2709ms).
[13:32:33.294] INFO: Test took 3941ms.
[13:32:33.328] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:34.054] INFO: Expecting 41600 events.
[13:32:37.245] INFO: 41600 events read in total (2664ms).
[13:32:37.246] INFO: Test took 3899ms.
[13:32:37.282] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:37.000] INFO: Expecting 41600 events.
[13:32:41.181] INFO: 41600 events read in total (2654ms).
[13:32:41.182] INFO: Test took 3881ms.
[13:32:41.217] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:41.938] INFO: Expecting 41600 events.
[13:32:45.115] INFO: 41600 events read in total (2650ms).
[13:32:45.116] INFO: Test took 3878ms.
[13:32:45.150] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:45.876] INFO: Expecting 41600 events.
[13:32:47.290] WARNING: Channel 0 ROC 1: Readback start marker after 8 readouts!

[13:32:47.290] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (2) != Token Chain Length (8)

[13:32:47.290] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 1 ROCs were found

[13:32:47.290] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (16) != TBM ID (200)

[13:32:47.290] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ca 8000 43c8 10 2865 71a 2465 43c8 10 288c 43c9 10 2882 450 2461 43c8 10 2868 43c9 10 2885 2c9 224c 43c9 10 2861 43c9 10 2881 43c9 10 288f e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c4 80b1 4388 11 206d 4388 14 2047 11 20a1 4388 11 206f 4388 11 2068 4388 11 208f 4388 11 2083 4388 11 2085 4388 11 208f e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c5 80c0 4388 11 206f 289 2064 55b 204d 4388 11 20a7 4388 11 206f 4388 11 2067 4388 11 208a 4d 204d 4388 11 206d 4388 11 2089 4388 11 2089 e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c6 8000 4388 11 206d 4388 11 20a2 4389 11 2085 4388 11 2065 345 244f 4388 11 20a5 58 264a 58 2a2d 4388 11 2069 210 2a45 4388 11 2087 4388 11 208d e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a1c7 8040 43c8 1011 2041 55f 2ffa 807 2c0d 1ff7 28a1 40d 2f80 1efa 200d 80f 2eea 803 280f eed 3e55 1081 265c f00 28af 1fff 3c0f 80f 2fe0 0 2821 efe 201f 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

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c8 80b1 43c9 11 206c 43c9 11 20a5 a 244f 420 2086 742 2a2c 43c9 11 206f 43c9 11 2065 43c9 11 208c 43c9 11 2084 43c9 11 2089 43c9 11 208f e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c9 80c0 43c8 11 2082 43c8 11 20a9 43c8 11 206c 43c8 11 206f 43c8 11 20a5 115 2269 43c8 11 206c 115 224b 43c8 11 208c 43c8 11 208e e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0cb 8040 43c9 10 2866 43c9 10 286d 43c9 10 2883 43c9 10 2885 43c9 10 286f 43c9 10 2869 35c 2247 43c8 10 286d 43c8 10 2881 e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c6 8000 4388 11 2084 60 2841 4388 11 2081 d8 2265 4388 11 2082 448 2865 4388 11 2085 d0 2a49 4388 11 206f 4388 11 208d 4388 13 282f 11 2085 4388 11 2082 449 204a e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a0c7 8040 43c8 1011 208f ffe 2745 7f0 22af 1fac 2706 270f 16fb 215f 43c8 43ca 2155 43c8

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a00f 80cd aef 2ffc 1c2 2bf4 1599 43c8 fda 2a6a 7cc 2feb 2ae 2020 ff 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

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c8 80b1 43c9 11 206a 58 222d 43c9 11 2082 43c8 11 2084 43c8 11 208e 90 2442 43c8 11 206f 43c9 11 208d 43c9 11 2081 4ca 262f 43c8 11 2087 e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c9 80c0 43c8 11 206e 43c8 11 2087 43c8 11 2081 43c8 11 2088 844 2a6b 43c8 11 2085 2c9 284f 43c8 11 208b 43c8 11 2083 43c8 11 2086 e002 c000

[13:32:47.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ca 8000 43c8 10 2882 24d 2a4f 43c9 10 286f 43c9 10 286f 43c9 10 2885 43c9 10 286f 43c8 10 286b 43c8 10 2881 145 244f 43c8 10 2882 15d 224f e002 c000

[13:32:49.229] CRITICAL: <hal.cc/condenseTriggers:L1899> Data size does not correspond to 10 triggers! Aborting data processing!

[13:32:49.232] INFO: 0 events read in total (2829ms).
[13:32:49.232] CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L783> Incomplete DAQ data readout! Missing 4160 Events.

[13:32:49.866] INFO: Expecting 41600 events.
[13:32:53.063] INFO: 41600 events read in total (2671ms).
[13:32:53.064] INFO: Test took 3801ms.
[13:32:53.099] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:53.818] INFO: Expecting 41600 events.
[13:32:57.017] INFO: 41600 events read in total (2672ms).
[13:32:57.018] INFO: Test took 3902ms.
[13:32:57.053] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:32:57.772] INFO: Expecting 41600 events.
[13:33:00.951] INFO: 41600 events read in total (2652ms).
[13:33:00.952] INFO: Test took 3879ms.
[13:33:00.988] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:01.711] INFO: Expecting 41600 events.
[13:33:03.127] WARNING: Channel 0 ROC 5: Readback start marker after 8 readouts!

[13:33:03.127] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)

[13:33:03.127] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 3 ROCs were found

[13:33:03.127] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (152) != TBM ID (128)

[13:33:03.127] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (0) != Token Chain Length (8)

[13:33:03.127] ERROR: <datapipe.cc/CheckEventID:L463> Channel 1 Event ID mismatch: local ID (152) != TBM ID (4)

[13:33:03.128] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (0) != Token Chain Length (8)

[13:33:03.128] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (129) != TBM ID (152)

[13:33:03.128] ERROR: <datapipe.cc/CheckEventID:L463> Channel 1 Event ID mismatch: local ID (5) != TBM ID (152)

[13:33:03.128] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a09b 8040 43c8 12 2469 43c9 12 2489 43c8 12 2488 43c8 12 248b 43c8 12 2485 51b 2461 43c9 12 2482 409 2847 43c8 12 246f 43c9 12 248d 410 220d e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a096 8000 4388 12 2862 4388 12 2882 4d2 2863 4388 12 2887 4388 12 288a 15a 2048 4388 12 288c 4388 12 2887 4388 12 286f 4388 12 286d 80c 2047 e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a097 8040 4388 12 2868 4388 12 2882 4389 12 2883 4389 12 2886 43c9 14 282b 43cb fdc 23e6 f38 22ae 1bad 2706 aae 3b4f 704 23de

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a080 8094 e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a098 80b1 43c9 12 246b 43c9 12 248b 43c8 12 2487 43c8 12 248a 43c8 12 2485 412 2446 551 202f 43c9 12 2482 249 2245 655 2a4f 43c9 12 246f 10a 242f 43c8 12 246f e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a099 80c0 43c8 12 2468 758 204e 755 2846 43c8 12 2481 43c9 12 2485 43c9 12 24a1 43c9 12 2489 43c8 12 2481 202 2a6a 43c8 12 246f 43c8 12 2489 e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a09a 8000 43c9 12 2465 43c9 12 2485 43c8 12 2486 43c8 12 2485 43c8 12 248c 208 222d 43c8 12 2486 41d 2a65 43c8 12 2482 54a 222a 43c8 12 248b e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a19b 8040 43c9 12 2485 43c9 12 24a5 43c8 12 2483 43c8 12 2465 43c8 12 24a4 43c9 12 246f 43c8 12 2489 43c9 12 248b e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a196 8000 4388 12 2868 4388 12 2885 28d 2665 28d 2a43 4389 12 286f 118 2045 4388 12 286a 4388 12 288f 4388 14 2823 12 2881 4388 12 2886 4388 12 288c e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a197 8040 4388 12 286c 359 2460 4388 12 28a5 41b 2a82 4388 12 2886 445 286d 80a 2ee8 6a7 209f c0f 3ff2 8a1

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== b104 8053 f77 2334 38 2012 88f e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a198 80b1 43c9 12 2469 43c9 12 248f 209 284b 43c9 12 2482 43c9 12 2468 262 2845 43c9 12 24a1 43c9 12 246f 349 284d 43c9 12 2489 43c9 12 248f e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a199 80c0 43c8 12 2467 11 2067 84a 2847 43c8 12 24ad 43c9 12 2483 43c8 12 2465 35b 2467 43c8 12 24a1 43c8 12 246b 43c9 12 248d 43c8 12 248c e002 c000

[13:33:03.128] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a19a 8000 43c8 12 2469 43c8 12 24a9 43c8 12 2485 43c9 12 246a 43c9 12 24a5 71a 2a64 43c9 12 2469 43c8 12 2487 43c9 12 24a1 e002 c000

[13:33:04.852] CRITICAL: <hal.cc/condenseTriggers:L1899> Data size does not correspond to 10 triggers! Aborting data processing!

[13:33:04.854] INFO: 0 events read in total (2616ms).
[13:33:04.855] CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L783> Incomplete DAQ data readout! Missing 4160 Events.

[13:33:05.458] INFO: Expecting 41600 events.
[13:33:08.638] INFO: 41600 events read in total (2653ms).
[13:33:08.639] INFO: Test took 3784ms.
[13:33:08.674] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:09.396] INFO: Expecting 41600 events.
[13:33:12.564] INFO: 41600 events read in total (2641ms).
[13:33:12.565] INFO: Test took 3873ms.
[13:33:12.599] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:13.323] INFO: Expecting 41600 events.
[13:33:14.791] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 3 ROCs were found

[13:33:14.791] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (5) != Token Chain Length (8)

[13:33:14.791] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (73) != TBM ID (2)

[13:33:14.791] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (4) != Token Chain Length (8)

[13:33:14.791] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (3) != TBM ID (73)

[13:33:14.791] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14b 8040 43c9 5d 248f 43c8 5d 24a5 43c8 5d 2488 48d 2063 43c8 5d 248b 43c9 5d 24a4 43c9 5d 248f 43c8 5d 24a3 43c9 5d 24a4 e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a145 80c0 4388 5d 288a 4388 5d 288e 4388 5d 288b 4388 5d 288d 4388 5d 28a1 4388 5d 288d 4388 5d 28a1 4388 5d 28a7 e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a146 8000 4388 5d 2888 710 286f 4388 5d 28a2 4389 5d 288c 4388 5d 288c 4388 5d 28a5 4388 5d 28a1 30d 2a63 4388 5d 28a1 554 286f 4388 5d 28a9 e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a147 8040 4388 5d 288a 4388 5d 28a5 212 2668 212 2a49 4388 5d 288a 6c4 2848 4388 5d 288a 4388 5d 28a7 4388 5d 2888 2c5 2645 4388 5d 28a1 4388 5d 28a9 e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a148 80b1 4389 5d 2885 854 242d 43c9 5d 28a1 50b 2656 803 2de8 276 2072 bb 210e 130 43c9 5d 28aa 43c9 5d 28a1 43c9 5d 28a2 43c9 5d 28a7 e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a149 80c0 43c8 5d 2885 43c8 5d 2888 43c9 5d 2888 43c8 5d 288d 43c8 5d 288f 43c8 5d 28a5 43c9 5d 288f 84c 2265 43c8 5d 28a5 e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14a 8000 43c8 5d 248a 43c9 5d 24a1 759 246d 43c9 5d 2489 43c9 5d 248c 55b 2649 43c9 5d 24a7 359 2666 500 2648 43c9 5d 248d 45c 2845 43c8 5d 248f 43c9 5d 24a7 e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04c 80b1 43c8 5d 2484 458 2a4d 43c8 5d 2485 43c9 5d 2489 43c9 5d 2489 313 2444 612 204c 43c8 14 204f 5d 24a5 43c8 5d 24a5 34d 2262 43c8 5d 24a0 461 284f 64b 2a4c 43c8 5d 246f e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a047 8040 4388 5d 288d 4388 5d 288b 4389 5d 288f 4389 5d 286c 551 282d 4389 5d 288b 4388 5d 28a4 215 224c 4388 5d 28a4 443 2249 4389 5d 2882 299 224f e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a048 80b1 4389 5d 2884 4d 2842 4389 5d 288e 43c8 54 27fd 657

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a002 80ec 37b 226c 43c8 2260 2ec 43c9 5d 28a7 43c9 5d 288f 6dd 2a4f 43c8 5d 2887 2d8 2a47 e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a049 80c0 43c8 5d 288d 43c9 5d 2888 43c9 5d 2888 358 2641 43c9 5d 2886 249 2a69 43c9 5d 28a1 43c8 5d 28a2 43c8 5d 288f 43c8 5d 286d e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04a 8000 43c9 5d 2484 55d 282f 43c8 5d 248a 43c8 5d 248b 43c8 5d 2485 43c8 5d 248d 2db 284c 43c9 13 204f 5d 24a1 43c8 5d 248a 43c9 5d 2481 288 224f e002 c000

[13:33:14.791] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04b 8040 43c8 5d 2485 43c8 5d 2487 43c8 5d 248f 43c8 5d 2481 43c9 5d 248b 751 2229 43c8 5d 24a2 860 2269 43c9 4 244d 5d 24a7 158 2665 43c8 5d 246d e002 c000

[13:33:16.668] CRITICAL: <hal.cc/condenseTriggers:L1899> Data size does not correspond to 10 triggers! Aborting data processing!

[13:33:16.671] INFO: 0 events read in total (2821ms).
[13:33:16.671] CRITICAL: <hal.cc/MultiRocAllPixelsCalibrate:L783> Incomplete DAQ data readout! Missing 4160 Events.

[13:33:17.278] INFO: Expecting 41600 events.
[13:33:20.378] INFO: 41600 events read in total (2573ms).
[13:33:20.379] INFO: Test took 3708ms.
[13:33:20.414] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:21.137] INFO: Expecting 41600 events.
[13:33:24.206] INFO: 41600 events read in total (2543ms).
[13:33:24.207] INFO: Test took 3775ms.
[13:33:24.242] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:24.964] INFO: Expecting 41600 events.
[13:33:26.423] WARNING: Channel 0 ROC 4: Readback start marker after 1 readouts!

[13:33:26.423] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (7) != Token Chain Length (8)

[13:33:26.423] WARNING: Channel 1 ROC 2: Readback start marker after 2 readouts!

[13:33:26.423] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)

[13:33:26.423] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:33:26.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a072 8000 43c8 62 246f 43c8 62 248a 43c8 62 24a7 43c9 62 248c 288 2a2d 64d 2242 43c8 62 248e 6a1 282d 43c8 62 24ac 84d 2265 43c9 62 24a0 14c 2848 43c9 62 2485 e002 c000

[13:33:26.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06c 80b1 4389 62 2864 4389 62 286d 61 264f 4389 62 28a1 754 284f 4389 62 286f 4389 62 288f 4388 62 28a9 4389 62 288d 4389 62 2882 152 2a4a e002 c000

[13:33:26.423] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06d 80c0 4389 62 286e 4388 62 2880 4388 62 28a5 4388 62 286f 4389 62 288b 4389 62 28a5 4388 62 288b 4389 62 2887 e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06e 8000 4388 62 2867 4389 62 2881 438b 62 28a2 438b 62 286f 438b 62 288f 4389 62 28a7 4388 c 282f 62 288d 6d1 2244 84d 2041 438b 62 2882 200 2469 e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06f 8040 438a 62 2866 1710 2a66 43cb 60 43cb fc0 2314 43c8 2310 314 43c8 62 28a1 43ca 62 28a5 43cb 62 288d 43c8 62 2887 e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a070 80b1 43c8 19 2444 62 248c 43c8 62 2485 43c8 62 24a2 748 2849 43c8 62 2489 43c9 62 248f 211 284b 43c8 62 24a7 501 2062 43c8 62 24aa 43c9 62 248b 28c 2248 e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a071 80c0 43c8 62 246f 43c8 62 2487 43c9 62 24a6 612 2a4f 43c9 62 248d 43c8 62 248d 43c9 62 24a9 43c9 62 24a1 752 2a4c 43c9 62 248b e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a172 8000 43c8 62 248e 43c8 62 24af 43c8 62 248b 43c9 62 24a4 158 2a41 6d2 2240 855 2847 43c8 62 24a9 43c8 14 244d 62 24a9 43c9 62 24ab 43c9 62 24ad e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16c 80b1 4388 62 28a2 4389 62 28a1 14a 242e 6e1 2643 4389 62 288c 4388 62 288f 4389 62 28c2 4388 62 28a5 4388 62 28a7 4388 62 28a8 652 2866 e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16d 80c0 4388 62 28a4 4388 62 28a1 438b 62 288f 4388 62 28a8 4388 62 28ac 4389 62 28a4 4388 62 28a7 4389 62 28ac 421 2669 e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16e 8000 4389 62 28a0 4388 62 28a5 854 284f 4389 62 288d 4388 62 28a9 854 264c 4389 62 28ad 4388 62 28a0 4389 62 28a5 4388 62 28a5 e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16f 8040 438a 62 28a1 53cb 62 28a2 480 2f28 10 20c5 118 20c2 20c0 c5 214c 89b 43cb 62 28a2 43cb 62 28a2 43cb 62 28a5 43cb 62 28ab e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a170 80b1 43c9 62 248e 21b 224a 43c9 62 24a9 43c9 62 248e 43c9 62 24a9 43c9 62 24ab 652 2242 43c9 62 24a1 10d 246e 43c9 62 24a7 43c9 62 24af e002 c000

[13:33:26.424] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a171 80c0 43c8 62 24a0 43c8 62 248f 43c8 62 248c 14b 2066 312 244d 43c8 62 24a0 43c9 62 24a7 43c9 62 24ad 43c9 62 24a4 43c9 62 24a7 e002 c000

[13:33:28.113] INFO: 41600 events read in total (2623ms).
[13:33:28.115] INFO: Test took 3853ms.
[13:33:28.152] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:28.870] INFO: Expecting 41600 events.
[13:33:31.832] INFO: 41600 events read in total (2435ms).
[13:33:31.833] INFO: Test took 3663ms.
[13:33:31.867] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:32.231] INFO: enter test to run
[13:33:45.306] INFO: test: HighRate no parameter change
[13:33:45.306] INFO: running: highrate
[13:33:45.307] INFO: ----------------------------------------------------------------------
[13:33:45.307] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:33:45.307] INFO: ----------------------------------------------------------------------
[13:33:45.917] INFO: Expecting 208000 events.
[13:33:57.503] INFO: 208000 events read in total (11060ms).
[13:33:57.506] INFO: Test took 12190ms.
[13:33:57.652] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:33:57.904] INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 3 0 0 0 0 0
[13:33:57.904] INFO: number of red-efficiency pixels: 65 54 72 119 155 171 136 88 82 176 135 93 84 60 26 24
[13:33:57.904] INFO: number of X-ray hits detected: 62453 41988 69422 108666 115385 119453 118631 79593 75043 106899 99386 85303 87489 53704 21284 23928
[13:33:57.904] 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:57.904] INFO: number of Vcal hits detected: 207934 207896 207927 207875 207837 207822 207860 207910 207918 207818 207713 207904 207914 207940 207971 207976
[13:33:57.904] 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 100.0 100.0 100.0 100.0
[13:33:57.904] INFO: Vcal hit overall 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 100.0 100.0 100.0 100.0
[13:33:57.904] INFO: X-ray hit rate [MHz/cm2]: 18.3 12.3 20.3 31.9 33.8 35.0 34.8 23.3 22.0 31.3 29.1 25.0 25.6 15.7 6.2 7.0
[13:33:57.904] INFO: PixTestHighRate::doXPixelAlive() done
[13:33:57.961] INFO: PixTest:: pg_setup set to default.
[13:33:57.974] INFO: enter test to run
[13:34:37.457] INFO: test: HighRate no parameter change
[13:34:37.457] INFO: running: highrate
[13:34:37.458] INFO: ----------------------------------------------------------------------
[13:34:37.459] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:34:37.459] INFO: ----------------------------------------------------------------------
[13:34:38.078] INFO: Expecting 208000 events.
[13:34:51.023] INFO: 208000 events read in total (12418ms).
[13:34:51.029] INFO: Test took 13561ms.
[13:34:51.345] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:34:51.653] INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 3 0 0 0 0 0
[13:34:51.653] INFO: number of red-efficiency pixels: 221 118 254 396 604 633 475 355 248 518 348 335 346 143 45 49
[13:34:51.653] INFO: number of X-ray hits detected: 130196 88066 144077 225184 241254 248238 246448 165356 157546 222522 206741 178309 183264 113095 44621 50209
[13:34:51.653] 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:51.653] INFO: number of Vcal hits detected: 207767 207830 207722 207566 207315 207280 207476 207605 207732 207426 207489 207631 207640 207852 207955 207951
[13:34:51.653] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.7 99.8 99.8 99.9 99.7 99.8 99.8 99.8 99.9 100.0 100.0
[13:34:51.653] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.7 99.7 99.8 99.9 99.7 99.8 99.8 99.8 99.9 100.0 100.0
[13:34:51.653] INFO: X-ray hit rate [MHz/cm2]: 38.2 25.8 42.2 66.0 70.7 72.8 72.2 48.5 46.2 65.2 60.6 52.3 53.7 33.1 13.1 14.7
[13:34:51.653] INFO: PixTestHighRate::doXPixelAlive() done
[13:34:51.699] INFO: PixTest:: pg_setup set to default.
[13:34:51.708] INFO: enter test to run
[13:35:10.650] INFO: test: HighRate no parameter change
[13:35:10.650] INFO: running: highrate
[13:35:10.652] INFO: ----------------------------------------------------------------------
[13:35:10.652] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[13:35:10.652] INFO: ----------------------------------------------------------------------
[13:35:11.288] INFO: Expecting 208000 events.
[13:35:26.269] INFO: 208000 events read in total (14453ms).
[13:35:26.277] INFO: Test took 15615ms.
[13:35:26.774] INFO: Fetched DAQ statistics. Counters are being reset now.
[13:35:27.151] INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 3 0 0 0 0 0
[13:35:27.151] INFO: number of red-efficiency pixels: 443 257 586 920 1385 1512 1118 865 540 1260 828 763 708 390 100 89
[13:35:27.151] INFO: number of X-ray hits detected: 198153 133582 218681 341395 365410 375204 372821 251906 237528 336619 314533 269824 278494 171674 67462 76819
[13:35:27.151] 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:27.152] INFO: number of Vcal hits detected: 207470 207678 207218 206895 206109 205800 206543 206850 207365 206364 206863 207108 207194 207550 207897 207909
[13:35:27.152] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.7 99.5 99.2 99.1 99.4 99.5 99.7 99.3 99.6 99.6 99.7 99.8 100.0 100.0
[13:35:27.152] INFO: Vcal hit overall efficiency (%): 99.7 99.8 99.6 99.5 99.1 98.9 99.3 99.4 99.7 99.2 99.5 99.6 99.6 99.8 100.0 100.0
[13:35:27.152] INFO: X-ray hit rate [MHz/cm2]: 58.1 39.2 64.1 100.1 107.1 110.0 109.3 73.8 69.6 98.7 92.2 79.1 81.6 50.3 19.8 22.5
[13:35:27.152] INFO: PixTestHighRate::doXPixelAlive() done
[13:35:27.198] INFO: PixTest:: pg_setup set to default.
[13:35:27.213] INFO: enter test to run
[13:35:37.161] INFO: test: exit no parameter change
[13:35:38.797] QUIET: Connection to board 33 closed.
[13:35:39.076] INFO: pXar: this is the end, my friend
MoReWeb-v0.5.1-904-gd94b9f2 on branch master