[14:33:27.812] <TB3> INFO: *** Welcome to pxar ***
[14:33:27.812] <TB3> INFO: *** Today: 2015/12/08
[14:33:27.911] <TB3> INFO: *** Version: 3197
[14:33:27.911] <TB3> INFO: readRocDacs: /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C15.dat
[14:33:27.912] <TB3> INFO: readTbmDacs: /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//tbmParameters_C0b.dat
[14:33:27.912] <TB3> INFO: readMaskFile: /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//defaultMaskFile.dat
[14:33:27.912] <TB3> INFO: readTrimFile: /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters_C15.dat
[14:33:27.986] <TB3> INFO: clk: 4
[14:33:27.986] <TB3> INFO: ctr: 4
[14:33:27.986] <TB3> INFO: sda: 19
[14:33:27.986] <TB3> INFO: tin: 9
[14:33:27.986] <TB3> INFO: level: 15
[14:33:27.986] <TB3> INFO: triggerdelay: 0
[14:33:27.986] <TB3> QUIET: Instanciating API for pxar prod-12
[14:33:27.986] <TB3> INFO: Log level: INFO
[14:33:27.995] <TB3> INFO: Found DTB DTB_WZ4I6J
[14:33:28.003] <TB3> QUIET: Connection to board DTB_WZ4I6J opened.
[14:33:28.006] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 170
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WZ4I6J
MAC address: 40D8551180AA
Hostname: pixelDTB170
Comment:
------------------------------------------------------
[14:33:28.009] <TB3> INFO: RPC call hashes of host and DTB match: 398089610
[14:33:29.535] <TB3> INFO: DUT info:
[14:33:29.535] <TB3> INFO: The DUT currently contains the following objects:
[14:33:29.535] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[14:33:29.535] <TB3> INFO: TBM Core alpha (0): 7 registers set
[14:33:29.536] <TB3> INFO: TBM Core beta (1): 7 registers set
[14:33:29.536] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:33:29.536] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.536] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:33:29.937] <TB3> INFO: enter 'restricted' command line mode
[14:33:29.937] <TB3> INFO: enter test to run
[14:33:29.938] <TB3> INFO: test: pretest no parameter change
[14:33:29.938] <TB3> INFO: running: pretest
[14:33:29.945] <TB3> INFO: ######################################################################
[14:33:29.945] <TB3> INFO: PixTestPretest::doTest()
[14:33:29.945] <TB3> INFO: ######################################################################
[14:33:29.947] <TB3> INFO: ----------------------------------------------------------------------
[14:33:29.947] <TB3> INFO: PixTestPretest::programROC()
[14:33:29.947] <TB3> INFO: ----------------------------------------------------------------------
[14:33:47.966] <TB3> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[14:33:47.966] <TB3> INFO: IA differences per ROC: 16.1 20.9 17.7 17.7 20.1 20.1 19.3 17.7 20.1 20.1 18.5 17.7 17.7 19.3 19.3 16.9
[14:33:48.051] <TB3> INFO: ----------------------------------------------------------------------
[14:33:48.051] <TB3> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[14:33:48.051] <TB3> INFO: ----------------------------------------------------------------------
[14:33:54.254] <TB3> INFO: PixTestPretest::setVana() done, Module Ia 381 mA = 23.8125 mA/ROC
[14:33:54.254] <TB3> INFO: i(loss) [mA/ROC]: 18.5 19.3 20.1 19.3 18.5 18.5 20.1 19.3 18.5 18.5 18.5 18.5 19.3 18.5 18.5 18.5
[14:33:54.291] <TB3> INFO: ----------------------------------------------------------------------
[14:33:54.291] <TB3> INFO: PixTestPretest::findTiming()
[14:33:54.291] <TB3> INFO: ----------------------------------------------------------------------
[14:33:54.291] <TB3> INFO: PixTestCmd::init()
[14:33:54.886] <TB3> WARNING: Not unmasking DUT, not setting Calibrate bits!
[14:35:28.817] <TB3> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[14:35:28.817] <TB3> INFO: (success/tries = 100/100), width = 4
[14:35:28.819] <TB3> INFO: ----------------------------------------------------------------------
[14:35:28.819] <TB3> INFO: PixTestPretest::findWorkingPixel()
[14:35:28.819] <TB3> INFO: ----------------------------------------------------------------------
[14:35:28.959] <TB3> INFO: Expecting 231680 events.
[14:35:33.569] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (1) != Token Chain Length (8)
[14:35:33.572] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (21) != TBM ID (2)
[14:35:36.394] <TB3> INFO: 231680 events read in total (6720ms).
[14:35:36.399] <TB3> INFO: Test took 7574ms.
[14:35:36.811] <TB3> INFO: Found working pixel in all ROCs: col/row = 12/22
[14:35:36.849] <TB3> INFO: ----------------------------------------------------------------------
[14:35:36.850] <TB3> INFO: PixTestPretest::setVthrCompCalDel()
[14:35:36.850] <TB3> INFO: ----------------------------------------------------------------------
[14:35:36.986] <TB3> INFO: Expecting 231680 events.
[14:35:45.345] <TB3> INFO: 231680 events read in total (7644ms).
[14:35:45.350] <TB3> INFO: Test took 8495ms.
[14:35:45.779] <TB3> INFO: PixTestPretest::setVthrCompCalDel() done
[14:35:45.779] <TB3> INFO: CalDel: 149 143 140 142 162 148 153 147 138 139 145 133 131 168 129 132
[14:35:45.779] <TB3> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[14:35:45.783] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C0.dat
[14:35:45.783] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C1.dat
[14:35:45.783] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C2.dat
[14:35:45.784] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C3.dat
[14:35:45.784] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C4.dat
[14:35:45.784] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C5.dat
[14:35:45.785] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C6.dat
[14:35:45.785] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C7.dat
[14:35:45.785] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C8.dat
[14:35:45.786] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C9.dat
[14:35:45.786] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C10.dat
[14:35:45.786] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C11.dat
[14:35:45.787] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C12.dat
[14:35:45.787] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C13.dat
[14:35:45.787] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C14.dat
[14:35:45.788] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters_C15.dat
[14:35:45.788] <TB3> INFO: write tbm parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//tbmParameters_C0a.dat
[14:35:45.788] <TB3> INFO: write tbm parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//tbmParameters_C0b.dat
[14:35:45.788] <TB3> INFO: PixTestPretest::doTest() done, duration: 135 seconds
[14:35:45.872] <TB3> INFO: enter test to run
[14:35:45.872] <TB3> INFO: test: fulltest no parameter change
[14:35:45.872] <TB3> INFO: running: fulltest
[14:35:45.872] <TB3> INFO: ######################################################################
[14:35:45.872] <TB3> INFO: PixTestFullTest::doTest()
[14:35:45.872] <TB3> INFO: ######################################################################
[14:35:45.873] <TB3> INFO: ######################################################################
[14:35:45.873] <TB3> INFO: PixTestAlive::doTest()
[14:35:45.873] <TB3> INFO: ######################################################################
[14:35:45.875] <TB3> INFO: ----------------------------------------------------------------------
[14:35:45.875] <TB3> 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:35:45.875] <TB3> INFO: ----------------------------------------------------------------------
[14:35:46.213] <TB3> INFO: Expecting 41600 events.
[14:35:50.512] <TB3> INFO: 41600 events read in total (3584ms).
[14:35:50.513] <TB3> INFO: Test took 4636ms.
[14:35:50.536] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:35:50.900] <TB3> INFO: PixTestAlive::aliveTest() done
[14:35:50.900] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 2 0 0 0 1 0 0 0 0 0 0 0 0
[14:35:50.902] <TB3> INFO: ----------------------------------------------------------------------
[14:35:50.902] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:35:50.902] <TB3> INFO: ----------------------------------------------------------------------
[14:35:51.240] <TB3> INFO: Expecting 41600 events.
[14:35:54.375] <TB3> INFO: 41600 events read in total (2420ms).
[14:35:54.375] <TB3> INFO: Test took 3472ms.
[14:35:54.375] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:35:54.375] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:35:54.781] <TB3> INFO: PixTestAlive::maskTest() done
[14:35:54.781] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:35:54.783] <TB3> INFO: ----------------------------------------------------------------------
[14:35:54.783] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[14:35:54.783] <TB3> INFO: ----------------------------------------------------------------------
[14:35:55.105] <TB3> INFO: Expecting 41600 events.
[14:35:59.322] <TB3> INFO: 41600 events read in total (3502ms).
[14:35:59.322] <TB3> INFO: Test took 4538ms.
[14:35:59.330] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:35:59.710] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[14:35:59.710] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[14:35:59.710] <TB3> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[14:35:59.710] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:35:59.710] <TB3> INFO: Decoding statistics:
[14:35:59.710] <TB3> INFO: General information:
[14:35:59.710] <TB3> INFO: 16bit words read: 0
[14:35:59.710] <TB3> INFO: valid events total: 0
[14:35:59.710] <TB3> INFO: empty events: 0
[14:35:59.710] <TB3> INFO: valid events with pixels: 0
[14:35:59.710] <TB3> INFO: valid pixel hits: 0
[14:35:59.710] <TB3> INFO: Event errors: 0
[14:35:59.710] <TB3> INFO: start marker: 0
[14:35:59.710] <TB3> INFO: stop marker: 0
[14:35:59.710] <TB3> INFO: overflow: 0
[14:35:59.710] <TB3> INFO: invalid 5bit words: 0
[14:35:59.710] <TB3> INFO: invalid XOR eye diagram: 0
[14:35:59.710] <TB3> INFO: TBM errors: 0
[14:35:59.710] <TB3> INFO: flawed TBM headers: 0
[14:35:59.710] <TB3> INFO: flawed TBM trailers: 0
[14:35:59.710] <TB3> INFO: event ID mismatches: 0
[14:35:59.710] <TB3> INFO: ROC errors: 0
[14:35:59.710] <TB3> INFO: missing ROC header(s): 0
[14:35:59.710] <TB3> INFO: misplaced readback start: 0
[14:35:59.710] <TB3> INFO: Pixel decoding errors: 0
[14:35:59.710] <TB3> INFO: pixel data incomplete: 0
[14:35:59.710] <TB3> INFO: pixel address: 0
[14:35:59.710] <TB3> INFO: pulse height fill bit: 0
[14:35:59.711] <TB3> INFO: buffer corruption: 0
[14:35:59.721] <TB3> INFO: ######################################################################
[14:35:59.721] <TB3> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[14:35:59.721] <TB3> INFO: ######################################################################
[14:35:59.724] <TB3> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[14:35:59.736] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[14:35:59.736] <TB3> INFO: run 1 of 1
[14:36:00.040] <TB3> INFO: Expecting 3120000 events.
[14:36:51.102] <TB3> INFO: 1200030 events read in total (50347ms).
[14:37:43.256] <TB3> INFO: 2394775 events read in total (102501ms).
[14:38:11.614] <TB3> INFO: 3120000 events read in total (130859ms).
[14:38:11.668] <TB3> INFO: Test took 131933ms.
[14:38:11.756] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:38:35.490] <TB3> INFO: PixTestBBMap::doTest() done, duration: 155 seconds
[14:38:35.490] <TB3> INFO: number of dead bumps (per ROC): 0 1 0 0 1 1 0 0 0 0 0 0 2 0 0 0
[14:38:35.490] <TB3> INFO: separation cut (per ROC): 99 133 132 119 112 112 111 123 111 126 106 103 104 106 117 106
[14:38:35.490] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:38:35.490] <TB3> INFO: Decoding statistics:
[14:38:35.490] <TB3> INFO: General information:
[14:38:35.490] <TB3> INFO: 16bit words read: 0
[14:38:35.490] <TB3> INFO: valid events total: 0
[14:38:35.490] <TB3> INFO: empty events: 0
[14:38:35.490] <TB3> INFO: valid events with pixels: 0
[14:38:35.490] <TB3> INFO: valid pixel hits: 0
[14:38:35.490] <TB3> INFO: Event errors: 0
[14:38:35.490] <TB3> INFO: start marker: 0
[14:38:35.490] <TB3> INFO: stop marker: 0
[14:38:35.490] <TB3> INFO: overflow: 0
[14:38:35.490] <TB3> INFO: invalid 5bit words: 0
[14:38:35.490] <TB3> INFO: invalid XOR eye diagram: 0
[14:38:35.490] <TB3> INFO: TBM errors: 0
[14:38:35.490] <TB3> INFO: flawed TBM headers: 0
[14:38:35.490] <TB3> INFO: flawed TBM trailers: 0
[14:38:35.490] <TB3> INFO: event ID mismatches: 0
[14:38:35.490] <TB3> INFO: ROC errors: 0
[14:38:35.490] <TB3> INFO: missing ROC header(s): 0
[14:38:35.490] <TB3> INFO: misplaced readback start: 0
[14:38:35.490] <TB3> INFO: Pixel decoding errors: 0
[14:38:35.490] <TB3> INFO: pixel data incomplete: 0
[14:38:35.490] <TB3> INFO: pixel address: 0
[14:38:35.490] <TB3> INFO: pulse height fill bit: 0
[14:38:35.490] <TB3> INFO: buffer corruption: 0
[14:38:35.562] <TB3> INFO: ######################################################################
[14:38:35.562] <TB3> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[14:38:35.562] <TB3> INFO: ######################################################################
[14:38:35.562] <TB3> INFO: ----------------------------------------------------------------------
[14:38:35.562] <TB3> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[14:38:35.562] <TB3> INFO: ----------------------------------------------------------------------
[14:38:35.563] <TB3> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[14:38:35.571] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[14:38:35.571] <TB3> INFO: run 1 of 1
[14:38:35.878] <TB3> INFO: Expecting 26208000 events.
[14:39:08.023] <TB3> INFO: 1102450 events read in total (31430ms).
[14:39:39.018] <TB3> INFO: 2185000 events read in total (62425ms).
[14:40:10.804] <TB3> INFO: 3264050 events read in total (94211ms).
[14:40:41.450] <TB3> INFO: 4340100 events read in total (124857ms).
[14:41:11.816] <TB3> INFO: 5412400 events read in total (155223ms).
[14:41:42.556] <TB3> INFO: 6483850 events read in total (185963ms).
[14:42:13.183] <TB3> INFO: 7552700 events read in total (216590ms).
[14:42:44.407] <TB3> INFO: 8618950 events read in total (247814ms).
[14:43:16.168] <TB3> INFO: 9685700 events read in total (279575ms).
[14:43:47.886] <TB3> INFO: 10746550 events read in total (311293ms).
[14:44:19.393] <TB3> INFO: 11807250 events read in total (342800ms).
[14:44:50.241] <TB3> INFO: 12864500 events read in total (373648ms).
[14:45:21.146] <TB3> INFO: 13912850 events read in total (404553ms).
[14:45:51.815] <TB3> INFO: 14955550 events read in total (435222ms).
[14:46:23.217] <TB3> INFO: 15995150 events read in total (466624ms).
[14:46:54.138] <TB3> INFO: 17032900 events read in total (497545ms).
[14:47:25.440] <TB3> INFO: 18069700 events read in total (528847ms).
[14:47:56.629] <TB3> INFO: 19103850 events read in total (560036ms).
[14:48:27.491] <TB3> INFO: 20135800 events read in total (590898ms).
[14:48:35.600] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[14:48:35.600] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (5) != Token Chain Length (8)
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0aa 8000 43c9 641 26c0 43c9 641 26c8 43c9 641 266e 43c9 641 26ad 43c9 641 26c5 43c9 641 26e5 43c9 641 26c4 43c9 641 26c9 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a4 80b1 4388 641 26c2 4388 641 26c9 4388 641 266d 4388 641 26ad 4388 641 26c5 4388 641 26e5 4388 641 26c2 4388 641 26c9 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a5 80c0 4388 641 26af 4388 641 26c7 4388 641 266e 4388 641 26ac 4388 641 26c5 4388 641 26e5 4388 641 26c2 4388 641 26c9 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a6 8000 4388 641 26c0 4388 641 26c7 4388 4388 641 26ad 4388 641 26c5 4388 641 26e6 4388 641 26c4 4388 641 26c9 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a7 8040 4388 641 26c1 4388 641 26c8 4388 43c8 641 26ad 43c8 53f 2ff3 d6d 2f3f 7f6 43c8 641 26c3 43c8 641 26c9 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a8 80b1 43c8 641 26af 43c8 641 26c8 43c8 641 266e 43c8 641 26ad 43c8 641 26c6 43c8 641 26e5 43c8 641 26c1 43c8 641 26c9 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a9 80c0 43c9 641 26c1 43c9 641 26c9 43c9 641 266d 43c9 641 26ad 43c9 641 26c4 43c9 641 26e4 43c9 641 26c4 43c9 641 26cc e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1aa 8000 43c9 641 26e0 43c9 641 26a9 43c9 641 26ec 43c9 641 2701 43c9 641 2702 43c9 641 26c5 43c9 641 26c7 43c9 641 26c7 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a4 80b1 4388 641 26e0 4388 641 26a9 4388 641 26ec 4388 641 2701 4388 641 2700 4388 641 26c5 4388 641 26c6 4388 641 26c7 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a5 80c0 4388 641 26e0 4388 641 26ab 4388 641 26ed 4388 641 2703 4388 641 2700 4388 641 26c4 4388 641 26c5 4388 641 26c7 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a6 8000 4388 641 26e0 4388 641 26aa 4388 641 26ed 4388 641 2701 4388 641 2702 4388 641 26c5 4388 641 26c5 4388 641 26c7 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a7 8040 4388 641 26e0 4388 641 26ab 4388 641 26ec 43c8 641 27fd 3 200f fc 2010 c82 43c8 641 26c6 43c8 641 26c7 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a8 80b1 43c8 641 26e0 43c8 641 26a9 43c8 641 26ed 43c8 641 2703 43c8 641 2701 43c8 641 26c5 43c8 641 26c5 43c8 641 26c8 e022 c000
[14:48:35.600] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1a9 80c0 43c9 641 26e0 43c9 641 26a9 43c9 641 26ec 43c9 641 2702 43c9 641 2700 43c9 641 26c4 43c9 641 26c5 43c9 641 26c7 e022 c000
[14:48:58.758] <TB3> INFO: 21167750 events read in total (622165ms).
[14:49:30.207] <TB3> INFO: 22198100 events read in total (653614ms).
[14:50:01.039] <TB3> INFO: 23227550 events read in total (684446ms).
[14:50:32.543] <TB3> INFO: 24259350 events read in total (715950ms).
[14:51:02.600] <TB3> INFO: 25290550 events read in total (746007ms).
[14:51:29.420] <TB3> INFO: 26208000 events read in total (772827ms).
[14:51:29.460] <TB3> INFO: Test took 773889ms.
[14:51:29.549] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:51:29.740] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:31.314] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:32.825] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:34.202] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:35.642] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:37.122] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:38.586] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:40.297] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:42.162] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:44.316] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:45.809] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:47.502] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:49.588] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:51.258] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:52.728] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:54.194] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[14:51:55.675] <TB3> INFO: PixTestScurves::scurves() done
[14:51:55.675] <TB3> INFO: Vcal mean: 70.65 93.02 113.21 102.70 84.14 84.57 83.97 89.35 86.12 100.58 82.81 80.85 73.40 78.15 92.95 90.68
[14:51:55.675] <TB3> INFO: Vcal RMS: 4.74 5.09 5.37 6.05 4.70 4.88 4.89 6.31 4.95 6.20 4.83 5.26 5.12 4.51 8.61 5.67
[14:51:55.675] <TB3> INFO: PixTestScurves::fullTest() done, duration: 800 seconds
[14:51:55.675] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:51:55.675] <TB3> INFO: Decoding statistics:
[14:51:55.675] <TB3> INFO: General information:
[14:51:55.675] <TB3> INFO: 16bit words read: 0
[14:51:55.675] <TB3> INFO: valid events total: 0
[14:51:55.675] <TB3> INFO: empty events: 0
[14:51:55.675] <TB3> INFO: valid events with pixels: 0
[14:51:55.675] <TB3> INFO: valid pixel hits: 0
[14:51:55.675] <TB3> INFO: Event errors: 0
[14:51:55.675] <TB3> INFO: start marker: 0
[14:51:55.675] <TB3> INFO: stop marker: 0
[14:51:55.675] <TB3> INFO: overflow: 0
[14:51:55.675] <TB3> INFO: invalid 5bit words: 0
[14:51:55.675] <TB3> INFO: invalid XOR eye diagram: 0
[14:51:55.675] <TB3> INFO: TBM errors: 0
[14:51:55.675] <TB3> INFO: flawed TBM headers: 0
[14:51:55.675] <TB3> INFO: flawed TBM trailers: 0
[14:51:55.675] <TB3> INFO: event ID mismatches: 0
[14:51:55.675] <TB3> INFO: ROC errors: 0
[14:51:55.675] <TB3> INFO: missing ROC header(s): 0
[14:51:55.675] <TB3> INFO: misplaced readback start: 0
[14:51:55.675] <TB3> INFO: Pixel decoding errors: 0
[14:51:55.675] <TB3> INFO: pixel data incomplete: 0
[14:51:55.675] <TB3> INFO: pixel address: 0
[14:51:55.675] <TB3> INFO: pulse height fill bit: 0
[14:51:55.675] <TB3> INFO: buffer corruption: 0
[14:51:55.752] <TB3> INFO: ######################################################################
[14:51:55.752] <TB3> INFO: PixTestTrim::doTest()
[14:51:55.752] <TB3> INFO: ######################################################################
[14:51:55.754] <TB3> INFO: ----------------------------------------------------------------------
[14:51:55.754] <TB3> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[14:51:55.754] <TB3> INFO: ----------------------------------------------------------------------
[14:51:55.833] <TB3> INFO: ---> VthrComp thr map (minimal VthrComp)
[14:51:55.833] <TB3> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[14:51:55.842] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[14:51:55.842] <TB3> INFO: run 1 of 1
[14:51:56.146] <TB3> INFO: Expecting 6281600 events.
[14:52:16.831] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 2 ROCs were found
[14:52:16.831] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (5) != Token Chain Length (8)
[14:52:16.831] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (110) != TBM ID (255)
[14:52:16.831] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (4) != Token Chain Length (8)
[14:52:16.831] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (256) != TBM ID (110)
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a170 80b1 43c9 22 20c2 43c9 43c9 22 20e7 43c9 22 20ed 43c9 22 2101 43c9 43c9 43c9 22 20ad e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16a 8000 4389 22 20c1 4389 4389 22 20e7 4389 4389 22 2101 4389 4389 22 20a9 4389 22 20ac e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16b 8040 4389 22 20c2 4389 4389 22 20e8 4389 22 20ed 4389 22 2102 4389 4389 22 20aa 4389 22 20ac e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16c 80b1 4389 22 20c2 4389 4389 22 20e8 4389 22 20ed 4389 22 2101 4389 4389 22 20a9 4389 22 20ad e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16d 80c0 4389 22 20c2 53c9 43c9 9 2e0a 80a 2012 44 43c9 43c9 22 20ab 43c9 22 20ad e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16e 8000 43c9 22 20c2 43c9 43c9 22 20e9 43c9 22 20ee 43c9 22 2101 43c9 43c9 22 20a9 43c9 22 20ac e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16f 8040 43cb 22 20c2 43cb 43cb 22 20e9 43cb 22 20ed 43cb 22 2101 43cb 43cb 22 20a8 43cb 22 20ad e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a071 80c0 43c8 43c8 22 20aa 43c8 43c8 22 20a4 43c9 43c9 43c9 22 20ac 43c9 22 20c1 e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06c 80b1 4389 4389 22 20aa 4389 4389 22 20a5 4389 4389 4389 22 20aa 4389 22 20c1 e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a06d 80c0 4389 4389 22 30a9 43c9
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ff 8057 43c9 43c9 43c9 22 20ad 43c9 22 20c1 e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06e 8000 43c9 43c9 22 20aa 43c9 43c9 22 20a4 43c9 43c9 43c9 22 20aa 43c9 22 20c2 e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06f 8040 43cb 43cb 43cb 22 2066 43cb 22 20a3 43cb 43cb 43cb 22 20ac 43cb 22 20c2 e022 c000
[14:52:16.831] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a070 80b1 43c8 22 20a6 43c8 43c8 43c8 22 20a4 43c8 43c8 43c8 22 20ac 43c8 22 20c0 e022 c000
[14:52:37.571] <TB3> CRITICAL: <hal.cc/condenseTriggers:L1899> Data size does not correspond to 10 triggers! Aborting data processing!
[14:52:37.587] <TB3> INFO: 0 events read in total (40722ms).
[14:53:21.113] <TB3> INFO: 1413600 events read in total (84248ms).
[14:54:05.161] <TB3> INFO: 2830920 events read in total (128296ms).
[14:54:48.635] <TB3> INFO: 4256700 events read in total (171770ms).
[14:55:07.532] <TB3> INFO: 4853320 events read in total (190667ms).
[14:55:07.534] <TB3> CRITICAL: <hal.cc/MultiRocAllPixelsDacScan:L958> Incomplete DAQ data readout! Missing 142828 Events.
[14:55:07.860] <TB3> INFO: Expecting 6281600 events.
[14:55:48.866] <TB3> INFO: 1428330 events read in total (40291ms).
[14:56:08.670] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (7) != Token Chain Length (8)
[14:56:08.670] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[14:56:08.670] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:56:08.670] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a09d 80c0 43c8 43c8 43c8 43c8 43c8 43c8 43c8 43c8 e022 c000
[14:56:08.670] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a097 8040 4388 4388 4388 4388 4388 4388 4388 4388 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a098 80b1 4389 4389 4389 4389 4389 4389 4389 4389 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a099 80c0 4388 4388 4388 4388 4388 4388 4388 4388 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a09a 8000 4388 4388 4388 43c8 43c8 43c8 43c8 d58 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a09b 8040 43c9 43c9 43c9 43c9 43c9 43c9 43c9 43c9 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a09c 80b1 43c9 43c9 43c9 43c9 43c9 43c9 43c9 43c9 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a19d 80c0 43c8 43c8 43c8 43c8 43c8 43c8 43c8 43c8 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a197 8040 4388 4388 4388 4388 4388 4388 4388 4388 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a198 80b1 4389 4389 4389 4389 4389 4389 4389 4389 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a199 80c0 4388 4388 4388 4388 4388 4388 4388 4388 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a19a 8000 4388 4388 4388 43c8 43c8 43c8 43c9 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a19b 8040 43c9 43c9 43c9 43c9 43c9 43c9 43c9 43c9 e022 c000
[14:56:08.671] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a19c 80b1 43c9 43c9 43c9 43c9 43c9 43c9 43c9 43c9 e022 c000
[14:56:29.515] <TB3> INFO: 2841840 events read in total (80940ms).
[14:57:13.705] <TB3> INFO: 4259190 events read in total (125130ms).
[14:57:57.398] <TB3> INFO: 5684840 events read in total (168823ms).
[14:58:16.900] <TB3> INFO: 6281600 events read in total (188325ms).
[14:58:16.936] <TB3> INFO: Test took 189388ms.
[14:58:16.993] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:58:36.471] <TB3> INFO: ROC 0 VthrComp = 73
[14:58:36.471] <TB3> INFO: ROC 1 VthrComp = 99
[14:58:36.471] <TB3> INFO: ROC 2 VthrComp = 108
[14:58:36.471] <TB3> INFO: ROC 3 VthrComp = 99
[14:58:36.471] <TB3> INFO: ROC 4 VthrComp = 87
[14:58:36.471] <TB3> INFO: ROC 5 VthrComp = 86
[14:58:36.471] <TB3> INFO: ROC 6 VthrComp = 86
[14:58:36.472] <TB3> INFO: ROC 7 VthrComp = 92
[14:58:36.472] <TB3> INFO: ROC 8 VthrComp = 90
[14:58:36.472] <TB3> INFO: ROC 9 VthrComp = 100
[14:58:36.472] <TB3> INFO: ROC 10 VthrComp = 86
[14:58:36.472] <TB3> INFO: ROC 11 VthrComp = 83
[14:58:36.472] <TB3> INFO: ROC 12 VthrComp = 79
[14:58:36.472] <TB3> INFO: ROC 13 VthrComp = 80
[14:58:36.472] <TB3> INFO: ROC 14 VthrComp = 89
[14:58:36.472] <TB3> INFO: ROC 15 VthrComp = 91
[14:58:36.472] <TB3> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[14:58:36.472] <TB3> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[14:58:36.482] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[14:58:36.482] <TB3> INFO: run 1 of 1
[14:58:36.787] <TB3> INFO: Expecting 6281600 events.
[14:59:12.123] <TB3> INFO: 889990 events read in total (34621ms).
[14:59:47.143] <TB3> INFO: 1776970 events read in total (69641ms).
[15:00:19.061] <TB3> INFO: 2665720 events read in total (101559ms).
[15:00:54.153] <TB3> INFO: 3550750 events read in total (136651ms).
[15:01:25.642] <TB3> INFO: 4427230 events read in total (168140ms).
[15:02:04.327] <TB3> INFO: 5299970 events read in total (206825ms).
[15:02:43.083] <TB3> INFO: 6171840 events read in total (245581ms).
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a07b 8040 43c8 85d 26c7 43c8 85d 26cf 43c8 85d 266f 43c8 85d 26c2 43c8 85d 26c9 43c8 85d 26e7 43c8 85d 26ae 43c8 85d 26cd e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a075 80c0 4388 85d 26c6 4388 85d 26cf 4388 85d 266f 4388 85d 26c4 4388 85d 26c9 4388 85d 26e9 4388 85d 26ad 4388 85d 26cd e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a076 8000 4388 85d 26c7 4388 85d 26cf 4388 85d 2681 4388 85d 26c4 4388 85d 26c9 4388 85d 26e7 4388 85d 26ad 4388 85d 26cc e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a077 8040 4388 85d 26c8 4388 85d 26cf 4388 85d 2680 4388 85d 26c5 4388 85d 26c9 4388 85d 26e7 4388 85d 26af 4388 85d 26cd e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a078 80b1 4389 85d 26c6 4389 85d 26e0 4389 85d 266f 4389 85d 26c5 4389 85d 26c9 4389 85d 26e9 4389 85d 26c0 4389 85d 26ce f022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a079 80c0 43c8 85d 26c7 43c8 85d 26e0 43c8 85d 266f 43c8 85d 26c4 43c8 85d 26cb 43c8 85d 26e7 43c8 85d 26af 43c8 85d 26ce e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a07a 8000 43c8 85d 26c7 43c8 85d 26cd 43c8 85d 266f 43c8 85d 26c2 43c8 85d 26c7 43c8 85d 26e5 43c8 85d 26ad 43c8 85d 26cd e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a17b 8040 43c8 85d 26e0 43c8 85d 26c3 43c8 85d 26eb 43c8 85d 2705 43c8 85d 2706 43c8 85d 26cc 43c8 85d 26c5 43c8 85d 26e5 e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a175 80c0 4388 85d 26e0 4388 85d 26c3 4388 85d 26eb 4388 85d 2705 4388 85d 2706 4388 85d 26cd 4388 85d 26c4 4388 85d 26e7 e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a176 8000 4388 85d 26e1 4388 85d 26c3 4388 85d 26e9 4388 85d 2705 4388 85d 2705 4388 85d 26cc 4388 85d 26c6 4388 85d 26e7 e022 c000
[15:02:44.961] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a177 8040 4388 85d 26e2 4388 85d 26c2 4388 85d 26ec 4388 85d 2704 4388 85d 2705 4388 85d 26cc 4388 85d 26c5 4388 85d 26e7 e022 c000
[15:02:44.962] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a178 80b1 4389 85d 26e2 4389 85d 26c2 4389 85d 26e9 4389 85d 2705 4389 85d 2706 4389 85d 26cd 4389 85d 26c5 4389 85d 26e7 f022 c000
[15:02:44.962] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a179 80c0 43c8 85d 26e2 43c8 85d 26c1 43c8 85d 26ec 43c8 85d 2705 43c8 85d 2706 43c8 85d 26cc 43c8 85d 26c5 43c8 85d 26e8 e022 c000
[15:02:44.962] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a17a 8000 43c8 85d 26e1 43c8 85d 26c2 43c8 85d 26ea 43c8 85d 2705 43c8 85d 2705 43c8 85d 26cd 43c8 85d 26c5 43c8 85d 26e7 e022 c000
[15:02:48.218] <TB3> INFO: 6281600 events read in total (250716ms).
[15:02:48.281] <TB3> INFO: Test took 251799ms.
[15:02:48.421] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:03:13.504] <TB3> INFO: roc 0 with ID = 0 has maximal Vcal 58.2275 for pixel 0/40 mean/min/max = 46.5676/34.6994/58.4358
[15:03:13.504] <TB3> INFO: roc 1 with ID = 1 has maximal Vcal 56.4897 for pixel 51/0 mean/min/max = 43.755/31.0186/56.4914
[15:03:13.504] <TB3> INFO: roc 2 with ID = 2 has maximal Vcal 64.6511 for pixel 34/27 mean/min/max = 49.8532/34.5557/65.1508
[15:03:13.505] <TB3> INFO: roc 3 with ID = 3 has maximal Vcal 61.6047 for pixel 25/3 mean/min/max = 46.9798/32.1828/61.7768
[15:03:13.505] <TB3> INFO: roc 4 with ID = 4 has maximal Vcal 57.1552 for pixel 51/14 mean/min/max = 44.7738/32.1867/57.3609
[15:03:13.506] <TB3> INFO: roc 5 with ID = 5 has maximal Vcal 58.0644 for pixel 23/2 mean/min/max = 45.0346/31.8116/58.2576
[15:03:13.506] <TB3> INFO: roc 6 with ID = 6 has maximal Vcal 58.2803 for pixel 27/12 mean/min/max = 45.5395/32.7616/58.3174
[15:03:13.506] <TB3> INFO: roc 7 with ID = 7 has maximal Vcal 62.4155 for pixel 16/79 mean/min/max = 46.9575/31.3442/62.5709
[15:03:13.507] <TB3> INFO: roc 8 with ID = 8 has maximal Vcal 57.2591 for pixel 34/77 mean/min/max = 45.4303/33.223/57.6376
[15:03:13.507] <TB3> INFO: roc 9 with ID = 9 has maximal Vcal 62.5415 for pixel 35/1 mean/min/max = 46.9713/31.3705/62.5721
[15:03:13.507] <TB3> INFO: roc 10 with ID = 10 has maximal Vcal 56.6789 for pixel 0/62 mean/min/max = 44.372/31.6834/57.0606
[15:03:13.507] <TB3> INFO: roc 11 with ID = 11 has maximal Vcal 59.3387 for pixel 0/78 mean/min/max = 45.2854/31.1536/59.4172
[15:03:13.508] <TB3> INFO: roc 12 with ID = 12 has maximal Vcal 59.4614 for pixel 0/76 mean/min/max = 46.7255/33.8864/59.5646
[15:03:13.508] <TB3> INFO: roc 13 with ID = 13 has maximal Vcal 58.0375 for pixel 18/79 mean/min/max = 45.5424/32.7842/58.3005
[15:03:13.508] <TB3> INFO: roc 14 with ID = 14 has maximal Vcal 68.4339 for pixel 8/0 mean/min/max = 49.1925/29.6087/68.7762
[15:03:13.509] <TB3> INFO: roc 15 with ID = 15 has maximal Vcal 60.8223 for pixel 17/16 mean/min/max = 46.1495/31.4687/60.8303
[15:03:13.509] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:03:13.640] <TB3> INFO: Expecting 514560 events.
[15:03:23.386] <TB3> INFO: 514560 events read in total (9031ms).
[15:03:23.391] <TB3> INFO: Expecting 514560 events.
[15:03:32.842] <TB3> INFO: 514560 events read in total (8782ms).
[15:03:32.849] <TB3> INFO: Expecting 514560 events.
[15:03:42.519] <TB3> INFO: 514560 events read in total (9012ms).
[15:03:42.527] <TB3> INFO: Expecting 514560 events.
[15:03:52.045] <TB3> INFO: 514560 events read in total (8853ms).
[15:03:52.057] <TB3> INFO: Expecting 514560 events.
[15:04:01.686] <TB3> INFO: 514560 events read in total (8966ms).
[15:04:01.700] <TB3> INFO: Expecting 514560 events.
[15:04:11.272] <TB3> INFO: 514560 events read in total (8913ms).
[15:04:11.286] <TB3> INFO: Expecting 514560 events.
[15:04:21.009] <TB3> INFO: 514560 events read in total (9062ms).
[15:04:21.026] <TB3> INFO: Expecting 514560 events.
[15:04:30.547] <TB3> INFO: 514560 events read in total (8863ms).
[15:04:30.569] <TB3> INFO: Expecting 514560 events.
[15:04:40.103] <TB3> INFO: 514560 events read in total (8894ms).
[15:04:40.126] <TB3> INFO: Expecting 514560 events.
[15:04:49.553] <TB3> INFO: 514560 events read in total (8781ms).
[15:04:49.575] <TB3> INFO: Expecting 514560 events.
[15:04:59.283] <TB3> INFO: 514560 events read in total (9055ms).
[15:04:59.305] <TB3> INFO: Expecting 514560 events.
[15:05:08.735] <TB3> INFO: 514560 events read in total (8771ms).
[15:05:08.762] <TB3> INFO: Expecting 514560 events.
[15:05:18.332] <TB3> INFO: 514560 events read in total (8921ms).
[15:05:18.364] <TB3> INFO: Expecting 514560 events.
[15:05:27.936] <TB3> INFO: 514560 events read in total (8929ms).
[15:05:27.968] <TB3> INFO: Expecting 514560 events.
[15:05:37.473] <TB3> INFO: 514560 events read in total (8859ms).
[15:05:37.504] <TB3> INFO: Expecting 514560 events.
[15:05:47.181] <TB3> INFO: 514560 events read in total (9033ms).
[15:05:47.217] <TB3> INFO: Test took 153708ms.
[15:05:48.281] <TB3> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[15:05:48.290] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[15:05:48.290] <TB3> INFO: run 1 of 1
[15:05:48.593] <TB3> INFO: Expecting 6281600 events.
[15:06:25.787] <TB3> INFO: 871060 events read in total (36479ms).
[15:07:02.172] <TB3> INFO: 1740060 events read in total (72864ms).
[15:07:14.556] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[15:07:14.556] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a007 8040 43c8 252 28ad 43c8 252 28c5 43c8 252 2883 43c8 252 28ac 43c8 252 28c7 43c8 252 28ef 43c8 252 28c2 43c8 252 28cc e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a001 80c0 4388 252 28ad 4388 252 28c4 4388 252 2881 4388 252 28ac 4389 252 28c7 4389 252 28ee 4389 252 28c1 4389 252 28cc e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a002 8000 4388 252 28ac 4388 252 28c5 4389 252 2881 4389 252 28a9 4388 252 28c8 4388 252 28ef 4389 252 28c2 4389 252 28cb e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a003 8040 4388 252 28ad 4389 252 28c5 4388 252 2881 4389 252 28a9 4388 252 28c8 4389 252 28ef 4388 252 28c3 4389 252 28cc e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a004 80b1 4388 1252 38ac 43c8 25f 2f63 ff8 2252 881 43c8 252 28aa 43c8 252 28c9 43c8 252 28ed 43c8 252 28c0 43c8 252 28cb e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a005 80c0 43c8 252 28ad 43c8 252 28c5 43c8 252 2881 43c8 252 28ab 43c8 252 28c7 43c8 252 2900 43c8 252 28c2 43c8 252 28ca e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a006 8000 43c8 252 28ad 43c8 252 28c5 43c8 252 2883 43c8 252 28ab 43c8 252 28c7 43c8 252 28ef 43c8 252 28c1 43c8 252 28cc e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a107 8040 43c8 252 28cd 43c8 252 28ab 43c8 252 28ec 43c8 252 2907 43c8 252 2902 43c8 252 28cc 43c8 252 28c2 43c8 252 28cf e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a101 80c0 4388 252 28cc 4388 252 28ab 4388 252 28ee 4388 252 2908 4389 252 2903 4389 252 28c9 4389 252 28c2 4389 252 28cd e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a102 8000 4388 252 28cc 4388 252 28a9 4389 252 28ed 4389 252 2909 4388 252 2902 4388 252 28cb 4389 252 28c2 4389 252 28cf e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a103 8040 4388 252 28cc 4389 252 28aa 4388 252 28ed 4389 252 2909 4388 252 2903 4389 252 28c9 4388 252 28c2 4389 252 28cf e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a104 80b1 43c8 1252 38cd 43c8 25a 2a66 70 24a5 24a0 4a5 43c8 252 2903 43c8 252 28cc 43c8 252 28c3 43c8 252 28cf e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a105 80c0 43c8 252 28cc 43c8 252 28ac 43c8 252 28ed 43c8 252 2909 43c8 252 2905 43c8 252 28cc 43c8 252 28c2 43c8 252 28ce e022 c000
[15:07:14.556] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a106 8000 43c8 252 28cd 43c8 252 28ac 43c8 252 28ed 43c8 252 2908 43c8 252 2903 43c8 252 28cc 43c8 252 28c2 43c8 252 28e0 e022 c000
[15:07:38.102] <TB3> INFO: 2609610 events read in total (108794ms).
[15:08:11.871] <TB3> INFO: 3474650 events read in total (142563ms).
[15:08:44.826] <TB3> INFO: 4332060 events read in total (175518ms).
[15:09:16.602] <TB3> INFO: 5186310 events read in total (207294ms).
[15:09:53.306] <TB3> INFO: 6040410 events read in total (243998ms).
[15:10:03.545] <TB3> INFO: 6281600 events read in total (254237ms).
[15:10:03.605] <TB3> INFO: Test took 255315ms.
[15:10:03.750] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:10:28.634] <TB3> INFO: ---> TrimStepCorr4 extremal thresholds: 0.022087 .. 255.000000
[15:10:28.709] <TB3> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[15:10:28.717] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[15:10:28.717] <TB3> INFO: run 1 of 1
[15:10:29.021] <TB3> INFO: Expecting 10649600 events.
[15:11:05.557] <TB3> INFO: 826180 events read in total (35821ms).
[15:11:40.470] <TB3> INFO: 1652740 events read in total (70734ms).
[15:12:15.835] <TB3> INFO: 2479230 events read in total (106099ms).
[15:12:50.723] <TB3> INFO: 3306090 events read in total (140987ms).
[15:13:25.575] <TB3> INFO: 4132870 events read in total (175839ms).
[15:14:00.783] <TB3> INFO: 4960050 events read in total (211047ms).
[15:14:35.092] <TB3> INFO: 5786570 events read in total (245356ms).
[15:15:09.700] <TB3> INFO: 6613110 events read in total (279964ms).
[15:15:21.249] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 8 ROCs were found
[15:15:21.249] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 8 ROCs were found
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b4 80b1 43c8 518 28c7 43c8 518 28c9 43c8 518 286f 43c8 518 28c2 43c8 518 28c9 43c8 518 28ed 43c8 518 28cc 43c8 518 28c9 e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ae 8000 4389 518 28c6 4389 518 28c9 4389 518 286f 4389 518 28c3 4389 518 28c9 4389 518 28ed 4389 518 28cc 4389 518 28ca e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0af 8040 438b 518 28c8 438b 518 28c9 438b 518 286f 438b 518 28c3 438b 518 28c9 438b 518 28ee 438b 518 28cc 438b 518 28cb e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b0 80b1 4388 518 28c7 4388 518 28c9 4388 518 286f 4388 518 28c4 4388 518 28c9 4388 518 28ec 4388 518 28cc 4388 518 28c9 e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a0b1 80c0 4388 518 28c7 4388 518 28c9 4388 518 2881 4388 518 28c4 4389 518 28c9 4389 518 28ed 4389 518 28cc 43c9 518 297e ffe 2220 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 2fff fff 2fff fff 2fff fff
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b2 8000 43c8 518 28c7 43c8 518 28cc 43c9 518 2880 43c9 518 28c2 43c8 518 28c9 43c8 518 28ec 43c9 518 28cc 43c9 518 28c9 e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0b3 8040 43c8 518 28c6 43c9 518 28c9 43c8 518 286f 43c9 518 28c4 43c8 518 28c9 43c9 518 28ed 43c8 518 28cc 43c9 518 28c9 e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b4 80b1 43c8 518 28e6 43c8 518 28c4 43c8 518 28ec 43c8 518 2905 43c8 518 2909 43c8 518 28cd 43c8 518 28c5 43c8 518 28cf e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ae 8000 4389 518 28e7 4389 518 28c4 4389 518 28eb 4389 518 2905 4389 518 2907 4389 518 28cc 4389 518 28c6 4389 518 28cf e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1af 8040 438b 518 28e7 438b 518 28c4 438b 518 28ec 438b 518 2905 438b 518 2907 438b 518 28cd 438b 518 28c5 438b 518 28cd e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b0 80b1 4389 518 28e8 4389 518 28c3 4389 518 28ea 4389 518 2905 4389 518 2909 4389 518 28cc 4389 518 28c5 4389 518 28cd e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a1b1 80c0 4388 518 28e6 4388 518 28c5 4388 518 28ec 4388 518 2905 4389 518 2909 4389 518 28ca 4389 518 28c5 43c9 518 282c 7c 2440 1ff 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
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b2 8000 43c8 518 28e7 43c8 518 28c4 43c9 518 28ec 43c9 518 2906 43c8 518 2907 43c8 518 28cd 43c9 518 28c6 43c9 518 28ce e022 c000
[15:15:21.249] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1b3 8040 43c8 518 28e8 43c9 518 28c5 43c8 518 28ec 43c9 518 2905 43c8 518 2907 43c9 518 28cd 43c8 518 28c5 43c9 518 28ce e022 c000
[15:15:43.533] <TB3> INFO: 7438780 events read in total (313797ms).
[15:16:15.147] <TB3> INFO: 8263160 events read in total (345411ms).
[15:16:51.500] <TB3> INFO: 9087580 events read in total (381764ms).
[15:17:23.999] <TB3> INFO: 9911440 events read in total (414263ms).
[15:17:53.956] <TB3> INFO: 10649600 events read in total (444220ms).
[15:17:54.064] <TB3> INFO: Test took 445348ms.
[15:17:54.352] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:18:27.763] <TB3> INFO: ---> TrimStepCorr2 extremal thresholds: 0.191861 .. 50.623574
[15:18:27.857] <TB3> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 0 .. 60 (-1/-1) hits flags = 528 (plus default)
[15:18:27.866] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[15:18:27.866] <TB3> INFO: run 1 of 1
[15:18:28.203] <TB3> INFO: Expecting 2537600 events.
[15:19:05.249] <TB3> INFO: 1147020 events read in total (36331ms).
[15:19:44.836] <TB3> INFO: 2291610 events read in total (75918ms).
[15:19:54.107] <TB3> INFO: 2537600 events read in total (85189ms).
[15:19:54.125] <TB3> INFO: Test took 86259ms.
[15:19:54.164] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:20:10.020] <TB3> INFO: ---> TrimStepCorr1a extremal thresholds: 18.304362 .. 45.063657
[15:20:10.108] <TB3> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 8 .. 55 (-1/-1) hits flags = 528 (plus default)
[15:20:10.117] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[15:20:10.117] <TB3> INFO: run 1 of 1
[15:20:10.447] <TB3> INFO: Expecting 1996800 events.
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a029 80c0 43c8 20 20a4 43c8 20 20a8 43c8 20 2066 43c8 20 20a5 43c8 20 20ad 43c8 20 20e1 43c8 20 20a6 43c8 20 20ac e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a023 8040 4388 20 20a3 4389 20 20a9 4388 20 2067 4389 20 20a3 4388 20 20ad 4389 20 20e0 4388 20 20a5 4389 20 20ad e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a024 80b1 4388 20 20a4 4388 20 20a8 4388 20 2066 4388 20 20a3 4388 20 20ad 4388 20 20e1 4388 20 20a4 4388 20 20ad e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a025 80c0 4388 20 20a4 4388 20 20a7 4388 20 2067 4388 20 20a2 4388 20 20ac 4388 20 20e1 4388 20 20a4 4388 20 20ac e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a026 8000 4388 20 20a5 4388 20 20a8 4388 20 2067 4388 20 20a4 4388 20 20ad 4388 20 20e0 4388 20 20a5 4388 20 20ad f022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a027 8040 43c8 20 20a5 43c8 20 20a7 43c8 20 2068 43c8 20 20a3 43c8 20 20ad 43c8 20 20e2 43c8 20 20a6 43c8 20 20ad e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a028 80b1 43c8 20 20a6 43c8 20 20a7 43c8 20 2067 43c8 20 20a4 43c8 20 20ac 43c8 20 20e1 43c8 20 20a4 43c8 20 20ad e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a129 80c0 43c8 20 20ad 43c8 20 208f 43c8 20 20e1 43c8 20 20e5 43c8 20 20ec 43c8 20 20c3 43c8 20 20a6 43c8 20 20a8 e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a123 8040 4388 20 20ad 4389 20 208f 4388 20 20e0 4389 20 20e7 4388 20 20ec 4389 20 20c5 4388 20 20a6 4389 20 20a9 e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a124 80b1 4388 20 20ae 4388 20 208e 4388 20 20e1 4388 20 20e8 4388 20 20ec 4388 20 20c4 4388 20 20a5 4388 20 20a9 e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a125 80c0 4388 20 20ad 4388 20 208f 4388 20 20e2 4388 20 20e7 4388 20 20ec 4388 20 20c3 4388 20 20a5 4388 20 20a9 e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a126 8000 4388 20 20ad 4388 20 208e 4388 20 20e1 4388 20 20e5 4388 20 20ed 4388 20 20c3 4388 20 20a6 4388 20 20a8 f022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a127 8040 43c8 20 20ae 43c8 20 208e 43c8 20 20e2 43c8 20 20e6 43c8 20 20ec 43c8 20 20c4 43c8 20 20a6 43c8 20 20a8 e022 c000
[15:20:27.679] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a128 80b1 43c8 20 20ad 43c8 20 208f 43c8 20 20e0 43c8 20 20e7 43c8 20 20ec 43c8 20 20c5 43c8 20 20a7 43c8 20 20a9 e022 c000
[15:20:52.486] <TB3> INFO: 1140470 events read in total (41324ms).
[15:21:22.312] <TB3> INFO: 1996800 events read in total (71150ms).
[15:21:22.324] <TB3> INFO: Test took 72207ms.
[15:21:22.354] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:21:36.195] <TB3> INFO: ---> TrimStepCorr1b extremal thresholds: 1.909371 .. 43.603524
[15:21:36.271] <TB3> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 1 .. 53 (-1/-1) hits flags = 528 (plus default)
[15:21:36.280] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[15:21:36.280] <TB3> INFO: run 1 of 1
[15:21:36.587] <TB3> INFO: Expecting 2204800 events.
[15:22:16.049] <TB3> INFO: 1222660 events read in total (38748ms).
[15:22:49.699] <TB3> INFO: 2204800 events read in total (72398ms).
[15:22:49.712] <TB3> INFO: Test took 73432ms.
[15:22:49.742] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:23:03.765] <TB3> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[15:23:03.765] <TB3> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[15:23:03.774] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[15:23:03.774] <TB3> INFO: run 1 of 1
[15:23:04.112] <TB3> INFO: Expecting 1705600 events.
[15:23:44.648] <TB3> INFO: 1074870 events read in total (39821ms).
[15:23:54.036] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 3 ROCs were found
[15:23:54.036] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 11 readouts!
[15:23:54.036] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (6) != Token Chain Length (8)
[15:23:54.036] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (235) != TBM ID (168)
[15:23:54.036] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (3) != Token Chain Length (8)
[15:23:54.036] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (169) != TBM ID (235)
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ed 80c0 43c9 503 20ca 43c9 503 20a7 43c9 503 20e1 43c9 503 20ea 43c9 503 20e9 43c9 503 20c1 43c9 503 20a9 43c9 503 20c3 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e7 8040 4388 503 20c9 4388 503 20a6 4388 503 20e2 4388 503 20ec 4388 503 20e9 4388 503 20c1 4388 503 20aa 4388 503 20c4 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e8 80b1 4388 503 20ca 4388 503 20a7 4388 503 20e0 4388 503 20ea 4388 503 20ea 4388 503 20c0 4388 503 20ac 4388 503 20c2 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1e9 80c0 4388 503 20c9 4388 503 20a7 4388 503 20e0 4388 503 20ed 4388 503 20e9 4388 503 20c1 4388 503 20aa 4388 503 20c2 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ea 8000 4389 503 20ca 4389 503 20a6 53c9 1503 20e1 43ca 5fa 2eae 72 2a06 2a00 a06 43c9 503 20ab 43c9 503 20c4 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1eb 8040 43c8 503 20c9 43c8 503 20a7 43c8 503 20e1 43c8 503 20eb 43c8 503 20e9 43c8 503 20c1 43c8 503 20a9 43c8 503 20c3 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a1ec 80b1 43c9 503 20c9 43c9 503 20a7 43c9 503 20e1 43c9 503 20ea 43c9 503 20e9 43c9 503 20c2 43c9 503 20aa 43c9 503 20c2 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ee 8000 43c8 503 20a9 43c8 503 20c1 43c8 503 206c 43c8 503 20a9 43c8 503 20ad 43c8 503 20e0 43c8 503 20c1 43c8 503 20c0 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0e9 80c0 4388 503 20a8 4388 503 20c1 4388 503 206c 4388 503 20aa 4388 503 20ac 4388 503 20e1 4388 503 20c0 4388 503 20c0 e022 c000
[15:23:54.036] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a0ea 8000 4389 503 20a9 4389 503 20c1 53c9 1503 206b 43ca fff
[15:23:54.037] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0a8 8018 43c9 2ff2 818 43c9 503 20c0 43c9 503 20c1 e022 c000
[15:23:54.037] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0eb 8040 43c8 503 20a9 43c8 503 20c3 43c8 503 206b 43c8 503 20a9 43c8 503 20ad 43c8 503 20e0 43c8 503 20c1 43c8 503 20c0 e022 c000
[15:23:54.037] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ec 80b1 43c9 503 20a8 43c9 503 20c2 43c9 503 206c 43c9 503 20ac 43c9 503 20ac 43c9 503 20e1 43c9 503 20c0 43c9 503 20c0 e022 c000
[15:23:54.037] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a0ed 80c0 43c9 503 20aa 43c9 503 20c1 43c9 503 206c 43c9 503 20ab 43c9 503 20ac 43c9 503 20e1 43c9 503 20af 43c9 503 20c0 e022 c000
[15:24:08.174] <TB3> CRITICAL: <hal.cc/condenseTriggers:L1899> Data size does not correspond to 10 triggers! Aborting data processing!
[15:24:08.189] <TB3> INFO: 1074870 events read in total (63362ms).
[15:24:08.191] <TB3> CRITICAL: <hal.cc/MultiRocAllPixelsDacScan:L958> Incomplete DAQ data readout! Missing 63073 Events.
[15:24:08.536] <TB3> INFO: Expecting 1705600 events.
[15:24:47.093] <TB3> INFO: 1075530 events read in total (37842ms).
[15:25:08.098] <TB3> INFO: 1705600 events read in total (58847ms).
[15:25:08.109] <TB3> INFO: Test took 59913ms.
[15:25:08.138] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:25:21.425] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C0.dat
[15:25:21.425] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C1.dat
[15:25:21.426] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C2.dat
[15:25:21.426] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C3.dat
[15:25:21.426] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C4.dat
[15:25:21.426] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C5.dat
[15:25:21.427] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C6.dat
[15:25:21.427] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C7.dat
[15:25:21.428] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C8.dat
[15:25:21.428] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C9.dat
[15:25:21.428] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C10.dat
[15:25:21.429] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C11.dat
[15:25:21.429] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C12.dat
[15:25:21.429] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C13.dat
[15:25:21.430] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C14.dat
[15:25:21.430] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C15.dat
[15:25:21.430] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C0.dat
[15:25:21.442] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C1.dat
[15:25:21.450] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C2.dat
[15:25:21.459] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C3.dat
[15:25:21.469] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C4.dat
[15:25:21.478] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C5.dat
[15:25:21.487] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C6.dat
[15:25:21.495] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C7.dat
[15:25:21.504] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C8.dat
[15:25:21.514] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C9.dat
[15:25:21.523] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C10.dat
[15:25:21.532] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C11.dat
[15:25:21.541] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C12.dat
[15:25:21.551] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C13.dat
[15:25:21.560] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C14.dat
[15:25:21.569] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//trimParameters35_C15.dat
[15:25:21.577] <TB3> INFO: PixTestTrim::trimTest() done
[15:25:21.577] <TB3> INFO: vtrim: 98 87 120 95 85 105 99 111 88 115 86 82 92 85 116 102
[15:25:21.577] <TB3> INFO: vthrcomp: 73 99 108 99 87 86 86 92 90 100 86 83 79 80 89 91
[15:25:21.577] <TB3> INFO: vcal mean: 34.99 34.92 34.99 34.92 34.98 34.98 35.00 34.99 34.97 35.01 34.96 34.96 35.03 34.94 34.95 34.97
[15:25:21.577] <TB3> INFO: vcal RMS: 0.83 0.94 1.08 1.38 0.81 0.87 0.87 1.03 0.78 0.93 0.89 0.87 0.79 1.01 1.40 1.03
[15:25:21.577] <TB3> INFO: bits mean: 8.83 9.51 8.60 9.17 9.39 9.69 9.40 9.15 9.10 9.62 9.70 9.37 8.78 8.99 9.43 9.63
[15:25:21.577] <TB3> INFO: bits RMS: 2.56 2.91 2.45 2.69 2.81 2.67 2.69 2.80 2.72 2.56 2.71 2.87 2.69 2.80 2.66 2.61
[15:25:21.585] <TB3> INFO: ----------------------------------------------------------------------
[15:25:21.585] <TB3> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[15:25:21.585] <TB3> INFO: ----------------------------------------------------------------------
[15:25:21.590] <TB3> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[15:25:21.605] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[15:25:21.605] <TB3> INFO: run 1 of 1
[15:25:21.941] <TB3> INFO: Expecting 4160000 events.
[15:26:09.637] <TB3> INFO: 1140435 events read in total (46981ms).
[15:26:33.911] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 5 ROCs were found
[15:26:33.911] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 3 ROCs were found
[15:26:33.911] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:26:33.911] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06e 8000 43c9 258 28ac 43c9 258 28ad 43c9 258 286d 43c9 258 28ac 43c9 258 28ca 43c9 258 2900 43c9 258 28c4 43c9 258 28c8 e022 c000
[15:26:33.911] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a068 80b1 4389 258 28ab 4389 258 28ad 4389 4389 4389 258 28cc 4389 258 28ef 4389 258 28c4 4389 258 28c6 e022 c000
[15:26:33.911] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a069 80c0 4388 258 28ad 4388 258 28ad 4388 4388 258 28ab 4388 258 28cd 4388 258 28ef 4388 258 28c4 4388 258 28c9 e022 c000
[15:26:33.911] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06a 8000 4388 258 28ad 4388 258 28ae 4388 4388 258 28aa 4388 258 28ca 4388 258 28ed 4388 258 28c4 4388 258 28c8 e022 c000
[15:26:33.911] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 2 ====== a06b 8040 4388 258 28ab 4388 258 28ad 43c8 43c8 43c8 257 3e97 a7 2503 e95 20af 503 2e9b 2ab 2503 e92 2eae 220 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
[15:26:33.911] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06c 80b1 43c8 258 28ad 43c8 258 28ad 43c8 43c8 43c8 258 28cb 43c8 258 28ef 43c8 258 28c2 43c8 258 28c7 e022 c000
[15:26:33.911] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a06d 80c0 43c9 258 28ac 43c9 258 28ae 43c9 43c9 43c9 258 28cc 43c9 258 28ef 43c9 258 28c4 43c9 258 28c7 e022 c000
[15:26:33.912] <TB3> ERROR: <datapipe.cc/Read:L164> Dumping the flawed event +- 3 events:
[15:26:33.912] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16e 8000 43c9 258 28cd 43c9 258 28a7 43c9 258 2900 43c9 258 2906 43c9 258 2902 43c9 258 28c9 43c9 258 28c3 43c9 258 28ce e022 c000
[15:26:33.912] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a168 80b1 4389 258 28cd 4389 258 28a8 4389 258 28ed 4389 258 2905 4389 258 2900 4389 258 28c9 4389 4389 258 28cd e022 c000
[15:26:33.912] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a169 80c0 4388 258 28cc 4388 258 28a7 4388 258 28ed 4388 258 2906 4388 258 2901 4388 258 28c9 4388 258 28c2 4388 258 28cd e022 c000
[15:26:33.912] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16a 8000 4388 258 28cf 4388 258 28a7 4388 258 28ed 4388 258 2905 4388 258 2901 4388 258 28c9 4388 258 28c2 4388 258 28cd e022 c000
[15:26:33.912] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16b 8040 4388 258 28cc 4388 258 28a6 43c8 258 28ee e0ea d060
[15:26:33.912] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16c 80b1 43c8 258 28cc 43c8 258 28a7 43c8 258 28ee 43c8 258 2905 43c8 258 2901 43c8 258 28c9 43c8 258 28c2 43c8 258 28ce e022 c000
[15:26:33.912] <TB3> ERROR: <datapipe.cc/Read:L166> ====== 0 ====== a16d 80c0 43c9 258 28cc 43c9 258 28a7 43c9 258 28ed 43c9 258 2907 43c9 258 2902 43c9 258 28c9 43c9 258 28c2 43c9 258 28cd e022 c000
[15:26:54.440] <TB3> INFO: 2261825 events read in total (91784ms).
[15:27:39.076] <TB3> INFO: 3365595 events read in total (136421ms).
[15:28:11.687] <TB3> INFO: 4160000 events read in total (169031ms).
[15:28:11.738] <TB3> INFO: Test took 170133ms.
[15:28:11.847] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:28:45.590] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 181 (-1/-1) hits flags = 528 (plus default)
[15:28:45.599] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[15:28:45.599] <TB3> INFO: run 1 of 1
[15:28:45.933] <TB3> INFO: Expecting 3785600 events.
[15:29:31.225] <TB3> INFO: 1140575 events read in total (44577ms).
[15:30:15.659] <TB3> INFO: 2260385 events read in total (89011ms).
[15:31:03.910] <TB3> INFO: 3362900 events read in total (137262ms).
[15:31:22.156] <TB3> INFO: 3785600 events read in total (155508ms).
[15:31:22.219] <TB3> INFO: Test took 156620ms.
[15:31:22.347] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:31:49.231] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 167 (-1/-1) hits flags = 528 (plus default)
[15:31:49.240] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[15:31:49.240] <TB3> INFO: run 1 of 1
[15:31:49.580] <TB3> INFO: Expecting 3494400 events.
[15:32:35.298] <TB3> INFO: 1188155 events read in total (45003ms).
[15:33:22.597] <TB3> INFO: 2348290 events read in total (92302ms).
[15:34:10.965] <TB3> INFO: 3494400 events read in total (140671ms).
[15:34:11.011] <TB3> INFO: Test took 141771ms.
[15:34:11.091] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:34:38.481] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 167 (-1/-1) hits flags = 528 (plus default)
[15:34:38.490] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[15:34:38.493] <TB3> INFO: run 1 of 1
[15:34:38.824] <TB3> INFO: Expecting 3494400 events.
[15:35:25.816] <TB3> INFO: 1186545 events read in total (46277ms).
[15:36:14.335] <TB3> INFO: 2345160 events read in total (94796ms).
[15:37:03.980] <TB3> INFO: 3490220 events read in total (144441ms).
[15:37:04.564] <TB3> INFO: 3494400 events read in total (145025ms).
[15:37:04.610] <TB3> INFO: Test took 146118ms.
[15:37:04.701] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:37:30.824] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 165 (-1/-1) hits flags = 528 (plus default)
[15:37:30.833] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[15:37:30.833] <TB3> INFO: run 1 of 1
[15:37:31.168] <TB3> INFO: Expecting 3452800 events.
[15:38:17.360] <TB3> INFO: 1193335 events read in total (45477ms).
[15:39:10.041] <TB3> INFO: 2356950 events read in total (98158ms).
[15:40:00.060] <TB3> INFO: 3452800 events read in total (148177ms).
[15:40:00.109] <TB3> INFO: Test took 149277ms.
[15:40:00.198] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:28.735] <TB3> INFO: PixTestTrim::trimBitTest() done
[15:40:28.736] <TB3> INFO: PixTestTrim::doTest() done, duration: 2912 seconds
[15:40:28.736] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:28.736] <TB3> INFO: Decoding statistics:
[15:40:28.736] <TB3> INFO: General information:
[15:40:28.736] <TB3> INFO: 16bit words read: 0
[15:40:28.736] <TB3> INFO: valid events total: 0
[15:40:28.736] <TB3> INFO: empty events: 0
[15:40:28.736] <TB3> INFO: valid events with pixels: 0
[15:40:28.736] <TB3> INFO: valid pixel hits: 0
[15:40:28.736] <TB3> INFO: Event errors: 0
[15:40:28.736] <TB3> INFO: start marker: 0
[15:40:28.736] <TB3> INFO: stop marker: 0
[15:40:28.736] <TB3> INFO: overflow: 0
[15:40:28.736] <TB3> INFO: invalid 5bit words: 0
[15:40:28.736] <TB3> INFO: invalid XOR eye diagram: 0
[15:40:28.736] <TB3> INFO: TBM errors: 0
[15:40:28.736] <TB3> INFO: flawed TBM headers: 0
[15:40:28.736] <TB3> INFO: flawed TBM trailers: 0
[15:40:28.736] <TB3> INFO: event ID mismatches: 0
[15:40:28.736] <TB3> INFO: ROC errors: 0
[15:40:28.736] <TB3> INFO: missing ROC header(s): 0
[15:40:28.736] <TB3> INFO: misplaced readback start: 0
[15:40:28.736] <TB3> INFO: Pixel decoding errors: 0
[15:40:28.736] <TB3> INFO: pixel data incomplete: 0
[15:40:28.736] <TB3> INFO: pixel address: 0
[15:40:28.737] <TB3> INFO: pulse height fill bit: 0
[15:40:28.737] <TB3> INFO: buffer corruption: 0
[15:40:29.448] <TB3> INFO: ######################################################################
[15:40:29.448] <TB3> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[15:40:29.448] <TB3> INFO: ######################################################################
[15:40:29.772] <TB3> INFO: Expecting 41600 events.
[15:40:34.117] <TB3> INFO: 41600 events read in total (3630ms).
[15:40:34.117] <TB3> INFO: Test took 4667ms.
[15:40:34.124] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:34.791] <TB3> INFO: Expecting 41600 events.
[15:40:39.217] <TB3> INFO: 41600 events read in total (3711ms).
[15:40:39.218] <TB3> INFO: Test took 4741ms.
[15:40:39.224] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:39.689] <TB3> INFO: Expecting 41600 events.
[15:40:44.061] <TB3> INFO: 41600 events read in total (3657ms).
[15:40:44.061] <TB3> INFO: Test took 4719ms.
[15:40:44.069] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:40:44.498] <TB3> INFO: Expecting 2560 events.
[15:40:45.460] <TB3> INFO: 2560 events read in total (247ms).
[15:40:45.460] <TB3> INFO: Test took 1382ms.
[15:40:45.968] <TB3> INFO: Expecting 2560 events.
[15:40:46.930] <TB3> INFO: 2560 events read in total (247ms).
[15:40:46.930] <TB3> INFO: Test took 1469ms.
[15:40:47.438] <TB3> INFO: Expecting 2560 events.
[15:40:48.400] <TB3> INFO: 2560 events read in total (247ms).
[15:40:48.401] <TB3> INFO: Test took 1470ms.
[15:40:48.909] <TB3> INFO: Expecting 2560 events.
[15:40:49.870] <TB3> INFO: 2560 events read in total (246ms).
[15:40:49.870] <TB3> INFO: Test took 1469ms.
[15:40:50.378] <TB3> INFO: Expecting 2560 events.
[15:40:51.340] <TB3> INFO: 2560 events read in total (247ms).
[15:40:51.341] <TB3> INFO: Test took 1466ms.
[15:40:51.849] <TB3> INFO: Expecting 2560 events.
[15:40:52.811] <TB3> INFO: 2560 events read in total (247ms).
[15:40:52.811] <TB3> INFO: Test took 1470ms.
[15:40:53.319] <TB3> INFO: Expecting 2560 events.
[15:40:54.282] <TB3> INFO: 2560 events read in total (248ms).
[15:40:54.282] <TB3> INFO: Test took 1471ms.
[15:40:54.790] <TB3> INFO: Expecting 2560 events.
[15:40:55.752] <TB3> INFO: 2560 events read in total (247ms).
[15:40:55.752] <TB3> INFO: Test took 1469ms.
[15:40:56.260] <TB3> INFO: Expecting 2560 events.
[15:40:57.222] <TB3> INFO: 2560 events read in total (247ms).
[15:40:57.222] <TB3> INFO: Test took 1469ms.
[15:40:57.732] <TB3> INFO: Expecting 2560 events.
[15:40:58.695] <TB3> INFO: 2560 events read in total (248ms).
[15:40:58.695] <TB3> INFO: Test took 1472ms.
[15:40:59.203] <TB3> INFO: Expecting 2560 events.
[15:41:00.166] <TB3> INFO: 2560 events read in total (248ms).
[15:41:00.167] <TB3> INFO: Test took 1472ms.
[15:41:00.674] <TB3> INFO: Expecting 2560 events.
[15:41:01.636] <TB3> INFO: 2560 events read in total (247ms).
[15:41:01.637] <TB3> INFO: Test took 1470ms.
[15:41:02.144] <TB3> INFO: Expecting 2560 events.
[15:41:03.106] <TB3> INFO: 2560 events read in total (247ms).
[15:41:03.107] <TB3> INFO: Test took 1470ms.
[15:41:03.615] <TB3> INFO: Expecting 2560 events.
[15:41:04.579] <TB3> INFO: 2560 events read in total (249ms).
[15:41:04.579] <TB3> INFO: Test took 1472ms.
[15:41:05.086] <TB3> INFO: Expecting 2560 events.
[15:41:05.860] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 4 ROCs were found
[15:41:05.860] <TB3> WARNING: Channel 1 ROC 5: Readback start marker after 4 readouts!
[15:41:05.860] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[15:41:05.860] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (0) != Token Chain Length (8)
[15:41:06.239] <TB3> CRITICAL: <hal.cc/condenseTriggers:L1899> Data size does not correspond to 10 triggers! Aborting data processing!
[15:41:06.245] <TB3> INFO: 0 events read in total (443ms).
[15:41:06.245] <TB3> CRITICAL: <hal.cc/SingleRocOnePixelDacScan:L1109> Incomplete DAQ data readout! Missing 256 Events.
[15:41:06.245] <TB3> CRITICAL: <PixTestPhOptimization.cc/GetMinPhPixel:L605> pXar execption: Incomplete DAQ data readout in function SingleRocOnePixelDacScan
[15:41:06.560] <TB3> INFO: Expecting 2560 events.
[15:41:07.522] <TB3> INFO: 2560 events read in total (247ms).
[15:41:07.523] <TB3> INFO: Test took 1277ms.
[15:41:08.030] <TB3> INFO: Expecting 2560 events.
[15:41:08.993] <TB3> INFO: 2560 events read in total (248ms).
[15:41:08.993] <TB3> INFO: Test took 1470ms.
[15:41:08.997] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:41:09.503] <TB3> INFO: Expecting 655360 events.
[15:41:21.845] <TB3> INFO: 655360 events read in total (11627ms).
[15:41:21.854] <TB3> INFO: Expecting 655360 events.
[15:41:34.188] <TB3> INFO: 655360 events read in total (11747ms).
[15:41:34.201] <TB3> INFO: Expecting 655360 events.
[15:41:46.546] <TB3> INFO: 655360 events read in total (11757ms).
[15:41:46.566] <TB3> INFO: Expecting 655360 events.
[15:41:58.814] <TB3> INFO: 655360 events read in total (11691ms).
[15:41:58.834] <TB3> INFO: Expecting 655360 events.
[15:42:11.080] <TB3> INFO: 655360 events read in total (11656ms).
[15:42:11.108] <TB3> INFO: Expecting 655360 events.
[15:42:23.341] <TB3> INFO: 655360 events read in total (11653ms).
[15:42:23.369] <TB3> INFO: Expecting 655360 events.
[15:42:35.657] <TB3> INFO: 655360 events read in total (11722ms).
[15:42:35.694] <TB3> INFO: Expecting 655360 events.
[15:42:48.059] <TB3> INFO: 655360 events read in total (11825ms).
[15:42:48.101] <TB3> INFO: Expecting 655360 events.
[15:43:00.322] <TB3> INFO: 655360 events read in total (11677ms).
[15:43:00.363] <TB3> INFO: Expecting 655360 events.
[15:43:12.648] <TB3> INFO: 655360 events read in total (11737ms).
[15:43:12.690] <TB3> INFO: Expecting 655360 events.
[15:43:25.001] <TB3> INFO: 655360 events read in total (11747ms).
[15:43:25.044] <TB3> INFO: Expecting 655360 events.
[15:43:37.343] <TB3> INFO: 655360 events read in total (11730ms).
[15:43:37.402] <TB3> INFO: Expecting 655360 events.
[15:43:49.664] <TB3> INFO: 655360 events read in total (11706ms).
[15:43:49.714] <TB3> INFO: Expecting 655360 events.
[15:44:01.899] <TB3> INFO: 655360 events read in total (11629ms).
[15:44:01.958] <TB3> INFO: Expecting 655360 events.
[15:44:14.167] <TB3> INFO: 655360 events read in total (11666ms).
[15:44:14.223] <TB3> INFO: Expecting 655360 events.
[15:44:26.363] <TB3> INFO: 655360 events read in total (11592ms).
[15:44:26.424] <TB3> INFO: Test took 197427ms.
[15:44:26.506] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:44:26.816] <TB3> INFO: Expecting 655360 events.
[15:44:39.109] <TB3> INFO: 655360 events read in total (11578ms).
[15:44:39.118] <TB3> INFO: Expecting 655360 events.
[15:44:51.304] <TB3> INFO: 655360 events read in total (11581ms).
[15:44:51.317] <TB3> INFO: Expecting 655360 events.
[15:44:56.769] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (73) != TBM ID (74)
[15:44:56.769] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[15:44:56.769] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 1 Event ID mismatch: local ID (73) != TBM ID (74)
[15:44:56.769] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[15:44:56.769] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 0 Event ID mismatch: local ID (75) != TBM ID (74)
[15:44:56.769] <TB3> ERROR: <datapipe.cc/CheckEventID:L463> Channel 1 Event ID mismatch: local ID (75) != TBM ID (74)
[15:45:03.472] <TB3> INFO: 655360 events read in total (11559ms).
[15:45:03.495] <TB3> INFO: Expecting 655360 events.
[15:45:15.681] <TB3> INFO: 655360 events read in total (11605ms).
[15:45:15.701] <TB3> INFO: Expecting 655360 events.
[15:45:27.884] <TB3> INFO: 655360 events read in total (11590ms).
[15:45:27.907] <TB3> INFO: Expecting 655360 events.
[15:45:40.016] <TB3> INFO: 655360 events read in total (11520ms).
[15:45:40.041] <TB3> INFO: Expecting 655360 events.
[15:45:52.216] <TB3> INFO: 655360 events read in total (11594ms).
[15:45:52.247] <TB3> INFO: Expecting 655360 events.
[15:46:04.407] <TB3> INFO: 655360 events read in total (11605ms).
[15:46:04.449] <TB3> INFO: Expecting 655360 events.
[15:46:16.617] <TB3> INFO: 655360 events read in total (11600ms).
[15:46:16.660] <TB3> INFO: Expecting 655360 events.
[15:46:27.808] <TB3> INFO: 655360 events read in total (10606ms).
[15:46:27.850] <TB3> INFO: Expecting 655360 events.
[15:46:33.205] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[15:46:33.205] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[15:46:39.115] <TB3> INFO: 655360 events read in total (10690ms).
[15:46:39.158] <TB3> INFO: Expecting 655360 events.
[15:46:50.429] <TB3> INFO: 655360 events read in total (10701ms).
[15:46:50.478] <TB3> INFO: Expecting 655360 events.
[15:47:02.661] <TB3> INFO: 655360 events read in total (11626ms).
[15:47:02.712] <TB3> INFO: Expecting 655360 events.
[15:47:14.775] <TB3> INFO: 655360 events read in total (11506ms).
[15:47:14.846] <TB3> INFO: Expecting 655360 events.
[15:47:27.114] <TB3> INFO: 655360 events read in total (11724ms).
[15:47:27.175] <TB3> INFO: Expecting 655360 events.
[15:47:32.588] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (7) != Token Chain Length (8)
[15:47:32.588] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[15:47:39.283] <TB3> INFO: 655360 events read in total (11563ms).
[15:47:39.358] <TB3> INFO: Test took 192852ms.
[15:47:39.609] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.618] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.627] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.636] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.645] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.654] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.663] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.672] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.681] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.690] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.700] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.708] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.717] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.726] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.735] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.744] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[15:47:39.793] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C0.dat
[15:47:39.794] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C1.dat
[15:47:39.794] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C2.dat
[15:47:39.794] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C3.dat
[15:47:39.794] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C4.dat
[15:47:39.795] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C5.dat
[15:47:39.795] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C6.dat
[15:47:39.795] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C7.dat
[15:47:39.795] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C8.dat
[15:47:39.795] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C9.dat
[15:47:39.795] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C10.dat
[15:47:39.795] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C11.dat
[15:47:39.796] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C12.dat
[15:47:39.796] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C13.dat
[15:47:39.796] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C14.dat
[15:47:39.796] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//dacParameters35_C15.dat
[15:47:40.138] <TB3> INFO: Expecting 41600 events.
[15:47:43.977] <TB3> INFO: 41600 events read in total (3124ms).
[15:47:43.978] <TB3> INFO: Test took 4179ms.
[15:47:44.613] <TB3> INFO: Expecting 41600 events.
[15:47:48.447] <TB3> INFO: 41600 events read in total (3119ms).
[15:47:48.448] <TB3> INFO: Test took 4146ms.
[15:47:49.102] <TB3> INFO: Expecting 41600 events.
[15:47:53.036] <TB3> INFO: 41600 events read in total (3219ms).
[15:47:53.037] <TB3> INFO: Test took 4257ms.
[15:47:53.334] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:53.467] <TB3> INFO: Expecting 2560 events.
[15:47:54.430] <TB3> INFO: 2560 events read in total (248ms).
[15:47:54.430] <TB3> INFO: Test took 1096ms.
[15:47:54.433] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:54.939] <TB3> INFO: Expecting 2560 events.
[15:47:55.900] <TB3> INFO: 2560 events read in total (246ms).
[15:47:55.901] <TB3> INFO: Test took 1468ms.
[15:47:55.904] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:56.409] <TB3> INFO: Expecting 2560 events.
[15:47:57.372] <TB3> INFO: 2560 events read in total (247ms).
[15:47:57.372] <TB3> INFO: Test took 1469ms.
[15:47:57.375] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:57.879] <TB3> INFO: Expecting 2560 events.
[15:47:58.842] <TB3> INFO: 2560 events read in total (248ms).
[15:47:58.842] <TB3> INFO: Test took 1467ms.
[15:47:58.845] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:59.351] <TB3> INFO: Expecting 2560 events.
[15:48:00.314] <TB3> INFO: 2560 events read in total (248ms).
[15:48:00.315] <TB3> INFO: Test took 1470ms.
[15:48:00.317] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:00.823] <TB3> INFO: Expecting 2560 events.
[15:48:01.785] <TB3> INFO: 2560 events read in total (247ms).
[15:48:01.786] <TB3> INFO: Test took 1469ms.
[15:48:01.788] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:02.295] <TB3> INFO: Expecting 2560 events.
[15:48:03.252] <TB3> INFO: 2560 events read in total (242ms).
[15:48:03.252] <TB3> INFO: Test took 1464ms.
[15:48:03.255] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:03.761] <TB3> INFO: Expecting 2560 events.
[15:48:04.724] <TB3> INFO: 2560 events read in total (248ms).
[15:48:04.725] <TB3> INFO: Test took 1470ms.
[15:48:04.727] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:05.233] <TB3> INFO: Expecting 2560 events.
[15:48:06.197] <TB3> INFO: 2560 events read in total (249ms).
[15:48:06.197] <TB3> INFO: Test took 1470ms.
[15:48:06.200] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:06.706] <TB3> INFO: Expecting 2560 events.
[15:48:07.664] <TB3> INFO: 2560 events read in total (243ms).
[15:48:07.664] <TB3> INFO: Test took 1464ms.
[15:48:07.667] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:08.173] <TB3> INFO: Expecting 2560 events.
[15:48:09.136] <TB3> INFO: 2560 events read in total (248ms).
[15:48:09.136] <TB3> INFO: Test took 1470ms.
[15:48:09.139] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:09.644] <TB3> INFO: Expecting 2560 events.
[15:48:10.606] <TB3> INFO: 2560 events read in total (247ms).
[15:48:10.606] <TB3> INFO: Test took 1467ms.
[15:48:10.609] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:11.115] <TB3> INFO: Expecting 2560 events.
[15:48:12.076] <TB3> INFO: 2560 events read in total (246ms).
[15:48:12.076] <TB3> INFO: Test took 1467ms.
[15:48:12.079] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:12.585] <TB3> INFO: Expecting 2560 events.
[15:48:13.547] <TB3> INFO: 2560 events read in total (247ms).
[15:48:13.547] <TB3> INFO: Test took 1468ms.
[15:48:13.550] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:14.056] <TB3> INFO: Expecting 2560 events.
[15:48:15.019] <TB3> INFO: 2560 events read in total (248ms).
[15:48:15.019] <TB3> INFO: Test took 1469ms.
[15:48:15.022] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:15.528] <TB3> INFO: Expecting 2560 events.
[15:48:16.491] <TB3> INFO: 2560 events read in total (248ms).
[15:48:16.491] <TB3> INFO: Test took 1469ms.
[15:48:16.494] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:17.000] <TB3> INFO: Expecting 2560 events.
[15:48:17.963] <TB3> INFO: 2560 events read in total (248ms).
[15:48:17.963] <TB3> INFO: Test took 1469ms.
[15:48:17.966] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:18.472] <TB3> INFO: Expecting 2560 events.
[15:48:19.236] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 4 ROCs were found
[15:48:19.236] <TB3> WARNING: Channel 1 ROC 3: Readback start marker after 15 readouts!
[15:48:19.236] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[15:48:19.237] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (0) != Token Chain Length (8)
[15:48:19.622] <TB3> CRITICAL: <hal.cc/condenseTriggers:L1899> Data size does not correspond to 10 triggers! Aborting data processing!
[15:48:19.622] <TB3> INFO: 0 events read in total (435ms).
[15:48:19.623] <TB3> CRITICAL: <hal.cc/SingleRocOnePixelDacScan:L1109> Incomplete DAQ data readout! Missing 256 Events.
[15:48:19.623] <TB3> CRITICAL: <PixTestPhOptimization.cc/DrawPhCurves:L829> pXar execption: Incomplete DAQ data readout in function SingleRocOnePixelDacScan
[15:48:19.623] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:19.942] <TB3> INFO: Expecting 2560 events.
[15:48:20.702] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 0 Number of ROCs (6) != Token Chain Length (8)
[15:48:20.702] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L491> Channel 1 Number of ROCs (7) != Token Chain Length (8)
[15:48:20.906] <TB3> INFO: 2560 events read in total (249ms).
[15:48:20.906] <TB3> INFO: Test took 1283ms.
[15:48:20.909] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:21.415] <TB3> INFO: Expecting 2560 events.
[15:48:22.373] <TB3> INFO: 2560 events read in total (243ms).
[15:48:22.373] <TB3> INFO: Test took 1464ms.
[15:48:22.375] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:22.882] <TB3> INFO: Expecting 2560 events.
[15:48:23.846] <TB3> INFO: 2560 events read in total (249ms).
[15:48:23.846] <TB3> INFO: Test took 1471ms.
[15:48:23.850] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:24.355] <TB3> INFO: Expecting 2560 events.
[15:48:25.318] <TB3> INFO: 2560 events read in total (248ms).
[15:48:25.318] <TB3> INFO: Test took 1469ms.
[15:48:25.321] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:25.828] <TB3> INFO: Expecting 2560 events.
[15:48:26.792] <TB3> INFO: 2560 events read in total (249ms).
[15:48:26.793] <TB3> INFO: Test took 1472ms.
[15:48:26.796] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:27.301] <TB3> INFO: Expecting 2560 events.
[15:48:28.264] <TB3> INFO: 2560 events read in total (248ms).
[15:48:28.264] <TB3> INFO: Test took 1468ms.
[15:48:28.267] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:28.773] <TB3> INFO: Expecting 2560 events.
[15:48:29.737] <TB3> INFO: 2560 events read in total (249ms).
[15:48:29.737] <TB3> INFO: Test took 1470ms.
[15:48:29.739] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:30.246] <TB3> INFO: Expecting 2560 events.
[15:48:31.208] <TB3> INFO: 2560 events read in total (247ms).
[15:48:31.208] <TB3> INFO: Test took 1469ms.
[15:48:31.211] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:31.717] <TB3> INFO: Expecting 2560 events.
[15:48:32.680] <TB3> INFO: 2560 events read in total (248ms).
[15:48:32.681] <TB3> INFO: Test took 1471ms.
[15:48:32.684] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:33.189] <TB3> INFO: Expecting 2560 events.
[15:48:34.152] <TB3> INFO: 2560 events read in total (248ms).
[15:48:34.152] <TB3> INFO: Test took 1469ms.
[15:48:34.155] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:34.661] <TB3> INFO: Expecting 2560 events.
[15:48:35.623] <TB3> INFO: 2560 events read in total (247ms).
[15:48:35.624] <TB3> INFO: Test took 1470ms.
[15:48:35.627] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:36.132] <TB3> INFO: Expecting 2560 events.
[15:48:37.094] <TB3> INFO: 2560 events read in total (247ms).
[15:48:37.094] <TB3> INFO: Test took 1467ms.
[15:48:37.096] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:37.604] <TB3> INFO: Expecting 2560 events.
[15:48:38.566] <TB3> INFO: 2560 events read in total (247ms).
[15:48:38.566] <TB3> INFO: Test took 1470ms.
[15:48:38.569] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:39.075] <TB3> INFO: Expecting 2560 events.
[15:48:40.037] <TB3> INFO: 2560 events read in total (247ms).
[15:48:40.037] <TB3> INFO: Test took 1468ms.
[15:48:40.040] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:48:40.547] <TB3> INFO: Expecting 2560 events.
[15:48:41.509] <TB3> INFO: 2560 events read in total (247ms).
[15:48:41.509] <TB3> INFO: Test took 1469ms.
[15:48:42.216] <TB3> INFO: PixTestPhOptimization::doTest() done, duration: 492 seconds
[15:48:42.216] <TB3> INFO: PH scale (per ROC): 90 81 74 73 82 81 84 83 83 81 84 79 97 81 70 80
[15:48:42.216] <TB3> INFO: PH offset (per ROC): 157 154 183 166 156 144 158 155 145 161 141 138 131 149 159 150
[15:48:42.224] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:48:42.224] <TB3> INFO: Decoding statistics:
[15:48:42.224] <TB3> INFO: General information:
[15:48:42.224] <TB3> INFO: 16bit words read: 66442
[15:48:42.224] <TB3> INFO: valid events total: 5120
[15:48:42.224] <TB3> INFO: empty events: 2619
[15:48:42.224] <TB3> INFO: valid events with pixels: 2501
[15:48:42.224] <TB3> INFO: valid pixel hits: 2501
[15:48:42.224] <TB3> INFO: Event errors: 0
[15:48:42.224] <TB3> INFO: start marker: 0
[15:48:42.224] <TB3> INFO: stop marker: 0
[15:48:42.224] <TB3> INFO: overflow: 0
[15:48:42.224] <TB3> INFO: invalid 5bit words: 0
[15:48:42.224] <TB3> INFO: invalid XOR eye diagram: 0
[15:48:42.224] <TB3> INFO: TBM errors: 0
[15:48:42.224] <TB3> INFO: flawed TBM headers: 0
[15:48:42.224] <TB3> INFO: flawed TBM trailers: 0
[15:48:42.224] <TB3> INFO: event ID mismatches: 0
[15:48:42.225] <TB3> INFO: ROC errors: 0
[15:48:42.225] <TB3> INFO: missing ROC header(s): 0
[15:48:42.225] <TB3> INFO: misplaced readback start: 0
[15:48:42.225] <TB3> INFO: Pixel decoding errors: 0
[15:48:42.225] <TB3> INFO: pixel data incomplete: 0
[15:48:42.225] <TB3> INFO: pixel address: 0
[15:48:42.225] <TB3> INFO: pulse height fill bit: 0
[15:48:42.225] <TB3> INFO: buffer corruption: 0
[15:48:42.404] <TB3> INFO: ######################################################################
[15:48:42.404] <TB3> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[15:48:42.404] <TB3> INFO: ######################################################################
[15:48:42.415] <TB3> INFO: scanning low vcal = 10
[15:48:42.753] <TB3> INFO: Expecting 41600 events.
[15:48:46.524] <TB3> INFO: 41600 events read in total (3056ms).
[15:48:46.524] <TB3> INFO: Test took 4109ms.
[15:48:46.525] <TB3> INFO: scanning low vcal = 20
[15:48:47.032] <TB3> INFO: Expecting 41600 events.
[15:48:50.801] <TB3> INFO: 41600 events read in total (3054ms).
[15:48:50.802] <TB3> INFO: Test took 4277ms.
[15:48:50.805] <TB3> INFO: scanning low vcal = 30
[15:48:51.310] <TB3> INFO: Expecting 41600 events.
[15:48:55.111] <TB3> INFO: 41600 events read in total (3086ms).
[15:48:55.111] <TB3> INFO: Test took 4306ms.
[15:48:55.115] <TB3> INFO: scanning low vcal = 40
[15:48:55.611] <TB3> INFO: Expecting 41600 events.
[15:48:59.765] <TB3> INFO: 41600 events read in total (3439ms).
[15:48:59.766] <TB3> INFO: Test took 4651ms.
[15:48:59.769] <TB3> INFO: scanning low vcal = 50
[15:49:00.216] <TB3> INFO: Expecting 41600 events.
[15:49:04.428] <TB3> INFO: 41600 events read in total (3497ms).
[15:49:04.428] <TB3> INFO: Test took 4659ms.
[15:49:04.431] <TB3> INFO: scanning low vcal = 60
[15:49:04.862] <TB3> INFO: Expecting 41600 events.
[15:49:09.064] <TB3> INFO: 41600 events read in total (3487ms).
[15:49:09.064] <TB3> INFO: Test took 4633ms.
[15:49:09.067] <TB3> INFO: scanning low vcal = 70
[15:49:09.495] <TB3> INFO: Expecting 41600 events.
[15:49:13.709] <TB3> INFO: 41600 events read in total (3499ms).
[15:49:13.709] <TB3> INFO: Test took 4642ms.
[15:49:13.712] <TB3> INFO: scanning low vcal = 80
[15:49:14.141] <TB3> INFO: Expecting 41600 events.
[15:49:18.341] <TB3> INFO: 41600 events read in total (3485ms).
[15:49:18.341] <TB3> INFO: Test took 4629ms.
[15:49:18.344] <TB3> INFO: scanning low vcal = 90
[15:49:18.791] <TB3> INFO: Expecting 41600 events.
[15:49:23.026] <TB3> INFO: 41600 events read in total (3520ms).
[15:49:23.027] <TB3> INFO: Test took 4683ms.
[15:49:23.031] <TB3> INFO: scanning low vcal = 100
[15:49:23.467] <TB3> INFO: Expecting 41600 events.
[15:49:27.874] <TB3> INFO: 41600 events read in total (3692ms).
[15:49:27.874] <TB3> INFO: Test took 4843ms.
[15:49:27.879] <TB3> INFO: scanning low vcal = 110
[15:49:28.287] <TB3> INFO: Expecting 41600 events.
[15:49:32.518] <TB3> INFO: 41600 events read in total (3516ms).
[15:49:32.519] <TB3> INFO: Test took 4640ms.
[15:49:32.522] <TB3> INFO: scanning low vcal = 120
[15:49:32.968] <TB3> INFO: Expecting 41600 events.
[15:49:37.164] <TB3> INFO: 41600 events read in total (3481ms).
[15:49:37.164] <TB3> INFO: Test took 4642ms.
[15:49:37.167] <TB3> INFO: scanning low vcal = 130
[15:49:37.600] <TB3> INFO: Expecting 41600 events.
[15:49:41.812] <TB3> INFO: 41600 events read in total (3497ms).
[15:49:41.812] <TB3> INFO: Test took 4645ms.
[15:49:41.815] <TB3> INFO: scanning low vcal = 140
[15:49:42.264] <TB3> INFO: Expecting 41600 events.
[15:49:46.477] <TB3> INFO: 41600 events read in total (3498ms).
[15:49:46.478] <TB3> INFO: Test took 4663ms.
[15:49:46.480] <TB3> INFO: scanning low vcal = 150
[15:49:46.920] <TB3> INFO: Expecting 41600 events.
[15:49:51.279] <TB3> INFO: 41600 events read in total (3644ms).
[15:49:51.280] <TB3> INFO: Test took 4800ms.
[15:49:51.297] <TB3> INFO: scanning low vcal = 160
[15:49:51.709] <TB3> INFO: Expecting 41600 events.
[15:49:56.063] <TB3> INFO: 41600 events read in total (3639ms).
[15:49:56.064] <TB3> INFO: Test took 4767ms.
[15:49:56.067] <TB3> INFO: scanning low vcal = 170
[15:49:56.506] <TB3> INFO: Expecting 41600 events.
[15:50:00.833] <TB3> INFO: 41600 events read in total (3612ms).
[15:50:00.833] <TB3> INFO: Test took 4766ms.
[15:50:00.837] <TB3> INFO: scanning low vcal = 180
[15:50:01.282] <TB3> INFO: Expecting 41600 events.
[15:50:05.629] <TB3> INFO: 41600 events read in total (3632ms).
[15:50:05.630] <TB3> INFO: Test took 4793ms.
[15:50:05.633] <TB3> INFO: scanning low vcal = 190
[15:50:06.059] <TB3> INFO: Expecting 41600 events.
[15:50:10.414] <TB3> INFO: 41600 events read in total (3640ms).
[15:50:10.415] <TB3> INFO: Test took 4782ms.
[15:50:10.419] <TB3> INFO: scanning low vcal = 200
[15:50:10.840] <TB3> INFO: Expecting 41600 events.
[15:50:15.184] <TB3> INFO: 41600 events read in total (3629ms).
[15:50:15.184] <TB3> INFO: Test took 4765ms.
[15:50:15.187] <TB3> INFO: scanning low vcal = 210
[15:50:15.613] <TB3> INFO: Expecting 41600 events.
[15:50:19.955] <TB3> INFO: 41600 events read in total (3627ms).
[15:50:19.955] <TB3> INFO: Test took 4767ms.
[15:50:19.958] <TB3> INFO: scanning low vcal = 220
[15:50:20.387] <TB3> INFO: Expecting 41600 events.
[15:50:24.742] <TB3> INFO: 41600 events read in total (3640ms).
[15:50:24.743] <TB3> INFO: Test took 4785ms.
[15:50:24.745] <TB3> INFO: scanning low vcal = 230
[15:50:25.188] <TB3> INFO: Expecting 41600 events.
[15:50:29.548] <TB3> INFO: 41600 events read in total (3645ms).
[15:50:29.548] <TB3> INFO: Test took 4802ms.
[15:50:29.552] <TB3> INFO: scanning low vcal = 240
[15:50:29.966] <TB3> INFO: Expecting 41600 events.
[15:50:34.278] <TB3> INFO: 41600 events read in total (3597ms).
[15:50:34.279] <TB3> INFO: Test took 4727ms.
[15:50:34.282] <TB3> INFO: scanning low vcal = 250
[15:50:34.729] <TB3> INFO: Expecting 41600 events.
[15:50:39.055] <TB3> INFO: 41600 events read in total (3612ms).
[15:50:39.056] <TB3> INFO: Test took 4774ms.
[15:50:39.060] <TB3> INFO: scanning high vcal = 30 (= 210 in low range)
[15:50:39.499] <TB3> INFO: Expecting 41600 events.
[15:50:43.854] <TB3> INFO: 41600 events read in total (3640ms).
[15:50:43.854] <TB3> INFO: Test took 4794ms.
[15:50:43.857] <TB3> INFO: scanning high vcal = 50 (= 350 in low range)
[15:50:44.298] <TB3> INFO: Expecting 41600 events.
[15:50:48.642] <TB3> INFO: 41600 events read in total (3630ms).
[15:50:48.642] <TB3> INFO: Test took 4785ms.
[15:50:48.645] <TB3> INFO: scanning high vcal = 70 (= 490 in low range)
[15:50:49.085] <TB3> INFO: Expecting 41600 events.
[15:50:52.280] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 0 has NoTokenPass but 8 ROCs were found
[15:50:52.280] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L480> Channel 1 has NoTokenPass but 8 ROCs were found
[15:50:53.438] <TB3> INFO: 41600 events read in total (3638ms).
[15:50:53.439] <TB3> INFO: Test took 4794ms.
[15:50:53.442] <TB3> INFO: scanning high vcal = 90 (= 630 in low range)
[15:50:53.878] <TB3> INFO: Expecting 41600 events.
[15:50:58.187] <TB3> INFO: 41600 events read in total (3594ms).
[15:50:58.187] <TB3> INFO: Test took 4745ms.
[15:50:58.191] <TB3> INFO: scanning high vcal = 200 (= 1400 in low range)
[15:50:58.634] <TB3> INFO: Expecting 41600 events.
[15:51:02.929] <TB3> INFO: 41600 events read in total (3580ms).
[15:51:02.929] <TB3> INFO: Test took 4738ms.
[15:51:03.390] <TB3> INFO: PixTestGainPedestal::measure() done
[15:51:38.824] <TB3> INFO: PixTestGainPedestal::fit() done
[15:51:38.824] <TB3> INFO: non-linearity mean: 0.958 0.957 0.949 0.956 0.958 0.955 0.954 0.957 0.955 0.955 0.957 0.954 0.954 0.953 0.953 0.955
[15:51:38.824] <TB3> INFO: non-linearity RMS: 0.006 0.005 0.006 0.008 0.005 0.006 0.005 0.005 0.005 0.005 0.004 0.005 0.005 0.005 0.005 0.006
[15:51:38.824] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[15:51:38.854] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[15:51:38.887] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[15:51:38.910] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[15:51:38.946] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[15:51:38.971] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[15:51:38.989] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[15:51:39.010] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[15:51:39.042] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[15:51:39.077] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[15:51:39.111] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[15:51:39.144] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[15:51:39.178] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[15:51:39.211] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[15:51:39.246] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[15:51:39.282] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[15:51:39.317] <TB3> INFO: PixTestGainPedestal::fullTest() done, duration: 176 seconds
[15:51:39.317] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:51:39.317] <TB3> INFO: Decoding statistics:
[15:51:39.317] <TB3> INFO: General information:
[15:51:39.317] <TB3> INFO: 16bit words read: 2329334
[15:51:39.317] <TB3> INFO: valid events total: 83200
[15:51:39.317] <TB3> INFO: empty events: 0
[15:51:39.317] <TB3> INFO: valid events with pixels: 83200
[15:51:39.317] <TB3> INFO: valid pixel hits: 665467
[15:51:39.317] <TB3> INFO: Event errors: 0
[15:51:39.317] <TB3> INFO: start marker: 0
[15:51:39.317] <TB3> INFO: stop marker: 0
[15:51:39.317] <TB3> INFO: overflow: 0
[15:51:39.317] <TB3> INFO: invalid 5bit words: 0
[15:51:39.317] <TB3> INFO: invalid XOR eye diagram: 0
[15:51:39.317] <TB3> INFO: TBM errors: 0
[15:51:39.317] <TB3> INFO: flawed TBM headers: 0
[15:51:39.317] <TB3> INFO: flawed TBM trailers: 0
[15:51:39.317] <TB3> INFO: event ID mismatches: 0
[15:51:39.317] <TB3> INFO: ROC errors: 0
[15:51:39.317] <TB3> INFO: missing ROC header(s): 0
[15:51:39.317] <TB3> INFO: misplaced readback start: 0
[15:51:39.317] <TB3> INFO: Pixel decoding errors: 0
[15:51:39.317] <TB3> INFO: pixel data incomplete: 0
[15:51:39.317] <TB3> INFO: pixel address: 0
[15:51:39.317] <TB3> INFO: pulse height fill bit: 0
[15:51:39.317] <TB3> INFO: buffer corruption: 0
[15:51:39.326] <TB3> INFO: readReadbackCal: /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C15.dat
[15:51:39.327] <TB3> INFO: ######################################################################
[15:51:39.328] <TB3> INFO: PixTestReadback::doTest()
[15:51:39.328] <TB3> INFO: ######################################################################
[15:51:39.329] <TB3> INFO: PixTestReadback::RES sent once
[15:51:50.591] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C0.dat
[15:51:50.591] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C1.dat
[15:51:50.591] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C2.dat
[15:51:50.591] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C3.dat
[15:51:50.591] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C4.dat
[15:51:50.591] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C5.dat
[15:51:50.591] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C6.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C7.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C8.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C9.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C10.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C11.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C12.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C13.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C14.dat
[15:51:50.592] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C15.dat
[15:51:50.629] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[15:51:50.630] <TB3> INFO: PixTestReadback::RES sent once
[15:52:01.803] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C0.dat
[15:52:01.804] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C1.dat
[15:52:01.804] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C2.dat
[15:52:01.805] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C3.dat
[15:52:01.805] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C4.dat
[15:52:01.805] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C5.dat
[15:52:01.805] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C6.dat
[15:52:01.805] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C7.dat
[15:52:01.806] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C8.dat
[15:52:01.806] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C9.dat
[15:52:01.806] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C10.dat
[15:52:01.806] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C11.dat
[15:52:01.806] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C12.dat
[15:52:01.806] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C13.dat
[15:52:01.807] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C14.dat
[15:52:01.807] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C15.dat
[15:52:01.841] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[15:52:01.841] <TB3> INFO: PixTestReadback::RES sent once
[15:52:10.428] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[15:52:10.428] <TB3> INFO: Vbg will be calibrated using Vd calibration
[15:52:10.428] <TB3> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 150calibrated Vbg = 1.23049 :::*/*/*/*/
[15:52:10.428] <TB3> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 149.8calibrated Vbg = 1.23066 :::*/*/*/*/
[15:52:10.428] <TB3> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 146.5calibrated Vbg = 1.23613 :::*/*/*/*/
[15:52:10.428] <TB3> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 148.1calibrated Vbg = 1.2414 :::*/*/*/*/
[15:52:10.428] <TB3> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 156.1calibrated Vbg = 1.24533 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 150.9calibrated Vbg = 1.24617 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 152.8calibrated Vbg = 1.23597 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 147.9calibrated Vbg = 1.24369 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 151.2calibrated Vbg = 1.25033 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 156.2calibrated Vbg = 1.25431 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 150.7calibrated Vbg = 1.25413 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 153.8calibrated Vbg = 1.24886 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 148.6calibrated Vbg = 1.24502 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 147.7calibrated Vbg = 1.23747 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 156.8calibrated Vbg = 1.23483 :::*/*/*/*/
[15:52:10.429] <TB3> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 159.6calibrated Vbg = 1.24197 :::*/*/*/*/
[15:52:10.432] <TB3> INFO: PixTestReadback::RES sent once
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C0.dat
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C1.dat
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C2.dat
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C3.dat
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C4.dat
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C5.dat
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C6.dat
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C7.dat
[15:55:04.375] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C8.dat
[15:55:04.376] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C9.dat
[15:55:04.376] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C10.dat
[15:55:04.376] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C11.dat
[15:55:04.376] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C12.dat
[15:55:04.376] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C13.dat
[15:55:04.376] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C14.dat
[15:55:04.376] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M4080_FullQualification_2015-12-08_13h26m_1449577585//002_FulltestPxar_m20//readbackCal_C15.dat
[15:55:04.408] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[15:55:04.409] <TB3> INFO: PixTestReadback::doTest() done
[15:55:04.409] <TB3> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:55:04.409] <TB3> INFO: Decoding statistics:
[15:55:04.409] <TB3> INFO: General information:
[15:55:04.409] <TB3> INFO: 16bit words read: 768
[15:55:04.409] <TB3> INFO: valid events total: 64
[15:55:04.409] <TB3> INFO: empty events: 64
[15:55:04.409] <TB3> INFO: valid events with pixels: 0
[15:55:04.409] <TB3> INFO: valid pixel hits: 0
[15:55:04.409] <TB3> INFO: Event errors: 0
[15:55:04.409] <TB3> INFO: start marker: 0
[15:55:04.409] <TB3> INFO: stop marker: 0
[15:55:04.409] <TB3> INFO: overflow: 0
[15:55:04.409] <TB3> INFO: invalid 5bit words: 0
[15:55:04.409] <TB3> INFO: invalid XOR eye diagram: 0
[15:55:04.409] <TB3> INFO: TBM errors: 0
[15:55:04.409] <TB3> INFO: flawed TBM headers: 0
[15:55:04.409] <TB3> INFO: flawed TBM trailers: 0
[15:55:04.409] <TB3> INFO: event ID mismatches: 0
[15:55:04.410] <TB3> INFO: ROC errors: 0
[15:55:04.410] <TB3> INFO: missing ROC header(s): 0
[15:55:04.410] <TB3> INFO: misplaced readback start: 0
[15:55:04.410] <TB3> INFO: Pixel decoding errors: 0
[15:55:04.410] <TB3> INFO: pixel data incomplete: 0
[15:55:04.410] <TB3> INFO: pixel address: 0
[15:55:04.410] <TB3> INFO: pulse height fill bit: 0
[15:55:04.410] <TB3> INFO: buffer corruption: 0
[15:55:04.423] <TB3> INFO: Decoding statistics:
[15:55:04.423] <TB3> INFO: General information:
[15:55:04.423] <TB3> INFO: 16bit words read: 2396544
[15:55:04.423] <TB3> INFO: valid events total: 88384
[15:55:04.423] <TB3> INFO: empty events: 2683
[15:55:04.423] <TB3> INFO: valid events with pixels: 85701
[15:55:04.423] <TB3> INFO: valid pixel hits: 667968
[15:55:04.423] <TB3> INFO: Event errors: 0
[15:55:04.423] <TB3> INFO: start marker: 0
[15:55:04.423] <TB3> INFO: stop marker: 0
[15:55:04.423] <TB3> INFO: overflow: 0
[15:55:04.423] <TB3> INFO: invalid 5bit words: 0
[15:55:04.423] <TB3> INFO: invalid XOR eye diagram: 0
[15:55:04.423] <TB3> INFO: TBM errors: 0
[15:55:04.423] <TB3> INFO: flawed TBM headers: 0
[15:55:04.423] <TB3> INFO: flawed TBM trailers: 0
[15:55:04.423] <TB3> INFO: event ID mismatches: 0
[15:55:04.423] <TB3> INFO: ROC errors: 0
[15:55:04.423] <TB3> INFO: missing ROC header(s): 0
[15:55:04.423] <TB3> INFO: misplaced readback start: 0
[15:55:04.423] <TB3> INFO: Pixel decoding errors: 0
[15:55:04.423] <TB3> INFO: pixel data incomplete: 0
[15:55:04.423] <TB3> INFO: pixel address: 0
[15:55:04.423] <TB3> INFO: pulse height fill bit: 0
[15:55:04.423] <TB3> INFO: buffer corruption: 0
[15:55:04.423] <TB3> INFO: enter test to run
[15:55:04.423] <TB3> INFO: test: exit no parameter change
[15:55:04.614] <TB3> QUIET: Connection to board 170 closed.
[15:55:04.694] <TB3> INFO: pXar: this is the end, my friend