[13:45:07.096] <TB2> INFO: *** Welcome to pxar ***
[13:45:07.096] <TB2> INFO: *** Today: 2016/04/10
[13:45:07.193] <TB2> INFO: *** Version: 9751-dirty
[13:45:07.193] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C15.dat
[13:45:07.195] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//tbmParameters_C0b.dat
[13:45:07.196] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//defaultMaskFile.dat
[13:45:07.196] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters_C15.dat
[13:45:07.292] <TB2> INFO: clk: 4
[13:45:07.292] <TB2> INFO: ctr: 4
[13:45:07.292] <TB2> INFO: sda: 19
[13:45:07.292] <TB2> INFO: tin: 9
[13:45:07.292] <TB2> INFO: level: 15
[13:45:07.292] <TB2> INFO: triggerdelay: 0
[13:45:07.292] <TB2> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[13:45:07.292] <TB2> INFO: Log level: INFO
[13:45:07.299] <TB2> INFO: Found DTB DTB_WXC55Z
[13:45:07.309] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[13:45:07.311] <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:
------------------------------------------------------
[13:45:07.313] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[13:45:08.874] <TB2> INFO: DUT info:
[13:45:08.874] <TB2> INFO: The DUT currently contains the following objects:
[13:45:08.874] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:45:08.874] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:45:08.874] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:45:08.874] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:45:08.874] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:08.875] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:45:09.275] <TB2> INFO: enter 'restricted' command line mode
[13:45:09.275] <TB2> INFO: enter test to run
[13:45:09.276] <TB2> INFO: test: pretest no parameter change
[13:45:09.276] <TB2> INFO: running: pretest
[13:45:09.280] <TB2> INFO: ----------------------------------------------------------------------
[13:45:09.280] <TB2> INFO: PixTestPretest::programROC()
[13:45:09.280] <TB2> INFO: ----------------------------------------------------------------------
[13:45:27.294] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[13:45:27.294] <TB2> INFO: IA differences per ROC: 19.3 18.5 19.3 17.7 16.9 19.3 17.7 19.3 20.1 16.9 16.9 20.9 19.3 18.5 20.1 20.1
[13:45:27.391] <TB2> INFO: enter test to run
[13:45:27.391] <TB2> INFO: test: pretest no parameter change
[13:45:27.391] <TB2> INFO: running: pretest
[13:45:27.392] <TB2> INFO: ----------------------------------------------------------------------
[13:45:27.392] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[13:45:27.392] <TB2> INFO: ----------------------------------------------------------------------
[13:45:48.656] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 392.3 mA = 24.5187 mA/ROC
[13:45:48.656] <TB2> INFO: i(loss) [mA/ROC]: 20.9 20.1 20.9 20.1 20.1 20.1 20.1 20.1 20.1 20.1 20.1 20.1 20.1 20.1 20.9 19.3
[13:45:48.695] <TB2> INFO: enter test to run
[13:45:48.695] <TB2> INFO: test: pretest no parameter change
[13:45:48.695] <TB2> INFO: running: pretest
[13:45:48.696] <TB2> INFO: ----------------------------------------------------------------------
[13:45:48.696] <TB2> INFO: PixTestPretest::findTiming()
[13:45:48.696] <TB2> INFO: ----------------------------------------------------------------------
[13:45:48.696] <TB2> INFO: PixTestCmd::init()

[13:47:18.653] <TB2> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[13:47:18.653] <TB2> INFO: (success/tries = 100/100), width = 4
[13:47:18.654] <TB2> INFO: enter test to run
[13:47:18.654] <TB2> INFO: test: pretest no parameter change
[13:47:18.654] <TB2> INFO: running: pretest
[13:47:18.655] <TB2> INFO: ----------------------------------------------------------------------
[13:47:18.655] <TB2> INFO: PixTestPretest::findWorkingPixel()
[13:47:18.655] <TB2> INFO: ----------------------------------------------------------------------
[13:47:18.746] <TB2> INFO: Expecting 231680 events.


[13:47:28.956] <TB2> INFO: 231680 events read in total (9654ms).
[13:47:28.960] <TB2> INFO: Test took 10303ms.
[13:47:29.202] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[13:47:29.276] <TB2> INFO: enter test to run
[13:47:29.276] <TB2> INFO: test: pretest no parameter change
[13:47:29.276] <TB2> INFO: running: pretest
[13:47:29.277] <TB2> INFO: ----------------------------------------------------------------------
[13:47:29.277] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[13:47:29.277] <TB2> INFO: ----------------------------------------------------------------------
[13:47:29.369] <TB2> INFO: Expecting 231680 events.
[13:47:39.511] <TB2> INFO: 231680 events read in total (9586ms).
[13:47:39.515] <TB2> INFO: Test took 10235ms.
[13:47:39.747] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[13:47:39.747] <TB2> INFO: CalDel: 143 154 148 123 145 143 149 129 126 118 147 169 131 140 161 154
[13:47:39.747] <TB2> INFO: VthrComp: 52 51 51 52 51 51 51 51 51 51 51 56 51 52 51 51
[13:47:39.782] <TB2> INFO: enter test to run
[13:47:39.782] <TB2> INFO: test: pretest no parameter change
[13:47:39.782] <TB2> INFO: running: pretest
[13:47:39.782] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C0.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C1.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C2.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C3.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C4.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C5.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C6.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C7.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C8.dat
[13:47:39.783] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C9.dat
[13:47:39.784] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C10.dat
[13:47:39.784] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C11.dat
[13:47:39.784] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C12.dat
[13:47:39.784] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C13.dat
[13:47:39.784] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C14.dat
[13:47:39.784] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters_C15.dat
[13:47:39.785] <TB2> INFO: enter test to run
[13:47:39.785] <TB2> INFO: test: fulltest no parameter change
[13:47:39.785] <TB2> INFO: running: fulltest
[13:47:39.785] <TB2> INFO: ######################################################################
[13:47:39.785] <TB2> INFO: PixTestFullTest::doTest()
[13:47:39.785] <TB2> INFO: ######################################################################
[13:47:39.786] <TB2> INFO: ######################################################################
[13:47:39.786] <TB2> INFO: PixTestAlive::doTest()
[13:47:39.786] <TB2> INFO: ######################################################################
[13:47:39.787] <TB2> INFO: ----------------------------------------------------------------------
[13:47:39.787] <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)
[13:47:39.787] <TB2> INFO: ----------------------------------------------------------------------
[13:47:40.055] <TB2> INFO: Expecting 41600 events.
[13:47:43.882] <TB2> INFO: 41600 events read in total (3271ms).
[13:47:43.883] <TB2> INFO: Test took 4095ms.
[13:47:44.106] <TB2> INFO: PixTestAlive::aliveTest() done
[13:47:44.106] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:47:44.107] <TB2> INFO: ----------------------------------------------------------------------
[13:47:44.107] <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)
[13:47:44.108] <TB2> INFO: ----------------------------------------------------------------------
[13:47:44.372] <TB2> INFO: Expecting 41600 events.
[13:47:47.371] <TB2> INFO: 41600 events read in total (2443ms).
[13:47:47.371] <TB2> INFO: Test took 3262ms.
[13:47:47.372] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:47:47.613] <TB2> INFO: PixTestAlive::maskTest() done
[13:47:47.613] <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
[13:47:47.614] <TB2> INFO: ----------------------------------------------------------------------
[13:47:47.614] <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)
[13:47:47.614] <TB2> INFO: ----------------------------------------------------------------------
[13:47:47.888] <TB2> INFO: Expecting 41600 events.
[13:47:51.675] <TB2> INFO: 41600 events read in total (3231ms).
[13:47:51.676] <TB2> INFO: Test took 4061ms.
[13:47:51.905] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:47:51.905] <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
[13:47:51.905] <TB2> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[13:47:51.905] <TB2> INFO: Decoding statistics:
[13:47:51.905] <TB2> INFO: General information:
[13:47:51.905] <TB2> INFO: 16bit words read: 0
[13:47:51.905] <TB2> INFO: valid events total: 0
[13:47:51.905] <TB2> INFO: empty events: 0
[13:47:51.905] <TB2> INFO: valid events with pixels: 0
[13:47:51.905] <TB2> INFO: valid pixel hits: 0
[13:47:51.905] <TB2> INFO: Event errors: 0
[13:47:51.905] <TB2> INFO: start marker: 0
[13:47:51.905] <TB2> INFO: stop marker: 0
[13:47:51.905] <TB2> INFO: overflow: 0
[13:47:51.905] <TB2> INFO: invalid 5bit words: 0
[13:47:51.905] <TB2> INFO: invalid XOR eye diagram: 0
[13:47:51.905] <TB2> INFO: frame (failed synchr.): 0
[13:47:51.905] <TB2> INFO: idle data (no TBM trl): 0
[13:47:51.905] <TB2> INFO: no data (only TBM hdr): 0
[13:47:51.905] <TB2> INFO: TBM errors: 0
[13:47:51.905] <TB2> INFO: flawed TBM headers: 0
[13:47:51.905] <TB2> INFO: flawed TBM trailers: 0
[13:47:51.905] <TB2> INFO: event ID mismatches: 0
[13:47:51.905] <TB2> INFO: ROC errors: 0
[13:47:51.905] <TB2> INFO: missing ROC header(s): 0
[13:47:51.905] <TB2> INFO: misplaced readback start: 0
[13:47:51.905] <TB2> INFO: Pixel decoding errors: 0
[13:47:51.905] <TB2> INFO: pixel data incomplete: 0
[13:47:51.905] <TB2> INFO: pixel address: 0
[13:47:51.905] <TB2> INFO: pulse height fill bit: 0
[13:47:51.905] <TB2> INFO: buffer corruption: 0
[13:47:51.912] <TB2> INFO: ######################################################################
[13:47:51.912] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[13:47:51.912] <TB2> INFO: ######################################################################
[13:47:51.915] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[13:47:51.926] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[13:47:51.926] <TB2> INFO: run 1 of 1
[13:47:52.211] <TB2> INFO: Expecting 3120000 events.
[13:48:33.611] <TB2> INFO: 867700 events read in total (40844ms).
[13:49:13.742] <TB2> INFO: 1724195 events read in total (80975ms).
[13:49:54.711] <TB2> INFO: 2590950 events read in total (121945ms).
[13:50:19.412] <TB2> INFO: 3120000 events read in total (146645ms).
[13:50:19.467] <TB2> INFO: Test took 147542ms.
[13:50:43.626] <TB2> INFO: PixTestBBMap::doTest() done, duration: 171 seconds
[13:50:43.627] <TB2> INFO: number of dead bumps (per ROC): 1 0 0 0 0 0 0 0 9 2 4 0 2 3 14 35
[13:50:43.627] <TB2> INFO: separation cut (per ROC): 102 101 76 110 102 94 100 99 75 93 79 119 109 103 83 77
[13:50:43.627] <TB2> INFO: Decoding statistics:
[13:50:43.627] <TB2> INFO: General information:
[13:50:43.627] <TB2> INFO: 16bit words read: 0
[13:50:43.627] <TB2> INFO: valid events total: 0
[13:50:43.627] <TB2> INFO: empty events: 0
[13:50:43.627] <TB2> INFO: valid events with pixels: 0
[13:50:43.627] <TB2> INFO: valid pixel hits: 0
[13:50:43.627] <TB2> INFO: Event errors: 0
[13:50:43.627] <TB2> INFO: start marker: 0
[13:50:43.627] <TB2> INFO: stop marker: 0
[13:50:43.627] <TB2> INFO: overflow: 0
[13:50:43.627] <TB2> INFO: invalid 5bit words: 0
[13:50:43.627] <TB2> INFO: invalid XOR eye diagram: 0
[13:50:43.627] <TB2> INFO: frame (failed synchr.): 0
[13:50:43.627] <TB2> INFO: idle data (no TBM trl): 0
[13:50:43.627] <TB2> INFO: no data (only TBM hdr): 0
[13:50:43.627] <TB2> INFO: TBM errors: 0
[13:50:43.627] <TB2> INFO: flawed TBM headers: 0
[13:50:43.627] <TB2> INFO: flawed TBM trailers: 0
[13:50:43.627] <TB2> INFO: event ID mismatches: 0
[13:50:43.627] <TB2> INFO: ROC errors: 0
[13:50:43.627] <TB2> INFO: missing ROC header(s): 0
[13:50:43.627] <TB2> INFO: misplaced readback start: 0
[13:50:43.627] <TB2> INFO: Pixel decoding errors: 0
[13:50:43.627] <TB2> INFO: pixel data incomplete: 0
[13:50:43.627] <TB2> INFO: pixel address: 0
[13:50:43.627] <TB2> INFO: pulse height fill bit: 0
[13:50:43.627] <TB2> INFO: buffer corruption: 0
[13:50:43.731] <TB2> INFO: ######################################################################
[13:50:43.731] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[13:50:43.731] <TB2> INFO: ######################################################################
[13:50:43.732] <TB2> INFO: ----------------------------------------------------------------------
[13:50:43.732] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[13:50:43.732] <TB2> INFO: ----------------------------------------------------------------------
[13:50:43.732] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[13:50:43.743] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[13:50:43.743] <TB2> INFO: run 1 of 1
[13:50:44.066] <TB2> INFO: Expecting 26208000 events.
[13:51:18.395] <TB2> INFO: 931800 events read in total (33769ms).
[13:51:51.972] <TB2> INFO: 1848850 events read in total (67346ms).
[13:52:25.536] <TB2> INFO: 2762550 events read in total (100910ms).
[13:52:58.829] <TB2> INFO: 3676150 events read in total (134203ms).
[13:53:32.098] <TB2> INFO: 4586100 events read in total (167472ms).
[13:54:05.608] <TB2> INFO: 5493100 events read in total (200982ms).
[13:54:38.784] <TB2> INFO: 6403900 events read in total (234158ms).
[13:55:12.035] <TB2> INFO: 7311800 events read in total (267409ms).
[13:55:45.631] <TB2> INFO: 8217850 events read in total (301005ms).
[13:56:19.100] <TB2> INFO: 9125700 events read in total (334474ms).
[13:56:52.313] <TB2> INFO: 10030550 events read in total (367687ms).
[13:57:25.890] <TB2> INFO: 10935450 events read in total (401264ms).
[13:57:59.150] <TB2> INFO: 11840400 events read in total (434524ms).
[13:58:32.766] <TB2> INFO: 12743300 events read in total (468140ms).
[13:59:06.482] <TB2> INFO: 13639000 events read in total (501856ms).
[13:59:39.577] <TB2> INFO: 14528050 events read in total (534951ms).
[14:00:12.787] <TB2> INFO: 15420650 events read in total (568161ms).
[14:00:46.098] <TB2> INFO: 16311950 events read in total (601472ms).
[14:01:19.089] <TB2> INFO: 17201000 events read in total (634463ms).
[14:01:52.326] <TB2> INFO: 18086850 events read in total (667700ms).
[14:02:25.641] <TB2> INFO: 18975350 events read in total (701015ms).
[14:02:58.711] <TB2> INFO: 19861800 events read in total (734085ms).
[14:03:31.775] <TB2> INFO: 20748800 events read in total (767149ms).
[14:04:05.224] <TB2> INFO: 21633250 events read in total (800598ms).
[14:04:38.100] <TB2> INFO: 22516400 events read in total (833474ms).
[14:05:10.847] <TB2> INFO: 23403800 events read in total (866221ms).
[14:05:44.315] <TB2> INFO: 24290050 events read in total (899689ms).
[14:06:17.581] <TB2> INFO: 25175600 events read in total (932955ms).
[14:06:50.867] <TB2> INFO: 26076250 events read in total (966241ms).
[14:06:55.955] <TB2> INFO: 26208000 events read in total (971329ms).
[14:06:55.991] <TB2> INFO: Test took 972248ms.
[14:06:56.263] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:06:57.771] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:06:59.341] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:00.772] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:02.252] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:03.804] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:05.219] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:06.588] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:07.988] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:09.468] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:10.851] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:12.451] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:13.798] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:15.390] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:16.844] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:18.247] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[14:07:19.992] <TB2> INFO: PixTestScurves::scurves() done
[14:07:19.992] <TB2> INFO: Vcal mean: 105.74 95.35 79.33 105.18 91.88 91.69 100.83 94.53 76.04 90.67 89.30 115.65 95.36 109.58 86.80 80.85
[14:07:19.992] <TB2> INFO: Vcal RMS: 5.86 6.05 4.59 6.29 6.04 5.34 6.17 5.55 3.87 5.95 6.07 7.59 5.86 5.88 6.32 4.26
[14:07:19.992] <TB2> INFO: PixTestScurves::fullTest() done, duration: 996 seconds
[14:07:19.992] <TB2> INFO: Decoding statistics:
[14:07:19.992] <TB2> INFO: General information:
[14:07:19.992] <TB2> INFO: 16bit words read: 0
[14:07:19.992] <TB2> INFO: valid events total: 0
[14:07:19.992] <TB2> INFO: empty events: 0
[14:07:19.992] <TB2> INFO: valid events with pixels: 0
[14:07:19.992] <TB2> INFO: valid pixel hits: 0
[14:07:19.992] <TB2> INFO: Event errors: 0
[14:07:19.992] <TB2> INFO: start marker: 0
[14:07:19.992] <TB2> INFO: stop marker: 0
[14:07:19.992] <TB2> INFO: overflow: 0
[14:07:19.992] <TB2> INFO: invalid 5bit words: 0
[14:07:19.992] <TB2> INFO: invalid XOR eye diagram: 0
[14:07:19.992] <TB2> INFO: frame (failed synchr.): 0
[14:07:19.992] <TB2> INFO: idle data (no TBM trl): 0
[14:07:19.992] <TB2> INFO: no data (only TBM hdr): 0
[14:07:19.992] <TB2> INFO: TBM errors: 0
[14:07:19.992] <TB2> INFO: flawed TBM headers: 0
[14:07:19.992] <TB2> INFO: flawed TBM trailers: 0
[14:07:19.992] <TB2> INFO: event ID mismatches: 0
[14:07:19.992] <TB2> INFO: ROC errors: 0
[14:07:19.992] <TB2> INFO: missing ROC header(s): 0
[14:07:19.992] <TB2> INFO: misplaced readback start: 0
[14:07:19.992] <TB2> INFO: Pixel decoding errors: 0
[14:07:19.992] <TB2> INFO: pixel data incomplete: 0
[14:07:19.992] <TB2> INFO: pixel address: 0
[14:07:19.992] <TB2> INFO: pulse height fill bit: 0
[14:07:19.992] <TB2> INFO: buffer corruption: 0
[14:07:20.080] <TB2> INFO: ######################################################################
[14:07:20.080] <TB2> INFO: PixTestTrim::doTest()
[14:07:20.080] <TB2> INFO: ######################################################################
[14:07:20.081] <TB2> INFO: ----------------------------------------------------------------------
[14:07:20.081] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[14:07:20.081] <TB2> INFO: ----------------------------------------------------------------------
[14:07:20.171] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[14:07:20.171] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[14:07:20.179] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:07:20.179] <TB2> INFO: run 1 of 1
[14:07:20.468] <TB2> INFO: Expecting 6281600 events.
[14:08:00.344] <TB2> INFO: 1082140 events read in total (39317ms).
[14:08:39.969] <TB2> INFO: 2158470 events read in total (78942ms).
[14:09:19.591] <TB2> INFO: 3229760 events read in total (118564ms).
[14:09:59.055] <TB2> INFO: 4305270 events read in total (158028ms).
[14:10:38.580] <TB2> INFO: 5383830 events read in total (197553ms).
[14:11:10.844] <TB2> INFO: 6281600 events read in total (229817ms).
[14:11:10.879] <TB2> INFO: Test took 230700ms.
[14:11:30.290] <TB2> INFO: ROC 0 VthrComp = 100
[14:11:30.290] <TB2> INFO: ROC 1 VthrComp = 92
[14:11:30.290] <TB2> INFO: ROC 2 VthrComp = 80
[14:11:30.290] <TB2> INFO: ROC 3 VthrComp = 103
[14:11:30.290] <TB2> INFO: ROC 4 VthrComp = 92
[14:11:30.290] <TB2> INFO: ROC 5 VthrComp = 94
[14:11:30.290] <TB2> INFO: ROC 6 VthrComp = 99
[14:11:30.291] <TB2> INFO: ROC 7 VthrComp = 99
[14:11:30.291] <TB2> INFO: ROC 8 VthrComp = 83
[14:11:30.291] <TB2> INFO: ROC 9 VthrComp = 92
[14:11:30.291] <TB2> INFO: ROC 10 VthrComp = 89
[14:11:30.291] <TB2> INFO: ROC 11 VthrComp = 104
[14:11:30.291] <TB2> INFO: ROC 12 VthrComp = 99
[14:11:30.291] <TB2> INFO: ROC 13 VthrComp = 103
[14:11:30.291] <TB2> INFO: ROC 14 VthrComp = 89
[14:11:30.291] <TB2> INFO: ROC 15 VthrComp = 85
[14:11:30.291] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[14:11:30.291] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[14:11:30.299] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:11:30.299] <TB2> INFO: run 1 of 1
[14:11:30.576] <TB2> INFO: Expecting 6281600 events.
[14:12:05.975] <TB2> INFO: 759580 events read in total (34842ms).
[14:12:41.251] <TB2> INFO: 1516940 events read in total (70118ms).
[14:13:16.653] <TB2> INFO: 2274910 events read in total (105520ms).
[14:13:51.906] <TB2> INFO: 3033010 events read in total (140773ms).
[14:14:26.795] <TB2> INFO: 3784830 events read in total (175662ms).
[14:15:01.542] <TB2> INFO: 4532800 events read in total (210409ms).
[14:15:36.693] <TB2> INFO: 5278570 events read in total (245560ms).
[14:16:11.069] <TB2> INFO: 6024960 events read in total (279936ms).
[14:16:23.213] <TB2> INFO: 6281600 events read in total (292080ms).
[14:16:23.253] <TB2> INFO: Test took 292953ms.
[14:16:46.803] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 61.731 for pixel 11/62 mean/min/max = 46.8284/31.8539/61.8029
[14:16:46.803] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 63.1146 for pixel 0/3 mean/min/max = 47.5186/31.7825/63.2547
[14:16:46.803] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 58.9011 for pixel 45/21 mean/min/max = 45.4358/31.968/58.9036
[14:16:46.804] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 63.3861 for pixel 42/79 mean/min/max = 47.6567/31.9157/63.3978
[14:16:46.804] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 61.2954 for pixel 20/68 mean/min/max = 46.53/31.542/61.5179
[14:16:46.804] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 58.64 for pixel 6/5 mean/min/max = 45.6126/32.4445/58.7808
[14:16:46.804] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 62.51 for pixel 0/70 mean/min/max = 47.0811/31.2902/62.8721
[14:16:46.804] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 58.6497 for pixel 17/50 mean/min/max = 45.3917/32.062/58.7214
[14:16:46.805] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 55.2095 for pixel 0/53 mean/min/max = 43.8322/32.3905/55.2739
[14:16:46.805] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 61.171 for pixel 1/2 mean/min/max = 46.7069/32.1344/61.2794
[14:16:46.805] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 63.3481 for pixel 0/13 mean/min/max = 47.6673/31.9819/63.3527
[14:16:46.805] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 81.6916 for pixel 21/1 mean/min/max = 58.8792/35.6734/82.0849
[14:16:46.806] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 60.0039 for pixel 0/16 mean/min/max = 45.9631/31.9151/60.0111
[14:16:46.806] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 63.9911 for pixel 16/25 mean/min/max = 48.0511/31.9302/64.172
[14:16:46.806] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 63.5957 for pixel 17/10 mean/min/max = 47.5334/31.2903/63.7765
[14:16:46.806] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 56.1627 for pixel 7/66 mean/min/max = 44.4208/32.5408/56.3008
[14:16:46.807] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:16:46.894] <TB2> INFO: Expecting 514560 events.
[14:16:59.922] <TB2> INFO: 514560 events read in total (12471ms).
[14:16:59.929] <TB2> INFO: Expecting 514560 events.
[14:17:12.730] <TB2> INFO: 514560 events read in total (12395ms).
[14:17:12.739] <TB2> INFO: Expecting 514560 events.
[14:17:25.553] <TB2> INFO: 514560 events read in total (12407ms).
[14:17:25.561] <TB2> INFO: Expecting 514560 events.
[14:17:38.381] <TB2> INFO: 514560 events read in total (12400ms).
[14:17:38.391] <TB2> INFO: Expecting 514560 events.
[14:17:51.142] <TB2> INFO: 514560 events read in total (12333ms).
[14:17:51.154] <TB2> INFO: Expecting 514560 events.
[14:18:03.943] <TB2> INFO: 514560 events read in total (12371ms).
[14:18:03.956] <TB2> INFO: Expecting 514560 events.
[14:18:16.828] <TB2> INFO: 514560 events read in total (12454ms).
[14:18:16.844] <TB2> INFO: Expecting 514560 events.
[14:18:29.633] <TB2> INFO: 514560 events read in total (12380ms).
[14:18:29.650] <TB2> INFO: Expecting 514560 events.
[14:18:42.440] <TB2> INFO: 514560 events read in total (12378ms).
[14:18:42.461] <TB2> INFO: Expecting 514560 events.
[14:18:55.396] <TB2> INFO: 514560 events read in total (12534ms).
[14:18:55.418] <TB2> INFO: Expecting 514560 events.
[14:19:08.296] <TB2> INFO: 514560 events read in total (12476ms).
[14:19:08.323] <TB2> INFO: Expecting 514560 events.
[14:19:21.252] <TB2> INFO: 514560 events read in total (12528ms).
[14:19:21.279] <TB2> INFO: Expecting 514560 events.
[14:19:33.987] <TB2> INFO: 514560 events read in total (12306ms).
[14:19:34.014] <TB2> INFO: Expecting 514560 events.
[14:19:46.889] <TB2> INFO: 514560 events read in total (12473ms).
[14:19:46.917] <TB2> INFO: Expecting 514560 events.
[14:19:59.818] <TB2> INFO: 514560 events read in total (12499ms).
[14:19:59.849] <TB2> INFO: Expecting 514560 events.
[14:20:12.701] <TB2> INFO: 514560 events read in total (12450ms).
[14:20:12.735] <TB2> INFO: Test took 205928ms.
[14:20:13.632] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[14:20:13.640] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:20:13.640] <TB2> INFO: run 1 of 1
[14:20:13.921] <TB2> INFO: Expecting 6281600 events.
[14:20:49.197] <TB2> INFO: 743040 events read in total (34720ms).
[14:21:24.218] <TB2> INFO: 1484310 events read in total (69741ms).
[14:21:58.647] <TB2> INFO: 2226470 events read in total (104170ms).
[14:22:33.266] <TB2> INFO: 2968250 events read in total (138789ms).
[14:23:08.111] <TB2> INFO: 3704390 events read in total (173634ms).
[14:23:42.623] <TB2> INFO: 4435810 events read in total (208146ms).
[14:24:17.086] <TB2> INFO: 5164760 events read in total (242609ms).
[14:24:51.853] <TB2> INFO: 5893080 events read in total (277376ms).
[14:25:10.593] <TB2> INFO: 6281600 events read in total (296116ms).
[14:25:10.639] <TB2> INFO: Test took 296999ms.
[14:25:35.810] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.112191 .. 255.000000
[14:25:35.887] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[14:25:35.894] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:25:35.894] <TB2> INFO: run 1 of 1
[14:25:36.164] <TB2> INFO: Expecting 10649600 events.
[14:26:11.085] <TB2> INFO: 711110 events read in total (34365ms).
[14:26:45.738] <TB2> INFO: 1422350 events read in total (69018ms).
[14:27:20.309] <TB2> INFO: 2134120 events read in total (103589ms).
[14:27:55.077] <TB2> INFO: 2846370 events read in total (138357ms).
[14:28:29.622] <TB2> INFO: 3558870 events read in total (172902ms).
[14:29:04.013] <TB2> INFO: 4271280 events read in total (207293ms).
[14:29:38.519] <TB2> INFO: 4983310 events read in total (241799ms).
[14:30:13.084] <TB2> INFO: 5695670 events read in total (276364ms).
[14:30:47.474] <TB2> INFO: 6408230 events read in total (310754ms).
[14:31:21.635] <TB2> INFO: 7119640 events read in total (344915ms).
[14:31:56.214] <TB2> INFO: 7830910 events read in total (379494ms).
[14:32:30.558] <TB2> INFO: 8541630 events read in total (413838ms).
[14:33:04.746] <TB2> INFO: 9252410 events read in total (448027ms).
[14:33:38.977] <TB2> INFO: 9963350 events read in total (482257ms).
[14:34:12.040] <TB2> INFO: 10649600 events read in total (515320ms).
[14:34:12.124] <TB2> INFO: Test took 516229ms.
[14:34:42.751] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 15.157221 .. 47.552980
[14:34:42.826] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 5 .. 57 (-1/-1) hits flags = 528 (plus default)
[14:34:42.834] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:34:42.834] <TB2> INFO: run 1 of 1
[14:34:43.093] <TB2> INFO: Expecting 2204800 events.
[14:35:21.916] <TB2> INFO: 922420 events read in total (38267ms).
[14:35:59.663] <TB2> INFO: 1843240 events read in total (76014ms).
[14:36:14.820] <TB2> INFO: 2204800 events read in total (91171ms).
[14:36:14.837] <TB2> INFO: Test took 92003ms.
[14:36:28.788] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 20.874777 .. 46.322543
[14:36:28.863] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 10 .. 56 (-1/-1) hits flags = 528 (plus default)
[14:36:28.871] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:36:28.871] <TB2> INFO: run 1 of 1
[14:36:29.131] <TB2> INFO: Expecting 1955200 events.
[14:37:07.698] <TB2> INFO: 903860 events read in total (38011ms).
[14:37:46.247] <TB2> INFO: 1806660 events read in total (76560ms).
[14:37:53.086] <TB2> INFO: 1955200 events read in total (83399ms).
[14:37:53.098] <TB2> INFO: Test took 84227ms.
[14:38:07.079] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 23.041586 .. 46.322543
[14:38:07.169] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 13 .. 56 (-1/-1) hits flags = 528 (plus default)
[14:38:07.178] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:38:07.178] <TB2> INFO: run 1 of 1
[14:38:07.474] <TB2> INFO: Expecting 1830400 events.
[14:38:45.790] <TB2> INFO: 885100 events read in total (37760ms).
[14:39:23.264] <TB2> INFO: 1769450 events read in total (75234ms).
[14:39:26.336] <TB2> INFO: 1830400 events read in total (78307ms).
[14:39:26.352] <TB2> INFO: Test took 79174ms.
[14:39:41.377] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[14:39:41.377] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[14:39:41.385] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:39:41.385] <TB2> INFO: run 1 of 1
[14:39:41.647] <TB2> INFO: Expecting 1705600 events.
[14:40:19.860] <TB2> INFO: 878600 events read in total (37657ms).
[14:40:55.447] <TB2> INFO: 1705600 events read in total (73244ms).
[14:40:55.458] <TB2> INFO: Test took 74073ms.
[14:41:10.269] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C0.dat
[14:41:10.269] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C1.dat
[14:41:10.270] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C2.dat
[14:41:10.270] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C3.dat
[14:41:10.270] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C4.dat
[14:41:10.270] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C5.dat
[14:41:10.270] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C6.dat
[14:41:10.270] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C7.dat
[14:41:10.270] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C8.dat
[14:41:10.270] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C9.dat
[14:41:10.271] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C10.dat
[14:41:10.271] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C11.dat
[14:41:10.271] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C12.dat
[14:41:10.271] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C13.dat
[14:41:10.271] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C14.dat
[14:41:10.271] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C15.dat
[14:41:10.272] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C0.dat
[14:41:10.280] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C1.dat
[14:41:10.289] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C2.dat
[14:41:10.297] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C3.dat
[14:41:10.307] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C4.dat
[14:41:10.316] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C5.dat
[14:41:10.325] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C6.dat
[14:41:10.333] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C7.dat
[14:41:10.342] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C8.dat
[14:41:10.351] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C9.dat
[14:41:10.360] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C10.dat
[14:41:10.369] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C11.dat
[14:41:10.377] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C12.dat
[14:41:10.386] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C13.dat
[14:41:10.395] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C14.dat
[14:41:10.404] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//trimParameters35_C15.dat
[14:41:10.412] <TB2> INFO: PixTestTrim::trimTest() done
[14:41:10.412] <TB2> INFO: vtrim: 111 98 94 100 98 92 104 91 87 107 116 170 91 112 112 94
[14:41:10.412] <TB2> INFO: vthrcomp: 100 92 80 103 92 94 99 99 83 92 89 104 99 103 89 85
[14:41:10.412] <TB2> INFO: vcal mean: 34.97 35.00 34.97 34.99 35.00 34.99 34.98 35.01 35.00 34.99 35.01 34.77 34.96 35.01 34.97 35.02
[14:41:10.412] <TB2> INFO: vcal RMS: 0.94 0.86 0.88 0.90 1.08 0.84 1.01 0.86 0.76 0.89 0.88 1.38 0.89 0.96 0.89 0.79
[14:41:10.412] <TB2> INFO: bits mean: 9.37 8.71 9.48 8.47 9.68 9.28 8.81 9.76 9.76 9.26 8.85 8.17 8.88 9.01 9.33 9.79
[14:41:10.412] <TB2> INFO: bits RMS: 2.72 2.91 2.70 2.96 2.61 2.72 2.98 2.59 2.60 2.69 2.84 2.12 2.98 2.71 2.74 2.53
[14:41:10.419] <TB2> INFO: ----------------------------------------------------------------------
[14:41:10.419] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[14:41:10.419] <TB2> INFO: ----------------------------------------------------------------------
[14:41:10.422] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[14:41:10.431] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:41:10.431] <TB2> INFO: run 1 of 1
[14:41:10.711] <TB2> INFO: Expecting 4160000 events.
[14:41:53.501] <TB2> INFO: 951960 events read in total (42234ms).
[14:42:35.565] <TB2> INFO: 1895915 events read in total (84299ms).
[14:43:17.417] <TB2> INFO: 2830540 events read in total (126151ms).
[14:43:59.338] <TB2> INFO: 3761275 events read in total (168071ms).
[14:44:17.262] <TB2> INFO: 4160000 events read in total (185995ms).
[14:44:17.305] <TB2> INFO: Test took 186874ms.
[14:44:46.766] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 205 (-1/-1) hits flags = 528 (plus default)
[14:44:46.774] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:44:46.774] <TB2> INFO: run 1 of 1
[14:44:47.045] <TB2> INFO: Expecting 4284800 events.
[14:45:29.135] <TB2> INFO: 910435 events read in total (41533ms).
[14:46:10.612] <TB2> INFO: 1814655 events read in total (83010ms).
[14:46:52.543] <TB2> INFO: 2710720 events read in total (124941ms).
[14:47:34.062] <TB2> INFO: 3602240 events read in total (166460ms).
[14:48:06.094] <TB2> INFO: 4284800 events read in total (198492ms).
[14:48:06.154] <TB2> INFO: Test took 199379ms.
[14:48:36.425] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 193 (-1/-1) hits flags = 528 (plus default)
[14:48:36.434] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:48:36.434] <TB2> INFO: run 1 of 1
[14:48:36.726] <TB2> INFO: Expecting 4035200 events.
[14:49:19.732] <TB2> INFO: 931415 events read in total (42449ms).
[14:50:01.904] <TB2> INFO: 1855285 events read in total (84621ms).
[14:50:44.298] <TB2> INFO: 2769025 events read in total (127015ms).
[14:51:26.257] <TB2> INFO: 3679500 events read in total (168974ms).
[14:51:42.723] <TB2> INFO: 4035200 events read in total (185440ms).
[14:51:42.761] <TB2> INFO: Test took 186328ms.
[14:52:12.847] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 188 (-1/-1) hits flags = 528 (plus default)
[14:52:12.855] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:52:12.855] <TB2> INFO: run 1 of 1
[14:52:13.120] <TB2> INFO: Expecting 3931200 events.
[14:52:55.675] <TB2> INFO: 940745 events read in total (41999ms).
[14:53:37.488] <TB2> INFO: 1873415 events read in total (83812ms).
[14:54:19.682] <TB2> INFO: 2795245 events read in total (126006ms).
[14:55:01.628] <TB2> INFO: 3714560 events read in total (167952ms).
[14:55:11.782] <TB2> INFO: 3931200 events read in total (178106ms).
[14:55:11.831] <TB2> INFO: Test took 178976ms.
[14:55:42.475] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 187 (-1/-1) hits flags = 528 (plus default)
[14:55:42.484] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:55:42.484] <TB2> INFO: run 1 of 1
[14:55:42.766] <TB2> INFO: Expecting 3910400 events.
[14:56:25.966] <TB2> INFO: 942540 events read in total (42644ms).
[14:57:07.986] <TB2> INFO: 1876920 events read in total (84664ms).
[14:57:49.840] <TB2> INFO: 2800160 events read in total (126518ms).
[14:58:31.831] <TB2> INFO: 3721045 events read in total (168509ms).
[14:58:40.631] <TB2> INFO: 3910400 events read in total (177309ms).
[14:58:40.712] <TB2> INFO: Test took 178228ms.
[14:59:08.701] <TB2> INFO: PixTestTrim::trimBitTest() done
[14:59:08.702] <TB2> INFO: PixTestTrim::doTest() done, duration: 3108 seconds
[14:59:08.702] <TB2> INFO: Decoding statistics:
[14:59:08.702] <TB2> INFO: General information:
[14:59:08.702] <TB2> INFO: 16bit words read: 0
[14:59:08.702] <TB2> INFO: valid events total: 0
[14:59:08.702] <TB2> INFO: empty events: 0
[14:59:08.702] <TB2> INFO: valid events with pixels: 0
[14:59:08.702] <TB2> INFO: valid pixel hits: 0
[14:59:08.702] <TB2> INFO: Event errors: 0
[14:59:08.702] <TB2> INFO: start marker: 0
[14:59:08.702] <TB2> INFO: stop marker: 0
[14:59:08.702] <TB2> INFO: overflow: 0
[14:59:08.702] <TB2> INFO: invalid 5bit words: 0
[14:59:08.702] <TB2> INFO: invalid XOR eye diagram: 0
[14:59:08.702] <TB2> INFO: frame (failed synchr.): 0
[14:59:08.702] <TB2> INFO: idle data (no TBM trl): 0
[14:59:08.702] <TB2> INFO: no data (only TBM hdr): 0
[14:59:08.702] <TB2> INFO: TBM errors: 0
[14:59:08.702] <TB2> INFO: flawed TBM headers: 0
[14:59:08.702] <TB2> INFO: flawed TBM trailers: 0
[14:59:08.702] <TB2> INFO: event ID mismatches: 0
[14:59:08.702] <TB2> INFO: ROC errors: 0
[14:59:08.702] <TB2> INFO: missing ROC header(s): 0
[14:59:08.702] <TB2> INFO: misplaced readback start: 0
[14:59:08.702] <TB2> INFO: Pixel decoding errors: 0
[14:59:08.702] <TB2> INFO: pixel data incomplete: 0
[14:59:08.702] <TB2> INFO: pixel address: 0
[14:59:08.702] <TB2> INFO: pulse height fill bit: 0
[14:59:08.702] <TB2> INFO: buffer corruption: 0
[14:59:09.374] <TB2> INFO: ######################################################################
[14:59:09.374] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[14:59:09.374] <TB2> INFO: ######################################################################
[14:59:09.656] <TB2> INFO: Expecting 41600 events.
[14:59:13.436] <TB2> INFO: 41600 events read in total (3224ms).
[14:59:13.436] <TB2> INFO: Test took 4061ms.
[14:59:13.904] <TB2> INFO: Expecting 41600 events.
[14:59:17.766] <TB2> INFO: 41600 events read in total (3306ms).
[14:59:17.767] <TB2> INFO: Test took 4138ms.
[14:59:18.055] <TB2> INFO: Expecting 41600 events.
[14:59:21.951] <TB2> INFO: 41600 events read in total (3340ms).
[14:59:21.952] <TB2> INFO: Test took 4163ms.
[14:59:22.208] <TB2> INFO: Expecting 2560 events.
[14:59:23.067] <TB2> INFO: 2560 events read in total (303ms).
[14:59:23.068] <TB2> INFO: Test took 1103ms.
[14:59:23.373] <TB2> INFO: Expecting 2560 events.
[14:59:24.226] <TB2> INFO: 2560 events read in total (297ms).
[14:59:24.226] <TB2> INFO: Test took 1158ms.
[14:59:24.532] <TB2> INFO: Expecting 2560 events.
[14:59:25.386] <TB2> INFO: 2560 events read in total (298ms).
[14:59:25.387] <TB2> INFO: Test took 1160ms.
[14:59:25.694] <TB2> INFO: Expecting 2560 events.
[14:59:26.549] <TB2> INFO: 2560 events read in total (299ms).
[14:59:26.549] <TB2> INFO: Test took 1162ms.
[14:59:26.854] <TB2> INFO: Expecting 2560 events.
[14:59:27.712] <TB2> INFO: 2560 events read in total (302ms).
[14:59:27.712] <TB2> INFO: Test took 1162ms.
[14:59:28.017] <TB2> INFO: Expecting 2560 events.
[14:59:28.874] <TB2> INFO: 2560 events read in total (301ms).
[14:59:28.874] <TB2> INFO: Test took 1161ms.
[14:59:29.179] <TB2> INFO: Expecting 2560 events.
[14:59:30.034] <TB2> INFO: 2560 events read in total (299ms).
[14:59:30.035] <TB2> INFO: Test took 1161ms.
[14:59:30.339] <TB2> INFO: Expecting 2560 events.
[14:59:31.193] <TB2> INFO: 2560 events read in total (298ms).
[14:59:31.193] <TB2> INFO: Test took 1158ms.
[14:59:31.498] <TB2> INFO: Expecting 2560 events.
[14:59:32.351] <TB2> INFO: 2560 events read in total (297ms).
[14:59:32.351] <TB2> INFO: Test took 1157ms.
[14:59:32.657] <TB2> INFO: Expecting 2560 events.
[14:59:33.514] <TB2> INFO: 2560 events read in total (301ms).
[14:59:33.514] <TB2> INFO: Test took 1162ms.
[14:59:33.820] <TB2> INFO: Expecting 2560 events.
[14:59:34.674] <TB2> INFO: 2560 events read in total (298ms).
[14:59:34.674] <TB2> INFO: Test took 1154ms.
[14:59:34.980] <TB2> INFO: Expecting 2560 events.
[14:59:35.833] <TB2> INFO: 2560 events read in total (297ms).
[14:59:35.834] <TB2> INFO: Test took 1160ms.
[14:59:36.143] <TB2> INFO: Expecting 2560 events.
[14:59:36.996] <TB2> INFO: 2560 events read in total (297ms).
[14:59:36.996] <TB2> INFO: Test took 1161ms.
[14:59:37.302] <TB2> INFO: Expecting 2560 events.
[14:59:38.159] <TB2> INFO: 2560 events read in total (301ms).
[14:59:38.159] <TB2> INFO: Test took 1163ms.
[14:59:38.464] <TB2> INFO: Expecting 2560 events.
[14:59:39.318] <TB2> INFO: 2560 events read in total (298ms).
[14:59:39.318] <TB2> INFO: Test took 1158ms.
[14:59:39.623] <TB2> INFO: Expecting 2560 events.
[14:59:40.483] <TB2> INFO: 2560 events read in total (303ms).
[14:59:40.483] <TB2> INFO: Test took 1164ms.
[14:59:40.488] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:59:40.789] <TB2> INFO: Expecting 655360 events.
[14:59:57.728] <TB2> INFO: 655360 events read in total (16383ms).
[14:59:57.737] <TB2> INFO: Expecting 655360 events.
[15:00:14.449] <TB2> INFO: 655360 events read in total (16310ms).
[15:00:14.462] <TB2> INFO: Expecting 655360 events.
[15:00:31.023] <TB2> INFO: 655360 events read in total (16159ms).
[15:00:31.039] <TB2> INFO: Expecting 655360 events.
[15:00:47.806] <TB2> INFO: 655360 events read in total (16366ms).
[15:00:47.826] <TB2> INFO: Expecting 655360 events.
[15:01:04.537] <TB2> INFO: 655360 events read in total (16309ms).
[15:01:04.561] <TB2> INFO: Expecting 655360 events.
[15:01:21.310] <TB2> INFO: 655360 events read in total (16348ms).
[15:01:21.335] <TB2> INFO: Expecting 655360 events.
[15:01:38.095] <TB2> INFO: 655360 events read in total (16358ms).
[15:01:38.124] <TB2> INFO: Expecting 655360 events.
[15:01:54.803] <TB2> INFO: 655360 events read in total (16277ms).
[15:01:54.837] <TB2> INFO: Expecting 655360 events.
[15:02:11.657] <TB2> INFO: 655360 events read in total (16419ms).
[15:02:11.693] <TB2> INFO: Expecting 655360 events.
[15:02:28.594] <TB2> INFO: 655360 events read in total (16499ms).
[15:02:28.636] <TB2> INFO: Expecting 655360 events.
[15:02:45.419] <TB2> INFO: 655360 events read in total (16382ms).
[15:02:45.464] <TB2> INFO: Expecting 655360 events.
[15:03:02.223] <TB2> INFO: 655360 events read in total (16357ms).
[15:03:02.273] <TB2> INFO: Expecting 655360 events.
[15:03:19.085] <TB2> INFO: 655360 events read in total (16410ms).
[15:03:19.135] <TB2> INFO: Expecting 655360 events.
[15:03:36.010] <TB2> INFO: 655360 events read in total (16473ms).
[15:03:36.064] <TB2> INFO: Expecting 655360 events.
[15:03:52.806] <TB2> INFO: 655360 events read in total (16341ms).
[15:03:52.861] <TB2> INFO: Expecting 655360 events.
[15:04:09.705] <TB2> INFO: 655360 events read in total (16442ms).
[15:04:09.766] <TB2> INFO: Test took 269278ms.
[15:04:09.847] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:04:10.077] <TB2> INFO: Expecting 655360 events.
[15:04:27.058] <TB2> INFO: 655360 events read in total (16424ms).
[15:04:27.068] <TB2> INFO: Expecting 655360 events.
[15:04:43.958] <TB2> INFO: 655360 events read in total (16488ms).
[15:04:43.970] <TB2> INFO: Expecting 655360 events.
[15:05:00.790] <TB2> INFO: 655360 events read in total (16419ms).
[15:05:00.806] <TB2> INFO: Expecting 655360 events.
[15:05:17.651] <TB2> INFO: 655360 events read in total (16444ms).
[15:05:17.673] <TB2> INFO: Expecting 655360 events.
[15:05:34.508] <TB2> INFO: 655360 events read in total (16433ms).
[15:05:34.533] <TB2> INFO: Expecting 655360 events.
[15:05:51.384] <TB2> INFO: 655360 events read in total (16449ms).
[15:05:51.415] <TB2> INFO: Expecting 655360 events.
[15:06:08.010] <TB2> INFO: 655360 events read in total (16194ms).
[15:06:08.040] <TB2> INFO: Expecting 655360 events.
[15:06:24.780] <TB2> INFO: 655360 events read in total (16338ms).
[15:06:24.814] <TB2> INFO: Expecting 655360 events.
[15:06:41.674] <TB2> INFO: 655360 events read in total (16459ms).
[15:06:41.712] <TB2> INFO: Expecting 655360 events.
[15:06:58.373] <TB2> INFO: 655360 events read in total (16259ms).
[15:06:58.414] <TB2> INFO: Expecting 655360 events.
[15:07:15.191] <TB2> INFO: 655360 events read in total (16375ms).
[15:07:15.235] <TB2> INFO: Expecting 655360 events.
[15:07:31.887] <TB2> INFO: 655360 events read in total (16250ms).
[15:07:31.943] <TB2> INFO: Expecting 655360 events.
[15:07:48.897] <TB2> INFO: 655360 events read in total (16552ms).
[15:07:48.946] <TB2> INFO: Expecting 655360 events.
[15:08:05.648] <TB2> INFO: 655360 events read in total (16300ms).
[15:08:05.709] <TB2> INFO: Expecting 655360 events.
[15:08:22.589] <TB2> INFO: 655360 events read in total (16476ms).
[15:08:22.648] <TB2> INFO: Expecting 655360 events.
[15:08:39.465] <TB2> INFO: 655360 events read in total (16415ms).
[15:08:39.526] <TB2> INFO: Test took 269679ms.
[15:08:39.719] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.726] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.733] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.740] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.746] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.753] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.760] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[15:08:39.767] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[15:08:39.774] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.781] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.787] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.794] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.801] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.808] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[15:08:39.815] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[15:08:39.822] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[15:08:39.828] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.835] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.842] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.849] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.856] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[15:08:39.890] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C0.dat
[15:08:39.890] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C1.dat
[15:08:39.890] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C2.dat
[15:08:39.890] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C3.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C4.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C5.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C6.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C7.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C8.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C9.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C10.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C11.dat
[15:08:39.891] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C12.dat
[15:08:39.892] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C13.dat
[15:08:39.892] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C14.dat
[15:08:39.892] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//dacParameters35_C15.dat
[15:08:40.171] <TB2> INFO: Expecting 41600 events.
[15:08:43.677] <TB2> INFO: 41600 events read in total (2950ms).
[15:08:43.678] <TB2> INFO: Test took 3783ms.
[15:08:44.123] <TB2> INFO: Expecting 41600 events.
[15:08:47.611] <TB2> INFO: 41600 events read in total (2932ms).
[15:08:47.612] <TB2> INFO: Test took 3758ms.
[15:08:48.076] <TB2> INFO: Expecting 41600 events.
[15:08:51.553] <TB2> INFO: 41600 events read in total (2921ms).
[15:08:51.554] <TB2> INFO: Test took 3763ms.
[15:08:51.742] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:08:51.831] <TB2> INFO: Expecting 2560 events.
[15:08:52.689] <TB2> INFO: 2560 events read in total (301ms).
[15:08:52.690] <TB2> INFO: Test took 948ms.
[15:08:52.692] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:08:52.995] <TB2> INFO: Expecting 2560 events.
[15:08:53.850] <TB2> INFO: 2560 events read in total (298ms).
[15:08:53.850] <TB2> INFO: Test took 1158ms.
[15:08:53.853] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:08:54.155] <TB2> INFO: Expecting 2560 events.
[15:08:55.008] <TB2> INFO: 2560 events read in total (297ms).
[15:08:55.009] <TB2> INFO: Test took 1156ms.
[15:08:55.010] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:08:55.314] <TB2> INFO: Expecting 2560 events.
[15:08:56.173] <TB2> INFO: 2560 events read in total (303ms).
[15:08:56.174] <TB2> INFO: Test took 1164ms.
[15:08:56.177] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:08:56.479] <TB2> INFO: Expecting 2560 events.
[15:08:57.337] <TB2> INFO: 2560 events read in total (301ms).
[15:08:57.337] <TB2> INFO: Test took 1161ms.
[15:08:57.339] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:08:57.644] <TB2> INFO: Expecting 2560 events.
[15:08:58.499] <TB2> INFO: 2560 events read in total (299ms).
[15:08:58.499] <TB2> INFO: Test took 1160ms.
[15:08:58.501] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:08:58.804] <TB2> INFO: Expecting 2560 events.
[15:08:59.659] <TB2> INFO: 2560 events read in total (298ms).
[15:08:59.659] <TB2> INFO: Test took 1158ms.
[15:08:59.661] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:08:59.965] <TB2> INFO: Expecting 2560 events.
[15:09:00.825] <TB2> INFO: 2560 events read in total (304ms).
[15:09:00.825] <TB2> INFO: Test took 1164ms.
[15:09:00.828] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:01.131] <TB2> INFO: Expecting 2560 events.
[15:09:01.989] <TB2> INFO: 2560 events read in total (302ms).
[15:09:01.990] <TB2> INFO: Test took 1162ms.
[15:09:01.992] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:02.295] <TB2> INFO: Expecting 2560 events.
[15:09:03.154] <TB2> INFO: 2560 events read in total (302ms).
[15:09:03.155] <TB2> INFO: Test took 1163ms.
[15:09:03.156] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:03.460] <TB2> INFO: Expecting 2560 events.
[15:09:04.315] <TB2> INFO: 2560 events read in total (299ms).
[15:09:04.315] <TB2> INFO: Test took 1159ms.
[15:09:04.318] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:04.620] <TB2> INFO: Expecting 2560 events.
[15:09:05.474] <TB2> INFO: 2560 events read in total (298ms).
[15:09:05.474] <TB2> INFO: Test took 1156ms.
[15:09:05.477] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:05.780] <TB2> INFO: Expecting 2560 events.
[15:09:06.638] <TB2> INFO: 2560 events read in total (301ms).
[15:09:06.638] <TB2> INFO: Test took 1161ms.
[15:09:06.640] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:06.945] <TB2> INFO: Expecting 2560 events.
[15:09:07.798] <TB2> INFO: 2560 events read in total (297ms).
[15:09:07.799] <TB2> INFO: Test took 1160ms.
[15:09:07.802] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:08.104] <TB2> INFO: Expecting 2560 events.
[15:09:08.957] <TB2> INFO: 2560 events read in total (297ms).
[15:09:08.957] <TB2> INFO: Test took 1155ms.
[15:09:08.959] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:09.263] <TB2> INFO: Expecting 2560 events.
[15:09:10.119] <TB2> INFO: 2560 events read in total (300ms).
[15:09:10.119] <TB2> INFO: Test took 1160ms.
[15:09:10.122] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:10.425] <TB2> INFO: Expecting 2560 events.
[15:09:11.284] <TB2> INFO: 2560 events read in total (302ms).
[15:09:11.284] <TB2> INFO: Test took 1162ms.
[15:09:11.287] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:11.591] <TB2> INFO: Expecting 2560 events.
[15:09:12.445] <TB2> INFO: 2560 events read in total (297ms).
[15:09:12.459] <TB2> INFO: Test took 1172ms.
[15:09:12.461] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:12.752] <TB2> INFO: Expecting 2560 events.
[15:09:13.604] <TB2> INFO: 2560 events read in total (296ms).
[15:09:13.604] <TB2> INFO: Test took 1143ms.
[15:09:13.606] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:13.911] <TB2> INFO: Expecting 2560 events.
[15:09:14.771] <TB2> INFO: 2560 events read in total (304ms).
[15:09:14.771] <TB2> INFO: Test took 1165ms.
[15:09:14.774] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:15.077] <TB2> INFO: Expecting 2560 events.
[15:09:15.935] <TB2> INFO: 2560 events read in total (302ms).
[15:09:15.935] <TB2> INFO: Test took 1162ms.
[15:09:15.938] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:16.240] <TB2> INFO: Expecting 2560 events.
[15:09:17.097] <TB2> INFO: 2560 events read in total (301ms).
[15:09:17.097] <TB2> INFO: Test took 1159ms.
[15:09:17.099] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:17.403] <TB2> INFO: Expecting 2560 events.
[15:09:18.257] <TB2> INFO: 2560 events read in total (298ms).
[15:09:18.257] <TB2> INFO: Test took 1158ms.
[15:09:18.260] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:18.563] <TB2> INFO: Expecting 2560 events.
[15:09:19.419] <TB2> INFO: 2560 events read in total (300ms).
[15:09:19.419] <TB2> INFO: Test took 1161ms.
[15:09:19.422] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:19.725] <TB2> INFO: Expecting 2560 events.
[15:09:20.579] <TB2> INFO: 2560 events read in total (297ms).
[15:09:20.579] <TB2> INFO: Test took 1157ms.
[15:09:20.581] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:20.885] <TB2> INFO: Expecting 2560 events.
[15:09:21.739] <TB2> INFO: 2560 events read in total (298ms).
[15:09:21.740] <TB2> INFO: Test took 1159ms.
[15:09:21.741] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:22.045] <TB2> INFO: Expecting 2560 events.
[15:09:22.900] <TB2> INFO: 2560 events read in total (299ms).
[15:09:22.901] <TB2> INFO: Test took 1160ms.
[15:09:22.904] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:23.207] <TB2> INFO: Expecting 2560 events.
[15:09:24.066] <TB2> INFO: 2560 events read in total (303ms).
[15:09:24.067] <TB2> INFO: Test took 1163ms.
[15:09:24.069] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:24.373] <TB2> INFO: Expecting 2560 events.
[15:09:25.230] <TB2> INFO: 2560 events read in total (301ms).
[15:09:25.230] <TB2> INFO: Test took 1161ms.
[15:09:25.233] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:25.537] <TB2> INFO: Expecting 2560 events.
[15:09:26.391] <TB2> INFO: 2560 events read in total (298ms).
[15:09:26.391] <TB2> INFO: Test took 1158ms.
[15:09:26.394] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:26.698] <TB2> INFO: Expecting 2560 events.
[15:09:27.557] <TB2> INFO: 2560 events read in total (303ms).
[15:09:27.557] <TB2> INFO: Test took 1163ms.
[15:09:27.560] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:09:27.863] <TB2> INFO: Expecting 2560 events.
[15:09:28.720] <TB2> INFO: 2560 events read in total (300ms).
[15:09:28.720] <TB2> INFO: Test took 1160ms.
[15:09:29.203] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 619 seconds
[15:09:29.203] <TB2> INFO: PH scale (per ROC): 66 78 70 82 68 80 80 74 83 85 80 63 80 72 83 80
[15:09:29.203] <TB2> INFO: PH offset (per ROC): 186 170 165 174 166 161 173 165 172 165 171 180 167 183 161 148
[15:09:29.210] <TB2> INFO: Decoding statistics:
[15:09:29.210] <TB2> INFO: General information:
[15:09:29.210] <TB2> INFO: 16bit words read: 91924
[15:09:29.210] <TB2> INFO: valid events total: 10240
[15:09:29.210] <TB2> INFO: empty events: 7739
[15:09:29.210] <TB2> INFO: valid events with pixels: 2501
[15:09:29.210] <TB2> INFO: valid pixel hits: 2501
[15:09:29.210] <TB2> INFO: Event errors: 0
[15:09:29.210] <TB2> INFO: start marker: 0
[15:09:29.210] <TB2> INFO: stop marker: 0
[15:09:29.210] <TB2> INFO: overflow: 0
[15:09:29.210] <TB2> INFO: invalid 5bit words: 0
[15:09:29.210] <TB2> INFO: invalid XOR eye diagram: 0
[15:09:29.210] <TB2> INFO: frame (failed synchr.): 0
[15:09:29.210] <TB2> INFO: idle data (no TBM trl): 0
[15:09:29.210] <TB2> INFO: no data (only TBM hdr): 0
[15:09:29.210] <TB2> INFO: TBM errors: 0
[15:09:29.210] <TB2> INFO: flawed TBM headers: 0
[15:09:29.210] <TB2> INFO: flawed TBM trailers: 0
[15:09:29.210] <TB2> INFO: event ID mismatches: 0
[15:09:29.210] <TB2> INFO: ROC errors: 0
[15:09:29.210] <TB2> INFO: missing ROC header(s): 0
[15:09:29.210] <TB2> INFO: misplaced readback start: 0
[15:09:29.210] <TB2> INFO: Pixel decoding errors: 0
[15:09:29.210] <TB2> INFO: pixel data incomplete: 0
[15:09:29.210] <TB2> INFO: pixel address: 0
[15:09:29.210] <TB2> INFO: pulse height fill bit: 0
[15:09:29.210] <TB2> INFO: buffer corruption: 0
[15:09:29.411] <TB2> INFO: ######################################################################
[15:09:29.411] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[15:09:29.411] <TB2> INFO: ######################################################################
[15:09:29.422] <TB2> INFO: scanning low vcal = 10
[15:09:29.712] <TB2> INFO: Expecting 41600 events.
[15:09:33.272] <TB2> INFO: 41600 events read in total (3004ms).
[15:09:33.272] <TB2> INFO: Test took 3850ms.
[15:09:33.274] <TB2> INFO: scanning low vcal = 20
[15:09:33.577] <TB2> INFO: Expecting 41600 events.
[15:09:37.149] <TB2> INFO: 41600 events read in total (3016ms).
[15:09:37.149] <TB2> INFO: Test took 3875ms.
[15:09:37.151] <TB2> INFO: scanning low vcal = 30
[15:09:37.453] <TB2> INFO: Expecting 41600 events.
[15:09:41.043] <TB2> INFO: 41600 events read in total (3034ms).
[15:09:41.043] <TB2> INFO: Test took 3892ms.
[15:09:41.045] <TB2> INFO: scanning low vcal = 40
[15:09:41.340] <TB2> INFO: Expecting 41600 events.
[15:09:45.472] <TB2> INFO: 41600 events read in total (3575ms).
[15:09:45.472] <TB2> INFO: Test took 4428ms.
[15:09:45.475] <TB2> INFO: scanning low vcal = 50
[15:09:45.738] <TB2> INFO: Expecting 41600 events.
[15:09:49.943] <TB2> INFO: 41600 events read in total (3649ms).
[15:09:49.944] <TB2> INFO: Test took 4469ms.
[15:09:49.946] <TB2> INFO: scanning low vcal = 60
[15:09:50.221] <TB2> INFO: Expecting 41600 events.
[15:09:54.421] <TB2> INFO: 41600 events read in total (3644ms).
[15:09:54.421] <TB2> INFO: Test took 4475ms.
[15:09:54.427] <TB2> INFO: scanning low vcal = 70
[15:09:54.723] <TB2> INFO: Expecting 41600 events.
[15:09:58.924] <TB2> INFO: 41600 events read in total (3645ms).
[15:09:58.925] <TB2> INFO: Test took 4498ms.
[15:09:58.927] <TB2> INFO: scanning low vcal = 80
[15:09:59.205] <TB2> INFO: Expecting 41600 events.
[15:10:03.386] <TB2> INFO: 41600 events read in total (3625ms).
[15:10:03.386] <TB2> INFO: Test took 4459ms.
[15:10:03.389] <TB2> INFO: scanning low vcal = 90
[15:10:03.656] <TB2> INFO: Expecting 41600 events.
[15:10:07.840] <TB2> INFO: 41600 events read in total (3628ms).
[15:10:07.841] <TB2> INFO: Test took 4452ms.
[15:10:07.844] <TB2> INFO: scanning low vcal = 100
[15:10:08.111] <TB2> INFO: Expecting 41600 events.
[15:10:12.295] <TB2> INFO: 41600 events read in total (3628ms).
[15:10:12.295] <TB2> INFO: Test took 4451ms.
[15:10:12.298] <TB2> INFO: scanning low vcal = 110
[15:10:12.563] <TB2> INFO: Expecting 41600 events.
[15:10:16.756] <TB2> INFO: 41600 events read in total (3637ms).
[15:10:16.757] <TB2> INFO: Test took 4459ms.
[15:10:16.759] <TB2> INFO: scanning low vcal = 120
[15:10:17.024] <TB2> INFO: Expecting 41600 events.
[15:10:21.205] <TB2> INFO: 41600 events read in total (3625ms).
[15:10:21.205] <TB2> INFO: Test took 4446ms.
[15:10:21.208] <TB2> INFO: scanning low vcal = 130
[15:10:21.489] <TB2> INFO: Expecting 41600 events.
[15:10:25.660] <TB2> INFO: 41600 events read in total (3615ms).
[15:10:25.661] <TB2> INFO: Test took 4453ms.
[15:10:25.663] <TB2> INFO: scanning low vcal = 140
[15:10:25.928] <TB2> INFO: Expecting 41600 events.
[15:10:30.134] <TB2> INFO: 41600 events read in total (3650ms).
[15:10:30.135] <TB2> INFO: Test took 4472ms.
[15:10:30.138] <TB2> INFO: scanning low vcal = 150
[15:10:30.451] <TB2> INFO: Expecting 41600 events.
[15:10:34.618] <TB2> INFO: 41600 events read in total (3611ms).
[15:10:34.618] <TB2> INFO: Test took 4480ms.
[15:10:34.621] <TB2> INFO: scanning low vcal = 160
[15:10:34.887] <TB2> INFO: Expecting 41600 events.
[15:10:39.055] <TB2> INFO: 41600 events read in total (3611ms).
[15:10:39.056] <TB2> INFO: Test took 4435ms.
[15:10:39.059] <TB2> INFO: scanning low vcal = 170
[15:10:39.324] <TB2> INFO: Expecting 41600 events.
[15:10:43.496] <TB2> INFO: 41600 events read in total (3616ms).
[15:10:43.497] <TB2> INFO: Test took 4438ms.
[15:10:43.500] <TB2> INFO: scanning low vcal = 180
[15:10:43.769] <TB2> INFO: Expecting 41600 events.
[15:10:47.940] <TB2> INFO: 41600 events read in total (3615ms).
[15:10:47.941] <TB2> INFO: Test took 4440ms.
[15:10:47.943] <TB2> INFO: scanning low vcal = 190
[15:10:48.203] <TB2> INFO: Expecting 41600 events.
[15:10:52.378] <TB2> INFO: 41600 events read in total (3619ms).
[15:10:52.379] <TB2> INFO: Test took 4436ms.
[15:10:52.381] <TB2> INFO: scanning low vcal = 200
[15:10:52.655] <TB2> INFO: Expecting 41600 events.
[15:10:56.820] <TB2> INFO: 41600 events read in total (3608ms).
[15:10:56.821] <TB2> INFO: Test took 4440ms.
[15:10:56.823] <TB2> INFO: scanning low vcal = 210
[15:10:57.084] <TB2> INFO: Expecting 41600 events.
[15:11:01.272] <TB2> INFO: 41600 events read in total (3632ms).
[15:11:01.273] <TB2> INFO: Test took 4450ms.
[15:11:01.276] <TB2> INFO: scanning low vcal = 220
[15:11:01.544] <TB2> INFO: Expecting 41600 events.
[15:11:05.801] <TB2> INFO: 41600 events read in total (3701ms).
[15:11:05.801] <TB2> INFO: Test took 4525ms.
[15:11:05.804] <TB2> INFO: scanning low vcal = 230
[15:11:06.071] <TB2> INFO: Expecting 41600 events.
[15:11:10.322] <TB2> INFO: 41600 events read in total (3695ms).
[15:11:10.322] <TB2> INFO: Test took 4518ms.
[15:11:10.325] <TB2> INFO: scanning low vcal = 240
[15:11:10.589] <TB2> INFO: Expecting 41600 events.
[15:11:14.812] <TB2> INFO: 41600 events read in total (3667ms).
[15:11:14.813] <TB2> INFO: Test took 4488ms.
[15:11:14.816] <TB2> INFO: scanning low vcal = 250
[15:11:15.083] <TB2> INFO: Expecting 41600 events.
[15:11:19.283] <TB2> INFO: 41600 events read in total (3643ms).
[15:11:19.283] <TB2> INFO: Test took 4467ms.
[15:11:19.287] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[15:11:19.553] <TB2> INFO: Expecting 41600 events.
[15:11:23.782] <TB2> INFO: 41600 events read in total (3673ms).
[15:11:23.782] <TB2> INFO: Test took 4495ms.
[15:11:23.785] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[15:11:24.052] <TB2> INFO: Expecting 41600 events.
[15:11:28.252] <TB2> INFO: 41600 events read in total (3644ms).
[15:11:28.253] <TB2> INFO: Test took 4468ms.
[15:11:28.255] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[15:11:28.517] <TB2> INFO: Expecting 41600 events.
[15:11:32.737] <TB2> INFO: 41600 events read in total (3664ms).
[15:11:32.738] <TB2> INFO: Test took 4483ms.
[15:11:32.740] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[15:11:33.018] <TB2> INFO: Expecting 41600 events.
[15:11:37.253] <TB2> INFO: 41600 events read in total (3678ms).
[15:11:37.253] <TB2> INFO: Test took 4513ms.
[15:11:37.256] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[15:11:37.545] <TB2> INFO: Expecting 41600 events.
[15:11:41.747] <TB2> INFO: 41600 events read in total (3646ms).
[15:11:41.747] <TB2> INFO: Test took 4491ms.
[15:11:42.290] <TB2> INFO: PixTestGainPedestal::measure() done
[15:12:15.052] <TB2> INFO: PixTestGainPedestal::fit() done
[15:12:15.052] <TB2> INFO: non-linearity mean: 0.957 0.953 0.954 0.958 0.952 0.956 0.959 0.953 0.952 0.957 0.960 0.956 0.957 0.954 0.957 0.954
[15:12:15.052] <TB2> INFO: non-linearity RMS: 0.006 0.006 0.006 0.006 0.006 0.005 0.006 0.007 0.006 0.005 0.005 0.007 0.005 0.006 0.007 0.005
[15:12:15.053] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[15:12:15.071] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[15:12:15.096] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[15:12:15.117] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[15:12:15.140] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[15:12:15.167] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[15:12:15.189] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[15:12:15.214] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[15:12:15.232] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[15:12:15.250] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[15:12:15.268] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[15:12:15.286] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[15:12:15.304] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[15:12:15.322] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[15:12:15.339] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[15:12:15.357] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[15:12:15.375] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 165 seconds
[15:12:15.375] <TB2> INFO: Decoding statistics:
[15:12:15.375] <TB2> INFO: General information:
[15:12:15.375] <TB2> INFO: 16bit words read: 2662400
[15:12:15.375] <TB2> INFO: valid events total: 166400
[15:12:15.375] <TB2> INFO: empty events: 0
[15:12:15.375] <TB2> INFO: valid events with pixels: 166400
[15:12:15.375] <TB2> INFO: valid pixel hits: 665560
[15:12:15.375] <TB2> INFO: Event errors: 0
[15:12:15.375] <TB2> INFO: start marker: 0
[15:12:15.375] <TB2> INFO: stop marker: 0
[15:12:15.375] <TB2> INFO: overflow: 0
[15:12:15.375] <TB2> INFO: invalid 5bit words: 0
[15:12:15.375] <TB2> INFO: invalid XOR eye diagram: 0
[15:12:15.375] <TB2> INFO: frame (failed synchr.): 0
[15:12:15.375] <TB2> INFO: idle data (no TBM trl): 0
[15:12:15.375] <TB2> INFO: no data (only TBM hdr): 0
[15:12:15.375] <TB2> INFO: TBM errors: 0
[15:12:15.375] <TB2> INFO: flawed TBM headers: 0
[15:12:15.375] <TB2> INFO: flawed TBM trailers: 0
[15:12:15.375] <TB2> INFO: event ID mismatches: 0
[15:12:15.375] <TB2> INFO: ROC errors: 0
[15:12:15.375] <TB2> INFO: missing ROC header(s): 0
[15:12:15.375] <TB2> INFO: misplaced readback start: 0
[15:12:15.375] <TB2> INFO: Pixel decoding errors: 0
[15:12:15.375] <TB2> INFO: pixel data incomplete: 0
[15:12:15.375] <TB2> INFO: pixel address: 0
[15:12:15.375] <TB2> INFO: pulse height fill bit: 0
[15:12:15.375] <TB2> INFO: buffer corruption: 0
[15:12:15.383] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C15.dat
[15:12:15.384] <TB2> INFO: ######################################################################
[15:12:15.384] <TB2> INFO: PixTestReadback::doTest()
[15:12:15.384] <TB2> INFO: ######################################################################
[15:12:15.384] <TB2> INFO: ----------------------------------------------------------------------
[15:12:15.384] <TB2> INFO: PixTestReadback::CalibrateVd()
[15:12:15.384] <TB2> INFO: ----------------------------------------------------------------------
[15:12:24.881] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C0.dat
[15:12:24.881] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C1.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C2.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C3.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C4.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C5.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C6.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C7.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C8.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C9.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C10.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C11.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C12.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C13.dat
[15:12:24.882] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C14.dat
[15:12:24.883] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C15.dat
[15:12:24.903] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[15:12:24.904] <TB2> INFO: ----------------------------------------------------------------------
[15:12:24.904] <TB2> INFO: PixTestReadback::CalibrateVa()
[15:12:24.904] <TB2> INFO: ----------------------------------------------------------------------
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C0.dat
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C1.dat
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C2.dat
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C3.dat
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C4.dat
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C5.dat
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C6.dat
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C7.dat
[15:12:34.413] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C8.dat
[15:12:34.414] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C9.dat
[15:12:34.414] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C10.dat
[15:12:34.414] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C11.dat
[15:12:34.414] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C12.dat
[15:12:34.414] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C13.dat
[15:12:34.414] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C14.dat
[15:12:34.414] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C15.dat
[15:12:34.437] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[15:12:34.437] <TB2> INFO: ----------------------------------------------------------------------
[15:12:34.437] <TB2> INFO: PixTestReadback::readbackVbg()
[15:12:34.437] <TB2> INFO: ----------------------------------------------------------------------
[15:12:41.753] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[15:12:41.753] <TB2> INFO: ----------------------------------------------------------------------
[15:12:41.758] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[15:12:41.758] <TB2> INFO: ----------------------------------------------------------------------
[15:12:41.758] <TB2> INFO: Vbg will be calibrated using Vd calibration
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 161.7calibrated Vbg = 1.18181 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 171calibrated Vbg = 1.18382 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 145.2calibrated Vbg = 1.17915 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 150.8calibrated Vbg = 1.19464 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 156.1calibrated Vbg = 1.19821 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 155.5calibrated Vbg = 1.20387 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 149.3calibrated Vbg = 1.20546 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 142.8calibrated Vbg = 1.1941 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 148.9calibrated Vbg = 1.20665 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 160.4calibrated Vbg = 1.20173 :::*/*/*/*/
[15:12:41.758] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 143.2calibrated Vbg = 1.19456 :::*/*/*/*/
[15:12:41.759] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 157.4calibrated Vbg = 1.19477 :::*/*/*/*/
[15:12:41.759] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 158.4calibrated Vbg = 1.19433 :::*/*/*/*/
[15:12:41.759] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 166.4calibrated Vbg = 1.19292 :::*/*/*/*/
[15:12:41.759] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 158.9calibrated Vbg = 1.20134 :::*/*/*/*/
[15:12:41.759] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 156calibrated Vbg = 1.19072 :::*/*/*/*/
[15:12:41.762] <TB2> INFO: ----------------------------------------------------------------------
[15:12:41.762] <TB2> INFO: PixTestReadback::CalibrateIa()
[15:12:41.762] <TB2> INFO: ----------------------------------------------------------------------
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C0.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C1.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C2.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C3.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C4.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C5.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C6.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C7.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C8.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C9.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C10.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C11.dat
[15:15:17.234] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C12.dat
[15:15:17.235] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C13.dat
[15:15:17.235] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C14.dat
[15:15:17.235] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2193_FullQualification_2016-04-10_11h32m_1460280744//002_FulltestPxar_m20//readbackCal_C15.dat
[15:15:17.264] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[15:15:17.265] <TB2> INFO: PixTestReadback::doTest() done
[15:15:17.265] <TB2> INFO: Decoding statistics:
[15:15:17.265] <TB2> INFO: General information:
[15:15:17.265] <TB2> INFO: 16bit words read: 1024
[15:15:17.265] <TB2> INFO: valid events total: 128
[15:15:17.265] <TB2> INFO: empty events: 128
[15:15:17.265] <TB2> INFO: valid events with pixels: 0
[15:15:17.265] <TB2> INFO: valid pixel hits: 0
[15:15:17.265] <TB2> INFO: Event errors: 0
[15:15:17.265] <TB2> INFO: start marker: 0
[15:15:17.265] <TB2> INFO: stop marker: 0
[15:15:17.265] <TB2> INFO: overflow: 0
[15:15:17.265] <TB2> INFO: invalid 5bit words: 0
[15:15:17.265] <TB2> INFO: invalid XOR eye diagram: 0
[15:15:17.265] <TB2> INFO: frame (failed synchr.): 0
[15:15:17.265] <TB2> INFO: idle data (no TBM trl): 0
[15:15:17.265] <TB2> INFO: no data (only TBM hdr): 0
[15:15:17.265] <TB2> INFO: TBM errors: 0
[15:15:17.265] <TB2> INFO: flawed TBM headers: 0
[15:15:17.265] <TB2> INFO: flawed TBM trailers: 0
[15:15:17.265] <TB2> INFO: event ID mismatches: 0
[15:15:17.265] <TB2> INFO: ROC errors: 0
[15:15:17.265] <TB2> INFO: missing ROC header(s): 0
[15:15:17.265] <TB2> INFO: misplaced readback start: 0
[15:15:17.265] <TB2> INFO: Pixel decoding errors: 0
[15:15:17.265] <TB2> INFO: pixel data incomplete: 0
[15:15:17.265] <TB2> INFO: pixel address: 0
[15:15:17.265] <TB2> INFO: pulse height fill bit: 0
[15:15:17.265] <TB2> INFO: buffer corruption: 0
[15:15:17.284] <TB2> INFO: Decoding statistics:
[15:15:17.284] <TB2> INFO: General information:
[15:15:17.284] <TB2> INFO: 16bit words read: 2755348
[15:15:17.284] <TB2> INFO: valid events total: 176768
[15:15:17.284] <TB2> INFO: empty events: 7867
[15:15:17.284] <TB2> INFO: valid events with pixels: 168901
[15:15:17.284] <TB2> INFO: valid pixel hits: 668061
[15:15:17.284] <TB2> INFO: Event errors: 0
[15:15:17.284] <TB2> INFO: start marker: 0
[15:15:17.284] <TB2> INFO: stop marker: 0
[15:15:17.284] <TB2> INFO: overflow: 0
[15:15:17.284] <TB2> INFO: invalid 5bit words: 0
[15:15:17.284] <TB2> INFO: invalid XOR eye diagram: 0
[15:15:17.284] <TB2> INFO: frame (failed synchr.): 0
[15:15:17.284] <TB2> INFO: idle data (no TBM trl): 0
[15:15:17.284] <TB2> INFO: no data (only TBM hdr): 0
[15:15:17.284] <TB2> INFO: TBM errors: 0
[15:15:17.284] <TB2> INFO: flawed TBM headers: 0
[15:15:17.284] <TB2> INFO: flawed TBM trailers: 0
[15:15:17.284] <TB2> INFO: event ID mismatches: 0
[15:15:17.284] <TB2> INFO: ROC errors: 0
[15:15:17.284] <TB2> INFO: missing ROC header(s): 0
[15:15:17.284] <TB2> INFO: misplaced readback start: 0
[15:15:17.284] <TB2> INFO: Pixel decoding errors: 0
[15:15:17.284] <TB2> INFO: pixel data incomplete: 0
[15:15:17.284] <TB2> INFO: pixel address: 0
[15:15:17.284] <TB2> INFO: pulse height fill bit: 0
[15:15:17.284] <TB2> INFO: buffer corruption: 0
[15:15:17.284] <TB2> INFO: enter test to run
[15:15:17.284] <TB2> INFO: test: exit no parameter change
[15:15:17.477] <TB2> QUIET: Connection to board 156 closed.
[15:15:17.556] <TB2> INFO: pXar: this is the end, my friend