[13:31:26.769] <TB2> INFO: *** Welcome to pxar ***
[13:31:26.769] <TB2> INFO: *** Today: 2016/01/13
[13:31:26.866] <TB2> INFO: *** Version: 3197
[13:31:26.866] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C15.dat
[13:31:26.867] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//tbmParameters_C0b.dat
[13:31:26.867] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//defaultMaskFile.dat
[13:31:26.867] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters_C15.dat
[13:31:26.962] <TB2> INFO: clk: 4
[13:31:26.962] <TB2> INFO: ctr: 4
[13:31:26.962] <TB2> INFO: sda: 19
[13:31:26.962] <TB2> INFO: tin: 9
[13:31:26.962] <TB2> INFO: level: 15
[13:31:26.962] <TB2> INFO: triggerdelay: 0
[13:31:26.962] <TB2> QUIET: Instanciating API for pxar prod-12
[13:31:26.962] <TB2> INFO: Log level: INFO
[13:31:26.969] <TB2> INFO: Found DTB DTB_WXC55Z
[13:31:26.978] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[13:31:26.981] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[13:31:26.984] <TB2> INFO: RPC call hashes of host and DTB match: 398089610
[13:31:28.499] <TB2> INFO: DUT info:
[13:31:28.499] <TB2> INFO: The DUT currently contains the following objects:
[13:31:28.499] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[13:31:28.499] <TB2> INFO: TBM Core alpha (0): 7 registers set
[13:31:28.499] <TB2> INFO: TBM Core beta (1): 7 registers set
[13:31:28.499] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:31:28.499] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.499] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.499] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.499] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.499] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.499] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.499] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.499] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.499] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.500] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.500] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.500] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.500] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.500] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.500] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.500] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:31:28.901] <TB2> INFO: enter 'restricted' command line mode
[13:31:28.901] <TB2> INFO: enter test to run
[13:31:28.901] <TB2> INFO: test: pretest no parameter change
[13:31:28.901] <TB2> INFO: running: pretest
[13:31:28.908] <TB2> INFO: ######################################################################
[13:31:28.908] <TB2> INFO: PixTestPretest::doTest()
[13:31:28.908] <TB2> INFO: ######################################################################
[13:31:28.909] <TB2> INFO: ----------------------------------------------------------------------
[13:31:28.909] <TB2> INFO: PixTestPretest::programROC()
[13:31:28.909] <TB2> INFO: ----------------------------------------------------------------------
[13:31:46.928] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[13:31:46.928] <TB2> INFO: IA differences per ROC: 18.5 18.5 19.3 17.7 18.5 18.5 16.9 19.3 20.1 17.7 21.7 20.1 18.5 18.5 20.1 19.3
[13:31:47.002] <TB2> INFO: ----------------------------------------------------------------------
[13:31:47.002] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[13:31:47.002] <TB2> INFO: ----------------------------------------------------------------------
[13:31:53.003] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 382.7 mA = 23.9187 mA/ROC
[13:31:53.003] <TB2> INFO: i(loss) [mA/ROC]: 19.3 18.5 19.3 18.5 19.3 19.3 19.3 19.3 18.5 19.3 18.5 18.5 19.3 19.3 19.3 18.5
[13:31:53.037] <TB2> INFO: ----------------------------------------------------------------------
[13:31:53.037] <TB2> INFO: PixTestPretest::findTiming()
[13:31:53.037] <TB2> INFO: ----------------------------------------------------------------------
[13:31:53.037] <TB2> INFO: PixTestCmd::init()

[13:33:43.732] <TB2> INFO: TBM phases: 160MHz: 0, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[13:33:43.732] <TB2> INFO: (success/tries = 100/100), width = 4
[13:33:43.733] <TB2> INFO: ----------------------------------------------------------------------
[13:33:43.733] <TB2> INFO: PixTestPretest::findWorkingPixel()
[13:33:43.733] <TB2> INFO: ----------------------------------------------------------------------
[13:33:43.871] <TB2> INFO: Expecting 231680 events.
[13:33:52.698] <TB2> INFO: 231680 events read in total (8111ms).
[13:33:52.703] <TB2> INFO: Test took 8967ms.
[13:33:53.015] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[13:33:53.052] <TB2> INFO: ----------------------------------------------------------------------
[13:33:53.053] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[13:33:53.053] <TB2> INFO: ----------------------------------------------------------------------
[13:33:53.189] <TB2> INFO: Expecting 231680 events.
[13:34:01.980] <TB2> INFO: 231680 events read in total (8075ms).
[13:34:01.985] <TB2> INFO: Test took 8928ms.
[13:34:02.295] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[13:34:02.295] <TB2> INFO: CalDel: 126 126 128 144 114 128 134 151 123 120 128 157 135 119 143 132
[13:34:02.295] <TB2> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[13:34:02.299] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C0.dat
[13:34:02.299] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C1.dat
[13:34:02.299] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C2.dat
[13:34:02.300] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C3.dat
[13:34:02.300] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C4.dat
[13:34:02.300] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C5.dat
[13:34:02.301] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C6.dat
[13:34:02.301] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C7.dat
[13:34:02.301] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C8.dat
[13:34:02.301] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C9.dat
[13:34:02.302] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C10.dat
[13:34:02.302] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C11.dat
[13:34:02.302] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C12.dat
[13:34:02.302] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C13.dat
[13:34:02.303] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C14.dat
[13:34:02.303] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters_C15.dat
[13:34:02.303] <TB2> INFO: write tbm parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//tbmParameters_C0a.dat
[13:34:02.303] <TB2> INFO: write tbm parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//tbmParameters_C0b.dat
[13:34:02.303] <TB2> INFO: PixTestPretest::doTest() done, duration: 153 seconds
[13:34:02.383] <TB2> INFO: enter test to run
[13:34:02.384] <TB2> INFO: test: fulltest no parameter change
[13:34:02.384] <TB2> INFO: running: fulltest
[13:34:02.384] <TB2> INFO: ######################################################################
[13:34:02.384] <TB2> INFO: PixTestFullTest::doTest()
[13:34:02.384] <TB2> INFO: ######################################################################
[13:34:02.385] <TB2> INFO: ######################################################################
[13:34:02.385] <TB2> INFO: PixTestAlive::doTest()
[13:34:02.385] <TB2> INFO: ######################################################################
[13:34:02.387] <TB2> INFO: ----------------------------------------------------------------------
[13:34:02.387] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:34:02.387] <TB2> INFO: ----------------------------------------------------------------------
[13:34:02.717] <TB2> INFO: Expecting 41600 events.
[13:34:07.019] <TB2> INFO: 41600 events read in total (3586ms).
[13:34:07.019] <TB2> INFO: Test took 4630ms.
[13:34:07.027] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:34:07.318] <TB2> INFO: PixTestAlive::aliveTest() done
[13:34:07.318] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:34:07.320] <TB2> INFO: ----------------------------------------------------------------------
[13:34:07.320] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:34:07.320] <TB2> INFO: ----------------------------------------------------------------------
[13:34:07.658] <TB2> INFO: Expecting 41600 events.
[13:34:10.829] <TB2> INFO: 41600 events read in total (2456ms).
[13:34:10.829] <TB2> INFO: Test took 3507ms.
[13:34:10.829] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:34:10.830] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:34:11.146] <TB2> INFO: PixTestAlive::maskTest() done
[13:34:11.146] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:34:11.149] <TB2> INFO: ----------------------------------------------------------------------
[13:34:11.149] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:34:11.149] <TB2> INFO: ----------------------------------------------------------------------
[13:34:11.477] <TB2> INFO: Expecting 41600 events.
[13:34:15.719] <TB2> INFO: 41600 events read in total (3526ms).
[13:34:15.720] <TB2> INFO: Test took 4569ms.
[13:34:15.726] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:34:16.012] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[13:34:16.012] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:34:16.012] <TB2> INFO: PixTestAlive::doTest() done, duration: 13 seconds
[13:34:16.012] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:34:16.012] <TB2> INFO: Decoding statistics:
[13:34:16.012] <TB2> INFO: General information:
[13:34:16.012] <TB2> INFO: 16bit words read: 0
[13:34:16.012] <TB2> INFO: valid events total: 0
[13:34:16.012] <TB2> INFO: empty events: 0
[13:34:16.012] <TB2> INFO: valid events with pixels: 0
[13:34:16.012] <TB2> INFO: valid pixel hits: 0
[13:34:16.012] <TB2> INFO: Event errors: 0
[13:34:16.012] <TB2> INFO: start marker: 0
[13:34:16.012] <TB2> INFO: stop marker: 0
[13:34:16.012] <TB2> INFO: overflow: 0
[13:34:16.012] <TB2> INFO: invalid 5bit words: 0
[13:34:16.012] <TB2> INFO: invalid XOR eye diagram: 0
[13:34:16.012] <TB2> INFO: TBM errors: 0
[13:34:16.012] <TB2> INFO: flawed TBM headers: 0
[13:34:16.012] <TB2> INFO: flawed TBM trailers: 0
[13:34:16.012] <TB2> INFO: event ID mismatches: 0
[13:34:16.012] <TB2> INFO: ROC errors: 0
[13:34:16.012] <TB2> INFO: missing ROC header(s): 0
[13:34:16.012] <TB2> INFO: misplaced readback start: 0
[13:34:16.012] <TB2> INFO: Pixel decoding errors: 0
[13:34:16.012] <TB2> INFO: pixel data incomplete: 0
[13:34:16.012] <TB2> INFO: pixel address: 0
[13:34:16.012] <TB2> INFO: pulse height fill bit: 0
[13:34:16.012] <TB2> INFO: buffer corruption: 0
[13:34:16.021] <TB2> INFO: ######################################################################
[13:34:16.021] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[13:34:16.021] <TB2> INFO: ######################################################################
[13:34:16.024] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[13:34:16.038] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[13:34:16.038] <TB2> INFO: run 1 of 1
[13:34:16.367] <TB2> INFO: Expecting 3120000 events.
[13:34:57.536] <TB2> INFO: 874840 events read in total (40453ms).
[13:35:37.892] <TB2> INFO: 1732190 events read in total (80809ms).
[13:36:19.022] <TB2> INFO: 2597525 events read in total (121939ms).
[13:36:42.828] <TB2> INFO: 3120000 events read in total (145745ms).
[13:36:42.876] <TB2> INFO: Test took 146838ms.
[13:36:42.968] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:37:07.111] <TB2> INFO: PixTestBBMap::doTest() done, duration: 171 seconds
[13:37:07.111] <TB2> INFO: number of dead bumps (per ROC): 41 28 18 45 21 29 35 82 34 5 14 11 4 3 2 20
[13:37:07.111] <TB2> INFO: separation cut (per ROC): 79 78 85 83 85 87 76 80 82 90 91 84 90 106 103 75
[13:37:07.111] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:37:07.111] <TB2> INFO: Decoding statistics:
[13:37:07.111] <TB2> INFO: General information:
[13:37:07.111] <TB2> INFO: 16bit words read: 0
[13:37:07.111] <TB2> INFO: valid events total: 0
[13:37:07.111] <TB2> INFO: empty events: 0
[13:37:07.111] <TB2> INFO: valid events with pixels: 0
[13:37:07.111] <TB2> INFO: valid pixel hits: 0
[13:37:07.111] <TB2> INFO: Event errors: 0
[13:37:07.111] <TB2> INFO: start marker: 0
[13:37:07.111] <TB2> INFO: stop marker: 0
[13:37:07.111] <TB2> INFO: overflow: 0
[13:37:07.111] <TB2> INFO: invalid 5bit words: 0
[13:37:07.111] <TB2> INFO: invalid XOR eye diagram: 0
[13:37:07.111] <TB2> INFO: TBM errors: 0
[13:37:07.111] <TB2> INFO: flawed TBM headers: 0
[13:37:07.111] <TB2> INFO: flawed TBM trailers: 0
[13:37:07.111] <TB2> INFO: event ID mismatches: 0
[13:37:07.111] <TB2> INFO: ROC errors: 0
[13:37:07.111] <TB2> INFO: missing ROC header(s): 0
[13:37:07.111] <TB2> INFO: misplaced readback start: 0
[13:37:07.111] <TB2> INFO: Pixel decoding errors: 0
[13:37:07.111] <TB2> INFO: pixel data incomplete: 0
[13:37:07.111] <TB2> INFO: pixel address: 0
[13:37:07.111] <TB2> INFO: pulse height fill bit: 0
[13:37:07.111] <TB2> INFO: buffer corruption: 0
[13:37:07.180] <TB2> INFO: ######################################################################
[13:37:07.180] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[13:37:07.180] <TB2> INFO: ######################################################################
[13:37:07.180] <TB2> INFO: ----------------------------------------------------------------------
[13:37:07.180] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[13:37:07.180] <TB2> INFO: ----------------------------------------------------------------------
[13:37:07.180] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[13:37:07.188] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[13:37:07.188] <TB2> INFO: run 1 of 1
[13:37:07.503] <TB2> INFO: Expecting 26208000 events.
[13:37:38.767] <TB2> INFO: 948800 events read in total (30548ms).
[13:38:08.832] <TB2> INFO: 1879700 events read in total (60613ms).
[13:38:39.371] <TB2> INFO: 2814450 events read in total (91152ms).
[13:39:10.156] <TB2> INFO: 3747300 events read in total (121937ms).
[13:39:41.112] <TB2> INFO: 4679900 events read in total (152893ms).
[13:40:11.309] <TB2> INFO: 5609650 events read in total (183090ms).
[13:40:41.573] <TB2> INFO: 6539000 events read in total (213354ms).
[13:41:11.915] <TB2> INFO: 7465400 events read in total (243696ms).
[13:41:42.937] <TB2> INFO: 8391800 events read in total (274718ms).
[13:42:13.107] <TB2> INFO: 9322050 events read in total (304888ms).
[13:42:43.236] <TB2> INFO: 10247800 events read in total (335017ms).
[13:43:13.970] <TB2> INFO: 11173150 events read in total (365751ms).
[13:43:43.788] <TB2> INFO: 12098600 events read in total (395569ms).
[13:44:14.031] <TB2> INFO: 13019400 events read in total (425812ms).
[13:44:44.212] <TB2> INFO: 13930200 events read in total (455993ms).
[13:45:14.977] <TB2> INFO: 14841650 events read in total (486758ms).
[13:45:46.467] <TB2> INFO: 15753850 events read in total (518248ms).
[13:46:16.942] <TB2> INFO: 16660750 events read in total (548723ms).
[13:46:48.478] <TB2> INFO: 17566300 events read in total (580259ms).
[13:47:18.535] <TB2> INFO: 18474050 events read in total (610316ms).
[13:47:49.534] <TB2> INFO: 19378450 events read in total (641315ms).
[13:48:20.155] <TB2> INFO: 20285600 events read in total (671937ms).
[13:48:50.658] <TB2> INFO: 21191500 events read in total (702439ms).
[13:49:21.523] <TB2> INFO: 22096450 events read in total (733304ms).
[13:49:52.324] <TB2> INFO: 23001150 events read in total (764105ms).
[13:50:22.644] <TB2> INFO: 23909300 events read in total (794425ms).
[13:50:54.511] <TB2> INFO: 24819100 events read in total (826292ms).
[13:51:25.886] <TB2> INFO: 25727100 events read in total (857667ms).
[13:51:41.788] <TB2> INFO: 26208000 events read in total (873569ms).
[13:51:41.825] <TB2> INFO: Test took 874636ms.
[13:51:41.919] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:51:42.152] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:43.688] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:45.135] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:46.554] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:47.980] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:49.404] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:50.823] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:52.276] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:53.730] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:55.180] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:56.598] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:57.937] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:51:59.354] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:52:01.014] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:52:02.389] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:52:03.795] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[13:52:05.292] <TB2> INFO: PixTestScurves::scurves() done
[13:52:05.292] <TB2> INFO: Vcal mean: 99.77 94.76 101.15 100.17 102.32 104.80 93.72 97.06 93.60 95.09 102.58 91.64 93.33 107.52 101.15 87.71
[13:52:05.292] <TB2> INFO: Vcal RMS: 6.01 4.69 5.61 6.37 5.36 5.03 5.44 5.19 5.51 5.24 5.04 5.72 5.00 5.17 5.82 4.80
[13:52:05.292] <TB2> INFO: PixTestScurves::fullTest() done, duration: 898 seconds
[13:52:05.292] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:52:05.292] <TB2> INFO: Decoding statistics:
[13:52:05.292] <TB2> INFO: General information:
[13:52:05.292] <TB2> INFO: 16bit words read: 0
[13:52:05.292] <TB2> INFO: valid events total: 0
[13:52:05.292] <TB2> INFO: empty events: 0
[13:52:05.292] <TB2> INFO: valid events with pixels: 0
[13:52:05.292] <TB2> INFO: valid pixel hits: 0
[13:52:05.292] <TB2> INFO: Event errors: 0
[13:52:05.292] <TB2> INFO: start marker: 0
[13:52:05.292] <TB2> INFO: stop marker: 0
[13:52:05.292] <TB2> INFO: overflow: 0
[13:52:05.292] <TB2> INFO: invalid 5bit words: 0
[13:52:05.292] <TB2> INFO: invalid XOR eye diagram: 0
[13:52:05.292] <TB2> INFO: TBM errors: 0
[13:52:05.292] <TB2> INFO: flawed TBM headers: 0
[13:52:05.292] <TB2> INFO: flawed TBM trailers: 0
[13:52:05.292] <TB2> INFO: event ID mismatches: 0
[13:52:05.292] <TB2> INFO: ROC errors: 0
[13:52:05.292] <TB2> INFO: missing ROC header(s): 0
[13:52:05.292] <TB2> INFO: misplaced readback start: 0
[13:52:05.292] <TB2> INFO: Pixel decoding errors: 0
[13:52:05.292] <TB2> INFO: pixel data incomplete: 0
[13:52:05.292] <TB2> INFO: pixel address: 0
[13:52:05.292] <TB2> INFO: pulse height fill bit: 0
[13:52:05.292] <TB2> INFO: buffer corruption: 0
[13:52:05.376] <TB2> INFO: ######################################################################
[13:52:05.376] <TB2> INFO: PixTestTrim::doTest()
[13:52:05.376] <TB2> INFO: ######################################################################
[13:52:05.378] <TB2> INFO: ----------------------------------------------------------------------
[13:52:05.378] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[13:52:05.378] <TB2> INFO: ----------------------------------------------------------------------
[13:52:05.477] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[13:52:05.477] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:52:05.488] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[13:52:05.488] <TB2> INFO: run 1 of 1
[13:52:05.827] <TB2> INFO: Expecting 6281600 events.
[13:52:44.860] <TB2> INFO: 1101280 events read in total (38317ms).
[13:53:23.358] <TB2> INFO: 2195640 events read in total (76815ms).
[13:54:01.825] <TB2> INFO: 3282830 events read in total (115282ms).
[13:54:40.993] <TB2> INFO: 4375550 events read in total (154450ms).
[13:55:19.556] <TB2> INFO: 5471050 events read in total (193013ms).
[13:55:48.138] <TB2> INFO: 6281600 events read in total (221595ms).
[13:55:48.170] <TB2> INFO: Test took 222682ms.
[13:55:48.216] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[13:56:08.245] <TB2> INFO: ROC 0 VthrComp = 95
[13:56:08.245] <TB2> INFO: ROC 1 VthrComp = 94
[13:56:08.245] <TB2> INFO: ROC 2 VthrComp = 100
[13:56:08.245] <TB2> INFO: ROC 3 VthrComp = 94
[13:56:08.245] <TB2> INFO: ROC 4 VthrComp = 102
[13:56:08.245] <TB2> INFO: ROC 5 VthrComp = 104
[13:56:08.246] <TB2> INFO: ROC 6 VthrComp = 92
[13:56:08.246] <TB2> INFO: ROC 7 VthrComp = 97
[13:56:08.246] <TB2> INFO: ROC 8 VthrComp = 95
[13:56:08.246] <TB2> INFO: ROC 9 VthrComp = 92
[13:56:08.246] <TB2> INFO: ROC 10 VthrComp = 106
[13:56:08.246] <TB2> INFO: ROC 11 VthrComp = 92
[13:56:08.246] <TB2> INFO: ROC 12 VthrComp = 94
[13:56:08.246] <TB2> INFO: ROC 13 VthrComp = 104
[13:56:08.246] <TB2> INFO: ROC 14 VthrComp = 101
[13:56:08.246] <TB2> INFO: ROC 15 VthrComp = 89
[13:56:08.246] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[13:56:08.246] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:56:08.255] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[13:56:08.255] <TB2> INFO: run 1 of 1
[13:56:08.557] <TB2> INFO: Expecting 6281600 events.
[13:56:42.881] <TB2> INFO: 757660 events read in total (33609ms).
[13:57:16.871] <TB2> INFO: 1514100 events read in total (67599ms).
[13:57:51.090] <TB2> INFO: 2270940 events read in total (101818ms).
[13:58:24.831] <TB2> INFO: 3028660 events read in total (135559ms).
[13:58:59.334] <TB2> INFO: 3780330 events read in total (170062ms).
[13:59:33.879] <TB2> INFO: 4528040 events read in total (204607ms).
[14:00:08.262] <TB2> INFO: 5273890 events read in total (238990ms).
[14:00:42.625] <TB2> INFO: 6019380 events read in total (273353ms).
[14:00:54.515] <TB2> INFO: 6281600 events read in total (285243ms).
[14:00:54.552] <TB2> INFO: Test took 286297ms.
[14:00:54.689] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:01:19.862] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 60.6392 for pixel 29/4 mean/min/max = 46.8256/32.7819/60.8693
[14:01:19.862] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 57.0694 for pixel 12/1 mean/min/max = 45.1407/33.1282/57.1532
[14:01:19.863] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 58.4471 for pixel 0/31 mean/min/max = 45.4884/32.4499/58.527
[14:01:19.863] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 62.8139 for pixel 6/62 mean/min/max = 47.7962/32.727/62.8654
[14:01:19.863] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 58.368 for pixel 5/68 mean/min/max = 45.5915/32.5065/58.6766
[14:01:19.863] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 59.5773 for pixel 19/79 mean/min/max = 47.3379/34.8976/59.7782
[14:01:19.863] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 60.5745 for pixel 8/1 mean/min/max = 46.7582/32.9338/60.5826
[14:01:19.864] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 56.7804 for pixel 50/61 mean/min/max = 44.7143/32.2987/57.1299
[14:01:19.864] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 59.4035 for pixel 13/5 mean/min/max = 45.9061/32.3469/59.4654
[14:01:19.864] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 59.6615 for pixel 0/5 mean/min/max = 46.6227/33.532/59.7135
[14:01:19.864] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 58.0354 for pixel 51/9 mean/min/max = 46.2653/34.4637/58.067
[14:01:19.865] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 59.4254 for pixel 5/58 mean/min/max = 46.1078/32.7082/59.5073
[14:01:19.865] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 57.4614 for pixel 1/64 mean/min/max = 45.5951/33.4611/57.7292
[14:01:19.865] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 61.3264 for pixel 23/79 mean/min/max = 47.7036/34.0706/61.3366
[14:01:19.865] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 59.4134 for pixel 3/48 mean/min/max = 45.4392/31.3853/59.493
[14:01:19.866] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 55.5573 for pixel 14/31 mean/min/max = 44.6772/33.5489/55.8056
[14:01:19.866] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:01:19.996] <TB2> INFO: Expecting 514560 events.
[14:01:32.391] <TB2> INFO: 514560 events read in total (11679ms).
[14:01:32.396] <TB2> INFO: Expecting 514560 events.
[14:01:44.443] <TB2> INFO: 514560 events read in total (11476ms).
[14:01:44.451] <TB2> INFO: Expecting 514560 events.
[14:01:56.386] <TB2> INFO: 514560 events read in total (11363ms).
[14:01:56.396] <TB2> INFO: Expecting 514560 events.
[14:02:08.511] <TB2> INFO: 514560 events read in total (11549ms).
[14:02:08.521] <TB2> INFO: Expecting 514560 events.
[14:02:20.024] <TB2> INFO: 514560 events read in total (10923ms).
[14:02:20.036] <TB2> INFO: Expecting 514560 events.
[14:02:32.343] <TB2> INFO: 514560 events read in total (11734ms).
[14:02:32.357] <TB2> INFO: Expecting 514560 events.
[14:02:44.594] <TB2> INFO: 514560 events read in total (11672ms).
[14:02:44.613] <TB2> INFO: Expecting 514560 events.
[14:02:56.186] <TB2> INFO: 514560 events read in total (11020ms).
[14:02:56.204] <TB2> INFO: Expecting 514560 events.
[14:03:08.675] <TB2> INFO: 514560 events read in total (11901ms).
[14:03:08.695] <TB2> INFO: Expecting 514560 events.
[14:03:20.589] <TB2> INFO: 514560 events read in total (11333ms).
[14:03:20.616] <TB2> INFO: Expecting 514560 events.
[14:03:32.290] <TB2> INFO: 514560 events read in total (11118ms).
[14:03:32.314] <TB2> INFO: Expecting 514560 events.
[14:03:43.947] <TB2> INFO: 514560 events read in total (11077ms).
[14:03:43.971] <TB2> INFO: Expecting 514560 events.
[14:03:55.721] <TB2> INFO: 514560 events read in total (11189ms).
[14:03:55.747] <TB2> INFO: Expecting 514560 events.
[14:04:07.767] <TB2> INFO: 514560 events read in total (11459ms).
[14:04:07.798] <TB2> INFO: Expecting 514560 events.
[14:04:19.506] <TB2> INFO: 514560 events read in total (11161ms).
[14:04:19.543] <TB2> INFO: Expecting 514560 events.
[14:04:31.253] <TB2> INFO: 514560 events read in total (11162ms).
[14:04:31.289] <TB2> INFO: Test took 191423ms.
[14:04:32.310] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[14:04:32.319] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:04:32.319] <TB2> INFO: run 1 of 1
[14:04:32.624] <TB2> INFO: Expecting 6281600 events.
[14:05:06.695] <TB2> INFO: 743330 events read in total (33356ms).
[14:05:41.271] <TB2> INFO: 1485520 events read in total (67932ms).
[14:06:15.562] <TB2> INFO: 2228380 events read in total (102223ms).
[14:06:48.890] <TB2> INFO: 2971920 events read in total (135551ms).
[14:07:20.825] <TB2> INFO: 3709130 events read in total (167486ms).
[14:07:54.654] <TB2> INFO: 4441730 events read in total (201315ms).
[14:08:27.837] <TB2> INFO: 5172350 events read in total (234498ms).
[14:09:00.665] <TB2> INFO: 5902220 events read in total (267326ms).
[14:09:17.844] <TB2> INFO: 6281600 events read in total (284505ms).
[14:09:17.893] <TB2> INFO: Test took 285574ms.
[14:09:18.047] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:09:45.307] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.176506 .. 255.000000
[14:09:45.405] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[14:09:45.415] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:09:45.415] <TB2> INFO: run 1 of 1
[14:09:45.754] <TB2> INFO: Expecting 10649600 events.
[14:10:20.439] <TB2> INFO: 712170 events read in total (33970ms).
[14:10:52.938] <TB2> INFO: 1424540 events read in total (66469ms).
[14:11:25.915] <TB2> INFO: 2137050 events read in total (99446ms).
[14:11:58.098] <TB2> INFO: 2849870 events read in total (131629ms).
[14:12:30.059] <TB2> INFO: 3562180 events read in total (163590ms).
[14:13:01.296] <TB2> INFO: 4274720 events read in total (194827ms).
[14:13:32.612] <TB2> INFO: 4987770 events read in total (226143ms).
[14:14:04.636] <TB2> INFO: 5700620 events read in total (258167ms).
[14:14:36.239] <TB2> INFO: 6413510 events read in total (289770ms).
[14:15:07.630] <TB2> INFO: 7125520 events read in total (321161ms).
[14:15:39.900] <TB2> INFO: 7837240 events read in total (353431ms).
[14:16:11.769] <TB2> INFO: 8548650 events read in total (385300ms).
[14:16:44.255] <TB2> INFO: 9259860 events read in total (417786ms).
[14:17:16.083] <TB2> INFO: 9970860 events read in total (449614ms).
[14:17:46.656] <TB2> INFO: 10649600 events read in total (480187ms).
[14:17:46.734] <TB2> INFO: Test took 481319ms.
[14:17:46.990] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:18:17.019] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 16.486012 .. 45.839073
[14:18:17.115] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 6 .. 55 (-1/-1) hits flags = 528 (plus default)
[14:18:17.124] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:18:17.125] <TB2> INFO: run 1 of 1
[14:18:17.449] <TB2> INFO: Expecting 2080000 events.
[14:18:54.759] <TB2> INFO: 931800 events read in total (36595ms).
[14:19:32.136] <TB2> INFO: 1862290 events read in total (73972ms).
[14:19:40.616] <TB2> INFO: 2080000 events read in total (82453ms).
[14:19:40.635] <TB2> INFO: Test took 83511ms.
[14:19:40.668] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:19:54.662] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 20.407662 .. 42.135821
[14:19:54.758] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 10 .. 52 (-1/-1) hits flags = 528 (plus default)
[14:19:54.766] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:19:54.766] <TB2> INFO: run 1 of 1
[14:19:55.104] <TB2> INFO: Expecting 1788800 events.
[14:20:31.421] <TB2> INFO: 935180 events read in total (35602ms).
[14:21:04.865] <TB2> INFO: 1788800 events read in total (69046ms).
[14:21:04.885] <TB2> INFO: Test took 70119ms.
[14:21:04.913] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:21:19.100] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 2.798838 .. 42.043709
[14:21:19.201] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 2 .. 52 (-1/-1) hits flags = 528 (plus default)
[14:21:19.210] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:21:19.210] <TB2> INFO: run 1 of 1
[14:21:19.555] <TB2> INFO: Expecting 2121600 events.
[14:21:55.916] <TB2> INFO: 980790 events read in total (35646ms).
[14:22:32.489] <TB2> INFO: 1962180 events read in total (72219ms).
[14:22:39.192] <TB2> INFO: 2121600 events read in total (78922ms).
[14:22:39.210] <TB2> INFO: Test took 80000ms.
[14:22:39.242] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:22:52.879] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[14:22:52.879] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[14:22:52.887] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[14:22:52.887] <TB2> INFO: run 1 of 1
[14:22:53.195] <TB2> INFO: Expecting 1705600 events.
[14:23:30.373] <TB2> INFO: 877680 events read in total (36463ms).
[14:24:04.909] <TB2> INFO: 1705600 events read in total (70999ms).
[14:24:04.924] <TB2> INFO: Test took 72038ms.
[14:24:04.955] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:24:19.010] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C0.dat
[14:24:19.010] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C1.dat
[14:24:19.010] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C2.dat
[14:24:19.010] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C3.dat
[14:24:19.010] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C4.dat
[14:24:19.010] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C5.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C6.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C7.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C8.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C9.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C10.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C11.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C12.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C13.dat
[14:24:19.011] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C14.dat
[14:24:19.012] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C15.dat
[14:24:19.012] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C0.dat
[14:24:19.019] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C1.dat
[14:24:19.025] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C2.dat
[14:24:19.031] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C3.dat
[14:24:19.037] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C4.dat
[14:24:19.043] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C5.dat
[14:24:19.049] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C6.dat
[14:24:19.055] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C7.dat
[14:24:19.062] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C8.dat
[14:24:19.068] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C9.dat
[14:24:19.074] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C10.dat
[14:24:19.080] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C11.dat
[14:24:19.086] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C12.dat
[14:24:19.092] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C13.dat
[14:24:19.098] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C14.dat
[14:24:19.105] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//trimParameters35_C15.dat
[14:24:19.111] <TB2> INFO: PixTestTrim::trimTest() done
[14:24:19.111] <TB2> INFO: vtrim: 119 99 102 90 107 106 105 84 112 95 102 110 102 106 107 93
[14:24:19.111] <TB2> INFO: vthrcomp: 95 94 100 94 102 104 92 97 95 92 106 92 94 104 101 89
[14:24:19.111] <TB2> INFO: vcal mean: 34.91 34.97 34.95 34.96 34.92 34.96 34.96 34.93 34.96 34.98 35.02 34.97 34.98 34.97 34.94 34.95
[14:24:19.111] <TB2> INFO: vcal RMS: 0.92 0.87 0.83 0.88 0.87 0.87 0.89 0.88 0.86 0.99 0.83 0.90 0.83 0.86 0.90 0.83
[14:24:19.111] <TB2> INFO: bits mean: 9.43 9.50 9.23 8.88 9.41 8.36 9.06 9.33 9.45 8.94 8.74 9.54 9.38 8.62 9.64 9.52
[14:24:19.111] <TB2> INFO: bits RMS: 2.56 2.59 2.80 2.64 2.71 2.67 2.73 2.82 2.66 2.69 2.64 2.58 2.55 2.61 2.74 2.52
[14:24:19.118] <TB2> INFO: ----------------------------------------------------------------------
[14:24:19.118] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[14:24:19.118] <TB2> INFO: ----------------------------------------------------------------------
[14:24:19.120] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[14:24:19.128] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:24:19.128] <TB2> INFO: run 1 of 1
[14:24:19.430] <TB2> INFO: Expecting 4160000 events.
[14:25:01.756] <TB2> INFO: 969490 events read in total (41611ms).
[14:25:43.890] <TB2> INFO: 1930530 events read in total (83745ms).
[14:26:27.242] <TB2> INFO: 2879685 events read in total (127097ms).
[14:27:06.157] <TB2> INFO: 3826645 events read in total (166012ms).
[14:27:21.603] <TB2> INFO: 4160000 events read in total (181459ms).
[14:27:21.639] <TB2> INFO: Test took 182511ms.
[14:27:21.731] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:27:50.264] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 173 (-1/-1) hits flags = 528 (plus default)
[14:27:50.272] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:27:50.272] <TB2> INFO: run 1 of 1
[14:27:50.588] <TB2> INFO: Expecting 3619200 events.
[14:28:36.125] <TB2> INFO: 994270 events read in total (44822ms).
[14:29:19.761] <TB2> INFO: 1977695 events read in total (88458ms).
[14:30:03.601] <TB2> INFO: 2949415 events read in total (132298ms).
[14:30:33.970] <TB2> INFO: 3619200 events read in total (162667ms).
[14:30:34.000] <TB2> INFO: Test took 163728ms.
[14:30:34.075] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:31:01.446] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 163 (-1/-1) hits flags = 528 (plus default)
[14:31:01.456] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:31:01.456] <TB2> INFO: run 1 of 1
[14:31:01.761] <TB2> INFO: Expecting 3411200 events.
[14:31:48.055] <TB2> INFO: 1024840 events read in total (45579ms).
[14:32:31.953] <TB2> INFO: 2035995 events read in total (89477ms).
[14:33:16.146] <TB2> INFO: 3035640 events read in total (133670ms).
[14:33:32.129] <TB2> INFO: 3411200 events read in total (149653ms).
[14:33:32.156] <TB2> INFO: Test took 150700ms.
[14:33:32.217] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:33:57.603] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 161 (-1/-1) hits flags = 528 (plus default)
[14:33:57.612] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:33:57.612] <TB2> INFO: run 1 of 1
[14:33:57.919] <TB2> INFO: Expecting 3369600 events.
[14:34:39.718] <TB2> INFO: 1031415 events read in total (41084ms).
[14:35:23.975] <TB2> INFO: 2047750 events read in total (85341ms).
[14:36:08.031] <TB2> INFO: 3053590 events read in total (129398ms).
[14:36:21.220] <TB2> INFO: 3369600 events read in total (142586ms).
[14:36:21.252] <TB2> INFO: Test took 143640ms.
[14:36:21.315] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:36:49.634] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 161 (-1/-1) hits flags = 528 (plus default)
[14:36:49.642] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[14:36:49.642] <TB2> INFO: run 1 of 1
[14:36:49.964] <TB2> INFO: Expecting 3369600 events.
[14:37:34.600] <TB2> INFO: 1030915 events read in total (43920ms).
[14:38:18.445] <TB2> INFO: 2046780 events read in total (87765ms).
[14:39:01.404] <TB2> INFO: 3052080 events read in total (130724ms).
[14:39:15.075] <TB2> INFO: 3369600 events read in total (144395ms).
[14:39:15.104] <TB2> INFO: Test took 145462ms.
[14:39:15.164] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:39:40.598] <TB2> INFO: PixTestTrim::trimBitTest() done
[14:39:40.599] <TB2> INFO: PixTestTrim::doTest() done, duration: 2855 seconds
[14:39:40.599] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:39:40.599] <TB2> INFO: Decoding statistics:
[14:39:40.599] <TB2> INFO: General information:
[14:39:40.599] <TB2> INFO: 16bit words read: 0
[14:39:40.599] <TB2> INFO: valid events total: 0
[14:39:40.600] <TB2> INFO: empty events: 0
[14:39:40.600] <TB2> INFO: valid events with pixels: 0
[14:39:40.600] <TB2> INFO: valid pixel hits: 0
[14:39:40.600] <TB2> INFO: Event errors: 0
[14:39:40.600] <TB2> INFO: start marker: 0
[14:39:40.600] <TB2> INFO: stop marker: 0
[14:39:40.600] <TB2> INFO: overflow: 0
[14:39:40.600] <TB2> INFO: invalid 5bit words: 0
[14:39:40.600] <TB2> INFO: invalid XOR eye diagram: 0
[14:39:40.600] <TB2> INFO: TBM errors: 0
[14:39:40.600] <TB2> INFO: flawed TBM headers: 0
[14:39:40.600] <TB2> INFO: flawed TBM trailers: 0
[14:39:40.600] <TB2> INFO: event ID mismatches: 0
[14:39:40.600] <TB2> INFO: ROC errors: 0
[14:39:40.600] <TB2> INFO: missing ROC header(s): 0
[14:39:40.600] <TB2> INFO: misplaced readback start: 0
[14:39:40.600] <TB2> INFO: Pixel decoding errors: 0
[14:39:40.600] <TB2> INFO: pixel data incomplete: 0
[14:39:40.600] <TB2> INFO: pixel address: 0
[14:39:40.600] <TB2> INFO: pulse height fill bit: 0
[14:39:40.600] <TB2> INFO: buffer corruption: 0
[14:39:41.341] <TB2> INFO: ######################################################################
[14:39:41.341] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[14:39:41.341] <TB2> INFO: ######################################################################
[14:39:41.649] <TB2> INFO: Expecting 41600 events.
[14:39:45.949] <TB2> INFO: 41600 events read in total (3585ms).
[14:39:45.949] <TB2> INFO: Test took 4606ms.
[14:39:45.955] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:39:46.524] <TB2> INFO: Expecting 41600 events.
[14:39:50.836] <TB2> INFO: 41600 events read in total (3596ms).
[14:39:50.837] <TB2> INFO: Test took 4618ms.
[14:39:50.843] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:39:51.185] <TB2> INFO: Expecting 41600 events.
[14:39:55.406] <TB2> INFO: 41600 events read in total (3505ms).
[14:39:55.406] <TB2> INFO: Test took 4545ms.
[14:39:55.412] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:39:55.762] <TB2> INFO: Expecting 2560 events.
[14:39:56.824] <TB2> INFO: 2560 events read in total (347ms).
[14:39:56.824] <TB2> INFO: Test took 1403ms.
[14:39:57.238] <TB2> INFO: Expecting 2560 events.
[14:39:58.305] <TB2> INFO: 2560 events read in total (352ms).
[14:39:58.305] <TB2> INFO: Test took 1481ms.
[14:39:58.719] <TB2> INFO: Expecting 2560 events.
[14:39:59.779] <TB2> INFO: 2560 events read in total (345ms).
[14:39:59.780] <TB2> INFO: Test took 1474ms.
[14:40:00.194] <TB2> INFO: Expecting 2560 events.
[14:40:01.261] <TB2> INFO: 2560 events read in total (351ms).
[14:40:01.261] <TB2> INFO: Test took 1481ms.
[14:40:01.674] <TB2> INFO: Expecting 2560 events.
[14:40:02.740] <TB2> INFO: 2560 events read in total (350ms).
[14:40:02.741] <TB2> INFO: Test took 1479ms.
[14:40:03.155] <TB2> INFO: Expecting 2560 events.
[14:40:04.222] <TB2> INFO: 2560 events read in total (351ms).
[14:40:04.222] <TB2> INFO: Test took 1481ms.
[14:40:04.636] <TB2> INFO: Expecting 2560 events.
[14:40:05.699] <TB2> INFO: 2560 events read in total (348ms).
[14:40:05.700] <TB2> INFO: Test took 1478ms.
[14:40:06.113] <TB2> INFO: Expecting 2560 events.
[14:40:07.191] <TB2> INFO: 2560 events read in total (362ms).
[14:40:07.191] <TB2> INFO: Test took 1491ms.
[14:40:07.604] <TB2> INFO: Expecting 2560 events.
[14:40:08.666] <TB2> INFO: 2560 events read in total (346ms).
[14:40:08.666] <TB2> INFO: Test took 1475ms.
[14:40:09.080] <TB2> INFO: Expecting 2560 events.
[14:40:10.141] <TB2> INFO: 2560 events read in total (345ms).
[14:40:10.141] <TB2> INFO: Test took 1475ms.
[14:40:10.555] <TB2> INFO: Expecting 2560 events.
[14:40:11.646] <TB2> INFO: 2560 events read in total (376ms).
[14:40:11.646] <TB2> INFO: Test took 1504ms.
[14:40:12.060] <TB2> INFO: Expecting 2560 events.
[14:40:13.137] <TB2> INFO: 2560 events read in total (361ms).
[14:40:13.137] <TB2> INFO: Test took 1490ms.
[14:40:13.551] <TB2> INFO: Expecting 2560 events.
[14:40:14.612] <TB2> INFO: 2560 events read in total (346ms).
[14:40:14.612] <TB2> INFO: Test took 1474ms.
[14:40:15.025] <TB2> INFO: Expecting 2560 events.
[14:40:16.115] <TB2> INFO: 2560 events read in total (374ms).
[14:40:16.115] <TB2> INFO: Test took 1502ms.
[14:40:16.529] <TB2> INFO: Expecting 2560 events.
[14:40:17.589] <TB2> INFO: 2560 events read in total (345ms).
[14:40:17.589] <TB2> INFO: Test took 1474ms.
[14:40:18.003] <TB2> INFO: Expecting 2560 events.
[14:40:19.078] <TB2> INFO: 2560 events read in total (360ms).
[14:40:19.078] <TB2> INFO: Test took 1489ms.
[14:40:19.081] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:40:19.494] <TB2> INFO: Expecting 655360 events.
[14:40:34.783] <TB2> INFO: 655360 events read in total (14574ms).
[14:40:34.795] <TB2> INFO: Expecting 655360 events.
[14:40:49.736] <TB2> INFO: 655360 events read in total (14413ms).
[14:40:49.748] <TB2> INFO: Expecting 655360 events.
[14:41:05.811] <TB2> INFO: 655360 events read in total (15535ms).
[14:41:05.830] <TB2> INFO: Expecting 655360 events.
[14:41:20.415] <TB2> INFO: 655360 events read in total (14058ms).
[14:41:20.433] <TB2> INFO: Expecting 655360 events.
[14:41:35.600] <TB2> INFO: 655360 events read in total (14639ms).
[14:41:35.623] <TB2> INFO: Expecting 655360 events.
[14:41:51.580] <TB2> INFO: 655360 events read in total (15430ms).
[14:41:51.606] <TB2> INFO: Expecting 655360 events.
[14:42:06.243] <TB2> INFO: 655360 events read in total (14109ms).
[14:42:06.275] <TB2> INFO: Expecting 655360 events.
[14:42:20.075] <TB2> INFO: 655360 events read in total (13273ms).
[14:42:20.108] <TB2> INFO: Expecting 655360 events.
[14:42:33.971] <TB2> INFO: 655360 events read in total (13336ms).
[14:42:34.010] <TB2> INFO: Expecting 655360 events.
[14:42:48.457] <TB2> INFO: 655360 events read in total (13920ms).
[14:42:48.496] <TB2> INFO: Expecting 655360 events.
[14:43:03.659] <TB2> INFO: 655360 events read in total (14636ms).
[14:43:03.701] <TB2> INFO: Expecting 655360 events.
[14:43:19.386] <TB2> INFO: 655360 events read in total (15157ms).
[14:43:19.433] <TB2> INFO: Expecting 655360 events.
[14:43:33.811] <TB2> INFO: 655360 events read in total (13851ms).
[14:43:33.864] <TB2> INFO: Expecting 655360 events.
[14:43:49.130] <TB2> INFO: 655360 events read in total (14739ms).
[14:43:49.185] <TB2> INFO: Expecting 655360 events.
[14:44:04.976] <TB2> INFO: 655360 events read in total (15264ms).
[14:44:05.033] <TB2> INFO: Expecting 655360 events.
[14:44:19.184] <TB2> INFO: 655360 events read in total (13623ms).
[14:44:19.248] <TB2> INFO: Test took 240167ms.
[14:44:19.331] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:44:19.641] <TB2> INFO: Expecting 655360 events.
[14:44:35.390] <TB2> INFO: 655360 events read in total (15034ms).
[14:44:35.400] <TB2> INFO: Expecting 655360 events.
[14:44:51.098] <TB2> INFO: 655360 events read in total (15171ms).
[14:44:51.111] <TB2> INFO: Expecting 655360 events.
[14:45:05.466] <TB2> INFO: 655360 events read in total (13828ms).
[14:45:05.483] <TB2> INFO: Expecting 655360 events.
[14:45:21.195] <TB2> INFO: 655360 events read in total (15184ms).
[14:45:21.216] <TB2> INFO: Expecting 655360 events.
[14:45:36.946] <TB2> INFO: 655360 events read in total (15202ms).
[14:45:36.974] <TB2> INFO: Expecting 655360 events.
[14:45:50.632] <TB2> INFO: 655360 events read in total (13131ms).
[14:45:50.664] <TB2> INFO: Expecting 655360 events.
[14:46:04.183] <TB2> INFO: 655360 events read in total (12992ms).
[14:46:04.211] <TB2> INFO: Expecting 655360 events.
[14:46:18.189] <TB2> INFO: 655360 events read in total (13450ms).
[14:46:18.221] <TB2> INFO: Expecting 655360 events.
[14:46:33.101] <TB2> INFO: 655360 events read in total (14352ms).
[14:46:33.138] <TB2> INFO: Expecting 655360 events.
[14:46:49.009] <TB2> INFO: 655360 events read in total (15344ms).
[14:46:49.048] <TB2> INFO: Expecting 655360 events.
[14:47:04.101] <TB2> INFO: 655360 events read in total (14526ms).
[14:47:04.149] <TB2> INFO: Expecting 655360 events.
[14:47:18.891] <TB2> INFO: 655360 events read in total (14214ms).
[14:47:18.942] <TB2> INFO: Expecting 655360 events.
[14:47:35.239] <TB2> INFO: 655360 events read in total (15770ms).
[14:47:35.291] <TB2> INFO: Expecting 655360 events.
[14:47:49.743] <TB2> INFO: 655360 events read in total (13925ms).
[14:47:49.796] <TB2> INFO: Expecting 655360 events.
[14:48:04.711] <TB2> INFO: 655360 events read in total (14388ms).
[14:48:04.770] <TB2> INFO: Expecting 655360 events.
[14:48:20.638] <TB2> INFO: 655360 events read in total (15341ms).
[14:48:20.698] <TB2> INFO: Test took 241367ms.
[14:48:20.895] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.902] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.909] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.916] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.923] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.929] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.936] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.943] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.950] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.957] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.963] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.970] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.977] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.984] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.990] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:20.997] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[14:48:21.030] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C0.dat
[14:48:21.030] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C1.dat
[14:48:21.030] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C2.dat
[14:48:21.030] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C3.dat
[14:48:21.030] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C4.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C5.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C6.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C7.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C8.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C9.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C10.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C11.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C12.dat
[14:48:21.031] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C13.dat
[14:48:21.032] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C14.dat
[14:48:21.032] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//dacParameters35_C15.dat
[14:48:21.339] <TB2> INFO: Expecting 41600 events.
[14:48:25.367] <TB2> INFO: 41600 events read in total (3312ms).
[14:48:25.367] <TB2> INFO: Test took 4333ms.
[14:48:25.953] <TB2> INFO: Expecting 41600 events.
[14:48:29.910] <TB2> INFO: 41600 events read in total (3242ms).
[14:48:29.910] <TB2> INFO: Test took 4301ms.
[14:48:30.460] <TB2> INFO: Expecting 41600 events.
[14:48:34.450] <TB2> INFO: 41600 events read in total (3275ms).
[14:48:34.450] <TB2> INFO: Test took 4302ms.
[14:48:34.675] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:34.807] <TB2> INFO: Expecting 2560 events.
[14:48:35.874] <TB2> INFO: 2560 events read in total (352ms).
[14:48:35.875] <TB2> INFO: Test took 1201ms.
[14:48:35.877] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:36.289] <TB2> INFO: Expecting 2560 events.
[14:48:37.357] <TB2> INFO: 2560 events read in total (352ms).
[14:48:37.357] <TB2> INFO: Test took 1480ms.
[14:48:37.360] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:37.772] <TB2> INFO: Expecting 2560 events.
[14:48:38.834] <TB2> INFO: 2560 events read in total (346ms).
[14:48:38.835] <TB2> INFO: Test took 1475ms.
[14:48:38.838] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:39.248] <TB2> INFO: Expecting 2560 events.
[14:48:40.311] <TB2> INFO: 2560 events read in total (347ms).
[14:48:40.312] <TB2> INFO: Test took 1474ms.
[14:48:40.314] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:40.726] <TB2> INFO: Expecting 2560 events.
[14:48:41.787] <TB2> INFO: 2560 events read in total (345ms).
[14:48:41.787] <TB2> INFO: Test took 1473ms.
[14:48:41.789] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:42.202] <TB2> INFO: Expecting 2560 events.
[14:48:43.263] <TB2> INFO: 2560 events read in total (346ms).
[14:48:43.264] <TB2> INFO: Test took 1475ms.
[14:48:43.266] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:43.678] <TB2> INFO: Expecting 2560 events.
[14:48:44.753] <TB2> INFO: 2560 events read in total (360ms).
[14:48:44.753] <TB2> INFO: Test took 1488ms.
[14:48:44.754] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:45.167] <TB2> INFO: Expecting 2560 events.
[14:48:46.258] <TB2> INFO: 2560 events read in total (375ms).
[14:48:46.259] <TB2> INFO: Test took 1505ms.
[14:48:46.261] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:46.673] <TB2> INFO: Expecting 2560 events.
[14:48:47.736] <TB2> INFO: 2560 events read in total (347ms).
[14:48:47.736] <TB2> INFO: Test took 1475ms.
[14:48:47.738] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:48.151] <TB2> INFO: Expecting 2560 events.
[14:48:49.211] <TB2> INFO: 2560 events read in total (344ms).
[14:48:49.212] <TB2> INFO: Test took 1474ms.
[14:48:49.213] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:49.626] <TB2> INFO: Expecting 2560 events.
[14:48:50.703] <TB2> INFO: 2560 events read in total (361ms).
[14:48:50.703] <TB2> INFO: Test took 1490ms.
[14:48:50.704] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:51.117] <TB2> INFO: Expecting 2560 events.
[14:48:52.207] <TB2> INFO: 2560 events read in total (374ms).
[14:48:52.207] <TB2> INFO: Test took 1503ms.
[14:48:52.208] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:52.621] <TB2> INFO: Expecting 2560 events.
[14:48:53.682] <TB2> INFO: 2560 events read in total (345ms).
[14:48:53.683] <TB2> INFO: Test took 1475ms.
[14:48:53.684] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:54.097] <TB2> INFO: Expecting 2560 events.
[14:48:55.158] <TB2> INFO: 2560 events read in total (345ms).
[14:48:55.159] <TB2> INFO: Test took 1475ms.
[14:48:55.160] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:55.573] <TB2> INFO: Expecting 2560 events.
[14:48:56.636] <TB2> INFO: 2560 events read in total (347ms).
[14:48:56.637] <TB2> INFO: Test took 1477ms.
[14:48:56.638] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:57.051] <TB2> INFO: Expecting 2560 events.
[14:48:58.115] <TB2> INFO: 2560 events read in total (348ms).
[14:48:58.116] <TB2> INFO: Test took 1478ms.
[14:48:58.118] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:48:58.530] <TB2> INFO: Expecting 2560 events.
[14:48:59.591] <TB2> INFO: 2560 events read in total (346ms).
[14:48:59.591] <TB2> INFO: Test took 1474ms.
[14:48:59.593] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:00.006] <TB2> INFO: Expecting 2560 events.
[14:49:01.070] <TB2> INFO: 2560 events read in total (349ms).
[14:49:01.070] <TB2> INFO: Test took 1477ms.
[14:49:01.072] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:01.484] <TB2> INFO: Expecting 2560 events.
[14:49:02.548] <TB2> INFO: 2560 events read in total (348ms).
[14:49:02.548] <TB2> INFO: Test took 1476ms.
[14:49:02.550] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:02.962] <TB2> INFO: Expecting 2560 events.
[14:49:04.025] <TB2> INFO: 2560 events read in total (347ms).
[14:49:04.025] <TB2> INFO: Test took 1475ms.
[14:49:04.027] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:04.440] <TB2> INFO: Expecting 2560 events.
[14:49:05.503] <TB2> INFO: 2560 events read in total (348ms).
[14:49:05.503] <TB2> INFO: Test took 1476ms.
[14:49:05.505] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:05.918] <TB2> INFO: Expecting 2560 events.
[14:49:06.981] <TB2> INFO: 2560 events read in total (348ms).
[14:49:06.981] <TB2> INFO: Test took 1476ms.
[14:49:06.983] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:07.395] <TB2> INFO: Expecting 2560 events.
[14:49:08.456] <TB2> INFO: 2560 events read in total (345ms).
[14:49:08.456] <TB2> INFO: Test took 1473ms.
[14:49:08.458] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:08.870] <TB2> INFO: Expecting 2560 events.
[14:49:09.931] <TB2> INFO: 2560 events read in total (345ms).
[14:49:09.931] <TB2> INFO: Test took 1473ms.
[14:49:09.932] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:10.345] <TB2> INFO: Expecting 2560 events.
[14:49:11.406] <TB2> INFO: 2560 events read in total (345ms).
[14:49:11.406] <TB2> INFO: Test took 1474ms.
[14:49:11.408] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:11.821] <TB2> INFO: Expecting 2560 events.
[14:49:12.884] <TB2> INFO: 2560 events read in total (348ms).
[14:49:12.885] <TB2> INFO: Test took 1477ms.
[14:49:12.887] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:13.299] <TB2> INFO: Expecting 2560 events.
[14:49:14.363] <TB2> INFO: 2560 events read in total (348ms).
[14:49:14.363] <TB2> INFO: Test took 1477ms.
[14:49:14.365] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:14.777] <TB2> INFO: Expecting 2560 events.
[14:49:15.841] <TB2> INFO: 2560 events read in total (348ms).
[14:49:15.841] <TB2> INFO: Test took 1476ms.
[14:49:15.843] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:16.256] <TB2> INFO: Expecting 2560 events.
[14:49:17.319] <TB2> INFO: 2560 events read in total (348ms).
[14:49:17.319] <TB2> INFO: Test took 1476ms.
[14:49:17.321] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:17.734] <TB2> INFO: Expecting 2560 events.
[14:49:18.797] <TB2> INFO: 2560 events read in total (348ms).
[14:49:18.797] <TB2> INFO: Test took 1476ms.
[14:49:18.799] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:19.211] <TB2> INFO: Expecting 2560 events.
[14:49:20.275] <TB2> INFO: 2560 events read in total (348ms).
[14:49:20.275] <TB2> INFO: Test took 1476ms.
[14:49:20.277] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:49:20.690] <TB2> INFO: Expecting 2560 events.
[14:49:21.753] <TB2> INFO: 2560 events read in total (348ms).
[14:49:21.753] <TB2> INFO: Test took 1476ms.
[14:49:22.361] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 581 seconds
[14:49:22.361] <TB2> INFO: PH scale (per ROC): 74 70 76 65 69 71 66 69 69 71 66 75 67 71 67 76
[14:49:22.361] <TB2> INFO: PH offset (per ROC): 163 180 175 184 186 181 176 161 177 189 175 179 187 197 176 173
[14:49:22.366] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:49:22.366] <TB2> INFO: Decoding statistics:
[14:49:22.366] <TB2> INFO: General information:
[14:49:22.366] <TB2> INFO: 16bit words read: 91928
[14:49:22.366] <TB2> INFO: valid events total: 10240
[14:49:22.366] <TB2> INFO: empty events: 7738
[14:49:22.366] <TB2> INFO: valid events with pixels: 2502
[14:49:22.366] <TB2> INFO: valid pixel hits: 2502
[14:49:22.366] <TB2> INFO: Event errors: 0
[14:49:22.366] <TB2> INFO: start marker: 0
[14:49:22.367] <TB2> INFO: stop marker: 0
[14:49:22.367] <TB2> INFO: overflow: 0
[14:49:22.367] <TB2> INFO: invalid 5bit words: 0
[14:49:22.367] <TB2> INFO: invalid XOR eye diagram: 0
[14:49:22.367] <TB2> INFO: TBM errors: 0
[14:49:22.367] <TB2> INFO: flawed TBM headers: 0
[14:49:22.367] <TB2> INFO: flawed TBM trailers: 0
[14:49:22.367] <TB2> INFO: event ID mismatches: 0
[14:49:22.367] <TB2> INFO: ROC errors: 0
[14:49:22.367] <TB2> INFO: missing ROC header(s): 0
[14:49:22.367] <TB2> INFO: misplaced readback start: 0
[14:49:22.367] <TB2> INFO: Pixel decoding errors: 0
[14:49:22.367] <TB2> INFO: pixel data incomplete: 0
[14:49:22.367] <TB2> INFO: pixel address: 0
[14:49:22.367] <TB2> INFO: pulse height fill bit: 0
[14:49:22.367] <TB2> INFO: buffer corruption: 0
[14:49:22.576] <TB2> INFO: ######################################################################
[14:49:22.576] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[14:49:22.576] <TB2> INFO: ######################################################################
[14:49:22.586] <TB2> INFO: scanning low vcal = 10
[14:49:22.889] <TB2> INFO: Expecting 41600 events.
[14:49:26.679] <TB2> INFO: 41600 events read in total (3075ms).
[14:49:26.679] <TB2> INFO: Test took 4093ms.
[14:49:26.681] <TB2> INFO: scanning low vcal = 20
[14:49:27.093] <TB2> INFO: Expecting 41600 events.
[14:49:30.877] <TB2> INFO: 41600 events read in total (3069ms).
[14:49:30.878] <TB2> INFO: Test took 4197ms.
[14:49:30.879] <TB2> INFO: scanning low vcal = 30
[14:49:31.292] <TB2> INFO: Expecting 41600 events.
[14:49:35.058] <TB2> INFO: 41600 events read in total (3051ms).
[14:49:35.059] <TB2> INFO: Test took 4180ms.
[14:49:35.060] <TB2> INFO: scanning low vcal = 40
[14:49:35.465] <TB2> INFO: Expecting 41600 events.
[14:49:39.682] <TB2> INFO: 41600 events read in total (3501ms).
[14:49:39.683] <TB2> INFO: Test took 4623ms.
[14:49:39.685] <TB2> INFO: scanning low vcal = 50
[14:49:40.038] <TB2> INFO: Expecting 41600 events.
[14:49:44.317] <TB2> INFO: 41600 events read in total (3564ms).
[14:49:44.318] <TB2> INFO: Test took 4633ms.
[14:49:44.320] <TB2> INFO: scanning low vcal = 60
[14:49:44.667] <TB2> INFO: Expecting 41600 events.
[14:49:49.106] <TB2> INFO: 41600 events read in total (3723ms).
[14:49:49.106] <TB2> INFO: Test took 4786ms.
[14:49:49.108] <TB2> INFO: scanning low vcal = 70
[14:49:49.465] <TB2> INFO: Expecting 41600 events.
[14:49:54.093] <TB2> INFO: 41600 events read in total (3912ms).
[14:49:54.094] <TB2> INFO: Test took 4986ms.
[14:49:54.096] <TB2> INFO: scanning low vcal = 80
[14:49:54.443] <TB2> INFO: Expecting 41600 events.
[14:49:58.951] <TB2> INFO: 41600 events read in total (3793ms).
[14:49:58.952] <TB2> INFO: Test took 4856ms.
[14:49:58.954] <TB2> INFO: scanning low vcal = 90
[14:49:59.292] <TB2> INFO: Expecting 41600 events.
[14:50:03.858] <TB2> INFO: 41600 events read in total (3851ms).
[14:50:03.859] <TB2> INFO: Test took 4905ms.
[14:50:03.862] <TB2> INFO: scanning low vcal = 100
[14:50:04.197] <TB2> INFO: Expecting 41600 events.
[14:50:08.702] <TB2> INFO: 41600 events read in total (3789ms).
[14:50:08.703] <TB2> INFO: Test took 4841ms.
[14:50:08.705] <TB2> INFO: scanning low vcal = 110
[14:50:09.060] <TB2> INFO: Expecting 41600 events.
[14:50:13.463] <TB2> INFO: 41600 events read in total (3687ms).
[14:50:13.463] <TB2> INFO: Test took 4758ms.
[14:50:13.466] <TB2> INFO: scanning low vcal = 120
[14:50:13.816] <TB2> INFO: Expecting 41600 events.
[14:50:18.176] <TB2> INFO: 41600 events read in total (3644ms).
[14:50:18.176] <TB2> INFO: Test took 4710ms.
[14:50:18.179] <TB2> INFO: scanning low vcal = 130
[14:50:18.533] <TB2> INFO: Expecting 41600 events.
[14:50:22.922] <TB2> INFO: 41600 events read in total (3673ms).
[14:50:22.923] <TB2> INFO: Test took 4744ms.
[14:50:22.925] <TB2> INFO: scanning low vcal = 140
[14:50:23.283] <TB2> INFO: Expecting 41600 events.
[14:50:27.712] <TB2> INFO: 41600 events read in total (3713ms).
[14:50:27.712] <TB2> INFO: Test took 4787ms.
[14:50:27.715] <TB2> INFO: scanning low vcal = 150
[14:50:28.071] <TB2> INFO: Expecting 41600 events.
[14:50:32.521] <TB2> INFO: 41600 events read in total (3734ms).
[14:50:32.521] <TB2> INFO: Test took 4806ms.
[14:50:32.524] <TB2> INFO: scanning low vcal = 160
[14:50:32.878] <TB2> INFO: Expecting 41600 events.
[14:50:37.338] <TB2> INFO: 41600 events read in total (3745ms).
[14:50:37.339] <TB2> INFO: Test took 4815ms.
[14:50:37.341] <TB2> INFO: scanning low vcal = 170
[14:50:37.697] <TB2> INFO: Expecting 41600 events.
[14:50:42.124] <TB2> INFO: 41600 events read in total (3712ms).
[14:50:42.124] <TB2> INFO: Test took 4783ms.
[14:50:42.128] <TB2> INFO: scanning low vcal = 180
[14:50:42.483] <TB2> INFO: Expecting 41600 events.
[14:50:46.935] <TB2> INFO: 41600 events read in total (3737ms).
[14:50:46.936] <TB2> INFO: Test took 4808ms.
[14:50:46.938] <TB2> INFO: scanning low vcal = 190
[14:50:47.291] <TB2> INFO: Expecting 41600 events.
[14:50:51.624] <TB2> INFO: 41600 events read in total (3617ms).
[14:50:51.624] <TB2> INFO: Test took 4686ms.
[14:50:51.627] <TB2> INFO: scanning low vcal = 200
[14:50:51.983] <TB2> INFO: Expecting 41600 events.
[14:50:56.322] <TB2> INFO: 41600 events read in total (3623ms).
[14:50:56.323] <TB2> INFO: Test took 4696ms.
[14:50:56.325] <TB2> INFO: scanning low vcal = 210
[14:50:56.674] <TB2> INFO: Expecting 41600 events.
[14:51:01.046] <TB2> INFO: 41600 events read in total (3657ms).
[14:51:01.047] <TB2> INFO: Test took 4722ms.
[14:51:01.049] <TB2> INFO: scanning low vcal = 220
[14:51:01.402] <TB2> INFO: Expecting 41600 events.
[14:51:05.794] <TB2> INFO: 41600 events read in total (3676ms).
[14:51:05.794] <TB2> INFO: Test took 4745ms.
[14:51:05.797] <TB2> INFO: scanning low vcal = 230
[14:51:06.147] <TB2> INFO: Expecting 41600 events.
[14:51:10.702] <TB2> INFO: 41600 events read in total (3839ms).
[14:51:10.703] <TB2> INFO: Test took 4906ms.
[14:51:10.705] <TB2> INFO: scanning low vcal = 240
[14:51:11.059] <TB2> INFO: Expecting 41600 events.
[14:51:15.504] <TB2> INFO: 41600 events read in total (3730ms).
[14:51:15.504] <TB2> INFO: Test took 4799ms.
[14:51:15.507] <TB2> INFO: scanning low vcal = 250
[14:51:15.859] <TB2> INFO: Expecting 41600 events.
[14:51:20.413] <TB2> INFO: 41600 events read in total (3838ms).
[14:51:20.414] <TB2> INFO: Test took 4907ms.
[14:51:20.417] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[14:51:20.766] <TB2> INFO: Expecting 41600 events.
[14:51:25.233] <TB2> INFO: 41600 events read in total (3752ms).
[14:51:25.234] <TB2> INFO: Test took 4816ms.
[14:51:25.236] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[14:51:25.588] <TB2> INFO: Expecting 41600 events.
[14:51:30.015] <TB2> INFO: 41600 events read in total (3711ms).
[14:51:30.015] <TB2> INFO: Test took 4779ms.
[14:51:30.018] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[14:51:30.372] <TB2> INFO: Expecting 41600 events.
[14:51:34.758] <TB2> INFO: 41600 events read in total (3670ms).
[14:51:34.758] <TB2> INFO: Test took 4740ms.
[14:51:34.761] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[14:51:35.114] <TB2> INFO: Expecting 41600 events.
[14:51:39.448] <TB2> INFO: 41600 events read in total (3618ms).
[14:51:39.448] <TB2> INFO: Test took 4687ms.
[14:51:39.451] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[14:51:39.807] <TB2> INFO: Expecting 41600 events.
[14:51:44.163] <TB2> INFO: 41600 events read in total (3640ms).
[14:51:44.163] <TB2> INFO: Test took 4712ms.
[14:51:44.617] <TB2> INFO: PixTestGainPedestal::measure() done
[14:52:18.898] <TB2> INFO: PixTestGainPedestal::fit() done
[14:52:18.898] <TB2> INFO: non-linearity mean: 0.960 0.957 0.954 0.957 0.957 0.957 0.954 0.953 0.953 0.960 0.956 0.958 0.956 0.961 0.959 0.963
[14:52:18.898] <TB2> INFO: non-linearity RMS: 0.006 0.007 0.007 0.007 0.007 0.007 0.006 0.007 0.008 0.008 0.006 0.006 0.006 0.005 0.005 0.006
[14:52:18.898] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[14:52:18.923] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[14:52:18.941] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[14:52:18.965] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[14:52:18.991] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[14:52:19.017] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[14:52:19.043] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[14:52:19.062] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[14:52:19.082] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[14:52:19.101] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[14:52:19.121] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[14:52:19.144] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[14:52:19.167] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[14:52:19.190] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[14:52:19.211] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[14:52:19.233] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[14:52:19.254] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 176 seconds
[14:52:19.254] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:52:19.254] <TB2> INFO: Decoding statistics:
[14:52:19.254] <TB2> INFO: General information:
[14:52:19.254] <TB2> INFO: 16bit words read: 2662400
[14:52:19.254] <TB2> INFO: valid events total: 166400
[14:52:19.254] <TB2> INFO: empty events: 0
[14:52:19.254] <TB2> INFO: valid events with pixels: 166400
[14:52:19.254] <TB2> INFO: valid pixel hits: 665590
[14:52:19.254] <TB2> INFO: Event errors: 0
[14:52:19.254] <TB2> INFO: start marker: 0
[14:52:19.254] <TB2> INFO: stop marker: 0
[14:52:19.254] <TB2> INFO: overflow: 0
[14:52:19.254] <TB2> INFO: invalid 5bit words: 0
[14:52:19.254] <TB2> INFO: invalid XOR eye diagram: 0
[14:52:19.254] <TB2> INFO: TBM errors: 0
[14:52:19.254] <TB2> INFO: flawed TBM headers: 0
[14:52:19.254] <TB2> INFO: flawed TBM trailers: 0
[14:52:19.255] <TB2> INFO: event ID mismatches: 0
[14:52:19.255] <TB2> INFO: ROC errors: 0
[14:52:19.255] <TB2> INFO: missing ROC header(s): 0
[14:52:19.255] <TB2> INFO: misplaced readback start: 0
[14:52:19.255] <TB2> INFO: Pixel decoding errors: 0
[14:52:19.255] <TB2> INFO: pixel data incomplete: 0
[14:52:19.255] <TB2> INFO: pixel address: 0
[14:52:19.255] <TB2> INFO: pulse height fill bit: 0
[14:52:19.255] <TB2> INFO: buffer corruption: 0
[14:52:19.262] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C15.dat
[14:52:19.264] <TB2> INFO: ######################################################################
[14:52:19.264] <TB2> INFO: PixTestReadback::doTest()
[14:52:19.264] <TB2> INFO: ######################################################################
[14:52:19.264] <TB2> INFO: PixTestReadback::RES sent once
[14:52:30.463] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C0.dat
[14:52:30.463] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C1.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C2.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C3.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C4.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C5.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C6.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C7.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C8.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C9.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C10.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C11.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C12.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C13.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C14.dat
[14:52:30.464] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C15.dat
[14:52:30.492] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[14:52:30.492] <TB2> INFO: PixTestReadback::RES sent once
[14:52:41.674] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C0.dat
[14:52:41.674] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C1.dat
[14:52:41.674] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C2.dat
[14:52:41.674] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C3.dat
[14:52:41.675] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C4.dat
[14:52:41.675] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C5.dat
[14:52:41.675] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C6.dat
[14:52:41.675] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C7.dat
[14:52:41.675] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C8.dat
[14:52:41.675] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C9.dat
[14:52:41.675] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C10.dat
[14:52:41.676] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C11.dat
[14:52:41.676] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C12.dat
[14:52:41.676] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C13.dat
[14:52:41.676] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C14.dat
[14:52:41.676] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C15.dat
[14:52:41.707] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[14:52:41.708] <TB2> INFO: PixTestReadback::RES sent once
[14:52:50.304] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[14:52:50.304] <TB2> INFO: Vbg will be calibrated using Vd calibration
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 151.8calibrated Vbg = 1.20546 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 145.4calibrated Vbg = 1.20143 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 152.6calibrated Vbg = 1.21018 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 155calibrated Vbg = 1.22048 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 163calibrated Vbg = 1.2191 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 156.2calibrated Vbg = 1.22031 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 156.9calibrated Vbg = 1.22007 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 147.3calibrated Vbg = 1.2204 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 147.1calibrated Vbg = 1.21875 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 153.7calibrated Vbg = 1.2197 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 148.9calibrated Vbg = 1.21913 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 149.9calibrated Vbg = 1.2118 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 143.6calibrated Vbg = 1.21018 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 155.4calibrated Vbg = 1.2051 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 153.1calibrated Vbg = 1.21195 :::*/*/*/*/
[14:52:50.304] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 148.4calibrated Vbg = 1.20955 :::*/*/*/*/
[14:52:50.306] <TB2> INFO: PixTestReadback::RES sent once
[14:55:44.557] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C0.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C1.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C2.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C3.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C4.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C5.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C6.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C7.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C8.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C9.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C10.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C11.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C12.dat
[14:55:44.558] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C13.dat
[14:55:44.559] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C14.dat
[14:55:44.559] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2141_FullQualification_2016-01-13_08h36m_1452670570//004_FulltestPxar_p17//readbackCal_C15.dat
[14:55:44.586] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[14:55:44.586] <TB2> INFO: PixTestReadback::doTest() done
[14:55:44.587] <TB2> INFO: Fetched DAQ statistics. Counters are being reset now.
[14:55:44.587] <TB2> INFO: Decoding statistics:
[14:55:44.587] <TB2> INFO: General information:
[14:55:44.587] <TB2> INFO: 16bit words read: 1024
[14:55:44.587] <TB2> INFO: valid events total: 128
[14:55:44.587] <TB2> INFO: empty events: 128
[14:55:44.587] <TB2> INFO: valid events with pixels: 0
[14:55:44.587] <TB2> INFO: valid pixel hits: 0
[14:55:44.587] <TB2> INFO: Event errors: 0
[14:55:44.587] <TB2> INFO: start marker: 0
[14:55:44.587] <TB2> INFO: stop marker: 0
[14:55:44.587] <TB2> INFO: overflow: 0
[14:55:44.587] <TB2> INFO: invalid 5bit words: 0
[14:55:44.587] <TB2> INFO: invalid XOR eye diagram: 0
[14:55:44.587] <TB2> INFO: TBM errors: 0
[14:55:44.587] <TB2> INFO: flawed TBM headers: 0
[14:55:44.587] <TB2> INFO: flawed TBM trailers: 0
[14:55:44.587] <TB2> INFO: event ID mismatches: 0
[14:55:44.587] <TB2> INFO: ROC errors: 0
[14:55:44.587] <TB2> INFO: missing ROC header(s): 0
[14:55:44.587] <TB2> INFO: misplaced readback start: 0
[14:55:44.587] <TB2> INFO: Pixel decoding errors: 0
[14:55:44.587] <TB2> INFO: pixel data incomplete: 0
[14:55:44.587] <TB2> INFO: pixel address: 0
[14:55:44.587] <TB2> INFO: pulse height fill bit: 0
[14:55:44.587] <TB2> INFO: buffer corruption: 0
[14:55:44.599] <TB2> INFO: Decoding statistics:
[14:55:44.600] <TB2> INFO: General information:
[14:55:44.600] <TB2> INFO: 16bit words read: 2755352
[14:55:44.600] <TB2> INFO: valid events total: 176768
[14:55:44.600] <TB2> INFO: empty events: 7866
[14:55:44.600] <TB2> INFO: valid events with pixels: 168902
[14:55:44.600] <TB2> INFO: valid pixel hits: 668092
[14:55:44.600] <TB2> INFO: Event errors: 0
[14:55:44.600] <TB2> INFO: start marker: 0
[14:55:44.600] <TB2> INFO: stop marker: 0
[14:55:44.600] <TB2> INFO: overflow: 0
[14:55:44.600] <TB2> INFO: invalid 5bit words: 0
[14:55:44.600] <TB2> INFO: invalid XOR eye diagram: 0
[14:55:44.600] <TB2> INFO: TBM errors: 0
[14:55:44.600] <TB2> INFO: flawed TBM headers: 0
[14:55:44.600] <TB2> INFO: flawed TBM trailers: 0
[14:55:44.600] <TB2> INFO: event ID mismatches: 0
[14:55:44.600] <TB2> INFO: ROC errors: 0
[14:55:44.600] <TB2> INFO: missing ROC header(s): 0
[14:55:44.600] <TB2> INFO: misplaced readback start: 0
[14:55:44.600] <TB2> INFO: Pixel decoding errors: 0
[14:55:44.600] <TB2> INFO: pixel data incomplete: 0
[14:55:44.600] <TB2> INFO: pixel address: 0
[14:55:44.600] <TB2> INFO: pulse height fill bit: 0
[14:55:44.600] <TB2> INFO: buffer corruption: 0
[14:55:44.604] <TB2> INFO: enter test to run
[14:55:44.604] <TB2> INFO: test: exit no parameter change
[14:55:44.806] <TB2> QUIET: Connection to board 156 closed.
[14:55:44.886] <TB2> INFO: pXar: this is the end, my friend