[14:26:35.815] <TB0> INFO: *** Welcome to pxar ***
[14:26:35.815] <TB0> INFO: *** Today: 2015/09/16
[14:26:35.815] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C15.dat
[14:26:35.816] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//tbmParameters_C0b.dat
[14:26:35.816] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//defaultMaskFile.dat
[14:26:35.816] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters_C15.dat
[14:26:35.918] <TB0> INFO: clk: 4
[14:26:35.918] <TB0> INFO: ctr: 4
[14:26:35.918] <TB0> INFO: sda: 19
[14:26:35.918] <TB0> INFO: tin: 9
[14:26:35.918] <TB0> INFO: level: 15
[14:26:35.918] <TB0> INFO: triggerdelay: 0
[14:26:35.918] <TB0> QUIET: Instanciating API for pxar prod-10+28~ga8f1456
[14:26:35.918] <TB0> INFO: Log level: INFO
[14:26:35.925] <TB0> INFO: Found DTB DTB_WS6AYH
[14:26:35.937] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[14:26:35.940] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.2
SW version: 4.4
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[14:26:35.942] <TB0> INFO: RPC call hashes of host and DTB match: 397073690
[14:26:37.456] <TB0> INFO: DUT info:
[14:26:37.456] <TB0> INFO: The DUT currently contains the following objects:
[14:26:37.456] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[14:26:37.456] <TB0> INFO: TBM Core alpha (0): 7 registers set
[14:26:37.456] <TB0> INFO: TBM Core beta (1): 7 registers set
[14:26:37.456] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[14:26:37.456] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.456] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[14:26:37.857] <TB0> INFO: enter 'restricted' command line mode
[14:26:37.857] <TB0> INFO: enter test to run
[14:26:37.857] <TB0> INFO: test: pretest no parameter change
[14:26:37.857] <TB0> INFO: running: pretest
[14:26:37.861] <TB0> INFO: ######################################################################
[14:26:37.861] <TB0> INFO: PixTestPretest::doTest()
[14:26:37.861] <TB0> INFO: ######################################################################
[14:26:37.863] <TB0> INFO: ----------------------------------------------------------------------
[14:26:37.863] <TB0> INFO: PixTestPretest::programROC()
[14:26:37.863] <TB0> INFO: ----------------------------------------------------------------------
[14:26:55.879] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[14:26:55.880] <TB0> INFO: IA differences per ROC: 17.7 16.9 20.9 19.3 18.5 17.7 17.7 17.7 17.7 18.5 18.5 16.9 16.9 17.7 19.3 19.3
[14:26:55.943] <TB0> INFO: ----------------------------------------------------------------------
[14:26:55.943] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[14:26:55.943] <TB0> INFO: ----------------------------------------------------------------------
[14:27:15.507] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 382.7 mA = 23.9187 mA/ROC
[14:27:15.508] <TB0> INFO: ----------------------------------------------------------------------
[14:27:15.508] <TB0> INFO: PixTestPretest::findTiming()
[14:27:15.508] <TB0> INFO: ----------------------------------------------------------------------
[14:27:15.508] <TB0> INFO: PixTestCmd::init()

[14:29:03.378] <TB0> INFO: TBM phases: 160MHz: 0, 400MHz: 4, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[14:29:03.378] <TB0> INFO: (success/tries = 100/100), width = 4
[14:29:03.380] <TB0> INFO: ----------------------------------------------------------------------
[14:29:03.380] <TB0> INFO: PixTestPretest::findWorkingPixel()
[14:29:03.380] <TB0> INFO: ----------------------------------------------------------------------
[14:29:03.517] <TB0> INFO: Expecting 231680 events.
[14:29:12.644] <TB0> INFO: 231680 events read in total (8410ms).
[14:29:12.649] <TB0> INFO: Test took 9266ms.
[14:29:12.957] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[14:29:12.994] <TB0> INFO: ----------------------------------------------------------------------
[14:29:12.994] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[14:29:12.994] <TB0> INFO: ----------------------------------------------------------------------
[14:29:13.131] <TB0> INFO: Expecting 231680 events.
[14:29:22.630] <TB0> INFO: 231680 events read in total (8783ms).
[14:29:22.634] <TB0> INFO: Test took 9635ms.
[14:29:22.959] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[14:29:22.960] <TB0> INFO: CalDel: 127 143 138 143 159 155 142 131 157 166 154 140 118 141 125 127
[14:29:22.960] <TB0> INFO: VthrComp: 51 51 51 51 51 51 54 51 51 52 51 51 51 51 51 51
[14:29:22.963] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C0.dat
[14:29:22.964] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C1.dat
[14:29:22.964] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C2.dat
[14:29:22.964] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C3.dat
[14:29:22.964] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C4.dat
[14:29:22.965] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C5.dat
[14:29:22.965] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C6.dat
[14:29:22.965] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C7.dat
[14:29:22.965] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C8.dat
[14:29:22.966] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C9.dat
[14:29:22.966] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C10.dat
[14:29:22.966] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C11.dat
[14:29:22.966] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C12.dat
[14:29:22.966] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C13.dat
[14:29:22.967] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C14.dat
[14:29:22.967] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters_C15.dat
[14:29:22.967] <TB0> INFO: write tbm parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//tbmParameters_C0a.dat
[14:29:22.967] <TB0> INFO: write tbm parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//tbmParameters_C0b.dat
[14:29:22.967] <TB0> INFO: PixTestPretest::doTest() done, duration: 165 seconds
[14:29:23.035] <TB0> INFO: enter test to run
[14:29:23.035] <TB0> INFO: test: fulltest no parameter change
[14:29:23.035] <TB0> INFO: running: fulltest
[14:29:23.035] <TB0> INFO: ######################################################################
[14:29:23.035] <TB0> INFO: PixTestFullTest::doTest()
[14:29:23.035] <TB0> INFO: ######################################################################
[14:29:23.037] <TB0> INFO: ######################################################################
[14:29:23.037] <TB0> INFO: PixTestAlive::doTest()
[14:29:23.037] <TB0> INFO: ######################################################################
[14:29:23.038] <TB0> INFO: ----------------------------------------------------------------------
[14:29:23.038] <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)
[14:29:23.038] <TB0> INFO: ----------------------------------------------------------------------
[14:29:23.344] <TB0> INFO: Expecting 41600 events.
[14:29:28.428] <TB0> INFO: 41600 events read in total (4367ms).
[14:29:28.429] <TB0> INFO: Test took 5389ms.
[14:29:28.435] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:29:28.732] <TB0> INFO: PixTestAlive::aliveTest() done
[14:29:28.732] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1
[14:29:28.734] <TB0> INFO: ----------------------------------------------------------------------
[14:29:28.734] <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)
[14:29:28.734] <TB0> INFO: ----------------------------------------------------------------------
[14:29:29.077] <TB0> INFO: Expecting 41600 events.
[14:29:32.602] <TB0> INFO: 41600 events read in total (2809ms).
[14:29:32.602] <TB0> INFO: Test took 3866ms.
[14:29:32.602] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:29:32.603] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[14:29:32.918] <TB0> INFO: PixTestAlive::maskTest() done
[14:29:32.918] <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
[14:29:32.920] <TB0> INFO: ----------------------------------------------------------------------
[14:29:32.920] <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)
[14:29:32.920] <TB0> INFO: ----------------------------------------------------------------------
[14:29:33.246] <TB0> INFO: Expecting 41600 events.
[14:29:38.355] <TB0> INFO: 41600 events read in total (4392ms).
[14:29:38.356] <TB0> INFO: Test took 5434ms.
[14:29:38.363] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:29:38.650] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[14:29:38.650] <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
[14:29:38.650] <TB0> INFO: PixTestAlive::doTest() done, duration: 15 seconds
[14:29:38.650] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:29:38.650] <TB0> INFO: Decoding statistics:
[14:29:38.650] <TB0> INFO: General information:
[14:29:38.650] <TB0> INFO: 16bit words read: 0
[14:29:38.650] <TB0> INFO: valid events total: 0
[14:29:38.650] <TB0> INFO: empty events: 0
[14:29:38.650] <TB0> INFO: valid events with pixels: 0
[14:29:38.650] <TB0> INFO: valid pixel hits: 0
[14:29:38.650] <TB0> INFO: Event errors: 0
[14:29:38.650] <TB0> INFO: start marker: 0
[14:29:38.650] <TB0> INFO: stop marker: 0
[14:29:38.650] <TB0> INFO: overflow: 0
[14:29:38.650] <TB0> INFO: invalid 5bit words: 0
[14:29:38.651] <TB0> INFO: invalid XOR eye diagram: 0
[14:29:38.651] <TB0> INFO: TBM errors: 0
[14:29:38.651] <TB0> INFO: flawed TBM headers: 0
[14:29:38.651] <TB0> INFO: flawed TBM trailers: 0
[14:29:38.651] <TB0> INFO: event ID mismatches: 0
[14:29:38.651] <TB0> INFO: ROC errors: 0
[14:29:38.651] <TB0> INFO: missing ROC header(s): 0
[14:29:38.651] <TB0> INFO: misplaced readback start: 0
[14:29:38.651] <TB0> INFO: Pixel decoding errors: 0
[14:29:38.651] <TB0> INFO: pixel data incomplete: 0
[14:29:38.651] <TB0> INFO: pixel address: 0
[14:29:38.651] <TB0> INFO: pulse height fill bit: 0
[14:29:38.651] <TB0> INFO: buffer corruption: 0
[14:29:38.667] <TB0> INFO: ######################################################################
[14:29:38.667] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[14:29:38.667] <TB0> INFO: ######################################################################
[14:29:38.670] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[14:29:38.687] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[14:29:38.687] <TB0> INFO: run 1 of 1
[14:29:39.039] <TB0> INFO: Expecting 3120000 events.
[14:30:27.180] <TB0> INFO: 851305 events read in total (47425ms).
[14:31:11.472] <TB0> INFO: 1695275 events read in total (91718ms).
[14:31:54.653] <TB0> INFO: 2554090 events read in total (134899ms).
[14:32:22.444] <TB0> INFO: 3120000 events read in total (162689ms).
[14:32:22.499] <TB0> INFO: Test took 163812ms.
[14:32:22.601] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:46.722] <TB0> INFO: PixTestBBMap::doTest() done, duration: 188 seconds
[14:32:46.722] <TB0> INFO: number of dead bumps (per ROC): 5 0 0 0 0 0 0 0 0 0 0 2 1 0 2 2
[14:32:46.723] <TB0> INFO: separation cut (per ROC): 92 90 97 93 88 81 89 92 86 99 89 67 91 96 83 91
[14:32:46.723] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:32:46.723] <TB0> INFO: Decoding statistics:
[14:32:46.723] <TB0> INFO: General information:
[14:32:46.723] <TB0> INFO: 16bit words read: 0
[14:32:46.723] <TB0> INFO: valid events total: 0
[14:32:46.723] <TB0> INFO: empty events: 0
[14:32:46.723] <TB0> INFO: valid events with pixels: 0
[14:32:46.723] <TB0> INFO: valid pixel hits: 0
[14:32:46.723] <TB0> INFO: Event errors: 0
[14:32:46.723] <TB0> INFO: start marker: 0
[14:32:46.723] <TB0> INFO: stop marker: 0
[14:32:46.724] <TB0> INFO: overflow: 0
[14:32:46.724] <TB0> INFO: invalid 5bit words: 0
[14:32:46.724] <TB0> INFO: invalid XOR eye diagram: 0
[14:32:46.724] <TB0> INFO: TBM errors: 0
[14:32:46.724] <TB0> INFO: flawed TBM headers: 0
[14:32:46.724] <TB0> INFO: flawed TBM trailers: 0
[14:32:46.724] <TB0> INFO: event ID mismatches: 0
[14:32:46.724] <TB0> INFO: ROC errors: 0
[14:32:46.724] <TB0> INFO: missing ROC header(s): 0
[14:32:46.724] <TB0> INFO: misplaced readback start: 0
[14:32:46.724] <TB0> INFO: Pixel decoding errors: 0
[14:32:46.724] <TB0> INFO: pixel data incomplete: 0
[14:32:46.724] <TB0> INFO: pixel address: 0
[14:32:46.724] <TB0> INFO: pulse height fill bit: 0
[14:32:46.724] <TB0> INFO: buffer corruption: 0
[14:32:46.793] <TB0> INFO: ######################################################################
[14:32:46.793] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[14:32:46.793] <TB0> INFO: ######################################################################
[14:32:46.793] <TB0> INFO: ----------------------------------------------------------------------
[14:32:46.793] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[14:32:46.793] <TB0> INFO: ----------------------------------------------------------------------
[14:32:46.793] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[14:32:46.801] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[14:32:46.801] <TB0> INFO: run 1 of 1
[14:32:47.147] <TB0> INFO: Expecting 26208000 events.
[14:33:21.134] <TB0> INFO: 972750 events read in total (33271ms).
[14:33:56.977] <TB0> INFO: 1923750 events read in total (69114ms).
[14:34:32.352] <TB0> INFO: 2871450 events read in total (104489ms).
[14:35:07.860] <TB0> INFO: 3817750 events read in total (139997ms).
[14:35:43.639] <TB0> INFO: 4762000 events read in total (175776ms).
[14:36:18.592] <TB0> INFO: 5707050 events read in total (210729ms).
[14:36:53.658] <TB0> INFO: 6649850 events read in total (245795ms).
[14:37:28.961] <TB0> INFO: 7589750 events read in total (281098ms).
[14:38:05.149] <TB0> INFO: 8528650 events read in total (317286ms).
[14:38:40.789] <TB0> INFO: 9467950 events read in total (352926ms).
[14:39:16.085] <TB0> INFO: 10405200 events read in total (388222ms).
[14:39:50.159] <TB0> INFO: 11339600 events read in total (422296ms).
[14:40:25.745] <TB0> INFO: 12277200 events read in total (457882ms).
[14:41:00.329] <TB0> INFO: 13208450 events read in total (492466ms).
[14:41:34.975] <TB0> INFO: 14130700 events read in total (527112ms).
[14:42:09.832] <TB0> INFO: 15048300 events read in total (561969ms).
[14:42:44.414] <TB0> INFO: 15966600 events read in total (596551ms).
[14:43:20.127] <TB0> INFO: 16882750 events read in total (632264ms).
[14:43:56.160] <TB0> INFO: 17799900 events read in total (668297ms).
[14:44:31.537] <TB0> INFO: 18716400 events read in total (703674ms).
[14:45:05.780] <TB0> INFO: 19629350 events read in total (737917ms).
[14:45:41.079] <TB0> INFO: 20544400 events read in total (773216ms).
[14:46:15.795] <TB0> INFO: 21457750 events read in total (807932ms).
[14:46:51.125] <TB0> INFO: 22370950 events read in total (843262ms).
[14:47:26.312] <TB0> INFO: 23287450 events read in total (878449ms).
[14:48:01.649] <TB0> INFO: 24202200 events read in total (913786ms).
[14:48:34.919] <TB0> INFO: 25116000 events read in total (947056ms).
[14:49:08.005] <TB0> INFO: 26043550 events read in total (980142ms).
[14:49:14.527] <TB0> INFO: 26208000 events read in total (986664ms).
[14:49:14.555] <TB0> INFO: Test took 987754ms.
[14:49:14.632] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:49:14.769] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:16.232] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:17.609] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:18.968] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:20.588] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:21.943] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:23.322] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:24.731] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:26.354] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:27.889] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:29.547] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:31.035] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:32.548] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:33.983] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:35.499] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:37.038] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[14:49:38.535] <TB0> INFO: PixTestScurves::scurves() done
[14:49:38.535] <TB0> INFO: Vcal mean: 100.12 97.62 105.22 94.76 109.13 103.50 116.23 106.90 115.20 110.57 105.01 86.10 102.14 98.08 91.19 98.60
[14:49:38.535] <TB0> INFO: Vcal RMS: 5.54 6.07 5.90 6.29 5.83 5.71 6.10 5.58 6.41 5.37 5.47 4.60 6.12 5.88 5.57 5.75
[14:49:38.535] <TB0> INFO: PixTestScurves::fullTest() done, duration: 1011 seconds
[14:49:38.535] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:49:38.535] <TB0> INFO: Decoding statistics:
[14:49:38.535] <TB0> INFO: General information:
[14:49:38.535] <TB0> INFO: 16bit words read: 0
[14:49:38.535] <TB0> INFO: valid events total: 0
[14:49:38.535] <TB0> INFO: empty events: 0
[14:49:38.535] <TB0> INFO: valid events with pixels: 0
[14:49:38.535] <TB0> INFO: valid pixel hits: 0
[14:49:38.535] <TB0> INFO: Event errors: 0
[14:49:38.535] <TB0> INFO: start marker: 0
[14:49:38.535] <TB0> INFO: stop marker: 0
[14:49:38.535] <TB0> INFO: overflow: 0
[14:49:38.535] <TB0> INFO: invalid 5bit words: 0
[14:49:38.535] <TB0> INFO: invalid XOR eye diagram: 0
[14:49:38.535] <TB0> INFO: TBM errors: 0
[14:49:38.535] <TB0> INFO: flawed TBM headers: 0
[14:49:38.535] <TB0> INFO: flawed TBM trailers: 0
[14:49:38.535] <TB0> INFO: event ID mismatches: 0
[14:49:38.535] <TB0> INFO: ROC errors: 0
[14:49:38.535] <TB0> INFO: missing ROC header(s): 0
[14:49:38.535] <TB0> INFO: misplaced readback start: 0
[14:49:38.535] <TB0> INFO: Pixel decoding errors: 0
[14:49:38.535] <TB0> INFO: pixel data incomplete: 0
[14:49:38.535] <TB0> INFO: pixel address: 0
[14:49:38.535] <TB0> INFO: pulse height fill bit: 0
[14:49:38.535] <TB0> INFO: buffer corruption: 0
[14:49:38.620] <TB0> INFO: ######################################################################
[14:49:38.620] <TB0> INFO: PixTestTrim::doTest()
[14:49:38.620] <TB0> INFO: ######################################################################
[14:49:38.621] <TB0> INFO: ----------------------------------------------------------------------
[14:49:38.621] <TB0> INFO: PixTestTrim::trimTest() ntrig = 8, vcal = 35
[14:49:38.621] <TB0> INFO: ----------------------------------------------------------------------
[14:49:38.723] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[14:49:38.723] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[14:49:38.734] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[14:49:38.734] <TB0> INFO: run 1 of 1
[14:49:39.037] <TB0> INFO: Expecting 5025280 events.
[14:50:21.720] <TB0> INFO: 1096480 events read in total (41965ms).
[14:51:04.020] <TB0> INFO: 2185248 events read in total (84265ms).
[14:51:47.702] <TB0> INFO: 3275632 events read in total (127948ms).
[14:52:29.945] <TB0> INFO: 4371440 events read in total (170190ms).
[14:52:55.451] <TB0> INFO: 5025280 events read in total (195696ms).
[14:52:55.479] <TB0> INFO: Test took 196745ms.
[14:52:55.526] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:53:15.750] <TB0> INFO: ROC 0 VthrComp = 100
[14:53:15.750] <TB0> INFO: ROC 1 VthrComp = 94
[14:53:15.750] <TB0> INFO: ROC 2 VthrComp = 103
[14:53:15.750] <TB0> INFO: ROC 3 VthrComp = 91
[14:53:15.750] <TB0> INFO: ROC 4 VthrComp = 94
[14:53:15.751] <TB0> INFO: ROC 5 VthrComp = 94
[14:53:15.751] <TB0> INFO: ROC 6 VthrComp = 103
[14:53:15.751] <TB0> INFO: ROC 7 VthrComp = 98
[14:53:15.751] <TB0> INFO: ROC 8 VthrComp = 97
[14:53:15.751] <TB0> INFO: ROC 9 VthrComp = 105
[14:53:15.751] <TB0> INFO: ROC 10 VthrComp = 100
[14:53:15.751] <TB0> INFO: ROC 11 VthrComp = 85
[14:53:15.751] <TB0> INFO: ROC 12 VthrComp = 99
[14:53:15.751] <TB0> INFO: ROC 13 VthrComp = 96
[14:53:15.751] <TB0> INFO: ROC 14 VthrComp = 91
[14:53:15.752] <TB0> INFO: ROC 15 VthrComp = 100
[14:53:15.752] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[14:53:15.752] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[14:53:15.761] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[14:53:15.761] <TB0> INFO: run 1 of 1
[14:53:16.065] <TB0> INFO: Expecting 5025280 events.
[14:53:50.934] <TB0> INFO: 762024 events read in total (34153ms).
[14:54:28.499] <TB0> INFO: 1522048 events read in total (71718ms).
[14:55:06.444] <TB0> INFO: 2281976 events read in total (109663ms).
[14:55:44.212] <TB0> INFO: 3036504 events read in total (147431ms).
[14:56:22.019] <TB0> INFO: 3785400 events read in total (185238ms).
[14:57:00.164] <TB0> INFO: 4532232 events read in total (223383ms).
[14:57:23.461] <TB0> INFO: 5025280 events read in total (246680ms).
[14:57:23.515] <TB0> INFO: Test took 247754ms.
[14:57:23.649] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:57:47.613] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 58.5987 for pixel 50/77 mean/min/max = 45.3147/31.913/58.7165
[14:57:47.613] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 62.1401 for pixel 21/76 mean/min/max = 47.0344/31.8744/62.1944
[14:57:47.614] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 60.7866 for pixel 51/75 mean/min/max = 46.6398/32.3849/60.8948
[14:57:47.614] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 62.1301 for pixel 1/4 mean/min/max = 47.2197/32.0881/62.3513
[14:57:47.614] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 68.2871 for pixel 18/53 mean/min/max = 51.0622/33.7625/68.362
[14:57:47.614] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 63.9487 for pixel 0/1 mean/min/max = 48.5934/33.1604/64.0263
[14:57:47.625] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 67.2847 for pixel 9/3 mean/min/max = 50.7529/33.971/67.5347
[14:57:47.625] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 62.047 for pixel 5/79 mean/min/max = 47.1594/32.2611/62.0577
[14:57:47.625] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 71.6669 for pixel 0/75 mean/min/max = 52.704/33.7318/71.6762
[14:57:47.626] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 61.7464 for pixel 21/6 mean/min/max = 47.9785/34.1509/61.806
[14:57:47.626] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 62.2719 for pixel 15/0 mean/min/max = 47.5524/32.787/62.3177
[14:57:47.626] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 57.3402 for pixel 11/11 mean/min/max = 45.2758/33.0263/57.5252
[14:57:47.626] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 61.1935 for pixel 9/10 mean/min/max = 46.3839/31.3031/61.4647
[14:57:47.627] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 62.3321 for pixel 0/61 mean/min/max = 47.2624/31.9655/62.5594
[14:57:47.627] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 59.0535 for pixel 22/2 mean/min/max = 45.8624/32.5501/59.1747
[14:57:47.627] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 59.3428 for pixel 19/68 mean/min/max = 45.5549/31.5196/59.5902
[14:57:47.628] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:57:47.758] <TB0> INFO: Expecting 411648 events.
[14:57:57.525] <TB0> INFO: 411648 events read in total (9048ms).
[14:57:57.531] <TB0> INFO: Expecting 411648 events.
[14:58:07.631] <TB0> INFO: 411648 events read in total (9522ms).
[14:58:07.638] <TB0> INFO: Expecting 411648 events.
[14:58:18.936] <TB0> INFO: 411648 events read in total (10720ms).
[14:58:18.947] <TB0> INFO: Expecting 411648 events.
[14:58:30.112] <TB0> INFO: 411648 events read in total (10587ms).
[14:58:30.122] <TB0> INFO: Expecting 411648 events.
[14:58:41.307] <TB0> INFO: 411648 events read in total (10607ms).
[14:58:41.320] <TB0> INFO: Expecting 411648 events.
[14:58:52.649] <TB0> INFO: 411648 events read in total (10753ms).
[14:58:52.664] <TB0> INFO: Expecting 411648 events.
[14:59:04.001] <TB0> INFO: 411648 events read in total (10765ms).
[14:59:04.016] <TB0> INFO: Expecting 411648 events.
[14:59:15.128] <TB0> INFO: 411648 events read in total (10538ms).
[14:59:15.144] <TB0> INFO: Expecting 411648 events.
[14:59:26.266] <TB0> INFO: 411648 events read in total (10553ms).
[14:59:26.285] <TB0> INFO: Expecting 411648 events.
[14:59:37.602] <TB0> INFO: 411648 events read in total (10745ms).
[14:59:37.624] <TB0> INFO: Expecting 411648 events.
[14:59:48.913] <TB0> INFO: 411648 events read in total (10731ms).
[14:59:48.936] <TB0> INFO: Expecting 411648 events.
[14:59:59.957] <TB0> INFO: 411648 events read in total (10452ms).
[14:59:59.987] <TB0> INFO: Expecting 411648 events.
[15:00:11.644] <TB0> INFO: 411648 events read in total (11108ms).
[15:00:11.670] <TB0> INFO: Expecting 411648 events.
[15:00:22.735] <TB0> INFO: 411648 events read in total (10499ms).
[15:00:22.763] <TB0> INFO: Expecting 411648 events.
[15:00:34.073] <TB0> INFO: 411648 events read in total (10754ms).
[15:00:34.107] <TB0> INFO: Expecting 411648 events.
[15:00:45.273] <TB0> INFO: 411648 events read in total (10608ms).
[15:00:45.305] <TB0> INFO: Test took 177677ms.
[15:00:46.166] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 8 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[15:00:46.175] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[15:00:46.175] <TB0> INFO: run 1 of 1
[15:00:46.478] <TB0> INFO: Expecting 5025280 events.
[15:01:22.234] <TB0> INFO: 742920 events read in total (35040ms).
[15:01:57.770] <TB0> INFO: 1485304 events read in total (70576ms).
[15:02:32.143] <TB0> INFO: 2227216 events read in total (104949ms).
[15:03:09.363] <TB0> INFO: 2963936 events read in total (142169ms).
[15:03:46.210] <TB0> INFO: 3694320 events read in total (179016ms).
[15:04:21.789] <TB0> INFO: 4422040 events read in total (214595ms).
[15:04:51.551] <TB0> INFO: 5025280 events read in total (244357ms).
[15:04:51.598] <TB0> INFO: Test took 245423ms.
[15:04:51.736] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:05:16.771] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.049648 .. 255.000000
[15:05:16.847] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 8 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[15:05:16.857] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[15:05:16.859] <TB0> INFO: run 1 of 1
[15:05:17.167] <TB0> INFO: Expecting 8519680 events.
[15:05:51.440] <TB0> INFO: 712248 events read in total (33556ms).
[15:06:28.344] <TB0> INFO: 1424920 events read in total (70460ms).
[15:07:04.800] <TB0> INFO: 2137592 events read in total (106916ms).
[15:07:42.215] <TB0> INFO: 2850304 events read in total (144331ms).
[15:08:18.920] <TB0> INFO: 3563128 events read in total (181036ms).
[15:08:57.461] <TB0> INFO: 4275816 events read in total (219577ms).
[15:09:34.759] <TB0> INFO: 4988656 events read in total (256875ms).
[15:10:12.480] <TB0> INFO: 5700736 events read in total (294596ms).
[15:10:49.910] <TB0> INFO: 6412344 events read in total (332026ms).
[15:11:26.405] <TB0> INFO: 7123432 events read in total (368521ms).
[15:11:59.878] <TB0> INFO: 7834264 events read in total (401994ms).
[15:12:35.020] <TB0> INFO: 8519680 events read in total (437136ms).
[15:12:35.098] <TB0> INFO: Test took 438239ms.
[15:12:35.358] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:13:03.872] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 15.015356 .. 47.361589
[15:13:03.947] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 8 dacrange: 5 .. 57 (-1/-1) hits flags = 528 (plus default)
[15:13:03.956] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[15:13:03.956] <TB0> INFO: run 1 of 1
[15:13:04.258] <TB0> INFO: Expecting 1763840 events.
[15:13:44.083] <TB0> INFO: 923472 events read in total (39109ms).
[15:14:20.222] <TB0> INFO: 1763840 events read in total (75248ms).
[15:14:20.237] <TB0> INFO: Test took 76281ms.
[15:14:20.268] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:14:34.571] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 1.500000 .. 45.212366
[15:14:34.647] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 8 dacrange: 1 .. 55 (-1/-1) hits flags = 528 (plus default)
[15:14:34.656] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[15:14:34.656] <TB0> INFO: run 1 of 1
[15:14:34.959] <TB0> INFO: Expecting 1830400 events.
[15:15:14.178] <TB0> INFO: 960720 events read in total (38503ms).
[15:15:52.273] <TB0> INFO: 1830400 events read in total (76598ms).
[15:15:52.285] <TB0> INFO: Test took 77629ms.
[15:15:52.313] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:16:06.395] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 7.500000 .. 44.319509
[15:16:06.471] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 8 dacrange: 7 .. 54 (-1/-1) hits flags = 528 (plus default)
[15:16:06.479] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[15:16:06.480] <TB0> INFO: run 1 of 1
[15:16:06.786] <TB0> INFO: Expecting 1597440 events.
[15:16:48.430] <TB0> INFO: 937272 events read in total (40928ms).
[15:17:15.846] <TB0> INFO: 1597440 events read in total (68344ms).
[15:17:15.857] <TB0> INFO: Test took 69377ms.
[15:17:15.884] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:17:30.071] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[15:17:30.071] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 8 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[15:17:30.080] <TB0> INFO: dacScan split into 1 runs with ntrig = 8
[15:17:30.080] <TB0> INFO: run 1 of 1
[15:17:30.386] <TB0> INFO: Expecting 1364480 events.
[15:18:10.997] <TB0> INFO: 878392 events read in total (39895ms).
[15:18:32.828] <TB0> INFO: 1364480 events read in total (61726ms).
[15:18:32.841] <TB0> INFO: Test took 62761ms.
[15:18:32.869] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:18:47.972] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C0.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C1.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C2.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C3.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C4.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C5.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C6.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C7.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C8.dat
[15:18:47.973] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C9.dat
[15:18:47.974] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C10.dat
[15:18:47.974] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C11.dat
[15:18:47.974] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C12.dat
[15:18:47.974] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C13.dat
[15:18:47.974] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C14.dat
[15:18:47.974] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C15.dat
[15:18:47.974] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C0.dat
[15:18:47.981] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C1.dat
[15:18:47.986] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C2.dat
[15:18:47.992] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C3.dat
[15:18:47.998] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C4.dat
[15:18:48.005] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C5.dat
[15:18:48.011] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C6.dat
[15:18:48.017] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C7.dat
[15:18:48.023] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C8.dat
[15:18:48.028] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C9.dat
[15:18:48.034] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C10.dat
[15:18:48.040] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C11.dat
[15:18:48.046] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C12.dat
[15:18:48.052] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C13.dat
[15:18:48.058] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C14.dat
[15:18:48.064] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//trimParameters35_C15.dat
[15:18:48.070] <TB0> INFO: PixTestTrim::trimTest() done
[15:18:48.070] <TB0> INFO: vtrim: 97 117 91 109 110 105 119 96 109 112 103 93 108 113 101 103
[15:18:48.070] <TB0> INFO: vthrcomp: 100 94 103 91 94 94 103 98 97 105 100 85 99 96 91 100
[15:18:48.070] <TB0> INFO: vcal mean: 34.94 34.90 35.06 35.02 35.03 34.98 34.97 34.98 34.96 35.02 34.98 34.94 35.01 34.97 35.01 34.96
[15:18:48.070] <TB0> INFO: vcal RMS: 0.93 1.10 0.97 0.94 1.07 0.99 1.08 1.14 1.15 0.94 0.96 0.91 0.97 1.00 1.02 1.16
[15:18:48.070] <TB0> INFO: bits mean: 9.49 9.47 8.23 9.29 8.53 8.82 9.01 9.02 7.99 8.93 9.31 9.78 9.61 9.34 9.58 9.88
[15:18:48.070] <TB0> INFO: bits RMS: 2.71 2.60 3.09 2.66 2.56 2.65 2.31 2.73 2.66 2.47 2.57 2.46 2.68 2.70 2.60 2.58
[15:18:48.077] <TB0> INFO: ----------------------------------------------------------------------
[15:18:48.077] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[15:18:48.077] <TB0> INFO: ----------------------------------------------------------------------
[15:18:48.080] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[15:18:48.090] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[15:18:48.090] <TB0> INFO: run 1 of 1
[15:18:48.395] <TB0> INFO: Expecting 4160000 events.
[15:19:31.223] <TB0> INFO: 979785 events read in total (42112ms).
[15:20:17.508] <TB0> INFO: 1948380 events read in total (88397ms).
[15:21:01.083] <TB0> INFO: 2903935 events read in total (131972ms).
[15:21:44.686] <TB0> INFO: 3856780 events read in total (175575ms).
[15:22:00.609] <TB0> INFO: 4160000 events read in total (191498ms).
[15:22:00.650] <TB0> INFO: Test took 192561ms.
[15:22:00.736] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:22:30.772] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 195 (-1/-1) hits flags = 528 (plus default)
[15:22:30.781] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[15:22:30.781] <TB0> INFO: run 1 of 1
[15:22:31.122] <TB0> INFO: Expecting 4076800 events.
[15:23:17.395] <TB0> INFO: 949990 events read in total (45556ms).
[15:24:02.789] <TB0> INFO: 1890235 events read in total (90950ms).
[15:24:44.035] <TB0> INFO: 2818840 events read in total (132196ms).
[15:25:26.164] <TB0> INFO: 3744545 events read in total (174325ms).
[15:25:42.943] <TB0> INFO: 4076800 events read in total (191104ms).
[15:25:42.981] <TB0> INFO: Test took 192199ms.
[15:25:43.073] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:26:10.708] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 181 (-1/-1) hits flags = 528 (plus default)
[15:26:10.718] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[15:26:10.718] <TB0> INFO: run 1 of 1
[15:26:11.052] <TB0> INFO: Expecting 3785600 events.
[15:26:58.897] <TB0> INFO: 981795 events read in total (47129ms).
[15:27:41.263] <TB0> INFO: 1951375 events read in total (89495ms).
[15:28:23.891] <TB0> INFO: 2907690 events read in total (132123ms).
[15:29:08.236] <TB0> INFO: 3785600 events read in total (176469ms).
[15:29:08.277] <TB0> INFO: Test took 177559ms.
[15:29:08.364] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:29:35.048] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 181 (-1/-1) hits flags = 528 (plus default)
[15:29:35.058] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[15:29:35.058] <TB0> INFO: run 1 of 1
[15:29:35.360] <TB0> INFO: Expecting 3785600 events.
[15:30:25.274] <TB0> INFO: 981540 events read in total (49198ms).
[15:31:07.721] <TB0> INFO: 1950530 events read in total (91645ms).
[15:31:50.725] <TB0> INFO: 2906340 events read in total (134649ms).
[15:32:29.627] <TB0> INFO: 3785600 events read in total (173551ms).
[15:32:29.670] <TB0> INFO: Test took 174612ms.
[15:32:29.752] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:32:55.827] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 180 (-1/-1) hits flags = 528 (plus default)
[15:32:55.837] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[15:32:55.837] <TB0> INFO: run 1 of 1
[15:32:56.139] <TB0> INFO: Expecting 3764800 events.
[15:33:38.553] <TB0> INFO: 983505 events read in total (41698ms).
[15:34:23.606] <TB0> INFO: 1954580 events read in total (86751ms).
[15:35:09.879] <TB0> INFO: 2912165 events read in total (133024ms).
[15:35:49.778] <TB0> INFO: 3764800 events read in total (172923ms).
[15:35:49.813] <TB0> INFO: Test took 173976ms.
[15:35:49.889] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:15.848] <TB0> INFO: PixTestTrim::trimBitTest() done
[15:36:15.850] <TB0> INFO: PixTestTrim::doTest() done, duration: 2797 seconds
[15:36:15.850] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:15.850] <TB0> INFO: Decoding statistics:
[15:36:15.850] <TB0> INFO: General information:
[15:36:15.850] <TB0> INFO: 16bit words read: 0
[15:36:15.850] <TB0> INFO: valid events total: 0
[15:36:15.850] <TB0> INFO: empty events: 0
[15:36:15.850] <TB0> INFO: valid events with pixels: 0
[15:36:15.850] <TB0> INFO: valid pixel hits: 0
[15:36:15.850] <TB0> INFO: Event errors: 0
[15:36:15.850] <TB0> INFO: start marker: 0
[15:36:15.850] <TB0> INFO: stop marker: 0
[15:36:15.850] <TB0> INFO: overflow: 0
[15:36:15.850] <TB0> INFO: invalid 5bit words: 0
[15:36:15.850] <TB0> INFO: invalid XOR eye diagram: 0
[15:36:15.850] <TB0> INFO: TBM errors: 0
[15:36:15.850] <TB0> INFO: flawed TBM headers: 0
[15:36:15.850] <TB0> INFO: flawed TBM trailers: 0
[15:36:15.850] <TB0> INFO: event ID mismatches: 0
[15:36:15.850] <TB0> INFO: ROC errors: 0
[15:36:15.850] <TB0> INFO: missing ROC header(s): 0
[15:36:15.850] <TB0> INFO: misplaced readback start: 0
[15:36:15.850] <TB0> INFO: Pixel decoding errors: 0
[15:36:15.850] <TB0> INFO: pixel data incomplete: 0
[15:36:15.850] <TB0> INFO: pixel address: 0
[15:36:15.850] <TB0> INFO: pulse height fill bit: 0
[15:36:15.850] <TB0> INFO: buffer corruption: 0
[15:36:16.552] <TB0> INFO: ######################################################################
[15:36:16.552] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[15:36:16.552] <TB0> INFO: ######################################################################
[15:36:16.856] <TB0> INFO: Expecting 41600 events.
[15:36:21.918] <TB0> INFO: 41600 events read in total (4346ms).
[15:36:21.919] <TB0> INFO: Test took 5366ms.
[15:36:21.926] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:22.488] <TB0> INFO: Expecting 41600 events.
[15:36:27.284] <TB0> INFO: 41600 events read in total (4080ms).
[15:36:27.284] <TB0> INFO: Test took 5101ms.
[15:36:27.292] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:27.638] <TB0> INFO: Expecting 41600 events.
[15:36:32.314] <TB0> INFO: 41600 events read in total (3960ms).
[15:36:32.315] <TB0> INFO: Test took 5010ms.
[15:36:32.322] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:36:32.663] <TB0> INFO: Expecting 2560 events.
[15:36:33.725] <TB0> INFO: 2560 events read in total (346ms).
[15:36:33.726] <TB0> INFO: Test took 1396ms.
[15:36:34.140] <TB0> INFO: Expecting 2560 events.
[15:36:35.200] <TB0> INFO: 2560 events read in total (344ms).
[15:36:35.200] <TB0> INFO: Test took 1473ms.
[15:36:35.615] <TB0> INFO: Expecting 2560 events.
[15:36:36.675] <TB0> INFO: 2560 events read in total (344ms).
[15:36:36.675] <TB0> INFO: Test took 1474ms.
[15:36:37.090] <TB0> INFO: Expecting 2560 events.
[15:36:38.165] <TB0> INFO: 2560 events read in total (359ms).
[15:36:38.167] <TB0> INFO: Test took 1489ms.
[15:36:38.579] <TB0> INFO: Expecting 2560 events.
[15:36:39.639] <TB0> INFO: 2560 events read in total (344ms).
[15:36:39.639] <TB0> INFO: Test took 1472ms.
[15:36:40.054] <TB0> INFO: Expecting 2560 events.
[15:36:41.114] <TB0> INFO: 2560 events read in total (344ms).
[15:36:41.114] <TB0> INFO: Test took 1474ms.
[15:36:41.529] <TB0> INFO: Expecting 2560 events.
[15:36:42.589] <TB0> INFO: 2560 events read in total (344ms).
[15:36:42.589] <TB0> INFO: Test took 1474ms.
[15:36:43.004] <TB0> INFO: Expecting 2560 events.
[15:36:44.067] <TB0> INFO: 2560 events read in total (347ms).
[15:36:44.067] <TB0> INFO: Test took 1478ms.
[15:36:44.482] <TB0> INFO: Expecting 2560 events.
[15:36:45.542] <TB0> INFO: 2560 events read in total (344ms).
[15:36:45.542] <TB0> INFO: Test took 1475ms.
[15:36:45.957] <TB0> INFO: Expecting 2560 events.
[15:36:47.032] <TB0> INFO: 2560 events read in total (359ms).
[15:36:47.032] <TB0> INFO: Test took 1489ms.
[15:36:47.447] <TB0> INFO: Expecting 2560 events.
[15:36:48.507] <TB0> INFO: 2560 events read in total (344ms).
[15:36:48.508] <TB0> INFO: Test took 1476ms.
[15:36:48.922] <TB0> INFO: Expecting 2560 events.
[15:36:49.983] <TB0> INFO: 2560 events read in total (345ms).
[15:36:49.983] <TB0> INFO: Test took 1475ms.
[15:36:50.397] <TB0> INFO: Expecting 2560 events.
[15:36:51.475] <TB0> INFO: 2560 events read in total (362ms).
[15:36:51.476] <TB0> INFO: Test took 1493ms.
[15:36:51.890] <TB0> INFO: Expecting 2560 events.
[15:36:52.952] <TB0> INFO: 2560 events read in total (346ms).
[15:36:52.952] <TB0> INFO: Test took 1476ms.
[15:36:53.366] <TB0> INFO: Expecting 2560 events.
[15:36:54.428] <TB0> INFO: 2560 events read in total (346ms).
[15:36:54.429] <TB0> INFO: Test took 1477ms.
[15:36:54.843] <TB0> INFO: Expecting 2560 events.
[15:36:55.907] <TB0> INFO: 2560 events read in total (348ms).
[15:36:55.907] <TB0> INFO: Test took 1478ms.
[15:36:55.910] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:36:56.324] <TB0> INFO: Expecting 655360 events.
[15:37:13.076] <TB0> INFO: 655360 events read in total (16036ms).
[15:37:13.088] <TB0> INFO: Expecting 655360 events.
[15:37:29.749] <TB0> INFO: 655360 events read in total (16133ms).
[15:37:29.764] <TB0> INFO: Expecting 655360 events.
[15:37:47.747] <TB0> INFO: 655360 events read in total (17455ms).
[15:37:47.768] <TB0> INFO: Expecting 655360 events.
[15:38:05.950] <TB0> INFO: 655360 events read in total (17654ms).
[15:38:05.979] <TB0> INFO: Expecting 655360 events.
[15:38:24.675] <TB0> INFO: 655360 events read in total (18169ms).
[15:38:24.708] <TB0> INFO: Expecting 655360 events.
[15:38:43.594] <TB0> INFO: 655360 events read in total (18358ms).
[15:38:43.626] <TB0> INFO: Expecting 655360 events.
[15:39:02.451] <TB0> INFO: 655360 events read in total (18297ms).
[15:39:02.488] <TB0> INFO: Expecting 655360 events.
[15:39:20.777] <TB0> INFO: 655360 events read in total (17761ms).
[15:39:20.812] <TB0> INFO: Expecting 655360 events.
[15:39:38.776] <TB0> INFO: 655360 events read in total (17436ms).
[15:39:38.821] <TB0> INFO: Expecting 655360 events.
[15:39:57.609] <TB0> INFO: 655360 events read in total (18260ms).
[15:39:57.651] <TB0> INFO: Expecting 655360 events.
[15:40:16.392] <TB0> INFO: 655360 events read in total (18213ms).
[15:40:16.441] <TB0> INFO: Expecting 655360 events.
[15:40:34.799] <TB0> INFO: 655360 events read in total (17830ms).
[15:40:34.857] <TB0> INFO: Expecting 655360 events.
[15:40:53.460] <TB0> INFO: 655360 events read in total (18075ms).
[15:40:53.511] <TB0> INFO: Expecting 655360 events.
[15:41:11.890] <TB0> INFO: 655360 events read in total (17852ms).
[15:41:11.949] <TB0> INFO: Expecting 655360 events.
[15:41:30.838] <TB0> INFO: 655360 events read in total (18362ms).
[15:41:30.930] <TB0> INFO: Expecting 655360 events.
[15:41:49.673] <TB0> INFO: 655360 events read in total (18216ms).
[15:41:49.760] <TB0> INFO: Test took 293850ms.
[15:41:49.858] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:41:50.164] <TB0> INFO: Expecting 655360 events.
[15:42:08.803] <TB0> INFO: 655360 events read in total (17923ms).
[15:42:08.813] <TB0> INFO: Expecting 655360 events.
[15:42:27.047] <TB0> INFO: 655360 events read in total (17707ms).
[15:42:27.060] <TB0> INFO: Expecting 655360 events.
[15:42:45.621] <TB0> INFO: 655360 events read in total (18033ms).
[15:42:45.638] <TB0> INFO: Expecting 655360 events.
[15:43:04.250] <TB0> INFO: 655360 events read in total (18084ms).
[15:43:04.275] <TB0> INFO: Expecting 655360 events.
[15:43:22.995] <TB0> INFO: 655360 events read in total (18193ms).
[15:43:23.030] <TB0> INFO: Expecting 655360 events.
[15:43:41.443] <TB0> INFO: 655360 events read in total (17886ms).
[15:43:41.480] <TB0> INFO: Expecting 655360 events.
[15:43:59.328] <TB0> INFO: 655360 events read in total (17320ms).
[15:43:59.363] <TB0> INFO: Expecting 655360 events.
[15:44:17.529] <TB0> INFO: 655360 events read in total (17639ms).
[15:44:17.564] <TB0> INFO: Expecting 655360 events.
[15:44:35.495] <TB0> INFO: 655360 events read in total (17404ms).
[15:44:35.546] <TB0> INFO: Expecting 655360 events.
[15:44:53.713] <TB0> INFO: 655360 events read in total (17640ms).
[15:44:53.769] <TB0> INFO: Expecting 655360 events.
[15:45:11.888] <TB0> INFO: 655360 events read in total (17591ms).
[15:45:11.931] <TB0> INFO: Expecting 655360 events.
[15:45:30.325] <TB0> INFO: 655360 events read in total (17867ms).
[15:45:30.377] <TB0> INFO: Expecting 655360 events.
[15:45:48.713] <TB0> INFO: 655360 events read in total (17808ms).
[15:45:48.764] <TB0> INFO: Expecting 655360 events.
[15:46:07.028] <TB0> INFO: 655360 events read in total (17737ms).
[15:46:07.087] <TB0> INFO: Expecting 655360 events.
[15:46:25.854] <TB0> INFO: 655360 events read in total (18239ms).
[15:46:25.914] <TB0> INFO: Expecting 655360 events.
[15:46:44.399] <TB0> INFO: 655360 events read in total (17957ms).
[15:46:44.485] <TB0> INFO: Test took 294627ms.
[15:46:44.707] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.716] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.726] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.736] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.745] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.755] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.764] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.774] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.783] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.793] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.803] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.812] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.814] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[15:46:44.823] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.825] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[15:46:44.834] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.836] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[15:46:44.845] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.847] <TB0> INFO: safety margin for low PH: adding 4, margin is now 24
[15:46:44.856] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.858] <TB0> INFO: safety margin for low PH: adding 5, margin is now 25
[15:46:44.867] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.869] <TB0> INFO: safety margin for low PH: adding 6, margin is now 26
[15:46:44.878] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.880] <TB0> INFO: safety margin for low PH: adding 7, margin is now 27
[15:46:44.889] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.891] <TB0> INFO: safety margin for low PH: adding 8, margin is now 28
[15:46:44.898] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.899] <TB0> INFO: safety margin for low PH: adding 9, margin is now 29
[15:46:44.908] <TB0> INFO: For ROC 10: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.910] <TB0> INFO: safety margin for low PH: adding 10, margin is now 30
[15:46:44.919] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.929] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.939] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.947] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.956] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[15:46:44.963] <TB0> INFO: For ROC 15: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[15:46:44.964] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[15:46:45.013] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C0.dat
[15:46:45.014] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C1.dat
[15:46:45.014] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C2.dat
[15:46:45.014] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C3.dat
[15:46:45.014] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C4.dat
[15:46:45.015] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C5.dat
[15:46:45.015] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C6.dat
[15:46:45.015] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C7.dat
[15:46:45.015] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C8.dat
[15:46:45.015] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C9.dat
[15:46:45.016] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C10.dat
[15:46:45.016] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C11.dat
[15:46:45.016] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C12.dat
[15:46:45.016] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C13.dat
[15:46:45.016] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C14.dat
[15:46:45.017] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//dacParameters35_C15.dat
[15:46:45.331] <TB0> INFO: Expecting 41600 events.
[15:46:49.809] <TB0> INFO: 41600 events read in total (3762ms).
[15:46:49.810] <TB0> INFO: Test took 4790ms.
[15:46:50.369] <TB0> INFO: Expecting 41600 events.
[15:46:55.095] <TB0> INFO: 41600 events read in total (4010ms).
[15:46:55.096] <TB0> INFO: Test took 5051ms.
[15:46:55.697] <TB0> INFO: Expecting 41600 events.
[15:47:00.357] <TB0> INFO: 41600 events read in total (3943ms).
[15:47:00.358] <TB0> INFO: Test took 5019ms.
[15:47:00.595] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:00.726] <TB0> INFO: Expecting 2560 events.
[15:47:01.794] <TB0> INFO: 2560 events read in total (351ms).
[15:47:01.794] <TB0> INFO: Test took 1199ms.
[15:47:01.798] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:02.210] <TB0> INFO: Expecting 2560 events.
[15:47:03.280] <TB0> INFO: 2560 events read in total (354ms).
[15:47:03.281] <TB0> INFO: Test took 1483ms.
[15:47:03.283] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:03.696] <TB0> INFO: Expecting 2560 events.
[15:47:04.765] <TB0> INFO: 2560 events read in total (352ms).
[15:47:04.765] <TB0> INFO: Test took 1482ms.
[15:47:04.768] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:05.181] <TB0> INFO: Expecting 2560 events.
[15:47:06.264] <TB0> INFO: 2560 events read in total (367ms).
[15:47:06.264] <TB0> INFO: Test took 1496ms.
[15:47:06.266] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:06.680] <TB0> INFO: Expecting 2560 events.
[15:47:07.776] <TB0> INFO: 2560 events read in total (380ms).
[15:47:07.776] <TB0> INFO: Test took 1510ms.
[15:47:07.780] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:08.191] <TB0> INFO: Expecting 2560 events.
[15:47:09.274] <TB0> INFO: 2560 events read in total (367ms).
[15:47:09.275] <TB0> INFO: Test took 1495ms.
[15:47:09.277] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:09.690] <TB0> INFO: Expecting 2560 events.
[15:47:10.760] <TB0> INFO: 2560 events read in total (353ms).
[15:47:10.761] <TB0> INFO: Test took 1484ms.
[15:47:10.763] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:11.176] <TB0> INFO: Expecting 2560 events.
[15:47:12.244] <TB0> INFO: 2560 events read in total (352ms).
[15:47:12.245] <TB0> INFO: Test took 1482ms.
[15:47:12.248] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:12.660] <TB0> INFO: Expecting 2560 events.
[15:47:13.739] <TB0> INFO: 2560 events read in total (362ms).
[15:47:13.739] <TB0> INFO: Test took 1492ms.
[15:47:13.741] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:14.156] <TB0> INFO: Expecting 2560 events.
[15:47:15.225] <TB0> INFO: 2560 events read in total (352ms).
[15:47:15.225] <TB0> INFO: Test took 1484ms.
[15:47:15.227] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:15.641] <TB0> INFO: Expecting 2560 events.
[15:47:16.710] <TB0> INFO: 2560 events read in total (353ms).
[15:47:16.710] <TB0> INFO: Test took 1483ms.
[15:47:16.712] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:17.126] <TB0> INFO: Expecting 2560 events.
[15:47:18.207] <TB0> INFO: 2560 events read in total (365ms).
[15:47:18.207] <TB0> INFO: Test took 1495ms.
[15:47:18.210] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:18.622] <TB0> INFO: Expecting 2560 events.
[15:47:19.704] <TB0> INFO: 2560 events read in total (366ms).
[15:47:19.705] <TB0> INFO: Test took 1495ms.
[15:47:19.707] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:20.120] <TB0> INFO: Expecting 2560 events.
[15:47:21.189] <TB0> INFO: 2560 events read in total (352ms).
[15:47:21.189] <TB0> INFO: Test took 1482ms.
[15:47:21.192] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:21.605] <TB0> INFO: Expecting 2560 events.
[15:47:22.667] <TB0> INFO: 2560 events read in total (346ms).
[15:47:22.667] <TB0> INFO: Test took 1475ms.
[15:47:22.670] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:23.083] <TB0> INFO: Expecting 2560 events.
[15:47:24.152] <TB0> INFO: 2560 events read in total (353ms).
[15:47:24.152] <TB0> INFO: Test took 1482ms.
[15:47:24.156] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:24.568] <TB0> INFO: Expecting 2560 events.
[15:47:25.650] <TB0> INFO: 2560 events read in total (366ms).
[15:47:25.650] <TB0> INFO: Test took 1495ms.
[15:47:25.654] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:26.066] <TB0> INFO: Expecting 2560 events.
[15:47:27.134] <TB0> INFO: 2560 events read in total (352ms).
[15:47:27.135] <TB0> INFO: Test took 1481ms.
[15:47:27.137] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:27.550] <TB0> INFO: Expecting 2560 events.
[15:47:28.618] <TB0> INFO: 2560 events read in total (352ms).
[15:47:28.618] <TB0> INFO: Test took 1481ms.
[15:47:28.620] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:29.034] <TB0> INFO: Expecting 2560 events.
[15:47:30.102] <TB0> INFO: 2560 events read in total (352ms).
[15:47:30.102] <TB0> INFO: Test took 1482ms.
[15:47:30.105] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:30.518] <TB0> INFO: Expecting 2560 events.
[15:47:31.618] <TB0> INFO: 2560 events read in total (384ms).
[15:47:31.619] <TB0> INFO: Test took 1515ms.
[15:47:31.622] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:32.035] <TB0> INFO: Expecting 2560 events.
[15:47:33.102] <TB0> INFO: 2560 events read in total (351ms).
[15:47:33.103] <TB0> INFO: Test took 1481ms.
[15:47:33.105] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:33.519] <TB0> INFO: Expecting 2560 events.
[15:47:34.587] <TB0> INFO: 2560 events read in total (352ms).
[15:47:34.587] <TB0> INFO: Test took 1482ms.
[15:47:34.591] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:35.003] <TB0> INFO: Expecting 2560 events.
[15:47:36.071] <TB0> INFO: 2560 events read in total (352ms).
[15:47:36.071] <TB0> INFO: Test took 1480ms.
[15:47:36.073] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:36.487] <TB0> INFO: Expecting 2560 events.
[15:47:37.554] <TB0> INFO: 2560 events read in total (351ms).
[15:47:37.554] <TB0> INFO: Test took 1481ms.
[15:47:37.557] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:37.970] <TB0> INFO: Expecting 2560 events.
[15:47:39.039] <TB0> INFO: 2560 events read in total (353ms).
[15:47:39.039] <TB0> INFO: Test took 1482ms.
[15:47:39.042] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:39.455] <TB0> INFO: Expecting 2560 events.
[15:47:40.522] <TB0> INFO: 2560 events read in total (351ms).
[15:47:40.523] <TB0> INFO: Test took 1482ms.
[15:47:40.525] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:40.939] <TB0> INFO: Expecting 2560 events.
[15:47:42.021] <TB0> INFO: 2560 events read in total (366ms).
[15:47:42.021] <TB0> INFO: Test took 1496ms.
[15:47:42.024] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:42.437] <TB0> INFO: Expecting 2560 events.
[15:47:43.505] <TB0> INFO: 2560 events read in total (352ms).
[15:47:43.505] <TB0> INFO: Test took 1481ms.
[15:47:43.507] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:43.921] <TB0> INFO: Expecting 2560 events.
[15:47:45.003] <TB0> INFO: 2560 events read in total (366ms).
[15:47:45.003] <TB0> INFO: Test took 1496ms.
[15:47:45.006] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:45.419] <TB0> INFO: Expecting 2560 events.
[15:47:46.486] <TB0> INFO: 2560 events read in total (351ms).
[15:47:46.486] <TB0> INFO: Test took 1480ms.
[15:47:46.490] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:47:46.902] <TB0> INFO: Expecting 2560 events.
[15:47:47.969] <TB0> INFO: 2560 events read in total (351ms).
[15:47:47.970] <TB0> INFO: Test took 1481ms.
[15:47:48.589] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 692 seconds
[15:47:48.589] <TB0> INFO: PH scale (per ROC): 81 68 67 66 61 62 61 64 58 66 65 77 73 70 69 77
[15:47:48.589] <TB0> INFO: PH offset (per ROC): 171 186 180 173 205 188 196 167 203 182 192 182 194 178 173 176
[15:47:48.597] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:47:48.597] <TB0> INFO: Decoding statistics:
[15:47:48.597] <TB0> INFO: General information:
[15:47:48.597] <TB0> INFO: 16bit words read: 91936
[15:47:48.597] <TB0> INFO: valid events total: 10240
[15:47:48.597] <TB0> INFO: empty events: 7736
[15:47:48.597] <TB0> INFO: valid events with pixels: 2504
[15:47:48.597] <TB0> INFO: valid pixel hits: 2504
[15:47:48.598] <TB0> INFO: Event errors: 0
[15:47:48.598] <TB0> INFO: start marker: 0
[15:47:48.598] <TB0> INFO: stop marker: 0
[15:47:48.598] <TB0> INFO: overflow: 0
[15:47:48.598] <TB0> INFO: invalid 5bit words: 0
[15:47:48.598] <TB0> INFO: invalid XOR eye diagram: 0
[15:47:48.598] <TB0> INFO: TBM errors: 0
[15:47:48.598] <TB0> INFO: flawed TBM headers: 0
[15:47:48.598] <TB0> INFO: flawed TBM trailers: 0
[15:47:48.598] <TB0> INFO: event ID mismatches: 0
[15:47:48.598] <TB0> INFO: ROC errors: 0
[15:47:48.598] <TB0> INFO: missing ROC header(s): 0
[15:47:48.598] <TB0> INFO: misplaced readback start: 0
[15:47:48.598] <TB0> INFO: Pixel decoding errors: 0
[15:47:48.598] <TB0> INFO: pixel data incomplete: 0
[15:47:48.598] <TB0> INFO: pixel address: 0
[15:47:48.598] <TB0> INFO: pulse height fill bit: 0
[15:47:48.598] <TB0> INFO: buffer corruption: 0
[15:47:48.789] <TB0> INFO: ######################################################################
[15:47:48.789] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[15:47:48.789] <TB0> INFO: ######################################################################
[15:47:48.800] <TB0> INFO: scanning low vcal = 10
[15:47:49.134] <TB0> INFO: Expecting 41600 events.
[15:47:52.786] <TB0> INFO: 41600 events read in total (2936ms).
[15:47:52.787] <TB0> INFO: Test took 3987ms.
[15:47:52.789] <TB0> INFO: scanning low vcal = 20
[15:47:53.202] <TB0> INFO: Expecting 41600 events.
[15:47:56.864] <TB0> INFO: 41600 events read in total (2946ms).
[15:47:56.864] <TB0> INFO: Test took 4075ms.
[15:47:56.866] <TB0> INFO: scanning low vcal = 30
[15:47:57.279] <TB0> INFO: Expecting 41600 events.
[15:48:00.959] <TB0> INFO: 41600 events read in total (2963ms).
[15:48:00.960] <TB0> INFO: Test took 4094ms.
[15:48:00.962] <TB0> INFO: scanning low vcal = 40
[15:48:01.364] <TB0> INFO: Expecting 41600 events.
[15:48:05.679] <TB0> INFO: 41600 events read in total (3599ms).
[15:48:05.680] <TB0> INFO: Test took 4718ms.
[15:48:05.683] <TB0> INFO: scanning low vcal = 50
[15:48:06.036] <TB0> INFO: Expecting 41600 events.
[15:48:10.309] <TB0> INFO: 41600 events read in total (3557ms).
[15:48:10.310] <TB0> INFO: Test took 4627ms.
[15:48:10.313] <TB0> INFO: scanning low vcal = 60
[15:48:10.656] <TB0> INFO: Expecting 41600 events.
[15:48:14.869] <TB0> INFO: 41600 events read in total (3496ms).
[15:48:14.869] <TB0> INFO: Test took 4556ms.
[15:48:14.872] <TB0> INFO: scanning low vcal = 70
[15:48:15.229] <TB0> INFO: Expecting 41600 events.
[15:48:19.455] <TB0> INFO: 41600 events read in total (3510ms).
[15:48:19.456] <TB0> INFO: Test took 4584ms.
[15:48:19.459] <TB0> INFO: scanning low vcal = 80
[15:48:19.811] <TB0> INFO: Expecting 41600 events.
[15:48:24.047] <TB0> INFO: 41600 events read in total (3520ms).
[15:48:24.048] <TB0> INFO: Test took 4589ms.
[15:48:24.050] <TB0> INFO: scanning low vcal = 90
[15:48:24.404] <TB0> INFO: Expecting 41600 events.
[15:48:28.906] <TB0> INFO: 41600 events read in total (3786ms).
[15:48:28.906] <TB0> INFO: Test took 4856ms.
[15:48:28.909] <TB0> INFO: scanning low vcal = 100
[15:48:29.269] <TB0> INFO: Expecting 41600 events.
[15:48:33.509] <TB0> INFO: 41600 events read in total (3524ms).
[15:48:33.509] <TB0> INFO: Test took 4600ms.
[15:48:33.513] <TB0> INFO: scanning low vcal = 110
[15:48:33.864] <TB0> INFO: Expecting 41600 events.
[15:48:38.119] <TB0> INFO: 41600 events read in total (3538ms).
[15:48:38.120] <TB0> INFO: Test took 4607ms.
[15:48:38.124] <TB0> INFO: scanning low vcal = 120
[15:48:38.472] <TB0> INFO: Expecting 41600 events.
[15:48:42.777] <TB0> INFO: 41600 events read in total (3589ms).
[15:48:42.778] <TB0> INFO: Test took 4654ms.
[15:48:42.781] <TB0> INFO: scanning low vcal = 130
[15:48:43.135] <TB0> INFO: Expecting 41600 events.
[15:48:47.429] <TB0> INFO: 41600 events read in total (3578ms).
[15:48:47.430] <TB0> INFO: Test took 4649ms.
[15:48:47.433] <TB0> INFO: scanning low vcal = 140
[15:48:47.772] <TB0> INFO: Expecting 41600 events.
[15:48:52.049] <TB0> INFO: 41600 events read in total (3561ms).
[15:48:52.049] <TB0> INFO: Test took 4616ms.
[15:48:52.052] <TB0> INFO: scanning low vcal = 150
[15:48:52.402] <TB0> INFO: Expecting 41600 events.
[15:48:56.682] <TB0> INFO: 41600 events read in total (3563ms).
[15:48:56.682] <TB0> INFO: Test took 4630ms.
[15:48:56.685] <TB0> INFO: scanning low vcal = 160
[15:48:57.038] <TB0> INFO: Expecting 41600 events.
[15:49:01.348] <TB0> INFO: 41600 events read in total (3594ms).
[15:49:01.349] <TB0> INFO: Test took 4664ms.
[15:49:01.351] <TB0> INFO: scanning low vcal = 170
[15:49:01.706] <TB0> INFO: Expecting 41600 events.
[15:49:05.989] <TB0> INFO: 41600 events read in total (3566ms).
[15:49:05.992] <TB0> INFO: Test took 4641ms.
[15:49:05.997] <TB0> INFO: scanning low vcal = 180
[15:49:06.349] <TB0> INFO: Expecting 41600 events.
[15:49:10.667] <TB0> INFO: 41600 events read in total (3602ms).
[15:49:10.667] <TB0> INFO: Test took 4670ms.
[15:49:10.675] <TB0> INFO: scanning low vcal = 190
[15:49:11.024] <TB0> INFO: Expecting 41600 events.
[15:49:15.377] <TB0> INFO: 41600 events read in total (3637ms).
[15:49:15.378] <TB0> INFO: Test took 4703ms.
[15:49:15.380] <TB0> INFO: scanning low vcal = 200
[15:49:15.732] <TB0> INFO: Expecting 41600 events.
[15:49:20.136] <TB0> INFO: 41600 events read in total (3688ms).
[15:49:20.136] <TB0> INFO: Test took 4756ms.
[15:49:20.139] <TB0> INFO: scanning low vcal = 210
[15:49:20.484] <TB0> INFO: Expecting 41600 events.
[15:49:24.935] <TB0> INFO: 41600 events read in total (3735ms).
[15:49:24.935] <TB0> INFO: Test took 4796ms.
[15:49:24.938] <TB0> INFO: scanning low vcal = 220
[15:49:25.294] <TB0> INFO: Expecting 41600 events.
[15:49:29.687] <TB0> INFO: 41600 events read in total (3677ms).
[15:49:29.688] <TB0> INFO: Test took 4750ms.
[15:49:29.691] <TB0> INFO: scanning low vcal = 230
[15:49:30.045] <TB0> INFO: Expecting 41600 events.
[15:49:34.610] <TB0> INFO: 41600 events read in total (3848ms).
[15:49:34.611] <TB0> INFO: Test took 4920ms.
[15:49:34.613] <TB0> INFO: scanning low vcal = 240
[15:49:34.957] <TB0> INFO: Expecting 41600 events.
[15:49:39.293] <TB0> INFO: 41600 events read in total (3620ms).
[15:49:39.293] <TB0> INFO: Test took 4680ms.
[15:49:39.296] <TB0> INFO: scanning low vcal = 250
[15:49:39.628] <TB0> INFO: Expecting 41600 events.
[15:49:44.009] <TB0> INFO: 41600 events read in total (3665ms).
[15:49:44.009] <TB0> INFO: Test took 4713ms.
[15:49:44.014] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[15:49:44.340] <TB0> INFO: Expecting 41600 events.
[15:49:48.780] <TB0> INFO: 41600 events read in total (3724ms).
[15:49:48.781] <TB0> INFO: Test took 4767ms.
[15:49:48.784] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[15:49:49.127] <TB0> INFO: Expecting 41600 events.
[15:49:53.548] <TB0> INFO: 41600 events read in total (3705ms).
[15:49:53.549] <TB0> INFO: Test took 4765ms.
[15:49:53.551] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[15:49:53.907] <TB0> INFO: Expecting 41600 events.
[15:49:58.288] <TB0> INFO: 41600 events read in total (3665ms).
[15:49:58.289] <TB0> INFO: Test took 4738ms.
[15:49:58.292] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[15:49:58.646] <TB0> INFO: Expecting 41600 events.
[15:50:03.079] <TB0> INFO: 41600 events read in total (3717ms).
[15:50:03.079] <TB0> INFO: Test took 4787ms.
[15:50:03.082] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[15:50:03.438] <TB0> INFO: Expecting 41600 events.
[15:50:07.771] <TB0> INFO: 41600 events read in total (3617ms).
[15:50:07.771] <TB0> INFO: Test took 4689ms.
[15:50:08.415] <TB0> INFO: PixTestGainPedestal::measure() done
[15:50:44.321] <TB0> INFO: PixTestGainPedestal::fit() done
[15:50:44.321] <TB0> INFO: non-linearity mean: 0.962 0.948 0.957 0.958 0.959 0.957 0.962 0.956 0.957 0.955 0.968 0.959 0.954 0.958 0.944 0.953
[15:50:44.321] <TB0> INFO: non-linearity RMS: 0.007 0.008 0.007 0.008 0.009 0.008 0.006 0.008 0.011 0.007 0.004 0.008 0.007 0.005 0.008 0.007
[15:50:44.321] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[15:50:44.339] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[15:50:44.357] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[15:50:44.375] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[15:50:44.394] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[15:50:44.412] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[15:50:44.430] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[15:50:44.448] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[15:50:44.466] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[15:50:44.484] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[15:50:44.503] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[15:50:44.520] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[15:50:44.538] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[15:50:44.557] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[15:50:44.575] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[15:50:44.593] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[15:50:44.611] <TB0> INFO: PixTestGainPedestal::doTest() done, duration: 175 seconds
[15:50:44.611] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:50:44.611] <TB0> INFO: Decoding statistics:
[15:50:44.611] <TB0> INFO: General information:
[15:50:44.611] <TB0> INFO: 16bit words read: 2662400
[15:50:44.611] <TB0> INFO: valid events total: 166400
[15:50:44.611] <TB0> INFO: empty events: 0
[15:50:44.611] <TB0> INFO: valid events with pixels: 166400
[15:50:44.611] <TB0> INFO: valid pixel hits: 665543
[15:50:44.611] <TB0> INFO: Event errors: 0
[15:50:44.611] <TB0> INFO: start marker: 0
[15:50:44.611] <TB0> INFO: stop marker: 0
[15:50:44.611] <TB0> INFO: overflow: 0
[15:50:44.611] <TB0> INFO: invalid 5bit words: 0
[15:50:44.611] <TB0> INFO: invalid XOR eye diagram: 0
[15:50:44.611] <TB0> INFO: TBM errors: 0
[15:50:44.611] <TB0> INFO: flawed TBM headers: 0
[15:50:44.611] <TB0> INFO: flawed TBM trailers: 0
[15:50:44.611] <TB0> INFO: event ID mismatches: 0
[15:50:44.611] <TB0> INFO: ROC errors: 0
[15:50:44.611] <TB0> INFO: missing ROC header(s): 0
[15:50:44.611] <TB0> INFO: misplaced readback start: 0
[15:50:44.611] <TB0> INFO: Pixel decoding errors: 0
[15:50:44.611] <TB0> INFO: pixel data incomplete: 0
[15:50:44.611] <TB0> INFO: pixel address: 0
[15:50:44.611] <TB0> INFO: pulse height fill bit: 0
[15:50:44.611] <TB0> INFO: buffer corruption: 0
[15:50:44.617] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C15.dat
[15:50:44.618] <TB0> INFO: ######################################################################
[15:50:44.618] <TB0> INFO: PixTestTrim::doTest()
[15:50:44.619] <TB0> INFO: ######################################################################
[15:50:44.619] <TB0> INFO: PixTestReadback::RES sent once
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C0.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C1.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C2.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C3.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C4.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C5.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C6.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C7.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C8.dat
[15:50:55.876] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C9.dat
[15:50:55.877] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C10.dat
[15:50:55.877] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C11.dat
[15:50:55.877] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C12.dat
[15:50:55.877] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C13.dat
[15:50:55.877] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C14.dat
[15:50:55.877] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C15.dat
[15:50:55.907] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[15:50:55.908] <TB0> INFO: PixTestReadback::RES sent once
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C0.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C1.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C2.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C3.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C4.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C5.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C6.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C7.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C8.dat
[15:51:07.081] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C9.dat
[15:51:07.082] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C10.dat
[15:51:07.082] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C11.dat
[15:51:07.082] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C12.dat
[15:51:07.082] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C13.dat
[15:51:07.082] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C14.dat
[15:51:07.082] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C15.dat
[15:51:07.110] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[15:51:07.111] <TB0> INFO: PixTestReadback::RES sent once
[15:51:15.728] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[15:51:15.728] <TB0> INFO: Vbg will be calibrated using Vd calibration
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 155.7calibrated Vbg = 1.24112 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 145.4calibrated Vbg = 1.2365 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 156.9calibrated Vbg = 1.24348 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 145.8calibrated Vbg = 1.24754 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 161.1calibrated Vbg = 1.25264 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 156calibrated Vbg = 1.25484 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 158.2calibrated Vbg = 1.25284 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 156.2calibrated Vbg = 1.25342 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 148.1calibrated Vbg = 1.25981 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 155.1calibrated Vbg = 1.2556 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 154.1calibrated Vbg = 1.25324 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 142.8calibrated Vbg = 1.24298 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 158.3calibrated Vbg = 1.23597 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 152.4calibrated Vbg = 1.23967 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 147.4calibrated Vbg = 1.23978 :::*/*/*/*/
[15:51:15.728] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 158.3calibrated Vbg = 1.24086 :::*/*/*/*/
[15:51:15.732] <TB0> INFO: PixTestReadback::RES sent once
[15:54:10.408] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C0.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C1.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C2.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C3.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C4.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C5.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C6.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C7.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C8.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C9.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C10.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C11.dat
[15:54:10.409] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C12.dat
[15:54:10.410] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C13.dat
[15:54:10.410] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C14.dat
[15:54:10.410] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2053_FullQualification_2015-09-16_11h18m_1442395098//004_FulltestPxar_p17//readbackCal_C15.dat
[15:54:10.435] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[15:54:10.437] <TB0> INFO: PixTestReadback::doTest() done
[15:54:10.437] <TB0> INFO: Fetched DAQ statistics. Counters are being reset now.
[15:54:10.437] <TB0> INFO: Decoding statistics:
[15:54:10.437] <TB0> INFO: General information:
[15:54:10.437] <TB0> INFO: 16bit words read: 1024
[15:54:10.437] <TB0> INFO: valid events total: 128
[15:54:10.437] <TB0> INFO: empty events: 128
[15:54:10.437] <TB0> INFO: valid events with pixels: 0
[15:54:10.437] <TB0> INFO: valid pixel hits: 0
[15:54:10.437] <TB0> INFO: Event errors: 0
[15:54:10.437] <TB0> INFO: start marker: 0
[15:54:10.437] <TB0> INFO: stop marker: 0
[15:54:10.437] <TB0> INFO: overflow: 0
[15:54:10.437] <TB0> INFO: invalid 5bit words: 0
[15:54:10.437] <TB0> INFO: invalid XOR eye diagram: 0
[15:54:10.437] <TB0> INFO: TBM errors: 0
[15:54:10.437] <TB0> INFO: flawed TBM headers: 0
[15:54:10.437] <TB0> INFO: flawed TBM trailers: 0
[15:54:10.437] <TB0> INFO: event ID mismatches: 0
[15:54:10.437] <TB0> INFO: ROC errors: 0
[15:54:10.437] <TB0> INFO: missing ROC header(s): 0
[15:54:10.437] <TB0> INFO: misplaced readback start: 0
[15:54:10.437] <TB0> INFO: Pixel decoding errors: 0
[15:54:10.437] <TB0> INFO: pixel data incomplete: 0
[15:54:10.437] <TB0> INFO: pixel address: 0
[15:54:10.437] <TB0> INFO: pulse height fill bit: 0
[15:54:10.437] <TB0> INFO: buffer corruption: 0
[15:54:10.454] <TB0> INFO: Decoding statistics:
[15:54:10.454] <TB0> INFO: General information:
[15:54:10.454] <TB0> INFO: 16bit words read: 2755360
[15:54:10.454] <TB0> INFO: valid events total: 176768
[15:54:10.454] <TB0> INFO: empty events: 7864
[15:54:10.454] <TB0> INFO: valid events with pixels: 168904
[15:54:10.454] <TB0> INFO: valid pixel hits: 668047
[15:54:10.454] <TB0> INFO: Event errors: 0
[15:54:10.454] <TB0> INFO: start marker: 0
[15:54:10.454] <TB0> INFO: stop marker: 0
[15:54:10.454] <TB0> INFO: overflow: 0
[15:54:10.454] <TB0> INFO: invalid 5bit words: 0
[15:54:10.454] <TB0> INFO: invalid XOR eye diagram: 0
[15:54:10.454] <TB0> INFO: TBM errors: 0
[15:54:10.454] <TB0> INFO: flawed TBM headers: 0
[15:54:10.454] <TB0> INFO: flawed TBM trailers: 0
[15:54:10.454] <TB0> INFO: event ID mismatches: 0
[15:54:10.454] <TB0> INFO: ROC errors: 0
[15:54:10.454] <TB0> INFO: missing ROC header(s): 0
[15:54:10.454] <TB0> INFO: misplaced readback start: 0
[15:54:10.454] <TB0> INFO: Pixel decoding errors: 0
[15:54:10.454] <TB0> INFO: pixel data incomplete: 0
[15:54:10.454] <TB0> INFO: pixel address: 0
[15:54:10.454] <TB0> INFO: pulse height fill bit: 0
[15:54:10.454] <TB0> INFO: buffer corruption: 0
[15:54:10.454] <TB0> INFO: enter test to run
[15:54:10.454] <TB0> INFO: test: exit no parameter change
[15:54:11.101] <TB0> QUIET: Connection to board 73 closed.
[15:54:11.181] <TB0> INFO: pXar: this is the end, my friend