[09:34:18.149] <TB3> INFO: *** Welcome to pxar ***
[09:34:18.149] <TB3> INFO: *** Today: 2016/02/08
[09:34:18.257] <TB3> INFO: *** Version: 9751-dirty
[09:34:18.257] <TB3> INFO: readRocDacs: /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C0.dat .. /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C15.dat
[09:34:18.259] <TB3> INFO: readTbmDacs: /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//tbmParameters_C0a.dat .. /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//tbmParameters_C0b.dat
[09:34:18.259] <TB3> INFO: readMaskFile: /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//defaultMaskFile.dat
[09:34:18.259] <TB3> INFO: readTrimFile: /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters_C0.dat .. /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters_C15.dat
[09:34:18.346] <TB3> INFO: clk: 4
[09:34:18.346] <TB3> INFO: ctr: 4
[09:34:18.346] <TB3> INFO: sda: 19
[09:34:18.346] <TB3> INFO: tin: 9
[09:34:18.346] <TB3> INFO: level: 15
[09:34:18.346] <TB3> INFO: triggerdelay: 0
[09:34:18.346] <TB3> QUIET: Instanciating API for pxar v2.7.5+16~g4df2ad8
[09:34:18.346] <TB3> INFO: Log level: INFO
[09:34:18.354] <TB3> INFO: Found DTB DTB_WZ4I6J
[09:34:18.362] <TB3> QUIET: Connection to board DTB_WZ4I6J opened.
[09:34:18.364] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 170
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WZ4I6J
MAC address: 40D8551180AA
Hostname: pixelDTB170
Comment:
------------------------------------------------------
[09:34:18.365] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[09:34:19.909] <TB3> INFO: DUT info:
[09:34:19.909] <TB3> INFO: The DUT currently contains the following objects:
[09:34:19.909] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[09:34:19.909] <TB3> INFO: TBM Core alpha (0): 7 registers set
[09:34:19.909] <TB3> INFO: TBM Core beta (1): 7 registers set
[09:34:19.909] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[09:34:19.909] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.909] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:19.910] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[09:34:20.311] <TB3> INFO: enter 'restricted' command line mode
[09:34:20.311] <TB3> INFO: enter test to run
[09:34:20.311] <TB3> INFO: test: pretest no parameter change
[09:34:20.311] <TB3> INFO: running: pretest
[09:34:20.319] <TB3> INFO: ----------------------------------------------------------------------
[09:34:20.319] <TB3> INFO: PixTestPretest::programROC()
[09:34:20.319] <TB3> INFO: ----------------------------------------------------------------------
[09:34:38.333] <TB3> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[09:34:38.333] <TB3> INFO: IA differences per ROC: 19.3 20.1 19.3 17.7 20.1 18.5 16.9 19.3 19.3 20.9 19.3 19.3 18.5 17.7 20.1 20.1
[09:34:38.442] <TB3> INFO: enter test to run
[09:34:38.442] <TB3> INFO: test: pretest no parameter change
[09:34:38.442] <TB3> INFO: running: pretest
[09:34:38.443] <TB3> INFO: ----------------------------------------------------------------------
[09:34:38.443] <TB3> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[09:34:38.443] <TB3> INFO: ----------------------------------------------------------------------
[09:34:59.733] <TB3> INFO: PixTestPretest::setVana() done, Module Ia 381.9 mA = 23.8688 mA/ROC
[09:34:59.733] <TB3> INFO: i(loss) [mA/ROC]: 19.3 19.3 18.5 20.1 19.3 19.3 19.3 18.5 19.3 19.3 18.5 17.7 19.3 19.3 19.3 19.3
[09:34:59.772] <TB3> INFO: enter test to run
[09:34:59.772] <TB3> INFO: test: pretest no parameter change
[09:34:59.772] <TB3> INFO: running: pretest
[09:34:59.772] <TB3> INFO: ----------------------------------------------------------------------
[09:34:59.772] <TB3> INFO: PixTestPretest::findTiming()
[09:34:59.772] <TB3> INFO: ----------------------------------------------------------------------
[09:34:59.772] <TB3> INFO: PixTestCmd::init()

[09:36:28.435] <TB3> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[09:36:28.435] <TB3> INFO: (success/tries = 100/100), width = 3
[09:36:28.435] <TB3> INFO: enter test to run
[09:36:28.435] <TB3> INFO: test: pretest no parameter change
[09:36:28.435] <TB3> INFO: running: pretest
[09:36:28.437] <TB3> INFO: ----------------------------------------------------------------------
[09:36:28.437] <TB3> INFO: PixTestPretest::findWorkingPixel()
[09:36:28.438] <TB3> INFO: ----------------------------------------------------------------------
[09:36:28.528] <TB3> INFO: Expecting 231680 events.


[09:36:38.614] <TB3> INFO: 231680 events read in total (9530ms).
[09:36:38.617] <TB3> INFO: Test took 10177ms.
[09:36:38.856] <TB3> INFO: Found working pixel in all ROCs: col/row = 12/22
[09:36:38.928] <TB3> INFO: enter test to run
[09:36:38.928] <TB3> INFO: test: pretest no parameter change
[09:36:38.928] <TB3> INFO: running: pretest
[09:36:38.929] <TB3> INFO: ----------------------------------------------------------------------
[09:36:38.929] <TB3> INFO: PixTestPretest::setVthrCompCalDel()
[09:36:38.929] <TB3> INFO: ----------------------------------------------------------------------
[09:36:39.021] <TB3> INFO: Expecting 231680 events.
[09:36:49.106] <TB3> INFO: 231680 events read in total (9528ms).
[09:36:49.109] <TB3> INFO: Test took 10176ms.
[09:36:49.348] <TB3> INFO: PixTestPretest::setVthrCompCalDel() done
[09:36:49.348] <TB3> INFO: CalDel: 161 143 148 125 153 141 145 133 141 158 147 144 159 143 135 145
[09:36:49.348] <TB3> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[09:36:49.381] <TB3> INFO: enter test to run
[09:36:49.381] <TB3> INFO: test: pretest no parameter change
[09:36:49.381] <TB3> INFO: running: pretest
[09:36:49.381] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C0.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C1.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C2.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C3.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C4.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C5.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C6.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C7.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C8.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C9.dat
[09:36:49.382] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C10.dat
[09:36:49.383] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C11.dat
[09:36:49.383] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C12.dat
[09:36:49.383] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C13.dat
[09:36:49.383] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C14.dat
[09:36:49.383] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters_C15.dat
[09:36:49.383] <TB3> INFO: enter test to run
[09:36:49.383] <TB3> INFO: test: fulltest no parameter change
[09:36:49.383] <TB3> INFO: running: fulltest
[09:36:49.383] <TB3> INFO: ######################################################################
[09:36:49.383] <TB3> INFO: PixTestFullTest::doTest()
[09:36:49.383] <TB3> INFO: ######################################################################
[09:36:49.384] <TB3> INFO: ######################################################################
[09:36:49.384] <TB3> INFO: PixTestAlive::doTest()
[09:36:49.384] <TB3> INFO: ######################################################################
[09:36:49.385] <TB3> INFO: ----------------------------------------------------------------------
[09:36:49.385] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:36:49.385] <TB3> INFO: ----------------------------------------------------------------------
[09:36:49.657] <TB3> INFO: Expecting 41600 events.
[09:36:53.410] <TB3> INFO: 41600 events read in total (3197ms).
[09:36:53.411] <TB3> INFO: Test took 4024ms.
[09:36:53.640] <TB3> INFO: PixTestAlive::aliveTest() done
[09:36:53.640] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:36:53.642] <TB3> INFO: ----------------------------------------------------------------------
[09:36:53.642] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:36:53.642] <TB3> INFO: ----------------------------------------------------------------------
[09:36:53.934] <TB3> INFO: Expecting 41600 events.
[09:36:56.925] <TB3> INFO: 41600 events read in total (2435ms).
[09:36:56.925] <TB3> INFO: Test took 3282ms.
[09:36:56.925] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[09:36:57.165] <TB3> INFO: PixTestAlive::maskTest() done
[09:36:57.165] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:36:57.166] <TB3> INFO: ----------------------------------------------------------------------
[09:36:57.166] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[09:36:57.166] <TB3> INFO: ----------------------------------------------------------------------
[09:36:57.434] <TB3> INFO: Expecting 41600 events.
[09:37:01.151] <TB3> INFO: 41600 events read in total (3161ms).
[09:37:01.152] <TB3> INFO: Test took 3984ms.
[09:37:01.380] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[09:37:01.380] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[09:37:01.380] <TB3> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[09:37:01.380] <TB3> INFO: Decoding statistics:
[09:37:01.380] <TB3> INFO: General information:
[09:37:01.380] <TB3> INFO: 16bit words read: 0
[09:37:01.380] <TB3> INFO: valid events total: 0
[09:37:01.380] <TB3> INFO: empty events: 0
[09:37:01.380] <TB3> INFO: valid events with pixels: 0
[09:37:01.380] <TB3> INFO: valid pixel hits: 0
[09:37:01.380] <TB3> INFO: Event errors: 0
[09:37:01.380] <TB3> INFO: start marker: 0
[09:37:01.380] <TB3> INFO: stop marker: 0
[09:37:01.380] <TB3> INFO: overflow: 0
[09:37:01.380] <TB3> INFO: invalid 5bit words: 0
[09:37:01.380] <TB3> INFO: invalid XOR eye diagram: 0
[09:37:01.380] <TB3> INFO: frame (failed synchr.): 0
[09:37:01.380] <TB3> INFO: idle data (no TBM trl): 0
[09:37:01.380] <TB3> INFO: no data (only TBM hdr): 0
[09:37:01.380] <TB3> INFO: TBM errors: 0
[09:37:01.380] <TB3> INFO: flawed TBM headers: 0
[09:37:01.380] <TB3> INFO: flawed TBM trailers: 0
[09:37:01.380] <TB3> INFO: event ID mismatches: 0
[09:37:01.380] <TB3> INFO: ROC errors: 0
[09:37:01.380] <TB3> INFO: missing ROC header(s): 0
[09:37:01.380] <TB3> INFO: misplaced readback start: 0
[09:37:01.380] <TB3> INFO: Pixel decoding errors: 0
[09:37:01.380] <TB3> INFO: pixel data incomplete: 0
[09:37:01.380] <TB3> INFO: pixel address: 0
[09:37:01.380] <TB3> INFO: pulse height fill bit: 0
[09:37:01.380] <TB3> INFO: buffer corruption: 0
[09:37:01.388] <TB3> INFO: ######################################################################
[09:37:01.388] <TB3> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[09:37:01.388] <TB3> INFO: ######################################################################
[09:37:01.390] <TB3> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[09:37:01.402] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[09:37:01.402] <TB3> INFO: run 1 of 1
[09:37:01.666] <TB3> INFO: Expecting 3120000 events.
[09:37:42.951] <TB3> INFO: 891025 events read in total (40728ms).
[09:38:24.364] <TB3> INFO: 1778030 events read in total (82141ms).
[09:39:05.782] <TB3> INFO: 2678590 events read in total (123560ms).
[09:39:26.933] <TB3> INFO: 3120000 events read in total (144710ms).
[09:39:26.978] <TB3> INFO: Test took 145576ms.
[09:39:51.019] <TB3> INFO: PixTestBBMap::doTest() done, duration: 169 seconds
[09:39:51.019] <TB3> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0 1
[09:39:51.019] <TB3> INFO: separation cut (per ROC): 83 90 107 92 89 102 96 99 97 107 97 93 90 94 103 99
[09:39:51.019] <TB3> INFO: Decoding statistics:
[09:39:51.019] <TB3> INFO: General information:
[09:39:51.019] <TB3> INFO: 16bit words read: 0
[09:39:51.019] <TB3> INFO: valid events total: 0
[09:39:51.019] <TB3> INFO: empty events: 0
[09:39:51.019] <TB3> INFO: valid events with pixels: 0
[09:39:51.019] <TB3> INFO: valid pixel hits: 0
[09:39:51.019] <TB3> INFO: Event errors: 0
[09:39:51.019] <TB3> INFO: start marker: 0
[09:39:51.019] <TB3> INFO: stop marker: 0
[09:39:51.019] <TB3> INFO: overflow: 0
[09:39:51.019] <TB3> INFO: invalid 5bit words: 0
[09:39:51.019] <TB3> INFO: invalid XOR eye diagram: 0
[09:39:51.019] <TB3> INFO: frame (failed synchr.): 0
[09:39:51.019] <TB3> INFO: idle data (no TBM trl): 0
[09:39:51.019] <TB3> INFO: no data (only TBM hdr): 0
[09:39:51.019] <TB3> INFO: TBM errors: 0
[09:39:51.019] <TB3> INFO: flawed TBM headers: 0
[09:39:51.019] <TB3> INFO: flawed TBM trailers: 0
[09:39:51.019] <TB3> INFO: event ID mismatches: 0
[09:39:51.019] <TB3> INFO: ROC errors: 0
[09:39:51.019] <TB3> INFO: missing ROC header(s): 0
[09:39:51.019] <TB3> INFO: misplaced readback start: 0
[09:39:51.019] <TB3> INFO: Pixel decoding errors: 0
[09:39:51.019] <TB3> INFO: pixel data incomplete: 0
[09:39:51.019] <TB3> INFO: pixel address: 0
[09:39:51.019] <TB3> INFO: pulse height fill bit: 0
[09:39:51.019] <TB3> INFO: buffer corruption: 0
[09:39:51.096] <TB3> INFO: ######################################################################
[09:39:51.096] <TB3> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[09:39:51.096] <TB3> INFO: ######################################################################
[09:39:51.096] <TB3> INFO: ----------------------------------------------------------------------
[09:39:51.096] <TB3> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[09:39:51.096] <TB3> INFO: ----------------------------------------------------------------------
[09:39:51.096] <TB3> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[09:39:51.105] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[09:39:51.105] <TB3> INFO: run 1 of 1
[09:39:51.368] <TB3> INFO: Expecting 26208000 events.
[09:40:24.818] <TB3> INFO: 905600 events read in total (32894ms).
[09:40:57.960] <TB3> INFO: 1796550 events read in total (66036ms).
[09:41:31.097] <TB3> INFO: 2687950 events read in total (99173ms).
[09:42:04.297] <TB3> INFO: 3577450 events read in total (132373ms).
[09:42:37.552] <TB3> INFO: 4465800 events read in total (165628ms).
[09:43:10.928] <TB3> INFO: 5353150 events read in total (199004ms).
[09:43:44.035] <TB3> INFO: 6244800 events read in total (232111ms).
[09:44:16.972] <TB3> INFO: 7133600 events read in total (265048ms).
[09:44:49.940] <TB3> INFO: 8021100 events read in total (298016ms).
[09:45:23.161] <TB3> INFO: 8908600 events read in total (331237ms).
[09:45:56.151] <TB3> INFO: 9796550 events read in total (364227ms).
[09:46:28.962] <TB3> INFO: 10684650 events read in total (397038ms).
[09:47:02.185] <TB3> INFO: 11569750 events read in total (430261ms).
[09:47:35.648] <TB3> INFO: 12455750 events read in total (463724ms).
[09:48:08.398] <TB3> INFO: 13338750 events read in total (496474ms).
[09:48:41.458] <TB3> INFO: 14216650 events read in total (529534ms).
[09:49:14.729] <TB3> INFO: 15090950 events read in total (562805ms).
[09:49:47.805] <TB3> INFO: 15964000 events read in total (595881ms).
[09:50:20.974] <TB3> INFO: 16838650 events read in total (629050ms).
[09:50:54.749] <TB3> INFO: 17713200 events read in total (662825ms).
[09:51:28.590] <TB3> INFO: 18586750 events read in total (696666ms).
[09:52:01.616] <TB3> INFO: 19458800 events read in total (729692ms).
[09:52:34.288] <TB3> INFO: 20333900 events read in total (762364ms).
[09:53:07.048] <TB3> INFO: 21206200 events read in total (795124ms).
[09:53:40.327] <TB3> INFO: 22079650 events read in total (828403ms).
[09:54:12.979] <TB3> INFO: 22954550 events read in total (861055ms).
[09:54:45.985] <TB3> INFO: 23830200 events read in total (894062ms).
[09:55:18.942] <TB3> INFO: 24705650 events read in total (927018ms).
[09:55:54.404] <TB3> INFO: 25581300 events read in total (962480ms).
[09:56:17.809] <TB3> INFO: 26208000 events read in total (985885ms).
[09:56:17.843] <TB3> INFO: Test took 986738ms.
[09:56:18.132] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:19.733] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:21.222] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:22.655] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:24.350] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:26.014] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:27.574] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:29.208] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:30.733] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:32.324] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:33.883] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:35.428] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:36.969] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:38.535] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:39.974] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:41.422] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[09:56:42.901] <TB3> INFO: PixTestScurves::scurves() done
[09:56:42.901] <TB3> INFO: Vcal mean: 79.53 84.45 101.65 84.92 82.23 89.42 92.90 101.27 88.66 104.17 87.10 81.43 81.81 89.44 93.70 91.62
[09:56:42.901] <TB3> INFO: Vcal RMS: 4.63 4.57 5.84 4.73 4.68 5.79 5.88 6.02 5.64 6.30 5.65 5.06 4.59 5.60 5.39 5.49
[09:56:42.902] <TB3> INFO: PixTestScurves::fullTest() done, duration: 1011 seconds
[09:56:42.902] <TB3> INFO: Decoding statistics:
[09:56:42.902] <TB3> INFO: General information:
[09:56:42.902] <TB3> INFO: 16bit words read: 0
[09:56:42.902] <TB3> INFO: valid events total: 0
[09:56:42.902] <TB3> INFO: empty events: 0
[09:56:42.902] <TB3> INFO: valid events with pixels: 0
[09:56:42.902] <TB3> INFO: valid pixel hits: 0
[09:56:42.902] <TB3> INFO: Event errors: 0
[09:56:42.902] <TB3> INFO: start marker: 0
[09:56:42.902] <TB3> INFO: stop marker: 0
[09:56:42.902] <TB3> INFO: overflow: 0
[09:56:42.902] <TB3> INFO: invalid 5bit words: 0
[09:56:42.902] <TB3> INFO: invalid XOR eye diagram: 0
[09:56:42.902] <TB3> INFO: frame (failed synchr.): 0
[09:56:42.902] <TB3> INFO: idle data (no TBM trl): 0
[09:56:42.902] <TB3> INFO: no data (only TBM hdr): 0
[09:56:42.902] <TB3> INFO: TBM errors: 0
[09:56:42.902] <TB3> INFO: flawed TBM headers: 0
[09:56:42.902] <TB3> INFO: flawed TBM trailers: 0
[09:56:42.902] <TB3> INFO: event ID mismatches: 0
[09:56:42.902] <TB3> INFO: ROC errors: 0
[09:56:42.902] <TB3> INFO: missing ROC header(s): 0
[09:56:42.902] <TB3> INFO: misplaced readback start: 0
[09:56:42.902] <TB3> INFO: Pixel decoding errors: 0
[09:56:42.902] <TB3> INFO: pixel data incomplete: 0
[09:56:42.902] <TB3> INFO: pixel address: 0
[09:56:42.902] <TB3> INFO: pulse height fill bit: 0
[09:56:42.902] <TB3> INFO: buffer corruption: 0
[09:56:42.975] <TB3> INFO: ######################################################################
[09:56:42.975] <TB3> INFO: PixTestTrim::doTest()
[09:56:42.975] <TB3> INFO: ######################################################################
[09:56:42.976] <TB3> INFO: ----------------------------------------------------------------------
[09:56:42.976] <TB3> INFO: PixTestTrim::trimTest() ntrig = 10, vcal = 35
[09:56:42.976] <TB3> INFO: ----------------------------------------------------------------------
[09:56:43.078] <TB3> INFO: ---> VthrComp thr map (minimal VthrComp)
[09:56:43.079] <TB3> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[09:56:43.088] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[09:56:43.088] <TB3> INFO: run 1 of 1
[09:56:43.369] <TB3> INFO: Expecting 6281600 events.
[09:57:23.690] <TB3> INFO: 1094330 events read in total (39761ms).
[09:58:03.133] <TB3> INFO: 2185300 events read in total (79204ms).
[09:58:42.678] <TB3> INFO: 3270360 events read in total (118749ms).
[09:59:22.331] <TB3> INFO: 4361420 events read in total (158402ms).
[10:00:03.918] <TB3> INFO: 5455190 events read in total (199989ms).
[10:00:33.704] <TB3> INFO: 6281600 events read in total (229775ms).
[10:00:33.742] <TB3> INFO: Test took 230654ms.
[10:00:52.253] <TB3> INFO: ROC 0 VthrComp = 81
[10:00:52.254] <TB3> INFO: ROC 1 VthrComp = 88
[10:00:52.254] <TB3> INFO: ROC 2 VthrComp = 101
[10:00:52.254] <TB3> INFO: ROC 3 VthrComp = 90
[10:00:52.254] <TB3> INFO: ROC 4 VthrComp = 85
[10:00:52.254] <TB3> INFO: ROC 5 VthrComp = 92
[10:00:52.254] <TB3> INFO: ROC 6 VthrComp = 93
[10:00:52.254] <TB3> INFO: ROC 7 VthrComp = 97
[10:00:52.254] <TB3> INFO: ROC 8 VthrComp = 88
[10:00:52.254] <TB3> INFO: ROC 9 VthrComp = 97
[10:00:52.255] <TB3> INFO: ROC 10 VthrComp = 87
[10:00:52.255] <TB3> INFO: ROC 11 VthrComp = 81
[10:00:52.255] <TB3> INFO: ROC 12 VthrComp = 81
[10:00:52.255] <TB3> INFO: ROC 13 VthrComp = 87
[10:00:52.255] <TB3> INFO: ROC 14 VthrComp = 98
[10:00:52.255] <TB3> INFO: ROC 15 VthrComp = 95
[10:00:52.255] <TB3> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[10:00:52.255] <TB3> INFO: ---> dac: vcal name: TrimThr1 ntrig: 10 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[10:00:52.263] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:00:52.263] <TB3> INFO: run 1 of 1
[10:00:52.523] <TB3> INFO: Expecting 6281600 events.
[10:01:27.533] <TB3> INFO: 756150 events read in total (34452ms).
[10:02:02.685] <TB3> INFO: 1510520 events read in total (69604ms).
[10:02:37.449] <TB3> INFO: 2264830 events read in total (104368ms).
[10:03:12.017] <TB3> INFO: 3019690 events read in total (138936ms).
[10:03:46.756] <TB3> INFO: 3769580 events read in total (173675ms).
[10:04:21.551] <TB3> INFO: 4516180 events read in total (208470ms).
[10:04:56.618] <TB3> INFO: 5261130 events read in total (243537ms).
[10:05:32.730] <TB3> INFO: 6005990 events read in total (279649ms).
[10:05:45.707] <TB3> INFO: 6281600 events read in total (292626ms).
[10:05:45.746] <TB3> INFO: Test took 293483ms.
[10:06:09.883] <TB3> INFO: roc 0 with ID = 0 has maximal Vcal 59.2665 for pixel 0/9 mean/min/max = 46.0685/32.7606/59.3764
[10:06:09.884] <TB3> INFO: roc 1 with ID = 1 has maximal Vcal 57.3157 for pixel 49/4 mean/min/max = 45.1233/32.9085/57.338
[10:06:09.884] <TB3> INFO: roc 2 with ID = 2 has maximal Vcal 59.2809 for pixel 9/79 mean/min/max = 45.8719/32.4205/59.3232
[10:06:09.884] <TB3> INFO: roc 3 with ID = 3 has maximal Vcal 56.6483 for pixel 10/3 mean/min/max = 44.7095/32.6844/56.7346
[10:06:09.884] <TB3> INFO: roc 4 with ID = 4 has maximal Vcal 58.445 for pixel 9/69 mean/min/max = 45.222/31.9761/58.4678
[10:06:09.885] <TB3> INFO: roc 5 with ID = 5 has maximal Vcal 59.0226 for pixel 10/76 mean/min/max = 45.5752/31.7583/59.392
[10:06:09.885] <TB3> INFO: roc 6 with ID = 6 has maximal Vcal 59.6205 for pixel 14/70 mean/min/max = 45.7825/31.8153/59.7498
[10:06:09.885] <TB3> INFO: roc 7 with ID = 7 has maximal Vcal 61.4383 for pixel 25/76 mean/min/max = 46.3618/31.2398/61.4838
[10:06:09.885] <TB3> INFO: roc 8 with ID = 8 has maximal Vcal 60.8582 for pixel 0/79 mean/min/max = 46.7157/32.5503/60.8812
[10:06:09.885] <TB3> INFO: roc 9 with ID = 9 has maximal Vcal 65.1545 for pixel 21/3 mean/min/max = 48.1359/31.1146/65.1573
[10:06:09.886] <TB3> INFO: roc 10 with ID = 10 has maximal Vcal 60.4007 for pixel 14/59 mean/min/max = 46.13/31.575/60.685
[10:06:09.886] <TB3> INFO: roc 11 with ID = 11 has maximal Vcal 59.4374 for pixel 0/12 mean/min/max = 45.8068/32.0988/59.5148
[10:06:09.886] <TB3> INFO: roc 12 with ID = 12 has maximal Vcal 58.5973 for pixel 21/12 mean/min/max = 45.6729/32.6598/58.6859
[10:06:09.886] <TB3> INFO: roc 13 with ID = 13 has maximal Vcal 60.6437 for pixel 25/22 mean/min/max = 46.1505/31.6208/60.6803
[10:06:09.887] <TB3> INFO: roc 14 with ID = 14 has maximal Vcal 57.4074 for pixel 19/0 mean/min/max = 44.4531/31.1226/57.7836
[10:06:09.887] <TB3> INFO: roc 15 with ID = 15 has maximal Vcal 58.1855 for pixel 30/79 mean/min/max = 44.9516/31.5333/58.37
[10:06:09.887] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:06:09.975] <TB3> INFO: Expecting 514560 events.
[10:06:22.795] <TB3> INFO: 514560 events read in total (12263ms).
[10:06:22.799] <TB3> INFO: Expecting 514560 events.
[10:06:35.573] <TB3> INFO: 514560 events read in total (12346ms).
[10:06:35.579] <TB3> INFO: Expecting 514560 events.
[10:06:48.182] <TB3> INFO: 514560 events read in total (12181ms).
[10:06:48.191] <TB3> INFO: Expecting 514560 events.
[10:07:01.049] <TB3> INFO: 514560 events read in total (12446ms).
[10:07:01.059] <TB3> INFO: Expecting 514560 events.
[10:07:13.839] <TB3> INFO: 514560 events read in total (12367ms).
[10:07:13.851] <TB3> INFO: Expecting 514560 events.
[10:07:26.755] <TB3> INFO: 514560 events read in total (12487ms).
[10:07:26.768] <TB3> INFO: Expecting 514560 events.
[10:07:39.386] <TB3> INFO: 514560 events read in total (12206ms).
[10:07:39.402] <TB3> INFO: Expecting 514560 events.
[10:07:52.109] <TB3> INFO: 514560 events read in total (12296ms).
[10:07:52.126] <TB3> INFO: Expecting 514560 events.
[10:08:04.777] <TB3> INFO: 514560 events read in total (12242ms).
[10:08:04.795] <TB3> INFO: Expecting 514560 events.
[10:08:17.555] <TB3> INFO: 514560 events read in total (12343ms).
[10:08:17.576] <TB3> INFO: Expecting 514560 events.
[10:08:30.391] <TB3> INFO: 514560 events read in total (12409ms).
[10:08:30.414] <TB3> INFO: Expecting 514560 events.
[10:08:43.070] <TB3> INFO: 514560 events read in total (12251ms).
[10:08:43.095] <TB3> INFO: Expecting 514560 events.
[10:08:55.829] <TB3> INFO: 514560 events read in total (12327ms).
[10:08:55.854] <TB3> INFO: Expecting 514560 events.
[10:09:08.512] <TB3> INFO: 514560 events read in total (12252ms).
[10:09:08.539] <TB3> INFO: Expecting 514560 events.
[10:09:21.240] <TB3> INFO: 514560 events read in total (12299ms).
[10:09:21.270] <TB3> INFO: Expecting 514560 events.
[10:09:33.891] <TB3> INFO: 514560 events read in total (12219ms).
[10:09:33.922] <TB3> INFO: Test took 204035ms.
[10:09:34.802] <TB3> INFO: ---> dac: vcal name: TrimThr2 ntrig: 10 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[10:09:34.810] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:09:34.810] <TB3> INFO: run 1 of 1
[10:09:35.073] <TB3> INFO: Expecting 6281600 events.
[10:10:10.343] <TB3> INFO: 741780 events read in total (34714ms).
[10:10:45.202] <TB3> INFO: 1482040 events read in total (69573ms).
[10:11:19.686] <TB3> INFO: 2222610 events read in total (104057ms).
[10:11:54.289] <TB3> INFO: 2963580 events read in total (138660ms).
[10:12:28.908] <TB3> INFO: 3699380 events read in total (173279ms).
[10:13:03.418] <TB3> INFO: 4431840 events read in total (207789ms).
[10:13:38.139] <TB3> INFO: 5162130 events read in total (242510ms).
[10:14:14.290] <TB3> INFO: 5892040 events read in total (278661ms).
[10:14:32.909] <TB3> INFO: 6281600 events read in total (297280ms).
[10:14:32.955] <TB3> INFO: Test took 298145ms.
[10:14:56.231] <TB3> INFO: ---> TrimStepCorr4 extremal thresholds: 0.176488 .. 51.980689
[10:14:56.307] <TB3> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 10 dacrange: 0 .. 61 (-1/-1) hits flags = 528 (plus default)
[10:14:56.316] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:14:56.316] <TB3> INFO: run 1 of 1
[10:14:56.577] <TB3> INFO: Expecting 2579200 events.
[10:15:34.793] <TB3> INFO: 918360 events read in total (37660ms).
[10:16:11.885] <TB3> INFO: 1832490 events read in total (74753ms).
[10:16:42.224] <TB3> INFO: 2579200 events read in total (105092ms).
[10:16:42.243] <TB3> INFO: Test took 105928ms.
[10:16:56.841] <TB3> INFO: ---> TrimStepCorr2 extremal thresholds: 3.701895 .. 45.400670
[10:16:56.916] <TB3> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 10 dacrange: 3 .. 55 (-1/-1) hits flags = 528 (plus default)
[10:16:56.925] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:16:56.925] <TB3> INFO: run 1 of 1
[10:16:57.200] <TB3> INFO: Expecting 2204800 events.
[10:17:35.457] <TB3> INFO: 948400 events read in total (37700ms).
[10:18:13.503] <TB3> INFO: 1894170 events read in total (75746ms).
[10:18:26.105] <TB3> INFO: 2204800 events read in total (88348ms).
[10:18:26.123] <TB3> INFO: Test took 89199ms.
[10:18:39.094] <TB3> INFO: ---> TrimStepCorr1a extremal thresholds: 6.770490 .. 42.267372
[10:18:39.175] <TB3> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 10 dacrange: 6 .. 52 (-1/-1) hits flags = 528 (plus default)
[10:18:39.183] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:18:39.183] <TB3> INFO: run 1 of 1
[10:18:39.471] <TB3> INFO: Expecting 1955200 events.
[10:19:18.041] <TB3> INFO: 959730 events read in total (38014ms).
[10:19:55.900] <TB3> INFO: 1917480 events read in total (75873ms).
[10:19:57.763] <TB3> INFO: 1955200 events read in total (77737ms).
[10:19:57.779] <TB3> INFO: Test took 78596ms.
[10:20:11.369] <TB3> INFO: ---> TrimStepCorr1b extremal thresholds: 6.770490 .. 42.026549
[10:20:11.446] <TB3> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 10 dacrange: 6 .. 52 (-1/-1) hits flags = 528 (plus default)
[10:20:11.457] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:20:11.457] <TB3> INFO: run 1 of 1
[10:20:11.719] <TB3> INFO: Expecting 1955200 events.
[10:20:51.626] <TB3> INFO: 959030 events read in total (39351ms).
[10:21:30.147] <TB3> INFO: 1915560 events read in total (77872ms).
[10:21:32.145] <TB3> INFO: 1955200 events read in total (79871ms).
[10:21:32.167] <TB3> INFO: Test took 80711ms.
[10:21:45.525] <TB3> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[10:21:45.525] <TB3> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 10 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[10:21:45.534] <TB3> INFO: dacScan split into 1 runs with ntrig = 10
[10:21:45.534] <TB3> INFO: run 1 of 1
[10:21:45.794] <TB3> INFO: Expecting 1705600 events.
[10:22:23.347] <TB3> INFO: 877290 events read in total (36997ms).
[10:23:00.527] <TB3> INFO: 1705600 events read in total (74177ms).
[10:23:00.546] <TB3> INFO: Test took 75013ms.
[10:23:14.076] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C0.dat
[10:23:14.077] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C1.dat
[10:23:14.077] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C2.dat
[10:23:14.077] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C3.dat
[10:23:14.077] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C4.dat
[10:23:14.078] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C5.dat
[10:23:14.078] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C6.dat
[10:23:14.078] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C7.dat
[10:23:14.078] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C8.dat
[10:23:14.078] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C9.dat
[10:23:14.079] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C10.dat
[10:23:14.079] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C11.dat
[10:23:14.079] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C12.dat
[10:23:14.079] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C13.dat
[10:23:14.079] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C14.dat
[10:23:14.079] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C15.dat
[10:23:14.080] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C0.dat
[10:23:14.096] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C1.dat
[10:23:14.112] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C2.dat
[10:23:14.127] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C3.dat
[10:23:14.144] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C4.dat
[10:23:14.159] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C5.dat
[10:23:14.175] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C6.dat
[10:23:14.191] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C7.dat
[10:23:14.207] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C8.dat
[10:23:14.223] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C9.dat
[10:23:14.239] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C10.dat
[10:23:14.255] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C11.dat
[10:23:14.271] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C12.dat
[10:23:14.287] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C13.dat
[10:23:14.303] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C14.dat
[10:23:14.318] <TB3> INFO: write trim parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//trimParameters35_C15.dat
[10:23:14.334] <TB3> INFO: PixTestTrim::trimTest() done
[10:23:14.334] <TB3> INFO: vtrim: 88 96 86 93 96 108 80 97 91 102 105 85 88 96 93 88
[10:23:14.334] <TB3> INFO: vthrcomp: 81 88 101 90 85 92 93 97 88 97 87 81 81 87 98 95
[10:23:14.334] <TB3> INFO: vcal mean: 34.99 34.94 34.96 34.96 34.91 34.96 34.68 34.96 35.01 35.00 35.00 34.96 34.96 35.02 34.95 34.97
[10:23:14.334] <TB3> INFO: vcal RMS: 0.88 0.85 0.85 0.85 0.85 0.88 1.79 0.92 0.86 1.09 0.88 0.88 0.83 0.91 0.90 0.88
[10:23:14.334] <TB3> INFO: bits mean: 9.49 9.48 9.21 9.65 9.58 9.59 9.30 9.38 8.36 8.96 9.50 8.93 9.04 9.58 9.99 9.50
[10:23:14.334] <TB3> INFO: bits RMS: 2.57 2.60 2.78 2.59 2.70 2.70 3.13 2.80 3.02 2.85 2.70 2.93 2.82 2.64 2.65 2.81
[10:23:14.341] <TB3> INFO: ----------------------------------------------------------------------
[10:23:14.341] <TB3> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[10:23:14.341] <TB3> INFO: ----------------------------------------------------------------------
[10:23:14.344] <TB3> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[10:23:14.355] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[10:23:14.355] <TB3> INFO: run 1 of 1
[10:23:14.624] <TB3> INFO: Expecting 4160000 events.
[10:23:56.706] <TB3> INFO: 935650 events read in total (41526ms).
[10:24:37.850] <TB3> INFO: 1866685 events read in total (82671ms).
[10:25:19.840] <TB3> INFO: 2789355 events read in total (124660ms).
[10:26:01.434] <TB3> INFO: 3711035 events read in total (166254ms).
[10:26:21.928] <TB3> INFO: 4160000 events read in total (186748ms).
[10:26:21.965] <TB3> INFO: Test took 187609ms.
[10:26:50.798] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 171 (-1/-1) hits flags = 528 (plus default)
[10:26:50.806] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[10:26:50.806] <TB3> INFO: run 1 of 1
[10:26:51.068] <TB3> INFO: Expecting 3577600 events.
[10:27:33.505] <TB3> INFO: 959155 events read in total (41881ms).
[10:28:15.707] <TB3> INFO: 1911710 events read in total (84083ms).
[10:28:58.098] <TB3> INFO: 2854250 events read in total (126474ms).
[10:29:31.067] <TB3> INFO: 3577600 events read in total (159443ms).
[10:29:31.107] <TB3> INFO: Test took 160300ms.
[10:29:57.765] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 156 (-1/-1) hits flags = 528 (plus default)
[10:29:57.774] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[10:29:57.774] <TB3> INFO: run 1 of 1
[10:29:58.040] <TB3> INFO: Expecting 3265600 events.
[10:30:41.386] <TB3> INFO: 1000750 events read in total (42790ms).
[10:31:23.938] <TB3> INFO: 1990520 events read in total (85343ms).
[10:32:06.525] <TB3> INFO: 2972665 events read in total (127930ms).
[10:32:19.406] <TB3> INFO: 3265600 events read in total (140810ms).
[10:32:19.437] <TB3> INFO: Test took 141663ms.
[10:32:43.947] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 155 (-1/-1) hits flags = 528 (plus default)
[10:32:43.956] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[10:32:43.956] <TB3> INFO: run 1 of 1
[10:32:44.216] <TB3> INFO: Expecting 3244800 events.
[10:33:27.452] <TB3> INFO: 1002695 events read in total (42680ms).
[10:34:10.281] <TB3> INFO: 1993530 events read in total (85509ms).
[10:34:53.221] <TB3> INFO: 2977225 events read in total (128449ms).
[10:35:05.140] <TB3> INFO: 3244800 events read in total (140368ms).
[10:35:05.181] <TB3> INFO: Test took 141225ms.
[10:35:29.429] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 156 (-1/-1) hits flags = 528 (plus default)
[10:35:29.438] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[10:35:29.438] <TB3> INFO: run 1 of 1
[10:35:29.724] <TB3> INFO: Expecting 3265600 events.
[10:36:12.836] <TB3> INFO: 999190 events read in total (42555ms).
[10:36:56.509] <TB3> INFO: 1987525 events read in total (86228ms).
[10:37:39.207] <TB3> INFO: 2968630 events read in total (128926ms).
[10:37:52.222] <TB3> INFO: 3265600 events read in total (141941ms).
[10:37:52.252] <TB3> INFO: Test took 142814ms.
[10:38:17.135] <TB3> INFO: PixTestTrim::trimBitTest() done
[10:38:17.136] <TB3> INFO: PixTestTrim::doTest() done, duration: 2494 seconds
[10:38:17.136] <TB3> INFO: Decoding statistics:
[10:38:17.136] <TB3> INFO: General information:
[10:38:17.136] <TB3> INFO: 16bit words read: 0
[10:38:17.136] <TB3> INFO: valid events total: 0
[10:38:17.136] <TB3> INFO: empty events: 0
[10:38:17.136] <TB3> INFO: valid events with pixels: 0
[10:38:17.136] <TB3> INFO: valid pixel hits: 0
[10:38:17.136] <TB3> INFO: Event errors: 0
[10:38:17.136] <TB3> INFO: start marker: 0
[10:38:17.136] <TB3> INFO: stop marker: 0
[10:38:17.136] <TB3> INFO: overflow: 0
[10:38:17.136] <TB3> INFO: invalid 5bit words: 0
[10:38:17.136] <TB3> INFO: invalid XOR eye diagram: 0
[10:38:17.136] <TB3> INFO: frame (failed synchr.): 0
[10:38:17.136] <TB3> INFO: idle data (no TBM trl): 0
[10:38:17.136] <TB3> INFO: no data (only TBM hdr): 0
[10:38:17.136] <TB3> INFO: TBM errors: 0
[10:38:17.136] <TB3> INFO: flawed TBM headers: 0
[10:38:17.136] <TB3> INFO: flawed TBM trailers: 0
[10:38:17.136] <TB3> INFO: event ID mismatches: 0
[10:38:17.136] <TB3> INFO: ROC errors: 0
[10:38:17.136] <TB3> INFO: missing ROC header(s): 0
[10:38:17.136] <TB3> INFO: misplaced readback start: 0
[10:38:17.136] <TB3> INFO: Pixel decoding errors: 0
[10:38:17.136] <TB3> INFO: pixel data incomplete: 0
[10:38:17.136] <TB3> INFO: pixel address: 0
[10:38:17.136] <TB3> INFO: pulse height fill bit: 0
[10:38:17.136] <TB3> INFO: buffer corruption: 0
[10:38:17.803] <TB3> INFO: ######################################################################
[10:38:17.803] <TB3> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[10:38:17.803] <TB3> INFO: ######################################################################
[10:38:18.063] <TB3> INFO: Expecting 41600 events.
[10:38:21.821] <TB3> INFO: 41600 events read in total (3201ms).
[10:38:21.822] <TB3> INFO: Test took 4018ms.
[10:38:22.322] <TB3> INFO: Expecting 41600 events.
[10:38:26.150] <TB3> INFO: 41600 events read in total (3272ms).
[10:38:26.150] <TB3> INFO: Test took 4123ms.
[10:38:26.437] <TB3> INFO: Expecting 41600 events.
[10:38:30.236] <TB3> INFO: 41600 events read in total (3243ms).
[10:38:30.236] <TB3> INFO: Test took 4064ms.
[10:38:30.492] <TB3> INFO: Expecting 2560 events.
[10:38:31.346] <TB3> INFO: 2560 events read in total (298ms).
[10:38:31.346] <TB3> INFO: Test took 1096ms.
[10:38:31.651] <TB3> INFO: Expecting 2560 events.
[10:38:32.506] <TB3> INFO: 2560 events read in total (299ms).
[10:38:32.507] <TB3> INFO: Test took 1160ms.
[10:38:32.812] <TB3> INFO: Expecting 2560 events.
[10:38:33.665] <TB3> INFO: 2560 events read in total (297ms).
[10:38:33.665] <TB3> INFO: Test took 1158ms.
[10:38:33.970] <TB3> INFO: Expecting 2560 events.
[10:38:34.825] <TB3> INFO: 2560 events read in total (299ms).
[10:38:34.825] <TB3> INFO: Test took 1160ms.
[10:38:35.130] <TB3> INFO: Expecting 2560 events.
[10:38:35.983] <TB3> INFO: 2560 events read in total (297ms).
[10:38:35.983] <TB3> INFO: Test took 1158ms.
[10:38:36.288] <TB3> INFO: Expecting 2560 events.
[10:38:37.142] <TB3> INFO: 2560 events read in total (298ms).
[10:38:37.142] <TB3> INFO: Test took 1159ms.
[10:38:37.447] <TB3> INFO: Expecting 2560 events.
[10:38:38.300] <TB3> INFO: 2560 events read in total (297ms).
[10:38:38.300] <TB3> INFO: Test took 1158ms.
[10:38:38.606] <TB3> INFO: Expecting 2560 events.
[10:38:39.459] <TB3> INFO: 2560 events read in total (297ms).
[10:38:39.459] <TB3> INFO: Test took 1159ms.
[10:38:39.764] <TB3> INFO: Expecting 2560 events.
[10:38:40.618] <TB3> INFO: 2560 events read in total (298ms).
[10:38:40.618] <TB3> INFO: Test took 1159ms.
[10:38:40.923] <TB3> INFO: Expecting 2560 events.
[10:38:41.776] <TB3> INFO: 2560 events read in total (297ms).
[10:38:41.776] <TB3> INFO: Test took 1158ms.
[10:38:42.081] <TB3> INFO: Expecting 2560 events.
[10:38:42.934] <TB3> INFO: 2560 events read in total (297ms).
[10:38:42.934] <TB3> INFO: Test took 1158ms.
[10:38:43.239] <TB3> INFO: Expecting 2560 events.
[10:38:44.091] <TB3> INFO: 2560 events read in total (296ms).
[10:38:44.091] <TB3> INFO: Test took 1157ms.
[10:38:44.396] <TB3> INFO: Expecting 2560 events.
[10:38:45.250] <TB3> INFO: 2560 events read in total (297ms).
[10:38:45.250] <TB3> INFO: Test took 1158ms.
[10:38:45.555] <TB3> INFO: Expecting 2560 events.
[10:38:46.406] <TB3> INFO: 2560 events read in total (295ms).
[10:38:46.407] <TB3> INFO: Test took 1157ms.
[10:38:46.712] <TB3> INFO: Expecting 2560 events.
[10:38:47.566] <TB3> INFO: 2560 events read in total (298ms).
[10:38:47.566] <TB3> INFO: Test took 1158ms.
[10:38:47.872] <TB3> INFO: Expecting 2560 events.
[10:38:48.726] <TB3> INFO: 2560 events read in total (298ms).
[10:38:48.726] <TB3> INFO: Test took 1159ms.
[10:38:48.729] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:38:49.032] <TB3> INFO: Expecting 655360 events.
[10:39:05.910] <TB3> INFO: 655360 events read in total (16321ms).
[10:39:05.921] <TB3> INFO: Expecting 655360 events.
[10:39:22.471] <TB3> INFO: 655360 events read in total (16148ms).
[10:39:22.485] <TB3> INFO: Expecting 655360 events.
[10:39:39.194] <TB3> INFO: 655360 events read in total (16308ms).
[10:39:39.210] <TB3> INFO: Expecting 655360 events.
[10:39:55.774] <TB3> INFO: 655360 events read in total (16163ms).
[10:39:55.796] <TB3> INFO: Expecting 655360 events.
[10:40:12.268] <TB3> INFO: 655360 events read in total (16070ms).
[10:40:12.290] <TB3> INFO: Expecting 655360 events.
[10:40:28.904] <TB3> INFO: 655360 events read in total (16212ms).
[10:40:28.930] <TB3> INFO: Expecting 655360 events.
[10:40:45.587] <TB3> INFO: 655360 events read in total (16255ms).
[10:40:45.617] <TB3> INFO: Expecting 655360 events.
[10:41:02.111] <TB3> INFO: 655360 events read in total (16092ms).
[10:41:02.144] <TB3> INFO: Expecting 655360 events.
[10:41:18.686] <TB3> INFO: 655360 events read in total (16140ms).
[10:41:18.729] <TB3> INFO: Expecting 655360 events.
[10:41:35.237] <TB3> INFO: 655360 events read in total (16107ms).
[10:41:35.278] <TB3> INFO: Expecting 655360 events.
[10:41:51.889] <TB3> INFO: 655360 events read in total (16210ms).
[10:41:51.936] <TB3> INFO: Expecting 655360 events.
[10:42:08.460] <TB3> INFO: 655360 events read in total (16122ms).
[10:42:08.516] <TB3> INFO: Expecting 655360 events.
[10:42:25.093] <TB3> INFO: 655360 events read in total (16175ms).
[10:42:25.166] <TB3> INFO: Expecting 655360 events.
[10:42:41.759] <TB3> INFO: 655360 events read in total (16191ms).
[10:42:41.815] <TB3> INFO: Expecting 655360 events.
[10:42:58.558] <TB3> INFO: 655360 events read in total (16341ms).
[10:42:58.615] <TB3> INFO: Expecting 655360 events.
[10:43:15.243] <TB3> INFO: 655360 events read in total (16226ms).
[10:43:15.312] <TB3> INFO: Test took 266583ms.
[10:43:15.405] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:43:15.630] <TB3> INFO: Expecting 655360 events.
[10:43:32.698] <TB3> INFO: 655360 events read in total (16512ms).
[10:43:32.709] <TB3> INFO: Expecting 655360 events.
[10:43:49.144] <TB3> INFO: 655360 events read in total (16034ms).
[10:43:49.156] <TB3> INFO: Expecting 655360 events.
[10:44:05.706] <TB3> INFO: 655360 events read in total (16148ms).
[10:44:05.722] <TB3> INFO: Expecting 655360 events.
[10:44:22.227] <TB3> INFO: 655360 events read in total (16103ms).
[10:44:22.247] <TB3> INFO: Expecting 655360 events.
[10:44:38.852] <TB3> INFO: 655360 events read in total (16204ms).
[10:44:38.874] <TB3> INFO: Expecting 655360 events.
[10:44:55.532] <TB3> INFO: 655360 events read in total (16257ms).
[10:44:55.560] <TB3> INFO: Expecting 655360 events.
[10:45:11.655] <TB3> INFO: 655360 events read in total (15694ms).
[10:45:11.691] <TB3> INFO: Expecting 655360 events.
[10:45:27.962] <TB3> INFO: 655360 events read in total (15870ms).
[10:45:27.995] <TB3> INFO: Expecting 655360 events.
[10:45:44.461] <TB3> INFO: 655360 events read in total (16064ms).
[10:45:44.501] <TB3> INFO: Expecting 655360 events.
[10:46:01.067] <TB3> INFO: 655360 events read in total (16164ms).
[10:46:01.106] <TB3> INFO: Expecting 655360 events.
[10:46:17.595] <TB3> INFO: 655360 events read in total (16088ms).
[10:46:17.638] <TB3> INFO: Expecting 655360 events.
[10:46:34.218] <TB3> INFO: 655360 events read in total (16179ms).
[10:46:34.264] <TB3> INFO: Expecting 655360 events.
[10:46:50.907] <TB3> INFO: 655360 events read in total (16241ms).
[10:46:50.955] <TB3> INFO: Expecting 655360 events.
[10:47:07.486] <TB3> INFO: 655360 events read in total (16129ms).
[10:47:07.539] <TB3> INFO: Expecting 655360 events.
[10:47:24.318] <TB3> INFO: 655360 events read in total (16378ms).
[10:47:24.374] <TB3> INFO: Expecting 655360 events.
[10:47:40.956] <TB3> INFO: 655360 events read in total (16180ms).
[10:47:41.017] <TB3> INFO: Test took 265612ms.
[10:47:41.225] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.232] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.239] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.246] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.253] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.260] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.267] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.277] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.284] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[10:47:41.291] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.298] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.305] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.312] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[10:47:41.319] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[10:47:41.326] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[10:47:41.336] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[10:47:41.343] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[10:47:41.350] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.357] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[10:47:41.364] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[10:47:41.371] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[10:47:41.378] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[10:47:41.385] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[10:47:41.392] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[10:47:41.403] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[10:47:41.410] <TB3> INFO: safety margin for low PH: adding 8, margin is now 28
[10:47:41.417] <TB3> INFO: safety margin for low PH: adding 9, margin is now 29
[10:47:41.424] <TB3> INFO: safety margin for low PH: adding 10, margin is now 30
[10:47:41.432] <TB3> INFO: safety margin for low PH: adding 11, margin is now 31
[10:47:41.440] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.447] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.454] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[10:47:41.462] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[10:47:41.469] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.476] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[10:47:41.516] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C0.dat
[10:47:41.516] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C1.dat
[10:47:41.516] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C2.dat
[10:47:41.516] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C3.dat
[10:47:41.516] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C4.dat
[10:47:41.516] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C5.dat
[10:47:41.517] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C6.dat
[10:47:41.517] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C7.dat
[10:47:41.517] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C8.dat
[10:47:41.517] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C9.dat
[10:47:41.517] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C10.dat
[10:47:41.517] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C11.dat
[10:47:41.517] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C12.dat
[10:47:41.517] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C13.dat
[10:47:41.518] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C14.dat
[10:47:41.518] <TB3> INFO: write dac parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//dacParameters35_C15.dat
[10:47:41.782] <TB3> INFO: Expecting 41600 events.
[10:47:45.246] <TB3> INFO: 41600 events read in total (2908ms).
[10:47:45.247] <TB3> INFO: Test took 3726ms.
[10:47:45.712] <TB3> INFO: Expecting 41600 events.
[10:47:49.159] <TB3> INFO: 41600 events read in total (2891ms).
[10:47:49.160] <TB3> INFO: Test took 3737ms.
[10:47:49.601] <TB3> INFO: Expecting 41600 events.
[10:47:53.061] <TB3> INFO: 41600 events read in total (2904ms).
[10:47:53.062] <TB3> INFO: Test took 3724ms.
[10:47:53.252] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:47:53.340] <TB3> INFO: Expecting 2560 events.
[10:47:54.193] <TB3> INFO: 2560 events read in total (296ms).
[10:47:54.193] <TB3> INFO: Test took 941ms.
[10:47:54.195] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:47:54.499] <TB3> INFO: Expecting 2560 events.
[10:47:55.353] <TB3> INFO: 2560 events read in total (298ms).
[10:47:55.353] <TB3> INFO: Test took 1158ms.
[10:47:55.355] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:47:55.659] <TB3> INFO: Expecting 2560 events.
[10:47:56.513] <TB3> INFO: 2560 events read in total (298ms).
[10:47:56.513] <TB3> INFO: Test took 1158ms.
[10:47:56.515] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:47:56.818] <TB3> INFO: Expecting 2560 events.
[10:47:57.671] <TB3> INFO: 2560 events read in total (296ms).
[10:47:57.672] <TB3> INFO: Test took 1157ms.
[10:47:57.674] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:47:57.977] <TB3> INFO: Expecting 2560 events.
[10:47:58.830] <TB3> INFO: 2560 events read in total (298ms).
[10:47:58.831] <TB3> INFO: Test took 1157ms.
[10:47:58.832] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:47:59.136] <TB3> INFO: Expecting 2560 events.
[10:47:59.990] <TB3> INFO: 2560 events read in total (297ms).
[10:47:59.990] <TB3> INFO: Test took 1158ms.
[10:47:59.992] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:00.296] <TB3> INFO: Expecting 2560 events.
[10:48:01.149] <TB3> INFO: 2560 events read in total (297ms).
[10:48:01.149] <TB3> INFO: Test took 1157ms.
[10:48:01.151] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:01.455] <TB3> INFO: Expecting 2560 events.
[10:48:02.316] <TB3> INFO: 2560 events read in total (305ms).
[10:48:02.316] <TB3> INFO: Test took 1165ms.
[10:48:02.318] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:02.621] <TB3> INFO: Expecting 2560 events.
[10:48:03.478] <TB3> INFO: 2560 events read in total (301ms).
[10:48:03.478] <TB3> INFO: Test took 1160ms.
[10:48:03.480] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:03.784] <TB3> INFO: Expecting 2560 events.
[10:48:04.639] <TB3> INFO: 2560 events read in total (298ms).
[10:48:04.639] <TB3> INFO: Test took 1159ms.
[10:48:04.642] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:04.945] <TB3> INFO: Expecting 2560 events.
[10:48:05.798] <TB3> INFO: 2560 events read in total (297ms).
[10:48:05.798] <TB3> INFO: Test took 1156ms.
[10:48:05.800] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:06.105] <TB3> INFO: Expecting 2560 events.
[10:48:06.959] <TB3> INFO: 2560 events read in total (298ms).
[10:48:06.959] <TB3> INFO: Test took 1159ms.
[10:48:06.961] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:07.265] <TB3> INFO: Expecting 2560 events.
[10:48:08.120] <TB3> INFO: 2560 events read in total (299ms).
[10:48:08.120] <TB3> INFO: Test took 1159ms.
[10:48:08.123] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:08.425] <TB3> INFO: Expecting 2560 events.
[10:48:09.279] <TB3> INFO: 2560 events read in total (298ms).
[10:48:09.279] <TB3> INFO: Test took 1156ms.
[10:48:09.282] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:09.585] <TB3> INFO: Expecting 2560 events.
[10:48:10.441] <TB3> INFO: 2560 events read in total (300ms).
[10:48:10.441] <TB3> INFO: Test took 1159ms.
[10:48:10.442] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:10.746] <TB3> INFO: Expecting 2560 events.
[10:48:11.599] <TB3> INFO: 2560 events read in total (296ms).
[10:48:11.600] <TB3> INFO: Test took 1158ms.
[10:48:11.603] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:11.905] <TB3> INFO: Expecting 2560 events.
[10:48:12.758] <TB3> INFO: 2560 events read in total (297ms).
[10:48:12.758] <TB3> INFO: Test took 1155ms.
[10:48:12.762] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:13.065] <TB3> INFO: Expecting 2560 events.
[10:48:13.920] <TB3> INFO: 2560 events read in total (299ms).
[10:48:13.920] <TB3> INFO: Test took 1159ms.
[10:48:13.923] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:14.226] <TB3> INFO: Expecting 2560 events.
[10:48:15.079] <TB3> INFO: 2560 events read in total (297ms).
[10:48:15.079] <TB3> INFO: Test took 1156ms.
[10:48:15.086] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:15.385] <TB3> INFO: Expecting 2560 events.
[10:48:16.238] <TB3> INFO: 2560 events read in total (297ms).
[10:48:16.239] <TB3> INFO: Test took 1154ms.
[10:48:16.241] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:16.544] <TB3> INFO: Expecting 2560 events.
[10:48:17.397] <TB3> INFO: 2560 events read in total (297ms).
[10:48:17.398] <TB3> INFO: Test took 1158ms.
[10:48:17.399] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:17.703] <TB3> INFO: Expecting 2560 events.
[10:48:18.556] <TB3> INFO: 2560 events read in total (296ms).
[10:48:18.557] <TB3> INFO: Test took 1158ms.
[10:48:18.558] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:18.862] <TB3> INFO: Expecting 2560 events.
[10:48:19.716] <TB3> INFO: 2560 events read in total (298ms).
[10:48:19.716] <TB3> INFO: Test took 1158ms.
[10:48:19.718] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:20.022] <TB3> INFO: Expecting 2560 events.
[10:48:20.875] <TB3> INFO: 2560 events read in total (297ms).
[10:48:20.875] <TB3> INFO: Test took 1157ms.
[10:48:20.877] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:21.181] <TB3> INFO: Expecting 2560 events.
[10:48:22.034] <TB3> INFO: 2560 events read in total (297ms).
[10:48:22.034] <TB3> INFO: Test took 1157ms.
[10:48:22.037] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:22.340] <TB3> INFO: Expecting 2560 events.
[10:48:23.197] <TB3> INFO: 2560 events read in total (301ms).
[10:48:23.197] <TB3> INFO: Test took 1160ms.
[10:48:23.199] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:23.503] <TB3> INFO: Expecting 2560 events.
[10:48:24.356] <TB3> INFO: 2560 events read in total (297ms).
[10:48:24.356] <TB3> INFO: Test took 1157ms.
[10:48:24.358] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:24.662] <TB3> INFO: Expecting 2560 events.
[10:48:25.516] <TB3> INFO: 2560 events read in total (298ms).
[10:48:25.516] <TB3> INFO: Test took 1158ms.
[10:48:25.524] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:25.822] <TB3> INFO: Expecting 2560 events.
[10:48:26.675] <TB3> INFO: 2560 events read in total (297ms).
[10:48:26.675] <TB3> INFO: Test took 1151ms.
[10:48:26.678] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:26.981] <TB3> INFO: Expecting 2560 events.
[10:48:27.834] <TB3> INFO: 2560 events read in total (297ms).
[10:48:27.834] <TB3> INFO: Test took 1156ms.
[10:48:27.837] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:28.141] <TB3> INFO: Expecting 2560 events.
[10:48:28.994] <TB3> INFO: 2560 events read in total (297ms).
[10:48:28.994] <TB3> INFO: Test took 1157ms.
[10:48:28.997] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[10:48:29.299] <TB3> INFO: Expecting 2560 events.
[10:48:30.154] <TB3> INFO: 2560 events read in total (298ms).
[10:48:30.154] <TB3> INFO: Test took 1158ms.
[10:48:30.617] <TB3> INFO: PixTestPhOptimization::doTest() done, duration: 612 seconds
[10:48:30.617] <TB3> INFO: PH scale (per ROC): 72 77 76 80 78 82 71 80 78 74 80 80 79 80 78 78
[10:48:30.617] <TB3> INFO: PH offset (per ROC): 154 147 185 163 153 173 176 161 160 163 155 176 173 158 171 165
[10:48:30.622] <TB3> INFO: Decoding statistics:
[10:48:30.622] <TB3> INFO: General information:
[10:48:30.622] <TB3> INFO: 16bit words read: 91920
[10:48:30.622] <TB3> INFO: valid events total: 10240
[10:48:30.622] <TB3> INFO: empty events: 7740
[10:48:30.622] <TB3> INFO: valid events with pixels: 2500
[10:48:30.622] <TB3> INFO: valid pixel hits: 2500
[10:48:30.622] <TB3> INFO: Event errors: 0
[10:48:30.622] <TB3> INFO: start marker: 0
[10:48:30.622] <TB3> INFO: stop marker: 0
[10:48:30.622] <TB3> INFO: overflow: 0
[10:48:30.622] <TB3> INFO: invalid 5bit words: 0
[10:48:30.622] <TB3> INFO: invalid XOR eye diagram: 0
[10:48:30.622] <TB3> INFO: frame (failed synchr.): 0
[10:48:30.622] <TB3> INFO: idle data (no TBM trl): 0
[10:48:30.622] <TB3> INFO: no data (only TBM hdr): 0
[10:48:30.622] <TB3> INFO: TBM errors: 0
[10:48:30.622] <TB3> INFO: flawed TBM headers: 0
[10:48:30.622] <TB3> INFO: flawed TBM trailers: 0
[10:48:30.622] <TB3> INFO: event ID mismatches: 0
[10:48:30.622] <TB3> INFO: ROC errors: 0
[10:48:30.622] <TB3> INFO: missing ROC header(s): 0
[10:48:30.622] <TB3> INFO: misplaced readback start: 0
[10:48:30.622] <TB3> INFO: Pixel decoding errors: 0
[10:48:30.622] <TB3> INFO: pixel data incomplete: 0
[10:48:30.622] <TB3> INFO: pixel address: 0
[10:48:30.622] <TB3> INFO: pulse height fill bit: 0
[10:48:30.622] <TB3> INFO: buffer corruption: 0
[10:48:30.803] <TB3> INFO: ######################################################################
[10:48:30.803] <TB3> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[10:48:30.803] <TB3> INFO: ######################################################################
[10:48:30.815] <TB3> INFO: scanning low vcal = 10
[10:48:31.084] <TB3> INFO: Expecting 41600 events.
[10:48:34.619] <TB3> INFO: 41600 events read in total (2979ms).
[10:48:34.619] <TB3> INFO: Test took 3804ms.
[10:48:34.621] <TB3> INFO: scanning low vcal = 20
[10:48:34.924] <TB3> INFO: Expecting 41600 events.
[10:48:38.478] <TB3> INFO: 41600 events read in total (2997ms).
[10:48:38.478] <TB3> INFO: Test took 3857ms.
[10:48:38.480] <TB3> INFO: scanning low vcal = 30
[10:48:38.784] <TB3> INFO: Expecting 41600 events.
[10:48:42.338] <TB3> INFO: 41600 events read in total (2998ms).
[10:48:42.339] <TB3> INFO: Test took 3859ms.
[10:48:42.341] <TB3> INFO: scanning low vcal = 40
[10:48:42.645] <TB3> INFO: Expecting 41600 events.
[10:48:46.769] <TB3> INFO: 41600 events read in total (3568ms).
[10:48:46.769] <TB3> INFO: Test took 4428ms.
[10:48:46.772] <TB3> INFO: scanning low vcal = 50
[10:48:47.046] <TB3> INFO: Expecting 41600 events.
[10:48:51.254] <TB3> INFO: 41600 events read in total (3651ms).
[10:48:51.254] <TB3> INFO: Test took 4482ms.
[10:48:51.257] <TB3> INFO: scanning low vcal = 60
[10:48:51.517] <TB3> INFO: Expecting 41600 events.
[10:48:55.716] <TB3> INFO: 41600 events read in total (3643ms).
[10:48:55.716] <TB3> INFO: Test took 4459ms.
[10:48:55.719] <TB3> INFO: scanning low vcal = 70
[10:48:55.995] <TB3> INFO: Expecting 41600 events.
[10:49:00.199] <TB3> INFO: 41600 events read in total (3647ms).
[10:49:00.200] <TB3> INFO: Test took 4481ms.
[10:49:00.203] <TB3> INFO: scanning low vcal = 80
[10:49:00.477] <TB3> INFO: Expecting 41600 events.
[10:49:04.667] <TB3> INFO: 41600 events read in total (3634ms).
[10:49:04.668] <TB3> INFO: Test took 4465ms.
[10:49:04.671] <TB3> INFO: scanning low vcal = 90
[10:49:04.943] <TB3> INFO: Expecting 41600 events.
[10:49:09.139] <TB3> INFO: 41600 events read in total (3640ms).
[10:49:09.141] <TB3> INFO: Test took 4470ms.
[10:49:09.144] <TB3> INFO: scanning low vcal = 100
[10:49:09.419] <TB3> INFO: Expecting 41600 events.
[10:49:13.642] <TB3> INFO: 41600 events read in total (3666ms).
[10:49:13.642] <TB3> INFO: Test took 4497ms.
[10:49:13.645] <TB3> INFO: scanning low vcal = 110
[10:49:13.920] <TB3> INFO: Expecting 41600 events.
[10:49:18.100] <TB3> INFO: 41600 events read in total (3624ms).
[10:49:18.100] <TB3> INFO: Test took 4455ms.
[10:49:18.102] <TB3> INFO: scanning low vcal = 120
[10:49:18.365] <TB3> INFO: Expecting 41600 events.
[10:49:22.542] <TB3> INFO: 41600 events read in total (3621ms).
[10:49:22.543] <TB3> INFO: Test took 4440ms.
[10:49:22.545] <TB3> INFO: scanning low vcal = 130
[10:49:22.826] <TB3> INFO: Expecting 41600 events.
[10:49:27.035] <TB3> INFO: 41600 events read in total (3653ms).
[10:49:27.036] <TB3> INFO: Test took 4491ms.
[10:49:27.039] <TB3> INFO: scanning low vcal = 140
[10:49:27.321] <TB3> INFO: Expecting 41600 events.
[10:49:31.514] <TB3> INFO: 41600 events read in total (3637ms).
[10:49:31.515] <TB3> INFO: Test took 4476ms.
[10:49:31.518] <TB3> INFO: scanning low vcal = 150
[10:49:31.797] <TB3> INFO: Expecting 41600 events.
[10:49:36.001] <TB3> INFO: 41600 events read in total (3648ms).
[10:49:36.002] <TB3> INFO: Test took 4484ms.
[10:49:36.005] <TB3> INFO: scanning low vcal = 160
[10:49:36.279] <TB3> INFO: Expecting 41600 events.
[10:49:40.464] <TB3> INFO: 41600 events read in total (3629ms).
[10:49:40.465] <TB3> INFO: Test took 4460ms.
[10:49:40.467] <TB3> INFO: scanning low vcal = 170
[10:49:40.731] <TB3> INFO: Expecting 41600 events.
[10:49:44.934] <TB3> INFO: 41600 events read in total (3647ms).
[10:49:44.934] <TB3> INFO: Test took 4467ms.
[10:49:44.938] <TB3> INFO: scanning low vcal = 180
[10:49:45.199] <TB3> INFO: Expecting 41600 events.
[10:49:49.406] <TB3> INFO: 41600 events read in total (3650ms).
[10:49:49.407] <TB3> INFO: Test took 4469ms.
[10:49:49.410] <TB3> INFO: scanning low vcal = 190
[10:49:49.673] <TB3> INFO: Expecting 41600 events.
[10:49:53.856] <TB3> INFO: 41600 events read in total (3627ms).
[10:49:53.856] <TB3> INFO: Test took 4446ms.
[10:49:53.859] <TB3> INFO: scanning low vcal = 200
[10:49:54.130] <TB3> INFO: Expecting 41600 events.
[10:49:58.349] <TB3> INFO: 41600 events read in total (3663ms).
[10:49:58.350] <TB3> INFO: Test took 4491ms.
[10:49:58.352] <TB3> INFO: scanning low vcal = 210
[10:49:58.644] <TB3> INFO: Expecting 41600 events.
[10:50:02.847] <TB3> INFO: 41600 events read in total (3647ms).
[10:50:02.847] <TB3> INFO: Test took 4495ms.
[10:50:02.850] <TB3> INFO: scanning low vcal = 220
[10:50:03.120] <TB3> INFO: Expecting 41600 events.
[10:50:07.323] <TB3> INFO: 41600 events read in total (3646ms).
[10:50:07.324] <TB3> INFO: Test took 4474ms.
[10:50:07.326] <TB3> INFO: scanning low vcal = 230
[10:50:07.588] <TB3> INFO: Expecting 41600 events.
[10:50:11.779] <TB3> INFO: 41600 events read in total (3635ms).
[10:50:11.779] <TB3> INFO: Test took 4452ms.
[10:50:11.782] <TB3> INFO: scanning low vcal = 240
[10:50:12.054] <TB3> INFO: Expecting 41600 events.
[10:50:16.225] <TB3> INFO: 41600 events read in total (3615ms).
[10:50:16.226] <TB3> INFO: Test took 4444ms.
[10:50:16.229] <TB3> INFO: scanning low vcal = 250
[10:50:16.493] <TB3> INFO: Expecting 41600 events.
[10:50:20.667] <TB3> INFO: 41600 events read in total (3618ms).
[10:50:20.668] <TB3> INFO: Test took 4439ms.
[10:50:20.672] <TB3> INFO: scanning high vcal = 30 (= 210 in low range)
[10:50:20.944] <TB3> INFO: Expecting 41600 events.
[10:50:25.185] <TB3> INFO: 41600 events read in total (3685ms).
[10:50:25.186] <TB3> INFO: Test took 4514ms.
[10:50:25.189] <TB3> INFO: scanning high vcal = 50 (= 350 in low range)
[10:50:25.459] <TB3> INFO: Expecting 41600 events.
[10:50:29.697] <TB3> INFO: 41600 events read in total (3681ms).
[10:50:29.698] <TB3> INFO: Test took 4509ms.
[10:50:29.701] <TB3> INFO: scanning high vcal = 70 (= 490 in low range)
[10:50:29.968] <TB3> INFO: Expecting 41600 events.
[10:50:34.155] <TB3> INFO: 41600 events read in total (3631ms).
[10:50:34.155] <TB3> INFO: Test took 4454ms.
[10:50:34.158] <TB3> INFO: scanning high vcal = 90 (= 630 in low range)
[10:50:34.423] <TB3> INFO: Expecting 41600 events.
[10:50:38.608] <TB3> INFO: 41600 events read in total (3629ms).
[10:50:38.608] <TB3> INFO: Test took 4450ms.
[10:50:38.611] <TB3> INFO: scanning high vcal = 200 (= 1400 in low range)
[10:50:38.876] <TB3> INFO: Expecting 41600 events.
[10:50:43.072] <TB3> INFO: 41600 events read in total (3640ms).
[10:50:43.073] <TB3> INFO: Test took 4462ms.
[10:50:43.680] <TB3> INFO: PixTestGainPedestal::measure() done
[10:51:16.082] <TB3> INFO: PixTestGainPedestal::fit() done
[10:51:16.083] <TB3> INFO: non-linearity mean: 0.952 0.954 0.952 0.958 0.951 0.952 0.958 0.961 0.949 0.959 0.960 0.964 0.952 0.962 0.954 0.949
[10:51:16.083] <TB3> INFO: non-linearity RMS: 0.006 0.006 0.006 0.006 0.006 0.006 0.008 0.005 0.007 0.005 0.004 0.004 0.007 0.005 0.005 0.007
[10:51:16.083] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[10:51:16.106] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[10:51:16.129] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[10:51:16.153] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[10:51:16.176] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[10:51:16.199] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[10:51:16.223] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[10:51:16.246] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[10:51:16.269] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[10:51:16.292] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[10:51:16.315] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[10:51:16.339] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[10:51:16.362] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[10:51:16.385] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[10:51:16.408] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[10:51:16.432] <TB3> INFO: write gain/ped parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[10:51:16.455] <TB3> INFO: PixTestGainPedestal::fullTest() done, duration: 165 seconds
[10:51:16.455] <TB3> INFO: Decoding statistics:
[10:51:16.455] <TB3> INFO: General information:
[10:51:16.455] <TB3> INFO: 16bit words read: 2662400
[10:51:16.455] <TB3> INFO: valid events total: 166400
[10:51:16.455] <TB3> INFO: empty events: 0
[10:51:16.455] <TB3> INFO: valid events with pixels: 166400
[10:51:16.455] <TB3> INFO: valid pixel hits: 665565
[10:51:16.455] <TB3> INFO: Event errors: 0
[10:51:16.455] <TB3> INFO: start marker: 0
[10:51:16.455] <TB3> INFO: stop marker: 0
[10:51:16.455] <TB3> INFO: overflow: 0
[10:51:16.455] <TB3> INFO: invalid 5bit words: 0
[10:51:16.455] <TB3> INFO: invalid XOR eye diagram: 0
[10:51:16.455] <TB3> INFO: frame (failed synchr.): 0
[10:51:16.455] <TB3> INFO: idle data (no TBM trl): 0
[10:51:16.455] <TB3> INFO: no data (only TBM hdr): 0
[10:51:16.455] <TB3> INFO: TBM errors: 0
[10:51:16.455] <TB3> INFO: flawed TBM headers: 0
[10:51:16.455] <TB3> INFO: flawed TBM trailers: 0
[10:51:16.455] <TB3> INFO: event ID mismatches: 0
[10:51:16.455] <TB3> INFO: ROC errors: 0
[10:51:16.455] <TB3> INFO: missing ROC header(s): 0
[10:51:16.455] <TB3> INFO: misplaced readback start: 0
[10:51:16.455] <TB3> INFO: Pixel decoding errors: 0
[10:51:16.455] <TB3> INFO: pixel data incomplete: 0
[10:51:16.455] <TB3> INFO: pixel address: 0
[10:51:16.455] <TB3> INFO: pulse height fill bit: 0
[10:51:16.455] <TB3> INFO: buffer corruption: 0
[10:51:16.463] <TB3> INFO: readReadbackCal: /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C0.dat .. /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C15.dat
[10:51:16.464] <TB3> INFO: ######################################################################
[10:51:16.464] <TB3> INFO: PixTestReadback::doTest()
[10:51:16.464] <TB3> INFO: ######################################################################
[10:51:16.464] <TB3> INFO: ----------------------------------------------------------------------
[10:51:16.464] <TB3> INFO: PixTestReadback::CalibrateVd()
[10:51:16.464] <TB3> INFO: ----------------------------------------------------------------------
[10:51:25.911] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C0.dat
[10:51:25.911] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C1.dat
[10:51:25.911] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C2.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C3.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C4.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C5.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C6.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C7.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C8.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C9.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C10.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C11.dat
[10:51:25.912] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C12.dat
[10:51:25.913] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C13.dat
[10:51:25.913] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C14.dat
[10:51:25.913] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C15.dat
[10:51:25.944] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[10:51:25.944] <TB3> INFO: ----------------------------------------------------------------------
[10:51:25.944] <TB3> INFO: PixTestReadback::CalibrateVa()
[10:51:25.944] <TB3> INFO: ----------------------------------------------------------------------
[10:51:36.476] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C0.dat
[10:51:36.476] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C1.dat
[10:51:36.476] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C2.dat
[10:51:36.476] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C3.dat
[10:51:36.477] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C4.dat
[10:51:36.477] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C5.dat
[10:51:36.477] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C6.dat
[10:51:36.477] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C7.dat
[10:51:36.477] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C8.dat
[10:51:36.477] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C9.dat
[10:51:36.477] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C10.dat
[10:51:36.477] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C11.dat
[10:51:36.478] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C12.dat
[10:51:36.478] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C13.dat
[10:51:36.478] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C14.dat
[10:51:36.478] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C15.dat
[10:51:36.505] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[10:51:36.505] <TB3> INFO: ----------------------------------------------------------------------
[10:51:36.505] <TB3> INFO: PixTestReadback::readbackVbg()
[10:51:36.505] <TB3> INFO: ----------------------------------------------------------------------
[10:51:43.798] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[10:51:43.798] <TB3> INFO: ----------------------------------------------------------------------
[10:51:43.798] <TB3> INFO: PixTestReadback::getCalibratedVbg()
[10:51:43.798] <TB3> INFO: ----------------------------------------------------------------------
[10:51:43.798] <TB3> INFO: Vbg will be calibrated using Vd calibration
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 146.7calibrated Vbg = 1.18301 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 150.7calibrated Vbg = 1.18602 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 152.9calibrated Vbg = 1.1944 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 145.2calibrated Vbg = 1.19979 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 151.8calibrated Vbg = 1.19803 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 147.6calibrated Vbg = 1.20814 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 155.8calibrated Vbg = 1.20059 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 160.3calibrated Vbg = 1.20317 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 149.4calibrated Vbg = 1.20812 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 162.9calibrated Vbg = 1.20748 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 161.3calibrated Vbg = 1.19455 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 153calibrated Vbg = 1.18696 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 151.8calibrated Vbg = 1.19573 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 159.5calibrated Vbg = 1.19363 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 154.4calibrated Vbg = 1.19418 :::*/*/*/*/
[10:51:43.798] <TB3> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 150.3calibrated Vbg = 1.20276 :::*/*/*/*/
[10:51:43.800] <TB3> INFO: ----------------------------------------------------------------------
[10:51:43.800] <TB3> INFO: PixTestReadback::CalibrateIa()
[10:51:43.800] <TB3> INFO: ----------------------------------------------------------------------
[10:54:18.905] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C0.dat
[10:54:18.905] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C1.dat
[10:54:18.905] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C2.dat
[10:54:18.905] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C3.dat
[10:54:18.905] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C4.dat
[10:54:18.906] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C5.dat
[10:54:18.906] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C6.dat
[10:54:18.906] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C7.dat
[10:54:18.906] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C8.dat
[10:54:18.906] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C9.dat
[10:54:18.906] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C10.dat
[10:54:18.907] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C11.dat
[10:54:18.907] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C12.dat
[10:54:18.907] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C13.dat
[10:54:18.907] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C14.dat
[10:54:18.907] <TB3> INFO: write readback calibration parameters into /usr/local/coldboxDATA/M2155_FullQualification_2016-02-08_10h24m_1454923474//000_FulltestPxar_m20//readbackCal_C15.dat
[10:54:18.932] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[10:54:18.933] <TB3> INFO: PixTestReadback::doTest() done
[10:54:18.933] <TB3> INFO: Decoding statistics:
[10:54:18.933] <TB3> INFO: General information:
[10:54:18.933] <TB3> INFO: 16bit words read: 1024
[10:54:18.933] <TB3> INFO: valid events total: 128
[10:54:18.933] <TB3> INFO: empty events: 128
[10:54:18.933] <TB3> INFO: valid events with pixels: 0
[10:54:18.933] <TB3> INFO: valid pixel hits: 0
[10:54:18.933] <TB3> INFO: Event errors: 0
[10:54:18.933] <TB3> INFO: start marker: 0
[10:54:18.933] <TB3> INFO: stop marker: 0
[10:54:18.933] <TB3> INFO: overflow: 0
[10:54:18.933] <TB3> INFO: invalid 5bit words: 0
[10:54:18.934] <TB3> INFO: invalid XOR eye diagram: 0
[10:54:18.934] <TB3> INFO: frame (failed synchr.): 0
[10:54:18.934] <TB3> INFO: idle data (no TBM trl): 0
[10:54:18.934] <TB3> INFO: no data (only TBM hdr): 0
[10:54:18.934] <TB3> INFO: TBM errors: 0
[10:54:18.934] <TB3> INFO: flawed TBM headers: 0
[10:54:18.934] <TB3> INFO: flawed TBM trailers: 0
[10:54:18.934] <TB3> INFO: event ID mismatches: 0
[10:54:18.934] <TB3> INFO: ROC errors: 0
[10:54:18.934] <TB3> INFO: missing ROC header(s): 0
[10:54:18.934] <TB3> INFO: misplaced readback start: 0
[10:54:18.934] <TB3> INFO: Pixel decoding errors: 0
[10:54:18.934] <TB3> INFO: pixel data incomplete: 0
[10:54:18.934] <TB3> INFO: pixel address: 0
[10:54:18.934] <TB3> INFO: pulse height fill bit: 0
[10:54:18.934] <TB3> INFO: buffer corruption: 0
[10:54:18.957] <TB3> INFO: Decoding statistics:
[10:54:18.957] <TB3> INFO: General information:
[10:54:18.957] <TB3> INFO: 16bit words read: 2755344
[10:54:18.957] <TB3> INFO: valid events total: 176768
[10:54:18.957] <TB3> INFO: empty events: 7868
[10:54:18.957] <TB3> INFO: valid events with pixels: 168900
[10:54:18.957] <TB3> INFO: valid pixel hits: 668065
[10:54:18.957] <TB3> INFO: Event errors: 0
[10:54:18.957] <TB3> INFO: start marker: 0
[10:54:18.957] <TB3> INFO: stop marker: 0
[10:54:18.957] <TB3> INFO: overflow: 0
[10:54:18.957] <TB3> INFO: invalid 5bit words: 0
[10:54:18.957] <TB3> INFO: invalid XOR eye diagram: 0
[10:54:18.957] <TB3> INFO: frame (failed synchr.): 0
[10:54:18.957] <TB3> INFO: idle data (no TBM trl): 0
[10:54:18.957] <TB3> INFO: no data (only TBM hdr): 0
[10:54:18.957] <TB3> INFO: TBM errors: 0
[10:54:18.957] <TB3> INFO: flawed TBM headers: 0
[10:54:18.957] <TB3> INFO: flawed TBM trailers: 0
[10:54:18.957] <TB3> INFO: event ID mismatches: 0
[10:54:18.957] <TB3> INFO: ROC errors: 0
[10:54:18.957] <TB3> INFO: missing ROC header(s): 0
[10:54:18.957] <TB3> INFO: misplaced readback start: 0
[10:54:18.957] <TB3> INFO: Pixel decoding errors: 0
[10:54:18.957] <TB3> INFO: pixel data incomplete: 0
[10:54:18.957] <TB3> INFO: pixel address: 0
[10:54:18.957] <TB3> INFO: pulse height fill bit: 0
[10:54:18.957] <TB3> INFO: buffer corruption: 0
[10:54:18.957] <TB3> INFO: enter test to run
[10:54:18.957] <TB3> INFO: test: exit no parameter change
[10:54:19.093] <TB3> QUIET: Connection to board 170 closed.
[10:54:19.172] <TB3> INFO: pXar: this is the end, my friend