[15:29:44.123] <TB0> INFO: *** Welcome to pxar ***
[15:29:44.123] <TB0> INFO: *** Today: 2016/06/30
[15:29:44.624] <TB0> INFO: *** Version: 9751-dirty
[15:29:44.624] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C15.dat
[15:29:44.625] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//tbmParameters_C0b.dat
[15:29:44.625] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//defaultMaskFile.dat
[15:29:44.625] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters_C15.dat
[15:29:44.691] <TB0> INFO: clk: 4
[15:29:44.691] <TB0> INFO: ctr: 4
[15:29:44.691] <TB0> INFO: sda: 19
[15:29:44.691] <TB0> INFO: tin: 9
[15:29:44.691] <TB0> INFO: level: 15
[15:29:44.691] <TB0> INFO: triggerdelay: 0
[15:29:44.691] <TB0> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[15:29:44.691] <TB0> INFO: Log level: INFO
[15:29:44.701] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[15:29:44.703] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[15:29:44.705] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[15:29:46.236] <TB0> INFO: DUT info:
[15:29:46.236] <TB0> INFO: The DUT currently contains the following objects:
[15:29:46.236] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[15:29:46.236] <TB0> INFO: TBM Core alpha (0): 7 registers set
[15:29:46.236] <TB0> INFO: TBM Core beta (1): 7 registers set
[15:29:46.236] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:29:46.236] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.236] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:29:46.637] <TB0> INFO: enter 'restricted' command line mode
[15:29:46.637] <TB0> INFO: enter test to run
[15:29:46.637] <TB0> INFO: test: pretest no parameter change
[15:29:46.637] <TB0> INFO: running: pretest
[15:29:46.641] <TB0> INFO: ----------------------------------------------------------------------
[15:29:46.641] <TB0> INFO: PixTestPretest::programROC()
[15:29:46.641] <TB0> INFO: ----------------------------------------------------------------------
[15:30:04.655] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[15:30:04.655] <TB0> INFO: IA differences per ROC: 18.5 19.3 19.3 19.3 17.7 19.3 19.3 17.7 20.1 21.7 19.3 20.9 20.9 20.9 18.5 18.5
[15:30:04.739] <TB0> INFO: enter test to run
[15:30:04.739] <TB0> INFO: test: pretest no parameter change
[15:30:04.739] <TB0> INFO: running: pretest
[15:30:04.740] <TB0> INFO: ----------------------------------------------------------------------
[15:30:04.740] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[15:30:04.740] <TB0> INFO: ----------------------------------------------------------------------
[15:30:11.122] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 377 mA = 23.5625 mA/ROC
[15:30:11.122] <TB0> INFO: i(loss) [mA/ROC]: 19.3 18.5 18.5 18.5 18.5 18.5 18.5 18.5 18.5 17.7 18.5 18.5 17.7 17.7 17.7 17.7
[15:30:11.148] <TB0> INFO: enter test to run
[15:30:11.148] <TB0> INFO: test: pretest no parameter change
[15:30:11.148] <TB0> INFO: running: pretest
[15:30:11.148] <TB0> INFO: ----------------------------------------------------------------------
[15:30:11.148] <TB0> INFO: PixTestPretest::findTiming()
[15:30:11.148] <TB0> INFO: ----------------------------------------------------------------------
[15:30:11.148] <TB0> INFO: PixTestCmd::init()

[15:31:41.538] <TB0> INFO: TBM phases: 160MHz: 7, 400MHz: 2, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[15:31:41.538] <TB0> INFO: (success/tries = 100/100), width = 4
[15:31:41.539] <TB0> INFO: enter test to run
[15:31:41.539] <TB0> INFO: test: pretest no parameter change
[15:31:41.539] <TB0> INFO: running: pretest
[15:31:41.540] <TB0> INFO: ----------------------------------------------------------------------
[15:31:41.540] <TB0> INFO: PixTestPretest::findWorkingPixel()
[15:31:41.540] <TB0> INFO: ----------------------------------------------------------------------
[15:31:41.632] <TB0> INFO: Expecting 231680 events.


[15:31:51.694] <TB0> INFO: 231680 events read in total (9506ms).
[15:31:51.697] <TB0> INFO: Test took 10154ms.
[15:31:51.927] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[15:31:51.986] <TB0> INFO: enter test to run
[15:31:51.986] <TB0> INFO: test: pretest no parameter change
[15:31:51.986] <TB0> INFO: running: pretest
[15:31:51.987] <TB0> INFO: ----------------------------------------------------------------------
[15:31:51.987] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[15:31:51.987] <TB0> INFO: ----------------------------------------------------------------------
[15:31:52.078] <TB0> INFO: Expecting 231680 events.
[15:32:02.166] <TB0> INFO: 231680 events read in total (9531ms).
[15:32:02.169] <TB0> INFO: Test took 10179ms.
[15:32:02.412] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[15:32:02.412] <TB0> INFO: CalDel: 139 143 132 157 150 114 128 120 116 128 130 132 154 163 142 129
[15:32:02.412] <TB0> INFO: VthrComp: 51 51 51 51 55 51 51 51 51 51 51 51 51 51 51 51
[15:32:02.444] <TB0> INFO: enter test to run
[15:32:02.444] <TB0> INFO: test: pretest no parameter change
[15:32:02.444] <TB0> INFO: running: pretest
[15:32:02.444] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C0.dat
[15:32:02.445] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C1.dat
[15:32:02.445] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C2.dat
[15:32:02.445] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C3.dat
[15:32:02.445] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C4.dat
[15:32:02.445] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C5.dat
[15:32:02.445] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C6.dat
[15:32:02.446] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C7.dat
[15:32:02.446] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C8.dat
[15:32:02.446] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C9.dat
[15:32:02.446] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C10.dat
[15:32:02.446] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C11.dat
[15:32:02.447] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C12.dat
[15:32:02.447] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C13.dat
[15:32:02.447] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C14.dat
[15:32:02.447] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters_C15.dat
[15:32:02.447] <TB0> INFO: enter test to run
[15:32:02.447] <TB0> INFO: test: fulltest no parameter change
[15:32:02.448] <TB0> INFO: running: fulltest
[15:32:02.448] <TB0> INFO: ######################################################################
[15:32:02.448] <TB0> INFO: PixTestFullTest::doTest()
[15:32:02.448] <TB0> INFO: ######################################################################
[15:32:02.449] <TB0> INFO: ######################################################################
[15:32:02.449] <TB0> INFO: PixTestAlive::doTest()
[15:32:02.449] <TB0> INFO: ######################################################################
[15:32:02.450] <TB0> INFO: ----------------------------------------------------------------------
[15:32:02.450] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:32:02.450] <TB0> INFO: ----------------------------------------------------------------------
[15:32:02.708] <TB0> INFO: Expecting 41600 events.
[15:32:06.428] <TB0> INFO: 41600 events read in total (3163ms).
[15:32:06.428] <TB0> INFO: Test took 3977ms.
[15:32:06.659] <TB0> INFO: PixTestAlive::aliveTest() done
[15:32:06.659] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0
[15:32:06.660] <TB0> INFO: ----------------------------------------------------------------------
[15:32:06.660] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:32:06.660] <TB0> INFO: ----------------------------------------------------------------------
[15:32:06.917] <TB0> INFO: Expecting 41600 events.
[15:32:09.823] <TB0> INFO: 41600 events read in total (2350ms).
[15:32:09.823] <TB0> INFO: Test took 3162ms.
[15:32:09.823] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:32:10.067] <TB0> INFO: PixTestAlive::maskTest() done
[15:32:10.067] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:32:10.068] <TB0> INFO: ----------------------------------------------------------------------
[15:32:10.068] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:32:10.068] <TB0> INFO: ----------------------------------------------------------------------
[15:32:10.323] <TB0> INFO: Expecting 41600 events.
[15:32:14.017] <TB0> INFO: 41600 events read in total (3137ms).
[15:32:14.017] <TB0> INFO: Test took 3948ms.
[15:32:14.248] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[15:32:14.248] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:32:14.248] <TB0> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[15:32:14.248] <TB0> INFO: Decoding statistics:
[15:32:14.248] <TB0> INFO: General information:
[15:32:14.248] <TB0> INFO: 16bit words read: 0
[15:32:14.248] <TB0> INFO: valid events total: 0
[15:32:14.248] <TB0> INFO: empty events: 0
[15:32:14.248] <TB0> INFO: valid events with pixels: 0
[15:32:14.248] <TB0> INFO: valid pixel hits: 0
[15:32:14.248] <TB0> INFO: Event errors: 0
[15:32:14.248] <TB0> INFO: start marker: 0
[15:32:14.248] <TB0> INFO: stop marker: 0
[15:32:14.248] <TB0> INFO: overflow: 0
[15:32:14.248] <TB0> INFO: invalid 5bit words: 0
[15:32:14.248] <TB0> INFO: invalid XOR eye diagram: 0
[15:32:14.248] <TB0> INFO: frame (failed synchr.): 0
[15:32:14.248] <TB0> INFO: idle data (no TBM trl): 0
[15:32:14.248] <TB0> INFO: no data (only TBM hdr): 0
[15:32:14.248] <TB0> INFO: TBM errors: 0
[15:32:14.248] <TB0> INFO: flawed TBM headers: 0
[15:32:14.248] <TB0> INFO: flawed TBM trailers: 0
[15:32:14.248] <TB0> INFO: event ID mismatches: 0
[15:32:14.248] <TB0> INFO: ROC errors: 0
[15:32:14.248] <TB0> INFO: missing ROC header(s): 0
[15:32:14.248] <TB0> INFO: misplaced readback start: 0
[15:32:14.248] <TB0> INFO: Pixel decoding errors: 0
[15:32:14.248] <TB0> INFO: pixel data incomplete: 0
[15:32:14.248] <TB0> INFO: pixel address: 0
[15:32:14.248] <TB0> INFO: pulse height fill bit: 0
[15:32:14.248] <TB0> INFO: buffer corruption: 0
[15:32:14.255] <TB0> INFO: ######################################################################
[15:32:14.255] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[15:32:14.255] <TB0> INFO: ######################################################################
[15:32:14.257] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[15:32:14.267] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[15:32:14.268] <TB0> INFO: run 1 of 1
[15:32:14.523] <TB0> INFO: Expecting 3120000 events.
[15:32:55.019] <TB0> INFO: 917560 events read in total (39939ms).
[15:33:34.239] <TB0> INFO: 1807165 events read in total (79159ms).
[15:34:13.419] <TB0> INFO: 2708785 events read in total (118340ms).
[15:34:31.246] <TB0> INFO: 3120000 events read in total (136166ms).
[15:34:31.288] <TB0> INFO: Test took 137020ms.
[15:34:52.186] <TB0> INFO: PixTestBBMap::doTest() done, duration: 157 seconds
[15:34:52.186] <TB0> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:34:52.186] <TB0> INFO: separation cut (per ROC): 110 102 102 101 105 111 112 108 115 113 104 106 103 105 108 101
[15:34:52.186] <TB0> INFO: Decoding statistics:
[15:34:52.186] <TB0> INFO: General information:
[15:34:52.186] <TB0> INFO: 16bit words read: 0
[15:34:52.186] <TB0> INFO: valid events total: 0
[15:34:52.186] <TB0> INFO: empty events: 0
[15:34:52.186] <TB0> INFO: valid events with pixels: 0
[15:34:52.186] <TB0> INFO: valid pixel hits: 0
[15:34:52.186] <TB0> INFO: Event errors: 0
[15:34:52.186] <TB0> INFO: start marker: 0
[15:34:52.186] <TB0> INFO: stop marker: 0
[15:34:52.186] <TB0> INFO: overflow: 0
[15:34:52.186] <TB0> INFO: invalid 5bit words: 0
[15:34:52.186] <TB0> INFO: invalid XOR eye diagram: 0
[15:34:52.186] <TB0> INFO: frame (failed synchr.): 0
[15:34:52.186] <TB0> INFO: idle data (no TBM trl): 0
[15:34:52.186] <TB0> INFO: no data (only TBM hdr): 0
[15:34:52.186] <TB0> INFO: TBM errors: 0
[15:34:52.186] <TB0> INFO: flawed TBM headers: 0
[15:34:52.186] <TB0> INFO: flawed TBM trailers: 0
[15:34:52.186] <TB0> INFO: event ID mismatches: 0
[15:34:52.186] <TB0> INFO: ROC errors: 0
[15:34:52.186] <TB0> INFO: missing ROC header(s): 0
[15:34:52.186] <TB0> INFO: misplaced readback start: 0
[15:34:52.186] <TB0> INFO: Pixel decoding errors: 0
[15:34:52.186] <TB0> INFO: pixel data incomplete: 0
[15:34:52.186] <TB0> INFO: pixel address: 0
[15:34:52.186] <TB0> INFO: pulse height fill bit: 0
[15:34:52.186] <TB0> INFO: buffer corruption: 0
[15:34:52.254] <TB0> INFO: ######################################################################
[15:34:52.254] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[15:34:52.254] <TB0> INFO: ######################################################################
[15:34:52.254] <TB0> INFO: ----------------------------------------------------------------------
[15:34:52.254] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[15:34:52.254] <TB0> INFO: ----------------------------------------------------------------------
[15:34:52.254] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[15:34:52.262] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[15:34:52.262] <TB0> INFO: run 1 of 1
[15:34:52.516] <TB0> INFO: Expecting 26208000 events.
[15:35:24.072] <TB0> INFO: 918350 events read in total (31000ms).
[15:35:55.351] <TB0> INFO: 1824800 events read in total (62279ms).
[15:36:26.279] <TB0> INFO: 2730100 events read in total (93207ms).
[15:36:57.558] <TB0> INFO: 3634800 events read in total (124486ms).
[15:37:28.656] <TB0> INFO: 4542950 events read in total (155584ms).
[15:37:59.592] <TB0> INFO: 5446800 events read in total (186520ms).
[15:38:30.662] <TB0> INFO: 6355900 events read in total (217590ms).
[15:39:01.725] <TB0> INFO: 7263500 events read in total (248653ms).
[15:39:32.923] <TB0> INFO: 8170450 events read in total (279851ms).
[15:40:04.220] <TB0> INFO: 9080300 events read in total (311148ms).
[15:40:35.406] <TB0> INFO: 9987500 events read in total (342334ms).
[15:41:06.735] <TB0> INFO: 10894150 events read in total (373663ms).
[15:41:37.887] <TB0> INFO: 11802000 events read in total (404815ms).
[15:42:09.276] <TB0> INFO: 12712000 events read in total (436204ms).
[15:42:40.434] <TB0> INFO: 13612350 events read in total (467362ms).
[15:43:11.590] <TB0> INFO: 14510050 events read in total (498518ms).
[15:43:42.873] <TB0> INFO: 15409600 events read in total (529801ms).
[15:44:14.013] <TB0> INFO: 16307200 events read in total (560941ms).
[15:44:45.192] <TB0> INFO: 17204850 events read in total (592120ms).
[15:45:16.546] <TB0> INFO: 18103550 events read in total (623474ms).
[15:45:47.887] <TB0> INFO: 19001850 events read in total (654815ms).
[15:46:19.117] <TB0> INFO: 19900650 events read in total (686045ms).
[15:46:50.344] <TB0> INFO: 20799950 events read in total (717272ms).
[15:47:21.569] <TB0> INFO: 21700650 events read in total (748497ms).
[15:47:52.834] <TB0> INFO: 22601950 events read in total (779763ms).
[15:48:24.285] <TB0> INFO: 23504750 events read in total (811213ms).
[15:48:55.788] <TB0> INFO: 24411250 events read in total (842716ms).
[15:49:27.086] <TB0> INFO: 25318950 events read in total (874014ms).
[15:49:57.613] <TB0> INFO: 26208000 events read in total (904541ms).
[15:49:57.636] <TB0> INFO: Test took 905374ms.
[15:49:57.849] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:49:59.216] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:00.584] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:01.961] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:03.333] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:04.684] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:06.033] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:07.368] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:08.702] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:10.038] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:11.387] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:12.737] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:14.091] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:15.439] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:16.779] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:18.106] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[15:50:19.485] <TB0> INFO: PixTestScurves::scurves() done
[15:50:19.485] <TB0> INFO: Vcal mean: 90.97 90.76 91.70 91.15 101.98 97.75 106.55 103.92 105.19 100.12 97.74 98.25 99.31 107.10 108.76 100.63
[15:50:19.485] <TB0> INFO: Vcal RMS: 4.60 4.72 4.68 4.87 5.34 4.68 4.89 5.23 6.28 6.06 5.02 5.08 5.20 5.46 5.40 5.99
[15:50:19.485] <TB0> INFO: PixTestScurves::fullTest() done, duration: 927 seconds
[15:50:19.485] <TB0> INFO: Decoding statistics:
[15:50:19.485] <TB0> INFO: General information:
[15:50:19.485] <TB0> INFO: 16bit words read: 0
[15:50:19.485] <TB0> INFO: valid events total: 0
[15:50:19.485] <TB0> INFO: empty events: 0
[15:50:19.485] <TB0> INFO: valid events with pixels: 0
[15:50:19.485] <TB0> INFO: valid pixel hits: 0
[15:50:19.485] <TB0> INFO: Event errors: 0
[15:50:19.485] <TB0> INFO: start marker: 0
[15:50:19.485] <TB0> INFO: stop marker: 0
[15:50:19.485] <TB0> INFO: overflow: 0
[15:50:19.485] <TB0> INFO: invalid 5bit words: 0
[15:50:19.485] <TB0> INFO: invalid XOR eye diagram: 0
[15:50:19.485] <TB0> INFO: frame (failed synchr.): 0
[15:50:19.485] <TB0> INFO: idle data (no TBM trl): 0
[15:50:19.485] <TB0> INFO: no data (only TBM hdr): 0
[15:50:19.485] <TB0> INFO: TBM errors: 0
[15:50:19.485] <TB0> INFO: flawed TBM headers: 0
[15:50:19.485] <TB0> INFO: flawed TBM trailers: 0
[15:50:19.485] <TB0> INFO: event ID mismatches: 0
[15:50:19.485] <TB0> INFO: ROC errors: 0
[15:50:19.485] <TB0> INFO: missing ROC header(s): 0
[15:50:19.485] <TB0> INFO: misplaced readback start: 0
[15:50:19.485] <TB0> INFO: Pixel decoding errors: 0
[15:50:19.485] <TB0> INFO: pixel data incomplete: 0
[15:50:19.485] <TB0> INFO: pixel address: 0
[15:50:19.485] <TB0> INFO: pulse height fill bit: 0
[15:50:19.485] <TB0> INFO: buffer corruption: 0
[15:50:19.553] <TB0> INFO: ######################################################################
[15:50:19.553] <TB0> INFO: PixTestTrim::doTest()
[15:50:19.553] <TB0> INFO: ######################################################################
[15:50:19.554] <TB0> INFO: ----------------------------------------------------------------------
[15:50:19.554] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[15:50:19.554] <TB0> INFO: ----------------------------------------------------------------------
[15:50:19.629] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[15:50:19.629] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[15:50:19.637] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[15:50:19.637] <TB0> INFO: run 1 of 1
[15:50:19.890] <TB0> INFO: Expecting 6281600 events.
[15:50:57.806] <TB0> INFO: 1088190 events read in total (37356ms).
[15:51:35.377] <TB0> INFO: 2170910 events read in total (74927ms).
[15:52:13.471] <TB0> INFO: 3248100 events read in total (113021ms).
[15:52:50.748] <TB0> INFO: 4331400 events read in total (150298ms).
[15:53:28.118] <TB0> INFO: 5418900 events read in total (187668ms).
[15:53:57.568] <TB0> INFO: 6281600 events read in total (217118ms).
[15:53:57.593] <TB0> INFO: Test took 217956ms.
[15:54:14.519] <TB0> INFO: ROC 0 VthrComp = 91
[15:54:14.519] <TB0> INFO: ROC 1 VthrComp = 89
[15:54:14.519] <TB0> INFO: ROC 2 VthrComp = 92
[15:54:14.519] <TB0> INFO: ROC 3 VthrComp = 90
[15:54:14.519] <TB0> INFO: ROC 4 VthrComp = 91
[15:54:14.519] <TB0> INFO: ROC 5 VthrComp = 98
[15:54:14.519] <TB0> INFO: ROC 6 VthrComp = 104
[15:54:14.520] <TB0> INFO: ROC 7 VthrComp = 101
[15:54:14.520] <TB0> INFO: ROC 8 VthrComp = 96
[15:54:14.520] <TB0> INFO: ROC 9 VthrComp = 98
[15:54:14.520] <TB0> INFO: ROC 10 VthrComp = 91
[15:54:14.520] <TB0> INFO: ROC 11 VthrComp = 93
[15:54:14.520] <TB0> INFO: ROC 12 VthrComp = 91
[15:54:14.520] <TB0> INFO: ROC 13 VthrComp = 85
[15:54:14.520] <TB0> INFO: ROC 14 VthrComp = 99
[15:54:14.520] <TB0> INFO: ROC 15 VthrComp = 93
[15:54:14.520] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[15:54:14.520] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[15:54:14.528] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[15:54:14.528] <TB0> INFO: run 1 of 1
[15:54:14.782] <TB0> INFO: Expecting 6281600 events.
[15:54:48.590] <TB0> INFO: 752750 events read in total (33252ms).
[15:55:21.855] <TB0> INFO: 1505160 events read in total (66517ms).
[15:55:55.223] <TB0> INFO: 2259390 events read in total (99885ms).
[15:56:28.575] <TB0> INFO: 3015260 events read in total (133237ms).
[15:57:01.915] <TB0> INFO: 3767090 events read in total (166578ms).
[15:57:35.252] <TB0> INFO: 4516320 events read in total (199914ms).
[15:58:08.869] <TB0> INFO: 5264380 events read in total (233531ms).
[15:58:42.119] <TB0> INFO: 6011910 events read in total (266781ms).
[15:58:54.304] <TB0> INFO: 6281600 events read in total (278966ms).
[15:58:54.347] <TB0> INFO: Test took 279819ms.
[15:59:17.455] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 57.3633 for pixel 0/5 mean/min/max = 45.3191/33.0266/57.6115
[15:59:17.455] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 56.9765 for pixel 14/77 mean/min/max = 45.4215/33.6937/57.1493
[15:59:17.455] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 56.9008 for pixel 17/47 mean/min/max = 45.4119/33.8688/56.9551
[15:59:17.455] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 57.1259 for pixel 38/2 mean/min/max = 45.4999/33.5085/57.4912
[15:59:17.456] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 69.4164 for pixel 9/7 mean/min/max = 53.4302/37.418/69.4424
[15:59:17.456] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 55.9197 for pixel 8/13 mean/min/max = 44.6117/32.8673/56.3561
[15:59:17.456] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 58.3416 for pixel 51/79 mean/min/max = 46.4157/34.4543/58.377
[15:59:17.456] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 57.734 for pixel 51/49 mean/min/max = 44.7382/31.724/57.7524
[15:59:17.457] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 66.0591 for pixel 4/41 mean/min/max = 48.8934/31.0326/66.7543
[15:59:17.457] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 59.2854 for pixel 5/57 mean/min/max = 45.2364/31.0269/59.4459
[15:59:17.457] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 57.7958 for pixel 51/3 mean/min/max = 46.2037/34.6092/57.7983
[15:59:17.457] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 57.9641 for pixel 18/12 mean/min/max = 45.6878/33.2332/58.1423
[15:59:17.458] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 60.7958 for pixel 22/29 mean/min/max = 47.4647/34.1098/60.8195
[15:59:17.458] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 73.4261 for pixel 45/6 mean/min/max = 55.0723/36.646/73.4986
[15:59:17.458] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 63.6353 for pixel 19/71 mean/min/max = 47.6861/31.6667/63.7056
[15:59:17.459] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 62.3861 for pixel 12/60 mean/min/max = 47.0587/31.4923/62.6251
[15:59:17.459] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:59:17.547] <TB0> INFO: Expecting 514560 events.
[15:59:30.164] <TB0> INFO: 514560 events read in total (12061ms).
[15:59:30.168] <TB0> INFO: Expecting 514560 events.
[15:59:42.689] <TB0> INFO: 514560 events read in total (12092ms).
[15:59:42.694] <TB0> INFO: Expecting 514560 events.
[15:59:55.187] <TB0> INFO: 514560 events read in total (12066ms).
[15:59:55.194] <TB0> INFO: Expecting 514560 events.
[16:00:07.701] <TB0> INFO: 514560 events read in total (12082ms).
[16:00:07.710] <TB0> INFO: Expecting 514560 events.
[16:00:20.276] <TB0> INFO: 514560 events read in total (12144ms).
[16:00:20.287] <TB0> INFO: Expecting 514560 events.
[16:00:32.832] <TB0> INFO: 514560 events read in total (12122ms).
[16:00:32.845] <TB0> INFO: Expecting 514560 events.
[16:00:45.396] <TB0> INFO: 514560 events read in total (12133ms).
[16:00:45.411] <TB0> INFO: Expecting 514560 events.
[16:00:57.872] <TB0> INFO: 514560 events read in total (12040ms).
[16:00:57.888] <TB0> INFO: Expecting 514560 events.
[16:01:10.496] <TB0> INFO: 514560 events read in total (12188ms).
[16:01:10.514] <TB0> INFO: Expecting 514560 events.
[16:01:22.992] <TB0> INFO: 514560 events read in total (12067ms).
[16:01:23.011] <TB0> INFO: Expecting 514560 events.
[16:01:35.499] <TB0> INFO: 514560 events read in total (12074ms).
[16:01:35.520] <TB0> INFO: Expecting 514560 events.
[16:01:48.139] <TB0> INFO: 514560 events read in total (12206ms).
[16:01:48.164] <TB0> INFO: Expecting 514560 events.
[16:02:00.778] <TB0> INFO: 514560 events read in total (12204ms).
[16:02:00.802] <TB0> INFO: Expecting 514560 events.
[16:02:13.303] <TB0> INFO: 514560 events read in total (12088ms).
[16:02:13.331] <TB0> INFO: Expecting 514560 events.
[16:02:25.814] <TB0> INFO: 514560 events read in total (12079ms).
[16:02:25.844] <TB0> INFO: Expecting 514560 events.
[16:02:38.321] <TB0> INFO: 514560 events read in total (12075ms).
[16:02:38.352] <TB0> INFO: Test took 200893ms.
[16:02:39.143] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[16:02:39.151] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[16:02:39.151] <TB0> INFO: run 1 of 1
[16:02:39.404] <TB0> INFO: Expecting 6281600 events.
[16:03:13.119] <TB0> INFO: 740400 events read in total (33158ms).
[16:03:46.305] <TB0> INFO: 1480430 events read in total (66344ms).
[16:04:19.661] <TB0> INFO: 2221790 events read in total (99700ms).
[16:04:52.875] <TB0> INFO: 2963030 events read in total (132914ms).
[16:05:25.947] <TB0> INFO: 3697730 events read in total (165986ms).
[16:05:58.936] <TB0> INFO: 4427610 events read in total (198975ms).
[16:06:32.088] <TB0> INFO: 5154860 events read in total (232128ms).
[16:07:04.960] <TB0> INFO: 5882280 events read in total (264999ms).
[16:07:23.107] <TB0> INFO: 6281600 events read in total (283146ms).
[16:07:23.167] <TB0> INFO: Test took 284016ms.
[16:07:45.539] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.032637 .. 255.000000
[16:07:45.611] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[16:07:45.619] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[16:07:45.619] <TB0> INFO: run 1 of 1
[16:07:45.872] <TB0> INFO: Expecting 10649600 events.
[16:08:19.301] <TB0> INFO: 712260 events read in total (32870ms).
[16:08:52.142] <TB0> INFO: 1424100 events read in total (65712ms).
[16:09:24.920] <TB0> INFO: 2136500 events read in total (98489ms).
[16:09:57.729] <TB0> INFO: 2848910 events read in total (131298ms).
[16:10:30.514] <TB0> INFO: 3561440 events read in total (164083ms).
[16:11:03.311] <TB0> INFO: 4273740 events read in total (196880ms).
[16:11:36.156] <TB0> INFO: 4986000 events read in total (229725ms).
[16:12:08.876] <TB0> INFO: 5698180 events read in total (262445ms).
[16:12:41.629] <TB0> INFO: 6410580 events read in total (295198ms).
[16:13:14.480] <TB0> INFO: 7122270 events read in total (328049ms).
[16:13:47.499] <TB0> INFO: 7833490 events read in total (361068ms).
[16:14:20.576] <TB0> INFO: 8544420 events read in total (394145ms).
[16:14:53.598] <TB0> INFO: 9254860 events read in total (427167ms).
[16:15:26.448] <TB0> INFO: 9964550 events read in total (460017ms).
[16:15:58.172] <TB0> INFO: 10649600 events read in total (491741ms).
[16:15:58.284] <TB0> INFO: Test took 492665ms.
[16:16:26.268] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 15.783700 .. 69.291835
[16:16:26.340] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 5 .. 79 (-1/-1) hits flags = 528 (plus default)
[16:16:26.347] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[16:16:26.347] <TB0> INFO: run 1 of 1
[16:16:26.599] <TB0> INFO: Expecting 3120000 events.
[16:17:01.909] <TB0> INFO: 827580 events read in total (34754ms).
[16:17:36.458] <TB0> INFO: 1655000 events read in total (69304ms).
[16:18:11.258] <TB0> INFO: 2481630 events read in total (104103ms).
[16:18:38.068] <TB0> INFO: 3120000 events read in total (130913ms).
[16:18:38.087] <TB0> INFO: Test took 131739ms.
[16:18:53.358] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 1.280422 .. 41.560092
[16:18:53.430] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 1 .. 51 (-1/-1) hits flags = 528 (plus default)
[16:18:53.438] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[16:18:53.438] <TB0> INFO: run 1 of 1
[16:18:53.691] <TB0> INFO: Expecting 2121600 events.
[16:19:31.307] <TB0> INFO: 993850 events read in total (37059ms).
[16:20:08.236] <TB0> INFO: 1986400 events read in total (73988ms).
[16:20:13.642] <TB0> INFO: 2121600 events read in total (79394ms).
[16:20:13.654] <TB0> INFO: Test took 80217ms.
[16:20:25.514] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 0.085234 .. 40.112380
[16:20:25.587] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 0 .. 50 (-1/-1) hits flags = 528 (plus default)
[16:20:25.595] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[16:20:25.595] <TB0> INFO: run 1 of 1
[16:20:25.848] <TB0> INFO: Expecting 2121600 events.
[16:21:03.599] <TB0> INFO: 1008690 events read in total (37195ms).
[16:21:41.181] <TB0> INFO: 2017480 events read in total (74777ms).
[16:21:45.422] <TB0> INFO: 2121600 events read in total (79019ms).
[16:21:45.438] <TB0> INFO: Test took 79844ms.
[16:21:57.360] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[16:21:57.360] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[16:21:57.369] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[16:21:57.369] <TB0> INFO: run 1 of 1
[16:21:57.625] <TB0> INFO: Expecting 1705600 events.
[16:22:34.224] <TB0> INFO: 876360 events read in total (36043ms).
[16:23:07.857] <TB0> INFO: 1705600 events read in total (69676ms).
[16:23:07.871] <TB0> INFO: Test took 70503ms.
[16:23:20.170] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C0.dat
[16:23:20.170] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C1.dat
[16:23:20.170] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C2.dat
[16:23:20.170] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C3.dat
[16:23:20.170] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C4.dat
[16:23:20.171] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C5.dat
[16:23:20.171] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C6.dat
[16:23:20.171] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C7.dat
[16:23:20.171] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C8.dat
[16:23:20.171] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C9.dat
[16:23:20.171] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C10.dat
[16:23:20.171] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C11.dat
[16:23:20.171] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C12.dat
[16:23:20.172] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C13.dat
[16:23:20.172] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C14.dat
[16:23:20.172] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C15.dat
[16:23:20.172] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C0.dat
[16:23:20.183] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C1.dat
[16:23:20.194] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C2.dat
[16:23:20.205] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C3.dat
[16:23:20.216] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C4.dat
[16:23:20.227] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C5.dat
[16:23:20.237] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C6.dat
[16:23:20.248] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C7.dat
[16:23:20.259] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C8.dat
[16:23:20.270] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C9.dat
[16:23:20.281] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C10.dat
[16:23:20.291] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C11.dat
[16:23:20.302] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C12.dat
[16:23:20.313] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C13.dat
[16:23:20.324] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C14.dat
[16:23:20.335] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//trimParameters35_C15.dat
[16:23:20.345] <TB0> INFO: PixTestTrim::trimTest() done
[16:23:20.345] <TB0> INFO: vtrim: 91 92 94 92 116 93 89 86 128 98 88 85 85 120 109 109
[16:23:20.346] <TB0> INFO: vthrcomp: 91 89 92 90 91 98 104 101 96 98 91 93 91 85 99 93
[16:23:20.346] <TB0> INFO: vcal mean: 34.97 34.97 34.97 34.97 34.90 34.96 35.00 34.89 34.98 34.94 34.98 34.98 34.96 34.95 34.95 34.91
[16:23:20.346] <TB0> INFO: vcal RMS: 0.85 0.83 0.86 0.87 1.02 0.87 0.85 1.14 1.46 1.13 0.88 0.89 0.88 1.53 0.98 1.18
[16:23:20.346] <TB0> INFO: bits mean: 9.17 9.31 9.49 9.17 7.97 9.62 8.19 9.56 9.41 10.05 8.99 9.49 8.77 8.00 9.31 9.27
[16:23:20.346] <TB0> INFO: bits RMS: 2.73 2.54 2.43 2.62 2.18 2.62 2.85 2.78 2.69 2.62 2.49 2.52 2.56 2.17 2.72 2.77
[16:23:20.352] <TB0> INFO: ----------------------------------------------------------------------
[16:23:20.352] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[16:23:20.352] <TB0> INFO: ----------------------------------------------------------------------
[16:23:20.354] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[16:23:20.362] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[16:23:20.362] <TB0> INFO: run 1 of 1
[16:23:20.617] <TB0> INFO: Expecting 4160000 events.
[16:24:00.951] <TB0> INFO: 951695 events read in total (39778ms).
[16:24:40.866] <TB0> INFO: 1899990 events read in total (79694ms).
[16:25:20.663] <TB0> INFO: 2841880 events read in total (119490ms).
[16:26:00.523] <TB0> INFO: 3785650 events read in total (159350ms).
[16:26:16.453] <TB0> INFO: 4160000 events read in total (175280ms).
[16:26:16.484] <TB0> INFO: Test took 176122ms.
[16:26:42.999] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 183 (-1/-1) hits flags = 528 (plus default)
[16:26:43.007] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[16:26:43.007] <TB0> INFO: run 1 of 1
[16:26:43.260] <TB0> INFO: Expecting 3827200 events.
[16:27:23.791] <TB0> INFO: 951170 events read in total (39974ms).
[16:28:03.649] <TB0> INFO: 1899825 events read in total (79832ms).
[16:28:43.742] <TB0> INFO: 2842085 events read in total (119926ms).
[16:29:23.760] <TB0> INFO: 3789990 events read in total (159943ms).
[16:29:25.695] <TB0> INFO: 3827200 events read in total (161878ms).
[16:29:25.724] <TB0> INFO: Test took 162717ms.
[16:29:50.884] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 170 (-1/-1) hits flags = 528 (plus default)
[16:29:50.892] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[16:29:50.892] <TB0> INFO: run 1 of 1
[16:29:51.146] <TB0> INFO: Expecting 3556800 events.
[16:30:32.196] <TB0> INFO: 983900 events read in total (40494ms).
[16:31:12.912] <TB0> INFO: 1963020 events read in total (81210ms).
[16:31:53.388] <TB0> INFO: 2936990 events read in total (121686ms).
[16:32:19.130] <TB0> INFO: 3556800 events read in total (147428ms).
[16:32:19.162] <TB0> INFO: Test took 148270ms.
[16:32:42.930] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 168 (-1/-1) hits flags = 528 (plus default)
[16:32:42.938] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[16:32:42.938] <TB0> INFO: run 1 of 1
[16:32:43.196] <TB0> INFO: Expecting 3515200 events.
[16:33:24.255] <TB0> INFO: 989420 events read in total (40502ms).
[16:34:04.833] <TB0> INFO: 1973850 events read in total (81080ms).
[16:34:45.444] <TB0> INFO: 2953025 events read in total (121691ms).
[16:35:08.793] <TB0> INFO: 3515200 events read in total (145040ms).
[16:35:08.826] <TB0> INFO: Test took 145888ms.
[16:35:32.413] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 169 (-1/-1) hits flags = 528 (plus default)
[16:35:32.421] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[16:35:32.421] <TB0> INFO: run 1 of 1
[16:35:32.677] <TB0> INFO: Expecting 3536000 events.
[16:36:13.660] <TB0> INFO: 986720 events read in total (40427ms).
[16:36:54.082] <TB0> INFO: 1968310 events read in total (80849ms).
[16:37:34.507] <TB0> INFO: 2944285 events read in total (121275ms).
[16:37:59.064] <TB0> INFO: 3536000 events read in total (145831ms).
[16:37:59.095] <TB0> INFO: Test took 146675ms.
[16:38:22.834] <TB0> INFO: PixTestTrim::trimBitTest() done
[16:38:22.835] <TB0> INFO: PixTestTrim::doTest() done, duration: 2883 seconds
[16:38:22.835] <TB0> INFO: Decoding statistics:
[16:38:22.835] <TB0> INFO: General information:
[16:38:22.835] <TB0> INFO: 16bit words read: 0
[16:38:22.835] <TB0> INFO: valid events total: 0
[16:38:22.835] <TB0> INFO: empty events: 0
[16:38:22.835] <TB0> INFO: valid events with pixels: 0
[16:38:22.835] <TB0> INFO: valid pixel hits: 0
[16:38:22.835] <TB0> INFO: Event errors: 0
[16:38:22.835] <TB0> INFO: start marker: 0
[16:38:22.835] <TB0> INFO: stop marker: 0
[16:38:22.835] <TB0> INFO: overflow: 0
[16:38:22.835] <TB0> INFO: invalid 5bit words: 0
[16:38:22.835] <TB0> INFO: invalid XOR eye diagram: 0
[16:38:22.835] <TB0> INFO: frame (failed synchr.): 0
[16:38:22.835] <TB0> INFO: idle data (no TBM trl): 0
[16:38:22.835] <TB0> INFO: no data (only TBM hdr): 0
[16:38:22.835] <TB0> INFO: TBM errors: 0
[16:38:22.835] <TB0> INFO: flawed TBM headers: 0
[16:38:22.835] <TB0> INFO: flawed TBM trailers: 0
[16:38:22.835] <TB0> INFO: event ID mismatches: 0
[16:38:22.835] <TB0> INFO: ROC errors: 0
[16:38:22.835] <TB0> INFO: missing ROC header(s): 0
[16:38:22.835] <TB0> INFO: misplaced readback start: 0
[16:38:22.835] <TB0> INFO: Pixel decoding errors: 0
[16:38:22.835] <TB0> INFO: pixel data incomplete: 0
[16:38:22.835] <TB0> INFO: pixel address: 0
[16:38:22.835] <TB0> INFO: pulse height fill bit: 0
[16:38:22.835] <TB0> INFO: buffer corruption: 0
[16:38:23.491] <TB0> INFO: ######################################################################
[16:38:23.491] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[16:38:23.491] <TB0> INFO: ######################################################################
[16:38:23.745] <TB0> INFO: Expecting 41600 events.
[16:38:27.439] <TB0> INFO: 41600 events read in total (3137ms).
[16:38:27.440] <TB0> INFO: Test took 3948ms.
[16:38:27.899] <TB0> INFO: Expecting 41600 events.
[16:38:31.636] <TB0> INFO: 41600 events read in total (3181ms).
[16:38:31.636] <TB0> INFO: Test took 3990ms.
[16:38:31.913] <TB0> INFO: Expecting 41600 events.
[16:38:35.643] <TB0> INFO: 41600 events read in total (3173ms).
[16:38:35.643] <TB0> INFO: Test took 3986ms.
[16:38:35.898] <TB0> INFO: Expecting 2560 events.
[16:38:36.752] <TB0> INFO: 2560 events read in total (298ms).
[16:38:36.752] <TB0> INFO: Test took 1097ms.
[16:38:37.058] <TB0> INFO: Expecting 2560 events.
[16:38:37.911] <TB0> INFO: 2560 events read in total (297ms).
[16:38:37.911] <TB0> INFO: Test took 1159ms.
[16:38:38.217] <TB0> INFO: Expecting 2560 events.
[16:38:39.069] <TB0> INFO: 2560 events read in total (296ms).
[16:38:39.069] <TB0> INFO: Test took 1158ms.
[16:38:39.375] <TB0> INFO: Expecting 2560 events.
[16:38:40.227] <TB0> INFO: 2560 events read in total (296ms).
[16:38:40.228] <TB0> INFO: Test took 1158ms.
[16:38:40.533] <TB0> INFO: Expecting 2560 events.
[16:38:41.385] <TB0> INFO: 2560 events read in total (296ms).
[16:38:41.385] <TB0> INFO: Test took 1157ms.
[16:38:41.691] <TB0> INFO: Expecting 2560 events.
[16:38:42.543] <TB0> INFO: 2560 events read in total (296ms).
[16:38:42.543] <TB0> INFO: Test took 1157ms.
[16:38:42.848] <TB0> INFO: Expecting 2560 events.
[16:38:43.701] <TB0> INFO: 2560 events read in total (297ms).
[16:38:43.701] <TB0> INFO: Test took 1158ms.
[16:38:44.006] <TB0> INFO: Expecting 2560 events.
[16:38:44.859] <TB0> INFO: 2560 events read in total (297ms).
[16:38:44.859] <TB0> INFO: Test took 1158ms.
[16:38:45.164] <TB0> INFO: Expecting 2560 events.
[16:38:46.017] <TB0> INFO: 2560 events read in total (297ms).
[16:38:46.017] <TB0> INFO: Test took 1158ms.
[16:38:46.322] <TB0> INFO: Expecting 2560 events.
[16:38:47.175] <TB0> INFO: 2560 events read in total (297ms).
[16:38:47.175] <TB0> INFO: Test took 1158ms.
[16:38:47.480] <TB0> INFO: Expecting 2560 events.
[16:38:48.331] <TB0> INFO: 2560 events read in total (295ms).
[16:38:48.331] <TB0> INFO: Test took 1156ms.
[16:38:48.636] <TB0> INFO: Expecting 2560 events.
[16:38:49.489] <TB0> INFO: 2560 events read in total (296ms).
[16:38:49.489] <TB0> INFO: Test took 1158ms.
[16:38:49.794] <TB0> INFO: Expecting 2560 events.
[16:38:50.646] <TB0> INFO: 2560 events read in total (296ms).
[16:38:50.646] <TB0> INFO: Test took 1157ms.
[16:38:50.951] <TB0> INFO: Expecting 2560 events.
[16:38:51.804] <TB0> INFO: 2560 events read in total (297ms).
[16:38:51.804] <TB0> INFO: Test took 1158ms.
[16:38:52.109] <TB0> INFO: Expecting 2560 events.
[16:38:52.960] <TB0> INFO: 2560 events read in total (295ms).
[16:38:52.961] <TB0> INFO: Test took 1157ms.
[16:38:53.266] <TB0> INFO: Expecting 2560 events.
[16:38:54.118] <TB0> INFO: 2560 events read in total (296ms).
[16:38:54.119] <TB0> INFO: Test took 1158ms.
[16:38:54.121] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:38:54.425] <TB0> INFO: Expecting 655360 events.
[16:39:10.884] <TB0> INFO: 655360 events read in total (15903ms).
[16:39:10.892] <TB0> INFO: Expecting 655360 events.
[16:39:27.195] <TB0> INFO: 655360 events read in total (15901ms).
[16:39:27.206] <TB0> INFO: Expecting 655360 events.
[16:39:43.507] <TB0> INFO: 655360 events read in total (15899ms).
[16:39:43.522] <TB0> INFO: Expecting 655360 events.
[16:39:59.855] <TB0> INFO: 655360 events read in total (15931ms).
[16:39:59.872] <TB0> INFO: Expecting 655360 events.
[16:40:16.176] <TB0> INFO: 655360 events read in total (15902ms).
[16:40:16.198] <TB0> INFO: Expecting 655360 events.
[16:40:32.568] <TB0> INFO: 655360 events read in total (15968ms).
[16:40:32.593] <TB0> INFO: Expecting 655360 events.
[16:40:48.938] <TB0> INFO: 655360 events read in total (15943ms).
[16:40:48.965] <TB0> INFO: Expecting 655360 events.
[16:41:05.269] <TB0> INFO: 655360 events read in total (15902ms).
[16:41:05.301] <TB0> INFO: Expecting 655360 events.
[16:41:21.614] <TB0> INFO: 655360 events read in total (15911ms).
[16:41:21.649] <TB0> INFO: Expecting 655360 events.
[16:41:37.964] <TB0> INFO: 655360 events read in total (15913ms).
[16:41:38.001] <TB0> INFO: Expecting 655360 events.
[16:41:54.327] <TB0> INFO: 655360 events read in total (15924ms).
[16:41:54.367] <TB0> INFO: Expecting 655360 events.
[16:42:10.728] <TB0> INFO: 655360 events read in total (15959ms).
[16:42:10.771] <TB0> INFO: Expecting 655360 events.
[16:42:27.082] <TB0> INFO: 655360 events read in total (15909ms).
[16:42:27.129] <TB0> INFO: Expecting 655360 events.
[16:42:43.477] <TB0> INFO: 655360 events read in total (15946ms).
[16:42:43.529] <TB0> INFO: Expecting 655360 events.
[16:42:59.903] <TB0> INFO: 655360 events read in total (15972ms).
[16:42:59.956] <TB0> INFO: Expecting 655360 events.
[16:43:16.285] <TB0> INFO: 655360 events read in total (15927ms).
[16:43:16.343] <TB0> INFO: Test took 262222ms.
[16:43:16.418] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:16.649] <TB0> INFO: Expecting 655360 events.
[16:43:32.979] <TB0> INFO: 655360 events read in total (15774ms).
[16:43:32.987] <TB0> INFO: Expecting 655360 events.
[16:43:49.211] <TB0> INFO: 655360 events read in total (15822ms).
[16:43:49.222] <TB0> INFO: Expecting 655360 events.
[16:44:05.472] <TB0> INFO: 655360 events read in total (15848ms).
[16:44:05.487] <TB0> INFO: Expecting 655360 events.
[16:44:21.743] <TB0> INFO: 655360 events read in total (15854ms).
[16:44:21.762] <TB0> INFO: Expecting 655360 events.
[16:44:38.031] <TB0> INFO: 655360 events read in total (15867ms).
[16:44:38.053] <TB0> INFO: Expecting 655360 events.
[16:44:54.274] <TB0> INFO: 655360 events read in total (15819ms).
[16:44:54.299] <TB0> INFO: Expecting 655360 events.
[16:45:10.592] <TB0> INFO: 655360 events read in total (15891ms).
[16:45:10.619] <TB0> INFO: Expecting 655360 events.
[16:45:26.956] <TB0> INFO: 655360 events read in total (15935ms).
[16:45:26.987] <TB0> INFO: Expecting 655360 events.
[16:45:43.199] <TB0> INFO: 655360 events read in total (15810ms).
[16:45:43.233] <TB0> INFO: Expecting 655360 events.
[16:45:59.304] <TB0> INFO: 655360 events read in total (15669ms).
[16:45:59.341] <TB0> INFO: Expecting 655360 events.
[16:46:15.563] <TB0> INFO: 655360 events read in total (15820ms).
[16:46:15.604] <TB0> INFO: Expecting 655360 events.
[16:46:31.901] <TB0> INFO: 655360 events read in total (15895ms).
[16:46:31.944] <TB0> INFO: Expecting 655360 events.
[16:46:47.963] <TB0> INFO: 655360 events read in total (15617ms).
[16:46:48.010] <TB0> INFO: Expecting 655360 events.
[16:47:03.918] <TB0> INFO: 655360 events read in total (15506ms).
[16:47:03.968] <TB0> INFO: Expecting 655360 events.
[16:47:20.245] <TB0> INFO: 655360 events read in total (15875ms).
[16:47:20.300] <TB0> INFO: Expecting 655360 events.
[16:47:36.513] <TB0> INFO: 655360 events read in total (15811ms).
[16:47:36.571] <TB0> INFO: Test took 260153ms.
[16:47:36.748] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.754] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.761] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.767] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.773] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.780] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.786] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.792] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.799] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.805] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.812] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.818] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[16:47:36.824] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[16:47:36.831] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[16:47:36.837] <TB0> INFO: safety margin for low PH: adding 4, margin is now 24
[16:47:36.843] <TB0> INFO: safety margin for low PH: adding 5, margin is now 25
[16:47:36.850] <TB0> INFO: safety margin for low PH: adding 6, margin is now 26
[16:47:36.856] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.862] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.869] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.875] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.881] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[16:47:36.917] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C0.dat
[16:47:36.917] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C1.dat
[16:47:36.917] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C2.dat
[16:47:36.917] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C3.dat
[16:47:36.917] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C4.dat
[16:47:36.917] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C5.dat
[16:47:36.918] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C6.dat
[16:47:36.918] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C7.dat
[16:47:36.918] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C8.dat
[16:47:36.918] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C9.dat
[16:47:36.918] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C10.dat
[16:47:36.918] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C11.dat
[16:47:36.918] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C12.dat
[16:47:36.918] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C13.dat
[16:47:36.919] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C14.dat
[16:47:36.919] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//dacParameters35_C15.dat
[16:47:37.173] <TB0> INFO: Expecting 41600 events.
[16:47:40.617] <TB0> INFO: 41600 events read in total (2888ms).
[16:47:40.618] <TB0> INFO: Test took 3697ms.
[16:47:41.055] <TB0> INFO: Expecting 41600 events.
[16:47:44.420] <TB0> INFO: 41600 events read in total (2809ms).
[16:47:44.420] <TB0> INFO: Test took 3624ms.
[16:47:44.849] <TB0> INFO: Expecting 41600 events.
[16:47:48.278] <TB0> INFO: 41600 events read in total (2872ms).
[16:47:48.278] <TB0> INFO: Test took 3680ms.
[16:47:48.460] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:48.548] <TB0> INFO: Expecting 2560 events.
[16:47:49.400] <TB0> INFO: 2560 events read in total (296ms).
[16:47:49.400] <TB0> INFO: Test took 940ms.
[16:47:49.402] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:49.706] <TB0> INFO: Expecting 2560 events.
[16:47:50.559] <TB0> INFO: 2560 events read in total (297ms).
[16:47:50.559] <TB0> INFO: Test took 1157ms.
[16:47:50.561] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:50.865] <TB0> INFO: Expecting 2560 events.
[16:47:51.717] <TB0> INFO: 2560 events read in total (296ms).
[16:47:51.717] <TB0> INFO: Test took 1156ms.
[16:47:51.719] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:52.023] <TB0> INFO: Expecting 2560 events.
[16:47:52.875] <TB0> INFO: 2560 events read in total (296ms).
[16:47:52.875] <TB0> INFO: Test took 1156ms.
[16:47:52.877] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:53.181] <TB0> INFO: Expecting 2560 events.
[16:47:54.033] <TB0> INFO: 2560 events read in total (296ms).
[16:47:54.033] <TB0> INFO: Test took 1156ms.
[16:47:54.035] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:54.339] <TB0> INFO: Expecting 2560 events.
[16:47:55.192] <TB0> INFO: 2560 events read in total (297ms).
[16:47:55.192] <TB0> INFO: Test took 1157ms.
[16:47:55.194] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:55.498] <TB0> INFO: Expecting 2560 events.
[16:47:56.351] <TB0> INFO: 2560 events read in total (297ms).
[16:47:56.351] <TB0> INFO: Test took 1157ms.
[16:47:56.353] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:56.657] <TB0> INFO: Expecting 2560 events.
[16:47:57.510] <TB0> INFO: 2560 events read in total (297ms).
[16:47:57.510] <TB0> INFO: Test took 1157ms.
[16:47:57.511] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:57.816] <TB0> INFO: Expecting 2560 events.
[16:47:58.669] <TB0> INFO: 2560 events read in total (297ms).
[16:47:58.669] <TB0> INFO: Test took 1158ms.
[16:47:58.670] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:47:58.975] <TB0> INFO: Expecting 2560 events.
[16:47:59.828] <TB0> INFO: 2560 events read in total (297ms).
[16:47:59.828] <TB0> INFO: Test took 1158ms.
[16:47:59.829] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:00.134] <TB0> INFO: Expecting 2560 events.
[16:48:00.987] <TB0> INFO: 2560 events read in total (297ms).
[16:48:00.987] <TB0> INFO: Test took 1158ms.
[16:48:00.988] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:01.293] <TB0> INFO: Expecting 2560 events.
[16:48:02.145] <TB0> INFO: 2560 events read in total (296ms).
[16:48:02.146] <TB0> INFO: Test took 1158ms.
[16:48:02.147] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:02.451] <TB0> INFO: Expecting 2560 events.
[16:48:03.304] <TB0> INFO: 2560 events read in total (296ms).
[16:48:03.305] <TB0> INFO: Test took 1158ms.
[16:48:03.306] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:03.610] <TB0> INFO: Expecting 2560 events.
[16:48:04.463] <TB0> INFO: 2560 events read in total (296ms).
[16:48:04.463] <TB0> INFO: Test took 1157ms.
[16:48:04.465] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:04.769] <TB0> INFO: Expecting 2560 events.
[16:48:05.622] <TB0> INFO: 2560 events read in total (296ms).
[16:48:05.623] <TB0> INFO: Test took 1158ms.
[16:48:05.624] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:05.929] <TB0> INFO: Expecting 2560 events.
[16:48:06.783] <TB0> INFO: 2560 events read in total (298ms).
[16:48:06.783] <TB0> INFO: Test took 1159ms.
[16:48:06.784] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:07.090] <TB0> INFO: Expecting 2560 events.
[16:48:07.942] <TB0> INFO: 2560 events read in total (296ms).
[16:48:07.942] <TB0> INFO: Test took 1158ms.
[16:48:07.944] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:08.248] <TB0> INFO: Expecting 2560 events.
[16:48:09.101] <TB0> INFO: 2560 events read in total (296ms).
[16:48:09.101] <TB0> INFO: Test took 1157ms.
[16:48:09.103] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:09.407] <TB0> INFO: Expecting 2560 events.
[16:48:10.260] <TB0> INFO: 2560 events read in total (296ms).
[16:48:10.260] <TB0> INFO: Test took 1157ms.
[16:48:10.262] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:10.566] <TB0> INFO: Expecting 2560 events.
[16:48:11.419] <TB0> INFO: 2560 events read in total (296ms).
[16:48:11.419] <TB0> INFO: Test took 1157ms.
[16:48:11.421] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:11.725] <TB0> INFO: Expecting 2560 events.
[16:48:12.578] <TB0> INFO: 2560 events read in total (297ms).
[16:48:12.578] <TB0> INFO: Test took 1157ms.
[16:48:12.580] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:12.884] <TB0> INFO: Expecting 2560 events.
[16:48:13.737] <TB0> INFO: 2560 events read in total (297ms).
[16:48:13.737] <TB0> INFO: Test took 1157ms.
[16:48:13.739] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:14.043] <TB0> INFO: Expecting 2560 events.
[16:48:14.896] <TB0> INFO: 2560 events read in total (297ms).
[16:48:14.896] <TB0> INFO: Test took 1157ms.
[16:48:14.898] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:15.202] <TB0> INFO: Expecting 2560 events.
[16:48:16.055] <TB0> INFO: 2560 events read in total (297ms).
[16:48:16.055] <TB0> INFO: Test took 1157ms.
[16:48:16.057] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:16.361] <TB0> INFO: Expecting 2560 events.
[16:48:17.214] <TB0> INFO: 2560 events read in total (297ms).
[16:48:17.214] <TB0> INFO: Test took 1158ms.
[16:48:17.216] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:17.520] <TB0> INFO: Expecting 2560 events.
[16:48:18.373] <TB0> INFO: 2560 events read in total (297ms).
[16:48:18.373] <TB0> INFO: Test took 1158ms.
[16:48:18.374] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:18.679] <TB0> INFO: Expecting 2560 events.
[16:48:19.532] <TB0> INFO: 2560 events read in total (297ms).
[16:48:19.532] <TB0> INFO: Test took 1158ms.
[16:48:19.533] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:19.838] <TB0> INFO: Expecting 2560 events.
[16:48:20.690] <TB0> INFO: 2560 events read in total (296ms).
[16:48:20.691] <TB0> INFO: Test took 1158ms.
[16:48:20.692] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:20.996] <TB0> INFO: Expecting 2560 events.
[16:48:21.849] <TB0> INFO: 2560 events read in total (296ms).
[16:48:21.850] <TB0> INFO: Test took 1158ms.
[16:48:21.851] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:22.155] <TB0> INFO: Expecting 2560 events.
[16:48:23.008] <TB0> INFO: 2560 events read in total (297ms).
[16:48:23.008] <TB0> INFO: Test took 1157ms.
[16:48:23.010] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:23.314] <TB0> INFO: Expecting 2560 events.
[16:48:24.167] <TB0> INFO: 2560 events read in total (297ms).
[16:48:24.167] <TB0> INFO: Test took 1157ms.
[16:48:24.169] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:48:24.473] <TB0> INFO: Expecting 2560 events.
[16:48:25.326] <TB0> INFO: 2560 events read in total (297ms).
[16:48:25.326] <TB0> INFO: Test took 1157ms.
[16:48:25.805] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 602 seconds
[16:48:25.805] <TB0> INFO: PH scale (per ROC): 79 67 73 67 62 73 70 73 69 65 68 66 60 57 68 63
[16:48:25.805] <TB0> INFO: PH offset (per ROC): 162 188 174 177 207 167 176 181 184 181 176 170 165 177 188 173
[16:48:25.809] <TB0> INFO: Decoding statistics:
[16:48:25.809] <TB0> INFO: General information:
[16:48:25.809] <TB0> INFO: 16bit words read: 91952
[16:48:25.809] <TB0> INFO: valid events total: 10240
[16:48:25.809] <TB0> INFO: empty events: 7732
[16:48:25.809] <TB0> INFO: valid events with pixels: 2508
[16:48:25.809] <TB0> INFO: valid pixel hits: 2508
[16:48:25.809] <TB0> INFO: Event errors: 0
[16:48:25.809] <TB0> INFO: start marker: 0
[16:48:25.809] <TB0> INFO: stop marker: 0
[16:48:25.809] <TB0> INFO: overflow: 0
[16:48:25.809] <TB0> INFO: invalid 5bit words: 0
[16:48:25.809] <TB0> INFO: invalid XOR eye diagram: 0
[16:48:25.809] <TB0> INFO: frame (failed synchr.): 0
[16:48:25.809] <TB0> INFO: idle data (no TBM trl): 0
[16:48:25.809] <TB0> INFO: no data (only TBM hdr): 0
[16:48:25.809] <TB0> INFO: TBM errors: 0
[16:48:25.809] <TB0> INFO: flawed TBM headers: 0
[16:48:25.809] <TB0> INFO: flawed TBM trailers: 0
[16:48:25.809] <TB0> INFO: event ID mismatches: 0
[16:48:25.809] <TB0> INFO: ROC errors: 0
[16:48:25.809] <TB0> INFO: missing ROC header(s): 0
[16:48:25.809] <TB0> INFO: misplaced readback start: 0
[16:48:25.809] <TB0> INFO: Pixel decoding errors: 0
[16:48:25.809] <TB0> INFO: pixel data incomplete: 0
[16:48:25.809] <TB0> INFO: pixel address: 0
[16:48:25.809] <TB0> INFO: pulse height fill bit: 0
[16:48:25.809] <TB0> INFO: buffer corruption: 0
[16:48:25.975] <TB0> INFO: ######################################################################
[16:48:25.975] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[16:48:25.975] <TB0> INFO: ######################################################################
[16:48:25.984] <TB0> INFO: scanning low vcal = 10
[16:48:26.238] <TB0> INFO: Expecting 41600 events.
[16:48:29.759] <TB0> INFO: 41600 events read in total (2965ms).
[16:48:29.759] <TB0> INFO: Test took 3774ms.
[16:48:29.760] <TB0> INFO: scanning low vcal = 20
[16:48:30.064] <TB0> INFO: Expecting 41600 events.
[16:48:33.596] <TB0> INFO: 41600 events read in total (2976ms).
[16:48:33.597] <TB0> INFO: Test took 3837ms.
[16:48:33.598] <TB0> INFO: scanning low vcal = 30
[16:48:33.902] <TB0> INFO: Expecting 41600 events.
[16:48:37.453] <TB0> INFO: 41600 events read in total (2995ms).
[16:48:37.454] <TB0> INFO: Test took 3856ms.
[16:48:37.456] <TB0> INFO: scanning low vcal = 40
[16:48:37.749] <TB0> INFO: Expecting 41600 events.
[16:48:41.830] <TB0> INFO: 41600 events read in total (3525ms).
[16:48:41.831] <TB0> INFO: Test took 4375ms.
[16:48:41.834] <TB0> INFO: scanning low vcal = 50
[16:48:42.086] <TB0> INFO: Expecting 41600 events.
[16:48:46.277] <TB0> INFO: 41600 events read in total (3635ms).
[16:48:46.278] <TB0> INFO: Test took 4444ms.
[16:48:46.280] <TB0> INFO: scanning low vcal = 60
[16:48:46.532] <TB0> INFO: Expecting 41600 events.
[16:48:50.689] <TB0> INFO: 41600 events read in total (3601ms).
[16:48:50.689] <TB0> INFO: Test took 4409ms.
[16:48:50.692] <TB0> INFO: scanning low vcal = 70
[16:48:50.947] <TB0> INFO: Expecting 41600 events.
[16:48:55.097] <TB0> INFO: 41600 events read in total (3594ms).
[16:48:55.097] <TB0> INFO: Test took 4405ms.
[16:48:55.100] <TB0> INFO: scanning low vcal = 80
[16:48:55.351] <TB0> INFO: Expecting 41600 events.
[16:48:59.503] <TB0> INFO: 41600 events read in total (3595ms).
[16:48:59.503] <TB0> INFO: Test took 4403ms.
[16:48:59.506] <TB0> INFO: scanning low vcal = 90
[16:48:59.759] <TB0> INFO: Expecting 41600 events.
[16:49:03.911] <TB0> INFO: 41600 events read in total (3596ms).
[16:49:03.912] <TB0> INFO: Test took 4406ms.
[16:49:03.915] <TB0> INFO: scanning low vcal = 100
[16:49:04.167] <TB0> INFO: Expecting 41600 events.
[16:49:08.321] <TB0> INFO: 41600 events read in total (3598ms).
[16:49:08.321] <TB0> INFO: Test took 4406ms.
[16:49:08.324] <TB0> INFO: scanning low vcal = 110
[16:49:08.579] <TB0> INFO: Expecting 41600 events.
[16:49:12.728] <TB0> INFO: 41600 events read in total (3593ms).
[16:49:12.729] <TB0> INFO: Test took 4405ms.
[16:49:12.731] <TB0> INFO: scanning low vcal = 120
[16:49:12.984] <TB0> INFO: Expecting 41600 events.
[16:49:17.134] <TB0> INFO: 41600 events read in total (3594ms).
[16:49:17.135] <TB0> INFO: Test took 4403ms.
[16:49:17.140] <TB0> INFO: scanning low vcal = 130
[16:49:17.395] <TB0> INFO: Expecting 41600 events.
[16:49:21.544] <TB0> INFO: 41600 events read in total (3593ms).
[16:49:21.545] <TB0> INFO: Test took 4404ms.
[16:49:21.547] <TB0> INFO: scanning low vcal = 140
[16:49:21.800] <TB0> INFO: Expecting 41600 events.
[16:49:25.949] <TB0> INFO: 41600 events read in total (3593ms).
[16:49:25.949] <TB0> INFO: Test took 4402ms.
[16:49:25.951] <TB0> INFO: scanning low vcal = 150
[16:49:26.205] <TB0> INFO: Expecting 41600 events.
[16:49:30.356] <TB0> INFO: 41600 events read in total (3595ms).
[16:49:30.356] <TB0> INFO: Test took 4404ms.
[16:49:30.359] <TB0> INFO: scanning low vcal = 160
[16:49:30.611] <TB0> INFO: Expecting 41600 events.
[16:49:34.768] <TB0> INFO: 41600 events read in total (3600ms).
[16:49:34.768] <TB0> INFO: Test took 4409ms.
[16:49:34.771] <TB0> INFO: scanning low vcal = 170
[16:49:35.024] <TB0> INFO: Expecting 41600 events.
[16:49:39.186] <TB0> INFO: 41600 events read in total (3606ms).
[16:49:39.187] <TB0> INFO: Test took 4416ms.
[16:49:39.190] <TB0> INFO: scanning low vcal = 180
[16:49:39.446] <TB0> INFO: Expecting 41600 events.
[16:49:43.597] <TB0> INFO: 41600 events read in total (3595ms).
[16:49:43.598] <TB0> INFO: Test took 4407ms.
[16:49:43.600] <TB0> INFO: scanning low vcal = 190
[16:49:43.855] <TB0> INFO: Expecting 41600 events.
[16:49:48.007] <TB0> INFO: 41600 events read in total (3597ms).
[16:49:48.008] <TB0> INFO: Test took 4408ms.
[16:49:48.011] <TB0> INFO: scanning low vcal = 200
[16:49:48.264] <TB0> INFO: Expecting 41600 events.
[16:49:52.416] <TB0> INFO: 41600 events read in total (3595ms).
[16:49:52.416] <TB0> INFO: Test took 4405ms.
[16:49:52.419] <TB0> INFO: scanning low vcal = 210
[16:49:52.673] <TB0> INFO: Expecting 41600 events.
[16:49:56.823] <TB0> INFO: 41600 events read in total (3594ms).
[16:49:56.824] <TB0> INFO: Test took 4405ms.
[16:49:56.826] <TB0> INFO: scanning low vcal = 220
[16:49:57.079] <TB0> INFO: Expecting 41600 events.
[16:50:01.230] <TB0> INFO: 41600 events read in total (3594ms).
[16:50:01.231] <TB0> INFO: Test took 4405ms.
[16:50:01.233] <TB0> INFO: scanning low vcal = 230
[16:50:01.491] <TB0> INFO: Expecting 41600 events.
[16:50:05.642] <TB0> INFO: 41600 events read in total (3595ms).
[16:50:05.643] <TB0> INFO: Test took 4409ms.
[16:50:05.645] <TB0> INFO: scanning low vcal = 240
[16:50:05.898] <TB0> INFO: Expecting 41600 events.
[16:50:10.050] <TB0> INFO: 41600 events read in total (3595ms).
[16:50:10.050] <TB0> INFO: Test took 4404ms.
[16:50:10.053] <TB0> INFO: scanning low vcal = 250
[16:50:10.308] <TB0> INFO: Expecting 41600 events.
[16:50:14.457] <TB0> INFO: 41600 events read in total (3593ms).
[16:50:14.457] <TB0> INFO: Test took 4404ms.
[16:50:14.461] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[16:50:14.715] <TB0> INFO: Expecting 41600 events.
[16:50:18.864] <TB0> INFO: 41600 events read in total (3593ms).
[16:50:18.865] <TB0> INFO: Test took 4404ms.
[16:50:18.867] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[16:50:19.121] <TB0> INFO: Expecting 41600 events.
[16:50:23.274] <TB0> INFO: 41600 events read in total (3597ms).
[16:50:23.274] <TB0> INFO: Test took 4406ms.
[16:50:23.277] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[16:50:23.531] <TB0> INFO: Expecting 41600 events.
[16:50:27.680] <TB0> INFO: 41600 events read in total (3593ms).
[16:50:27.681] <TB0> INFO: Test took 4404ms.
[16:50:27.684] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[16:50:27.936] <TB0> INFO: Expecting 41600 events.
[16:50:32.086] <TB0> INFO: 41600 events read in total (3594ms).
[16:50:32.087] <TB0> INFO: Test took 4403ms.
[16:50:32.090] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[16:50:32.342] <TB0> INFO: Expecting 41600 events.
[16:50:36.494] <TB0> INFO: 41600 events read in total (3596ms).
[16:50:36.494] <TB0> INFO: Test took 4404ms.
[16:50:37.026] <TB0> INFO: PixTestGainPedestal::measure() done
[16:51:08.096] <TB0> INFO: PixTestGainPedestal::fit() done
[16:51:08.096] <TB0> INFO: non-linearity mean: 0.966 0.956 0.961 0.960 0.961 0.960 0.958 0.958 0.955 0.946 0.955 0.953 0.953 0.956 0.957 0.953
[16:51:08.096] <TB0> INFO: non-linearity RMS: 0.006 0.007 0.006 0.006 0.009 0.007 0.007 0.007 0.008 0.009 0.006 0.008 0.007 0.007 0.008 0.008
[16:51:08.096] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[16:51:08.121] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[16:51:08.146] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[16:51:08.171] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[16:51:08.197] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[16:51:08.222] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[16:51:08.248] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[16:51:08.273] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[16:51:08.298] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[16:51:08.323] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[16:51:08.351] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[16:51:08.376] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[16:51:08.401] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[16:51:08.426] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[16:51:08.452] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[16:51:08.477] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[16:51:08.502] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 162 seconds
[16:51:08.502] <TB0> INFO: Decoding statistics:
[16:51:08.502] <TB0> INFO: General information:
[16:51:08.502] <TB0> INFO: 16bit words read: 2662392
[16:51:08.502] <TB0> INFO: valid events total: 166400
[16:51:08.502] <TB0> INFO: empty events: 0
[16:51:08.502] <TB0> INFO: valid events with pixels: 166400
[16:51:08.502] <TB0> INFO: valid pixel hits: 665262
[16:51:08.502] <TB0> INFO: Event errors: 0
[16:51:08.502] <TB0> INFO: start marker: 0
[16:51:08.502] <TB0> INFO: stop marker: 0
[16:51:08.502] <TB0> INFO: overflow: 0
[16:51:08.502] <TB0> INFO: invalid 5bit words: 0
[16:51:08.502] <TB0> INFO: invalid XOR eye diagram: 0
[16:51:08.502] <TB0> INFO: frame (failed synchr.): 0
[16:51:08.502] <TB0> INFO: idle data (no TBM trl): 0
[16:51:08.502] <TB0> INFO: no data (only TBM hdr): 0
[16:51:08.502] <TB0> INFO: TBM errors: 0
[16:51:08.502] <TB0> INFO: flawed TBM headers: 0
[16:51:08.502] <TB0> INFO: flawed TBM trailers: 0
[16:51:08.502] <TB0> INFO: event ID mismatches: 0
[16:51:08.502] <TB0> INFO: ROC errors: 0
[16:51:08.502] <TB0> INFO: missing ROC header(s): 0
[16:51:08.502] <TB0> INFO: misplaced readback start: 0
[16:51:08.502] <TB0> INFO: Pixel decoding errors: 0
[16:51:08.502] <TB0> INFO: pixel data incomplete: 0
[16:51:08.502] <TB0> INFO: pixel address: 0
[16:51:08.502] <TB0> INFO: pulse height fill bit: 0
[16:51:08.502] <TB0> INFO: buffer corruption: 0
[16:51:08.511] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C15.dat
[16:51:08.512] <TB0> INFO: ######################################################################
[16:51:08.512] <TB0> INFO: PixTestReadback::doTest()
[16:51:08.512] <TB0> INFO: ######################################################################
[16:51:08.512] <TB0> INFO: ----------------------------------------------------------------------
[16:51:08.512] <TB0> INFO: PixTestReadback::CalibrateVd()
[16:51:08.512] <TB0> INFO: ----------------------------------------------------------------------
[16:51:18.004] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C0.dat
[16:51:18.004] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C1.dat
[16:51:18.004] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C2.dat
[16:51:18.004] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C3.dat
[16:51:18.004] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C4.dat
[16:51:18.004] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C5.dat
[16:51:18.004] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C6.dat
[16:51:18.005] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C7.dat
[16:51:18.005] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C8.dat
[16:51:18.005] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C9.dat
[16:51:18.005] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C10.dat
[16:51:18.005] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C11.dat
[16:51:18.005] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C12.dat
[16:51:18.005] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C13.dat
[16:51:18.005] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C14.dat
[16:51:18.006] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C15.dat
[16:51:18.033] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[16:51:18.033] <TB0> INFO: ----------------------------------------------------------------------
[16:51:18.033] <TB0> INFO: PixTestReadback::CalibrateVa()
[16:51:18.033] <TB0> INFO: ----------------------------------------------------------------------
[16:51:27.523] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C0.dat
[16:51:27.523] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C1.dat
[16:51:27.523] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C2.dat
[16:51:27.523] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C3.dat
[16:51:27.523] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C4.dat
[16:51:27.523] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C5.dat
[16:51:27.524] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C6.dat
[16:51:27.524] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C7.dat
[16:51:27.524] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C8.dat
[16:51:27.524] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C9.dat
[16:51:27.524] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C10.dat
[16:51:27.524] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C11.dat
[16:51:27.524] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C12.dat
[16:51:27.524] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C13.dat
[16:51:27.525] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C14.dat
[16:51:27.525] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C15.dat
[16:51:27.553] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[16:51:27.553] <TB0> INFO: ----------------------------------------------------------------------
[16:51:27.553] <TB0> INFO: PixTestReadback::readbackVbg()
[16:51:27.553] <TB0> INFO: ----------------------------------------------------------------------
[16:51:34.847] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[16:51:34.847] <TB0> INFO: ----------------------------------------------------------------------
[16:51:34.847] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[16:51:34.847] <TB0> INFO: ----------------------------------------------------------------------
[16:51:34.847] <TB0> INFO: Vbg will be calibrated using Vd calibration
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 146.8calibrated Vbg = 1.22771 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 141.8calibrated Vbg = 1.23741 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 143.1calibrated Vbg = 1.22442 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 146.6calibrated Vbg = 1.24298 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 149.9calibrated Vbg = 1.24315 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 152calibrated Vbg = 1.24094 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 147.1calibrated Vbg = 1.24601 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 150.3calibrated Vbg = 1.244 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 154.4calibrated Vbg = 1.24033 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 158.8calibrated Vbg = 1.24239 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 145.8calibrated Vbg = 1.2417 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 141.9calibrated Vbg = 1.23316 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 143.1calibrated Vbg = 1.23193 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 147.8calibrated Vbg = 1.23313 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 149.6calibrated Vbg = 1.22781 :::*/*/*/*/
[16:51:34.847] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 151.3calibrated Vbg = 1.22976 :::*/*/*/*/
[16:51:34.849] <TB0> INFO: ----------------------------------------------------------------------
[16:51:34.849] <TB0> INFO: PixTestReadback::CalibrateIa()
[16:51:34.849] <TB0> INFO: ----------------------------------------------------------------------
[16:54:09.981] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C0.dat
[16:54:09.981] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C1.dat
[16:54:09.981] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C2.dat
[16:54:09.981] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C3.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C4.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C5.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C6.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C7.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C8.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C9.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C10.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C11.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C12.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C13.dat
[16:54:09.982] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C14.dat
[16:54:09.983] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2270_FullQualification_2016-06-30_12h11m_1467281482//004_FulltestPxar_p17//readbackCal_C15.dat
[16:54:10.010] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[16:54:10.010] <TB0> INFO: PixTestReadback::doTest() done
[16:54:10.011] <TB0> INFO: Decoding statistics:
[16:54:10.011] <TB0> INFO: General information:
[16:54:10.011] <TB0> INFO: 16bit words read: 1024
[16:54:10.011] <TB0> INFO: valid events total: 128
[16:54:10.011] <TB0> INFO: empty events: 128
[16:54:10.011] <TB0> INFO: valid events with pixels: 0
[16:54:10.011] <TB0> INFO: valid pixel hits: 0
[16:54:10.011] <TB0> INFO: Event errors: 0
[16:54:10.011] <TB0> INFO: start marker: 0
[16:54:10.011] <TB0> INFO: stop marker: 0
[16:54:10.011] <TB0> INFO: overflow: 0
[16:54:10.011] <TB0> INFO: invalid 5bit words: 0
[16:54:10.011] <TB0> INFO: invalid XOR eye diagram: 0
[16:54:10.011] <TB0> INFO: frame (failed synchr.): 0
[16:54:10.011] <TB0> INFO: idle data (no TBM trl): 0
[16:54:10.011] <TB0> INFO: no data (only TBM hdr): 0
[16:54:10.011] <TB0> INFO: TBM errors: 0
[16:54:10.011] <TB0> INFO: flawed TBM headers: 0
[16:54:10.011] <TB0> INFO: flawed TBM trailers: 0
[16:54:10.011] <TB0> INFO: event ID mismatches: 0
[16:54:10.011] <TB0> INFO: ROC errors: 0
[16:54:10.011] <TB0> INFO: missing ROC header(s): 0
[16:54:10.011] <TB0> INFO: misplaced readback start: 0
[16:54:10.011] <TB0> INFO: Pixel decoding errors: 0
[16:54:10.011] <TB0> INFO: pixel data incomplete: 0
[16:54:10.011] <TB0> INFO: pixel address: 0
[16:54:10.011] <TB0> INFO: pulse height fill bit: 0
[16:54:10.011] <TB0> INFO: buffer corruption: 0
[16:54:10.033] <TB0> INFO: Decoding statistics:
[16:54:10.033] <TB0> INFO: General information:
[16:54:10.033] <TB0> INFO: 16bit words read: 2755368
[16:54:10.033] <TB0> INFO: valid events total: 176768
[16:54:10.033] <TB0> INFO: empty events: 7860
[16:54:10.033] <TB0> INFO: valid events with pixels: 168908
[16:54:10.033] <TB0> INFO: valid pixel hits: 667770
[16:54:10.033] <TB0> INFO: Event errors: 0
[16:54:10.033] <TB0> INFO: start marker: 0
[16:54:10.033] <TB0> INFO: stop marker: 0
[16:54:10.033] <TB0> INFO: overflow: 0
[16:54:10.033] <TB0> INFO: invalid 5bit words: 0
[16:54:10.033] <TB0> INFO: invalid XOR eye diagram: 0
[16:54:10.033] <TB0> INFO: frame (failed synchr.): 0
[16:54:10.033] <TB0> INFO: idle data (no TBM trl): 0
[16:54:10.033] <TB0> INFO: no data (only TBM hdr): 0
[16:54:10.033] <TB0> INFO: TBM errors: 0
[16:54:10.033] <TB0> INFO: flawed TBM headers: 0
[16:54:10.033] <TB0> INFO: flawed TBM trailers: 0
[16:54:10.033] <TB0> INFO: event ID mismatches: 0
[16:54:10.033] <TB0> INFO: ROC errors: 0
[16:54:10.033] <TB0> INFO: missing ROC header(s): 0
[16:54:10.033] <TB0> INFO: misplaced readback start: 0
[16:54:10.033] <TB0> INFO: Pixel decoding errors: 0
[16:54:10.033] <TB0> INFO: pixel data incomplete: 0
[16:54:10.033] <TB0> INFO: pixel address: 0
[16:54:10.033] <TB0> INFO: pulse height fill bit: 0
[16:54:10.033] <TB0> INFO: buffer corruption: 0
[16:54:10.033] <TB0> INFO: enter test to run
[16:54:10.033] <TB0> INFO: test: exit no parameter change
[16:54:10.220] <TB0> QUIET: Connection to board 73 closed.
[16:54:10.300] <TB0> INFO: pXar: this is the end, my friend