[13:19:20.804] <TB1> INFO: *** Welcome to pxar ***
[13:19:20.804] <TB1> INFO: *** Today: 2016/06/28
[13:19:20.895] <TB1> INFO: *** Version: 9751-dirty
[13:19:20.895] <TB1> INFO: readRocDacs: /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C15.dat
[13:19:20.896] <TB1> INFO: readTbmDacs: /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//tbmParameters_C0b.dat
[13:19:20.896] <TB1> INFO: readMaskFile: /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//defaultMaskFile.dat
[13:19:20.896] <TB1> INFO: readTrimFile: /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters_C15.dat
[13:19:20.969] <TB1> INFO: clk: 4
[13:19:20.969] <TB1> INFO: ctr: 4
[13:19:20.969] <TB1> INFO: sda: 19
[13:19:20.969] <TB1> INFO: tin: 9
[13:19:20.969] <TB1> INFO: level: 15
[13:19:20.969] <TB1> INFO: triggerdelay: 0
[13:19:20.969] <TB1> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[13:19:20.969] <TB1> INFO: Log level: INFO
[13:19:20.977] <TB1> INFO: Found DTB DTB_WXBYFL
[13:19:20.986] <TB1> QUIET: Connection to board DTB_WXBYFL opened.
[13:19:20.988] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 153
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXBYFL
MAC address: 40D855118099
Hostname: pixelDTB153
Comment:
------------------------------------------------------
[13:19:20.989] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[13:19:22.545] <TB1> INFO: DUT info:
[13:19:22.545] <TB1> INFO: The DUT currently contains the following objects:
[13:19:22.545] <TB1> INFO: 2 TBM Cores tbm09c (2 ON)
[13:19:22.545] <TB1> INFO: TBM Core alpha (0): 7 registers set
[13:19:22.545] <TB1> INFO: TBM Core beta (1): 7 registers set
[13:19:22.545] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[13:19:22.545] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.545] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[13:19:22.946] <TB1> INFO: enter 'restricted' command line mode
[13:19:22.946] <TB1> INFO: enter test to run
[13:19:22.946] <TB1> INFO: test: pretest no parameter change
[13:19:22.946] <TB1> INFO: running: pretest
[13:19:22.957] <TB1> INFO: ----------------------------------------------------------------------
[13:19:22.957] <TB1> INFO: PixTestPretest::programROC()
[13:19:22.957] <TB1> INFO: ----------------------------------------------------------------------
[13:19:40.972] <TB1> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[13:19:40.972] <TB1> INFO: IA differences per ROC: 18.5 20.1 18.5 16.9 17.7 18.5 20.9 17.7 18.5 18.5 20.1 18.5 20.1 18.5 17.7 17.7
[13:19:41.067] <TB1> INFO: enter test to run
[13:19:41.067] <TB1> INFO: test: pretest no parameter change
[13:19:41.067] <TB1> INFO: running: pretest
[13:19:41.068] <TB1> INFO: ----------------------------------------------------------------------
[13:19:41.068] <TB1> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[13:19:41.068] <TB1> INFO: ----------------------------------------------------------------------
[13:20:02.333] <TB1> INFO: PixTestPretest::setVana() done, Module Ia 389.1 mA = 24.3188 mA/ROC
[13:20:02.333] <TB1> INFO: i(loss) [mA/ROC]: 20.1 21.7 20.9 19.3 20.1 20.1 20.1 19.3 20.1 20.1 19.3 20.1 20.1 20.1 20.1 20.1
[13:20:02.368] <TB1> INFO: enter test to run
[13:20:02.368] <TB1> INFO: test: pretest no parameter change
[13:20:02.368] <TB1> INFO: running: pretest
[13:20:02.368] <TB1> INFO: ----------------------------------------------------------------------
[13:20:02.368] <TB1> INFO: PixTestPretest::findTiming()
[13:20:02.368] <TB1> INFO: ----------------------------------------------------------------------
[13:20:02.368] <TB1> INFO: PixTestCmd::init()

[13:21:30.351] <TB1> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[13:21:30.351] <TB1> INFO: (success/tries = 100/100), width = 3
[13:21:30.352] <TB1> INFO: enter test to run
[13:21:30.352] <TB1> INFO: test: pretest no parameter change
[13:21:30.352] <TB1> INFO: running: pretest
[13:21:30.354] <TB1> INFO: ----------------------------------------------------------------------
[13:21:30.354] <TB1> INFO: PixTestPretest::findWorkingPixel()
[13:21:30.354] <TB1> INFO: ----------------------------------------------------------------------
[13:21:30.445] <TB1> INFO: Expecting 231680 events.


[13:21:40.494] <TB1> INFO: 231680 events read in total (9493ms).
[13:21:40.499] <TB1> INFO: Test took 10141ms.
[13:21:40.720] <TB1> INFO: Found working pixel in all ROCs: col/row = 12/22
[13:21:40.780] <TB1> INFO: enter test to run
[13:21:40.780] <TB1> INFO: test: pretest no parameter change
[13:21:40.780] <TB1> INFO: running: pretest
[13:21:40.781] <TB1> INFO: ----------------------------------------------------------------------
[13:21:40.781] <TB1> INFO: PixTestPretest::setVthrCompCalDel()
[13:21:40.781] <TB1> INFO: ----------------------------------------------------------------------
[13:21:40.873] <TB1> INFO: Expecting 231680 events.
[13:21:50.984] <TB1> INFO: 231680 events read in total (9554ms).
[13:21:50.988] <TB1> INFO: Test took 10203ms.
[13:21:51.224] <TB1> INFO: PixTestPretest::setVthrCompCalDel() done
[13:21:51.224] <TB1> INFO: CalDel: 138 159 123 119 124 143 129 120 148 129 147 144 149 124 145 115
[13:21:51.224] <TB1> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[13:21:51.258] <TB1> INFO: enter test to run
[13:21:51.259] <TB1> INFO: test: pretest no parameter change
[13:21:51.259] <TB1> INFO: running: pretest
[13:21:51.259] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C0.dat
[13:21:51.259] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C1.dat
[13:21:51.259] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C2.dat
[13:21:51.259] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C3.dat
[13:21:51.259] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C4.dat
[13:21:51.259] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C5.dat
[13:21:51.259] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C6.dat
[13:21:51.259] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C7.dat
[13:21:51.260] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C8.dat
[13:21:51.260] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C9.dat
[13:21:51.260] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C10.dat
[13:21:51.260] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C11.dat
[13:21:51.260] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C12.dat
[13:21:51.260] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C13.dat
[13:21:51.260] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C14.dat
[13:21:51.260] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters_C15.dat
[13:21:51.261] <TB1> INFO: enter test to run
[13:21:51.261] <TB1> INFO: test: fulltest no parameter change
[13:21:51.261] <TB1> INFO: running: fulltest
[13:21:51.261] <TB1> INFO: ######################################################################
[13:21:51.261] <TB1> INFO: PixTestFullTest::doTest()
[13:21:51.261] <TB1> INFO: ######################################################################
[13:21:51.262] <TB1> INFO: ######################################################################
[13:21:51.262] <TB1> INFO: PixTestAlive::doTest()
[13:21:51.262] <TB1> INFO: ######################################################################
[13:21:51.263] <TB1> INFO: ----------------------------------------------------------------------
[13:21:51.263] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:21:51.263] <TB1> INFO: ----------------------------------------------------------------------
[13:21:51.529] <TB1> INFO: Expecting 41600 events.
[13:21:55.309] <TB1> INFO: 41600 events read in total (3223ms).
[13:21:55.310] <TB1> INFO: Test took 4046ms.
[13:21:55.533] <TB1> INFO: PixTestAlive::aliveTest() done
[13:21:55.533] <TB1> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 1 0 0 0
[13:21:55.534] <TB1> INFO: ----------------------------------------------------------------------
[13:21:55.534] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:21:55.534] <TB1> INFO: ----------------------------------------------------------------------
[13:21:55.798] <TB1> INFO: Expecting 41600 events.
[13:21:58.800] <TB1> INFO: 41600 events read in total (2445ms).
[13:21:58.800] <TB1> INFO: Test took 3265ms.
[13:21:58.800] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[13:21:59.039] <TB1> INFO: PixTestAlive::maskTest() done
[13:21:59.039] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:21:59.040] <TB1> INFO: ----------------------------------------------------------------------
[13:21:59.040] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[13:21:59.040] <TB1> INFO: ----------------------------------------------------------------------
[13:21:59.361] <TB1> INFO: Expecting 41600 events.
[13:22:03.094] <TB1> INFO: 41600 events read in total (3176ms).
[13:22:03.094] <TB1> INFO: Test took 4052ms.
[13:22:03.318] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[13:22:03.318] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[13:22:03.318] <TB1> INFO: PixTestAlive::doTest() done, duration: 12 seconds
[13:22:03.318] <TB1> INFO: Decoding statistics:
[13:22:03.318] <TB1> INFO: General information:
[13:22:03.318] <TB1> INFO: 16bit words read: 0
[13:22:03.318] <TB1> INFO: valid events total: 0
[13:22:03.318] <TB1> INFO: empty events: 0
[13:22:03.318] <TB1> INFO: valid events with pixels: 0
[13:22:03.318] <TB1> INFO: valid pixel hits: 0
[13:22:03.318] <TB1> INFO: Event errors: 0
[13:22:03.318] <TB1> INFO: start marker: 0
[13:22:03.318] <TB1> INFO: stop marker: 0
[13:22:03.318] <TB1> INFO: overflow: 0
[13:22:03.318] <TB1> INFO: invalid 5bit words: 0
[13:22:03.318] <TB1> INFO: invalid XOR eye diagram: 0
[13:22:03.318] <TB1> INFO: frame (failed synchr.): 0
[13:22:03.318] <TB1> INFO: idle data (no TBM trl): 0
[13:22:03.318] <TB1> INFO: no data (only TBM hdr): 0
[13:22:03.318] <TB1> INFO: TBM errors: 0
[13:22:03.318] <TB1> INFO: flawed TBM headers: 0
[13:22:03.318] <TB1> INFO: flawed TBM trailers: 0
[13:22:03.318] <TB1> INFO: event ID mismatches: 0
[13:22:03.318] <TB1> INFO: ROC errors: 0
[13:22:03.318] <TB1> INFO: missing ROC header(s): 0
[13:22:03.318] <TB1> INFO: misplaced readback start: 0
[13:22:03.318] <TB1> INFO: Pixel decoding errors: 0
[13:22:03.318] <TB1> INFO: pixel data incomplete: 0
[13:22:03.318] <TB1> INFO: pixel address: 0
[13:22:03.318] <TB1> INFO: pulse height fill bit: 0
[13:22:03.318] <TB1> INFO: buffer corruption: 0
[13:22:03.325] <TB1> INFO: ######################################################################
[13:22:03.325] <TB1> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[13:22:03.325] <TB1> INFO: ######################################################################
[13:22:03.327] <TB1> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[13:22:03.338] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[13:22:03.338] <TB1> INFO: run 1 of 1
[13:22:03.603] <TB1> INFO: Expecting 3120000 events.
[13:22:45.255] <TB1> INFO: 859205 events read in total (41096ms).
[13:23:25.715] <TB1> INFO: 1708755 events read in total (81556ms).
[13:24:06.318] <TB1> INFO: 2567865 events read in total (122160ms).
[13:24:31.889] <TB1> INFO: 3120000 events read in total (147730ms).
[13:24:31.935] <TB1> INFO: Test took 148597ms.
[13:24:56.931] <TB1> INFO: PixTestBBMap::doTest() done, duration: 173 seconds
[13:24:56.931] <TB1> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 1 1 0 0
[13:24:56.931] <TB1> INFO: separation cut (per ROC): 95 92 109 86 88 84 90 95 88 85 83 89 104 102 90 111
[13:24:56.931] <TB1> INFO: Decoding statistics:
[13:24:56.931] <TB1> INFO: General information:
[13:24:56.931] <TB1> INFO: 16bit words read: 0
[13:24:56.931] <TB1> INFO: valid events total: 0
[13:24:56.931] <TB1> INFO: empty events: 0
[13:24:56.931] <TB1> INFO: valid events with pixels: 0
[13:24:56.931] <TB1> INFO: valid pixel hits: 0
[13:24:56.931] <TB1> INFO: Event errors: 0
[13:24:56.931] <TB1> INFO: start marker: 0
[13:24:56.931] <TB1> INFO: stop marker: 0
[13:24:56.931] <TB1> INFO: overflow: 0
[13:24:56.931] <TB1> INFO: invalid 5bit words: 0
[13:24:56.931] <TB1> INFO: invalid XOR eye diagram: 0
[13:24:56.931] <TB1> INFO: frame (failed synchr.): 0
[13:24:56.931] <TB1> INFO: idle data (no TBM trl): 0
[13:24:56.931] <TB1> INFO: no data (only TBM hdr): 0
[13:24:56.931] <TB1> INFO: TBM errors: 0
[13:24:56.931] <TB1> INFO: flawed TBM headers: 0
[13:24:56.931] <TB1> INFO: flawed TBM trailers: 0
[13:24:56.931] <TB1> INFO: event ID mismatches: 0
[13:24:56.931] <TB1> INFO: ROC errors: 0
[13:24:56.931] <TB1> INFO: missing ROC header(s): 0
[13:24:56.931] <TB1> INFO: misplaced readback start: 0
[13:24:56.931] <TB1> INFO: Pixel decoding errors: 0
[13:24:56.931] <TB1> INFO: pixel data incomplete: 0
[13:24:56.931] <TB1> INFO: pixel address: 0
[13:24:56.931] <TB1> INFO: pulse height fill bit: 0
[13:24:56.931] <TB1> INFO: buffer corruption: 0
[13:24:57.013] <TB1> INFO: ######################################################################
[13:24:57.013] <TB1> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[13:24:57.013] <TB1> INFO: ######################################################################
[13:24:57.013] <TB1> INFO: ----------------------------------------------------------------------
[13:24:57.013] <TB1> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[13:24:57.013] <TB1> INFO: ----------------------------------------------------------------------
[13:24:57.014] <TB1> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[13:24:57.022] <TB1> INFO: dacScan split into 1 runs with ntrig = 50
[13:24:57.022] <TB1> INFO: run 1 of 1
[13:24:57.314] <TB1> INFO: Expecting 26208000 events.
[13:25:31.037] <TB1> INFO: 918600 events read in total (33167ms).
[13:26:04.011] <TB1> INFO: 1824050 events read in total (66141ms).
[13:26:37.436] <TB1> INFO: 2725850 events read in total (99566ms).
[13:27:10.529] <TB1> INFO: 3628500 events read in total (132659ms).
[13:27:43.794] <TB1> INFO: 4534000 events read in total (165924ms).
[13:28:16.787] <TB1> INFO: 5434450 events read in total (198917ms).
[13:28:50.082] <TB1> INFO: 6340300 events read in total (232212ms).
[13:29:23.208] <TB1> INFO: 7243400 events read in total (265338ms).
[13:29:56.455] <TB1> INFO: 8149150 events read in total (298585ms).
[13:30:29.706] <TB1> INFO: 9052300 events read in total (331836ms).
[13:31:02.905] <TB1> INFO: 9954550 events read in total (365035ms).
[13:31:36.129] <TB1> INFO: 10862150 events read in total (398259ms).
[13:32:09.375] <TB1> INFO: 11767500 events read in total (431505ms).
[13:32:42.755] <TB1> INFO: 12674150 events read in total (464885ms).
[13:33:16.952] <TB1> INFO: 13570700 events read in total (499082ms).
[13:33:50.289] <TB1> INFO: 14464550 events read in total (532419ms).
[13:34:23.636] <TB1> INFO: 15358800 events read in total (565766ms).
[13:34:56.674] <TB1> INFO: 16251200 events read in total (598804ms).
[13:35:29.837] <TB1> INFO: 17141200 events read in total (631967ms).
[13:36:02.429] <TB1> INFO: 18029750 events read in total (664559ms).
[13:36:35.156] <TB1> INFO: 18920900 events read in total (697286ms).
[13:37:07.993] <TB1> INFO: 19809900 events read in total (730123ms).
[13:37:40.551] <TB1> INFO: 20698400 events read in total (762681ms).
[13:38:13.834] <TB1> INFO: 21583650 events read in total (795964ms).
[13:38:46.454] <TB1> INFO: 22470650 events read in total (828584ms).
[13:39:19.403] <TB1> INFO: 23359750 events read in total (861533ms).
[13:39:52.145] <TB1> INFO: 24250150 events read in total (894275ms).
[13:40:25.028] <TB1> INFO: 25136100 events read in total (927158ms).
[13:40:58.099] <TB1> INFO: 26040800 events read in total (960229ms).
[13:41:04.580] <TB1> INFO: 26208000 events read in total (966710ms).
[13:41:04.607] <TB1> INFO: Test took 967585ms.
[13:41:04.830] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:06.336] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:07.829] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:09.385] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:10.861] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:12.327] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:13.831] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:15.317] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:16.711] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:18.350] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:19.951] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:21.387] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:23.021] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:24.499] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:25.991] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:27.540] <TB1> INFO: dumping ASCII scurve output file: SCurveData
[13:41:29.163] <TB1> INFO: PixTestScurves::scurves() done
[13:41:29.163] <TB1> INFO: Vcal mean: 95.36 89.98 107.03 82.67 87.44 88.08 95.87 99.95 94.31 90.10 88.35 91.64 98.00 101.84 86.17 105.43
[13:41:29.163] <TB1> INFO: Vcal RMS: 7.54 6.98 5.90 4.75 5.29 5.75 5.19 5.68 6.79 5.43 5.51 5.41 6.08 6.31 5.20 6.09
[13:41:29.163] <TB1> INFO: PixTestScurves::fullTest() done, duration: 992 seconds
[13:41:29.163] <TB1> INFO: Decoding statistics:
[13:41:29.164] <TB1> INFO: General information:
[13:41:29.164] <TB1> INFO: 16bit words read: 0
[13:41:29.164] <TB1> INFO: valid events total: 0
[13:41:29.164] <TB1> INFO: empty events: 0
[13:41:29.164] <TB1> INFO: valid events with pixels: 0
[13:41:29.164] <TB1> INFO: valid pixel hits: 0
[13:41:29.164] <TB1> INFO: Event errors: 0
[13:41:29.164] <TB1> INFO: start marker: 0
[13:41:29.164] <TB1> INFO: stop marker: 0
[13:41:29.164] <TB1> INFO: overflow: 0
[13:41:29.164] <TB1> INFO: invalid 5bit words: 0
[13:41:29.164] <TB1> INFO: invalid XOR eye diagram: 0
[13:41:29.164] <TB1> INFO: frame (failed synchr.): 0
[13:41:29.164] <TB1> INFO: idle data (no TBM trl): 0
[13:41:29.164] <TB1> INFO: no data (only TBM hdr): 0
[13:41:29.164] <TB1> INFO: TBM errors: 0
[13:41:29.164] <TB1> INFO: flawed TBM headers: 0
[13:41:29.164] <TB1> INFO: flawed TBM trailers: 0
[13:41:29.164] <TB1> INFO: event ID mismatches: 0
[13:41:29.164] <TB1> INFO: ROC errors: 0
[13:41:29.164] <TB1> INFO: missing ROC header(s): 0
[13:41:29.164] <TB1> INFO: misplaced readback start: 0
[13:41:29.164] <TB1> INFO: Pixel decoding errors: 0
[13:41:29.164] <TB1> INFO: pixel data incomplete: 0
[13:41:29.164] <TB1> INFO: pixel address: 0
[13:41:29.164] <TB1> INFO: pulse height fill bit: 0
[13:41:29.164] <TB1> INFO: buffer corruption: 0
[13:41:29.242] <TB1> INFO: ######################################################################
[13:41:29.242] <TB1> INFO: PixTestTrim::doTest()
[13:41:29.242] <TB1> INFO: ######################################################################
[13:41:29.243] <TB1> INFO: ----------------------------------------------------------------------
[13:41:29.243] <TB1> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[13:41:29.243] <TB1> INFO: ----------------------------------------------------------------------
[13:41:29.351] <TB1> INFO: ---> VthrComp thr map (minimal VthrComp)
[13:41:29.351] <TB1> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:41:29.360] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:41:29.360] <TB1> INFO: run 1 of 1
[13:41:29.646] <TB1> INFO: Expecting 6281600 events.
[13:42:09.246] <TB1> INFO: 1070270 events read in total (39044ms).
[13:42:47.800] <TB1> INFO: 2137780 events read in total (77598ms).
[13:43:26.483] <TB1> INFO: 3203750 events read in total (116281ms).
[13:44:05.437] <TB1> INFO: 4278170 events read in total (155236ms).
[13:44:44.407] <TB1> INFO: 5358040 events read in total (194205ms).
[13:45:18.165] <TB1> INFO: 6281600 events read in total (227963ms).
[13:45:18.200] <TB1> INFO: Test took 228840ms.
[13:45:36.919] <TB1> INFO: ROC 0 VthrComp = 94
[13:45:36.919] <TB1> INFO: ROC 1 VthrComp = 94
[13:45:36.919] <TB1> INFO: ROC 2 VthrComp = 105
[13:45:36.919] <TB1> INFO: ROC 3 VthrComp = 89
[13:45:36.921] <TB1> INFO: ROC 4 VthrComp = 91
[13:45:36.921] <TB1> INFO: ROC 5 VthrComp = 91
[13:45:36.921] <TB1> INFO: ROC 6 VthrComp = 102
[13:45:36.921] <TB1> INFO: ROC 7 VthrComp = 101
[13:45:36.921] <TB1> INFO: ROC 8 VthrComp = 90
[13:45:36.921] <TB1> INFO: ROC 9 VthrComp = 89
[13:45:36.921] <TB1> INFO: ROC 10 VthrComp = 87
[13:45:36.921] <TB1> INFO: ROC 11 VthrComp = 91
[13:45:36.922] <TB1> INFO: ROC 12 VthrComp = 98
[13:45:36.922] <TB1> INFO: ROC 13 VthrComp = 98
[13:45:36.922] <TB1> INFO: ROC 14 VthrComp = 89
[13:45:36.922] <TB1> INFO: ROC 15 VthrComp = 101
[13:45:36.922] <TB1> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[13:45:36.922] <TB1> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[13:45:36.934] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:45:36.934] <TB1> INFO: run 1 of 1
[13:45:37.228] <TB1> INFO: Expecting 6281600 events.
[13:46:12.585] <TB1> INFO: 756740 events read in total (34801ms).
[13:46:47.391] <TB1> INFO: 1512330 events read in total (69607ms).
[13:47:21.891] <TB1> INFO: 2268530 events read in total (104107ms).
[13:47:56.532] <TB1> INFO: 3025700 events read in total (138748ms).
[13:48:31.273] <TB1> INFO: 3777270 events read in total (173489ms).
[13:49:05.503] <TB1> INFO: 4525280 events read in total (207719ms).
[13:49:40.378] <TB1> INFO: 5271140 events read in total (242594ms).
[13:50:15.156] <TB1> INFO: 6016600 events read in total (277372ms).
[13:50:27.679] <TB1> INFO: 6281600 events read in total (289895ms).
[13:50:27.725] <TB1> INFO: Test took 290791ms.
[13:50:53.621] <TB1> INFO: roc 0 with ID = 0 has maximal Vcal 64.6459 for pixel 2/79 mean/min/max = 47.7389/30.7134/64.7643
[13:50:53.622] <TB1> INFO: roc 1 with ID = 1 has maximal Vcal 62.0484 for pixel 4/0 mean/min/max = 46.5001/30.6348/62.3655
[13:50:53.622] <TB1> INFO: roc 2 with ID = 2 has maximal Vcal 63.0579 for pixel 10/75 mean/min/max = 48.1433/33.1697/63.117
[13:50:53.622] <TB1> INFO: roc 3 with ID = 3 has maximal Vcal 58.1318 for pixel 4/66 mean/min/max = 45.5507/32.8949/58.2065
[13:50:53.622] <TB1> INFO: roc 4 with ID = 4 has maximal Vcal 59.0976 for pixel 4/3 mean/min/max = 45.9983/32.8395/59.1572
[13:50:53.623] <TB1> INFO: roc 5 with ID = 5 has maximal Vcal 59.7311 for pixel 51/7 mean/min/max = 46.0715/32.3095/59.8336
[13:50:53.623] <TB1> INFO: roc 6 with ID = 6 has maximal Vcal 56.9478 for pixel 7/2 mean/min/max = 45.023/32.8364/57.2096
[13:50:53.623] <TB1> INFO: roc 7 with ID = 7 has maximal Vcal 59.4543 for pixel 23/63 mean/min/max = 45.7129/31.8631/59.5626
[13:50:53.624] <TB1> INFO: roc 8 with ID = 8 has maximal Vcal 63.3353 for pixel 51/18 mean/min/max = 47.5669/31.7915/63.3424
[13:50:53.624] <TB1> INFO: roc 9 with ID = 9 has maximal Vcal 59.909 for pixel 20/51 mean/min/max = 46.3873/32.8448/59.9298
[13:50:53.624] <TB1> INFO: roc 10 with ID = 10 has maximal Vcal 59.7925 for pixel 2/26 mean/min/max = 45.8728/31.9073/59.8383
[13:50:53.624] <TB1> INFO: roc 11 with ID = 11 has maximal Vcal 58.8794 for pixel 2/2 mean/min/max = 46.0137/33.0807/58.9468
[13:50:53.625] <TB1> INFO: roc 12 with ID = 12 has maximal Vcal 60.2367 for pixel 6/8 mean/min/max = 45.6357/30.9693/60.3021
[13:50:53.625] <TB1> INFO: roc 13 with ID = 13 has maximal Vcal 62.4866 for pixel 35/76 mean/min/max = 47.061/31.417/62.7051
[13:50:53.625] <TB1> INFO: roc 14 with ID = 14 has maximal Vcal 58.5527 for pixel 20/11 mean/min/max = 45.4069/32.0467/58.7671
[13:50:53.625] <TB1> INFO: roc 15 with ID = 15 has maximal Vcal 64.3631 for pixel 0/51 mean/min/max = 48.0782/31.6714/64.485
[13:50:53.626] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[13:50:53.714] <TB1> INFO: Expecting 514560 events.
[13:51:06.427] <TB1> INFO: 514560 events read in total (12157ms).
[13:51:06.432] <TB1> INFO: Expecting 514560 events.
[13:51:19.509] <TB1> INFO: 514560 events read in total (12650ms).
[13:51:19.517] <TB1> INFO: Expecting 514560 events.
[13:51:32.203] <TB1> INFO: 514560 events read in total (12270ms).
[13:51:32.212] <TB1> INFO: Expecting 514560 events.
[13:51:44.875] <TB1> INFO: 514560 events read in total (12244ms).
[13:51:44.889] <TB1> INFO: Expecting 514560 events.
[13:51:57.666] <TB1> INFO: 514560 events read in total (12366ms).
[13:51:57.680] <TB1> INFO: Expecting 514560 events.
[13:52:10.365] <TB1> INFO: 514560 events read in total (12279ms).
[13:52:10.379] <TB1> INFO: Expecting 514560 events.
[13:52:23.052] <TB1> INFO: 514560 events read in total (12256ms).
[13:52:23.068] <TB1> INFO: Expecting 514560 events.
[13:52:35.718] <TB1> INFO: 514560 events read in total (12239ms).
[13:52:35.742] <TB1> INFO: Expecting 514560 events.
[13:52:48.401] <TB1> INFO: 514560 events read in total (12257ms).
[13:52:48.420] <TB1> INFO: Expecting 514560 events.
[13:53:01.152] <TB1> INFO: 514560 events read in total (12317ms).
[13:53:01.176] <TB1> INFO: Expecting 514560 events.
[13:53:13.985] <TB1> INFO: 514560 events read in total (12403ms).
[13:53:14.008] <TB1> INFO: Expecting 514560 events.
[13:53:26.768] <TB1> INFO: 514560 events read in total (12356ms).
[13:53:26.792] <TB1> INFO: Expecting 514560 events.
[13:53:39.734] <TB1> INFO: 514560 events read in total (12540ms).
[13:53:39.765] <TB1> INFO: Expecting 514560 events.
[13:53:52.539] <TB1> INFO: 514560 events read in total (12372ms).
[13:53:52.571] <TB1> INFO: Expecting 514560 events.
[13:54:05.445] <TB1> INFO: 514560 events read in total (12472ms).
[13:54:05.478] <TB1> INFO: Expecting 514560 events.
[13:54:18.136] <TB1> INFO: 514560 events read in total (12256ms).
[13:54:18.167] <TB1> INFO: Test took 204541ms.
[13:54:19.054] <TB1> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[13:54:19.062] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:54:19.062] <TB1> INFO: run 1 of 1
[13:54:19.322] <TB1> INFO: Expecting 6281600 events.
[13:54:54.453] <TB1> INFO: 740340 events read in total (34575ms).
[13:55:29.112] <TB1> INFO: 1479600 events read in total (69234ms).
[13:56:03.363] <TB1> INFO: 2219380 events read in total (103485ms).
[13:56:37.967] <TB1> INFO: 2960170 events read in total (138089ms).
[13:57:12.756] <TB1> INFO: 3694860 events read in total (172878ms).
[13:57:46.789] <TB1> INFO: 4425970 events read in total (206911ms).
[13:58:21.292] <TB1> INFO: 5154750 events read in total (241414ms).
[13:58:55.556] <TB1> INFO: 5883520 events read in total (275678ms).
[13:59:14.172] <TB1> INFO: 6281600 events read in total (294294ms).
[13:59:14.216] <TB1> INFO: Test took 295154ms.
[13:59:38.013] <TB1> INFO: ---> TrimStepCorr4 extremal thresholds: 0.023254 .. 255.000000
[13:59:38.088] <TB1> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 255 (-1/-1) hits flags = 528 (plus default)
[13:59:38.097] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[13:59:38.097] <TB1> INFO: run 1 of 1
[13:59:38.362] <TB1> INFO: Expecting 10649600 events.
[14:00:13.235] <TB1> INFO: 711390 events read in total (34316ms).
[14:00:47.144] <TB1> INFO: 1423560 events read in total (68225ms).
[14:01:21.322] <TB1> INFO: 2135700 events read in total (102403ms).
[14:01:55.384] <TB1> INFO: 2848060 events read in total (136465ms).
[14:02:29.298] <TB1> INFO: 3560380 events read in total (170379ms).
[14:03:03.913] <TB1> INFO: 4272710 events read in total (204994ms).
[14:03:38.200] <TB1> INFO: 4985060 events read in total (239281ms).
[14:04:12.142] <TB1> INFO: 5697350 events read in total (273223ms).
[14:04:45.891] <TB1> INFO: 6409650 events read in total (306972ms).
[14:05:19.982] <TB1> INFO: 7120930 events read in total (341063ms).
[14:05:54.355] <TB1> INFO: 7832250 events read in total (375436ms).
[14:06:28.740] <TB1> INFO: 8542980 events read in total (409821ms).
[14:07:03.305] <TB1> INFO: 9253570 events read in total (444386ms).
[14:07:37.175] <TB1> INFO: 9964320 events read in total (478256ms).
[14:08:11.153] <TB1> INFO: 10649600 events read in total (512234ms).
[14:08:11.257] <TB1> INFO: Test took 513161ms.
[14:08:40.426] <TB1> INFO: ---> TrimStepCorr2 extremal thresholds: 15.289526 .. 70.077572
[14:08:40.511] <TB1> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 5 .. 80 (-1/-1) hits flags = 528 (plus default)
[14:08:40.520] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[14:08:40.520] <TB1> INFO: run 1 of 1
[14:08:40.807] <TB1> INFO: Expecting 3161600 events.
[14:09:17.130] <TB1> INFO: 824930 events read in total (35767ms).
[14:09:53.073] <TB1> INFO: 1649870 events read in total (71711ms).
[14:10:28.849] <TB1> INFO: 2473530 events read in total (107486ms).
[14:10:58.811] <TB1> INFO: 3161600 events read in total (137448ms).
[14:10:58.833] <TB1> INFO: Test took 138312ms.
[14:11:16.354] <TB1> INFO: ---> TrimStepCorr1a extremal thresholds: 1.909266 .. 45.538032
[14:11:16.434] <TB1> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 1 .. 55 (-1/-1) hits flags = 528 (plus default)
[14:11:16.444] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[14:11:16.444] <TB1> INFO: run 1 of 1
[14:11:16.707] <TB1> INFO: Expecting 2288000 events.
[14:11:54.795] <TB1> INFO: 959620 events read in total (37532ms).
[14:12:32.941] <TB1> INFO: 1917970 events read in total (75679ms).
[14:12:48.040] <TB1> INFO: 2288000 events read in total (90777ms).
[14:12:48.053] <TB1> INFO: Test took 91609ms.
[14:13:01.881] <TB1> INFO: ---> TrimStepCorr1b extremal thresholds: 1.909266 .. 45.538032
[14:13:01.959] <TB1> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 1 .. 55 (-1/-1) hits flags = 528 (plus default)
[14:13:01.968] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[14:13:01.968] <TB1> INFO: run 1 of 1
[14:13:02.231] <TB1> INFO: Expecting 2288000 events.
[14:13:40.785] <TB1> INFO: 959890 events read in total (37998ms).
[14:14:18.464] <TB1> INFO: 1919890 events read in total (75677ms).
[14:14:33.213] <TB1> INFO: 2288000 events read in total (90427ms).
[14:14:33.230] <TB1> INFO: Test took 91262ms.
[14:14:47.259] <TB1> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[14:14:47.259] <TB1> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[14:14:47.268] <TB1> INFO: dacScan split into 1 runs with ntrig = 10
[14:14:47.268] <TB1> INFO: run 1 of 1
[14:14:47.532] <TB1> INFO: Expecting 1705600 events.
[14:15:25.288] <TB1> INFO: 878220 events read in total (37200ms).
[14:16:00.444] <TB1> INFO: 1705600 events read in total (72356ms).
[14:16:00.457] <TB1> INFO: Test took 73189ms.
[14:16:13.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C0.dat
[14:16:13.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C1.dat
[14:16:13.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C2.dat
[14:16:13.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C3.dat
[14:16:13.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C4.dat
[14:16:13.407] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C5.dat
[14:16:13.408] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C6.dat
[14:16:13.408] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C7.dat
[14:16:13.408] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C8.dat
[14:16:13.408] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C9.dat
[14:16:13.408] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C10.dat
[14:16:13.408] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C11.dat
[14:16:13.408] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C12.dat
[14:16:13.408] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C13.dat
[14:16:13.409] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C14.dat
[14:16:13.409] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C15.dat
[14:16:13.409] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C0.dat
[14:16:13.416] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C1.dat
[14:16:13.422] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C2.dat
[14:16:13.428] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C3.dat
[14:16:13.434] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C4.dat
[14:16:13.441] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C5.dat
[14:16:13.447] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C6.dat
[14:16:13.453] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C7.dat
[14:16:13.460] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C8.dat
[14:16:13.466] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C9.dat
[14:16:13.472] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C10.dat
[14:16:13.479] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C11.dat
[14:16:13.485] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C12.dat
[14:16:13.491] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C13.dat
[14:16:13.498] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C14.dat
[14:16:13.504] <TB1> INFO: write trim parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//trimParameters35_C15.dat
[14:16:13.510] <TB1> INFO: PixTestTrim::trimTest() done
[14:16:13.510] <TB1> INFO: vtrim: 106 116 115 91 94 97 96 105 91 87 96 99 100 93 106 97
[14:16:13.510] <TB1> INFO: vthrcomp: 94 94 105 89 91 91 102 101 90 89 87 91 98 98 89 101
[14:16:13.510] <TB1> INFO: vcal mean: 34.97 34.98 35.01 34.98 34.98 34.96 34.94 34.96 35.00 35.00 34.96 35.01 34.92 34.96 34.92 35.06
[14:16:13.510] <TB1> INFO: vcal RMS: 0.95 0.88 0.90 0.77 0.83 0.93 0.83 0.93 0.93 0.98 1.11 0.85 1.17 0.93 0.86 1.07
[14:16:13.510] <TB1> INFO: bits mean: 8.95 9.40 8.79 8.99 9.17 8.90 9.19 9.48 8.63 9.29 9.73 9.18 9.70 9.24 9.70 8.91
[14:16:13.510] <TB1> INFO: bits RMS: 2.96 2.86 2.62 2.76 2.69 2.90 2.76 2.69 2.88 2.60 2.59 2.69 2.66 2.77 2.62 2.86
[14:16:13.516] <TB1> INFO: ----------------------------------------------------------------------
[14:16:13.516] <TB1> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[14:16:13.516] <TB1> INFO: ----------------------------------------------------------------------
[14:16:13.519] <TB1> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[14:16:13.527] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[14:16:13.527] <TB1> INFO: run 1 of 1
[14:16:13.786] <TB1> INFO: Expecting 4160000 events.
[14:16:56.669] <TB1> INFO: 947050 events read in total (42327ms).
[14:17:38.560] <TB1> INFO: 1887895 events read in total (84218ms).
[14:18:20.590] <TB1> INFO: 2819325 events read in total (126248ms).
[14:19:01.570] <TB1> INFO: 3746720 events read in total (167228ms).
[14:19:20.315] <TB1> INFO: 4160000 events read in total (185973ms).
[14:19:20.356] <TB1> INFO: Test took 186829ms.
[14:19:48.990] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 185 (-1/-1) hits flags = 528 (plus default)
[14:19:48.998] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[14:19:48.998] <TB1> INFO: run 1 of 1
[14:19:49.285] <TB1> INFO: Expecting 3868800 events.
[14:20:31.457] <TB1> INFO: 942015 events read in total (41616ms).
[14:21:13.666] <TB1> INFO: 1879025 events read in total (83825ms).
[14:21:55.543] <TB1> INFO: 2804580 events read in total (125702ms).
[14:22:37.351] <TB1> INFO: 3727320 events read in total (167510ms).
[14:22:43.905] <TB1> INFO: 3868800 events read in total (174064ms).
[14:22:43.947] <TB1> INFO: Test took 174948ms.
[14:23:10.806] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 170 (-1/-1) hits flags = 528 (plus default)
[14:23:10.815] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[14:23:10.815] <TB1> INFO: run 1 of 1
[14:23:11.096] <TB1> INFO: Expecting 3556800 events.
[14:23:53.946] <TB1> INFO: 977400 events read in total (42294ms).
[14:24:37.148] <TB1> INFO: 1946395 events read in total (85496ms).
[14:25:18.659] <TB1> INFO: 2902960 events read in total (127008ms).
[14:25:47.280] <TB1> INFO: 3556800 events read in total (155628ms).
[14:25:47.315] <TB1> INFO: Test took 156500ms.
[14:26:13.070] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 168 (-1/-1) hits flags = 528 (plus default)
[14:26:13.079] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[14:26:13.079] <TB1> INFO: run 1 of 1
[14:26:13.348] <TB1> INFO: Expecting 3515200 events.
[14:26:56.197] <TB1> INFO: 982520 events read in total (42293ms).
[14:27:38.819] <TB1> INFO: 1955910 events read in total (84916ms).
[14:28:20.972] <TB1> INFO: 2916890 events read in total (127069ms).
[14:28:47.290] <TB1> INFO: 3515200 events read in total (153386ms).
[14:28:47.323] <TB1> INFO: Test took 154244ms.
[14:29:12.667] <TB1> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 168 (-1/-1) hits flags = 528 (plus default)
[14:29:12.676] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[14:29:12.676] <TB1> INFO: run 1 of 1
[14:29:12.963] <TB1> INFO: Expecting 3515200 events.
[14:29:55.993] <TB1> INFO: 982005 events read in total (42474ms).
[14:30:37.971] <TB1> INFO: 1955015 events read in total (84452ms).
[14:31:19.973] <TB1> INFO: 2915640 events read in total (126455ms).
[14:31:46.168] <TB1> INFO: 3515200 events read in total (152649ms).
[14:31:46.200] <TB1> INFO: Test took 153524ms.
[14:32:12.615] <TB1> INFO: PixTestTrim::trimBitTest() done
[14:32:12.616] <TB1> INFO: PixTestTrim::doTest() done, duration: 3043 seconds
[14:32:12.616] <TB1> INFO: Decoding statistics:
[14:32:12.616] <TB1> INFO: General information:
[14:32:12.616] <TB1> INFO: 16bit words read: 0
[14:32:12.616] <TB1> INFO: valid events total: 0
[14:32:12.616] <TB1> INFO: empty events: 0
[14:32:12.616] <TB1> INFO: valid events with pixels: 0
[14:32:12.616] <TB1> INFO: valid pixel hits: 0
[14:32:12.616] <TB1> INFO: Event errors: 0
[14:32:12.616] <TB1> INFO: start marker: 0
[14:32:12.616] <TB1> INFO: stop marker: 0
[14:32:12.616] <TB1> INFO: overflow: 0
[14:32:12.616] <TB1> INFO: invalid 5bit words: 0
[14:32:12.616] <TB1> INFO: invalid XOR eye diagram: 0
[14:32:12.616] <TB1> INFO: frame (failed synchr.): 0
[14:32:12.616] <TB1> INFO: idle data (no TBM trl): 0
[14:32:12.616] <TB1> INFO: no data (only TBM hdr): 0
[14:32:12.616] <TB1> INFO: TBM errors: 0
[14:32:12.616] <TB1> INFO: flawed TBM headers: 0
[14:32:12.616] <TB1> INFO: flawed TBM trailers: 0
[14:32:12.616] <TB1> INFO: event ID mismatches: 0
[14:32:12.616] <TB1> INFO: ROC errors: 0
[14:32:12.616] <TB1> INFO: missing ROC header(s): 0
[14:32:12.616] <TB1> INFO: misplaced readback start: 0
[14:32:12.616] <TB1> INFO: Pixel decoding errors: 0
[14:32:12.616] <TB1> INFO: pixel data incomplete: 0
[14:32:12.616] <TB1> INFO: pixel address: 0
[14:32:12.616] <TB1> INFO: pulse height fill bit: 0
[14:32:12.616] <TB1> INFO: buffer corruption: 0
[14:32:13.360] <TB1> INFO: ######################################################################
[14:32:13.360] <TB1> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[14:32:13.360] <TB1> INFO: ######################################################################
[14:32:13.623] <TB1> INFO: Expecting 41600 events.
[14:32:17.360] <TB1> INFO: 41600 events read in total (3181ms).
[14:32:17.361] <TB1> INFO: Test took 4000ms.
[14:32:17.826] <TB1> INFO: Expecting 41600 events.
[14:32:21.645] <TB1> INFO: 41600 events read in total (3263ms).
[14:32:21.646] <TB1> INFO: Test took 4087ms.
[14:32:21.925] <TB1> INFO: Expecting 41600 events.
[14:32:25.735] <TB1> INFO: 41600 events read in total (3254ms).
[14:32:25.735] <TB1> INFO: Test took 4068ms.
[14:32:25.991] <TB1> INFO: Expecting 2560 events.
[14:32:26.845] <TB1> INFO: 2560 events read in total (298ms).
[14:32:26.845] <TB1> INFO: Test took 1096ms.
[14:32:27.150] <TB1> INFO: Expecting 2560 events.
[14:32:28.004] <TB1> INFO: 2560 events read in total (298ms).
[14:32:28.004] <TB1> INFO: Test took 1159ms.
[14:32:28.309] <TB1> INFO: Expecting 2560 events.
[14:32:29.162] <TB1> INFO: 2560 events read in total (297ms).
[14:32:29.162] <TB1> INFO: Test took 1157ms.
[14:32:29.467] <TB1> INFO: Expecting 2560 events.
[14:32:30.324] <TB1> INFO: 2560 events read in total (301ms).
[14:32:30.324] <TB1> INFO: Test took 1161ms.
[14:32:30.629] <TB1> INFO: Expecting 2560 events.
[14:32:31.483] <TB1> INFO: 2560 events read in total (298ms).
[14:32:31.483] <TB1> INFO: Test took 1159ms.
[14:32:31.788] <TB1> INFO: Expecting 2560 events.
[14:32:32.642] <TB1> INFO: 2560 events read in total (297ms).
[14:32:32.642] <TB1> INFO: Test took 1158ms.
[14:32:32.947] <TB1> INFO: Expecting 2560 events.
[14:32:33.799] <TB1> INFO: 2560 events read in total (296ms).
[14:32:33.800] <TB1> INFO: Test took 1157ms.
[14:32:34.105] <TB1> INFO: Expecting 2560 events.
[14:32:34.958] <TB1> INFO: 2560 events read in total (297ms).
[14:32:34.958] <TB1> INFO: Test took 1158ms.
[14:32:35.264] <TB1> INFO: Expecting 2560 events.
[14:32:36.122] <TB1> INFO: 2560 events read in total (302ms).
[14:32:36.122] <TB1> INFO: Test took 1163ms.
[14:32:36.427] <TB1> INFO: Expecting 2560 events.
[14:32:37.281] <TB1> INFO: 2560 events read in total (297ms).
[14:32:37.281] <TB1> INFO: Test took 1159ms.
[14:32:37.586] <TB1> INFO: Expecting 2560 events.
[14:32:38.440] <TB1> INFO: 2560 events read in total (297ms).
[14:32:38.441] <TB1> INFO: Test took 1159ms.
[14:32:38.745] <TB1> INFO: Expecting 2560 events.
[14:32:39.597] <TB1> INFO: 2560 events read in total (296ms).
[14:32:39.598] <TB1> INFO: Test took 1157ms.
[14:32:39.903] <TB1> INFO: Expecting 2560 events.
[14:32:40.756] <TB1> INFO: 2560 events read in total (297ms).
[14:32:40.756] <TB1> INFO: Test took 1158ms.
[14:32:41.062] <TB1> INFO: Expecting 2560 events.
[14:32:41.914] <TB1> INFO: 2560 events read in total (296ms).
[14:32:41.915] <TB1> INFO: Test took 1157ms.
[14:32:42.220] <TB1> INFO: Expecting 2560 events.
[14:32:43.077] <TB1> INFO: 2560 events read in total (300ms).
[14:32:43.077] <TB1> INFO: Test took 1162ms.
[14:32:43.382] <TB1> INFO: Expecting 2560 events.
[14:32:44.237] <TB1> INFO: 2560 events read in total (299ms).
[14:32:44.238] <TB1> INFO: Test took 1161ms.
[14:32:44.247] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:32:44.544] <TB1> INFO: Expecting 655360 events.
[14:33:01.520] <TB1> INFO: 655360 events read in total (16419ms).
[14:33:01.529] <TB1> INFO: Expecting 655360 events.
[14:33:18.185] <TB1> INFO: 655360 events read in total (16254ms).
[14:33:18.198] <TB1> INFO: Expecting 655360 events.
[14:33:34.809] <TB1> INFO: 655360 events read in total (16209ms).
[14:33:34.826] <TB1> INFO: Expecting 655360 events.
[14:33:51.567] <TB1> INFO: 655360 events read in total (16339ms).
[14:33:51.588] <TB1> INFO: Expecting 655360 events.
[14:34:08.316] <TB1> INFO: 655360 events read in total (16326ms).
[14:34:08.341] <TB1> INFO: Expecting 655360 events.
[14:34:25.038] <TB1> INFO: 655360 events read in total (16296ms).
[14:34:25.066] <TB1> INFO: Expecting 655360 events.
[14:34:41.841] <TB1> INFO: 655360 events read in total (16373ms).
[14:34:41.877] <TB1> INFO: Expecting 655360 events.
[14:34:58.710] <TB1> INFO: 655360 events read in total (16431ms).
[14:34:58.749] <TB1> INFO: Expecting 655360 events.
[14:35:15.478] <TB1> INFO: 655360 events read in total (16327ms).
[14:35:15.519] <TB1> INFO: Expecting 655360 events.
[14:35:32.244] <TB1> INFO: 655360 events read in total (16324ms).
[14:35:32.287] <TB1> INFO: Expecting 655360 events.
[14:35:49.135] <TB1> INFO: 655360 events read in total (16447ms).
[14:35:49.183] <TB1> INFO: Expecting 655360 events.
[14:36:05.884] <TB1> INFO: 655360 events read in total (16299ms).
[14:36:05.939] <TB1> INFO: Expecting 655360 events.
[14:36:22.787] <TB1> INFO: 655360 events read in total (16447ms).
[14:36:22.842] <TB1> INFO: Expecting 655360 events.
[14:36:39.649] <TB1> INFO: 655360 events read in total (16405ms).
[14:36:39.709] <TB1> INFO: Expecting 655360 events.
[14:36:56.305] <TB1> INFO: 655360 events read in total (16194ms).
[14:36:56.365] <TB1> INFO: Expecting 655360 events.
[14:37:12.845] <TB1> INFO: 655360 events read in total (16079ms).
[14:37:12.916] <TB1> INFO: Test took 268669ms.
[14:37:12.998] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:37:13.229] <TB1> INFO: Expecting 655360 events.
[14:37:29.798] <TB1> INFO: 655360 events read in total (16013ms).
[14:37:29.807] <TB1> INFO: Expecting 655360 events.
[14:37:46.555] <TB1> INFO: 655360 events read in total (16346ms).
[14:37:46.568] <TB1> INFO: Expecting 655360 events.
[14:38:03.223] <TB1> INFO: 655360 events read in total (16253ms).
[14:38:03.239] <TB1> INFO: Expecting 655360 events.
[14:38:19.950] <TB1> INFO: 655360 events read in total (16310ms).
[14:38:19.971] <TB1> INFO: Expecting 655360 events.
[14:38:36.856] <TB1> INFO: 655360 events read in total (16483ms).
[14:38:36.880] <TB1> INFO: Expecting 655360 events.
[14:38:53.504] <TB1> INFO: 655360 events read in total (16222ms).
[14:38:53.533] <TB1> INFO: Expecting 655360 events.
[14:39:10.173] <TB1> INFO: 655360 events read in total (16238ms).
[14:39:10.204] <TB1> INFO: Expecting 655360 events.
[14:39:26.930] <TB1> INFO: 655360 events read in total (16324ms).
[14:39:26.963] <TB1> INFO: Expecting 655360 events.
[14:39:43.682] <TB1> INFO: 655360 events read in total (16317ms).
[14:39:43.723] <TB1> INFO: Expecting 655360 events.
[14:40:00.501] <TB1> INFO: 655360 events read in total (16376ms).
[14:40:00.542] <TB1> INFO: Expecting 655360 events.
[14:40:17.237] <TB1> INFO: 655360 events read in total (16293ms).
[14:40:17.282] <TB1> INFO: Expecting 655360 events.
[14:40:33.936] <TB1> INFO: 655360 events read in total (16253ms).
[14:40:33.991] <TB1> INFO: Expecting 655360 events.
[14:40:50.652] <TB1> INFO: 655360 events read in total (16260ms).
[14:40:50.714] <TB1> INFO: Expecting 655360 events.
[14:41:07.438] <TB1> INFO: 655360 events read in total (16322ms).
[14:41:07.497] <TB1> INFO: Expecting 655360 events.
[14:41:24.286] <TB1> INFO: 655360 events read in total (16388ms).
[14:41:24.354] <TB1> INFO: Expecting 655360 events.
[14:41:41.154] <TB1> INFO: 655360 events read in total (16398ms).
[14:41:41.217] <TB1> INFO: Test took 268220ms.
[14:41:41.432] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.440] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.447] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.454] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.460] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.467] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.476] <TB1> INFO: safety margin for low PH: adding 1, margin is now 21
[14:41:41.485] <TB1> INFO: safety margin for low PH: adding 2, margin is now 22
[14:41:41.492] <TB1> INFO: safety margin for low PH: adding 3, margin is now 23
[14:41:41.499] <TB1> INFO: safety margin for low PH: adding 4, margin is now 24
[14:41:41.506] <TB1> INFO: safety margin for low PH: adding 5, margin is now 25
[14:41:41.514] <TB1> INFO: safety margin for low PH: adding 6, margin is now 26
[14:41:41.521] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.528] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.535] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.541] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.550] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.558] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.565] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.572] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.579] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.585] <TB1> INFO: safety margin for low PH: adding 0, margin is now 20
[14:41:41.622] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C0.dat
[14:41:41.623] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C1.dat
[14:41:41.623] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C2.dat
[14:41:41.623] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C3.dat
[14:41:41.623] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C4.dat
[14:41:41.624] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C5.dat
[14:41:41.624] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C6.dat
[14:41:41.624] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C7.dat
[14:41:41.624] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C8.dat
[14:41:41.624] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C9.dat
[14:41:41.624] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C10.dat
[14:41:41.625] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C11.dat
[14:41:41.625] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C12.dat
[14:41:41.625] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C13.dat
[14:41:41.625] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C14.dat
[14:41:41.625] <TB1> INFO: write dac parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//dacParameters35_C15.dat
[14:41:41.903] <TB1> INFO: Expecting 41600 events.
[14:41:45.393] <TB1> INFO: 41600 events read in total (2933ms).
[14:41:45.394] <TB1> INFO: Test took 3766ms.
[14:41:45.845] <TB1> INFO: Expecting 41600 events.
[14:41:49.341] <TB1> INFO: 41600 events read in total (2939ms).
[14:41:49.342] <TB1> INFO: Test took 3771ms.
[14:41:49.797] <TB1> INFO: Expecting 41600 events.
[14:41:53.296] <TB1> INFO: 41600 events read in total (2942ms).
[14:41:53.297] <TB1> INFO: Test took 3774ms.
[14:41:53.476] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:41:53.564] <TB1> INFO: Expecting 2560 events.
[14:41:54.418] <TB1> INFO: 2560 events read in total (297ms).
[14:41:54.419] <TB1> INFO: Test took 943ms.
[14:41:54.420] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:41:54.725] <TB1> INFO: Expecting 2560 events.
[14:41:55.585] <TB1> INFO: 2560 events read in total (304ms).
[14:41:55.585] <TB1> INFO: Test took 1165ms.
[14:41:55.587] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:41:55.891] <TB1> INFO: Expecting 2560 events.
[14:41:56.746] <TB1> INFO: 2560 events read in total (299ms).
[14:41:56.748] <TB1> INFO: Test took 1161ms.
[14:41:56.750] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:41:57.052] <TB1> INFO: Expecting 2560 events.
[14:41:57.906] <TB1> INFO: 2560 events read in total (297ms).
[14:41:57.907] <TB1> INFO: Test took 1157ms.
[14:41:57.909] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:41:58.212] <TB1> INFO: Expecting 2560 events.
[14:41:59.066] <TB1> INFO: 2560 events read in total (298ms).
[14:41:59.066] <TB1> INFO: Test took 1157ms.
[14:41:59.068] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:41:59.373] <TB1> INFO: Expecting 2560 events.
[14:42:00.227] <TB1> INFO: 2560 events read in total (298ms).
[14:42:00.227] <TB1> INFO: Test took 1159ms.
[14:42:00.229] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:00.533] <TB1> INFO: Expecting 2560 events.
[14:42:01.387] <TB1> INFO: 2560 events read in total (298ms).
[14:42:01.387] <TB1> INFO: Test took 1158ms.
[14:42:01.390] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:01.693] <TB1> INFO: Expecting 2560 events.
[14:42:02.547] <TB1> INFO: 2560 events read in total (298ms).
[14:42:02.548] <TB1> INFO: Test took 1158ms.
[14:42:02.551] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:02.852] <TB1> INFO: Expecting 2560 events.
[14:42:03.705] <TB1> INFO: 2560 events read in total (296ms).
[14:42:03.705] <TB1> INFO: Test took 1154ms.
[14:42:03.707] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:04.011] <TB1> INFO: Expecting 2560 events.
[14:42:04.872] <TB1> INFO: 2560 events read in total (305ms).
[14:42:04.872] <TB1> INFO: Test took 1165ms.
[14:42:04.875] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:05.177] <TB1> INFO: Expecting 2560 events.
[14:42:06.031] <TB1> INFO: 2560 events read in total (297ms).
[14:42:06.032] <TB1> INFO: Test took 1157ms.
[14:42:06.033] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:06.338] <TB1> INFO: Expecting 2560 events.
[14:42:07.195] <TB1> INFO: 2560 events read in total (301ms).
[14:42:07.195] <TB1> INFO: Test took 1162ms.
[14:42:07.197] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:07.501] <TB1> INFO: Expecting 2560 events.
[14:42:08.358] <TB1> INFO: 2560 events read in total (301ms).
[14:42:08.358] <TB1> INFO: Test took 1161ms.
[14:42:08.361] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:08.664] <TB1> INFO: Expecting 2560 events.
[14:42:09.521] <TB1> INFO: 2560 events read in total (300ms).
[14:42:09.522] <TB1> INFO: Test took 1161ms.
[14:42:09.524] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:09.828] <TB1> INFO: Expecting 2560 events.
[14:42:10.686] <TB1> INFO: 2560 events read in total (302ms).
[14:42:10.687] <TB1> INFO: Test took 1163ms.
[14:42:10.689] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:10.992] <TB1> INFO: Expecting 2560 events.
[14:42:11.845] <TB1> INFO: 2560 events read in total (297ms).
[14:42:11.845] <TB1> INFO: Test took 1157ms.
[14:42:11.847] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:12.151] <TB1> INFO: Expecting 2560 events.
[14:42:13.007] <TB1> INFO: 2560 events read in total (300ms).
[14:42:13.008] <TB1> INFO: Test took 1161ms.
[14:42:13.010] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:13.314] <TB1> INFO: Expecting 2560 events.
[14:42:14.169] <TB1> INFO: 2560 events read in total (299ms).
[14:42:14.169] <TB1> INFO: Test took 1159ms.
[14:42:14.172] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:14.475] <TB1> INFO: Expecting 2560 events.
[14:42:15.335] <TB1> INFO: 2560 events read in total (304ms).
[14:42:15.335] <TB1> INFO: Test took 1163ms.
[14:42:15.337] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:15.641] <TB1> INFO: Expecting 2560 events.
[14:42:16.496] <TB1> INFO: 2560 events read in total (299ms).
[14:42:16.496] <TB1> INFO: Test took 1159ms.
[14:42:16.498] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:16.801] <TB1> INFO: Expecting 2560 events.
[14:42:17.656] <TB1> INFO: 2560 events read in total (298ms).
[14:42:17.657] <TB1> INFO: Test took 1159ms.
[14:42:17.659] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:17.963] <TB1> INFO: Expecting 2560 events.
[14:42:18.818] <TB1> INFO: 2560 events read in total (298ms).
[14:42:18.818] <TB1> INFO: Test took 1159ms.
[14:42:18.822] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:19.124] <TB1> INFO: Expecting 2560 events.
[14:42:19.983] <TB1> INFO: 2560 events read in total (302ms).
[14:42:19.983] <TB1> INFO: Test took 1162ms.
[14:42:19.986] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:20.289] <TB1> INFO: Expecting 2560 events.
[14:42:21.141] <TB1> INFO: 2560 events read in total (296ms).
[14:42:21.141] <TB1> INFO: Test took 1155ms.
[14:42:21.143] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:21.447] <TB1> INFO: Expecting 2560 events.
[14:42:22.305] <TB1> INFO: 2560 events read in total (302ms).
[14:42:22.305] <TB1> INFO: Test took 1162ms.
[14:42:22.307] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:22.610] <TB1> INFO: Expecting 2560 events.
[14:42:23.466] <TB1> INFO: 2560 events read in total (300ms).
[14:42:23.466] <TB1> INFO: Test took 1159ms.
[14:42:23.468] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:23.772] <TB1> INFO: Expecting 2560 events.
[14:42:24.626] <TB1> INFO: 2560 events read in total (298ms).
[14:42:24.627] <TB1> INFO: Test took 1159ms.
[14:42:24.628] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:24.932] <TB1> INFO: Expecting 2560 events.
[14:42:25.787] <TB1> INFO: 2560 events read in total (299ms).
[14:42:25.787] <TB1> INFO: Test took 1159ms.
[14:42:25.789] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:26.094] <TB1> INFO: Expecting 2560 events.
[14:42:26.953] <TB1> INFO: 2560 events read in total (303ms).
[14:42:26.953] <TB1> INFO: Test took 1164ms.
[14:42:26.956] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:27.259] <TB1> INFO: Expecting 2560 events.
[14:42:28.116] <TB1> INFO: 2560 events read in total (301ms).
[14:42:28.117] <TB1> INFO: Test took 1161ms.
[14:42:28.122] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:28.423] <TB1> INFO: Expecting 2560 events.
[14:42:29.276] <TB1> INFO: 2560 events read in total (297ms).
[14:42:29.276] <TB1> INFO: Test took 1155ms.
[14:42:29.278] <TB1> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[14:42:29.582] <TB1> INFO: Expecting 2560 events.
[14:42:30.435] <TB1> INFO: 2560 events read in total (297ms).
[14:42:30.435] <TB1> INFO: Test took 1157ms.
[14:42:30.904] <TB1> INFO: PixTestPhOptimization::doTest() done, duration: 617 seconds
[14:42:30.905] <TB1> INFO: PH scale (per ROC): 77 75 83 83 74 86 82 82 73 87 82 74 86 78 87 82
[14:42:30.905] <TB1> INFO: PH offset (per ROC): 171 173 162 159 162 176 144 158 173 156 167 165 161 143 139 165
[14:42:30.910] <TB1> INFO: Decoding statistics:
[14:42:30.910] <TB1> INFO: General information:
[14:42:30.910] <TB1> INFO: 16bit words read: 91924
[14:42:30.910] <TB1> INFO: valid events total: 10240
[14:42:30.910] <TB1> INFO: empty events: 7739
[14:42:30.910] <TB1> INFO: valid events with pixels: 2501
[14:42:30.910] <TB1> INFO: valid pixel hits: 2501
[14:42:30.910] <TB1> INFO: Event errors: 0
[14:42:30.910] <TB1> INFO: start marker: 0
[14:42:30.910] <TB1> INFO: stop marker: 0
[14:42:30.910] <TB1> INFO: overflow: 0
[14:42:30.910] <TB1> INFO: invalid 5bit words: 0
[14:42:30.910] <TB1> INFO: invalid XOR eye diagram: 0
[14:42:30.910] <TB1> INFO: frame (failed synchr.): 0
[14:42:30.910] <TB1> INFO: idle data (no TBM trl): 0
[14:42:30.910] <TB1> INFO: no data (only TBM hdr): 0
[14:42:30.910] <TB1> INFO: TBM errors: 0
[14:42:30.910] <TB1> INFO: flawed TBM headers: 0
[14:42:30.910] <TB1> INFO: flawed TBM trailers: 0
[14:42:30.910] <TB1> INFO: event ID mismatches: 0
[14:42:30.910] <TB1> INFO: ROC errors: 0
[14:42:30.911] <TB1> INFO: missing ROC header(s): 0
[14:42:30.911] <TB1> INFO: misplaced readback start: 0
[14:42:30.911] <TB1> INFO: Pixel decoding errors: 0
[14:42:30.911] <TB1> INFO: pixel data incomplete: 0
[14:42:30.911] <TB1> INFO: pixel address: 0
[14:42:30.911] <TB1> INFO: pulse height fill bit: 0
[14:42:30.911] <TB1> INFO: buffer corruption: 0
[14:42:31.087] <TB1> INFO: ######################################################################
[14:42:31.087] <TB1> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[14:42:31.087] <TB1> INFO: ######################################################################
[14:42:31.097] <TB1> INFO: scanning low vcal = 10
[14:42:31.360] <TB1> INFO: Expecting 41600 events.
[14:42:34.887] <TB1> INFO: 41600 events read in total (2971ms).
[14:42:34.887] <TB1> INFO: Test took 3790ms.
[14:42:34.889] <TB1> INFO: scanning low vcal = 20
[14:42:35.192] <TB1> INFO: Expecting 41600 events.
[14:42:38.736] <TB1> INFO: 41600 events read in total (2988ms).
[14:42:38.736] <TB1> INFO: Test took 3846ms.
[14:42:38.737] <TB1> INFO: scanning low vcal = 30
[14:42:39.041] <TB1> INFO: Expecting 41600 events.
[14:42:42.614] <TB1> INFO: 41600 events read in total (3017ms).
[14:42:42.614] <TB1> INFO: Test took 3877ms.
[14:42:42.616] <TB1> INFO: scanning low vcal = 40
[14:42:42.911] <TB1> INFO: Expecting 41600 events.
[14:42:47.069] <TB1> INFO: 41600 events read in total (3601ms).
[14:42:47.070] <TB1> INFO: Test took 4454ms.
[14:42:47.073] <TB1> INFO: scanning low vcal = 50
[14:42:47.336] <TB1> INFO: Expecting 41600 events.
[14:42:51.551] <TB1> INFO: 41600 events read in total (3659ms).
[14:42:51.551] <TB1> INFO: Test took 4478ms.
[14:42:51.554] <TB1> INFO: scanning low vcal = 60
[14:42:51.825] <TB1> INFO: Expecting 41600 events.
[14:42:56.040] <TB1> INFO: 41600 events read in total (3659ms).
[14:42:56.040] <TB1> INFO: Test took 4486ms.
[14:42:56.043] <TB1> INFO: scanning low vcal = 70
[14:42:56.305] <TB1> INFO: Expecting 41600 events.
[14:43:00.505] <TB1> INFO: 41600 events read in total (3643ms).
[14:43:00.505] <TB1> INFO: Test took 4462ms.
[14:43:00.508] <TB1> INFO: scanning low vcal = 80
[14:43:00.772] <TB1> INFO: Expecting 41600 events.
[14:43:04.989] <TB1> INFO: 41600 events read in total (3661ms).
[14:43:04.990] <TB1> INFO: Test took 4482ms.
[14:43:04.993] <TB1> INFO: scanning low vcal = 90
[14:43:05.285] <TB1> INFO: Expecting 41600 events.
[14:43:09.476] <TB1> INFO: 41600 events read in total (3635ms).
[14:43:09.476] <TB1> INFO: Test took 4483ms.
[14:43:09.480] <TB1> INFO: scanning low vcal = 100
[14:43:09.746] <TB1> INFO: Expecting 41600 events.
[14:43:13.967] <TB1> INFO: 41600 events read in total (3664ms).
[14:43:13.967] <TB1> INFO: Test took 4487ms.
[14:43:13.970] <TB1> INFO: scanning low vcal = 110
[14:43:14.234] <TB1> INFO: Expecting 41600 events.
[14:43:18.439] <TB1> INFO: 41600 events read in total (3649ms).
[14:43:18.439] <TB1> INFO: Test took 4469ms.
[14:43:18.441] <TB1> INFO: scanning low vcal = 120
[14:43:18.701] <TB1> INFO: Expecting 41600 events.
[14:43:22.875] <TB1> INFO: 41600 events read in total (3617ms).
[14:43:22.876] <TB1> INFO: Test took 4434ms.
[14:43:22.878] <TB1> INFO: scanning low vcal = 130
[14:43:23.142] <TB1> INFO: Expecting 41600 events.
[14:43:27.333] <TB1> INFO: 41600 events read in total (3635ms).
[14:43:27.333] <TB1> INFO: Test took 4455ms.
[14:43:27.336] <TB1> INFO: scanning low vcal = 140
[14:43:27.598] <TB1> INFO: Expecting 41600 events.
[14:43:31.801] <TB1> INFO: 41600 events read in total (3647ms).
[14:43:31.802] <TB1> INFO: Test took 4466ms.
[14:43:31.804] <TB1> INFO: scanning low vcal = 150
[14:43:32.064] <TB1> INFO: Expecting 41600 events.
[14:43:36.243] <TB1> INFO: 41600 events read in total (3623ms).
[14:43:36.243] <TB1> INFO: Test took 4439ms.
[14:43:36.246] <TB1> INFO: scanning low vcal = 160
[14:43:36.510] <TB1> INFO: Expecting 41600 events.
[14:43:40.696] <TB1> INFO: 41600 events read in total (3630ms).
[14:43:40.696] <TB1> INFO: Test took 4450ms.
[14:43:40.699] <TB1> INFO: scanning low vcal = 170
[14:43:40.958] <TB1> INFO: Expecting 41600 events.
[14:43:45.125] <TB1> INFO: 41600 events read in total (3611ms).
[14:43:45.125] <TB1> INFO: Test took 4426ms.
[14:43:45.129] <TB1> INFO: scanning low vcal = 180
[14:43:45.399] <TB1> INFO: Expecting 41600 events.
[14:43:49.572] <TB1> INFO: 41600 events read in total (3617ms).
[14:43:49.573] <TB1> INFO: Test took 4444ms.
[14:43:49.576] <TB1> INFO: scanning low vcal = 190
[14:43:49.843] <TB1> INFO: Expecting 41600 events.
[14:43:54.015] <TB1> INFO: 41600 events read in total (3616ms).
[14:43:54.015] <TB1> INFO: Test took 4439ms.
[14:43:54.018] <TB1> INFO: scanning low vcal = 200
[14:43:54.279] <TB1> INFO: Expecting 41600 events.
[14:43:58.446] <TB1> INFO: 41600 events read in total (3610ms).
[14:43:58.446] <TB1> INFO: Test took 4428ms.
[14:43:58.449] <TB1> INFO: scanning low vcal = 210
[14:43:58.745] <TB1> INFO: Expecting 41600 events.
[14:44:02.906] <TB1> INFO: 41600 events read in total (3605ms).
[14:44:02.906] <TB1> INFO: Test took 4457ms.
[14:44:02.909] <TB1> INFO: scanning low vcal = 220
[14:44:03.169] <TB1> INFO: Expecting 41600 events.
[14:44:07.338] <TB1> INFO: 41600 events read in total (3612ms).
[14:44:07.338] <TB1> INFO: Test took 4429ms.
[14:44:07.341] <TB1> INFO: scanning low vcal = 230
[14:44:07.606] <TB1> INFO: Expecting 41600 events.
[14:44:11.829] <TB1> INFO: 41600 events read in total (3667ms).
[14:44:11.829] <TB1> INFO: Test took 4488ms.
[14:44:11.832] <TB1> INFO: scanning low vcal = 240
[14:44:12.090] <TB1> INFO: Expecting 41600 events.
[14:44:16.292] <TB1> INFO: 41600 events read in total (3646ms).
[14:44:16.292] <TB1> INFO: Test took 4460ms.
[14:44:16.295] <TB1> INFO: scanning low vcal = 250
[14:44:16.562] <TB1> INFO: Expecting 41600 events.
[14:44:20.778] <TB1> INFO: 41600 events read in total (3660ms).
[14:44:20.778] <TB1> INFO: Test took 4483ms.
[14:44:20.782] <TB1> INFO: scanning high vcal = 30 (= 210 in low range)
[14:44:21.041] <TB1> INFO: Expecting 41600 events.
[14:44:25.289] <TB1> INFO: 41600 events read in total (3692ms).
[14:44:25.289] <TB1> INFO: Test took 4507ms.
[14:44:25.292] <TB1> INFO: scanning high vcal = 50 (= 350 in low range)
[14:44:25.551] <TB1> INFO: Expecting 41600 events.
[14:44:29.749] <TB1> INFO: 41600 events read in total (3642ms).
[14:44:29.750] <TB1> INFO: Test took 4458ms.
[14:44:29.752] <TB1> INFO: scanning high vcal = 70 (= 490 in low range)
[14:44:30.012] <TB1> INFO: Expecting 41600 events.
[14:44:34.234] <TB1> INFO: 41600 events read in total (3666ms).
[14:44:34.234] <TB1> INFO: Test took 4481ms.
[14:44:34.237] <TB1> INFO: scanning high vcal = 90 (= 630 in low range)
[14:44:34.496] <TB1> INFO: Expecting 41600 events.
[14:44:38.694] <TB1> INFO: 41600 events read in total (3642ms).
[14:44:38.695] <TB1> INFO: Test took 4458ms.
[14:44:38.697] <TB1> INFO: scanning high vcal = 200 (= 1400 in low range)
[14:44:38.960] <TB1> INFO: Expecting 41600 events.
[14:44:43.220] <TB1> INFO: 41600 events read in total (3704ms).
[14:44:43.221] <TB1> INFO: Test took 4523ms.
[14:44:43.796] <TB1> INFO: PixTestGainPedestal::measure() done
[14:45:17.913] <TB1> INFO: PixTestGainPedestal::fit() done
[14:45:17.913] <TB1> INFO: non-linearity mean: 0.956 0.953 0.953 0.947 0.955 0.960 0.960 0.961 0.959 0.961 0.958 0.955 0.958 0.955 0.956 0.957
[14:45:17.913] <TB1> INFO: non-linearity RMS: 0.006 0.005 0.006 0.006 0.006 0.004 0.004 0.005 0.006 0.006 0.006 0.006 0.006 0.006 0.007 0.006
[14:45:17.914] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[14:45:17.933] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[14:45:17.951] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[14:45:17.970] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[14:45:17.989] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[14:45:18.008] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[14:45:18.027] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[14:45:18.046] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[14:45:18.067] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[14:45:18.087] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[14:45:18.108] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[14:45:18.129] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[14:45:18.149] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[14:45:18.170] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[14:45:18.190] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[14:45:18.211] <TB1> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[14:45:18.231] <TB1> INFO: PixTestGainPedestal::fullTest() done, duration: 167 seconds
[14:45:18.231] <TB1> INFO: Decoding statistics:
[14:45:18.231] <TB1> INFO: General information:
[14:45:18.231] <TB1> INFO: 16bit words read: 2662400
[14:45:18.231] <TB1> INFO: valid events total: 166400
[14:45:18.231] <TB1> INFO: empty events: 0
[14:45:18.231] <TB1> INFO: valid events with pixels: 166400
[14:45:18.231] <TB1> INFO: valid pixel hits: 665559
[14:45:18.231] <TB1> INFO: Event errors: 0
[14:45:18.231] <TB1> INFO: start marker: 0
[14:45:18.231] <TB1> INFO: stop marker: 0
[14:45:18.231] <TB1> INFO: overflow: 0
[14:45:18.231] <TB1> INFO: invalid 5bit words: 0
[14:45:18.231] <TB1> INFO: invalid XOR eye diagram: 0
[14:45:18.231] <TB1> INFO: frame (failed synchr.): 0
[14:45:18.231] <TB1> INFO: idle data (no TBM trl): 0
[14:45:18.231] <TB1> INFO: no data (only TBM hdr): 0
[14:45:18.231] <TB1> INFO: TBM errors: 0
[14:45:18.231] <TB1> INFO: flawed TBM headers: 0
[14:45:18.231] <TB1> INFO: flawed TBM trailers: 0
[14:45:18.231] <TB1> INFO: event ID mismatches: 0
[14:45:18.231] <TB1> INFO: ROC errors: 0
[14:45:18.231] <TB1> INFO: missing ROC header(s): 0
[14:45:18.231] <TB1> INFO: misplaced readback start: 0
[14:45:18.231] <TB1> INFO: Pixel decoding errors: 0
[14:45:18.231] <TB1> INFO: pixel data incomplete: 0
[14:45:18.231] <TB1> INFO: pixel address: 0
[14:45:18.231] <TB1> INFO: pulse height fill bit: 0
[14:45:18.231] <TB1> INFO: buffer corruption: 0
[14:45:18.240] <TB1> INFO: readReadbackCal: /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C15.dat
[14:45:18.241] <TB1> INFO: ######################################################################
[14:45:18.241] <TB1> INFO: PixTestReadback::doTest()
[14:45:18.241] <TB1> INFO: ######################################################################
[14:45:18.241] <TB1> INFO: ----------------------------------------------------------------------
[14:45:18.241] <TB1> INFO: PixTestReadback::CalibrateVd()
[14:45:18.241] <TB1> INFO: ----------------------------------------------------------------------
[14:45:27.720] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C0.dat
[14:45:27.721] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C1.dat
[14:45:27.721] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C2.dat
[14:45:27.721] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C3.dat
[14:45:27.722] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C4.dat
[14:45:27.722] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C5.dat
[14:45:27.722] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C6.dat
[14:45:27.722] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C7.dat
[14:45:27.722] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C8.dat
[14:45:27.722] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C9.dat
[14:45:27.723] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C10.dat
[14:45:27.723] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C11.dat
[14:45:27.723] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C12.dat
[14:45:27.723] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C13.dat
[14:45:27.723] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C14.dat
[14:45:27.723] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C15.dat
[14:45:27.753] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[14:45:27.753] <TB1> INFO: ----------------------------------------------------------------------
[14:45:27.753] <TB1> INFO: PixTestReadback::CalibrateVa()
[14:45:27.753] <TB1> INFO: ----------------------------------------------------------------------
[14:45:37.246] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C0.dat
[14:45:37.246] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C1.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C2.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C3.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C4.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C5.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C6.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C7.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C8.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C9.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C10.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C11.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C12.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C13.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C14.dat
[14:45:37.247] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C15.dat
[14:45:37.270] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[14:45:37.270] <TB1> INFO: ----------------------------------------------------------------------
[14:45:37.270] <TB1> INFO: PixTestReadback::readbackVbg()
[14:45:37.270] <TB1> INFO: ----------------------------------------------------------------------
[14:45:44.567] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[14:45:44.567] <TB1> INFO: ----------------------------------------------------------------------
[14:45:44.567] <TB1> INFO: PixTestReadback::getCalibratedVbg()
[14:45:44.567] <TB1> INFO: ----------------------------------------------------------------------
[14:45:44.567] <TB1> INFO: Vbg will be calibrated using Vd calibration
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 159.3calibrated Vbg = 1.17709 :::*/*/*/*/
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 155.3calibrated Vbg = 1.17327 :::*/*/*/*/
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 161calibrated Vbg = 1.1789 :::*/*/*/*/
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 157calibrated Vbg = 1.18496 :::*/*/*/*/
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 149.6calibrated Vbg = 1.19676 :::*/*/*/*/
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 159.7calibrated Vbg = 1.20043 :::*/*/*/*/
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 146.4calibrated Vbg = 1.1987 :::*/*/*/*/
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 150.2calibrated Vbg = 1.19641 :::*/*/*/*/
[14:45:44.567] <TB1> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 159calibrated Vbg = 1.20095 :::*/*/*/*/
[14:45:44.568] <TB1> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 152.4calibrated Vbg = 1.19711 :::*/*/*/*/
[14:45:44.568] <TB1> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 157.8calibrated Vbg = 1.19037 :::*/*/*/*/
[14:45:44.568] <TB1> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 155.8calibrated Vbg = 1.18565 :::*/*/*/*/
[14:45:44.568] <TB1> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 156.1calibrated Vbg = 1.17453 :::*/*/*/*/
[14:45:44.568] <TB1> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 166.4calibrated Vbg = 1.17597 :::*/*/*/*/
[14:45:44.568] <TB1> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 145.8calibrated Vbg = 1.18765 :::*/*/*/*/
[14:45:44.568] <TB1> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 145.5calibrated Vbg = 1.18529 :::*/*/*/*/
[14:45:44.570] <TB1> INFO: ----------------------------------------------------------------------
[14:45:44.570] <TB1> INFO: PixTestReadback::CalibrateIa()
[14:45:44.570] <TB1> INFO: ----------------------------------------------------------------------
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C0.dat
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C1.dat
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C2.dat
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C3.dat
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C4.dat
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C5.dat
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C6.dat
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C7.dat
[14:48:19.837] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C8.dat
[14:48:19.838] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C9.dat
[14:48:19.838] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C10.dat
[14:48:19.838] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C11.dat
[14:48:19.838] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C12.dat
[14:48:19.838] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C13.dat
[14:48:19.838] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C14.dat
[14:48:19.838] <TB1> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2263_FullQualification_2016-06-28_11h18m_1467105510//002_FulltestPxar_m20//readbackCal_C15.dat
[14:48:19.865] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[14:48:19.866] <TB1> INFO: PixTestReadback::doTest() done
[14:48:19.866] <TB1> INFO: Decoding statistics:
[14:48:19.866] <TB1> INFO: General information:
[14:48:19.866] <TB1> INFO: 16bit words read: 1024
[14:48:19.866] <TB1> INFO: valid events total: 128
[14:48:19.866] <TB1> INFO: empty events: 128
[14:48:19.866] <TB1> INFO: valid events with pixels: 0
[14:48:19.866] <TB1> INFO: valid pixel hits: 0
[14:48:19.866] <TB1> INFO: Event errors: 0
[14:48:19.866] <TB1> INFO: start marker: 0
[14:48:19.866] <TB1> INFO: stop marker: 0
[14:48:19.866] <TB1> INFO: overflow: 0
[14:48:19.866] <TB1> INFO: invalid 5bit words: 0
[14:48:19.866] <TB1> INFO: invalid XOR eye diagram: 0
[14:48:19.866] <TB1> INFO: frame (failed synchr.): 0
[14:48:19.866] <TB1> INFO: idle data (no TBM trl): 0
[14:48:19.866] <TB1> INFO: no data (only TBM hdr): 0
[14:48:19.866] <TB1> INFO: TBM errors: 0
[14:48:19.866] <TB1> INFO: flawed TBM headers: 0
[14:48:19.866] <TB1> INFO: flawed TBM trailers: 0
[14:48:19.866] <TB1> INFO: event ID mismatches: 0
[14:48:19.866] <TB1> INFO: ROC errors: 0
[14:48:19.866] <TB1> INFO: missing ROC header(s): 0
[14:48:19.866] <TB1> INFO: misplaced readback start: 0
[14:48:19.866] <TB1> INFO: Pixel decoding errors: 0
[14:48:19.866] <TB1> INFO: pixel data incomplete: 0
[14:48:19.866] <TB1> INFO: pixel address: 0
[14:48:19.866] <TB1> INFO: pulse height fill bit: 0
[14:48:19.866] <TB1> INFO: buffer corruption: 0
[14:48:19.883] <TB1> INFO: Decoding statistics:
[14:48:19.883] <TB1> INFO: General information:
[14:48:19.883] <TB1> INFO: 16bit words read: 2755348
[14:48:19.883] <TB1> INFO: valid events total: 176768
[14:48:19.883] <TB1> INFO: empty events: 7867
[14:48:19.883] <TB1> INFO: valid events with pixels: 168901
[14:48:19.883] <TB1> INFO: valid pixel hits: 668060
[14:48:19.883] <TB1> INFO: Event errors: 0
[14:48:19.883] <TB1> INFO: start marker: 0
[14:48:19.883] <TB1> INFO: stop marker: 0
[14:48:19.883] <TB1> INFO: overflow: 0
[14:48:19.883] <TB1> INFO: invalid 5bit words: 0
[14:48:19.883] <TB1> INFO: invalid XOR eye diagram: 0
[14:48:19.883] <TB1> INFO: frame (failed synchr.): 0
[14:48:19.883] <TB1> INFO: idle data (no TBM trl): 0
[14:48:19.883] <TB1> INFO: no data (only TBM hdr): 0
[14:48:19.883] <TB1> INFO: TBM errors: 0
[14:48:19.883] <TB1> INFO: flawed TBM headers: 0
[14:48:19.883] <TB1> INFO: flawed TBM trailers: 0
[14:48:19.883] <TB1> INFO: event ID mismatches: 0
[14:48:19.883] <TB1> INFO: ROC errors: 0
[14:48:19.883] <TB1> INFO: missing ROC header(s): 0
[14:48:19.883] <TB1> INFO: misplaced readback start: 0
[14:48:19.883] <TB1> INFO: Pixel decoding errors: 0
[14:48:19.883] <TB1> INFO: pixel data incomplete: 0
[14:48:19.883] <TB1> INFO: pixel address: 0
[14:48:19.883] <TB1> INFO: pulse height fill bit: 0
[14:48:19.883] <TB1> INFO: buffer corruption: 0
[14:48:19.883] <TB1> INFO: enter test to run
[14:48:19.883] <TB1> INFO: test: exit no parameter change
[14:48:20.030] <TB1> QUIET: Connection to board 153 closed.
[14:48:20.109] <TB1> INFO: pXar: this is the end, my friend