[17:05:11.336] <TB2> INFO: *** Welcome to pxar ***
[17:05:11.336] <TB2> INFO: *** Today: 2016/08/31
[17:05:11.453] <TB2> INFO: *** Version: fe94
[17:05:11.453] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C15.dat
[17:05:11.454] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//tbmParameters_C0b.dat
[17:05:11.454] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//defaultMaskFile.dat
[17:05:11.454] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters_C15.dat
[17:05:11.530] <TB2> INFO: clk: 4
[17:05:11.530] <TB2> INFO: ctr: 4
[17:05:11.530] <TB2> INFO: sda: 19
[17:05:11.530] <TB2> INFO: tin: 9
[17:05:11.530] <TB2> INFO: level: 15
[17:05:11.530] <TB2> INFO: triggerdelay: 0
[17:05:11.530] <TB2> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[17:05:11.531] <TB2> INFO: Log level: INFO
[17:05:11.536] <TB2> INFO: Found DTB DTB_WXC55Z
[17:05:11.544] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[17:05:11.546] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[17:05:11.548] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[17:05:13.081] <TB2> INFO: DUT info:
[17:05:13.081] <TB2> INFO: The DUT currently contains the following objects:
[17:05:13.081] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[17:05:13.081] <TB2> INFO: TBM Core alpha (0): 7 registers set
[17:05:13.081] <TB2> INFO: TBM Core beta (1): 7 registers set
[17:05:13.081] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[17:05:13.081] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.081] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.082] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.082] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.082] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.082] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[17:05:13.483] <TB2> INFO: enter 'restricted' command line mode
[17:05:13.483] <TB2> INFO: enter test to run
[17:05:13.483] <TB2> INFO: test: pretest no parameter change
[17:05:13.483] <TB2> INFO: running: pretest
[17:05:13.491] <TB2> INFO: ----------------------------------------------------------------------
[17:05:13.491] <TB2> INFO: PixTestPretest::programROC()
[17:05:13.491] <TB2> INFO: ----------------------------------------------------------------------
[17:05:31.505] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[17:05:31.505] <TB2> INFO: IA differences per ROC: 19.3 18.5 18.5 18.5 17.7 16.9 17.7 16.9 18.5 18.5 17.7 16.9 19.3 20.1 20.1 18.5
[17:05:31.598] <TB2> INFO: enter test to run
[17:05:31.598] <TB2> INFO: test: pretest no parameter change
[17:05:31.598] <TB2> INFO: running: pretest
[17:05:31.599] <TB2> INFO: ----------------------------------------------------------------------
[17:05:31.599] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[17:05:31.599] <TB2> INFO: ----------------------------------------------------------------------
[17:05:52.883] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 402 mA = 25.125 mA/ROC
[17:05:52.883] <TB2> INFO: i(loss) [mA/ROC]: 20.1 19.2 19.2 19.2 19.2 20.1 19.2 18.4 20.1 20.1 21.7 17.6 19.2 19.2 19.2 19.2
[17:05:52.917] <TB2> INFO: enter test to run
[17:05:52.918] <TB2> INFO: test: pretest no parameter change
[17:05:52.918] <TB2> INFO: running: pretest
[17:05:52.918] <TB2> INFO: ----------------------------------------------------------------------
[17:05:52.918] <TB2> INFO: PixTestPretest::findTiming()
[17:05:52.918] <TB2> INFO: ----------------------------------------------------------------------
[17:05:52.918] <TB2> INFO: PixTestCmd::init()
[17:05:53.439] <TB2> WARNING: Not unmasking DUT, not setting Calibrate bits!
[17:07:22.475] <TB2> INFO: TBM phases: 160MHz: 7, 400MHz: 2, TBM delays: ROC(0/1):4, header/trailer: 1, token: 1
[17:07:22.475] <TB2> INFO: (success/tries = 100/100), width = 5
[17:07:22.478] <TB2> INFO: enter test to run
[17:07:22.478] <TB2> INFO: test: pretest no parameter change
[17:07:22.478] <TB2> INFO: running: pretest
[17:07:22.480] <TB2> INFO: ----------------------------------------------------------------------
[17:07:22.480] <TB2> INFO: PixTestPretest::findWorkingPixel()
[17:07:22.480] <TB2> INFO: ----------------------------------------------------------------------
[17:07:22.574] <TB2> INFO: Expecting 231680 events.
[17:07:28.353] <TB2> ERROR: <datapipe.cc/CheckEventValidity:L497> Channel 0 Number of ROCs (1) != Token Chain Length (4)
[17:07:28.435] <TB2> ERROR: <datapipe.cc/CheckEventID:L459> Channel 0 Event ID mismatch: local ID (21) != TBM ID (2)
[17:07:32.924] <TB2> INFO: 231680 events read in total (9794ms).
[17:07:32.929] <TB2> INFO: Test took 10444ms.
[17:07:33.147] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[17:07:33.215] <TB2> INFO: enter test to run
[17:07:33.215] <TB2> INFO: test: pretest no parameter change
[17:07:33.215] <TB2> INFO: running: pretest
[17:07:33.217] <TB2> INFO: ----------------------------------------------------------------------
[17:07:33.217] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[17:07:33.217] <TB2> INFO: ----------------------------------------------------------------------
[17:07:33.309] <TB2> INFO: Expecting 231680 events.
[17:07:43.642] <TB2> INFO: 231680 events read in total (9777ms).
[17:07:43.646] <TB2> INFO: Test took 10425ms.
[17:07:43.881] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[17:07:43.881] <TB2> INFO: CalDel: 129 136 143 119 135 134 144 139 125 118 117 128 125 169 157 130
[17:07:43.881] <TB2> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[17:07:43.915] <TB2> INFO: enter test to run
[17:07:43.915] <TB2> INFO: test: pretest no parameter change
[17:07:43.915] <TB2> INFO: running: pretest
[17:07:43.916] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C0.dat
[17:07:43.916] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C1.dat
[17:07:43.916] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C2.dat
[17:07:43.916] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C3.dat
[17:07:43.916] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C4.dat
[17:07:43.916] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C5.dat
[17:07:43.916] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C6.dat
[17:07:43.916] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C7.dat
[17:07:43.917] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C8.dat
[17:07:43.917] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C9.dat
[17:07:43.917] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C10.dat
[17:07:43.917] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C11.dat
[17:07:43.917] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C12.dat
[17:07:43.917] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C13.dat
[17:07:43.917] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C14.dat
[17:07:43.918] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters_C15.dat
[17:07:43.918] <TB2> INFO: enter test to run
[17:07:43.918] <TB2> INFO: test: fulltest no parameter change
[17:07:43.918] <TB2> INFO: running: fulltest
[17:07:43.918] <TB2> INFO: ######################################################################
[17:07:43.918] <TB2> INFO: PixTestFullTest::doTest()
[17:07:43.918] <TB2> INFO: ######################################################################
[17:07:43.919] <TB2> INFO: ######################################################################
[17:07:43.919] <TB2> INFO: PixTestAlive::doTest()
[17:07:43.919] <TB2> INFO: ######################################################################
[17:07:43.921] <TB2> INFO: ----------------------------------------------------------------------
[17:07:43.921] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[17:07:43.921] <TB2> INFO: ----------------------------------------------------------------------
[17:07:44.192] <TB2> INFO: Expecting 41600 events.
[17:07:48.171] <TB2> INFO: 41600 events read in total (3422ms).
[17:07:48.171] <TB2> INFO: Test took 4249ms.
[17:07:48.403] <TB2> INFO: PixTestAlive::aliveTest() done
[17:07:48.403] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[17:07:48.404] <TB2> INFO: ----------------------------------------------------------------------
[17:07:48.404] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[17:07:48.404] <TB2> INFO: ----------------------------------------------------------------------
[17:07:48.670] <TB2> INFO: Expecting 41600 events.
[17:07:51.749] <TB2> INFO: 41600 events read in total (2523ms).
[17:07:51.749] <TB2> INFO: Test took 3344ms.
[17:07:51.750] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[17:07:51.991] <TB2> INFO: PixTestAlive::maskTest() done
[17:07:51.991] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[17:07:51.993] <TB2> INFO: ----------------------------------------------------------------------
[17:07:51.993] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[17:07:51.993] <TB2> INFO: ----------------------------------------------------------------------
[17:07:52.269] <TB2> INFO: Expecting 41600 events.
[17:07:56.312] <TB2> INFO: 41600 events read in total (3487ms).
[17:07:56.313] <TB2> INFO: Test took 4319ms.
[17:07:56.543] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[17:07:56.543] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[17:07:56.543] <TB2> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[17:07:56.543] <TB2> INFO: Decoding statistics:
[17:07:56.543] <TB2> INFO: General information:
[17:07:56.543] <TB2> INFO: 16bit words read: 0
[17:07:56.543] <TB2> INFO: valid events total: 0
[17:07:56.543] <TB2> INFO: empty events: 0
[17:07:56.543] <TB2> INFO: valid events with pixels: 0
[17:07:56.543] <TB2> INFO: valid pixel hits: 0
[17:07:56.543] <TB2> INFO: Event errors: 0
[17:07:56.543] <TB2> INFO: start marker: 0
[17:07:56.543] <TB2> INFO: stop marker: 0
[17:07:56.543] <TB2> INFO: overflow: 0
[17:07:56.543] <TB2> INFO: invalid 5bit words: 0
[17:07:56.543] <TB2> INFO: invalid XOR eye diagram: 0
[17:07:56.543] <TB2> INFO: frame (failed synchr.): 0
[17:07:56.543] <TB2> INFO: idle data (no TBM trl): 0
[17:07:56.543] <TB2> INFO: no data (only TBM hdr): 0
[17:07:56.543] <TB2> INFO: TBM errors: 0
[17:07:56.543] <TB2> INFO: flawed TBM headers: 0
[17:07:56.543] <TB2> INFO: flawed TBM trailers: 0
[17:07:56.543] <TB2> INFO: event ID mismatches: 0
[17:07:56.543] <TB2> INFO: ROC errors: 0
[17:07:56.543] <TB2> INFO: missing ROC header(s): 0
[17:07:56.543] <TB2> INFO: misplaced readback start: 0
[17:07:56.543] <TB2> INFO: Pixel decoding errors: 0
[17:07:56.543] <TB2> INFO: pixel data incomplete: 0
[17:07:56.543] <TB2> INFO: pixel address: 0
[17:07:56.543] <TB2> INFO: pulse height fill bit: 0
[17:07:56.543] <TB2> INFO: buffer corruption: 0
[17:07:56.550] <TB2> INFO: ######################################################################
[17:07:56.550] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[17:07:56.550] <TB2> INFO: ######################################################################
[17:07:56.553] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[17:07:56.564] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[17:07:56.564] <TB2> INFO: run 1 of 1
[17:07:56.822] <TB2> INFO: Expecting 3120000 events.
[17:08:39.192] <TB2> INFO: 859975 events read in total (41813ms).
[17:09:19.140] <TB2> INFO: 1710885 events read in total (81761ms).
[17:10:00.467] <TB2> INFO: 2566345 events read in total (123088ms).
[17:10:27.665] <TB2> INFO: 3120000 events read in total (150286ms).
[17:10:27.718] <TB2> INFO: Test took 151154ms.
[17:10:50.839] <TB2> INFO: PixTestBBMap::doTest() done, duration: 174 seconds
[17:10:50.839] <TB2> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 2 0 0 0 0 0 0 0 1
[17:10:50.839] <TB2> INFO: separation cut (per ROC): 106 89 93 101 91 103 85 91 103 100 105 88 103 93 83 87
[17:10:50.839] <TB2> INFO: Decoding statistics:
[17:10:50.839] <TB2> INFO: General information:
[17:10:50.839] <TB2> INFO: 16bit words read: 0
[17:10:50.839] <TB2> INFO: valid events total: 0
[17:10:50.839] <TB2> INFO: empty events: 0
[17:10:50.839] <TB2> INFO: valid events with pixels: 0
[17:10:50.839] <TB2> INFO: valid pixel hits: 0
[17:10:50.839] <TB2> INFO: Event errors: 0
[17:10:50.839] <TB2> INFO: start marker: 0
[17:10:50.839] <TB2> INFO: stop marker: 0
[17:10:50.839] <TB2> INFO: overflow: 0
[17:10:50.839] <TB2> INFO: invalid 5bit words: 0
[17:10:50.839] <TB2> INFO: invalid XOR eye diagram: 0
[17:10:50.839] <TB2> INFO: frame (failed synchr.): 0
[17:10:50.839] <TB2> INFO: idle data (no TBM trl): 0
[17:10:50.839] <TB2> INFO: no data (only TBM hdr): 0
[17:10:50.839] <TB2> INFO: TBM errors: 0
[17:10:50.839] <TB2> INFO: flawed TBM headers: 0
[17:10:50.839] <TB2> INFO: flawed TBM trailers: 0
[17:10:50.839] <TB2> INFO: event ID mismatches: 0
[17:10:50.839] <TB2> INFO: ROC errors: 0
[17:10:50.839] <TB2> INFO: missing ROC header(s): 0
[17:10:50.839] <TB2> INFO: misplaced readback start: 0
[17:10:50.839] <TB2> INFO: Pixel decoding errors: 0
[17:10:50.839] <TB2> INFO: pixel data incomplete: 0
[17:10:50.839] <TB2> INFO: pixel address: 0
[17:10:50.839] <TB2> INFO: pulse height fill bit: 0
[17:10:50.839] <TB2> INFO: buffer corruption: 0
[17:10:50.908] <TB2> INFO: ######################################################################
[17:10:50.908] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[17:10:50.908] <TB2> INFO: ######################################################################
[17:10:50.908] <TB2> INFO: ----------------------------------------------------------------------
[17:10:50.908] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[17:10:50.908] <TB2> INFO: ----------------------------------------------------------------------
[17:10:50.908] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[17:10:50.916] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[17:10:50.916] <TB2> INFO: run 1 of 1
[17:10:51.175] <TB2> INFO: Expecting 26208000 events.
[17:11:26.770] <TB2> INFO: 961600 events read in total (35039ms).
[17:12:01.027] <TB2> INFO: 1902500 events read in total (69296ms).
[17:12:33.666] <TB2> INFO: 2841050 events read in total (101935ms).
[17:13:09.693] <TB2> INFO: 3778350 events read in total (137962ms).
[17:13:43.880] <TB2> INFO: 4712150 events read in total (172149ms).
[17:14:16.429] <TB2> INFO: 5647300 events read in total (204698ms).
[17:14:51.064] <TB2> INFO: 6580950 events read in total (239333ms).
[17:15:23.875] <TB2> INFO: 7510350 events read in total (272144ms).
[17:15:57.086] <TB2> INFO: 8439900 events read in total (305355ms).
[17:16:31.053] <TB2> INFO: 9371550 events read in total (339322ms).
[17:17:03.858] <TB2> INFO: 10299150 events read in total (372127ms).
[17:17:38.405] <TB2> INFO: 11226700 events read in total (406675ms).
[17:18:10.620] <TB2> INFO: 12152600 events read in total (438889ms).
[17:18:43.747] <TB2> INFO: 13076300 events read in total (472016ms).
[17:19:18.328] <TB2> INFO: 13989600 events read in total (506597ms).
[17:19:50.244] <TB2> INFO: 14900000 events read in total (538513ms).
[17:20:23.405] <TB2> INFO: 15812150 events read in total (571674ms).
[17:20:57.156] <TB2> INFO: 16719400 events read in total (605425ms).
[17:21:32.025] <TB2> INFO: 17626300 events read in total (640294ms).
[17:22:04.628] <TB2> INFO: 18533900 events read in total (672897ms).
[17:22:37.859] <TB2> INFO: 19439150 events read in total (706128ms).
[17:23:11.395] <TB2> INFO: 20345200 events read in total (739664ms).
[17:23:44.474] <TB2> INFO: 21249000 events read in total (772743ms).
[17:24:17.226] <TB2> INFO: 22150300 events read in total (805495ms).
[17:24:49.645] <TB2> INFO: 23052000 events read in total (837914ms).
[17:25:22.421] <TB2> INFO: 23956450 events read in total (870690ms).
[17:25:56.204] <TB2> INFO: 24863200 events read in total (904473ms).
[17:26:27.968] <TB2> INFO: 25771850 events read in total (936237ms).
[17:26:43.073] <TB2> INFO: 26208000 events read in total (951342ms).
[17:26:43.099] <TB2> INFO: Test took 952182ms.
[17:26:43.285] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:44.612] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:45.962] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:47.340] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:48.668] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:50.003] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:51.303] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:52.662] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:54.060] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:55.342] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:56.669] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:57.944] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:26:59.307] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:27:00.659] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:27:02.057] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:27:03.478] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[17:27:04.925] <TB2> INFO: PixTestScurves::scurves() done
[17:27:04.925] <TB2> INFO: Vcal mean: 106.78 88.40 86.67 99.86 99.19 112.47 86.51 96.39 113.67 100.98 115.42 93.44 109.63 110.08 93.81 95.19
[17:27:04.925] <TB2> INFO: Vcal RMS: 5.33 4.95 5.24 5.52 5.35 5.32 5.00 6.13 4.49 5.52 4.76 5.12 5.13 4.71 5.86 4.70
[17:27:04.925] <TB2> INFO: PixTestScurves::fullTest() done, duration: 974 seconds
[17:27:04.925] <TB2> INFO: Decoding statistics:
[17:27:04.925] <TB2> INFO: General information:
[17:27:04.925] <TB2> INFO: 16bit words read: 0
[17:27:04.925] <TB2> INFO: valid events total: 0
[17:27:04.925] <TB2> INFO: empty events: 0
[17:27:04.925] <TB2> INFO: valid events with pixels: 0
[17:27:04.925] <TB2> INFO: valid pixel hits: 0
[17:27:04.925] <TB2> INFO: Event errors: 0
[17:27:04.925] <TB2> INFO: start marker: 0
[17:27:04.925] <TB2> INFO: stop marker: 0
[17:27:04.925] <TB2> INFO: overflow: 0
[17:27:04.925] <TB2> INFO: invalid 5bit words: 0
[17:27:04.925] <TB2> INFO: invalid XOR eye diagram: 0
[17:27:04.925] <TB2> INFO: frame (failed synchr.): 0
[17:27:04.925] <TB2> INFO: idle data (no TBM trl): 0
[17:27:04.925] <TB2> INFO: no data (only TBM hdr): 0
[17:27:04.925] <TB2> INFO: TBM errors: 0
[17:27:04.925] <TB2> INFO: flawed TBM headers: 0
[17:27:04.925] <TB2> INFO: flawed TBM trailers: 0
[17:27:04.925] <TB2> INFO: event ID mismatches: 0
[17:27:04.925] <TB2> INFO: ROC errors: 0
[17:27:04.925] <TB2> INFO: missing ROC header(s): 0
[17:27:04.925] <TB2> INFO: misplaced readback start: 0
[17:27:04.925] <TB2> INFO: Pixel decoding errors: 0
[17:27:04.925] <TB2> INFO: pixel data incomplete: 0
[17:27:04.925] <TB2> INFO: pixel address: 0
[17:27:04.925] <TB2> INFO: pulse height fill bit: 0
[17:27:04.925] <TB2> INFO: buffer corruption: 0
[17:27:04.997] <TB2> INFO: ######################################################################
[17:27:04.997] <TB2> INFO: PixTestTrim::doTest()
[17:27:04.997] <TB2> INFO: ######################################################################
[17:27:04.998] <TB2> INFO: ----------------------------------------------------------------------
[17:27:04.998] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[17:27:04.998] <TB2> INFO: ----------------------------------------------------------------------
[17:27:05.077] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[17:27:05.077] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[17:27:05.085] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:27:05.085] <TB2> INFO: run 1 of 1
[17:27:05.347] <TB2> INFO: Expecting 6281600 events.
[17:27:46.375] <TB2> INFO: 1084860 events read in total (40471ms).
[17:28:26.167] <TB2> INFO: 2164210 events read in total (80263ms).
[17:29:06.572] <TB2> INFO: 3236420 events read in total (120668ms).
[17:29:47.454] <TB2> INFO: 4307120 events read in total (161550ms).
[17:30:25.877] <TB2> INFO: 5377350 events read in total (199973ms).
[17:30:59.202] <TB2> INFO: 6281600 events read in total (233298ms).
[17:30:59.234] <TB2> INFO: Test took 234149ms.
[17:31:18.048] <TB2> INFO: ROC 0 VthrComp = 109
[17:31:18.048] <TB2> INFO: ROC 1 VthrComp = 93
[17:31:18.048] <TB2> INFO: ROC 2 VthrComp = 90
[17:31:18.048] <TB2> INFO: ROC 3 VthrComp = 103
[17:31:18.048] <TB2> INFO: ROC 4 VthrComp = 98
[17:31:18.048] <TB2> INFO: ROC 5 VthrComp = 110
[17:31:18.048] <TB2> INFO: ROC 6 VthrComp = 92
[17:31:18.048] <TB2> INFO: ROC 7 VthrComp = 94
[17:31:18.049] <TB2> INFO: ROC 8 VthrComp = 117
[17:31:18.049] <TB2> INFO: ROC 9 VthrComp = 106
[17:31:18.049] <TB2> INFO: ROC 10 VthrComp = 118
[17:31:18.049] <TB2> INFO: ROC 11 VthrComp = 93
[17:31:18.049] <TB2> INFO: ROC 12 VthrComp = 109
[17:31:18.049] <TB2> INFO: ROC 13 VthrComp = 107
[17:31:18.049] <TB2> INFO: ROC 14 VthrComp = 95
[17:31:18.049] <TB2> INFO: ROC 15 VthrComp = 98
[17:31:18.049] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[17:31:18.049] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[17:31:18.058] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:31:18.058] <TB2> INFO: run 1 of 1
[17:31:18.317] <TB2> INFO: Expecting 6281600 events.
[17:31:55.662] <TB2> INFO: 760190 events read in total (36789ms).
[17:32:29.874] <TB2> INFO: 1518450 events read in total (71001ms).
[17:33:04.286] <TB2> INFO: 2276860 events read in total (105413ms).
[17:33:40.116] <TB2> INFO: 3035290 events read in total (141243ms).
[17:34:15.996] <TB2> INFO: 3787280 events read in total (177123ms).
[17:34:51.408] <TB2> INFO: 4535030 events read in total (212535ms).
[17:35:26.697] <TB2> INFO: 5280100 events read in total (247824ms).
[17:36:02.160] <TB2> INFO: 6024120 events read in total (283287ms).
[17:36:14.254] <TB2> INFO: 6281600 events read in total (295381ms).
[17:36:14.291] <TB2> INFO: Test took 296233ms.
[17:36:37.110] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 61.1905 for pixel 4/0 mean/min/max = 47.6086/33.8422/61.3751
[17:36:37.110] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 57.1431 for pixel 5/4 mean/min/max = 45.4655/33.7435/57.1875
[17:36:37.110] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 57.3153 for pixel 8/55 mean/min/max = 45.7201/34.0802/57.3601
[17:36:37.110] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 57.5994 for pixel 17/39 mean/min/max = 45.3342/32.9985/57.6699
[17:36:37.111] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 58.9095 for pixel 15/34 mean/min/max = 45.0543/31.0334/59.0752
[17:36:37.111] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 63.8528 for pixel 0/79 mean/min/max = 49.6307/35.3399/63.9215
[17:36:37.111] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 56.1953 for pixel 1/74 mean/min/max = 44.9649/33.7044/56.2254
[17:36:37.111] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 60.6593 for pixel 1/0 mean/min/max = 46.4401/31.7691/61.1111
[17:36:37.112] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 58.1275 for pixel 14/63 mean/min/max = 46.7821/35.3812/58.1829
[17:36:37.112] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 57.5133 for pixel 24/7 mean/min/max = 45.7336/33.7689/57.6983
[17:36:37.112] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 57.8649 for pixel 51/3 mean/min/max = 45.9641/34.044/57.8842
[17:36:37.112] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 59.0063 for pixel 0/1 mean/min/max = 45.8199/32.6264/59.0133
[17:36:37.112] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 63.9724 for pixel 2/2 mean/min/max = 49.7448/35.4497/64.0399
[17:36:37.113] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 60.4856 for pixel 0/8 mean/min/max = 47.9002/35.2836/60.5169
[17:36:37.113] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 60.2639 for pixel 0/25 mean/min/max = 46.0752/31.6596/60.4908
[17:36:37.113] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 57.2153 for pixel 51/4 mean/min/max = 44.6799/32.0066/57.3531
[17:36:37.113] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:36:37.201] <TB2> INFO: Expecting 514560 events.
[17:36:50.306] <TB2> INFO: 514560 events read in total (12548ms).
[17:36:50.311] <TB2> INFO: Expecting 514560 events.
[17:37:03.099] <TB2> INFO: 514560 events read in total (12370ms).
[17:37:03.107] <TB2> INFO: Expecting 514560 events.
[17:37:15.730] <TB2> INFO: 514560 events read in total (12207ms).
[17:37:15.739] <TB2> INFO: Expecting 514560 events.
[17:37:28.541] <TB2> INFO: 514560 events read in total (12382ms).
[17:37:28.552] <TB2> INFO: Expecting 514560 events.
[17:37:41.521] <TB2> INFO: 514560 events read in total (12558ms).
[17:37:41.533] <TB2> INFO: Expecting 514560 events.
[17:37:54.312] <TB2> INFO: 514560 events read in total (12377ms).
[17:37:54.328] <TB2> INFO: Expecting 514560 events.
[17:38:07.191] <TB2> INFO: 514560 events read in total (12461ms).
[17:38:07.207] <TB2> INFO: Expecting 514560 events.
[17:38:20.101] <TB2> INFO: 514560 events read in total (12484ms).
[17:38:20.119] <TB2> INFO: Expecting 514560 events.
[17:38:33.115] <TB2> INFO: 514560 events read in total (12593ms).
[17:38:33.136] <TB2> INFO: Expecting 514560 events.
[17:38:45.897] <TB2> INFO: 514560 events read in total (12359ms).
[17:38:45.919] <TB2> INFO: Expecting 514560 events.
[17:38:58.547] <TB2> INFO: 514560 events read in total (12226ms).
[17:38:58.571] <TB2> INFO: Expecting 514560 events.
[17:39:11.481] <TB2> INFO: 514560 events read in total (12505ms).
[17:39:11.508] <TB2> INFO: Expecting 514560 events.
[17:39:24.621] <TB2> INFO: 514560 events read in total (12711ms).
[17:39:24.651] <TB2> INFO: Expecting 514560 events.
[17:39:37.378] <TB2> INFO: 514560 events read in total (12325ms).
[17:39:37.408] <TB2> INFO: Expecting 514560 events.
[17:39:50.056] <TB2> INFO: 514560 events read in total (12246ms).
[17:39:50.086] <TB2> INFO: Expecting 514560 events.
[17:40:03.026] <TB2> INFO: 514560 events read in total (12538ms).
[17:40:03.074] <TB2> INFO: Test took 205961ms.
[17:40:04.060] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[17:40:04.069] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:40:04.069] <TB2> INFO: run 1 of 1
[17:40:04.326] <TB2> INFO: Expecting 6281600 events.
[17:40:40.366] <TB2> INFO: 743890 events read in total (35483ms).
[17:41:15.945] <TB2> INFO: 1486580 events read in total (71062ms).
[17:41:51.007] <TB2> INFO: 2229430 events read in total (106124ms).
[17:42:25.845] <TB2> INFO: 2972670 events read in total (140962ms).
[17:43:01.557] <TB2> INFO: 3709820 events read in total (176674ms).
[17:43:36.786] <TB2> INFO: 4442220 events read in total (211903ms).
[17:44:11.960] <TB2> INFO: 5172180 events read in total (247077ms).
[17:44:47.158] <TB2> INFO: 5901140 events read in total (282275ms).
[17:45:06.087] <TB2> INFO: 6281600 events read in total (301204ms).
[17:45:06.129] <TB2> INFO: Test took 302060ms.
[17:45:28.684] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.207031 .. 255.000000
[17:45:28.760] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[17:45:28.768] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:45:28.768] <TB2> INFO: run 1 of 1
[17:45:29.027] <TB2> INFO: Expecting 10649600 events.
[17:46:04.056] <TB2> INFO: 712270 events read in total (34471ms).
[17:46:40.279] <TB2> INFO: 1424920 events read in total (70694ms).
[17:47:14.380] <TB2> INFO: 2137880 events read in total (104795ms).
[17:47:48.741] <TB2> INFO: 2850510 events read in total (139156ms).
[17:48:22.392] <TB2> INFO: 3563290 events read in total (172807ms).
[17:48:56.426] <TB2> INFO: 4276360 events read in total (206841ms).
[17:49:30.771] <TB2> INFO: 4989170 events read in total (241186ms).
[17:50:05.275] <TB2> INFO: 5702260 events read in total (275690ms).
[17:50:39.668] <TB2> INFO: 6415230 events read in total (310083ms).
[17:51:15.861] <TB2> INFO: 7127710 events read in total (346276ms).
[17:51:49.896] <TB2> INFO: 7839760 events read in total (380311ms).
[17:52:25.243] <TB2> INFO: 8551030 events read in total (415658ms).
[17:53:00.041] <TB2> INFO: 9262040 events read in total (450456ms).
[17:53:33.208] <TB2> INFO: 9973070 events read in total (483623ms).
[17:54:06.559] <TB2> INFO: 10649600 events read in total (516974ms).
[17:54:06.642] <TB2> INFO: Test took 517874ms.
[17:54:34.340] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 17.268697 .. 45.617838
[17:54:34.415] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 7 .. 55 (-1/-1) hits flags = 528 (plus default)
[17:54:34.423] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:54:34.423] <TB2> INFO: run 1 of 1
[17:54:34.682] <TB2> INFO: Expecting 2038400 events.
[17:55:13.565] <TB2> INFO: 927410 events read in total (38323ms).
[17:55:51.513] <TB2> INFO: 1853590 events read in total (76271ms).
[17:55:59.496] <TB2> INFO: 2038400 events read in total (84255ms).
[17:55:59.514] <TB2> INFO: Test took 85092ms.
[17:56:12.588] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 1.989893 .. 41.848512
[17:56:12.664] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 1 .. 51 (-1/-1) hits flags = 528 (plus default)
[17:56:12.673] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:56:12.673] <TB2> INFO: run 1 of 1
[17:56:12.931] <TB2> INFO: Expecting 2121600 events.
[17:56:51.958] <TB2> INFO: 996490 events read in total (38470ms).
[17:57:30.980] <TB2> INFO: 1992030 events read in total (77492ms).
[17:57:36.217] <TB2> INFO: 2121600 events read in total (82729ms).
[17:57:36.225] <TB2> INFO: Test took 83552ms.
[17:57:48.679] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 2.095075 .. 41.057061
[17:57:48.753] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 2 .. 51 (-1/-1) hits flags = 528 (plus default)
[17:57:48.762] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:57:48.762] <TB2> INFO: run 1 of 1
[17:57:49.021] <TB2> INFO: Expecting 2080000 events.
[17:58:30.209] <TB2> INFO: 991870 events read in total (40632ms).
[17:59:10.706] <TB2> INFO: 1982970 events read in total (81129ms).
[17:59:14.721] <TB2> INFO: 2080000 events read in total (85145ms).
[17:59:14.733] <TB2> INFO: Test took 85971ms.
[17:59:27.210] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[17:59:27.210] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[17:59:27.218] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:59:27.218] <TB2> INFO: run 1 of 1
[17:59:27.476] <TB2> INFO: Expecting 1705600 events.
[18:00:05.289] <TB2> INFO: 878980 events read in total (37256ms).
[18:00:39.877] <TB2> INFO: 1705600 events read in total (71844ms).
[18:00:39.893] <TB2> INFO: Test took 72675ms.
[18:00:52.616] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C0.dat
[18:00:52.616] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C1.dat
[18:00:52.616] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C2.dat
[18:00:52.616] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C3.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C4.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C5.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C6.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C7.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C8.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C9.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C10.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C11.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C12.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C13.dat
[18:00:52.617] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C14.dat
[18:00:52.618] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C15.dat
[18:00:52.618] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C0.dat
[18:00:52.624] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C1.dat
[18:00:52.629] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C2.dat
[18:00:52.635] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C3.dat
[18:00:52.641] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C4.dat
[18:00:52.647] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C5.dat
[18:00:52.653] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C6.dat
[18:00:52.659] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C7.dat
[18:00:52.664] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C8.dat
[18:00:52.670] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C9.dat
[18:00:52.676] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C10.dat
[18:00:52.682] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C11.dat
[18:00:52.688] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C12.dat
[18:00:52.694] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C13.dat
[18:00:52.700] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C14.dat
[18:00:52.706] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//trimParameters35_C15.dat
[18:00:52.712] <TB2> INFO: PixTestTrim::trimTest() done
[18:00:52.712] <TB2> INFO: vtrim: 116 110 88 99 95 106 98 116 115 108 152 97 148 114 90 100
[18:00:52.712] <TB2> INFO: vthrcomp: 109 93 90 103 98 110 92 94 117 106 118 93 109 107 95 98
[18:00:52.712] <TB2> INFO: vcal mean: 34.97 34.94 34.96 34.97 34.85 35.02 34.99 34.99 35.00 34.97 34.96 34.98 35.00 35.02 34.97 34.97
[18:00:52.712] <TB2> INFO: vcal RMS: 0.85 0.75 0.79 0.82 0.91 0.87 0.77 1.07 0.81 0.80 1.09 0.82 0.90 0.86 0.87 0.83
[18:00:52.712] <TB2> INFO: bits mean: 8.71 9.27 8.97 9.27 9.84 7.34 9.44 9.38 8.68 9.55 10.79 8.83 8.77 8.26 9.07 9.58
[18:00:52.712] <TB2> INFO: bits RMS: 2.64 2.57 2.68 2.71 2.68 2.74 2.55 2.71 2.50 2.45 1.82 2.93 2.27 2.59 2.96 2.74
[18:00:52.718] <TB2> INFO: ----------------------------------------------------------------------
[18:00:52.718] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[18:00:52.718] <TB2> INFO: ----------------------------------------------------------------------
[18:00:52.721] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[18:00:52.729] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[18:00:52.729] <TB2> INFO: run 1 of 1
[18:00:52.990] <TB2> INFO: Expecting 4160000 events.
[18:01:36.494] <TB2> INFO: 970365 events read in total (42947ms).
[18:02:19.888] <TB2> INFO: 1929985 events read in total (86341ms).
[18:03:01.885] <TB2> INFO: 2877280 events read in total (128338ms).
[18:03:43.575] <TB2> INFO: 3819900 events read in total (170028ms).
[18:03:59.261] <TB2> INFO: 4160000 events read in total (185714ms).
[18:03:59.299] <TB2> INFO: Test took 186569ms.
[18:04:28.343] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 182 (-1/-1) hits flags = 528 (plus default)
[18:04:28.351] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[18:04:28.351] <TB2> INFO: run 1 of 1
[18:04:28.610] <TB2> INFO: Expecting 3806400 events.
[18:05:12.904] <TB2> INFO: 972040 events read in total (43738ms).
[18:05:54.811] <TB2> INFO: 1932620 events read in total (85645ms).
[18:06:35.901] <TB2> INFO: 2879410 events read in total (126735ms).
[18:07:15.892] <TB2> INFO: 3806400 events read in total (166726ms).
[18:07:15.927] <TB2> INFO: Test took 167576ms.
[18:07:41.565] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 167 (-1/-1) hits flags = 528 (plus default)
[18:07:41.573] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[18:07:41.573] <TB2> INFO: run 1 of 1
[18:07:41.830] <TB2> INFO: Expecting 3494400 events.
[18:08:24.941] <TB2> INFO: 1012755 events read in total (42555ms).
[18:09:07.424] <TB2> INFO: 2009055 events read in total (85038ms).
[18:09:49.219] <TB2> INFO: 2990975 events read in total (126833ms).
[18:10:11.553] <TB2> INFO: 3494400 events read in total (149167ms).
[18:10:11.594] <TB2> INFO: Test took 150021ms.
[18:10:36.817] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 168 (-1/-1) hits flags = 528 (plus default)
[18:10:36.825] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[18:10:36.825] <TB2> INFO: run 1 of 1
[18:10:37.084] <TB2> INFO: Expecting 3515200 events.
[18:11:20.472] <TB2> INFO: 1009095 events read in total (42831ms).
[18:12:02.804] <TB2> INFO: 2002020 events read in total (85163ms).
[18:12:45.331] <TB2> INFO: 2980625 events read in total (127690ms).
[18:13:08.130] <TB2> INFO: 3515200 events read in total (150489ms).
[18:13:08.160] <TB2> INFO: Test took 151335ms.
[18:13:32.256] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 170 (-1/-1) hits flags = 528 (plus default)
[18:13:32.264] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[18:13:32.264] <TB2> INFO: run 1 of 1
[18:13:32.523] <TB2> INFO: Expecting 3556800 events.
[18:14:16.793] <TB2> INFO: 1002580 events read in total (43714ms).
[18:14:59.921] <TB2> INFO: 1990170 events read in total (86842ms).
[18:15:42.605] <TB2> INFO: 2963215 events read in total (129526ms).
[18:16:09.597] <TB2> INFO: 3556800 events read in total (156518ms).
[18:16:09.635] <TB2> INFO: Test took 157371ms.
[18:16:34.102] <TB2> INFO: PixTestTrim::trimBitTest() done
[18:16:34.104] <TB2> INFO: PixTestTrim::doTest() done, duration: 2969 seconds
[18:16:34.104] <TB2> INFO: Decoding statistics:
[18:16:34.104] <TB2> INFO: General information:
[18:16:34.104] <TB2> INFO: 16bit words read: 0
[18:16:34.104] <TB2> INFO: valid events total: 0
[18:16:34.104] <TB2> INFO: empty events: 0
[18:16:34.104] <TB2> INFO: valid events with pixels: 0
[18:16:34.104] <TB2> INFO: valid pixel hits: 0
[18:16:34.104] <TB2> INFO: Event errors: 0
[18:16:34.104] <TB2> INFO: start marker: 0
[18:16:34.104] <TB2> INFO: stop marker: 0
[18:16:34.104] <TB2> INFO: overflow: 0
[18:16:34.104] <TB2> INFO: invalid 5bit words: 0
[18:16:34.104] <TB2> INFO: invalid XOR eye diagram: 0
[18:16:34.104] <TB2> INFO: frame (failed synchr.): 0
[18:16:34.104] <TB2> INFO: idle data (no TBM trl): 0
[18:16:34.104] <TB2> INFO: no data (only TBM hdr): 0
[18:16:34.104] <TB2> INFO: TBM errors: 0
[18:16:34.104] <TB2> INFO: flawed TBM headers: 0
[18:16:34.104] <TB2> INFO: flawed TBM trailers: 0
[18:16:34.104] <TB2> INFO: event ID mismatches: 0
[18:16:34.104] <TB2> INFO: ROC errors: 0
[18:16:34.104] <TB2> INFO: missing ROC header(s): 0
[18:16:34.104] <TB2> INFO: misplaced readback start: 0
[18:16:34.104] <TB2> INFO: Pixel decoding errors: 0
[18:16:34.104] <TB2> INFO: pixel data incomplete: 0
[18:16:34.104] <TB2> INFO: pixel address: 0
[18:16:34.104] <TB2> INFO: pulse height fill bit: 0
[18:16:34.104] <TB2> INFO: buffer corruption: 0
[18:16:34.832] <TB2> INFO: ######################################################################
[18:16:34.832] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[18:16:34.832] <TB2> INFO: ######################################################################
[18:16:35.099] <TB2> INFO: Expecting 41600 events.
[18:16:38.955] <TB2> INFO: 41600 events read in total (3299ms).
[18:16:38.956] <TB2> INFO: Test took 4122ms.
[18:16:39.480] <TB2> INFO: Expecting 41600 events.
[18:16:43.336] <TB2> INFO: 41600 events read in total (3300ms).
[18:16:43.337] <TB2> INFO: Test took 4176ms.
[18:16:43.634] <TB2> INFO: Expecting 41600 events.
[18:16:47.403] <TB2> INFO: 41600 events read in total (3212ms).
[18:16:47.404] <TB2> INFO: Test took 4041ms.
[18:16:47.663] <TB2> INFO: Expecting 2560 events.
[18:16:48.520] <TB2> INFO: 2560 events read in total (300ms).
[18:16:48.522] <TB2> INFO: Test took 1101ms.
[18:16:48.825] <TB2> INFO: Expecting 2560 events.
[18:16:49.680] <TB2> INFO: 2560 events read in total (299ms).
[18:16:49.680] <TB2> INFO: Test took 1157ms.
[18:16:49.986] <TB2> INFO: Expecting 2560 events.
[18:16:50.842] <TB2> INFO: 2560 events read in total (300ms).
[18:16:50.843] <TB2> INFO: Test took 1162ms.
[18:16:51.149] <TB2> INFO: Expecting 2560 events.
[18:16:52.002] <TB2> INFO: 2560 events read in total (297ms).
[18:16:52.002] <TB2> INFO: Test took 1159ms.
[18:16:52.307] <TB2> INFO: Expecting 2560 events.
[18:16:53.164] <TB2> INFO: 2560 events read in total (300ms).
[18:16:53.164] <TB2> INFO: Test took 1161ms.
[18:16:53.469] <TB2> INFO: Expecting 2560 events.
[18:16:54.324] <TB2> INFO: 2560 events read in total (299ms).
[18:16:54.325] <TB2> INFO: Test took 1160ms.
[18:16:54.630] <TB2> INFO: Expecting 2560 events.
[18:16:55.487] <TB2> INFO: 2560 events read in total (301ms).
[18:16:55.487] <TB2> INFO: Test took 1162ms.
[18:16:55.792] <TB2> INFO: Expecting 2560 events.
[18:16:56.648] <TB2> INFO: 2560 events read in total (300ms).
[18:16:56.648] <TB2> INFO: Test took 1160ms.
[18:16:56.954] <TB2> INFO: Expecting 2560 events.
[18:16:57.807] <TB2> INFO: 2560 events read in total (298ms).
[18:16:57.808] <TB2> INFO: Test took 1159ms.
[18:16:58.113] <TB2> INFO: Expecting 2560 events.
[18:16:58.966] <TB2> INFO: 2560 events read in total (297ms).
[18:16:58.966] <TB2> INFO: Test took 1158ms.
[18:16:59.272] <TB2> INFO: Expecting 2560 events.
[18:17:00.128] <TB2> INFO: 2560 events read in total (299ms).
[18:17:00.128] <TB2> INFO: Test took 1161ms.
[18:17:00.434] <TB2> INFO: Expecting 2560 events.
[18:17:01.298] <TB2> INFO: 2560 events read in total (307ms).
[18:17:01.298] <TB2> INFO: Test took 1169ms.
[18:17:01.604] <TB2> INFO: Expecting 2560 events.
[18:17:02.462] <TB2> INFO: 2560 events read in total (302ms).
[18:17:02.462] <TB2> INFO: Test took 1163ms.
[18:17:02.768] <TB2> INFO: Expecting 2560 events.
[18:17:03.625] <TB2> INFO: 2560 events read in total (301ms).
[18:17:03.626] <TB2> INFO: Test took 1162ms.
[18:17:03.931] <TB2> INFO: Expecting 2560 events.
[18:17:04.789] <TB2> INFO: 2560 events read in total (302ms).
[18:17:04.790] <TB2> INFO: Test took 1164ms.
[18:17:05.094] <TB2> INFO: Expecting 2560 events.
[18:17:05.949] <TB2> INFO: 2560 events read in total (300ms).
[18:17:05.950] <TB2> INFO: Test took 1159ms.
[18:17:05.953] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:17:06.256] <TB2> INFO: Expecting 655360 events.
[18:17:23.075] <TB2> INFO: 655360 events read in total (16262ms).
[18:17:23.084] <TB2> INFO: Expecting 655360 events.
[18:17:39.970] <TB2> INFO: 655360 events read in total (16484ms).
[18:17:39.982] <TB2> INFO: Expecting 655360 events.
[18:17:56.943] <TB2> INFO: 655360 events read in total (16559ms).
[18:17:56.965] <TB2> INFO: Expecting 655360 events.
[18:18:13.639] <TB2> INFO: 655360 events read in total (16273ms).
[18:18:13.658] <TB2> INFO: Expecting 655360 events.
[18:18:30.314] <TB2> INFO: 655360 events read in total (16254ms).
[18:18:30.335] <TB2> INFO: Expecting 655360 events.
[18:18:46.883] <TB2> INFO: 655360 events read in total (16146ms).
[18:18:46.916] <TB2> INFO: Expecting 655360 events.
[18:19:03.457] <TB2> INFO: 655360 events read in total (16139ms).
[18:19:03.485] <TB2> INFO: Expecting 655360 events.
[18:19:20.023] <TB2> INFO: 655360 events read in total (16136ms).
[18:19:20.057] <TB2> INFO: Expecting 655360 events.
[18:19:36.605] <TB2> INFO: 655360 events read in total (16146ms).
[18:19:36.643] <TB2> INFO: Expecting 655360 events.
[18:19:53.170] <TB2> INFO: 655360 events read in total (16126ms).
[18:19:53.208] <TB2> INFO: Expecting 655360 events.
[18:20:09.755] <TB2> INFO: 655360 events read in total (16145ms).
[18:20:09.800] <TB2> INFO: Expecting 655360 events.
[18:20:26.339] <TB2> INFO: 655360 events read in total (16137ms).
[18:20:26.398] <TB2> INFO: Expecting 655360 events.
[18:20:42.937] <TB2> INFO: 655360 events read in total (16137ms).
[18:20:42.986] <TB2> INFO: Expecting 655360 events.
[18:20:59.732] <TB2> INFO: 655360 events read in total (16344ms).
[18:20:59.785] <TB2> INFO: Expecting 655360 events.
[18:21:16.387] <TB2> INFO: 655360 events read in total (16200ms).
[18:21:16.458] <TB2> INFO: Expecting 655360 events.
[18:21:33.233] <TB2> INFO: 655360 events read in total (16373ms).
[18:21:33.291] <TB2> INFO: Test took 267338ms.
[18:21:33.370] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:21:33.600] <TB2> INFO: Expecting 655360 events.
[18:21:50.582] <TB2> INFO: 655360 events read in total (16426ms).
[18:21:50.592] <TB2> INFO: Expecting 655360 events.
[18:22:07.506] <TB2> INFO: 655360 events read in total (16512ms).
[18:22:07.520] <TB2> INFO: Expecting 655360 events.
[18:22:24.378] <TB2> INFO: 655360 events read in total (16456ms).
[18:22:24.393] <TB2> INFO: Expecting 655360 events.
[18:22:40.948] <TB2> INFO: 655360 events read in total (16153ms).
[18:22:40.971] <TB2> INFO: Expecting 655360 events.
[18:22:57.390] <TB2> INFO: 655360 events read in total (16017ms).
[18:22:57.413] <TB2> INFO: Expecting 655360 events.
[18:23:13.964] <TB2> INFO: 655360 events read in total (16149ms).
[18:23:13.989] <TB2> INFO: Expecting 655360 events.
[18:23:30.557] <TB2> INFO: 655360 events read in total (16166ms).
[18:23:30.585] <TB2> INFO: Expecting 655360 events.
[18:23:47.107] <TB2> INFO: 655360 events read in total (16120ms).
[18:23:47.140] <TB2> INFO: Expecting 655360 events.
[18:24:03.595] <TB2> INFO: 655360 events read in total (16053ms).
[18:24:03.633] <TB2> INFO: Expecting 655360 events.
[18:24:20.177] <TB2> INFO: 655360 events read in total (16142ms).
[18:24:20.218] <TB2> INFO: Expecting 655360 events.
[18:24:36.738] <TB2> INFO: 655360 events read in total (16118ms).
[18:24:36.779] <TB2> INFO: Expecting 655360 events.
[18:24:53.331] <TB2> INFO: 655360 events read in total (16150ms).
[18:24:53.379] <TB2> INFO: Expecting 655360 events.
[18:25:10.302] <TB2> INFO: 655360 events read in total (16521ms).
[18:25:10.351] <TB2> INFO: Expecting 655360 events.
[18:25:27.093] <TB2> INFO: 655360 events read in total (16340ms).
[18:25:27.157] <TB2> INFO: Expecting 655360 events.
[18:25:43.875] <TB2> INFO: 655360 events read in total (16316ms).
[18:25:43.931] <TB2> INFO: Expecting 655360 events.
[18:26:00.603] <TB2> INFO: 655360 events read in total (16269ms).
[18:26:00.664] <TB2> INFO: Test took 267294ms.
[18:26:00.856] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.862] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.869] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.875] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.882] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.889] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.895] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.902] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.908] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.915] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.922] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.928] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.935] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.941] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.948] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.955] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[18:26:00.991] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C0.dat
[18:26:00.991] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C1.dat
[18:26:00.991] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C2.dat
[18:26:00.991] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C3.dat
[18:26:00.991] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C4.dat
[18:26:00.991] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C5.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C6.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C7.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C8.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C9.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C10.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C11.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C12.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C13.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C14.dat
[18:26:00.992] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//dacParameters35_C15.dat
[18:26:01.254] <TB2> INFO: Expecting 41600 events.
[18:26:04.697] <TB2> INFO: 41600 events read in total (2887ms).
[18:26:04.698] <TB2> INFO: Test took 3703ms.
[18:26:05.136] <TB2> INFO: Expecting 41600 events.
[18:26:08.591] <TB2> INFO: 41600 events read in total (2898ms).
[18:26:08.591] <TB2> INFO: Test took 3713ms.
[18:26:09.028] <TB2> INFO: Expecting 41600 events.
[18:26:12.490] <TB2> INFO: 41600 events read in total (2906ms).
[18:26:12.490] <TB2> INFO: Test took 3721ms.
[18:26:12.674] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:12.762] <TB2> INFO: Expecting 2560 events.
[18:26:13.614] <TB2> INFO: 2560 events read in total (296ms).
[18:26:13.614] <TB2> INFO: Test took 940ms.
[18:26:13.616] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:13.920] <TB2> INFO: Expecting 2560 events.
[18:26:14.772] <TB2> INFO: 2560 events read in total (297ms).
[18:26:14.773] <TB2> INFO: Test took 1157ms.
[18:26:14.775] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:15.079] <TB2> INFO: Expecting 2560 events.
[18:26:15.937] <TB2> INFO: 2560 events read in total (302ms).
[18:26:15.937] <TB2> INFO: Test took 1162ms.
[18:26:15.939] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:16.243] <TB2> INFO: Expecting 2560 events.
[18:26:17.098] <TB2> INFO: 2560 events read in total (299ms).
[18:26:17.098] <TB2> INFO: Test took 1159ms.
[18:26:17.100] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:17.404] <TB2> INFO: Expecting 2560 events.
[18:26:18.256] <TB2> INFO: 2560 events read in total (296ms).
[18:26:18.256] <TB2> INFO: Test took 1156ms.
[18:26:18.258] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:18.563] <TB2> INFO: Expecting 2560 events.
[18:26:19.418] <TB2> INFO: 2560 events read in total (299ms).
[18:26:19.419] <TB2> INFO: Test took 1161ms.
[18:26:19.421] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:19.724] <TB2> INFO: Expecting 2560 events.
[18:26:20.578] <TB2> INFO: 2560 events read in total (297ms).
[18:26:20.578] <TB2> INFO: Test took 1157ms.
[18:26:20.580] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:20.885] <TB2> INFO: Expecting 2560 events.
[18:26:21.739] <TB2> INFO: 2560 events read in total (297ms).
[18:26:21.739] <TB2> INFO: Test took 1159ms.
[18:26:21.741] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:22.044] <TB2> INFO: Expecting 2560 events.
[18:26:22.897] <TB2> INFO: 2560 events read in total (296ms).
[18:26:22.897] <TB2> INFO: Test took 1156ms.
[18:26:22.899] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:23.203] <TB2> INFO: Expecting 2560 events.
[18:26:24.056] <TB2> INFO: 2560 events read in total (297ms).
[18:26:24.056] <TB2> INFO: Test took 1157ms.
[18:26:24.058] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:24.363] <TB2> INFO: Expecting 2560 events.
[18:26:25.218] <TB2> INFO: 2560 events read in total (299ms).
[18:26:25.218] <TB2> INFO: Test took 1160ms.
[18:26:25.220] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:25.524] <TB2> INFO: Expecting 2560 events.
[18:26:26.378] <TB2> INFO: 2560 events read in total (298ms).
[18:26:26.378] <TB2> INFO: Test took 1158ms.
[18:26:26.380] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:26.684] <TB2> INFO: Expecting 2560 events.
[18:26:27.537] <TB2> INFO: 2560 events read in total (297ms).
[18:26:27.537] <TB2> INFO: Test took 1157ms.
[18:26:27.539] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:27.842] <TB2> INFO: Expecting 2560 events.
[18:26:28.698] <TB2> INFO: 2560 events read in total (299ms).
[18:26:28.698] <TB2> INFO: Test took 1160ms.
[18:26:28.700] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:29.004] <TB2> INFO: Expecting 2560 events.
[18:26:29.859] <TB2> INFO: 2560 events read in total (298ms).
[18:26:29.859] <TB2> INFO: Test took 1160ms.
[18:26:29.866] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:30.165] <TB2> INFO: Expecting 2560 events.
[18:26:31.019] <TB2> INFO: 2560 events read in total (297ms).
[18:26:31.019] <TB2> INFO: Test took 1154ms.
[18:26:31.021] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:31.325] <TB2> INFO: Expecting 2560 events.
[18:26:32.178] <TB2> INFO: 2560 events read in total (297ms).
[18:26:32.178] <TB2> INFO: Test took 1157ms.
[18:26:32.180] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:32.484] <TB2> INFO: Expecting 2560 events.
[18:26:33.338] <TB2> INFO: 2560 events read in total (298ms).
[18:26:33.339] <TB2> INFO: Test took 1159ms.
[18:26:33.341] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:33.646] <TB2> INFO: Expecting 2560 events.
[18:26:34.505] <TB2> INFO: 2560 events read in total (303ms).
[18:26:34.505] <TB2> INFO: Test took 1165ms.
[18:26:34.509] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:34.812] <TB2> INFO: Expecting 2560 events.
[18:26:35.668] <TB2> INFO: 2560 events read in total (300ms).
[18:26:35.668] <TB2> INFO: Test took 1159ms.
[18:26:35.670] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:35.974] <TB2> INFO: Expecting 2560 events.
[18:26:36.830] <TB2> INFO: 2560 events read in total (300ms).
[18:26:36.830] <TB2> INFO: Test took 1160ms.
[18:26:36.833] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:37.136] <TB2> INFO: Expecting 2560 events.
[18:26:37.995] <TB2> INFO: 2560 events read in total (302ms).
[18:26:37.996] <TB2> INFO: Test took 1163ms.
[18:26:37.999] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:38.302] <TB2> INFO: Expecting 2560 events.
[18:26:39.166] <TB2> INFO: 2560 events read in total (307ms).
[18:26:39.166] <TB2> INFO: Test took 1167ms.
[18:26:39.170] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:39.473] <TB2> INFO: Expecting 2560 events.
[18:26:40.329] <TB2> INFO: 2560 events read in total (300ms).
[18:26:40.329] <TB2> INFO: Test took 1160ms.
[18:26:40.332] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:40.635] <TB2> INFO: Expecting 2560 events.
[18:26:41.487] <TB2> INFO: 2560 events read in total (295ms).
[18:26:41.488] <TB2> INFO: Test took 1156ms.
[18:26:41.490] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:41.793] <TB2> INFO: Expecting 2560 events.
[18:26:42.648] <TB2> INFO: 2560 events read in total (298ms).
[18:26:42.648] <TB2> INFO: Test took 1159ms.
[18:26:42.651] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:42.955] <TB2> INFO: Expecting 2560 events.
[18:26:43.809] <TB2> INFO: 2560 events read in total (298ms).
[18:26:43.810] <TB2> INFO: Test took 1160ms.
[18:26:43.812] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:44.116] <TB2> INFO: Expecting 2560 events.
[18:26:44.970] <TB2> INFO: 2560 events read in total (298ms).
[18:26:44.970] <TB2> INFO: Test took 1158ms.
[18:26:44.972] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:45.276] <TB2> INFO: Expecting 2560 events.
[18:26:46.129] <TB2> INFO: 2560 events read in total (296ms).
[18:26:46.129] <TB2> INFO: Test took 1157ms.
[18:26:46.131] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:46.435] <TB2> INFO: Expecting 2560 events.
[18:26:47.289] <TB2> INFO: 2560 events read in total (298ms).
[18:26:47.289] <TB2> INFO: Test took 1158ms.
[18:26:47.291] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:47.595] <TB2> INFO: Expecting 2560 events.
[18:26:48.453] <TB2> INFO: 2560 events read in total (301ms).
[18:26:48.454] <TB2> INFO: Test took 1163ms.
[18:26:48.456] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:26:48.760] <TB2> INFO: Expecting 2560 events.
[18:26:49.613] <TB2> INFO: 2560 events read in total (297ms).
[18:26:49.613] <TB2> INFO: Test took 1157ms.
[18:26:50.092] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 615 seconds
[18:26:50.092] <TB2> INFO: PH scale (per ROC): 70 81 78 76 71 66 81 76 75 83 75 77 76 75 80 76
[18:26:50.092] <TB2> INFO: PH offset (per ROC): 176 163 155 184 173 169 160 177 163 174 173 180 175 193 181 176
[18:26:50.096] <TB2> INFO: Decoding statistics:
[18:26:50.096] <TB2> INFO: General information:
[18:26:50.096] <TB2> INFO: 16bit words read: 91928
[18:26:50.096] <TB2> INFO: valid events total: 10240
[18:26:50.096] <TB2> INFO: empty events: 7738
[18:26:50.096] <TB2> INFO: valid events with pixels: 2502
[18:26:50.096] <TB2> INFO: valid pixel hits: 2502
[18:26:50.096] <TB2> INFO: Event errors: 0
[18:26:50.096] <TB2> INFO: start marker: 0
[18:26:50.096] <TB2> INFO: stop marker: 0
[18:26:50.096] <TB2> INFO: overflow: 0
[18:26:50.096] <TB2> INFO: invalid 5bit words: 0
[18:26:50.096] <TB2> INFO: invalid XOR eye diagram: 0
[18:26:50.096] <TB2> INFO: frame (failed synchr.): 0
[18:26:50.096] <TB2> INFO: idle data (no TBM trl): 0
[18:26:50.096] <TB2> INFO: no data (only TBM hdr): 0
[18:26:50.096] <TB2> INFO: TBM errors: 0
[18:26:50.096] <TB2> INFO: flawed TBM headers: 0
[18:26:50.096] <TB2> INFO: flawed TBM trailers: 0
[18:26:50.096] <TB2> INFO: event ID mismatches: 0
[18:26:50.097] <TB2> INFO: ROC errors: 0
[18:26:50.097] <TB2> INFO: missing ROC header(s): 0
[18:26:50.097] <TB2> INFO: misplaced readback start: 0
[18:26:50.097] <TB2> INFO: Pixel decoding errors: 0
[18:26:50.097] <TB2> INFO: pixel data incomplete: 0
[18:26:50.097] <TB2> INFO: pixel address: 0
[18:26:50.097] <TB2> INFO: pulse height fill bit: 0
[18:26:50.097] <TB2> INFO: buffer corruption: 0
[18:26:50.262] <TB2> INFO: ######################################################################
[18:26:50.262] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[18:26:50.262] <TB2> INFO: ######################################################################
[18:26:50.272] <TB2> INFO: scanning low vcal = 10
[18:26:50.528] <TB2> INFO: Expecting 41600 events.
[18:26:54.064] <TB2> INFO: 41600 events read in total (2980ms).
[18:26:54.065] <TB2> INFO: Test took 3793ms.
[18:26:54.066] <TB2> INFO: scanning low vcal = 20
[18:26:54.370] <TB2> INFO: Expecting 41600 events.
[18:26:57.926] <TB2> INFO: 41600 events read in total (3000ms).
[18:26:57.926] <TB2> INFO: Test took 3860ms.
[18:26:57.928] <TB2> INFO: scanning low vcal = 30
[18:26:58.230] <TB2> INFO: Expecting 41600 events.
[18:27:01.801] <TB2> INFO: 41600 events read in total (3015ms).
[18:27:01.802] <TB2> INFO: Test took 3874ms.
[18:27:01.803] <TB2> INFO: scanning low vcal = 40
[18:27:02.100] <TB2> INFO: Expecting 41600 events.
[18:27:06.308] <TB2> INFO: 41600 events read in total (3652ms).
[18:27:06.309] <TB2> INFO: Test took 4505ms.
[18:27:06.312] <TB2> INFO: scanning low vcal = 50
[18:27:06.571] <TB2> INFO: Expecting 41600 events.
[18:27:10.795] <TB2> INFO: 41600 events read in total (3668ms).
[18:27:10.796] <TB2> INFO: Test took 4483ms.
[18:27:10.799] <TB2> INFO: scanning low vcal = 60
[18:27:11.088] <TB2> INFO: Expecting 41600 events.
[18:27:15.282] <TB2> INFO: 41600 events read in total (3638ms).
[18:27:15.283] <TB2> INFO: Test took 4484ms.
[18:27:15.285] <TB2> INFO: scanning low vcal = 70
[18:27:15.547] <TB2> INFO: Expecting 41600 events.
[18:27:19.784] <TB2> INFO: 41600 events read in total (3681ms).
[18:27:19.784] <TB2> INFO: Test took 4499ms.
[18:27:19.787] <TB2> INFO: scanning low vcal = 80
[18:27:20.053] <TB2> INFO: Expecting 41600 events.
[18:27:24.327] <TB2> INFO: 41600 events read in total (3718ms).
[18:27:24.328] <TB2> INFO: Test took 4541ms.
[18:27:24.331] <TB2> INFO: scanning low vcal = 90
[18:27:24.611] <TB2> INFO: Expecting 41600 events.
[18:27:28.855] <TB2> INFO: 41600 events read in total (3687ms).
[18:27:28.855] <TB2> INFO: Test took 4524ms.
[18:27:28.859] <TB2> INFO: scanning low vcal = 100
[18:27:29.155] <TB2> INFO: Expecting 41600 events.
[18:27:33.348] <TB2> INFO: 41600 events read in total (3637ms).
[18:27:33.349] <TB2> INFO: Test took 4490ms.
[18:27:33.351] <TB2> INFO: scanning low vcal = 110
[18:27:33.624] <TB2> INFO: Expecting 41600 events.
[18:27:37.840] <TB2> INFO: 41600 events read in total (3659ms).
[18:27:37.841] <TB2> INFO: Test took 4489ms.
[18:27:37.849] <TB2> INFO: scanning low vcal = 120
[18:27:38.121] <TB2> INFO: Expecting 41600 events.
[18:27:42.284] <TB2> INFO: 41600 events read in total (3607ms).
[18:27:42.285] <TB2> INFO: Test took 4436ms.
[18:27:42.287] <TB2> INFO: scanning low vcal = 130
[18:27:42.546] <TB2> INFO: Expecting 41600 events.
[18:27:46.730] <TB2> INFO: 41600 events read in total (3628ms).
[18:27:46.730] <TB2> INFO: Test took 4443ms.
[18:27:46.733] <TB2> INFO: scanning low vcal = 140
[18:27:46.990] <TB2> INFO: Expecting 41600 events.
[18:27:51.148] <TB2> INFO: 41600 events read in total (3601ms).
[18:27:51.148] <TB2> INFO: Test took 4415ms.
[18:27:51.151] <TB2> INFO: scanning low vcal = 150
[18:27:51.410] <TB2> INFO: Expecting 41600 events.
[18:27:55.606] <TB2> INFO: 41600 events read in total (3639ms).
[18:27:55.607] <TB2> INFO: Test took 4456ms.
[18:27:55.609] <TB2> INFO: scanning low vcal = 160
[18:27:55.867] <TB2> INFO: Expecting 41600 events.
[18:28:00.070] <TB2> INFO: 41600 events read in total (3646ms).
[18:28:00.071] <TB2> INFO: Test took 4462ms.
[18:28:00.073] <TB2> INFO: scanning low vcal = 170
[18:28:00.352] <TB2> INFO: Expecting 41600 events.
[18:28:04.562] <TB2> INFO: 41600 events read in total (3653ms).
[18:28:04.563] <TB2> INFO: Test took 4490ms.
[18:28:04.566] <TB2> INFO: scanning low vcal = 180
[18:28:04.858] <TB2> INFO: Expecting 41600 events.
[18:28:09.058] <TB2> INFO: 41600 events read in total (3644ms).
[18:28:09.058] <TB2> INFO: Test took 4492ms.
[18:28:09.061] <TB2> INFO: scanning low vcal = 190
[18:28:09.320] <TB2> INFO: Expecting 41600 events.
[18:28:13.532] <TB2> INFO: 41600 events read in total (3656ms).
[18:28:13.532] <TB2> INFO: Test took 4471ms.
[18:28:13.535] <TB2> INFO: scanning low vcal = 200
[18:28:13.792] <TB2> INFO: Expecting 41600 events.
[18:28:17.981] <TB2> INFO: 41600 events read in total (3633ms).
[18:28:17.982] <TB2> INFO: Test took 4447ms.
[18:28:17.984] <TB2> INFO: scanning low vcal = 210
[18:28:18.242] <TB2> INFO: Expecting 41600 events.
[18:28:22.428] <TB2> INFO: 41600 events read in total (3630ms).
[18:28:22.429] <TB2> INFO: Test took 4445ms.
[18:28:22.431] <TB2> INFO: scanning low vcal = 220
[18:28:22.694] <TB2> INFO: Expecting 41600 events.
[18:28:26.877] <TB2> INFO: 41600 events read in total (3627ms).
[18:28:26.877] <TB2> INFO: Test took 4445ms.
[18:28:26.883] <TB2> INFO: scanning low vcal = 230
[18:28:27.139] <TB2> INFO: Expecting 41600 events.
[18:28:31.349] <TB2> INFO: 41600 events read in total (3654ms).
[18:28:31.349] <TB2> INFO: Test took 4466ms.
[18:28:31.352] <TB2> INFO: scanning low vcal = 240
[18:28:31.610] <TB2> INFO: Expecting 41600 events.
[18:28:35.817] <TB2> INFO: 41600 events read in total (3650ms).
[18:28:35.818] <TB2> INFO: Test took 4466ms.
[18:28:35.821] <TB2> INFO: scanning low vcal = 250
[18:28:36.079] <TB2> INFO: Expecting 41600 events.
[18:28:40.329] <TB2> INFO: 41600 events read in total (3694ms).
[18:28:40.330] <TB2> INFO: Test took 4509ms.
[18:28:40.334] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[18:28:40.632] <TB2> INFO: Expecting 41600 events.
[18:28:44.890] <TB2> INFO: 41600 events read in total (3701ms).
[18:28:44.891] <TB2> INFO: Test took 4557ms.
[18:28:44.903] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[18:28:45.163] <TB2> INFO: Expecting 41600 events.
[18:28:49.443] <TB2> INFO: 41600 events read in total (3724ms).
[18:28:49.444] <TB2> INFO: Test took 4540ms.
[18:28:49.447] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[18:28:49.739] <TB2> INFO: Expecting 41600 events.
[18:28:53.964] <TB2> INFO: 41600 events read in total (3669ms).
[18:28:53.964] <TB2> INFO: Test took 4517ms.
[18:28:53.967] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[18:28:54.233] <TB2> INFO: Expecting 41600 events.
[18:28:58.433] <TB2> INFO: 41600 events read in total (3644ms).
[18:28:58.434] <TB2> INFO: Test took 4467ms.
[18:28:58.436] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[18:28:58.696] <TB2> INFO: Expecting 41600 events.
[18:29:02.888] <TB2> INFO: 41600 events read in total (3636ms).
[18:29:02.889] <TB2> INFO: Test took 4453ms.
[18:29:03.335] <TB2> INFO: PixTestGainPedestal::measure() done
[18:29:34.386] <TB2> INFO: PixTestGainPedestal::fit() done
[18:29:34.386] <TB2> INFO: non-linearity mean: 0.958 0.952 0.948 0.950 0.961 0.955 0.953 0.952 0.957 0.954 0.962 0.957 0.960 0.964 0.960 0.957
[18:29:34.386] <TB2> INFO: non-linearity RMS: 0.007 0.006 0.007 0.008 0.006 0.007 0.006 0.007 0.007 0.006 0.007 0.007 0.006 0.007 0.005 0.009
[18:29:34.386] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[18:29:34.405] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[18:29:34.422] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[18:29:34.440] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[18:29:34.458] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[18:29:34.476] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[18:29:34.494] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[18:29:34.512] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[18:29:34.530] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[18:29:34.548] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[18:29:34.566] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[18:29:34.584] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[18:29:34.601] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[18:29:34.619] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[18:29:34.636] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[18:29:34.653] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[18:29:34.670] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 164 seconds
[18:29:34.670] <TB2> INFO: Decoding statistics:
[18:29:34.670] <TB2> INFO: General information:
[18:29:34.671] <TB2> INFO: 16bit words read: 2662400
[18:29:34.671] <TB2> INFO: valid events total: 166400
[18:29:34.671] <TB2> INFO: empty events: 0
[18:29:34.671] <TB2> INFO: valid events with pixels: 166400
[18:29:34.671] <TB2> INFO: valid pixel hits: 665570
[18:29:34.671] <TB2> INFO: Event errors: 0
[18:29:34.671] <TB2> INFO: start marker: 0
[18:29:34.671] <TB2> INFO: stop marker: 0
[18:29:34.671] <TB2> INFO: overflow: 0
[18:29:34.671] <TB2> INFO: invalid 5bit words: 0
[18:29:34.671] <TB2> INFO: invalid XOR eye diagram: 0
[18:29:34.671] <TB2> INFO: frame (failed synchr.): 0
[18:29:34.671] <TB2> INFO: idle data (no TBM trl): 0
[18:29:34.671] <TB2> INFO: no data (only TBM hdr): 0
[18:29:34.671] <TB2> INFO: TBM errors: 0
[18:29:34.671] <TB2> INFO: flawed TBM headers: 0
[18:29:34.671] <TB2> INFO: flawed TBM trailers: 0
[18:29:34.671] <TB2> INFO: event ID mismatches: 0
[18:29:34.671] <TB2> INFO: ROC errors: 0
[18:29:34.671] <TB2> INFO: missing ROC header(s): 0
[18:29:34.671] <TB2> INFO: misplaced readback start: 0
[18:29:34.671] <TB2> INFO: Pixel decoding errors: 0
[18:29:34.671] <TB2> INFO: pixel data incomplete: 0
[18:29:34.671] <TB2> INFO: pixel address: 0
[18:29:34.671] <TB2> INFO: pulse height fill bit: 0
[18:29:34.671] <TB2> INFO: buffer corruption: 0
[18:29:34.678] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C15.dat
[18:29:34.679] <TB2> INFO: ######################################################################
[18:29:34.679] <TB2> INFO: PixTestReadback::doTest()
[18:29:34.679] <TB2> INFO: ######################################################################
[18:29:34.679] <TB2> INFO: ----------------------------------------------------------------------
[18:29:34.679] <TB2> INFO: PixTestReadback::CalibrateVd()
[18:29:34.679] <TB2> INFO: ----------------------------------------------------------------------
[18:29:44.194] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C0.dat
[18:29:44.194] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C1.dat
[18:29:44.194] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C2.dat
[18:29:44.195] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C3.dat
[18:29:44.195] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C4.dat
[18:29:44.195] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C5.dat
[18:29:44.195] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C6.dat
[18:29:44.195] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C7.dat
[18:29:44.195] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C8.dat
[18:29:44.195] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C9.dat
[18:29:44.196] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C10.dat
[18:29:44.196] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C11.dat
[18:29:44.196] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C12.dat
[18:29:44.196] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C13.dat
[18:29:44.196] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C14.dat
[18:29:44.196] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C15.dat
[18:29:44.226] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[18:29:44.226] <TB2> INFO: ----------------------------------------------------------------------
[18:29:44.226] <TB2> INFO: PixTestReadback::CalibrateVa()
[18:29:44.226] <TB2> INFO: ----------------------------------------------------------------------
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C0.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C1.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C2.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C3.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C4.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C5.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C6.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C7.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C8.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C9.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C10.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C11.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C12.dat
[18:29:53.763] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C13.dat
[18:29:53.764] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C14.dat
[18:29:53.764] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C15.dat
[18:29:53.792] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[18:29:53.792] <TB2> INFO: ----------------------------------------------------------------------
[18:29:53.792] <TB2> INFO: PixTestReadback::readbackVbg()
[18:29:53.792] <TB2> INFO: ----------------------------------------------------------------------
[18:30:01.103] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[18:30:01.103] <TB2> INFO: ----------------------------------------------------------------------
[18:30:01.103] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[18:30:01.103] <TB2> INFO: ----------------------------------------------------------------------
[18:30:01.103] <TB2> INFO: Vbg will be calibrated using Vd calibration
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 157.1calibrated Vbg = 1.21626 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 157.4calibrated Vbg = 1.213 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 141.3calibrated Vbg = 1.21895 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 157calibrated Vbg = 1.22888 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 159.8calibrated Vbg = 1.22675 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 148.6calibrated Vbg = 1.2285 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 145.1calibrated Vbg = 1.22583 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 153.4calibrated Vbg = 1.22639 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 153.9calibrated Vbg = 1.23003 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 160.1calibrated Vbg = 1.22847 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 146.9calibrated Vbg = 1.22332 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 149.1calibrated Vbg = 1.22561 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 154.6calibrated Vbg = 1.21493 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 157calibrated Vbg = 1.21955 :::*/*/*/*/
[18:30:01.103] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 160.1calibrated Vbg = 1.22181 :::*/*/*/*/
[18:30:01.104] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 158.1calibrated Vbg = 1.21842 :::*/*/*/*/
[18:30:01.105] <TB2> INFO: ----------------------------------------------------------------------
[18:30:01.105] <TB2> INFO: PixTestReadback::CalibrateIa()
[18:30:01.105] <TB2> INFO: ----------------------------------------------------------------------
[18:32:36.518] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C0.dat
[18:32:36.518] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C1.dat
[18:32:36.518] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C2.dat
[18:32:36.518] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C3.dat
[18:32:36.518] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C4.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C5.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C6.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C7.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C8.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C9.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C10.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C11.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C12.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C13.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C14.dat
[18:32:36.519] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2306_FullQualification_2016-08-31_11h57m_1472637425//004_FulltestPxar_p17//readbackCal_C15.dat
[18:32:36.546] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[18:32:36.547] <TB2> INFO: PixTestReadback::doTest() done
[18:32:36.547] <TB2> INFO: Decoding statistics:
[18:32:36.547] <TB2> INFO: General information:
[18:32:36.547] <TB2> INFO: 16bit words read: 1024
[18:32:36.547] <TB2> INFO: valid events total: 128
[18:32:36.547] <TB2> INFO: empty events: 128
[18:32:36.547] <TB2> INFO: valid events with pixels: 0
[18:32:36.547] <TB2> INFO: valid pixel hits: 0
[18:32:36.547] <TB2> INFO: Event errors: 0
[18:32:36.547] <TB2> INFO: start marker: 0
[18:32:36.547] <TB2> INFO: stop marker: 0
[18:32:36.547] <TB2> INFO: overflow: 0
[18:32:36.547] <TB2> INFO: invalid 5bit words: 0
[18:32:36.547] <TB2> INFO: invalid XOR eye diagram: 0
[18:32:36.547] <TB2> INFO: frame (failed synchr.): 0
[18:32:36.547] <TB2> INFO: idle data (no TBM trl): 0
[18:32:36.547] <TB2> INFO: no data (only TBM hdr): 0
[18:32:36.547] <TB2> INFO: TBM errors: 0
[18:32:36.547] <TB2> INFO: flawed TBM headers: 0
[18:32:36.547] <TB2> INFO: flawed TBM trailers: 0
[18:32:36.547] <TB2> INFO: event ID mismatches: 0
[18:32:36.547] <TB2> INFO: ROC errors: 0
[18:32:36.547] <TB2> INFO: missing ROC header(s): 0
[18:32:36.547] <TB2> INFO: misplaced readback start: 0
[18:32:36.547] <TB2> INFO: Pixel decoding errors: 0
[18:32:36.547] <TB2> INFO: pixel data incomplete: 0
[18:32:36.547] <TB2> INFO: pixel address: 0
[18:32:36.547] <TB2> INFO: pulse height fill bit: 0
[18:32:36.547] <TB2> INFO: buffer corruption: 0
[18:32:36.564] <TB2> INFO: Decoding statistics:
[18:32:36.564] <TB2> INFO: General information:
[18:32:36.564] <TB2> INFO: 16bit words read: 2755352
[18:32:36.564] <TB2> INFO: valid events total: 176768
[18:32:36.564] <TB2> INFO: empty events: 7866
[18:32:36.564] <TB2> INFO: valid events with pixels: 168902
[18:32:36.564] <TB2> INFO: valid pixel hits: 668072
[18:32:36.564] <TB2> INFO: Event errors: 0
[18:32:36.564] <TB2> INFO: start marker: 0
[18:32:36.564] <TB2> INFO: stop marker: 0
[18:32:36.564] <TB2> INFO: overflow: 0
[18:32:36.564] <TB2> INFO: invalid 5bit words: 0
[18:32:36.564] <TB2> INFO: invalid XOR eye diagram: 0
[18:32:36.564] <TB2> INFO: frame (failed synchr.): 0
[18:32:36.564] <TB2> INFO: idle data (no TBM trl): 0
[18:32:36.564] <TB2> INFO: no data (only TBM hdr): 0
[18:32:36.564] <TB2> INFO: TBM errors: 0
[18:32:36.564] <TB2> INFO: flawed TBM headers: 0
[18:32:36.564] <TB2> INFO: flawed TBM trailers: 0
[18:32:36.564] <TB2> INFO: event ID mismatches: 0
[18:32:36.564] <TB2> INFO: ROC errors: 0
[18:32:36.564] <TB2> INFO: missing ROC header(s): 0
[18:32:36.564] <TB2> INFO: misplaced readback start: 0
[18:32:36.564] <TB2> INFO: Pixel decoding errors: 0
[18:32:36.564] <TB2> INFO: pixel data incomplete: 0
[18:32:36.564] <TB2> INFO: pixel address: 0
[18:32:36.564] <TB2> INFO: pulse height fill bit: 0
[18:32:36.564] <TB2> INFO: buffer corruption: 0
[18:32:36.564] <TB2> INFO: enter test to run
[18:32:36.564] <TB2> INFO: test: exit no parameter change
[18:32:36.748] <TB2> QUIET: Connection to board 156 closed.
[18:32:36.828] <TB2> INFO: pXar: this is the end, my friend