[08:14:47.856] <TB0> INFO: *** Welcome to pxar ***
[08:14:47.856] <TB0> INFO: *** Today: 2016/07/18
[08:14:50.928] <TB0> INFO: *** Version: 9751-dirty
[08:14:50.928] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C15.dat
[08:14:50.929] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//tbmParameters_C0b.dat
[08:14:50.929] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//defaultMaskFile.dat
[08:14:50.929] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters_C15.dat
[08:14:50.999] <TB0> INFO: clk: 4
[08:14:50.999] <TB0> INFO: ctr: 4
[08:14:50.999] <TB0> INFO: sda: 19
[08:14:50.999] <TB0> INFO: tin: 9
[08:14:50.999] <TB0> INFO: level: 15
[08:14:50.999] <TB0> INFO: triggerdelay: 0
[08:14:50.999] <TB0> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[08:14:50.999] <TB0> INFO: Log level: INFO
[08:14:51.029] <TB0> INFO: Found DTB DTB_WS6AYH
[08:14:51.049] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[08:14:51.050] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[08:14:51.052] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[08:14:52.581] <TB0> INFO: DUT info:
[08:14:52.581] <TB0> INFO: The DUT currently contains the following objects:
[08:14:52.581] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[08:14:52.581] <TB0> INFO: TBM Core alpha (0): 7 registers set
[08:14:52.581] <TB0> INFO: TBM Core beta (1): 7 registers set
[08:14:52.581] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:14:52.581] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.581] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:14:52.981] <TB0> INFO: enter 'restricted' command line mode
[08:14:52.981] <TB0> INFO: enter test to run
[08:14:52.982] <TB0> INFO: test: pretest no parameter change
[08:14:52.982] <TB0> INFO: running: pretest
[08:14:52.986] <TB0> INFO: ----------------------------------------------------------------------
[08:14:52.986] <TB0> INFO: PixTestPretest::programROC()
[08:14:52.986] <TB0> INFO: ----------------------------------------------------------------------
[08:15:11.001] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[08:15:11.001] <TB0> INFO: IA differences per ROC: 18.5 18.5 19.3 18.5 19.3 16.9 16.9 19.3 20.1 20.1 17.7 17.7 19.3 19.3 19.3 19.3
[08:15:11.239] <TB0> INFO: enter test to run
[08:15:11.239] <TB0> INFO: test: pretest no parameter change
[08:15:11.239] <TB0> INFO: running: pretest
[08:15:11.240] <TB0> INFO: ----------------------------------------------------------------------
[08:15:11.240] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[08:15:11.240] <TB0> INFO: ----------------------------------------------------------------------
[08:15:32.514] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 377.8 mA = 23.6125 mA/ROC
[08:15:32.514] <TB0> INFO: i(loss) [mA/ROC]: 20.1 20.1 20.1 19.3 19.3 19.3 19.3 18.5 19.3 18.5 19.3 19.3 18.5 20.1 18.5 18.5
[08:15:32.546] <TB0> INFO: enter test to run
[08:15:32.546] <TB0> INFO: test: pretest no parameter change
[08:15:32.546] <TB0> INFO: running: pretest
[08:15:32.546] <TB0> INFO: ----------------------------------------------------------------------
[08:15:32.546] <TB0> INFO: PixTestPretest::findTiming()
[08:15:32.546] <TB0> INFO: ----------------------------------------------------------------------
[08:15:32.546] <TB0> INFO: PixTestCmd::init()
[08:15:33.490] <TB0> WARNING: Not unmasking DUT, not setting Calibrate bits!
[08:17:01.646] <TB0> INFO: TBM phases: 160MHz: 3, 400MHz: 2, TBM delays: ROC(0/1):2, header/trailer: 1, token: 0
[08:17:01.646] <TB0> INFO: (success/tries = 100/100), width = 2
[08:17:01.647] <TB0> INFO: enter test to run
[08:17:01.647] <TB0> INFO: test: pretest no parameter change
[08:17:01.647] <TB0> INFO: running: pretest
[08:17:01.648] <TB0> INFO: ----------------------------------------------------------------------
[08:17:01.648] <TB0> INFO: PixTestPretest::findWorkingPixel()
[08:17:01.648] <TB0> INFO: ----------------------------------------------------------------------
[08:17:01.738] <TB0> INFO: Expecting 231680 events.
[08:17:07.515] <TB0> ERROR: <datapipe.cc/CheckEventValidity:L497> Channel 0 Number of ROCs (1) != Token Chain Length (4)
[08:17:07.596] <TB0> ERROR: <datapipe.cc/CheckEventID:L459> Channel 0 Event ID mismatch: local ID (21) != TBM ID (2)
[08:17:11.843] <TB0> INFO: 231680 events read in total (9548ms).
[08:17:11.847] <TB0> INFO: Test took 10196ms.
[08:17:12.073] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[08:17:12.134] <TB0> INFO: enter test to run
[08:17:12.134] <TB0> INFO: test: pretest no parameter change
[08:17:12.134] <TB0> INFO: running: pretest
[08:17:12.135] <TB0> INFO: ----------------------------------------------------------------------
[08:17:12.135] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[08:17:12.135] <TB0> INFO: ----------------------------------------------------------------------
[08:17:12.227] <TB0> INFO: Expecting 231680 events.
[08:17:22.430] <TB0> INFO: 231680 events read in total (9648ms).
[08:17:22.435] <TB0> INFO: Test took 10296ms.
[08:17:22.673] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[08:17:22.673] <TB0> INFO: CalDel: 151 131 146 109 122 113 142 130 142 118 108 106 124 170 115 130
[08:17:22.673] <TB0> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 53 51 51
[08:17:22.707] <TB0> INFO: enter test to run
[08:17:22.707] <TB0> INFO: test: pretest no parameter change
[08:17:22.707] <TB0> INFO: running: pretest
[08:17:22.707] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C0.dat
[08:17:22.708] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C1.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C2.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C3.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C4.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C5.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C6.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C7.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C8.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C9.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C10.dat
[08:17:22.709] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C11.dat
[08:17:22.710] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C12.dat
[08:17:22.710] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C13.dat
[08:17:22.710] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C14.dat
[08:17:22.710] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters_C15.dat
[08:17:22.710] <TB0> INFO: enter test to run
[08:17:22.710] <TB0> INFO: test: fulltest no parameter change
[08:17:22.710] <TB0> INFO: running: fulltest
[08:17:22.710] <TB0> INFO: ######################################################################
[08:17:22.710] <TB0> INFO: PixTestFullTest::doTest()
[08:17:22.710] <TB0> INFO: ######################################################################
[08:17:22.711] <TB0> INFO: ######################################################################
[08:17:22.711] <TB0> INFO: PixTestAlive::doTest()
[08:17:22.711] <TB0> INFO: ######################################################################
[08:17:22.712] <TB0> INFO: ----------------------------------------------------------------------
[08:17:22.712] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:17:22.712] <TB0> INFO: ----------------------------------------------------------------------
[08:17:22.976] <TB0> INFO: Expecting 41600 events.
[08:17:26.804] <TB0> INFO: 41600 events read in total (3272ms).
[08:17:26.805] <TB0> INFO: Test took 4091ms.
[08:17:27.027] <TB0> INFO: PixTestAlive::aliveTest() done
[08:17:27.027] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:17:27.028] <TB0> INFO: ----------------------------------------------------------------------
[08:17:27.028] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:17:27.028] <TB0> INFO: ----------------------------------------------------------------------
[08:17:27.294] <TB0> INFO: Expecting 41600 events.
[08:17:30.394] <TB0> INFO: 41600 events read in total (2544ms).
[08:17:30.394] <TB0> INFO: Test took 3365ms.
[08:17:30.395] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:17:30.640] <TB0> INFO: PixTestAlive::maskTest() done
[08:17:30.640] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:17:30.641] <TB0> INFO: ----------------------------------------------------------------------
[08:17:30.641] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:17:30.641] <TB0> INFO: ----------------------------------------------------------------------
[08:17:30.969] <TB0> INFO: Expecting 41600 events.
[08:17:34.756] <TB0> INFO: 41600 events read in total (3231ms).
[08:17:34.757] <TB0> INFO: Test took 4114ms.
[08:17:34.978] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[08:17:34.978] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:17:34.978] <TB0> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[08:17:34.978] <TB0> INFO: Decoding statistics:
[08:17:34.978] <TB0> INFO: General information:
[08:17:34.978] <TB0> INFO: 16bit words read: 0
[08:17:34.978] <TB0> INFO: valid events total: 0
[08:17:34.978] <TB0> INFO: empty events: 0
[08:17:34.978] <TB0> INFO: valid events with pixels: 0
[08:17:34.978] <TB0> INFO: valid pixel hits: 0
[08:17:34.978] <TB0> INFO: Event errors: 0
[08:17:34.978] <TB0> INFO: start marker: 0
[08:17:34.978] <TB0> INFO: stop marker: 0
[08:17:34.978] <TB0> INFO: overflow: 0
[08:17:34.978] <TB0> INFO: invalid 5bit words: 0
[08:17:34.978] <TB0> INFO: invalid XOR eye diagram: 0
[08:17:34.978] <TB0> INFO: frame (failed synchr.): 0
[08:17:34.978] <TB0> INFO: idle data (no TBM trl): 0
[08:17:34.978] <TB0> INFO: no data (only TBM hdr): 0
[08:17:34.978] <TB0> INFO: TBM errors: 0
[08:17:34.978] <TB0> INFO: flawed TBM headers: 0
[08:17:34.978] <TB0> INFO: flawed TBM trailers: 0
[08:17:34.978] <TB0> INFO: event ID mismatches: 0
[08:17:34.978] <TB0> INFO: ROC errors: 0
[08:17:34.978] <TB0> INFO: missing ROC header(s): 0
[08:17:34.978] <TB0> INFO: misplaced readback start: 0
[08:17:34.978] <TB0> INFO: Pixel decoding errors: 0
[08:17:34.978] <TB0> INFO: pixel data incomplete: 0
[08:17:34.978] <TB0> INFO: pixel address: 0
[08:17:34.978] <TB0> INFO: pulse height fill bit: 0
[08:17:34.978] <TB0> INFO: buffer corruption: 0
[08:17:34.988] <TB0> INFO: ######################################################################
[08:17:34.988] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[08:17:34.988] <TB0> INFO: ######################################################################
[08:17:34.990] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[08:17:35.002] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[08:17:35.002] <TB0> INFO: run 1 of 1
[08:17:35.293] <TB0> INFO: Expecting 3120000 events.
[08:18:17.021] <TB0> INFO: 886075 events read in total (41171ms).
[08:18:57.630] <TB0> INFO: 1747195 events read in total (81780ms).
[08:19:38.326] <TB0> INFO: 2610600 events read in total (122477ms).
[08:20:02.269] <TB0> INFO: 3120000 events read in total (146419ms).
[08:20:02.324] <TB0> INFO: Test took 147322ms.
[08:20:26.164] <TB0> INFO: PixTestBBMap::doTest() done, duration: 171 seconds
[08:20:26.164] <TB0> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:20:26.164] <TB0> INFO: separation cut (per ROC): 120 111 113 110 99 112 104 90 106 98 103 114 102 118 112 111
[08:20:26.164] <TB0> INFO: Decoding statistics:
[08:20:26.164] <TB0> INFO: General information:
[08:20:26.164] <TB0> INFO: 16bit words read: 0
[08:20:26.164] <TB0> INFO: valid events total: 0
[08:20:26.164] <TB0> INFO: empty events: 0
[08:20:26.165] <TB0> INFO: valid events with pixels: 0
[08:20:26.165] <TB0> INFO: valid pixel hits: 0
[08:20:26.165] <TB0> INFO: Event errors: 0
[08:20:26.165] <TB0> INFO: start marker: 0
[08:20:26.165] <TB0> INFO: stop marker: 0
[08:20:26.165] <TB0> INFO: overflow: 0
[08:20:26.165] <TB0> INFO: invalid 5bit words: 0
[08:20:26.165] <TB0> INFO: invalid XOR eye diagram: 0
[08:20:26.165] <TB0> INFO: frame (failed synchr.): 0
[08:20:26.165] <TB0> INFO: idle data (no TBM trl): 0
[08:20:26.165] <TB0> INFO: no data (only TBM hdr): 0
[08:20:26.165] <TB0> INFO: TBM errors: 0
[08:20:26.165] <TB0> INFO: flawed TBM headers: 0
[08:20:26.165] <TB0> INFO: flawed TBM trailers: 0
[08:20:26.165] <TB0> INFO: event ID mismatches: 0
[08:20:26.165] <TB0> INFO: ROC errors: 0
[08:20:26.165] <TB0> INFO: missing ROC header(s): 0
[08:20:26.165] <TB0> INFO: misplaced readback start: 0
[08:20:26.165] <TB0> INFO: Pixel decoding errors: 0
[08:20:26.165] <TB0> INFO: pixel data incomplete: 0
[08:20:26.165] <TB0> INFO: pixel address: 0
[08:20:26.165] <TB0> INFO: pulse height fill bit: 0
[08:20:26.165] <TB0> INFO: buffer corruption: 0
[08:20:26.262] <TB0> INFO: ######################################################################
[08:20:26.262] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[08:20:26.262] <TB0> INFO: ######################################################################
[08:20:26.262] <TB0> INFO: ----------------------------------------------------------------------
[08:20:26.262] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[08:20:26.262] <TB0> INFO: ----------------------------------------------------------------------
[08:20:26.263] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[08:20:26.271] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[08:20:26.271] <TB0> INFO: run 1 of 1
[08:20:26.546] <TB0> INFO: Expecting 26208000 events.
[08:21:00.612] <TB0> INFO: 899450 events read in total (33509ms).
[08:21:33.776] <TB0> INFO: 1782450 events read in total (66673ms).
[08:22:07.026] <TB0> INFO: 2666350 events read in total (99923ms).
[08:22:40.180] <TB0> INFO: 3550150 events read in total (133077ms).
[08:23:13.675] <TB0> INFO: 4433800 events read in total (166572ms).
[08:23:47.258] <TB0> INFO: 5315100 events read in total (200155ms).
[08:24:20.834] <TB0> INFO: 6198450 events read in total (233731ms).
[08:24:54.519] <TB0> INFO: 7079650 events read in total (267416ms).
[08:25:28.103] <TB0> INFO: 7962350 events read in total (301000ms).
[08:26:01.341] <TB0> INFO: 8844800 events read in total (334238ms).
[08:26:34.990] <TB0> INFO: 9729400 events read in total (367887ms).
[08:27:08.435] <TB0> INFO: 10611050 events read in total (401332ms).
[08:27:42.162] <TB0> INFO: 11490950 events read in total (435059ms).
[08:28:15.591] <TB0> INFO: 12373950 events read in total (468488ms).
[08:28:49.429] <TB0> INFO: 13253750 events read in total (502326ms).
[08:29:22.556] <TB0> INFO: 14127250 events read in total (535453ms).
[08:29:55.854] <TB0> INFO: 14997700 events read in total (568751ms).
[08:30:29.079] <TB0> INFO: 15869000 events read in total (601976ms).
[08:31:02.484] <TB0> INFO: 16740250 events read in total (635381ms).
[08:31:35.967] <TB0> INFO: 17610450 events read in total (668864ms).
[08:32:09.242] <TB0> INFO: 18481950 events read in total (702139ms).
[08:32:42.588] <TB0> INFO: 19352150 events read in total (735485ms).
[08:33:15.451] <TB0> INFO: 20222100 events read in total (768348ms).
[08:33:48.974] <TB0> INFO: 21092900 events read in total (801871ms).
[08:34:22.365] <TB0> INFO: 21966200 events read in total (835262ms).
[08:34:55.643] <TB0> INFO: 22839000 events read in total (868540ms).
[08:35:28.761] <TB0> INFO: 23713450 events read in total (901658ms).
[08:36:01.836] <TB0> INFO: 24590550 events read in total (934733ms).
[08:36:35.545] <TB0> INFO: 25469300 events read in total (968442ms).
[08:37:03.092] <TB0> INFO: 26208000 events read in total (995989ms).
[08:37:03.127] <TB0> INFO: Test took 996856ms.
[08:37:03.371] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:04.837] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:06.400] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:07.891] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:09.411] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:10.984] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:12.387] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:13.789] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:15.214] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:16.790] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:18.522] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:20.170] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:21.697] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:23.306] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:24.750] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:26.377] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[08:37:27.874] <TB0> INFO: PixTestScurves::scurves() done
[08:37:27.874] <TB0> INFO: Vcal mean: 95.49 92.13 94.52 87.01 91.40 100.93 89.72 85.01 89.72 80.57 80.01 93.57 85.97 102.00 92.33 89.90
[08:37:27.874] <TB0> INFO: Vcal RMS: 5.46 5.46 5.64 5.26 5.05 5.36 5.03 4.63 4.72 3.88 4.10 5.46 5.17 5.59 5.44 5.27
[08:37:27.874] <TB0> INFO: PixTestScurves::fullTest() done, duration: 1021 seconds
[08:37:27.874] <TB0> INFO: Decoding statistics:
[08:37:27.874] <TB0> INFO: General information:
[08:37:27.874] <TB0> INFO: 16bit words read: 0
[08:37:27.874] <TB0> INFO: valid events total: 0
[08:37:27.874] <TB0> INFO: empty events: 0
[08:37:27.874] <TB0> INFO: valid events with pixels: 0
[08:37:27.874] <TB0> INFO: valid pixel hits: 0
[08:37:27.874] <TB0> INFO: Event errors: 0
[08:37:27.874] <TB0> INFO: start marker: 0
[08:37:27.874] <TB0> INFO: stop marker: 0
[08:37:27.874] <TB0> INFO: overflow: 0
[08:37:27.874] <TB0> INFO: invalid 5bit words: 0
[08:37:27.874] <TB0> INFO: invalid XOR eye diagram: 0
[08:37:27.874] <TB0> INFO: frame (failed synchr.): 0
[08:37:27.874] <TB0> INFO: idle data (no TBM trl): 0
[08:37:27.874] <TB0> INFO: no data (only TBM hdr): 0
[08:37:27.874] <TB0> INFO: TBM errors: 0
[08:37:27.874] <TB0> INFO: flawed TBM headers: 0
[08:37:27.874] <TB0> INFO: flawed TBM trailers: 0
[08:37:27.874] <TB0> INFO: event ID mismatches: 0
[08:37:27.874] <TB0> INFO: ROC errors: 0
[08:37:27.874] <TB0> INFO: missing ROC header(s): 0
[08:37:27.874] <TB0> INFO: misplaced readback start: 0
[08:37:27.874] <TB0> INFO: Pixel decoding errors: 0
[08:37:27.874] <TB0> INFO: pixel data incomplete: 0
[08:37:27.874] <TB0> INFO: pixel address: 0
[08:37:27.874] <TB0> INFO: pulse height fill bit: 0
[08:37:27.874] <TB0> INFO: buffer corruption: 0
[08:37:27.944] <TB0> INFO: ######################################################################
[08:37:27.944] <TB0> INFO: PixTestTrim::doTest()
[08:37:27.944] <TB0> INFO: ######################################################################
[08:37:27.945] <TB0> INFO: ----------------------------------------------------------------------
[08:37:27.945] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[08:37:27.945] <TB0> INFO: ----------------------------------------------------------------------
[08:37:28.023] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[08:37:28.023] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[08:37:28.031] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[08:37:28.031] <TB0> INFO: run 1 of 1
[08:37:28.319] <TB0> INFO: Expecting 6281600 events.
[08:38:08.126] <TB0> INFO: 1070220 events read in total (39251ms).
[08:38:46.975] <TB0> INFO: 2134980 events read in total (78100ms).
[08:39:26.170] <TB0> INFO: 3199360 events read in total (117295ms).
[08:40:05.615] <TB0> INFO: 4273300 events read in total (156740ms).
[08:40:45.436] <TB0> INFO: 5353110 events read in total (196561ms).
[08:41:19.002] <TB0> INFO: 6281600 events read in total (230127ms).
[08:41:19.036] <TB0> INFO: Test took 231005ms.
[08:41:38.944] <TB0> INFO: ROC 0 VthrComp = 99
[08:41:38.944] <TB0> INFO: ROC 1 VthrComp = 97
[08:41:38.944] <TB0> INFO: ROC 2 VthrComp = 99
[08:41:38.944] <TB0> INFO: ROC 3 VthrComp = 90
[08:41:38.945] <TB0> INFO: ROC 4 VthrComp = 93
[08:41:38.945] <TB0> INFO: ROC 5 VthrComp = 100
[08:41:38.945] <TB0> INFO: ROC 6 VthrComp = 91
[08:41:38.945] <TB0> INFO: ROC 7 VthrComp = 89
[08:41:38.945] <TB0> INFO: ROC 8 VthrComp = 97
[08:41:38.945] <TB0> INFO: ROC 9 VthrComp = 85
[08:41:38.945] <TB0> INFO: ROC 10 VthrComp = 85
[08:41:38.945] <TB0> INFO: ROC 11 VthrComp = 96
[08:41:38.945] <TB0> INFO: ROC 12 VthrComp = 87
[08:41:38.946] <TB0> INFO: ROC 13 VthrComp = 101
[08:41:38.946] <TB0> INFO: ROC 14 VthrComp = 91
[08:41:38.946] <TB0> INFO: ROC 15 VthrComp = 92
[08:41:38.946] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[08:41:38.946] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[08:41:38.954] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[08:41:38.955] <TB0> INFO: run 1 of 1
[08:41:39.223] <TB0> INFO: Expecting 6281600 events.
[08:42:14.875] <TB0> INFO: 752330 events read in total (35096ms).
[08:42:49.790] <TB0> INFO: 1503290 events read in total (70011ms).
[08:43:25.003] <TB0> INFO: 2255070 events read in total (105224ms).
[08:44:00.068] <TB0> INFO: 3007310 events read in total (140289ms).
[08:44:35.226] <TB0> INFO: 3755270 events read in total (175447ms).
[08:45:10.673] <TB0> INFO: 4500870 events read in total (210894ms).
[08:45:45.992] <TB0> INFO: 5245400 events read in total (246213ms).
[08:46:21.464] <TB0> INFO: 5990820 events read in total (281685ms).
[08:46:35.884] <TB0> INFO: 6281600 events read in total (296105ms).
[08:46:35.939] <TB0> INFO: Test took 296984ms.
[08:47:05.169] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 59.5574 for pixel 21/14 mean/min/max = 45.8346/32.1114/59.5578
[08:47:05.169] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 58.2747 for pixel 23/79 mean/min/max = 44.8545/31.4278/58.2812
[08:47:05.169] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 59.1925 for pixel 15/4 mean/min/max = 45.7414/32.0722/59.4106
[08:47:05.169] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 60.4476 for pixel 9/1 mean/min/max = 46.4175/32.3498/60.4853
[08:47:05.170] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 58.0317 for pixel 45/79 mean/min/max = 45.6232/33.0919/58.1545
[08:47:05.170] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 58.805 for pixel 11/2 mean/min/max = 45.248/31.5886/58.9074
[08:47:05.170] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 57.4604 for pixel 51/68 mean/min/max = 45.0298/32.5887/57.471
[08:47:05.170] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 56.5753 for pixel 19/33 mean/min/max = 44.8122/33.0277/56.5967
[08:47:05.171] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 56.5794 for pixel 15/0 mean/min/max = 44.2162/31.8323/56.6001
[08:47:05.171] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 55.8448 for pixel 17/12 mean/min/max = 44.6896/33.0934/56.2859
[08:47:05.171] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 55.7009 for pixel 2/28 mean/min/max = 43.8708/31.9229/55.8187
[08:47:05.171] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 58.8786 for pixel 0/53 mean/min/max = 45.0296/31.0344/59.0248
[08:47:05.172] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 57.7036 for pixel 9/64 mean/min/max = 44.8144/31.7602/57.8687
[08:47:05.172] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 60.1434 for pixel 48/8 mean/min/max = 45.9449/31.7174/60.1723
[08:47:05.172] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 61.3057 for pixel 0/21 mean/min/max = 46.5147/31.7133/61.3161
[08:47:05.172] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 58.3188 for pixel 51/10 mean/min/max = 45.4617/32.3627/58.5607
[08:47:05.173] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:47:05.261] <TB0> INFO: Expecting 514560 events.
[08:47:18.589] <TB0> INFO: 514560 events read in total (12770ms).
[08:47:18.596] <TB0> INFO: Expecting 514560 events.
[08:47:31.334] <TB0> INFO: 514560 events read in total (12336ms).
[08:47:31.341] <TB0> INFO: Expecting 514560 events.
[08:47:44.223] <TB0> INFO: 514560 events read in total (12468ms).
[08:47:44.233] <TB0> INFO: Expecting 514560 events.
[08:47:57.145] <TB0> INFO: 514560 events read in total (12503ms).
[08:47:57.158] <TB0> INFO: Expecting 514560 events.
[08:48:09.991] <TB0> INFO: 514560 events read in total (12426ms).
[08:48:10.005] <TB0> INFO: Expecting 514560 events.
[08:48:22.718] <TB0> INFO: 514560 events read in total (12311ms).
[08:48:22.733] <TB0> INFO: Expecting 514560 events.
[08:48:35.495] <TB0> INFO: 514560 events read in total (12350ms).
[08:48:35.512] <TB0> INFO: Expecting 514560 events.
[08:48:48.337] <TB0> INFO: 514560 events read in total (12419ms).
[08:48:48.358] <TB0> INFO: Expecting 514560 events.
[08:49:01.277] <TB0> INFO: 514560 events read in total (12517ms).
[08:49:01.298] <TB0> INFO: Expecting 514560 events.
[08:49:14.133] <TB0> INFO: 514560 events read in total (12434ms).
[08:49:14.157] <TB0> INFO: Expecting 514560 events.
[08:49:26.944] <TB0> INFO: 514560 events read in total (12385ms).
[08:49:26.968] <TB0> INFO: Expecting 514560 events.
[08:49:39.843] <TB0> INFO: 514560 events read in total (12474ms).
[08:49:39.870] <TB0> INFO: Expecting 514560 events.
[08:49:52.629] <TB0> INFO: 514560 events read in total (12358ms).
[08:49:52.656] <TB0> INFO: Expecting 514560 events.
[08:50:05.454] <TB0> INFO: 514560 events read in total (12396ms).
[08:50:05.483] <TB0> INFO: Expecting 514560 events.
[08:50:18.257] <TB0> INFO: 514560 events read in total (12372ms).
[08:50:18.288] <TB0> INFO: Expecting 514560 events.
[08:50:30.999] <TB0> INFO: 514560 events read in total (12309ms).
[08:50:31.036] <TB0> INFO: Test took 205863ms.
[08:50:31.999] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[08:50:32.009] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[08:50:32.009] <TB0> INFO: run 1 of 1
[08:50:32.278] <TB0> INFO: Expecting 6281600 events.
[08:51:08.068] <TB0> INFO: 738040 events read in total (35234ms).
[08:51:43.214] <TB0> INFO: 1475750 events read in total (70380ms).
[08:52:18.301] <TB0> INFO: 2214050 events read in total (105467ms).
[08:52:53.322] <TB0> INFO: 2953060 events read in total (140488ms).
[08:53:28.318] <TB0> INFO: 3687620 events read in total (175484ms).
[08:54:03.593] <TB0> INFO: 4419350 events read in total (210759ms).
[08:54:38.636] <TB0> INFO: 5149870 events read in total (245802ms).
[08:55:13.495] <TB0> INFO: 5880540 events read in total (280661ms).
[08:55:32.797] <TB0> INFO: 6281600 events read in total (299963ms).
[08:55:32.841] <TB0> INFO: Test took 300832ms.
[08:55:56.211] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.078666 .. 255.000000
[08:55:56.288] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[08:55:56.297] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[08:55:56.297] <TB0> INFO: run 1 of 1
[08:55:56.560] <TB0> INFO: Expecting 10649600 events.
[08:56:32.526] <TB0> INFO: 711650 events read in total (35406ms).
[08:57:07.435] <TB0> INFO: 1423810 events read in total (70315ms).
[08:57:41.940] <TB0> INFO: 2135880 events read in total (104820ms).
[08:58:16.837] <TB0> INFO: 2848280 events read in total (139717ms).
[08:58:51.267] <TB0> INFO: 3560680 events read in total (174147ms).
[08:59:26.286] <TB0> INFO: 4273260 events read in total (209166ms).
[09:00:01.122] <TB0> INFO: 4985930 events read in total (244002ms).
[09:00:35.876] <TB0> INFO: 5698170 events read in total (278756ms).
[09:01:10.218] <TB0> INFO: 6410030 events read in total (313098ms).
[09:01:45.179] <TB0> INFO: 7121270 events read in total (348059ms).
[09:02:19.777] <TB0> INFO: 7832630 events read in total (382657ms).
[09:02:54.420] <TB0> INFO: 8543470 events read in total (417300ms).
[09:03:29.479] <TB0> INFO: 9254240 events read in total (452359ms).
[09:04:04.283] <TB0> INFO: 9965540 events read in total (487163ms).
[09:04:37.516] <TB0> INFO: 10649600 events read in total (520396ms).
[09:04:37.606] <TB0> INFO: Test took 521310ms.
[09:05:08.041] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 15.447947 .. 45.437557
[09:05:08.145] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 5 .. 55 (-1/-1) hits flags = 528 (plus default)
[09:05:08.154] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[09:05:08.154] <TB0> INFO: run 1 of 1
[09:05:08.439] <TB0> INFO: Expecting 2121600 events.
[09:05:47.729] <TB0> INFO: 936400 events read in total (38731ms).
[09:06:26.423] <TB0> INFO: 1871670 events read in total (77425ms).
[09:06:36.891] <TB0> INFO: 2121600 events read in total (87893ms).
[09:06:36.906] <TB0> INFO: Test took 88752ms.
[09:06:50.992] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 20.596991 .. 42.031499
[09:06:51.072] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 10 .. 52 (-1/-1) hits flags = 528 (plus default)
[09:06:51.081] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[09:06:51.081] <TB0> INFO: run 1 of 1
[09:06:51.344] <TB0> INFO: Expecting 1788800 events.
[09:07:30.488] <TB0> INFO: 934410 events read in total (38588ms).
[09:08:05.415] <TB0> INFO: 1788800 events read in total (73515ms).
[09:08:05.430] <TB0> INFO: Test took 74349ms.
[09:08:18.277] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 23.156576 .. 42.031499
[09:08:18.352] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 13 .. 52 (-1/-1) hits flags = 528 (plus default)
[09:08:18.360] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[09:08:18.360] <TB0> INFO: run 1 of 1
[09:08:18.619] <TB0> INFO: Expecting 1664000 events.
[09:08:57.484] <TB0> INFO: 914990 events read in total (38309ms).
[09:09:28.972] <TB0> INFO: 1664000 events read in total (69797ms).
[09:09:28.999] <TB0> INFO: Test took 70640ms.
[09:09:42.357] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[09:09:42.357] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[09:09:42.365] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[09:09:42.365] <TB0> INFO: run 1 of 1
[09:09:42.624] <TB0> INFO: Expecting 1705600 events.
[09:10:21.874] <TB0> INFO: 877750 events read in total (38694ms).
[09:10:57.566] <TB0> INFO: 1705600 events read in total (74386ms).
[09:10:57.586] <TB0> INFO: Test took 75222ms.
[09:11:11.599] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C0.dat
[09:11:11.599] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C1.dat
[09:11:11.600] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C2.dat
[09:11:11.600] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C3.dat
[09:11:11.600] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C4.dat
[09:11:11.600] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C5.dat
[09:11:11.600] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C6.dat
[09:11:11.600] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C7.dat
[09:11:11.601] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C8.dat
[09:11:11.601] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C9.dat
[09:11:11.601] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C10.dat
[09:11:11.601] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C11.dat
[09:11:11.601] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C12.dat
[09:11:11.602] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C13.dat
[09:11:11.602] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C14.dat
[09:11:11.602] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C15.dat
[09:11:11.602] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C0.dat
[09:11:11.609] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C1.dat
[09:11:11.615] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C2.dat
[09:11:11.621] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C3.dat
[09:11:11.627] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C4.dat
[09:11:11.633] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C5.dat
[09:11:11.639] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C6.dat
[09:11:11.645] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C7.dat
[09:11:11.652] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C8.dat
[09:11:11.658] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C9.dat
[09:11:11.664] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C10.dat
[09:11:11.670] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C11.dat
[09:11:11.676] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C12.dat
[09:11:11.682] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C13.dat
[09:11:11.690] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C14.dat
[09:11:11.696] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//trimParameters35_C15.dat
[09:11:11.702] <TB0> INFO: PixTestTrim::trimTest() done
[09:11:11.702] <TB0> INFO: vtrim: 107 98 131 113 97 97 86 95 100 93 94 95 85 101 105 93
[09:11:11.702] <TB0> INFO: vthrcomp: 99 97 99 90 93 100 91 89 97 85 85 96 87 101 91 92
[09:11:11.702] <TB0> INFO: vcal mean: 34.96 34.96 34.96 35.02 35.01 34.91 34.98 34.99 34.95 35.03 34.94 34.91 34.96 35.00 34.98 34.95
[09:11:11.702] <TB0> INFO: vcal RMS: 0.86 0.87 0.94 0.88 0.89 0.89 0.86 0.81 0.84 0.80 0.85 0.91 0.90 0.89 0.91 0.84
[09:11:11.702] <TB0> INFO: bits mean: 9.23 9.49 9.63 9.48 9.23 9.73 9.33 9.52 9.80 9.74 10.13 9.62 9.61 9.24 9.47 9.51
[09:11:11.702] <TB0> INFO: bits RMS: 2.77 2.84 2.58 2.64 2.68 2.60 2.73 2.56 2.63 2.52 2.49 2.78 2.70 2.79 2.71 2.64
[09:11:11.709] <TB0> INFO: ----------------------------------------------------------------------
[09:11:11.709] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[09:11:11.709] <TB0> INFO: ----------------------------------------------------------------------
[09:11:11.711] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[09:11:11.720] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[09:11:11.721] <TB0> INFO: run 1 of 1
[09:11:12.007] <TB0> INFO: Expecting 4160000 events.
[09:11:54.236] <TB0> INFO: 930695 events read in total (41672ms).
[09:12:36.023] <TB0> INFO: 1857055 events read in total (83459ms).
[09:13:17.574] <TB0> INFO: 2776260 events read in total (125010ms).
[09:13:59.023] <TB0> INFO: 3694280 events read in total (166459ms).
[09:14:20.403] <TB0> INFO: 4160000 events read in total (187839ms).
[09:14:20.443] <TB0> INFO: Test took 188722ms.
[09:14:49.215] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 179 (-1/-1) hits flags = 528 (plus default)
[09:14:49.224] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[09:14:49.224] <TB0> INFO: run 1 of 1
[09:14:49.486] <TB0> INFO: Expecting 3744000 events.
[09:15:32.063] <TB0> INFO: 936035 events read in total (42019ms).
[09:16:14.245] <TB0> INFO: 1868340 events read in total (84201ms).
[09:16:57.450] <TB0> INFO: 2791545 events read in total (127406ms).
[09:17:40.378] <TB0> INFO: 3719510 events read in total (170334ms).
[09:17:41.901] <TB0> INFO: 3744000 events read in total (171857ms).
[09:17:41.946] <TB0> INFO: Test took 172723ms.
[09:18:09.822] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 166 (-1/-1) hits flags = 528 (plus default)
[09:18:09.831] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[09:18:09.831] <TB0> INFO: run 1 of 1
[09:18:10.096] <TB0> INFO: Expecting 3473600 events.
[09:18:53.700] <TB0> INFO: 966665 events read in total (43048ms).
[09:19:36.265] <TB0> INFO: 1926695 events read in total (85613ms).
[09:20:18.909] <TB0> INFO: 2878825 events read in total (128257ms).
[09:20:45.470] <TB0> INFO: 3473600 events read in total (154818ms).
[09:20:45.513] <TB0> INFO: Test took 155682ms.
[09:21:11.604] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 167 (-1/-1) hits flags = 528 (plus default)
[09:21:11.613] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[09:21:11.613] <TB0> INFO: run 1 of 1
[09:21:11.880] <TB0> INFO: Expecting 3494400 events.
[09:21:55.007] <TB0> INFO: 963395 events read in total (42571ms).
[09:22:37.388] <TB0> INFO: 1920815 events read in total (84952ms).
[09:23:20.132] <TB0> INFO: 2869955 events read in total (127696ms).
[09:23:47.482] <TB0> INFO: 3494400 events read in total (155046ms).
[09:23:47.517] <TB0> INFO: Test took 155904ms.
[09:24:14.218] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 166 (-1/-1) hits flags = 528 (plus default)
[09:24:14.229] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[09:24:14.229] <TB0> INFO: run 1 of 1
[09:24:14.499] <TB0> INFO: Expecting 3473600 events.
[09:24:57.527] <TB0> INFO: 965765 events read in total (42471ms).
[09:25:40.171] <TB0> INFO: 1924740 events read in total (85115ms).
[09:26:22.437] <TB0> INFO: 2876025 events read in total (127382ms).
[09:26:48.977] <TB0> INFO: 3473600 events read in total (153921ms).
[09:26:49.013] <TB0> INFO: Test took 154784ms.
[09:27:16.793] <TB0> INFO: PixTestTrim::trimBitTest() done
[09:27:16.794] <TB0> INFO: PixTestTrim::doTest() done, duration: 2988 seconds
[09:27:16.794] <TB0> INFO: Decoding statistics:
[09:27:16.794] <TB0> INFO: General information:
[09:27:16.794] <TB0> INFO: 16bit words read: 0
[09:27:16.794] <TB0> INFO: valid events total: 0
[09:27:16.794] <TB0> INFO: empty events: 0
[09:27:16.794] <TB0> INFO: valid events with pixels: 0
[09:27:16.794] <TB0> INFO: valid pixel hits: 0
[09:27:16.794] <TB0> INFO: Event errors: 0
[09:27:16.794] <TB0> INFO: start marker: 0
[09:27:16.794] <TB0> INFO: stop marker: 0
[09:27:16.794] <TB0> INFO: overflow: 0
[09:27:16.794] <TB0> INFO: invalid 5bit words: 0
[09:27:16.794] <TB0> INFO: invalid XOR eye diagram: 0
[09:27:16.794] <TB0> INFO: frame (failed synchr.): 0
[09:27:16.794] <TB0> INFO: idle data (no TBM trl): 0
[09:27:16.794] <TB0> INFO: no data (only TBM hdr): 0
[09:27:16.794] <TB0> INFO: TBM errors: 0
[09:27:16.794] <TB0> INFO: flawed TBM headers: 0
[09:27:16.794] <TB0> INFO: flawed TBM trailers: 0
[09:27:16.794] <TB0> INFO: event ID mismatches: 0
[09:27:16.794] <TB0> INFO: ROC errors: 0
[09:27:16.794] <TB0> INFO: missing ROC header(s): 0
[09:27:16.794] <TB0> INFO: misplaced readback start: 0
[09:27:16.794] <TB0> INFO: Pixel decoding errors: 0
[09:27:16.794] <TB0> INFO: pixel data incomplete: 0
[09:27:16.794] <TB0> INFO: pixel address: 0
[09:27:16.794] <TB0> INFO: pulse height fill bit: 0
[09:27:16.794] <TB0> INFO: buffer corruption: 0
[09:27:17.505] <TB0> INFO: ######################################################################
[09:27:17.505] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[09:27:17.505] <TB0> INFO: ######################################################################
[09:27:17.775] <TB0> INFO: Expecting 41600 events.
[09:27:21.568] <TB0> INFO: 41600 events read in total (3237ms).
[09:27:21.569] <TB0> INFO: Test took 4063ms.
[09:27:22.037] <TB0> INFO: Expecting 41600 events.
[09:27:25.963] <TB0> INFO: 41600 events read in total (3370ms).
[09:27:25.964] <TB0> INFO: Test took 4193ms.
[09:27:26.263] <TB0> INFO: Expecting 41600 events.
[09:27:30.204] <TB0> INFO: 41600 events read in total (3384ms).
[09:27:30.204] <TB0> INFO: Test took 4218ms.
[09:27:30.460] <TB0> INFO: Expecting 2560 events.
[09:27:31.315] <TB0> INFO: 2560 events read in total (299ms).
[09:27:31.315] <TB0> INFO: Test took 1097ms.
[09:27:31.620] <TB0> INFO: Expecting 2560 events.
[09:27:32.473] <TB0> INFO: 2560 events read in total (297ms).
[09:27:32.473] <TB0> INFO: Test took 1157ms.
[09:27:32.778] <TB0> INFO: Expecting 2560 events.
[09:27:33.631] <TB0> INFO: 2560 events read in total (297ms).
[09:27:33.631] <TB0> INFO: Test took 1158ms.
[09:27:33.937] <TB0> INFO: Expecting 2560 events.
[09:27:34.792] <TB0> INFO: 2560 events read in total (299ms).
[09:27:34.792] <TB0> INFO: Test took 1160ms.
[09:27:35.097] <TB0> INFO: Expecting 2560 events.
[09:27:35.955] <TB0> INFO: 2560 events read in total (302ms).
[09:27:35.955] <TB0> INFO: Test took 1162ms.
[09:27:36.259] <TB0> INFO: Expecting 2560 events.
[09:27:37.112] <TB0> INFO: 2560 events read in total (297ms).
[09:27:37.112] <TB0> INFO: Test took 1157ms.
[09:27:37.417] <TB0> INFO: Expecting 2560 events.
[09:27:38.271] <TB0> INFO: 2560 events read in total (298ms).
[09:27:38.271] <TB0> INFO: Test took 1159ms.
[09:27:38.575] <TB0> INFO: Expecting 2560 events.
[09:27:39.433] <TB0> INFO: 2560 events read in total (302ms).
[09:27:39.433] <TB0> INFO: Test took 1161ms.
[09:27:39.738] <TB0> INFO: Expecting 2560 events.
[09:27:40.592] <TB0> INFO: 2560 events read in total (298ms).
[09:27:40.593] <TB0> INFO: Test took 1159ms.
[09:27:40.897] <TB0> INFO: Expecting 2560 events.
[09:27:41.754] <TB0> INFO: 2560 events read in total (300ms).
[09:27:41.754] <TB0> INFO: Test took 1161ms.
[09:27:42.059] <TB0> INFO: Expecting 2560 events.
[09:27:42.912] <TB0> INFO: 2560 events read in total (296ms).
[09:27:42.912] <TB0> INFO: Test took 1158ms.
[09:27:43.218] <TB0> INFO: Expecting 2560 events.
[09:27:44.073] <TB0> INFO: 2560 events read in total (299ms).
[09:27:44.073] <TB0> INFO: Test took 1160ms.
[09:27:44.377] <TB0> INFO: Expecting 2560 events.
[09:27:45.231] <TB0> INFO: 2560 events read in total (297ms).
[09:27:45.231] <TB0> INFO: Test took 1157ms.
[09:27:45.536] <TB0> INFO: Expecting 2560 events.
[09:27:46.393] <TB0> INFO: 2560 events read in total (301ms).
[09:27:46.394] <TB0> INFO: Test took 1163ms.
[09:27:46.698] <TB0> INFO: Expecting 2560 events.
[09:27:47.551] <TB0> INFO: 2560 events read in total (297ms).
[09:27:47.551] <TB0> INFO: Test took 1157ms.
[09:27:47.857] <TB0> INFO: Expecting 2560 events.
[09:27:48.711] <TB0> INFO: 2560 events read in total (298ms).
[09:27:48.711] <TB0> INFO: Test took 1159ms.
[09:27:48.714] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:27:49.018] <TB0> INFO: Expecting 655360 events.
[09:28:06.007] <TB0> INFO: 655360 events read in total (16433ms).
[09:28:06.017] <TB0> INFO: Expecting 655360 events.
[09:28:22.899] <TB0> INFO: 655360 events read in total (16481ms).
[09:28:22.911] <TB0> INFO: Expecting 655360 events.
[09:28:39.592] <TB0> INFO: 655360 events read in total (16279ms).
[09:28:39.607] <TB0> INFO: Expecting 655360 events.
[09:28:56.403] <TB0> INFO: 655360 events read in total (16394ms).
[09:28:56.422] <TB0> INFO: Expecting 655360 events.
[09:29:13.139] <TB0> INFO: 655360 events read in total (16315ms).
[09:29:13.162] <TB0> INFO: Expecting 655360 events.
[09:29:29.781] <TB0> INFO: 655360 events read in total (16218ms).
[09:29:29.806] <TB0> INFO: Expecting 655360 events.
[09:29:46.526] <TB0> INFO: 655360 events read in total (16318ms).
[09:29:46.556] <TB0> INFO: Expecting 655360 events.
[09:30:03.236] <TB0> INFO: 655360 events read in total (16279ms).
[09:30:03.270] <TB0> INFO: Expecting 655360 events.
[09:30:20.003] <TB0> INFO: 655360 events read in total (16331ms).
[09:30:20.040] <TB0> INFO: Expecting 655360 events.
[09:30:36.678] <TB0> INFO: 655360 events read in total (16236ms).
[09:30:36.718] <TB0> INFO: Expecting 655360 events.
[09:30:53.367] <TB0> INFO: 655360 events read in total (16247ms).
[09:30:53.412] <TB0> INFO: Expecting 655360 events.
[09:31:10.127] <TB0> INFO: 655360 events read in total (16313ms).
[09:31:10.180] <TB0> INFO: Expecting 655360 events.
[09:31:26.894] <TB0> INFO: 655360 events read in total (16312ms).
[09:31:26.943] <TB0> INFO: Expecting 655360 events.
[09:31:43.640] <TB0> INFO: 655360 events read in total (16295ms).
[09:31:43.694] <TB0> INFO: Expecting 655360 events.
[09:32:00.450] <TB0> INFO: 655360 events read in total (16355ms).
[09:32:00.509] <TB0> INFO: Expecting 655360 events.
[09:32:17.284] <TB0> INFO: 655360 events read in total (16373ms).
[09:32:17.349] <TB0> INFO: Test took 268635ms.
[09:32:17.429] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:32:17.659] <TB0> INFO: Expecting 655360 events.
[09:32:34.503] <TB0> INFO: 655360 events read in total (16288ms).
[09:32:34.512] <TB0> INFO: Expecting 655360 events.
[09:32:51.204] <TB0> INFO: 655360 events read in total (16291ms).
[09:32:51.217] <TB0> INFO: Expecting 655360 events.
[09:33:07.949] <TB0> INFO: 655360 events read in total (16330ms).
[09:33:07.966] <TB0> INFO: Expecting 655360 events.
[09:33:24.794] <TB0> INFO: 655360 events read in total (16426ms).
[09:33:24.814] <TB0> INFO: Expecting 655360 events.
[09:33:41.700] <TB0> INFO: 655360 events read in total (16484ms).
[09:33:41.728] <TB0> INFO: Expecting 655360 events.
[09:33:58.566] <TB0> INFO: 655360 events read in total (16436ms).
[09:33:58.594] <TB0> INFO: Expecting 655360 events.
[09:34:15.518] <TB0> INFO: 655360 events read in total (16522ms).
[09:34:15.547] <TB0> INFO: Expecting 655360 events.
[09:34:32.321] <TB0> INFO: 655360 events read in total (16372ms).
[09:34:32.360] <TB0> INFO: Expecting 655360 events.
[09:34:49.041] <TB0> INFO: 655360 events read in total (16279ms).
[09:34:49.080] <TB0> INFO: Expecting 655360 events.
[09:35:05.816] <TB0> INFO: 655360 events read in total (16334ms).
[09:35:05.858] <TB0> INFO: Expecting 655360 events.
[09:35:22.622] <TB0> INFO: 655360 events read in total (16363ms).
[09:35:22.666] <TB0> INFO: Expecting 655360 events.
[09:35:39.601] <TB0> INFO: 655360 events read in total (16534ms).
[09:35:39.652] <TB0> INFO: Expecting 655360 events.
[09:35:56.105] <TB0> INFO: 655360 events read in total (16052ms).
[09:35:56.156] <TB0> INFO: Expecting 655360 events.
[09:36:12.605] <TB0> INFO: 655360 events read in total (16047ms).
[09:36:12.666] <TB0> INFO: Expecting 655360 events.
[09:36:29.359] <TB0> INFO: 655360 events read in total (16291ms).
[09:36:29.465] <TB0> INFO: Expecting 655360 events.
[09:36:45.899] <TB0> INFO: 655360 events read in total (16032ms).
[09:36:45.963] <TB0> INFO: Test took 268534ms.
[09:36:46.149] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.156] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.165] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.173] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.181] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.189] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.197] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.206] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.214] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.222] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.230] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.239] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.247] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.254] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[09:36:46.262] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[09:36:46.270] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[09:36:46.278] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.285] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.292] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[09:36:46.328] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C0.dat
[09:36:46.328] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C1.dat
[09:36:46.328] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C2.dat
[09:36:46.328] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C3.dat
[09:36:46.328] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C4.dat
[09:36:46.328] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C5.dat
[09:36:46.328] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C6.dat
[09:36:46.328] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C7.dat
[09:36:46.329] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C8.dat
[09:36:46.329] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C9.dat
[09:36:46.329] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C10.dat
[09:36:46.329] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C11.dat
[09:36:46.329] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C12.dat
[09:36:46.329] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C13.dat
[09:36:46.329] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C14.dat
[09:36:46.329] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//dacParameters35_C15.dat
[09:36:46.619] <TB0> INFO: Expecting 41600 events.
[09:36:50.078] <TB0> INFO: 41600 events read in total (2903ms).
[09:36:50.079] <TB0> INFO: Test took 3747ms.
[09:36:50.523] <TB0> INFO: Expecting 41600 events.
[09:36:53.963] <TB0> INFO: 41600 events read in total (2884ms).
[09:36:53.964] <TB0> INFO: Test took 3707ms.
[09:36:54.404] <TB0> INFO: Expecting 41600 events.
[09:36:57.858] <TB0> INFO: 41600 events read in total (2898ms).
[09:36:57.859] <TB0> INFO: Test took 3717ms.
[09:36:58.043] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:36:58.131] <TB0> INFO: Expecting 2560 events.
[09:36:58.983] <TB0> INFO: 2560 events read in total (296ms).
[09:36:58.984] <TB0> INFO: Test took 941ms.
[09:36:58.985] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:36:59.289] <TB0> INFO: Expecting 2560 events.
[09:37:00.144] <TB0> INFO: 2560 events read in total (299ms).
[09:37:00.145] <TB0> INFO: Test took 1160ms.
[09:37:00.146] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:00.451] <TB0> INFO: Expecting 2560 events.
[09:37:01.310] <TB0> INFO: 2560 events read in total (303ms).
[09:37:01.310] <TB0> INFO: Test took 1164ms.
[09:37:01.312] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:01.616] <TB0> INFO: Expecting 2560 events.
[09:37:02.475] <TB0> INFO: 2560 events read in total (303ms).
[09:37:02.475] <TB0> INFO: Test took 1163ms.
[09:37:02.477] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:02.780] <TB0> INFO: Expecting 2560 events.
[09:37:03.632] <TB0> INFO: 2560 events read in total (296ms).
[09:37:03.632] <TB0> INFO: Test took 1155ms.
[09:37:03.634] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:03.938] <TB0> INFO: Expecting 2560 events.
[09:37:04.796] <TB0> INFO: 2560 events read in total (302ms).
[09:37:04.797] <TB0> INFO: Test took 1163ms.
[09:37:04.799] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:05.102] <TB0> INFO: Expecting 2560 events.
[09:37:05.961] <TB0> INFO: 2560 events read in total (302ms).
[09:37:05.961] <TB0> INFO: Test took 1162ms.
[09:37:05.963] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:06.267] <TB0> INFO: Expecting 2560 events.
[09:37:07.123] <TB0> INFO: 2560 events read in total (300ms).
[09:37:07.123] <TB0> INFO: Test took 1160ms.
[09:37:07.125] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:07.428] <TB0> INFO: Expecting 2560 events.
[09:37:08.282] <TB0> INFO: 2560 events read in total (298ms).
[09:37:08.282] <TB0> INFO: Test took 1157ms.
[09:37:08.284] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:08.587] <TB0> INFO: Expecting 2560 events.
[09:37:09.444] <TB0> INFO: 2560 events read in total (300ms).
[09:37:09.444] <TB0> INFO: Test took 1161ms.
[09:37:09.445] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:09.750] <TB0> INFO: Expecting 2560 events.
[09:37:10.605] <TB0> INFO: 2560 events read in total (299ms).
[09:37:10.606] <TB0> INFO: Test took 1161ms.
[09:37:10.607] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:10.911] <TB0> INFO: Expecting 2560 events.
[09:37:11.769] <TB0> INFO: 2560 events read in total (301ms).
[09:37:11.769] <TB0> INFO: Test took 1162ms.
[09:37:11.771] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:12.075] <TB0> INFO: Expecting 2560 events.
[09:37:12.928] <TB0> INFO: 2560 events read in total (296ms).
[09:37:12.929] <TB0> INFO: Test took 1158ms.
[09:37:12.930] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:13.235] <TB0> INFO: Expecting 2560 events.
[09:37:14.092] <TB0> INFO: 2560 events read in total (301ms).
[09:37:14.093] <TB0> INFO: Test took 1163ms.
[09:37:14.095] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:14.398] <TB0> INFO: Expecting 2560 events.
[09:37:15.254] <TB0> INFO: 2560 events read in total (300ms).
[09:37:15.255] <TB0> INFO: Test took 1160ms.
[09:37:15.257] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:15.559] <TB0> INFO: Expecting 2560 events.
[09:37:16.413] <TB0> INFO: 2560 events read in total (298ms).
[09:37:16.413] <TB0> INFO: Test took 1156ms.
[09:37:16.415] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:16.718] <TB0> INFO: Expecting 2560 events.
[09:37:17.571] <TB0> INFO: 2560 events read in total (297ms).
[09:37:17.571] <TB0> INFO: Test took 1156ms.
[09:37:17.573] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:17.878] <TB0> INFO: Expecting 2560 events.
[09:37:18.734] <TB0> INFO: 2560 events read in total (300ms).
[09:37:18.734] <TB0> INFO: Test took 1161ms.
[09:37:18.737] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:19.040] <TB0> INFO: Expecting 2560 events.
[09:37:19.895] <TB0> INFO: 2560 events read in total (298ms).
[09:37:19.896] <TB0> INFO: Test took 1160ms.
[09:37:19.898] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:20.202] <TB0> INFO: Expecting 2560 events.
[09:37:21.054] <TB0> INFO: 2560 events read in total (296ms).
[09:37:21.055] <TB0> INFO: Test took 1157ms.
[09:37:21.056] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:21.360] <TB0> INFO: Expecting 2560 events.
[09:37:22.215] <TB0> INFO: 2560 events read in total (298ms).
[09:37:22.216] <TB0> INFO: Test took 1160ms.
[09:37:22.218] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:22.522] <TB0> INFO: Expecting 2560 events.
[09:37:23.380] <TB0> INFO: 2560 events read in total (302ms).
[09:37:23.380] <TB0> INFO: Test took 1162ms.
[09:37:23.383] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:23.686] <TB0> INFO: Expecting 2560 events.
[09:37:24.540] <TB0> INFO: 2560 events read in total (297ms).
[09:37:24.540] <TB0> INFO: Test took 1157ms.
[09:37:24.542] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:24.851] <TB0> INFO: Expecting 2560 events.
[09:37:25.709] <TB0> INFO: 2560 events read in total (302ms).
[09:37:25.709] <TB0> INFO: Test took 1167ms.
[09:37:25.712] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:26.016] <TB0> INFO: Expecting 2560 events.
[09:37:26.875] <TB0> INFO: 2560 events read in total (302ms).
[09:37:26.875] <TB0> INFO: Test took 1163ms.
[09:37:26.878] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:27.181] <TB0> INFO: Expecting 2560 events.
[09:37:28.036] <TB0> INFO: 2560 events read in total (298ms).
[09:37:28.036] <TB0> INFO: Test took 1159ms.
[09:37:28.039] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:28.342] <TB0> INFO: Expecting 2560 events.
[09:37:29.196] <TB0> INFO: 2560 events read in total (297ms).
[09:37:29.196] <TB0> INFO: Test took 1157ms.
[09:37:29.200] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:29.502] <TB0> INFO: Expecting 2560 events.
[09:37:30.356] <TB0> INFO: 2560 events read in total (298ms).
[09:37:30.357] <TB0> INFO: Test took 1157ms.
[09:37:30.359] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:30.662] <TB0> INFO: Expecting 2560 events.
[09:37:31.522] <TB0> INFO: 2560 events read in total (303ms).
[09:37:31.523] <TB0> INFO: Test took 1164ms.
[09:37:31.525] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:31.829] <TB0> INFO: Expecting 2560 events.
[09:37:32.688] <TB0> INFO: 2560 events read in total (303ms).
[09:37:32.688] <TB0> INFO: Test took 1163ms.
[09:37:32.691] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:32.994] <TB0> INFO: Expecting 2560 events.
[09:37:33.852] <TB0> INFO: 2560 events read in total (302ms).
[09:37:33.853] <TB0> INFO: Test took 1162ms.
[09:37:33.854] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:37:34.159] <TB0> INFO: Expecting 2560 events.
[09:37:35.012] <TB0> INFO: 2560 events read in total (297ms).
[09:37:35.012] <TB0> INFO: Test took 1158ms.
[09:37:35.486] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 617 seconds
[09:37:35.486] <TB0> INFO: PH scale (per ROC): 79 87 85 83 83 66 80 82 82 90 87 80 80 71 89 79
[09:37:35.486] <TB0> INFO: PH offset (per ROC): 177 165 151 146 146 170 146 141 146 148 148 156 154 162 164 139
[09:37:35.494] <TB0> INFO: Decoding statistics:
[09:37:35.494] <TB0> INFO: General information:
[09:37:35.494] <TB0> INFO: 16bit words read: 91932
[09:37:35.494] <TB0> INFO: valid events total: 10240
[09:37:35.494] <TB0> INFO: empty events: 7737
[09:37:35.494] <TB0> INFO: valid events with pixels: 2503
[09:37:35.494] <TB0> INFO: valid pixel hits: 2503
[09:37:35.494] <TB0> INFO: Event errors: 0
[09:37:35.494] <TB0> INFO: start marker: 0
[09:37:35.494] <TB0> INFO: stop marker: 0
[09:37:35.494] <TB0> INFO: overflow: 0
[09:37:35.494] <TB0> INFO: invalid 5bit words: 0
[09:37:35.494] <TB0> INFO: invalid XOR eye diagram: 0
[09:37:35.494] <TB0> INFO: frame (failed synchr.): 0
[09:37:35.494] <TB0> INFO: idle data (no TBM trl): 0
[09:37:35.494] <TB0> INFO: no data (only TBM hdr): 0
[09:37:35.494] <TB0> INFO: TBM errors: 0
[09:37:35.494] <TB0> INFO: flawed TBM headers: 0
[09:37:35.494] <TB0> INFO: flawed TBM trailers: 0
[09:37:35.494] <TB0> INFO: event ID mismatches: 0
[09:37:35.494] <TB0> INFO: ROC errors: 0
[09:37:35.494] <TB0> INFO: missing ROC header(s): 0
[09:37:35.494] <TB0> INFO: misplaced readback start: 0
[09:37:35.494] <TB0> INFO: Pixel decoding errors: 0
[09:37:35.494] <TB0> INFO: pixel data incomplete: 0
[09:37:35.494] <TB0> INFO: pixel address: 0
[09:37:35.494] <TB0> INFO: pulse height fill bit: 0
[09:37:35.494] <TB0> INFO: buffer corruption: 0
[09:37:35.683] <TB0> INFO: ######################################################################
[09:37:35.683] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[09:37:35.683] <TB0> INFO: ######################################################################
[09:37:35.694] <TB0> INFO: scanning low vcal = 10
[09:37:35.962] <TB0> INFO: Expecting 41600 events.
[09:37:39.518] <TB0> INFO: 41600 events read in total (2999ms).
[09:37:39.518] <TB0> INFO: Test took 3824ms.
[09:37:39.520] <TB0> INFO: scanning low vcal = 20
[09:37:39.822] <TB0> INFO: Expecting 41600 events.
[09:37:43.374] <TB0> INFO: 41600 events read in total (2995ms).
[09:37:43.375] <TB0> INFO: Test took 3855ms.
[09:37:43.376] <TB0> INFO: scanning low vcal = 30
[09:37:43.680] <TB0> INFO: Expecting 41600 events.
[09:37:47.255] <TB0> INFO: 41600 events read in total (3019ms).
[09:37:47.256] <TB0> INFO: Test took 3879ms.
[09:37:47.258] <TB0> INFO: scanning low vcal = 40
[09:37:47.548] <TB0> INFO: Expecting 41600 events.
[09:37:51.747] <TB0> INFO: 41600 events read in total (3642ms).
[09:37:51.748] <TB0> INFO: Test took 4490ms.
[09:37:51.750] <TB0> INFO: scanning low vcal = 50
[09:37:52.017] <TB0> INFO: Expecting 41600 events.
[09:37:56.258] <TB0> INFO: 41600 events read in total (3685ms).
[09:37:56.258] <TB0> INFO: Test took 4508ms.
[09:37:56.261] <TB0> INFO: scanning low vcal = 60
[09:37:56.521] <TB0> INFO: Expecting 41600 events.
[09:38:00.787] <TB0> INFO: 41600 events read in total (3710ms).
[09:38:00.788] <TB0> INFO: Test took 4527ms.
[09:38:00.790] <TB0> INFO: scanning low vcal = 70
[09:38:01.055] <TB0> INFO: Expecting 41600 events.
[09:38:05.284] <TB0> INFO: 41600 events read in total (3672ms).
[09:38:05.284] <TB0> INFO: Test took 4493ms.
[09:38:05.287] <TB0> INFO: scanning low vcal = 80
[09:38:05.559] <TB0> INFO: Expecting 41600 events.
[09:38:09.797] <TB0> INFO: 41600 events read in total (3682ms).
[09:38:09.797] <TB0> INFO: Test took 4510ms.
[09:38:09.800] <TB0> INFO: scanning low vcal = 90
[09:38:10.069] <TB0> INFO: Expecting 41600 events.
[09:38:14.319] <TB0> INFO: 41600 events read in total (3694ms).
[09:38:14.320] <TB0> INFO: Test took 4519ms.
[09:38:14.323] <TB0> INFO: scanning low vcal = 100
[09:38:14.590] <TB0> INFO: Expecting 41600 events.
[09:38:18.752] <TB0> INFO: 41600 events read in total (3606ms).
[09:38:18.753] <TB0> INFO: Test took 4430ms.
[09:38:18.755] <TB0> INFO: scanning low vcal = 110
[09:38:19.014] <TB0> INFO: Expecting 41600 events.
[09:38:23.175] <TB0> INFO: 41600 events read in total (3605ms).
[09:38:23.176] <TB0> INFO: Test took 4421ms.
[09:38:23.178] <TB0> INFO: scanning low vcal = 120
[09:38:23.440] <TB0> INFO: Expecting 41600 events.
[09:38:27.695] <TB0> INFO: 41600 events read in total (3699ms).
[09:38:27.703] <TB0> INFO: Test took 4524ms.
[09:38:27.706] <TB0> INFO: scanning low vcal = 130
[09:38:28.053] <TB0> INFO: Expecting 41600 events.
[09:38:32.270] <TB0> INFO: 41600 events read in total (3661ms).
[09:38:32.270] <TB0> INFO: Test took 4564ms.
[09:38:32.273] <TB0> INFO: scanning low vcal = 140
[09:38:32.537] <TB0> INFO: Expecting 41600 events.
[09:38:36.704] <TB0> INFO: 41600 events read in total (3611ms).
[09:38:36.705] <TB0> INFO: Test took 4432ms.
[09:38:36.707] <TB0> INFO: scanning low vcal = 150
[09:38:36.968] <TB0> INFO: Expecting 41600 events.
[09:38:41.142] <TB0> INFO: 41600 events read in total (3618ms).
[09:38:41.143] <TB0> INFO: Test took 4435ms.
[09:38:41.146] <TB0> INFO: scanning low vcal = 160
[09:38:41.420] <TB0> INFO: Expecting 41600 events.
[09:38:45.599] <TB0> INFO: 41600 events read in total (3623ms).
[09:38:45.600] <TB0> INFO: Test took 4454ms.
[09:38:45.603] <TB0> INFO: scanning low vcal = 170
[09:38:45.892] <TB0> INFO: Expecting 41600 events.
[09:38:50.120] <TB0> INFO: 41600 events read in total (3672ms).
[09:38:50.121] <TB0> INFO: Test took 4518ms.
[09:38:50.125] <TB0> INFO: scanning low vcal = 180
[09:38:50.385] <TB0> INFO: Expecting 41600 events.
[09:38:54.621] <TB0> INFO: 41600 events read in total (3680ms).
[09:38:54.622] <TB0> INFO: Test took 4497ms.
[09:38:54.624] <TB0> INFO: scanning low vcal = 190
[09:38:54.891] <TB0> INFO: Expecting 41600 events.
[09:38:59.141] <TB0> INFO: 41600 events read in total (3693ms).
[09:38:59.142] <TB0> INFO: Test took 4518ms.
[09:38:59.144] <TB0> INFO: scanning low vcal = 200
[09:38:59.406] <TB0> INFO: Expecting 41600 events.
[09:39:03.664] <TB0> INFO: 41600 events read in total (3702ms).
[09:39:03.664] <TB0> INFO: Test took 4520ms.
[09:39:03.667] <TB0> INFO: scanning low vcal = 210
[09:39:03.935] <TB0> INFO: Expecting 41600 events.
[09:39:08.190] <TB0> INFO: 41600 events read in total (3699ms).
[09:39:08.191] <TB0> INFO: Test took 4524ms.
[09:39:08.194] <TB0> INFO: scanning low vcal = 220
[09:39:08.458] <TB0> INFO: Expecting 41600 events.
[09:39:12.708] <TB0> INFO: 41600 events read in total (3694ms).
[09:39:12.709] <TB0> INFO: Test took 4515ms.
[09:39:12.711] <TB0> INFO: scanning low vcal = 230
[09:39:12.980] <TB0> INFO: Expecting 41600 events.
[09:39:17.205] <TB0> INFO: 41600 events read in total (3669ms).
[09:39:17.205] <TB0> INFO: Test took 4494ms.
[09:39:17.208] <TB0> INFO: scanning low vcal = 240
[09:39:17.472] <TB0> INFO: Expecting 41600 events.
[09:39:21.710] <TB0> INFO: 41600 events read in total (3682ms).
[09:39:21.710] <TB0> INFO: Test took 4502ms.
[09:39:21.713] <TB0> INFO: scanning low vcal = 250
[09:39:21.983] <TB0> INFO: Expecting 41600 events.
[09:39:26.199] <TB0> INFO: 41600 events read in total (3660ms).
[09:39:26.199] <TB0> INFO: Test took 4486ms.
[09:39:26.203] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[09:39:26.467] <TB0> INFO: Expecting 41600 events.
[09:39:30.687] <TB0> INFO: 41600 events read in total (3664ms).
[09:39:30.687] <TB0> INFO: Test took 4484ms.
[09:39:30.689] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[09:39:30.949] <TB0> INFO: Expecting 41600 events.
[09:39:35.149] <TB0> INFO: 41600 events read in total (3644ms).
[09:39:35.149] <TB0> INFO: Test took 4459ms.
[09:39:35.152] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[09:39:35.414] <TB0> INFO: Expecting 41600 events.
[09:39:39.614] <TB0> INFO: 41600 events read in total (3644ms).
[09:39:39.615] <TB0> INFO: Test took 4463ms.
[09:39:39.617] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[09:39:39.874] <TB0> INFO: Expecting 41600 events.
[09:39:44.094] <TB0> INFO: 41600 events read in total (3664ms).
[09:39:44.094] <TB0> INFO: Test took 4477ms.
[09:39:44.097] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[09:39:44.358] <TB0> INFO: Expecting 41600 events.
[09:39:48.579] <TB0> INFO: 41600 events read in total (3665ms).
[09:39:48.580] <TB0> INFO: Test took 4483ms.
[09:39:49.029] <TB0> INFO: PixTestGainPedestal::measure() done
[09:40:20.396] <TB0> INFO: PixTestGainPedestal::fit() done
[09:40:20.396] <TB0> INFO: non-linearity mean: 0.955 0.960 0.960 0.955 0.953 0.950 0.951 0.955 0.952 0.951 0.947 0.949 0.964 0.951 0.957 0.953
[09:40:20.396] <TB0> INFO: non-linearity RMS: 0.006 0.006 0.005 0.006 0.006 0.006 0.007 0.005 0.006 0.006 0.006 0.005 0.005 0.007 0.007 0.005
[09:40:20.396] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[09:40:20.413] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[09:40:20.431] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[09:40:20.448] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[09:40:20.465] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[09:40:20.483] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[09:40:20.500] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[09:40:20.517] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[09:40:20.534] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[09:40:20.552] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[09:40:20.575] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[09:40:20.605] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[09:40:20.622] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[09:40:20.640] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[09:40:20.658] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[09:40:20.675] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[09:40:20.692] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 165 seconds
[09:40:20.693] <TB0> INFO: Decoding statistics:
[09:40:20.693] <TB0> INFO: General information:
[09:40:20.693] <TB0> INFO: 16bit words read: 2662400
[09:40:20.693] <TB0> INFO: valid events total: 166400
[09:40:20.693] <TB0> INFO: empty events: 0
[09:40:20.693] <TB0> INFO: valid events with pixels: 166400
[09:40:20.693] <TB0> INFO: valid pixel hits: 665590
[09:40:20.693] <TB0> INFO: Event errors: 0
[09:40:20.693] <TB0> INFO: start marker: 0
[09:40:20.693] <TB0> INFO: stop marker: 0
[09:40:20.693] <TB0> INFO: overflow: 0
[09:40:20.693] <TB0> INFO: invalid 5bit words: 0
[09:40:20.693] <TB0> INFO: invalid XOR eye diagram: 0
[09:40:20.693] <TB0> INFO: frame (failed synchr.): 0
[09:40:20.693] <TB0> INFO: idle data (no TBM trl): 0
[09:40:20.693] <TB0> INFO: no data (only TBM hdr): 0
[09:40:20.693] <TB0> INFO: TBM errors: 0
[09:40:20.693] <TB0> INFO: flawed TBM headers: 0
[09:40:20.693] <TB0> INFO: flawed TBM trailers: 0
[09:40:20.693] <TB0> INFO: event ID mismatches: 0
[09:40:20.693] <TB0> INFO: ROC errors: 0
[09:40:20.693] <TB0> INFO: missing ROC header(s): 0
[09:40:20.693] <TB0> INFO: misplaced readback start: 0
[09:40:20.693] <TB0> INFO: Pixel decoding errors: 0
[09:40:20.693] <TB0> INFO: pixel data incomplete: 0
[09:40:20.693] <TB0> INFO: pixel address: 0
[09:40:20.693] <TB0> INFO: pulse height fill bit: 0
[09:40:20.693] <TB0> INFO: buffer corruption: 0
[09:40:20.700] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C15.dat
[09:40:20.701] <TB0> INFO: ######################################################################
[09:40:20.701] <TB0> INFO: PixTestReadback::doTest()
[09:40:20.701] <TB0> INFO: ######################################################################
[09:40:20.701] <TB0> INFO: ----------------------------------------------------------------------
[09:40:20.701] <TB0> INFO: PixTestReadback::CalibrateVd()
[09:40:20.701] <TB0> INFO: ----------------------------------------------------------------------
[09:40:30.212] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C0.dat
[09:40:30.213] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C1.dat
[09:40:30.213] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C2.dat
[09:40:30.213] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C3.dat
[09:40:30.213] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C4.dat
[09:40:30.213] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C5.dat
[09:40:30.213] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C6.dat
[09:40:30.213] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C7.dat
[09:40:30.214] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C8.dat
[09:40:30.214] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C9.dat
[09:40:30.214] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C10.dat
[09:40:30.214] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C11.dat
[09:40:30.214] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C12.dat
[09:40:30.214] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C13.dat
[09:40:30.214] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C14.dat
[09:40:30.214] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C15.dat
[09:40:30.244] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[09:40:30.244] <TB0> INFO: ----------------------------------------------------------------------
[09:40:30.244] <TB0> INFO: PixTestReadback::CalibrateVa()
[09:40:30.244] <TB0> INFO: ----------------------------------------------------------------------
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C0.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C1.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C2.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C3.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C4.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C5.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C6.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C7.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C8.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C9.dat
[09:40:39.705] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C10.dat
[09:40:39.706] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C11.dat
[09:40:39.706] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C12.dat
[09:40:39.706] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C13.dat
[09:40:39.706] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C14.dat
[09:40:39.706] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C15.dat
[09:40:39.734] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[09:40:39.734] <TB0> INFO: ----------------------------------------------------------------------
[09:40:39.734] <TB0> INFO: PixTestReadback::readbackVbg()
[09:40:39.734] <TB0> INFO: ----------------------------------------------------------------------
[09:40:47.058] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[09:40:47.058] <TB0> INFO: ----------------------------------------------------------------------
[09:40:47.058] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[09:40:47.058] <TB0> INFO: ----------------------------------------------------------------------
[09:40:47.058] <TB0> INFO: Vbg will be calibrated using Vd calibration
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 144.7calibrated Vbg = 1.21093 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 153.8calibrated Vbg = 1.21117 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 147calibrated Vbg = 1.21285 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 152.3calibrated Vbg = 1.21913 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 151.5calibrated Vbg = 1.21319 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 147.9calibrated Vbg = 1.21569 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 150.3calibrated Vbg = 1.2229 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 151calibrated Vbg = 1.21598 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 137.6calibrated Vbg = 1.22883 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 152calibrated Vbg = 1.22479 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 151.8calibrated Vbg = 1.22126 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152.6calibrated Vbg = 1.21765 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 151.6calibrated Vbg = 1.21499 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 155calibrated Vbg = 1.21898 :::*/*/*/*/
[09:40:47.058] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 151.2calibrated Vbg = 1.21802 :::*/*/*/*/
[09:40:47.059] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 141.9calibrated Vbg = 1.21409 :::*/*/*/*/
[09:40:47.061] <TB0> INFO: ----------------------------------------------------------------------
[09:40:47.061] <TB0> INFO: PixTestReadback::CalibrateIa()
[09:40:47.061] <TB0> INFO: ----------------------------------------------------------------------
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C0.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C1.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C2.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C3.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C4.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C5.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C6.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C7.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C8.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C9.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C10.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C11.dat
[09:43:22.326] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C12.dat
[09:43:22.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C13.dat
[09:43:22.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C14.dat
[09:43:22.327] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//002_FulltestPxar_m20//readbackCal_C15.dat
[09:43:22.355] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[09:43:22.355] <TB0> INFO: PixTestReadback::doTest() done
[09:43:22.355] <TB0> INFO: Decoding statistics:
[09:43:22.355] <TB0> INFO: General information:
[09:43:22.355] <TB0> INFO: 16bit words read: 1024
[09:43:22.355] <TB0> INFO: valid events total: 128
[09:43:22.355] <TB0> INFO: empty events: 128
[09:43:22.355] <TB0> INFO: valid events with pixels: 0
[09:43:22.355] <TB0> INFO: valid pixel hits: 0
[09:43:22.355] <TB0> INFO: Event errors: 0
[09:43:22.355] <TB0> INFO: start marker: 0
[09:43:22.355] <TB0> INFO: stop marker: 0
[09:43:22.355] <TB0> INFO: overflow: 0
[09:43:22.355] <TB0> INFO: invalid 5bit words: 0
[09:43:22.356] <TB0> INFO: invalid XOR eye diagram: 0
[09:43:22.356] <TB0> INFO: frame (failed synchr.): 0
[09:43:22.356] <TB0> INFO: idle data (no TBM trl): 0
[09:43:22.356] <TB0> INFO: no data (only TBM hdr): 0
[09:43:22.356] <TB0> INFO: TBM errors: 0
[09:43:22.356] <TB0> INFO: flawed TBM headers: 0
[09:43:22.356] <TB0> INFO: flawed TBM trailers: 0
[09:43:22.356] <TB0> INFO: event ID mismatches: 0
[09:43:22.356] <TB0> INFO: ROC errors: 0
[09:43:22.356] <TB0> INFO: missing ROC header(s): 0
[09:43:22.356] <TB0> INFO: misplaced readback start: 0
[09:43:22.356] <TB0> INFO: Pixel decoding errors: 0
[09:43:22.356] <TB0> INFO: pixel data incomplete: 0
[09:43:22.356] <TB0> INFO: pixel address: 0
[09:43:22.356] <TB0> INFO: pulse height fill bit: 0
[09:43:22.356] <TB0> INFO: buffer corruption: 0
[09:43:22.376] <TB0> INFO: Decoding statistics:
[09:43:22.376] <TB0> INFO: General information:
[09:43:22.376] <TB0> INFO: 16bit words read: 2755356
[09:43:22.376] <TB0> INFO: valid events total: 176768
[09:43:22.376] <TB0> INFO: empty events: 7865
[09:43:22.376] <TB0> INFO: valid events with pixels: 168903
[09:43:22.376] <TB0> INFO: valid pixel hits: 668093
[09:43:22.376] <TB0> INFO: Event errors: 0
[09:43:22.376] <TB0> INFO: start marker: 0
[09:43:22.376] <TB0> INFO: stop marker: 0
[09:43:22.376] <TB0> INFO: overflow: 0
[09:43:22.376] <TB0> INFO: invalid 5bit words: 0
[09:43:22.376] <TB0> INFO: invalid XOR eye diagram: 0
[09:43:22.376] <TB0> INFO: frame (failed synchr.): 0
[09:43:22.376] <TB0> INFO: idle data (no TBM trl): 0
[09:43:22.376] <TB0> INFO: no data (only TBM hdr): 0
[09:43:22.376] <TB0> INFO: TBM errors: 0
[09:43:22.376] <TB0> INFO: flawed TBM headers: 0
[09:43:22.376] <TB0> INFO: flawed TBM trailers: 0
[09:43:22.376] <TB0> INFO: event ID mismatches: 0
[09:43:22.376] <TB0> INFO: ROC errors: 0
[09:43:22.376] <TB0> INFO: missing ROC header(s): 0
[09:43:22.376] <TB0> INFO: misplaced readback start: 0
[09:43:22.376] <TB0> INFO: Pixel decoding errors: 0
[09:43:22.376] <TB0> INFO: pixel data incomplete: 0
[09:43:22.377] <TB0> INFO: pixel address: 0
[09:43:22.377] <TB0> INFO: pulse height fill bit: 0
[09:43:22.377] <TB0> INFO: buffer corruption: 0
[09:43:22.377] <TB0> INFO: enter test to run
[09:43:22.377] <TB0> INFO: test: exit no parameter change
[09:43:22.528] <TB0> QUIET: Connection to board 73 closed.
[09:43:22.607] <TB0> INFO: pXar: this is the end, my friend