[15:19:32.475] <TB2> INFO: *** Welcome to pxar ***
[15:19:32.475] <TB2> INFO: *** Today: 2016/03/22
[15:19:32.573] <TB2> INFO: *** Version: 9751-dirty
[15:19:32.573] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C15.dat
[15:19:32.575] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//tbmParameters_C0b.dat
[15:19:32.575] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//defaultMaskFile.dat
[15:19:32.575] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters_C15.dat
[15:19:32.651] <TB2> INFO: clk: 4
[15:19:32.651] <TB2> INFO: ctr: 4
[15:19:32.651] <TB2> INFO: sda: 19
[15:19:32.651] <TB2> INFO: tin: 9
[15:19:32.651] <TB2> INFO: level: 15
[15:19:32.651] <TB2> INFO: triggerdelay: 0
[15:19:32.651] <TB2> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[15:19:32.651] <TB2> INFO: Log level: INFO
[15:19:32.658] <TB2> INFO: Found DTB DTB_WXC55Z
[15:19:32.669] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[15:19:32.671] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[15:19:32.673] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[15:19:34.223] <TB2> INFO: DUT info:
[15:19:34.223] <TB2> INFO: The DUT currently contains the following objects:
[15:19:34.223] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[15:19:34.223] <TB2> INFO: TBM Core alpha (0): 7 registers set
[15:19:34.223] <TB2> INFO: TBM Core beta (1): 7 registers set
[15:19:34.223] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:19:34.223] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.223] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.224] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.224] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:19:34.625] <TB2> INFO: enter 'restricted' command line mode
[15:19:34.625] <TB2> INFO: enter test to run
[15:19:34.625] <TB2> INFO: test: pretest no parameter change
[15:19:34.625] <TB2> INFO: running: pretest
[15:19:34.628] <TB2> INFO: ----------------------------------------------------------------------
[15:19:34.628] <TB2> INFO: PixTestPretest::programROC()
[15:19:34.628] <TB2> INFO: ----------------------------------------------------------------------
[15:19:52.642] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[15:19:52.642] <TB2> INFO: IA differences per ROC: 19.3 18.5 19.3 16.9 17.7 19.3 18.5 19.3 20.9 19.3 17.7 17.7 19.3 20.1 21.7 18.5
[15:19:52.743] <TB2> INFO: enter test to run
[15:19:52.744] <TB2> INFO: test: pretest no parameter change
[15:19:52.744] <TB2> INFO: running: pretest
[15:19:52.745] <TB2> INFO: ----------------------------------------------------------------------
[15:19:52.745] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[15:19:52.745] <TB2> INFO: ----------------------------------------------------------------------
[15:20:14.024] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 381 mA = 23.8125 mA/ROC
[15:20:14.024] <TB2> INFO: i(loss) [mA/ROC]: 18.4 19.2 19.2 19.2 18.4 18.4 19.2 19.2 18.4 18.4 18.4 18.4 17.6 18.4 17.6 18.4
[15:20:14.058] <TB2> INFO: enter test to run
[15:20:14.058] <TB2> INFO: test: pretest no parameter change
[15:20:14.058] <TB2> INFO: running: pretest
[15:20:14.059] <TB2> INFO: ----------------------------------------------------------------------
[15:20:14.059] <TB2> INFO: PixTestPretest::findTiming()
[15:20:14.059] <TB2> INFO: ----------------------------------------------------------------------
[15:20:14.059] <TB2> INFO: PixTestCmd::init()

[15:21:44.134] <TB2> INFO: TBM phases: 160MHz: 7, 400MHz: 2, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[15:21:44.134] <TB2> INFO: (success/tries = 100/100), width = 4
[15:21:44.135] <TB2> INFO: enter test to run
[15:21:44.135] <TB2> INFO: test: pretest no parameter change
[15:21:44.135] <TB2> INFO: running: pretest
[15:21:44.137] <TB2> INFO: ----------------------------------------------------------------------
[15:21:44.137] <TB2> INFO: PixTestPretest::findWorkingPixel()
[15:21:44.137] <TB2> INFO: ----------------------------------------------------------------------
[15:21:44.230] <TB2> INFO: Expecting 231680 events.


[15:21:54.415] <TB2> INFO: 231680 events read in total (9629ms).
[15:21:54.419] <TB2> INFO: Test took 10277ms.
[15:21:54.638] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[15:21:54.696] <TB2> INFO: enter test to run
[15:21:54.696] <TB2> INFO: test: pretest no parameter change
[15:21:54.696] <TB2> INFO: running: pretest
[15:21:54.697] <TB2> INFO: ----------------------------------------------------------------------
[15:21:54.697] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[15:21:54.697] <TB2> INFO: ----------------------------------------------------------------------
[15:21:54.789] <TB2> INFO: Expecting 231680 events.
[15:22:04.985] <TB2> INFO: 231680 events read in total (9640ms).
[15:22:04.989] <TB2> INFO: Test took 10288ms.
[15:22:05.220] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[15:22:05.220] <TB2> INFO: CalDel: 142 143 156 144 143 143 135 154 141 137 147 167 125 154 146 135
[15:22:05.220] <TB2> INFO: VthrComp: 51 51 51 51 51 51 51 57 51 51 51 51 51 51 51 51
[15:22:05.255] <TB2> INFO: enter test to run
[15:22:05.255] <TB2> INFO: test: pretest no parameter change
[15:22:05.255] <TB2> INFO: running: pretest
[15:22:05.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C0.dat
[15:22:05.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C1.dat
[15:22:05.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C2.dat
[15:22:05.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C3.dat
[15:22:05.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C4.dat
[15:22:05.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C5.dat
[15:22:05.256] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C6.dat
[15:22:05.257] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C7.dat
[15:22:05.257] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C8.dat
[15:22:05.257] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C9.dat
[15:22:05.257] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C10.dat
[15:22:05.257] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C11.dat
[15:22:05.257] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C12.dat
[15:22:05.257] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C13.dat
[15:22:05.257] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C14.dat
[15:22:05.258] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters_C15.dat
[15:22:05.258] <TB2> INFO: enter test to run
[15:22:05.258] <TB2> INFO: test: fulltest no parameter change
[15:22:05.258] <TB2> INFO: running: fulltest
[15:22:05.258] <TB2> INFO: ######################################################################
[15:22:05.258] <TB2> INFO: PixTestFullTest::doTest()
[15:22:05.258] <TB2> INFO: ######################################################################
[15:22:05.259] <TB2> INFO: ######################################################################
[15:22:05.260] <TB2> INFO: PixTestAlive::doTest()
[15:22:05.260] <TB2> INFO: ######################################################################
[15:22:05.261] <TB2> INFO: ----------------------------------------------------------------------
[15:22:05.261] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:22:05.261] <TB2> INFO: ----------------------------------------------------------------------
[15:22:05.558] <TB2> INFO: Expecting 41600 events.
[15:22:09.354] <TB2> INFO: 41600 events read in total (3239ms).
[15:22:09.354] <TB2> INFO: Test took 4092ms.
[15:22:09.592] <TB2> INFO: PixTestAlive::aliveTest() done
[15:22:09.592] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0
[15:22:09.593] <TB2> INFO: ----------------------------------------------------------------------
[15:22:09.594] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:22:09.594] <TB2> INFO: ----------------------------------------------------------------------
[15:22:09.868] <TB2> INFO: Expecting 41600 events.
[15:22:12.864] <TB2> INFO: 41600 events read in total (2440ms).
[15:22:12.864] <TB2> INFO: Test took 3269ms.
[15:22:12.864] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:22:13.106] <TB2> INFO: PixTestAlive::maskTest() done
[15:22:13.106] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:22:13.107] <TB2> INFO: ----------------------------------------------------------------------
[15:22:13.107] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[15:22:13.107] <TB2> INFO: ----------------------------------------------------------------------
[15:22:13.387] <TB2> INFO: Expecting 41600 events.
[15:22:17.163] <TB2> INFO: 41600 events read in total (3219ms).
[15:22:17.164] <TB2> INFO: Test took 4056ms.
[15:22:17.394] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[15:22:17.394] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[15:22:17.394] <TB2> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[15:22:17.394] <TB2> INFO: Decoding statistics:
[15:22:17.394] <TB2> INFO: General information:
[15:22:17.394] <TB2> INFO: 16bit words read: 0
[15:22:17.394] <TB2> INFO: valid events total: 0
[15:22:17.394] <TB2> INFO: empty events: 0
[15:22:17.394] <TB2> INFO: valid events with pixels: 0
[15:22:17.394] <TB2> INFO: valid pixel hits: 0
[15:22:17.394] <TB2> INFO: Event errors: 0
[15:22:17.394] <TB2> INFO: start marker: 0
[15:22:17.394] <TB2> INFO: stop marker: 0
[15:22:17.394] <TB2> INFO: overflow: 0
[15:22:17.394] <TB2> INFO: invalid 5bit words: 0
[15:22:17.394] <TB2> INFO: invalid XOR eye diagram: 0
[15:22:17.394] <TB2> INFO: frame (failed synchr.): 0
[15:22:17.394] <TB2> INFO: idle data (no TBM trl): 0
[15:22:17.394] <TB2> INFO: no data (only TBM hdr): 0
[15:22:17.394] <TB2> INFO: TBM errors: 0
[15:22:17.394] <TB2> INFO: flawed TBM headers: 0
[15:22:17.394] <TB2> INFO: flawed TBM trailers: 0
[15:22:17.394] <TB2> INFO: event ID mismatches: 0
[15:22:17.394] <TB2> INFO: ROC errors: 0
[15:22:17.394] <TB2> INFO: missing ROC header(s): 0
[15:22:17.394] <TB2> INFO: misplaced readback start: 0
[15:22:17.394] <TB2> INFO: Pixel decoding errors: 0
[15:22:17.394] <TB2> INFO: pixel data incomplete: 0
[15:22:17.394] <TB2> INFO: pixel address: 0
[15:22:17.394] <TB2> INFO: pulse height fill bit: 0
[15:22:17.394] <TB2> INFO: buffer corruption: 0
[15:22:17.401] <TB2> INFO: ######################################################################
[15:22:17.401] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[15:22:17.401] <TB2> INFO: ######################################################################
[15:22:17.403] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[15:22:17.414] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[15:22:17.414] <TB2> INFO: run 1 of 1
[15:22:17.673] <TB2> INFO: Expecting 3120000 events.
[15:22:59.348] <TB2> INFO: 878930 events read in total (41118ms).
[15:23:40.616] <TB2> INFO: 1745020 events read in total (82386ms).
[15:24:21.542] <TB2> INFO: 2616835 events read in total (123313ms).
[15:24:45.578] <TB2> INFO: 3120000 events read in total (147348ms).
[15:24:45.649] <TB2> INFO: Test took 148235ms.
[15:25:11.117] <TB2> INFO: PixTestBBMap::doTest() done, duration: 173 seconds
[15:25:11.117] <TB2> INFO: number of dead bumps (per ROC): 7 1 0 95 1 1 2 4 2 8 1 2 1 0 0 3
[15:25:11.117] <TB2> INFO: separation cut (per ROC): 70 91 108 78 82 91 102 120 103 89 94 92 106 67 97 90
[15:25:11.117] <TB2> INFO: Decoding statistics:
[15:25:11.117] <TB2> INFO: General information:
[15:25:11.117] <TB2> INFO: 16bit words read: 0
[15:25:11.117] <TB2> INFO: valid events total: 0
[15:25:11.117] <TB2> INFO: empty events: 0
[15:25:11.117] <TB2> INFO: valid events with pixels: 0
[15:25:11.117] <TB2> INFO: valid pixel hits: 0
[15:25:11.118] <TB2> INFO: Event errors: 0
[15:25:11.118] <TB2> INFO: start marker: 0
[15:25:11.118] <TB2> INFO: stop marker: 0
[15:25:11.118] <TB2> INFO: overflow: 0
[15:25:11.118] <TB2> INFO: invalid 5bit words: 0
[15:25:11.118] <TB2> INFO: invalid XOR eye diagram: 0
[15:25:11.118] <TB2> INFO: frame (failed synchr.): 0
[15:25:11.118] <TB2> INFO: idle data (no TBM trl): 0
[15:25:11.118] <TB2> INFO: no data (only TBM hdr): 0
[15:25:11.118] <TB2> INFO: TBM errors: 0
[15:25:11.118] <TB2> INFO: flawed TBM headers: 0
[15:25:11.118] <TB2> INFO: flawed TBM trailers: 0
[15:25:11.118] <TB2> INFO: event ID mismatches: 0
[15:25:11.118] <TB2> INFO: ROC errors: 0
[15:25:11.118] <TB2> INFO: missing ROC header(s): 0
[15:25:11.118] <TB2> INFO: misplaced readback start: 0
[15:25:11.118] <TB2> INFO: Pixel decoding errors: 0
[15:25:11.118] <TB2> INFO: pixel data incomplete: 0
[15:25:11.118] <TB2> INFO: pixel address: 0
[15:25:11.118] <TB2> INFO: pulse height fill bit: 0
[15:25:11.118] <TB2> INFO: buffer corruption: 0
[15:25:11.199] <TB2> INFO: ######################################################################
[15:25:11.199] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[15:25:11.199] <TB2> INFO: ######################################################################
[15:25:11.199] <TB2> INFO: ----------------------------------------------------------------------
[15:25:11.199] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[15:25:11.199] <TB2> INFO: ----------------------------------------------------------------------
[15:25:11.199] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[15:25:11.208] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[15:25:11.208] <TB2> INFO: run 1 of 1
[15:25:11.507] <TB2> INFO: Expecting 26208000 events.
[15:25:45.510] <TB2> INFO: 920250 events read in total (33447ms).
[15:26:18.836] <TB2> INFO: 1825250 events read in total (66773ms).
[15:26:52.128] <TB2> INFO: 2728200 events read in total (100065ms).
[15:27:25.848] <TB2> INFO: 3630900 events read in total (133785ms).
[15:27:59.500] <TB2> INFO: 4528800 events read in total (167437ms).
[15:28:32.765] <TB2> INFO: 5424300 events read in total (200702ms).
[15:29:06.204] <TB2> INFO: 6322650 events read in total (234141ms).
[15:29:40.231] <TB2> INFO: 7218500 events read in total (268168ms).
[15:30:13.826] <TB2> INFO: 8112700 events read in total (301763ms).
[15:30:47.668] <TB2> INFO: 9006550 events read in total (335605ms).
[15:31:20.950] <TB2> INFO: 9898950 events read in total (368887ms).
[15:31:54.179] <TB2> INFO: 10790750 events read in total (402117ms).
[15:32:27.575] <TB2> INFO: 11682350 events read in total (435512ms).
[15:33:00.910] <TB2> INFO: 12571600 events read in total (468847ms).
[15:33:34.598] <TB2> INFO: 13455250 events read in total (502535ms).
[15:34:08.093] <TB2> INFO: 14336850 events read in total (536030ms).
[15:34:40.963] <TB2> INFO: 15214250 events read in total (568900ms).
[15:35:14.105] <TB2> INFO: 16089050 events read in total (602042ms).
[15:35:47.421] <TB2> INFO: 16964350 events read in total (635358ms).
[15:36:20.403] <TB2> INFO: 17840800 events read in total (668340ms).
[15:36:53.443] <TB2> INFO: 18716550 events read in total (701380ms).
[15:37:26.445] <TB2> INFO: 19587750 events read in total (734382ms).
[15:37:59.819] <TB2> INFO: 20460550 events read in total (767756ms).
[15:38:32.760] <TB2> INFO: 21334700 events read in total (800697ms).
[15:39:05.396] <TB2> INFO: 22206750 events read in total (833333ms).
[15:39:38.293] <TB2> INFO: 23079300 events read in total (866230ms).
[15:40:11.332] <TB2> INFO: 23953700 events read in total (899269ms).
[15:40:44.368] <TB2> INFO: 24829300 events read in total (932305ms).
[15:41:17.116] <TB2> INFO: 25702050 events read in total (965053ms).
[15:41:35.797] <TB2> INFO: 26208000 events read in total (983734ms).
[15:41:35.828] <TB2> INFO: Test took 984620ms.
[15:41:36.084] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:37.831] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:39.452] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:40.889] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:42.573] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:44.177] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:45.553] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:47.070] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:48.623] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:50.149] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:51.680] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:53.107] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:54.735] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:56.405] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:57.970] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:41:59.784] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[15:42:01.617] <TB2> INFO: PixTestScurves::scurves() done
[15:42:01.617] <TB2> INFO: Vcal mean: 77.47 84.19 103.44 86.30 81.87 89.95 100.14 106.50 101.65 89.40 100.68 93.81 102.17 70.93 98.51 92.70
[15:42:01.617] <TB2> INFO: Vcal RMS: 4.46 5.59 5.84 5.39 4.30 5.48 5.91 8.17 5.62 5.02 6.17 5.88 6.41 4.97 6.16 6.05
[15:42:01.618] <TB2> INFO: PixTestScurves::fullTest() done, duration: 1010 seconds
[15:42:01.618] <TB2> INFO: Decoding statistics:
[15:42:01.618] <TB2> INFO: General information:
[15:42:01.618] <TB2> INFO: 16bit words read: 0
[15:42:01.618] <TB2> INFO: valid events total: 0
[15:42:01.618] <TB2> INFO: empty events: 0
[15:42:01.618] <TB2> INFO: valid events with pixels: 0
[15:42:01.618] <TB2> INFO: valid pixel hits: 0
[15:42:01.618] <TB2> INFO: Event errors: 0
[15:42:01.618] <TB2> INFO: start marker: 0
[15:42:01.618] <TB2> INFO: stop marker: 0
[15:42:01.618] <TB2> INFO: overflow: 0
[15:42:01.618] <TB2> INFO: invalid 5bit words: 0
[15:42:01.618] <TB2> INFO: invalid XOR eye diagram: 0
[15:42:01.618] <TB2> INFO: frame (failed synchr.): 0
[15:42:01.618] <TB2> INFO: idle data (no TBM trl): 0
[15:42:01.618] <TB2> INFO: no data (only TBM hdr): 0
[15:42:01.618] <TB2> INFO: TBM errors: 0
[15:42:01.618] <TB2> INFO: flawed TBM headers: 0
[15:42:01.618] <TB2> INFO: flawed TBM trailers: 0
[15:42:01.618] <TB2> INFO: event ID mismatches: 0
[15:42:01.618] <TB2> INFO: ROC errors: 0
[15:42:01.618] <TB2> INFO: missing ROC header(s): 0
[15:42:01.618] <TB2> INFO: misplaced readback start: 0
[15:42:01.618] <TB2> INFO: Pixel decoding errors: 0
[15:42:01.618] <TB2> INFO: pixel data incomplete: 0
[15:42:01.618] <TB2> INFO: pixel address: 0
[15:42:01.618] <TB2> INFO: pulse height fill bit: 0
[15:42:01.618] <TB2> INFO: buffer corruption: 0
[15:42:01.688] <TB2> INFO: ######################################################################
[15:42:01.688] <TB2> INFO: PixTestTrim::doTest()
[15:42:01.688] <TB2> INFO: ######################################################################
[15:42:01.689] <TB2> INFO: ----------------------------------------------------------------------
[15:42:01.689] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[15:42:01.689] <TB2> INFO: ----------------------------------------------------------------------
[15:42:01.768] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[15:42:01.768] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[15:42:01.777] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[15:42:01.777] <TB2> INFO: run 1 of 1
[15:42:02.040] <TB2> INFO: Expecting 6281600 events.
[15:42:42.025] <TB2> INFO: 1086680 events read in total (39425ms).
[15:43:21.100] <TB2> INFO: 2168140 events read in total (78500ms).
[15:44:00.479] <TB2> INFO: 3242410 events read in total (117880ms).
[15:44:40.371] <TB2> INFO: 4318290 events read in total (157771ms).
[15:45:20.155] <TB2> INFO: 5394370 events read in total (197555ms).
[15:45:52.706] <TB2> INFO: 6281600 events read in total (230106ms).
[15:45:52.741] <TB2> INFO: Test took 230964ms.
[15:46:13.341] <TB2> INFO: ROC 0 VthrComp = 79
[15:46:13.342] <TB2> INFO: ROC 1 VthrComp = 88
[15:46:13.342] <TB2> INFO: ROC 2 VthrComp = 103
[15:46:13.342] <TB2> INFO: ROC 3 VthrComp = 89
[15:46:13.342] <TB2> INFO: ROC 4 VthrComp = 86
[15:46:13.342] <TB2> INFO: ROC 5 VthrComp = 92
[15:46:13.342] <TB2> INFO: ROC 6 VthrComp = 98
[15:46:13.342] <TB2> INFO: ROC 7 VthrComp = 103
[15:46:13.342] <TB2> INFO: ROC 8 VthrComp = 102
[15:46:13.344] <TB2> INFO: ROC 9 VthrComp = 91
[15:46:13.344] <TB2> INFO: ROC 10 VthrComp = 95
[15:46:13.344] <TB2> INFO: ROC 11 VthrComp = 91
[15:46:13.344] <TB2> INFO: ROC 12 VthrComp = 102
[15:46:13.344] <TB2> INFO: ROC 13 VthrComp = 74
[15:46:13.344] <TB2> INFO: ROC 14 VthrComp = 95
[15:46:13.344] <TB2> INFO: ROC 15 VthrComp = 89
[15:46:13.344] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[15:46:13.344] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[15:46:13.355] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[15:46:13.355] <TB2> INFO: run 1 of 1
[15:46:13.639] <TB2> INFO: Expecting 6281600 events.
[15:46:50.644] <TB2> INFO: 759060 events read in total (36449ms).
[15:47:26.010] <TB2> INFO: 1515570 events read in total (71815ms).
[15:48:01.363] <TB2> INFO: 2273000 events read in total (107168ms).
[15:48:36.754] <TB2> INFO: 3031090 events read in total (142559ms).
[15:49:11.691] <TB2> INFO: 3782930 events read in total (177496ms).
[15:49:46.968] <TB2> INFO: 4531590 events read in total (212773ms).
[15:50:21.607] <TB2> INFO: 5278510 events read in total (247412ms).
[15:50:56.630] <TB2> INFO: 6025760 events read in total (282435ms).
[15:51:08.770] <TB2> INFO: 6281600 events read in total (294575ms).
[15:51:08.810] <TB2> INFO: Test took 295455ms.
[15:51:33.817] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 59.953 for pixel 20/16 mean/min/max = 47.3445/34.5506/60.1385
[15:51:33.817] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 61.0989 for pixel 17/12 mean/min/max = 46.4178/31.6159/61.2198
[15:51:33.818] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 61.4767 for pixel 6/45 mean/min/max = 46.9727/32.364/61.5814
[15:51:33.818] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 58.9671 for pixel 10/18 mean/min/max = 45.6407/32.2972/58.9841
[15:51:33.818] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 56.49 for pixel 22/1 mean/min/max = 44.496/32.403/56.5889
[15:51:33.818] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 58.589 for pixel 0/79 mean/min/max = 45.39/31.9865/58.7935
[15:51:33.819] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 60.7098 for pixel 28/6 mean/min/max = 46.2779/31.7629/60.7928
[15:51:33.819] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 73.2148 for pixel 16/1 mean/min/max = 52.4647/31.5812/73.3482
[15:51:33.819] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 58.4287 for pixel 46/73 mean/min/max = 45.1382/31.8239/58.4526
[15:51:33.820] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 57.7922 for pixel 51/5 mean/min/max = 45.5815/33.2067/57.9563
[15:51:33.820] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 63.4116 for pixel 0/44 mean/min/max = 47.5132/31.5998/63.4266
[15:51:33.820] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 61.7321 for pixel 0/26 mean/min/max = 46.9685/32.1478/61.7892
[15:51:33.821] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 63.5316 for pixel 5/2 mean/min/max = 47.6324/31.5887/63.6761
[15:51:33.821] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 58.5458 for pixel 15/19 mean/min/max = 46.4225/34.2233/58.6217
[15:51:33.821] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 61.7233 for pixel 0/64 mean/min/max = 46.3775/31.0271/61.7279
[15:51:33.821] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 62.1741 for pixel 22/0 mean/min/max = 46.7453/31.3129/62.1776
[15:51:33.822] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[15:51:33.910] <TB2> INFO: Expecting 514560 events.
[15:51:46.700] <TB2> INFO: 514560 events read in total (12234ms).
[15:51:46.705] <TB2> INFO: Expecting 514560 events.
[15:51:59.566] <TB2> INFO: 514560 events read in total (12441ms).
[15:51:59.574] <TB2> INFO: Expecting 514560 events.
[15:52:12.470] <TB2> INFO: 514560 events read in total (12495ms).
[15:52:12.480] <TB2> INFO: Expecting 514560 events.
[15:52:25.345] <TB2> INFO: 514560 events read in total (12456ms).
[15:52:25.355] <TB2> INFO: Expecting 514560 events.
[15:52:38.300] <TB2> INFO: 514560 events read in total (12526ms).
[15:52:38.312] <TB2> INFO: Expecting 514560 events.
[15:52:51.078] <TB2> INFO: 514560 events read in total (12353ms).
[15:52:51.096] <TB2> INFO: Expecting 514560 events.
[15:53:04.088] <TB2> INFO: 514560 events read in total (12582ms).
[15:53:04.107] <TB2> INFO: Expecting 514560 events.
[15:53:16.999] <TB2> INFO: 514560 events read in total (12490ms).
[15:53:17.021] <TB2> INFO: Expecting 514560 events.
[15:53:30.089] <TB2> INFO: 514560 events read in total (12666ms).
[15:53:30.110] <TB2> INFO: Expecting 514560 events.
[15:53:42.861] <TB2> INFO: 514560 events read in total (12349ms).
[15:53:42.883] <TB2> INFO: Expecting 514560 events.
[15:53:55.695] <TB2> INFO: 514560 events read in total (12403ms).
[15:53:55.719] <TB2> INFO: Expecting 514560 events.
[15:54:08.675] <TB2> INFO: 514560 events read in total (12550ms).
[15:54:08.702] <TB2> INFO: Expecting 514560 events.
[15:54:21.761] <TB2> INFO: 514560 events read in total (12657ms).
[15:54:21.792] <TB2> INFO: Expecting 514560 events.
[15:54:34.614] <TB2> INFO: 514560 events read in total (12420ms).
[15:54:34.644] <TB2> INFO: Expecting 514560 events.
[15:54:47.394] <TB2> INFO: 514560 events read in total (12348ms).
[15:54:47.425] <TB2> INFO: Expecting 514560 events.
[15:55:00.428] <TB2> INFO: 514560 events read in total (12601ms).
[15:55:00.461] <TB2> INFO: Test took 206639ms.
[15:55:01.464] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[15:55:01.473] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[15:55:01.473] <TB2> INFO: run 1 of 1
[15:55:01.774] <TB2> INFO: Expecting 6281600 events.
[15:55:37.246] <TB2> INFO: 742790 events read in total (34916ms).
[15:56:11.892] <TB2> INFO: 1483720 events read in total (69562ms).
[15:56:46.688] <TB2> INFO: 2225330 events read in total (104358ms).
[15:57:21.570] <TB2> INFO: 2967500 events read in total (139240ms).
[15:57:56.460] <TB2> INFO: 3703210 events read in total (174130ms).
[15:58:31.329] <TB2> INFO: 4435380 events read in total (208999ms).
[15:59:06.114] <TB2> INFO: 5165380 events read in total (243784ms).
[15:59:40.691] <TB2> INFO: 5895080 events read in total (278361ms).
[15:59:59.310] <TB2> INFO: 6281600 events read in total (296980ms).
[15:59:59.355] <TB2> INFO: Test took 297882ms.
[16:00:23.544] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.078747 .. 255.000000
[16:00:23.642] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[16:00:23.651] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:00:23.651] <TB2> INFO: run 1 of 1
[16:00:23.936] <TB2> INFO: Expecting 10649600 events.
[16:00:58.678] <TB2> INFO: 711480 events read in total (34185ms).
[16:01:33.179] <TB2> INFO: 1424220 events read in total (68686ms).
[16:02:07.433] <TB2> INFO: 2136540 events read in total (102940ms).
[16:02:41.746] <TB2> INFO: 2848800 events read in total (137253ms).
[16:03:16.051] <TB2> INFO: 3561040 events read in total (171558ms).
[16:03:51.338] <TB2> INFO: 4273570 events read in total (206845ms).
[16:04:26.131] <TB2> INFO: 4986090 events read in total (241638ms).
[16:05:00.657] <TB2> INFO: 5698540 events read in total (276164ms).
[16:05:35.008] <TB2> INFO: 6410700 events read in total (310515ms).
[16:06:09.439] <TB2> INFO: 7122060 events read in total (344946ms).
[16:06:43.756] <TB2> INFO: 7833820 events read in total (379263ms).
[16:07:17.846] <TB2> INFO: 8544710 events read in total (413353ms).
[16:07:52.472] <TB2> INFO: 9255850 events read in total (447979ms).
[16:08:27.068] <TB2> INFO: 9966840 events read in total (482575ms).
[16:09:00.093] <TB2> INFO: 10649600 events read in total (515600ms).
[16:09:00.185] <TB2> INFO: Test took 516534ms.
[16:09:27.352] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 14.030348 .. 50.370839
[16:09:27.428] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 4 .. 60 (-1/-1) hits flags = 528 (plus default)
[16:09:27.436] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:09:27.436] <TB2> INFO: run 1 of 1
[16:09:27.698] <TB2> INFO: Expecting 2371200 events.
[16:10:06.319] <TB2> INFO: 909730 events read in total (38065ms).
[16:10:43.901] <TB2> INFO: 1817920 events read in total (75647ms).
[16:11:06.655] <TB2> INFO: 2371200 events read in total (98401ms).
[16:11:06.677] <TB2> INFO: Test took 99241ms.
[16:11:20.544] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 18.779215 .. 47.845507
[16:11:20.626] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 8 .. 57 (-1/-1) hits flags = 528 (plus default)
[16:11:20.635] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:11:20.635] <TB2> INFO: run 1 of 1
[16:11:20.898] <TB2> INFO: Expecting 2080000 events.
[16:11:59.306] <TB2> INFO: 909630 events read in total (37852ms).
[16:12:36.757] <TB2> INFO: 1817820 events read in total (75303ms).
[16:12:47.798] <TB2> INFO: 2080000 events read in total (86345ms).
[16:12:47.816] <TB2> INFO: Test took 87181ms.
[16:13:02.573] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 21.097192 .. 46.794815
[16:13:02.649] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 11 .. 56 (-1/-1) hits flags = 528 (plus default)
[16:13:02.657] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:13:02.657] <TB2> INFO: run 1 of 1
[16:13:02.932] <TB2> INFO: Expecting 1913600 events.
[16:13:41.392] <TB2> INFO: 897750 events read in total (37904ms).
[16:14:18.917] <TB2> INFO: 1795450 events read in total (75429ms).
[16:14:24.160] <TB2> INFO: 1913600 events read in total (80672ms).
[16:14:24.183] <TB2> INFO: Test took 81525ms.
[16:14:38.892] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[16:14:38.892] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[16:14:38.901] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:14:38.901] <TB2> INFO: run 1 of 1
[16:14:39.181] <TB2> INFO: Expecting 1705600 events.
[16:15:16.613] <TB2> INFO: 879030 events read in total (36876ms).
[16:15:52.384] <TB2> INFO: 1705600 events read in total (72648ms).
[16:15:52.408] <TB2> INFO: Test took 73508ms.
[16:16:07.429] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C0.dat
[16:16:07.430] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C1.dat
[16:16:07.430] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C2.dat
[16:16:07.430] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C3.dat
[16:16:07.430] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C4.dat
[16:16:07.430] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C5.dat
[16:16:07.430] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C6.dat
[16:16:07.430] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C7.dat
[16:16:07.430] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C8.dat
[16:16:07.431] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C9.dat
[16:16:07.431] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C10.dat
[16:16:07.431] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C11.dat
[16:16:07.431] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C12.dat
[16:16:07.431] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C13.dat
[16:16:07.431] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C14.dat
[16:16:07.431] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C15.dat
[16:16:07.432] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C0.dat
[16:16:07.438] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C1.dat
[16:16:07.445] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C2.dat
[16:16:07.451] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C3.dat
[16:16:07.458] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C4.dat
[16:16:07.466] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C5.dat
[16:16:07.473] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C6.dat
[16:16:07.480] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C7.dat
[16:16:07.487] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C8.dat
[16:16:07.494] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C9.dat
[16:16:07.501] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C10.dat
[16:16:07.508] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C11.dat
[16:16:07.515] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C12.dat
[16:16:07.522] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C13.dat
[16:16:07.529] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C14.dat
[16:16:07.536] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//trimParameters35_C15.dat
[16:16:07.542] <TB2> INFO: PixTestTrim::trimTest() done
[16:16:07.542] <TB2> INFO: vtrim: 99 135 117 88 87 85 108 138 106 84 105 95 117 99 85 103
[16:16:07.542] <TB2> INFO: vthrcomp: 79 88 103 89 86 92 98 103 102 91 95 91 102 74 95 89
[16:16:07.543] <TB2> INFO: vcal mean: 34.96 34.99 35.01 34.97 34.94 34.99 34.95 34.97 35.00 35.02 34.96 34.98 35.00 35.02 35.00 34.99
[16:16:07.543] <TB2> INFO: vcal RMS: 0.84 0.86 0.88 0.85 0.80 0.85 0.90 1.00 0.87 0.79 0.94 1.04 0.98 0.98 0.91 0.94
[16:16:07.543] <TB2> INFO: bits mean: 8.72 9.72 9.21 9.40 9.67 8.82 9.45 8.13 9.60 8.89 8.77 9.03 9.56 9.11 8.99 9.55
[16:16:07.543] <TB2> INFO: bits RMS: 2.57 2.59 2.63 2.67 2.63 3.00 2.70 2.83 2.74 2.77 2.93 2.77 2.55 2.51 2.99 2.64
[16:16:07.549] <TB2> INFO: ----------------------------------------------------------------------
[16:16:07.549] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[16:16:07.549] <TB2> INFO: ----------------------------------------------------------------------
[16:16:07.552] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[16:16:07.560] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[16:16:07.560] <TB2> INFO: run 1 of 1
[16:16:07.888] <TB2> INFO: Expecting 4160000 events.
[16:16:51.542] <TB2> INFO: 943985 events read in total (43098ms).
[16:17:33.748] <TB2> INFO: 1879230 events read in total (85304ms).
[16:18:15.812] <TB2> INFO: 2804665 events read in total (127368ms).
[16:18:57.796] <TB2> INFO: 3726660 events read in total (169352ms).
[16:19:17.694] <TB2> INFO: 4160000 events read in total (189250ms).
[16:19:17.738] <TB2> INFO: Test took 190178ms.
[16:19:46.106] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 202 (-1/-1) hits flags = 528 (plus default)
[16:19:46.115] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[16:19:46.115] <TB2> INFO: run 1 of 1
[16:19:46.402] <TB2> INFO: Expecting 4222400 events.
[16:20:28.987] <TB2> INFO: 907290 events read in total (42028ms).
[16:21:10.381] <TB2> INFO: 1807050 events read in total (83422ms).
[16:21:51.190] <TB2> INFO: 2698340 events read in total (124231ms).
[16:22:31.857] <TB2> INFO: 3585610 events read in total (164898ms).
[16:23:01.153] <TB2> INFO: 4222400 events read in total (194194ms).
[16:23:01.194] <TB2> INFO: Test took 195080ms.
[16:23:30.365] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 186 (-1/-1) hits flags = 528 (plus default)
[16:23:30.374] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[16:23:30.374] <TB2> INFO: run 1 of 1
[16:23:30.638] <TB2> INFO: Expecting 3889600 events.
[16:24:13.284] <TB2> INFO: 935820 events read in total (42090ms).
[16:24:55.737] <TB2> INFO: 1862635 events read in total (84543ms).
[16:25:38.103] <TB2> INFO: 2778355 events read in total (126910ms).
[16:26:20.086] <TB2> INFO: 3691930 events read in total (168892ms).
[16:26:29.335] <TB2> INFO: 3889600 events read in total (178141ms).
[16:26:29.372] <TB2> INFO: Test took 178998ms.
[16:27:00.956] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 186 (-1/-1) hits flags = 528 (plus default)
[16:27:00.968] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[16:27:00.968] <TB2> INFO: run 1 of 1
[16:27:01.256] <TB2> INFO: Expecting 3889600 events.
[16:27:44.662] <TB2> INFO: 935350 events read in total (42850ms).
[16:28:26.419] <TB2> INFO: 1861670 events read in total (84607ms).
[16:29:08.106] <TB2> INFO: 2777015 events read in total (126295ms).
[16:29:49.699] <TB2> INFO: 3690460 events read in total (167887ms).
[16:29:58.976] <TB2> INFO: 3889600 events read in total (177164ms).
[16:29:59.010] <TB2> INFO: Test took 178043ms.
[16:30:27.253] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 186 (-1/-1) hits flags = 528 (plus default)
[16:30:27.262] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[16:30:27.262] <TB2> INFO: run 1 of 1
[16:30:27.549] <TB2> INFO: Expecting 3889600 events.
[16:31:09.995] <TB2> INFO: 934950 events read in total (41890ms).
[16:31:51.743] <TB2> INFO: 1861170 events read in total (83639ms).
[16:32:33.824] <TB2> INFO: 2776140 events read in total (125720ms).
[16:33:15.177] <TB2> INFO: 3689345 events read in total (167072ms).
[16:33:24.525] <TB2> INFO: 3889600 events read in total (176420ms).
[16:33:24.563] <TB2> INFO: Test took 177301ms.
[16:33:52.756] <TB2> INFO: PixTestTrim::trimBitTest() done
[16:33:52.757] <TB2> INFO: PixTestTrim::doTest() done, duration: 3111 seconds
[16:33:52.757] <TB2> INFO: Decoding statistics:
[16:33:52.757] <TB2> INFO: General information:
[16:33:52.757] <TB2> INFO: 16bit words read: 0
[16:33:52.757] <TB2> INFO: valid events total: 0
[16:33:52.757] <TB2> INFO: empty events: 0
[16:33:52.757] <TB2> INFO: valid events with pixels: 0
[16:33:52.757] <TB2> INFO: valid pixel hits: 0
[16:33:52.757] <TB2> INFO: Event errors: 0
[16:33:52.757] <TB2> INFO: start marker: 0
[16:33:52.757] <TB2> INFO: stop marker: 0
[16:33:52.757] <TB2> INFO: overflow: 0
[16:33:52.757] <TB2> INFO: invalid 5bit words: 0
[16:33:52.757] <TB2> INFO: invalid XOR eye diagram: 0
[16:33:52.757] <TB2> INFO: frame (failed synchr.): 0
[16:33:52.757] <TB2> INFO: idle data (no TBM trl): 0
[16:33:52.757] <TB2> INFO: no data (only TBM hdr): 0
[16:33:52.757] <TB2> INFO: TBM errors: 0
[16:33:52.757] <TB2> INFO: flawed TBM headers: 0
[16:33:52.757] <TB2> INFO: flawed TBM trailers: 0
[16:33:52.757] <TB2> INFO: event ID mismatches: 0
[16:33:52.757] <TB2> INFO: ROC errors: 0
[16:33:52.757] <TB2> INFO: missing ROC header(s): 0
[16:33:52.757] <TB2> INFO: misplaced readback start: 0
[16:33:52.757] <TB2> INFO: Pixel decoding errors: 0
[16:33:52.757] <TB2> INFO: pixel data incomplete: 0
[16:33:52.757] <TB2> INFO: pixel address: 0
[16:33:52.757] <TB2> INFO: pulse height fill bit: 0
[16:33:52.757] <TB2> INFO: buffer corruption: 0
[16:33:53.465] <TB2> INFO: ######################################################################
[16:33:53.465] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[16:33:53.465] <TB2> INFO: ######################################################################
[16:33:53.738] <TB2> INFO: Expecting 41600 events.
[16:33:57.471] <TB2> INFO: 41600 events read in total (3177ms).
[16:33:57.472] <TB2> INFO: Test took 4004ms.
[16:33:57.947] <TB2> INFO: Expecting 41600 events.
[16:34:01.743] <TB2> INFO: 41600 events read in total (3240ms).
[16:34:01.744] <TB2> INFO: Test took 4069ms.
[16:34:02.035] <TB2> INFO: Expecting 41600 events.
[16:34:05.795] <TB2> INFO: 41600 events read in total (3204ms).
[16:34:05.795] <TB2> INFO: Test took 4029ms.
[16:34:06.050] <TB2> INFO: Expecting 2560 events.
[16:34:06.903] <TB2> INFO: 2560 events read in total (297ms).
[16:34:06.903] <TB2> INFO: Test took 1095ms.
[16:34:07.208] <TB2> INFO: Expecting 2560 events.
[16:34:08.060] <TB2> INFO: 2560 events read in total (296ms).
[16:34:08.060] <TB2> INFO: Test took 1157ms.
[16:34:08.365] <TB2> INFO: Expecting 2560 events.
[16:34:09.218] <TB2> INFO: 2560 events read in total (297ms).
[16:34:09.218] <TB2> INFO: Test took 1158ms.
[16:34:09.523] <TB2> INFO: Expecting 2560 events.
[16:34:10.376] <TB2> INFO: 2560 events read in total (297ms).
[16:34:10.376] <TB2> INFO: Test took 1158ms.
[16:34:10.681] <TB2> INFO: Expecting 2560 events.
[16:34:11.534] <TB2> INFO: 2560 events read in total (297ms).
[16:34:11.534] <TB2> INFO: Test took 1157ms.
[16:34:11.839] <TB2> INFO: Expecting 2560 events.
[16:34:12.692] <TB2> INFO: 2560 events read in total (297ms).
[16:34:12.692] <TB2> INFO: Test took 1158ms.
[16:34:12.997] <TB2> INFO: Expecting 2560 events.
[16:34:13.850] <TB2> INFO: 2560 events read in total (297ms).
[16:34:13.850] <TB2> INFO: Test took 1146ms.
[16:34:14.155] <TB2> INFO: Expecting 2560 events.
[16:34:15.008] <TB2> INFO: 2560 events read in total (297ms).
[16:34:15.008] <TB2> INFO: Test took 1158ms.
[16:34:15.313] <TB2> INFO: Expecting 2560 events.
[16:34:16.166] <TB2> INFO: 2560 events read in total (297ms).
[16:34:16.167] <TB2> INFO: Test took 1158ms.
[16:34:16.472] <TB2> INFO: Expecting 2560 events.
[16:34:17.328] <TB2> INFO: 2560 events read in total (300ms).
[16:34:17.329] <TB2> INFO: Test took 1162ms.
[16:34:17.633] <TB2> INFO: Expecting 2560 events.
[16:34:18.488] <TB2> INFO: 2560 events read in total (299ms).
[16:34:18.489] <TB2> INFO: Test took 1160ms.
[16:34:18.794] <TB2> INFO: Expecting 2560 events.
[16:34:19.649] <TB2> INFO: 2560 events read in total (299ms).
[16:34:19.649] <TB2> INFO: Test took 1160ms.
[16:34:19.954] <TB2> INFO: Expecting 2560 events.
[16:34:20.809] <TB2> INFO: 2560 events read in total (299ms).
[16:34:20.810] <TB2> INFO: Test took 1160ms.
[16:34:21.115] <TB2> INFO: Expecting 2560 events.
[16:34:21.969] <TB2> INFO: 2560 events read in total (298ms).
[16:34:21.969] <TB2> INFO: Test took 1159ms.
[16:34:22.274] <TB2> INFO: Expecting 2560 events.
[16:34:23.128] <TB2> INFO: 2560 events read in total (298ms).
[16:34:23.128] <TB2> INFO: Test took 1159ms.
[16:34:23.433] <TB2> INFO: Expecting 2560 events.
[16:34:24.287] <TB2> INFO: 2560 events read in total (297ms).
[16:34:24.288] <TB2> INFO: Test took 1159ms.
[16:34:24.292] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:34:24.593] <TB2> INFO: Expecting 655360 events.
[16:34:41.604] <TB2> INFO: 655360 events read in total (16454ms).
[16:34:41.613] <TB2> INFO: Expecting 655360 events.
[16:34:58.404] <TB2> INFO: 655360 events read in total (16390ms).
[16:34:58.416] <TB2> INFO: Expecting 655360 events.
[16:35:15.321] <TB2> INFO: 655360 events read in total (16503ms).
[16:35:15.340] <TB2> INFO: Expecting 655360 events.
[16:35:32.177] <TB2> INFO: 655360 events read in total (16435ms).
[16:35:32.196] <TB2> INFO: Expecting 655360 events.
[16:35:49.037] <TB2> INFO: 655360 events read in total (16439ms).
[16:35:49.062] <TB2> INFO: Expecting 655360 events.
[16:36:05.913] <TB2> INFO: 655360 events read in total (16449ms).
[16:36:05.940] <TB2> INFO: Expecting 655360 events.
[16:36:22.845] <TB2> INFO: 655360 events read in total (16504ms).
[16:36:22.877] <TB2> INFO: Expecting 655360 events.
[16:36:39.765] <TB2> INFO: 655360 events read in total (16486ms).
[16:36:39.800] <TB2> INFO: Expecting 655360 events.
[16:36:56.555] <TB2> INFO: 655360 events read in total (16353ms).
[16:36:56.596] <TB2> INFO: Expecting 655360 events.
[16:37:13.419] <TB2> INFO: 655360 events read in total (16421ms).
[16:37:13.462] <TB2> INFO: Expecting 655360 events.
[16:37:30.283] <TB2> INFO: 655360 events read in total (16420ms).
[16:37:30.332] <TB2> INFO: Expecting 655360 events.
[16:37:47.070] <TB2> INFO: 655360 events read in total (16336ms).
[16:37:47.118] <TB2> INFO: Expecting 655360 events.
[16:38:03.944] <TB2> INFO: 655360 events read in total (16424ms).
[16:38:04.000] <TB2> INFO: Expecting 655360 events.
[16:38:20.879] <TB2> INFO: 655360 events read in total (16476ms).
[16:38:20.939] <TB2> INFO: Expecting 655360 events.
[16:38:37.806] <TB2> INFO: 655360 events read in total (16465ms).
[16:38:37.864] <TB2> INFO: Expecting 655360 events.
[16:38:54.646] <TB2> INFO: 655360 events read in total (16381ms).
[16:38:54.707] <TB2> INFO: Test took 270415ms.
[16:38:54.786] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:38:55.015] <TB2> INFO: Expecting 655360 events.
[16:39:12.001] <TB2> INFO: 655360 events read in total (16429ms).
[16:39:12.010] <TB2> INFO: Expecting 655360 events.
[16:39:28.697] <TB2> INFO: 655360 events read in total (16285ms).
[16:39:28.709] <TB2> INFO: Expecting 655360 events.
[16:39:45.541] <TB2> INFO: 655360 events read in total (16430ms).
[16:39:45.557] <TB2> INFO: Expecting 655360 events.
[16:40:02.274] <TB2> INFO: 655360 events read in total (16315ms).
[16:40:02.292] <TB2> INFO: Expecting 655360 events.
[16:40:19.192] <TB2> INFO: 655360 events read in total (16494ms).
[16:40:19.215] <TB2> INFO: Expecting 655360 events.
[16:40:36.269] <TB2> INFO: 655360 events read in total (16652ms).
[16:40:36.295] <TB2> INFO: Expecting 655360 events.
[16:40:53.187] <TB2> INFO: 655360 events read in total (16490ms).
[16:40:53.216] <TB2> INFO: Expecting 655360 events.
[16:41:10.287] <TB2> INFO: 655360 events read in total (16669ms).
[16:41:10.322] <TB2> INFO: Expecting 655360 events.
[16:41:27.430] <TB2> INFO: 655360 events read in total (16707ms).
[16:41:27.469] <TB2> INFO: Expecting 655360 events.
[16:41:44.361] <TB2> INFO: 655360 events read in total (16490ms).
[16:41:44.402] <TB2> INFO: Expecting 655360 events.
[16:42:01.499] <TB2> INFO: 655360 events read in total (16695ms).
[16:42:01.549] <TB2> INFO: Expecting 655360 events.
[16:42:18.582] <TB2> INFO: 655360 events read in total (16632ms).
[16:42:18.635] <TB2> INFO: Expecting 655360 events.
[16:42:35.622] <TB2> INFO: 655360 events read in total (16585ms).
[16:42:35.686] <TB2> INFO: Expecting 655360 events.
[16:42:52.496] <TB2> INFO: 655360 events read in total (16408ms).
[16:42:52.551] <TB2> INFO: Expecting 655360 events.
[16:43:09.177] <TB2> INFO: 655360 events read in total (16224ms).
[16:43:09.241] <TB2> INFO: Expecting 655360 events.
[16:43:25.756] <TB2> INFO: 655360 events read in total (16113ms).
[16:43:25.817] <TB2> INFO: Test took 271031ms.
[16:43:26.038] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.045] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[16:43:26.052] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[16:43:26.059] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.065] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.072] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.079] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.086] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.093] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.100] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.106] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.113] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.120] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.127] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.134] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.141] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.147] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.154] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[16:43:26.161] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[16:43:26.168] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[16:43:26.175] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[16:43:26.182] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[16:43:26.189] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[16:43:26.196] <TB2> INFO: safety margin for low PH: adding 7, margin is now 27
[16:43:26.203] <TB2> INFO: safety margin for low PH: adding 8, margin is now 28
[16:43:26.210] <TB2> INFO: safety margin for low PH: adding 9, margin is now 29
[16:43:26.217] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[16:43:26.254] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C0.dat
[16:43:26.254] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C1.dat
[16:43:26.254] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C2.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C3.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C4.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C5.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C6.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C7.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C8.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C9.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C10.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C11.dat
[16:43:26.255] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C12.dat
[16:43:26.256] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C13.dat
[16:43:26.256] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C14.dat
[16:43:26.256] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//dacParameters35_C15.dat
[16:43:26.518] <TB2> INFO: Expecting 41600 events.
[16:43:29.984] <TB2> INFO: 41600 events read in total (2910ms).
[16:43:29.985] <TB2> INFO: Test took 3726ms.
[16:43:30.442] <TB2> INFO: Expecting 41600 events.
[16:43:33.933] <TB2> INFO: 41600 events read in total (2935ms).
[16:43:33.934] <TB2> INFO: Test took 3769ms.
[16:43:34.408] <TB2> INFO: Expecting 41600 events.
[16:43:37.900] <TB2> INFO: 41600 events read in total (2936ms).
[16:43:37.900] <TB2> INFO: Test took 3787ms.
[16:43:38.089] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:38.178] <TB2> INFO: Expecting 2560 events.
[16:43:39.032] <TB2> INFO: 2560 events read in total (298ms).
[16:43:39.032] <TB2> INFO: Test took 943ms.
[16:43:39.036] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:39.338] <TB2> INFO: Expecting 2560 events.
[16:43:40.196] <TB2> INFO: 2560 events read in total (302ms).
[16:43:40.197] <TB2> INFO: Test took 1161ms.
[16:43:40.199] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:40.502] <TB2> INFO: Expecting 2560 events.
[16:43:41.355] <TB2> INFO: 2560 events read in total (297ms).
[16:43:41.355] <TB2> INFO: Test took 1156ms.
[16:43:41.358] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:41.662] <TB2> INFO: Expecting 2560 events.
[16:43:42.520] <TB2> INFO: 2560 events read in total (302ms).
[16:43:42.521] <TB2> INFO: Test took 1163ms.
[16:43:42.524] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:42.827] <TB2> INFO: Expecting 2560 events.
[16:43:43.686] <TB2> INFO: 2560 events read in total (303ms).
[16:43:43.687] <TB2> INFO: Test took 1163ms.
[16:43:43.690] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:43.992] <TB2> INFO: Expecting 2560 events.
[16:43:44.846] <TB2> INFO: 2560 events read in total (298ms).
[16:43:44.846] <TB2> INFO: Test took 1156ms.
[16:43:44.848] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:45.152] <TB2> INFO: Expecting 2560 events.
[16:43:46.007] <TB2> INFO: 2560 events read in total (299ms).
[16:43:46.007] <TB2> INFO: Test took 1159ms.
[16:43:46.010] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:46.313] <TB2> INFO: Expecting 2560 events.
[16:43:47.168] <TB2> INFO: 2560 events read in total (299ms).
[16:43:47.168] <TB2> INFO: Test took 1158ms.
[16:43:47.172] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:47.474] <TB2> INFO: Expecting 2560 events.
[16:43:48.328] <TB2> INFO: 2560 events read in total (298ms).
[16:43:48.328] <TB2> INFO: Test took 1156ms.
[16:43:48.330] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:48.633] <TB2> INFO: Expecting 2560 events.
[16:43:49.486] <TB2> INFO: 2560 events read in total (297ms).
[16:43:49.486] <TB2> INFO: Test took 1156ms.
[16:43:49.488] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:49.792] <TB2> INFO: Expecting 2560 events.
[16:43:50.647] <TB2> INFO: 2560 events read in total (299ms).
[16:43:50.647] <TB2> INFO: Test took 1159ms.
[16:43:50.649] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:50.952] <TB2> INFO: Expecting 2560 events.
[16:43:51.806] <TB2> INFO: 2560 events read in total (298ms).
[16:43:51.806] <TB2> INFO: Test took 1157ms.
[16:43:51.810] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:52.112] <TB2> INFO: Expecting 2560 events.
[16:43:52.964] <TB2> INFO: 2560 events read in total (296ms).
[16:43:52.966] <TB2> INFO: Test took 1156ms.
[16:43:52.967] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:53.270] <TB2> INFO: Expecting 2560 events.
[16:43:54.124] <TB2> INFO: 2560 events read in total (298ms).
[16:43:54.124] <TB2> INFO: Test took 1157ms.
[16:43:54.126] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:54.430] <TB2> INFO: Expecting 2560 events.
[16:43:55.282] <TB2> INFO: 2560 events read in total (296ms).
[16:43:55.283] <TB2> INFO: Test took 1157ms.
[16:43:55.285] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:55.589] <TB2> INFO: Expecting 2560 events.
[16:43:56.442] <TB2> INFO: 2560 events read in total (297ms).
[16:43:56.442] <TB2> INFO: Test took 1157ms.
[16:43:56.445] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:56.747] <TB2> INFO: Expecting 2560 events.
[16:43:57.601] <TB2> INFO: 2560 events read in total (297ms).
[16:43:57.601] <TB2> INFO: Test took 1157ms.
[16:43:57.604] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:57.913] <TB2> INFO: Expecting 2560 events.
[16:43:58.766] <TB2> INFO: 2560 events read in total (297ms).
[16:43:58.768] <TB2> INFO: Test took 1164ms.
[16:43:58.770] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:59.072] <TB2> INFO: Expecting 2560 events.
[16:43:59.924] <TB2> INFO: 2560 events read in total (296ms).
[16:43:59.925] <TB2> INFO: Test took 1156ms.
[16:43:59.928] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:00.230] <TB2> INFO: Expecting 2560 events.
[16:44:01.083] <TB2> INFO: 2560 events read in total (297ms).
[16:44:01.083] <TB2> INFO: Test took 1155ms.
[16:44:01.086] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:01.389] <TB2> INFO: Expecting 2560 events.
[16:44:02.242] <TB2> INFO: 2560 events read in total (297ms).
[16:44:02.242] <TB2> INFO: Test took 1157ms.
[16:44:02.246] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:02.549] <TB2> INFO: Expecting 2560 events.
[16:44:03.401] <TB2> INFO: 2560 events read in total (296ms).
[16:44:03.401] <TB2> INFO: Test took 1156ms.
[16:44:03.403] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:03.707] <TB2> INFO: Expecting 2560 events.
[16:44:04.560] <TB2> INFO: 2560 events read in total (297ms).
[16:44:04.561] <TB2> INFO: Test took 1158ms.
[16:44:04.564] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:04.866] <TB2> INFO: Expecting 2560 events.
[16:44:05.719] <TB2> INFO: 2560 events read in total (297ms).
[16:44:05.719] <TB2> INFO: Test took 1155ms.
[16:44:05.723] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:06.024] <TB2> INFO: Expecting 2560 events.
[16:44:06.877] <TB2> INFO: 2560 events read in total (297ms).
[16:44:06.877] <TB2> INFO: Test took 1154ms.
[16:44:06.880] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:07.182] <TB2> INFO: Expecting 2560 events.
[16:44:08.036] <TB2> INFO: 2560 events read in total (297ms).
[16:44:08.036] <TB2> INFO: Test took 1156ms.
[16:44:08.039] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:08.343] <TB2> INFO: Expecting 2560 events.
[16:44:09.196] <TB2> INFO: 2560 events read in total (297ms).
[16:44:09.196] <TB2> INFO: Test took 1157ms.
[16:44:09.197] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:09.501] <TB2> INFO: Expecting 2560 events.
[16:44:10.355] <TB2> INFO: 2560 events read in total (298ms).
[16:44:10.355] <TB2> INFO: Test took 1158ms.
[16:44:10.359] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:10.661] <TB2> INFO: Expecting 2560 events.
[16:44:11.512] <TB2> INFO: 2560 events read in total (295ms).
[16:44:11.513] <TB2> INFO: Test took 1154ms.
[16:44:11.515] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:11.818] <TB2> INFO: Expecting 2560 events.
[16:44:12.672] <TB2> INFO: 2560 events read in total (298ms).
[16:44:12.672] <TB2> INFO: Test took 1157ms.
[16:44:12.675] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:12.980] <TB2> INFO: Expecting 2560 events.
[16:44:13.832] <TB2> INFO: 2560 events read in total (296ms).
[16:44:13.833] <TB2> INFO: Test took 1158ms.
[16:44:13.834] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:44:14.138] <TB2> INFO: Expecting 2560 events.
[16:44:14.991] <TB2> INFO: 2560 events read in total (297ms).
[16:44:14.992] <TB2> INFO: Test took 1158ms.
[16:44:15.450] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 621 seconds
[16:44:15.450] <TB2> INFO: PH scale (per ROC): 83 86 73 80 80 84 82 71 84 71 78 75 81 88 81 76
[16:44:15.450] <TB2> INFO: PH offset (per ROC): 144 172 170 158 155 180 189 190 170 188 176 173 178 149 176 178
[16:44:15.455] <TB2> INFO: Decoding statistics:
[16:44:15.455] <TB2> INFO: General information:
[16:44:15.455] <TB2> INFO: 16bit words read: 91924
[16:44:15.455] <TB2> INFO: valid events total: 10240
[16:44:15.455] <TB2> INFO: empty events: 7739
[16:44:15.455] <TB2> INFO: valid events with pixels: 2501
[16:44:15.455] <TB2> INFO: valid pixel hits: 2501
[16:44:15.455] <TB2> INFO: Event errors: 0
[16:44:15.455] <TB2> INFO: start marker: 0
[16:44:15.455] <TB2> INFO: stop marker: 0
[16:44:15.455] <TB2> INFO: overflow: 0
[16:44:15.455] <TB2> INFO: invalid 5bit words: 0
[16:44:15.455] <TB2> INFO: invalid XOR eye diagram: 0
[16:44:15.455] <TB2> INFO: frame (failed synchr.): 0
[16:44:15.455] <TB2> INFO: idle data (no TBM trl): 0
[16:44:15.455] <TB2> INFO: no data (only TBM hdr): 0
[16:44:15.455] <TB2> INFO: TBM errors: 0
[16:44:15.455] <TB2> INFO: flawed TBM headers: 0
[16:44:15.455] <TB2> INFO: flawed TBM trailers: 0
[16:44:15.455] <TB2> INFO: event ID mismatches: 0
[16:44:15.455] <TB2> INFO: ROC errors: 0
[16:44:15.455] <TB2> INFO: missing ROC header(s): 0
[16:44:15.455] <TB2> INFO: misplaced readback start: 0
[16:44:15.455] <TB2> INFO: Pixel decoding errors: 0
[16:44:15.455] <TB2> INFO: pixel data incomplete: 0
[16:44:15.455] <TB2> INFO: pixel address: 0
[16:44:15.455] <TB2> INFO: pulse height fill bit: 0
[16:44:15.455] <TB2> INFO: buffer corruption: 0
[16:44:15.634] <TB2> INFO: ######################################################################
[16:44:15.634] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[16:44:15.634] <TB2> INFO: ######################################################################
[16:44:15.645] <TB2> INFO: scanning low vcal = 10
[16:44:15.908] <TB2> INFO: Expecting 41600 events.
[16:44:19.456] <TB2> INFO: 41600 events read in total (2992ms).
[16:44:19.456] <TB2> INFO: Test took 3811ms.
[16:44:19.458] <TB2> INFO: scanning low vcal = 20
[16:44:19.761] <TB2> INFO: Expecting 41600 events.
[16:44:23.330] <TB2> INFO: 41600 events read in total (3013ms).
[16:44:23.330] <TB2> INFO: Test took 3871ms.
[16:44:23.333] <TB2> INFO: scanning low vcal = 30
[16:44:23.635] <TB2> INFO: Expecting 41600 events.
[16:44:27.216] <TB2> INFO: 41600 events read in total (3025ms).
[16:44:27.218] <TB2> INFO: Test took 3885ms.
[16:44:27.220] <TB2> INFO: scanning low vcal = 40
[16:44:27.509] <TB2> INFO: Expecting 41600 events.
[16:44:31.669] <TB2> INFO: 41600 events read in total (3604ms).
[16:44:31.670] <TB2> INFO: Test took 4450ms.
[16:44:31.674] <TB2> INFO: scanning low vcal = 50
[16:44:31.945] <TB2> INFO: Expecting 41600 events.
[16:44:36.149] <TB2> INFO: 41600 events read in total (3649ms).
[16:44:36.150] <TB2> INFO: Test took 4476ms.
[16:44:36.153] <TB2> INFO: scanning low vcal = 60
[16:44:36.418] <TB2> INFO: Expecting 41600 events.
[16:44:40.648] <TB2> INFO: 41600 events read in total (3674ms).
[16:44:40.649] <TB2> INFO: Test took 4496ms.
[16:44:40.653] <TB2> INFO: scanning low vcal = 70
[16:44:40.915] <TB2> INFO: Expecting 41600 events.
[16:44:45.147] <TB2> INFO: 41600 events read in total (3675ms).
[16:44:45.148] <TB2> INFO: Test took 4495ms.
[16:44:45.151] <TB2> INFO: scanning low vcal = 80
[16:44:45.410] <TB2> INFO: Expecting 41600 events.
[16:44:49.626] <TB2> INFO: 41600 events read in total (3660ms).
[16:44:49.626] <TB2> INFO: Test took 4475ms.
[16:44:49.629] <TB2> INFO: scanning low vcal = 90
[16:44:49.911] <TB2> INFO: Expecting 41600 events.
[16:44:54.135] <TB2> INFO: 41600 events read in total (3667ms).
[16:44:54.135] <TB2> INFO: Test took 4505ms.
[16:44:54.139] <TB2> INFO: scanning low vcal = 100
[16:44:54.403] <TB2> INFO: Expecting 41600 events.
[16:44:58.633] <TB2> INFO: 41600 events read in total (3674ms).
[16:44:58.633] <TB2> INFO: Test took 4493ms.
[16:44:58.637] <TB2> INFO: scanning low vcal = 110
[16:44:58.903] <TB2> INFO: Expecting 41600 events.
[16:45:03.131] <TB2> INFO: 41600 events read in total (3671ms).
[16:45:03.131] <TB2> INFO: Test took 4494ms.
[16:45:03.135] <TB2> INFO: scanning low vcal = 120
[16:45:03.409] <TB2> INFO: Expecting 41600 events.
[16:45:07.601] <TB2> INFO: 41600 events read in total (3636ms).
[16:45:07.601] <TB2> INFO: Test took 4466ms.
[16:45:07.604] <TB2> INFO: scanning low vcal = 130
[16:45:07.871] <TB2> INFO: Expecting 41600 events.
[16:45:12.072] <TB2> INFO: 41600 events read in total (3645ms).
[16:45:12.073] <TB2> INFO: Test took 4469ms.
[16:45:12.075] <TB2> INFO: scanning low vcal = 140
[16:45:12.348] <TB2> INFO: Expecting 41600 events.
[16:45:16.582] <TB2> INFO: 41600 events read in total (3677ms).
[16:45:16.582] <TB2> INFO: Test took 4506ms.
[16:45:16.585] <TB2> INFO: scanning low vcal = 150
[16:45:16.852] <TB2> INFO: Expecting 41600 events.
[16:45:21.078] <TB2> INFO: 41600 events read in total (3670ms).
[16:45:21.078] <TB2> INFO: Test took 4493ms.
[16:45:21.081] <TB2> INFO: scanning low vcal = 160
[16:45:21.345] <TB2> INFO: Expecting 41600 events.
[16:45:25.587] <TB2> INFO: 41600 events read in total (3686ms).
[16:45:25.588] <TB2> INFO: Test took 4507ms.
[16:45:25.590] <TB2> INFO: scanning low vcal = 170
[16:45:25.884] <TB2> INFO: Expecting 41600 events.
[16:45:30.122] <TB2> INFO: 41600 events read in total (3681ms).
[16:45:30.122] <TB2> INFO: Test took 4532ms.
[16:45:30.126] <TB2> INFO: scanning low vcal = 180
[16:45:30.401] <TB2> INFO: Expecting 41600 events.
[16:45:34.641] <TB2> INFO: 41600 events read in total (3684ms).
[16:45:34.642] <TB2> INFO: Test took 4515ms.
[16:45:34.645] <TB2> INFO: scanning low vcal = 190
[16:45:34.909] <TB2> INFO: Expecting 41600 events.
[16:45:39.148] <TB2> INFO: 41600 events read in total (3683ms).
[16:45:39.149] <TB2> INFO: Test took 4504ms.
[16:45:39.152] <TB2> INFO: scanning low vcal = 200
[16:45:39.411] <TB2> INFO: Expecting 41600 events.
[16:45:43.640] <TB2> INFO: 41600 events read in total (3672ms).
[16:45:43.641] <TB2> INFO: Test took 4489ms.
[16:45:43.643] <TB2> INFO: scanning low vcal = 210
[16:45:43.914] <TB2> INFO: Expecting 41600 events.
[16:45:48.130] <TB2> INFO: 41600 events read in total (3660ms).
[16:45:48.130] <TB2> INFO: Test took 4486ms.
[16:45:48.133] <TB2> INFO: scanning low vcal = 220
[16:45:48.393] <TB2> INFO: Expecting 41600 events.
[16:45:52.612] <TB2> INFO: 41600 events read in total (3663ms).
[16:45:52.613] <TB2> INFO: Test took 4480ms.
[16:45:52.615] <TB2> INFO: scanning low vcal = 230
[16:45:52.879] <TB2> INFO: Expecting 41600 events.
[16:45:57.111] <TB2> INFO: 41600 events read in total (3676ms).
[16:45:57.111] <TB2> INFO: Test took 4496ms.
[16:45:57.114] <TB2> INFO: scanning low vcal = 240
[16:45:57.402] <TB2> INFO: Expecting 41600 events.
[16:46:01.619] <TB2> INFO: 41600 events read in total (3660ms).
[16:46:01.621] <TB2> INFO: Test took 4507ms.
[16:46:01.625] <TB2> INFO: scanning low vcal = 250
[16:46:01.902] <TB2> INFO: Expecting 41600 events.
[16:46:06.111] <TB2> INFO: 41600 events read in total (3653ms).
[16:46:06.111] <TB2> INFO: Test took 4486ms.
[16:46:06.115] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[16:46:06.389] <TB2> INFO: Expecting 41600 events.
[16:46:10.597] <TB2> INFO: 41600 events read in total (3651ms).
[16:46:10.597] <TB2> INFO: Test took 4482ms.
[16:46:10.602] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[16:46:10.865] <TB2> INFO: Expecting 41600 events.
[16:46:15.057] <TB2> INFO: 41600 events read in total (3635ms).
[16:46:15.058] <TB2> INFO: Test took 4456ms.
[16:46:15.061] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[16:46:15.330] <TB2> INFO: Expecting 41600 events.
[16:46:19.512] <TB2> INFO: 41600 events read in total (3626ms).
[16:46:19.512] <TB2> INFO: Test took 4451ms.
[16:46:19.515] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[16:46:19.778] <TB2> INFO: Expecting 41600 events.
[16:46:23.961] <TB2> INFO: 41600 events read in total (3627ms).
[16:46:23.961] <TB2> INFO: Test took 4446ms.
[16:46:23.965] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[16:46:24.228] <TB2> INFO: Expecting 41600 events.
[16:46:28.399] <TB2> INFO: 41600 events read in total (3615ms).
[16:46:28.400] <TB2> INFO: Test took 4435ms.
[16:46:28.895] <TB2> INFO: PixTestGainPedestal::measure() done
[16:47:01.378] <TB2> INFO: PixTestGainPedestal::fit() done
[16:47:01.378] <TB2> INFO: non-linearity mean: 0.960 0.963 0.952 0.952 0.965 0.956 0.958 0.958 0.952 0.958 0.961 0.954 0.958 0.960 0.965 0.957
[16:47:01.378] <TB2> INFO: non-linearity RMS: 0.005 0.007 0.007 0.005 0.005 0.006 0.005 0.005 0.006 0.005 0.006 0.006 0.006 0.005 0.003 0.006
[16:47:01.378] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[16:47:01.397] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[16:47:01.415] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[16:47:01.434] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[16:47:01.453] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[16:47:01.472] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[16:47:01.491] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[16:47:01.510] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[16:47:01.528] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[16:47:01.547] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[16:47:01.566] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[16:47:01.585] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[16:47:01.604] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[16:47:01.623] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[16:47:01.642] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[16:47:01.660] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[16:47:01.679] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 166 seconds
[16:47:01.679] <TB2> INFO: Decoding statistics:
[16:47:01.679] <TB2> INFO: General information:
[16:47:01.679] <TB2> INFO: 16bit words read: 2662400
[16:47:01.679] <TB2> INFO: valid events total: 166400
[16:47:01.679] <TB2> INFO: empty events: 0
[16:47:01.679] <TB2> INFO: valid events with pixels: 166400
[16:47:01.679] <TB2> INFO: valid pixel hits: 665580
[16:47:01.679] <TB2> INFO: Event errors: 0
[16:47:01.679] <TB2> INFO: start marker: 0
[16:47:01.679] <TB2> INFO: stop marker: 0
[16:47:01.679] <TB2> INFO: overflow: 0
[16:47:01.679] <TB2> INFO: invalid 5bit words: 0
[16:47:01.679] <TB2> INFO: invalid XOR eye diagram: 0
[16:47:01.679] <TB2> INFO: frame (failed synchr.): 0
[16:47:01.679] <TB2> INFO: idle data (no TBM trl): 0
[16:47:01.679] <TB2> INFO: no data (only TBM hdr): 0
[16:47:01.679] <TB2> INFO: TBM errors: 0
[16:47:01.679] <TB2> INFO: flawed TBM headers: 0
[16:47:01.679] <TB2> INFO: flawed TBM trailers: 0
[16:47:01.679] <TB2> INFO: event ID mismatches: 0
[16:47:01.679] <TB2> INFO: ROC errors: 0
[16:47:01.679] <TB2> INFO: missing ROC header(s): 0
[16:47:01.679] <TB2> INFO: misplaced readback start: 0
[16:47:01.679] <TB2> INFO: Pixel decoding errors: 0
[16:47:01.679] <TB2> INFO: pixel data incomplete: 0
[16:47:01.679] <TB2> INFO: pixel address: 0
[16:47:01.679] <TB2> INFO: pulse height fill bit: 0
[16:47:01.679] <TB2> INFO: buffer corruption: 0
[16:47:01.686] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C15.dat
[16:47:01.687] <TB2> INFO: ######################################################################
[16:47:01.687] <TB2> INFO: PixTestReadback::doTest()
[16:47:01.687] <TB2> INFO: ######################################################################
[16:47:01.688] <TB2> INFO: ----------------------------------------------------------------------
[16:47:01.688] <TB2> INFO: PixTestReadback::CalibrateVd()
[16:47:01.688] <TB2> INFO: ----------------------------------------------------------------------
[16:47:11.135] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C0.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C1.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C2.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C3.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C4.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C5.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C6.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C7.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C8.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C9.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C10.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C11.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C12.dat
[16:47:11.136] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C13.dat
[16:47:11.137] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C14.dat
[16:47:11.137] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C15.dat
[16:47:11.170] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[16:47:11.170] <TB2> INFO: ----------------------------------------------------------------------
[16:47:11.170] <TB2> INFO: PixTestReadback::CalibrateVa()
[16:47:11.170] <TB2> INFO: ----------------------------------------------------------------------
[16:47:20.659] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C0.dat
[16:47:20.659] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C1.dat
[16:47:20.659] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C2.dat
[16:47:20.659] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C3.dat
[16:47:20.659] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C4.dat
[16:47:20.659] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C5.dat
[16:47:20.659] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C6.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C7.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C8.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C9.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C10.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C11.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C12.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C13.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C14.dat
[16:47:20.660] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C15.dat
[16:47:20.691] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[16:47:20.691] <TB2> INFO: ----------------------------------------------------------------------
[16:47:20.691] <TB2> INFO: PixTestReadback::readbackVbg()
[16:47:20.691] <TB2> INFO: ----------------------------------------------------------------------
[16:47:27.990] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[16:47:27.990] <TB2> INFO: ----------------------------------------------------------------------
[16:47:27.990] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[16:47:27.990] <TB2> INFO: ----------------------------------------------------------------------
[16:47:27.991] <TB2> INFO: Vbg will be calibrated using Vd calibration
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 150.6calibrated Vbg = 1.1812 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 162.3calibrated Vbg = 1.18573 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 151calibrated Vbg = 1.19029 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 163.4calibrated Vbg = 1.1936 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 153calibrated Vbg = 1.2021 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 160.3calibrated Vbg = 1.20588 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 162.5calibrated Vbg = 1.20433 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 160.1calibrated Vbg = 1.20782 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 144.2calibrated Vbg = 1.20542 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 151.3calibrated Vbg = 1.20301 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 155.8calibrated Vbg = 1.20007 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 150.9calibrated Vbg = 1.20265 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 153.7calibrated Vbg = 1.1953 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 144calibrated Vbg = 1.19596 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 157.8calibrated Vbg = 1.19977 :::*/*/*/*/
[16:47:27.991] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 159.5calibrated Vbg = 1.19199 :::*/*/*/*/
[16:47:27.995] <TB2> INFO: ----------------------------------------------------------------------
[16:47:27.995] <TB2> INFO: PixTestReadback::CalibrateIa()
[16:47:27.995] <TB2> INFO: ----------------------------------------------------------------------
[16:50:03.537] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C0.dat
[16:50:03.537] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C1.dat
[16:50:03.537] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C2.dat
[16:50:03.537] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C3.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C4.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C5.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C6.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C7.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C8.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C9.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C10.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C11.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C12.dat
[16:50:03.538] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C13.dat
[16:50:03.539] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C14.dat
[16:50:03.539] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2182_FullQualification_2016-03-22_12h03m_1458644604//002_FulltestPxar_m20//readbackCal_C15.dat
[16:50:03.573] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[16:50:03.575] <TB2> INFO: PixTestReadback::doTest() done
[16:50:03.575] <TB2> INFO: Decoding statistics:
[16:50:03.575] <TB2> INFO: General information:
[16:50:03.575] <TB2> INFO: 16bit words read: 1024
[16:50:03.575] <TB2> INFO: valid events total: 128
[16:50:03.575] <TB2> INFO: empty events: 128
[16:50:03.575] <TB2> INFO: valid events with pixels: 0
[16:50:03.575] <TB2> INFO: valid pixel hits: 0
[16:50:03.575] <TB2> INFO: Event errors: 0
[16:50:03.575] <TB2> INFO: start marker: 0
[16:50:03.575] <TB2> INFO: stop marker: 0
[16:50:03.575] <TB2> INFO: overflow: 0
[16:50:03.575] <TB2> INFO: invalid 5bit words: 0
[16:50:03.575] <TB2> INFO: invalid XOR eye diagram: 0
[16:50:03.575] <TB2> INFO: frame (failed synchr.): 0
[16:50:03.575] <TB2> INFO: idle data (no TBM trl): 0
[16:50:03.575] <TB2> INFO: no data (only TBM hdr): 0
[16:50:03.575] <TB2> INFO: TBM errors: 0
[16:50:03.575] <TB2> INFO: flawed TBM headers: 0
[16:50:03.575] <TB2> INFO: flawed TBM trailers: 0
[16:50:03.575] <TB2> INFO: event ID mismatches: 0
[16:50:03.575] <TB2> INFO: ROC errors: 0
[16:50:03.575] <TB2> INFO: missing ROC header(s): 0
[16:50:03.575] <TB2> INFO: misplaced readback start: 0
[16:50:03.575] <TB2> INFO: Pixel decoding errors: 0
[16:50:03.575] <TB2> INFO: pixel data incomplete: 0
[16:50:03.575] <TB2> INFO: pixel address: 0
[16:50:03.575] <TB2> INFO: pulse height fill bit: 0
[16:50:03.575] <TB2> INFO: buffer corruption: 0
[16:50:03.602] <TB2> INFO: Decoding statistics:
[16:50:03.602] <TB2> INFO: General information:
[16:50:03.602] <TB2> INFO: 16bit words read: 2755348
[16:50:03.602] <TB2> INFO: valid events total: 176768
[16:50:03.602] <TB2> INFO: empty events: 7867
[16:50:03.602] <TB2> INFO: valid events with pixels: 168901
[16:50:03.602] <TB2> INFO: valid pixel hits: 668081
[16:50:03.602] <TB2> INFO: Event errors: 0
[16:50:03.602] <TB2> INFO: start marker: 0
[16:50:03.602] <TB2> INFO: stop marker: 0
[16:50:03.602] <TB2> INFO: overflow: 0
[16:50:03.602] <TB2> INFO: invalid 5bit words: 0
[16:50:03.602] <TB2> INFO: invalid XOR eye diagram: 0
[16:50:03.602] <TB2> INFO: frame (failed synchr.): 0
[16:50:03.602] <TB2> INFO: idle data (no TBM trl): 0
[16:50:03.602] <TB2> INFO: no data (only TBM hdr): 0
[16:50:03.602] <TB2> INFO: TBM errors: 0
[16:50:03.602] <TB2> INFO: flawed TBM headers: 0
[16:50:03.602] <TB2> INFO: flawed TBM trailers: 0
[16:50:03.602] <TB2> INFO: event ID mismatches: 0
[16:50:03.602] <TB2> INFO: ROC errors: 0
[16:50:03.602] <TB2> INFO: missing ROC header(s): 0
[16:50:03.602] <TB2> INFO: misplaced readback start: 0
[16:50:03.602] <TB2> INFO: Pixel decoding errors: 0
[16:50:03.602] <TB2> INFO: pixel data incomplete: 0
[16:50:03.602] <TB2> INFO: pixel address: 0
[16:50:03.602] <TB2> INFO: pulse height fill bit: 0
[16:50:03.603] <TB2> INFO: buffer corruption: 0
[16:50:03.603] <TB2> INFO: enter test to run
[16:50:03.603] <TB2> INFO: test: exit no parameter change
[16:50:03.756] <TB2> QUIET: Connection to board 156 closed.
[16:50:03.836] <TB2> INFO: pXar: this is the end, my friend