[16:12:31.063] <TB2> INFO: *** Welcome to pxar ***
[16:12:31.063] <TB2> INFO: *** Today: 2016/04/22
[16:12:31.158] <TB2> INFO: *** Version: 9751-dirty
[16:12:31.158] <TB2> INFO: readRocDacs: /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C15.dat
[16:12:31.160] <TB2> INFO: readTbmDacs: /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//tbmParameters_C0b.dat
[16:12:31.160] <TB2> INFO: readMaskFile: /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//defaultMaskFile.dat
[16:12:31.160] <TB2> INFO: readTrimFile: /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters_C15.dat
[16:12:31.229] <TB2> INFO: clk: 4
[16:12:31.229] <TB2> INFO: ctr: 4
[16:12:31.229] <TB2> INFO: sda: 19
[16:12:31.229] <TB2> INFO: tin: 9
[16:12:31.229] <TB2> INFO: level: 15
[16:12:31.229] <TB2> INFO: triggerdelay: 0
[16:12:31.229] <TB2> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[16:12:31.229] <TB2> INFO: Log level: INFO
[16:12:31.236] <TB2> INFO: Found DTB DTB_WXC55Z
[16:12:31.245] <TB2> QUIET: Connection to board DTB_WXC55Z opened.
[16:12:31.247] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 156
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXC55Z
MAC address: 40D85511809C
Hostname: pixelDTB156
Comment:
------------------------------------------------------
[16:12:31.249] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[16:12:32.798] <TB2> INFO: DUT info:
[16:12:32.799] <TB2> INFO: The DUT currently contains the following objects:
[16:12:32.799] <TB2> INFO: 2 TBM Cores tbm09c (2 ON)
[16:12:32.799] <TB2> INFO: TBM Core alpha (0): 7 registers set
[16:12:32.799] <TB2> INFO: TBM Core beta (1): 7 registers set
[16:12:32.799] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:12:32.799] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:32.799] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:12:33.200] <TB2> INFO: enter 'restricted' command line mode
[16:12:33.200] <TB2> INFO: enter test to run
[16:12:33.200] <TB2> INFO: test: pretest no parameter change
[16:12:33.200] <TB2> INFO: running: pretest
[16:12:33.209] <TB2> INFO: ----------------------------------------------------------------------
[16:12:33.209] <TB2> INFO: PixTestPretest::programROC()
[16:12:33.209] <TB2> INFO: ----------------------------------------------------------------------
[16:12:51.224] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[16:12:51.224] <TB2> INFO: IA differences per ROC: 18.5 20.1 19.3 20.1 19.3 19.3 18.5 19.3 18.5 18.5 17.7 18.5 18.5 19.3 20.1 20.1
[16:12:51.331] <TB2> INFO: enter test to run
[16:12:51.331] <TB2> INFO: test: pretest no parameter change
[16:12:51.331] <TB2> INFO: running: pretest
[16:12:51.332] <TB2> INFO: ----------------------------------------------------------------------
[16:12:51.332] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[16:12:51.332] <TB2> INFO: ----------------------------------------------------------------------
[16:12:58.125] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 381 mA = 23.8125 mA/ROC
[16:12:58.125] <TB2> INFO: i(loss) [mA/ROC]: 19.2 19.2 19.2 19.2 19.2 19.2 19.2 19.2 19.2 19.2 19.2 17.6 19.2 19.2 19.2 19.2
[16:12:58.154] <TB2> INFO: enter test to run
[16:12:58.154] <TB2> INFO: test: pretest no parameter change
[16:12:58.154] <TB2> INFO: running: pretest
[16:12:58.154] <TB2> INFO: ----------------------------------------------------------------------
[16:12:58.154] <TB2> INFO: PixTestPretest::findTiming()
[16:12:58.154] <TB2> INFO: ----------------------------------------------------------------------
[16:12:58.157] <TB2> INFO: PixTestCmd::init()

[16:14:26.035] <TB2> INFO: TBM phases: 160MHz: 0, 400MHz: 2, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[16:14:26.035] <TB2> INFO: (success/tries = 100/100), width = 4
[16:14:26.036] <TB2> INFO: enter test to run
[16:14:26.036] <TB2> INFO: test: pretest no parameter change
[16:14:26.036] <TB2> INFO: running: pretest
[16:14:26.039] <TB2> INFO: ----------------------------------------------------------------------
[16:14:26.039] <TB2> INFO: PixTestPretest::findWorkingPixel()
[16:14:26.039] <TB2> INFO: ----------------------------------------------------------------------
[16:14:26.133] <TB2> INFO: Expecting 231680 events.


[16:14:36.379] <TB2> INFO: 231680 events read in total (9690ms).
[16:14:36.384] <TB2> INFO: Test took 10339ms.
[16:14:36.602] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[16:14:36.671] <TB2> INFO: enter test to run
[16:14:36.671] <TB2> INFO: test: pretest no parameter change
[16:14:36.671] <TB2> INFO: running: pretest
[16:14:36.673] <TB2> INFO: ----------------------------------------------------------------------
[16:14:36.673] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[16:14:36.673] <TB2> INFO: ----------------------------------------------------------------------
[16:14:36.765] <TB2> INFO: Expecting 231680 events.
[16:14:47.098] <TB2> INFO: 231680 events read in total (9777ms).
[16:14:47.103] <TB2> INFO: Test took 10426ms.
[16:14:47.332] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[16:14:47.332] <TB2> INFO: CalDel: 132 142 132 174 145 153 148 139 147 144 134 142 130 145 120 115
[16:14:47.332] <TB2> INFO: VthrComp: 51 52 51 51 51 54 51 54 52 51 51 51 51 51 51 56
[16:14:47.369] <TB2> INFO: enter test to run
[16:14:47.369] <TB2> INFO: test: pretest no parameter change
[16:14:47.369] <TB2> INFO: running: pretest
[16:14:47.369] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C0.dat
[16:14:47.370] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C1.dat
[16:14:47.370] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C2.dat
[16:14:47.370] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C3.dat
[16:14:47.370] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C4.dat
[16:14:47.370] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C5.dat
[16:14:47.370] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C6.dat
[16:14:47.370] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C7.dat
[16:14:47.371] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C8.dat
[16:14:47.371] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C9.dat
[16:14:47.371] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C10.dat
[16:14:47.371] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C11.dat
[16:14:47.371] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C12.dat
[16:14:47.371] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C13.dat
[16:14:47.371] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C14.dat
[16:14:47.372] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters_C15.dat
[16:14:47.372] <TB2> INFO: enter test to run
[16:14:47.372] <TB2> INFO: test: fulltest no parameter change
[16:14:47.372] <TB2> INFO: running: fulltest
[16:14:47.372] <TB2> INFO: ######################################################################
[16:14:47.372] <TB2> INFO: PixTestFullTest::doTest()
[16:14:47.372] <TB2> INFO: ######################################################################
[16:14:47.373] <TB2> INFO: ######################################################################
[16:14:47.373] <TB2> INFO: PixTestAlive::doTest()
[16:14:47.373] <TB2> INFO: ######################################################################
[16:14:47.374] <TB2> INFO: ----------------------------------------------------------------------
[16:14:47.374] <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)
[16:14:47.374] <TB2> INFO: ----------------------------------------------------------------------
[16:14:47.650] <TB2> INFO: Expecting 41600 events.
[16:14:51.504] <TB2> INFO: 41600 events read in total (3297ms).
[16:14:51.505] <TB2> INFO: Test took 4129ms.
[16:14:51.729] <TB2> INFO: PixTestAlive::aliveTest() done
[16:14:51.729] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[16:14:51.731] <TB2> INFO: ----------------------------------------------------------------------
[16:14:51.731] <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)
[16:14:51.731] <TB2> INFO: ----------------------------------------------------------------------
[16:14:52.016] <TB2> INFO: Expecting 41600 events.
[16:14:54.983] <TB2> INFO: 41600 events read in total (2411ms).
[16:14:54.984] <TB2> INFO: Test took 3251ms.
[16:14:54.984] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:14:55.231] <TB2> INFO: PixTestAlive::maskTest() done
[16:14:55.231] <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
[16:14:55.234] <TB2> INFO: ----------------------------------------------------------------------
[16:14:55.234] <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)
[16:14:55.234] <TB2> INFO: ----------------------------------------------------------------------
[16:14:55.507] <TB2> INFO: Expecting 41600 events.
[16:14:59.334] <TB2> INFO: 41600 events read in total (3271ms).
[16:14:59.335] <TB2> INFO: Test took 4098ms.
[16:14:59.557] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[16:14:59.557] <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
[16:14:59.557] <TB2> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[16:14:59.557] <TB2> INFO: Decoding statistics:
[16:14:59.557] <TB2> INFO: General information:
[16:14:59.557] <TB2> INFO: 16bit words read: 0
[16:14:59.557] <TB2> INFO: valid events total: 0
[16:14:59.557] <TB2> INFO: empty events: 0
[16:14:59.557] <TB2> INFO: valid events with pixels: 0
[16:14:59.557] <TB2> INFO: valid pixel hits: 0
[16:14:59.557] <TB2> INFO: Event errors: 0
[16:14:59.557] <TB2> INFO: start marker: 0
[16:14:59.557] <TB2> INFO: stop marker: 0
[16:14:59.557] <TB2> INFO: overflow: 0
[16:14:59.557] <TB2> INFO: invalid 5bit words: 0
[16:14:59.557] <TB2> INFO: invalid XOR eye diagram: 0
[16:14:59.557] <TB2> INFO: frame (failed synchr.): 0
[16:14:59.557] <TB2> INFO: idle data (no TBM trl): 0
[16:14:59.557] <TB2> INFO: no data (only TBM hdr): 0
[16:14:59.557] <TB2> INFO: TBM errors: 0
[16:14:59.557] <TB2> INFO: flawed TBM headers: 0
[16:14:59.557] <TB2> INFO: flawed TBM trailers: 0
[16:14:59.557] <TB2> INFO: event ID mismatches: 0
[16:14:59.558] <TB2> INFO: ROC errors: 0
[16:14:59.558] <TB2> INFO: missing ROC header(s): 0
[16:14:59.558] <TB2> INFO: misplaced readback start: 0
[16:14:59.558] <TB2> INFO: Pixel decoding errors: 0
[16:14:59.558] <TB2> INFO: pixel data incomplete: 0
[16:14:59.558] <TB2> INFO: pixel address: 0
[16:14:59.558] <TB2> INFO: pulse height fill bit: 0
[16:14:59.558] <TB2> INFO: buffer corruption: 0
[16:14:59.566] <TB2> INFO: ######################################################################
[16:14:59.566] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[16:14:59.566] <TB2> INFO: ######################################################################
[16:14:59.569] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[16:14:59.581] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[16:14:59.581] <TB2> INFO: run 1 of 1
[16:14:59.857] <TB2> INFO: Expecting 3120000 events.
[16:15:41.287] <TB2> INFO: 885035 events read in total (40874ms).
[16:16:22.061] <TB2> INFO: 1760575 events read in total (81649ms).
[16:17:02.999] <TB2> INFO: 2646150 events read in total (122587ms).
[16:17:25.460] <TB2> INFO: 3120000 events read in total (145047ms).
[16:17:25.507] <TB2> INFO: Test took 145926ms.
[16:17:48.444] <TB2> INFO: PixTestBBMap::doTest() done, duration: 168 seconds
[16:17:48.444] <TB2> INFO: number of dead bumps (per ROC): 0 0 0 0 0 1 0 1 0 0 0 0 7 0 0 0
[16:17:48.444] <TB2> INFO: separation cut (per ROC): 84 101 85 82 89 102 85 94 95 86 92 70 94 83 103 108
[16:17:48.445] <TB2> INFO: Decoding statistics:
[16:17:48.445] <TB2> INFO: General information:
[16:17:48.445] <TB2> INFO: 16bit words read: 0
[16:17:48.445] <TB2> INFO: valid events total: 0
[16:17:48.445] <TB2> INFO: empty events: 0
[16:17:48.445] <TB2> INFO: valid events with pixels: 0
[16:17:48.445] <TB2> INFO: valid pixel hits: 0
[16:17:48.445] <TB2> INFO: Event errors: 0
[16:17:48.445] <TB2> INFO: start marker: 0
[16:17:48.445] <TB2> INFO: stop marker: 0
[16:17:48.445] <TB2> INFO: overflow: 0
[16:17:48.445] <TB2> INFO: invalid 5bit words: 0
[16:17:48.445] <TB2> INFO: invalid XOR eye diagram: 0
[16:17:48.445] <TB2> INFO: frame (failed synchr.): 0
[16:17:48.445] <TB2> INFO: idle data (no TBM trl): 0
[16:17:48.445] <TB2> INFO: no data (only TBM hdr): 0
[16:17:48.445] <TB2> INFO: TBM errors: 0
[16:17:48.445] <TB2> INFO: flawed TBM headers: 0
[16:17:48.445] <TB2> INFO: flawed TBM trailers: 0
[16:17:48.445] <TB2> INFO: event ID mismatches: 0
[16:17:48.445] <TB2> INFO: ROC errors: 0
[16:17:48.445] <TB2> INFO: missing ROC header(s): 0
[16:17:48.445] <TB2> INFO: misplaced readback start: 0
[16:17:48.445] <TB2> INFO: Pixel decoding errors: 0
[16:17:48.445] <TB2> INFO: pixel data incomplete: 0
[16:17:48.445] <TB2> INFO: pixel address: 0
[16:17:48.445] <TB2> INFO: pulse height fill bit: 0
[16:17:48.445] <TB2> INFO: buffer corruption: 0
[16:17:48.516] <TB2> INFO: ######################################################################
[16:17:48.516] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[16:17:48.517] <TB2> INFO: ######################################################################
[16:17:48.517] <TB2> INFO: ----------------------------------------------------------------------
[16:17:48.517] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[16:17:48.517] <TB2> INFO: ----------------------------------------------------------------------
[16:17:48.517] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[16:17:48.526] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[16:17:48.526] <TB2> INFO: run 1 of 1
[16:17:48.806] <TB2> INFO: Expecting 26208000 events.
[16:18:23.113] <TB2> INFO: 936700 events read in total (33751ms).
[16:18:56.629] <TB2> INFO: 1858650 events read in total (67267ms).
[16:19:30.301] <TB2> INFO: 2780100 events read in total (100939ms).
[16:20:03.914] <TB2> INFO: 3701650 events read in total (134552ms).
[16:20:37.526] <TB2> INFO: 4622450 events read in total (168164ms).
[16:21:11.069] <TB2> INFO: 5541000 events read in total (201707ms).
[16:21:44.460] <TB2> INFO: 6459750 events read in total (235098ms).
[16:22:18.343] <TB2> INFO: 7376150 events read in total (268981ms).
[16:22:51.704] <TB2> INFO: 8295550 events read in total (302342ms).
[16:23:25.506] <TB2> INFO: 9214750 events read in total (336144ms).
[16:23:59.341] <TB2> INFO: 10130200 events read in total (369979ms).
[16:24:32.738] <TB2> INFO: 11045950 events read in total (403376ms).
[16:25:06.530] <TB2> INFO: 11961950 events read in total (437168ms).
[16:25:40.229] <TB2> INFO: 12875600 events read in total (470867ms).
[16:26:13.843] <TB2> INFO: 13781700 events read in total (504481ms).
[16:26:47.530] <TB2> INFO: 14683500 events read in total (538168ms).
[16:27:20.703] <TB2> INFO: 15584500 events read in total (571341ms).
[16:27:54.193] <TB2> INFO: 16484900 events read in total (604831ms).
[16:28:27.816] <TB2> INFO: 17385950 events read in total (638455ms).
[16:29:01.084] <TB2> INFO: 18287100 events read in total (671722ms).
[16:29:34.766] <TB2> INFO: 19185600 events read in total (705404ms).
[16:30:08.169] <TB2> INFO: 20083100 events read in total (738807ms).
[16:30:41.714] <TB2> INFO: 20980250 events read in total (772352ms).
[16:31:14.851] <TB2> INFO: 21877500 events read in total (805489ms).
[16:31:48.180] <TB2> INFO: 22773900 events read in total (838818ms).
[16:32:21.519] <TB2> INFO: 23673000 events read in total (872157ms).
[16:32:54.895] <TB2> INFO: 24571650 events read in total (905533ms).
[16:33:28.592] <TB2> INFO: 25471750 events read in total (939230ms).
[16:33:55.735] <TB2> INFO: 26208000 events read in total (966373ms).
[16:33:55.763] <TB2> INFO: Test took 967237ms.
[16:33:56.009] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:33:57.708] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:33:59.365] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:00.978] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:02.649] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:04.196] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:05.726] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:07.107] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:08.557] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:09.994] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:11.407] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:12.776] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:14.243] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:15.666] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:17.119] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:18.504] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[16:34:20.013] <TB2> INFO: PixTestScurves::scurves() done
[16:34:20.013] <TB2> INFO: Vcal mean: 95.48 110.51 85.73 84.65 90.36 106.28 88.20 98.99 107.48 95.46 96.99 80.02 98.43 80.79 100.15 111.69
[16:34:20.013] <TB2> INFO: Vcal RMS: 5.50 4.98 4.77 5.07 5.55 5.70 5.64 5.86 5.04 5.08 5.26 3.97 5.52 4.56 5.72 5.43
[16:34:20.013] <TB2> INFO: PixTestScurves::fullTest() done, duration: 991 seconds
[16:34:20.013] <TB2> INFO: Decoding statistics:
[16:34:20.013] <TB2> INFO: General information:
[16:34:20.013] <TB2> INFO: 16bit words read: 0
[16:34:20.013] <TB2> INFO: valid events total: 0
[16:34:20.013] <TB2> INFO: empty events: 0
[16:34:20.013] <TB2> INFO: valid events with pixels: 0
[16:34:20.013] <TB2> INFO: valid pixel hits: 0
[16:34:20.013] <TB2> INFO: Event errors: 0
[16:34:20.013] <TB2> INFO: start marker: 0
[16:34:20.013] <TB2> INFO: stop marker: 0
[16:34:20.013] <TB2> INFO: overflow: 0
[16:34:20.013] <TB2> INFO: invalid 5bit words: 0
[16:34:20.013] <TB2> INFO: invalid XOR eye diagram: 0
[16:34:20.013] <TB2> INFO: frame (failed synchr.): 0
[16:34:20.013] <TB2> INFO: idle data (no TBM trl): 0
[16:34:20.013] <TB2> INFO: no data (only TBM hdr): 0
[16:34:20.013] <TB2> INFO: TBM errors: 0
[16:34:20.013] <TB2> INFO: flawed TBM headers: 0
[16:34:20.013] <TB2> INFO: flawed TBM trailers: 0
[16:34:20.013] <TB2> INFO: event ID mismatches: 0
[16:34:20.013] <TB2> INFO: ROC errors: 0
[16:34:20.013] <TB2> INFO: missing ROC header(s): 0
[16:34:20.013] <TB2> INFO: misplaced readback start: 0
[16:34:20.013] <TB2> INFO: Pixel decoding errors: 0
[16:34:20.013] <TB2> INFO: pixel data incomplete: 0
[16:34:20.013] <TB2> INFO: pixel address: 0
[16:34:20.013] <TB2> INFO: pulse height fill bit: 0
[16:34:20.013] <TB2> INFO: buffer corruption: 0
[16:34:20.085] <TB2> INFO: ######################################################################
[16:34:20.085] <TB2> INFO: PixTestTrim::doTest()
[16:34:20.085] <TB2> INFO: ######################################################################
[16:34:20.086] <TB2> INFO: ----------------------------------------------------------------------
[16:34:20.086] <TB2> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[16:34:20.086] <TB2> INFO: ----------------------------------------------------------------------
[16:34:20.166] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[16:34:20.166] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[16:34:20.175] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:34:20.175] <TB2> INFO: run 1 of 1
[16:34:20.438] <TB2> INFO: Expecting 6281600 events.
[16:35:00.434] <TB2> INFO: 1088630 events read in total (39439ms).
[16:35:40.243] <TB2> INFO: 2171780 events read in total (79248ms).
[16:36:19.671] <TB2> INFO: 3248940 events read in total (118676ms).
[16:36:59.293] <TB2> INFO: 4332320 events read in total (158298ms).
[16:37:38.423] <TB2> INFO: 5421320 events read in total (197428ms).
[16:38:10.055] <TB2> INFO: 6281600 events read in total (229060ms).
[16:38:10.094] <TB2> INFO: Test took 229919ms.
[16:38:30.996] <TB2> INFO: ROC 0 VthrComp = 94
[16:38:30.997] <TB2> INFO: ROC 1 VthrComp = 104
[16:38:30.997] <TB2> INFO: ROC 2 VthrComp = 85
[16:38:30.997] <TB2> INFO: ROC 3 VthrComp = 80
[16:38:30.997] <TB2> INFO: ROC 4 VthrComp = 90
[16:38:30.997] <TB2> INFO: ROC 5 VthrComp = 99
[16:38:30.997] <TB2> INFO: ROC 6 VthrComp = 87
[16:38:30.997] <TB2> INFO: ROC 7 VthrComp = 94
[16:38:30.997] <TB2> INFO: ROC 8 VthrComp = 102
[16:38:30.998] <TB2> INFO: ROC 9 VthrComp = 95
[16:38:30.998] <TB2> INFO: ROC 10 VthrComp = 97
[16:38:30.998] <TB2> INFO: ROC 11 VthrComp = 81
[16:38:30.998] <TB2> INFO: ROC 12 VthrComp = 97
[16:38:30.998] <TB2> INFO: ROC 13 VthrComp = 81
[16:38:30.998] <TB2> INFO: ROC 14 VthrComp = 103
[16:38:30.998] <TB2> INFO: ROC 15 VthrComp = 108
[16:38:30.998] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[16:38:30.998] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[16:38:31.006] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:38:31.006] <TB2> INFO: run 1 of 1
[16:38:31.272] <TB2> INFO: Expecting 6281600 events.
[16:39:07.182] <TB2> INFO: 757810 events read in total (35354ms).
[16:39:42.703] <TB2> INFO: 1514000 events read in total (70875ms).
[16:40:18.436] <TB2> INFO: 2269980 events read in total (106608ms).
[16:40:53.738] <TB2> INFO: 3026850 events read in total (141910ms).
[16:41:28.744] <TB2> INFO: 3777520 events read in total (176916ms).
[16:42:03.775] <TB2> INFO: 4524530 events read in total (211947ms).
[16:42:38.765] <TB2> INFO: 5268830 events read in total (246937ms).
[16:43:13.856] <TB2> INFO: 6013490 events read in total (282028ms).
[16:43:26.480] <TB2> INFO: 6281600 events read in total (294652ms).
[16:43:26.521] <TB2> INFO: Test took 295516ms.
[16:43:51.085] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 59.8602 for pixel 0/78 mean/min/max = 46.2409/32.5074/59.9744
[16:43:51.086] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 60.4025 for pixel 51/63 mean/min/max = 47.2638/34.0428/60.4848
[16:43:51.091] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 56.0858 for pixel 25/59 mean/min/max = 44.6744/33.2424/56.1064
[16:43:51.091] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 60.2597 for pixel 13/58 mean/min/max = 46.5871/32.8746/60.2996
[16:43:51.092] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 59.3964 for pixel 3/65 mean/min/max = 46.6435/33.814/59.473
[16:43:51.092] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 64.2295 for pixel 1/18 mean/min/max = 48.1621/32.0652/64.2589
[16:43:51.092] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 57.8234 for pixel 0/67 mean/min/max = 45.0699/32.2997/57.84
[16:43:51.092] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 63.4561 for pixel 3/4 mean/min/max = 47.8046/31.9779/63.6313
[16:43:51.093] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 59.0245 for pixel 0/78 mean/min/max = 45.9222/32.6736/59.1708
[16:43:51.093] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 56.7284 for pixel 1/0 mean/min/max = 45.1395/33.3583/56.9207
[16:43:51.093] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 57.7064 for pixel 20/0 mean/min/max = 44.8504/31.8804/57.8205
[16:43:51.093] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 56.5046 for pixel 19/2 mean/min/max = 44.4951/32.4541/56.536
[16:43:51.094] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 58.61 for pixel 8/23 mean/min/max = 45.7209/32.754/58.6878
[16:43:51.094] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 57.5257 for pixel 2/79 mean/min/max = 44.9676/32.3186/57.6166
[16:43:51.094] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 58.9179 for pixel 7/79 mean/min/max = 45.9269/32.8979/58.9558
[16:43:51.094] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 67.1027 for pixel 4/7 mean/min/max = 51.3978/35.6034/67.1923
[16:43:51.094] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[16:43:51.182] <TB2> INFO: Expecting 514560 events.
[16:44:03.888] <TB2> INFO: 514560 events read in total (12149ms).
[16:44:03.893] <TB2> INFO: Expecting 514560 events.
[16:44:16.956] <TB2> INFO: 514560 events read in total (12634ms).
[16:44:16.961] <TB2> INFO: Expecting 514560 events.
[16:44:29.856] <TB2> INFO: 514560 events read in total (12472ms).
[16:44:29.865] <TB2> INFO: Expecting 514560 events.
[16:44:42.671] <TB2> INFO: 514560 events read in total (12387ms).
[16:44:42.679] <TB2> INFO: Expecting 514560 events.
[16:44:55.631] <TB2> INFO: 514560 events read in total (12526ms).
[16:44:55.645] <TB2> INFO: Expecting 514560 events.
[16:45:08.534] <TB2> INFO: 514560 events read in total (12476ms).
[16:45:08.547] <TB2> INFO: Expecting 514560 events.
[16:45:21.365] <TB2> INFO: 514560 events read in total (12398ms).
[16:45:21.379] <TB2> INFO: Expecting 514560 events.
[16:45:34.328] <TB2> INFO: 514560 events read in total (12528ms).
[16:45:34.343] <TB2> INFO: Expecting 514560 events.
[16:45:47.283] <TB2> INFO: 514560 events read in total (12524ms).
[16:45:47.305] <TB2> INFO: Expecting 514560 events.
[16:46:00.285] <TB2> INFO: 514560 events read in total (12575ms).
[16:46:00.308] <TB2> INFO: Expecting 514560 events.
[16:46:13.396] <TB2> INFO: 514560 events read in total (12686ms).
[16:46:13.427] <TB2> INFO: Expecting 514560 events.
[16:46:26.249] <TB2> INFO: 514560 events read in total (12420ms).
[16:46:26.275] <TB2> INFO: Expecting 514560 events.
[16:46:39.105] <TB2> INFO: 514560 events read in total (12428ms).
[16:46:39.136] <TB2> INFO: Expecting 514560 events.
[16:46:51.885] <TB2> INFO: 514560 events read in total (12347ms).
[16:46:51.915] <TB2> INFO: Expecting 514560 events.
[16:47:04.885] <TB2> INFO: 514560 events read in total (12568ms).
[16:47:04.917] <TB2> INFO: Expecting 514560 events.
[16:47:17.682] <TB2> INFO: 514560 events read in total (12363ms).
[16:47:17.716] <TB2> INFO: Test took 206622ms.
[16:47:18.552] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[16:47:18.561] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:47:18.561] <TB2> INFO: run 1 of 1
[16:47:18.820] <TB2> INFO: Expecting 6281600 events.
[16:47:54.474] <TB2> INFO: 742800 events read in total (35098ms).
[16:48:29.520] <TB2> INFO: 1484680 events read in total (70144ms).
[16:49:04.274] <TB2> INFO: 2226260 events read in total (104898ms).
[16:49:38.905] <TB2> INFO: 2968600 events read in total (139529ms).
[16:50:13.749] <TB2> INFO: 3704950 events read in total (174373ms).
[16:50:48.537] <TB2> INFO: 4436830 events read in total (209161ms).
[16:51:23.239] <TB2> INFO: 5165560 events read in total (243863ms).
[16:51:58.176] <TB2> INFO: 5894380 events read in total (278800ms).
[16:52:16.870] <TB2> INFO: 6281600 events read in total (297494ms).
[16:52:16.911] <TB2> INFO: Test took 298350ms.
[16:52:43.280] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 0.080382 .. 255.000000
[16:52:43.385] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[16:52:43.393] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[16:52:43.393] <TB2> INFO: run 1 of 1
[16:52:43.678] <TB2> INFO: Expecting 10649600 events.
[16:53:18.583] <TB2> INFO: 712420 events read in total (34349ms).
[16:53:53.003] <TB2> INFO: 1425130 events read in total (68769ms).
[16:54:27.800] <TB2> INFO: 2137900 events read in total (103566ms).
[16:55:02.357] <TB2> INFO: 2850270 events read in total (138123ms).
[16:55:36.721] <TB2> INFO: 3562940 events read in total (172487ms).
[16:56:11.073] <TB2> INFO: 4275550 events read in total (206839ms).
[16:56:45.218] <TB2> INFO: 4988230 events read in total (240984ms).
[16:57:19.475] <TB2> INFO: 5700900 events read in total (275241ms).
[16:57:53.597] <TB2> INFO: 6413670 events read in total (309363ms).
[16:58:27.987] <TB2> INFO: 7125530 events read in total (343753ms).
[16:59:02.428] <TB2> INFO: 7836990 events read in total (378194ms).
[16:59:37.062] <TB2> INFO: 8547510 events read in total (412828ms).
[17:00:11.559] <TB2> INFO: 9258590 events read in total (447325ms).
[17:00:46.096] <TB2> INFO: 9969490 events read in total (481862ms).
[17:01:18.965] <TB2> INFO: 10649600 events read in total (514731ms).
[17:01:19.050] <TB2> INFO: Test took 515657ms.
[17:01:48.319] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 16.042179 .. 45.922104
[17:01:48.395] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 6 .. 55 (-1/-1) hits flags = 528 (plus default)
[17:01:48.404] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:01:48.404] <TB2> INFO: run 1 of 1
[17:01:48.689] <TB2> INFO: Expecting 2080000 events.
[17:02:27.453] <TB2> INFO: 932280 events read in total (38194ms).
[17:03:05.235] <TB2> INFO: 1863060 events read in total (75977ms).
[17:03:14.432] <TB2> INFO: 2080000 events read in total (85174ms).
[17:03:14.456] <TB2> INFO: Test took 86053ms.
[17:03:28.849] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 1.989892 .. 42.320062
[17:03:28.937] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 1 .. 52 (-1/-1) hits flags = 528 (plus default)
[17:03:28.946] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:03:28.946] <TB2> INFO: run 1 of 1
[17:03:29.237] <TB2> INFO: Expecting 2163200 events.
[17:04:08.672] <TB2> INFO: 985820 events read in total (38879ms).
[17:04:48.099] <TB2> INFO: 1970350 events read in total (78306ms).
[17:04:56.073] <TB2> INFO: 2163200 events read in total (86281ms).
[17:04:56.089] <TB2> INFO: Test took 87144ms.
[17:05:10.182] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 0.197411 .. 42.320062
[17:05:10.258] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 0 .. 52 (-1/-1) hits flags = 528 (plus default)
[17:05:10.266] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:05:10.266] <TB2> INFO: run 1 of 1
[17:05:10.534] <TB2> INFO: Expecting 2204800 events.
[17:05:50.393] <TB2> INFO: 991240 events read in total (39303ms).
[17:06:29.230] <TB2> INFO: 1981910 events read in total (78140ms).
[17:06:38.265] <TB2> INFO: 2204800 events read in total (87175ms).
[17:06:38.288] <TB2> INFO: Test took 88023ms.
[17:06:53.688] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[17:06:53.688] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[17:06:53.696] <TB2> INFO: dacScan split into 1 runs with ntrig = 10
[17:06:53.696] <TB2> INFO: run 1 of 1
[17:06:53.955] <TB2> INFO: Expecting 1705600 events.
[17:07:32.438] <TB2> INFO: 878420 events read in total (37926ms).
[17:08:07.599] <TB2> INFO: 1705600 events read in total (73087ms).
[17:08:07.621] <TB2> INFO: Test took 73925ms.
[17:08:22.098] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C0.dat
[17:08:22.098] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C1.dat
[17:08:22.099] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C2.dat
[17:08:22.099] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C3.dat
[17:08:22.099] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C4.dat
[17:08:22.099] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C5.dat
[17:08:22.099] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C6.dat
[17:08:22.099] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C7.dat
[17:08:22.099] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C8.dat
[17:08:22.100] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C9.dat
[17:08:22.100] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C10.dat
[17:08:22.100] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C11.dat
[17:08:22.100] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C12.dat
[17:08:22.100] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C13.dat
[17:08:22.100] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C14.dat
[17:08:22.100] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C15.dat
[17:08:22.101] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C0.dat
[17:08:22.108] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C1.dat
[17:08:22.117] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C2.dat
[17:08:22.125] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C3.dat
[17:08:22.133] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C4.dat
[17:08:22.142] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C5.dat
[17:08:22.150] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C6.dat
[17:08:22.156] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C7.dat
[17:08:22.162] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C8.dat
[17:08:22.168] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C9.dat
[17:08:22.174] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C10.dat
[17:08:22.180] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C11.dat
[17:08:22.186] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C12.dat
[17:08:22.192] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C13.dat
[17:08:22.197] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C14.dat
[17:08:22.203] <TB2> INFO: write trim parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//trimParameters35_C15.dat
[17:08:22.209] <TB2> INFO: PixTestTrim::trimTest() done
[17:08:22.209] <TB2> INFO: vtrim: 91 89 80 91 103 111 79 106 91 99 102 84 110 86 102 125
[17:08:22.209] <TB2> INFO: vthrcomp: 94 104 85 80 90 99 87 94 102 95 97 81 97 81 103 108
[17:08:22.209] <TB2> INFO: vcal mean: 34.96 35.00 35.01 35.00 35.00 35.00 34.97 34.95 34.97 34.96 34.99 34.92 34.95 35.01 34.98 35.00
[17:08:22.209] <TB2> INFO: vcal RMS: 0.89 0.86 0.81 1.17 0.84 1.15 0.86 1.06 0.90 0.86 0.88 0.85 0.91 0.84 0.85 0.95
[17:08:22.209] <TB2> INFO: bits mean: 9.26 8.23 9.53 9.40 9.00 9.37 9.31 9.39 9.28 9.68 9.81 10.29 9.42 9.60 9.17 8.01
[17:08:22.209] <TB2> INFO: bits RMS: 2.76 2.79 2.62 2.58 2.64 2.57 2.84 2.60 2.75 2.47 2.63 2.36 2.65 2.65 2.72 2.38
[17:08:22.216] <TB2> INFO: ----------------------------------------------------------------------
[17:08:22.216] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[17:08:22.216] <TB2> INFO: ----------------------------------------------------------------------
[17:08:22.219] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[17:08:22.227] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[17:08:22.227] <TB2> INFO: run 1 of 1
[17:08:22.490] <TB2> INFO: Expecting 4160000 events.
[17:09:05.882] <TB2> INFO: 970845 events read in total (42836ms).
[17:09:49.129] <TB2> INFO: 1934880 events read in total (86083ms).
[17:10:31.830] <TB2> INFO: 2887855 events read in total (128784ms).
[17:11:13.849] <TB2> INFO: 3838255 events read in total (170803ms).
[17:11:28.509] <TB2> INFO: 4160000 events read in total (185463ms).
[17:11:28.556] <TB2> INFO: Test took 186330ms.
[17:12:01.733] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 186 (-1/-1) hits flags = 528 (plus default)
[17:12:01.741] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[17:12:01.741] <TB2> INFO: run 1 of 1
[17:12:02.005] <TB2> INFO: Expecting 3889600 events.
[17:12:45.044] <TB2> INFO: 959775 events read in total (42483ms).
[17:13:27.020] <TB2> INFO: 1912875 events read in total (84460ms).
[17:14:09.345] <TB2> INFO: 2855210 events read in total (126785ms).
[17:14:51.035] <TB2> INFO: 3797360 events read in total (168474ms).
[17:14:55.686] <TB2> INFO: 3889600 events read in total (173125ms).
[17:14:55.719] <TB2> INFO: Test took 173978ms.
[17:15:24.718] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 176 (-1/-1) hits flags = 528 (plus default)
[17:15:24.726] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[17:15:24.726] <TB2> INFO: run 1 of 1
[17:15:25.015] <TB2> INFO: Expecting 3681600 events.
[17:16:08.701] <TB2> INFO: 984145 events read in total (43130ms).
[17:16:51.216] <TB2> INFO: 1959830 events read in total (85646ms).
[17:17:34.001] <TB2> INFO: 2923765 events read in total (128431ms).
[17:18:07.381] <TB2> INFO: 3681600 events read in total (161810ms).
[17:18:07.425] <TB2> INFO: Test took 162698ms.
[17:18:34.593] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 174 (-1/-1) hits flags = 528 (plus default)
[17:18:34.602] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[17:18:34.602] <TB2> INFO: run 1 of 1
[17:18:34.865] <TB2> INFO: Expecting 3640000 events.
[17:19:18.645] <TB2> INFO: 989065 events read in total (43224ms).
[17:20:01.062] <TB2> INFO: 1969290 events read in total (85641ms).
[17:20:43.747] <TB2> INFO: 2937420 events read in total (128327ms).
[17:21:15.116] <TB2> INFO: 3640000 events read in total (159695ms).
[17:21:15.153] <TB2> INFO: Test took 160551ms.
[17:21:44.513] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 172 (-1/-1) hits flags = 528 (plus default)
[17:21:44.522] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[17:21:44.522] <TB2> INFO: run 1 of 1
[17:21:44.792] <TB2> INFO: Expecting 3598400 events.
[17:22:28.555] <TB2> INFO: 994310 events read in total (43207ms).
[17:23:11.491] <TB2> INFO: 1979060 events read in total (86143ms).
[17:23:53.901] <TB2> INFO: 2952350 events read in total (128554ms).
[17:24:21.917] <TB2> INFO: 3598400 events read in total (156569ms).
[17:24:21.964] <TB2> INFO: Test took 157442ms.
[17:24:48.465] <TB2> INFO: PixTestTrim::trimBitTest() done
[17:24:48.466] <TB2> INFO: PixTestTrim::doTest() done, duration: 3028 seconds
[17:24:48.466] <TB2> INFO: Decoding statistics:
[17:24:48.466] <TB2> INFO: General information:
[17:24:48.466] <TB2> INFO: 16bit words read: 0
[17:24:48.467] <TB2> INFO: valid events total: 0
[17:24:48.467] <TB2> INFO: empty events: 0
[17:24:48.467] <TB2> INFO: valid events with pixels: 0
[17:24:48.467] <TB2> INFO: valid pixel hits: 0
[17:24:48.467] <TB2> INFO: Event errors: 0
[17:24:48.467] <TB2> INFO: start marker: 0
[17:24:48.467] <TB2> INFO: stop marker: 0
[17:24:48.467] <TB2> INFO: overflow: 0
[17:24:48.467] <TB2> INFO: invalid 5bit words: 0
[17:24:48.467] <TB2> INFO: invalid XOR eye diagram: 0
[17:24:48.467] <TB2> INFO: frame (failed synchr.): 0
[17:24:48.467] <TB2> INFO: idle data (no TBM trl): 0
[17:24:48.467] <TB2> INFO: no data (only TBM hdr): 0
[17:24:48.467] <TB2> INFO: TBM errors: 0
[17:24:48.467] <TB2> INFO: flawed TBM headers: 0
[17:24:48.467] <TB2> INFO: flawed TBM trailers: 0
[17:24:48.467] <TB2> INFO: event ID mismatches: 0
[17:24:48.467] <TB2> INFO: ROC errors: 0
[17:24:48.467] <TB2> INFO: missing ROC header(s): 0
[17:24:48.467] <TB2> INFO: misplaced readback start: 0
[17:24:48.467] <TB2> INFO: Pixel decoding errors: 0
[17:24:48.467] <TB2> INFO: pixel data incomplete: 0
[17:24:48.467] <TB2> INFO: pixel address: 0
[17:24:48.467] <TB2> INFO: pulse height fill bit: 0
[17:24:48.467] <TB2> INFO: buffer corruption: 0
[17:24:49.137] <TB2> INFO: ######################################################################
[17:24:49.137] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[17:24:49.137] <TB2> INFO: ######################################################################
[17:24:49.422] <TB2> INFO: Expecting 41600 events.
[17:24:53.257] <TB2> INFO: 41600 events read in total (3279ms).
[17:24:53.257] <TB2> INFO: Test took 4118ms.
[17:24:53.768] <TB2> INFO: Expecting 41600 events.
[17:24:57.573] <TB2> INFO: 41600 events read in total (3249ms).
[17:24:57.574] <TB2> INFO: Test took 4115ms.
[17:24:57.858] <TB2> INFO: Expecting 41600 events.
[17:25:01.730] <TB2> INFO: 41600 events read in total (3316ms).
[17:25:01.730] <TB2> INFO: Test took 4135ms.
[17:25:01.986] <TB2> INFO: Expecting 2560 events.
[17:25:02.846] <TB2> INFO: 2560 events read in total (304ms).
[17:25:02.846] <TB2> INFO: Test took 1103ms.
[17:25:03.151] <TB2> INFO: Expecting 2560 events.
[17:25:04.005] <TB2> INFO: 2560 events read in total (298ms).
[17:25:04.005] <TB2> INFO: Test took 1159ms.
[17:25:04.310] <TB2> INFO: Expecting 2560 events.
[17:25:05.163] <TB2> INFO: 2560 events read in total (297ms).
[17:25:05.163] <TB2> INFO: Test took 1158ms.
[17:25:05.468] <TB2> INFO: Expecting 2560 events.
[17:25:06.328] <TB2> INFO: 2560 events read in total (304ms).
[17:25:06.328] <TB2> INFO: Test took 1165ms.
[17:25:06.633] <TB2> INFO: Expecting 2560 events.
[17:25:07.486] <TB2> INFO: 2560 events read in total (297ms).
[17:25:07.487] <TB2> INFO: Test took 1158ms.
[17:25:07.793] <TB2> INFO: Expecting 2560 events.
[17:25:08.647] <TB2> INFO: 2560 events read in total (298ms).
[17:25:08.647] <TB2> INFO: Test took 1160ms.
[17:25:08.952] <TB2> INFO: Expecting 2560 events.
[17:25:09.805] <TB2> INFO: 2560 events read in total (297ms).
[17:25:09.806] <TB2> INFO: Test took 1159ms.
[17:25:10.110] <TB2> INFO: Expecting 2560 events.
[17:25:10.965] <TB2> INFO: 2560 events read in total (299ms).
[17:25:10.965] <TB2> INFO: Test took 1159ms.
[17:25:11.270] <TB2> INFO: Expecting 2560 events.
[17:25:12.127] <TB2> INFO: 2560 events read in total (301ms).
[17:25:12.127] <TB2> INFO: Test took 1162ms.
[17:25:12.433] <TB2> INFO: Expecting 2560 events.
[17:25:13.288] <TB2> INFO: 2560 events read in total (299ms).
[17:25:13.288] <TB2> INFO: Test took 1160ms.
[17:25:13.593] <TB2> INFO: Expecting 2560 events.
[17:25:14.447] <TB2> INFO: 2560 events read in total (297ms).
[17:25:14.448] <TB2> INFO: Test took 1159ms.
[17:25:14.753] <TB2> INFO: Expecting 2560 events.
[17:25:15.605] <TB2> INFO: 2560 events read in total (296ms).
[17:25:15.605] <TB2> INFO: Test took 1157ms.
[17:25:15.911] <TB2> INFO: Expecting 2560 events.
[17:25:16.766] <TB2> INFO: 2560 events read in total (299ms).
[17:25:16.766] <TB2> INFO: Test took 1154ms.
[17:25:17.071] <TB2> INFO: Expecting 2560 events.
[17:25:17.927] <TB2> INFO: 2560 events read in total (300ms).
[17:25:17.927] <TB2> INFO: Test took 1161ms.
[17:25:18.232] <TB2> INFO: Expecting 2560 events.
[17:25:19.088] <TB2> INFO: 2560 events read in total (300ms).
[17:25:19.088] <TB2> INFO: Test took 1161ms.
[17:25:19.393] <TB2> INFO: Expecting 2560 events.
[17:25:20.246] <TB2> INFO: 2560 events read in total (297ms).
[17:25:20.246] <TB2> INFO: Test took 1157ms.
[17:25:20.249] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:25:20.553] <TB2> INFO: Expecting 655360 events.
[17:25:37.476] <TB2> INFO: 655360 events read in total (16366ms).
[17:25:37.486] <TB2> INFO: Expecting 655360 events.
[17:25:54.312] <TB2> INFO: 655360 events read in total (16424ms).
[17:25:54.323] <TB2> INFO: Expecting 655360 events.
[17:26:10.948] <TB2> INFO: 655360 events read in total (16223ms).
[17:26:10.966] <TB2> INFO: Expecting 655360 events.
[17:26:27.856] <TB2> INFO: 655360 events read in total (16488ms).
[17:26:27.875] <TB2> INFO: Expecting 655360 events.
[17:26:44.642] <TB2> INFO: 655360 events read in total (16365ms).
[17:26:44.665] <TB2> INFO: Expecting 655360 events.
[17:27:01.375] <TB2> INFO: 655360 events read in total (16308ms).
[17:27:01.404] <TB2> INFO: Expecting 655360 events.
[17:27:18.094] <TB2> INFO: 655360 events read in total (16288ms).
[17:27:18.125] <TB2> INFO: Expecting 655360 events.
[17:27:34.824] <TB2> INFO: 655360 events read in total (16297ms).
[17:27:34.860] <TB2> INFO: Expecting 655360 events.
[17:27:51.839] <TB2> INFO: 655360 events read in total (16577ms).
[17:27:51.879] <TB2> INFO: Expecting 655360 events.
[17:28:08.529] <TB2> INFO: 655360 events read in total (16249ms).
[17:28:08.574] <TB2> INFO: Expecting 655360 events.
[17:28:25.068] <TB2> INFO: 655360 events read in total (16092ms).
[17:28:25.114] <TB2> INFO: Expecting 655360 events.
[17:28:41.703] <TB2> INFO: 655360 events read in total (16187ms).
[17:28:41.755] <TB2> INFO: Expecting 655360 events.
[17:28:58.670] <TB2> INFO: 655360 events read in total (16513ms).
[17:28:58.722] <TB2> INFO: Expecting 655360 events.
[17:29:15.507] <TB2> INFO: 655360 events read in total (16383ms).
[17:29:15.568] <TB2> INFO: Expecting 655360 events.
[17:29:32.388] <TB2> INFO: 655360 events read in total (16419ms).
[17:29:32.449] <TB2> INFO: Expecting 655360 events.
[17:29:49.335] <TB2> INFO: 655360 events read in total (16484ms).
[17:29:49.398] <TB2> INFO: Test took 269149ms.
[17:29:49.483] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:29:49.712] <TB2> INFO: Expecting 655360 events.
[17:30:06.553] <TB2> INFO: 655360 events read in total (16284ms).
[17:30:06.562] <TB2> INFO: Expecting 655360 events.
[17:30:23.450] <TB2> INFO: 655360 events read in total (16486ms).
[17:30:23.463] <TB2> INFO: Expecting 655360 events.
[17:30:40.280] <TB2> INFO: 655360 events read in total (16415ms).
[17:30:40.298] <TB2> INFO: Expecting 655360 events.
[17:30:57.053] <TB2> INFO: 655360 events read in total (16354ms).
[17:30:57.072] <TB2> INFO: Expecting 655360 events.
[17:31:13.817] <TB2> INFO: 655360 events read in total (16343ms).
[17:31:13.839] <TB2> INFO: Expecting 655360 events.
[17:31:30.669] <TB2> INFO: 655360 events read in total (16429ms).
[17:31:30.696] <TB2> INFO: Expecting 655360 events.
[17:31:47.387] <TB2> INFO: 655360 events read in total (16289ms).
[17:31:47.418] <TB2> INFO: Expecting 655360 events.
[17:32:04.135] <TB2> INFO: 655360 events read in total (16316ms).
[17:32:04.174] <TB2> INFO: Expecting 655360 events.
[17:32:20.961] <TB2> INFO: 655360 events read in total (16385ms).
[17:32:21.000] <TB2> INFO: Expecting 655360 events.
[17:32:37.843] <TB2> INFO: 655360 events read in total (16441ms).
[17:32:37.890] <TB2> INFO: Expecting 655360 events.
[17:32:54.738] <TB2> INFO: 655360 events read in total (16446ms).
[17:32:54.782] <TB2> INFO: Expecting 655360 events.
[17:33:11.449] <TB2> INFO: 655360 events read in total (16265ms).
[17:33:11.496] <TB2> INFO: Expecting 655360 events.
[17:33:28.357] <TB2> INFO: 655360 events read in total (16459ms).
[17:33:28.410] <TB2> INFO: Expecting 655360 events.
[17:33:45.247] <TB2> INFO: 655360 events read in total (16435ms).
[17:33:45.304] <TB2> INFO: Expecting 655360 events.
[17:34:02.152] <TB2> INFO: 655360 events read in total (16446ms).
[17:34:02.217] <TB2> INFO: Expecting 655360 events.
[17:34:18.912] <TB2> INFO: 655360 events read in total (16293ms).
[17:34:18.972] <TB2> INFO: Test took 269489ms.
[17:34:19.180] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.187] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.194] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.203] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[17:34:19.211] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.220] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.227] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.234] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.242] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.250] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.258] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.266] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.274] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.282] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.289] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.296] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.303] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[17:34:19.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C0.dat
[17:34:19.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C1.dat
[17:34:19.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C2.dat
[17:34:19.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C3.dat
[17:34:19.342] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C4.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C5.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C6.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C7.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C8.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C9.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C10.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C11.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C12.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C13.dat
[17:34:19.343] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C14.dat
[17:34:19.344] <TB2> INFO: write dac parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//dacParameters35_C15.dat
[17:34:19.627] <TB2> INFO: Expecting 41600 events.
[17:34:23.145] <TB2> INFO: 41600 events read in total (2962ms).
[17:34:23.145] <TB2> INFO: Test took 3798ms.
[17:34:23.591] <TB2> INFO: Expecting 41600 events.
[17:34:27.110] <TB2> INFO: 41600 events read in total (2963ms).
[17:34:27.111] <TB2> INFO: Test took 3791ms.
[17:34:27.560] <TB2> INFO: Expecting 41600 events.
[17:34:31.114] <TB2> INFO: 41600 events read in total (2998ms).
[17:34:31.114] <TB2> INFO: Test took 3825ms.
[17:34:31.302] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:31.391] <TB2> INFO: Expecting 2560 events.
[17:34:32.248] <TB2> INFO: 2560 events read in total (300ms).
[17:34:32.248] <TB2> INFO: Test took 946ms.
[17:34:32.251] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:32.554] <TB2> INFO: Expecting 2560 events.
[17:34:33.410] <TB2> INFO: 2560 events read in total (300ms).
[17:34:33.410] <TB2> INFO: Test took 1159ms.
[17:34:33.413] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:33.715] <TB2> INFO: Expecting 2560 events.
[17:34:34.574] <TB2> INFO: 2560 events read in total (303ms).
[17:34:34.575] <TB2> INFO: Test took 1163ms.
[17:34:34.577] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:34.880] <TB2> INFO: Expecting 2560 events.
[17:34:35.734] <TB2> INFO: 2560 events read in total (297ms).
[17:34:35.735] <TB2> INFO: Test took 1158ms.
[17:34:35.737] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:36.040] <TB2> INFO: Expecting 2560 events.
[17:34:36.893] <TB2> INFO: 2560 events read in total (297ms).
[17:34:36.893] <TB2> INFO: Test took 1156ms.
[17:34:36.895] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:37.200] <TB2> INFO: Expecting 2560 events.
[17:34:38.057] <TB2> INFO: 2560 events read in total (301ms).
[17:34:38.064] <TB2> INFO: Test took 1169ms.
[17:34:38.065] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:38.363] <TB2> INFO: Expecting 2560 events.
[17:34:39.217] <TB2> INFO: 2560 events read in total (298ms).
[17:34:39.217] <TB2> INFO: Test took 1152ms.
[17:34:39.218] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:39.523] <TB2> INFO: Expecting 2560 events.
[17:34:40.381] <TB2> INFO: 2560 events read in total (302ms).
[17:34:40.381] <TB2> INFO: Test took 1163ms.
[17:34:40.383] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:40.687] <TB2> INFO: Expecting 2560 events.
[17:34:41.546] <TB2> INFO: 2560 events read in total (303ms).
[17:34:41.546] <TB2> INFO: Test took 1163ms.
[17:34:41.547] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:41.852] <TB2> INFO: Expecting 2560 events.
[17:34:42.706] <TB2> INFO: 2560 events read in total (298ms).
[17:34:42.706] <TB2> INFO: Test took 1159ms.
[17:34:42.709] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:43.012] <TB2> INFO: Expecting 2560 events.
[17:34:43.867] <TB2> INFO: 2560 events read in total (299ms).
[17:34:43.868] <TB2> INFO: Test took 1159ms.
[17:34:43.872] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:44.174] <TB2> INFO: Expecting 2560 events.
[17:34:45.028] <TB2> INFO: 2560 events read in total (298ms).
[17:34:45.028] <TB2> INFO: Test took 1156ms.
[17:34:45.031] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:45.333] <TB2> INFO: Expecting 2560 events.
[17:34:46.192] <TB2> INFO: 2560 events read in total (302ms).
[17:34:46.192] <TB2> INFO: Test took 1161ms.
[17:34:46.195] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:46.501] <TB2> INFO: Expecting 2560 events.
[17:34:47.361] <TB2> INFO: 2560 events read in total (303ms).
[17:34:47.361] <TB2> INFO: Test took 1166ms.
[17:34:47.364] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:47.667] <TB2> INFO: Expecting 2560 events.
[17:34:48.527] <TB2> INFO: 2560 events read in total (303ms).
[17:34:48.527] <TB2> INFO: Test took 1163ms.
[17:34:48.530] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:48.832] <TB2> INFO: Expecting 2560 events.
[17:34:49.689] <TB2> INFO: 2560 events read in total (300ms).
[17:34:49.689] <TB2> INFO: Test took 1159ms.
[17:34:49.693] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:49.995] <TB2> INFO: Expecting 2560 events.
[17:34:50.854] <TB2> INFO: 2560 events read in total (303ms).
[17:34:50.855] <TB2> INFO: Test took 1162ms.
[17:34:50.858] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:51.160] <TB2> INFO: Expecting 2560 events.
[17:34:52.018] <TB2> INFO: 2560 events read in total (302ms).
[17:34:52.018] <TB2> INFO: Test took 1160ms.
[17:34:52.021] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:52.324] <TB2> INFO: Expecting 2560 events.
[17:34:53.182] <TB2> INFO: 2560 events read in total (302ms).
[17:34:53.182] <TB2> INFO: Test took 1161ms.
[17:34:53.185] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:53.490] <TB2> INFO: Expecting 2560 events.
[17:34:54.344] <TB2> INFO: 2560 events read in total (298ms).
[17:34:54.345] <TB2> INFO: Test took 1160ms.
[17:34:54.348] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:54.651] <TB2> INFO: Expecting 2560 events.
[17:34:55.509] <TB2> INFO: 2560 events read in total (302ms).
[17:34:55.509] <TB2> INFO: Test took 1162ms.
[17:34:55.512] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:55.814] <TB2> INFO: Expecting 2560 events.
[17:34:56.667] <TB2> INFO: 2560 events read in total (297ms).
[17:34:56.668] <TB2> INFO: Test took 1156ms.
[17:34:56.670] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:56.973] <TB2> INFO: Expecting 2560 events.
[17:34:57.833] <TB2> INFO: 2560 events read in total (303ms).
[17:34:57.833] <TB2> INFO: Test took 1164ms.
[17:34:57.837] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:58.138] <TB2> INFO: Expecting 2560 events.
[17:34:58.992] <TB2> INFO: 2560 events read in total (298ms).
[17:34:58.992] <TB2> INFO: Test took 1155ms.
[17:34:58.994] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:34:59.298] <TB2> INFO: Expecting 2560 events.
[17:35:00.156] <TB2> INFO: 2560 events read in total (301ms).
[17:35:00.157] <TB2> INFO: Test took 1163ms.
[17:35:00.159] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:35:00.462] <TB2> INFO: Expecting 2560 events.
[17:35:01.317] <TB2> INFO: 2560 events read in total (298ms).
[17:35:01.317] <TB2> INFO: Test took 1158ms.
[17:35:01.320] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:35:01.623] <TB2> INFO: Expecting 2560 events.
[17:35:02.477] <TB2> INFO: 2560 events read in total (298ms).
[17:35:02.477] <TB2> INFO: Test took 1158ms.
[17:35:02.480] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:35:02.783] <TB2> INFO: Expecting 2560 events.
[17:35:03.637] <TB2> INFO: 2560 events read in total (298ms).
[17:35:03.637] <TB2> INFO: Test took 1158ms.
[17:35:03.641] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:35:03.942] <TB2> INFO: Expecting 2560 events.
[17:35:04.796] <TB2> INFO: 2560 events read in total (298ms).
[17:35:04.797] <TB2> INFO: Test took 1156ms.
[17:35:04.799] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:35:05.103] <TB2> INFO: Expecting 2560 events.
[17:35:05.959] <TB2> INFO: 2560 events read in total (299ms).
[17:35:05.960] <TB2> INFO: Test took 1161ms.
[17:35:05.963] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:35:06.266] <TB2> INFO: Expecting 2560 events.
[17:35:07.124] <TB2> INFO: 2560 events read in total (302ms).
[17:35:07.125] <TB2> INFO: Test took 1162ms.
[17:35:07.128] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[17:35:07.430] <TB2> INFO: Expecting 2560 events.
[17:35:08.284] <TB2> INFO: 2560 events read in total (298ms).
[17:35:08.284] <TB2> INFO: Test took 1156ms.
[17:35:08.753] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 619 seconds
[17:35:08.753] <TB2> INFO: PH scale (per ROC): 70 63 69 57 74 59 64 62 65 75 76 72 74 81 72 61
[17:35:08.753] <TB2> INFO: PH offset (per ROC): 189 193 175 177 181 195 175 190 203 155 186 176 185 158 192 189
[17:35:08.758] <TB2> INFO: Decoding statistics:
[17:35:08.758] <TB2> INFO: General information:
[17:35:08.758] <TB2> INFO: 16bit words read: 91920
[17:35:08.758] <TB2> INFO: valid events total: 10240
[17:35:08.758] <TB2> INFO: empty events: 7740
[17:35:08.758] <TB2> INFO: valid events with pixels: 2500
[17:35:08.758] <TB2> INFO: valid pixel hits: 2500
[17:35:08.758] <TB2> INFO: Event errors: 0
[17:35:08.758] <TB2> INFO: start marker: 0
[17:35:08.758] <TB2> INFO: stop marker: 0
[17:35:08.758] <TB2> INFO: overflow: 0
[17:35:08.758] <TB2> INFO: invalid 5bit words: 0
[17:35:08.758] <TB2> INFO: invalid XOR eye diagram: 0
[17:35:08.758] <TB2> INFO: frame (failed synchr.): 0
[17:35:08.758] <TB2> INFO: idle data (no TBM trl): 0
[17:35:08.758] <TB2> INFO: no data (only TBM hdr): 0
[17:35:08.758] <TB2> INFO: TBM errors: 0
[17:35:08.758] <TB2> INFO: flawed TBM headers: 0
[17:35:08.758] <TB2> INFO: flawed TBM trailers: 0
[17:35:08.758] <TB2> INFO: event ID mismatches: 0
[17:35:08.758] <TB2> INFO: ROC errors: 0
[17:35:08.758] <TB2> INFO: missing ROC header(s): 0
[17:35:08.758] <TB2> INFO: misplaced readback start: 0
[17:35:08.758] <TB2> INFO: Pixel decoding errors: 0
[17:35:08.758] <TB2> INFO: pixel data incomplete: 0
[17:35:08.758] <TB2> INFO: pixel address: 0
[17:35:08.758] <TB2> INFO: pulse height fill bit: 0
[17:35:08.758] <TB2> INFO: buffer corruption: 0
[17:35:08.925] <TB2> INFO: ######################################################################
[17:35:08.925] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[17:35:08.925] <TB2> INFO: ######################################################################
[17:35:08.935] <TB2> INFO: scanning low vcal = 10
[17:35:09.198] <TB2> INFO: Expecting 41600 events.
[17:35:12.740] <TB2> INFO: 41600 events read in total (2986ms).
[17:35:12.740] <TB2> INFO: Test took 3804ms.
[17:35:12.743] <TB2> INFO: scanning low vcal = 20
[17:35:13.069] <TB2> INFO: Expecting 41600 events.
[17:35:16.629] <TB2> INFO: 41600 events read in total (3004ms).
[17:35:16.629] <TB2> INFO: Test took 3886ms.
[17:35:16.630] <TB2> INFO: scanning low vcal = 30
[17:35:16.936] <TB2> INFO: Expecting 41600 events.
[17:35:20.515] <TB2> INFO: 41600 events read in total (3023ms).
[17:35:20.516] <TB2> INFO: Test took 3885ms.
[17:35:20.518] <TB2> INFO: scanning low vcal = 40
[17:35:20.805] <TB2> INFO: Expecting 41600 events.
[17:35:24.954] <TB2> INFO: 41600 events read in total (3593ms).
[17:35:24.955] <TB2> INFO: Test took 4437ms.
[17:35:24.958] <TB2> INFO: scanning low vcal = 50
[17:35:25.237] <TB2> INFO: Expecting 41600 events.
[17:35:29.490] <TB2> INFO: 41600 events read in total (3697ms).
[17:35:29.490] <TB2> INFO: Test took 4532ms.
[17:35:29.493] <TB2> INFO: scanning low vcal = 60
[17:35:29.782] <TB2> INFO: Expecting 41600 events.
[17:35:33.996] <TB2> INFO: 41600 events read in total (3658ms).
[17:35:33.996] <TB2> INFO: Test took 4503ms.
[17:35:34.000] <TB2> INFO: scanning low vcal = 70
[17:35:34.293] <TB2> INFO: Expecting 41600 events.
[17:35:38.532] <TB2> INFO: 41600 events read in total (3683ms).
[17:35:38.532] <TB2> INFO: Test took 4532ms.
[17:35:38.535] <TB2> INFO: scanning low vcal = 80
[17:35:38.801] <TB2> INFO: Expecting 41600 events.
[17:35:43.038] <TB2> INFO: 41600 events read in total (3681ms).
[17:35:43.038] <TB2> INFO: Test took 4503ms.
[17:35:43.041] <TB2> INFO: scanning low vcal = 90
[17:35:43.311] <TB2> INFO: Expecting 41600 events.
[17:35:47.518] <TB2> INFO: 41600 events read in total (3650ms).
[17:35:47.519] <TB2> INFO: Test took 4477ms.
[17:35:47.522] <TB2> INFO: scanning low vcal = 100
[17:35:47.799] <TB2> INFO: Expecting 41600 events.
[17:35:51.998] <TB2> INFO: 41600 events read in total (3643ms).
[17:35:51.999] <TB2> INFO: Test took 4477ms.
[17:35:52.002] <TB2> INFO: scanning low vcal = 110
[17:35:52.290] <TB2> INFO: Expecting 41600 events.
[17:35:56.525] <TB2> INFO: 41600 events read in total (3679ms).
[17:35:56.525] <TB2> INFO: Test took 4523ms.
[17:35:56.528] <TB2> INFO: scanning low vcal = 120
[17:35:56.804] <TB2> INFO: Expecting 41600 events.
[17:36:01.003] <TB2> INFO: 41600 events read in total (3643ms).
[17:36:01.004] <TB2> INFO: Test took 4476ms.
[17:36:01.006] <TB2> INFO: scanning low vcal = 130
[17:36:01.281] <TB2> INFO: Expecting 41600 events.
[17:36:05.532] <TB2> INFO: 41600 events read in total (3694ms).
[17:36:05.532] <TB2> INFO: Test took 4526ms.
[17:36:05.535] <TB2> INFO: scanning low vcal = 140
[17:36:05.822] <TB2> INFO: Expecting 41600 events.
[17:36:10.007] <TB2> INFO: 41600 events read in total (3628ms).
[17:36:10.008] <TB2> INFO: Test took 4473ms.
[17:36:10.011] <TB2> INFO: scanning low vcal = 150
[17:36:10.293] <TB2> INFO: Expecting 41600 events.
[17:36:14.458] <TB2> INFO: 41600 events read in total (3609ms).
[17:36:14.459] <TB2> INFO: Test took 4448ms.
[17:36:14.461] <TB2> INFO: scanning low vcal = 160
[17:36:14.730] <TB2> INFO: Expecting 41600 events.
[17:36:18.895] <TB2> INFO: 41600 events read in total (3609ms).
[17:36:18.895] <TB2> INFO: Test took 4433ms.
[17:36:18.898] <TB2> INFO: scanning low vcal = 170
[17:36:19.166] <TB2> INFO: Expecting 41600 events.
[17:36:23.332] <TB2> INFO: 41600 events read in total (3610ms).
[17:36:23.333] <TB2> INFO: Test took 4435ms.
[17:36:23.337] <TB2> INFO: scanning low vcal = 180
[17:36:23.597] <TB2> INFO: Expecting 41600 events.
[17:36:27.769] <TB2> INFO: 41600 events read in total (3616ms).
[17:36:27.770] <TB2> INFO: Test took 4433ms.
[17:36:27.772] <TB2> INFO: scanning low vcal = 190
[17:36:28.047] <TB2> INFO: Expecting 41600 events.
[17:36:32.226] <TB2> INFO: 41600 events read in total (3623ms).
[17:36:32.227] <TB2> INFO: Test took 4455ms.
[17:36:32.229] <TB2> INFO: scanning low vcal = 200
[17:36:32.495] <TB2> INFO: Expecting 41600 events.
[17:36:36.666] <TB2> INFO: 41600 events read in total (3614ms).
[17:36:36.667] <TB2> INFO: Test took 4438ms.
[17:36:36.669] <TB2> INFO: scanning low vcal = 210
[17:36:36.932] <TB2> INFO: Expecting 41600 events.
[17:36:41.106] <TB2> INFO: 41600 events read in total (3618ms).
[17:36:41.106] <TB2> INFO: Test took 4437ms.
[17:36:41.109] <TB2> INFO: scanning low vcal = 220
[17:36:41.378] <TB2> INFO: Expecting 41600 events.
[17:36:45.548] <TB2> INFO: 41600 events read in total (3614ms).
[17:36:45.549] <TB2> INFO: Test took 4440ms.
[17:36:45.552] <TB2> INFO: scanning low vcal = 230
[17:36:45.834] <TB2> INFO: Expecting 41600 events.
[17:36:50.059] <TB2> INFO: 41600 events read in total (3669ms).
[17:36:50.059] <TB2> INFO: Test took 4507ms.
[17:36:50.062] <TB2> INFO: scanning low vcal = 240
[17:36:50.331] <TB2> INFO: Expecting 41600 events.
[17:36:54.541] <TB2> INFO: 41600 events read in total (3654ms).
[17:36:54.541] <TB2> INFO: Test took 4479ms.
[17:36:54.544] <TB2> INFO: scanning low vcal = 250
[17:36:54.817] <TB2> INFO: Expecting 41600 events.
[17:36:59.039] <TB2> INFO: 41600 events read in total (3666ms).
[17:36:59.040] <TB2> INFO: Test took 4496ms.
[17:36:59.044] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[17:36:59.315] <TB2> INFO: Expecting 41600 events.
[17:37:03.537] <TB2> INFO: 41600 events read in total (3666ms).
[17:37:03.537] <TB2> INFO: Test took 4493ms.
[17:37:03.540] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[17:37:03.829] <TB2> INFO: Expecting 41600 events.
[17:37:08.067] <TB2> INFO: 41600 events read in total (3681ms).
[17:37:08.068] <TB2> INFO: Test took 4527ms.
[17:37:08.071] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[17:37:08.361] <TB2> INFO: Expecting 41600 events.
[17:37:12.560] <TB2> INFO: 41600 events read in total (3643ms).
[17:37:12.560] <TB2> INFO: Test took 4489ms.
[17:37:12.563] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[17:37:12.835] <TB2> INFO: Expecting 41600 events.
[17:37:17.008] <TB2> INFO: 41600 events read in total (3617ms).
[17:37:17.008] <TB2> INFO: Test took 4445ms.
[17:37:17.011] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[17:37:17.282] <TB2> INFO: Expecting 41600 events.
[17:37:21.458] <TB2> INFO: 41600 events read in total (3620ms).
[17:37:21.458] <TB2> INFO: Test took 4447ms.
[17:37:21.984] <TB2> INFO: PixTestGainPedestal::measure() done
[17:37:56.310] <TB2> INFO: PixTestGainPedestal::fit() done
[17:37:56.311] <TB2> INFO: non-linearity mean: 0.962 0.961 0.959 0.954 0.958 0.960 0.958 0.960 0.961 0.960 0.956 0.954 0.953 0.953 0.953 0.965
[17:37:56.311] <TB2> INFO: non-linearity RMS: 0.006 0.006 0.005 0.008 0.006 0.006 0.005 0.006 0.007 0.005 0.007 0.007 0.007 0.006 0.008 0.006
[17:37:56.311] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C0.dat
[17:37:56.330] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C1.dat
[17:37:56.350] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C2.dat
[17:37:56.370] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C3.dat
[17:37:56.389] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C4.dat
[17:37:56.409] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C5.dat
[17:37:56.429] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C6.dat
[17:37:56.448] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C7.dat
[17:37:56.467] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C8.dat
[17:37:56.486] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C9.dat
[17:37:56.505] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C10.dat
[17:37:56.524] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C11.dat
[17:37:56.543] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C12.dat
[17:37:56.562] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C13.dat
[17:37:56.581] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C14.dat
[17:37:56.600] <TB2> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//phCalibrationFitErr35_C15.dat
[17:37:56.619] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 167 seconds
[17:37:56.620] <TB2> INFO: Decoding statistics:
[17:37:56.620] <TB2> INFO: General information:
[17:37:56.620] <TB2> INFO: 16bit words read: 2662400
[17:37:56.620] <TB2> INFO: valid events total: 166400
[17:37:56.620] <TB2> INFO: empty events: 0
[17:37:56.620] <TB2> INFO: valid events with pixels: 166400
[17:37:56.620] <TB2> INFO: valid pixel hits: 665528
[17:37:56.620] <TB2> INFO: Event errors: 0
[17:37:56.620] <TB2> INFO: start marker: 0
[17:37:56.620] <TB2> INFO: stop marker: 0
[17:37:56.620] <TB2> INFO: overflow: 0
[17:37:56.620] <TB2> INFO: invalid 5bit words: 0
[17:37:56.620] <TB2> INFO: invalid XOR eye diagram: 0
[17:37:56.620] <TB2> INFO: frame (failed synchr.): 0
[17:37:56.620] <TB2> INFO: idle data (no TBM trl): 0
[17:37:56.620] <TB2> INFO: no data (only TBM hdr): 0
[17:37:56.620] <TB2> INFO: TBM errors: 0
[17:37:56.620] <TB2> INFO: flawed TBM headers: 0
[17:37:56.620] <TB2> INFO: flawed TBM trailers: 0
[17:37:56.620] <TB2> INFO: event ID mismatches: 0
[17:37:56.620] <TB2> INFO: ROC errors: 0
[17:37:56.620] <TB2> INFO: missing ROC header(s): 0
[17:37:56.620] <TB2> INFO: misplaced readback start: 0
[17:37:56.620] <TB2> INFO: Pixel decoding errors: 0
[17:37:56.620] <TB2> INFO: pixel data incomplete: 0
[17:37:56.620] <TB2> INFO: pixel address: 0
[17:37:56.620] <TB2> INFO: pulse height fill bit: 0
[17:37:56.620] <TB2> INFO: buffer corruption: 0
[17:37:56.628] <TB2> INFO: readReadbackCal: /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C15.dat
[17:37:56.629] <TB2> INFO: ######################################################################
[17:37:56.629] <TB2> INFO: PixTestReadback::doTest()
[17:37:56.629] <TB2> INFO: ######################################################################
[17:37:56.629] <TB2> INFO: ----------------------------------------------------------------------
[17:37:56.629] <TB2> INFO: PixTestReadback::CalibrateVd()
[17:37:56.629] <TB2> INFO: ----------------------------------------------------------------------
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C0.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C1.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C2.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C3.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C4.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C5.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C6.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C7.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C8.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C9.dat
[17:38:06.121] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C10.dat
[17:38:06.122] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C11.dat
[17:38:06.122] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C12.dat
[17:38:06.122] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C13.dat
[17:38:06.122] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C14.dat
[17:38:06.122] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C15.dat
[17:38:06.157] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[17:38:06.157] <TB2> INFO: ----------------------------------------------------------------------
[17:38:06.157] <TB2> INFO: PixTestReadback::CalibrateVa()
[17:38:06.157] <TB2> INFO: ----------------------------------------------------------------------
[17:38:15.616] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C0.dat
[17:38:15.616] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C1.dat
[17:38:15.616] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C2.dat
[17:38:15.616] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C3.dat
[17:38:15.616] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C4.dat
[17:38:15.616] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C5.dat
[17:38:15.616] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C6.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C7.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C8.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C9.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C10.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C11.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C12.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C13.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C14.dat
[17:38:15.617] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C15.dat
[17:38:15.648] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[17:38:15.648] <TB2> INFO: ----------------------------------------------------------------------
[17:38:15.648] <TB2> INFO: PixTestReadback::readbackVbg()
[17:38:15.648] <TB2> INFO: ----------------------------------------------------------------------
[17:38:22.962] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[17:38:22.962] <TB2> INFO: ----------------------------------------------------------------------
[17:38:22.962] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[17:38:22.962] <TB2> INFO: ----------------------------------------------------------------------
[17:38:22.962] <TB2> INFO: Vbg will be calibrated using Vd calibration
[17:38:22.962] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 154.2calibrated Vbg = 1.21198 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 157.3calibrated Vbg = 1.21268 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 147.8calibrated Vbg = 1.21774 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 150.4calibrated Vbg = 1.22308 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 149.4calibrated Vbg = 1.22327 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 159.1calibrated Vbg = 1.22481 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 156.1calibrated Vbg = 1.22724 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 153.4calibrated Vbg = 1.22994 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 156.9calibrated Vbg = 1.23039 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 155.7calibrated Vbg = 1.22833 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 149.2calibrated Vbg = 1.22175 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 154.6calibrated Vbg = 1.22081 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 149.4calibrated Vbg = 1.21563 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 152.2calibrated Vbg = 1.20836 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 154.3calibrated Vbg = 1.21273 :::*/*/*/*/
[17:38:22.963] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 165calibrated Vbg = 1.21372 :::*/*/*/*/
[17:38:22.965] <TB2> INFO: ----------------------------------------------------------------------
[17:38:22.965] <TB2> INFO: PixTestReadback::CalibrateIa()
[17:38:22.965] <TB2> INFO: ----------------------------------------------------------------------
[17:40:58.302] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C0.dat
[17:40:58.302] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C1.dat
[17:40:58.302] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C2.dat
[17:40:58.302] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C3.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C4.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C5.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C6.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C7.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C8.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C9.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C10.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C11.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C12.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C13.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C14.dat
[17:40:58.303] <TB2> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2214_FullQualification_2016-04-22_11h26m_1461317188//004_FulltestPxar_p17//readbackCal_C15.dat
[17:40:58.334] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[17:40:58.336] <TB2> INFO: PixTestReadback::doTest() done
[17:40:58.336] <TB2> INFO: Decoding statistics:
[17:40:58.336] <TB2> INFO: General information:
[17:40:58.336] <TB2> INFO: 16bit words read: 1024
[17:40:58.337] <TB2> INFO: valid events total: 128
[17:40:58.337] <TB2> INFO: empty events: 128
[17:40:58.337] <TB2> INFO: valid events with pixels: 0
[17:40:58.337] <TB2> INFO: valid pixel hits: 0
[17:40:58.337] <TB2> INFO: Event errors: 0
[17:40:58.337] <TB2> INFO: start marker: 0
[17:40:58.337] <TB2> INFO: stop marker: 0
[17:40:58.337] <TB2> INFO: overflow: 0
[17:40:58.337] <TB2> INFO: invalid 5bit words: 0
[17:40:58.337] <TB2> INFO: invalid XOR eye diagram: 0
[17:40:58.337] <TB2> INFO: frame (failed synchr.): 0
[17:40:58.337] <TB2> INFO: idle data (no TBM trl): 0
[17:40:58.337] <TB2> INFO: no data (only TBM hdr): 0
[17:40:58.337] <TB2> INFO: TBM errors: 0
[17:40:58.337] <TB2> INFO: flawed TBM headers: 0
[17:40:58.337] <TB2> INFO: flawed TBM trailers: 0
[17:40:58.337] <TB2> INFO: event ID mismatches: 0
[17:40:58.337] <TB2> INFO: ROC errors: 0
[17:40:58.337] <TB2> INFO: missing ROC header(s): 0
[17:40:58.337] <TB2> INFO: misplaced readback start: 0
[17:40:58.337] <TB2> INFO: Pixel decoding errors: 0
[17:40:58.337] <TB2> INFO: pixel data incomplete: 0
[17:40:58.337] <TB2> INFO: pixel address: 0
[17:40:58.337] <TB2> INFO: pulse height fill bit: 0
[17:40:58.337] <TB2> INFO: buffer corruption: 0
[17:40:58.358] <TB2> INFO: Decoding statistics:
[17:40:58.358] <TB2> INFO: General information:
[17:40:58.358] <TB2> INFO: 16bit words read: 2755344
[17:40:58.358] <TB2> INFO: valid events total: 176768
[17:40:58.358] <TB2> INFO: empty events: 7868
[17:40:58.358] <TB2> INFO: valid events with pixels: 168900
[17:40:58.358] <TB2> INFO: valid pixel hits: 668028
[17:40:58.358] <TB2> INFO: Event errors: 0
[17:40:58.358] <TB2> INFO: start marker: 0
[17:40:58.358] <TB2> INFO: stop marker: 0
[17:40:58.358] <TB2> INFO: overflow: 0
[17:40:58.358] <TB2> INFO: invalid 5bit words: 0
[17:40:58.358] <TB2> INFO: invalid XOR eye diagram: 0
[17:40:58.358] <TB2> INFO: frame (failed synchr.): 0
[17:40:58.358] <TB2> INFO: idle data (no TBM trl): 0
[17:40:58.358] <TB2> INFO: no data (only TBM hdr): 0
[17:40:58.358] <TB2> INFO: TBM errors: 0
[17:40:58.358] <TB2> INFO: flawed TBM headers: 0
[17:40:58.358] <TB2> INFO: flawed TBM trailers: 0
[17:40:58.358] <TB2> INFO: event ID mismatches: 0
[17:40:58.358] <TB2> INFO: ROC errors: 0
[17:40:58.358] <TB2> INFO: missing ROC header(s): 0
[17:40:58.358] <TB2> INFO: misplaced readback start: 0
[17:40:58.358] <TB2> INFO: Pixel decoding errors: 0
[17:40:58.358] <TB2> INFO: pixel data incomplete: 0
[17:40:58.358] <TB2> INFO: pixel address: 0
[17:40:58.358] <TB2> INFO: pulse height fill bit: 0
[17:40:58.358] <TB2> INFO: buffer corruption: 0
[17:40:58.358] <TB2> INFO: enter test to run
[17:40:58.358] <TB2> INFO: test: exit no parameter change
[17:40:58.546] <TB2> QUIET: Connection to board 156 closed.
[17:40:58.625] <TB2> INFO: pXar: this is the end, my friend