[05:53:52.162] <TB0> INFO: *** Welcome to pxar ***
[05:53:52.162] <TB0> INFO: *** Today: 2016/07/18
[05:53:53.457] <TB0> INFO: *** Version: 9751-dirty
[05:53:53.457] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C15.dat
[05:53:53.458] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//tbmParameters_C0b.dat
[05:53:53.458] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//defaultMaskFile.dat
[05:53:53.458] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters_C15.dat
[05:53:53.524] <TB0> INFO: clk: 4
[05:53:53.524] <TB0> INFO: ctr: 4
[05:53:53.524] <TB0> INFO: sda: 19
[05:53:53.524] <TB0> INFO: tin: 9
[05:53:53.524] <TB0> INFO: level: 15
[05:53:53.524] <TB0> INFO: triggerdelay: 0
[05:53:53.525] <TB0> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[05:53:53.525] <TB0> INFO: Log level: INFO
[05:53:53.532] <TB0> INFO: Found DTB DTB_WS6AYH
[05:53:53.543] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[05:53:53.545] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[05:53:53.546] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[05:53:55.075] <TB0> INFO: DUT info:
[05:53:55.075] <TB0> INFO: The DUT currently contains the following objects:
[05:53:55.075] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[05:53:55.075] <TB0> INFO: TBM Core alpha (0): 7 registers set
[05:53:55.075] <TB0> INFO: TBM Core beta (1): 7 registers set
[05:53:55.075] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[05:53:55.075] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.075] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.075] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.075] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.075] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.075] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.075] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.076] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[05:53:55.476] <TB0> INFO: enter 'restricted' command line mode
[05:53:55.476] <TB0> INFO: enter test to run
[05:53:55.476] <TB0> INFO: test: pretest no parameter change
[05:53:55.476] <TB0> INFO: running: pretest
[05:53:55.480] <TB0> INFO: ----------------------------------------------------------------------
[05:53:55.480] <TB0> INFO: PixTestPretest::programROC()
[05:53:55.480] <TB0> INFO: ----------------------------------------------------------------------
[05:54:13.495] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[05:54:13.495] <TB0> INFO: IA differences per ROC: 18.5 18.5 20.1 18.5 19.3 16.9 17.7 18.5 20.1 20.1 17.7 17.7 19.3 19.3 19.3 18.5
[05:54:13.585] <TB0> INFO: enter test to run
[05:54:13.585] <TB0> INFO: test: pretest no parameter change
[05:54:13.585] <TB0> INFO: running: pretest
[05:54:13.586] <TB0> INFO: ----------------------------------------------------------------------
[05:54:13.586] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[05:54:13.586] <TB0> INFO: ----------------------------------------------------------------------
[05:54:34.869] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 378.6 mA = 23.6625 mA/ROC
[05:54:34.869] <TB0> INFO: i(loss) [mA/ROC]: 19.3 20.1 19.3 19.3 19.3 18.5 19.3 19.3 18.5 18.5 18.5 18.5 18.5 18.5 18.5 18.5
[05:54:34.906] <TB0> INFO: enter test to run
[05:54:34.906] <TB0> INFO: test: pretest no parameter change
[05:54:34.906] <TB0> INFO: running: pretest
[05:54:34.906] <TB0> INFO: ----------------------------------------------------------------------
[05:54:34.906] <TB0> INFO: PixTestPretest::findTiming()
[05:54:34.906] <TB0> INFO: ----------------------------------------------------------------------
[05:54:34.906] <TB0> INFO: PixTestCmd::init()

[05:56:04.001] <TB0> INFO: TBM phases: 160MHz: 0, 400MHz: 6, TBM delays: ROC(0/1):4, header/trailer: 1, token: 1
[05:56:04.001] <TB0> INFO: (success/tries = 100/100), width = 5
[05:56:04.002] <TB0> INFO: enter test to run
[05:56:04.002] <TB0> INFO: test: pretest no parameter change
[05:56:04.002] <TB0> INFO: running: pretest
[05:56:04.003] <TB0> INFO: ----------------------------------------------------------------------
[05:56:04.003] <TB0> INFO: PixTestPretest::findWorkingPixel()
[05:56:04.003] <TB0> INFO: ----------------------------------------------------------------------
[05:56:04.097] <TB0> INFO: Expecting 231680 events.


[05:56:14.362] <TB0> INFO: 231680 events read in total (9709ms).
[05:56:14.366] <TB0> INFO: Test took 10358ms.
[05:56:14.588] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[05:56:14.642] <TB0> INFO: enter test to run
[05:56:14.642] <TB0> INFO: test: pretest no parameter change
[05:56:14.642] <TB0> INFO: running: pretest
[05:56:14.643] <TB0> INFO: ----------------------------------------------------------------------
[05:56:14.643] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[05:56:14.643] <TB0> INFO: ----------------------------------------------------------------------
[05:56:14.735] <TB0> INFO: Expecting 231680 events.
[05:56:25.054] <TB0> INFO: 231680 events read in total (9763ms).
[05:56:25.059] <TB0> INFO: Test took 10413ms.
[05:56:25.296] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[05:56:25.296] <TB0> INFO: CalDel: 151 130 146 109 122 112 142 130 142 117 109 105 125 170 115 130
[05:56:25.296] <TB0> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[05:56:25.333] <TB0> INFO: enter test to run
[05:56:25.333] <TB0> INFO: test: pretest no parameter change
[05:56:25.333] <TB0> INFO: running: pretest
[05:56:25.334] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C0.dat
[05:56:25.334] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C1.dat
[05:56:25.334] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C2.dat
[05:56:25.334] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C3.dat
[05:56:25.334] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C4.dat
[05:56:25.334] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C5.dat
[05:56:25.334] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C6.dat
[05:56:25.335] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C7.dat
[05:56:25.335] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C8.dat
[05:56:25.335] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C9.dat
[05:56:25.335] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C10.dat
[05:56:25.335] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C11.dat
[05:56:25.335] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C12.dat
[05:56:25.335] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C13.dat
[05:56:25.335] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C14.dat
[05:56:25.336] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters_C15.dat
[05:56:25.336] <TB0> INFO: enter test to run
[05:56:25.336] <TB0> INFO: test: fulltest no parameter change
[05:56:25.336] <TB0> INFO: running: fulltest
[05:56:25.336] <TB0> INFO: ######################################################################
[05:56:25.336] <TB0> INFO: PixTestFullTest::doTest()
[05:56:25.336] <TB0> INFO: ######################################################################
[05:56:25.337] <TB0> INFO: ######################################################################
[05:56:25.337] <TB0> INFO: PixTestAlive::doTest()
[05:56:25.337] <TB0> INFO: ######################################################################
[05:56:25.338] <TB0> INFO: ----------------------------------------------------------------------
[05:56:25.338] <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)
[05:56:25.338] <TB0> INFO: ----------------------------------------------------------------------
[05:56:25.599] <TB0> INFO: Expecting 41600 events.
[05:56:29.334] <TB0> INFO: 41600 events read in total (3179ms).
[05:56:29.335] <TB0> INFO: Test took 3996ms.
[05:56:29.563] <TB0> INFO: PixTestAlive::aliveTest() done
[05:56:29.563] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[05:56:29.565] <TB0> INFO: ----------------------------------------------------------------------
[05:56:29.565] <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)
[05:56:29.565] <TB0> INFO: ----------------------------------------------------------------------
[05:56:29.841] <TB0> INFO: Expecting 41600 events.
[05:56:32.797] <TB0> INFO: 41600 events read in total (2398ms).
[05:56:32.798] <TB0> INFO: Test took 3232ms.
[05:56:32.798] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[05:56:33.042] <TB0> INFO: PixTestAlive::maskTest() done
[05:56:33.042] <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
[05:56:33.043] <TB0> INFO: ----------------------------------------------------------------------
[05:56:33.043] <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)
[05:56:33.043] <TB0> INFO: ----------------------------------------------------------------------
[05:56:33.308] <TB0> INFO: Expecting 41600 events.
[05:56:37.104] <TB0> INFO: 41600 events read in total (3240ms).
[05:56:37.105] <TB0> INFO: Test took 4060ms.
[05:56:37.332] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[05:56:37.332] <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
[05:56:37.332] <TB0> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[05:56:37.333] <TB0> INFO: Decoding statistics:
[05:56:37.333] <TB0> INFO: General information:
[05:56:37.333] <TB0> INFO: 16bit words read: 0
[05:56:37.333] <TB0> INFO: valid events total: 0
[05:56:37.333] <TB0> INFO: empty events: 0
[05:56:37.333] <TB0> INFO: valid events with pixels: 0
[05:56:37.333] <TB0> INFO: valid pixel hits: 0
[05:56:37.333] <TB0> INFO: Event errors: 0
[05:56:37.333] <TB0> INFO: start marker: 0
[05:56:37.333] <TB0> INFO: stop marker: 0
[05:56:37.333] <TB0> INFO: overflow: 0
[05:56:37.333] <TB0> INFO: invalid 5bit words: 0
[05:56:37.333] <TB0> INFO: invalid XOR eye diagram: 0
[05:56:37.333] <TB0> INFO: frame (failed synchr.): 0
[05:56:37.333] <TB0> INFO: idle data (no TBM trl): 0
[05:56:37.333] <TB0> INFO: no data (only TBM hdr): 0
[05:56:37.333] <TB0> INFO: TBM errors: 0
[05:56:37.333] <TB0> INFO: flawed TBM headers: 0
[05:56:37.333] <TB0> INFO: flawed TBM trailers: 0
[05:56:37.333] <TB0> INFO: event ID mismatches: 0
[05:56:37.333] <TB0> INFO: ROC errors: 0
[05:56:37.333] <TB0> INFO: missing ROC header(s): 0
[05:56:37.333] <TB0> INFO: misplaced readback start: 0
[05:56:37.333] <TB0> INFO: Pixel decoding errors: 0
[05:56:37.333] <TB0> INFO: pixel data incomplete: 0
[05:56:37.333] <TB0> INFO: pixel address: 0
[05:56:37.333] <TB0> INFO: pulse height fill bit: 0
[05:56:37.333] <TB0> INFO: buffer corruption: 0
[05:56:37.343] <TB0> INFO: ######################################################################
[05:56:37.343] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[05:56:37.343] <TB0> INFO: ######################################################################
[05:56:37.346] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[05:56:37.375] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[05:56:37.375] <TB0> INFO: run 1 of 1
[05:56:37.639] <TB0> INFO: Expecting 3120000 events.
[05:57:18.978] <TB0> INFO: 887815 events read in total (40783ms).
[05:57:59.490] <TB0> INFO: 1749785 events read in total (81295ms).
[05:58:39.997] <TB0> INFO: 2612725 events read in total (121803ms).
[05:59:03.305] <TB0> INFO: 3120000 events read in total (145110ms).
[05:59:03.356] <TB0> INFO: Test took 145981ms.
[05:59:27.717] <TB0> INFO: PixTestBBMap::doTest() done, duration: 170 seconds
[05:59:27.717] <TB0> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[05:59:27.717] <TB0> INFO: separation cut (per ROC): 121 114 113 112 98 112 103 96 107 101 105 114 101 112 113 110
[05:59:27.717] <TB0> INFO: Decoding statistics:
[05:59:27.717] <TB0> INFO: General information:
[05:59:27.717] <TB0> INFO: 16bit words read: 0
[05:59:27.717] <TB0> INFO: valid events total: 0
[05:59:27.717] <TB0> INFO: empty events: 0
[05:59:27.717] <TB0> INFO: valid events with pixels: 0
[05:59:27.717] <TB0> INFO: valid pixel hits: 0
[05:59:27.717] <TB0> INFO: Event errors: 0
[05:59:27.717] <TB0> INFO: start marker: 0
[05:59:27.717] <TB0> INFO: stop marker: 0
[05:59:27.717] <TB0> INFO: overflow: 0
[05:59:27.717] <TB0> INFO: invalid 5bit words: 0
[05:59:27.717] <TB0> INFO: invalid XOR eye diagram: 0
[05:59:27.717] <TB0> INFO: frame (failed synchr.): 0
[05:59:27.717] <TB0> INFO: idle data (no TBM trl): 0
[05:59:27.717] <TB0> INFO: no data (only TBM hdr): 0
[05:59:27.717] <TB0> INFO: TBM errors: 0
[05:59:27.717] <TB0> INFO: flawed TBM headers: 0
[05:59:27.717] <TB0> INFO: flawed TBM trailers: 0
[05:59:27.717] <TB0> INFO: event ID mismatches: 0
[05:59:27.717] <TB0> INFO: ROC errors: 0
[05:59:27.717] <TB0> INFO: missing ROC header(s): 0
[05:59:27.717] <TB0> INFO: misplaced readback start: 0
[05:59:27.717] <TB0> INFO: Pixel decoding errors: 0
[05:59:27.717] <TB0> INFO: pixel data incomplete: 0
[05:59:27.717] <TB0> INFO: pixel address: 0
[05:59:27.717] <TB0> INFO: pulse height fill bit: 0
[05:59:27.717] <TB0> INFO: buffer corruption: 0
[05:59:27.788] <TB0> INFO: ######################################################################
[05:59:27.788] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[05:59:27.788] <TB0> INFO: ######################################################################
[05:59:27.788] <TB0> INFO: ----------------------------------------------------------------------
[05:59:27.788] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[05:59:27.788] <TB0> INFO: ----------------------------------------------------------------------
[05:59:27.788] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[05:59:27.797] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[05:59:27.797] <TB0> INFO: run 1 of 1
[05:59:28.060] <TB0> INFO: Expecting 26208000 events.
[06:00:01.979] <TB0> INFO: 901150 events read in total (33362ms).
[06:00:34.540] <TB0> INFO: 1787050 events read in total (65923ms).
[06:01:07.507] <TB0> INFO: 2672450 events read in total (98890ms).
[06:01:40.244] <TB0> INFO: 3557950 events read in total (131627ms).
[06:02:13.072] <TB0> INFO: 4444550 events read in total (164455ms).
[06:02:45.651] <TB0> INFO: 5327350 events read in total (197034ms).
[06:03:19.060] <TB0> INFO: 6212100 events read in total (230443ms).
[06:03:52.242] <TB0> INFO: 7095450 events read in total (263625ms).
[06:04:25.524] <TB0> INFO: 7980100 events read in total (296907ms).
[06:04:58.248] <TB0> INFO: 8863650 events read in total (329631ms).
[06:05:31.251] <TB0> INFO: 9749950 events read in total (362634ms).
[06:06:04.188] <TB0> INFO: 10633300 events read in total (395571ms).
[06:06:36.678] <TB0> INFO: 11515200 events read in total (428061ms).
[06:07:09.604] <TB0> INFO: 12399650 events read in total (460987ms).
[06:07:41.903] <TB0> INFO: 13280000 events read in total (493286ms).
[06:08:14.752] <TB0> INFO: 14154650 events read in total (526135ms).
[06:08:47.047] <TB0> INFO: 15026450 events read in total (558430ms).
[06:09:20.126] <TB0> INFO: 15899750 events read in total (591509ms).
[06:09:52.918] <TB0> INFO: 16772300 events read in total (624301ms).
[06:10:25.883] <TB0> INFO: 17643950 events read in total (657266ms).
[06:10:58.720] <TB0> INFO: 18515850 events read in total (690103ms).
[06:11:31.694] <TB0> INFO: 19388550 events read in total (723077ms).
[06:12:04.383] <TB0> INFO: 20259650 events read in total (755766ms).
[06:12:37.467] <TB0> INFO: 21132900 events read in total (788850ms).
[06:13:10.022] <TB0> INFO: 22006000 events read in total (821405ms).
[06:13:43.081] <TB0> INFO: 22880800 events read in total (854464ms).
[06:14:16.136] <TB0> INFO: 23756800 events read in total (887519ms).
[06:14:48.476] <TB0> INFO: 24636200 events read in total (919859ms).
[06:15:21.588] <TB0> INFO: 25515850 events read in total (952971ms).
[06:15:47.205] <TB0> INFO: 26208000 events read in total (978588ms).
[06:15:47.239] <TB0> INFO: Test took 979442ms.
[06:15:47.489] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:15:49.154] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:15:50.681] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:15:52.316] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:15:53.762] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:15:55.212] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:15:56.639] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:15:58.099] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:15:59.650] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:16:01.106] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:16:02.633] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:16:04.052] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:16:05.432] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:16:06.819] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:16:08.225] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:16:09.660] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[06:16:11.077] <TB0> INFO: PixTestScurves::scurves() done
[06:16:11.077] <TB0> INFO: Vcal mean: 96.45 91.92 94.52 86.95 91.50 100.40 88.63 89.46 89.76 82.27 80.61 93.43 86.41 97.64 92.34 89.94
[06:16:11.077] <TB0> INFO: Vcal RMS: 5.49 5.45 5.68 5.26 5.06 5.31 5.03 4.80 4.72 4.04 4.23 5.50 5.23 5.57 5.45 5.28
[06:16:11.077] <TB0> INFO: PixTestScurves::fullTest() done, duration: 1003 seconds
[06:16:11.077] <TB0> INFO: Decoding statistics:
[06:16:11.077] <TB0> INFO: General information:
[06:16:11.077] <TB0> INFO: 16bit words read: 0
[06:16:11.077] <TB0> INFO: valid events total: 0
[06:16:11.077] <TB0> INFO: empty events: 0
[06:16:11.077] <TB0> INFO: valid events with pixels: 0
[06:16:11.077] <TB0> INFO: valid pixel hits: 0
[06:16:11.077] <TB0> INFO: Event errors: 0
[06:16:11.077] <TB0> INFO: start marker: 0
[06:16:11.077] <TB0> INFO: stop marker: 0
[06:16:11.077] <TB0> INFO: overflow: 0
[06:16:11.077] <TB0> INFO: invalid 5bit words: 0
[06:16:11.077] <TB0> INFO: invalid XOR eye diagram: 0
[06:16:11.077] <TB0> INFO: frame (failed synchr.): 0
[06:16:11.077] <TB0> INFO: idle data (no TBM trl): 0
[06:16:11.077] <TB0> INFO: no data (only TBM hdr): 0
[06:16:11.077] <TB0> INFO: TBM errors: 0
[06:16:11.077] <TB0> INFO: flawed TBM headers: 0
[06:16:11.077] <TB0> INFO: flawed TBM trailers: 0
[06:16:11.077] <TB0> INFO: event ID mismatches: 0
[06:16:11.077] <TB0> INFO: ROC errors: 0
[06:16:11.077] <TB0> INFO: missing ROC header(s): 0
[06:16:11.077] <TB0> INFO: misplaced readback start: 0
[06:16:11.077] <TB0> INFO: Pixel decoding errors: 0
[06:16:11.077] <TB0> INFO: pixel data incomplete: 0
[06:16:11.078] <TB0> INFO: pixel address: 0
[06:16:11.078] <TB0> INFO: pulse height fill bit: 0
[06:16:11.078] <TB0> INFO: buffer corruption: 0
[06:16:11.148] <TB0> INFO: ######################################################################
[06:16:11.148] <TB0> INFO: PixTestTrim::doTest()
[06:16:11.148] <TB0> INFO: ######################################################################
[06:16:11.149] <TB0> INFO: ----------------------------------------------------------------------
[06:16:11.149] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[06:16:11.149] <TB0> INFO: ----------------------------------------------------------------------
[06:16:11.231] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[06:16:11.231] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[06:16:11.240] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:16:11.240] <TB0> INFO: run 1 of 1
[06:16:11.500] <TB0> INFO: Expecting 6281600 events.
[06:16:53.877] <TB0> INFO: 1073070 events read in total (41820ms).
[06:17:33.138] <TB0> INFO: 2140620 events read in total (81081ms).
[06:18:12.315] <TB0> INFO: 3206920 events read in total (120258ms).
[06:18:52.138] <TB0> INFO: 4282610 events read in total (160082ms).
[06:19:31.411] <TB0> INFO: 5362810 events read in total (199354ms).
[06:20:04.823] <TB0> INFO: 6281600 events read in total (232766ms).
[06:20:04.860] <TB0> INFO: Test took 233620ms.
[06:20:24.128] <TB0> INFO: ROC 0 VthrComp = 100
[06:20:24.128] <TB0> INFO: ROC 1 VthrComp = 97
[06:20:24.128] <TB0> INFO: ROC 2 VthrComp = 99
[06:20:24.128] <TB0> INFO: ROC 3 VthrComp = 90
[06:20:24.129] <TB0> INFO: ROC 4 VthrComp = 93
[06:20:24.129] <TB0> INFO: ROC 5 VthrComp = 100
[06:20:24.129] <TB0> INFO: ROC 6 VthrComp = 89
[06:20:24.129] <TB0> INFO: ROC 7 VthrComp = 94
[06:20:24.129] <TB0> INFO: ROC 8 VthrComp = 97
[06:20:24.129] <TB0> INFO: ROC 9 VthrComp = 88
[06:20:24.129] <TB0> INFO: ROC 10 VthrComp = 85
[06:20:24.129] <TB0> INFO: ROC 11 VthrComp = 96
[06:20:24.129] <TB0> INFO: ROC 12 VthrComp = 87
[06:20:24.129] <TB0> INFO: ROC 13 VthrComp = 93
[06:20:24.129] <TB0> INFO: ROC 14 VthrComp = 91
[06:20:24.130] <TB0> INFO: ROC 15 VthrComp = 92
[06:20:24.130] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[06:20:24.130] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[06:20:24.138] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:20:24.138] <TB0> INFO: run 1 of 1
[06:20:24.413] <TB0> INFO: Expecting 6281600 events.
[06:21:00.023] <TB0> INFO: 752850 events read in total (35054ms).
[06:21:34.901] <TB0> INFO: 1504440 events read in total (69932ms).
[06:22:09.770] <TB0> INFO: 2256650 events read in total (104801ms).
[06:22:44.863] <TB0> INFO: 3009350 events read in total (139894ms).
[06:23:19.596] <TB0> INFO: 3758010 events read in total (174627ms).
[06:23:54.437] <TB0> INFO: 4504060 events read in total (209468ms).
[06:24:28.990] <TB0> INFO: 5249120 events read in total (244021ms).
[06:25:03.290] <TB0> INFO: 5994490 events read in total (278321ms).
[06:25:16.856] <TB0> INFO: 6281600 events read in total (291887ms).
[06:25:16.904] <TB0> INFO: Test took 292766ms.
[06:25:43.464] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 59.5046 for pixel 2/9 mean/min/max = 45.9494/32.2289/59.6698
[06:25:43.465] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 58.2401 for pixel 11/29 mean/min/max = 44.7353/31.2268/58.2439
[06:25:43.465] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 58.6809 for pixel 22/32 mean/min/max = 45.7008/31.9637/59.438
[06:25:43.465] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 60.4213 for pixel 27/1 mean/min/max = 46.4382/32.4206/60.4557
[06:25:43.465] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 58.2289 for pixel 41/61 mean/min/max = 45.8422/33.3908/58.2937
[06:25:43.466] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 58.5724 for pixel 8/35 mean/min/max = 45.0498/31.3315/58.768
[06:25:43.466] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 58.046 for pixel 6/54 mean/min/max = 45.6994/33.3181/58.0807
[06:25:43.467] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 56.4662 for pixel 13/60 mean/min/max = 44.7779/33.0134/56.5423
[06:25:43.467] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 56.63 for pixel 49/4 mean/min/max = 44.2611/31.876/56.6462
[06:25:43.467] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 56.4774 for pixel 50/11 mean/min/max = 45.2151/33.8654/56.5648
[06:25:43.468] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 55.969 for pixel 0/79 mean/min/max = 44.1254/32.2312/56.0197
[06:25:43.468] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 58.7137 for pixel 0/52 mean/min/max = 44.8956/30.8282/58.9631
[06:25:43.468] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 58.0777 for pixel 20/73 mean/min/max = 45.0386/31.9869/58.0903
[06:25:43.469] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 60.4964 for pixel 22/78 mean/min/max = 46.6255/32.7327/60.5183
[06:25:43.469] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 61.0547 for pixel 11/13 mean/min/max = 46.5156/31.7765/61.2547
[06:25:43.470] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 58.3031 for pixel 0/27 mean/min/max = 45.4198/32.3434/58.4962
[06:25:43.470] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[06:25:43.558] <TB0> INFO: Expecting 514560 events.
[06:25:56.434] <TB0> INFO: 514560 events read in total (12320ms).
[06:25:56.439] <TB0> INFO: Expecting 514560 events.
[06:26:09.275] <TB0> INFO: 514560 events read in total (12414ms).
[06:26:09.283] <TB0> INFO: Expecting 514560 events.
[06:26:22.444] <TB0> INFO: 514560 events read in total (12742ms).
[06:26:22.454] <TB0> INFO: Expecting 514560 events.
[06:26:35.178] <TB0> INFO: 514560 events read in total (12310ms).
[06:26:35.189] <TB0> INFO: Expecting 514560 events.
[06:26:48.069] <TB0> INFO: 514560 events read in total (12465ms).
[06:26:48.082] <TB0> INFO: Expecting 514560 events.
[06:27:00.824] <TB0> INFO: 514560 events read in total (12328ms).
[06:27:00.839] <TB0> INFO: Expecting 514560 events.
[06:27:13.575] <TB0> INFO: 514560 events read in total (12324ms).
[06:27:13.591] <TB0> INFO: Expecting 514560 events.
[06:27:26.610] <TB0> INFO: 514560 events read in total (12605ms).
[06:27:26.630] <TB0> INFO: Expecting 514560 events.
[06:27:39.550] <TB0> INFO: 514560 events read in total (12518ms).
[06:27:39.571] <TB0> INFO: Expecting 514560 events.
[06:27:52.563] <TB0> INFO: 514560 events read in total (12589ms).
[06:27:52.590] <TB0> INFO: Expecting 514560 events.
[06:28:05.327] <TB0> INFO: 514560 events read in total (12335ms).
[06:28:05.351] <TB0> INFO: Expecting 514560 events.
[06:28:18.172] <TB0> INFO: 514560 events read in total (12413ms).
[06:28:18.199] <TB0> INFO: Expecting 514560 events.
[06:28:31.033] <TB0> INFO: 514560 events read in total (12432ms).
[06:28:31.061] <TB0> INFO: Expecting 514560 events.
[06:28:43.904] <TB0> INFO: 514560 events read in total (12440ms).
[06:28:43.934] <TB0> INFO: Expecting 514560 events.
[06:28:56.805] <TB0> INFO: 514560 events read in total (12470ms).
[06:28:56.843] <TB0> INFO: Expecting 514560 events.
[06:29:09.653] <TB0> INFO: 514560 events read in total (12408ms).
[06:29:09.687] <TB0> INFO: Test took 206217ms.
[06:29:10.771] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[06:29:10.781] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:29:10.781] <TB0> INFO: run 1 of 1
[06:29:11.041] <TB0> INFO: Expecting 6281600 events.
[06:29:46.688] <TB0> INFO: 737700 events read in total (35090ms).
[06:30:20.977] <TB0> INFO: 1475480 events read in total (69379ms).
[06:30:55.531] <TB0> INFO: 2214320 events read in total (103933ms).
[06:31:29.824] <TB0> INFO: 2954060 events read in total (138226ms).
[06:32:04.224] <TB0> INFO: 3689040 events read in total (172626ms).
[06:32:38.605] <TB0> INFO: 4421250 events read in total (207007ms).
[06:33:13.404] <TB0> INFO: 5152030 events read in total (241806ms).
[06:33:48.128] <TB0> INFO: 5882760 events read in total (276530ms).
[06:34:06.905] <TB0> INFO: 6281600 events read in total (295307ms).
[06:34:06.954] <TB0> INFO: Test took 296173ms.
[06:34:31.164] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.157332 .. 255.000000
[06:34:31.239] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[06:34:31.247] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:34:31.247] <TB0> INFO: run 1 of 1
[06:34:31.508] <TB0> INFO: Expecting 10649600 events.
[06:35:07.013] <TB0> INFO: 711720 events read in total (34948ms).
[06:35:41.517] <TB0> INFO: 1423960 events read in total (69452ms).
[06:36:15.879] <TB0> INFO: 2136140 events read in total (103814ms).
[06:36:49.962] <TB0> INFO: 2848460 events read in total (137897ms).
[06:37:23.933] <TB0> INFO: 3560960 events read in total (171868ms).
[06:37:58.674] <TB0> INFO: 4273620 events read in total (206609ms).
[06:38:32.788] <TB0> INFO: 4986280 events read in total (240723ms).
[06:39:07.090] <TB0> INFO: 5698790 events read in total (275025ms).
[06:39:41.428] <TB0> INFO: 6410870 events read in total (309363ms).
[06:40:16.370] <TB0> INFO: 7122330 events read in total (344305ms).
[06:40:50.109] <TB0> INFO: 7833620 events read in total (378044ms).
[06:41:24.127] <TB0> INFO: 8544620 events read in total (412062ms).
[06:41:58.558] <TB0> INFO: 9255610 events read in total (446493ms).
[06:42:33.225] <TB0> INFO: 9967030 events read in total (481160ms).
[06:43:05.983] <TB0> INFO: 10649600 events read in total (513918ms).
[06:43:06.074] <TB0> INFO: Test took 514827ms.
[06:43:35.676] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 1.996350 .. 48.728383
[06:43:35.760] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 1 .. 58 (-1/-1) hits flags = 528 (plus default)
[06:43:35.768] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:43:35.769] <TB0> INFO: run 1 of 1
[06:43:36.054] <TB0> INFO: Expecting 2412800 events.
[06:44:14.176] <TB0> INFO: 935860 events read in total (37563ms).
[06:44:51.625] <TB0> INFO: 1871370 events read in total (75013ms).
[06:45:14.154] <TB0> INFO: 2412800 events read in total (97542ms).
[06:45:14.171] <TB0> INFO: Test took 98403ms.
[06:45:28.060] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 19.798091 .. 45.512269
[06:45:28.136] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 9 .. 55 (-1/-1) hits flags = 528 (plus default)
[06:45:28.144] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:45:28.144] <TB0> INFO: run 1 of 1
[06:45:28.403] <TB0> INFO: Expecting 1955200 events.
[06:46:06.681] <TB0> INFO: 916900 events read in total (37722ms).
[06:46:45.713] <TB0> INFO: 1832970 events read in total (76754ms).
[06:46:51.215] <TB0> INFO: 1955200 events read in total (82257ms).
[06:46:51.241] <TB0> INFO: Test took 83098ms.
[06:47:06.193] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 23.488366 .. 45.512269
[06:47:06.273] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 13 .. 55 (-1/-1) hits flags = 528 (plus default)
[06:47:06.283] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:47:06.283] <TB0> INFO: run 1 of 1
[06:47:06.556] <TB0> INFO: Expecting 1788800 events.
[06:47:45.060] <TB0> INFO: 891480 events read in total (37948ms).
[06:48:22.312] <TB0> INFO: 1782670 events read in total (75200ms).
[06:48:22.984] <TB0> INFO: 1788800 events read in total (75873ms).
[06:48:23.005] <TB0> INFO: Test took 76723ms.
[06:48:36.393] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[06:48:36.393] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[06:48:36.401] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[06:48:36.401] <TB0> INFO: run 1 of 1
[06:48:36.660] <TB0> INFO: Expecting 1705600 events.
[06:49:15.099] <TB0> INFO: 877680 events read in total (37883ms).
[06:49:50.148] <TB0> INFO: 1705600 events read in total (72934ms).
[06:49:50.170] <TB0> INFO: Test took 73770ms.
[06:50:04.192] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C0.dat
[06:50:04.192] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C1.dat
[06:50:04.192] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C2.dat
[06:50:04.192] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C3.dat
[06:50:04.192] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C4.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C5.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C6.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C7.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C8.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C9.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C10.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C11.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C12.dat
[06:50:04.193] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C13.dat
[06:50:04.194] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C14.dat
[06:50:04.194] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C15.dat
[06:50:04.194] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C0.dat
[06:50:04.200] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C1.dat
[06:50:04.207] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C2.dat
[06:50:04.213] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C3.dat
[06:50:04.219] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C4.dat
[06:50:04.226] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C5.dat
[06:50:04.232] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C6.dat
[06:50:04.238] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C7.dat
[06:50:04.245] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C8.dat
[06:50:04.251] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C9.dat
[06:50:04.258] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C10.dat
[06:50:04.264] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C11.dat
[06:50:04.270] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C12.dat
[06:50:04.277] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C13.dat
[06:50:04.283] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C14.dat
[06:50:04.290] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//trimParameters35_C15.dat
[06:50:04.296] <TB0> INFO: PixTestTrim::trimTest() done
[06:50:04.296] <TB0> INFO: vtrim: 108 108 121 111 108 94 90 101 99 93 83 94 91 106 102 93
[06:50:04.296] <TB0> INFO: vthrcomp: 100 97 99 90 93 100 89 94 97 88 85 96 87 93 91 92
[06:50:04.296] <TB0> INFO: vcal mean: 34.95 34.94 34.95 34.94 34.99 34.87 35.02 35.00 34.95 35.00 34.96 34.92 34.91 34.98 35.00 34.97
[06:50:04.296] <TB0> INFO: vcal RMS: 0.86 0.88 1.00 0.88 0.91 0.87 0.85 0.83 0.86 0.78 0.82 0.92 1.03 1.02 0.92 0.85
[06:50:04.296] <TB0> INFO: bits mean: 9.14 9.99 9.22 9.31 9.61 9.47 9.17 9.63 9.72 9.15 9.37 9.63 9.81 9.39 9.35 9.55
[06:50:04.296] <TB0> INFO: bits RMS: 2.78 2.60 2.77 2.72 2.46 2.68 2.60 2.51 2.66 2.63 2.77 2.81 2.56 2.53 2.77 2.64
[06:50:04.302] <TB0> INFO: ----------------------------------------------------------------------
[06:50:04.302] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[06:50:04.302] <TB0> INFO: ----------------------------------------------------------------------
[06:50:04.305] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[06:50:04.313] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[06:50:04.313] <TB0> INFO: run 1 of 1
[06:50:04.583] <TB0> INFO: Expecting 4160000 events.
[06:50:47.350] <TB0> INFO: 931750 events read in total (42211ms).
[06:51:29.027] <TB0> INFO: 1859260 events read in total (83888ms).
[06:52:09.759] <TB0> INFO: 2779640 events read in total (124620ms).
[06:52:51.100] <TB0> INFO: 3699005 events read in total (165961ms).
[06:53:11.869] <TB0> INFO: 4160000 events read in total (186730ms).
[06:53:11.916] <TB0> INFO: Test took 187604ms.
[06:53:42.359] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 169 (-1/-1) hits flags = 528 (plus default)
[06:53:42.367] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[06:53:42.367] <TB0> INFO: run 1 of 1
[06:53:42.627] <TB0> INFO: Expecting 3536000 events.
[06:54:24.826] <TB0> INFO: 960755 events read in total (41643ms).
[06:55:06.849] <TB0> INFO: 1915840 events read in total (83666ms).
[06:55:48.137] <TB0> INFO: 2862410 events read in total (124954ms).
[06:56:17.499] <TB0> INFO: 3536000 events read in total (154316ms).
[06:56:17.540] <TB0> INFO: Test took 155173ms.
[06:56:44.515] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 158 (-1/-1) hits flags = 528 (plus default)
[06:56:44.523] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[06:56:44.523] <TB0> INFO: run 1 of 1
[06:56:44.785] <TB0> INFO: Expecting 3307200 events.
[06:57:27.470] <TB0> INFO: 990960 events read in total (42129ms).
[06:58:10.027] <TB0> INFO: 1973580 events read in total (84686ms).
[06:58:52.474] <TB0> INFO: 2949400 events read in total (127133ms).
[06:59:08.264] <TB0> INFO: 3307200 events read in total (142923ms).
[06:59:08.291] <TB0> INFO: Test took 143768ms.
[06:59:32.249] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 159 (-1/-1) hits flags = 528 (plus default)
[06:59:32.257] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[06:59:32.257] <TB0> INFO: run 1 of 1
[06:59:32.536] <TB0> INFO: Expecting 3328000 events.
[07:00:15.378] <TB0> INFO: 987160 events read in total (42286ms).
[07:00:58.353] <TB0> INFO: 1966460 events read in total (85262ms).
[07:01:40.484] <TB0> INFO: 2938975 events read in total (127392ms).
[07:01:57.482] <TB0> INFO: 3328000 events read in total (144390ms).
[07:01:57.514] <TB0> INFO: Test took 145257ms.
[07:02:23.697] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 155 (-1/-1) hits flags = 528 (plus default)
[07:02:23.706] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[07:02:23.706] <TB0> INFO: run 1 of 1
[07:02:23.996] <TB0> INFO: Expecting 3244800 events.
[07:03:07.372] <TB0> INFO: 999035 events read in total (42820ms).
[07:03:50.098] <TB0> INFO: 1989145 events read in total (85546ms).
[07:04:32.835] <TB0> INFO: 2973450 events read in total (128283ms).
[07:04:44.746] <TB0> INFO: 3244800 events read in total (140194ms).
[07:04:44.777] <TB0> INFO: Test took 141071ms.
[07:05:09.836] <TB0> INFO: PixTestTrim::trimBitTest() done
[07:05:09.837] <TB0> INFO: PixTestTrim::doTest() done, duration: 2938 seconds
[07:05:09.837] <TB0> INFO: Decoding statistics:
[07:05:09.837] <TB0> INFO: General information:
[07:05:09.837] <TB0> INFO: 16bit words read: 0
[07:05:09.837] <TB0> INFO: valid events total: 0
[07:05:09.837] <TB0> INFO: empty events: 0
[07:05:09.837] <TB0> INFO: valid events with pixels: 0
[07:05:09.837] <TB0> INFO: valid pixel hits: 0
[07:05:09.837] <TB0> INFO: Event errors: 0
[07:05:09.837] <TB0> INFO: start marker: 0
[07:05:09.837] <TB0> INFO: stop marker: 0
[07:05:09.837] <TB0> INFO: overflow: 0
[07:05:09.837] <TB0> INFO: invalid 5bit words: 0
[07:05:09.837] <TB0> INFO: invalid XOR eye diagram: 0
[07:05:09.837] <TB0> INFO: frame (failed synchr.): 0
[07:05:09.837] <TB0> INFO: idle data (no TBM trl): 0
[07:05:09.837] <TB0> INFO: no data (only TBM hdr): 0
[07:05:09.837] <TB0> INFO: TBM errors: 0
[07:05:09.837] <TB0> INFO: flawed TBM headers: 0
[07:05:09.837] <TB0> INFO: flawed TBM trailers: 0
[07:05:09.837] <TB0> INFO: event ID mismatches: 0
[07:05:09.837] <TB0> INFO: ROC errors: 0
[07:05:09.837] <TB0> INFO: missing ROC header(s): 0
[07:05:09.837] <TB0> INFO: misplaced readback start: 0
[07:05:09.837] <TB0> INFO: Pixel decoding errors: 0
[07:05:09.837] <TB0> INFO: pixel data incomplete: 0
[07:05:09.837] <TB0> INFO: pixel address: 0
[07:05:09.837] <TB0> INFO: pulse height fill bit: 0
[07:05:09.837] <TB0> INFO: buffer corruption: 0
[07:05:10.572] <TB0> INFO: ######################################################################
[07:05:10.572] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[07:05:10.572] <TB0> INFO: ######################################################################
[07:05:10.848] <TB0> INFO: Expecting 41600 events.
[07:05:14.550] <TB0> INFO: 41600 events read in total (3145ms).
[07:05:14.551] <TB0> INFO: Test took 3978ms.
[07:05:15.028] <TB0> INFO: Expecting 41600 events.
[07:05:18.756] <TB0> INFO: 41600 events read in total (3172ms).
[07:05:18.756] <TB0> INFO: Test took 4000ms.
[07:05:19.042] <TB0> INFO: Expecting 41600 events.
[07:05:22.898] <TB0> INFO: 41600 events read in total (3300ms).
[07:05:22.898] <TB0> INFO: Test took 4121ms.
[07:05:23.153] <TB0> INFO: Expecting 2560 events.
[07:05:24.007] <TB0> INFO: 2560 events read in total (298ms).
[07:05:24.007] <TB0> INFO: Test took 1096ms.
[07:05:24.312] <TB0> INFO: Expecting 2560 events.
[07:05:25.164] <TB0> INFO: 2560 events read in total (296ms).
[07:05:25.164] <TB0> INFO: Test took 1157ms.
[07:05:25.469] <TB0> INFO: Expecting 2560 events.
[07:05:26.322] <TB0> INFO: 2560 events read in total (297ms).
[07:05:26.322] <TB0> INFO: Test took 1157ms.
[07:05:26.627] <TB0> INFO: Expecting 2560 events.
[07:05:27.482] <TB0> INFO: 2560 events read in total (299ms).
[07:05:27.482] <TB0> INFO: Test took 1158ms.
[07:05:27.787] <TB0> INFO: Expecting 2560 events.
[07:05:28.643] <TB0> INFO: 2560 events read in total (299ms).
[07:05:28.644] <TB0> INFO: Test took 1162ms.
[07:05:28.949] <TB0> INFO: Expecting 2560 events.
[07:05:29.805] <TB0> INFO: 2560 events read in total (300ms).
[07:05:29.805] <TB0> INFO: Test took 1161ms.
[07:05:30.110] <TB0> INFO: Expecting 2560 events.
[07:05:30.964] <TB0> INFO: 2560 events read in total (298ms).
[07:05:30.965] <TB0> INFO: Test took 1160ms.
[07:05:31.269] <TB0> INFO: Expecting 2560 events.
[07:05:32.124] <TB0> INFO: 2560 events read in total (298ms).
[07:05:32.124] <TB0> INFO: Test took 1159ms.
[07:05:32.428] <TB0> INFO: Expecting 2560 events.
[07:05:33.283] <TB0> INFO: 2560 events read in total (299ms).
[07:05:33.283] <TB0> INFO: Test took 1158ms.
[07:05:33.588] <TB0> INFO: Expecting 2560 events.
[07:05:34.444] <TB0> INFO: 2560 events read in total (300ms).
[07:05:34.444] <TB0> INFO: Test took 1160ms.
[07:05:34.749] <TB0> INFO: Expecting 2560 events.
[07:05:35.606] <TB0> INFO: 2560 events read in total (301ms).
[07:05:35.606] <TB0> INFO: Test took 1162ms.
[07:05:35.912] <TB0> INFO: Expecting 2560 events.
[07:05:36.766] <TB0> INFO: 2560 events read in total (298ms).
[07:05:36.766] <TB0> INFO: Test took 1159ms.
[07:05:37.071] <TB0> INFO: Expecting 2560 events.
[07:05:37.922] <TB0> INFO: 2560 events read in total (295ms).
[07:05:37.923] <TB0> INFO: Test took 1157ms.
[07:05:38.228] <TB0> INFO: Expecting 2560 events.
[07:05:39.086] <TB0> INFO: 2560 events read in total (301ms).
[07:05:39.086] <TB0> INFO: Test took 1163ms.
[07:05:39.391] <TB0> INFO: Expecting 2560 events.
[07:05:40.250] <TB0> INFO: 2560 events read in total (302ms).
[07:05:40.250] <TB0> INFO: Test took 1164ms.
[07:05:40.555] <TB0> INFO: Expecting 2560 events.
[07:05:41.413] <TB0> INFO: 2560 events read in total (302ms).
[07:05:41.414] <TB0> INFO: Test took 1164ms.
[07:05:41.416] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:05:41.720] <TB0> INFO: Expecting 655360 events.
[07:05:58.510] <TB0> INFO: 655360 events read in total (16234ms).
[07:05:58.519] <TB0> INFO: Expecting 655360 events.
[07:06:15.167] <TB0> INFO: 655360 events read in total (16246ms).
[07:06:15.179] <TB0> INFO: Expecting 655360 events.
[07:06:31.763] <TB0> INFO: 655360 events read in total (16183ms).
[07:06:31.780] <TB0> INFO: Expecting 655360 events.
[07:06:48.311] <TB0> INFO: 655360 events read in total (16129ms).
[07:06:48.332] <TB0> INFO: Expecting 655360 events.
[07:07:05.218] <TB0> INFO: 655360 events read in total (16485ms).
[07:07:05.243] <TB0> INFO: Expecting 655360 events.
[07:07:21.862] <TB0> INFO: 655360 events read in total (16217ms).
[07:07:21.888] <TB0> INFO: Expecting 655360 events.
[07:07:38.600] <TB0> INFO: 655360 events read in total (16310ms).
[07:07:38.629] <TB0> INFO: Expecting 655360 events.
[07:07:55.319] <TB0> INFO: 655360 events read in total (16288ms).
[07:07:55.351] <TB0> INFO: Expecting 655360 events.
[07:08:11.811] <TB0> INFO: 655360 events read in total (16059ms).
[07:08:11.847] <TB0> INFO: Expecting 655360 events.
[07:08:28.485] <TB0> INFO: 655360 events read in total (16236ms).
[07:08:28.524] <TB0> INFO: Expecting 655360 events.
[07:08:45.333] <TB0> INFO: 655360 events read in total (16407ms).
[07:08:45.378] <TB0> INFO: Expecting 655360 events.
[07:09:02.147] <TB0> INFO: 655360 events read in total (16367ms).
[07:09:02.193] <TB0> INFO: Expecting 655360 events.
[07:09:18.977] <TB0> INFO: 655360 events read in total (16382ms).
[07:09:19.027] <TB0> INFO: Expecting 655360 events.
[07:09:35.691] <TB0> INFO: 655360 events read in total (16263ms).
[07:09:35.744] <TB0> INFO: Expecting 655360 events.
[07:09:52.532] <TB0> INFO: 655360 events read in total (16386ms).
[07:09:52.589] <TB0> INFO: Expecting 655360 events.
[07:10:09.291] <TB0> INFO: 655360 events read in total (16301ms).
[07:10:09.350] <TB0> INFO: Test took 267934ms.
[07:10:09.439] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:10:09.668] <TB0> INFO: Expecting 655360 events.
[07:10:26.369] <TB0> INFO: 655360 events read in total (16144ms).
[07:10:26.378] <TB0> INFO: Expecting 655360 events.
[07:10:42.836] <TB0> INFO: 655360 events read in total (16056ms).
[07:10:42.850] <TB0> INFO: Expecting 655360 events.
[07:10:59.323] <TB0> INFO: 655360 events read in total (16071ms).
[07:10:59.341] <TB0> INFO: Expecting 655360 events.
[07:11:16.070] <TB0> INFO: 655360 events read in total (16328ms).
[07:11:16.091] <TB0> INFO: Expecting 655360 events.
[07:11:32.690] <TB0> INFO: 655360 events read in total (16198ms).
[07:11:32.711] <TB0> INFO: Expecting 655360 events.
[07:11:49.384] <TB0> INFO: 655360 events read in total (16271ms).
[07:11:49.410] <TB0> INFO: Expecting 655360 events.
[07:12:06.055] <TB0> INFO: 655360 events read in total (16243ms).
[07:12:06.089] <TB0> INFO: Expecting 655360 events.
[07:12:22.795] <TB0> INFO: 655360 events read in total (16304ms).
[07:12:22.827] <TB0> INFO: Expecting 655360 events.
[07:12:39.549] <TB0> INFO: 655360 events read in total (16321ms).
[07:12:39.588] <TB0> INFO: Expecting 655360 events.
[07:12:56.184] <TB0> INFO: 655360 events read in total (16194ms).
[07:12:56.226] <TB0> INFO: Expecting 655360 events.
[07:13:12.942] <TB0> INFO: 655360 events read in total (16314ms).
[07:13:12.985] <TB0> INFO: Expecting 655360 events.
[07:13:29.788] <TB0> INFO: 655360 events read in total (16401ms).
[07:13:29.833] <TB0> INFO: Expecting 655360 events.
[07:13:46.674] <TB0> INFO: 655360 events read in total (16439ms).
[07:13:46.724] <TB0> INFO: Expecting 655360 events.
[07:14:03.091] <TB0> INFO: 655360 events read in total (15966ms).
[07:14:03.144] <TB0> INFO: Expecting 655360 events.
[07:14:19.775] <TB0> INFO: 655360 events read in total (16229ms).
[07:14:19.839] <TB0> INFO: Expecting 655360 events.
[07:14:36.370] <TB0> INFO: 655360 events read in total (16129ms).
[07:14:36.428] <TB0> INFO: Test took 266989ms.
[07:14:36.629] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.636] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.642] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.649] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.656] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.663] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.669] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.676] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[07:14:36.683] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.690] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.696] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.703] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.710] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.720] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.728] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.735] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.742] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[07:14:36.777] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C0.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C1.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C2.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C3.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C4.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C5.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C6.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C7.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C8.dat
[07:14:36.778] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C9.dat
[07:14:36.779] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C10.dat
[07:14:36.779] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C11.dat
[07:14:36.779] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C12.dat
[07:14:36.779] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C13.dat
[07:14:36.779] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C14.dat
[07:14:36.779] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//dacParameters35_C15.dat
[07:14:37.060] <TB0> INFO: Expecting 41600 events.
[07:14:40.521] <TB0> INFO: 41600 events read in total (2905ms).
[07:14:40.522] <TB0> INFO: Test took 3740ms.
[07:14:40.961] <TB0> INFO: Expecting 41600 events.
[07:14:44.398] <TB0> INFO: 41600 events read in total (2881ms).
[07:14:44.399] <TB0> INFO: Test took 3699ms.
[07:14:44.837] <TB0> INFO: Expecting 41600 events.
[07:14:48.328] <TB0> INFO: 41600 events read in total (2935ms).
[07:14:48.328] <TB0> INFO: Test took 3751ms.
[07:14:48.511] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:48.599] <TB0> INFO: Expecting 2560 events.
[07:14:49.452] <TB0> INFO: 2560 events read in total (297ms).
[07:14:49.453] <TB0> INFO: Test took 942ms.
[07:14:49.454] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:49.758] <TB0> INFO: Expecting 2560 events.
[07:14:50.611] <TB0> INFO: 2560 events read in total (297ms).
[07:14:50.611] <TB0> INFO: Test took 1157ms.
[07:14:50.613] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:50.917] <TB0> INFO: Expecting 2560 events.
[07:14:51.771] <TB0> INFO: 2560 events read in total (298ms).
[07:14:51.771] <TB0> INFO: Test took 1158ms.
[07:14:51.773] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:52.076] <TB0> INFO: Expecting 2560 events.
[07:14:52.929] <TB0> INFO: 2560 events read in total (296ms).
[07:14:52.929] <TB0> INFO: Test took 1156ms.
[07:14:52.932] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:53.235] <TB0> INFO: Expecting 2560 events.
[07:14:54.088] <TB0> INFO: 2560 events read in total (297ms).
[07:14:54.088] <TB0> INFO: Test took 1156ms.
[07:14:54.091] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:54.394] <TB0> INFO: Expecting 2560 events.
[07:14:55.248] <TB0> INFO: 2560 events read in total (298ms).
[07:14:55.248] <TB0> INFO: Test took 1157ms.
[07:14:55.250] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:55.553] <TB0> INFO: Expecting 2560 events.
[07:14:56.410] <TB0> INFO: 2560 events read in total (301ms).
[07:14:56.410] <TB0> INFO: Test took 1160ms.
[07:14:56.412] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:56.715] <TB0> INFO: Expecting 2560 events.
[07:14:57.572] <TB0> INFO: 2560 events read in total (300ms).
[07:14:57.572] <TB0> INFO: Test took 1160ms.
[07:14:57.574] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:57.878] <TB0> INFO: Expecting 2560 events.
[07:14:58.731] <TB0> INFO: 2560 events read in total (297ms).
[07:14:58.732] <TB0> INFO: Test took 1158ms.
[07:14:58.733] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:14:59.037] <TB0> INFO: Expecting 2560 events.
[07:14:59.893] <TB0> INFO: 2560 events read in total (300ms).
[07:14:59.893] <TB0> INFO: Test took 1160ms.
[07:14:59.895] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:00.199] <TB0> INFO: Expecting 2560 events.
[07:15:01.055] <TB0> INFO: 2560 events read in total (299ms).
[07:15:01.056] <TB0> INFO: Test took 1161ms.
[07:15:01.058] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:01.360] <TB0> INFO: Expecting 2560 events.
[07:15:02.214] <TB0> INFO: 2560 events read in total (298ms).
[07:15:02.215] <TB0> INFO: Test took 1157ms.
[07:15:02.218] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:02.519] <TB0> INFO: Expecting 2560 events.
[07:15:03.373] <TB0> INFO: 2560 events read in total (298ms).
[07:15:03.373] <TB0> INFO: Test took 1155ms.
[07:15:03.375] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:03.679] <TB0> INFO: Expecting 2560 events.
[07:15:04.533] <TB0> INFO: 2560 events read in total (298ms).
[07:15:04.533] <TB0> INFO: Test took 1158ms.
[07:15:04.535] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:04.840] <TB0> INFO: Expecting 2560 events.
[07:15:05.695] <TB0> INFO: 2560 events read in total (299ms).
[07:15:05.695] <TB0> INFO: Test took 1160ms.
[07:15:05.698] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:06.001] <TB0> INFO: Expecting 2560 events.
[07:15:06.856] <TB0> INFO: 2560 events read in total (299ms).
[07:15:06.856] <TB0> INFO: Test took 1158ms.
[07:15:06.858] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:07.162] <TB0> INFO: Expecting 2560 events.
[07:15:08.015] <TB0> INFO: 2560 events read in total (297ms).
[07:15:08.015] <TB0> INFO: Test took 1157ms.
[07:15:08.017] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:08.321] <TB0> INFO: Expecting 2560 events.
[07:15:09.175] <TB0> INFO: 2560 events read in total (298ms).
[07:15:09.175] <TB0> INFO: Test took 1158ms.
[07:15:09.177] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:09.481] <TB0> INFO: Expecting 2560 events.
[07:15:10.335] <TB0> INFO: 2560 events read in total (298ms).
[07:15:10.335] <TB0> INFO: Test took 1158ms.
[07:15:10.337] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:10.641] <TB0> INFO: Expecting 2560 events.
[07:15:11.499] <TB0> INFO: 2560 events read in total (301ms).
[07:15:11.499] <TB0> INFO: Test took 1162ms.
[07:15:11.502] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:11.805] <TB0> INFO: Expecting 2560 events.
[07:15:12.658] <TB0> INFO: 2560 events read in total (297ms).
[07:15:12.658] <TB0> INFO: Test took 1157ms.
[07:15:12.660] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:12.964] <TB0> INFO: Expecting 2560 events.
[07:15:13.817] <TB0> INFO: 2560 events read in total (297ms).
[07:15:13.817] <TB0> INFO: Test took 1157ms.
[07:15:13.819] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:14.123] <TB0> INFO: Expecting 2560 events.
[07:15:14.976] <TB0> INFO: 2560 events read in total (297ms).
[07:15:14.976] <TB0> INFO: Test took 1157ms.
[07:15:14.978] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:15.282] <TB0> INFO: Expecting 2560 events.
[07:15:16.137] <TB0> INFO: 2560 events read in total (299ms).
[07:15:16.137] <TB0> INFO: Test took 1159ms.
[07:15:16.139] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:16.442] <TB0> INFO: Expecting 2560 events.
[07:15:17.299] <TB0> INFO: 2560 events read in total (301ms).
[07:15:17.299] <TB0> INFO: Test took 1160ms.
[07:15:17.302] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:17.604] <TB0> INFO: Expecting 2560 events.
[07:15:18.457] <TB0> INFO: 2560 events read in total (297ms).
[07:15:18.458] <TB0> INFO: Test took 1156ms.
[07:15:18.461] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:18.764] <TB0> INFO: Expecting 2560 events.
[07:15:19.623] <TB0> INFO: 2560 events read in total (303ms).
[07:15:19.623] <TB0> INFO: Test took 1163ms.
[07:15:19.625] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:19.928] <TB0> INFO: Expecting 2560 events.
[07:15:20.784] <TB0> INFO: 2560 events read in total (300ms).
[07:15:20.791] <TB0> INFO: Test took 1166ms.
[07:15:20.793] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:21.089] <TB0> INFO: Expecting 2560 events.
[07:15:21.946] <TB0> INFO: 2560 events read in total (300ms).
[07:15:21.946] <TB0> INFO: Test took 1153ms.
[07:15:21.947] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:22.252] <TB0> INFO: Expecting 2560 events.
[07:15:23.113] <TB0> INFO: 2560 events read in total (304ms).
[07:15:23.114] <TB0> INFO: Test took 1167ms.
[07:15:23.116] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:23.419] <TB0> INFO: Expecting 2560 events.
[07:15:24.275] <TB0> INFO: 2560 events read in total (299ms).
[07:15:24.275] <TB0> INFO: Test took 1159ms.
[07:15:24.277] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:15:24.581] <TB0> INFO: Expecting 2560 events.
[07:15:25.436] <TB0> INFO: 2560 events read in total (299ms).
[07:15:25.436] <TB0> INFO: Test took 1159ms.
[07:15:25.898] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 615 seconds
[07:15:25.898] <TB0> INFO: PH scale (per ROC): 79 85 85 85 84 67 80 82 82 92 89 80 79 72 89 79
[07:15:25.898] <TB0> INFO: PH offset (per ROC): 177 165 151 145 146 170 147 141 146 147 146 156 153 162 163 139
[07:15:25.901] <TB0> INFO: Decoding statistics:
[07:15:25.901] <TB0> INFO: General information:
[07:15:25.901] <TB0> INFO: 16bit words read: 91940
[07:15:25.902] <TB0> INFO: valid events total: 10240
[07:15:25.902] <TB0> INFO: empty events: 7735
[07:15:25.902] <TB0> INFO: valid events with pixels: 2505
[07:15:25.902] <TB0> INFO: valid pixel hits: 2505
[07:15:25.902] <TB0> INFO: Event errors: 0
[07:15:25.902] <TB0> INFO: start marker: 0
[07:15:25.902] <TB0> INFO: stop marker: 0
[07:15:25.902] <TB0> INFO: overflow: 0
[07:15:25.902] <TB0> INFO: invalid 5bit words: 0
[07:15:25.902] <TB0> INFO: invalid XOR eye diagram: 0
[07:15:25.902] <TB0> INFO: frame (failed synchr.): 0
[07:15:25.902] <TB0> INFO: idle data (no TBM trl): 0
[07:15:25.902] <TB0> INFO: no data (only TBM hdr): 0
[07:15:25.902] <TB0> INFO: TBM errors: 0
[07:15:25.902] <TB0> INFO: flawed TBM headers: 0
[07:15:25.902] <TB0> INFO: flawed TBM trailers: 0
[07:15:25.902] <TB0> INFO: event ID mismatches: 0
[07:15:25.902] <TB0> INFO: ROC errors: 0
[07:15:25.902] <TB0> INFO: missing ROC header(s): 0
[07:15:25.902] <TB0> INFO: misplaced readback start: 0
[07:15:25.902] <TB0> INFO: Pixel decoding errors: 0
[07:15:25.902] <TB0> INFO: pixel data incomplete: 0
[07:15:25.902] <TB0> INFO: pixel address: 0
[07:15:25.902] <TB0> INFO: pulse height fill bit: 0
[07:15:25.902] <TB0> INFO: buffer corruption: 0
[07:15:26.070] <TB0> INFO: ######################################################################
[07:15:26.070] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[07:15:26.070] <TB0> INFO: ######################################################################
[07:15:26.080] <TB0> INFO: scanning low vcal = 10
[07:15:26.350] <TB0> INFO: Expecting 41600 events.
[07:15:29.878] <TB0> INFO: 41600 events read in total (2972ms).
[07:15:29.878] <TB0> INFO: Test took 3798ms.
[07:15:29.879] <TB0> INFO: scanning low vcal = 20
[07:15:30.183] <TB0> INFO: Expecting 41600 events.
[07:15:33.742] <TB0> INFO: 41600 events read in total (3003ms).
[07:15:33.742] <TB0> INFO: Test took 3863ms.
[07:15:33.744] <TB0> INFO: scanning low vcal = 30
[07:15:34.047] <TB0> INFO: Expecting 41600 events.
[07:15:37.620] <TB0> INFO: 41600 events read in total (3016ms).
[07:15:37.621] <TB0> INFO: Test took 3877ms.
[07:15:37.623] <TB0> INFO: scanning low vcal = 40
[07:15:37.917] <TB0> INFO: Expecting 41600 events.
[07:15:42.061] <TB0> INFO: 41600 events read in total (3588ms).
[07:15:42.061] <TB0> INFO: Test took 4439ms.
[07:15:42.064] <TB0> INFO: scanning low vcal = 50
[07:15:42.327] <TB0> INFO: Expecting 41600 events.
[07:15:46.517] <TB0> INFO: 41600 events read in total (3634ms).
[07:15:46.518] <TB0> INFO: Test took 4454ms.
[07:15:46.521] <TB0> INFO: scanning low vcal = 60
[07:15:46.802] <TB0> INFO: Expecting 41600 events.
[07:15:50.998] <TB0> INFO: 41600 events read in total (3640ms).
[07:15:50.998] <TB0> INFO: Test took 4477ms.
[07:15:51.001] <TB0> INFO: scanning low vcal = 70
[07:15:51.260] <TB0> INFO: Expecting 41600 events.
[07:15:55.456] <TB0> INFO: 41600 events read in total (3639ms).
[07:15:55.457] <TB0> INFO: Test took 4456ms.
[07:15:55.459] <TB0> INFO: scanning low vcal = 80
[07:15:55.720] <TB0> INFO: Expecting 41600 events.
[07:15:59.912] <TB0> INFO: 41600 events read in total (3635ms).
[07:15:59.913] <TB0> INFO: Test took 4454ms.
[07:15:59.916] <TB0> INFO: scanning low vcal = 90
[07:16:00.188] <TB0> INFO: Expecting 41600 events.
[07:16:04.368] <TB0> INFO: 41600 events read in total (3624ms).
[07:16:04.368] <TB0> INFO: Test took 4452ms.
[07:16:04.371] <TB0> INFO: scanning low vcal = 100
[07:16:04.630] <TB0> INFO: Expecting 41600 events.
[07:16:08.849] <TB0> INFO: 41600 events read in total (3663ms).
[07:16:08.850] <TB0> INFO: Test took 4479ms.
[07:16:08.853] <TB0> INFO: scanning low vcal = 110
[07:16:09.132] <TB0> INFO: Expecting 41600 events.
[07:16:13.320] <TB0> INFO: 41600 events read in total (3631ms).
[07:16:13.321] <TB0> INFO: Test took 4468ms.
[07:16:13.324] <TB0> INFO: scanning low vcal = 120
[07:16:13.587] <TB0> INFO: Expecting 41600 events.
[07:16:17.801] <TB0> INFO: 41600 events read in total (3658ms).
[07:16:17.802] <TB0> INFO: Test took 4478ms.
[07:16:17.804] <TB0> INFO: scanning low vcal = 130
[07:16:18.074] <TB0> INFO: Expecting 41600 events.
[07:16:22.354] <TB0> INFO: 41600 events read in total (3724ms).
[07:16:22.355] <TB0> INFO: Test took 4551ms.
[07:16:22.358] <TB0> INFO: scanning low vcal = 140
[07:16:22.624] <TB0> INFO: Expecting 41600 events.
[07:16:26.818] <TB0> INFO: 41600 events read in total (3638ms).
[07:16:26.819] <TB0> INFO: Test took 4461ms.
[07:16:26.821] <TB0> INFO: scanning low vcal = 150
[07:16:27.091] <TB0> INFO: Expecting 41600 events.
[07:16:31.262] <TB0> INFO: 41600 events read in total (3615ms).
[07:16:31.263] <TB0> INFO: Test took 4441ms.
[07:16:31.265] <TB0> INFO: scanning low vcal = 160
[07:16:31.536] <TB0> INFO: Expecting 41600 events.
[07:16:35.709] <TB0> INFO: 41600 events read in total (3617ms).
[07:16:35.709] <TB0> INFO: Test took 4444ms.
[07:16:35.712] <TB0> INFO: scanning low vcal = 170
[07:16:35.983] <TB0> INFO: Expecting 41600 events.
[07:16:40.158] <TB0> INFO: 41600 events read in total (3619ms).
[07:16:40.158] <TB0> INFO: Test took 4445ms.
[07:16:40.162] <TB0> INFO: scanning low vcal = 180
[07:16:40.422] <TB0> INFO: Expecting 41600 events.
[07:16:44.599] <TB0> INFO: 41600 events read in total (3621ms).
[07:16:44.600] <TB0> INFO: Test took 4438ms.
[07:16:44.602] <TB0> INFO: scanning low vcal = 190
[07:16:44.873] <TB0> INFO: Expecting 41600 events.
[07:16:49.054] <TB0> INFO: 41600 events read in total (3624ms).
[07:16:49.055] <TB0> INFO: Test took 4453ms.
[07:16:49.058] <TB0> INFO: scanning low vcal = 200
[07:16:49.326] <TB0> INFO: Expecting 41600 events.
[07:16:53.560] <TB0> INFO: 41600 events read in total (3678ms).
[07:16:53.560] <TB0> INFO: Test took 4502ms.
[07:16:53.563] <TB0> INFO: scanning low vcal = 210
[07:16:53.852] <TB0> INFO: Expecting 41600 events.
[07:16:58.048] <TB0> INFO: 41600 events read in total (3640ms).
[07:16:58.049] <TB0> INFO: Test took 4486ms.
[07:16:58.051] <TB0> INFO: scanning low vcal = 220
[07:16:58.324] <TB0> INFO: Expecting 41600 events.
[07:17:02.541] <TB0> INFO: 41600 events read in total (3661ms).
[07:17:02.542] <TB0> INFO: Test took 4491ms.
[07:17:02.545] <TB0> INFO: scanning low vcal = 230
[07:17:02.824] <TB0> INFO: Expecting 41600 events.
[07:17:07.014] <TB0> INFO: 41600 events read in total (3633ms).
[07:17:07.015] <TB0> INFO: Test took 4470ms.
[07:17:07.017] <TB0> INFO: scanning low vcal = 240
[07:17:07.289] <TB0> INFO: Expecting 41600 events.
[07:17:11.460] <TB0> INFO: 41600 events read in total (3615ms).
[07:17:11.460] <TB0> INFO: Test took 4443ms.
[07:17:11.463] <TB0> INFO: scanning low vcal = 250
[07:17:11.732] <TB0> INFO: Expecting 41600 events.
[07:17:15.891] <TB0> INFO: 41600 events read in total (3603ms).
[07:17:15.892] <TB0> INFO: Test took 4429ms.
[07:17:15.896] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[07:17:16.161] <TB0> INFO: Expecting 41600 events.
[07:17:20.372] <TB0> INFO: 41600 events read in total (3655ms).
[07:17:20.372] <TB0> INFO: Test took 4476ms.
[07:17:20.375] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[07:17:20.639] <TB0> INFO: Expecting 41600 events.
[07:17:24.800] <TB0> INFO: 41600 events read in total (3605ms).
[07:17:24.801] <TB0> INFO: Test took 4426ms.
[07:17:24.804] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[07:17:25.067] <TB0> INFO: Expecting 41600 events.
[07:17:29.243] <TB0> INFO: 41600 events read in total (3620ms).
[07:17:29.243] <TB0> INFO: Test took 4438ms.
[07:17:29.246] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[07:17:29.515] <TB0> INFO: Expecting 41600 events.
[07:17:33.770] <TB0> INFO: 41600 events read in total (3699ms).
[07:17:33.771] <TB0> INFO: Test took 4525ms.
[07:17:33.774] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[07:17:34.072] <TB0> INFO: Expecting 41600 events.
[07:17:38.279] <TB0> INFO: 41600 events read in total (3651ms).
[07:17:38.280] <TB0> INFO: Test took 4506ms.
[07:17:38.767] <TB0> INFO: PixTestGainPedestal::measure() done
[07:18:13.773] <TB0> INFO: PixTestGainPedestal::fit() done
[07:18:13.774] <TB0> INFO: non-linearity mean: 0.955 0.956 0.960 0.956 0.955 0.952 0.953 0.955 0.952 0.953 0.946 0.949 0.958 0.951 0.955 0.953
[07:18:13.774] <TB0> INFO: non-linearity RMS: 0.006 0.007 0.005 0.005 0.006 0.006 0.006 0.005 0.006 0.005 0.006 0.005 0.006 0.007 0.008 0.006
[07:18:13.774] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[07:18:13.806] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[07:18:13.829] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[07:18:13.848] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[07:18:13.877] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[07:18:13.910] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[07:18:13.940] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[07:18:13.971] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[07:18:13.997] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[07:18:14.017] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[07:18:14.036] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[07:18:14.055] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[07:18:14.074] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[07:18:14.093] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[07:18:14.112] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[07:18:14.138] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[07:18:14.165] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 168 seconds
[07:18:14.165] <TB0> INFO: Decoding statistics:
[07:18:14.165] <TB0> INFO: General information:
[07:18:14.165] <TB0> INFO: 16bit words read: 2662400
[07:18:14.165] <TB0> INFO: valid events total: 166400
[07:18:14.165] <TB0> INFO: empty events: 0
[07:18:14.165] <TB0> INFO: valid events with pixels: 166400
[07:18:14.165] <TB0> INFO: valid pixel hits: 665572
[07:18:14.165] <TB0> INFO: Event errors: 0
[07:18:14.165] <TB0> INFO: start marker: 0
[07:18:14.165] <TB0> INFO: stop marker: 0
[07:18:14.165] <TB0> INFO: overflow: 0
[07:18:14.165] <TB0> INFO: invalid 5bit words: 0
[07:18:14.165] <TB0> INFO: invalid XOR eye diagram: 0
[07:18:14.165] <TB0> INFO: frame (failed synchr.): 0
[07:18:14.165] <TB0> INFO: idle data (no TBM trl): 0
[07:18:14.165] <TB0> INFO: no data (only TBM hdr): 0
[07:18:14.165] <TB0> INFO: TBM errors: 0
[07:18:14.165] <TB0> INFO: flawed TBM headers: 0
[07:18:14.165] <TB0> INFO: flawed TBM trailers: 0
[07:18:14.165] <TB0> INFO: event ID mismatches: 0
[07:18:14.165] <TB0> INFO: ROC errors: 0
[07:18:14.165] <TB0> INFO: missing ROC header(s): 0
[07:18:14.165] <TB0> INFO: misplaced readback start: 0
[07:18:14.165] <TB0> INFO: Pixel decoding errors: 0
[07:18:14.165] <TB0> INFO: pixel data incomplete: 0
[07:18:14.165] <TB0> INFO: pixel address: 0
[07:18:14.165] <TB0> INFO: pulse height fill bit: 0
[07:18:14.165] <TB0> INFO: buffer corruption: 0
[07:18:14.176] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C15.dat
[07:18:14.177] <TB0> INFO: ######################################################################
[07:18:14.177] <TB0> INFO: PixTestReadback::doTest()
[07:18:14.177] <TB0> INFO: ######################################################################
[07:18:14.177] <TB0> INFO: ----------------------------------------------------------------------
[07:18:14.177] <TB0> INFO: PixTestReadback::CalibrateVd()
[07:18:14.177] <TB0> INFO: ----------------------------------------------------------------------
[07:18:23.664] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C0.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C1.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C2.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C3.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C4.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C5.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C6.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C7.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C8.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C9.dat
[07:18:23.665] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C10.dat
[07:18:23.666] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C11.dat
[07:18:23.666] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C12.dat
[07:18:23.666] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C13.dat
[07:18:23.666] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C14.dat
[07:18:23.666] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C15.dat
[07:18:23.697] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[07:18:23.697] <TB0> INFO: ----------------------------------------------------------------------
[07:18:23.697] <TB0> INFO: PixTestReadback::CalibrateVa()
[07:18:23.697] <TB0> INFO: ----------------------------------------------------------------------
[07:18:33.207] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C0.dat
[07:18:33.207] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C1.dat
[07:18:33.207] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C2.dat
[07:18:33.207] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C3.dat
[07:18:33.207] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C4.dat
[07:18:33.207] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C5.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C6.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C7.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C8.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C9.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C10.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C11.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C12.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C13.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C14.dat
[07:18:33.208] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C15.dat
[07:18:33.229] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[07:18:33.229] <TB0> INFO: ----------------------------------------------------------------------
[07:18:33.229] <TB0> INFO: PixTestReadback::readbackVbg()
[07:18:33.229] <TB0> INFO: ----------------------------------------------------------------------
[07:18:40.540] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[07:18:40.540] <TB0> INFO: ----------------------------------------------------------------------
[07:18:40.540] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[07:18:40.540] <TB0> INFO: ----------------------------------------------------------------------
[07:18:40.540] <TB0> INFO: Vbg will be calibrated using Vd calibration
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 145calibrated Vbg = 1.21356 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 153.6calibrated Vbg = 1.20906 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 147.1calibrated Vbg = 1.21221 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 152.1calibrated Vbg = 1.21483 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 151.8calibrated Vbg = 1.21509 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 148.3calibrated Vbg = 1.22117 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 150.4calibrated Vbg = 1.2222 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 151calibrated Vbg = 1.21581 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 137.5calibrated Vbg = 1.22839 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 152.3calibrated Vbg = 1.23013 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 151.8calibrated Vbg = 1.22268 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 153.1calibrated Vbg = 1.22135 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 151.3calibrated Vbg = 1.21452 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 155calibrated Vbg = 1.22017 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 151.2calibrated Vbg = 1.21847 :::*/*/*/*/
[07:18:40.540] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 142.2calibrated Vbg = 1.21984 :::*/*/*/*/
[07:18:40.543] <TB0> INFO: ----------------------------------------------------------------------
[07:18:40.543] <TB0> INFO: PixTestReadback::CalibrateIa()
[07:18:40.543] <TB0> INFO: ----------------------------------------------------------------------
[07:21:15.838] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C0.dat
[07:21:15.838] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C1.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C2.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C3.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C4.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C5.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C6.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C7.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C8.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C9.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C10.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C11.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C12.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C13.dat
[07:21:15.839] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C14.dat
[07:21:15.840] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2271_FullQualification_2016-07-18_07h31m_1468819860//000_FulltestPxar_m20//readbackCal_C15.dat
[07:21:15.867] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[07:21:15.867] <TB0> INFO: PixTestReadback::doTest() done
[07:21:15.867] <TB0> INFO: Decoding statistics:
[07:21:15.867] <TB0> INFO: General information:
[07:21:15.867] <TB0> INFO: 16bit words read: 1024
[07:21:15.867] <TB0> INFO: valid events total: 128
[07:21:15.867] <TB0> INFO: empty events: 128
[07:21:15.867] <TB0> INFO: valid events with pixels: 0
[07:21:15.867] <TB0> INFO: valid pixel hits: 0
[07:21:15.867] <TB0> INFO: Event errors: 0
[07:21:15.867] <TB0> INFO: start marker: 0
[07:21:15.867] <TB0> INFO: stop marker: 0
[07:21:15.867] <TB0> INFO: overflow: 0
[07:21:15.867] <TB0> INFO: invalid 5bit words: 0
[07:21:15.867] <TB0> INFO: invalid XOR eye diagram: 0
[07:21:15.867] <TB0> INFO: frame (failed synchr.): 0
[07:21:15.867] <TB0> INFO: idle data (no TBM trl): 0
[07:21:15.867] <TB0> INFO: no data (only TBM hdr): 0
[07:21:15.867] <TB0> INFO: TBM errors: 0
[07:21:15.867] <TB0> INFO: flawed TBM headers: 0
[07:21:15.867] <TB0> INFO: flawed TBM trailers: 0
[07:21:15.867] <TB0> INFO: event ID mismatches: 0
[07:21:15.867] <TB0> INFO: ROC errors: 0
[07:21:15.868] <TB0> INFO: missing ROC header(s): 0
[07:21:15.868] <TB0> INFO: misplaced readback start: 0
[07:21:15.868] <TB0> INFO: Pixel decoding errors: 0
[07:21:15.868] <TB0> INFO: pixel data incomplete: 0
[07:21:15.868] <TB0> INFO: pixel address: 0
[07:21:15.868] <TB0> INFO: pulse height fill bit: 0
[07:21:15.868] <TB0> INFO: buffer corruption: 0
[07:21:15.885] <TB0> INFO: Decoding statistics:
[07:21:15.885] <TB0> INFO: General information:
[07:21:15.885] <TB0> INFO: 16bit words read: 2755364
[07:21:15.885] <TB0> INFO: valid events total: 176768
[07:21:15.885] <TB0> INFO: empty events: 7863
[07:21:15.885] <TB0> INFO: valid events with pixels: 168905
[07:21:15.885] <TB0> INFO: valid pixel hits: 668077
[07:21:15.885] <TB0> INFO: Event errors: 0
[07:21:15.885] <TB0> INFO: start marker: 0
[07:21:15.885] <TB0> INFO: stop marker: 0
[07:21:15.885] <TB0> INFO: overflow: 0
[07:21:15.885] <TB0> INFO: invalid 5bit words: 0
[07:21:15.885] <TB0> INFO: invalid XOR eye diagram: 0
[07:21:15.885] <TB0> INFO: frame (failed synchr.): 0
[07:21:15.885] <TB0> INFO: idle data (no TBM trl): 0
[07:21:15.885] <TB0> INFO: no data (only TBM hdr): 0
[07:21:15.885] <TB0> INFO: TBM errors: 0
[07:21:15.885] <TB0> INFO: flawed TBM headers: 0
[07:21:15.885] <TB0> INFO: flawed TBM trailers: 0
[07:21:15.885] <TB0> INFO: event ID mismatches: 0
[07:21:15.885] <TB0> INFO: ROC errors: 0
[07:21:15.885] <TB0> INFO: missing ROC header(s): 0
[07:21:15.885] <TB0> INFO: misplaced readback start: 0
[07:21:15.885] <TB0> INFO: Pixel decoding errors: 0
[07:21:15.885] <TB0> INFO: pixel data incomplete: 0
[07:21:15.885] <TB0> INFO: pixel address: 0
[07:21:15.885] <TB0> INFO: pulse height fill bit: 0
[07:21:15.885] <TB0> INFO: buffer corruption: 0
[07:21:15.885] <TB0> INFO: enter test to run
[07:21:15.885] <TB0> INFO: test: exit no parameter change
[07:21:16.024] <TB0> QUIET: Connection to board 73 closed.
[07:21:16.103] <TB0> INFO: pXar: this is the end, my friend