[14:23:31.080] INFO: *** Welcome to pxar ***
[14:23:31.080] INFO: *** Today: 2016/04/05
[14:23:31.095] INFO: *** Version: v1.9.0-793-ge521-dirty
[14:23:31.095] INFO: readRocDacs: /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//dacParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//dacParameters35_C15.dat
[14:23:31.145] INFO: readTbmDacs: /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//tbmParameters_C0a.dat .. /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//tbmParameters_C0b.dat
[14:23:31.145] INFO: readMaskFile: /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//defaultMaskFile.dat
[14:23:31.145] INFO: readTrimFile: /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C15.dat
[14:23:31.282] INFO: clk: 4
[14:23:31.282] INFO: ctr: 4
[14:23:31.282] INFO: sda: 19
[14:23:31.282] INFO: tin: 9
[14:23:31.282] INFO: level: 15
[14:23:31.282] INFO: triggerdelay: 0
[14:23:31.282] QUIET: Instanciating API for pxar v1.9.0+793~ge5211a7
[14:23:31.282] INFO: Log level: INFO
[14:23:31.300] QUIET: Connection to board DTB_WREKRL opened.
[14:23:31.303] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 33
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WREKRL
MAC address: 40D855118021
Hostname: pixelDTB033
Comment:
------------------------------------------------------
[14:23:31.306] INFO: RPC call hashes of host and DTB match: 398089610
[14:23:32.841] INFO: DUT info:
[14:23:32.841] INFO: The DUT currently contains the following objects:
[14:23:32.841] INFO: 2 TBM Cores tbm08c (2 ON)
[14:23:32.841] INFO: TBM Core alpha (0): 7 registers set
[14:23:32.841] INFO: TBM Core beta (1): 7 registers set
[14:23:32.841] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:23:32.841] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.841] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.841] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.841] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.841] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:32.842] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:23:33.245] INFO: enter 'restricted' command line mode
[14:23:33.245] INFO: enter test to run
[14:23:42.650] INFO: test: PixelAlive no parameter change
[14:23:42.650] INFO: running: pixelalive
[14:23:42.659] INFO: ----------------------------------------------------------------------
[14:23:42.659] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:23:42.659] INFO: ----------------------------------------------------------------------
[14:23:42.982] INFO: Expecting 41600 events.
[14:23:47.344] INFO: 41600 events read in total (3643ms).
[14:23:47.508] INFO: Test took 4846ms.
[14:23:47.518] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:23:47.779] INFO: PixTestAlive::aliveTest() done
[14:23:47.779] INFO: number of dead pixels (per ROC): 0 0 0 0 6 2 0 73 1 0 0 0 0 0 0 1
[14:23:47.810] INFO: enter test to run
[14:24:20.713] INFO: test: HighRate setting parameters: ->runsecondshotpixels=5;trimhotpixelthr=200<-
[14:24:20.713] INFO: running: highrate
[14:24:20.714] INFO: readGainPedestalParameters /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//phCalibrationFitErr35_C0.dat .. /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//phCalibrationFitErr35_C15.dat
[14:24:20.933] INFO: ----------------------------------------------------------------------
[14:24:20.933] INFO: PixTest::trimHotPixels() running for 5 seconds with 100 kHz trigger rate
[14:24:20.933] INFO: ----------------------------------------------------------------------
[14:24:20.933] INFO: THR = 200, corresponding to ~ 106.667 MHz/cm2
[14:24:20.933] INFO: edge/corner pixel THR is adjusted
[14:24:20.933] INFO: PixTestHighRate::trimHotPixels: step 0...
[14:24:21.893] INFO: Collecting data for 5 seconds...
[14:24:26.910] INFO: Done with hot pixel readout
[14:24:38.264] INFO: PixTest:: pg_setup set to default.
[14:24:38.265] INFO: 20 hot pixels found in step 0
[14:24:39.250] INFO: Collecting data for 5 seconds...
[14:24:44.266] INFO: Done with hot pixel readout
[14:24:55.563] INFO: PixTest:: pg_setup set to default.
[14:24:55.564] INFO: 20 hot pixels found in step 1
[14:24:56.554] INFO: Collecting data for 5 seconds...
[14:25:01.571] INFO: Done with hot pixel readout
[14:25:12.939] INFO: PixTest:: pg_setup set to default.
[14:25:12.940] INFO: 20 hot pixels found in step 2
[14:25:13.927] INFO: Collecting data for 5 seconds...
[14:25:18.943] INFO: Done with hot pixel readout
[14:25:30.263] INFO: PixTest:: pg_setup set to default.
[14:25:30.264] INFO: 18 hot pixels found in step 3
[14:25:31.250] INFO: Collecting data for 5 seconds...
[14:25:36.266] INFO: Done with hot pixel readout
[14:25:47.582] INFO: PixTest:: pg_setup set to default.
[14:25:47.583] INFO: 18 hot pixels found in step 4
[14:25:48.570] INFO: Collecting data for 5 seconds...
[14:25:53.586] INFO: Done with hot pixel readout
[14:26:04.943] INFO: PixTest:: pg_setup set to default.
[14:26:04.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:04.943] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:04.944] INFO: 19 hot pixels found in step 5
[14:26:05.931] INFO: Collecting data for 5 seconds...
[14:26:10.947] INFO: Done with hot pixel readout
[14:26:22.286] INFO: PixTest:: pg_setup set to default.
[14:26:22.286] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:22.286] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:22.287] INFO: 18 hot pixels found in step 6
[14:26:23.275] INFO: Collecting data for 5 seconds...
[14:26:28.291] INFO: Done with hot pixel readout
[14:26:39.614] INFO: PixTest:: pg_setup set to default.
[14:26:39.614] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:39.614] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:39.614] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:39.614] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:39.615] INFO: 18 hot pixels found in step 7
[14:26:40.602] INFO: Collecting data for 5 seconds...
[14:26:45.618] INFO: Done with hot pixel readout
[14:26:56.975] INFO: PixTest:: pg_setup set to default.
[14:26:56.975] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:56.975] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:56.975] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:56.975] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:56.975] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:26:56.976] INFO: 9 hot pixels found in step 8
[14:26:57.963] INFO: Collecting data for 5 seconds...
[14:27:02.979] INFO: Done with hot pixel readout
[14:27:14.290] INFO: PixTest:: pg_setup set to default.
[14:27:14.290] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:14.290] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:14.290] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:14.290] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:14.290] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:14.290] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:14.291] INFO: 8 hot pixels found in step 9
[14:27:15.277] INFO: Collecting data for 5 seconds...
[14:27:20.293] INFO: Done with hot pixel readout
[14:27:31.656] INFO: PixTest:: pg_setup set to default.
[14:27:31.656] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:31.656] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:31.656] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:31.656] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:31.656] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:31.657] INFO: 8 hot pixels found in step 10
[14:27:32.645] INFO: Collecting data for 5 seconds...
[14:27:37.661] INFO: Done with hot pixel readout
[14:27:48.996] INFO: PixTest:: pg_setup set to default.
[14:27:48.996] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:48.996] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:48.996] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:48.996] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:48.996] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:27:48.997] INFO: 8 hot pixels found in step 11
[14:27:49.984] INFO: Collecting data for 5 seconds...
[14:27:54.000] INFO: Done with hot pixel readout
[14:28:06.328] INFO: PixTest:: pg_setup set to default.
[14:28:06.328] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:06.328] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:06.328] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:06.328] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:06.328] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:06.329] INFO: 7 hot pixels found in step 12
[14:28:07.316] INFO: Collecting data for 5 seconds...
[14:28:12.332] INFO: Done with hot pixel readout
[14:28:23.651] INFO: PixTest:: pg_setup set to default.
[14:28:23.651] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:23.651] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:23.651] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:23.651] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:23.651] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:23.652] INFO: 6 hot pixels found in step 13
[14:28:24.638] INFO: Collecting data for 5 seconds...
[14:28:29.655] INFO: Done with hot pixel readout
[14:28:41.018] INFO: PixTest:: pg_setup set to default.
[14:28:41.018] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:41.018] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:41.018] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:41.018] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:41.018] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:41.018] WARNING: => trimBits already at highest possible threshold, 'real' hot pixel found
[14:28:41.019] INFO: 8 hot pixels found in step 14
[14:28:41.049] INFO: 8 hot pixels could not be trimmed and have been masked.
[14:28:41.053] INFO: PixTest::trimHotPixels() done
[14:28:41.053] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C0.dat
[14:28:41.061] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C1.dat
[14:28:41.069] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C2.dat
[14:28:41.076] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C3.dat
[14:28:41.083] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C4.dat
[14:28:41.090] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C5.dat
[14:28:41.097] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C6.dat
[14:28:41.104] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C7.dat
[14:28:41.111] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C8.dat
[14:28:41.119] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C9.dat
[14:28:41.126] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C10.dat
[14:28:41.133] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C11.dat
[14:28:41.140] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C12.dat
[14:28:41.147] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C13.dat
[14:28:41.154] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C14.dat
[14:28:41.161] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C15.dat
[14:28:41.168] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//defaultMaskFile.dat
[14:28:41.178] INFO: enter test to run
[14:29:20.919] INFO: test: HighRate setting parameters: ->runsecondshotpixels=1;trimhotpixelthr=200<-
[14:29:20.919] INFO: running: highrate
[14:29:20.924] INFO: ----------------------------------------------------------------------
[14:29:20.924] INFO: PixTest::trimHotPixels() running for 1 seconds with 100 kHz trigger rate
[14:29:20.924] INFO: ----------------------------------------------------------------------
[14:29:20.924] INFO: THR = 200, corresponding to ~ 533.333 MHz/cm2
[14:29:20.924] INFO: edge/corner pixel THR is adjusted
[14:29:20.924] INFO: PixTestHighRate::trimHotPixels: step 0...
[14:29:21.881] INFO: Collecting data for 1 seconds...
[14:29:22.884] INFO: Done with hot pixel readout
[14:29:26.674] INFO: PixTest:: pg_setup set to default.
[14:29:26.675] INFO: 0 hot pixels found in step 0
[14:29:26.681] INFO: 0 hot pixels could not be trimmed and have been masked.
[14:29:26.780] INFO: PixTest::trimHotPixels() done
[14:29:26.781] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C0.dat
[14:29:26.793] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C1.dat
[14:29:26.800] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C2.dat
[14:29:26.807] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C3.dat
[14:29:26.815] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C4.dat
[14:29:26.822] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C5.dat
[14:29:26.829] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C6.dat
[14:29:26.836] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C7.dat
[14:29:26.844] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C8.dat
[14:29:26.851] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C9.dat
[14:29:26.858] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C10.dat
[14:29:26.865] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C11.dat
[14:29:26.872] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C12.dat
[14:29:26.879] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C13.dat
[14:29:26.887] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C14.dat
[14:29:26.894] INFO: write trim parameters into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//trimParameters35_C15.dat
[14:29:26.901] INFO: write masked pixels into /home/uicpirepix2/ProductionTestResults/M-H-1-06_ElComandanteTest_2015-12-15_12h25m_1450203934/000_FPIXTest_p17//defaultMaskFile.dat
[14:29:26.911] INFO: enter test to run
[14:29:56.015] INFO: test: Xray setting parameters: ->source=DCLowRate<-
[14:29:56.015] INFO: running: xray
[14:29:56.016] INFO: ----------------------------------------------------------------------
[14:29:56.016] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[14:29:56.016] INFO: ----------------------------------------------------------------------
[14:29:56.979] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[14:30:09.028] INFO: run duration 12 seconds, buffer almost full (81%), pausing triggers.
[14:30:38.317] INFO: Resuming triggers.
[14:30:50.369] INFO: run duration 24 seconds, buffer almost full (81%), pausing triggers.
[14:31:19.615] INFO: Resuming triggers.
[14:31:31.670] INFO: run duration 36 seconds, buffer almost full (81%), pausing triggers.
[14:32:01.035] INFO: Resuming triggers.
[14:32:13.088] INFO: run duration 48 seconds, buffer almost full (81%), pausing triggers.
[14:32:40.087] INFO: Resuming triggers.
[14:32:52.142] INFO: run duration 60 seconds, buffer almost full (81%), pausing triggers.
[14:33:21.371] INFO: Resuming triggers.
[14:33:33.428] INFO: run duration 72 seconds, buffer almost full (81%), pausing triggers.
[14:34:02.739] INFO: Resuming triggers.
[14:34:14.791] INFO: run duration 84 seconds, buffer almost full (81%), pausing triggers.
[14:34:44.053] INFO: Resuming triggers.
[14:34:56.108] INFO: run duration 96 seconds, buffer almost full (81%), pausing triggers.
[14:34:58.978] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:34:58.978] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (3) != Token Chain Length (8)
[14:34:58.978] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e5 80c0 43c8 43c8 43c8 43c8 43c8 43c8 43c8 43c8 65c 2400 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0df 8040 438a 295 2046 438a 462 244c 438a 485 2843 438a 438a 438a 438a 255 2446 438a e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e0 80b1 4388 4388 4388 4388 4388 2cc 202d 4388 4388 15d 2666 702 2464 4388 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e1 80c0 4388 4388 4388 4388 490 2a2f 4389 4389 4389 4389 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e2 8000 4388 4388 4389 4389 64a 2062 43c8 482 242f 7fd 43c9 709 2a47 43c9 35a 2800 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e3 8040 43c8 43c9 495 2628 43c8 43c9 43c8 43c9 43c8 43c9 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e4 80b1 43c8 19 222d 43c8 43c8 43c8 43c8 43c8 43c8 15 2427 43c8 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e5 80c0 43c8 43c8 43c8 809 282f 43c8 43c8 43c8 43c8 558 2a29 43c8 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1df 8040 438a 438a 438a 438a 438a 438a 2d5 2662 438a 438a 548 242e e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e0 80b1 4389 4389 4389 4389 4389 4389 35b 264c 4389 4389 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e1 80c0 4388 145 2045 54d 224a 80a 2a41 4388 619 2448 4388 4388 412 2844 454 2429 813 2449 4389 4389 4389 4389 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e2 8000 4388 4388 34a 242f 411 2246 655 284f 43c9 e001 c00f
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e3 8040 43c8 43c9 43c8 6d5 2a45 43c9 43c8 43c9 43c8 43c9 e000 c000
[14:34:58.978] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e4 80b1 43c8 43c8 43c8 718 2044 43c8 43c8 43c8 43c8 61d 2a43 43c8 e000 c000
[14:35:06.803] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:35:06.803] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[14:35:06.803] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:35:06.803] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04f 8040 43ca 43ca 43ca 43ca 43ca 43ca 53 2a4f 43ca 43ca e000 c000
[14:35:06.803] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a049 80c0 4388 4388 4388 4388 4388 4388 4388 4388 e000 c000
[14:35:06.803] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04a 8000 4388 4388 4388 4388 d4 206f 4388 4388 4388 4388 50a 2400 50a 2000 e000 c000
[14:35:06.803] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04b 8040 4388 4388 4388 4388 4388 655 2845 4388 4388 4388 d 2000 e000 c000
[14:35:06.803] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04c 80b1 554 235a 445 43c8 352 204c 43c8 43c8 43c8 2dd 2a23 720 282f 43c8 43c8 43c8 e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04d 80c0 43c8 43c8 302 2042 43c8 85b 2a62 43c8 43c8 70c 2026 43c8 43c8 43c8 e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04e 8000 43c8 9d 2067 43c8 43c8 43c8 43c8 43c8 43c8 312 2066 460 2a4c 43c8 e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14f 8040 43ca 43ca 43ca 43ca 43ca 43ca 43ca 43ca e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a149 80c0 4388 4388 4388 4388 61 2466 4388 860 2660 4388 4388 4388 e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14a 8000 4388 4388 11c 222b 4388 4388 511 224d 4388 4388 4388 4388 e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14b 8040 4388 4388 48c 2a47 4388 4388 4388 4388 4388 4388 e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14c 80b1 43c8 43c8 43c8 43c8 43c8 43c8 43c8 e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14d 80c0 43c8 43c8 94 2860 43c8 43c8 43c8 43c8 43c8 43c8 e000 c000
[14:35:06.804] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14e 8000 43c8 43c8 43c8 e0 2429 43c8 43c8 43c8 43c8 43c8 e000 c000
[14:35:25.310] INFO: Resuming triggers.
[14:35:29.201] INFO: data taking finished, elapsed time: 100 seconds.
[14:35:34.880] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:35:34.880] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (4) != Token Chain Length (8)
[14:35:34.880] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f6 8000 4388 4388 4388 4388 689 2047 4388 4388 311 2460 34d 2462 4388 4388 698 2400 6d8 2600 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f0 80b1 43c8 43c8 43c8 113 2241 43c8 43c8 43c8 43c8 43c8 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f1 80c0 43c8 dd 2a41 43c8 43c8 43c8 43c9 43c9 43c9 43c9 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f2 8000 43c8 43c8 43c9 43c9 43c8 110 2241 845 222d 43c8 519 2669 43c9 43c9 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f3 8040 43c8 154 2a65 4389 4388 7eb 2c11 d5f 2815 515 2441 4389 4388 689 2247 4389 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f4 80b1 4388 4d8 2640 4388 4388 4388 4388 4388 4388 4388 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f5 80c0 4388 4388 21b 264f 4388 858 204b 4388 c8 224a 285 2849 4388 4388 28c 202d 4388 4388 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f6 8000 4388 4388 4388 40a 244e 4388 4388 4388 4388 4388 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f0 80b1 43c9 43c9 43c9 820 2a44 43c9 43c9 43c9 43c9 43c9 613 2865 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f1 80c0 43c8 44b 264f 43c8 442 2a45 43c8 43c8 2d3 2449 43c9 43c9 43c9 43c9 9b 2445 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f2 8000 43c8 43c8 43c9 43c9 611 262d 43c8 43c8 43c9 43c9 e000 c000
[14:35:34.880] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f3 8040 43c8 43c9 4388 4389 362 2456 942 2aa2 7d6 2882 a20 215c e000 c000
[14:35:34.881] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f4 80b1 4388 414 2a69 4388 850 242c 4388 71a 204a 4388 4388 4388 4388 4388 e000 c000
[14:35:34.881] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f5 80c0 4388 4388 4388 4cd 2641 4388 409 2643 4388 4388 4388 4388 e000 c000
[14:35:39.009] INFO: PixTest:: pg_setup set to default.
[14:35:39.012] INFO: PixTestXray::doPhRun() done
[14:35:39.145] INFO: enter test to run
[14:37:40.203] INFO: test: Xray setting parameters: ->source=DCHighRate<-
[14:37:40.203] INFO: running: xray
[14:37:40.205] INFO: ----------------------------------------------------------------------
[14:37:40.205] INFO: PixTestXray::doPhRun() fParRunSeconds = 100
[14:37:40.205] INFO: ----------------------------------------------------------------------
[14:37:41.172] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 100 seconds, fEventsMax = 10000000
[14:37:48.325] INFO: run duration 7 seconds, buffer almost full (81%), pausing triggers.
[14:38:18.299] INFO: Resuming triggers.
[14:38:25.451] INFO: run duration 14 seconds, buffer almost full (81%), pausing triggers.
[14:38:25.640] WARNING: Channel 0 ROC 6: Readback start marker after 1 readouts!
[14:38:25.640] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (7) != Token Chain Length (8)
[14:38:25.640] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[14:38:25.640] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:38:25.640] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0d3 8040 43c8 2e0 2044 43c9 43c8 43c9 15b 2245 43c8 98 264f 43c9 24a 224e 40d 266f 43c8 43c9 45c 2800 e000 c000
[14:38:25.640] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0cd 80c0 4388 4388 4388 703 2a42 718 262d 4388 b 242f 319 24a1 4388 350 2648 71d 222f 85b 2a4c 4388 4388 51 204a 4388 c 2200 e000 c000
[14:38:25.640] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ce 8000 4388 4388 4388 35c 208b 440 2646 61c 244c 4388 d4 2245 65b 2068 4388 654 202f 4388 4388 71d 2064 4388 e000 c000
[14:38:25.640] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0cf 8040 438a 438a 438a 438a 2d3 2288 549 2449 438a 438a 285 2442 309 2a84 683 284f 438a 22 2042 438a e000 c000
[14:38:25.640] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0d0 80b1 4388 70a 264a 4388 4388 45c 2049 549 2861 4388 60 2647 35b 2a67 4388 53c8 28a 2a2b 43ca 7cc 27ff ff8 201b 0 200b 800 e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0d1 80c0 43c8 4d3 2860 43c8 2d3 2a44 43c8 695 222f 43c8 751 262f 43c9 40d 224e 43c9 280 242b 288 262d 815 264f 43c9 420 228d 6d1 2a4e 43c9 e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0d2 8000 43c8 43c8 43c9 43c9 d2 2848 15b 2864 150 204d 4ca 284f 75c 222d 43c8 43c8 c 2840 28c 2243 43c9 155 266a 559 2669 43c9 e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1d3 8040 43c8 43c9 58 262b 43c8 155 2265 43c9 144 2226 461 204f 84c 2a61 43c8 14b 2a6d 6cc 2465 714 2827 43c9 142 2429 43c8 43c9 660 2645 e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1cd 80c0 4388 50 2a0e da 2069 450 226d 4388 0 2629 60c 262d 4388 4388 12 2064 41d 2a4b 4388 22 2462 109 2664 311 2468 4388 4388 4388 e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ce 8000 4388 215 2048 2cd 2849 513 2247 4388 289 282d 4388 2c4 2261 4388 4388 849 224f 4388 d0 2069 348 2843 4388 4388 421 2649 e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1cf 8040 438a 2e0 2064 314 222d 438a 438a 85a 2042 438a 438a 438a 45 264d 209 2a4d 438a 438a e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1d0 80b1 4389 25b 2a4a 4389 310 2a44 4389 605 2862 4389 74c 2043 850 2442 4389 109a 202f 158 284a f8f 2b28 72 212b 43c9 43c9 e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1d1 80c0 43c8 452 244e 43c8 259 2a4a 30a 2827 43c8 6d9 2245 43c8 a0 2844 74a 2a2f 43c9 162 2645 450 2849 620 244c 43c9 215 2065 43c9 45c 222c 43c9 41b 284d 45a 2640 e000 c000
[14:38:25.641] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1d2 8000 43c8 35a 2a41 43c8 43c9 760 200f 43c9 713 204d 43c8 43c8 21 2087 1d 2061 83 2261 43c9 43c9 e000 c000
[14:38:55.568] INFO: Resuming triggers.
[14:39:02.726] INFO: run duration 21 seconds, buffer almost full (81%), pausing triggers.
[14:39:32.727] INFO: Resuming triggers.
[14:39:39.883] INFO: run duration 28 seconds, buffer almost full (81%), pausing triggers.
[14:39:40.143] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[14:39:40.143] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c4 80b1 43c8 43c8 43c8 43c8 43c8 43c8 5 2064 100 2a2c 6e2 2847 43c8 10 2829 d 2043 298 2a2d 4cb 2666 4d9 2667 54a 2865 43c8 250 2a00 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0be 8000 4388 698 244c 4388 4388 4d8 2a4d 4388 4388 94 2245 2d1 202e 4388 460 2041 4388 20c 262b 250 264a 4c5 264f 653 2a65 713 224e 851 244f 4388 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0bf 8040 438a 438a 458 2041 438a 438a 421 224f 489 2246 50d 244e 438a d8 242d 118 2665 438a 438a 11b 2046 608 2641 715 224e 438a 413 2200 64d 2200 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c0 80b1 4388 4388 5d 2649 4388 4388 91 2249 70a 2a2f 4388 4388 45 2a23 4a2 244e 80d 204a 4388 11 222f 4388 29b 2a00 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c1 80c0 4388 4388 5d 2449 4388 722 204c 53c8 59 2429 97f 2ff4 43c9 20c 2861 43c9 45d 222c 43c9 35a 2861 355 266a 43c9 18 2600 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c2 8000 43c8 4db 2664 43c8 353 2649 43c9 43c9 24b 2a45 295 2444 853 2a6f 43c8 40c 2827 43c8 93 264f 43c9 8b 2049 10b 2448 520 2062 43c9 449 2800 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0c3 8040 43c8 43c9 43c8 43c9 609 266d 43c8 418 264f 859 2045 43c9 8 2248 28c 244a 43c8 650 2a44 80c 226e 840 2640 43c9 219 2600 259 2400 71a 2a00 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c4 80b1 43c8 43c8 43c8 605 2869 855 2a40 43c8 20 286f 511 286d 512 2645 43c8 259 224f 43c8 43c8 43c8 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1be 8000 4388 54 242f e0 2028 413 246c 4388 b 284f 4388 149 224f 61a 264e 4388 15c 284f 41a 2866 514 202f 6d0 244f 4388 558 2a0f 4388 14c 240f 20b 2465 420 2441 4388 4388 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1bf 8040 438a 438a 64c 284b 81a 2a4e 438a 438a 150 2445 438a 258 284a 2c9 2a4c 438a 438a 438a e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c0 80b1 4389 4389 e1 224c 141 224e 4389 95 2246 488 2245 64b 2840 4389 48a 2245 4389 118 2429 4389 4389 4389 69b 2841 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c1 80c0 4388 4cb 2642 652 2449 4388 110 3429 319 266f 7c0 2b28 10 2a22 c9a 2c37 2c30 622 43c9 458 2449 43c9 8d 244f 291 226c 343 244f 451 244f 71b 226e 43c9 550 2229 81a 204b 43c9 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c2 8000 43c8 542 2a4b 750 224e 43c8 43c9 43c9 242 2247 43c8 20a 2a44 309 2860 813 2a61 43c8 415 2a43 4ca 2462 43c9 43c9 69d 242d 6e1 2449 e000 c000
[14:39:40.143] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1c3 8040 43c8 43c9 43c8 34c 2a24 43c9 2d1 224c 842 244f 43c8 50 2241 15c 2a45 81c 284c 43c9 105 2649 43c8 4a1 2040 43c9 e000 c000
[14:40:09.853] INFO: Resuming triggers.
[14:40:17.007] INFO: run duration 35 seconds, buffer almost full (81%), pausing triggers.
[14:40:46.927] INFO: Resuming triggers.
[14:40:54.083] INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[14:41:24.053] INFO: Resuming triggers.
[14:41:31.206] INFO: run duration 49 seconds, buffer almost full (81%), pausing triggers.
[14:42:01.130] INFO: Resuming triggers.
[14:42:08.284] INFO: run duration 57 seconds, buffer almost full (81%), pausing triggers.
[14:42:08.452] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a057 8040 43c8 43c8 92 2847 43c8 708 2a29 43c8 43 2649 54a 222f 43c8 43c8 54b 224f 622 286f 43c8 44a 206a 43c8 118 2000 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a051 80c0 4388 4388 4388 4388 41a 2a6d 4389 440 284d 4389 1c 2a44 684 2045 4389 4389 400 2600 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a052 8000 4388 9a 244f 4388 4389 4389 4388 4db 266a 51a 2845 842 264e 4388 692 2444 4389 9a 202d 652 226a 4389 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a053 8040 4388 61 224f 201 286a 4389 112 204c 349 2a48 4388 44a 2a6d 4389 11 2067 44 242f 75c 220f 84a 2a2f 4388 19 2441 120 2664 28d 2661 65a 2a4a 4389 2cd 244b 2ca 2842 610 2043 4388 4389 29a 2800 44b 2000 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a054 80b1 4388 2cd 2a45 4388 151 2261 4388 455 264c 61a 2a4c 4388 689 2645 74d 244f 4388 1288 242f 354 284c 18 2247 43c8 4d 2a41 6d5 204b 74c 224d 43c8 6c5 226a 6c8 2a69 715 2669 43c8 503 2000 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a055 80c0 43c8 258 2244 559 2a4f 43c8 43c8 43c8 43c8 91 264f 54c 2840 84c 262f 43c8 242 2a2f 51a 2485 694 284a 43c8 e1 2049 258 204b 43c8 248 2600 49a 2000 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a056 8000 43c8 519 2a6f 43c8 43c8 602 2a44 43c8 43c8 43c8 9a 244d 43c8 315 2069 553 2082 54c 2265 43c8 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a157 8040 43c8 53 204f 50d 204c 43c8 552 2049 43c8 43c8 43c8 43c8 43c8 43c8 802 242f e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a151 80c0 4388 642 224c 4388 8d 2245 815 204b 4388 749 2669 4388 9 264d 2d3 2682 41a 2689 4389 4e1 2a81 4389 209 2061 301 2a24 4389 4389 10d 2a41 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a152 8000 4388 622 204c 4388 112 2229 51b 224f 4389 4cb 286a 540 242d 4389 35a 264e 688 2440 4388 109 2240 10a 2648 4388 4389 4389 749 2849 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a153 8040 4388 4389 4388 601 2849 4389 4d 284d 551 2245 4388 4389 410 262c 4388 51c 202d 4389 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a154 80b1 4388 803 206c 4388 c8 206d 48a 2465 4388 4388 95 204d 4388 4388 4388 4388 e000 d000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a155 80c0 43c8 43c8 90 2842 412 224f 74a 2240 84c 2a40 43c8 43c8 250 2843 43c8 43c8 55 224d 43c8 353 2229 43c8 e000 c000
[14:42:08.452] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a156 8000 43c8 43c8 4a 2645 65d 2061 43c8 815 2646 43c8 91 2629 43c8 43c8 43c8 43c8 71c 204a 71b 2867 e000 c000
[14:42:33.863] INFO: Resuming triggers.
[14:42:41.017] INFO: run duration 64 seconds, buffer almost full (81%), pausing triggers.
[14:43:10.935] INFO: Resuming triggers.
[14:43:18.088] INFO: run duration 71 seconds, buffer almost full (81%), pausing triggers.
[14:43:47.993] INFO: Resuming triggers.
[14:43:55.147] INFO: run duration 78 seconds, buffer almost full (81%), pausing triggers.
[14:44:25.089] INFO: Resuming triggers.
[14:44:32.245] INFO: run duration 85 seconds, buffer almost full (81%), pausing triggers.
[14:44:55.397] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f2 8000 43c8 248 2a6e 43c8 82 2246 c2 2045 43c9 43c9 43c8 43c8 5b 2a4d 283 282f 403 246f 43c9 1d 284f 8 2427 449 2669 43c9 455 2600 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ec 80b1 4388 4388 301 2845 4388 9c 2842 64b 2889 4388 314 2a41 4388 451 2047 4388 24d 2a61 4388 294 204e 315 2a6d 4388 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ed 80c0 4388 21b 226f 4388 114 2044 4388 4388 a 244f 1 2241 4388 4388 28d 222e 602 284d 74b 2a2f 4388 255 224d 4388 408 2a00 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ee 8000 4388 61 2468 4388 4388 4388 709 222f 4388 449 246c 4388 4388 4388 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ef 8040 438a 755 2488 438a 438a 438a 4b 244f cb 2085 649 284f 438a 438a 31d 2688 438a 438a 4c 2a00 5b 2a00 262 2400 e000 d000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f0 80b1 43c8 453 204a 84a 284f 43c8 43c8 43c8 290 2247 43c8 43c8 50d 206d 602 2a4f 815 2445 43c8 411 204e 492 2a6c 43c8 455 2400 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f1 80c0 43c8 291 2065 43c8 43c8 50a 2242 651 2a45 43c8 14c 2644 43c9 5c 242c 93 244d 318 222f 43c9 43c9 481 224c 43c9 11 2000 111 2800 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f2 8000 43c8 69c 244c 43c8 24c 2442 43c9 14d 284a 43c9 4c9 244a 720 2269 43c8 153 226c 43c8 35d 284a 43c9 43c9 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ec 80b1 4388 6d5 2844 4388 95 264d 109 2827 34d 2046 4388 65a 2849 4388 450 282f 4388 84a 2a49 4388 4388 4388 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ed 80c0 4388 318 284f 4388 28c 2828 34a 246f 4388 160 2269 245 266a 40d 2866 440 2449 4388 90 200f 252 2445 449 284f 499 2048 4388 4388 45d 2461 519 2263 4388 4388 e000 c000
[14:44:55.397] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ee 8000 4388 118 2642 4388 4388 50d 2840 4388 4388 4388 4388 4388 6dc 2427 e000 c000
[14:44:55.398] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ef 8040 438a 4da 2a40 6da 222d 438a 85c 2047 438a 2dd 2462 44d 244e 438a b 266a 312 2665 438a 438a 2c9 2041 438a 438a e000 d000
[14:44:55.398] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f0 80b1 43c9 43c9 12 2842 43c9 4cd 2a49 608 2a48 43c9 21a 2443 43c9 255 2049 43c9 14 2427 20d 284c 254 202f 43c9 43c9 e000 c000
[14:44:55.398] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f1 80c0 43c8 43c8 43c8 559 2646 649 2648 740 242d 43c8 d0 2a41 d1 2229 343 2669 51a 204d 553 2688 754 264b 43c9 253 2a4c 2d1 2648 43c9 43c9 43c9 e000 c000
[14:45:02.255] INFO: Resuming triggers.
[14:45:09.412] INFO: run duration 92 seconds, buffer almost full (81%), pausing triggers.
[14:45:21.990] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 3 ROCs were found
[14:45:21.990] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[14:45:21.990] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (54) != TBM ID (7)
[14:45:21.991] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (3) != Token Chain Length (8)
[14:45:21.991] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (8) != TBM ID (54)
[14:45:21.991] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a138 80b1 43c8 852 242e 43c8 718 2225 43c8 81c 2a66 43c8 653 204e 43c8 1c 224f 6c9 2047 43c8 210 2244 43c8 43c8 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a132 8000 4388 49c 264c 4388 110 202c 294 2842 294 242c 4389 11d 2865 111 2a8a 4389 12 288a 4388 10d 264c 298 2045 298 224c 4388 b 244c 4389 419 2041 4389 642 2861 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a133 8040 4388 4389 4388 14 202d 2d9 266c 301 2889 68d 2a42 84c 2a27 4389 64b 2265 710 264c 4388 619 2245 4389 41c 244d 4388 45b 2a42 4389 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a134 80b1 4388 709 2a88 4388 152 2229 4d9 2a62 698 202a 4388 50c 222e 50c 2625 64d 2843 4388 60b 2661 4388 2 2067 d9 244c 311 2a6d 4388 4388 6d9 224e 4388 403 224c e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a135 80c0 4388 4388 252 2840 4388 28c 2842 41c 206d 80d 3a40 43c8 849 285a 10 2136 906 2a83 43c8 43c8 43c8 35c 244a 358 2865 358 244b e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a136 8000 43c8 412 204d 43c8 43c8 43c8 43c8 b 2465 40d 2881 6a2 2061 43c8 43c8 43c8 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a137 8040 43c8 43c8 43c8 8d 2a4c 43c8 6cd 2447 43c8 71d 2849 43c8 249 2645 43c8 61b 2643 43c8 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a039 80c0 43c8 43c8 43c8 43c8 b 284f 43c8 89 2049 149 2262 710 2045 43c8 43c8 754 2a61 43c8 a2 2800 410 2a00 658 2800 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a034 80b1 4388 850 284d 4388 4388 853 2080 849 2668 849 2a62 4388 1d 2a69 4388 2d1 2a28 551 2463 55c 2a41 815 2041 4388 4388 4388 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a035 80c0 4388 21 2a49 51c 2a42 4388 94 2a43 4388 505 344f 43c8 70c
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a007 8001 43c8 43c8 445 206d 43c8 65a 2600 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a036 8000 43c8 61 224d 259 2861 255 2447 43c8 218 2440 354 2027 43c8 43c8 43c8 59 2848 34c 204c 350 2245 712 2243 43c8 648 2825 6ca 2a48 43c8 43c8 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a037 8040 43c8 548 2885 43c8 294 202e 761 2667 43c8 444 282f 43c8 43c8 612 204f 844 264d 43c8 93 2046 43c8 254 2442 4c9 2849 43c8 410 2600 488 2800 e000 c000
[14:45:21.991] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a038 80b1 43c8 13 222f 43c8 215 2648 35a 2647 43c8 495 224c 43c8 43c8 459 222f 459 2a4a 43c8 713 2844 43c8 b 284c 43c8 103 2400 152 2a00 705 2400 e000 c000
[14:45:39.567] INFO: Resuming triggers.
[14:45:46.725] INFO: run duration 99 seconds, buffer almost full (81%), pausing triggers.
[14:45:48.233] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (5) != Token Chain Length (8)
[14:45:48.233] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 2 ROCs were found
[14:45:48.233] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (135) != TBM ID (0)
[14:45:48.233] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (1) != Token Chain Length (8)
[14:45:48.233] ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (1) != TBM ID (135)
[14:45:48.234] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a189 80c0 43c8 2a0 2882 309 2647 43c8 43c8 312 224d 6c1 2248 43c8 43c8 43c8 43c8 343 2429 43c8 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a183 8040 4388 4389 4388 4389 15c 2846 661 2285 4388 93 2a65 292 2849 811 282f 4389 4388 4389 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a184 80b1 4388 4388 4388 19 2842 db 2a40 614 2066 4388 362 264d 500 2461 4388 4b 264f 4388 2d9 2249 4388 4388 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a185 80c0 4388 95 2047 455 2265 85b 2060 4388 10 2840 4388 4388 4388 51d 226a 4388 4388 803 2649 4388 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a186 8000 4388 44c 2a60 4388 450 2848 54a 2861 60b 2022 aa1 2403 e0ea c0da
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a187 8040 43c8 641 2a44 748 2660 43c8 315 2a45 43c8 358 242a 558 2a2f 43c8 43c8 4c1 2440 721 2025 43c8 43c8 401 2643 43c8 25b 2280 682 2040 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a188 80b1 43c8 549 2042 43c8 750 282e 750 2442 43c8 c9 284f 80c 2045 43c8 71a 224f 752 2443 43c8 43c8 458 2848 43c8 43c8 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a08a 8000 43c8 4cd 2a4e 43c8 15d 2a6d 218 2263 43c8 608 2a45 43c8 24a 264e 4d5 2a45 4d8 2244 43c8 211 222b 28d 224f 85a 224a 43c8 4dc 2246 43c8 493 284f 48b 2662 84d 2a6a 43c8 309 2000 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a085 80c0 4388 41a 284a 4388 4388 2d9 2a4d 4388 4388 683 2a61 6d4 264f 4388 350 244b 4388 851 2867 4388 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a086 8000 4388 13 2444 4388 362 244d 43c8 43c8 43c8 5fd 2502 aa9 2a75 e1f 2fcd
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a000 80da 43c8 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a087 8040 43c8 61 2061 54 2846 54 2a4f 43c8 da 2641 43c8 43c8 43c8 9b 2a45 43c8 43c8 249 2647 610 2845 43c8 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a088 80b1 43c8 45c 2064 43c8 43c8 43c8 d1 2685 31b 264f 849 2665 43c8 1a 2041 d1 2866 451 264b 508 282d 43c8 43c8 2cb 204a 43c8 e000 c000
[14:45:48.234] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a089 80c0 43c8 65b 2a6d 43c8 43c8 819 264f 43c8 c3 2a45 43c8 40a 2063 43c8 811 2440 43c8 50d 244a 715 224d 845 204b 43c8 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (5) != Token Chain Length (8)
[14:45:49.966] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (4) != Token Chain Length (8)
[14:45:49.966] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14f 8040 43ca cb 2242 554 2841 6c0 2644 850 2a2b 43ca 43ca 258 2a65 6c5 2248 43ca 43ca 291 2a43 43ca 43ca 499 2445 43ca e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a149 80c0 4388 4388 51d 284b 553 2047 761 206b 4388 4388 413 284f 545 264e 4388 542 2a0c 4388 14 202f c 224c 4388 21a 2045 4388 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14a 8000 4388 2c9 2462 485 202f 6d2 2227 4388 20 2847 4388 db 2469 4388 4388 1b 2667 1b 2a6c 488 2848 691 2249 6cc 2a45 4388 4388 4388 658 282d e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14b 8040 4388 4388 4388 5c 2449 4388 313 264d 4388 4388 4388 4388 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14c 80b1 4388 4388 280 262a 171b 264f 43c8 4ca 296d a01 29c4 fff 297c 760 2070 12 208a 8a1 43c8 43c8 43c8 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14d 80c0 43c8 514 2848 43c8 409 2447 43c8 43c8 44c 2240 608 2426 608 262d 43c8 690 2a25 43c8 349 2a4f 43c8 43c8 688 2044 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a14e 8000 43c8 43c8 9 284f 43c8 14b 286f 65c 202f 43c8 43c8 340 2641 51c 2461 693 2680 708 2647 43c8 4a 2445 43c8 81d 2661 43c8 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04f 8040 43ca 12 2440 55 2264 43ca 294 2845 43ca 4c3 264f 553 284e 43ca 59 262d 59 2a4d 43ca 502 2021 43ca 43ca 22 206b 14 2249 43ca 50a 2400 6c2 2800 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a049 80c0 4388 4388 252 2842 291 2043 4388 494 222e 54b 2861 690 2a61 4388 4388 294 204f 28b 264f 45d 2869 4388 11a 2048 4c8 2844 6d5 2a42 70c 2842 4388 85 2a4b 253 224c 4388 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04a 8000 4388 4388 294 2647 403 224d 4388 50c 2a47 542 2244 4388 c 286c 40c 2a61 508 2242 4388 612 2a43 4388 42 2061 148 204a 253 2a4f 4388 355 2665 4388 4c5 2600 e000 c000
[14:45:49.966] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04b 8040 4388 41c 2040 4388 4388 803 224b 4388 255 204c 242 266f 4388 69a 204c 755 2825 4388 80 2442 505 206a 4388 40d 2885 4388 e000 c000
[14:45:49.967] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04c 80b1 4388 4388 4388 810 342d 43c8 80 260f ce7 25f6 5ff 2eaa acb e003 c064
[14:45:49.967] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04d 80c0 43c8 dc 202c 4dd 2a47 43c8 202 246c 43c8 43c8 288 2647 43c8 43c8 8b 2a49 43c8 488 2a48 540 2680 43c8 9 2800 1 2600 e000 c000
[14:45:49.967] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a04e 8000 43c8 253 264c 45c 206f 43c8 819 2864 43c8 65c 2047 691 264d 43c8 43c8 43c8 295 2245 43c8 43c8 4d2 2000 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[14:45:51.707] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:45:51.707] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a115 80c0 4388 4388 4388 80b 264c 4388 64a 2861 4388 6d0 2a2f 70a 2645 74a 2440 4388 40b 2663 4388 4388 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a10f 8040 43ca 68a 2a0f 43ca 43ca 311 284f 43ca 71b 2868 43ca 295 2249 43ca 43ca 43ca e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a110 80b1 43c9 43c9 104 2625 71c 2661 43c9 715 2242 814 2a4f 43c9 14 262f 4d2 284f 43c9 10 244d 512 2648 43c9 14a 2445 43c9 43c9 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a111 80c0 43c8 159 2684 854 244f 851 2447 43c8 74b 2a45 43c8 611 2645 613 224f 84d 222f 43c8 295 2a2c 2d5 2065 490 2a4d 43c9 499 2261 43c9 280 2445 522 2464 43c9 43c9 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a112 8000 43c8 43c8 31b 2047 40d 2047 61c 286d 213 23a6 316 4389 4388 9b 204f 849 2645 4388 2ca 222f 4389 4389 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a113 8040 4388 d1 264f 4389 4388 50b 286a 549 244c 850 2225 4389 4388 6c2 202d 4389 6dc 2a45 4388 4389 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a114 80b1 4388 4388 852 262a 4388 4388 311 284f 64d 2043 4388 4388 35c 2044 4d1 2880 4388 4388 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a015 80c0 4388 25c 224c 291 2447 35b 204d 35a 286f 4388 4388 842 2a4a 4388 505 2869 4388 4388 4388 94 2641 509 2646 74a 2061 4388 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a00f 8040 43ca 43ca 43ca 43ca 113 2642 413 204c 43ca 6c3 2446 43ca b 2468 44d 2046 55b 284a 558 2649 43ca da 2640 10b 2a69 43ca e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a010 80b1 43c8 43c8 43c8 61c 2049 43c8 648 242d 43c8 9d 202f 748 2a65 43c8 11b 204d 609 244f 43c8 84a 224f 43c8 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a011 80c0 43c8 52 2662 49a 244f 519 268d 43c8 43c8 11d 2046 40d 266d 43c8 43c9 499 202e 808 2a2d 43c9 43c9 71d 2665 43c9 4ca 2000 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a012 8000 43c8 43c8 460 264a 61b 244a 439 4389 50 2824 9b 224d 4388 285 244f 455 2049 84c 2640 4388 4389 4389 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a013 8040 4388 4389 4388 4389 4388 1a 2840 4c8 2445 51d 2640 4389 211 2846 219 264a 25b 2064 514 224f 4388 249 2843 4389 309 2200 e000 c000
[14:45:51.707] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a014 80b1 4388 14 2826 559 224f 742 2065 4388 212 2a4c 412 2041 4388 85b 2464 85b 2066 84c 2265 4388 4388 99 2a45 c1 2a4f 809 2640 4388 219 2a41 64d 222d 84a 2062 4388 449 284a 549 226f 4388 210 2800 e000 c000
[14:45:58.660] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[14:45:58.660] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:45:58.661] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a12d 80c0 4388 44d 2048 85b 264d 4388 1c 2465 80a 2667 4388 4388 4388 411 244d 820 202d 4388 4388 4388 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a127 8040 43c8 43c8 43c8 358 2042 348 2044 43c8 9d 2040 692 2641 43c8 cb 2049 281 2464 2e0 2a2c 43c8 43c8 43c8 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a128 80b1 43c8 43c8 309 2449 85a 2642 43c8 43c8 3 2a49 43c8 710 264f 43c8 50 2247 43c8 43c8 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a129 80c0 43c8 43c8 1c 2428 43c8 43c8 60c 2641 43c8 350 202d 34d 2027 34d 2241 43c8 200 2442 43c8 43c8 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a12a 8000 4388 7c 2064 927 288d 931 2911 225 2222 c31 4388 4388 4388 660 2043 4388 312 2421 4388 552 282d 4388 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a12b 8040 4388 28c 2080 51a 204f 4388 3 2a27 4388 361 224c 4388 359 284f 6d9 2049 4388 14d 2465 493 244f 4d2 2a4d 512 224d 4388 99 2861 49a 2245 4388 4388 4d9 2a63 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a12c 80b1 4388 4388 48a 2a46 709 2040 4388 2d3 2a61 4388 85a 2a48 4388 41c 2a2d 55a 2045 618 204a 4388 88 2045 210 2046 298 2641 4388 4388 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a02d 80c0 4388 4388 461 2a61 4388 49c 2264 65d 224d 860 2464 4388 4388 28a 2a4a 30c 262e 4388 55b 2865 754 2442 4388 4388 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a027 8040 43c8 35c 2447 43c8 d3 202f 43c8 43c8 35d 204c 85b 2a65 43c8 491 2225 43c8 759 204f 43c8 30a 244d 4c8 284d 615 2646 43c8 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a028 80b1 43c8 43c8 43c8 30d 202f 43c8 85c 224f 43c8 1c 2029 dd 204f 43c8 43c8 43c8 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a029 80c0 43c8 21 244f 43c8 15b 2469 43c8 85b 2067 43c8 91 2a2f 2d9 224b 43c8 285 2448 85d 2a42 43c8 6d1 2a4a 43c8 1a 2845 6d2 246a 741 264f 43c8 414 2400 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a02a 8000 4388 8f8 4388 60b 2269 4388 214 222f 44b 2680 4388 359 2a45 450 202e 4388 492 2049 4388 24b 2462 24b 264f 552 2862 4388 319 2600 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a02b 8040 4388 4388 4388 4388 721 2a4f 4388 248 2085 319 2642 358 2a49 4388 4388 c 2027 750 246a 4388 64a 2000 e000 c000
[14:45:58.661] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a02c 80b1 4388 813 246a 4388 4388 412 2646 61d 244b 4388 90 2244 44c 2040 759 2486 755 204f 4388 113 2240 689 2448 4388 91 2a62 d0 2845 21b 2260 4cd 2866 651 222d 4388 4388 452 2000 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[14:46:00.377] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:46:00.377] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f3 8040 43c8 69b 206d 43c9 4a 282a 82 2a8e 43c8 93 224f 14a 224f 24b 2241 854 2242 43c9 6d2 2843 43c8 d3 2285 350 264f 350 2a47 418 284f 43c9 4db 2a67 43c8 43c9 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ed 80c0 4388 113 2265 4388 612 282f 650 2448 74a 202d 4388 59 2a6b 2da 2a8a 449 2a65 488 2241 48c 2a46 61b 2464 61b 2082 4388 4388 4388 4388 4388 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ee 8000 4388 692 2228 80a 264a 4388 55d 2468 653 2a6b 4388 71a 264a 4388 95 2228 4d4 2245 688 242c 4388 4388 493 2a4f 4388 4388 14a 2a45 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ef 8040 438a 438a 550 2641 438a 561 2a42 84d 224f 438a 438a cd 2048 55b 2249 654 2a42 438a 438a 438a e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f0 80b6 2a40 39 43c9 31d 284a 853 2480 84b 264c 43c9 43c9 20 2241 410 2842 43c9 43c9 684 2a2f 43c9 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f1 80c0 43c8 215 2a42 311 244a 359 264a 752 2264 843 266b 43c8 214 2242 689 204a 43c8 28a 284f 2d3 2066 300 2443 43c8 43c9 2a0 224c 2e1 226f 693 2449 43c9 43c9 43c9 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1f2 8000 43c8 719 244c 81a 2445 43c8 6cd 224f 43c9 a 282d 2db 208f 40a 2a6f 43c9 43c8 43c8 43c9 75d 2447 43c9 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f3 8040 43c8 98 2842 43c9 43c8 462 2069 462 224f 43c9 651 2861 718 2043 43c8 702 2a2a 43c9 43c8 43c9 682 2400 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ed 80c0 4388 29a 2643 4388 4388 4388 715 202c 821 2a6c 4388 553 2267 61b 2a4c 4388 41 2444 99 2484 4388 609 2445 4388 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ee 8000 4388 612 2861 4388 4388 518 2280 552 2645 4388 11 2864 c 242f 4388 68b 284f 4388 1c 264f 150 2a4b 4388 4d0 284c 549 2268 4388 114 2000 31b 2800 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ef 8040 438a 243 2a42 438a 52 202e c2 2245 438a 438a 438a 488 2a2d 508 282f 438a 810 2645 438a 10 2025 252 2440 438a e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f0 80b3 ff8 2080 445 43c8 43c8 11d 2445 2dd 264d 454 2a4c 6cc 226c 43c8 551 266f 43c8 803 2640 43c8 43c8 21c 2240 54b 2285 43c8 508 2000 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f1 80c0 43c8 d1 204a 291 2845 43c8 43c8 43c8 2dc 284b 2c5 2a8d 43c9 c 282b 493 224d 4c9 244a 43c9 9 2462 8d 224e 43c9 8a 2442 21d 2048 748 244a 43c9 28d 2800 e000 c000
[14:46:00.377] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0f2 8000 43c8 499 224a 43c8 43c9 844 2449 43c9 209 2467 43c8 852 2a24 43c8 1a 2464 4d3 2046 74d 264a 81c 244b 43c9 43c9 e000 c000
[14:46:05.286] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[14:46:05.287] ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 7 ROCs were found
[14:46:05.287] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:46:05.287] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ea 8000 43c8 118 2a6f 662 2260 6cb 242f 43c8 43c8 43c8 253 224d 322 2462 753 2665 43c8 154 282c 710 200f 43c8 21d 284c 2dd 2845 43c8 43c8 e000 c000
[14:46:05.287] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e4 80b1 4388 4c9 244c 4388 14 2040 4388 28a 2862 420 208e 542 244a 4388 18 2042 810 2445 4388 60d 2a49 4388 4388 4388 4d9 244c e000 c000
[14:46:05.287] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e5 80c0 4388 414 204d 4388 14b 2840 68d 284a 68d 2465 4388 4d2 222e 4388 349 2a67 85a 2645 4388 4388 4388 4388 151 226c 842 2a45 e000 c000
[14:46:05.287] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e6 8000 4388 4388 d 2641 649 2845 4388 48d 2a45 4388 4388 64b 264c 4388 2e0 2a47 4388 44c 282c 4388 e000 c000
[14:46:05.287] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e7 8040 4388 4388 294 2027 650 2445 4388 2cd 2845 68b 204f 4388 85 2427 814 226c 4388 d2 2045 43c8 4d5 2661 43c8 502 43c8 499 2261 e000 c000
[14:46:05.287] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e8 80b1 43c8 54 282d 34c 2667 43c8 149 204c 451 2a6d 43c8 40a 2049 61b 2464 745 2049 43c8 91 222c 618 202f 43c8 71a 2642 43c8 43c8 43c8 e000 c000
[14:46:05.287] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e9 80c0 43c8 113 2649 4d9 2660 43c8 355 284c 43c8 5 2242 43c8 43c8 6a0 222e 43c8 404 2a2b 43c8 68c 262f 43c8 441 202c e000 c000
[14:46:05.290] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:46:05.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ea 8000 43c8 2da 202f 853 244c 43c8 93 2045 515 288b 43c8 552 2445 852 2648 43c8 15c 284f 43c8 69a 2842 43c8 250 2865 24b 2844 24b 244c 71d 2449 43c8 43c8 e000 c000
[14:46:05.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e4 80b1 4388 4388 4388 4388 4388 4388 4388 4388 8c 2800 e000 c000
[14:46:05.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e5 80c0 4388 4388 4388 755 2048 4388 4388 359 224f 4388 4388 50a 286d 4388 e000 c000
[14:46:05.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e6 8000 4388 41b 224e 455 26a1 4388 4388 4d3 224f 4388 2e0 284f 711 2645 4388 4388 10c 2645 4388 4388 1c 2a00 29d 2600 51b 2800 64a 2400 648 2600 6c2 2000 6c2 2200 e000 c000
[14:46:05.290] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a0e7 8040 4388 18 242e 4388 4388 4d1 284f 4388 510 222c 549 2441 4388 258 2a43 4388 b 224d 4388 10b 264c 202 2a4f 5a9 22d4 0 20ff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff
[14:46:05.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e8 80b1 43c8 43c8 415 2448 43c8 43c8 43c8 80d 2246 43c8 53 2845 4b 2063 43c8 53 264f 5a 2a48 758 2a4a 43c8 e000 c000
[14:46:05.290] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e9 80c0 43c8 43c8 43c8 220 284f 43c8 43c8 89 2a45 43c8 5a 2041 609 284c 43c8 11d 2064 48a 2a6f 54b 2a6b 43c8 55 2600 e000 c000
[14:46:07.016] ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[14:46:07.016] ERROR: <datapipe.cc/CheckEventID:L463> Channel 1 Event ID mismatch: local ID (1) != TBM ID (174)
[14:46:07.016] ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:46:07.016] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b1 80c0 4388 4388 48 2a45 695 202f 692 2240 4388 2e0 2a66 4dc 282f 4388 4389 220 2249 4c2 2849 6c4 266d 4389 4389 4389 80b 2447 e000 c000
[14:46:07.016] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ac 80b1 43c8 362 2248 753 2267 43c8 43c8 2c8 2a40 85b 2247 43c8 6d9 2862 43c8 43c8 111 2841 444 2464 43c8 491 222c 43c8 e000 c000
[14:46:07.016] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a1ad 80c0 43c8 43c8 291 264b 43c8 40c 204c 743 2244 43c8 43c8 43c8 a0 2a6a 44a 2265 43c8 461 222d 461 2641 4389
[14:46:07.016] ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a100 8001 fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff fff 2fff
[14:46:07.017] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ae 8000 4388 810 2a4f 849 282a 4388 4388 4388 554 2046 4388 a0 2a41 2c8 2249 4388 4388 4388 215 2041 e000 c000
[14:46:07.017] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1af 8040 438a 112 2845 438a 298 2441 438a 11a 2089 11a 2249 748 2826 438a 438a 154 2861 648 2245 438a 9 2645 438a 438a e000 c000
[14:46:07.017] ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b0 80b1 4389 80 2644 4389 82 2a4c 20d 244d 4389 2db 2265 500 2627 4389 81d 264f 4389 1c 2040 2d2 224a 4389 2d3 264d 4389 4389 e000 c000
[14:46:16.680] INFO: Resuming triggers.
[14:46:16.849] INFO: data taking finished, elapsed time: 100 seconds.
[14:46:17.969] INFO: PixTest:: pg_setup set to default.
[14:46:17.973] INFO: PixTestXray::doPhRun() done
[14:46:18.122] INFO: enter test to run
[14:47:14.383] INFO: test: HighRate no parameter change
[14:47:14.383] INFO: running: highrate
[14:47:14.384] INFO: ----------------------------------------------------------------------
[14:47:14.384] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[14:47:14.384] INFO: ----------------------------------------------------------------------
[14:47:14.526] INFO: Expecting 768 events.
[14:47:15.659] INFO: 768 events read in total (418ms).
[14:47:15.660] INFO: Test took 1268ms.
[14:47:16.463] INFO: Expecting 41600 events.
[14:47:19.497] INFO: 41600 events read in total (2507ms).
[14:47:19.498] INFO: Test took 3831ms.
[14:47:19.529] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:20.262] INFO: Expecting 41600 events.
[14:47:23.425] INFO: 41600 events read in total (2637ms).
[14:47:23.425] INFO: Test took 3879ms.
[14:47:23.455] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:24.188] INFO: Expecting 41600 events.
[14:47:27.373] INFO: 41600 events read in total (2659ms).
[14:47:27.374] INFO: Test took 3902ms.
[14:47:27.404] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:28.136] INFO: Expecting 41600 events.
[14:47:31.334] INFO: 41600 events read in total (2671ms).
[14:47:31.335] INFO: Test took 3914ms.
[14:47:31.365] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:32.098] INFO: Expecting 41600 events.
[14:47:35.290] INFO: 41600 events read in total (2665ms).
[14:47:35.291] INFO: Test took 3909ms.
[14:47:35.321] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:36.048] INFO: Expecting 41600 events.
[14:47:39.244] INFO: 41600 events read in total (2669ms).
[14:47:39.245] INFO: Test took 3908ms.
[14:47:39.275] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:40.009] INFO: Expecting 41600 events.
[14:47:43.215] INFO: 41600 events read in total (2679ms).
[14:47:43.216] INFO: Test took 3924ms.
[14:47:43.246] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:43.979] INFO: Expecting 41600 events.
[14:47:47.173] INFO: 41600 events read in total (2667ms).
[14:47:47.174] INFO: Test took 3910ms.
[14:47:47.203] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:47.936] INFO: Expecting 41600 events.
[14:47:51.147] INFO: 41600 events read in total (2684ms).
[14:47:51.148] INFO: Test took 3929ms.
[14:47:51.178] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:51.911] INFO: Expecting 41600 events.
[14:47:55.115] INFO: 41600 events read in total (2677ms).
[14:47:55.116] INFO: Test took 3922ms.
[14:47:55.146] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:55.876] INFO: Expecting 41600 events.
[14:47:59.077] INFO: 41600 events read in total (2674ms).
[14:47:59.078] INFO: Test took 3914ms.
[14:47:59.109] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:47:59.839] INFO: Expecting 41600 events.
[14:48:03.025] INFO: 41600 events read in total (2660ms).
[14:48:03.026] INFO: Test took 3899ms.
[14:48:03.056] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:03.786] INFO: Expecting 41600 events.
[14:48:06.983] INFO: 41600 events read in total (2670ms).
[14:48:06.984] INFO: Test took 3910ms.
[14:48:07.014] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:07.742] INFO: Expecting 41600 events.
[14:48:10.932] INFO: 41600 events read in total (2663ms).
[14:48:10.933] INFO: Test took 3901ms.
[14:48:10.964] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:11.693] INFO: Expecting 41600 events.
[14:48:14.880] INFO: 41600 events read in total (2660ms).
[14:48:14.881] INFO: Test took 3900ms.
[14:48:14.911] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:15.642] INFO: Expecting 41600 events.
[14:48:18.865] INFO: 41600 events read in total (2696ms).
[14:48:18.866] INFO: Test took 3938ms.
[14:48:18.896] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:19.628] INFO: Expecting 41600 events.
[14:48:22.837] INFO: 41600 events read in total (2682ms).
[14:48:22.838] INFO: Test took 3926ms.
[14:48:22.868] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:23.599] INFO: Expecting 41600 events.
[14:48:26.786] INFO: 41600 events read in total (2660ms).
[14:48:26.787] INFO: Test took 3901ms.
[14:48:26.817] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:27.549] INFO: Expecting 41600 events.
[14:48:30.742] INFO: 41600 events read in total (2666ms).
[14:48:30.743] INFO: Test took 3908ms.
[14:48:30.773] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:31.502] INFO: Expecting 41600 events.
[14:48:34.559] INFO: 41600 events read in total (2531ms).
[14:48:34.560] INFO: Test took 3769ms.
[14:48:34.589] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:48:34.963] INFO: enter test to run
[14:48:57.966] INFO: test: HighRate no parameter change
[14:48:57.966] INFO: running: highrate
[14:48:57.968] INFO: ----------------------------------------------------------------------
[14:48:57.968] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:48:57.968] INFO: ----------------------------------------------------------------------
[14:48:58.582] INFO: Expecting 208000 events.
[14:49:10.199] INFO: 208000 events read in total (11090ms).
[14:49:10.202] INFO: Test took 12226ms.
[14:49:10.328] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:49:10.574] INFO: number of dead pixels (per ROC): 0 0 0 0 6 2 0 71 1 0 0 0 0 0 0 1
[14:49:10.574] INFO: number of red-efficiency pixels: 62 41 73 90 111 126 100 175 81 109 103 66 95 54 19 28
[14:49:10.574] INFO: number of X-ray hits detected: 64076 39035 55946 88203 88192 91939 92163 60046 67405 89617 82314 76003 84707 49441 20596 22282
[14:49:10.574] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:49:10.574] INFO: number of Vcal hits detected: 207938 207959 207923 207910 207593 207772 207897 204226 207868 207888 207896 207934 207904 207945 207981 207923
[14:49:10.574] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 100.0 100.0 99.9 99.9 100.0 99.9 100.0 99.9 100.0 100.0 100.0 100.0 100.0 100.0
[14:49:10.574] INFO: Vcal hit overall efficiency (%): 100.0 100.0 100.0 100.0 99.8 99.9 100.0 98.2 99.9 99.9 100.0 100.0 100.0 100.0 100.0 100.0
[14:49:10.574] INFO: X-ray hit rate [MHz/cm2]: 18.8 11.4 16.4 25.9 25.8 26.9 27.0 17.6 19.8 26.3 24.1 22.3 24.8 14.5 6.0 6.5
[14:49:10.574] INFO: PixTestHighRate::doXPixelAlive() done
[14:49:10.627] INFO: PixTest:: pg_setup set to default.
[14:49:10.640] INFO: enter test to run
[14:49:42.838] INFO: test: HighRate no parameter change
[14:49:42.838] INFO: running: highrate
[14:49:42.839] INFO: ----------------------------------------------------------------------
[14:49:42.839] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:49:42.839] INFO: ----------------------------------------------------------------------
[14:49:43.454] INFO: Expecting 208000 events.
[14:49:56.599] INFO: 208000 events read in total (12618ms).
[14:49:56.604] INFO: Test took 13756ms.
[14:49:56.863] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:49:57.152] INFO: number of dead pixels (per ROC): 0 0 0 0 6 2 0 72 1 0 0 0 0 0 0 1
[14:49:57.152] INFO: number of red-efficiency pixels: 195 103 220 304 348 377 316 313 241 282 307 246 314 153 42 70
[14:49:57.152] INFO: number of X-ray hits detected: 135588 82782 118108 186314 185685 193462 194323 126278 142493 188426 173779 159702 177829 104259 43314 47553
[14:49:57.153] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:49:57.153] INFO: number of Vcal hits detected: 207796 207895 207767 207685 207335 207503 207668 204066 207698 207685 207676 207741 207670 207842 207958 207881
[14:49:57.153] INFO: Vcal hit fiducial efficiency (%): 99.9 100.0 99.9 99.9 99.8 99.8 99.9 99.8 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[14:49:57.153] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.9 99.8 99.7 99.8 99.8 98.1 99.9 99.8 99.8 99.9 99.8 99.9 100.0 99.9
[14:49:57.153] INFO: X-ray hit rate [MHz/cm2]: 39.7 24.3 34.6 54.6 54.4 56.7 57.0 37.0 41.8 55.2 50.9 46.8 52.1 30.6 12.7 13.9
[14:49:57.153] INFO: PixTestHighRate::doXPixelAlive() done
[14:49:57.201] INFO: PixTest:: pg_setup set to default.
[14:49:57.214] INFO: enter test to run
[14:51:06.069] INFO: test: HighRate no parameter change
[14:51:06.070] INFO: running: highrate
[14:51:06.071] INFO: ----------------------------------------------------------------------
[14:51:06.071] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[14:51:06.071] INFO: ----------------------------------------------------------------------
[14:51:06.687] INFO: Expecting 208000 events.
[14:51:21.517] INFO: 208000 events read in total (14304ms).
[14:51:21.524] INFO: Test took 15445ms.
[14:51:21.923] INFO: Fetched DAQ statistics. Counters are being reset now.
[14:51:22.259] INFO: number of dead pixels (per ROC): 0 0 0 0 6 2 0 72 1 0 0 0 0 0 0 1
[14:51:22.259] INFO: number of red-efficiency pixels: 381 249 495 721 812 883 748 592 478 575 709 491 725 422 71 90
[14:51:22.259] INFO: number of X-ray hits detected: 206638 125291 181625 284310 283626 293980 297079 192776 217875 287220 265720 243775 271930 159234 66536 72557
[14:51:22.259] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[14:51:22.259] INFO: number of Vcal hits detected: 207548 207735 207406 207164 206776 206857 207145 203714 207408 207312 207202 207452 207155 207515 207923 207861
[14:51:22.259] INFO: Vcal hit fiducial efficiency (%): 99.8 99.9 99.7 99.6 99.6 99.5 99.6 99.7 99.8 99.7 99.6 99.8 99.6 99.8 100.0 100.0
[14:51:22.259] INFO: Vcal hit overall efficiency (%): 99.8 99.9 99.7 99.6 99.4 99.5 99.6 97.9 99.7 99.7 99.6 99.7 99.6 99.8 100.0 99.9
[14:51:22.259] INFO: X-ray hit rate [MHz/cm2]: 60.6 36.7 53.2 83.3 83.1 86.2 87.1 56.5 63.9 84.2 77.9 71.5 79.7 46.7 19.5 21.3
[14:51:22.259] INFO: PixTestHighRate::doXPixelAlive() done
[14:51:22.305] INFO: PixTest:: pg_setup set to default.
[14:51:22.320] INFO: enter test to run
[14:51:38.637] INFO: test: exit no parameter change
[14:51:39.012] QUIET: Connection to board 33 closed.
[14:51:39.013] INFO: pXar: this is the end, my friend