[12:17:56.086] <TB2> INFO: *** Welcome to pxar ***
[12:17:56.086] <TB2> INFO: *** Today: 2016/09/08
[12:17:56.181] <TB2> INFO: *** Version: fe94
[12:17:56.181] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C15.dat
[12:17:56.182] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//tbmParameters_C0b.dat
[12:17:56.182] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//defaultMaskFile.dat
[12:17:56.183] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters_C15.dat
[12:17:56.263] <TB2> INFO: clk: 4
[12:17:56.263] <TB2> INFO: ctr: 4
[12:17:56.263] <TB2> INFO: sda: 19
[12:17:56.263] <TB2> INFO: tin: 9
[12:17:56.263] <TB2> INFO: level: 15
[12:17:56.263] <TB2> INFO: triggerdelay: 0
[12:17:56.264] <TB2> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[12:17:56.264] <TB2> INFO: Log level: INFO
[12:17:56.271] <TB2> INFO: Found DTB DTB_WXC55Z
[12:17:56.278] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[12:17:56.280] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[12:17:56.282] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[12:17:57.826] <TB2> INFO: DUT info:
[12:17:57.826] <TB2> INFO: The DUT currently contains the following objects:
[12:17:57.826] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[12:17:57.826] <TB2> INFO: TBM Core alpha (0): 7 registers set
[12:17:57.826] <TB2> INFO: TBM Core beta (1): 7 registers set
[12:17:57.826] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:17:57.826] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:57.826] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:17:58.227] <TB2> INFO: enter 'restricted' command line mode
[12:17:58.227] <TB2> INFO: enter test to run
[12:17:58.227] <TB2> INFO: test: pretest no parameter change
[12:17:58.227] <TB2> INFO: running: pretest
[12:17:58.235] <TB2> INFO: ----------------------------------------------------------------------
[12:17:58.235] <TB2> INFO: PixTestPretest::programROC()
[12:17:58.235] <TB2> INFO: ----------------------------------------------------------------------
[12:18:16.249] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[12:18:16.249] <TB2> INFO: IA differences per ROC: 20.9 20.9 20.9 20.9 19.3 20.1 20.9 17.7 20.1 20.1 17.7 20.9 20.9 20.1 19.3 20.1
[12:18:16.363] <TB2> INFO: enter test to run
[12:18:16.363] <TB2> INFO: test: pretest no parameter change
[12:18:16.363] <TB2> INFO: running: pretest
[12:18:16.364] <TB2> INFO: ----------------------------------------------------------------------
[12:18:16.364] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[12:18:16.364] <TB2> INFO: ----------------------------------------------------------------------
[12:18:23.145] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 409.2 mA = 25.575 mA/ROC
[12:18:23.145] <TB2> INFO: i(loss) [mA/ROC]: 20.9 20.9 20.9 20.9 20.1 20.9 20.1 20.1 20.1 20.1 20.9 20.9 20.1 20.9 20.1 20.1
[12:18:23.171] <TB2> INFO: enter test to run
[12:18:23.171] <TB2> INFO: test: pretest no parameter change
[12:18:23.171] <TB2> INFO: running: pretest
[12:18:23.171] <TB2> INFO: ----------------------------------------------------------------------
[12:18:23.171] <TB2> INFO: PixTestPretest::findTiming()
[12:18:23.171] <TB2> INFO: ----------------------------------------------------------------------
[12:18:23.171] <TB2> INFO: PixTestCmd::init()

[12:19:53.081] <TB2> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[12:19:53.082] <TB2> INFO: (success/tries = 100/100), width = 4
[12:19:53.083] <TB2> INFO: enter test to run
[12:19:53.083] <TB2> INFO: test: pretest no parameter change
[12:19:53.083] <TB2> INFO: running: pretest
[12:19:53.084] <TB2> INFO: ----------------------------------------------------------------------
[12:19:53.084] <TB2> INFO: PixTestPretest::findWorkingPixel()
[12:19:53.084] <TB2> INFO: ----------------------------------------------------------------------
[12:19:53.177] <TB2> INFO: Expecting 231680 events.


[12:20:03.492] <TB2> INFO: 231680 events read in total (9759ms).
[12:20:03.497] <TB2> INFO: Test took 10408ms.
[12:20:03.714] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[12:20:03.792] <TB2> INFO: enter test to run
[12:20:03.792] <TB2> INFO: test: pretest no parameter change
[12:20:03.792] <TB2> INFO: running: pretest
[12:20:03.793] <TB2> INFO: ----------------------------------------------------------------------
[12:20:03.793] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[12:20:03.793] <TB2> INFO: ----------------------------------------------------------------------
[12:20:03.884] <TB2> INFO: Expecting 231680 events.
[12:20:14.178] <TB2> INFO: 231680 events read in total (9737ms).
[12:20:14.182] <TB2> INFO: Test took 10386ms.
[12:20:14.413] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[12:20:14.413] <TB2> INFO: CalDel: 179 183 168 149 176 183 173 148 134 141 147 146 129 151 176 164
[12:20:14.413] <TB2> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[12:20:14.447] <TB2> INFO: enter test to run
[12:20:14.447] <TB2> INFO: test: pretest no parameter change
[12:20:14.447] <TB2> INFO: running: pretest
[12:20:14.447] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C0.dat
[12:20:14.447] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C1.dat
[12:20:14.447] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C2.dat
[12:20:14.447] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C3.dat
[12:20:14.447] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C4.dat
[12:20:14.447] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C5.dat
[12:20:14.447] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C6.dat
[12:20:14.447] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C7.dat
[12:20:14.448] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C8.dat
[12:20:14.448] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C9.dat
[12:20:14.448] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C10.dat
[12:20:14.448] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C11.dat
[12:20:14.448] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C12.dat
[12:20:14.448] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C13.dat
[12:20:14.448] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C14.dat
[12:20:14.448] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters_C15.dat
[12:20:14.448] <TB2> INFO: enter test to run
[12:20:14.448] <TB2> INFO: test: fulltest no parameter change
[12:20:14.448] <TB2> INFO: running: fulltest
[12:20:14.448] <TB2> INFO: ######################################################################
[12:20:14.448] <TB2> INFO: PixTestFullTest::doTest()
[12:20:14.448] <TB2> INFO: ######################################################################
[12:20:14.450] <TB2> INFO: ######################################################################
[12:20:14.450] <TB2> INFO: PixTestAlive::doTest()
[12:20:14.450] <TB2> INFO: ######################################################################
[12:20:14.451] <TB2> INFO: ----------------------------------------------------------------------
[12:20:14.451] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:20:14.451] <TB2> INFO: ----------------------------------------------------------------------
[12:20:14.715] <TB2> INFO: Expecting 41600 events.
[12:20:18.567] <TB2> INFO: 41600 events read in total (3296ms).
[12:20:18.568] <TB2> INFO: Test took 4116ms.
[12:20:18.791] <TB2> INFO: PixTestAlive::aliveTest() done
[12:20:18.791] <TB2> INFO: number of dead pixels (per ROC): 0 0 2 0 0 0 0 0 0 0 0 0 1 0 2 0
[12:20:18.792] <TB2> INFO: ----------------------------------------------------------------------
[12:20:18.793] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:20:18.793] <TB2> INFO: ----------------------------------------------------------------------
[12:20:19.077] <TB2> INFO: Expecting 41600 events.
[12:20:22.059] <TB2> INFO: 41600 events read in total (2426ms).
[12:20:22.059] <TB2> INFO: Test took 3265ms.
[12:20:22.060] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:20:22.311] <TB2> INFO: PixTestAlive::maskTest() done
[12:20:22.311] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:20:22.312] <TB2> INFO: ----------------------------------------------------------------------
[12:20:22.312] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:20:22.312] <TB2> INFO: ----------------------------------------------------------------------
[12:20:22.600] <TB2> INFO: Expecting 41600 events.
[12:20:26.389] <TB2> INFO: 41600 events read in total (3233ms).
[12:20:26.390] <TB2> INFO: Test took 4075ms.
[12:20:26.617] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[12:20:26.617] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:20:26.617] <TB2> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[12:20:26.617] <TB2> INFO: Decoding statistics:
[12:20:26.617] <TB2> INFO: General information:
[12:20:26.617] <TB2> INFO: 16bit words read: 0
[12:20:26.617] <TB2> INFO: valid events total: 0
[12:20:26.617] <TB2> INFO: empty events: 0
[12:20:26.617] <TB2> INFO: valid events with pixels: 0
[12:20:26.617] <TB2> INFO: valid pixel hits: 0
[12:20:26.617] <TB2> INFO: Event errors: 0
[12:20:26.617] <TB2> INFO: start marker: 0
[12:20:26.617] <TB2> INFO: stop marker: 0
[12:20:26.617] <TB2> INFO: overflow: 0
[12:20:26.617] <TB2> INFO: invalid 5bit words: 0
[12:20:26.617] <TB2> INFO: invalid XOR eye diagram: 0
[12:20:26.617] <TB2> INFO: frame (failed synchr.): 0
[12:20:26.617] <TB2> INFO: idle data (no TBM trl): 0
[12:20:26.617] <TB2> INFO: no data (only TBM hdr): 0
[12:20:26.617] <TB2> INFO: TBM errors: 0
[12:20:26.617] <TB2> INFO: flawed TBM headers: 0
[12:20:26.617] <TB2> INFO: flawed TBM trailers: 0
[12:20:26.617] <TB2> INFO: event ID mismatches: 0
[12:20:26.617] <TB2> INFO: ROC errors: 0
[12:20:26.617] <TB2> INFO: missing ROC header(s): 0
[12:20:26.617] <TB2> INFO: misplaced readback start: 0
[12:20:26.617] <TB2> INFO: Pixel decoding errors: 0
[12:20:26.617] <TB2> INFO: pixel data incomplete: 0
[12:20:26.617] <TB2> INFO: pixel address: 0
[12:20:26.617] <TB2> INFO: pulse height fill bit: 0
[12:20:26.617] <TB2> INFO: buffer corruption: 0
[12:20:26.629] <TB2> INFO: ######################################################################
[12:20:26.629] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[12:20:26.630] <TB2> INFO: ######################################################################
[12:20:26.633] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[12:20:26.644] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[12:20:26.644] <TB2> INFO: run 1 of 1
[12:20:26.909] <TB2> INFO: Expecting 3120000 events.
[12:21:06.961] <TB2> INFO: 836925 events read in total (39496ms).
[12:21:45.949] <TB2> INFO: 1661485 events read in total (78484ms).
[12:22:25.640] <TB2> INFO: 2491350 events read in total (118176ms).
[12:22:56.291] <TB2> INFO: 3120000 events read in total (148826ms).
[12:22:56.358] <TB2> INFO: Test took 149714ms.
[12:23:21.085] <TB2> INFO: PixTestBBMap::doTest() done, duration: 174 seconds
[12:23:21.085] <TB2> INFO: number of dead bumps (per ROC): 2 0 0 0 0 0 0 0 2 2 0 1 0 0 0 0
[12:23:21.085] <TB2> INFO: separation cut (per ROC): 90 85 96 85 75 91 93 81 96 81 81 86 82 112 85 83
[12:23:21.085] <TB2> INFO: Decoding statistics:
[12:23:21.085] <TB2> INFO: General information:
[12:23:21.085] <TB2> INFO: 16bit words read: 0
[12:23:21.085] <TB2> INFO: valid events total: 0
[12:23:21.085] <TB2> INFO: empty events: 0
[12:23:21.085] <TB2> INFO: valid events with pixels: 0
[12:23:21.085] <TB2> INFO: valid pixel hits: 0
[12:23:21.085] <TB2> INFO: Event errors: 0
[12:23:21.085] <TB2> INFO: start marker: 0
[12:23:21.085] <TB2> INFO: stop marker: 0
[12:23:21.085] <TB2> INFO: overflow: 0
[12:23:21.085] <TB2> INFO: invalid 5bit words: 0
[12:23:21.085] <TB2> INFO: invalid XOR eye diagram: 0
[12:23:21.085] <TB2> INFO: frame (failed synchr.): 0
[12:23:21.085] <TB2> INFO: idle data (no TBM trl): 0
[12:23:21.085] <TB2> INFO: no data (only TBM hdr): 0
[12:23:21.085] <TB2> INFO: TBM errors: 0
[12:23:21.085] <TB2> INFO: flawed TBM headers: 0
[12:23:21.085] <TB2> INFO: flawed TBM trailers: 0
[12:23:21.085] <TB2> INFO: event ID mismatches: 0
[12:23:21.085] <TB2> INFO: ROC errors: 0
[12:23:21.085] <TB2> INFO: missing ROC header(s): 0
[12:23:21.085] <TB2> INFO: misplaced readback start: 0
[12:23:21.086] <TB2> INFO: Pixel decoding errors: 0
[12:23:21.086] <TB2> INFO: pixel data incomplete: 0
[12:23:21.086] <TB2> INFO: pixel address: 0
[12:23:21.086] <TB2> INFO: pulse height fill bit: 0
[12:23:21.086] <TB2> INFO: buffer corruption: 0
[12:23:21.172] <TB2> INFO: ######################################################################
[12:23:21.172] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:23:21.172] <TB2> INFO: ######################################################################
[12:23:21.172] <TB2> INFO: ----------------------------------------------------------------------
[12:23:21.172] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:23:21.172] <TB2> INFO: ----------------------------------------------------------------------
[12:23:21.172] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:23:21.180] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[12:23:21.180] <TB2> INFO: run 1 of 1
[12:23:21.448] <TB2> INFO: Expecting 26208000 events.
[12:23:54.815] <TB2> INFO: 910100 events read in total (32811ms).
[12:24:28.134] <TB2> INFO: 1803000 events read in total (66130ms).
[12:25:00.977] <TB2> INFO: 2695850 events read in total (98973ms).
[12:25:33.829] <TB2> INFO: 3589700 events read in total (131826ms).
[12:26:06.489] <TB2> INFO: 4479250 events read in total (164485ms).
[12:26:39.119] <TB2> INFO: 5370350 events read in total (197115ms).
[12:27:11.559] <TB2> INFO: 6260600 events read in total (229555ms).
[12:27:44.572] <TB2> INFO: 7151200 events read in total (262568ms).
[12:28:17.516] <TB2> INFO: 8040400 events read in total (295512ms).
[12:28:50.270] <TB2> INFO: 8931000 events read in total (328266ms).
[12:29:23.249] <TB2> INFO: 9820450 events read in total (361245ms).
[12:29:56.026] <TB2> INFO: 10709800 events read in total (394022ms).
[12:30:28.907] <TB2> INFO: 11597050 events read in total (426903ms).
[12:31:01.890] <TB2> INFO: 12485550 events read in total (459886ms).
[12:31:34.940] <TB2> INFO: 13367300 events read in total (492936ms).
[12:32:07.785] <TB2> INFO: 14247150 events read in total (525781ms).
[12:32:40.724] <TB2> INFO: 15123600 events read in total (558720ms).
[12:33:13.240] <TB2> INFO: 16000000 events read in total (591236ms).
[12:33:45.863] <TB2> INFO: 16873850 events read in total (623859ms).
[12:34:18.504] <TB2> INFO: 17748900 events read in total (656500ms).
[12:34:51.258] <TB2> INFO: 18622500 events read in total (689254ms).
[12:35:23.953] <TB2> INFO: 19496000 events read in total (721949ms).
[12:35:56.603] <TB2> INFO: 20370850 events read in total (754599ms).
[12:36:29.204] <TB2> INFO: 21243000 events read in total (787200ms).
[12:37:01.513] <TB2> INFO: 22115800 events read in total (819509ms).
[12:37:34.226] <TB2> INFO: 22988950 events read in total (852222ms).
[12:38:07.049] <TB2> INFO: 23863450 events read in total (885045ms).
[12:38:39.507] <TB2> INFO: 24737950 events read in total (917503ms).
[12:39:12.019] <TB2> INFO: 25611800 events read in total (950015ms).
[12:39:33.798] <TB2> INFO: 26208000 events read in total (971794ms).
[12:39:33.836] <TB2> INFO: Test took 972655ms.
[12:39:34.120] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:35.576] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:36.998] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:38.435] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:39.879] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:41.305] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:42.693] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:44.114] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:45.535] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:46.919] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:48.347] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:49.788] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:51.277] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:52.779] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:54.267] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:55.766] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[12:39:57.435] <TB2> INFO: PixTestScurves::scurves() done
[12:39:57.435] <TB2> INFO: Vcal mean: 98.01 90.04 89.61 84.33 94.26 104.19 97.12 89.54 101.40 88.89 84.80 83.06 80.06 108.28 92.98 77.85
[12:39:57.435] <TB2> INFO: Vcal RMS: 6.14 5.94 5.15 4.46 6.10 6.65 5.79 5.09 5.23 4.78 4.35 4.43 4.47 4.93 6.55 4.22
[12:39:57.435] <TB2> INFO: PixTestScurves::fullTest() done, duration: 996 seconds
[12:39:57.435] <TB2> INFO: Decoding statistics:
[12:39:57.435] <TB2> INFO: General information:
[12:39:57.435] <TB2> INFO: 16bit words read: 0
[12:39:57.435] <TB2> INFO: valid events total: 0
[12:39:57.435] <TB2> INFO: empty events: 0
[12:39:57.435] <TB2> INFO: valid events with pixels: 0
[12:39:57.435] <TB2> INFO: valid pixel hits: 0
[12:39:57.435] <TB2> INFO: Event errors: 0
[12:39:57.435] <TB2> INFO: start marker: 0
[12:39:57.435] <TB2> INFO: stop marker: 0
[12:39:57.435] <TB2> INFO: overflow: 0
[12:39:57.435] <TB2> INFO: invalid 5bit words: 0
[12:39:57.435] <TB2> INFO: invalid XOR eye diagram: 0
[12:39:57.435] <TB2> INFO: frame (failed synchr.): 0
[12:39:57.435] <TB2> INFO: idle data (no TBM trl): 0
[12:39:57.435] <TB2> INFO: no data (only TBM hdr): 0
[12:39:57.435] <TB2> INFO: TBM errors: 0
[12:39:57.435] <TB2> INFO: flawed TBM headers: 0
[12:39:57.435] <TB2> INFO: flawed TBM trailers: 0
[12:39:57.435] <TB2> INFO: event ID mismatches: 0
[12:39:57.435] <TB2> INFO: ROC errors: 0
[12:39:57.435] <TB2> INFO: missing ROC header(s): 0
[12:39:57.435] <TB2> INFO: misplaced readback start: 0
[12:39:57.435] <TB2> INFO: Pixel decoding errors: 0
[12:39:57.435] <TB2> INFO: pixel data incomplete: 0
[12:39:57.435] <TB2> INFO: pixel address: 0
[12:39:57.435] <TB2> INFO: pulse height fill bit: 0
[12:39:57.435] <TB2> INFO: buffer corruption: 0
[12:39:57.509] <TB2> INFO: ######################################################################
[12:39:57.509] <TB2> INFO: PixTestTrim::doTest()
[12:39:57.509] <TB2> INFO: ######################################################################
[12:39:57.510] <TB2> INFO: ----------------------------------------------------------------------
[12:39:57.510] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[12:39:57.510] <TB2> INFO: ----------------------------------------------------------------------
[12:39:57.612] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[12:39:57.612] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[12:39:57.622] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[12:39:57.622] <TB2> INFO: run 1 of 1
[12:39:57.907] <TB2> INFO: Expecting 6281600 events.
[12:40:37.275] <TB2> INFO: 1066290 events read in total (38809ms).
[12:41:15.856] <TB2> INFO: 2126440 events read in total (77390ms).
[12:41:54.701] <TB2> INFO: 3180960 events read in total (116235ms).
[12:42:33.586] <TB2> INFO: 4236820 events read in total (155120ms).
[12:43:12.962] <TB2> INFO: 5295120 events read in total (194496ms).
[12:43:48.819] <TB2> INFO: 6281600 events read in total (230353ms).
[12:43:48.848] <TB2> INFO: Test took 231225ms.
[12:44:09.582] <TB2> INFO: ROC 0 VthrComp = 99
[12:44:09.582] <TB2> INFO: ROC 1 VthrComp = 93
[12:44:09.582] <TB2> INFO: ROC 2 VthrComp = 97
[12:44:09.582] <TB2> INFO: ROC 3 VthrComp = 95
[12:44:09.582] <TB2> INFO: ROC 4 VthrComp = 93
[12:44:09.582] <TB2> INFO: ROC 5 VthrComp = 101
[12:44:09.582] <TB2> INFO: ROC 6 VthrComp = 102
[12:44:09.582] <TB2> INFO: ROC 7 VthrComp = 94
[12:44:09.582] <TB2> INFO: ROC 8 VthrComp = 105
[12:44:09.583] <TB2> INFO: ROC 9 VthrComp = 94
[12:44:09.583] <TB2> INFO: ROC 10 VthrComp = 92
[12:44:09.583] <TB2> INFO: ROC 11 VthrComp = 94
[12:44:09.583] <TB2> INFO: ROC 12 VthrComp = 89
[12:44:09.584] <TB2> INFO: ROC 13 VthrComp = 113
[12:44:09.584] <TB2> INFO: ROC 14 VthrComp = 96
[12:44:09.584] <TB2> INFO: ROC 15 VthrComp = 86
[12:44:09.584] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[12:44:09.584] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[12:44:09.592] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[12:44:09.592] <TB2> INFO: run 1 of 1
[12:44:09.856] <TB2> INFO: Expecting 6281600 events.
[12:44:44.938] <TB2> INFO: 755000 events read in total (34526ms).
[12:45:19.572] <TB2> INFO: 1508510 events read in total (69160ms).
[12:45:54.528] <TB2> INFO: 2263030 events read in total (104116ms).
[12:46:28.814] <TB2> INFO: 3017870 events read in total (138402ms).
[12:47:03.779] <TB2> INFO: 3767310 events read in total (173367ms).
[12:47:38.173] <TB2> INFO: 4513280 events read in total (207761ms).
[12:48:12.447] <TB2> INFO: 5257590 events read in total (242035ms).
[12:48:46.766] <TB2> INFO: 6001590 events read in total (276354ms).
[12:49:00.280] <TB2> INFO: 6281600 events read in total (289868ms).
[12:49:00.323] <TB2> INFO: Test took 290731ms.
[12:49:24.773] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 62.4183 for pixel 51/0 mean/min/max = 47.2491/31.9804/62.5177
[12:49:24.773] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 62.042 for pixel 26/3 mean/min/max = 46.6201/31.0005/62.2398
[12:49:24.773] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 57.1127 for pixel 21/0 mean/min/max = 44.7659/32.4066/57.1252
[12:49:24.774] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 55.6466 for pixel 19/1 mean/min/max = 44.2693/32.3295/56.209
[12:49:24.774] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 64.0697 for pixel 14/1 mean/min/max = 47.875/31.6395/64.1104
[12:49:24.774] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 68.9809 for pixel 21/0 mean/min/max = 50.2673/31.5509/68.9836
[12:49:24.774] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 61.6346 for pixel 7/1 mean/min/max = 46.8959/32.0309/61.761
[12:49:24.775] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 58.3325 for pixel 17/79 mean/min/max = 45.2699/32.0389/58.501
[12:49:24.775] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 59.7613 for pixel 13/79 mean/min/max = 46.8454/33.8747/59.8161
[12:49:24.775] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 57.0666 for pixel 51/72 mean/min/max = 44.8021/32.0402/57.564
[12:49:24.775] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 55.5256 for pixel 35/47 mean/min/max = 44.3144/32.9516/55.6772
[12:49:24.776] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 57.1127 for pixel 20/0 mean/min/max = 44.7227/32.2287/57.2167
[12:49:24.776] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 56.9972 for pixel 1/49 mean/min/max = 44.8925/32.7286/57.0564
[12:49:24.776] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 58.6518 for pixel 22/79 mean/min/max = 45.5114/32.3073/58.7156
[12:49:24.776] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 62.0411 for pixel 18/0 mean/min/max = 46.3959/30.6807/62.1112
[12:49:24.776] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 56.6894 for pixel 0/13 mean/min/max = 44.5351/32.376/56.6941
[12:49:24.777] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[12:49:24.865] <TB2> INFO: Expecting 514560 events.
[12:49:37.591] <TB2> INFO: 514560 events read in total (12170ms).
[12:49:37.596] <TB2> INFO: Expecting 514560 events.
[12:49:50.216] <TB2> INFO: 514560 events read in total (12201ms).
[12:49:50.223] <TB2> INFO: Expecting 514560 events.
[12:50:03.040] <TB2> INFO: 514560 events read in total (12396ms).
[12:50:03.051] <TB2> INFO: Expecting 514560 events.
[12:50:15.652] <TB2> INFO: 514560 events read in total (12188ms).
[12:50:15.662] <TB2> INFO: Expecting 514560 events.
[12:50:28.496] <TB2> INFO: 514560 events read in total (12414ms).
[12:50:28.508] <TB2> INFO: Expecting 514560 events.
[12:50:41.268] <TB2> INFO: 514560 events read in total (12342ms).
[12:50:41.283] <TB2> INFO: Expecting 514560 events.
[12:50:53.997] <TB2> INFO: 514560 events read in total (12306ms).
[12:50:54.012] <TB2> INFO: Expecting 514560 events.
[12:51:06.790] <TB2> INFO: 514560 events read in total (12369ms).
[12:51:06.808] <TB2> INFO: Expecting 514560 events.
[12:51:19.647] <TB2> INFO: 514560 events read in total (12432ms).
[12:51:19.670] <TB2> INFO: Expecting 514560 events.
[12:51:32.400] <TB2> INFO: 514560 events read in total (12328ms).
[12:51:32.423] <TB2> INFO: Expecting 514560 events.
[12:51:45.323] <TB2> INFO: 514560 events read in total (12497ms).
[12:51:45.346] <TB2> INFO: Expecting 514560 events.
[12:51:58.305] <TB2> INFO: 514560 events read in total (12557ms).
[12:51:58.331] <TB2> INFO: Expecting 514560 events.
[12:52:11.176] <TB2> INFO: 514560 events read in total (12444ms).
[12:52:11.206] <TB2> INFO: Expecting 514560 events.
[12:52:24.199] <TB2> INFO: 514560 events read in total (12591ms).
[12:52:24.229] <TB2> INFO: Expecting 514560 events.
[12:52:37.072] <TB2> INFO: 514560 events read in total (12441ms).
[12:52:37.103] <TB2> INFO: Expecting 514560 events.
[12:52:50.002] <TB2> INFO: 514560 events read in total (12497ms).
[12:52:50.042] <TB2> INFO: Test took 205265ms.
[12:52:51.030] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:52:51.038] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[12:52:51.038] <TB2> INFO: run 1 of 1
[12:52:51.301] <TB2> INFO: Expecting 6281600 events.
[12:53:26.960] <TB2> INFO: 743620 events read in total (35103ms).
[12:54:01.401] <TB2> INFO: 1486340 events read in total (69544ms).
[12:54:35.484] <TB2> INFO: 2230110 events read in total (103627ms).
[12:55:09.920] <TB2> INFO: 2974390 events read in total (138063ms).
[12:55:44.106] <TB2> INFO: 3713380 events read in total (172249ms).
[12:56:17.946] <TB2> INFO: 4448250 events read in total (206089ms).
[12:56:52.296] <TB2> INFO: 5181940 events read in total (240439ms).
[12:57:26.600] <TB2> INFO: 5914650 events read in total (274743ms).
[12:57:43.955] <TB2> INFO: 6281600 events read in total (292098ms).
[12:57:43.998] <TB2> INFO: Test took 292960ms.
[12:58:07.807] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.016398 .. 255.000000
[12:58:07.885] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[12:58:07.893] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[12:58:07.893] <TB2> INFO: run 1 of 1
[12:58:08.157] <TB2> INFO: Expecting 10649600 events.
[12:58:42.959] <TB2> INFO: 711350 events read in total (34246ms).
[12:59:16.610] <TB2> INFO: 1423030 events read in total (67897ms).
[12:59:50.675] <TB2> INFO: 2135210 events read in total (101962ms).
[13:00:24.797] <TB2> INFO: 2847350 events read in total (136084ms).
[13:00:58.382] <TB2> INFO: 3559380 events read in total (169669ms).
[13:01:32.641] <TB2> INFO: 4271480 events read in total (203928ms).
[13:02:06.946] <TB2> INFO: 4983530 events read in total (238233ms).
[13:02:40.848] <TB2> INFO: 5695370 events read in total (272135ms).
[13:03:15.004] <TB2> INFO: 6406940 events read in total (306291ms).
[13:03:48.952] <TB2> INFO: 7118290 events read in total (340239ms).
[13:04:22.964] <TB2> INFO: 7829470 events read in total (374251ms).
[13:04:56.768] <TB2> INFO: 8540040 events read in total (408055ms).
[13:05:31.062] <TB2> INFO: 9250960 events read in total (442349ms).
[13:06:05.022] <TB2> INFO: 9961940 events read in total (476309ms).
[13:06:38.059] <TB2> INFO: 10649600 events read in total (509346ms).
[13:06:38.147] <TB2> INFO: Test took 510254ms.
[13:07:07.981] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 14.776175 .. 47.389081
[13:07:08.100] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 4 .. 57 (-1/-1) hits flags = 528 (plus default)
[13:07:08.112] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[13:07:08.112] <TB2> INFO: run 1 of 1
[13:07:08.449] <TB2> INFO: Expecting 2246400 events.
[13:07:46.444] <TB2> INFO: 928090 events read in total (37439ms).
[13:08:23.978] <TB2> INFO: 1855590 events read in total (74973ms).
[13:08:39.981] <TB2> INFO: 2246400 events read in total (90976ms).
[13:08:39.995] <TB2> INFO: Test took 91884ms.
[13:08:53.938] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 4.471138 .. 45.575462
[13:08:54.013] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 4 .. 55 (-1/-1) hits flags = 528 (plus default)
[13:08:54.021] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[13:08:54.021] <TB2> INFO: run 1 of 1
[13:08:54.280] <TB2> INFO: Expecting 2163200 events.
[13:09:32.720] <TB2> INFO: 946970 events read in total (37884ms).
[13:10:10.317] <TB2> INFO: 1892930 events read in total (75482ms).
[13:10:21.579] <TB2> INFO: 2163200 events read in total (86744ms).
[13:10:21.597] <TB2> INFO: Test took 87576ms.
[13:10:35.713] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 4.471138 .. 45.575462
[13:10:35.803] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 4 .. 55 (-1/-1) hits flags = 528 (plus default)
[13:10:35.812] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[13:10:35.812] <TB2> INFO: run 1 of 1
[13:10:36.071] <TB2> INFO: Expecting 2163200 events.
[13:11:14.735] <TB2> INFO: 946760 events read in total (38108ms).
[13:11:52.494] <TB2> INFO: 1892900 events read in total (75867ms).
[13:12:03.355] <TB2> INFO: 2163200 events read in total (86728ms).
[13:12:03.366] <TB2> INFO: Test took 87554ms.
[13:12:18.967] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[13:12:18.967] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[13:12:18.978] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[13:12:18.978] <TB2> INFO: run 1 of 1
[13:12:19.275] <TB2> INFO: Expecting 1705600 events.
[13:12:57.001] <TB2> INFO: 879440 events read in total (37170ms).
[13:13:32.872] <TB2> INFO: 1705600 events read in total (73041ms).
[13:13:32.891] <TB2> INFO: Test took 73912ms.
[13:13:48.995] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C0.dat
[13:13:49.005] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C1.dat
[13:13:49.005] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C2.dat
[13:13:49.005] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C3.dat
[13:13:49.005] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C4.dat
[13:13:49.005] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C5.dat
[13:13:49.006] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C6.dat
[13:13:49.006] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C7.dat
[13:13:49.006] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C8.dat
[13:13:49.006] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C9.dat
[13:13:49.006] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C10.dat
[13:13:49.006] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C11.dat
[13:13:49.006] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C12.dat
[13:13:49.007] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C13.dat
[13:13:49.007] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C14.dat
[13:13:49.007] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C15.dat
[13:13:49.007] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C0.dat
[13:13:49.018] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C1.dat
[13:13:49.029] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C2.dat
[13:13:49.038] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C3.dat
[13:13:49.044] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C4.dat
[13:13:49.051] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C5.dat
[13:13:49.058] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C6.dat
[13:13:49.064] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C7.dat
[13:13:49.071] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C8.dat
[13:13:49.077] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C9.dat
[13:13:49.084] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C10.dat
[13:13:49.090] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C11.dat
[13:13:49.097] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C12.dat
[13:13:49.103] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C13.dat
[13:13:49.110] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C14.dat
[13:13:49.116] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//trimParameters35_C15.dat
[13:13:49.122] <TB2> INFO: PixTestTrim::trimTest() done
[13:13:49.122] <TB2> INFO: vtrim: 73 82 102 75 104 110 91 96 103 89 90 102 96 119 94 91
[13:13:49.123] <TB2> INFO: vthrcomp: 99 93 97 95 93 101 102 94 105 94 92 94 89 113 96 86
[13:13:49.123] <TB2> INFO: vcal mean: 35.09 34.98 34.98 34.96 35.01 34.99 34.99 34.95 34.99 34.92 34.96 35.00 35.01 34.98 34.97 34.99
[13:13:49.123] <TB2> INFO: vcal RMS: 0.93 0.86 1.07 0.78 0.89 0.94 0.90 0.84 0.80 0.82 0.77 0.76 0.92 0.85 1.17 0.75
[13:13:49.123] <TB2> INFO: bits mean: 7.32 9.23 9.77 9.28 9.03 8.33 9.35 9.48 8.66 8.97 9.66 9.52 9.11 9.24 9.40 9.23
[13:13:49.123] <TB2> INFO: bits RMS: 3.39 2.82 2.56 2.87 2.70 2.85 2.65 2.68 2.66 2.95 2.53 2.70 2.78 2.74 2.81 2.83
[13:13:49.129] <TB2> INFO: ----------------------------------------------------------------------
[13:13:49.129] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[13:13:49.129] <TB2> INFO: ----------------------------------------------------------------------
[13:13:49.132] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[13:13:49.140] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[13:13:49.140] <TB2> INFO: run 1 of 1
[13:13:49.403] <TB2> INFO: Expecting 4160000 events.
[13:14:30.871] <TB2> INFO: 929670 events read in total (40912ms).
[13:15:12.338] <TB2> INFO: 1853725 events read in total (82379ms).
[13:15:53.756] <TB2> INFO: 2768935 events read in total (123797ms).
[13:16:35.263] <TB2> INFO: 3681435 events read in total (165304ms).
[13:16:56.807] <TB2> INFO: 4160000 events read in total (186848ms).
[13:16:56.841] <TB2> INFO: Test took 187702ms.
[13:17:27.681] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 169 (-1/-1) hits flags = 528 (plus default)
[13:17:27.690] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[13:17:27.690] <TB2> INFO: run 1 of 1
[13:17:27.977] <TB2> INFO: Expecting 3536000 events.
[13:18:10.325] <TB2> INFO: 959765 events read in total (41789ms).
[13:18:52.465] <TB2> INFO: 1911395 events read in total (83929ms).
[13:19:34.117] <TB2> INFO: 2851955 events read in total (125582ms).
[13:20:04.813] <TB2> INFO: 3536000 events read in total (156277ms).
[13:20:04.851] <TB2> INFO: Test took 157162ms.
[13:20:32.899] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 155 (-1/-1) hits flags = 528 (plus default)
[13:20:32.909] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[13:20:32.909] <TB2> INFO: run 1 of 1
[13:20:33.178] <TB2> INFO: Expecting 3244800 events.
[13:21:17.051] <TB2> INFO: 998175 events read in total (43317ms).
[13:21:59.371] <TB2> INFO: 1984185 events read in total (85637ms).
[13:22:41.726] <TB2> INFO: 2960030 events read in total (127992ms).
[13:22:54.289] <TB2> INFO: 3244800 events read in total (140555ms).
[13:22:54.324] <TB2> INFO: Test took 141414ms.
[13:23:18.014] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 155 (-1/-1) hits flags = 528 (plus default)
[13:23:18.025] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[13:23:18.025] <TB2> INFO: run 1 of 1
[13:23:18.328] <TB2> INFO: Expecting 3244800 events.
[13:24:01.475] <TB2> INFO: 996145 events read in total (42591ms).
[13:24:43.930] <TB2> INFO: 1980675 events read in total (85046ms).
[13:25:26.072] <TB2> INFO: 2955205 events read in total (127188ms).
[13:25:38.889] <TB2> INFO: 3244800 events read in total (140005ms).
[13:25:38.920] <TB2> INFO: Test took 140894ms.
[13:26:03.305] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 155 (-1/-1) hits flags = 528 (plus default)
[13:26:03.314] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[13:26:03.314] <TB2> INFO: run 1 of 1
[13:26:03.584] <TB2> INFO: Expecting 3244800 events.
[13:26:46.809] <TB2> INFO: 996575 events read in total (42669ms).
[13:27:29.600] <TB2> INFO: 1981070 events read in total (85460ms).
[13:28:11.736] <TB2> INFO: 2955730 events read in total (127596ms).
[13:28:24.437] <TB2> INFO: 3244800 events read in total (140297ms).
[13:28:24.467] <TB2> INFO: Test took 141153ms.
[13:28:49.677] <TB2> INFO: PixTestTrim::trimBitTest() done
[13:28:49.678] <TB2> INFO: PixTestTrim::doTest() done, duration: 2932 seconds
[13:28:49.678] <TB2> INFO: Decoding statistics:
[13:28:49.678] <TB2> INFO: General information:
[13:28:49.678] <TB2> INFO: 16bit words read: 0
[13:28:49.678] <TB2> INFO: valid events total: 0
[13:28:49.678] <TB2> INFO: empty events: 0
[13:28:49.678] <TB2> INFO: valid events with pixels: 0
[13:28:49.678] <TB2> INFO: valid pixel hits: 0
[13:28:49.678] <TB2> INFO: Event errors: 0
[13:28:49.678] <TB2> INFO: start marker: 0
[13:28:49.678] <TB2> INFO: stop marker: 0
[13:28:49.678] <TB2> INFO: overflow: 0
[13:28:49.678] <TB2> INFO: invalid 5bit words: 0
[13:28:49.678] <TB2> INFO: invalid XOR eye diagram: 0
[13:28:49.678] <TB2> INFO: frame (failed synchr.): 0
[13:28:49.678] <TB2> INFO: idle data (no TBM trl): 0
[13:28:49.678] <TB2> INFO: no data (only TBM hdr): 0
[13:28:49.678] <TB2> INFO: TBM errors: 0
[13:28:49.678] <TB2> INFO: flawed TBM headers: 0
[13:28:49.678] <TB2> INFO: flawed TBM trailers: 0
[13:28:49.678] <TB2> INFO: event ID mismatches: 0
[13:28:49.678] <TB2> INFO: ROC errors: 0
[13:28:49.678] <TB2> INFO: missing ROC header(s): 0
[13:28:49.678] <TB2> INFO: misplaced readback start: 0
[13:28:49.678] <TB2> INFO: Pixel decoding errors: 0
[13:28:49.678] <TB2> INFO: pixel data incomplete: 0
[13:28:49.678] <TB2> INFO: pixel address: 0
[13:28:49.678] <TB2> INFO: pulse height fill bit: 0
[13:28:49.678] <TB2> INFO: buffer corruption: 0
[13:28:50.385] <TB2> INFO: ######################################################################
[13:28:50.385] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[13:28:50.385] <TB2> INFO: ######################################################################
[13:28:50.646] <TB2> INFO: Expecting 41600 events.
[13:28:54.398] <TB2> INFO: 41600 events read in total (3196ms).
[13:28:54.399] <TB2> INFO: Test took 4013ms.
[13:28:54.862] <TB2> INFO: Expecting 41600 events.
[13:28:58.609] <TB2> INFO: 41600 events read in total (3190ms).
[13:28:58.610] <TB2> INFO: Test took 4011ms.
[13:28:58.899] <TB2> INFO: Expecting 41600 events.
[13:29:02.770] <TB2> INFO: 41600 events read in total (3315ms).
[13:29:02.771] <TB2> INFO: Test took 4138ms.
[13:29:03.026] <TB2> INFO: Expecting 2560 events.
[13:29:03.879] <TB2> INFO: 2560 events read in total (297ms).
[13:29:03.879] <TB2> INFO: Test took 1095ms.
[13:29:04.184] <TB2> INFO: Expecting 2560 events.
[13:29:05.040] <TB2> INFO: 2560 events read in total (300ms).
[13:29:05.040] <TB2> INFO: Test took 1161ms.
[13:29:05.345] <TB2> INFO: Expecting 2560 events.
[13:29:06.198] <TB2> INFO: 2560 events read in total (297ms).
[13:29:06.199] <TB2> INFO: Test took 1159ms.
[13:29:06.504] <TB2> INFO: Expecting 2560 events.
[13:29:07.361] <TB2> INFO: 2560 events read in total (301ms).
[13:29:07.361] <TB2> INFO: Test took 1162ms.
[13:29:07.667] <TB2> INFO: Expecting 2560 events.
[13:29:08.525] <TB2> INFO: 2560 events read in total (302ms).
[13:29:08.525] <TB2> INFO: Test took 1164ms.
[13:29:08.831] <TB2> INFO: Expecting 2560 events.
[13:29:09.687] <TB2> INFO: 2560 events read in total (300ms).
[13:29:09.687] <TB2> INFO: Test took 1161ms.
[13:29:09.992] <TB2> INFO: Expecting 2560 events.
[13:29:10.846] <TB2> INFO: 2560 events read in total (298ms).
[13:29:10.846] <TB2> INFO: Test took 1158ms.
[13:29:11.151] <TB2> INFO: Expecting 2560 events.
[13:29:12.004] <TB2> INFO: 2560 events read in total (297ms).
[13:29:12.004] <TB2> INFO: Test took 1157ms.
[13:29:12.309] <TB2> INFO: Expecting 2560 events.
[13:29:13.164] <TB2> INFO: 2560 events read in total (299ms).
[13:29:13.164] <TB2> INFO: Test took 1160ms.
[13:29:13.468] <TB2> INFO: Expecting 2560 events.
[13:29:14.324] <TB2> INFO: 2560 events read in total (300ms).
[13:29:14.324] <TB2> INFO: Test took 1159ms.
[13:29:14.630] <TB2> INFO: Expecting 2560 events.
[13:29:15.486] <TB2> INFO: 2560 events read in total (300ms).
[13:29:15.487] <TB2> INFO: Test took 1163ms.
[13:29:15.792] <TB2> INFO: Expecting 2560 events.
[13:29:16.647] <TB2> INFO: 2560 events read in total (299ms).
[13:29:16.648] <TB2> INFO: Test took 1161ms.
[13:29:16.953] <TB2> INFO: Expecting 2560 events.
[13:29:17.816] <TB2> INFO: 2560 events read in total (306ms).
[13:29:17.817] <TB2> INFO: Test took 1169ms.
[13:29:18.121] <TB2> INFO: Expecting 2560 events.
[13:29:18.978] <TB2> INFO: 2560 events read in total (301ms).
[13:29:18.979] <TB2> INFO: Test took 1162ms.
[13:29:19.284] <TB2> INFO: Expecting 2560 events.
[13:29:20.144] <TB2> INFO: 2560 events read in total (304ms).
[13:29:20.144] <TB2> INFO: Test took 1165ms.
[13:29:20.449] <TB2> INFO: Expecting 2560 events.
[13:29:21.303] <TB2> INFO: 2560 events read in total (298ms).
[13:29:21.304] <TB2> INFO: Test took 1159ms.
[13:29:21.307] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:29:21.609] <TB2> INFO: Expecting 655360 events.
[13:29:38.471] <TB2> INFO: 655360 events read in total (16305ms).
[13:29:38.482] <TB2> INFO: Expecting 655360 events.
[13:29:55.189] <TB2> INFO: 655360 events read in total (16305ms).
[13:29:55.205] <TB2> INFO: Expecting 655360 events.
[13:30:11.927] <TB2> INFO: 655360 events read in total (16320ms).
[13:30:11.944] <TB2> INFO: Expecting 655360 events.
[13:30:28.742] <TB2> INFO: 655360 events read in total (16396ms).
[13:30:28.761] <TB2> INFO: Expecting 655360 events.
[13:30:45.565] <TB2> INFO: 655360 events read in total (16403ms).
[13:30:45.587] <TB2> INFO: Expecting 655360 events.
[13:31:02.291] <TB2> INFO: 655360 events read in total (16303ms).
[13:31:02.320] <TB2> INFO: Expecting 655360 events.
[13:31:19.234] <TB2> INFO: 655360 events read in total (16513ms).
[13:31:19.265] <TB2> INFO: Expecting 655360 events.
[13:31:36.307] <TB2> INFO: 655360 events read in total (16641ms).
[13:31:36.344] <TB2> INFO: Expecting 655360 events.
[13:31:53.200] <TB2> INFO: 655360 events read in total (16455ms).
[13:31:53.238] <TB2> INFO: Expecting 655360 events.
[13:32:10.097] <TB2> INFO: 655360 events read in total (16457ms).
[13:32:10.139] <TB2> INFO: Expecting 655360 events.
[13:32:26.993] <TB2> INFO: 655360 events read in total (16452ms).
[13:32:27.034] <TB2> INFO: Expecting 655360 events.
[13:32:43.876] <TB2> INFO: 655360 events read in total (16440ms).
[13:32:43.923] <TB2> INFO: Expecting 655360 events.
[13:33:00.783] <TB2> INFO: 655360 events read in total (16459ms).
[13:33:00.833] <TB2> INFO: Expecting 655360 events.
[13:33:17.588] <TB2> INFO: 655360 events read in total (16353ms).
[13:33:17.646] <TB2> INFO: Expecting 655360 events.
[13:33:34.546] <TB2> INFO: 655360 events read in total (16498ms).
[13:33:34.612] <TB2> INFO: Expecting 655360 events.
[13:33:51.380] <TB2> INFO: 655360 events read in total (16366ms).
[13:33:51.439] <TB2> INFO: Test took 270132ms.
[13:33:51.517] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:33:51.748] <TB2> INFO: Expecting 655360 events.
[13:34:08.616] <TB2> INFO: 655360 events read in total (16312ms).
[13:34:08.625] <TB2> INFO: Expecting 655360 events.
[13:34:25.355] <TB2> INFO: 655360 events read in total (16328ms).
[13:34:25.367] <TB2> INFO: Expecting 655360 events.
[13:34:42.149] <TB2> INFO: 655360 events read in total (16380ms).
[13:34:42.164] <TB2> INFO: Expecting 655360 events.
[13:34:58.994] <TB2> INFO: 655360 events read in total (16428ms).
[13:34:59.013] <TB2> INFO: Expecting 655360 events.
[13:35:15.792] <TB2> INFO: 655360 events read in total (16377ms).
[13:35:15.816] <TB2> INFO: Expecting 655360 events.
[13:35:32.518] <TB2> INFO: 655360 events read in total (16300ms).
[13:35:32.544] <TB2> INFO: Expecting 655360 events.
[13:35:49.417] <TB2> INFO: 655360 events read in total (16471ms).
[13:35:49.450] <TB2> INFO: Expecting 655360 events.
[13:36:06.317] <TB2> INFO: 655360 events read in total (16465ms).
[13:36:06.356] <TB2> INFO: Expecting 655360 events.
[13:36:23.308] <TB2> INFO: 655360 events read in total (16550ms).
[13:36:23.343] <TB2> INFO: Expecting 655360 events.
[13:36:40.398] <TB2> INFO: 655360 events read in total (16653ms).
[13:36:40.438] <TB2> INFO: Expecting 655360 events.
[13:36:57.288] <TB2> INFO: 655360 events read in total (16448ms).
[13:36:57.332] <TB2> INFO: Expecting 655360 events.
[13:37:14.345] <TB2> INFO: 655360 events read in total (16611ms).
[13:37:14.392] <TB2> INFO: Expecting 655360 events.
[13:37:31.524] <TB2> INFO: 655360 events read in total (16730ms).
[13:37:31.576] <TB2> INFO: Expecting 655360 events.
[13:37:48.325] <TB2> INFO: 655360 events read in total (16347ms).
[13:37:48.400] <TB2> INFO: Expecting 655360 events.
[13:38:05.392] <TB2> INFO: 655360 events read in total (16590ms).
[13:38:05.455] <TB2> INFO: Expecting 655360 events.
[13:38:22.043] <TB2> INFO: 655360 events read in total (16186ms).
[13:38:22.110] <TB2> INFO: Test took 270593ms.
[13:38:22.302] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.309] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.315] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.322] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.329] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.335] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[13:38:22.342] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[13:38:22.349] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[13:38:22.355] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[13:38:22.362] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[13:38:22.368] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[13:38:22.374] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.381] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.387] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.394] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.400] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.407] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.413] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.420] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.426] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.433] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.439] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[13:38:22.474] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C0.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C1.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C2.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C3.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C4.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C5.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C6.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C7.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C8.dat
[13:38:22.475] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C9.dat
[13:38:22.476] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C10.dat
[13:38:22.476] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C11.dat
[13:38:22.476] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C12.dat
[13:38:22.476] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C13.dat
[13:38:22.476] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C14.dat
[13:38:22.476] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//dacParameters35_C15.dat
[13:38:22.735] <TB2> INFO: Expecting 41600 events.
[13:38:26.213] <TB2> INFO: 41600 events read in total (2922ms).
[13:38:26.213] <TB2> INFO: Test took 3734ms.
[13:38:26.684] <TB2> INFO: Expecting 41600 events.
[13:38:30.207] <TB2> INFO: 41600 events read in total (2966ms).
[13:38:30.207] <TB2> INFO: Test took 3814ms.
[13:38:30.665] <TB2> INFO: Expecting 41600 events.
[13:38:34.168] <TB2> INFO: 41600 events read in total (2947ms).
[13:38:34.168] <TB2> INFO: Test took 3783ms.
[13:38:34.353] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:34.441] <TB2> INFO: Expecting 2560 events.
[13:38:35.296] <TB2> INFO: 2560 events read in total (299ms).
[13:38:35.296] <TB2> INFO: Test took 943ms.
[13:38:35.306] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:35.602] <TB2> INFO: Expecting 2560 events.
[13:38:36.457] <TB2> INFO: 2560 events read in total (299ms).
[13:38:36.457] <TB2> INFO: Test took 1151ms.
[13:38:36.459] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:36.764] <TB2> INFO: Expecting 2560 events.
[13:38:37.627] <TB2> INFO: 2560 events read in total (306ms).
[13:38:37.627] <TB2> INFO: Test took 1168ms.
[13:38:37.629] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:37.934] <TB2> INFO: Expecting 2560 events.
[13:38:38.790] <TB2> INFO: 2560 events read in total (299ms).
[13:38:38.790] <TB2> INFO: Test took 1161ms.
[13:38:38.793] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:39.097] <TB2> INFO: Expecting 2560 events.
[13:38:39.957] <TB2> INFO: 2560 events read in total (303ms).
[13:38:39.957] <TB2> INFO: Test took 1164ms.
[13:38:39.959] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:40.264] <TB2> INFO: Expecting 2560 events.
[13:38:41.126] <TB2> INFO: 2560 events read in total (306ms).
[13:38:41.127] <TB2> INFO: Test took 1168ms.
[13:38:41.129] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:41.433] <TB2> INFO: Expecting 2560 events.
[13:38:42.289] <TB2> INFO: 2560 events read in total (300ms).
[13:38:42.290] <TB2> INFO: Test took 1161ms.
[13:38:42.292] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:42.594] <TB2> INFO: Expecting 2560 events.
[13:38:43.450] <TB2> INFO: 2560 events read in total (299ms).
[13:38:43.450] <TB2> INFO: Test took 1158ms.
[13:38:43.452] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:43.757] <TB2> INFO: Expecting 2560 events.
[13:38:44.612] <TB2> INFO: 2560 events read in total (299ms).
[13:38:44.613] <TB2> INFO: Test took 1161ms.
[13:38:44.615] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:44.919] <TB2> INFO: Expecting 2560 events.
[13:38:45.773] <TB2> INFO: 2560 events read in total (298ms).
[13:38:45.774] <TB2> INFO: Test took 1159ms.
[13:38:45.776] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:46.079] <TB2> INFO: Expecting 2560 events.
[13:38:46.934] <TB2> INFO: 2560 events read in total (298ms).
[13:38:46.934] <TB2> INFO: Test took 1158ms.
[13:38:46.936] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:47.240] <TB2> INFO: Expecting 2560 events.
[13:38:48.097] <TB2> INFO: 2560 events read in total (300ms).
[13:38:48.097] <TB2> INFO: Test took 1161ms.
[13:38:48.099] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:48.404] <TB2> INFO: Expecting 2560 events.
[13:38:49.258] <TB2> INFO: 2560 events read in total (298ms).
[13:38:49.258] <TB2> INFO: Test took 1159ms.
[13:38:49.260] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:49.564] <TB2> INFO: Expecting 2560 events.
[13:38:50.421] <TB2> INFO: 2560 events read in total (301ms).
[13:38:50.421] <TB2> INFO: Test took 1161ms.
[13:38:50.423] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:50.728] <TB2> INFO: Expecting 2560 events.
[13:38:51.588] <TB2> INFO: 2560 events read in total (303ms).
[13:38:51.589] <TB2> INFO: Test took 1166ms.
[13:38:51.591] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:51.895] <TB2> INFO: Expecting 2560 events.
[13:38:52.751] <TB2> INFO: 2560 events read in total (300ms).
[13:38:52.751] <TB2> INFO: Test took 1160ms.
[13:38:52.754] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:53.058] <TB2> INFO: Expecting 2560 events.
[13:38:53.915] <TB2> INFO: 2560 events read in total (300ms).
[13:38:53.915] <TB2> INFO: Test took 1161ms.
[13:38:53.918] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:54.222] <TB2> INFO: Expecting 2560 events.
[13:38:55.079] <TB2> INFO: 2560 events read in total (301ms).
[13:38:55.079] <TB2> INFO: Test took 1161ms.
[13:38:55.083] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:55.386] <TB2> INFO: Expecting 2560 events.
[13:38:56.242] <TB2> INFO: 2560 events read in total (300ms).
[13:38:56.242] <TB2> INFO: Test took 1160ms.
[13:38:56.246] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:56.549] <TB2> INFO: Expecting 2560 events.
[13:38:57.404] <TB2> INFO: 2560 events read in total (299ms).
[13:38:57.405] <TB2> INFO: Test took 1160ms.
[13:38:57.408] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:57.710] <TB2> INFO: Expecting 2560 events.
[13:38:58.566] <TB2> INFO: 2560 events read in total (299ms).
[13:38:58.566] <TB2> INFO: Test took 1159ms.
[13:38:58.568] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:38:58.872] <TB2> INFO: Expecting 2560 events.
[13:38:59.727] <TB2> INFO: 2560 events read in total (299ms).
[13:38:59.728] <TB2> INFO: Test took 1160ms.
[13:38:59.730] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:00.034] <TB2> INFO: Expecting 2560 events.
[13:39:00.891] <TB2> INFO: 2560 events read in total (301ms).
[13:39:00.891] <TB2> INFO: Test took 1161ms.
[13:39:00.893] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:01.198] <TB2> INFO: Expecting 2560 events.
[13:39:02.055] <TB2> INFO: 2560 events read in total (300ms).
[13:39:02.055] <TB2> INFO: Test took 1162ms.
[13:39:02.058] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:02.361] <TB2> INFO: Expecting 2560 events.
[13:39:03.215] <TB2> INFO: 2560 events read in total (298ms).
[13:39:03.215] <TB2> INFO: Test took 1157ms.
[13:39:03.219] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:03.522] <TB2> INFO: Expecting 2560 events.
[13:39:04.376] <TB2> INFO: 2560 events read in total (298ms).
[13:39:04.376] <TB2> INFO: Test took 1157ms.
[13:39:04.379] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:04.682] <TB2> INFO: Expecting 2560 events.
[13:39:05.536] <TB2> INFO: 2560 events read in total (297ms).
[13:39:05.536] <TB2> INFO: Test took 1157ms.
[13:39:05.538] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:05.844] <TB2> INFO: Expecting 2560 events.
[13:39:06.697] <TB2> INFO: 2560 events read in total (297ms).
[13:39:06.697] <TB2> INFO: Test took 1159ms.
[13:39:06.700] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:07.004] <TB2> INFO: Expecting 2560 events.
[13:39:07.862] <TB2> INFO: 2560 events read in total (301ms).
[13:39:07.862] <TB2> INFO: Test took 1163ms.
[13:39:07.864] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:08.168] <TB2> INFO: Expecting 2560 events.
[13:39:09.025] <TB2> INFO: 2560 events read in total (301ms).
[13:39:09.025] <TB2> INFO: Test took 1161ms.
[13:39:09.028] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:09.331] <TB2> INFO: Expecting 2560 events.
[13:39:10.183] <TB2> INFO: 2560 events read in total (296ms).
[13:39:10.184] <TB2> INFO: Test took 1157ms.
[13:39:10.186] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:39:10.489] <TB2> INFO: Expecting 2560 events.
[13:39:11.347] <TB2> INFO: 2560 events read in total (301ms).
[13:39:11.347] <TB2> INFO: Test took 1161ms.
[13:39:11.840] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 621 seconds
[13:39:11.840] <TB2> INFO: PH scale (per ROC): 77 77 85 95 74 76 81 84 80 84 89 80 90 85 80 96
[13:39:11.840] <TB2> INFO: PH offset (per ROC): 157 155 146 155 176 161 159 159 155 144 148 156 134 148 162 149
[13:39:11.847] <TB2> INFO: Decoding statistics:
[13:39:11.847] <TB2> INFO: General information:
[13:39:11.847] <TB2> INFO: 16bit words read: 91932
[13:39:11.847] <TB2> INFO: valid events total: 10240
[13:39:11.847] <TB2> INFO: empty events: 7737
[13:39:11.847] <TB2> INFO: valid events with pixels: 2503
[13:39:11.847] <TB2> INFO: valid pixel hits: 2503
[13:39:11.847] <TB2> INFO: Event errors: 0
[13:39:11.847] <TB2> INFO: start marker: 0
[13:39:11.847] <TB2> INFO: stop marker: 0
[13:39:11.847] <TB2> INFO: overflow: 0
[13:39:11.847] <TB2> INFO: invalid 5bit words: 0
[13:39:11.847] <TB2> INFO: invalid XOR eye diagram: 0
[13:39:11.847] <TB2> INFO: frame (failed synchr.): 0
[13:39:11.847] <TB2> INFO: idle data (no TBM trl): 0
[13:39:11.847] <TB2> INFO: no data (only TBM hdr): 0
[13:39:11.847] <TB2> INFO: TBM errors: 0
[13:39:11.847] <TB2> INFO: flawed TBM headers: 0
[13:39:11.847] <TB2> INFO: flawed TBM trailers: 0
[13:39:11.847] <TB2> INFO: event ID mismatches: 0
[13:39:11.847] <TB2> INFO: ROC errors: 0
[13:39:11.847] <TB2> INFO: missing ROC header(s): 0
[13:39:11.847] <TB2> INFO: misplaced readback start: 0
[13:39:11.847] <TB2> INFO: Pixel decoding errors: 0
[13:39:11.847] <TB2> INFO: pixel data incomplete: 0
[13:39:11.847] <TB2> INFO: pixel address: 0
[13:39:11.847] <TB2> INFO: pulse height fill bit: 0
[13:39:11.847] <TB2> INFO: buffer corruption: 0
[13:39:12.014] <TB2> INFO: ######################################################################
[13:39:12.014] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[13:39:12.014] <TB2> INFO: ######################################################################
[13:39:12.023] <TB2> INFO: scanning low vcal = 10
[13:39:12.282] <TB2> INFO: Expecting 41600 events.
[13:39:15.815] <TB2> INFO: 41600 events read in total (2977ms).
[13:39:15.815] <TB2> INFO: Test took 3791ms.
[13:39:15.817] <TB2> INFO: scanning low vcal = 20
[13:39:16.121] <TB2> INFO: Expecting 41600 events.
[13:39:19.688] <TB2> INFO: 41600 events read in total (3011ms).
[13:39:19.688] <TB2> INFO: Test took 3871ms.
[13:39:19.690] <TB2> INFO: scanning low vcal = 30
[13:39:19.993] <TB2> INFO: Expecting 41600 events.
[13:39:23.558] <TB2> INFO: 41600 events read in total (3009ms).
[13:39:23.559] <TB2> INFO: Test took 3869ms.
[13:39:23.561] <TB2> INFO: scanning low vcal = 40
[13:39:23.855] <TB2> INFO: Expecting 41600 events.
[13:39:28.014] <TB2> INFO: 41600 events read in total (3602ms).
[13:39:28.015] <TB2> INFO: Test took 4454ms.
[13:39:28.018] <TB2> INFO: scanning low vcal = 50
[13:39:28.320] <TB2> INFO: Expecting 41600 events.
[13:39:32.577] <TB2> INFO: 41600 events read in total (3700ms).
[13:39:32.577] <TB2> INFO: Test took 4559ms.
[13:39:32.580] <TB2> INFO: scanning low vcal = 60
[13:39:32.840] <TB2> INFO: Expecting 41600 events.
[13:39:37.071] <TB2> INFO: 41600 events read in total (3675ms).
[13:39:37.072] <TB2> INFO: Test took 4492ms.
[13:39:37.074] <TB2> INFO: scanning low vcal = 70
[13:39:37.336] <TB2> INFO: Expecting 41600 events.
[13:39:41.564] <TB2> INFO: 41600 events read in total (3672ms).
[13:39:41.565] <TB2> INFO: Test took 4490ms.
[13:39:41.568] <TB2> INFO: scanning low vcal = 80
[13:39:41.830] <TB2> INFO: Expecting 41600 events.
[13:39:46.019] <TB2> INFO: 41600 events read in total (3632ms).
[13:39:46.019] <TB2> INFO: Test took 4451ms.
[13:39:46.022] <TB2> INFO: scanning low vcal = 90
[13:39:46.281] <TB2> INFO: Expecting 41600 events.
[13:39:50.466] <TB2> INFO: 41600 events read in total (3629ms).
[13:39:50.466] <TB2> INFO: Test took 4444ms.
[13:39:50.469] <TB2> INFO: scanning low vcal = 100
[13:39:50.726] <TB2> INFO: Expecting 41600 events.
[13:39:54.930] <TB2> INFO: 41600 events read in total (3648ms).
[13:39:54.931] <TB2> INFO: Test took 4461ms.
[13:39:54.933] <TB2> INFO: scanning low vcal = 110
[13:39:55.190] <TB2> INFO: Expecting 41600 events.
[13:39:59.398] <TB2> INFO: 41600 events read in total (3651ms).
[13:39:59.398] <TB2> INFO: Test took 4465ms.
[13:39:59.401] <TB2> INFO: scanning low vcal = 120
[13:39:59.677] <TB2> INFO: Expecting 41600 events.
[13:40:03.881] <TB2> INFO: 41600 events read in total (3647ms).
[13:40:03.881] <TB2> INFO: Test took 4480ms.
[13:40:03.884] <TB2> INFO: scanning low vcal = 130
[13:40:04.140] <TB2> INFO: Expecting 41600 events.
[13:40:08.340] <TB2> INFO: 41600 events read in total (3644ms).
[13:40:08.341] <TB2> INFO: Test took 4457ms.
[13:40:08.344] <TB2> INFO: scanning low vcal = 140
[13:40:08.608] <TB2> INFO: Expecting 41600 events.
[13:40:12.838] <TB2> INFO: 41600 events read in total (3673ms).
[13:40:12.839] <TB2> INFO: Test took 4495ms.
[13:40:12.841] <TB2> INFO: scanning low vcal = 150
[13:40:13.099] <TB2> INFO: Expecting 41600 events.
[13:40:17.291] <TB2> INFO: 41600 events read in total (3636ms).
[13:40:17.292] <TB2> INFO: Test took 4451ms.
[13:40:17.295] <TB2> INFO: scanning low vcal = 160
[13:40:17.552] <TB2> INFO: Expecting 41600 events.
[13:40:21.820] <TB2> INFO: 41600 events read in total (3712ms).
[13:40:21.821] <TB2> INFO: Test took 4526ms.
[13:40:21.824] <TB2> INFO: scanning low vcal = 170
[13:40:22.097] <TB2> INFO: Expecting 41600 events.
[13:40:26.283] <TB2> INFO: 41600 events read in total (3630ms).
[13:40:26.284] <TB2> INFO: Test took 4460ms.
[13:40:26.288] <TB2> INFO: scanning low vcal = 180
[13:40:26.547] <TB2> INFO: Expecting 41600 events.
[13:40:30.733] <TB2> INFO: 41600 events read in total (3630ms).
[13:40:30.733] <TB2> INFO: Test took 4445ms.
[13:40:30.736] <TB2> INFO: scanning low vcal = 190
[13:40:30.995] <TB2> INFO: Expecting 41600 events.
[13:40:35.182] <TB2> INFO: 41600 events read in total (3631ms).
[13:40:35.183] <TB2> INFO: Test took 4447ms.
[13:40:35.186] <TB2> INFO: scanning low vcal = 200
[13:40:35.444] <TB2> INFO: Expecting 41600 events.
[13:40:39.612] <TB2> INFO: 41600 events read in total (3612ms).
[13:40:39.612] <TB2> INFO: Test took 4426ms.
[13:40:39.615] <TB2> INFO: scanning low vcal = 210
[13:40:39.872] <TB2> INFO: Expecting 41600 events.
[13:40:44.092] <TB2> INFO: 41600 events read in total (3664ms).
[13:40:44.093] <TB2> INFO: Test took 4478ms.
[13:40:44.096] <TB2> INFO: scanning low vcal = 220
[13:40:44.353] <TB2> INFO: Expecting 41600 events.
[13:40:48.611] <TB2> INFO: 41600 events read in total (3701ms).
[13:40:48.612] <TB2> INFO: Test took 4516ms.
[13:40:48.615] <TB2> INFO: scanning low vcal = 230
[13:40:48.887] <TB2> INFO: Expecting 41600 events.
[13:40:53.096] <TB2> INFO: 41600 events read in total (3652ms).
[13:40:53.097] <TB2> INFO: Test took 4482ms.
[13:40:53.100] <TB2> INFO: scanning low vcal = 240
[13:40:53.357] <TB2> INFO: Expecting 41600 events.
[13:40:57.595] <TB2> INFO: 41600 events read in total (3682ms).
[13:40:57.596] <TB2> INFO: Test took 4496ms.
[13:40:57.599] <TB2> INFO: scanning low vcal = 250
[13:40:57.861] <TB2> INFO: Expecting 41600 events.
[13:41:02.062] <TB2> INFO: 41600 events read in total (3645ms).
[13:41:02.063] <TB2> INFO: Test took 4464ms.
[13:41:02.067] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[13:41:02.324] <TB2> INFO: Expecting 41600 events.
[13:41:06.576] <TB2> INFO: 41600 events read in total (3696ms).
[13:41:06.577] <TB2> INFO: Test took 4510ms.
[13:41:06.581] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[13:41:06.842] <TB2> INFO: Expecting 41600 events.
[13:41:11.105] <TB2> INFO: 41600 events read in total (3707ms).
[13:41:11.106] <TB2> INFO: Test took 4525ms.
[13:41:11.109] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[13:41:11.381] <TB2> INFO: Expecting 41600 events.
[13:41:15.636] <TB2> INFO: 41600 events read in total (3698ms).
[13:41:15.638] <TB2> INFO: Test took 4528ms.
[13:41:15.641] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[13:41:15.907] <TB2> INFO: Expecting 41600 events.
[13:41:20.104] <TB2> INFO: 41600 events read in total (3640ms).
[13:41:20.104] <TB2> INFO: Test took 4463ms.
[13:41:20.107] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[13:41:20.364] <TB2> INFO: Expecting 41600 events.
[13:41:24.541] <TB2> INFO: 41600 events read in total (3621ms).
[13:41:24.542] <TB2> INFO: Test took 4435ms.
[13:41:24.984] <TB2> INFO: PixTestGainPedestal::measure() done
[13:41:56.143] <TB2> INFO: PixTestGainPedestal::fit() done
[13:41:56.143] <TB2> INFO: non-linearity mean: 0.956 0.951 0.961 0.954 0.962 0.954 0.954 0.954 0.958 0.951 0.956 0.957 0.954 0.950 0.950 0.954
[13:41:56.143] <TB2> INFO: non-linearity RMS: 0.006 0.008 0.008 0.005 0.006 0.007 0.005 0.007 0.005 0.006 0.006 0.005 0.005 0.006 0.007 0.005
[13:41:56.143] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[13:41:56.162] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[13:41:56.181] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[13:41:56.200] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[13:41:56.219] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[13:41:56.237] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[13:41:56.271] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[13:41:56.290] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[13:41:56.309] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[13:41:56.328] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[13:41:56.346] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[13:41:56.365] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[13:41:56.384] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[13:41:56.403] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[13:41:56.422] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[13:41:56.441] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[13:41:56.460] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 164 seconds
[13:41:56.460] <TB2> INFO: Decoding statistics:
[13:41:56.460] <TB2> INFO: General information:
[13:41:56.460] <TB2> INFO: 16bit words read: 2662400
[13:41:56.460] <TB2> INFO: valid events total: 166400
[13:41:56.460] <TB2> INFO: empty events: 0
[13:41:56.460] <TB2> INFO: valid events with pixels: 166400
[13:41:56.460] <TB2> INFO: valid pixel hits: 665550
[13:41:56.460] <TB2> INFO: Event errors: 0
[13:41:56.460] <TB2> INFO: start marker: 0
[13:41:56.460] <TB2> INFO: stop marker: 0
[13:41:56.460] <TB2> INFO: overflow: 0
[13:41:56.460] <TB2> INFO: invalid 5bit words: 0
[13:41:56.460] <TB2> INFO: invalid XOR eye diagram: 0
[13:41:56.460] <TB2> INFO: frame (failed synchr.): 0
[13:41:56.460] <TB2> INFO: idle data (no TBM trl): 0
[13:41:56.460] <TB2> INFO: no data (only TBM hdr): 0
[13:41:56.460] <TB2> INFO: TBM errors: 0
[13:41:56.460] <TB2> INFO: flawed TBM headers: 0
[13:41:56.460] <TB2> INFO: flawed TBM trailers: 0
[13:41:56.460] <TB2> INFO: event ID mismatches: 0
[13:41:56.460] <TB2> INFO: ROC errors: 0
[13:41:56.460] <TB2> INFO: missing ROC header(s): 0
[13:41:56.460] <TB2> INFO: misplaced readback start: 0
[13:41:56.460] <TB2> INFO: Pixel decoding errors: 0
[13:41:56.460] <TB2> INFO: pixel data incomplete: 0
[13:41:56.460] <TB2> INFO: pixel address: 0
[13:41:56.460] <TB2> INFO: pulse height fill bit: 0
[13:41:56.460] <TB2> INFO: buffer corruption: 0
[13:41:56.468] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C15.dat
[13:41:56.470] <TB2> INFO: ######################################################################
[13:41:56.470] <TB2> INFO: PixTestReadback::doTest()
[13:41:56.470] <TB2> INFO: ######################################################################
[13:41:56.470] <TB2> INFO: ----------------------------------------------------------------------
[13:41:56.470] <TB2> INFO: PixTestReadback::CalibrateVd()
[13:41:56.470] <TB2> INFO: ----------------------------------------------------------------------
[13:42:06.005] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C0.dat
[13:42:06.005] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C1.dat
[13:42:06.006] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C2.dat
[13:42:06.006] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C3.dat
[13:42:06.006] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C4.dat
[13:42:06.006] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C5.dat
[13:42:06.006] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C6.dat
[13:42:06.006] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C7.dat
[13:42:06.006] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C8.dat
[13:42:06.007] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C9.dat
[13:42:06.007] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C10.dat
[13:42:06.007] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C11.dat
[13:42:06.007] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C12.dat
[13:42:06.007] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C13.dat
[13:42:06.007] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C14.dat
[13:42:06.007] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C15.dat
[13:42:06.037] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[13:42:06.037] <TB2> INFO: ----------------------------------------------------------------------
[13:42:06.037] <TB2> INFO: PixTestReadback::CalibrateVa()
[13:42:06.037] <TB2> INFO: ----------------------------------------------------------------------
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C0.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C1.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C2.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C3.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C4.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C5.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C6.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C7.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C8.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C9.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C10.dat
[13:42:15.506] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C11.dat
[13:42:15.507] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C12.dat
[13:42:15.507] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C13.dat
[13:42:15.507] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C14.dat
[13:42:15.507] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C15.dat
[13:42:15.535] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[13:42:15.535] <TB2> INFO: ----------------------------------------------------------------------
[13:42:15.535] <TB2> INFO: PixTestReadback::readbackVbg()
[13:42:15.535] <TB2> INFO: ----------------------------------------------------------------------
[13:42:22.814] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[13:42:22.814] <TB2> INFO: ----------------------------------------------------------------------
[13:42:22.814] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[13:42:22.814] <TB2> INFO: ----------------------------------------------------------------------
[13:42:22.814] <TB2> INFO: Vbg will be calibrated using Vd calibration
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 154.1calibrated Vbg = 1.20366 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 156calibrated Vbg = 1.20086 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 143.4calibrated Vbg = 1.20257 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 142.9calibrated Vbg = 1.20618 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 159.3calibrated Vbg = 1.21136 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 158.8calibrated Vbg = 1.21144 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 144.8calibrated Vbg = 1.22092 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 154.7calibrated Vbg = 1.22095 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 156.3calibrated Vbg = 1.209 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 159.1calibrated Vbg = 1.21526 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 146.3calibrated Vbg = 1.21163 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 153.8calibrated Vbg = 1.21478 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 142.8calibrated Vbg = 1.20773 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 151.6calibrated Vbg = 1.19971 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 145calibrated Vbg = 1.21002 :::*/*/*/*/
[13:42:22.814] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 152.1calibrated Vbg = 1.20859 :::*/*/*/*/
[13:42:22.816] <TB2> INFO: ----------------------------------------------------------------------
[13:42:22.816] <TB2> INFO: PixTestReadback::CalibrateIa()
[13:42:22.816] <TB2> INFO: ----------------------------------------------------------------------
[13:44:58.083] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C0.dat
[13:44:58.083] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C1.dat
[13:44:58.083] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C2.dat
[13:44:58.083] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C3.dat
[13:44:58.083] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C4.dat
[13:44:58.083] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C5.dat
[13:44:58.083] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C6.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C7.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C8.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C9.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C10.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C11.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C12.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C13.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C14.dat
[13:44:58.084] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2317_FullQualification_2016-09-08_09h56m_1473321409//002_FulltestPxar_m20//readbackCal_C15.dat
[13:44:58.112] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[13:44:58.113] <TB2> INFO: PixTestReadback::doTest() done
[13:44:58.113] <TB2> INFO: Decoding statistics:
[13:44:58.113] <TB2> INFO: General information:
[13:44:58.113] <TB2> INFO: 16bit words read: 1024
[13:44:58.113] <TB2> INFO: valid events total: 128
[13:44:58.113] <TB2> INFO: empty events: 128
[13:44:58.113] <TB2> INFO: valid events with pixels: 0
[13:44:58.113] <TB2> INFO: valid pixel hits: 0
[13:44:58.113] <TB2> INFO: Event errors: 0
[13:44:58.113] <TB2> INFO: start marker: 0
[13:44:58.113] <TB2> INFO: stop marker: 0
[13:44:58.113] <TB2> INFO: overflow: 0
[13:44:58.113] <TB2> INFO: invalid 5bit words: 0
[13:44:58.113] <TB2> INFO: invalid XOR eye diagram: 0
[13:44:58.113] <TB2> INFO: frame (failed synchr.): 0
[13:44:58.113] <TB2> INFO: idle data (no TBM trl): 0
[13:44:58.113] <TB2> INFO: no data (only TBM hdr): 0
[13:44:58.113] <TB2> INFO: TBM errors: 0
[13:44:58.113] <TB2> INFO: flawed TBM headers: 0
[13:44:58.113] <TB2> INFO: flawed TBM trailers: 0
[13:44:58.113] <TB2> INFO: event ID mismatches: 0
[13:44:58.113] <TB2> INFO: ROC errors: 0
[13:44:58.113] <TB2> INFO: missing ROC header(s): 0
[13:44:58.113] <TB2> INFO: misplaced readback start: 0
[13:44:58.113] <TB2> INFO: Pixel decoding errors: 0
[13:44:58.113] <TB2> INFO: pixel data incomplete: 0
[13:44:58.114] <TB2> INFO: pixel address: 0
[13:44:58.114] <TB2> INFO: pulse height fill bit: 0
[13:44:58.114] <TB2> INFO: buffer corruption: 0
[13:44:58.135] <TB2> INFO: Decoding statistics:
[13:44:58.135] <TB2> INFO: General information:
[13:44:58.135] <TB2> INFO: 16bit words read: 2755356
[13:44:58.135] <TB2> INFO: valid events total: 176768
[13:44:58.135] <TB2> INFO: empty events: 7865
[13:44:58.135] <TB2> INFO: valid events with pixels: 168903
[13:44:58.135] <TB2> INFO: valid pixel hits: 668053
[13:44:58.135] <TB2> INFO: Event errors: 0
[13:44:58.135] <TB2> INFO: start marker: 0
[13:44:58.135] <TB2> INFO: stop marker: 0
[13:44:58.135] <TB2> INFO: overflow: 0
[13:44:58.135] <TB2> INFO: invalid 5bit words: 0
[13:44:58.135] <TB2> INFO: invalid XOR eye diagram: 0
[13:44:58.135] <TB2> INFO: frame (failed synchr.): 0
[13:44:58.135] <TB2> INFO: idle data (no TBM trl): 0
[13:44:58.135] <TB2> INFO: no data (only TBM hdr): 0
[13:44:58.135] <TB2> INFO: TBM errors: 0
[13:44:58.135] <TB2> INFO: flawed TBM headers: 0
[13:44:58.135] <TB2> INFO: flawed TBM trailers: 0
[13:44:58.135] <TB2> INFO: event ID mismatches: 0
[13:44:58.135] <TB2> INFO: ROC errors: 0
[13:44:58.135] <TB2> INFO: missing ROC header(s): 0
[13:44:58.135] <TB2> INFO: misplaced readback start: 0
[13:44:58.135] <TB2> INFO: Pixel decoding errors: 0
[13:44:58.135] <TB2> INFO: pixel data incomplete: 0
[13:44:58.135] <TB2> INFO: pixel address: 0
[13:44:58.135] <TB2> INFO: pulse height fill bit: 0
[13:44:58.135] <TB2> INFO: buffer corruption: 0
[13:44:58.135] <TB2> INFO: enter test to run
[13:44:58.135] <TB2> INFO: test: exit no parameter change
[13:44:58.331] <TB2> QUIET: Connection to board 156 closed.
[13:44:58.410] <TB2> INFO: pXar: this is the end, my friend