[12:34:02.156] <TB0> INFO: *** Welcome to pxar ***
[12:34:02.156] <TB0> INFO: *** Today: 2016/06/08
[12:34:02.667] <TB0> INFO: *** Version: 9751-dirty
[12:34:02.667] <TB0> INFO: readRocDacs: /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C15.dat
[12:34:02.668] <TB0> INFO: readTbmDacs: /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//tbmParameters_C0b.dat
[12:34:02.668] <TB0> INFO: readMaskFile: /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//defaultMaskFile.dat
[12:34:02.668] <TB0> INFO: readTrimFile: /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters_C15.dat
[12:34:02.734] <TB0> INFO: clk: 4
[12:34:02.734] <TB0> INFO: ctr: 4
[12:34:02.734] <TB0> INFO: sda: 19
[12:34:02.734] <TB0> INFO: tin: 9
[12:34:02.734] <TB0> INFO: level: 15
[12:34:02.734] <TB0> INFO: triggerdelay: 0
[12:34:02.734] <TB0> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[12:34:02.734] <TB0> INFO: Log level: INFO
[12:34:02.741] <TB0> INFO: Found DTB DTB_WS6AYH
[12:34:02.753] <TB0> QUIET: Connection to board DTB_WS6AYH opened.
[12:34:02.755] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 73
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WS6AYH
MAC address: 40D855118049
Hostname: pixelDTB073
Comment:
------------------------------------------------------
[12:34:02.757] <TB0> INFO: RPC call hashes of host and DTB match: 484264910
[12:34:04.285] <TB0> INFO: DUT info:
[12:34:04.285] <TB0> INFO: The DUT currently contains the following objects:
[12:34:04.285] <TB0> INFO: 2 TBM Cores tbm09c (2 ON)
[12:34:04.285] <TB0> INFO: TBM Core alpha (0): 7 registers set
[12:34:04.285] <TB0> INFO: TBM Core beta (1): 7 registers set
[12:34:04.285] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:34:04.285] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.285] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:34:04.686] <TB0> INFO: enter 'restricted' command line mode
[12:34:04.686] <TB0> INFO: enter test to run
[12:34:04.686] <TB0> INFO: test: pretest no parameter change
[12:34:04.686] <TB0> INFO: running: pretest
[12:34:04.690] <TB0> INFO: ----------------------------------------------------------------------
[12:34:04.690] <TB0> INFO: PixTestPretest::programROC()
[12:34:04.690] <TB0> INFO: ----------------------------------------------------------------------
[12:34:22.705] <TB0> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[12:34:22.705] <TB0> INFO: IA differences per ROC: 18.5 18.5 20.1 16.9 16.9 17.7 19.3 18.5 18.5 20.1 18.5 19.3 18.5 19.3 20.1 18.5
[12:34:22.833] <TB0> INFO: enter test to run
[12:34:22.833] <TB0> INFO: test: pretest no parameter change
[12:34:22.833] <TB0> INFO: running: pretest
[12:34:22.834] <TB0> INFO: ----------------------------------------------------------------------
[12:34:22.834] <TB0> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[12:34:22.834] <TB0> INFO: ----------------------------------------------------------------------
[12:34:28.615] <TB0> INFO: PixTestPretest::setVana() done, Module Ia 386.7 mA = 24.1687 mA/ROC
[12:34:28.615] <TB0> INFO: i(loss) [mA/ROC]: 20.1 20.1 20.1 20.1 20.1 20.1 19.3 19.3 19.3 20.1 19.3 19.3 19.3 19.3 19.3 20.1
[12:34:28.649] <TB0> INFO: enter test to run
[12:34:28.649] <TB0> INFO: test: pretest no parameter change
[12:34:28.649] <TB0> INFO: running: pretest
[12:34:28.649] <TB0> INFO: ----------------------------------------------------------------------
[12:34:28.649] <TB0> INFO: PixTestPretest::findTiming()
[12:34:28.649] <TB0> INFO: ----------------------------------------------------------------------
[12:34:28.649] <TB0> INFO: PixTestCmd::init()

[12:35:58.840] <TB0> INFO: TBM phases: 160MHz: 0, 400MHz: 2, TBM delays: ROC(0/1):4, header/trailer: 1, token: 1
[12:35:58.840] <TB0> INFO: (success/tries = 100/100), width = 3
[12:35:58.841] <TB0> INFO: enter test to run
[12:35:58.841] <TB0> INFO: test: pretest no parameter change
[12:35:58.841] <TB0> INFO: running: pretest
[12:35:58.843] <TB0> INFO: ----------------------------------------------------------------------
[12:35:58.843] <TB0> INFO: PixTestPretest::findWorkingPixel()
[12:35:58.843] <TB0> INFO: ----------------------------------------------------------------------
[12:35:58.937] <TB0> INFO: Expecting 231680 events.


[12:36:09.135] <TB0> INFO: 231680 events read in total (9642ms).
[12:36:09.139] <TB0> INFO: Test took 10291ms.
[12:36:09.365] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[12:36:09.435] <TB0> INFO: enter test to run
[12:36:09.435] <TB0> INFO: test: pretest no parameter change
[12:36:09.435] <TB0> INFO: running: pretest
[12:36:09.436] <TB0> INFO: ----------------------------------------------------------------------
[12:36:09.436] <TB0> INFO: PixTestPretest::setVthrCompCalDel()
[12:36:09.436] <TB0> INFO: ----------------------------------------------------------------------
[12:36:09.528] <TB0> INFO: Expecting 231680 events.
[12:36:19.883] <TB0> INFO: 231680 events read in total (9798ms).
[12:36:19.887] <TB0> INFO: Test took 10447ms.
[12:36:20.128] <TB0> INFO: PixTestPretest::setVthrCompCalDel() done
[12:36:20.128] <TB0> INFO: CalDel: 129 133 135 119 154 140 143 151 147 163 145 146 139 146 144 142
[12:36:20.128] <TB0> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[12:36:20.161] <TB0> INFO: enter test to run
[12:36:20.161] <TB0> INFO: test: pretest no parameter change
[12:36:20.161] <TB0> INFO: running: pretest
[12:36:20.161] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C0.dat
[12:36:20.161] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C1.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C2.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C3.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C4.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C5.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C6.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C7.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C8.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C9.dat
[12:36:20.162] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C10.dat
[12:36:20.163] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C11.dat
[12:36:20.163] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C12.dat
[12:36:20.163] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C13.dat
[12:36:20.163] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C14.dat
[12:36:20.163] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters_C15.dat
[12:36:20.163] <TB0> INFO: enter test to run
[12:36:20.163] <TB0> INFO: test: fulltest no parameter change
[12:36:20.163] <TB0> INFO: running: fulltest
[12:36:20.163] <TB0> INFO: ######################################################################
[12:36:20.163] <TB0> INFO: PixTestFullTest::doTest()
[12:36:20.163] <TB0> INFO: ######################################################################
[12:36:20.164] <TB0> INFO: ######################################################################
[12:36:20.164] <TB0> INFO: PixTestAlive::doTest()
[12:36:20.164] <TB0> INFO: ######################################################################
[12:36:20.165] <TB0> INFO: ----------------------------------------------------------------------
[12:36:20.165] <TB0> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:36:20.165] <TB0> INFO: ----------------------------------------------------------------------
[12:36:20.426] <TB0> INFO: Expecting 41600 events.
[12:36:24.237] <TB0> INFO: 41600 events read in total (3255ms).
[12:36:24.238] <TB0> INFO: Test took 4071ms.
[12:36:24.464] <TB0> INFO: PixTestAlive::aliveTest() done
[12:36:24.464] <TB0> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0
[12:36:24.465] <TB0> INFO: ----------------------------------------------------------------------
[12:36:24.465] <TB0> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:36:24.465] <TB0> INFO: ----------------------------------------------------------------------
[12:36:24.732] <TB0> INFO: Expecting 41600 events.
[12:36:27.766] <TB0> INFO: 41600 events read in total (2478ms).
[12:36:27.766] <TB0> INFO: Test took 3300ms.
[12:36:27.767] <TB0> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[12:36:28.016] <TB0> INFO: PixTestAlive::maskTest() done
[12:36:28.016] <TB0> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:36:28.018] <TB0> INFO: ----------------------------------------------------------------------
[12:36:28.018] <TB0> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[12:36:28.018] <TB0> INFO: ----------------------------------------------------------------------
[12:36:28.291] <TB0> INFO: Expecting 41600 events.
[12:36:32.128] <TB0> INFO: 41600 events read in total (3280ms).
[12:36:32.129] <TB0> INFO: Test took 4110ms.
[12:36:32.359] <TB0> INFO: PixTestAlive::addressDecodingTest() done
[12:36:32.359] <TB0> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:36:32.359] <TB0> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[12:36:32.359] <TB0> INFO: Decoding statistics:
[12:36:32.359] <TB0> INFO: General information:
[12:36:32.359] <TB0> INFO: 16bit words read: 0
[12:36:32.359] <TB0> INFO: valid events total: 0
[12:36:32.359] <TB0> INFO: empty events: 0
[12:36:32.359] <TB0> INFO: valid events with pixels: 0
[12:36:32.359] <TB0> INFO: valid pixel hits: 0
[12:36:32.359] <TB0> INFO: Event errors: 0
[12:36:32.359] <TB0> INFO: start marker: 0
[12:36:32.359] <TB0> INFO: stop marker: 0
[12:36:32.359] <TB0> INFO: overflow: 0
[12:36:32.359] <TB0> INFO: invalid 5bit words: 0
[12:36:32.359] <TB0> INFO: invalid XOR eye diagram: 0
[12:36:32.359] <TB0> INFO: frame (failed synchr.): 0
[12:36:32.359] <TB0> INFO: idle data (no TBM trl): 0
[12:36:32.360] <TB0> INFO: no data (only TBM hdr): 0
[12:36:32.360] <TB0> INFO: TBM errors: 0
[12:36:32.360] <TB0> INFO: flawed TBM headers: 0
[12:36:32.360] <TB0> INFO: flawed TBM trailers: 0
[12:36:32.360] <TB0> INFO: event ID mismatches: 0
[12:36:32.360] <TB0> INFO: ROC errors: 0
[12:36:32.360] <TB0> INFO: missing ROC header(s): 0
[12:36:32.360] <TB0> INFO: misplaced readback start: 0
[12:36:32.360] <TB0> INFO: Pixel decoding errors: 0
[12:36:32.360] <TB0> INFO: pixel data incomplete: 0
[12:36:32.360] <TB0> INFO: pixel address: 0
[12:36:32.360] <TB0> INFO: pulse height fill bit: 0
[12:36:32.360] <TB0> INFO: buffer corruption: 0
[12:36:32.373] <TB0> INFO: ######################################################################
[12:36:32.373] <TB0> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[12:36:32.373] <TB0> INFO: ######################################################################
[12:36:32.376] <TB0> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[12:36:32.388] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[12:36:32.388] <TB0> INFO: run 1 of 1
[12:36:32.670] <TB0> INFO: Expecting 3120000 events.
[12:37:14.384] <TB0> INFO: 864760 events read in total (41158ms).
[12:37:54.487] <TB0> INFO: 1716500 events read in total (81262ms).
[12:38:34.670] <TB0> INFO: 2573565 events read in total (121446ms).
[12:39:00.333] <TB0> INFO: 3120000 events read in total (147107ms).
[12:39:00.390] <TB0> INFO: Test took 148002ms.
[12:39:23.753] <TB0> INFO: PixTestBBMap::doTest() done, duration: 171 seconds
[12:39:23.753] <TB0> INFO: number of dead bumps (per ROC): 4 0 0 3 1 1 6 9 10 6 1 0 0 0 0 2
[12:39:23.753] <TB0> INFO: separation cut (per ROC): 99 95 111 103 89 86 90 84 90 91 88 105 106 97 92 95
[12:39:23.753] <TB0> INFO: Decoding statistics:
[12:39:23.753] <TB0> INFO: General information:
[12:39:23.753] <TB0> INFO: 16bit words read: 0
[12:39:23.753] <TB0> INFO: valid events total: 0
[12:39:23.753] <TB0> INFO: empty events: 0
[12:39:23.753] <TB0> INFO: valid events with pixels: 0
[12:39:23.753] <TB0> INFO: valid pixel hits: 0
[12:39:23.753] <TB0> INFO: Event errors: 0
[12:39:23.753] <TB0> INFO: start marker: 0
[12:39:23.753] <TB0> INFO: stop marker: 0
[12:39:23.753] <TB0> INFO: overflow: 0
[12:39:23.753] <TB0> INFO: invalid 5bit words: 0
[12:39:23.753] <TB0> INFO: invalid XOR eye diagram: 0
[12:39:23.753] <TB0> INFO: frame (failed synchr.): 0
[12:39:23.753] <TB0> INFO: idle data (no TBM trl): 0
[12:39:23.753] <TB0> INFO: no data (only TBM hdr): 0
[12:39:23.753] <TB0> INFO: TBM errors: 0
[12:39:23.753] <TB0> INFO: flawed TBM headers: 0
[12:39:23.753] <TB0> INFO: flawed TBM trailers: 0
[12:39:23.753] <TB0> INFO: event ID mismatches: 0
[12:39:23.753] <TB0> INFO: ROC errors: 0
[12:39:23.753] <TB0> INFO: missing ROC header(s): 0
[12:39:23.753] <TB0> INFO: misplaced readback start: 0
[12:39:23.753] <TB0> INFO: Pixel decoding errors: 0
[12:39:23.753] <TB0> INFO: pixel data incomplete: 0
[12:39:23.753] <TB0> INFO: pixel address: 0
[12:39:23.753] <TB0> INFO: pulse height fill bit: 0
[12:39:23.753] <TB0> INFO: buffer corruption: 0
[12:39:23.833] <TB0> INFO: ######################################################################
[12:39:23.833] <TB0> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:39:23.833] <TB0> INFO: ######################################################################
[12:39:23.833] <TB0> INFO: ----------------------------------------------------------------------
[12:39:23.833] <TB0> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[12:39:23.833] <TB0> INFO: ----------------------------------------------------------------------
[12:39:23.834] <TB0> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[12:39:23.841] <TB0> INFO: dacScan split into 1 runs with ntrig = 50
[12:39:23.841] <TB0> INFO: run 1 of 1
[12:39:24.115] <TB0> INFO: Expecting 26208000 events.
[12:39:58.357] <TB0> INFO: 924550 events read in total (33686ms).
[12:40:31.321] <TB0> INFO: 1835650 events read in total (66650ms).
[12:41:04.682] <TB0> INFO: 2743550 events read in total (100011ms).
[12:41:37.653] <TB0> INFO: 3651650 events read in total (132982ms).
[12:42:10.774] <TB0> INFO: 4558950 events read in total (166103ms).
[12:42:43.714] <TB0> INFO: 5462600 events read in total (199043ms).
[12:43:16.789] <TB0> INFO: 6368300 events read in total (232118ms).
[12:43:49.699] <TB0> INFO: 7271950 events read in total (265028ms).
[12:44:23.435] <TB0> INFO: 8172850 events read in total (298764ms).
[12:44:56.758] <TB0> INFO: 9076200 events read in total (332087ms).
[12:45:30.680] <TB0> INFO: 9974300 events read in total (366009ms).
[12:46:03.531] <TB0> INFO: 10873750 events read in total (398860ms).
[12:46:36.619] <TB0> INFO: 11773000 events read in total (431948ms).
[12:47:09.644] <TB0> INFO: 12672850 events read in total (464973ms).
[12:47:42.673] <TB0> INFO: 13562500 events read in total (498002ms).
[12:48:15.758] <TB0> INFO: 14451500 events read in total (531087ms).
[12:48:48.895] <TB0> INFO: 15338900 events read in total (564224ms).
[12:49:22.221] <TB0> INFO: 16225200 events read in total (597550ms).
[12:49:55.354] <TB0> INFO: 17107650 events read in total (630683ms).
[12:50:28.361] <TB0> INFO: 17990750 events read in total (663690ms).
[12:51:01.450] <TB0> INFO: 18873250 events read in total (696779ms).
[12:51:34.890] <TB0> INFO: 19755700 events read in total (730219ms).
[12:52:08.208] <TB0> INFO: 20638450 events read in total (763537ms).
[12:52:41.333] <TB0> INFO: 21520200 events read in total (796662ms).
[12:53:14.468] <TB0> INFO: 22401650 events read in total (829797ms).
[12:53:47.304] <TB0> INFO: 23283950 events read in total (862633ms).
[12:54:20.411] <TB0> INFO: 24166250 events read in total (895740ms).
[12:54:53.441] <TB0> INFO: 25049500 events read in total (928770ms).
[12:55:26.394] <TB0> INFO: 25942900 events read in total (961723ms).
[12:55:36.354] <TB0> INFO: 26208000 events read in total (971683ms).
[12:55:36.381] <TB0> INFO: Test took 972539ms.
[12:55:36.596] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:38.036] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:39.530] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:40.891] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:42.255] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:43.643] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:45.036] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:46.521] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:48.129] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:49.601] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:51.010] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:52.439] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:53.850] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:55.303] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:56.777] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:58.176] <TB0> INFO: dumping ASCII scurve output file: SCurveData
[12:55:59.604] <TB0> INFO: PixTestScurves::scurves() done
[12:55:59.604] <TB0> INFO: Vcal mean: 107.29 89.43 99.37 107.69 88.63 83.82 95.34 88.55 97.52 102.46 92.12 107.95 107.00 98.46 96.23 102.07
[12:55:59.604] <TB0> INFO: Vcal RMS: 5.02 5.77 5.22 5.45 5.29 4.27 5.56 4.90 5.42 7.32 5.63 5.81 5.93 5.59 5.28 5.10
[12:55:59.604] <TB0> INFO: PixTestScurves::fullTest() done, duration: 995 seconds
[12:55:59.604] <TB0> INFO: Decoding statistics:
[12:55:59.604] <TB0> INFO: General information:
[12:55:59.604] <TB0> INFO: 16bit words read: 0
[12:55:59.604] <TB0> INFO: valid events total: 0
[12:55:59.604] <TB0> INFO: empty events: 0
[12:55:59.604] <TB0> INFO: valid events with pixels: 0
[12:55:59.604] <TB0> INFO: valid pixel hits: 0
[12:55:59.604] <TB0> INFO: Event errors: 0
[12:55:59.604] <TB0> INFO: start marker: 0
[12:55:59.604] <TB0> INFO: stop marker: 0
[12:55:59.604] <TB0> INFO: overflow: 0
[12:55:59.604] <TB0> INFO: invalid 5bit words: 0
[12:55:59.604] <TB0> INFO: invalid XOR eye diagram: 0
[12:55:59.604] <TB0> INFO: frame (failed synchr.): 0
[12:55:59.604] <TB0> INFO: idle data (no TBM trl): 0
[12:55:59.604] <TB0> INFO: no data (only TBM hdr): 0
[12:55:59.604] <TB0> INFO: TBM errors: 0
[12:55:59.604] <TB0> INFO: flawed TBM headers: 0
[12:55:59.604] <TB0> INFO: flawed TBM trailers: 0
[12:55:59.604] <TB0> INFO: event ID mismatches: 0
[12:55:59.604] <TB0> INFO: ROC errors: 0
[12:55:59.604] <TB0> INFO: missing ROC header(s): 0
[12:55:59.604] <TB0> INFO: misplaced readback start: 0
[12:55:59.604] <TB0> INFO: Pixel decoding errors: 0
[12:55:59.604] <TB0> INFO: pixel data incomplete: 0
[12:55:59.604] <TB0> INFO: pixel address: 0
[12:55:59.604] <TB0> INFO: pulse height fill bit: 0
[12:55:59.604] <TB0> INFO: buffer corruption: 0
[12:55:59.685] <TB0> INFO: ######################################################################
[12:55:59.685] <TB0> INFO: PixTestTrim::doTest()
[12:55:59.685] <TB0> INFO: ######################################################################
[12:55:59.686] <TB0> INFO: ----------------------------------------------------------------------
[12:55:59.686] <TB0> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[12:55:59.686] <TB0> INFO: ----------------------------------------------------------------------
[12:55:59.771] <TB0> INFO: ---> VthrComp thr map (minimal VthrComp)
[12:55:59.771] <TB0> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[12:55:59.779] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[12:55:59.779] <TB0> INFO: run 1 of 1
[12:56:00.044] <TB0> INFO: Expecting 6281600 events.
[12:56:39.787] <TB0> INFO: 1067850 events read in total (39187ms).
[12:57:18.752] <TB0> INFO: 2128420 events read in total (78152ms).
[12:57:57.707] <TB0> INFO: 3178310 events read in total (117107ms).
[12:58:36.567] <TB0> INFO: 4234390 events read in total (155967ms).
[12:59:15.198] <TB0> INFO: 5291340 events read in total (194598ms).
[12:59:51.643] <TB0> INFO: 6281600 events read in total (231043ms).
[12:59:51.672] <TB0> INFO: Test took 231892ms.
[13:00:10.070] <TB0> INFO: ROC 0 VthrComp = 105
[13:00:10.070] <TB0> INFO: ROC 1 VthrComp = 92
[13:00:10.070] <TB0> INFO: ROC 2 VthrComp = 102
[13:00:10.070] <TB0> INFO: ROC 3 VthrComp = 104
[13:00:10.070] <TB0> INFO: ROC 4 VthrComp = 90
[13:00:10.070] <TB0> INFO: ROC 5 VthrComp = 87
[13:00:10.070] <TB0> INFO: ROC 6 VthrComp = 94
[13:00:10.071] <TB0> INFO: ROC 7 VthrComp = 89
[13:00:10.071] <TB0> INFO: ROC 8 VthrComp = 93
[13:00:10.071] <TB0> INFO: ROC 9 VthrComp = 95
[13:00:10.071] <TB0> INFO: ROC 10 VthrComp = 87
[13:00:10.071] <TB0> INFO: ROC 11 VthrComp = 101
[13:00:10.071] <TB0> INFO: ROC 12 VthrComp = 102
[13:00:10.071] <TB0> INFO: ROC 13 VthrComp = 94
[13:00:10.071] <TB0> INFO: ROC 14 VthrComp = 94
[13:00:10.071] <TB0> INFO: ROC 15 VthrComp = 100
[13:00:10.071] <TB0> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[13:00:10.071] <TB0> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:00:10.079] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:00:10.079] <TB0> INFO: run 1 of 1
[13:00:10.339] <TB0> INFO: Expecting 6281600 events.
[13:00:45.759] <TB0> INFO: 757500 events read in total (34864ms).
[13:01:20.755] <TB0> INFO: 1513530 events read in total (69860ms).
[13:01:55.592] <TB0> INFO: 2269300 events read in total (104697ms).
[13:02:30.562] <TB0> INFO: 3025580 events read in total (139667ms).
[13:03:05.561] <TB0> INFO: 3776420 events read in total (174666ms).
[13:03:40.283] <TB0> INFO: 4523540 events read in total (209388ms).
[13:04:15.329] <TB0> INFO: 5269380 events read in total (244434ms).
[13:04:50.498] <TB0> INFO: 6014950 events read in total (279603ms).
[13:05:03.223] <TB0> INFO: 6281600 events read in total (292328ms).
[13:05:03.270] <TB0> INFO: Test took 293191ms.
[13:05:28.444] <TB0> INFO: roc 0 with ID = 0 has maximal Vcal 59.8586 for pixel 12/7 mean/min/max = 47.4018/34.9306/59.8731
[13:05:28.444] <TB0> INFO: roc 1 with ID = 1 has maximal Vcal 58.6505 for pixel 17/5 mean/min/max = 46.0416/33.1185/58.9646
[13:05:28.445] <TB0> INFO: roc 2 with ID = 2 has maximal Vcal 57.0267 for pixel 28/79 mean/min/max = 44.6473/32.0565/57.238
[13:05:28.445] <TB0> INFO: roc 3 with ID = 3 has maximal Vcal 61.9097 for pixel 10/12 mean/min/max = 47.8581/33.7852/61.931
[13:05:28.445] <TB0> INFO: roc 4 with ID = 4 has maximal Vcal 58.4 for pixel 8/69 mean/min/max = 45.8271/33.2396/58.4146
[13:05:28.445] <TB0> INFO: roc 5 with ID = 5 has maximal Vcal 55.4648 for pixel 0/8 mean/min/max = 44.2476/32.8725/55.6227
[13:05:28.445] <TB0> INFO: roc 6 with ID = 6 has maximal Vcal 59.9168 for pixel 14/1 mean/min/max = 46.1758/32.3157/60.0359
[13:05:28.446] <TB0> INFO: roc 7 with ID = 7 has maximal Vcal 56.5289 for pixel 26/14 mean/min/max = 45.4296/34.0809/56.7783
[13:05:28.446] <TB0> INFO: roc 8 with ID = 8 has maximal Vcal 60.1543 for pixel 5/71 mean/min/max = 46.96/33.7288/60.1912
[13:05:28.446] <TB0> INFO: roc 9 with ID = 9 has maximal Vcal 67.6109 for pixel 0/15 mean/min/max = 48.7828/29.9468/67.6189
[13:05:28.446] <TB0> INFO: roc 10 with ID = 10 has maximal Vcal 61.2799 for pixel 4/79 mean/min/max = 46.7369/31.9952/61.4785
[13:05:28.447] <TB0> INFO: roc 11 with ID = 11 has maximal Vcal 63.2352 for pixel 4/78 mean/min/max = 47.5796/31.8956/63.2637
[13:05:28.447] <TB0> INFO: roc 12 with ID = 12 has maximal Vcal 61.4924 for pixel 5/72 mean/min/max = 46.8488/32.1174/61.5802
[13:05:28.447] <TB0> INFO: roc 13 with ID = 13 has maximal Vcal 60.1004 for pixel 13/3 mean/min/max = 46.2801/32.3687/60.1916
[13:05:28.447] <TB0> INFO: roc 14 with ID = 14 has maximal Vcal 58.9009 for pixel 16/69 mean/min/max = 46.3272/33.5857/59.0686
[13:05:28.447] <TB0> INFO: roc 15 with ID = 15 has maximal Vcal 59.0638 for pixel 0/78 mean/min/max = 46.0313/32.9693/59.0932
[13:05:28.448] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:05:28.535] <TB0> INFO: Expecting 514560 events.
[13:05:41.375] <TB0> INFO: 514560 events read in total (12284ms).
[13:05:41.380] <TB0> INFO: Expecting 514560 events.
[13:05:54.108] <TB0> INFO: 514560 events read in total (12305ms).
[13:05:54.114] <TB0> INFO: Expecting 514560 events.
[13:06:06.831] <TB0> INFO: 514560 events read in total (12299ms).
[13:06:06.839] <TB0> INFO: Expecting 514560 events.
[13:06:19.644] <TB0> INFO: 514560 events read in total (12381ms).
[13:06:19.654] <TB0> INFO: Expecting 514560 events.
[13:06:32.565] <TB0> INFO: 514560 events read in total (12492ms).
[13:06:32.577] <TB0> INFO: Expecting 514560 events.
[13:06:45.386] <TB0> INFO: 514560 events read in total (12393ms).
[13:06:45.400] <TB0> INFO: Expecting 514560 events.
[13:06:58.272] <TB0> INFO: 514560 events read in total (12453ms).
[13:06:58.287] <TB0> INFO: Expecting 514560 events.
[13:07:11.104] <TB0> INFO: 514560 events read in total (12415ms).
[13:07:11.121] <TB0> INFO: Expecting 514560 events.
[13:07:23.907] <TB0> INFO: 514560 events read in total (12377ms).
[13:07:23.925] <TB0> INFO: Expecting 514560 events.
[13:07:36.738] <TB0> INFO: 514560 events read in total (12402ms).
[13:07:36.758] <TB0> INFO: Expecting 514560 events.
[13:07:49.406] <TB0> INFO: 514560 events read in total (12244ms).
[13:07:49.430] <TB0> INFO: Expecting 514560 events.
[13:08:02.268] <TB0> INFO: 514560 events read in total (12429ms).
[13:08:02.295] <TB0> INFO: Expecting 514560 events.
[13:08:15.068] <TB0> INFO: 514560 events read in total (12371ms).
[13:08:15.094] <TB0> INFO: Expecting 514560 events.
[13:08:28.002] <TB0> INFO: 514560 events read in total (12507ms).
[13:08:28.032] <TB0> INFO: Expecting 514560 events.
[13:08:40.866] <TB0> INFO: 514560 events read in total (12433ms).
[13:08:40.900] <TB0> INFO: Expecting 514560 events.
[13:08:53.594] <TB0> INFO: 514560 events read in total (12292ms).
[13:08:53.628] <TB0> INFO: Test took 205180ms.
[13:08:54.471] <TB0> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[13:08:54.478] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:08:54.478] <TB0> INFO: run 1 of 1
[13:08:54.743] <TB0> INFO: Expecting 6281600 events.
[13:09:30.160] <TB0> INFO: 743810 events read in total (34861ms).
[13:10:05.051] <TB0> INFO: 1486490 events read in total (69752ms).
[13:10:39.786] <TB0> INFO: 2228990 events read in total (104487ms).
[13:11:14.771] <TB0> INFO: 2971670 events read in total (139472ms).
[13:11:49.439] <TB0> INFO: 3707670 events read in total (174140ms).
[13:12:24.141] <TB0> INFO: 4438770 events read in total (208842ms).
[13:12:58.951] <TB0> INFO: 5166380 events read in total (243652ms).
[13:13:33.928] <TB0> INFO: 5892930 events read in total (278629ms).
[13:13:52.859] <TB0> INFO: 6281600 events read in total (297560ms).
[13:13:52.916] <TB0> INFO: Test took 298437ms.
[13:14:18.804] <TB0> INFO: ---> TrimStepCorr4 extremal thresholds: 0.003254 .. 255.000000
[13:14:18.898] <TB0> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[13:14:18.907] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:14:18.907] <TB0> INFO: run 1 of 1
[13:14:19.192] <TB0> INFO: Expecting 10649600 events.
[13:14:54.948] <TB0> INFO: 712280 events read in total (35200ms).
[13:15:30.141] <TB0> INFO: 1425050 events read in total (70393ms).
[13:16:04.555] <TB0> INFO: 2137510 events read in total (104807ms).
[13:16:39.256] <TB0> INFO: 2850370 events read in total (139508ms).
[13:17:14.071] <TB0> INFO: 3563150 events read in total (174323ms).
[13:17:48.303] <TB0> INFO: 4276310 events read in total (208555ms).
[13:18:22.957] <TB0> INFO: 4989070 events read in total (243209ms).
[13:18:57.399] <TB0> INFO: 5702160 events read in total (277651ms).
[13:19:31.681] <TB0> INFO: 6414700 events read in total (311933ms).
[13:20:06.036] <TB0> INFO: 7126690 events read in total (346288ms).
[13:20:40.372] <TB0> INFO: 7838470 events read in total (380624ms).
[13:21:14.629] <TB0> INFO: 8549200 events read in total (414881ms).
[13:21:49.078] <TB0> INFO: 9260200 events read in total (449330ms).
[13:22:23.182] <TB0> INFO: 9970520 events read in total (483434ms).
[13:22:55.649] <TB0> INFO: 10649600 events read in total (515902ms).
[13:22:55.753] <TB0> INFO: Test took 516846ms.
[13:23:26.978] <TB0> INFO: ---> TrimStepCorr2 extremal thresholds: 15.944643 .. 45.078798
[13:23:27.069] <TB0> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 5 .. 55 (-1/-1) hits flags = 528 (plus default)
[13:23:27.077] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:23:27.077] <TB0> INFO: run 1 of 1
[13:23:27.336] <TB0> INFO: Expecting 2121600 events.
[13:24:05.797] <TB0> INFO: 937600 events read in total (37905ms).
[13:24:43.772] <TB0> INFO: 1873680 events read in total (75880ms).
[13:24:54.168] <TB0> INFO: 2121600 events read in total (86277ms).
[13:24:54.187] <TB0> INFO: Test took 87111ms.
[13:25:07.509] <TB0> INFO: ---> TrimStepCorr1a extremal thresholds: 0.994224 .. 41.459268
[13:25:07.584] <TB0> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 0 .. 51 (-1/-1) hits flags = 528 (plus default)
[13:25:07.591] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:25:07.592] <TB0> INFO: run 1 of 1
[13:25:07.856] <TB0> INFO: Expecting 2163200 events.
[13:25:47.757] <TB0> INFO: 1000450 events read in total (39345ms).
[13:26:26.903] <TB0> INFO: 1999900 events read in total (78491ms).
[13:26:33.531] <TB0> INFO: 2163200 events read in total (85119ms).
[13:26:33.544] <TB0> INFO: Test took 85953ms.
[13:26:47.255] <TB0> INFO: ---> TrimStepCorr1b extremal thresholds: 0.132211 .. 41.243174
[13:26:47.331] <TB0> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 0 .. 51 (-1/-1) hits flags = 528 (plus default)
[13:26:47.339] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:26:47.339] <TB0> INFO: run 1 of 1
[13:26:47.614] <TB0> INFO: Expecting 2163200 events.
[13:27:27.233] <TB0> INFO: 1000570 events read in total (39063ms).
[13:28:07.207] <TB0> INFO: 2001000 events read in total (79037ms).
[13:28:13.931] <TB0> INFO: 2163200 events read in total (85761ms).
[13:28:13.942] <TB0> INFO: Test took 86603ms.
[13:28:27.596] <TB0> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[13:28:27.596] <TB0> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[13:28:27.604] <TB0> INFO: dacScan split into 1 runs with ntrig = 10
[13:28:27.604] <TB0> INFO: run 1 of 1
[13:28:27.866] <TB0> INFO: Expecting 1705600 events.
[13:29:05.865] <TB0> INFO: 878480 events read in total (37443ms).
[13:29:41.627] <TB0> INFO: 1705600 events read in total (73205ms).
[13:29:41.645] <TB0> INFO: Test took 74042ms.
[13:29:56.823] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C0.dat
[13:29:56.823] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C1.dat
[13:29:56.824] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C2.dat
[13:29:56.824] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C3.dat
[13:29:56.824] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C4.dat
[13:29:56.824] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C5.dat
[13:29:56.824] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C6.dat
[13:29:56.824] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C7.dat
[13:29:56.824] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C8.dat
[13:29:56.824] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C9.dat
[13:29:56.825] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C10.dat
[13:29:56.825] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C11.dat
[13:29:56.825] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C12.dat
[13:29:56.825] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C13.dat
[13:29:56.825] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C14.dat
[13:29:56.825] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C15.dat
[13:29:56.825] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C0.dat
[13:29:56.834] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C1.dat
[13:29:56.840] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C2.dat
[13:29:56.847] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C3.dat
[13:29:56.853] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C4.dat
[13:29:56.860] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C5.dat
[13:29:56.866] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C6.dat
[13:29:56.873] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C7.dat
[13:29:56.879] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C8.dat
[13:29:56.885] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C9.dat
[13:29:56.891] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C10.dat
[13:29:56.898] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C11.dat
[13:29:56.904] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C12.dat
[13:29:56.910] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C13.dat
[13:29:56.919] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C14.dat
[13:29:56.926] <TB0> INFO: write trim parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//trimParameters35_C15.dat
[13:29:56.933] <TB0> INFO: PixTestTrim::trimTest() done
[13:29:56.933] <TB0> INFO: vtrim: 106 95 87 107 90 89 108 89 100 121 94 102 114 109 92 92
[13:29:56.933] <TB0> INFO: vthrcomp: 105 92 102 104 90 87 94 89 93 95 87 101 102 94 94 100
[13:29:56.933] <TB0> INFO: vcal mean: 34.98 35.01 34.97 34.97 35.01 35.00 35.01 34.97 34.97 34.91 34.93 34.99 34.97 34.96 34.99 34.95
[13:29:56.933] <TB0> INFO: vcal RMS: 0.86 0.86 0.83 1.02 0.84 0.81 0.86 0.97 0.98 1.37 1.18 0.91 1.08 0.90 0.86 0.87
[13:29:56.933] <TB0> INFO: bits mean: 8.74 9.19 9.53 9.05 9.31 9.70 9.39 9.31 9.06 9.17 9.26 9.14 9.69 9.40 9.13 8.87
[13:29:56.933] <TB0> INFO: bits RMS: 2.48 2.66 2.78 2.47 2.61 2.63 2.71 2.49 2.57 2.89 2.74 2.73 2.52 2.64 2.63 2.88
[13:29:56.939] <TB0> INFO: ----------------------------------------------------------------------
[13:29:56.939] <TB0> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[13:29:56.940] <TB0> INFO: ----------------------------------------------------------------------
[13:29:56.942] <TB0> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[13:29:56.950] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:29:56.950] <TB0> INFO: run 1 of 1
[13:29:57.214] <TB0> INFO: Expecting 4160000 events.
[13:30:39.846] <TB0> INFO: 952040 events read in total (42076ms).
[13:31:21.796] <TB0> INFO: 1895085 events read in total (84026ms).
[13:32:03.093] <TB0> INFO: 2828650 events read in total (125324ms).
[13:32:44.865] <TB0> INFO: 3758360 events read in total (167095ms).
[13:33:02.931] <TB0> INFO: 4160000 events read in total (185161ms).
[13:33:02.971] <TB0> INFO: Test took 186021ms.
[13:33:33.505] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 185 (-1/-1) hits flags = 528 (plus default)
[13:33:33.513] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:33:33.513] <TB0> INFO: run 1 of 1
[13:33:33.774] <TB0> INFO: Expecting 3868800 events.
[13:34:16.251] <TB0> INFO: 946340 events read in total (41921ms).
[13:34:58.356] <TB0> INFO: 1884025 events read in total (84026ms).
[13:35:40.329] <TB0> INFO: 2811100 events read in total (126000ms).
[13:36:22.057] <TB0> INFO: 3736475 events read in total (167727ms).
[13:36:28.467] <TB0> INFO: 3868800 events read in total (174137ms).
[13:36:28.494] <TB0> INFO: Test took 174982ms.
[13:36:56.711] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 172 (-1/-1) hits flags = 528 (plus default)
[13:36:56.719] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:36:56.719] <TB0> INFO: run 1 of 1
[13:36:56.978] <TB0> INFO: Expecting 3598400 events.
[13:37:39.727] <TB0> INFO: 976725 events read in total (42193ms).
[13:38:22.574] <TB0> INFO: 1942290 events read in total (85040ms).
[13:39:04.663] <TB0> INFO: 2896210 events read in total (127129ms).
[13:39:36.014] <TB0> INFO: 3598400 events read in total (158480ms).
[13:39:36.063] <TB0> INFO: Test took 159344ms.
[13:40:02.684] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 170 (-1/-1) hits flags = 528 (plus default)
[13:40:02.692] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:40:02.692] <TB0> INFO: run 1 of 1
[13:40:02.980] <TB0> INFO: Expecting 3556800 events.
[13:40:45.851] <TB0> INFO: 981400 events read in total (42315ms).
[13:41:27.842] <TB0> INFO: 1950870 events read in total (84307ms).
[13:42:10.069] <TB0> INFO: 2908820 events read in total (126534ms).
[13:42:38.919] <TB0> INFO: 3556800 events read in total (155383ms).
[13:42:38.951] <TB0> INFO: Test took 156259ms.
[13:43:04.413] <TB0> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 175 (-1/-1) hits flags = 528 (plus default)
[13:43:04.421] <TB0> INFO: dacScan split into 1 runs with ntrig = 5
[13:43:04.421] <TB0> INFO: run 1 of 1
[13:43:04.681] <TB0> INFO: Expecting 3660800 events.
[13:43:47.437] <TB0> INFO: 967855 events read in total (42200ms).
[13:44:30.358] <TB0> INFO: 1925145 events read in total (85121ms).
[13:45:13.250] <TB0> INFO: 2871230 events read in total (128014ms).
[13:45:49.271] <TB0> INFO: 3660800 events read in total (164034ms).
[13:45:49.310] <TB0> INFO: Test took 164889ms.
[13:46:14.976] <TB0> INFO: PixTestTrim::trimBitTest() done
[13:46:14.977] <TB0> INFO: PixTestTrim::doTest() done, duration: 3015 seconds
[13:46:14.977] <TB0> INFO: Decoding statistics:
[13:46:14.977] <TB0> INFO: General information:
[13:46:14.978] <TB0> INFO: 16bit words read: 0
[13:46:14.978] <TB0> INFO: valid events total: 0
[13:46:14.978] <TB0> INFO: empty events: 0
[13:46:14.978] <TB0> INFO: valid events with pixels: 0
[13:46:14.978] <TB0> INFO: valid pixel hits: 0
[13:46:14.978] <TB0> INFO: Event errors: 0
[13:46:14.978] <TB0> INFO: start marker: 0
[13:46:14.978] <TB0> INFO: stop marker: 0
[13:46:14.978] <TB0> INFO: overflow: 0
[13:46:14.978] <TB0> INFO: invalid 5bit words: 0
[13:46:14.978] <TB0> INFO: invalid XOR eye diagram: 0
[13:46:14.978] <TB0> INFO: frame (failed synchr.): 0
[13:46:14.978] <TB0> INFO: idle data (no TBM trl): 0
[13:46:14.978] <TB0> INFO: no data (only TBM hdr): 0
[13:46:14.978] <TB0> INFO: TBM errors: 0
[13:46:14.978] <TB0> INFO: flawed TBM headers: 0
[13:46:14.978] <TB0> INFO: flawed TBM trailers: 0
[13:46:14.978] <TB0> INFO: event ID mismatches: 0
[13:46:14.978] <TB0> INFO: ROC errors: 0
[13:46:14.978] <TB0> INFO: missing ROC header(s): 0
[13:46:14.978] <TB0> INFO: misplaced readback start: 0
[13:46:14.978] <TB0> INFO: Pixel decoding errors: 0
[13:46:14.978] <TB0> INFO: pixel data incomplete: 0
[13:46:14.978] <TB0> INFO: pixel address: 0
[13:46:14.978] <TB0> INFO: pulse height fill bit: 0
[13:46:14.978] <TB0> INFO: buffer corruption: 0
[13:46:15.649] <TB0> INFO: ######################################################################
[13:46:15.649] <TB0> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[13:46:15.649] <TB0> INFO: ######################################################################
[13:46:15.909] <TB0> INFO: Expecting 41600 events.
[13:46:19.677] <TB0> INFO: 41600 events read in total (3211ms).
[13:46:19.677] <TB0> INFO: Test took 4027ms.
[13:46:20.142] <TB0> INFO: Expecting 41600 events.
[13:46:23.955] <TB0> INFO: 41600 events read in total (3257ms).
[13:46:23.955] <TB0> INFO: Test took 4073ms.
[13:46:24.249] <TB0> INFO: Expecting 41600 events.
[13:46:28.097] <TB0> INFO: 41600 events read in total (3292ms).
[13:46:28.097] <TB0> INFO: Test took 4120ms.
[13:46:28.352] <TB0> INFO: Expecting 2560 events.
[13:46:29.205] <TB0> INFO: 2560 events read in total (297ms).
[13:46:29.205] <TB0> INFO: Test took 1095ms.
[13:46:29.510] <TB0> INFO: Expecting 2560 events.
[13:46:30.362] <TB0> INFO: 2560 events read in total (296ms).
[13:46:30.363] <TB0> INFO: Test took 1158ms.
[13:46:30.668] <TB0> INFO: Expecting 2560 events.
[13:46:31.527] <TB0> INFO: 2560 events read in total (303ms).
[13:46:31.527] <TB0> INFO: Test took 1164ms.
[13:46:31.832] <TB0> INFO: Expecting 2560 events.
[13:46:32.684] <TB0> INFO: 2560 events read in total (296ms).
[13:46:32.684] <TB0> INFO: Test took 1157ms.
[13:46:32.989] <TB0> INFO: Expecting 2560 events.
[13:46:33.846] <TB0> INFO: 2560 events read in total (301ms).
[13:46:33.846] <TB0> INFO: Test took 1162ms.
[13:46:34.151] <TB0> INFO: Expecting 2560 events.
[13:46:35.005] <TB0> INFO: 2560 events read in total (298ms).
[13:46:35.005] <TB0> INFO: Test took 1159ms.
[13:46:35.311] <TB0> INFO: Expecting 2560 events.
[13:46:36.165] <TB0> INFO: 2560 events read in total (298ms).
[13:46:36.165] <TB0> INFO: Test took 1159ms.
[13:46:36.470] <TB0> INFO: Expecting 2560 events.
[13:46:37.323] <TB0> INFO: 2560 events read in total (297ms).
[13:46:37.323] <TB0> INFO: Test took 1158ms.
[13:46:37.627] <TB0> INFO: Expecting 2560 events.
[13:46:38.481] <TB0> INFO: 2560 events read in total (297ms).
[13:46:38.481] <TB0> INFO: Test took 1157ms.
[13:46:38.786] <TB0> INFO: Expecting 2560 events.
[13:46:39.641] <TB0> INFO: 2560 events read in total (299ms).
[13:46:39.641] <TB0> INFO: Test took 1160ms.
[13:46:39.946] <TB0> INFO: Expecting 2560 events.
[13:46:40.804] <TB0> INFO: 2560 events read in total (302ms).
[13:46:40.805] <TB0> INFO: Test took 1164ms.
[13:46:41.110] <TB0> INFO: Expecting 2560 events.
[13:46:41.965] <TB0> INFO: 2560 events read in total (299ms).
[13:46:41.965] <TB0> INFO: Test took 1160ms.
[13:46:42.269] <TB0> INFO: Expecting 2560 events.
[13:46:43.123] <TB0> INFO: 2560 events read in total (297ms).
[13:46:43.123] <TB0> INFO: Test took 1157ms.
[13:46:43.428] <TB0> INFO: Expecting 2560 events.
[13:46:44.282] <TB0> INFO: 2560 events read in total (297ms).
[13:46:44.282] <TB0> INFO: Test took 1158ms.
[13:46:44.587] <TB0> INFO: Expecting 2560 events.
[13:46:45.440] <TB0> INFO: 2560 events read in total (296ms).
[13:46:45.440] <TB0> INFO: Test took 1158ms.
[13:46:45.746] <TB0> INFO: Expecting 2560 events.
[13:46:46.599] <TB0> INFO: 2560 events read in total (297ms).
[13:46:46.599] <TB0> INFO: Test took 1158ms.
[13:46:46.603] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:46:46.905] <TB0> INFO: Expecting 655360 events.
[13:47:03.654] <TB0> INFO: 655360 events read in total (16193ms).
[13:47:03.663] <TB0> INFO: Expecting 655360 events.
[13:47:20.221] <TB0> INFO: 655360 events read in total (16157ms).
[13:47:20.233] <TB0> INFO: Expecting 655360 events.
[13:47:36.988] <TB0> INFO: 655360 events read in total (16355ms).
[13:47:37.008] <TB0> INFO: Expecting 655360 events.
[13:47:53.780] <TB0> INFO: 655360 events read in total (16370ms).
[13:47:53.798] <TB0> INFO: Expecting 655360 events.
[13:48:10.586] <TB0> INFO: 655360 events read in total (16386ms).
[13:48:10.609] <TB0> INFO: Expecting 655360 events.
[13:48:27.296] <TB0> INFO: 655360 events read in total (16285ms).
[13:48:27.323] <TB0> INFO: Expecting 655360 events.
[13:48:44.027] <TB0> INFO: 655360 events read in total (16302ms).
[13:48:44.062] <TB0> INFO: Expecting 655360 events.
[13:49:00.897] <TB0> INFO: 655360 events read in total (16433ms).
[13:49:00.930] <TB0> INFO: Expecting 655360 events.
[13:49:17.696] <TB0> INFO: 655360 events read in total (16365ms).
[13:49:17.734] <TB0> INFO: Expecting 655360 events.
[13:49:34.547] <TB0> INFO: 655360 events read in total (16411ms).
[13:49:34.588] <TB0> INFO: Expecting 655360 events.
[13:49:51.314] <TB0> INFO: 655360 events read in total (16324ms).
[13:49:51.357] <TB0> INFO: Expecting 655360 events.
[13:50:08.202] <TB0> INFO: 655360 events read in total (16443ms).
[13:50:08.251] <TB0> INFO: Expecting 655360 events.
[13:50:24.938] <TB0> INFO: 655360 events read in total (16285ms).
[13:50:24.989] <TB0> INFO: Expecting 655360 events.
[13:50:41.728] <TB0> INFO: 655360 events read in total (16337ms).
[13:50:41.787] <TB0> INFO: Expecting 655360 events.
[13:50:58.681] <TB0> INFO: 655360 events read in total (16492ms).
[13:50:58.739] <TB0> INFO: Expecting 655360 events.
[13:51:15.638] <TB0> INFO: 655360 events read in total (16498ms).
[13:51:15.701] <TB0> INFO: Test took 269099ms.
[13:51:15.787] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:51:16.017] <TB0> INFO: Expecting 655360 events.
[13:51:32.889] <TB0> INFO: 655360 events read in total (16316ms).
[13:51:32.898] <TB0> INFO: Expecting 655360 events.
[13:51:49.588] <TB0> INFO: 655360 events read in total (16288ms).
[13:51:49.600] <TB0> INFO: Expecting 655360 events.
[13:52:06.440] <TB0> INFO: 655360 events read in total (16438ms).
[13:52:06.460] <TB0> INFO: Expecting 655360 events.
[13:52:23.099] <TB0> INFO: 655360 events read in total (16237ms).
[13:52:23.118] <TB0> INFO: Expecting 655360 events.
[13:52:39.779] <TB0> INFO: 655360 events read in total (16259ms).
[13:52:39.801] <TB0> INFO: Expecting 655360 events.
[13:52:56.349] <TB0> INFO: 655360 events read in total (16146ms).
[13:52:56.375] <TB0> INFO: Expecting 655360 events.
[13:53:13.067] <TB0> INFO: 655360 events read in total (16290ms).
[13:53:13.101] <TB0> INFO: Expecting 655360 events.
[13:53:29.791] <TB0> INFO: 655360 events read in total (16288ms).
[13:53:29.824] <TB0> INFO: Expecting 655360 events.
[13:53:46.657] <TB0> INFO: 655360 events read in total (16431ms).
[13:53:46.694] <TB0> INFO: Expecting 655360 events.
[13:54:03.417] <TB0> INFO: 655360 events read in total (16322ms).
[13:54:03.458] <TB0> INFO: Expecting 655360 events.
[13:54:20.162] <TB0> INFO: 655360 events read in total (16303ms).
[13:54:20.206] <TB0> INFO: Expecting 655360 events.
[13:54:36.808] <TB0> INFO: 655360 events read in total (16200ms).
[13:54:36.855] <TB0> INFO: Expecting 655360 events.
[13:54:53.392] <TB0> INFO: 655360 events read in total (16136ms).
[13:54:53.451] <TB0> INFO: Expecting 655360 events.
[13:55:10.182] <TB0> INFO: 655360 events read in total (16329ms).
[13:55:10.239] <TB0> INFO: Expecting 655360 events.
[13:55:27.010] <TB0> INFO: 655360 events read in total (16370ms).
[13:55:27.076] <TB0> INFO: Expecting 655360 events.
[13:55:44.014] <TB0> INFO: 655360 events read in total (16536ms).
[13:55:44.077] <TB0> INFO: Test took 268290ms.
[13:55:44.264] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.271] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.278] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.285] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.291] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.299] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.306] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.313] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[13:55:44.319] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.326] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.332] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.339] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.345] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.352] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.358] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.365] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.372] <TB0> INFO: safety margin for low PH: adding 1, margin is now 21
[13:55:44.378] <TB0> INFO: safety margin for low PH: adding 2, margin is now 22
[13:55:44.386] <TB0> INFO: safety margin for low PH: adding 3, margin is now 23
[13:55:44.393] <TB0> INFO: safety margin for low PH: adding 0, margin is now 20
[13:55:44.434] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C0.dat
[13:55:44.434] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C1.dat
[13:55:44.435] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C2.dat
[13:55:44.435] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C3.dat
[13:55:44.435] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C4.dat
[13:55:44.435] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C5.dat
[13:55:44.436] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C6.dat
[13:55:44.436] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C7.dat
[13:55:44.436] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C8.dat
[13:55:44.436] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C9.dat
[13:55:44.436] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C10.dat
[13:55:44.437] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C11.dat
[13:55:44.437] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C12.dat
[13:55:44.437] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C13.dat
[13:55:44.437] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C14.dat
[13:55:44.437] <TB0> INFO: write dac parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//dacParameters35_C15.dat
[13:55:44.711] <TB0> INFO: Expecting 41600 events.
[13:55:48.201] <TB0> INFO: 41600 events read in total (2934ms).
[13:55:48.202] <TB0> INFO: Test took 3761ms.
[13:55:48.657] <TB0> INFO: Expecting 41600 events.
[13:55:52.202] <TB0> INFO: 41600 events read in total (2989ms).
[13:55:52.202] <TB0> INFO: Test took 3823ms.
[13:55:52.647] <TB0> INFO: Expecting 41600 events.
[13:55:56.167] <TB0> INFO: 41600 events read in total (2964ms).
[13:55:56.168] <TB0> INFO: Test took 3785ms.
[13:55:56.352] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:55:56.440] <TB0> INFO: Expecting 2560 events.
[13:55:57.296] <TB0> INFO: 2560 events read in total (300ms).
[13:55:57.297] <TB0> INFO: Test took 945ms.
[13:55:57.299] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:55:57.602] <TB0> INFO: Expecting 2560 events.
[13:55:58.456] <TB0> INFO: 2560 events read in total (298ms).
[13:55:58.457] <TB0> INFO: Test took 1158ms.
[13:55:58.458] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:55:58.763] <TB0> INFO: Expecting 2560 events.
[13:55:59.622] <TB0> INFO: 2560 events read in total (303ms).
[13:55:59.622] <TB0> INFO: Test took 1164ms.
[13:55:59.624] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:55:59.927] <TB0> INFO: Expecting 2560 events.
[13:56:00.784] <TB0> INFO: 2560 events read in total (300ms).
[13:56:00.785] <TB0> INFO: Test took 1161ms.
[13:56:00.787] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:01.090] <TB0> INFO: Expecting 2560 events.
[13:56:01.944] <TB0> INFO: 2560 events read in total (298ms).
[13:56:01.945] <TB0> INFO: Test took 1159ms.
[13:56:01.947] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:02.249] <TB0> INFO: Expecting 2560 events.
[13:56:03.108] <TB0> INFO: 2560 events read in total (302ms).
[13:56:03.108] <TB0> INFO: Test took 1161ms.
[13:56:03.111] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:03.412] <TB0> INFO: Expecting 2560 events.
[13:56:04.271] <TB0> INFO: 2560 events read in total (302ms).
[13:56:04.271] <TB0> INFO: Test took 1160ms.
[13:56:04.273] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:04.577] <TB0> INFO: Expecting 2560 events.
[13:56:05.429] <TB0> INFO: 2560 events read in total (296ms).
[13:56:05.430] <TB0> INFO: Test took 1157ms.
[13:56:05.431] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:05.736] <TB0> INFO: Expecting 2560 events.
[13:56:06.595] <TB0> INFO: 2560 events read in total (303ms).
[13:56:06.595] <TB0> INFO: Test took 1164ms.
[13:56:06.597] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:06.900] <TB0> INFO: Expecting 2560 events.
[13:56:07.754] <TB0> INFO: 2560 events read in total (298ms).
[13:56:07.754] <TB0> INFO: Test took 1157ms.
[13:56:07.755] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:08.060] <TB0> INFO: Expecting 2560 events.
[13:56:08.913] <TB0> INFO: 2560 events read in total (297ms).
[13:56:08.913] <TB0> INFO: Test took 1158ms.
[13:56:08.915] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:09.219] <TB0> INFO: Expecting 2560 events.
[13:56:10.076] <TB0> INFO: 2560 events read in total (301ms).
[13:56:10.076] <TB0> INFO: Test took 1161ms.
[13:56:10.077] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:10.382] <TB0> INFO: Expecting 2560 events.
[13:56:11.235] <TB0> INFO: 2560 events read in total (297ms).
[13:56:11.235] <TB0> INFO: Test took 1158ms.
[13:56:11.237] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:11.541] <TB0> INFO: Expecting 2560 events.
[13:56:12.395] <TB0> INFO: 2560 events read in total (298ms).
[13:56:12.395] <TB0> INFO: Test took 1158ms.
[13:56:12.397] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:12.700] <TB0> INFO: Expecting 2560 events.
[13:56:13.554] <TB0> INFO: 2560 events read in total (298ms).
[13:56:13.554] <TB0> INFO: Test took 1158ms.
[13:56:13.556] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:13.859] <TB0> INFO: Expecting 2560 events.
[13:56:14.713] <TB0> INFO: 2560 events read in total (298ms).
[13:56:14.713] <TB0> INFO: Test took 1157ms.
[13:56:14.716] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:15.019] <TB0> INFO: Expecting 2560 events.
[13:56:15.877] <TB0> INFO: 2560 events read in total (301ms).
[13:56:15.877] <TB0> INFO: Test took 1161ms.
[13:56:15.880] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:16.183] <TB0> INFO: Expecting 2560 events.
[13:56:17.038] <TB0> INFO: 2560 events read in total (299ms).
[13:56:17.039] <TB0> INFO: Test took 1160ms.
[13:56:17.041] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:17.344] <TB0> INFO: Expecting 2560 events.
[13:56:18.199] <TB0> INFO: 2560 events read in total (299ms).
[13:56:18.199] <TB0> INFO: Test took 1158ms.
[13:56:18.201] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:18.505] <TB0> INFO: Expecting 2560 events.
[13:56:19.362] <TB0> INFO: 2560 events read in total (301ms).
[13:56:19.363] <TB0> INFO: Test took 1162ms.
[13:56:19.364] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:19.668] <TB0> INFO: Expecting 2560 events.
[13:56:20.521] <TB0> INFO: 2560 events read in total (297ms).
[13:56:20.521] <TB0> INFO: Test took 1157ms.
[13:56:20.522] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:20.827] <TB0> INFO: Expecting 2560 events.
[13:56:21.680] <TB0> INFO: 2560 events read in total (297ms).
[13:56:21.681] <TB0> INFO: Test took 1159ms.
[13:56:21.682] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:21.987] <TB0> INFO: Expecting 2560 events.
[13:56:22.844] <TB0> INFO: 2560 events read in total (301ms).
[13:56:22.844] <TB0> INFO: Test took 1162ms.
[13:56:22.846] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:23.150] <TB0> INFO: Expecting 2560 events.
[13:56:24.007] <TB0> INFO: 2560 events read in total (301ms).
[13:56:24.007] <TB0> INFO: Test took 1161ms.
[13:56:24.009] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:24.312] <TB0> INFO: Expecting 2560 events.
[13:56:25.167] <TB0> INFO: 2560 events read in total (299ms).
[13:56:25.167] <TB0> INFO: Test took 1159ms.
[13:56:25.169] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:25.472] <TB0> INFO: Expecting 2560 events.
[13:56:26.327] <TB0> INFO: 2560 events read in total (298ms).
[13:56:26.327] <TB0> INFO: Test took 1158ms.
[13:56:26.330] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:26.633] <TB0> INFO: Expecting 2560 events.
[13:56:27.486] <TB0> INFO: 2560 events read in total (297ms).
[13:56:27.486] <TB0> INFO: Test took 1156ms.
[13:56:27.488] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:27.793] <TB0> INFO: Expecting 2560 events.
[13:56:28.646] <TB0> INFO: 2560 events read in total (297ms).
[13:56:28.646] <TB0> INFO: Test took 1158ms.
[13:56:28.648] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:28.952] <TB0> INFO: Expecting 2560 events.
[13:56:29.807] <TB0> INFO: 2560 events read in total (299ms).
[13:56:29.807] <TB0> INFO: Test took 1159ms.
[13:56:29.809] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:30.113] <TB0> INFO: Expecting 2560 events.
[13:56:30.967] <TB0> INFO: 2560 events read in total (298ms).
[13:56:30.967] <TB0> INFO: Test took 1158ms.
[13:56:30.970] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:31.272] <TB0> INFO: Expecting 2560 events.
[13:56:32.130] <TB0> INFO: 2560 events read in total (302ms).
[13:56:32.131] <TB0> INFO: Test took 1161ms.
[13:56:32.132] <TB0> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:56:32.437] <TB0> INFO: Expecting 2560 events.
[13:56:33.290] <TB0> INFO: 2560 events read in total (297ms).
[13:56:33.291] <TB0> INFO: Test took 1159ms.
[13:56:33.750] <TB0> INFO: PixTestPhOptimization::doTest() done, duration: 618 seconds
[13:56:33.750] <TB0> INFO: PH scale (per ROC): 74 71 77 69 74 79 68 67 74 68 65 64 66 71 80 72
[13:56:33.750] <TB0> INFO: PH offset (per ROC): 178 178 181 174 177 189 189 174 179 192 189 186 197 175 190 182
[13:56:33.756] <TB0> INFO: Decoding statistics:
[13:56:33.756] <TB0> INFO: General information:
[13:56:33.756] <TB0> INFO: 16bit words read: 91928
[13:56:33.756] <TB0> INFO: valid events total: 10240
[13:56:33.756] <TB0> INFO: empty events: 7738
[13:56:33.756] <TB0> INFO: valid events with pixels: 2502
[13:56:33.756] <TB0> INFO: valid pixel hits: 2502
[13:56:33.756] <TB0> INFO: Event errors: 0
[13:56:33.756] <TB0> INFO: start marker: 0
[13:56:33.756] <TB0> INFO: stop marker: 0
[13:56:33.756] <TB0> INFO: overflow: 0
[13:56:33.756] <TB0> INFO: invalid 5bit words: 0
[13:56:33.756] <TB0> INFO: invalid XOR eye diagram: 0
[13:56:33.756] <TB0> INFO: frame (failed synchr.): 0
[13:56:33.756] <TB0> INFO: idle data (no TBM trl): 0
[13:56:33.756] <TB0> INFO: no data (only TBM hdr): 0
[13:56:33.756] <TB0> INFO: TBM errors: 0
[13:56:33.756] <TB0> INFO: flawed TBM headers: 0
[13:56:33.756] <TB0> INFO: flawed TBM trailers: 0
[13:56:33.756] <TB0> INFO: event ID mismatches: 0
[13:56:33.756] <TB0> INFO: ROC errors: 0
[13:56:33.756] <TB0> INFO: missing ROC header(s): 0
[13:56:33.756] <TB0> INFO: misplaced readback start: 0
[13:56:33.756] <TB0> INFO: Pixel decoding errors: 0
[13:56:33.756] <TB0> INFO: pixel data incomplete: 0
[13:56:33.756] <TB0> INFO: pixel address: 0
[13:56:33.756] <TB0> INFO: pulse height fill bit: 0
[13:56:33.756] <TB0> INFO: buffer corruption: 0
[13:56:33.929] <TB0> INFO: ######################################################################
[13:56:33.929] <TB0> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[13:56:33.929] <TB0> INFO: ######################################################################
[13:56:33.939] <TB0> INFO: scanning low vcal = 10
[13:56:34.202] <TB0> INFO: Expecting 41600 events.
[13:56:37.742] <TB0> INFO: 41600 events read in total (2984ms).
[13:56:37.743] <TB0> INFO: Test took 3804ms.
[13:56:37.744] <TB0> INFO: scanning low vcal = 20
[13:56:38.048] <TB0> INFO: Expecting 41600 events.
[13:56:41.592] <TB0> INFO: 41600 events read in total (2988ms).
[13:56:41.592] <TB0> INFO: Test took 3848ms.
[13:56:41.594] <TB0> INFO: scanning low vcal = 30
[13:56:41.905] <TB0> INFO: Expecting 41600 events.
[13:56:45.454] <TB0> INFO: 41600 events read in total (2993ms).
[13:56:45.455] <TB0> INFO: Test took 3861ms.
[13:56:45.457] <TB0> INFO: scanning low vcal = 40
[13:56:45.752] <TB0> INFO: Expecting 41600 events.
[13:56:49.918] <TB0> INFO: 41600 events read in total (3610ms).
[13:56:49.919] <TB0> INFO: Test took 4462ms.
[13:56:49.922] <TB0> INFO: scanning low vcal = 50
[13:56:50.211] <TB0> INFO: Expecting 41600 events.
[13:56:54.392] <TB0> INFO: 41600 events read in total (3624ms).
[13:56:54.392] <TB0> INFO: Test took 4470ms.
[13:56:54.395] <TB0> INFO: scanning low vcal = 60
[13:56:54.658] <TB0> INFO: Expecting 41600 events.
[13:56:58.856] <TB0> INFO: 41600 events read in total (3642ms).
[13:56:58.857] <TB0> INFO: Test took 4462ms.
[13:56:58.859] <TB0> INFO: scanning low vcal = 70
[13:56:59.143] <TB0> INFO: Expecting 41600 events.
[13:57:03.355] <TB0> INFO: 41600 events read in total (3656ms).
[13:57:03.355] <TB0> INFO: Test took 4496ms.
[13:57:03.358] <TB0> INFO: scanning low vcal = 80
[13:57:03.622] <TB0> INFO: Expecting 41600 events.
[13:57:07.808] <TB0> INFO: 41600 events read in total (3630ms).
[13:57:07.808] <TB0> INFO: Test took 4450ms.
[13:57:07.811] <TB0> INFO: scanning low vcal = 90
[13:57:08.071] <TB0> INFO: Expecting 41600 events.
[13:57:12.278] <TB0> INFO: 41600 events read in total (3650ms).
[13:57:12.279] <TB0> INFO: Test took 4468ms.
[13:57:12.281] <TB0> INFO: scanning low vcal = 100
[13:57:12.545] <TB0> INFO: Expecting 41600 events.
[13:57:16.756] <TB0> INFO: 41600 events read in total (3655ms).
[13:57:16.756] <TB0> INFO: Test took 4475ms.
[13:57:16.759] <TB0> INFO: scanning low vcal = 110
[13:57:17.035] <TB0> INFO: Expecting 41600 events.
[13:57:21.247] <TB0> INFO: 41600 events read in total (3655ms).
[13:57:21.248] <TB0> INFO: Test took 4489ms.
[13:57:21.250] <TB0> INFO: scanning low vcal = 120
[13:57:21.521] <TB0> INFO: Expecting 41600 events.
[13:57:25.748] <TB0> INFO: 41600 events read in total (3670ms).
[13:57:25.749] <TB0> INFO: Test took 4498ms.
[13:57:25.752] <TB0> INFO: scanning low vcal = 130
[13:57:26.033] <TB0> INFO: Expecting 41600 events.
[13:57:30.250] <TB0> INFO: 41600 events read in total (3661ms).
[13:57:30.251] <TB0> INFO: Test took 4499ms.
[13:57:30.253] <TB0> INFO: scanning low vcal = 140
[13:57:30.516] <TB0> INFO: Expecting 41600 events.
[13:57:34.722] <TB0> INFO: 41600 events read in total (3650ms).
[13:57:34.722] <TB0> INFO: Test took 4469ms.
[13:57:34.724] <TB0> INFO: scanning low vcal = 150
[13:57:34.988] <TB0> INFO: Expecting 41600 events.
[13:57:39.210] <TB0> INFO: 41600 events read in total (3666ms).
[13:57:39.211] <TB0> INFO: Test took 4486ms.
[13:57:39.213] <TB0> INFO: scanning low vcal = 160
[13:57:39.477] <TB0> INFO: Expecting 41600 events.
[13:57:43.692] <TB0> INFO: 41600 events read in total (3659ms).
[13:57:43.692] <TB0> INFO: Test took 4479ms.
[13:57:43.695] <TB0> INFO: scanning low vcal = 170
[13:57:43.958] <TB0> INFO: Expecting 41600 events.
[13:57:48.180] <TB0> INFO: 41600 events read in total (3666ms).
[13:57:48.180] <TB0> INFO: Test took 4485ms.
[13:57:48.184] <TB0> INFO: scanning low vcal = 180
[13:57:48.444] <TB0> INFO: Expecting 41600 events.
[13:57:52.655] <TB0> INFO: 41600 events read in total (3655ms).
[13:57:52.656] <TB0> INFO: Test took 4472ms.
[13:57:52.658] <TB0> INFO: scanning low vcal = 190
[13:57:52.925] <TB0> INFO: Expecting 41600 events.
[13:57:57.162] <TB0> INFO: 41600 events read in total (3681ms).
[13:57:57.162] <TB0> INFO: Test took 4504ms.
[13:57:57.165] <TB0> INFO: scanning low vcal = 200
[13:57:57.429] <TB0> INFO: Expecting 41600 events.
[13:58:01.638] <TB0> INFO: 41600 events read in total (3653ms).
[13:58:01.638] <TB0> INFO: Test took 4473ms.
[13:58:01.641] <TB0> INFO: scanning low vcal = 210
[13:58:01.923] <TB0> INFO: Expecting 41600 events.
[13:58:06.118] <TB0> INFO: 41600 events read in total (3639ms).
[13:58:06.119] <TB0> INFO: Test took 4478ms.
[13:58:06.121] <TB0> INFO: scanning low vcal = 220
[13:58:06.380] <TB0> INFO: Expecting 41600 events.
[13:58:10.603] <TB0> INFO: 41600 events read in total (3667ms).
[13:58:10.603] <TB0> INFO: Test took 4481ms.
[13:58:10.606] <TB0> INFO: scanning low vcal = 230
[13:58:10.888] <TB0> INFO: Expecting 41600 events.
[13:58:15.059] <TB0> INFO: 41600 events read in total (3615ms).
[13:58:15.059] <TB0> INFO: Test took 4453ms.
[13:58:15.062] <TB0> INFO: scanning low vcal = 240
[13:58:15.324] <TB0> INFO: Expecting 41600 events.
[13:58:19.505] <TB0> INFO: 41600 events read in total (3625ms).
[13:58:19.506] <TB0> INFO: Test took 4444ms.
[13:58:19.508] <TB0> INFO: scanning low vcal = 250
[13:58:19.769] <TB0> INFO: Expecting 41600 events.
[13:58:23.972] <TB0> INFO: 41600 events read in total (3647ms).
[13:58:23.972] <TB0> INFO: Test took 4463ms.
[13:58:23.976] <TB0> INFO: scanning high vcal = 30 (= 210 in low range)
[13:58:24.243] <TB0> INFO: Expecting 41600 events.
[13:58:28.453] <TB0> INFO: 41600 events read in total (3654ms).
[13:58:28.453] <TB0> INFO: Test took 4477ms.
[13:58:28.456] <TB0> INFO: scanning high vcal = 50 (= 350 in low range)
[13:58:28.715] <TB0> INFO: Expecting 41600 events.
[13:58:32.972] <TB0> INFO: 41600 events read in total (3701ms).
[13:58:32.973] <TB0> INFO: Test took 4517ms.
[13:58:32.975] <TB0> INFO: scanning high vcal = 70 (= 490 in low range)
[13:58:33.235] <TB0> INFO: Expecting 41600 events.
[13:58:37.455] <TB0> INFO: 41600 events read in total (3664ms).
[13:58:37.455] <TB0> INFO: Test took 4480ms.
[13:58:37.458] <TB0> INFO: scanning high vcal = 90 (= 630 in low range)
[13:58:37.720] <TB0> INFO: Expecting 41600 events.
[13:58:41.883] <TB0> INFO: 41600 events read in total (3607ms).
[13:58:41.883] <TB0> INFO: Test took 4425ms.
[13:58:41.886] <TB0> INFO: scanning high vcal = 200 (= 1400 in low range)
[13:58:42.156] <TB0> INFO: Expecting 41600 events.
[13:58:46.325] <TB0> INFO: 41600 events read in total (3613ms).
[13:58:46.326] <TB0> INFO: Test took 4440ms.
[13:58:46.777] <TB0> INFO: PixTestGainPedestal::measure() done
[13:59:18.953] <TB0> INFO: PixTestGainPedestal::fit() done
[13:59:18.953] <TB0> INFO: non-linearity mean: 0.955 0.958 0.960 0.960 0.957 0.963 0.957 0.954 0.960 0.959 0.955 0.958 0.964 0.964 0.971 0.961
[13:59:18.953] <TB0> INFO: non-linearity RMS: 0.006 0.006 0.006 0.006 0.006 0.005 0.007 0.007 0.008 0.008 0.007 0.007 0.007 0.005 0.005 0.006
[13:59:18.953] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[13:59:18.978] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[13:59:19.001] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[13:59:19.019] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[13:59:19.039] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[13:59:19.060] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[13:59:19.078] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[13:59:19.096] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[13:59:19.114] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[13:59:19.132] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[13:59:19.150] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[13:59:19.168] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[13:59:19.186] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[13:59:19.204] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[13:59:19.223] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[13:59:19.241] <TB0> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[13:59:19.259] <TB0> INFO: PixTestGainPedestal::fullTest() done, duration: 165 seconds
[13:59:19.259] <TB0> INFO: Decoding statistics:
[13:59:19.259] <TB0> INFO: General information:
[13:59:19.259] <TB0> INFO: 16bit words read: 2662400
[13:59:19.259] <TB0> INFO: valid events total: 166400
[13:59:19.259] <TB0> INFO: empty events: 0
[13:59:19.259] <TB0> INFO: valid events with pixels: 166400
[13:59:19.259] <TB0> INFO: valid pixel hits: 665502
[13:59:19.259] <TB0> INFO: Event errors: 0
[13:59:19.259] <TB0> INFO: start marker: 0
[13:59:19.259] <TB0> INFO: stop marker: 0
[13:59:19.259] <TB0> INFO: overflow: 0
[13:59:19.259] <TB0> INFO: invalid 5bit words: 0
[13:59:19.259] <TB0> INFO: invalid XOR eye diagram: 0
[13:59:19.259] <TB0> INFO: frame (failed synchr.): 0
[13:59:19.259] <TB0> INFO: idle data (no TBM trl): 0
[13:59:19.259] <TB0> INFO: no data (only TBM hdr): 0
[13:59:19.259] <TB0> INFO: TBM errors: 0
[13:59:19.259] <TB0> INFO: flawed TBM headers: 0
[13:59:19.259] <TB0> INFO: flawed TBM trailers: 0
[13:59:19.259] <TB0> INFO: event ID mismatches: 0
[13:59:19.259] <TB0> INFO: ROC errors: 0
[13:59:19.259] <TB0> INFO: missing ROC header(s): 0
[13:59:19.259] <TB0> INFO: misplaced readback start: 0
[13:59:19.259] <TB0> INFO: Pixel decoding errors: 0
[13:59:19.259] <TB0> INFO: pixel data incomplete: 0
[13:59:19.259] <TB0> INFO: pixel address: 0
[13:59:19.259] <TB0> INFO: pulse height fill bit: 0
[13:59:19.259] <TB0> INFO: buffer corruption: 0
[13:59:19.267] <TB0> INFO: readReadbackCal: /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C15.dat
[13:59:19.268] <TB0> INFO: ######################################################################
[13:59:19.268] <TB0> INFO: PixTestReadback::doTest()
[13:59:19.268] <TB0> INFO: ######################################################################
[13:59:19.268] <TB0> INFO: ----------------------------------------------------------------------
[13:59:19.268] <TB0> INFO: PixTestReadback::CalibrateVd()
[13:59:19.268] <TB0> INFO: ----------------------------------------------------------------------
[13:59:28.719] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C0.dat
[13:59:28.719] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C1.dat
[13:59:28.719] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C2.dat
[13:59:28.719] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C3.dat
[13:59:28.719] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C4.dat
[13:59:28.719] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C5.dat
[13:59:28.720] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C6.dat
[13:59:28.720] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C7.dat
[13:59:28.720] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C8.dat
[13:59:28.720] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C9.dat
[13:59:28.720] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C10.dat
[13:59:28.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C11.dat
[13:59:28.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C12.dat
[13:59:28.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C13.dat
[13:59:28.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C14.dat
[13:59:28.721] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C15.dat
[13:59:28.752] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:59:28.752] <TB0> INFO: ----------------------------------------------------------------------
[13:59:28.752] <TB0> INFO: PixTestReadback::CalibrateVa()
[13:59:28.752] <TB0> INFO: ----------------------------------------------------------------------
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C0.dat
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C1.dat
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C2.dat
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C3.dat
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C4.dat
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C5.dat
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C6.dat
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C7.dat
[13:59:38.218] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C8.dat
[13:59:38.219] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C9.dat
[13:59:38.219] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C10.dat
[13:59:38.219] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C11.dat
[13:59:38.219] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C12.dat
[13:59:38.219] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C13.dat
[13:59:38.219] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C14.dat
[13:59:38.219] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C15.dat
[13:59:38.247] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:59:38.247] <TB0> INFO: ----------------------------------------------------------------------
[13:59:38.247] <TB0> INFO: PixTestReadback::readbackVbg()
[13:59:38.248] <TB0> INFO: ----------------------------------------------------------------------
[13:59:45.564] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[13:59:45.564] <TB0> INFO: ----------------------------------------------------------------------
[13:59:45.564] <TB0> INFO: PixTestReadback::getCalibratedVbg()
[13:59:45.564] <TB0> INFO: ----------------------------------------------------------------------
[13:59:45.564] <TB0> INFO: Vbg will be calibrated using Vd calibration
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 159.9calibrated Vbg = 1.23338 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 154.5calibrated Vbg = 1.23048 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 146.7calibrated Vbg = 1.22802 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 155.9calibrated Vbg = 1.23993 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 154.3calibrated Vbg = 1.24208 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 146.2calibrated Vbg = 1.24615 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 155.1calibrated Vbg = 1.24745 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 151.2calibrated Vbg = 1.24286 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 158.7calibrated Vbg = 1.24341 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 157.3calibrated Vbg = 1.25071 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 156.4calibrated Vbg = 1.249 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 161.8calibrated Vbg = 1.23862 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 169calibrated Vbg = 1.23238 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 151.3calibrated Vbg = 1.23212 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 153.5calibrated Vbg = 1.231 :::*/*/*/*/
[13:59:45.564] <TB0> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 158.2calibrated Vbg = 1.23589 :::*/*/*/*/
[13:59:45.567] <TB0> INFO: ----------------------------------------------------------------------
[13:59:45.567] <TB0> INFO: PixTestReadback::CalibrateIa()
[13:59:45.567] <TB0> INFO: ----------------------------------------------------------------------
[14:02:20.868] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C0.dat
[14:02:20.868] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C1.dat
[14:02:20.868] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C2.dat
[14:02:20.868] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C3.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C4.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C5.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C6.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C7.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C8.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C9.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C10.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C11.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C12.dat
[14:02:20.869] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C13.dat
[14:02:20.870] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C14.dat
[14:02:20.870] <TB0> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2245_FullQualification_2016-06-08_08h43m_1465368217//004_FulltestPxar_p17//readbackCal_C15.dat
[14:02:20.899] <TB0> INFO: PixTestPattern:: pg_setup set to default.
[14:02:20.900] <TB0> INFO: PixTestReadback::doTest() done
[14:02:20.900] <TB0> INFO: Decoding statistics:
[14:02:20.900] <TB0> INFO: General information:
[14:02:20.900] <TB0> INFO: 16bit words read: 1024
[14:02:20.900] <TB0> INFO: valid events total: 128
[14:02:20.900] <TB0> INFO: empty events: 128
[14:02:20.900] <TB0> INFO: valid events with pixels: 0
[14:02:20.900] <TB0> INFO: valid pixel hits: 0
[14:02:20.900] <TB0> INFO: Event errors: 0
[14:02:20.900] <TB0> INFO: start marker: 0
[14:02:20.900] <TB0> INFO: stop marker: 0
[14:02:20.900] <TB0> INFO: overflow: 0
[14:02:20.900] <TB0> INFO: invalid 5bit words: 0
[14:02:20.900] <TB0> INFO: invalid XOR eye diagram: 0
[14:02:20.900] <TB0> INFO: frame (failed synchr.): 0
[14:02:20.900] <TB0> INFO: idle data (no TBM trl): 0
[14:02:20.900] <TB0> INFO: no data (only TBM hdr): 0
[14:02:20.900] <TB0> INFO: TBM errors: 0
[14:02:20.900] <TB0> INFO: flawed TBM headers: 0
[14:02:20.900] <TB0> INFO: flawed TBM trailers: 0
[14:02:20.900] <TB0> INFO: event ID mismatches: 0
[14:02:20.900] <TB0> INFO: ROC errors: 0
[14:02:20.900] <TB0> INFO: missing ROC header(s): 0
[14:02:20.900] <TB0> INFO: misplaced readback start: 0
[14:02:20.900] <TB0> INFO: Pixel decoding errors: 0
[14:02:20.900] <TB0> INFO: pixel data incomplete: 0
[14:02:20.900] <TB0> INFO: pixel address: 0
[14:02:20.900] <TB0> INFO: pulse height fill bit: 0
[14:02:20.900] <TB0> INFO: buffer corruption: 0
[14:02:20.917] <TB0> INFO: Decoding statistics:
[14:02:20.917] <TB0> INFO: General information:
[14:02:20.917] <TB0> INFO: 16bit words read: 2755352
[14:02:20.917] <TB0> INFO: valid events total: 176768
[14:02:20.917] <TB0> INFO: empty events: 7866
[14:02:20.917] <TB0> INFO: valid events with pixels: 168902
[14:02:20.917] <TB0> INFO: valid pixel hits: 668004
[14:02:20.917] <TB0> INFO: Event errors: 0
[14:02:20.917] <TB0> INFO: start marker: 0
[14:02:20.917] <TB0> INFO: stop marker: 0
[14:02:20.917] <TB0> INFO: overflow: 0
[14:02:20.917] <TB0> INFO: invalid 5bit words: 0
[14:02:20.917] <TB0> INFO: invalid XOR eye diagram: 0
[14:02:20.917] <TB0> INFO: frame (failed synchr.): 0
[14:02:20.917] <TB0> INFO: idle data (no TBM trl): 0
[14:02:20.917] <TB0> INFO: no data (only TBM hdr): 0
[14:02:20.917] <TB0> INFO: TBM errors: 0
[14:02:20.917] <TB0> INFO: flawed TBM headers: 0
[14:02:20.917] <TB0> INFO: flawed TBM trailers: 0
[14:02:20.917] <TB0> INFO: event ID mismatches: 0
[14:02:20.917] <TB0> INFO: ROC errors: 0
[14:02:20.917] <TB0> INFO: missing ROC header(s): 0
[14:02:20.917] <TB0> INFO: misplaced readback start: 0
[14:02:20.917] <TB0> INFO: Pixel decoding errors: 0
[14:02:20.917] <TB0> INFO: pixel data incomplete: 0
[14:02:20.917] <TB0> INFO: pixel address: 0
[14:02:20.917] <TB0> INFO: pulse height fill bit: 0
[14:02:20.917] <TB0> INFO: buffer corruption: 0
[14:02:20.917] <TB0> INFO: enter test to run
[14:02:20.917] <TB0> INFO: test: exit no parameter change
[14:02:21.059] <TB0> QUIET: Connection to board 73 closed.
[14:02:21.138] <TB0> INFO: pXar: this is the end, my friend