[06:19:03.787] <TB2> INFO: *** Welcome to pxar ***
[06:19:03.787] <TB2> INFO: *** Today: 2016/06/15
[06:19:03.890] <TB2> INFO: *** Version: 9751-dirty
[06:19:03.890] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C15.dat
[06:19:03.892] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//tbmParameters_C0b.dat
[06:19:03.893] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//defaultMaskFile.dat
[06:19:03.893] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters_C15.dat
[06:19:03.971] <TB2> INFO: clk: 4
[06:19:03.971] <TB2> INFO: ctr: 4
[06:19:03.971] <TB2> INFO: sda: 19
[06:19:03.971] <TB2> INFO: tin: 9
[06:19:03.971] <TB2> INFO: level: 15
[06:19:03.971] <TB2> INFO: triggerdelay: 0
[06:19:03.971] <TB2> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[06:19:03.971] <TB2> INFO: Log level: INFO
[06:19:03.978] <TB2> INFO: Found DTB DTB_WXC55Z
[06:19:03.988] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[06:19:03.990] <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:
------------------------------------------------------
[06:19:03.992] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[06:19:05.534] <TB2> INFO: DUT info:
[06:19:05.534] <TB2> INFO: The DUT currently contains the following objects:
[06:19:05.534] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[06:19:05.534] <TB2> INFO: TBM Core alpha (0): 7 registers set
[06:19:05.534] <TB2> INFO: TBM Core beta (1): 7 registers set
[06:19:05.534] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[06:19:05.534] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.534] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.534] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.535] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:19:05.936] <TB2> INFO: enter 'restricted' command line mode
[06:19:05.936] <TB2> INFO: enter test to run
[06:19:05.936] <TB2> INFO: test: pretest no parameter change
[06:19:05.936] <TB2> INFO: running: pretest
[06:19:05.942] <TB2> INFO: ----------------------------------------------------------------------
[06:19:05.942] <TB2> INFO: PixTestPretest::programROC()
[06:19:05.942] <TB2> INFO: ----------------------------------------------------------------------
[06:19:23.955] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[06:19:23.955] <TB2> INFO: IA differences per ROC: 18.5 18.5 17.7 20.9 20.9 21.7 21.7 18.5 20.1 19.3 20.1 19.3 21.7 19.3 19.3 20.9
[06:19:24.048] <TB2> INFO: enter test to run
[06:19:24.048] <TB2> INFO: test: pretest no parameter change
[06:19:24.048] <TB2> INFO: running: pretest
[06:19:24.049] <TB2> INFO: ----------------------------------------------------------------------
[06:19:24.049] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[06:19:24.049] <TB2> INFO: ----------------------------------------------------------------------
[06:19:30.527] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 385.1 mA = 24.0688 mA/ROC
[06:19:30.527] <TB2> INFO: i(loss) [mA/ROC]: 19.3 19.3 19.3 18.5 19.3 18.5 18.5 18.5 18.5 18.5 18.5 18.5 18.5 19.3 18.5 18.5
[06:19:30.556] <TB2> INFO: enter test to run
[06:19:30.556] <TB2> INFO: test: pretest no parameter change
[06:19:30.556] <TB2> INFO: running: pretest
[06:19:30.556] <TB2> INFO: ----------------------------------------------------------------------
[06:19:30.556] <TB2> INFO: PixTestPretest::findTiming()
[06:19:30.556] <TB2> INFO: ----------------------------------------------------------------------
[06:19:30.556] <TB2> INFO: PixTestCmd::init()

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


[06:21:08.652] <TB2> INFO: 231680 events read in total (9511ms).
[06:21:08.655] <TB2> INFO: Test took 10158ms.
[06:21:08.893] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[06:21:08.958] <TB2> INFO: enter test to run
[06:21:08.958] <TB2> INFO: test: pretest no parameter change
[06:21:08.958] <TB2> INFO: running: pretest
[06:21:08.959] <TB2> INFO: ----------------------------------------------------------------------
[06:21:08.959] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[06:21:08.959] <TB2> INFO: ----------------------------------------------------------------------
[06:21:09.051] <TB2> INFO: Expecting 231680 events.
[06:21:19.202] <TB2> INFO: 231680 events read in total (9595ms).
[06:21:19.206] <TB2> INFO: Test took 10243ms.
[06:21:19.464] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[06:21:19.464] <TB2> INFO: CalDel: 142 145 127 137 135 146 131 122 137 146 138 118 151 128 137 126
[06:21:19.464] <TB2> INFO: VthrComp: 51 51 51 52 51 51 51 51 51 51 51 51 51 51 51 51
[06:21:19.504] <TB2> INFO: enter test to run
[06:21:19.504] <TB2> INFO: test: pretest no parameter change
[06:21:19.504] <TB2> INFO: running: pretest
[06:21:19.504] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C0.dat
[06:21:19.505] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C1.dat
[06:21:19.505] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C2.dat
[06:21:19.505] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C3.dat
[06:21:19.505] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C4.dat
[06:21:19.506] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C5.dat
[06:21:19.506] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C6.dat
[06:21:19.506] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C7.dat
[06:21:19.506] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C8.dat
[06:21:19.506] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C9.dat
[06:21:19.506] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C10.dat
[06:21:19.506] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C11.dat
[06:21:19.507] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C12.dat
[06:21:19.507] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C13.dat
[06:21:19.507] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C14.dat
[06:21:19.507] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters_C15.dat
[06:21:19.507] <TB2> INFO: enter test to run
[06:21:19.507] <TB2> INFO: test: fulltest no parameter change
[06:21:19.507] <TB2> INFO: running: fulltest
[06:21:19.507] <TB2> INFO: ######################################################################
[06:21:19.507] <TB2> INFO: PixTestFullTest::doTest()
[06:21:19.507] <TB2> INFO: ######################################################################
[06:21:19.509] <TB2> INFO: ######################################################################
[06:21:19.509] <TB2> INFO: PixTestAlive::doTest()
[06:21:19.509] <TB2> INFO: ######################################################################
[06:21:19.510] <TB2> INFO: ----------------------------------------------------------------------
[06:21:19.510] <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)
[06:21:19.510] <TB2> INFO: ----------------------------------------------------------------------
[06:21:19.791] <TB2> INFO: Expecting 41600 events.
[06:21:23.573] <TB2> INFO: 41600 events read in total (3226ms).
[06:21:23.574] <TB2> INFO: Test took 4062ms.
[06:21:23.815] <TB2> INFO: PixTestAlive::aliveTest() done
[06:21:23.815] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 1 0 1 0 0 0 0 0 0 0 0 0
[06:21:23.817] <TB2> INFO: ----------------------------------------------------------------------
[06:21:23.817] <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)
[06:21:23.817] <TB2> INFO: ----------------------------------------------------------------------
[06:21:24.092] <TB2> INFO: Expecting 41600 events.
[06:21:27.081] <TB2> INFO: 41600 events read in total (2433ms).
[06:21:27.081] <TB2> INFO: Test took 3262ms.
[06:21:27.081] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[06:21:27.328] <TB2> INFO: PixTestAlive::maskTest() done
[06:21:27.328] <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
[06:21:27.330] <TB2> INFO: ----------------------------------------------------------------------
[06:21:27.330] <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)
[06:21:27.330] <TB2> INFO: ----------------------------------------------------------------------
[06:21:27.613] <TB2> INFO: Expecting 41600 events.
[06:21:31.370] <TB2> INFO: 41600 events read in total (3201ms).
[06:21:31.370] <TB2> INFO: Test took 4038ms.
[06:21:31.603] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[06:21:31.603] <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
[06:21:31.603] <TB2> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[06:21:31.603] <TB2> INFO: Decoding statistics:
[06:21:31.603] <TB2> INFO: General information:
[06:21:31.603] <TB2> INFO: 16bit words read: 0
[06:21:31.603] <TB2> INFO: valid events total: 0
[06:21:31.603] <TB2> INFO: empty events: 0
[06:21:31.603] <TB2> INFO: valid events with pixels: 0
[06:21:31.603] <TB2> INFO: valid pixel hits: 0
[06:21:31.603] <TB2> INFO: Event errors: 0
[06:21:31.603] <TB2> INFO: start marker: 0
[06:21:31.603] <TB2> INFO: stop marker: 0
[06:21:31.603] <TB2> INFO: overflow: 0
[06:21:31.603] <TB2> INFO: invalid 5bit words: 0
[06:21:31.603] <TB2> INFO: invalid XOR eye diagram: 0
[06:21:31.603] <TB2> INFO: frame (failed synchr.): 0
[06:21:31.603] <TB2> INFO: idle data (no TBM trl): 0
[06:21:31.603] <TB2> INFO: no data (only TBM hdr): 0
[06:21:31.603] <TB2> INFO: TBM errors: 0
[06:21:31.603] <TB2> INFO: flawed TBM headers: 0
[06:21:31.603] <TB2> INFO: flawed TBM trailers: 0
[06:21:31.603] <TB2> INFO: event ID mismatches: 0
[06:21:31.603] <TB2> INFO: ROC errors: 0
[06:21:31.603] <TB2> INFO: missing ROC header(s): 0
[06:21:31.603] <TB2> INFO: misplaced readback start: 0
[06:21:31.603] <TB2> INFO: Pixel decoding errors: 0
[06:21:31.603] <TB2> INFO: pixel data incomplete: 0
[06:21:31.603] <TB2> INFO: pixel address: 0
[06:21:31.603] <TB2> INFO: pulse height fill bit: 0
[06:21:31.603] <TB2> INFO: buffer corruption: 0
[06:21:31.610] <TB2> INFO: ######################################################################
[06:21:31.610] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[06:21:31.610] <TB2> INFO: ######################################################################
[06:21:31.613] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[06:21:31.624] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[06:21:31.624] <TB2> INFO: run 1 of 1
[06:21:31.890] <TB2> INFO: Expecting 3120000 events.
[06:22:13.221] <TB2> INFO: 869005 events read in total (40775ms).
[06:22:53.491] <TB2> INFO: 1730955 events read in total (81045ms).
[06:23:35.220] <TB2> INFO: 2605375 events read in total (122775ms).
[06:24:00.566] <TB2> INFO: 3120000 events read in total (148120ms).
[06:24:00.619] <TB2> INFO: Test took 148995ms.
[06:24:26.627] <TB2> INFO: PixTestBBMap::doTest() done, duration: 175 seconds
[06:24:26.627] <TB2> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0 0
[06:24:26.627] <TB2> INFO: separation cut (per ROC): 87 83 90 103 92 108 102 84 80 78 83 90 86 87 82 92
[06:24:26.627] <TB2> INFO: Decoding statistics:
[06:24:26.627] <TB2> INFO: General information:
[06:24:26.627] <TB2> INFO: 16bit words read: 0
[06:24:26.627] <TB2> INFO: valid events total: 0
[06:24:26.627] <TB2> INFO: empty events: 0
[06:24:26.627] <TB2> INFO: valid events with pixels: 0
[06:24:26.627] <TB2> INFO: valid pixel hits: 0
[06:24:26.627] <TB2> INFO: Event errors: 0
[06:24:26.627] <TB2> INFO: start marker: 0
[06:24:26.627] <TB2> INFO: stop marker: 0
[06:24:26.627] <TB2> INFO: overflow: 0
[06:24:26.628] <TB2> INFO: invalid 5bit words: 0
[06:24:26.628] <TB2> INFO: invalid XOR eye diagram: 0
[06:24:26.628] <TB2> INFO: frame (failed synchr.): 0
[06:24:26.628] <TB2> INFO: idle data (no TBM trl): 0
[06:24:26.628] <TB2> INFO: no data (only TBM hdr): 0
[06:24:26.628] <TB2> INFO: TBM errors: 0
[06:24:26.628] <TB2> INFO: flawed TBM headers: 0
[06:24:26.628] <TB2> INFO: flawed TBM trailers: 0
[06:24:26.628] <TB2> INFO: event ID mismatches: 0
[06:24:26.628] <TB2> INFO: ROC errors: 0
[06:24:26.628] <TB2> INFO: missing ROC header(s): 0
[06:24:26.628] <TB2> INFO: misplaced readback start: 0
[06:24:26.628] <TB2> INFO: Pixel decoding errors: 0
[06:24:26.628] <TB2> INFO: pixel data incomplete: 0
[06:24:26.628] <TB2> INFO: pixel address: 0
[06:24:26.628] <TB2> INFO: pulse height fill bit: 0
[06:24:26.628] <TB2> INFO: buffer corruption: 0
[06:24:26.716] <TB2> INFO: ######################################################################
[06:24:26.716] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[06:24:26.716] <TB2> INFO: ######################################################################
[06:24:26.717] <TB2> INFO: ----------------------------------------------------------------------
[06:24:26.717] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[06:24:26.717] <TB2> INFO: ----------------------------------------------------------------------
[06:24:26.717] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[06:24:26.729] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[06:24:26.729] <TB2> INFO: run 1 of 1
[06:24:27.022] <TB2> INFO: Expecting 26208000 events.
[06:25:00.584] <TB2> INFO: 895550 events read in total (33005ms).
[06:25:32.700] <TB2> INFO: 1776350 events read in total (65121ms).
[06:26:05.330] <TB2> INFO: 2656750 events read in total (97751ms).
[06:26:38.297] <TB2> INFO: 3533550 events read in total (130718ms).
[06:27:10.976] <TB2> INFO: 4409100 events read in total (163397ms).
[06:27:43.545] <TB2> INFO: 5285500 events read in total (195966ms).
[06:28:16.341] <TB2> INFO: 6163250 events read in total (228762ms).
[06:28:48.798] <TB2> INFO: 7036700 events read in total (261219ms).
[06:29:21.482] <TB2> INFO: 7911300 events read in total (293903ms).
[06:29:54.032] <TB2> INFO: 8787300 events read in total (326453ms).
[06:30:27.042] <TB2> INFO: 9664150 events read in total (359463ms).
[06:30:59.758] <TB2> INFO: 10537400 events read in total (392179ms).
[06:31:32.107] <TB2> INFO: 11410250 events read in total (424528ms).
[06:32:04.634] <TB2> INFO: 12284500 events read in total (457055ms).
[06:32:37.146] <TB2> INFO: 13156100 events read in total (489567ms).
[06:33:09.407] <TB2> INFO: 14017500 events read in total (521828ms).
[06:33:41.874] <TB2> INFO: 14881300 events read in total (554295ms).
[06:34:14.308] <TB2> INFO: 15746350 events read in total (586729ms).
[06:34:47.038] <TB2> INFO: 16605500 events read in total (619459ms).
[06:35:19.486] <TB2> INFO: 17466900 events read in total (651907ms).
[06:35:51.861] <TB2> INFO: 18328450 events read in total (684282ms).
[06:36:23.996] <TB2> INFO: 19189000 events read in total (716417ms).
[06:36:56.313] <TB2> INFO: 20047800 events read in total (748734ms).
[06:37:28.596] <TB2> INFO: 20907500 events read in total (781017ms).
[06:38:00.935] <TB2> INFO: 21768250 events read in total (813356ms).
[06:38:33.205] <TB2> INFO: 22625800 events read in total (845626ms).
[06:39:05.644] <TB2> INFO: 23487350 events read in total (878065ms).
[06:39:37.839] <TB2> INFO: 24348300 events read in total (910260ms).
[06:40:10.151] <TB2> INFO: 25209500 events read in total (942572ms).
[06:40:43.118] <TB2> INFO: 26082150 events read in total (975539ms).
[06:40:47.938] <TB2> INFO: 26208000 events read in total (980359ms).
[06:40:47.973] <TB2> INFO: Test took 981244ms.
[06:40:48.266] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:40:49.721] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:40:51.175] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:40:52.605] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:40:54.073] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:40:55.565] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:40:56.978] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:40:58.388] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:40:59.860] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:41:01.295] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:41:02.752] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:41:04.183] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:41:05.665] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:41:07.356] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:41:08.882] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:41:10.281] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[06:41:11.789] <TB2> INFO: PixTestScurves::scurves() done
[06:41:11.789] <TB2> INFO: Vcal mean: 88.78 84.42 92.98 102.69 95.90 102.46 92.02 84.75 81.88 87.73 84.94 85.73 92.42 82.39 81.64 89.08
[06:41:11.789] <TB2> INFO: Vcal RMS: 5.99 4.72 5.48 6.56 6.44 6.18 5.92 5.20 5.11 5.27 5.07 4.92 5.88 5.06 4.99 5.86
[06:41:11.789] <TB2> INFO: PixTestScurves::fullTest() done, duration: 1005 seconds
[06:41:11.789] <TB2> INFO: Decoding statistics:
[06:41:11.789] <TB2> INFO: General information:
[06:41:11.789] <TB2> INFO: 16bit words read: 0
[06:41:11.789] <TB2> INFO: valid events total: 0
[06:41:11.789] <TB2> INFO: empty events: 0
[06:41:11.789] <TB2> INFO: valid events with pixels: 0
[06:41:11.789] <TB2> INFO: valid pixel hits: 0
[06:41:11.789] <TB2> INFO: Event errors: 0
[06:41:11.789] <TB2> INFO: start marker: 0
[06:41:11.789] <TB2> INFO: stop marker: 0
[06:41:11.789] <TB2> INFO: overflow: 0
[06:41:11.789] <TB2> INFO: invalid 5bit words: 0
[06:41:11.789] <TB2> INFO: invalid XOR eye diagram: 0
[06:41:11.789] <TB2> INFO: frame (failed synchr.): 0
[06:41:11.789] <TB2> INFO: idle data (no TBM trl): 0
[06:41:11.789] <TB2> INFO: no data (only TBM hdr): 0
[06:41:11.789] <TB2> INFO: TBM errors: 0
[06:41:11.789] <TB2> INFO: flawed TBM headers: 0
[06:41:11.789] <TB2> INFO: flawed TBM trailers: 0
[06:41:11.789] <TB2> INFO: event ID mismatches: 0
[06:41:11.789] <TB2> INFO: ROC errors: 0
[06:41:11.789] <TB2> INFO: missing ROC header(s): 0
[06:41:11.789] <TB2> INFO: misplaced readback start: 0
[06:41:11.789] <TB2> INFO: Pixel decoding errors: 0
[06:41:11.789] <TB2> INFO: pixel data incomplete: 0
[06:41:11.789] <TB2> INFO: pixel address: 0
[06:41:11.790] <TB2> INFO: pulse height fill bit: 0
[06:41:11.790] <TB2> INFO: buffer corruption: 0
[06:41:11.863] <TB2> INFO: ######################################################################
[06:41:11.863] <TB2> INFO: PixTestTrim::doTest()
[06:41:11.863] <TB2> INFO: ######################################################################
[06:41:11.864] <TB2> INFO: ----------------------------------------------------------------------
[06:41:11.864] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[06:41:11.864] <TB2> INFO: ----------------------------------------------------------------------
[06:41:11.989] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[06:41:11.989] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[06:41:12.000] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[06:41:12.000] <TB2> INFO: run 1 of 1
[06:41:12.341] <TB2> INFO: Expecting 6281600 events.
[06:41:52.468] <TB2> INFO: 1086940 events read in total (39571ms).
[06:42:31.674] <TB2> INFO: 2172020 events read in total (78777ms).
[06:43:10.652] <TB2> INFO: 3251220 events read in total (117756ms).
[06:43:50.086] <TB2> INFO: 4337720 events read in total (157189ms).
[06:44:29.542] <TB2> INFO: 5429470 events read in total (196645ms).
[06:45:01.011] <TB2> INFO: 6281600 events read in total (228114ms).
[06:45:01.038] <TB2> INFO: Test took 229037ms.
[06:45:20.323] <TB2> INFO: ROC 0 VthrComp = 89
[06:45:20.323] <TB2> INFO: ROC 1 VthrComp = 87
[06:45:20.323] <TB2> INFO: ROC 2 VthrComp = 90
[06:45:20.323] <TB2> INFO: ROC 3 VthrComp = 99
[06:45:20.323] <TB2> INFO: ROC 4 VthrComp = 95
[06:45:20.323] <TB2> INFO: ROC 5 VthrComp = 101
[06:45:20.325] <TB2> INFO: ROC 6 VthrComp = 96
[06:45:20.325] <TB2> INFO: ROC 7 VthrComp = 88
[06:45:20.325] <TB2> INFO: ROC 8 VthrComp = 83
[06:45:20.325] <TB2> INFO: ROC 9 VthrComp = 89
[06:45:20.325] <TB2> INFO: ROC 10 VthrComp = 88
[06:45:20.325] <TB2> INFO: ROC 11 VthrComp = 92
[06:45:20.325] <TB2> INFO: ROC 12 VthrComp = 92
[06:45:20.327] <TB2> INFO: ROC 13 VthrComp = 87
[06:45:20.327] <TB2> INFO: ROC 14 VthrComp = 84
[06:45:20.327] <TB2> INFO: ROC 15 VthrComp = 93
[06:45:20.327] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[06:45:20.327] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[06:45:20.340] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[06:45:20.340] <TB2> INFO: run 1 of 1
[06:45:20.625] <TB2> INFO: Expecting 6281600 events.
[06:45:56.721] <TB2> INFO: 757000 events read in total (35540ms).
[06:46:31.431] <TB2> INFO: 1511470 events read in total (70250ms).
[06:47:06.223] <TB2> INFO: 2266500 events read in total (105042ms).
[06:47:41.238] <TB2> INFO: 3022000 events read in total (140057ms).
[06:48:15.815] <TB2> INFO: 3771740 events read in total (174634ms).
[06:48:50.378] <TB2> INFO: 4518540 events read in total (209197ms).
[06:49:25.157] <TB2> INFO: 5263490 events read in total (243976ms).
[06:49:59.816] <TB2> INFO: 6008200 events read in total (278635ms).
[06:50:13.032] <TB2> INFO: 6281600 events read in total (291851ms).
[06:50:13.089] <TB2> INFO: Test took 292749ms.
[06:50:37.405] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 62.1429 for pixel 8/0 mean/min/max = 47.1193/31.9882/62.2504
[06:50:37.405] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 57.5092 for pixel 8/31 mean/min/max = 44.8391/32.0508/57.6273
[06:50:37.405] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 61.4768 for pixel 18/4 mean/min/max = 47.3869/33.2764/61.4974
[06:50:37.405] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 62.6387 for pixel 17/79 mean/min/max = 46.9882/31.2681/62.7083
[06:50:37.406] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 61.1702 for pixel 31/79 mean/min/max = 46.3452/31.5129/61.1774
[06:50:37.406] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 61.4793 for pixel 13/77 mean/min/max = 46.7674/31.9441/61.5907
[06:50:37.406] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 59.2808 for pixel 0/57 mean/min/max = 45.3325/31.0836/59.5814
[06:50:37.406] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 59.7924 for pixel 0/37 mean/min/max = 46.2414/32.4899/59.9929
[06:50:37.407] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 59.1514 for pixel 51/27 mean/min/max = 45.2462/31.2497/59.2427
[06:50:37.407] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 58.5707 for pixel 1/2 mean/min/max = 45.8732/32.5065/59.2399
[06:50:37.407] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 58.5022 for pixel 3/11 mean/min/max = 45.504/32.4095/58.5985
[06:50:37.407] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 56.6108 for pixel 51/69 mean/min/max = 44.6002/32.5268/56.6735
[06:50:37.408] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 61.3518 for pixel 0/53 mean/min/max = 46.9161/32.4124/61.4197
[06:50:37.408] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 58.9593 for pixel 8/49 mean/min/max = 45.5816/32.1645/58.9988
[06:50:37.408] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 59.1416 for pixel 10/53 mean/min/max = 45.7457/32.1134/59.3781
[06:50:37.408] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 59.2175 for pixel 0/4 mean/min/max = 45.6131/31.8987/59.3274
[06:50:37.409] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[06:50:37.497] <TB2> INFO: Expecting 514560 events.
[06:50:50.372] <TB2> INFO: 514560 events read in total (12319ms).
[06:50:50.377] <TB2> INFO: Expecting 514560 events.
[06:51:03.156] <TB2> INFO: 514560 events read in total (12356ms).
[06:51:03.165] <TB2> INFO: Expecting 514560 events.
[06:51:15.752] <TB2> INFO: 514560 events read in total (12180ms).
[06:51:15.761] <TB2> INFO: Expecting 514560 events.
[06:51:28.481] <TB2> INFO: 514560 events read in total (12298ms).
[06:51:28.492] <TB2> INFO: Expecting 514560 events.
[06:51:41.132] <TB2> INFO: 514560 events read in total (12229ms).
[06:51:41.143] <TB2> INFO: Expecting 514560 events.
[06:51:53.989] <TB2> INFO: 514560 events read in total (12429ms).
[06:51:54.003] <TB2> INFO: Expecting 514560 events.
[06:52:06.812] <TB2> INFO: 514560 events read in total (12400ms).
[06:52:06.827] <TB2> INFO: Expecting 514560 events.
[06:52:19.552] <TB2> INFO: 514560 events read in total (12316ms).
[06:52:19.569] <TB2> INFO: Expecting 514560 events.
[06:52:32.360] <TB2> INFO: 514560 events read in total (12378ms).
[06:52:32.378] <TB2> INFO: Expecting 514560 events.
[06:52:45.024] <TB2> INFO: 514560 events read in total (12235ms).
[06:52:45.049] <TB2> INFO: Expecting 514560 events.
[06:52:57.887] <TB2> INFO: 514560 events read in total (12436ms).
[06:52:57.910] <TB2> INFO: Expecting 514560 events.
[06:53:10.669] <TB2> INFO: 514560 events read in total (12357ms).
[06:53:10.694] <TB2> INFO: Expecting 514560 events.
[06:53:23.262] <TB2> INFO: 514560 events read in total (12166ms).
[06:53:23.287] <TB2> INFO: Expecting 514560 events.
[06:53:35.969] <TB2> INFO: 514560 events read in total (12276ms).
[06:53:35.997] <TB2> INFO: Expecting 514560 events.
[06:53:48.698] <TB2> INFO: 514560 events read in total (12299ms).
[06:53:48.728] <TB2> INFO: Expecting 514560 events.
[06:54:01.511] <TB2> INFO: 514560 events read in total (12381ms).
[06:54:01.542] <TB2> INFO: Test took 204133ms.
[06:54:02.473] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[06:54:02.483] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[06:54:02.483] <TB2> INFO: run 1 of 1
[06:54:02.756] <TB2> INFO: Expecting 6281600 events.
[06:54:38.190] <TB2> INFO: 741730 events read in total (34878ms).
[06:55:12.670] <TB2> INFO: 1482290 events read in total (69358ms).
[06:55:46.898] <TB2> INFO: 2222710 events read in total (103586ms).
[06:56:21.153] <TB2> INFO: 2963860 events read in total (137841ms).
[06:56:55.764] <TB2> INFO: 3698950 events read in total (172452ms).
[06:57:30.320] <TB2> INFO: 4429630 events read in total (207008ms).
[06:58:04.962] <TB2> INFO: 5158840 events read in total (241650ms).
[06:58:40.055] <TB2> INFO: 5888050 events read in total (276743ms).
[06:58:59.744] <TB2> INFO: 6281600 events read in total (296432ms).
[06:58:59.793] <TB2> INFO: Test took 297310ms.
[06:59:24.164] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.113201 .. 255.000000
[06:59:24.243] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[06:59:24.255] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[06:59:24.255] <TB2> INFO: run 1 of 1
[06:59:24.551] <TB2> INFO: Expecting 10649600 events.
[06:59:59.147] <TB2> INFO: 712330 events read in total (34040ms).
[07:00:33.356] <TB2> INFO: 1424710 events read in total (68250ms).
[07:01:07.788] <TB2> INFO: 2137400 events read in total (102681ms).
[07:01:41.830] <TB2> INFO: 2850200 events read in total (136723ms).
[07:02:15.955] <TB2> INFO: 3562530 events read in total (170848ms).
[07:02:49.923] <TB2> INFO: 4275010 events read in total (204816ms).
[07:03:24.089] <TB2> INFO: 4987580 events read in total (238983ms).
[07:03:58.153] <TB2> INFO: 5699860 events read in total (273046ms).
[07:04:32.339] <TB2> INFO: 6412020 events read in total (307232ms).
[07:05:06.874] <TB2> INFO: 7123540 events read in total (341767ms).
[07:05:41.247] <TB2> INFO: 7835080 events read in total (376140ms).
[07:06:15.373] <TB2> INFO: 8546040 events read in total (410266ms).
[07:06:49.224] <TB2> INFO: 9256630 events read in total (444117ms).
[07:07:23.130] <TB2> INFO: 9967330 events read in total (478023ms).
[07:07:56.610] <TB2> INFO: 10649600 events read in total (511503ms).
[07:07:56.709] <TB2> INFO: Test took 512455ms.
[07:08:25.685] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 13.141892 .. 60.332754
[07:08:25.784] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 3 .. 70 (-1/-1) hits flags = 528 (plus default)
[07:08:25.794] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[07:08:25.794] <TB2> INFO: run 1 of 1
[07:08:26.083] <TB2> INFO: Expecting 2828800 events.
[07:09:02.913] <TB2> INFO: 866320 events read in total (36267ms).
[07:09:39.199] <TB2> INFO: 1732140 events read in total (72554ms).
[07:10:15.640] <TB2> INFO: 2596180 events read in total (108995ms).
[07:10:25.761] <TB2> INFO: 2828800 events read in total (119115ms).
[07:10:25.785] <TB2> INFO: Test took 119991ms.
[07:10:41.651] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 19.816431 .. 60.332754
[07:10:41.726] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 9 .. 70 (-1/-1) hits flags = 528 (plus default)
[07:10:41.735] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[07:10:41.735] <TB2> INFO: run 1 of 1
[07:10:42.000] <TB2> INFO: Expecting 2579200 events.
[07:11:19.061] <TB2> INFO: 839870 events read in total (36505ms).
[07:11:55.507] <TB2> INFO: 1679440 events read in total (72952ms).
[07:12:31.768] <TB2> INFO: 2517740 events read in total (109212ms).
[07:12:34.730] <TB2> INFO: 2579200 events read in total (112174ms).
[07:12:34.749] <TB2> INFO: Test took 113014ms.
[07:12:51.049] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 3.500000 .. 60.332754
[07:12:51.128] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 3 .. 70 (-1/-1) hits flags = 528 (plus default)
[07:12:51.137] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[07:12:51.137] <TB2> INFO: run 1 of 1
[07:12:51.414] <TB2> INFO: Expecting 2828800 events.
[07:13:28.296] <TB2> INFO: 867810 events read in total (36325ms).
[07:14:04.686] <TB2> INFO: 1735750 events read in total (72715ms).
[07:14:40.906] <TB2> INFO: 2603520 events read in total (108935ms).
[07:14:50.644] <TB2> INFO: 2828800 events read in total (118673ms).
[07:14:50.664] <TB2> INFO: Test took 119527ms.
[07:15:06.275] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[07:15:06.275] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[07:15:06.283] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[07:15:06.283] <TB2> INFO: run 1 of 1
[07:15:06.574] <TB2> INFO: Expecting 1705600 events.
[07:15:43.946] <TB2> INFO: 878450 events read in total (36816ms).
[07:16:18.524] <TB2> INFO: 1705600 events read in total (71394ms).
[07:16:18.539] <TB2> INFO: Test took 72256ms.
[07:16:33.198] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C0.dat
[07:16:33.198] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C1.dat
[07:16:33.198] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C2.dat
[07:16:33.198] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C3.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C4.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C5.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C6.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C7.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C8.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C9.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C10.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C11.dat
[07:16:33.199] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C12.dat
[07:16:33.200] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C13.dat
[07:16:33.200] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C14.dat
[07:16:33.200] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C15.dat
[07:16:33.200] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C0.dat
[07:16:33.206] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C1.dat
[07:16:33.212] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C2.dat
[07:16:33.218] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C3.dat
[07:16:33.225] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C4.dat
[07:16:33.231] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C5.dat
[07:16:33.238] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C6.dat
[07:16:33.245] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C7.dat
[07:16:33.251] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C8.dat
[07:16:33.258] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C9.dat
[07:16:33.264] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C10.dat
[07:16:33.271] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C11.dat
[07:16:33.277] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C12.dat
[07:16:33.283] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C13.dat
[07:16:33.289] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C14.dat
[07:16:33.295] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//trimParameters35_C15.dat
[07:16:33.301] <TB2> INFO: PixTestTrim::trimTest() done
[07:16:33.301] <TB2> INFO: vtrim: 109 88 99 96 94 98 104 88 86 81 104 86 89 90 92 87
[07:16:33.301] <TB2> INFO: vthrcomp: 89 87 90 99 95 101 96 88 83 89 88 92 92 87 84 93
[07:16:33.301] <TB2> INFO: vcal mean: 34.99 34.97 34.95 34.94 35.02 34.98 34.96 34.96 34.99 35.01 34.91 34.98 35.06 34.97 34.94 34.99
[07:16:33.301] <TB2> INFO: vcal RMS: 0.93 0.85 0.93 1.12 1.06 0.94 1.03 0.84 0.84 0.88 0.89 0.83 3.53 0.88 0.90 0.88
[07:16:33.301] <TB2> INFO: bits mean: 9.31 9.93 9.29 9.16 8.94 9.39 9.42 9.07 9.48 9.09 9.68 9.38 8.76 9.47 9.55 8.94
[07:16:33.302] <TB2> INFO: bits RMS: 2.71 2.57 2.51 2.80 2.96 2.64 2.89 2.76 2.81 2.82 2.54 2.77 2.91 2.71 2.62 3.00
[07:16:33.308] <TB2> INFO: ----------------------------------------------------------------------
[07:16:33.308] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[07:16:33.308] <TB2> INFO: ----------------------------------------------------------------------
[07:16:33.311] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[07:16:33.320] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[07:16:33.320] <TB2> INFO: run 1 of 1
[07:16:33.608] <TB2> INFO: Expecting 4160000 events.
[07:17:15.496] <TB2> INFO: 927090 events read in total (41332ms).
[07:17:57.130] <TB2> INFO: 1848545 events read in total (82966ms).
[07:18:37.547] <TB2> INFO: 2761935 events read in total (123383ms).
[07:19:18.342] <TB2> INFO: 3672890 events read in total (164178ms).
[07:19:40.236] <TB2> INFO: 4160000 events read in total (186072ms).
[07:19:40.275] <TB2> INFO: Test took 186955ms.
[07:20:08.206] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 194 (-1/-1) hits flags = 528 (plus default)
[07:20:08.214] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[07:20:08.214] <TB2> INFO: run 1 of 1
[07:20:08.475] <TB2> INFO: Expecting 4056000 events.
[07:20:49.754] <TB2> INFO: 905410 events read in total (40723ms).
[07:21:31.112] <TB2> INFO: 1805385 events read in total (82081ms).
[07:22:11.563] <TB2> INFO: 2696980 events read in total (122532ms).
[07:22:51.992] <TB2> INFO: 3585845 events read in total (162961ms).
[07:23:13.455] <TB2> INFO: 4056000 events read in total (184424ms).
[07:23:13.494] <TB2> INFO: Test took 185280ms.
[07:23:43.855] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 181 (-1/-1) hits flags = 528 (plus default)
[07:23:43.864] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[07:23:43.864] <TB2> INFO: run 1 of 1
[07:23:44.125] <TB2> INFO: Expecting 3785600 events.
[07:24:28.471] <TB2> INFO: 928510 events read in total (43789ms).
[07:25:09.616] <TB2> INFO: 1850690 events read in total (84934ms).
[07:25:50.218] <TB2> INFO: 2762285 events read in total (125536ms).
[07:26:31.316] <TB2> INFO: 3672500 events read in total (166634ms).
[07:26:36.693] <TB2> INFO: 3785600 events read in total (172011ms).
[07:26:36.727] <TB2> INFO: Test took 172863ms.
[07:27:04.665] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 182 (-1/-1) hits flags = 528 (plus default)
[07:27:04.674] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[07:27:04.674] <TB2> INFO: run 1 of 1
[07:27:04.935] <TB2> INFO: Expecting 3806400 events.
[07:27:46.816] <TB2> INFO: 925735 events read in total (41325ms).
[07:28:27.918] <TB2> INFO: 1845135 events read in total (82427ms).
[07:29:08.547] <TB2> INFO: 2753720 events read in total (123057ms).
[07:29:49.648] <TB2> INFO: 3661365 events read in total (164157ms).
[07:29:56.489] <TB2> INFO: 3806400 events read in total (170998ms).
[07:29:56.525] <TB2> INFO: Test took 171851ms.
[07:30:24.323] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 184 (-1/-1) hits flags = 528 (plus default)
[07:30:24.331] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[07:30:24.331] <TB2> INFO: run 1 of 1
[07:30:24.593] <TB2> INFO: Expecting 3848000 events.
[07:31:06.647] <TB2> INFO: 921320 events read in total (41498ms).
[07:31:47.519] <TB2> INFO: 1836370 events read in total (82370ms).
[07:32:28.582] <TB2> INFO: 2741430 events read in total (123433ms).
[07:33:09.362] <TB2> INFO: 3644515 events read in total (164213ms).
[07:33:18.689] <TB2> INFO: 3848000 events read in total (173540ms).
[07:33:18.725] <TB2> INFO: Test took 174393ms.
[07:33:47.933] <TB2> INFO: PixTestTrim::trimBitTest() done
[07:33:47.934] <TB2> INFO: PixTestTrim::doTest() done, duration: 3156 seconds
[07:33:47.934] <TB2> INFO: Decoding statistics:
[07:33:47.934] <TB2> INFO: General information:
[07:33:47.934] <TB2> INFO: 16bit words read: 0
[07:33:47.934] <TB2> INFO: valid events total: 0
[07:33:47.934] <TB2> INFO: empty events: 0
[07:33:47.934] <TB2> INFO: valid events with pixels: 0
[07:33:47.934] <TB2> INFO: valid pixel hits: 0
[07:33:47.934] <TB2> INFO: Event errors: 0
[07:33:47.934] <TB2> INFO: start marker: 0
[07:33:47.934] <TB2> INFO: stop marker: 0
[07:33:47.934] <TB2> INFO: overflow: 0
[07:33:47.934] <TB2> INFO: invalid 5bit words: 0
[07:33:47.934] <TB2> INFO: invalid XOR eye diagram: 0
[07:33:47.934] <TB2> INFO: frame (failed synchr.): 0
[07:33:47.934] <TB2> INFO: idle data (no TBM trl): 0
[07:33:47.934] <TB2> INFO: no data (only TBM hdr): 0
[07:33:47.934] <TB2> INFO: TBM errors: 0
[07:33:47.934] <TB2> INFO: flawed TBM headers: 0
[07:33:47.934] <TB2> INFO: flawed TBM trailers: 0
[07:33:47.934] <TB2> INFO: event ID mismatches: 0
[07:33:47.934] <TB2> INFO: ROC errors: 0
[07:33:47.934] <TB2> INFO: missing ROC header(s): 0
[07:33:47.934] <TB2> INFO: misplaced readback start: 0
[07:33:47.934] <TB2> INFO: Pixel decoding errors: 0
[07:33:47.934] <TB2> INFO: pixel data incomplete: 0
[07:33:47.934] <TB2> INFO: pixel address: 0
[07:33:47.934] <TB2> INFO: pulse height fill bit: 0
[07:33:47.934] <TB2> INFO: buffer corruption: 0
[07:33:48.648] <TB2> INFO: ######################################################################
[07:33:48.648] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[07:33:48.648] <TB2> INFO: ######################################################################
[07:33:48.926] <TB2> INFO: Expecting 41600 events.
[07:33:52.737] <TB2> INFO: 41600 events read in total (3255ms).
[07:33:52.738] <TB2> INFO: Test took 4089ms.
[07:33:53.242] <TB2> INFO: Expecting 41600 events.
[07:33:57.023] <TB2> INFO: 41600 events read in total (3224ms).
[07:33:57.023] <TB2> INFO: Test took 4081ms.
[07:33:57.306] <TB2> INFO: Expecting 41600 events.
[07:34:01.092] <TB2> INFO: 41600 events read in total (3229ms).
[07:34:01.093] <TB2> INFO: Test took 4048ms.
[07:34:01.349] <TB2> INFO: Expecting 2560 events.
[07:34:02.201] <TB2> INFO: 2560 events read in total (296ms).
[07:34:02.201] <TB2> INFO: Test took 1094ms.
[07:34:02.507] <TB2> INFO: Expecting 2560 events.
[07:34:03.359] <TB2> INFO: 2560 events read in total (296ms).
[07:34:03.360] <TB2> INFO: Test took 1158ms.
[07:34:03.665] <TB2> INFO: Expecting 2560 events.
[07:34:04.519] <TB2> INFO: 2560 events read in total (298ms).
[07:34:04.520] <TB2> INFO: Test took 1160ms.
[07:34:04.824] <TB2> INFO: Expecting 2560 events.
[07:34:05.679] <TB2> INFO: 2560 events read in total (298ms).
[07:34:05.680] <TB2> INFO: Test took 1160ms.
[07:34:05.985] <TB2> INFO: Expecting 2560 events.
[07:34:06.837] <TB2> INFO: 2560 events read in total (296ms).
[07:34:06.837] <TB2> INFO: Test took 1157ms.
[07:34:07.142] <TB2> INFO: Expecting 2560 events.
[07:34:07.994] <TB2> INFO: 2560 events read in total (295ms).
[07:34:07.994] <TB2> INFO: Test took 1156ms.
[07:34:08.299] <TB2> INFO: Expecting 2560 events.
[07:34:09.154] <TB2> INFO: 2560 events read in total (299ms).
[07:34:09.154] <TB2> INFO: Test took 1158ms.
[07:34:09.459] <TB2> INFO: Expecting 2560 events.
[07:34:10.312] <TB2> INFO: 2560 events read in total (297ms).
[07:34:10.312] <TB2> INFO: Test took 1156ms.
[07:34:10.617] <TB2> INFO: Expecting 2560 events.
[07:34:11.471] <TB2> INFO: 2560 events read in total (298ms).
[07:34:11.471] <TB2> INFO: Test took 1157ms.
[07:34:11.776] <TB2> INFO: Expecting 2560 events.
[07:34:12.631] <TB2> INFO: 2560 events read in total (299ms).
[07:34:12.631] <TB2> INFO: Test took 1160ms.
[07:34:12.936] <TB2> INFO: Expecting 2560 events.
[07:34:13.789] <TB2> INFO: 2560 events read in total (297ms).
[07:34:13.789] <TB2> INFO: Test took 1158ms.
[07:34:14.094] <TB2> INFO: Expecting 2560 events.
[07:34:14.949] <TB2> INFO: 2560 events read in total (299ms).
[07:34:14.949] <TB2> INFO: Test took 1160ms.
[07:34:15.254] <TB2> INFO: Expecting 2560 events.
[07:34:16.109] <TB2> INFO: 2560 events read in total (299ms).
[07:34:16.109] <TB2> INFO: Test took 1159ms.
[07:34:16.414] <TB2> INFO: Expecting 2560 events.
[07:34:17.267] <TB2> INFO: 2560 events read in total (297ms).
[07:34:17.267] <TB2> INFO: Test took 1158ms.
[07:34:17.572] <TB2> INFO: Expecting 2560 events.
[07:34:18.426] <TB2> INFO: 2560 events read in total (297ms).
[07:34:18.426] <TB2> INFO: Test took 1159ms.
[07:34:18.731] <TB2> INFO: Expecting 2560 events.
[07:34:19.584] <TB2> INFO: 2560 events read in total (297ms).
[07:34:19.584] <TB2> INFO: Test took 1158ms.
[07:34:19.588] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:34:19.890] <TB2> INFO: Expecting 655360 events.
[07:34:36.752] <TB2> INFO: 655360 events read in total (16306ms).
[07:34:36.765] <TB2> INFO: Expecting 655360 events.
[07:34:53.556] <TB2> INFO: 655360 events read in total (16390ms).
[07:34:53.568] <TB2> INFO: Expecting 655360 events.
[07:35:10.261] <TB2> INFO: 655360 events read in total (16291ms).
[07:35:10.276] <TB2> INFO: Expecting 655360 events.
[07:35:26.943] <TB2> INFO: 655360 events read in total (16266ms).
[07:35:26.971] <TB2> INFO: Expecting 655360 events.
[07:35:43.636] <TB2> INFO: 655360 events read in total (16264ms).
[07:35:43.662] <TB2> INFO: Expecting 655360 events.
[07:36:00.404] <TB2> INFO: 655360 events read in total (16340ms).
[07:36:00.431] <TB2> INFO: Expecting 655360 events.
[07:36:17.158] <TB2> INFO: 655360 events read in total (16325ms).
[07:36:17.187] <TB2> INFO: Expecting 655360 events.
[07:36:33.824] <TB2> INFO: 655360 events read in total (16235ms).
[07:36:33.857] <TB2> INFO: Expecting 655360 events.
[07:36:50.559] <TB2> INFO: 655360 events read in total (16301ms).
[07:36:50.597] <TB2> INFO: Expecting 655360 events.
[07:37:07.289] <TB2> INFO: 655360 events read in total (16290ms).
[07:37:07.333] <TB2> INFO: Expecting 655360 events.
[07:37:24.069] <TB2> INFO: 655360 events read in total (16335ms).
[07:37:24.113] <TB2> INFO: Expecting 655360 events.
[07:37:40.861] <TB2> INFO: 655360 events read in total (16346ms).
[07:37:40.909] <TB2> INFO: Expecting 655360 events.
[07:37:57.629] <TB2> INFO: 655360 events read in total (16318ms).
[07:37:57.679] <TB2> INFO: Expecting 655360 events.
[07:38:14.635] <TB2> INFO: 655360 events read in total (16554ms).
[07:38:14.689] <TB2> INFO: Expecting 655360 events.
[07:38:31.487] <TB2> INFO: 655360 events read in total (16396ms).
[07:38:31.544] <TB2> INFO: Expecting 655360 events.
[07:38:48.310] <TB2> INFO: 655360 events read in total (16364ms).
[07:38:48.379] <TB2> INFO: Test took 268791ms.
[07:38:48.462] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:38:48.692] <TB2> INFO: Expecting 655360 events.
[07:39:05.408] <TB2> INFO: 655360 events read in total (16159ms).
[07:39:05.417] <TB2> INFO: Expecting 655360 events.
[07:39:22.115] <TB2> INFO: 655360 events read in total (16296ms).
[07:39:22.131] <TB2> INFO: Expecting 655360 events.
[07:39:38.662] <TB2> INFO: 655360 events read in total (16130ms).
[07:39:38.678] <TB2> INFO: Expecting 655360 events.
[07:39:54.948] <TB2> INFO: 655360 events read in total (15868ms).
[07:39:54.970] <TB2> INFO: Expecting 655360 events.
[07:40:11.461] <TB2> INFO: 655360 events read in total (16090ms).
[07:40:11.483] <TB2> INFO: Expecting 655360 events.
[07:40:28.161] <TB2> INFO: 655360 events read in total (16276ms).
[07:40:28.187] <TB2> INFO: Expecting 655360 events.
[07:40:44.649] <TB2> INFO: 655360 events read in total (16060ms).
[07:40:44.677] <TB2> INFO: Expecting 655360 events.
[07:41:01.472] <TB2> INFO: 655360 events read in total (16393ms).
[07:41:01.504] <TB2> INFO: Expecting 655360 events.
[07:41:18.247] <TB2> INFO: 655360 events read in total (16341ms).
[07:41:18.282] <TB2> INFO: Expecting 655360 events.
[07:41:34.759] <TB2> INFO: 655360 events read in total (16075ms).
[07:41:34.809] <TB2> INFO: Expecting 655360 events.
[07:41:51.403] <TB2> INFO: 655360 events read in total (16193ms).
[07:41:51.454] <TB2> INFO: Expecting 655360 events.
[07:42:08.110] <TB2> INFO: 655360 events read in total (16254ms).
[07:42:08.156] <TB2> INFO: Expecting 655360 events.
[07:42:24.841] <TB2> INFO: 655360 events read in total (16283ms).
[07:42:24.891] <TB2> INFO: Expecting 655360 events.
[07:42:41.598] <TB2> INFO: 655360 events read in total (16305ms).
[07:42:41.664] <TB2> INFO: Expecting 655360 events.
[07:42:58.381] <TB2> INFO: 655360 events read in total (16315ms).
[07:42:58.436] <TB2> INFO: Expecting 655360 events.
[07:43:15.000] <TB2> INFO: 655360 events read in total (16162ms).
[07:43:15.062] <TB2> INFO: Test took 266600ms.
[07:43:15.245] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.252] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.259] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.265] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.273] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.280] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.287] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.293] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.300] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.307] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.314] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.321] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.327] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.334] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.341] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.348] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[07:43:15.387] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C0.dat
[07:43:15.387] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C1.dat
[07:43:15.387] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C2.dat
[07:43:15.387] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C3.dat
[07:43:15.387] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C4.dat
[07:43:15.387] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C5.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C6.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C7.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C8.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C9.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C10.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C11.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C12.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C13.dat
[07:43:15.388] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C14.dat
[07:43:15.389] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//dacParameters35_C15.dat
[07:43:15.651] <TB2> INFO: Expecting 41600 events.
[07:43:19.107] <TB2> INFO: 41600 events read in total (2900ms).
[07:43:19.107] <TB2> INFO: Test took 3716ms.
[07:43:19.546] <TB2> INFO: Expecting 41600 events.
[07:43:22.973] <TB2> INFO: 41600 events read in total (2871ms).
[07:43:22.974] <TB2> INFO: Test took 3690ms.
[07:43:23.415] <TB2> INFO: Expecting 41600 events.
[07:43:26.868] <TB2> INFO: 41600 events read in total (2897ms).
[07:43:26.869] <TB2> INFO: Test took 3716ms.
[07:43:27.054] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:27.142] <TB2> INFO: Expecting 2560 events.
[07:43:27.995] <TB2> INFO: 2560 events read in total (297ms).
[07:43:27.996] <TB2> INFO: Test took 942ms.
[07:43:27.998] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:28.301] <TB2> INFO: Expecting 2560 events.
[07:43:29.154] <TB2> INFO: 2560 events read in total (297ms).
[07:43:29.155] <TB2> INFO: Test took 1157ms.
[07:43:29.157] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:29.460] <TB2> INFO: Expecting 2560 events.
[07:43:30.313] <TB2> INFO: 2560 events read in total (297ms).
[07:43:30.313] <TB2> INFO: Test took 1156ms.
[07:43:30.315] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:30.618] <TB2> INFO: Expecting 2560 events.
[07:43:31.474] <TB2> INFO: 2560 events read in total (299ms).
[07:43:31.474] <TB2> INFO: Test took 1159ms.
[07:43:31.476] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:31.781] <TB2> INFO: Expecting 2560 events.
[07:43:32.636] <TB2> INFO: 2560 events read in total (299ms).
[07:43:32.636] <TB2> INFO: Test took 1160ms.
[07:43:32.638] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:32.941] <TB2> INFO: Expecting 2560 events.
[07:43:33.795] <TB2> INFO: 2560 events read in total (297ms).
[07:43:33.795] <TB2> INFO: Test took 1157ms.
[07:43:33.797] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:34.101] <TB2> INFO: Expecting 2560 events.
[07:43:34.954] <TB2> INFO: 2560 events read in total (297ms).
[07:43:34.954] <TB2> INFO: Test took 1157ms.
[07:43:34.956] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:35.259] <TB2> INFO: Expecting 2560 events.
[07:43:36.112] <TB2> INFO: 2560 events read in total (296ms).
[07:43:36.113] <TB2> INFO: Test took 1157ms.
[07:43:36.115] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:36.418] <TB2> INFO: Expecting 2560 events.
[07:43:37.272] <TB2> INFO: 2560 events read in total (297ms).
[07:43:37.272] <TB2> INFO: Test took 1157ms.
[07:43:37.275] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:37.577] <TB2> INFO: Expecting 2560 events.
[07:43:38.430] <TB2> INFO: 2560 events read in total (296ms).
[07:43:38.431] <TB2> INFO: Test took 1156ms.
[07:43:38.433] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:38.736] <TB2> INFO: Expecting 2560 events.
[07:43:39.592] <TB2> INFO: 2560 events read in total (299ms).
[07:43:39.592] <TB2> INFO: Test took 1159ms.
[07:43:39.594] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:39.898] <TB2> INFO: Expecting 2560 events.
[07:43:40.754] <TB2> INFO: 2560 events read in total (299ms).
[07:43:40.754] <TB2> INFO: Test took 1160ms.
[07:43:40.757] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:41.059] <TB2> INFO: Expecting 2560 events.
[07:43:41.915] <TB2> INFO: 2560 events read in total (300ms).
[07:43:41.915] <TB2> INFO: Test took 1158ms.
[07:43:41.917] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:42.220] <TB2> INFO: Expecting 2560 events.
[07:43:43.076] <TB2> INFO: 2560 events read in total (300ms).
[07:43:43.076] <TB2> INFO: Test took 1159ms.
[07:43:43.078] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:43.381] <TB2> INFO: Expecting 2560 events.
[07:43:44.235] <TB2> INFO: 2560 events read in total (297ms).
[07:43:44.236] <TB2> INFO: Test took 1158ms.
[07:43:44.238] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:44.541] <TB2> INFO: Expecting 2560 events.
[07:43:45.397] <TB2> INFO: 2560 events read in total (300ms).
[07:43:45.397] <TB2> INFO: Test took 1159ms.
[07:43:45.399] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:45.702] <TB2> INFO: Expecting 2560 events.
[07:43:46.555] <TB2> INFO: 2560 events read in total (296ms).
[07:43:46.556] <TB2> INFO: Test took 1157ms.
[07:43:46.558] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:46.861] <TB2> INFO: Expecting 2560 events.
[07:43:47.714] <TB2> INFO: 2560 events read in total (297ms).
[07:43:47.714] <TB2> INFO: Test took 1156ms.
[07:43:47.717] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:48.020] <TB2> INFO: Expecting 2560 events.
[07:43:48.876] <TB2> INFO: 2560 events read in total (299ms).
[07:43:48.876] <TB2> INFO: Test took 1159ms.
[07:43:48.878] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:49.183] <TB2> INFO: Expecting 2560 events.
[07:43:50.036] <TB2> INFO: 2560 events read in total (297ms).
[07:43:50.036] <TB2> INFO: Test took 1158ms.
[07:43:50.038] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:50.342] <TB2> INFO: Expecting 2560 events.
[07:43:51.196] <TB2> INFO: 2560 events read in total (298ms).
[07:43:51.196] <TB2> INFO: Test took 1158ms.
[07:43:51.198] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:51.502] <TB2> INFO: Expecting 2560 events.
[07:43:52.357] <TB2> INFO: 2560 events read in total (298ms).
[07:43:52.357] <TB2> INFO: Test took 1159ms.
[07:43:52.360] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:52.662] <TB2> INFO: Expecting 2560 events.
[07:43:53.515] <TB2> INFO: 2560 events read in total (297ms).
[07:43:53.516] <TB2> INFO: Test took 1156ms.
[07:43:53.519] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:53.821] <TB2> INFO: Expecting 2560 events.
[07:43:54.674] <TB2> INFO: 2560 events read in total (297ms).
[07:43:54.674] <TB2> INFO: Test took 1156ms.
[07:43:54.676] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:54.980] <TB2> INFO: Expecting 2560 events.
[07:43:55.833] <TB2> INFO: 2560 events read in total (297ms).
[07:43:55.833] <TB2> INFO: Test took 1157ms.
[07:43:55.835] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:56.139] <TB2> INFO: Expecting 2560 events.
[07:43:56.992] <TB2> INFO: 2560 events read in total (297ms).
[07:43:56.992] <TB2> INFO: Test took 1157ms.
[07:43:56.994] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:57.297] <TB2> INFO: Expecting 2560 events.
[07:43:58.156] <TB2> INFO: 2560 events read in total (302ms).
[07:43:58.156] <TB2> INFO: Test took 1162ms.
[07:43:58.159] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:58.462] <TB2> INFO: Expecting 2560 events.
[07:43:59.317] <TB2> INFO: 2560 events read in total (298ms).
[07:43:59.317] <TB2> INFO: Test took 1159ms.
[07:43:59.320] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:43:59.623] <TB2> INFO: Expecting 2560 events.
[07:44:00.478] <TB2> INFO: 2560 events read in total (299ms).
[07:44:00.478] <TB2> INFO: Test took 1159ms.
[07:44:00.480] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:44:00.785] <TB2> INFO: Expecting 2560 events.
[07:44:01.643] <TB2> INFO: 2560 events read in total (303ms).
[07:44:01.644] <TB2> INFO: Test took 1164ms.
[07:44:01.649] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:44:01.950] <TB2> INFO: Expecting 2560 events.
[07:44:02.807] <TB2> INFO: 2560 events read in total (301ms).
[07:44:02.807] <TB2> INFO: Test took 1158ms.
[07:44:02.811] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:44:03.113] <TB2> INFO: Expecting 2560 events.
[07:44:03.969] <TB2> INFO: 2560 events read in total (300ms).
[07:44:03.969] <TB2> INFO: Test took 1159ms.
[07:44:04.437] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 615 seconds
[07:44:04.437] <TB2> INFO: PH scale (per ROC): 78 82 74 84 70 80 79 92 89 81 88 87 73 83 82 80
[07:44:04.437] <TB2> INFO: PH offset (per ROC): 171 161 179 150 167 167 146 161 154 154 158 148 169 148 160 154
[07:44:04.444] <TB2> INFO: Decoding statistics:
[07:44:04.444] <TB2> INFO: General information:
[07:44:04.444] <TB2> INFO: 16bit words read: 91928
[07:44:04.444] <TB2> INFO: valid events total: 10240
[07:44:04.444] <TB2> INFO: empty events: 7738
[07:44:04.444] <TB2> INFO: valid events with pixels: 2502
[07:44:04.444] <TB2> INFO: valid pixel hits: 2502
[07:44:04.444] <TB2> INFO: Event errors: 0
[07:44:04.444] <TB2> INFO: start marker: 0
[07:44:04.444] <TB2> INFO: stop marker: 0
[07:44:04.444] <TB2> INFO: overflow: 0
[07:44:04.444] <TB2> INFO: invalid 5bit words: 0
[07:44:04.444] <TB2> INFO: invalid XOR eye diagram: 0
[07:44:04.444] <TB2> INFO: frame (failed synchr.): 0
[07:44:04.444] <TB2> INFO: idle data (no TBM trl): 0
[07:44:04.444] <TB2> INFO: no data (only TBM hdr): 0
[07:44:04.444] <TB2> INFO: TBM errors: 0
[07:44:04.444] <TB2> INFO: flawed TBM headers: 0
[07:44:04.444] <TB2> INFO: flawed TBM trailers: 0
[07:44:04.444] <TB2> INFO: event ID mismatches: 0
[07:44:04.444] <TB2> INFO: ROC errors: 0
[07:44:04.444] <TB2> INFO: missing ROC header(s): 0
[07:44:04.444] <TB2> INFO: misplaced readback start: 0
[07:44:04.444] <TB2> INFO: Pixel decoding errors: 0
[07:44:04.444] <TB2> INFO: pixel data incomplete: 0
[07:44:04.444] <TB2> INFO: pixel address: 0
[07:44:04.444] <TB2> INFO: pulse height fill bit: 0
[07:44:04.444] <TB2> INFO: buffer corruption: 0
[07:44:04.614] <TB2> INFO: ######################################################################
[07:44:04.614] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[07:44:04.614] <TB2> INFO: ######################################################################
[07:44:04.624] <TB2> INFO: scanning low vcal = 10
[07:44:04.885] <TB2> INFO: Expecting 41600 events.
[07:44:08.454] <TB2> INFO: 41600 events read in total (3013ms).
[07:44:08.454] <TB2> INFO: Test took 3830ms.
[07:44:08.456] <TB2> INFO: scanning low vcal = 20
[07:44:08.759] <TB2> INFO: Expecting 41600 events.
[07:44:12.308] <TB2> INFO: 41600 events read in total (2992ms).
[07:44:12.309] <TB2> INFO: Test took 3853ms.
[07:44:12.311] <TB2> INFO: scanning low vcal = 30
[07:44:12.614] <TB2> INFO: Expecting 41600 events.
[07:44:16.162] <TB2> INFO: 41600 events read in total (2992ms).
[07:44:16.162] <TB2> INFO: Test took 3851ms.
[07:44:16.164] <TB2> INFO: scanning low vcal = 40
[07:44:16.462] <TB2> INFO: Expecting 41600 events.
[07:44:20.584] <TB2> INFO: 41600 events read in total (3566ms).
[07:44:20.585] <TB2> INFO: Test took 4421ms.
[07:44:20.588] <TB2> INFO: scanning low vcal = 50
[07:44:20.847] <TB2> INFO: Expecting 41600 events.
[07:44:25.047] <TB2> INFO: 41600 events read in total (3644ms).
[07:44:25.048] <TB2> INFO: Test took 4460ms.
[07:44:25.050] <TB2> INFO: scanning low vcal = 60
[07:44:25.310] <TB2> INFO: Expecting 41600 events.
[07:44:29.500] <TB2> INFO: 41600 events read in total (3634ms).
[07:44:29.501] <TB2> INFO: Test took 4451ms.
[07:44:29.503] <TB2> INFO: scanning low vcal = 70
[07:44:29.765] <TB2> INFO: Expecting 41600 events.
[07:44:33.965] <TB2> INFO: 41600 events read in total (3644ms).
[07:44:33.966] <TB2> INFO: Test took 4463ms.
[07:44:33.969] <TB2> INFO: scanning low vcal = 80
[07:44:34.226] <TB2> INFO: Expecting 41600 events.
[07:44:38.419] <TB2> INFO: 41600 events read in total (3637ms).
[07:44:38.420] <TB2> INFO: Test took 4451ms.
[07:44:38.422] <TB2> INFO: scanning low vcal = 90
[07:44:38.688] <TB2> INFO: Expecting 41600 events.
[07:44:42.868] <TB2> INFO: 41600 events read in total (3624ms).
[07:44:42.869] <TB2> INFO: Test took 4447ms.
[07:44:42.872] <TB2> INFO: scanning low vcal = 100
[07:44:43.137] <TB2> INFO: Expecting 41600 events.
[07:44:47.347] <TB2> INFO: 41600 events read in total (3653ms).
[07:44:47.348] <TB2> INFO: Test took 4476ms.
[07:44:47.351] <TB2> INFO: scanning low vcal = 110
[07:44:47.613] <TB2> INFO: Expecting 41600 events.
[07:44:51.813] <TB2> INFO: 41600 events read in total (3644ms).
[07:44:51.814] <TB2> INFO: Test took 4463ms.
[07:44:51.816] <TB2> INFO: scanning low vcal = 120
[07:44:52.103] <TB2> INFO: Expecting 41600 events.
[07:44:56.368] <TB2> INFO: 41600 events read in total (3708ms).
[07:44:56.368] <TB2> INFO: Test took 4552ms.
[07:44:56.371] <TB2> INFO: scanning low vcal = 130
[07:44:56.649] <TB2> INFO: Expecting 41600 events.
[07:45:00.874] <TB2> INFO: 41600 events read in total (3668ms).
[07:45:00.875] <TB2> INFO: Test took 4504ms.
[07:45:00.877] <TB2> INFO: scanning low vcal = 140
[07:45:01.139] <TB2> INFO: Expecting 41600 events.
[07:45:05.358] <TB2> INFO: 41600 events read in total (3663ms).
[07:45:05.358] <TB2> INFO: Test took 4480ms.
[07:45:05.361] <TB2> INFO: scanning low vcal = 150
[07:45:05.628] <TB2> INFO: Expecting 41600 events.
[07:45:09.816] <TB2> INFO: 41600 events read in total (3631ms).
[07:45:09.817] <TB2> INFO: Test took 4456ms.
[07:45:09.820] <TB2> INFO: scanning low vcal = 160
[07:45:10.083] <TB2> INFO: Expecting 41600 events.
[07:45:14.292] <TB2> INFO: 41600 events read in total (3652ms).
[07:45:14.292] <TB2> INFO: Test took 4472ms.
[07:45:14.295] <TB2> INFO: scanning low vcal = 170
[07:45:14.583] <TB2> INFO: Expecting 41600 events.
[07:45:18.813] <TB2> INFO: 41600 events read in total (3673ms).
[07:45:18.813] <TB2> INFO: Test took 4518ms.
[07:45:18.817] <TB2> INFO: scanning low vcal = 180
[07:45:19.084] <TB2> INFO: Expecting 41600 events.
[07:45:23.279] <TB2> INFO: 41600 events read in total (3639ms).
[07:45:23.279] <TB2> INFO: Test took 4462ms.
[07:45:23.282] <TB2> INFO: scanning low vcal = 190
[07:45:23.539] <TB2> INFO: Expecting 41600 events.
[07:45:27.748] <TB2> INFO: 41600 events read in total (3653ms).
[07:45:27.748] <TB2> INFO: Test took 4466ms.
[07:45:27.752] <TB2> INFO: scanning low vcal = 200
[07:45:28.021] <TB2> INFO: Expecting 41600 events.
[07:45:32.280] <TB2> INFO: 41600 events read in total (3703ms).
[07:45:32.281] <TB2> INFO: Test took 4529ms.
[07:45:32.284] <TB2> INFO: scanning low vcal = 210
[07:45:32.557] <TB2> INFO: Expecting 41600 events.
[07:45:36.779] <TB2> INFO: 41600 events read in total (3666ms).
[07:45:36.779] <TB2> INFO: Test took 4496ms.
[07:45:36.782] <TB2> INFO: scanning low vcal = 220
[07:45:37.055] <TB2> INFO: Expecting 41600 events.
[07:45:41.287] <TB2> INFO: 41600 events read in total (3676ms).
[07:45:41.287] <TB2> INFO: Test took 4505ms.
[07:45:41.290] <TB2> INFO: scanning low vcal = 230
[07:45:41.555] <TB2> INFO: Expecting 41600 events.
[07:45:45.775] <TB2> INFO: 41600 events read in total (3663ms).
[07:45:45.776] <TB2> INFO: Test took 4485ms.
[07:45:45.779] <TB2> INFO: scanning low vcal = 240
[07:45:46.049] <TB2> INFO: Expecting 41600 events.
[07:45:50.249] <TB2> INFO: 41600 events read in total (3644ms).
[07:45:50.250] <TB2> INFO: Test took 4471ms.
[07:45:50.252] <TB2> INFO: scanning low vcal = 250
[07:45:50.516] <TB2> INFO: Expecting 41600 events.
[07:45:54.729] <TB2> INFO: 41600 events read in total (3657ms).
[07:45:54.730] <TB2> INFO: Test took 4477ms.
[07:45:54.734] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[07:45:55.034] <TB2> INFO: Expecting 41600 events.
[07:45:59.249] <TB2> INFO: 41600 events read in total (3659ms).
[07:45:59.250] <TB2> INFO: Test took 4516ms.
[07:45:59.253] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[07:45:59.515] <TB2> INFO: Expecting 41600 events.
[07:46:03.759] <TB2> INFO: 41600 events read in total (3688ms).
[07:46:03.760] <TB2> INFO: Test took 4507ms.
[07:46:03.763] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[07:46:04.031] <TB2> INFO: Expecting 41600 events.
[07:46:08.254] <TB2> INFO: 41600 events read in total (3667ms).
[07:46:08.255] <TB2> INFO: Test took 4492ms.
[07:46:08.258] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[07:46:08.551] <TB2> INFO: Expecting 41600 events.
[07:46:12.771] <TB2> INFO: 41600 events read in total (3664ms).
[07:46:12.771] <TB2> INFO: Test took 4513ms.
[07:46:12.774] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[07:46:13.038] <TB2> INFO: Expecting 41600 events.
[07:46:17.285] <TB2> INFO: 41600 events read in total (3691ms).
[07:46:17.287] <TB2> INFO: Test took 4512ms.
[07:46:17.787] <TB2> INFO: PixTestGainPedestal::measure() done
[07:46:50.550] <TB2> INFO: PixTestGainPedestal::fit() done
[07:46:50.550] <TB2> INFO: non-linearity mean: 0.957 0.958 0.951 0.956 0.955 0.957 0.953 0.961 0.955 0.962 0.954 0.953 0.953 0.953 0.956 0.957
[07:46:50.550] <TB2> INFO: non-linearity RMS: 0.005 0.006 0.007 0.006 0.006 0.006 0.006 0.005 0.006 0.005 0.006 0.005 0.006 0.006 0.006 0.005
[07:46:50.550] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[07:46:50.569] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[07:46:50.588] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[07:46:50.606] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[07:46:50.625] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[07:46:50.643] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[07:46:50.662] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[07:46:50.681] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[07:46:50.700] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[07:46:50.718] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[07:46:50.737] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[07:46:50.756] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[07:46:50.775] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[07:46:50.794] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[07:46:50.812] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[07:46:50.831] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[07:46:50.850] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 166 seconds
[07:46:50.850] <TB2> INFO: Decoding statistics:
[07:46:50.850] <TB2> INFO: General information:
[07:46:50.850] <TB2> INFO: 16bit words read: 2662400
[07:46:50.850] <TB2> INFO: valid events total: 166400
[07:46:50.850] <TB2> INFO: empty events: 0
[07:46:50.850] <TB2> INFO: valid events with pixels: 166400
[07:46:50.850] <TB2> INFO: valid pixel hits: 665565
[07:46:50.850] <TB2> INFO: Event errors: 0
[07:46:50.850] <TB2> INFO: start marker: 0
[07:46:50.850] <TB2> INFO: stop marker: 0
[07:46:50.850] <TB2> INFO: overflow: 0
[07:46:50.850] <TB2> INFO: invalid 5bit words: 0
[07:46:50.850] <TB2> INFO: invalid XOR eye diagram: 0
[07:46:50.850] <TB2> INFO: frame (failed synchr.): 0
[07:46:50.850] <TB2> INFO: idle data (no TBM trl): 0
[07:46:50.850] <TB2> INFO: no data (only TBM hdr): 0
[07:46:50.850] <TB2> INFO: TBM errors: 0
[07:46:50.850] <TB2> INFO: flawed TBM headers: 0
[07:46:50.850] <TB2> INFO: flawed TBM trailers: 0
[07:46:50.850] <TB2> INFO: event ID mismatches: 0
[07:46:50.850] <TB2> INFO: ROC errors: 0
[07:46:50.850] <TB2> INFO: missing ROC header(s): 0
[07:46:50.850] <TB2> INFO: misplaced readback start: 0
[07:46:50.850] <TB2> INFO: Pixel decoding errors: 0
[07:46:50.850] <TB2> INFO: pixel data incomplete: 0
[07:46:50.850] <TB2> INFO: pixel address: 0
[07:46:50.850] <TB2> INFO: pulse height fill bit: 0
[07:46:50.850] <TB2> INFO: buffer corruption: 0
[07:46:50.857] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C15.dat
[07:46:50.858] <TB2> INFO: ######################################################################
[07:46:50.858] <TB2> INFO: PixTestReadback::doTest()
[07:46:50.858] <TB2> INFO: ######################################################################
[07:46:50.858] <TB2> INFO: ----------------------------------------------------------------------
[07:46:50.858] <TB2> INFO: PixTestReadback::CalibrateVd()
[07:46:50.858] <TB2> INFO: ----------------------------------------------------------------------
[07:47:00.324] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C0.dat
[07:47:00.324] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C1.dat
[07:47:00.324] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C2.dat
[07:47:00.324] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C3.dat
[07:47:00.324] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C4.dat
[07:47:00.324] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C5.dat
[07:47:00.324] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C6.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C7.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C8.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C9.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C10.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C11.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C12.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C13.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C14.dat
[07:47:00.325] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C15.dat
[07:47:00.356] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[07:47:00.356] <TB2> INFO: ----------------------------------------------------------------------
[07:47:00.356] <TB2> INFO: PixTestReadback::CalibrateVa()
[07:47:00.356] <TB2> INFO: ----------------------------------------------------------------------
[07:47:09.835] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C0.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C1.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C2.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C3.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C4.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C5.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C6.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C7.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C8.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C9.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C10.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C11.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C12.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C13.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C14.dat
[07:47:09.836] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C15.dat
[07:47:09.867] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[07:47:09.867] <TB2> INFO: ----------------------------------------------------------------------
[07:47:09.867] <TB2> INFO: PixTestReadback::readbackVbg()
[07:47:09.867] <TB2> INFO: ----------------------------------------------------------------------
[07:47:17.152] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[07:47:17.152] <TB2> INFO: ----------------------------------------------------------------------
[07:47:17.152] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[07:47:17.152] <TB2> INFO: ----------------------------------------------------------------------
[07:47:17.152] <TB2> INFO: Vbg will be calibrated using Vd calibration
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 153calibrated Vbg = 1.1888 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 149calibrated Vbg = 1.18749 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 153.3calibrated Vbg = 1.19162 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 155.6calibrated Vbg = 1.2011 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 155.4calibrated Vbg = 1.19859 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 156.5calibrated Vbg = 1.19756 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 144.9calibrated Vbg = 1.20616 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 158.9calibrated Vbg = 1.20348 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 158.4calibrated Vbg = 1.20243 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 152.6calibrated Vbg = 1.20397 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 147.7calibrated Vbg = 1.19812 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152.4calibrated Vbg = 1.19975 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 164.1calibrated Vbg = 1.1959 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 157.1calibrated Vbg = 1.19726 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 158calibrated Vbg = 1.20088 :::*/*/*/*/
[07:47:17.152] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 149.2calibrated Vbg = 1.20017 :::*/*/*/*/
[07:47:17.154] <TB2> INFO: ----------------------------------------------------------------------
[07:47:17.154] <TB2> INFO: PixTestReadback::CalibrateIa()
[07:47:17.154] <TB2> INFO: ----------------------------------------------------------------------
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C0.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C1.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C2.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C3.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C4.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C5.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C6.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C7.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C8.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C9.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C10.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C11.dat
[07:49:52.578] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C12.dat
[07:49:52.579] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C13.dat
[07:49:52.579] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C14.dat
[07:49:52.579] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2259_FullQualification_2016-06-15_08h06m_1465970760//000_FulltestPxar_m20//readbackCal_C15.dat
[07:49:52.602] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[07:49:52.604] <TB2> INFO: PixTestReadback::doTest() done
[07:49:52.604] <TB2> INFO: Decoding statistics:
[07:49:52.604] <TB2> INFO: General information:
[07:49:52.604] <TB2> INFO: 16bit words read: 1024
[07:49:52.604] <TB2> INFO: valid events total: 128
[07:49:52.604] <TB2> INFO: empty events: 128
[07:49:52.604] <TB2> INFO: valid events with pixels: 0
[07:49:52.604] <TB2> INFO: valid pixel hits: 0
[07:49:52.604] <TB2> INFO: Event errors: 0
[07:49:52.604] <TB2> INFO: start marker: 0
[07:49:52.604] <TB2> INFO: stop marker: 0
[07:49:52.604] <TB2> INFO: overflow: 0
[07:49:52.604] <TB2> INFO: invalid 5bit words: 0
[07:49:52.604] <TB2> INFO: invalid XOR eye diagram: 0
[07:49:52.604] <TB2> INFO: frame (failed synchr.): 0
[07:49:52.604] <TB2> INFO: idle data (no TBM trl): 0
[07:49:52.604] <TB2> INFO: no data (only TBM hdr): 0
[07:49:52.604] <TB2> INFO: TBM errors: 0
[07:49:52.604] <TB2> INFO: flawed TBM headers: 0
[07:49:52.604] <TB2> INFO: flawed TBM trailers: 0
[07:49:52.604] <TB2> INFO: event ID mismatches: 0
[07:49:52.604] <TB2> INFO: ROC errors: 0
[07:49:52.604] <TB2> INFO: missing ROC header(s): 0
[07:49:52.604] <TB2> INFO: misplaced readback start: 0
[07:49:52.604] <TB2> INFO: Pixel decoding errors: 0
[07:49:52.604] <TB2> INFO: pixel data incomplete: 0
[07:49:52.604] <TB2> INFO: pixel address: 0
[07:49:52.604] <TB2> INFO: pulse height fill bit: 0
[07:49:52.604] <TB2> INFO: buffer corruption: 0
[07:49:52.625] <TB2> INFO: Decoding statistics:
[07:49:52.625] <TB2> INFO: General information:
[07:49:52.625] <TB2> INFO: 16bit words read: 2755352
[07:49:52.625] <TB2> INFO: valid events total: 176768
[07:49:52.625] <TB2> INFO: empty events: 7866
[07:49:52.625] <TB2> INFO: valid events with pixels: 168902
[07:49:52.625] <TB2> INFO: valid pixel hits: 668067
[07:49:52.625] <TB2> INFO: Event errors: 0
[07:49:52.625] <TB2> INFO: start marker: 0
[07:49:52.625] <TB2> INFO: stop marker: 0
[07:49:52.625] <TB2> INFO: overflow: 0
[07:49:52.625] <TB2> INFO: invalid 5bit words: 0
[07:49:52.625] <TB2> INFO: invalid XOR eye diagram: 0
[07:49:52.625] <TB2> INFO: frame (failed synchr.): 0
[07:49:52.625] <TB2> INFO: idle data (no TBM trl): 0
[07:49:52.625] <TB2> INFO: no data (only TBM hdr): 0
[07:49:52.625] <TB2> INFO: TBM errors: 0
[07:49:52.625] <TB2> INFO: flawed TBM headers: 0
[07:49:52.625] <TB2> INFO: flawed TBM trailers: 0
[07:49:52.625] <TB2> INFO: event ID mismatches: 0
[07:49:52.625] <TB2> INFO: ROC errors: 0
[07:49:52.625] <TB2> INFO: missing ROC header(s): 0
[07:49:52.625] <TB2> INFO: misplaced readback start: 0
[07:49:52.625] <TB2> INFO: Pixel decoding errors: 0
[07:49:52.625] <TB2> INFO: pixel data incomplete: 0
[07:49:52.625] <TB2> INFO: pixel address: 0
[07:49:52.625] <TB2> INFO: pulse height fill bit: 0
[07:49:52.625] <TB2> INFO: buffer corruption: 0
[07:49:52.625] <TB2> INFO: enter test to run
[07:49:52.625] <TB2> INFO: test: exit no parameter change
[07:49:52.769] <TB2> QUIET: Connection to board 156 closed.
[07:49:52.848] <TB2> INFO: pXar: this is the end, my friend