[09:21:15.449] <TB1> INFO: *** Welcome to pxar ***
[09:21:15.449] <TB1> INFO: *** Today: 2016/02/26
[09:21:15.548] <TB1> INFO: *** Version: 9751-dirty
[09:21:15.549] <TB1> INFO: readRocDacs: /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C15.dat
[09:21:15.550] <TB1> INFO: readTbmDacs: /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//tbmParameters_C0b.dat
[09:21:15.550] <TB1> INFO: readMaskFile: /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//defaultMaskFile.dat
[09:21:15.550] <TB1> INFO: readTrimFile: /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters_C15.dat
[09:21:15.656] <TB1> INFO: clk: 4
[09:21:15.656] <TB1> INFO: ctr: 4
[09:21:15.656] <TB1> INFO: sda: 19
[09:21:15.656] <TB1> INFO: tin: 9
[09:21:15.656] <TB1> INFO: level: 15
[09:21:15.656] <TB1> INFO: triggerdelay: 0
[09:21:15.656] <TB1> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[09:21:15.656] <TB1> INFO: Log level: INFO
[09:21:15.663] <TB1> INFO: Found DTB DTB_WXBYFL
[09:21:15.673] <TB1> QUIET: Connection to board DTB_WXBYFL opened.
[09:21:15.675] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 153
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXBYFL
MAC address: 40D855118099
Hostname: pixelDTB153
Comment:
------------------------------------------------------
[09:21:15.677] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[09:21:17.209] <TB1> INFO: DUT info:
[09:21:17.209] <TB1> INFO: The DUT currently contains the following objects:
[09:21:17.209] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[09:21:17.209] <TB1> INFO: TBM Core alpha (0): 7 registers set
[09:21:17.209] <TB1> INFO: TBM Core beta (1): 7 registers set
[09:21:17.209] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:21:17.209] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.209] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.210] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:21:17.610] <TB1> INFO: enter 'restricted' command line mode
[09:21:17.610] <TB1> INFO: enter test to run
[09:21:17.610] <TB1> INFO: test: pretest no parameter change
[09:21:17.610] <TB1> INFO: running: pretest
[09:21:17.618] <TB1> INFO: ----------------------------------------------------------------------
[09:21:17.618] <TB1> INFO: PixTestPretest::programROC()
[09:21:17.618] <TB1> INFO: ----------------------------------------------------------------------
[09:21:35.632] <TB1> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[09:21:35.632] <TB1> INFO: IA differences per ROC: 18.5 16.9 20.9 20.1 18.5 19.3 17.7 19.3 17.7 20.1 19.3 19.3 17.7 20.9 21.7 17.7
[09:21:35.727] <TB1> INFO: enter test to run
[09:21:35.727] <TB1> INFO: test: pretest no parameter change
[09:21:35.727] <TB1> INFO: running: pretest
[09:21:35.728] <TB1> INFO: ----------------------------------------------------------------------
[09:21:35.728] <TB1> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[09:21:35.728] <TB1> INFO: ----------------------------------------------------------------------
[09:21:56.998] <TB1> INFO: PixTestPretest::setVana() done, Module Ia 385.1 mA = 24.0688 mA/ROC
[09:21:56.998] <TB1> INFO: i(loss) [mA/ROC]: 20.1 20.1 19.3 20.1 19.3 19.3 19.3 19.3 19.3 19.3 20.1 19.3 19.3 19.3 19.3 19.3
[09:21:57.032] <TB1> INFO: enter test to run
[09:21:57.033] <TB1> INFO: test: pretest no parameter change
[09:21:57.033] <TB1> INFO: running: pretest
[09:21:57.033] <TB1> INFO: ----------------------------------------------------------------------
[09:21:57.033] <TB1> INFO: PixTestPretest::findTiming()
[09:21:57.033] <TB1> INFO: ----------------------------------------------------------------------
[09:21:57.033] <TB1> INFO: PixTestCmd::init()

[09:23:26.780] <TB1> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[09:23:26.781] <TB1> INFO: (success/tries = 100/100), width = 4
[09:23:26.781] <TB1> INFO: enter test to run
[09:23:26.781] <TB1> INFO: test: pretest no parameter change
[09:23:26.781] <TB1> INFO: running: pretest
[09:23:26.783] <TB1> INFO: ----------------------------------------------------------------------
[09:23:26.783] <TB1> INFO: PixTestPretest::findWorkingPixel()
[09:23:26.783] <TB1> INFO: ----------------------------------------------------------------------
[09:23:26.877] <TB1> INFO: Expecting 231680 events.


[09:23:37.115] <TB1> INFO: 231680 events read in total (9682ms).
[09:23:37.119] <TB1> INFO: Test took 10330ms.
[09:23:37.343] <TB1> INFO: Found working pixel in all ROCs: col/row = 12/22
[09:23:37.406] <TB1> INFO: enter test to run
[09:23:37.406] <TB1> INFO: test: pretest no parameter change
[09:23:37.406] <TB1> INFO: running: pretest
[09:23:37.407] <TB1> INFO: ----------------------------------------------------------------------
[09:23:37.407] <TB1> INFO: PixTestPretest::setVthrCompCalDel()
[09:23:37.407] <TB1> INFO: ----------------------------------------------------------------------
[09:23:37.498] <TB1> INFO: Expecting 231680 events.
[09:23:47.792] <TB1> INFO: 231680 events read in total (9738ms).
[09:23:47.796] <TB1> INFO: Test took 10386ms.
[09:23:48.057] <TB1> INFO: PixTestPretest::setVthrCompCalDel() done
[09:23:48.057] <TB1> INFO: CalDel: 159 160 157 173 179 136 142 139 143 122 132 135 131 149 154 136
[09:23:48.057] <TB1> INFO: VthrComp: 51 53 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[09:23:48.097] <TB1> INFO: enter test to run
[09:23:48.097] <TB1> INFO: test: pretest no parameter change
[09:23:48.097] <TB1> INFO: running: pretest
[09:23:48.098] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C0.dat
[09:23:48.098] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C1.dat
[09:23:48.098] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C2.dat
[09:23:48.098] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C3.dat
[09:23:48.098] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C4.dat
[09:23:48.098] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C5.dat
[09:23:48.098] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C6.dat
[09:23:48.098] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C7.dat
[09:23:48.099] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C8.dat
[09:23:48.099] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C9.dat
[09:23:48.099] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C10.dat
[09:23:48.099] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C11.dat
[09:23:48.099] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C12.dat
[09:23:48.099] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C13.dat
[09:23:48.099] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C14.dat
[09:23:48.099] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters_C15.dat
[09:23:48.099] <TB1> INFO: enter test to run
[09:23:48.099] <TB1> INFO: test: fulltest no parameter change
[09:23:48.099] <TB1> INFO: running: fulltest
[09:23:48.100] <TB1> INFO: ######################################################################
[09:23:48.100] <TB1> INFO: PixTestFullTest::doTest()
[09:23:48.100] <TB1> INFO: ######################################################################
[09:23:48.101] <TB1> INFO: ######################################################################
[09:23:48.101] <TB1> INFO: PixTestAlive::doTest()
[09:23:48.101] <TB1> INFO: ######################################################################
[09:23:48.102] <TB1> INFO: ----------------------------------------------------------------------
[09:23:48.102] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:23:48.102] <TB1> INFO: ----------------------------------------------------------------------
[09:23:48.371] <TB1> INFO: Expecting 41600 events.
[09:23:52.182] <TB1> INFO: 41600 events read in total (3255ms).
[09:23:52.182] <TB1> INFO: Test took 4079ms.
[09:23:52.404] <TB1> INFO: PixTestAlive::aliveTest() done
[09:23:52.404] <TB1> INFO: number of dead pixels (per ROC): 0 1 0 0 0 0 0 0 0 0 0 0 0 0 1 0
[09:23:52.405] <TB1> INFO: ----------------------------------------------------------------------
[09:23:52.405] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:23:52.405] <TB1> INFO: ----------------------------------------------------------------------
[09:23:52.697] <TB1> INFO: Expecting 41600 events.
[09:23:55.680] <TB1> INFO: 41600 events read in total (2426ms).
[09:23:55.680] <TB1> INFO: Test took 3273ms.
[09:23:55.681] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:23:55.929] <TB1> INFO: PixTestAlive::maskTest() done
[09:23:55.929] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:23:55.930] <TB1> INFO: ----------------------------------------------------------------------
[09:23:55.930] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:23:55.930] <TB1> INFO: ----------------------------------------------------------------------
[09:23:56.195] <TB1> INFO: Expecting 41600 events.
[09:24:00.003] <TB1> INFO: 41600 events read in total (3252ms).
[09:24:00.004] <TB1> INFO: Test took 4073ms.
[09:24:00.226] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[09:24:00.226] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:24:00.226] <TB1> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[09:24:00.226] <TB1> INFO: Decoding statistics:
[09:24:00.226] <TB1> INFO: General information:
[09:24:00.226] <TB1> INFO: 16bit words read: 0
[09:24:00.226] <TB1> INFO: valid events total: 0
[09:24:00.226] <TB1> INFO: empty events: 0
[09:24:00.226] <TB1> INFO: valid events with pixels: 0
[09:24:00.226] <TB1> INFO: valid pixel hits: 0
[09:24:00.226] <TB1> INFO: Event errors: 0
[09:24:00.226] <TB1> INFO: start marker: 0
[09:24:00.226] <TB1> INFO: stop marker: 0
[09:24:00.226] <TB1> INFO: overflow: 0
[09:24:00.226] <TB1> INFO: invalid 5bit words: 0
[09:24:00.226] <TB1> INFO: invalid XOR eye diagram: 0
[09:24:00.226] <TB1> INFO: frame (failed synchr.): 0
[09:24:00.226] <TB1> INFO: idle data (no TBM trl): 0
[09:24:00.226] <TB1> INFO: no data (only TBM hdr): 0
[09:24:00.226] <TB1> INFO: TBM errors: 0
[09:24:00.226] <TB1> INFO: flawed TBM headers: 0
[09:24:00.226] <TB1> INFO: flawed TBM trailers: 0
[09:24:00.226] <TB1> INFO: event ID mismatches: 0
[09:24:00.226] <TB1> INFO: ROC errors: 0
[09:24:00.226] <TB1> INFO: missing ROC header(s): 0
[09:24:00.226] <TB1> INFO: misplaced readback start: 0
[09:24:00.226] <TB1> INFO: Pixel decoding errors: 0
[09:24:00.226] <TB1> INFO: pixel data incomplete: 0
[09:24:00.226] <TB1> INFO: pixel address: 0
[09:24:00.226] <TB1> INFO: pulse height fill bit: 0
[09:24:00.226] <TB1> INFO: buffer corruption: 0
[09:24:00.233] <TB1> INFO: ######################################################################
[09:24:00.233] <TB1> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[09:24:00.233] <TB1> INFO: ######################################################################
[09:24:00.235] <TB1> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[09:24:00.246] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[09:24:00.246] <TB1> INFO: run 1 of 1
[09:24:00.509] <TB1> INFO: Expecting 3120000 events.
[09:24:41.490] <TB1> INFO: 854035 events read in total (40424ms).
[09:25:22.066] <TB1> INFO: 1701000 events read in total (81000ms).
[09:26:02.865] <TB1> INFO: 2559005 events read in total (121800ms).
[09:26:29.229] <TB1> INFO: 3120000 events read in total (148163ms).
[09:26:29.273] <TB1> INFO: Test took 149026ms.
[09:26:54.653] <TB1> INFO: PixTestBBMap::doTest() done, duration: 174 seconds
[09:26:54.653] <TB1> INFO: number of dead bumps (per ROC): 32 1 1 3 11 6 10 26 6 5 7 0 4 10 7 19
[09:26:54.653] <TB1> INFO: separation cut (per ROC): 83 101 99 77 84 91 97 69 91 101 96 92 103 108 83 79
[09:26:54.653] <TB1> INFO: Decoding statistics:
[09:26:54.653] <TB1> INFO: General information:
[09:26:54.653] <TB1> INFO: 16bit words read: 0
[09:26:54.653] <TB1> INFO: valid events total: 0
[09:26:54.653] <TB1> INFO: empty events: 0
[09:26:54.653] <TB1> INFO: valid events with pixels: 0
[09:26:54.653] <TB1> INFO: valid pixel hits: 0
[09:26:54.653] <TB1> INFO: Event errors: 0
[09:26:54.653] <TB1> INFO: start marker: 0
[09:26:54.653] <TB1> INFO: stop marker: 0
[09:26:54.653] <TB1> INFO: overflow: 0
[09:26:54.653] <TB1> INFO: invalid 5bit words: 0
[09:26:54.653] <TB1> INFO: invalid XOR eye diagram: 0
[09:26:54.653] <TB1> INFO: frame (failed synchr.): 0
[09:26:54.653] <TB1> INFO: idle data (no TBM trl): 0
[09:26:54.653] <TB1> INFO: no data (only TBM hdr): 0
[09:26:54.653] <TB1> INFO: TBM errors: 0
[09:26:54.654] <TB1> INFO: flawed TBM headers: 0
[09:26:54.654] <TB1> INFO: flawed TBM trailers: 0
[09:26:54.654] <TB1> INFO: event ID mismatches: 0
[09:26:54.654] <TB1> INFO: ROC errors: 0
[09:26:54.654] <TB1> INFO: missing ROC header(s): 0
[09:26:54.654] <TB1> INFO: misplaced readback start: 0
[09:26:54.654] <TB1> INFO: Pixel decoding errors: 0
[09:26:54.654] <TB1> INFO: pixel data incomplete: 0
[09:26:54.654] <TB1> INFO: pixel address: 0
[09:26:54.654] <TB1> INFO: pulse height fill bit: 0
[09:26:54.654] <TB1> INFO: buffer corruption: 0
[09:26:54.727] <TB1> INFO: ######################################################################
[09:26:54.727] <TB1> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[09:26:54.727] <TB1> INFO: ######################################################################
[09:26:54.727] <TB1> INFO: ----------------------------------------------------------------------
[09:26:54.727] <TB1> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[09:26:54.727] <TB1> INFO: ----------------------------------------------------------------------
[09:26:54.727] <TB1> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[09:26:54.735] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[09:26:54.735] <TB1> INFO: run 1 of 1
[09:26:55.000] <TB1> INFO: Expecting 26208000 events.
[09:27:28.047] <TB1> INFO: 893850 events read in total (32491ms).
[09:28:01.024] <TB1> INFO: 1775850 events read in total (65468ms).
[09:28:34.006] <TB1> INFO: 2656200 events read in total (98450ms).
[09:29:06.619] <TB1> INFO: 3534000 events read in total (131063ms).
[09:29:39.594] <TB1> INFO: 4411200 events read in total (164038ms).
[09:30:12.522] <TB1> INFO: 5289900 events read in total (196966ms).
[09:30:45.343] <TB1> INFO: 6168050 events read in total (229787ms).
[09:31:18.378] <TB1> INFO: 7043100 events read in total (262822ms).
[09:31:51.713] <TB1> INFO: 7920450 events read in total (296157ms).
[09:32:24.000] <TB1> INFO: 8797800 events read in total (328444ms).
[09:32:56.937] <TB1> INFO: 9675400 events read in total (361381ms).
[09:33:29.615] <TB1> INFO: 10550450 events read in total (394059ms).
[09:34:02.897] <TB1> INFO: 11425100 events read in total (427341ms).
[09:34:35.458] <TB1> INFO: 12302150 events read in total (459902ms).
[09:35:08.467] <TB1> INFO: 13175500 events read in total (492911ms).
[09:35:41.534] <TB1> INFO: 14041650 events read in total (525978ms).
[09:36:14.380] <TB1> INFO: 14907000 events read in total (558824ms).
[09:36:46.849] <TB1> INFO: 15773300 events read in total (591293ms).
[09:37:19.676] <TB1> INFO: 16636600 events read in total (624120ms).
[09:37:52.771] <TB1> INFO: 17500850 events read in total (657215ms).
[09:38:26.229] <TB1> INFO: 18368100 events read in total (690673ms).
[09:38:59.054] <TB1> INFO: 19232450 events read in total (723498ms).
[09:39:32.310] <TB1> INFO: 20094150 events read in total (756754ms).
[09:40:04.848] <TB1> INFO: 20957900 events read in total (789292ms).
[09:40:37.546] <TB1> INFO: 21823300 events read in total (821990ms).
[09:41:10.319] <TB1> INFO: 22686400 events read in total (854763ms).
[09:41:43.302] <TB1> INFO: 23553400 events read in total (887746ms).
[09:42:16.345] <TB1> INFO: 24420250 events read in total (920789ms).
[09:42:48.919] <TB1> INFO: 25287150 events read in total (953363ms).
[09:43:21.935] <TB1> INFO: 26167500 events read in total (986379ms).
[09:43:23.789] <TB1> INFO: 26208000 events read in total (988233ms).
[09:43:23.826] <TB1> INFO: Test took 989091ms.
[09:43:24.107] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:25.581] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:27.185] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:28.744] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:30.211] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:31.649] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:33.074] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:34.720] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:36.364] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:37.836] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:39.206] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:40.588] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:41.974] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:43.484] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:45.114] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:46.611] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[09:43:48.511] <TB1> INFO: PixTestScurves::scurves() done
[09:43:48.511] <TB1> INFO: Vcal mean: 83.34 106.31 100.59 85.72 86.10 85.48 91.60 74.38 86.76 93.77 88.98 83.15 88.29 90.79 82.57 90.03
[09:43:48.511] <TB1> INFO: Vcal RMS: 4.87 6.14 6.00 4.81 5.45 5.43 5.28 4.40 5.51 5.41 5.46 5.11 5.37 5.22 4.70 5.80
[09:43:48.511] <TB1> INFO: PixTestScurves::fullTest() done, duration: 1013 seconds
[09:43:48.511] <TB1> INFO: Decoding statistics:
[09:43:48.511] <TB1> INFO: General information:
[09:43:48.511] <TB1> INFO: 16bit words read: 0
[09:43:48.511] <TB1> INFO: valid events total: 0
[09:43:48.511] <TB1> INFO: empty events: 0
[09:43:48.511] <TB1> INFO: valid events with pixels: 0
[09:43:48.511] <TB1> INFO: valid pixel hits: 0
[09:43:48.511] <TB1> INFO: Event errors: 0
[09:43:48.511] <TB1> INFO: start marker: 0
[09:43:48.511] <TB1> INFO: stop marker: 0
[09:43:48.511] <TB1> INFO: overflow: 0
[09:43:48.511] <TB1> INFO: invalid 5bit words: 0
[09:43:48.511] <TB1> INFO: invalid XOR eye diagram: 0
[09:43:48.511] <TB1> INFO: frame (failed synchr.): 0
[09:43:48.511] <TB1> INFO: idle data (no TBM trl): 0
[09:43:48.511] <TB1> INFO: no data (only TBM hdr): 0
[09:43:48.511] <TB1> INFO: TBM errors: 0
[09:43:48.511] <TB1> INFO: flawed TBM headers: 0
[09:43:48.511] <TB1> INFO: flawed TBM trailers: 0
[09:43:48.511] <TB1> INFO: event ID mismatches: 0
[09:43:48.511] <TB1> INFO: ROC errors: 0
[09:43:48.511] <TB1> INFO: missing ROC header(s): 0
[09:43:48.511] <TB1> INFO: misplaced readback start: 0
[09:43:48.511] <TB1> INFO: Pixel decoding errors: 0
[09:43:48.511] <TB1> INFO: pixel data incomplete: 0
[09:43:48.511] <TB1> INFO: pixel address: 0
[09:43:48.511] <TB1> INFO: pulse height fill bit: 0
[09:43:48.511] <TB1> INFO: buffer corruption: 0
[09:43:48.580] <TB1> INFO: ######################################################################
[09:43:48.580] <TB1> INFO: PixTestTrim::doTest()
[09:43:48.580] <TB1> INFO: ######################################################################
[09:43:48.581] <TB1> INFO: ----------------------------------------------------------------------
[09:43:48.581] <TB1> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[09:43:48.581] <TB1> INFO: ----------------------------------------------------------------------
[09:43:48.659] <TB1> INFO: ---> VthrComp thr map (minimal VthrComp)
[09:43:48.659] <TB1> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[09:43:48.667] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[09:43:48.667] <TB1> INFO: run 1 of 1
[09:43:48.926] <TB1> INFO: Expecting 6281600 events.
[09:44:28.164] <TB1> INFO: 1058950 events read in total (38680ms).
[09:45:06.869] <TB1> INFO: 2114100 events read in total (77386ms).
[09:45:45.639] <TB1> INFO: 3166130 events read in total (116156ms).
[09:46:24.765] <TB1> INFO: 4223900 events read in total (155281ms).
[09:47:03.992] <TB1> INFO: 5287740 events read in total (194508ms).
[09:47:40.135] <TB1> INFO: 6281600 events read in total (230651ms).
[09:47:40.165] <TB1> INFO: Test took 231498ms.
[09:48:00.214] <TB1> INFO: ROC 0 VthrComp = 88
[09:48:00.214] <TB1> INFO: ROC 1 VthrComp = 101
[09:48:00.214] <TB1> INFO: ROC 2 VthrComp = 101
[09:48:00.214] <TB1> INFO: ROC 3 VthrComp = 88
[09:48:00.214] <TB1> INFO: ROC 4 VthrComp = 85
[09:48:00.215] <TB1> INFO: ROC 5 VthrComp = 89
[09:48:00.215] <TB1> INFO: ROC 6 VthrComp = 97
[09:48:00.215] <TB1> INFO: ROC 7 VthrComp = 82
[09:48:00.215] <TB1> INFO: ROC 8 VthrComp = 92
[09:48:00.215] <TB1> INFO: ROC 9 VthrComp = 101
[09:48:00.215] <TB1> INFO: ROC 10 VthrComp = 97
[09:48:00.215] <TB1> INFO: ROC 11 VthrComp = 90
[09:48:00.215] <TB1> INFO: ROC 12 VthrComp = 95
[09:48:00.215] <TB1> INFO: ROC 13 VthrComp = 101
[09:48:00.215] <TB1> INFO: ROC 14 VthrComp = 86
[09:48:00.215] <TB1> INFO: ROC 15 VthrComp = 92
[09:48:00.216] <TB1> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[09:48:00.216] <TB1> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[09:48:00.223] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[09:48:00.224] <TB1> INFO: run 1 of 1
[09:48:00.519] <TB1> INFO: Expecting 6281600 events.
[09:48:35.812] <TB1> INFO: 756360 events read in total (34737ms).
[09:49:10.305] <TB1> INFO: 1510880 events read in total (69230ms).
[09:49:45.159] <TB1> INFO: 2265000 events read in total (104084ms).
[09:50:20.062] <TB1> INFO: 3019360 events read in total (138987ms).
[09:50:54.981] <TB1> INFO: 3768750 events read in total (173906ms).
[09:51:29.920] <TB1> INFO: 4514880 events read in total (208845ms).
[09:52:04.454] <TB1> INFO: 5259180 events read in total (243379ms).
[09:52:39.476] <TB1> INFO: 6003620 events read in total (278401ms).
[09:52:52.598] <TB1> INFO: 6281600 events read in total (291523ms).
[09:52:52.656] <TB1> INFO: Test took 292432ms.
[09:53:18.422] <TB1> INFO: roc 0 with ID = 0 has maximal Vcal 58.4696 for pixel 21/79 mean/min/max = 45.6642/32.4818/58.8466
[09:53:18.437] <TB1> INFO: roc 1 with ID = 1 has maximal Vcal 65.5359 for pixel 9/5 mean/min/max = 48.9705/32.318/65.6229
[09:53:18.437] <TB1> INFO: roc 2 with ID = 2 has maximal Vcal 61.9818 for pixel 8/11 mean/min/max = 46.8955/31.8051/61.9859
[09:53:18.438] <TB1> INFO: roc 3 with ID = 3 has maximal Vcal 59.017 for pixel 23/0 mean/min/max = 45.9649/32.8115/59.1183
[09:53:18.438] <TB1> INFO: roc 4 with ID = 4 has maximal Vcal 60.8297 for pixel 51/21 mean/min/max = 46.3541/31.7525/60.9558
[09:53:18.438] <TB1> INFO: roc 5 with ID = 5 has maximal Vcal 59.774 for pixel 0/29 mean/min/max = 46.136/32.1902/60.0819
[09:53:18.438] <TB1> INFO: roc 6 with ID = 6 has maximal Vcal 58.314 for pixel 16/0 mean/min/max = 45.0567/31.7745/58.3389
[09:53:18.439] <TB1> INFO: roc 7 with ID = 7 has maximal Vcal 56.6929 for pixel 0/71 mean/min/max = 44.4555/32.1837/56.7273
[09:53:18.439] <TB1> INFO: roc 8 with ID = 8 has maximal Vcal 60.1047 for pixel 21/1 mean/min/max = 45.8065/31.3345/60.2785
[09:53:18.439] <TB1> INFO: roc 9 with ID = 9 has maximal Vcal 58.1906 for pixel 14/78 mean/min/max = 45.3313/32.3603/58.3022
[09:53:18.439] <TB1> INFO: roc 10 with ID = 10 has maximal Vcal 59.2261 for pixel 10/7 mean/min/max = 45.7155/32.1052/59.3258
[09:53:18.440] <TB1> INFO: roc 11 with ID = 11 has maximal Vcal 59.2882 for pixel 12/64 mean/min/max = 45.6609/32.0029/59.3189
[09:53:18.440] <TB1> INFO: roc 12 with ID = 12 has maximal Vcal 57.8246 for pixel 48/72 mean/min/max = 45.026/32.1018/57.9502
[09:53:18.440] <TB1> INFO: roc 13 with ID = 13 has maximal Vcal 56.784 for pixel 5/79 mean/min/max = 44.1581/31.4337/56.8825
[09:53:18.440] <TB1> INFO: roc 14 with ID = 14 has maximal Vcal 57.7866 for pixel 3/1 mean/min/max = 45.104/32.3158/57.8922
[09:53:18.441] <TB1> INFO: roc 15 with ID = 15 has maximal Vcal 61.673 for pixel 5/3 mean/min/max = 46.506/31.3382/61.6737
[09:53:18.441] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[09:53:18.529] <TB1> INFO: Expecting 514560 events.
[09:53:31.691] <TB1> INFO: 514560 events read in total (12606ms).
[09:53:31.696] <TB1> INFO: Expecting 514560 events.
[09:53:44.455] <TB1> INFO: 514560 events read in total (12339ms).
[09:53:44.463] <TB1> INFO: Expecting 514560 events.
[09:53:57.308] <TB1> INFO: 514560 events read in total (12433ms).
[09:53:57.317] <TB1> INFO: Expecting 514560 events.
[09:54:10.206] <TB1> INFO: 514560 events read in total (12478ms).
[09:54:10.218] <TB1> INFO: Expecting 514560 events.
[09:54:22.921] <TB1> INFO: 514560 events read in total (12291ms).
[09:54:22.934] <TB1> INFO: Expecting 514560 events.
[09:54:35.923] <TB1> INFO: 514560 events read in total (12576ms).
[09:54:35.938] <TB1> INFO: Expecting 514560 events.
[09:54:48.800] <TB1> INFO: 514560 events read in total (12456ms).
[09:54:48.817] <TB1> INFO: Expecting 514560 events.
[09:55:01.742] <TB1> INFO: 514560 events read in total (12518ms).
[09:55:01.761] <TB1> INFO: Expecting 514560 events.
[09:55:14.706] <TB1> INFO: 514560 events read in total (12539ms).
[09:55:14.728] <TB1> INFO: Expecting 514560 events.
[09:55:27.732] <TB1> INFO: 514560 events read in total (12603ms).
[09:55:27.756] <TB1> INFO: Expecting 514560 events.
[09:55:40.781] <TB1> INFO: 514560 events read in total (12623ms).
[09:55:40.807] <TB1> INFO: Expecting 514560 events.
[09:55:53.774] <TB1> INFO: 514560 events read in total (12566ms).
[09:55:53.802] <TB1> INFO: Expecting 514560 events.
[09:56:06.796] <TB1> INFO: 514560 events read in total (12592ms).
[09:56:06.826] <TB1> INFO: Expecting 514560 events.
[09:56:19.832] <TB1> INFO: 514560 events read in total (12604ms).
[09:56:19.865] <TB1> INFO: Expecting 514560 events.
[09:56:32.767] <TB1> INFO: 514560 events read in total (12500ms).
[09:56:32.803] <TB1> INFO: Expecting 514560 events.
[09:56:45.695] <TB1> INFO: 514560 events read in total (12490ms).
[09:56:45.733] <TB1> INFO: Test took 207292ms.
[09:56:46.759] <TB1> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[09:56:46.766] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[09:56:46.766] <TB1> INFO: run 1 of 1
[09:56:47.027] <TB1> INFO: Expecting 6281600 events.
[09:57:21.946] <TB1> INFO: 742710 events read in total (34363ms).
[09:57:56.575] <TB1> INFO: 1483620 events read in total (68992ms).
[09:58:31.004] <TB1> INFO: 2223840 events read in total (103421ms).
[09:59:05.514] <TB1> INFO: 2963590 events read in total (137931ms).
[09:59:40.140] <TB1> INFO: 3698340 events read in total (172557ms).
[10:00:14.664] <TB1> INFO: 4428850 events read in total (207081ms).
[10:00:48.733] <TB1> INFO: 5157430 events read in total (241150ms).
[10:01:23.304] <TB1> INFO: 5885340 events read in total (275721ms).
[10:01:42.310] <TB1> INFO: 6281600 events read in total (294727ms).
[10:01:42.364] <TB1> INFO: Test took 295598ms.
[10:02:07.858] <TB1> INFO: ---> TrimStepCorr4 extremal thresholds: 0.015302 .. 255.000000
[10:02:07.941] <TB1> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[10:02:07.952] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[10:02:07.952] <TB1> INFO: run 1 of 1
[10:02:08.217] <TB1> INFO: Expecting 10649600 events.
[10:02:43.287] <TB1> INFO: 712340 events read in total (34514ms).
[10:03:16.912] <TB1> INFO: 1424330 events read in total (68139ms).
[10:03:51.448] <TB1> INFO: 2136790 events read in total (102675ms).
[10:04:25.732] <TB1> INFO: 2849280 events read in total (136959ms).
[10:05:00.132] <TB1> INFO: 3561970 events read in total (171359ms).
[10:05:34.294] <TB1> INFO: 4274450 events read in total (205521ms).
[10:06:09.056] <TB1> INFO: 4987200 events read in total (240283ms).
[10:06:43.145] <TB1> INFO: 5699680 events read in total (274372ms).
[10:07:17.134] <TB1> INFO: 6411700 events read in total (308361ms).
[10:07:51.685] <TB1> INFO: 7123140 events read in total (342912ms).
[10:08:26.122] <TB1> INFO: 7834430 events read in total (377349ms).
[10:09:01.304] <TB1> INFO: 8544810 events read in total (412531ms).
[10:09:35.847] <TB1> INFO: 9255410 events read in total (447074ms).
[10:10:10.196] <TB1> INFO: 9965770 events read in total (481423ms).
[10:10:42.779] <TB1> INFO: 10649600 events read in total (514006ms).
[10:10:42.870] <TB1> INFO: Test took 514918ms.
[10:11:13.535] <TB1> INFO: ---> TrimStepCorr2 extremal thresholds: 14.658273 .. 45.400840
[10:11:13.619] <TB1> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 4 .. 55 (-1/-1) hits flags = 528 (plus default)
[10:11:13.628] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[10:11:13.628] <TB1> INFO: run 1 of 1
[10:11:13.898] <TB1> INFO: Expecting 2163200 events.
[10:11:51.644] <TB1> INFO: 942620 events read in total (37190ms).
[10:12:29.658] <TB1> INFO: 1883370 events read in total (75204ms).
[10:12:41.192] <TB1> INFO: 2163200 events read in total (86738ms).
[10:12:41.208] <TB1> INFO: Test took 87580ms.
[10:12:55.013] <TB1> INFO: ---> TrimStepCorr1a extremal thresholds: 17.672150 .. 41.177103
[10:12:55.107] <TB1> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 7 .. 51 (-1/-1) hits flags = 528 (plus default)
[10:12:55.116] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[10:12:55.116] <TB1> INFO: run 1 of 1
[10:12:55.408] <TB1> INFO: Expecting 1872000 events.
[10:13:33.822] <TB1> INFO: 963030 events read in total (37858ms).
[10:14:10.436] <TB1> INFO: 1872000 events read in total (74472ms).
[10:14:10.457] <TB1> INFO: Test took 75342ms.
[10:14:24.580] <TB1> INFO: ---> TrimStepCorr1b extremal thresholds: 1.990063 .. 40.602131
[10:14:24.660] <TB1> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 1 .. 50 (-1/-1) hits flags = 528 (plus default)
[10:14:24.669] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[10:14:24.669] <TB1> INFO: run 1 of 1
[10:14:24.958] <TB1> INFO: Expecting 2080000 events.
[10:15:04.654] <TB1> INFO: 1005150 events read in total (39141ms).
[10:15:43.451] <TB1> INFO: 2010720 events read in total (77937ms).
[10:15:46.451] <TB1> INFO: 2080000 events read in total (80937ms).
[10:15:46.460] <TB1> INFO: Test took 81791ms.
[10:15:59.576] <TB1> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[10:15:59.576] <TB1> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[10:15:59.584] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[10:15:59.584] <TB1> INFO: run 1 of 1
[10:15:59.845] <TB1> INFO: Expecting 1705600 events.
[10:16:37.282] <TB1> INFO: 879020 events read in total (36881ms).
[10:17:12.380] <TB1> INFO: 1705600 events read in total (71979ms).
[10:17:12.391] <TB1> INFO: Test took 72807ms.
[10:17:25.718] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C0.dat
[10:17:25.719] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C1.dat
[10:17:25.719] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C2.dat
[10:17:25.719] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C3.dat
[10:17:25.719] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C4.dat
[10:17:25.720] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C5.dat
[10:17:25.720] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C6.dat
[10:17:25.720] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C7.dat
[10:17:25.721] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C8.dat
[10:17:25.721] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C9.dat
[10:17:25.721] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C10.dat
[10:17:25.722] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C11.dat
[10:17:25.722] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C12.dat
[10:17:25.722] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C13.dat
[10:17:25.723] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C14.dat
[10:17:25.723] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C15.dat
[10:17:25.723] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C0.dat
[10:17:25.732] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C1.dat
[10:17:25.738] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C2.dat
[10:17:25.744] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C3.dat
[10:17:25.750] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C4.dat
[10:17:25.756] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C5.dat
[10:17:25.763] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C6.dat
[10:17:25.769] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C7.dat
[10:17:25.775] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C8.dat
[10:17:25.781] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C9.dat
[10:17:25.787] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C10.dat
[10:17:25.793] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C11.dat
[10:17:25.799] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C12.dat
[10:17:25.805] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C13.dat
[10:17:25.812] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C14.dat
[10:17:25.818] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//trimParameters35_C15.dat
[10:17:25.826] <TB1> INFO: PixTestTrim::trimTest() done
[10:17:25.826] <TB1> INFO: vtrim: 104 114 120 104 86 110 101 106 115 108 120 114 110 115 105 112
[10:17:25.826] <TB1> INFO: vthrcomp: 88 101 101 88 85 89 97 82 92 101 97 90 95 101 86 92
[10:17:25.826] <TB1> INFO: vcal mean: 34.98 34.99 34.96 34.99 35.01 35.01 34.96 35.00 35.01 34.99 35.01 34.96 35.00 34.98 35.01 35.02
[10:17:25.826] <TB1> INFO: vcal RMS: 0.80 1.16 0.94 0.86 0.96 0.81 0.88 0.75 0.89 0.82 0.87 0.85 0.83 0.83 0.97 0.91
[10:17:25.826] <TB1> INFO: bits mean: 9.18 8.85 9.50 9.55 8.76 8.64 9.64 9.40 9.77 9.52 9.32 9.66 9.55 9.91 9.27 9.61
[10:17:25.826] <TB1> INFO: bits RMS: 2.73 2.62 2.59 2.50 2.94 3.00 2.64 2.75 2.63 2.67 2.83 2.65 2.68 2.69 2.75 2.64
[10:17:25.832] <TB1> INFO: ----------------------------------------------------------------------
[10:17:25.832] <TB1> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[10:17:25.832] <TB1> INFO: ----------------------------------------------------------------------
[10:17:25.835] <TB1> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[10:17:25.843] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[10:17:25.843] <TB1> INFO: run 1 of 1
[10:17:26.106] <TB1> INFO: Expecting 4160000 events.
[10:18:08.069] <TB1> INFO: 923680 events read in total (41407ms).
[10:18:49.406] <TB1> INFO: 1841785 events read in total (82745ms).
[10:19:30.739] <TB1> INFO: 2753160 events read in total (124078ms).
[10:20:11.846] <TB1> INFO: 3662895 events read in total (165184ms).
[10:20:34.784] <TB1> INFO: 4160000 events read in total (188123ms).
[10:20:34.820] <TB1> INFO: Test took 188977ms.
[10:21:02.807] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 176 (-1/-1) hits flags = 528 (plus default)
[10:21:02.815] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[10:21:02.815] <TB1> INFO: run 1 of 1
[10:21:03.101] <TB1> INFO: Expecting 3681600 events.
[10:21:46.477] <TB1> INFO: 937040 events read in total (42819ms).
[10:22:28.217] <TB1> INFO: 1868020 events read in total (84559ms).
[10:23:10.087] <TB1> INFO: 2790610 events read in total (126429ms).
[10:23:49.677] <TB1> INFO: 3681600 events read in total (166019ms).
[10:23:49.714] <TB1> INFO: Test took 166899ms.
[10:24:16.261] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 161 (-1/-1) hits flags = 528 (plus default)
[10:24:16.269] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[10:24:16.269] <TB1> INFO: run 1 of 1
[10:24:16.533] <TB1> INFO: Expecting 3369600 events.
[10:24:59.715] <TB1> INFO: 973940 events read in total (42626ms).
[10:25:42.241] <TB1> INFO: 1938595 events read in total (85152ms).
[10:26:24.178] <TB1> INFO: 2895540 events read in total (127089ms).
[10:26:45.101] <TB1> INFO: 3369600 events read in total (148012ms).
[10:26:45.136] <TB1> INFO: Test took 148866ms.
[10:27:13.526] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 162 (-1/-1) hits flags = 528 (plus default)
[10:27:13.534] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[10:27:13.534] <TB1> INFO: run 1 of 1
[10:27:13.822] <TB1> INFO: Expecting 3390400 events.
[10:27:56.573] <TB1> INFO: 970945 events read in total (42195ms).
[10:28:38.896] <TB1> INFO: 1933140 events read in total (84518ms).
[10:29:21.066] <TB1> INFO: 2887895 events read in total (126688ms).
[10:29:43.411] <TB1> INFO: 3390400 events read in total (149033ms).
[10:29:43.439] <TB1> INFO: Test took 149905ms.
[10:30:08.911] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 163 (-1/-1) hits flags = 528 (plus default)
[10:30:08.919] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[10:30:08.919] <TB1> INFO: run 1 of 1
[10:30:09.178] <TB1> INFO: Expecting 3411200 events.
[10:30:52.516] <TB1> INFO: 968075 events read in total (42782ms).
[10:31:34.548] <TB1> INFO: 1927785 events read in total (84814ms).
[10:32:16.901] <TB1> INFO: 2879670 events read in total (127167ms).
[10:32:40.847] <TB1> INFO: 3411200 events read in total (151113ms).
[10:32:40.881] <TB1> INFO: Test took 151962ms.
[10:33:07.079] <TB1> INFO: PixTestTrim::trimBitTest() done
[10:33:07.080] <TB1> INFO: PixTestTrim::doTest() done, duration: 2958 seconds
[10:33:07.080] <TB1> INFO: Decoding statistics:
[10:33:07.080] <TB1> INFO: General information:
[10:33:07.080] <TB1> INFO: 16bit words read: 0
[10:33:07.080] <TB1> INFO: valid events total: 0
[10:33:07.080] <TB1> INFO: empty events: 0
[10:33:07.080] <TB1> INFO: valid events with pixels: 0
[10:33:07.080] <TB1> INFO: valid pixel hits: 0
[10:33:07.080] <TB1> INFO: Event errors: 0
[10:33:07.080] <TB1> INFO: start marker: 0
[10:33:07.080] <TB1> INFO: stop marker: 0
[10:33:07.080] <TB1> INFO: overflow: 0
[10:33:07.080] <TB1> INFO: invalid 5bit words: 0
[10:33:07.080] <TB1> INFO: invalid XOR eye diagram: 0
[10:33:07.080] <TB1> INFO: frame (failed synchr.): 0
[10:33:07.080] <TB1> INFO: idle data (no TBM trl): 0
[10:33:07.080] <TB1> INFO: no data (only TBM hdr): 0
[10:33:07.080] <TB1> INFO: TBM errors: 0
[10:33:07.080] <TB1> INFO: flawed TBM headers: 0
[10:33:07.080] <TB1> INFO: flawed TBM trailers: 0
[10:33:07.080] <TB1> INFO: event ID mismatches: 0
[10:33:07.080] <TB1> INFO: ROC errors: 0
[10:33:07.080] <TB1> INFO: missing ROC header(s): 0
[10:33:07.080] <TB1> INFO: misplaced readback start: 0
[10:33:07.080] <TB1> INFO: Pixel decoding errors: 0
[10:33:07.080] <TB1> INFO: pixel data incomplete: 0
[10:33:07.080] <TB1> INFO: pixel address: 0
[10:33:07.080] <TB1> INFO: pulse height fill bit: 0
[10:33:07.080] <TB1> INFO: buffer corruption: 0
[10:33:07.756] <TB1> INFO: ######################################################################
[10:33:07.756] <TB1> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[10:33:07.756] <TB1> INFO: ######################################################################
[10:33:08.016] <TB1> INFO: Expecting 41600 events.
[10:33:11.830] <TB1> INFO: 41600 events read in total (3258ms).
[10:33:11.830] <TB1> INFO: Test took 4073ms.
[10:33:12.307] <TB1> INFO: Expecting 41600 events.
[10:33:16.121] <TB1> INFO: 41600 events read in total (3257ms).
[10:33:16.121] <TB1> INFO: Test took 4090ms.
[10:33:16.408] <TB1> INFO: Expecting 41600 events.
[10:33:20.245] <TB1> INFO: 41600 events read in total (3281ms).
[10:33:20.245] <TB1> INFO: Test took 4102ms.
[10:33:20.502] <TB1> INFO: Expecting 2560 events.
[10:33:21.356] <TB1> INFO: 2560 events read in total (297ms).
[10:33:21.356] <TB1> INFO: Test took 1097ms.
[10:33:21.662] <TB1> INFO: Expecting 2560 events.
[10:33:22.515] <TB1> INFO: 2560 events read in total (297ms).
[10:33:22.515] <TB1> INFO: Test took 1158ms.
[10:33:22.819] <TB1> INFO: Expecting 2560 events.
[10:33:23.676] <TB1> INFO: 2560 events read in total (301ms).
[10:33:23.677] <TB1> INFO: Test took 1162ms.
[10:33:23.982] <TB1> INFO: Expecting 2560 events.
[10:33:24.835] <TB1> INFO: 2560 events read in total (297ms).
[10:33:24.835] <TB1> INFO: Test took 1158ms.
[10:33:25.140] <TB1> INFO: Expecting 2560 events.
[10:33:25.993] <TB1> INFO: 2560 events read in total (297ms).
[10:33:25.994] <TB1> INFO: Test took 1158ms.
[10:33:26.298] <TB1> INFO: Expecting 2560 events.
[10:33:27.152] <TB1> INFO: 2560 events read in total (298ms).
[10:33:27.152] <TB1> INFO: Test took 1158ms.
[10:33:27.457] <TB1> INFO: Expecting 2560 events.
[10:33:28.309] <TB1> INFO: 2560 events read in total (296ms).
[10:33:28.309] <TB1> INFO: Test took 1157ms.
[10:33:28.615] <TB1> INFO: Expecting 2560 events.
[10:33:29.468] <TB1> INFO: 2560 events read in total (297ms).
[10:33:29.468] <TB1> INFO: Test took 1157ms.
[10:33:29.774] <TB1> INFO: Expecting 2560 events.
[10:33:30.629] <TB1> INFO: 2560 events read in total (299ms).
[10:33:30.629] <TB1> INFO: Test took 1161ms.
[10:33:30.934] <TB1> INFO: Expecting 2560 events.
[10:33:31.788] <TB1> INFO: 2560 events read in total (297ms).
[10:33:31.788] <TB1> INFO: Test took 1158ms.
[10:33:32.094] <TB1> INFO: Expecting 2560 events.
[10:33:32.952] <TB1> INFO: 2560 events read in total (302ms).
[10:33:32.952] <TB1> INFO: Test took 1163ms.
[10:33:33.256] <TB1> INFO: Expecting 2560 events.
[10:33:34.115] <TB1> INFO: 2560 events read in total (302ms).
[10:33:34.115] <TB1> INFO: Test took 1163ms.
[10:33:34.420] <TB1> INFO: Expecting 2560 events.
[10:33:35.278] <TB1> INFO: 2560 events read in total (302ms).
[10:33:35.278] <TB1> INFO: Test took 1162ms.
[10:33:35.583] <TB1> INFO: Expecting 2560 events.
[10:33:36.438] <TB1> INFO: 2560 events read in total (299ms).
[10:33:36.438] <TB1> INFO: Test took 1159ms.
[10:33:36.744] <TB1> INFO: Expecting 2560 events.
[10:33:37.597] <TB1> INFO: 2560 events read in total (297ms).
[10:33:37.597] <TB1> INFO: Test took 1158ms.
[10:33:37.902] <TB1> INFO: Expecting 2560 events.
[10:33:38.758] <TB1> INFO: 2560 events read in total (300ms).
[10:33:38.758] <TB1> INFO: Test took 1160ms.
[10:33:38.761] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:33:39.064] <TB1> INFO: Expecting 655360 events.
[10:33:56.092] <TB1> INFO: 655360 events read in total (16471ms).
[10:33:56.101] <TB1> INFO: Expecting 655360 events.
[10:34:12.818] <TB1> INFO: 655360 events read in total (16315ms).
[10:34:12.829] <TB1> INFO: Expecting 655360 events.
[10:34:29.602] <TB1> INFO: 655360 events read in total (16371ms).
[10:34:29.621] <TB1> INFO: Expecting 655360 events.
[10:34:46.474] <TB1> INFO: 655360 events read in total (16452ms).
[10:34:46.493] <TB1> INFO: Expecting 655360 events.
[10:35:03.238] <TB1> INFO: 655360 events read in total (16344ms).
[10:35:03.261] <TB1> INFO: Expecting 655360 events.
[10:35:19.995] <TB1> INFO: 655360 events read in total (16332ms).
[10:35:20.024] <TB1> INFO: Expecting 655360 events.
[10:35:36.828] <TB1> INFO: 655360 events read in total (16402ms).
[10:35:36.863] <TB1> INFO: Expecting 655360 events.
[10:35:53.672] <TB1> INFO: 655360 events read in total (16407ms).
[10:35:53.707] <TB1> INFO: Expecting 655360 events.
[10:36:10.627] <TB1> INFO: 655360 events read in total (16518ms).
[10:36:10.670] <TB1> INFO: Expecting 655360 events.
[10:36:27.501] <TB1> INFO: 655360 events read in total (16429ms).
[10:36:27.540] <TB1> INFO: Expecting 655360 events.
[10:36:44.387] <TB1> INFO: 655360 events read in total (16445ms).
[10:36:44.429] <TB1> INFO: Expecting 655360 events.
[10:37:01.312] <TB1> INFO: 655360 events read in total (16482ms).
[10:37:01.358] <TB1> INFO: Expecting 655360 events.
[10:37:18.175] <TB1> INFO: 655360 events read in total (16416ms).
[10:37:18.225] <TB1> INFO: Expecting 655360 events.
[10:37:35.021] <TB1> INFO: 655360 events read in total (16395ms).
[10:37:35.074] <TB1> INFO: Expecting 655360 events.
[10:37:51.942] <TB1> INFO: 655360 events read in total (16466ms).
[10:37:51.998] <TB1> INFO: Expecting 655360 events.
[10:38:08.797] <TB1> INFO: 655360 events read in total (16397ms).
[10:38:08.862] <TB1> INFO: Test took 270101ms.
[10:38:08.952] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:38:09.181] <TB1> INFO: Expecting 655360 events.
[10:38:25.918] <TB1> INFO: 655360 events read in total (16181ms).
[10:38:25.927] <TB1> INFO: Expecting 655360 events.
[10:38:42.198] <TB1> INFO: 655360 events read in total (15870ms).
[10:38:42.210] <TB1> INFO: Expecting 655360 events.
[10:38:58.584] <TB1> INFO: 655360 events read in total (15972ms).
[10:38:58.606] <TB1> INFO: Expecting 655360 events.
[10:39:15.235] <TB1> INFO: 655360 events read in total (16227ms).
[10:39:15.254] <TB1> INFO: Expecting 655360 events.
[10:39:31.772] <TB1> INFO: 655360 events read in total (16116ms).
[10:39:31.794] <TB1> INFO: Expecting 655360 events.
[10:39:48.407] <TB1> INFO: 655360 events read in total (16211ms).
[10:39:48.433] <TB1> INFO: Expecting 655360 events.
[10:40:05.268] <TB1> INFO: 655360 events read in total (16433ms).
[10:40:05.300] <TB1> INFO: Expecting 655360 events.
[10:40:22.123] <TB1> INFO: 655360 events read in total (16422ms).
[10:40:22.158] <TB1> INFO: Expecting 655360 events.
[10:40:38.953] <TB1> INFO: 655360 events read in total (16394ms).
[10:40:38.989] <TB1> INFO: Expecting 655360 events.
[10:40:55.948] <TB1> INFO: 655360 events read in total (16557ms).
[10:40:55.987] <TB1> INFO: Expecting 655360 events.
[10:41:12.873] <TB1> INFO: 655360 events read in total (16484ms).
[10:41:12.917] <TB1> INFO: Expecting 655360 events.
[10:41:29.759] <TB1> INFO: 655360 events read in total (16440ms).
[10:41:29.807] <TB1> INFO: Expecting 655360 events.
[10:41:46.704] <TB1> INFO: 655360 events read in total (16495ms).
[10:41:46.753] <TB1> INFO: Expecting 655360 events.
[10:42:03.533] <TB1> INFO: 655360 events read in total (16378ms).
[10:42:03.587] <TB1> INFO: Expecting 655360 events.
[10:42:20.032] <TB1> INFO: 655360 events read in total (16043ms).
[10:42:20.087] <TB1> INFO: Expecting 655360 events.
[10:42:36.960] <TB1> INFO: 655360 events read in total (16471ms).
[10:42:37.019] <TB1> INFO: Test took 268067ms.
[10:42:37.218] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.225] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.232] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.240] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.247] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.254] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.261] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.269] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.276] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.283] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.291] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.298] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.306] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.316] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.326] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.336] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[10:42:37.346] <TB1> INFO: safety margin for low PH: adding 1, margin is now 21
[10:42:37.355] <TB1> INFO: safety margin for low PH: adding 2, margin is now 22
[10:42:37.362] <TB1> INFO: safety margin for low PH: adding 3, margin is now 23
[10:42:37.402] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C0.dat
[10:42:37.403] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C1.dat
[10:42:37.404] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C2.dat
[10:42:37.404] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C3.dat
[10:42:37.404] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C4.dat
[10:42:37.405] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C5.dat
[10:42:37.405] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C6.dat
[10:42:37.405] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C7.dat
[10:42:37.405] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C8.dat
[10:42:37.406] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C9.dat
[10:42:37.406] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C10.dat
[10:42:37.406] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C11.dat
[10:42:37.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C12.dat
[10:42:37.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C13.dat
[10:42:37.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C14.dat
[10:42:37.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//dacParameters35_C15.dat
[10:42:37.713] <TB1> INFO: Expecting 41600 events.
[10:42:41.197] <TB1> INFO: 41600 events read in total (2928ms).
[10:42:41.197] <TB1> INFO: Test took 3787ms.
[10:42:41.659] <TB1> INFO: Expecting 41600 events.
[10:42:45.124] <TB1> INFO: 41600 events read in total (2909ms).
[10:42:45.125] <TB1> INFO: Test took 3750ms.
[10:42:45.609] <TB1> INFO: Expecting 41600 events.
[10:42:49.128] <TB1> INFO: 41600 events read in total (2963ms).
[10:42:49.128] <TB1> INFO: Test took 3821ms.
[10:42:49.316] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:49.405] <TB1> INFO: Expecting 2560 events.
[10:42:50.259] <TB1> INFO: 2560 events read in total (298ms).
[10:42:50.259] <TB1> INFO: Test took 943ms.
[10:42:50.261] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:50.565] <TB1> INFO: Expecting 2560 events.
[10:42:51.419] <TB1> INFO: 2560 events read in total (298ms).
[10:42:51.419] <TB1> INFO: Test took 1158ms.
[10:42:51.422] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:51.726] <TB1> INFO: Expecting 2560 events.
[10:42:52.584] <TB1> INFO: 2560 events read in total (302ms).
[10:42:52.584] <TB1> INFO: Test took 1162ms.
[10:42:52.586] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:52.890] <TB1> INFO: Expecting 2560 events.
[10:42:53.748] <TB1> INFO: 2560 events read in total (302ms).
[10:42:53.748] <TB1> INFO: Test took 1162ms.
[10:42:53.750] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:54.054] <TB1> INFO: Expecting 2560 events.
[10:42:54.914] <TB1> INFO: 2560 events read in total (304ms).
[10:42:54.915] <TB1> INFO: Test took 1165ms.
[10:42:54.917] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:55.221] <TB1> INFO: Expecting 2560 events.
[10:42:56.078] <TB1> INFO: 2560 events read in total (301ms).
[10:42:56.078] <TB1> INFO: Test took 1161ms.
[10:42:56.081] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:56.384] <TB1> INFO: Expecting 2560 events.
[10:42:57.236] <TB1> INFO: 2560 events read in total (295ms).
[10:42:57.237] <TB1> INFO: Test took 1156ms.
[10:42:57.238] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:57.543] <TB1> INFO: Expecting 2560 events.
[10:42:58.397] <TB1> INFO: 2560 events read in total (298ms).
[10:42:58.397] <TB1> INFO: Test took 1159ms.
[10:42:58.400] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:58.704] <TB1> INFO: Expecting 2560 events.
[10:42:59.558] <TB1> INFO: 2560 events read in total (298ms).
[10:42:59.558] <TB1> INFO: Test took 1158ms.
[10:42:59.560] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:42:59.865] <TB1> INFO: Expecting 2560 events.
[10:43:00.719] <TB1> INFO: 2560 events read in total (298ms).
[10:43:00.719] <TB1> INFO: Test took 1159ms.
[10:43:00.721] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:01.025] <TB1> INFO: Expecting 2560 events.
[10:43:01.879] <TB1> INFO: 2560 events read in total (297ms).
[10:43:01.879] <TB1> INFO: Test took 1158ms.
[10:43:01.881] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:02.186] <TB1> INFO: Expecting 2560 events.
[10:43:03.040] <TB1> INFO: 2560 events read in total (298ms).
[10:43:03.040] <TB1> INFO: Test took 1159ms.
[10:43:03.042] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:03.345] <TB1> INFO: Expecting 2560 events.
[10:43:04.204] <TB1> INFO: 2560 events read in total (302ms).
[10:43:04.204] <TB1> INFO: Test took 1162ms.
[10:43:04.206] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:04.510] <TB1> INFO: Expecting 2560 events.
[10:43:05.368] <TB1> INFO: 2560 events read in total (302ms).
[10:43:05.368] <TB1> INFO: Test took 1162ms.
[10:43:05.370] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:05.673] <TB1> INFO: Expecting 2560 events.
[10:43:06.525] <TB1> INFO: 2560 events read in total (296ms).
[10:43:06.525] <TB1> INFO: Test took 1155ms.
[10:43:06.527] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:06.832] <TB1> INFO: Expecting 2560 events.
[10:43:07.687] <TB1> INFO: 2560 events read in total (299ms).
[10:43:07.688] <TB1> INFO: Test took 1161ms.
[10:43:07.689] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:07.994] <TB1> INFO: Expecting 2560 events.
[10:43:08.849] <TB1> INFO: 2560 events read in total (299ms).
[10:43:08.850] <TB1> INFO: Test took 1161ms.
[10:43:08.852] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:09.156] <TB1> INFO: Expecting 2560 events.
[10:43:10.009] <TB1> INFO: 2560 events read in total (297ms).
[10:43:10.009] <TB1> INFO: Test took 1157ms.
[10:43:10.011] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:10.315] <TB1> INFO: Expecting 2560 events.
[10:43:11.170] <TB1> INFO: 2560 events read in total (299ms).
[10:43:11.170] <TB1> INFO: Test took 1159ms.
[10:43:11.173] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:11.476] <TB1> INFO: Expecting 2560 events.
[10:43:12.331] <TB1> INFO: 2560 events read in total (298ms).
[10:43:12.331] <TB1> INFO: Test took 1159ms.
[10:43:12.335] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:12.637] <TB1> INFO: Expecting 2560 events.
[10:43:13.494] <TB1> INFO: 2560 events read in total (301ms).
[10:43:13.494] <TB1> INFO: Test took 1160ms.
[10:43:13.498] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:13.800] <TB1> INFO: Expecting 2560 events.
[10:43:14.658] <TB1> INFO: 2560 events read in total (302ms).
[10:43:14.658] <TB1> INFO: Test took 1160ms.
[10:43:14.660] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:14.963] <TB1> INFO: Expecting 2560 events.
[10:43:15.819] <TB1> INFO: 2560 events read in total (299ms).
[10:43:15.820] <TB1> INFO: Test took 1161ms.
[10:43:15.822] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:16.125] <TB1> INFO: Expecting 2560 events.
[10:43:16.979] <TB1> INFO: 2560 events read in total (297ms).
[10:43:16.980] <TB1> INFO: Test took 1158ms.
[10:43:16.982] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:17.285] <TB1> INFO: Expecting 2560 events.
[10:43:18.138] <TB1> INFO: 2560 events read in total (297ms).
[10:43:18.138] <TB1> INFO: Test took 1156ms.
[10:43:18.140] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:18.443] <TB1> INFO: Expecting 2560 events.
[10:43:19.297] <TB1> INFO: 2560 events read in total (297ms).
[10:43:19.298] <TB1> INFO: Test took 1158ms.
[10:43:19.299] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:19.604] <TB1> INFO: Expecting 2560 events.
[10:43:20.458] <TB1> INFO: 2560 events read in total (298ms).
[10:43:20.459] <TB1> INFO: Test took 1160ms.
[10:43:20.461] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:20.765] <TB1> INFO: Expecting 2560 events.
[10:43:21.625] <TB1> INFO: 2560 events read in total (303ms).
[10:43:21.625] <TB1> INFO: Test took 1165ms.
[10:43:21.627] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:21.930] <TB1> INFO: Expecting 2560 events.
[10:43:22.783] <TB1> INFO: 2560 events read in total (297ms).
[10:43:22.784] <TB1> INFO: Test took 1157ms.
[10:43:22.786] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:23.089] <TB1> INFO: Expecting 2560 events.
[10:43:23.943] <TB1> INFO: 2560 events read in total (298ms).
[10:43:23.944] <TB1> INFO: Test took 1158ms.
[10:43:23.946] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:24.249] <TB1> INFO: Expecting 2560 events.
[10:43:25.108] <TB1> INFO: 2560 events read in total (302ms).
[10:43:25.108] <TB1> INFO: Test took 1163ms.
[10:43:25.110] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:25.414] <TB1> INFO: Expecting 2560 events.
[10:43:26.268] <TB1> INFO: 2560 events read in total (297ms).
[10:43:26.269] <TB1> INFO: Test took 1159ms.
[10:43:26.730] <TB1> INFO: PixTestPhOptimization::doTest() done, duration: 618 seconds
[10:43:26.730] <TB1> INFO: PH scale (per ROC): 82 78 76 80 77 83 85 84 80 85 86 79 87 82 79 78
[10:43:26.730] <TB1> INFO: PH offset (per ROC): 153 182 178 151 166 186 159 160 166 161 163 166 148 167 157 176
[10:43:26.736] <TB1> INFO: Decoding statistics:
[10:43:26.736] <TB1> INFO: General information:
[10:43:26.736] <TB1> INFO: 16bit words read: 91912
[10:43:26.736] <TB1> INFO: valid events total: 10240
[10:43:26.736] <TB1> INFO: empty events: 7742
[10:43:26.736] <TB1> INFO: valid events with pixels: 2498
[10:43:26.736] <TB1> INFO: valid pixel hits: 2498
[10:43:26.736] <TB1> INFO: Event errors: 0
[10:43:26.736] <TB1> INFO: start marker: 0
[10:43:26.736] <TB1> INFO: stop marker: 0
[10:43:26.736] <TB1> INFO: overflow: 0
[10:43:26.736] <TB1> INFO: invalid 5bit words: 0
[10:43:26.736] <TB1> INFO: invalid XOR eye diagram: 0
[10:43:26.736] <TB1> INFO: frame (failed synchr.): 0
[10:43:26.736] <TB1> INFO: idle data (no TBM trl): 0
[10:43:26.736] <TB1> INFO: no data (only TBM hdr): 0
[10:43:26.736] <TB1> INFO: TBM errors: 0
[10:43:26.736] <TB1> INFO: flawed TBM headers: 0
[10:43:26.736] <TB1> INFO: flawed TBM trailers: 0
[10:43:26.736] <TB1> INFO: event ID mismatches: 0
[10:43:26.736] <TB1> INFO: ROC errors: 0
[10:43:26.736] <TB1> INFO: missing ROC header(s): 0
[10:43:26.736] <TB1> INFO: misplaced readback start: 0
[10:43:26.736] <TB1> INFO: Pixel decoding errors: 0
[10:43:26.736] <TB1> INFO: pixel data incomplete: 0
[10:43:26.736] <TB1> INFO: pixel address: 0
[10:43:26.737] <TB1> INFO: pulse height fill bit: 0
[10:43:26.737] <TB1> INFO: buffer corruption: 0
[10:43:26.902] <TB1> INFO: ######################################################################
[10:43:26.902] <TB1> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[10:43:26.902] <TB1> INFO: ######################################################################
[10:43:26.913] <TB1> INFO: scanning low vcal = 10
[10:43:27.186] <TB1> INFO: Expecting 41600 events.
[10:43:30.740] <TB1> INFO: 41600 events read in total (2997ms).
[10:43:30.740] <TB1> INFO: Test took 3827ms.
[10:43:30.742] <TB1> INFO: scanning low vcal = 20
[10:43:31.045] <TB1> INFO: Expecting 41600 events.
[10:43:34.618] <TB1> INFO: 41600 events read in total (3017ms).
[10:43:34.618] <TB1> INFO: Test took 3875ms.
[10:43:34.620] <TB1> INFO: scanning low vcal = 30
[10:43:34.924] <TB1> INFO: Expecting 41600 events.
[10:43:38.483] <TB1> INFO: 41600 events read in total (3003ms).
[10:43:38.483] <TB1> INFO: Test took 3863ms.
[10:43:38.485] <TB1> INFO: scanning low vcal = 40
[10:43:38.795] <TB1> INFO: Expecting 41600 events.
[10:43:43.008] <TB1> INFO: 41600 events read in total (3656ms).
[10:43:43.008] <TB1> INFO: Test took 4523ms.
[10:43:43.011] <TB1> INFO: scanning low vcal = 50
[10:43:43.312] <TB1> INFO: Expecting 41600 events.
[10:43:47.528] <TB1> INFO: 41600 events read in total (3660ms).
[10:43:47.528] <TB1> INFO: Test took 4517ms.
[10:43:47.531] <TB1> INFO: scanning low vcal = 60
[10:43:47.815] <TB1> INFO: Expecting 41600 events.
[10:43:52.024] <TB1> INFO: 41600 events read in total (3653ms).
[10:43:52.025] <TB1> INFO: Test took 4494ms.
[10:43:52.028] <TB1> INFO: scanning low vcal = 70
[10:43:52.289] <TB1> INFO: Expecting 41600 events.
[10:43:56.511] <TB1> INFO: 41600 events read in total (3665ms).
[10:43:56.512] <TB1> INFO: Test took 4484ms.
[10:43:56.515] <TB1> INFO: scanning low vcal = 80
[10:43:56.780] <TB1> INFO: Expecting 41600 events.
[10:44:00.994] <TB1> INFO: 41600 events read in total (3657ms).
[10:44:00.995] <TB1> INFO: Test took 4479ms.
[10:44:00.998] <TB1> INFO: scanning low vcal = 90
[10:44:01.259] <TB1> INFO: Expecting 41600 events.
[10:44:05.502] <TB1> INFO: 41600 events read in total (3687ms).
[10:44:05.503] <TB1> INFO: Test took 4505ms.
[10:44:05.507] <TB1> INFO: scanning low vcal = 100
[10:44:05.776] <TB1> INFO: Expecting 41600 events.
[10:44:09.976] <TB1> INFO: 41600 events read in total (3644ms).
[10:44:09.977] <TB1> INFO: Test took 4470ms.
[10:44:09.979] <TB1> INFO: scanning low vcal = 110
[10:44:10.238] <TB1> INFO: Expecting 41600 events.
[10:44:14.460] <TB1> INFO: 41600 events read in total (3666ms).
[10:44:14.460] <TB1> INFO: Test took 4481ms.
[10:44:14.463] <TB1> INFO: scanning low vcal = 120
[10:44:14.764] <TB1> INFO: Expecting 41600 events.
[10:44:18.997] <TB1> INFO: 41600 events read in total (3677ms).
[10:44:18.998] <TB1> INFO: Test took 4535ms.
[10:44:19.001] <TB1> INFO: scanning low vcal = 130
[10:44:19.290] <TB1> INFO: Expecting 41600 events.
[10:44:23.502] <TB1> INFO: 41600 events read in total (3655ms).
[10:44:23.502] <TB1> INFO: Test took 4501ms.
[10:44:23.505] <TB1> INFO: scanning low vcal = 140
[10:44:23.767] <TB1> INFO: Expecting 41600 events.
[10:44:27.980] <TB1> INFO: 41600 events read in total (3657ms).
[10:44:27.981] <TB1> INFO: Test took 4476ms.
[10:44:27.983] <TB1> INFO: scanning low vcal = 150
[10:44:28.269] <TB1> INFO: Expecting 41600 events.
[10:44:32.503] <TB1> INFO: 41600 events read in total (3678ms).
[10:44:32.504] <TB1> INFO: Test took 4520ms.
[10:44:32.507] <TB1> INFO: scanning low vcal = 160
[10:44:32.792] <TB1> INFO: Expecting 41600 events.
[10:44:37.035] <TB1> INFO: 41600 events read in total (3687ms).
[10:44:37.037] <TB1> INFO: Test took 4529ms.
[10:44:37.039] <TB1> INFO: scanning low vcal = 170
[10:44:37.303] <TB1> INFO: Expecting 41600 events.
[10:44:41.505] <TB1> INFO: 41600 events read in total (3646ms).
[10:44:41.506] <TB1> INFO: Test took 4467ms.
[10:44:41.511] <TB1> INFO: scanning low vcal = 180
[10:44:41.774] <TB1> INFO: Expecting 41600 events.
[10:44:46.000] <TB1> INFO: 41600 events read in total (3670ms).
[10:44:46.001] <TB1> INFO: Test took 4490ms.
[10:44:46.003] <TB1> INFO: scanning low vcal = 190
[10:44:46.300] <TB1> INFO: Expecting 41600 events.
[10:44:50.507] <TB1> INFO: 41600 events read in total (3650ms).
[10:44:50.508] <TB1> INFO: Test took 4504ms.
[10:44:50.510] <TB1> INFO: scanning low vcal = 200
[10:44:50.773] <TB1> INFO: Expecting 41600 events.
[10:44:54.974] <TB1> INFO: 41600 events read in total (3645ms).
[10:44:54.975] <TB1> INFO: Test took 4465ms.
[10:44:54.977] <TB1> INFO: scanning low vcal = 210
[10:44:55.239] <TB1> INFO: Expecting 41600 events.
[10:44:59.475] <TB1> INFO: 41600 events read in total (3680ms).
[10:44:59.475] <TB1> INFO: Test took 4498ms.
[10:44:59.478] <TB1> INFO: scanning low vcal = 220
[10:44:59.741] <TB1> INFO: Expecting 41600 events.
[10:45:03.939] <TB1> INFO: 41600 events read in total (3642ms).
[10:45:03.940] <TB1> INFO: Test took 4462ms.
[10:45:03.942] <TB1> INFO: scanning low vcal = 230
[10:45:04.211] <TB1> INFO: Expecting 41600 events.
[10:45:08.420] <TB1> INFO: 41600 events read in total (3653ms).
[10:45:08.421] <TB1> INFO: Test took 4479ms.
[10:45:08.423] <TB1> INFO: scanning low vcal = 240
[10:45:08.687] <TB1> INFO: Expecting 41600 events.
[10:45:12.899] <TB1> INFO: 41600 events read in total (3656ms).
[10:45:12.899] <TB1> INFO: Test took 4476ms.
[10:45:12.902] <TB1> INFO: scanning low vcal = 250
[10:45:13.173] <TB1> INFO: Expecting 41600 events.
[10:45:17.340] <TB1> INFO: 41600 events read in total (3611ms).
[10:45:17.341] <TB1> INFO: Test took 4439ms.
[10:45:17.345] <TB1> INFO: scanning high vcal = 30 (= 210 in low range)
[10:45:17.621] <TB1> INFO: Expecting 41600 events.
[10:45:21.813] <TB1> INFO: 41600 events read in total (3636ms).
[10:45:21.813] <TB1> INFO: Test took 4468ms.
[10:45:21.816] <TB1> INFO: scanning high vcal = 50 (= 350 in low range)
[10:45:22.099] <TB1> INFO: Expecting 41600 events.
[10:45:26.263] <TB1> INFO: 41600 events read in total (3608ms).
[10:45:26.263] <TB1> INFO: Test took 4447ms.
[10:45:26.266] <TB1> INFO: scanning high vcal = 70 (= 490 in low range)
[10:45:26.534] <TB1> INFO: Expecting 41600 events.
[10:45:30.780] <TB1> INFO: 41600 events read in total (3690ms).
[10:45:30.781] <TB1> INFO: Test took 4515ms.
[10:45:30.784] <TB1> INFO: scanning high vcal = 90 (= 630 in low range)
[10:45:31.045] <TB1> INFO: Expecting 41600 events.
[10:45:35.211] <TB1> INFO: 41600 events read in total (3610ms).
[10:45:35.211] <TB1> INFO: Test took 4427ms.
[10:45:35.213] <TB1> INFO: scanning high vcal = 200 (= 1400 in low range)
[10:45:35.476] <TB1> INFO: Expecting 41600 events.
[10:45:39.633] <TB1> INFO: 41600 events read in total (3601ms).
[10:45:39.633] <TB1> INFO: Test took 4419ms.
[10:45:40.103] <TB1> INFO: PixTestGainPedestal::measure() done
[10:46:13.220] <TB1> INFO: PixTestGainPedestal::fit() done
[10:46:13.220] <TB1> INFO: non-linearity mean: 0.950 0.962 0.959 0.966 0.956 0.954 0.957 0.951 0.952 0.958 0.957 0.953 0.958 0.954 0.955 0.952
[10:46:13.220] <TB1> INFO: non-linearity RMS: 0.007 0.006 0.006 0.005 0.008 0.006 0.006 0.006 0.006 0.006 0.005 0.005 0.006 0.007 0.006 0.006
[10:46:13.221] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[10:46:13.239] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[10:46:13.257] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[10:46:13.275] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[10:46:13.293] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[10:46:13.311] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[10:46:13.329] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[10:46:13.346] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[10:46:13.365] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[10:46:13.383] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[10:46:13.401] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[10:46:13.419] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[10:46:13.437] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[10:46:13.455] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[10:46:13.476] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[10:46:13.494] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[10:46:13.525] <TB1> INFO: PixTestGainPedestal::fullTest() done, duration: 166 seconds
[10:46:13.525] <TB1> INFO: Decoding statistics:
[10:46:13.525] <TB1> INFO: General information:
[10:46:13.525] <TB1> INFO: 16bit words read: 2662400
[10:46:13.525] <TB1> INFO: valid events total: 166400
[10:46:13.525] <TB1> INFO: empty events: 0
[10:46:13.525] <TB1> INFO: valid events with pixels: 166400
[10:46:13.525] <TB1> INFO: valid pixel hits: 665560
[10:46:13.525] <TB1> INFO: Event errors: 0
[10:46:13.525] <TB1> INFO: start marker: 0
[10:46:13.525] <TB1> INFO: stop marker: 0
[10:46:13.525] <TB1> INFO: overflow: 0
[10:46:13.525] <TB1> INFO: invalid 5bit words: 0
[10:46:13.525] <TB1> INFO: invalid XOR eye diagram: 0
[10:46:13.525] <TB1> INFO: frame (failed synchr.): 0
[10:46:13.525] <TB1> INFO: idle data (no TBM trl): 0
[10:46:13.525] <TB1> INFO: no data (only TBM hdr): 0
[10:46:13.525] <TB1> INFO: TBM errors: 0
[10:46:13.525] <TB1> INFO: flawed TBM headers: 0
[10:46:13.525] <TB1> INFO: flawed TBM trailers: 0
[10:46:13.525] <TB1> INFO: event ID mismatches: 0
[10:46:13.525] <TB1> INFO: ROC errors: 0
[10:46:13.525] <TB1> INFO: missing ROC header(s): 0
[10:46:13.525] <TB1> INFO: misplaced readback start: 0
[10:46:13.525] <TB1> INFO: Pixel decoding errors: 0
[10:46:13.525] <TB1> INFO: pixel data incomplete: 0
[10:46:13.525] <TB1> INFO: pixel address: 0
[10:46:13.525] <TB1> INFO: pulse height fill bit: 0
[10:46:13.525] <TB1> INFO: buffer corruption: 0
[10:46:13.535] <TB1> INFO: readReadbackCal: /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C15.dat
[10:46:13.537] <TB1> INFO: ######################################################################
[10:46:13.537] <TB1> INFO: PixTestReadback::doTest()
[10:46:13.537] <TB1> INFO: ######################################################################
[10:46:13.537] <TB1> INFO: ----------------------------------------------------------------------
[10:46:13.537] <TB1> INFO: PixTestReadback::CalibrateVd()
[10:46:13.537] <TB1> INFO: ----------------------------------------------------------------------
[10:46:22.982] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C0.dat
[10:46:22.982] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C1.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C2.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C3.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C4.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C5.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C6.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C7.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C8.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C9.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C10.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C11.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C12.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C13.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C14.dat
[10:46:22.983] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C15.dat
[10:46:23.015] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[10:46:23.015] <TB1> INFO: ----------------------------------------------------------------------
[10:46:23.015] <TB1> INFO: PixTestReadback::CalibrateVa()
[10:46:23.015] <TB1> INFO: ----------------------------------------------------------------------
[10:46:32.521] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C0.dat
[10:46:32.521] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C1.dat
[10:46:32.521] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C2.dat
[10:46:32.521] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C3.dat
[10:46:32.521] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C4.dat
[10:46:32.521] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C5.dat
[10:46:32.521] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C6.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C7.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C8.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C9.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C10.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C11.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C12.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C13.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C14.dat
[10:46:32.522] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C15.dat
[10:46:32.551] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[10:46:32.551] <TB1> INFO: ----------------------------------------------------------------------
[10:46:32.551] <TB1> INFO: PixTestReadback::readbackVbg()
[10:46:32.551] <TB1> INFO: ----------------------------------------------------------------------
[10:46:39.867] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[10:46:39.867] <TB1> INFO: ----------------------------------------------------------------------
[10:46:39.867] <TB1> INFO: PixTestReadback::getCalibratedVbg()
[10:46:39.867] <TB1> INFO: ----------------------------------------------------------------------
[10:46:39.867] <TB1> INFO: Vbg will be calibrated using Vd calibration
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 150.8calibrated Vbg = 1.16706 :::*/*/*/*/
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 151calibrated Vbg = 1.16865 :::*/*/*/*/
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 150.2calibrated Vbg = 1.17378 :::*/*/*/*/
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 141.4calibrated Vbg = 1.17991 :::*/*/*/*/
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 155.2calibrated Vbg = 1.1853 :::*/*/*/*/
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 157.1calibrated Vbg = 1.18837 :::*/*/*/*/
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 158calibrated Vbg = 1.18643 :::*/*/*/*/
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 147.5calibrated Vbg = 1.18276 :::*/*/*/*/
[10:46:39.867] <TB1> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 150calibrated Vbg = 1.18404 :::*/*/*/*/
[10:46:39.868] <TB1> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 155.9calibrated Vbg = 1.17875 :::*/*/*/*/
[10:46:39.868] <TB1> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 158.1calibrated Vbg = 1.17841 :::*/*/*/*/
[10:46:39.868] <TB1> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 148.6calibrated Vbg = 1.17412 :::*/*/*/*/
[10:46:39.868] <TB1> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 150.4calibrated Vbg = 1.16975 :::*/*/*/*/
[10:46:39.868] <TB1> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 141.4calibrated Vbg = 1.16922 :::*/*/*/*/
[10:46:39.868] <TB1> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 151.3calibrated Vbg = 1.18003 :::*/*/*/*/
[10:46:39.868] <TB1> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 157calibrated Vbg = 1.18146 :::*/*/*/*/
[10:46:39.870] <TB1> INFO: ----------------------------------------------------------------------
[10:46:39.870] <TB1> INFO: PixTestReadback::CalibrateIa()
[10:46:39.870] <TB1> INFO: ----------------------------------------------------------------------
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C0.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C1.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C2.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C3.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C4.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C5.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C6.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C7.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C8.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C9.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C10.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C11.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C12.dat
[10:49:15.302] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C13.dat
[10:49:15.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C14.dat
[10:49:15.303] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2174_FullQualification_2016-02-26_10h11m_1456477907//000_FulltestPxar_m20//readbackCal_C15.dat
[10:49:15.331] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[10:49:15.332] <TB1> INFO: PixTestReadback::doTest() done
[10:49:15.332] <TB1> INFO: Decoding statistics:
[10:49:15.332] <TB1> INFO: General information:
[10:49:15.332] <TB1> INFO: 16bit words read: 1024
[10:49:15.332] <TB1> INFO: valid events total: 128
[10:49:15.332] <TB1> INFO: empty events: 128
[10:49:15.332] <TB1> INFO: valid events with pixels: 0
[10:49:15.332] <TB1> INFO: valid pixel hits: 0
[10:49:15.332] <TB1> INFO: Event errors: 0
[10:49:15.332] <TB1> INFO: start marker: 0
[10:49:15.332] <TB1> INFO: stop marker: 0
[10:49:15.332] <TB1> INFO: overflow: 0
[10:49:15.332] <TB1> INFO: invalid 5bit words: 0
[10:49:15.332] <TB1> INFO: invalid XOR eye diagram: 0
[10:49:15.332] <TB1> INFO: frame (failed synchr.): 0
[10:49:15.332] <TB1> INFO: idle data (no TBM trl): 0
[10:49:15.332] <TB1> INFO: no data (only TBM hdr): 0
[10:49:15.332] <TB1> INFO: TBM errors: 0
[10:49:15.332] <TB1> INFO: flawed TBM headers: 0
[10:49:15.332] <TB1> INFO: flawed TBM trailers: 0
[10:49:15.332] <TB1> INFO: event ID mismatches: 0
[10:49:15.332] <TB1> INFO: ROC errors: 0
[10:49:15.332] <TB1> INFO: missing ROC header(s): 0
[10:49:15.332] <TB1> INFO: misplaced readback start: 0
[10:49:15.332] <TB1> INFO: Pixel decoding errors: 0
[10:49:15.332] <TB1> INFO: pixel data incomplete: 0
[10:49:15.332] <TB1> INFO: pixel address: 0
[10:49:15.332] <TB1> INFO: pulse height fill bit: 0
[10:49:15.332] <TB1> INFO: buffer corruption: 0
[10:49:15.351] <TB1> INFO: Decoding statistics:
[10:49:15.351] <TB1> INFO: General information:
[10:49:15.351] <TB1> INFO: 16bit words read: 2755336
[10:49:15.351] <TB1> INFO: valid events total: 176768
[10:49:15.351] <TB1> INFO: empty events: 7870
[10:49:15.351] <TB1> INFO: valid events with pixels: 168898
[10:49:15.351] <TB1> INFO: valid pixel hits: 668058
[10:49:15.351] <TB1> INFO: Event errors: 0
[10:49:15.351] <TB1> INFO: start marker: 0
[10:49:15.351] <TB1> INFO: stop marker: 0
[10:49:15.351] <TB1> INFO: overflow: 0
[10:49:15.351] <TB1> INFO: invalid 5bit words: 0
[10:49:15.351] <TB1> INFO: invalid XOR eye diagram: 0
[10:49:15.351] <TB1> INFO: frame (failed synchr.): 0
[10:49:15.351] <TB1> INFO: idle data (no TBM trl): 0
[10:49:15.351] <TB1> INFO: no data (only TBM hdr): 0
[10:49:15.351] <TB1> INFO: TBM errors: 0
[10:49:15.351] <TB1> INFO: flawed TBM headers: 0
[10:49:15.351] <TB1> INFO: flawed TBM trailers: 0
[10:49:15.351] <TB1> INFO: event ID mismatches: 0
[10:49:15.351] <TB1> INFO: ROC errors: 0
[10:49:15.351] <TB1> INFO: missing ROC header(s): 0
[10:49:15.351] <TB1> INFO: misplaced readback start: 0
[10:49:15.351] <TB1> INFO: Pixel decoding errors: 0
[10:49:15.351] <TB1> INFO: pixel data incomplete: 0
[10:49:15.351] <TB1> INFO: pixel address: 0
[10:49:15.351] <TB1> INFO: pulse height fill bit: 0
[10:49:15.351] <TB1> INFO: buffer corruption: 0
[10:49:15.351] <TB1> INFO: enter test to run
[10:49:15.351] <TB1> INFO: test: exit no parameter change
[10:49:15.478] <TB1> QUIET: Connection to board 153 closed.
[10:49:15.557] <TB1> INFO: pXar: this is the end, my friend