[07:29:00.826] <TB3> INFO: *** Welcome to pxar ***
[07:29:00.826] <TB3> INFO: *** Today: 2016/06/09
[07:29:01.260] <TB3> INFO: *** Version: 9751-dirty
[07:29:01.260] <TB3> INFO: readRocDacs: /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C0.dat .. /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C15.dat
[07:29:01.276] <TB3> INFO: readTbmDacs: /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//tbmParameters_C0a.dat .. /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//tbmParameters_C0b.dat
[07:29:01.278] <TB3> INFO: readMaskFile: /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//defaultMaskFile.dat
[07:29:01.279] <TB3> INFO: readTrimFile: /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters_C0.dat .. /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters_C15.dat
[07:29:01.380] <TB3> INFO: clk: 4
[07:29:01.380] <TB3> INFO: ctr: 4
[07:29:01.380] <TB3> INFO: sda: 19
[07:29:01.380] <TB3> INFO: tin: 9
[07:29:01.380] <TB3> INFO: level: 15
[07:29:01.380] <TB3> INFO: triggerdelay: 0
[07:29:01.380] <TB3> QUIET: Instanciating API for pxar v2.7.5+40~g4fce89b
[07:29:01.380] <TB3> INFO: Log level: INFO
[07:29:01.391] <TB3> QUIET: Connection to board DTB_WWVASW opened.
[07:29:01.393] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 126
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWVASW
MAC address: 40D85511807E
Hostname: pixelDTB126
Comment:
------------------------------------------------------
[07:29:01.395] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[07:29:02.904] <TB3> INFO: DUT info:
[07:29:02.904] <TB3> INFO: The DUT currently contains the following objects:
[07:29:02.904] <TB3> INFO: 2 TBM Cores tbm09c (2 ON)
[07:29:02.904] <TB3> INFO: TBM Core alpha (0): 7 registers set
[07:29:02.904] <TB3> INFO: TBM Core beta (1): 7 registers set
[07:29:02.904] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[07:29:02.904] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:02.904] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[07:29:03.307] <TB3> INFO: enter 'restricted' command line mode
[07:29:03.307] <TB3> INFO: enter test to run
[07:29:03.307] <TB3> INFO: test: pretest no parameter change
[07:29:03.307] <TB3> INFO: running: pretest
[07:29:03.312] <TB3> INFO: ----------------------------------------------------------------------
[07:29:03.312] <TB3> INFO: PixTestPretest::programROC()
[07:29:03.312] <TB3> INFO: ----------------------------------------------------------------------
[07:29:21.332] <TB3> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[07:29:21.333] <TB3> INFO: IA differences per ROC: 19.3 20.9 20.1 20.9 20.9 20.9 20.1 20.9 20.9 20.9 20.9 21.7 20.9 20.9 20.9 20.9
[07:29:21.435] <TB3> INFO: enter test to run
[07:29:21.435] <TB3> INFO: test: pretest no parameter change
[07:29:21.435] <TB3> INFO: running: pretest
[07:29:21.437] <TB3> INFO: ----------------------------------------------------------------------
[07:29:21.437] <TB3> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[07:29:21.437] <TB3> INFO: ----------------------------------------------------------------------
[07:29:42.733] <TB3> INFO: PixTestPretest::setVana() done, Module Ia 392.3 mA = 24.5187 mA/ROC
[07:29:42.733] <TB3> INFO: i(loss) [mA/ROC]: 20.9 20.1 20.1 20.9 20.9 20.1 20.1 19.3 20.1 19.3 20.1 19.3 20.1 20.1 19.3 20.1
[07:29:42.778] <TB3> INFO: enter test to run
[07:29:42.778] <TB3> INFO: test: pretest no parameter change
[07:29:42.778] <TB3> INFO: running: pretest
[07:29:42.778] <TB3> INFO: ----------------------------------------------------------------------
[07:29:42.778] <TB3> INFO: PixTestPretest::findTiming()
[07:29:42.778] <TB3> INFO: ----------------------------------------------------------------------
[07:29:42.778] <TB3> INFO: PixTestCmd::init()

[07:31:13.507] <TB3> INFO: TBM phases: 160MHz: 7, 400MHz: 6, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[07:31:13.507] <TB3> INFO: (success/tries = 100/100), width = 4
[07:31:13.508] <TB3> INFO: enter test to run
[07:31:13.508] <TB3> INFO: test: pretest no parameter change
[07:31:13.508] <TB3> INFO: running: pretest
[07:31:13.510] <TB3> INFO: ----------------------------------------------------------------------
[07:31:13.510] <TB3> INFO: PixTestPretest::findWorkingPixel()
[07:31:13.510] <TB3> INFO: ----------------------------------------------------------------------
[07:31:13.602] <TB3> INFO: Expecting 231680 events.


[07:31:23.646] <TB3> INFO: 231680 events read in total (9487ms).
[07:31:23.651] <TB3> INFO: Test took 10139ms.
[07:31:23.880] <TB3> INFO: Found working pixel in all ROCs: col/row = 12/22
[07:31:23.956] <TB3> INFO: enter test to run
[07:31:23.956] <TB3> INFO: test: pretest no parameter change
[07:31:23.956] <TB3> INFO: running: pretest
[07:31:23.957] <TB3> INFO: ----------------------------------------------------------------------
[07:31:23.957] <TB3> INFO: PixTestPretest::setVthrCompCalDel()
[07:31:23.957] <TB3> INFO: ----------------------------------------------------------------------
[07:31:24.053] <TB3> INFO: Expecting 231680 events.
[07:31:34.143] <TB3> INFO: 231680 events read in total (9533ms).
[07:31:34.147] <TB3> INFO: Test took 10185ms.
[07:31:34.411] <TB3> INFO: PixTestPretest::setVthrCompCalDel() done
[07:31:34.411] <TB3> INFO: CalDel: 163 161 152 142 138 170 147 148 132 123 149 128 128 144 160 147
[07:31:34.411] <TB3> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[07:31:34.443] <TB3> INFO: enter test to run
[07:31:34.443] <TB3> INFO: test: pretest no parameter change
[07:31:34.443] <TB3> INFO: running: pretest
[07:31:34.449] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C0.dat
[07:31:34.454] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C1.dat
[07:31:34.460] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C2.dat
[07:31:34.467] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C3.dat
[07:31:34.472] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C4.dat
[07:31:34.477] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C5.dat
[07:31:34.482] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C6.dat
[07:31:34.487] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C7.dat
[07:31:34.492] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C8.dat
[07:31:34.497] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C9.dat
[07:31:34.504] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C10.dat
[07:31:34.510] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C11.dat
[07:31:34.515] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C12.dat
[07:31:34.520] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C13.dat
[07:31:34.525] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C14.dat
[07:31:34.531] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters_C15.dat
[07:31:34.534] <TB3> INFO: enter test to run
[07:31:34.534] <TB3> INFO: test: fulltest no parameter change
[07:31:34.534] <TB3> INFO: running: fulltest
[07:31:34.534] <TB3> INFO: ######################################################################
[07:31:34.534] <TB3> INFO: PixTestFullTest::doTest()
[07:31:34.534] <TB3> INFO: ######################################################################
[07:31:34.535] <TB3> INFO: ######################################################################
[07:31:34.535] <TB3> INFO: PixTestAlive::doTest()
[07:31:34.535] <TB3> INFO: ######################################################################
[07:31:34.537] <TB3> INFO: ----------------------------------------------------------------------
[07:31:34.537] <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)
[07:31:34.537] <TB3> INFO: ----------------------------------------------------------------------
[07:31:34.796] <TB3> INFO: Expecting 41600 events.
[07:31:38.493] <TB3> INFO: 41600 events read in total (3141ms).
[07:31:38.497] <TB3> INFO: Test took 3958ms.
[07:31:38.743] <TB3> INFO: PixTestAlive::aliveTest() done
[07:31:38.743] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[07:31:38.744] <TB3> INFO: ----------------------------------------------------------------------
[07:31:38.744] <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)
[07:31:38.744] <TB3> INFO: ----------------------------------------------------------------------
[07:31:39.004] <TB3> INFO: Expecting 41600 events.
[07:31:41.916] <TB3> INFO: 41600 events read in total (2355ms).
[07:31:41.916] <TB3> INFO: Test took 3170ms.
[07:31:41.917] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[07:31:42.179] <TB3> INFO: PixTestAlive::maskTest() done
[07:31:42.179] <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
[07:31:42.180] <TB3> INFO: ----------------------------------------------------------------------
[07:31:42.180] <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)
[07:31:42.180] <TB3> INFO: ----------------------------------------------------------------------
[07:31:42.436] <TB3> INFO: Expecting 41600 events.
[07:31:46.111] <TB3> INFO: 41600 events read in total (3118ms).
[07:31:46.111] <TB3> INFO: Test took 3929ms.
[07:31:46.360] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[07:31:46.360] <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
[07:31:46.360] <TB3> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[07:31:46.360] <TB3> INFO: Decoding statistics:
[07:31:46.360] <TB3> INFO: General information:
[07:31:46.360] <TB3> INFO: 16bit words read: 0
[07:31:46.360] <TB3> INFO: valid events total: 0
[07:31:46.360] <TB3> INFO: empty events: 0
[07:31:46.360] <TB3> INFO: valid events with pixels: 0
[07:31:46.360] <TB3> INFO: valid pixel hits: 0
[07:31:46.360] <TB3> INFO: Event errors: 0
[07:31:46.360] <TB3> INFO: start marker: 0
[07:31:46.360] <TB3> INFO: stop marker: 0
[07:31:46.360] <TB3> INFO: overflow: 0
[07:31:46.360] <TB3> INFO: invalid 5bit words: 0
[07:31:46.360] <TB3> INFO: invalid XOR eye diagram: 0
[07:31:46.360] <TB3> INFO: frame (failed synchr.): 0
[07:31:46.360] <TB3> INFO: idle data (no TBM trl): 0
[07:31:46.360] <TB3> INFO: no data (only TBM hdr): 0
[07:31:46.360] <TB3> INFO: TBM errors: 0
[07:31:46.360] <TB3> INFO: flawed TBM headers: 0
[07:31:46.360] <TB3> INFO: flawed TBM trailers: 0
[07:31:46.360] <TB3> INFO: event ID mismatches: 0
[07:31:46.360] <TB3> INFO: ROC errors: 0
[07:31:46.360] <TB3> INFO: missing ROC header(s): 0
[07:31:46.360] <TB3> INFO: misplaced readback start: 0
[07:31:46.360] <TB3> INFO: Pixel decoding errors: 0
[07:31:46.360] <TB3> INFO: pixel data incomplete: 0
[07:31:46.360] <TB3> INFO: pixel address: 0
[07:31:46.360] <TB3> INFO: pulse height fill bit: 0
[07:31:46.360] <TB3> INFO: buffer corruption: 0
[07:31:46.367] <TB3> INFO: ######################################################################
[07:31:46.367] <TB3> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[07:31:46.367] <TB3> INFO: ######################################################################
[07:31:46.371] <TB3> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[07:31:46.471] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[07:31:46.471] <TB3> INFO: run 1 of 1
[07:31:46.725] <TB3> INFO: Expecting 3120000 events.
[07:32:25.364] <TB3> INFO: 823395 events read in total (38082ms).
[07:33:03.335] <TB3> INFO: 1641785 events read in total (76053ms).
[07:33:41.548] <TB3> INFO: 2472165 events read in total (114267ms).
[07:34:11.405] <TB3> INFO: 3120000 events read in total (144123ms).
[07:34:11.456] <TB3> INFO: Test took 144985ms.
[07:34:33.112] <TB3> INFO: PixTestBBMap::doTest() done, duration: 166 seconds
[07:34:33.112] <TB3> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 1 2 3 7 0 1 1 0 0
[07:34:33.112] <TB3> INFO: separation cut (per ROC): 87 87 86 87 84 87 80 89 70 74 69 78 77 85 65 68
[07:34:33.112] <TB3> INFO: Decoding statistics:
[07:34:33.112] <TB3> INFO: General information:
[07:34:33.112] <TB3> INFO: 16bit words read: 0
[07:34:33.112] <TB3> INFO: valid events total: 0
[07:34:33.112] <TB3> INFO: empty events: 0
[07:34:33.112] <TB3> INFO: valid events with pixels: 0
[07:34:33.112] <TB3> INFO: valid pixel hits: 0
[07:34:33.112] <TB3> INFO: Event errors: 0
[07:34:33.112] <TB3> INFO: start marker: 0
[07:34:33.112] <TB3> INFO: stop marker: 0
[07:34:33.112] <TB3> INFO: overflow: 0
[07:34:33.112] <TB3> INFO: invalid 5bit words: 0
[07:34:33.112] <TB3> INFO: invalid XOR eye diagram: 0
[07:34:33.112] <TB3> INFO: frame (failed synchr.): 0
[07:34:33.112] <TB3> INFO: idle data (no TBM trl): 0
[07:34:33.112] <TB3> INFO: no data (only TBM hdr): 0
[07:34:33.112] <TB3> INFO: TBM errors: 0
[07:34:33.112] <TB3> INFO: flawed TBM headers: 0
[07:34:33.112] <TB3> INFO: flawed TBM trailers: 0
[07:34:33.112] <TB3> INFO: event ID mismatches: 0
[07:34:33.112] <TB3> INFO: ROC errors: 0
[07:34:33.112] <TB3> INFO: missing ROC header(s): 0
[07:34:33.112] <TB3> INFO: misplaced readback start: 0
[07:34:33.113] <TB3> INFO: Pixel decoding errors: 0
[07:34:33.113] <TB3> INFO: pixel data incomplete: 0
[07:34:33.113] <TB3> INFO: pixel address: 0
[07:34:33.113] <TB3> INFO: pulse height fill bit: 0
[07:34:33.113] <TB3> INFO: buffer corruption: 0
[07:34:33.181] <TB3> INFO: ######################################################################
[07:34:33.181] <TB3> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[07:34:33.181] <TB3> INFO: ######################################################################
[07:34:33.181] <TB3> INFO: ----------------------------------------------------------------------
[07:34:33.181] <TB3> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[07:34:33.181] <TB3> INFO: ----------------------------------------------------------------------
[07:34:33.181] <TB3> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 150 (-1/-1) hits flags = 528 (plus default)
[07:34:33.190] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[07:34:33.190] <TB3> INFO: run 1 of 1
[07:34:33.447] <TB3> INFO: Expecting 26208000 events.
[07:35:05.237] <TB3> INFO: 893950 events read in total (31233ms).
[07:35:36.422] <TB3> INFO: 1774750 events read in total (62418ms).
[07:36:07.732] <TB3> INFO: 2655600 events read in total (93728ms).
[07:36:39.001] <TB3> INFO: 3533750 events read in total (124997ms).
[07:37:10.350] <TB3> INFO: 4412050 events read in total (156346ms).
[07:37:41.539] <TB3> INFO: 5290100 events read in total (187535ms).
[07:38:12.903] <TB3> INFO: 6170350 events read in total (218899ms).
[07:38:44.144] <TB3> INFO: 7047450 events read in total (250140ms).
[07:39:15.330] <TB3> INFO: 7924400 events read in total (281326ms).
[07:39:46.640] <TB3> INFO: 8802100 events read in total (312636ms).
[07:40:18.031] <TB3> INFO: 9680950 events read in total (344027ms).
[07:40:49.442] <TB3> INFO: 10556050 events read in total (375438ms).
[07:41:20.915] <TB3> INFO: 11431200 events read in total (406911ms).
[07:41:52.263] <TB3> INFO: 12307200 events read in total (438259ms).
[07:42:23.556] <TB3> INFO: 13178650 events read in total (469552ms).
[07:42:54.850] <TB3> INFO: 14042500 events read in total (500846ms).
[07:43:26.253] <TB3> INFO: 14908700 events read in total (532249ms).
[07:43:57.538] <TB3> INFO: 15773600 events read in total (563534ms).
[07:44:28.745] <TB3> INFO: 16635500 events read in total (594741ms).
[07:45:00.014] <TB3> INFO: 17498100 events read in total (626010ms).
[07:45:31.288] <TB3> INFO: 18361450 events read in total (657284ms).
[07:46:02.507] <TB3> INFO: 19222650 events read in total (688503ms).
[07:46:33.672] <TB3> INFO: 20081650 events read in total (719668ms).
[07:47:04.876] <TB3> INFO: 20942600 events read in total (750872ms).
[07:47:36.105] <TB3> INFO: 21804400 events read in total (782101ms).
[07:48:07.282] <TB3> INFO: 22664850 events read in total (813278ms).
[07:48:38.559] <TB3> INFO: 23527050 events read in total (844555ms).
[07:49:09.750] <TB3> INFO: 24390600 events read in total (875746ms).
[07:49:40.782] <TB3> INFO: 25253750 events read in total (906778ms).
[07:50:11.954] <TB3> INFO: 26129700 events read in total (937950ms).
[07:50:15.044] <TB3> INFO: 26208000 events read in total (941040ms).
[07:50:15.075] <TB3> INFO: Test took 941885ms.
[07:50:15.300] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:16.727] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:18.302] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:19.676] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:21.044] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:22.450] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:23.825] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:25.234] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:26.618] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:27.981] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:29.336] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:30.805] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:32.148] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:33.493] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:34.819] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:36.189] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:50:37.610] <TB3> INFO: PixTestScurves::scurves() done
[07:50:37.610] <TB3> INFO: Vcal mean: 96.14 93.44 87.88 91.00 86.69 90.11 86.78 94.30 92.67 91.06 77.95 83.22 82.92 95.66 77.51 88.27
[07:50:37.610] <TB3> INFO: Vcal RMS: 5.35 5.79 4.75 5.33 5.45 5.20 5.40 5.03 5.31 5.17 4.30 4.52 3.98 5.19 4.28 5.00
[07:50:37.610] <TB3> INFO: PixTestScurves::fullTest() done, duration: 964 seconds
[07:50:37.610] <TB3> INFO: Decoding statistics:
[07:50:37.610] <TB3> INFO: General information:
[07:50:37.610] <TB3> INFO: 16bit words read: 0
[07:50:37.610] <TB3> INFO: valid events total: 0
[07:50:37.611] <TB3> INFO: empty events: 0
[07:50:37.611] <TB3> INFO: valid events with pixels: 0
[07:50:37.611] <TB3> INFO: valid pixel hits: 0
[07:50:37.611] <TB3> INFO: Event errors: 0
[07:50:37.611] <TB3> INFO: start marker: 0
[07:50:37.611] <TB3> INFO: stop marker: 0
[07:50:37.611] <TB3> INFO: overflow: 0
[07:50:37.611] <TB3> INFO: invalid 5bit words: 0
[07:50:37.611] <TB3> INFO: invalid XOR eye diagram: 0
[07:50:37.611] <TB3> INFO: frame (failed synchr.): 0
[07:50:37.611] <TB3> INFO: idle data (no TBM trl): 0
[07:50:37.611] <TB3> INFO: no data (only TBM hdr): 0
[07:50:37.611] <TB3> INFO: TBM errors: 0
[07:50:37.611] <TB3> INFO: flawed TBM headers: 0
[07:50:37.611] <TB3> INFO: flawed TBM trailers: 0
[07:50:37.611] <TB3> INFO: event ID mismatches: 0
[07:50:37.611] <TB3> INFO: ROC errors: 0
[07:50:37.611] <TB3> INFO: missing ROC header(s): 0
[07:50:37.611] <TB3> INFO: misplaced readback start: 0
[07:50:37.611] <TB3> INFO: Pixel decoding errors: 0
[07:50:37.611] <TB3> INFO: pixel data incomplete: 0
[07:50:37.611] <TB3> INFO: pixel address: 0
[07:50:37.611] <TB3> INFO: pulse height fill bit: 0
[07:50:37.611] <TB3> INFO: buffer corruption: 0
[07:50:37.676] <TB3> INFO: ######################################################################
[07:50:37.676] <TB3> INFO: PixTestTrim::doTest()
[07:50:37.676] <TB3> INFO: ######################################################################
[07:50:37.678] <TB3> INFO: ----------------------------------------------------------------------
[07:50:37.678] <TB3> INFO: PixTestTrim::trimTest() ntrig = 8, vcal = 35
[07:50:37.678] <TB3> INFO: ----------------------------------------------------------------------
[07:50:37.754] <TB3> INFO: ---> VthrComp thr map (minimal VthrComp)
[07:50:37.754] <TB3> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[07:50:37.762] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:50:37.762] <TB3> INFO: run 1 of 1
[07:50:38.015] <TB3> INFO: Expecting 5025280 events.
[07:51:17.048] <TB3> INFO: 1050128 events read in total (38476ms).
[07:51:55.426] <TB3> INFO: 2098256 events read in total (76854ms).
[07:52:34.137] <TB3> INFO: 3150176 events read in total (115566ms).
[07:53:12.945] <TB3> INFO: 4212432 events read in total (154373ms).
[07:53:42.653] <TB3> INFO: 5025280 events read in total (184081ms).
[07:53:42.685] <TB3> INFO: Test took 184923ms.
[07:54:02.959] <TB3> INFO: ROC 0 VthrComp = 99
[07:54:02.960] <TB3> INFO: ROC 1 VthrComp = 96
[07:54:02.960] <TB3> INFO: ROC 2 VthrComp = 93
[07:54:02.960] <TB3> INFO: ROC 3 VthrComp = 97
[07:54:02.960] <TB3> INFO: ROC 4 VthrComp = 91
[07:54:02.960] <TB3> INFO: ROC 5 VthrComp = 94
[07:54:02.960] <TB3> INFO: ROC 6 VthrComp = 90
[07:54:02.960] <TB3> INFO: ROC 7 VthrComp = 98
[07:54:02.960] <TB3> INFO: ROC 8 VthrComp = 98
[07:54:02.961] <TB3> INFO: ROC 9 VthrComp = 97
[07:54:02.961] <TB3> INFO: ROC 10 VthrComp = 84
[07:54:02.961] <TB3> INFO: ROC 11 VthrComp = 92
[07:54:02.961] <TB3> INFO: ROC 12 VthrComp = 95
[07:54:02.961] <TB3> INFO: ROC 13 VthrComp = 99
[07:54:02.961] <TB3> INFO: ROC 14 VthrComp = 80
[07:54:02.961] <TB3> INFO: ROC 15 VthrComp = 90
[07:54:02.961] <TB3> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[07:54:02.961] <TB3> INFO: ---> dac: vcal name: TrimThr1 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[07:54:02.969] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:54:02.969] <TB3> INFO: run 1 of 1
[07:54:03.222] <TB3> INFO: Expecting 5025280 events.
[07:54:37.934] <TB3> INFO: 753752 events read in total (34154ms).
[07:55:12.197] <TB3> INFO: 1507120 events read in total (68417ms).
[07:55:46.491] <TB3> INFO: 2260840 events read in total (102711ms).
[07:56:20.806] <TB3> INFO: 3010104 events read in total (137027ms).
[07:56:54.995] <TB3> INFO: 3754520 events read in total (171215ms).
[07:57:29.275] <TB3> INFO: 4497728 events read in total (205495ms).
[07:57:53.569] <TB3> INFO: 5025280 events read in total (229789ms).
[07:57:53.611] <TB3> INFO: Test took 230642ms.
[07:58:18.745] <TB3> INFO: roc 0 with ID = 0 has maximal Vcal 58.4214 for pixel 0/77 mean/min/max = 45.0209/31.5093/58.5324
[07:58:18.746] <TB3> INFO: roc 1 with ID = 1 has maximal Vcal 61.0912 for pixel 2/12 mean/min/max = 46.2853/31.3037/61.2668
[07:58:18.746] <TB3> INFO: roc 2 with ID = 2 has maximal Vcal 57.076 for pixel 49/25 mean/min/max = 44.9554/32.7569/57.1538
[07:58:18.747] <TB3> INFO: roc 3 with ID = 3 has maximal Vcal 59.9951 for pixel 20/0 mean/min/max = 45.4639/30.9077/60.0202
[07:58:18.747] <TB3> INFO: roc 4 with ID = 4 has maximal Vcal 59.9978 for pixel 11/5 mean/min/max = 45.9978/31.8605/60.135
[07:58:18.747] <TB3> INFO: roc 5 with ID = 5 has maximal Vcal 57.1105 for pixel 0/34 mean/min/max = 44.8054/32.182/57.4288
[07:58:18.747] <TB3> INFO: roc 6 with ID = 6 has maximal Vcal 59.8608 for pixel 0/67 mean/min/max = 46.194/32.4699/59.918
[07:58:18.747] <TB3> INFO: roc 7 with ID = 7 has maximal Vcal 56.0253 for pixel 23/22 mean/min/max = 43.7949/31.4389/56.1509
[07:58:18.748] <TB3> INFO: roc 8 with ID = 8 has maximal Vcal 59.9169 for pixel 10/2 mean/min/max = 45.9599/31.9484/59.9715
[07:58:18.748] <TB3> INFO: roc 9 with ID = 9 has maximal Vcal 57.7185 for pixel 0/17 mean/min/max = 44.8987/32.0682/57.7293
[07:58:18.748] <TB3> INFO: roc 10 with ID = 10 has maximal Vcal 58.6507 for pixel 5/6 mean/min/max = 45.3612/32.055/58.6673
[07:58:18.749] <TB3> INFO: roc 11 with ID = 11 has maximal Vcal 57.1648 for pixel 11/74 mean/min/max = 44.7516/32.3313/57.172
[07:58:18.749] <TB3> INFO: roc 12 with ID = 12 has maximal Vcal 54.347 for pixel 51/42 mean/min/max = 43.4239/32.4208/54.427
[07:58:18.749] <TB3> INFO: roc 13 with ID = 13 has maximal Vcal 57.5343 for pixel 24/7 mean/min/max = 44.3999/31.1627/57.6371
[07:58:18.749] <TB3> INFO: roc 14 with ID = 14 has maximal Vcal 57.5008 for pixel 21/0 mean/min/max = 44.948/32.229/57.667
[07:58:18.750] <TB3> INFO: roc 15 with ID = 15 has maximal Vcal 59.0386 for pixel 22/2 mean/min/max = 46.0126/32.8774/59.1478
[07:58:18.750] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:58:18.840] <TB3> INFO: Expecting 411648 events.
[07:58:29.182] <TB3> INFO: 411648 events read in total (9785ms).
[07:58:29.186] <TB3> INFO: Expecting 411648 events.
[07:58:39.545] <TB3> INFO: 411648 events read in total (9924ms).
[07:58:39.552] <TB3> INFO: Expecting 411648 events.
[07:58:49.852] <TB3> INFO: 411648 events read in total (9872ms).
[07:58:49.861] <TB3> INFO: Expecting 411648 events.
[07:59:00.209] <TB3> INFO: 411648 events read in total (9920ms).
[07:59:00.219] <TB3> INFO: Expecting 411648 events.
[07:59:10.671] <TB3> INFO: 411648 events read in total (10026ms).
[07:59:10.684] <TB3> INFO: Expecting 411648 events.
[07:59:21.001] <TB3> INFO: 411648 events read in total (9900ms).
[07:59:21.016] <TB3> INFO: Expecting 411648 events.
[07:59:31.385] <TB3> INFO: 411648 events read in total (9948ms).
[07:59:31.401] <TB3> INFO: Expecting 411648 events.
[07:59:41.736] <TB3> INFO: 411648 events read in total (9914ms).
[07:59:41.754] <TB3> INFO: Expecting 411648 events.
[07:59:52.113] <TB3> INFO: 411648 events read in total (9940ms).
[07:59:52.134] <TB3> INFO: Expecting 411648 events.
[08:00:02.460] <TB3> INFO: 411648 events read in total (9915ms).
[08:00:02.481] <TB3> INFO: Expecting 411648 events.
[08:00:12.890] <TB3> INFO: 411648 events read in total (9994ms).
[08:00:12.915] <TB3> INFO: Expecting 411648 events.
[08:00:23.339] <TB3> INFO: 411648 events read in total (10018ms).
[08:00:23.365] <TB3> INFO: Expecting 411648 events.
[08:00:33.743] <TB3> INFO: 411648 events read in total (9973ms).
[08:00:33.772] <TB3> INFO: Expecting 411648 events.
[08:00:44.118] <TB3> INFO: 411648 events read in total (9942ms).
[08:00:44.147] <TB3> INFO: Expecting 411648 events.
[08:00:54.553] <TB3> INFO: 411648 events read in total (9997ms).
[08:00:54.585] <TB3> INFO: Expecting 411648 events.
[08:01:04.853] <TB3> INFO: 411648 events read in total (9865ms).
[08:01:04.886] <TB3> INFO: Test took 166136ms.
[08:01:05.858] <TB3> INFO: ---> dac: vcal name: TrimThr2 ntrig: 8 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[08:01:05.866] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:01:05.866] <TB3> INFO: run 1 of 1
[08:01:06.123] <TB3> INFO: Expecting 5025280 events.
[08:01:41.015] <TB3> INFO: 741120 events read in total (34335ms).
[08:02:15.062] <TB3> INFO: 1481592 events read in total (68382ms).
[08:02:49.345] <TB3> INFO: 2222288 events read in total (102665ms).
[08:03:23.429] <TB3> INFO: 2958704 events read in total (136749ms).
[08:03:57.495] <TB3> INFO: 3690000 events read in total (170815ms).
[08:04:31.488] <TB3> INFO: 4418648 events read in total (204808ms).
[08:04:59.685] <TB3> INFO: 5025280 events read in total (233005ms).
[08:04:59.728] <TB3> INFO: Test took 233862ms.
[08:05:24.413] <TB3> INFO: ---> TrimStepCorr4 extremal thresholds: 6.881049 .. 51.287905
[08:05:24.487] <TB3> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 8 dacrange: 6 .. 61 (-1/-1) hits flags = 528 (plus default)
[08:05:24.495] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:05:24.495] <TB3> INFO: run 1 of 1
[08:05:24.753] <TB3> INFO: Expecting 1863680 events.
[08:06:02.456] <TB3> INFO: 895464 events read in total (37146ms).
[08:06:39.196] <TB3> INFO: 1780592 events read in total (73886ms).
[08:06:43.028] <TB3> INFO: 1863680 events read in total (77719ms).
[08:06:43.048] <TB3> INFO: Test took 78554ms.
[08:06:56.641] <TB3> INFO: ---> TrimStepCorr2 extremal thresholds: 16.367972 .. 45.982482
[08:06:56.715] <TB3> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 8 dacrange: 6 .. 55 (-1/-1) hits flags = 528 (plus default)
[08:06:56.723] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:06:56.723] <TB3> INFO: run 1 of 1
[08:06:56.979] <TB3> INFO: Expecting 1664000 events.
[08:07:35.054] <TB3> INFO: 933168 events read in total (37518ms).
[08:08:04.763] <TB3> INFO: 1664000 events read in total (67227ms).
[08:08:04.775] <TB3> INFO: Test took 68052ms.
[08:08:17.657] <TB3> INFO: ---> TrimStepCorr1a extremal thresholds: 22.544116 .. 42.830475
[08:08:17.731] <TB3> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 8 dacrange: 12 .. 52 (-1/-1) hits flags = 528 (plus default)
[08:08:17.739] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:08:17.739] <TB3> INFO: run 1 of 1
[08:08:17.997] <TB3> INFO: Expecting 1364480 events.
[08:08:56.389] <TB3> INFO: 923192 events read in total (37835ms).
[08:09:14.624] <TB3> INFO: 1364480 events read in total (56070ms).
[08:09:14.634] <TB3> INFO: Test took 56895ms.
[08:09:27.109] <TB3> INFO: ---> TrimStepCorr1b extremal thresholds: 23.982618 .. 42.830475
[08:09:27.182] <TB3> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 8 dacrange: 13 .. 52 (-1/-1) hits flags = 528 (plus default)
[08:09:27.190] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:09:27.190] <TB3> INFO: run 1 of 1
[08:09:27.446] <TB3> INFO: Expecting 1331200 events.
[08:10:05.671] <TB3> INFO: 916520 events read in total (37668ms).
[08:10:22.978] <TB3> INFO: 1331200 events read in total (54975ms).
[08:10:22.988] <TB3> INFO: Test took 55797ms.
[08:10:35.340] <TB3> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[08:10:35.340] <TB3> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 8 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[08:10:35.348] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:10:35.348] <TB3> INFO: run 1 of 1
[08:10:35.605] <TB3> INFO: Expecting 1364480 events.
[08:11:13.161] <TB3> INFO: 879440 events read in total (36999ms).
[08:11:33.787] <TB3> INFO: 1364480 events read in total (57625ms).
[08:11:33.801] <TB3> INFO: Test took 58453ms.
[08:11:47.427] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C0.dat
[08:11:47.431] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C1.dat
[08:11:47.435] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C2.dat
[08:11:47.439] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C3.dat
[08:11:47.443] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C4.dat
[08:11:47.447] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C5.dat
[08:11:47.451] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C6.dat
[08:11:47.454] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C7.dat
[08:11:47.458] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C8.dat
[08:11:47.462] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C9.dat
[08:11:47.466] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C10.dat
[08:11:47.470] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C11.dat
[08:11:47.474] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C12.dat
[08:11:47.478] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C13.dat
[08:11:47.482] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C14.dat
[08:11:47.485] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C15.dat
[08:11:47.490] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C0.dat
[08:11:47.502] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C1.dat
[08:11:47.513] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C2.dat
[08:11:47.525] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C3.dat
[08:11:47.537] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C4.dat
[08:11:47.549] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C5.dat
[08:11:47.560] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C6.dat
[08:11:47.571] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C7.dat
[08:11:47.582] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C8.dat
[08:11:47.593] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C9.dat
[08:11:47.605] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C10.dat
[08:11:47.616] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C11.dat
[08:11:47.627] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C12.dat
[08:11:47.638] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C13.dat
[08:11:47.650] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C14.dat
[08:11:47.661] <TB3> INFO: write trim parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//trimParameters35_C15.dat
[08:11:47.672] <TB3> INFO: PixTestTrim::trimTest() done
[08:11:47.672] <TB3> INFO: vtrim: 97 109 96 107 123 96 102 90 111 109 112 110 98 92 106 94
[08:11:47.672] <TB3> INFO: vthrcomp: 99 96 93 97 91 94 90 98 98 97 84 92 95 99 80 90
[08:11:47.672] <TB3> INFO: vcal mean: 34.95 34.96 35.00 34.92 35.00 34.98 35.00 34.97 34.94 34.97 34.99 34.97 34.96 34.93 35.00 34.99
[08:11:47.672] <TB3> INFO: vcal RMS: 0.92 0.95 0.90 0.93 0.89 0.91 0.91 0.95 0.95 0.94 0.88 0.84 0.84 1.00 0.87 0.90
[08:11:47.672] <TB3> INFO: bits mean: 9.68 9.42 9.59 9.48 9.58 9.77 9.03 10.41 9.47 9.92 9.45 9.79 9.84 10.19 9.64 9.39
[08:11:47.672] <TB3> INFO: bits RMS: 2.67 2.77 2.59 2.85 2.66 2.66 2.77 2.43 2.68 2.55 2.72 2.57 2.55 2.51 2.64 2.60
[08:11:47.680] <TB3> INFO: ----------------------------------------------------------------------
[08:11:47.680] <TB3> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[08:11:47.680] <TB3> INFO: ----------------------------------------------------------------------
[08:11:47.684] <TB3> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[08:11:47.692] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:11:47.692] <TB3> INFO: run 1 of 1
[08:11:47.945] <TB3> INFO: Expecting 4160000 events.
[08:12:28.482] <TB3> INFO: 922000 events read in total (39980ms).
[08:13:08.399] <TB3> INFO: 1839020 events read in total (79897ms).
[08:13:48.273] <TB3> INFO: 2747730 events read in total (119771ms).
[08:14:27.929] <TB3> INFO: 3653330 events read in total (159427ms).
[08:14:50.172] <TB3> INFO: 4160000 events read in total (181670ms).
[08:14:50.208] <TB3> INFO: Test took 182516ms.
[08:15:16.870] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 159 (-1/-1) hits flags = 528 (plus default)
[08:15:16.878] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:15:16.878] <TB3> INFO: run 1 of 1
[08:15:17.134] <TB3> INFO: Expecting 3328000 events.
[08:15:58.550] <TB3> INFO: 977895 events read in total (40859ms).
[08:16:39.156] <TB3> INFO: 1945520 events read in total (81465ms).
[08:17:19.728] <TB3> INFO: 2902765 events read in total (122037ms).
[08:17:37.860] <TB3> INFO: 3328000 events read in total (140169ms).
[08:17:37.891] <TB3> INFO: Test took 141012ms.
[08:18:00.964] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 528 (plus default)
[08:18:00.973] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:18:00.973] <TB3> INFO: run 1 of 1
[08:18:01.230] <TB3> INFO: Expecting 3120000 events.
[08:18:43.230] <TB3> INFO: 1008590 events read in total (41443ms).
[08:19:24.433] <TB3> INFO: 2003715 events read in total (82646ms).
[08:20:05.521] <TB3> INFO: 2989985 events read in total (123735ms).
[08:20:11.201] <TB3> INFO: 3120000 events read in total (129414ms).
[08:20:11.229] <TB3> INFO: Test took 130256ms.
[08:20:33.273] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 148 (-1/-1) hits flags = 528 (plus default)
[08:20:33.282] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:20:33.282] <TB3> INFO: run 1 of 1
[08:20:33.538] <TB3> INFO: Expecting 3099200 events.
[08:21:15.586] <TB3> INFO: 1011000 events read in total (41491ms).
[08:21:56.880] <TB3> INFO: 2007890 events read in total (82785ms).
[08:22:38.113] <TB3> INFO: 2996355 events read in total (124019ms).
[08:22:42.710] <TB3> INFO: 3099200 events read in total (128615ms).
[08:22:42.734] <TB3> INFO: Test took 129452ms.
[08:23:04.615] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 147 (-1/-1) hits flags = 528 (plus default)
[08:23:04.624] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:23:04.624] <TB3> INFO: run 1 of 1
[08:23:04.880] <TB3> INFO: Expecting 3078400 events.
[08:23:46.825] <TB3> INFO: 1013750 events read in total (41389ms).
[08:24:28.013] <TB3> INFO: 2013125 events read in total (82577ms).
[08:25:09.251] <TB3> INFO: 3004170 events read in total (123815ms).
[08:25:12.622] <TB3> INFO: 3078400 events read in total (127186ms).
[08:25:12.645] <TB3> INFO: Test took 128021ms.
[08:25:34.445] <TB3> INFO: PixTestTrim::trimBitTest() done
[08:25:34.447] <TB3> INFO: PixTestTrim::doTest() done, duration: 2096 seconds
[08:25:34.447] <TB3> INFO: Decoding statistics:
[08:25:34.447] <TB3> INFO: General information:
[08:25:34.447] <TB3> INFO: 16bit words read: 0
[08:25:34.447] <TB3> INFO: valid events total: 0
[08:25:34.447] <TB3> INFO: empty events: 0
[08:25:34.447] <TB3> INFO: valid events with pixels: 0
[08:25:34.447] <TB3> INFO: valid pixel hits: 0
[08:25:34.447] <TB3> INFO: Event errors: 0
[08:25:34.447] <TB3> INFO: start marker: 0
[08:25:34.447] <TB3> INFO: stop marker: 0
[08:25:34.447] <TB3> INFO: overflow: 0
[08:25:34.447] <TB3> INFO: invalid 5bit words: 0
[08:25:34.447] <TB3> INFO: invalid XOR eye diagram: 0
[08:25:34.447] <TB3> INFO: frame (failed synchr.): 0
[08:25:34.447] <TB3> INFO: idle data (no TBM trl): 0
[08:25:34.447] <TB3> INFO: no data (only TBM hdr): 0
[08:25:34.447] <TB3> INFO: TBM errors: 0
[08:25:34.447] <TB3> INFO: flawed TBM headers: 0
[08:25:34.447] <TB3> INFO: flawed TBM trailers: 0
[08:25:34.447] <TB3> INFO: event ID mismatches: 0
[08:25:34.447] <TB3> INFO: ROC errors: 0
[08:25:34.447] <TB3> INFO: missing ROC header(s): 0
[08:25:34.447] <TB3> INFO: misplaced readback start: 0
[08:25:34.447] <TB3> INFO: Pixel decoding errors: 0
[08:25:34.447] <TB3> INFO: pixel data incomplete: 0
[08:25:34.447] <TB3> INFO: pixel address: 0
[08:25:34.447] <TB3> INFO: pulse height fill bit: 0
[08:25:34.447] <TB3> INFO: buffer corruption: 0
[08:25:35.097] <TB3> INFO: ######################################################################
[08:25:35.097] <TB3> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[08:25:35.097] <TB3> INFO: ######################################################################
[08:25:35.355] <TB3> INFO: Expecting 41600 events.
[08:25:39.057] <TB3> INFO: 41600 events read in total (3145ms).
[08:25:39.058] <TB3> INFO: Test took 3960ms.
[08:25:39.520] <TB3> INFO: Expecting 41600 events.
[08:25:43.243] <TB3> INFO: 41600 events read in total (3166ms).
[08:25:43.244] <TB3> INFO: Test took 3981ms.
[08:25:43.522] <TB3> INFO: Expecting 41600 events.
[08:25:47.257] <TB3> INFO: 41600 events read in total (3178ms).
[08:25:47.258] <TB3> INFO: Test took 3993ms.
[08:25:47.514] <TB3> INFO: Expecting 2560 events.
[08:25:48.368] <TB3> INFO: 2560 events read in total (298ms).
[08:25:48.368] <TB3> INFO: Test took 1097ms.
[08:25:48.675] <TB3> INFO: Expecting 2560 events.
[08:25:49.529] <TB3> INFO: 2560 events read in total (297ms).
[08:25:49.529] <TB3> INFO: Test took 1159ms.
[08:25:49.836] <TB3> INFO: Expecting 2560 events.
[08:25:50.690] <TB3> INFO: 2560 events read in total (297ms).
[08:25:50.690] <TB3> INFO: Test took 1160ms.
[08:25:50.998] <TB3> INFO: Expecting 2560 events.
[08:25:51.851] <TB3> INFO: 2560 events read in total (297ms).
[08:25:51.851] <TB3> INFO: Test took 1160ms.
[08:25:52.158] <TB3> INFO: Expecting 2560 events.
[08:25:53.012] <TB3> INFO: 2560 events read in total (297ms).
[08:25:53.012] <TB3> INFO: Test took 1160ms.
[08:25:53.319] <TB3> INFO: Expecting 2560 events.
[08:25:54.173] <TB3> INFO: 2560 events read in total (297ms).
[08:25:54.173] <TB3> INFO: Test took 1160ms.
[08:25:54.480] <TB3> INFO: Expecting 2560 events.
[08:25:55.334] <TB3> INFO: 2560 events read in total (297ms).
[08:25:55.334] <TB3> INFO: Test took 1160ms.
[08:25:55.641] <TB3> INFO: Expecting 2560 events.
[08:25:56.495] <TB3> INFO: 2560 events read in total (297ms).
[08:25:56.495] <TB3> INFO: Test took 1160ms.
[08:25:56.802] <TB3> INFO: Expecting 2560 events.
[08:25:57.657] <TB3> INFO: 2560 events read in total (298ms).
[08:25:57.657] <TB3> INFO: Test took 1161ms.
[08:25:57.964] <TB3> INFO: Expecting 2560 events.
[08:25:58.819] <TB3> INFO: 2560 events read in total (298ms).
[08:25:58.819] <TB3> INFO: Test took 1161ms.
[08:25:59.126] <TB3> INFO: Expecting 2560 events.
[08:25:59.980] <TB3> INFO: 2560 events read in total (297ms).
[08:25:59.980] <TB3> INFO: Test took 1160ms.
[08:26:00.286] <TB3> INFO: Expecting 2560 events.
[08:26:01.141] <TB3> INFO: 2560 events read in total (298ms).
[08:26:01.141] <TB3> INFO: Test took 1161ms.
[08:26:01.447] <TB3> INFO: Expecting 2560 events.
[08:26:02.302] <TB3> INFO: 2560 events read in total (298ms).
[08:26:02.302] <TB3> INFO: Test took 1161ms.
[08:26:02.609] <TB3> INFO: Expecting 2560 events.
[08:26:03.462] <TB3> INFO: 2560 events read in total (297ms).
[08:26:03.463] <TB3> INFO: Test took 1160ms.
[08:26:03.770] <TB3> INFO: Expecting 2560 events.
[08:26:04.623] <TB3> INFO: 2560 events read in total (297ms).
[08:26:04.624] <TB3> INFO: Test took 1161ms.
[08:26:04.930] <TB3> INFO: Expecting 2560 events.
[08:26:05.784] <TB3> INFO: 2560 events read in total (297ms).
[08:26:05.785] <TB3> INFO: Test took 1161ms.
[08:26:05.789] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:26:06.092] <TB3> INFO: Expecting 655360 events.
[08:26:22.545] <TB3> INFO: 655360 events read in total (15896ms).
[08:26:22.554] <TB3> INFO: Expecting 655360 events.
[08:26:38.913] <TB3> INFO: 655360 events read in total (15956ms).
[08:26:38.925] <TB3> INFO: Expecting 655360 events.
[08:26:55.361] <TB3> INFO: 655360 events read in total (16033ms).
[08:26:55.376] <TB3> INFO: Expecting 655360 events.
[08:27:11.781] <TB3> INFO: 655360 events read in total (16002ms).
[08:27:11.799] <TB3> INFO: Expecting 655360 events.
[08:27:28.265] <TB3> INFO: 655360 events read in total (16063ms).
[08:27:28.287] <TB3> INFO: Expecting 655360 events.
[08:27:44.685] <TB3> INFO: 655360 events read in total (15996ms).
[08:27:44.710] <TB3> INFO: Expecting 655360 events.
[08:28:01.101] <TB3> INFO: 655360 events read in total (15989ms).
[08:28:01.130] <TB3> INFO: Expecting 655360 events.
[08:28:17.502] <TB3> INFO: 655360 events read in total (15969ms).
[08:28:17.535] <TB3> INFO: Expecting 655360 events.
[08:28:33.932] <TB3> INFO: 655360 events read in total (15994ms).
[08:28:33.967] <TB3> INFO: Expecting 655360 events.
[08:28:50.400] <TB3> INFO: 655360 events read in total (16030ms).
[08:28:50.439] <TB3> INFO: Expecting 655360 events.
[08:29:06.885] <TB3> INFO: 655360 events read in total (16043ms).
[08:29:06.925] <TB3> INFO: Expecting 655360 events.
[08:29:23.277] <TB3> INFO: 655360 events read in total (15949ms).
[08:29:23.322] <TB3> INFO: Expecting 655360 events.
[08:29:39.781] <TB3> INFO: 655360 events read in total (16056ms).
[08:29:39.830] <TB3> INFO: Expecting 655360 events.
[08:29:56.189] <TB3> INFO: 655360 events read in total (15957ms).
[08:29:56.241] <TB3> INFO: Expecting 655360 events.
[08:30:12.606] <TB3> INFO: 655360 events read in total (15963ms).
[08:30:12.660] <TB3> INFO: Expecting 655360 events.
[08:30:29.066] <TB3> INFO: 655360 events read in total (16003ms).
[08:30:29.128] <TB3> INFO: Test took 263339ms.
[08:30:29.206] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:30:29.435] <TB3> INFO: Expecting 655360 events.
[08:30:45.985] <TB3> INFO: 655360 events read in total (15993ms).
[08:30:45.994] <TB3> INFO: Expecting 655360 events.
[08:31:02.371] <TB3> INFO: 655360 events read in total (15974ms).
[08:31:02.384] <TB3> INFO: Expecting 655360 events.
[08:31:18.752] <TB3> INFO: 655360 events read in total (15965ms).
[08:31:18.768] <TB3> INFO: Expecting 655360 events.
[08:31:35.135] <TB3> INFO: 655360 events read in total (15965ms).
[08:31:35.153] <TB3> INFO: Expecting 655360 events.
[08:31:51.582] <TB3> INFO: 655360 events read in total (16026ms).
[08:31:51.604] <TB3> INFO: Expecting 655360 events.
[08:32:07.972] <TB3> INFO: 655360 events read in total (15965ms).
[08:32:07.997] <TB3> INFO: Expecting 655360 events.
[08:32:24.366] <TB3> INFO: 655360 events read in total (15966ms).
[08:32:24.395] <TB3> INFO: Expecting 655360 events.
[08:32:40.792] <TB3> INFO: 655360 events read in total (15995ms).
[08:32:40.825] <TB3> INFO: Expecting 655360 events.
[08:32:57.185] <TB3> INFO: 655360 events read in total (15957ms).
[08:32:57.220] <TB3> INFO: Expecting 655360 events.
[08:33:13.568] <TB3> INFO: 655360 events read in total (15946ms).
[08:33:13.606] <TB3> INFO: Expecting 655360 events.
[08:33:29.904] <TB3> INFO: 655360 events read in total (15895ms).
[08:33:29.945] <TB3> INFO: Expecting 655360 events.
[08:33:46.261] <TB3> INFO: 655360 events read in total (15914ms).
[08:33:46.304] <TB3> INFO: Expecting 655360 events.
[08:34:02.647] <TB3> INFO: 655360 events read in total (15941ms).
[08:34:02.694] <TB3> INFO: Expecting 655360 events.
[08:34:18.951] <TB3> INFO: 655360 events read in total (15854ms).
[08:34:19.006] <TB3> INFO: Expecting 655360 events.
[08:34:35.406] <TB3> INFO: 655360 events read in total (15997ms).
[08:34:35.461] <TB3> INFO: Expecting 655360 events.
[08:34:51.879] <TB3> INFO: 655360 events read in total (16016ms).
[08:34:51.936] <TB3> INFO: Test took 262730ms.
[08:34:52.113] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.120] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.126] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.133] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.139] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.146] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.152] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.159] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.165] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:34:52.172] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:34:52.178] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:34:52.185] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.191] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.198] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.204] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:34:52.210] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:34:52.217] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:34:52.223] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:34:52.230] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:34:52.236] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.243] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.249] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:34:52.256] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:34:52.262] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:34:52.269] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.275] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.281] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:34:52.288] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:34:52.355] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C0.dat
[08:34:52.360] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C1.dat
[08:34:52.367] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C2.dat
[08:34:52.373] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C3.dat
[08:34:52.378] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C4.dat
[08:34:52.384] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C5.dat
[08:34:52.390] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C6.dat
[08:34:52.395] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C7.dat
[08:34:52.400] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C8.dat
[08:34:52.405] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C9.dat
[08:34:52.410] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C10.dat
[08:34:52.415] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C11.dat
[08:34:52.421] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C12.dat
[08:34:52.426] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C13.dat
[08:34:52.431] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C14.dat
[08:34:52.438] <TB3> INFO: write dac parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//dacParameters35_C15.dat
[08:34:52.703] <TB3> INFO: Expecting 41600 events.
[08:34:56.155] <TB3> INFO: 41600 events read in total (2895ms).
[08:34:56.155] <TB3> INFO: Test took 3710ms.
[08:34:56.602] <TB3> INFO: Expecting 41600 events.
[08:35:00.067] <TB3> INFO: 41600 events read in total (2908ms).
[08:35:00.068] <TB3> INFO: Test took 3724ms.
[08:35:00.511] <TB3> INFO: Expecting 41600 events.
[08:35:03.942] <TB3> INFO: 41600 events read in total (2874ms).
[08:35:03.943] <TB3> INFO: Test took 3687ms.
[08:35:04.134] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:04.224] <TB3> INFO: Expecting 2560 events.
[08:35:05.078] <TB3> INFO: 2560 events read in total (297ms).
[08:35:05.078] <TB3> INFO: Test took 944ms.
[08:35:05.081] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:05.385] <TB3> INFO: Expecting 2560 events.
[08:35:06.239] <TB3> INFO: 2560 events read in total (297ms).
[08:35:06.239] <TB3> INFO: Test took 1158ms.
[08:35:06.242] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:06.546] <TB3> INFO: Expecting 2560 events.
[08:35:07.400] <TB3> INFO: 2560 events read in total (297ms).
[08:35:07.400] <TB3> INFO: Test took 1158ms.
[08:35:07.403] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:07.707] <TB3> INFO: Expecting 2560 events.
[08:35:08.561] <TB3> INFO: 2560 events read in total (297ms).
[08:35:08.561] <TB3> INFO: Test took 1158ms.
[08:35:08.563] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:08.868] <TB3> INFO: Expecting 2560 events.
[08:35:09.722] <TB3> INFO: 2560 events read in total (297ms).
[08:35:09.722] <TB3> INFO: Test took 1159ms.
[08:35:09.724] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:10.029] <TB3> INFO: Expecting 2560 events.
[08:35:10.883] <TB3> INFO: 2560 events read in total (297ms).
[08:35:10.883] <TB3> INFO: Test took 1159ms.
[08:35:10.886] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:11.190] <TB3> INFO: Expecting 2560 events.
[08:35:12.044] <TB3> INFO: 2560 events read in total (297ms).
[08:35:12.044] <TB3> INFO: Test took 1158ms.
[08:35:12.046] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:12.351] <TB3> INFO: Expecting 2560 events.
[08:35:13.205] <TB3> INFO: 2560 events read in total (297ms).
[08:35:13.205] <TB3> INFO: Test took 1159ms.
[08:35:13.210] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:13.513] <TB3> INFO: Expecting 2560 events.
[08:35:14.367] <TB3> INFO: 2560 events read in total (297ms).
[08:35:14.367] <TB3> INFO: Test took 1158ms.
[08:35:14.371] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:14.675] <TB3> INFO: Expecting 2560 events.
[08:35:15.529] <TB3> INFO: 2560 events read in total (297ms).
[08:35:15.529] <TB3> INFO: Test took 1158ms.
[08:35:15.533] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:15.836] <TB3> INFO: Expecting 2560 events.
[08:35:16.691] <TB3> INFO: 2560 events read in total (298ms).
[08:35:16.691] <TB3> INFO: Test took 1158ms.
[08:35:16.694] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:16.999] <TB3> INFO: Expecting 2560 events.
[08:35:17.853] <TB3> INFO: 2560 events read in total (297ms).
[08:35:17.853] <TB3> INFO: Test took 1160ms.
[08:35:17.855] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:18.160] <TB3> INFO: Expecting 2560 events.
[08:35:19.015] <TB3> INFO: 2560 events read in total (298ms).
[08:35:19.015] <TB3> INFO: Test took 1160ms.
[08:35:19.018] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:19.322] <TB3> INFO: Expecting 2560 events.
[08:35:20.177] <TB3> INFO: 2560 events read in total (297ms).
[08:35:20.177] <TB3> INFO: Test took 1159ms.
[08:35:20.181] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:20.484] <TB3> INFO: Expecting 2560 events.
[08:35:21.339] <TB3> INFO: 2560 events read in total (298ms).
[08:35:21.339] <TB3> INFO: Test took 1158ms.
[08:35:21.343] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:21.646] <TB3> INFO: Expecting 2560 events.
[08:35:22.500] <TB3> INFO: 2560 events read in total (297ms).
[08:35:22.501] <TB3> INFO: Test took 1158ms.
[08:35:22.505] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:22.808] <TB3> INFO: Expecting 2560 events.
[08:35:23.662] <TB3> INFO: 2560 events read in total (297ms).
[08:35:23.662] <TB3> INFO: Test took 1158ms.
[08:35:23.665] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:23.970] <TB3> INFO: Expecting 2560 events.
[08:35:24.824] <TB3> INFO: 2560 events read in total (297ms).
[08:35:24.824] <TB3> INFO: Test took 1159ms.
[08:35:24.829] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:25.132] <TB3> INFO: Expecting 2560 events.
[08:35:25.986] <TB3> INFO: 2560 events read in total (297ms).
[08:35:25.987] <TB3> INFO: Test took 1158ms.
[08:35:25.990] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:26.294] <TB3> INFO: Expecting 2560 events.
[08:35:27.148] <TB3> INFO: 2560 events read in total (297ms).
[08:35:27.148] <TB3> INFO: Test took 1158ms.
[08:35:27.151] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:27.456] <TB3> INFO: Expecting 2560 events.
[08:35:28.310] <TB3> INFO: 2560 events read in total (297ms).
[08:35:28.310] <TB3> INFO: Test took 1159ms.
[08:35:28.314] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:28.617] <TB3> INFO: Expecting 2560 events.
[08:35:29.471] <TB3> INFO: 2560 events read in total (297ms).
[08:35:29.471] <TB3> INFO: Test took 1157ms.
[08:35:29.474] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:29.778] <TB3> INFO: Expecting 2560 events.
[08:35:30.632] <TB3> INFO: 2560 events read in total (297ms).
[08:35:30.632] <TB3> INFO: Test took 1158ms.
[08:35:30.635] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:30.939] <TB3> INFO: Expecting 2560 events.
[08:35:31.793] <TB3> INFO: 2560 events read in total (297ms).
[08:35:31.793] <TB3> INFO: Test took 1159ms.
[08:35:31.796] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:32.100] <TB3> INFO: Expecting 2560 events.
[08:35:32.954] <TB3> INFO: 2560 events read in total (297ms).
[08:35:32.954] <TB3> INFO: Test took 1158ms.
[08:35:32.957] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:33.261] <TB3> INFO: Expecting 2560 events.
[08:35:34.116] <TB3> INFO: 2560 events read in total (298ms).
[08:35:34.116] <TB3> INFO: Test took 1159ms.
[08:35:34.119] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:34.423] <TB3> INFO: Expecting 2560 events.
[08:35:35.277] <TB3> INFO: 2560 events read in total (297ms).
[08:35:35.277] <TB3> INFO: Test took 1158ms.
[08:35:35.279] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:35.584] <TB3> INFO: Expecting 2560 events.
[08:35:36.438] <TB3> INFO: 2560 events read in total (297ms).
[08:35:36.438] <TB3> INFO: Test took 1159ms.
[08:35:36.440] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:36.745] <TB3> INFO: Expecting 2560 events.
[08:35:37.598] <TB3> INFO: 2560 events read in total (297ms).
[08:35:37.599] <TB3> INFO: Test took 1159ms.
[08:35:37.601] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:37.906] <TB3> INFO: Expecting 2560 events.
[08:35:38.759] <TB3> INFO: 2560 events read in total (296ms).
[08:35:38.760] <TB3> INFO: Test took 1159ms.
[08:35:38.762] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:39.067] <TB3> INFO: Expecting 2560 events.
[08:35:39.920] <TB3> INFO: 2560 events read in total (297ms).
[08:35:39.921] <TB3> INFO: Test took 1159ms.
[08:35:39.923] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:35:40.228] <TB3> INFO: Expecting 2560 events.
[08:35:41.083] <TB3> INFO: 2560 events read in total (298ms).
[08:35:41.083] <TB3> INFO: Test took 1160ms.
[08:35:41.577] <TB3> INFO: PixTestPhOptimization::doTest() done, duration: 606 seconds
[08:35:41.577] <TB3> INFO: PH scale (per ROC): 78 76 79 76 80 73 82 80 87 80 89 92 96 80 84 79
[08:35:41.577] <TB3> INFO: PH offset (per ROC): 163 154 156 159 169 167 144 154 159 172 144 148 144 175 171 155
[08:35:41.580] <TB3> INFO: Decoding statistics:
[08:35:41.581] <TB3> INFO: General information:
[08:35:41.581] <TB3> INFO: 16bit words read: 91920
[08:35:41.581] <TB3> INFO: valid events total: 10240
[08:35:41.581] <TB3> INFO: empty events: 7740
[08:35:41.581] <TB3> INFO: valid events with pixels: 2500
[08:35:41.581] <TB3> INFO: valid pixel hits: 2500
[08:35:41.581] <TB3> INFO: Event errors: 0
[08:35:41.581] <TB3> INFO: start marker: 0
[08:35:41.581] <TB3> INFO: stop marker: 0
[08:35:41.581] <TB3> INFO: overflow: 0
[08:35:41.581] <TB3> INFO: invalid 5bit words: 0
[08:35:41.581] <TB3> INFO: invalid XOR eye diagram: 0
[08:35:41.581] <TB3> INFO: frame (failed synchr.): 0
[08:35:41.581] <TB3> INFO: idle data (no TBM trl): 0
[08:35:41.581] <TB3> INFO: no data (only TBM hdr): 0
[08:35:41.581] <TB3> INFO: TBM errors: 0
[08:35:41.581] <TB3> INFO: flawed TBM headers: 0
[08:35:41.581] <TB3> INFO: flawed TBM trailers: 0
[08:35:41.581] <TB3> INFO: event ID mismatches: 0
[08:35:41.581] <TB3> INFO: ROC errors: 0
[08:35:41.581] <TB3> INFO: missing ROC header(s): 0
[08:35:41.581] <TB3> INFO: misplaced readback start: 0
[08:35:41.581] <TB3> INFO: Pixel decoding errors: 0
[08:35:41.581] <TB3> INFO: pixel data incomplete: 0
[08:35:41.581] <TB3> INFO: pixel address: 0
[08:35:41.581] <TB3> INFO: pulse height fill bit: 0
[08:35:41.581] <TB3> INFO: buffer corruption: 0
[08:35:41.742] <TB3> INFO: ######################################################################
[08:35:41.742] <TB3> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[08:35:41.742] <TB3> INFO: ######################################################################
[08:35:41.752] <TB3> INFO: scanning low vcal = 10
[08:35:42.006] <TB3> INFO: Expecting 41600 events.
[08:35:45.523] <TB3> INFO: 41600 events read in total (2960ms).
[08:35:45.523] <TB3> INFO: Test took 3771ms.
[08:35:45.525] <TB3> INFO: scanning low vcal = 20
[08:35:45.830] <TB3> INFO: Expecting 41600 events.
[08:35:49.361] <TB3> INFO: 41600 events read in total (2974ms).
[08:35:49.361] <TB3> INFO: Test took 3835ms.
[08:35:49.364] <TB3> INFO: scanning low vcal = 30
[08:35:49.668] <TB3> INFO: Expecting 41600 events.
[08:35:53.201] <TB3> INFO: 41600 events read in total (2976ms).
[08:35:53.201] <TB3> INFO: Test took 3837ms.
[08:35:53.204] <TB3> INFO: scanning low vcal = 40
[08:35:53.504] <TB3> INFO: Expecting 41600 events.
[08:35:57.593] <TB3> INFO: 41600 events read in total (3532ms).
[08:35:57.594] <TB3> INFO: Test took 4390ms.
[08:35:57.597] <TB3> INFO: scanning low vcal = 50
[08:35:57.853] <TB3> INFO: Expecting 41600 events.
[08:36:02.005] <TB3> INFO: 41600 events read in total (3595ms).
[08:36:02.006] <TB3> INFO: Test took 4408ms.
[08:36:02.009] <TB3> INFO: scanning low vcal = 60
[08:36:02.263] <TB3> INFO: Expecting 41600 events.
[08:36:06.417] <TB3> INFO: 41600 events read in total (3597ms).
[08:36:06.417] <TB3> INFO: Test took 4408ms.
[08:36:06.421] <TB3> INFO: scanning low vcal = 70
[08:36:06.675] <TB3> INFO: Expecting 41600 events.
[08:36:10.827] <TB3> INFO: 41600 events read in total (3595ms).
[08:36:10.828] <TB3> INFO: Test took 4407ms.
[08:36:10.832] <TB3> INFO: scanning low vcal = 80
[08:36:11.087] <TB3> INFO: Expecting 41600 events.
[08:36:15.238] <TB3> INFO: 41600 events read in total (3594ms).
[08:36:15.239] <TB3> INFO: Test took 4407ms.
[08:36:15.242] <TB3> INFO: scanning low vcal = 90
[08:36:15.495] <TB3> INFO: Expecting 41600 events.
[08:36:19.648] <TB3> INFO: 41600 events read in total (3596ms).
[08:36:19.648] <TB3> INFO: Test took 4406ms.
[08:36:19.652] <TB3> INFO: scanning low vcal = 100
[08:36:19.905] <TB3> INFO: Expecting 41600 events.
[08:36:24.055] <TB3> INFO: 41600 events read in total (3593ms).
[08:36:24.056] <TB3> INFO: Test took 4404ms.
[08:36:24.060] <TB3> INFO: scanning low vcal = 110
[08:36:24.315] <TB3> INFO: Expecting 41600 events.
[08:36:28.477] <TB3> INFO: 41600 events read in total (3605ms).
[08:36:28.478] <TB3> INFO: Test took 4418ms.
[08:36:28.482] <TB3> INFO: scanning low vcal = 120
[08:36:28.738] <TB3> INFO: Expecting 41600 events.
[08:36:32.895] <TB3> INFO: 41600 events read in total (3600ms).
[08:36:32.896] <TB3> INFO: Test took 4414ms.
[08:36:32.899] <TB3> INFO: scanning low vcal = 130
[08:36:33.155] <TB3> INFO: Expecting 41600 events.
[08:36:37.305] <TB3> INFO: 41600 events read in total (3593ms).
[08:36:37.306] <TB3> INFO: Test took 4407ms.
[08:36:37.309] <TB3> INFO: scanning low vcal = 140
[08:36:37.562] <TB3> INFO: Expecting 41600 events.
[08:36:41.714] <TB3> INFO: 41600 events read in total (3595ms).
[08:36:41.714] <TB3> INFO: Test took 4405ms.
[08:36:41.718] <TB3> INFO: scanning low vcal = 150
[08:36:41.971] <TB3> INFO: Expecting 41600 events.
[08:36:46.121] <TB3> INFO: 41600 events read in total (3593ms).
[08:36:46.122] <TB3> INFO: Test took 4404ms.
[08:36:46.127] <TB3> INFO: scanning low vcal = 160
[08:36:46.383] <TB3> INFO: Expecting 41600 events.
[08:36:50.543] <TB3> INFO: 41600 events read in total (3603ms).
[08:36:50.544] <TB3> INFO: Test took 4417ms.
[08:36:50.547] <TB3> INFO: scanning low vcal = 170
[08:36:50.803] <TB3> INFO: Expecting 41600 events.
[08:36:54.953] <TB3> INFO: 41600 events read in total (3593ms).
[08:36:54.953] <TB3> INFO: Test took 4405ms.
[08:36:54.958] <TB3> INFO: scanning low vcal = 180
[08:36:55.212] <TB3> INFO: Expecting 41600 events.
[08:36:59.361] <TB3> INFO: 41600 events read in total (3592ms).
[08:36:59.362] <TB3> INFO: Test took 4404ms.
[08:36:59.366] <TB3> INFO: scanning low vcal = 190
[08:36:59.623] <TB3> INFO: Expecting 41600 events.
[08:37:03.785] <TB3> INFO: 41600 events read in total (3605ms).
[08:37:03.786] <TB3> INFO: Test took 4419ms.
[08:37:03.789] <TB3> INFO: scanning low vcal = 200
[08:37:04.045] <TB3> INFO: Expecting 41600 events.
[08:37:08.194] <TB3> INFO: 41600 events read in total (3592ms).
[08:37:08.195] <TB3> INFO: Test took 4406ms.
[08:37:08.199] <TB3> INFO: scanning low vcal = 210
[08:37:08.455] <TB3> INFO: Expecting 41600 events.
[08:37:12.612] <TB3> INFO: 41600 events read in total (3600ms).
[08:37:12.612] <TB3> INFO: Test took 4413ms.
[08:37:12.615] <TB3> INFO: scanning low vcal = 220
[08:37:12.873] <TB3> INFO: Expecting 41600 events.
[08:37:17.025] <TB3> INFO: 41600 events read in total (3595ms).
[08:37:17.026] <TB3> INFO: Test took 4410ms.
[08:37:17.029] <TB3> INFO: scanning low vcal = 230
[08:37:17.285] <TB3> INFO: Expecting 41600 events.
[08:37:21.438] <TB3> INFO: 41600 events read in total (3596ms).
[08:37:21.439] <TB3> INFO: Test took 4410ms.
[08:37:21.442] <TB3> INFO: scanning low vcal = 240
[08:37:21.698] <TB3> INFO: Expecting 41600 events.
[08:37:25.847] <TB3> INFO: 41600 events read in total (3592ms).
[08:37:25.848] <TB3> INFO: Test took 4405ms.
[08:37:25.851] <TB3> INFO: scanning low vcal = 250
[08:37:26.104] <TB3> INFO: Expecting 41600 events.
[08:37:30.256] <TB3> INFO: 41600 events read in total (3595ms).
[08:37:30.257] <TB3> INFO: Test took 4406ms.
[08:37:30.262] <TB3> INFO: scanning high vcal = 30 (= 210 in low range)
[08:37:30.518] <TB3> INFO: Expecting 41600 events.
[08:37:34.674] <TB3> INFO: 41600 events read in total (3599ms).
[08:37:34.675] <TB3> INFO: Test took 4413ms.
[08:37:34.678] <TB3> INFO: scanning high vcal = 50 (= 350 in low range)
[08:37:34.935] <TB3> INFO: Expecting 41600 events.
[08:37:39.101] <TB3> INFO: 41600 events read in total (3609ms).
[08:37:39.102] <TB3> INFO: Test took 4424ms.
[08:37:39.105] <TB3> INFO: scanning high vcal = 70 (= 490 in low range)
[08:37:39.361] <TB3> INFO: Expecting 41600 events.
[08:37:43.525] <TB3> INFO: 41600 events read in total (3607ms).
[08:37:43.526] <TB3> INFO: Test took 4421ms.
[08:37:43.530] <TB3> INFO: scanning high vcal = 90 (= 630 in low range)
[08:37:43.787] <TB3> INFO: Expecting 41600 events.
[08:37:47.945] <TB3> INFO: 41600 events read in total (3601ms).
[08:37:47.946] <TB3> INFO: Test took 4416ms.
[08:37:47.949] <TB3> INFO: scanning high vcal = 200 (= 1400 in low range)
[08:37:48.205] <TB3> INFO: Expecting 41600 events.
[08:37:52.357] <TB3> INFO: 41600 events read in total (3595ms).
[08:37:52.358] <TB3> INFO: Test took 4409ms.
[08:37:53.438] <TB3> INFO: PixTestGainPedestal::measure() done
[08:38:23.595] <TB3> INFO: PixTestGainPedestal::fit() done
[08:38:23.595] <TB3> INFO: non-linearity mean: 0.959 0.959 0.955 0.954 0.957 0.954 0.952 0.963 0.950 0.949 0.959 0.951 0.955 0.947 0.947 0.959
[08:38:23.595] <TB3> INFO: non-linearity RMS: 0.004 0.005 0.006 0.006 0.004 0.007 0.007 0.004 0.006 0.007 0.004 0.007 0.005 0.006 0.008 0.005
[08:38:23.596] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C0.dat
[08:38:23.636] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C1.dat
[08:38:23.673] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C2.dat
[08:38:23.710] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C3.dat
[08:38:23.747] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C4.dat
[08:38:23.791] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C5.dat
[08:38:23.826] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C6.dat
[08:38:23.863] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C7.dat
[08:38:23.899] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C8.dat
[08:38:23.936] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C9.dat
[08:38:23.972] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C10.dat
[08:38:24.008] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C11.dat
[08:38:24.045] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C12.dat
[08:38:24.082] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C13.dat
[08:38:24.118] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C14.dat
[08:38:24.155] <TB3> INFO: write gain/ped parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//phCalibrationFitErr35_C15.dat
[08:38:24.191] <TB3> INFO: PixTestGainPedestal::fullTest() done, duration: 162 seconds
[08:38:24.191] <TB3> INFO: Decoding statistics:
[08:38:24.191] <TB3> INFO: General information:
[08:38:24.191] <TB3> INFO: 16bit words read: 2662400
[08:38:24.191] <TB3> INFO: valid events total: 166400
[08:38:24.191] <TB3> INFO: empty events: 0
[08:38:24.191] <TB3> INFO: valid events with pixels: 166400
[08:38:24.191] <TB3> INFO: valid pixel hits: 665600
[08:38:24.191] <TB3> INFO: Event errors: 0
[08:38:24.191] <TB3> INFO: start marker: 0
[08:38:24.191] <TB3> INFO: stop marker: 0
[08:38:24.191] <TB3> INFO: overflow: 0
[08:38:24.191] <TB3> INFO: invalid 5bit words: 0
[08:38:24.191] <TB3> INFO: invalid XOR eye diagram: 0
[08:38:24.191] <TB3> INFO: frame (failed synchr.): 0
[08:38:24.191] <TB3> INFO: idle data (no TBM trl): 0
[08:38:24.191] <TB3> INFO: no data (only TBM hdr): 0
[08:38:24.191] <TB3> INFO: TBM errors: 0
[08:38:24.191] <TB3> INFO: flawed TBM headers: 0
[08:38:24.191] <TB3> INFO: flawed TBM trailers: 0
[08:38:24.191] <TB3> INFO: event ID mismatches: 0
[08:38:24.191] <TB3> INFO: ROC errors: 0
[08:38:24.191] <TB3> INFO: missing ROC header(s): 0
[08:38:24.191] <TB3> INFO: misplaced readback start: 0
[08:38:24.191] <TB3> INFO: Pixel decoding errors: 0
[08:38:24.191] <TB3> INFO: pixel data incomplete: 0
[08:38:24.191] <TB3> INFO: pixel address: 0
[08:38:24.191] <TB3> INFO: pulse height fill bit: 0
[08:38:24.191] <TB3> INFO: buffer corruption: 0
[08:38:24.199] <TB3> INFO: readReadbackCal: /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C0.dat .. /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C15.dat
[08:38:24.288] <TB3> INFO: ######################################################################
[08:38:24.288] <TB3> INFO: PixTestReadback::doTest()
[08:38:24.288] <TB3> INFO: ######################################################################
[08:38:24.288] <TB3> INFO: ----------------------------------------------------------------------
[08:38:24.288] <TB3> INFO: PixTestReadback::CalibrateVd()
[08:38:24.288] <TB3> INFO: ----------------------------------------------------------------------
[08:38:33.828] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C0.dat
[08:38:33.833] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C1.dat
[08:38:33.838] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C2.dat
[08:38:33.843] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C3.dat
[08:38:33.848] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C4.dat
[08:38:33.853] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C5.dat
[08:38:33.864] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C6.dat
[08:38:33.869] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C7.dat
[08:38:33.874] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C8.dat
[08:38:33.879] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C9.dat
[08:38:33.885] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C10.dat
[08:38:33.890] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C11.dat
[08:38:33.896] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C12.dat
[08:38:33.901] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C13.dat
[08:38:33.906] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C14.dat
[08:38:33.911] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C15.dat
[08:38:33.959] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[08:38:33.959] <TB3> INFO: ----------------------------------------------------------------------
[08:38:33.959] <TB3> INFO: PixTestReadback::CalibrateVa()
[08:38:33.959] <TB3> INFO: ----------------------------------------------------------------------
[08:38:43.639] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C0.dat
[08:38:43.648] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C1.dat
[08:38:43.653] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C2.dat
[08:38:43.658] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C3.dat
[08:38:43.664] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C4.dat
[08:38:43.670] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C5.dat
[08:38:43.676] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C6.dat
[08:38:43.681] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C7.dat
[08:38:43.686] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C8.dat
[08:38:43.691] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C9.dat
[08:38:43.696] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C10.dat
[08:38:43.703] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C11.dat
[08:38:43.708] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C12.dat
[08:38:43.714] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C13.dat
[08:38:43.719] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C14.dat
[08:38:43.724] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C15.dat
[08:38:43.772] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[08:38:43.772] <TB3> INFO: ----------------------------------------------------------------------
[08:38:43.772] <TB3> INFO: PixTestReadback::readbackVbg()
[08:38:43.772] <TB3> INFO: ----------------------------------------------------------------------
[08:38:51.132] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[08:38:51.135] <TB3> INFO: ----------------------------------------------------------------------
[08:38:51.135] <TB3> INFO: PixTestReadback::getCalibratedVbg()
[08:38:51.135] <TB3> INFO: ----------------------------------------------------------------------
[08:38:51.135] <TB3> INFO: Vbg will be calibrated using Vd calibration
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 151.6calibrated Vbg = 1.23716 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 155.2calibrated Vbg = 1.23751 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 150.5calibrated Vbg = 1.24689 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 148calibrated Vbg = 1.25872 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 156calibrated Vbg = 1.25894 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 154.2calibrated Vbg = 1.26215 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 156.1calibrated Vbg = 1.26102 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 157.3calibrated Vbg = 1.26182 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 161.7calibrated Vbg = 1.25853 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 160.1calibrated Vbg = 1.26193 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 143.9calibrated Vbg = 1.25176 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152.9calibrated Vbg = 1.25344 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 154.6calibrated Vbg = 1.24335 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 161.6calibrated Vbg = 1.24189 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 153.5calibrated Vbg = 1.24817 :::*/*/*/*/
[08:38:51.135] <TB3> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 158.9calibrated Vbg = 1.24315 :::*/*/*/*/
[08:38:51.137] <TB3> INFO: ----------------------------------------------------------------------
[08:38:51.137] <TB3> INFO: PixTestReadback::CalibrateIa()
[08:38:51.137] <TB3> INFO: ----------------------------------------------------------------------
[08:41:27.116] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C0.dat
[08:41:27.122] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C1.dat
[08:41:27.127] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C2.dat
[08:41:27.132] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C3.dat
[08:41:27.138] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C4.dat
[08:41:27.144] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C5.dat
[08:41:27.149] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C6.dat
[08:41:27.154] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C7.dat
[08:41:27.159] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C8.dat
[08:41:27.164] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C9.dat
[08:41:27.169] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C10.dat
[08:41:27.174] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C11.dat
[08:41:27.179] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C12.dat
[08:41:27.184] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C13.dat
[08:41:27.190] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C14.dat
[08:41:27.195] <TB3> INFO: write readback calibration parameters into /home/Reception/FullQualification/M2244_FullQualification_2016-06-09_09h08m_1465456087//001_FulltestPxar_m20//readbackCal_C15.dat
[08:41:27.242] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[08:41:27.243] <TB3> INFO: PixTestReadback::doTest() done
[08:41:27.243] <TB3> INFO: Decoding statistics:
[08:41:27.243] <TB3> INFO: General information:
[08:41:27.243] <TB3> INFO: 16bit words read: 1024
[08:41:27.243] <TB3> INFO: valid events total: 128
[08:41:27.243] <TB3> INFO: empty events: 128
[08:41:27.243] <TB3> INFO: valid events with pixels: 0
[08:41:27.243] <TB3> INFO: valid pixel hits: 0
[08:41:27.243] <TB3> INFO: Event errors: 0
[08:41:27.243] <TB3> INFO: start marker: 0
[08:41:27.243] <TB3> INFO: stop marker: 0
[08:41:27.243] <TB3> INFO: overflow: 0
[08:41:27.243] <TB3> INFO: invalid 5bit words: 0
[08:41:27.243] <TB3> INFO: invalid XOR eye diagram: 0
[08:41:27.243] <TB3> INFO: frame (failed synchr.): 0
[08:41:27.243] <TB3> INFO: idle data (no TBM trl): 0
[08:41:27.243] <TB3> INFO: no data (only TBM hdr): 0
[08:41:27.243] <TB3> INFO: TBM errors: 0
[08:41:27.243] <TB3> INFO: flawed TBM headers: 0
[08:41:27.243] <TB3> INFO: flawed TBM trailers: 0
[08:41:27.243] <TB3> INFO: event ID mismatches: 0
[08:41:27.243] <TB3> INFO: ROC errors: 0
[08:41:27.243] <TB3> INFO: missing ROC header(s): 0
[08:41:27.243] <TB3> INFO: misplaced readback start: 0
[08:41:27.243] <TB3> INFO: Pixel decoding errors: 0
[08:41:27.243] <TB3> INFO: pixel data incomplete: 0
[08:41:27.243] <TB3> INFO: pixel address: 0
[08:41:27.243] <TB3> INFO: pulse height fill bit: 0
[08:41:27.243] <TB3> INFO: buffer corruption: 0
[08:41:27.260] <TB3> INFO: Decoding statistics:
[08:41:27.260] <TB3> INFO: General information:
[08:41:27.260] <TB3> INFO: 16bit words read: 2755344
[08:41:27.260] <TB3> INFO: valid events total: 176768
[08:41:27.260] <TB3> INFO: empty events: 7868
[08:41:27.260] <TB3> INFO: valid events with pixels: 168900
[08:41:27.260] <TB3> INFO: valid pixel hits: 668100
[08:41:27.260] <TB3> INFO: Event errors: 0
[08:41:27.260] <TB3> INFO: start marker: 0
[08:41:27.260] <TB3> INFO: stop marker: 0
[08:41:27.260] <TB3> INFO: overflow: 0
[08:41:27.260] <TB3> INFO: invalid 5bit words: 0
[08:41:27.260] <TB3> INFO: invalid XOR eye diagram: 0
[08:41:27.260] <TB3> INFO: frame (failed synchr.): 0
[08:41:27.260] <TB3> INFO: idle data (no TBM trl): 0
[08:41:27.260] <TB3> INFO: no data (only TBM hdr): 0
[08:41:27.260] <TB3> INFO: TBM errors: 0
[08:41:27.260] <TB3> INFO: flawed TBM headers: 0
[08:41:27.260] <TB3> INFO: flawed TBM trailers: 0
[08:41:27.260] <TB3> INFO: event ID mismatches: 0
[08:41:27.260] <TB3> INFO: ROC errors: 0
[08:41:27.260] <TB3> INFO: missing ROC header(s): 0
[08:41:27.260] <TB3> INFO: misplaced readback start: 0
[08:41:27.260] <TB3> INFO: Pixel decoding errors: 0
[08:41:27.260] <TB3> INFO: pixel data incomplete: 0
[08:41:27.260] <TB3> INFO: pixel address: 0
[08:41:27.260] <TB3> INFO: pulse height fill bit: 0
[08:41:27.260] <TB3> INFO: buffer corruption: 0
[08:41:27.260] <TB3> INFO: enter test to run
[08:41:27.260] <TB3> INFO: test: exit no parameter change
[08:41:27.301] <TB3> QUIET: Connection to board 126 closed.
[08:41:27.381] <TB3> INFO: pXar: this is the end, my friend