[06:40:14.830] <TB3> INFO: *** Welcome to pxar ***
[06:40:14.830] <TB3> INFO: *** Today: 2016/11/04
[06:40:14.837] <TB3> INFO: *** Version: c8ba-dirty
[06:40:14.837] <TB3> INFO: readRocDacs: /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C0.dat .. /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C15.dat
[06:40:14.837] <TB3> INFO: readTbmDacs: /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//tbmParameters_C0a.dat .. /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//tbmParameters_C1b.dat
[06:40:14.837] <TB3> INFO: readMaskFile: /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//defaultMaskFile.dat
[06:40:14.837] <TB3> INFO: readTrimFile: /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters_C0.dat .. /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters_C15.dat
[06:40:14.898] <TB3> INFO: clk: 4
[06:40:14.898] <TB3> INFO: ctr: 4
[06:40:14.898] <TB3> INFO: sda: 19
[06:40:14.898] <TB3> INFO: tin: 9
[06:40:14.898] <TB3> INFO: level: 15
[06:40:14.898] <TB3> INFO: triggerdelay: 0
[06:40:14.898] <TB3> QUIET: Instanciating API for pxar v2.7.6+61~g7f4a123
[06:40:14.898] <TB3> INFO: Log level: INFO
[06:40:14.907] <TB3> INFO: Found DTB DTB_WWVASW
[06:40:14.971] <TB3> QUIET: Connection to board DTB_WWVASW opened.
[06:40:14.973] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 126
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWVASW
MAC address: 40D85511807E
Hostname: pixelDTB126
Comment:
------------------------------------------------------
[06:40:14.974] <TB3> INFO: RPC call hashes of host and DTB match: 486171790
[06:40:16.470] <TB3> INFO: DUT info:
[06:40:16.470] <TB3> INFO: The DUT currently contains the following objects:
[06:40:16.470] <TB3> INFO: 4 TBM Cores tbm10c (4 ON)
[06:40:16.470] <TB3> INFO: TBM Core alpha (0): 7 registers set
[06:40:16.470] <TB3> INFO: TBM Core beta (1): 7 registers set
[06:40:16.470] <TB3> INFO: TBM Core alpha (2): 7 registers set
[06:40:16.470] <TB3> INFO: TBM Core beta (3): 7 registers set
[06:40:16.470] <TB3> INFO: 16 ROCs proc600 (16 ON) with 4160 pixelConfigs
[06:40:16.470] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.470] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[06:40:16.872] <TB3> INFO: enter 'restricted' command line mode
[06:40:16.872] <TB3> INFO: enter test to run
[06:40:16.872] <TB3> INFO: test: pretest no parameter change
[06:40:16.872] <TB3> INFO: running: pretest
[06:40:16.879] <TB3> INFO: ######################################################################
[06:40:16.879] <TB3> INFO: PixTestPretest::doTest()
[06:40:16.879] <TB3> INFO: ######################################################################
[06:40:16.880] <TB3> INFO: ----------------------------------------------------------------------
[06:40:16.880] <TB3> INFO: PixTestPretest::programROC()
[06:40:16.880] <TB3> INFO: ----------------------------------------------------------------------
[06:40:34.896] <TB3> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[06:40:34.896] <TB3> INFO: IA differences per ROC: 23.3 17.7 18.5 16.9 19.3 17.7 21.7 18.5 19.3 17.7 19.3 19.3 20.1 17.7 18.5 18.5
[06:40:34.971] <TB3> INFO: ----------------------------------------------------------------------
[06:40:34.971] <TB3> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[06:40:34.971] <TB3> INFO: ----------------------------------------------------------------------
[06:40:40.972] <TB3> INFO: PixTestPretest::setVana() done, Module Ia 388.3 mA = 24.2687 mA/ROC
[06:40:40.972] <TB3> INFO: i(loss) [mA/ROC]: 20.1 20.9 20.1 20.1 19.3 20.1 19.3 19.3 20.1 20.1 20.1 19.3 20.1 20.1 20.1 19.3
[06:40:41.006] <TB3> INFO: ----------------------------------------------------------------------
[06:40:41.006] <TB3> INFO: PixTestPretest::findTiming()
[06:40:41.006] <TB3> INFO: ----------------------------------------------------------------------
[06:40:41.006] <TB3> INFO: PixTestCmd::init()

[06:41:12.805] <TB3> INFO: TBM phases: 160MHz: 7, 400MHz: 2, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[06:41:12.805] <TB3> INFO: (success/tries = 100/100), width = 3
[06:41:14.302] <TB3> INFO: ----------------------------------------------------------------------
[06:41:14.302] <TB3> INFO: PixTestPretest::findWorkingPixel()
[06:41:14.302] <TB3> INFO: ----------------------------------------------------------------------
[06:41:14.396] <TB3> INFO: Expecting 231680 events.
[06:41:24.335] <TB3> INFO: 231680 events read in total (9348ms).
[06:41:24.345] <TB3> INFO: Test took 10039ms.
[06:41:24.583] <TB3> INFO: Found working pixel in all ROCs: col/row = 12/22
[06:41:24.613] <TB3> INFO: ----------------------------------------------------------------------
[06:41:24.613] <TB3> INFO: PixTestPretest::setVthrCompCalDel()
[06:41:24.613] <TB3> INFO: ----------------------------------------------------------------------
[06:41:24.706] <TB3> INFO: Expecting 231680 events.
[06:41:34.812] <TB3> INFO: 231680 events read in total (9514ms).
[06:41:34.820] <TB3> INFO: Test took 10203ms.
[06:41:35.088] <TB3> INFO: PixTestPretest::setVthrCompCalDel() done
[06:41:35.088] <TB3> INFO: CalDel: 115 91 114 116 113 105 118 108 110 132 104 107 125 108 110 108
[06:41:35.088] <TB3> INFO: VthrComp: 52 52 52 51 51 51 51 52 51 54 51 51 53 53 51 51
[06:41:35.094] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C0.dat
[06:41:35.094] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C1.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C2.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C3.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C4.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C5.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C6.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C7.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C8.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C9.dat
[06:41:35.095] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C10.dat
[06:41:35.096] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C11.dat
[06:41:35.096] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C12.dat
[06:41:35.096] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C13.dat
[06:41:35.096] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C14.dat
[06:41:35.096] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters_C15.dat
[06:41:35.096] <TB3> INFO: write tbm parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//tbmParameters_C0a.dat
[06:41:35.096] <TB3> INFO: write tbm parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//tbmParameters_C0b.dat
[06:41:35.096] <TB3> INFO: write tbm parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//tbmParameters_C1a.dat
[06:41:35.096] <TB3> INFO: write tbm parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//tbmParameters_C1b.dat
[06:41:35.096] <TB3> INFO: PixTestPretest::doTest() done, duration: 78 seconds
[06:41:35.149] <TB3> INFO: enter test to run
[06:41:35.149] <TB3> INFO: test: fulltest no parameter change
[06:41:35.149] <TB3> INFO: running: fulltest
[06:41:35.149] <TB3> INFO: ######################################################################
[06:41:35.149] <TB3> INFO: PixTestFullTest::doTest()
[06:41:35.149] <TB3> INFO: ######################################################################
[06:41:35.150] <TB3> INFO: ######################################################################
[06:41:35.150] <TB3> INFO: PixTestAlive::doTest()
[06:41:35.150] <TB3> INFO: ######################################################################
[06:41:35.151] <TB3> INFO: ----------------------------------------------------------------------
[06:41:35.151] <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)
[06:41:35.151] <TB3> INFO: ----------------------------------------------------------------------
[06:41:35.391] <TB3> INFO: Expecting 41600 events.
[06:41:38.895] <TB3> INFO: 41600 events read in total (2912ms).
[06:41:38.895] <TB3> INFO: Test took 3742ms.
[06:41:39.133] <TB3> INFO: PixTestAlive::aliveTest() done
[06:41:39.133] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0
[06:41:39.135] <TB3> INFO: ----------------------------------------------------------------------
[06:41:39.135] <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)
[06:41:39.135] <TB3> INFO: ----------------------------------------------------------------------
[06:41:39.380] <TB3> INFO: Expecting 41600 events.
[06:41:42.405] <TB3> INFO: 41600 events read in total (2433ms).
[06:41:42.405] <TB3> INFO: Test took 3269ms.
[06:41:42.405] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[06:41:42.646] <TB3> INFO: PixTestAlive::maskTest() done
[06:41:42.646] <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
[06:41:42.648] <TB3> INFO: ----------------------------------------------------------------------
[06:41:42.648] <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)
[06:41:42.648] <TB3> INFO: ----------------------------------------------------------------------
[06:41:42.892] <TB3> INFO: Expecting 41600 events.
[06:41:46.522] <TB3> INFO: 41600 events read in total (3038ms).
[06:41:46.523] <TB3> INFO: Test took 3874ms.
[06:41:46.760] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[06:41:46.761] <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
[06:41:46.761] <TB3> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[06:41:46.761] <TB3> INFO: Decoding statistics:
[06:41:46.761] <TB3> INFO: General information:
[06:41:46.761] <TB3> INFO: 16bit words read: 0
[06:41:46.761] <TB3> INFO: valid events total: 0
[06:41:46.761] <TB3> INFO: empty events: 0
[06:41:46.761] <TB3> INFO: valid events with pixels: 0
[06:41:46.761] <TB3> INFO: valid pixel hits: 0
[06:41:46.761] <TB3> INFO: Event errors: 0
[06:41:46.761] <TB3> INFO: start marker: 0
[06:41:46.761] <TB3> INFO: stop marker: 0
[06:41:46.761] <TB3> INFO: overflow: 0
[06:41:46.761] <TB3> INFO: invalid 5bit words: 0
[06:41:46.761] <TB3> INFO: invalid XOR eye diagram: 0
[06:41:46.761] <TB3> INFO: frame (failed synchr.): 0
[06:41:46.761] <TB3> INFO: idle data (no TBM trl): 0
[06:41:46.761] <TB3> INFO: no data (only TBM hdr): 0
[06:41:46.761] <TB3> INFO: TBM errors: 0
[06:41:46.761] <TB3> INFO: flawed TBM headers: 0
[06:41:46.761] <TB3> INFO: flawed TBM trailers: 0
[06:41:46.761] <TB3> INFO: event ID mismatches: 0
[06:41:46.761] <TB3> INFO: ROC errors: 0
[06:41:46.761] <TB3> INFO: missing ROC header(s): 0
[06:41:46.761] <TB3> INFO: misplaced readback start: 0
[06:41:46.761] <TB3> INFO: Pixel decoding errors: 0
[06:41:46.761] <TB3> INFO: pixel data incomplete: 0
[06:41:46.762] <TB3> INFO: pixel address: 0
[06:41:46.762] <TB3> INFO: pulse height fill bit: 0
[06:41:46.762] <TB3> INFO: buffer corruption: 0
[06:41:46.770] <TB3> INFO: readReadbackCal: /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C0.dat .. /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C15.dat
[06:41:46.771] <TB3> INFO: readGainPedestalParameters /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr_C0.dat .. /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr_C15.dat

[06:41:46.771] <TB3> INFO: ######################################################################
[06:41:46.771] <TB3> INFO: PixTestReadback::doTest()
[06:41:46.771] <TB3> INFO: ######################################################################
[06:41:46.771] <TB3> INFO: ----------------------------------------------------------------------
[06:41:46.771] <TB3> INFO: PixTestReadback::CalibrateVd()
[06:41:46.771] <TB3> INFO: ----------------------------------------------------------------------
[06:41:56.756] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C0.dat
[06:41:56.756] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C1.dat
[06:41:56.756] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C2.dat
[06:41:56.756] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C3.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C4.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C5.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C6.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C7.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C8.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C9.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C10.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C11.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C12.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C13.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C14.dat
[06:41:56.757] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C15.dat
[06:41:56.789] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[06:41:56.789] <TB3> INFO: ----------------------------------------------------------------------
[06:41:56.789] <TB3> INFO: PixTestReadback::CalibrateVa()
[06:41:56.789] <TB3> INFO: ----------------------------------------------------------------------
[06:42:06.730] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C0.dat
[06:42:06.730] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C1.dat
[06:42:06.730] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C2.dat
[06:42:06.730] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C3.dat
[06:42:06.730] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C4.dat
[06:42:06.730] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C5.dat
[06:42:06.730] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C6.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C7.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C8.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C9.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C10.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C11.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C12.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C13.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C14.dat
[06:42:06.731] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C15.dat
[06:42:06.764] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[06:42:06.764] <TB3> INFO: ----------------------------------------------------------------------
[06:42:06.764] <TB3> INFO: PixTestReadback::readbackVbg()
[06:42:06.764] <TB3> INFO: ----------------------------------------------------------------------
[06:42:14.441] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[06:42:14.441] <TB3> INFO: ----------------------------------------------------------------------
[06:42:14.441] <TB3> INFO: PixTestReadback::getCalibratedVbg()
[06:42:14.441] <TB3> INFO: ----------------------------------------------------------------------
[06:42:14.441] <TB3> INFO: Vbg will be calibrated using Vd calibration
[06:42:14.441] <TB3> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 149calibrated Vbg = 1.21869 :::*/*/*/*/
[06:42:14.441] <TB3> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 158calibrated Vbg = 1.21487 :::*/*/*/*/
[06:42:14.441] <TB3> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 156.9calibrated Vbg = 1.21745 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 157.9calibrated Vbg = 1.21763 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 156.9calibrated Vbg = 1.22105 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 153.8calibrated Vbg = 1.2251 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 159.2calibrated Vbg = 1.21748 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 159.8calibrated Vbg = 1.22019 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 149.6calibrated Vbg = 1.21727 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 160.7calibrated Vbg = 1.21525 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 149.8calibrated Vbg = 1.2088 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152.4calibrated Vbg = 1.20465 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 153.3calibrated Vbg = 1.21355 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 159calibrated Vbg = 1.21645 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 146.7calibrated Vbg = 1.21253 :::*/*/*/*/
[06:42:14.442] <TB3> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 152.1calibrated Vbg = 1.20999 :::*/*/*/*/
[06:42:14.444] <TB3> INFO: ----------------------------------------------------------------------
[06:42:14.445] <TB3> INFO: PixTestReadback::CalibrateIa()
[06:42:14.445] <TB3> INFO: ----------------------------------------------------------------------
[06:44:55.263] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C0.dat
[06:44:55.263] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C1.dat
[06:44:55.263] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C2.dat
[06:44:55.263] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C3.dat
[06:44:55.263] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C4.dat
[06:44:55.263] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C5.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C6.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C7.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C8.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C9.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C10.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C11.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C12.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C13.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C14.dat
[06:44:55.264] <TB3> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//readbackCal_C15.dat
[06:44:55.290] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[06:44:55.291] <TB3> INFO: PixTestReadback::doTest() done
[06:44:55.292] <TB3> INFO: Decoding statistics:
[06:44:55.292] <TB3> INFO: General information:
[06:44:55.292] <TB3> INFO: 16bit words read: 1536
[06:44:55.292] <TB3> INFO: valid events total: 256
[06:44:55.292] <TB3> INFO: empty events: 256
[06:44:55.292] <TB3> INFO: valid events with pixels: 0
[06:44:55.292] <TB3> INFO: valid pixel hits: 0
[06:44:55.292] <TB3> INFO: Event errors: 0
[06:44:55.292] <TB3> INFO: start marker: 0
[06:44:55.292] <TB3> INFO: stop marker: 0
[06:44:55.292] <TB3> INFO: overflow: 0
[06:44:55.292] <TB3> INFO: invalid 5bit words: 0
[06:44:55.292] <TB3> INFO: invalid XOR eye diagram: 0
[06:44:55.292] <TB3> INFO: frame (failed synchr.): 0
[06:44:55.292] <TB3> INFO: idle data (no TBM trl): 0
[06:44:55.292] <TB3> INFO: no data (only TBM hdr): 0
[06:44:55.292] <TB3> INFO: TBM errors: 0
[06:44:55.292] <TB3> INFO: flawed TBM headers: 0
[06:44:55.292] <TB3> INFO: flawed TBM trailers: 0
[06:44:55.292] <TB3> INFO: event ID mismatches: 0
[06:44:55.292] <TB3> INFO: ROC errors: 0
[06:44:55.292] <TB3> INFO: missing ROC header(s): 0
[06:44:55.292] <TB3> INFO: misplaced readback start: 0
[06:44:55.292] <TB3> INFO: Pixel decoding errors: 0
[06:44:55.292] <TB3> INFO: pixel data incomplete: 0
[06:44:55.292] <TB3> INFO: pixel address: 0
[06:44:55.292] <TB3> INFO: pulse height fill bit: 0
[06:44:55.292] <TB3> INFO: buffer corruption: 0
[06:44:55.339] <TB3> INFO: ######################################################################
[06:44:55.339] <TB3> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[06:44:55.339] <TB3> INFO: ######################################################################
[06:44:55.341] <TB3> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[06:44:55.506] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[06:44:55.506] <TB3> INFO: run 1 of 1
[06:44:55.750] <TB3> INFO: Expecting 3120000 events.
[06:45:27.112] <TB3> INFO: 663335 events read in total (30769ms).











[06:45:57.136] <TB3> INFO: 1322750 events read in total (60793ms).











[06:46:27.116] <TB3> INFO: 1979810 events read in total (90773ms).
[06:46:57.207] <TB3> INFO: 2638165 events read in total (120864ms).











[06:47:20.350] <TB3> INFO: 3120000 events read in total (144007ms).
[06:47:20.454] <TB3> INFO: Test took 144948ms.
[06:47:46.605] <TB3> INFO: PixTestBBMap::doTest() done with 2 decoding errors: , duration: 171 seconds
[06:47:46.605] <TB3> INFO: number of dead bumps (per ROC): 0 0 0 0 1 0 0 0 0 0 0 1 2 0 0 0
[06:47:46.605] <TB3> INFO: separation cut (per ROC): 97 110 106 98 98 95 99 94 93 107 106 92 106 101 91 97
[06:47:46.605] <TB3> INFO: Decoding statistics:
[06:47:46.605] <TB3> INFO: General information:
[06:47:46.605] <TB3> INFO: 16bit words read: 0
[06:47:46.605] <TB3> INFO: valid events total: 0
[06:47:46.606] <TB3> INFO: empty events: 0
[06:47:46.606] <TB3> INFO: valid events with pixels: 0
[06:47:46.606] <TB3> INFO: valid pixel hits: 0
[06:47:46.606] <TB3> INFO: Event errors: 0
[06:47:46.606] <TB3> INFO: start marker: 0
[06:47:46.606] <TB3> INFO: stop marker: 0
[06:47:46.606] <TB3> INFO: overflow: 0
[06:47:46.606] <TB3> INFO: invalid 5bit words: 0
[06:47:46.606] <TB3> INFO: invalid XOR eye diagram: 0
[06:47:46.606] <TB3> INFO: frame (failed synchr.): 0
[06:47:46.606] <TB3> INFO: idle data (no TBM trl): 0
[06:47:46.606] <TB3> INFO: no data (only TBM hdr): 0
[06:47:46.606] <TB3> INFO: TBM errors: 0
[06:47:46.606] <TB3> INFO: flawed TBM headers: 0
[06:47:46.606] <TB3> INFO: flawed TBM trailers: 0
[06:47:46.606] <TB3> INFO: event ID mismatches: 0
[06:47:46.606] <TB3> INFO: ROC errors: 0
[06:47:46.606] <TB3> INFO: missing ROC header(s): 0
[06:47:46.606] <TB3> INFO: misplaced readback start: 0
[06:47:46.606] <TB3> INFO: Pixel decoding errors: 0
[06:47:46.606] <TB3> INFO: pixel data incomplete: 0
[06:47:46.606] <TB3> INFO: pixel address: 0
[06:47:46.606] <TB3> INFO: pulse height fill bit: 0
[06:47:46.606] <TB3> INFO: buffer corruption: 0
[06:47:46.646] <TB3> INFO: ######################################################################
[06:47:46.646] <TB3> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[06:47:46.646] <TB3> INFO: ######################################################################
[06:47:46.646] <TB3> INFO: ----------------------------------------------------------------------
[06:47:46.646] <TB3> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[06:47:46.646] <TB3> INFO: ----------------------------------------------------------------------
[06:47:46.647] <TB3> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 200 (-1/-1) hits flags = 528 (plus default)
[06:47:46.662] <TB3> INFO: dacScan split into 1 runs with ntrig = 50
[06:47:46.662] <TB3> INFO: run 1 of 1
[06:47:46.901] <TB3> INFO: Expecting 36608000 events.
[06:48:10.378] <TB3> INFO: 700000 events read in total (22885ms).
[06:48:33.260] <TB3> INFO: 1379850 events read in total (45767ms).
[06:48:56.088] <TB3> INFO: 2061750 events read in total (68595ms).
[06:49:19.006] <TB3> INFO: 2741050 events read in total (91513ms).
[06:49:41.964] <TB3> INFO: 3420450 events read in total (114471ms).
[06:50:04.707] <TB3> INFO: 4097300 events read in total (137214ms).
[06:50:27.627] <TB3> INFO: 4776000 events read in total (160134ms).
[06:50:50.469] <TB3> INFO: 5453950 events read in total (182976ms).
[06:51:13.274] <TB3> INFO: 6132300 events read in total (205781ms).
[06:51:36.314] <TB3> INFO: 6810800 events read in total (228821ms).
[06:51:59.252] <TB3> INFO: 7488750 events read in total (251759ms).
[06:52:22.161] <TB3> INFO: 8166450 events read in total (274668ms).
[06:52:45.140] <TB3> INFO: 8846250 events read in total (297647ms).
[06:53:08.139] <TB3> INFO: 9526100 events read in total (320646ms).
[06:53:30.924] <TB3> INFO: 10203100 events read in total (343431ms).
[06:53:53.811] <TB3> INFO: 10878850 events read in total (366318ms).
[06:54:16.897] <TB3> INFO: 11554600 events read in total (389404ms).
[06:54:40.021] <TB3> INFO: 12231200 events read in total (412528ms).
[06:55:02.997] <TB3> INFO: 12907200 events read in total (435504ms).
[06:55:25.853] <TB3> INFO: 13583650 events read in total (458360ms).
[06:55:48.798] <TB3> INFO: 14257200 events read in total (481305ms).
[06:56:11.549] <TB3> INFO: 14931550 events read in total (504056ms).
[06:56:34.118] <TB3> INFO: 15603350 events read in total (526625ms).
[06:56:56.984] <TB3> INFO: 16278250 events read in total (549491ms).
[06:57:20.167] <TB3> INFO: 16952850 events read in total (572674ms).
[06:57:43.136] <TB3> INFO: 17627450 events read in total (595643ms).
[06:58:06.122] <TB3> INFO: 18300850 events read in total (618629ms).
[06:58:29.197] <TB3> INFO: 18972000 events read in total (641704ms).
[06:58:52.209] <TB3> INFO: 19641600 events read in total (664716ms).
[06:59:15.030] <TB3> INFO: 20311150 events read in total (687537ms).
[06:59:37.795] <TB3> INFO: 20979850 events read in total (710302ms).
[07:00:00.404] <TB3> INFO: 21649850 events read in total (732911ms).
[07:00:23.353] <TB3> INFO: 22317950 events read in total (755860ms).
[07:00:45.995] <TB3> INFO: 22985800 events read in total (778502ms).
[07:01:09.034] <TB3> INFO: 23654750 events read in total (801541ms).
[07:01:31.808] <TB3> INFO: 24322350 events read in total (824315ms).
[07:01:54.528] <TB3> INFO: 24989750 events read in total (847035ms).
[07:02:17.354] <TB3> INFO: 25657050 events read in total (869861ms).
[07:02:40.169] <TB3> INFO: 26321400 events read in total (892676ms).
[07:03:02.706] <TB3> INFO: 26987350 events read in total (915213ms).
[07:03:25.434] <TB3> INFO: 27654850 events read in total (937941ms).
[07:03:48.100] <TB3> INFO: 28320900 events read in total (960607ms).
[07:04:10.713] <TB3> INFO: 28986050 events read in total (983220ms).
[07:04:33.429] <TB3> INFO: 29651050 events read in total (1005936ms).
[07:04:56.468] <TB3> INFO: 30315450 events read in total (1028975ms).
[07:05:18.974] <TB3> INFO: 30979250 events read in total (1051481ms).
[07:05:41.725] <TB3> INFO: 31644200 events read in total (1074232ms).
[07:06:04.496] <TB3> INFO: 32309450 events read in total (1097003ms).
[07:06:27.120] <TB3> INFO: 32976800 events read in total (1119627ms).
[07:06:49.944] <TB3> INFO: 33644200 events read in total (1142451ms).
[07:07:12.606] <TB3> INFO: 34312750 events read in total (1165113ms).
[07:07:35.334] <TB3> INFO: 34980550 events read in total (1187841ms).
[07:07:58.211] <TB3> INFO: 35648800 events read in total (1210719ms).
[07:08:21.091] <TB3> INFO: 36327400 events read in total (1233598ms).
[07:08:31.428] <TB3> INFO: 36608000 events read in total (1243935ms).
[07:08:31.518] <TB3> INFO: Test took 1244856ms.
[07:08:32.036] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:33.960] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:35.815] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:37.378] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:38.824] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:40.236] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:41.666] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:43.122] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:45.319] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:46.001] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:48.688] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:50.150] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:51.778] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:53.493] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:55.082] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:56.646] <TB3> INFO: dumping ASCII scurve output file: SCurveData
[07:08:58.160] <TB3> INFO: PixTestScurves::scurves() done
[07:08:58.161] <TB3> INFO: Vcal mean: 129.96 135.32 134.49 124.76 119.16 118.89 128.79 120.88 122.20 132.24 121.39 111.71 129.68 125.37 125.53 118.65
[07:08:58.161] <TB3> INFO: Vcal RMS: 6.53 6.21 6.79 6.92 6.25 6.29 6.11 6.78 7.03 6.13 6.38 5.23 6.57 6.50 6.92 6.61
[07:08:58.161] <TB3> INFO: PixTestScurves::fullTest() done, duration: 1271 seconds
[07:08:58.161] <TB3> INFO: Decoding statistics:
[07:08:58.161] <TB3> INFO: General information:
[07:08:58.161] <TB3> INFO: 16bit words read: 0
[07:08:58.161] <TB3> INFO: valid events total: 0
[07:08:58.161] <TB3> INFO: empty events: 0
[07:08:58.161] <TB3> INFO: valid events with pixels: 0
[07:08:58.161] <TB3> INFO: valid pixel hits: 0
[07:08:58.161] <TB3> INFO: Event errors: 0
[07:08:58.161] <TB3> INFO: start marker: 0
[07:08:58.161] <TB3> INFO: stop marker: 0
[07:08:58.161] <TB3> INFO: overflow: 0
[07:08:58.161] <TB3> INFO: invalid 5bit words: 0
[07:08:58.161] <TB3> INFO: invalid XOR eye diagram: 0
[07:08:58.161] <TB3> INFO: frame (failed synchr.): 0
[07:08:58.161] <TB3> INFO: idle data (no TBM trl): 0
[07:08:58.161] <TB3> INFO: no data (only TBM hdr): 0
[07:08:58.161] <TB3> INFO: TBM errors: 0
[07:08:58.161] <TB3> INFO: flawed TBM headers: 0
[07:08:58.161] <TB3> INFO: flawed TBM trailers: 0
[07:08:58.161] <TB3> INFO: event ID mismatches: 0
[07:08:58.161] <TB3> INFO: ROC errors: 0
[07:08:58.161] <TB3> INFO: missing ROC header(s): 0
[07:08:58.161] <TB3> INFO: misplaced readback start: 0
[07:08:58.161] <TB3> INFO: Pixel decoding errors: 0
[07:08:58.161] <TB3> INFO: pixel data incomplete: 0
[07:08:58.161] <TB3> INFO: pixel address: 0
[07:08:58.161] <TB3> INFO: pulse height fill bit: 0
[07:08:58.161] <TB3> INFO: buffer corruption: 0
[07:08:58.228] <TB3> INFO: ######################################################################
[07:08:58.228] <TB3> INFO: PixTestTrim::doTest()
[07:08:58.228] <TB3> INFO: ######################################################################
[07:08:58.229] <TB3> INFO: ----------------------------------------------------------------------
[07:08:58.229] <TB3> INFO: PixTestTrim::trimTest() ntrig = 8, vcal = 35
[07:08:58.229] <TB3> INFO: ----------------------------------------------------------------------
[07:08:58.270] <TB3> INFO: ---> VthrComp thr map (minimal VthrComp)
[07:08:58.270] <TB3> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[07:08:58.284] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:08:58.284] <TB3> INFO: run 1 of 1
[07:08:58.524] <TB3> INFO: Expecting 5025280 events.
[07:09:29.823] <TB3> INFO: 835000 events read in total (30696ms).
[07:10:00.488] <TB3> INFO: 1667192 events read in total (61362ms).
[07:10:30.859] <TB3> INFO: 2496736 events read in total (91733ms).
[07:11:01.982] <TB3> INFO: 3323736 events read in total (122855ms).
[07:11:32.304] <TB3> INFO: 4146656 events read in total (153177ms).
[07:12:02.224] <TB3> INFO: 4967768 events read in total (183097ms).
[07:12:04.674] <TB3> INFO: 5025280 events read in total (185547ms).
[07:12:04.733] <TB3> INFO: Test took 186449ms.
[07:12:18.258] <TB3> INFO: ROC 0 VthrComp = 124
[07:12:18.258] <TB3> INFO: ROC 1 VthrComp = 133
[07:12:18.258] <TB3> INFO: ROC 2 VthrComp = 125
[07:12:18.259] <TB3> INFO: ROC 3 VthrComp = 110
[07:12:18.259] <TB3> INFO: ROC 4 VthrComp = 110
[07:12:18.259] <TB3> INFO: ROC 5 VthrComp = 112
[07:12:18.259] <TB3> INFO: ROC 6 VthrComp = 116
[07:12:18.259] <TB3> INFO: ROC 7 VthrComp = 106
[07:12:18.259] <TB3> INFO: ROC 8 VthrComp = 108
[07:12:18.260] <TB3> INFO: ROC 9 VthrComp = 122
[07:12:18.260] <TB3> INFO: ROC 10 VthrComp = 124
[07:12:18.260] <TB3> INFO: ROC 11 VthrComp = 105
[07:12:18.261] <TB3> INFO: ROC 12 VthrComp = 120
[07:12:18.261] <TB3> INFO: ROC 13 VthrComp = 113
[07:12:18.261] <TB3> INFO: ROC 14 VthrComp = 116
[07:12:18.261] <TB3> INFO: ROC 15 VthrComp = 110
[07:12:18.500] <TB3> INFO: Expecting 41600 events.
[07:12:21.991] <TB3> INFO: 41600 events read in total (2900ms).
[07:12:21.992] <TB3> INFO: Test took 3729ms.
[07:12:21.001] <TB3> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[07:12:21.001] <TB3> INFO: ---> dac: vcal name: TrimThr1 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[07:12:22.013] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:12:22.013] <TB3> INFO: run 1 of 1
[07:12:22.291] <TB3> INFO: Expecting 5025280 events.
[07:12:48.742] <TB3> INFO: 596096 events read in total (25859ms).
[07:13:15.095] <TB3> INFO: 1190776 events read in total (52212ms).
[07:13:41.089] <TB3> INFO: 1785800 events read in total (78206ms).
[07:14:06.976] <TB3> INFO: 2379696 events read in total (104093ms).
[07:14:32.860] <TB3> INFO: 2971576 events read in total (129977ms).
[07:14:59.079] <TB3> INFO: 3561816 events read in total (156196ms).
[07:15:24.836] <TB3> INFO: 4151080 events read in total (181953ms).
[07:15:50.749] <TB3> INFO: 4739928 events read in total (207866ms).
[07:16:03.632] <TB3> INFO: 5025280 events read in total (220749ms).
[07:16:03.755] <TB3> INFO: Test took 221741ms.
[07:16:29.868] <TB3> INFO: roc 0 with ID = 0 has maximal Vcal 66.7452 for pixel 24/2 mean/min/max = 48.8783/30.9174/66.8392
[07:16:29.869] <TB3> INFO: roc 1 with ID = 1 has maximal Vcal 62.6939 for pixel 11/0 mean/min/max = 47.2381/31.7774/62.6989
[07:16:29.869] <TB3> INFO: roc 2 with ID = 2 has maximal Vcal 65.2267 for pixel 0/7 mean/min/max = 47.8906/30.4943/65.2869
[07:16:29.870] <TB3> INFO: roc 3 with ID = 3 has maximal Vcal 72.1834 for pixel 51/14 mean/min/max = 53.1422/33.9225/72.3618
[07:16:29.870] <TB3> INFO: roc 4 with ID = 4 has maximal Vcal 67.9496 for pixel 21/10 mean/min/max = 51.0275/34.007/68.048
[07:16:29.871] <TB3> INFO: roc 5 with ID = 5 has maximal Vcal 66.4203 for pixel 48/9 mean/min/max = 49.4131/32.0483/66.778
[07:16:29.871] <TB3> INFO: roc 6 with ID = 6 has maximal Vcal 68.2796 for pixel 15/9 mean/min/max = 50.0483/31.8086/68.288
[07:16:29.872] <TB3> INFO: roc 7 with ID = 7 has maximal Vcal 74.1565 for pixel 12/0 mean/min/max = 53.488/32.71/74.266
[07:16:29.872] <TB3> INFO: roc 8 with ID = 8 has maximal Vcal 69.0476 for pixel 2/4 mean/min/max = 51.9971/34.617/69.3773
[07:16:29.873] <TB3> INFO: roc 9 with ID = 9 has maximal Vcal 68.6498 for pixel 51/4 mean/min/max = 50.1558/31.6099/68.7018
[07:16:29.873] <TB3> INFO: roc 10 with ID = 10 has maximal Vcal 61.1479 for pixel 6/79 mean/min/max = 46.7971/32.4245/61.1698
[07:16:29.873] <TB3> INFO: roc 11 with ID = 11 has maximal Vcal 66.3326 for pixel 22/7 mean/min/max = 50.4852/34.3973/66.5732
[07:16:29.874] <TB3> INFO: roc 12 with ID = 12 has maximal Vcal 66.5169 for pixel 22/2 mean/min/max = 49.3356/32.1259/66.5454
[07:16:29.874] <TB3> INFO: roc 13 with ID = 13 has maximal Vcal 67.8853 for pixel 14/4 mean/min/max = 50.526/32.6146/68.4373
[07:16:29.874] <TB3> INFO: roc 14 with ID = 14 has maximal Vcal 65.8005 for pixel 4/8 mean/min/max = 48.9055/31.8945/65.9164
[07:16:29.875] <TB3> INFO: roc 15 with ID = 15 has maximal Vcal 66.22 for pixel 0/44 mean/min/max = 50.6276/34.7928/66.4625
[07:16:29.875] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:16:29.964] <TB3> INFO: Expecting 411648 events.
[07:16:39.437] <TB3> INFO: 411648 events read in total (8882ms).
[07:16:39.445] <TB3> INFO: Expecting 411648 events.
[07:16:48.766] <TB3> INFO: 411648 events read in total (8918ms).
[07:16:48.776] <TB3> INFO: Expecting 411648 events.
[07:16:58.147] <TB3> INFO: 411648 events read in total (8968ms).
[07:16:58.160] <TB3> INFO: Expecting 411648 events.
[07:17:07.479] <TB3> INFO: 411648 events read in total (8917ms).
[07:17:07.496] <TB3> INFO: Expecting 411648 events.
[07:17:16.750] <TB3> INFO: 411648 events read in total (8851ms).
[07:17:16.773] <TB3> INFO: Expecting 411648 events.
[07:17:26.089] <TB3> INFO: 411648 events read in total (8913ms).
[07:17:26.111] <TB3> INFO: Expecting 411648 events.
[07:17:35.536] <TB3> INFO: 411648 events read in total (9021ms).
[07:17:35.561] <TB3> INFO: Expecting 411648 events.
[07:17:44.874] <TB3> INFO: 411648 events read in total (8910ms).
[07:17:44.901] <TB3> INFO: Expecting 411648 events.
[07:17:54.144] <TB3> INFO: 411648 events read in total (8840ms).
[07:17:54.185] <TB3> INFO: Expecting 411648 events.
[07:18:03.466] <TB3> INFO: 411648 events read in total (8878ms).
[07:18:03.499] <TB3> INFO: Expecting 411648 events.
[07:18:12.875] <TB3> INFO: 411648 events read in total (8973ms).
[07:18:12.973] <TB3> INFO: Expecting 411648 events.
[07:18:22.374] <TB3> INFO: 411648 events read in total (8998ms).
[07:18:22.422] <TB3> INFO: Expecting 411648 events.
[07:18:31.720] <TB3> INFO: 411648 events read in total (8895ms).
[07:18:31.791] <TB3> INFO: Expecting 411648 events.
[07:18:41.151] <TB3> INFO: 411648 events read in total (8957ms).
[07:18:41.269] <TB3> INFO: Expecting 411648 events.
[07:18:50.393] <TB3> INFO: 411648 events read in total (8721ms).
[07:18:50.460] <TB3> INFO: Expecting 411648 events.
[07:18:59.649] <TB3> INFO: 411648 events read in total (8785ms).
[07:18:59.731] <TB3> INFO: Test took 149856ms.
[07:19:00.365] <TB3> INFO: ---> dac: vcal name: TrimThr2 ntrig: 8 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[07:19:00.379] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:19:00.379] <TB3> INFO: run 1 of 1
[07:19:00.625] <TB3> INFO: Expecting 5025280 events.
[07:19:26.830] <TB3> INFO: 593712 events read in total (25614ms).
[07:19:52.983] <TB3> INFO: 1185744 events read in total (51767ms).
[07:20:19.082] <TB3> INFO: 1777328 events read in total (77866ms).
[07:20:45.454] <TB3> INFO: 2370064 events read in total (104238ms).
[07:21:11.945] <TB3> INFO: 2963376 events read in total (130730ms).
[07:21:38.324] <TB3> INFO: 3559664 events read in total (157108ms).
[07:22:04.372] <TB3> INFO: 4153728 events read in total (183156ms).
[07:22:30.615] <TB3> INFO: 4746088 events read in total (209399ms).
[07:22:43.419] <TB3> INFO: 5025280 events read in total (222203ms).
[07:22:43.616] <TB3> INFO: Test took 223238ms.
[07:23:04.208] <TB3> INFO: ---> TrimStepCorr4 extremal thresholds: 4.639475 .. 147.817853
[07:23:04.448] <TB3> INFO: Expecting 208000 events.
[07:23:14.312] <TB3> INFO: 208000 events read in total (9272ms).
[07:23:14.313] <TB3> INFO: Test took 10103ms.
[07:23:14.393] <TB3> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 8 dacrange: 4 .. 157 (-1/-1) hits flags = 528 (plus default)
[07:23:14.407] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:23:14.408] <TB3> INFO: run 1 of 1
[07:23:14.733] <TB3> INFO: Expecting 5125120 events.
[07:23:41.272] <TB3> INFO: 581200 events read in total (25948ms).
[07:24:07.252] <TB3> INFO: 1162464 events read in total (51929ms).
[07:24:33.023] <TB3> INFO: 1743056 events read in total (77699ms).
[07:24:58.694] <TB3> INFO: 2323288 events read in total (103370ms).
[07:25:24.589] <TB3> INFO: 2904128 events read in total (129265ms).
[07:25:50.321] <TB3> INFO: 3484648 events read in total (154997ms).
[07:26:16.441] <TB3> INFO: 4064896 events read in total (181117ms).
[07:26:42.240] <TB3> INFO: 4644456 events read in total (206916ms).
[07:27:04.689] <TB3> INFO: 5125120 events read in total (229365ms).
[07:27:04.888] <TB3> INFO: Test took 230481ms.
[07:27:34.498] <TB3> INFO: ---> TrimStepCorr2 extremal thresholds: 25.500000 .. 48.835918
[07:27:34.749] <TB3> INFO: Expecting 208000 events.
[07:27:44.814] <TB3> INFO: 208000 events read in total (9474ms).
[07:27:44.815] <TB3> INFO: Test took 10315ms.
[07:27:44.890] <TB3> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 8 dacrange: 15 .. 58 (-1/-1) hits flags = 528 (plus default)
[07:27:44.905] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:27:44.905] <TB3> INFO: run 1 of 1
[07:27:45.183] <TB3> INFO: Expecting 1464320 events.
[07:28:13.837] <TB3> INFO: 662288 events read in total (28062ms).
[07:28:40.965] <TB3> INFO: 1323776 events read in total (55190ms).
[07:28:47.285] <TB3> INFO: 1464320 events read in total (61510ms).
[07:28:47.329] <TB3> INFO: Test took 62426ms.
[07:29:00.724] <TB3> INFO: ---> TrimStepCorr1a extremal thresholds: 28.680939 .. 50.174932
[07:29:00.963] <TB3> INFO: Expecting 208000 events.
[07:29:10.977] <TB3> INFO: 208000 events read in total (9422ms).
[07:29:10.978] <TB3> INFO: Test took 10252ms.
[07:29:11.047] <TB3> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 8 dacrange: 18 .. 60 (-1/-1) hits flags = 528 (plus default)
[07:29:11.062] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:29:11.062] <TB3> INFO: run 1 of 1
[07:29:11.340] <TB3> INFO: Expecting 1431040 events.
[07:29:40.009] <TB3> INFO: 641448 events read in total (28077ms).
[07:30:08.055] <TB3> INFO: 1282080 events read in total (56124ms).
[07:30:14.930] <TB3> INFO: 1431040 events read in total (62998ms).
[07:30:14.967] <TB3> INFO: Test took 63905ms.
[07:30:27.781] <TB3> INFO: ---> TrimStepCorr1b extremal thresholds: 27.649868 .. 54.383827
[07:30:28.021] <TB3> INFO: Expecting 208000 events.
[07:30:37.924] <TB3> INFO: 208000 events read in total (9311ms).
[07:30:37.925] <TB3> INFO: Test took 10142ms.
[07:30:37.975] <TB3> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 8 dacrange: 17 .. 64 (-1/-1) hits flags = 528 (plus default)
[07:30:37.989] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:30:37.989] <TB3> INFO: run 1 of 1
[07:30:38.267] <TB3> INFO: Expecting 1597440 events.
[07:31:06.258] <TB3> INFO: 631856 events read in total (27399ms).
[07:31:33.651] <TB3> INFO: 1263304 events read in total (54792ms).
[07:31:47.901] <TB3> INFO: 1597440 events read in total (69042ms).
[07:31:47.948] <TB3> INFO: Test took 69960ms.
[07:32:01.442] <TB3> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[07:32:01.442] <TB3> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 8 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[07:32:01.456] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[07:32:01.456] <TB3> INFO: run 1 of 1
[07:32:01.695] <TB3> INFO: Expecting 1364480 events.
[07:32:30.583] <TB3> INFO: 669992 events read in total (28297ms).
[07:32:58.437] <TB3> INFO: 1339296 events read in total (56151ms).
[07:32:59.898] <TB3> INFO: 1364480 events read in total (57613ms).
[07:32:59.936] <TB3> INFO: Test took 58480ms.
[07:33:14.107] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C0.dat
[07:33:14.107] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C1.dat
[07:33:14.107] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C2.dat
[07:33:14.107] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C3.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C4.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C5.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C6.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C7.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C8.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C9.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C10.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C11.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C12.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C13.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C14.dat
[07:33:14.108] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C15.dat
[07:33:14.108] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C0.dat
[07:33:14.114] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C1.dat
[07:33:14.119] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C2.dat
[07:33:14.123] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C3.dat
[07:33:14.128] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C4.dat
[07:33:14.133] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C5.dat
[07:33:14.138] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C6.dat
[07:33:14.143] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C7.dat
[07:33:14.148] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C8.dat
[07:33:14.152] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C9.dat
[07:33:14.157] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C10.dat
[07:33:14.162] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C11.dat
[07:33:14.167] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C12.dat
[07:33:14.173] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C13.dat
[07:33:14.180] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C14.dat
[07:33:14.187] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters35_C15.dat
[07:33:14.192] <TB3> INFO: PixTestTrim::trimTest() done
[07:33:14.192] <TB3> INFO: vtrim: 135 138 134 141 143 145 147 149 129 146 118 140 134 141 134 124
[07:33:14.192] <TB3> INFO: vthrcomp: 124 133 125 110 110 112 116 106 108 122 124 105 120 113 116 110
[07:33:14.192] <TB3> INFO: vcal mean: 35.08 35.27 35.48 35.68 35.16 35.48 35.40 36.36 35.34 36.58 35.08 35.23 35.53 35.94 35.58 35.26
[07:33:14.193] <TB3> INFO: vcal RMS: 1.19 1.40 1.69 1.94 1.27 1.67 1.65 2.56 1.53 2.68 1.04 1.30 1.66 2.14 1.89 1.34
[07:33:14.193] <TB3> INFO: bits mean: 9.22 9.57 9.54 8.38 8.80 9.73 9.47 9.23 8.03 9.46 8.96 9.14 9.65 9.33 9.61 8.15
[07:33:14.193] <TB3> INFO: bits RMS: 2.80 2.67 2.84 2.84 2.50 2.50 2.67 2.71 2.66 2.97 2.83 2.36 2.57 2.70 2.61 2.65
[07:33:14.200] <TB3> INFO: ----------------------------------------------------------------------
[07:33:14.200] <TB3> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[07:33:14.200] <TB3> INFO: ----------------------------------------------------------------------
[07:33:14.203] <TB3> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[07:33:14.217] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[07:33:14.217] <TB3> INFO: run 1 of 1
[07:33:14.502] <TB3> INFO: Expecting 4160000 events.
[07:33:47.514] <TB3> INFO: 769645 events read in total (32421ms).
[07:34:19.810] <TB3> INFO: 1532905 events read in total (64717ms).
[07:34:51.884] <TB3> INFO: 2290990 events read in total (96791ms).
[07:35:23.670] <TB3> INFO: 3041815 events read in total (128577ms).
[07:35:55.192] <TB3> INFO: 3790345 events read in total (160099ms).
[07:36:10.999] <TB3> INFO: 4160000 events read in total (175906ms).
[07:36:11.094] <TB3> INFO: Test took 176877ms.
[07:36:38.225] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 212 (-1/-1) hits flags = 528 (plus default)
[07:36:38.239] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[07:36:38.239] <TB3> INFO: run 1 of 1
[07:36:38.477] <TB3> INFO: Expecting 4430400 events.
[07:37:10.416] <TB3> INFO: 724600 events read in total (31347ms).
[07:37:41.886] <TB3> INFO: 1445130 events read in total (62817ms).
[07:38:13.481] <TB3> INFO: 2162630 events read in total (94412ms).
[07:38:44.711] <TB3> INFO: 2875120 events read in total (125642ms).
[07:39:15.906] <TB3> INFO: 3583775 events read in total (156837ms).
[07:39:46.613] <TB3> INFO: 4292770 events read in total (187544ms).
[07:39:53.016] <TB3> INFO: 4430400 events read in total (193947ms).
[07:39:53.132] <TB3> INFO: Test took 194892ms.
[07:40:23.091] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 208 (-1/-1) hits flags = 528 (plus default)
[07:40:23.106] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[07:40:23.106] <TB3> INFO: run 1 of 1
[07:40:23.358] <TB3> INFO: Expecting 4347200 events.
[07:40:55.947] <TB3> INFO: 729675 events read in total (31997ms).
[07:41:27.754] <TB3> INFO: 1455420 events read in total (63804ms).
[07:41:59.719] <TB3> INFO: 2177245 events read in total (95769ms).
[07:42:31.222] <TB3> INFO: 2893595 events read in total (127272ms).
[07:43:02.544] <TB3> INFO: 3606710 events read in total (158594ms).
[07:43:32.904] <TB3> INFO: 4322120 events read in total (188954ms).
[07:43:34.343] <TB3> INFO: 4347200 events read in total (190393ms).
[07:43:34.423] <TB3> INFO: Test took 191317ms.
[07:43:59.175] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 205 (-1/-1) hits flags = 528 (plus default)
[07:43:59.189] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[07:43:59.189] <TB3> INFO: run 1 of 1
[07:43:59.425] <TB3> INFO: Expecting 4284800 events.
[07:44:31.433] <TB3> INFO: 733610 events read in total (31417ms).
[07:45:02.544] <TB3> INFO: 1462765 events read in total (62528ms).
[07:45:33.757] <TB3> INFO: 2188645 events read in total (93741ms).
[07:46:04.761] <TB3> INFO: 2908720 events read in total (124745ms).
[07:46:35.007] <TB3> INFO: 3625335 events read in total (154991ms).
[07:47:03.850] <TB3> INFO: 4284800 events read in total (183834ms).
[07:47:03.945] <TB3> INFO: Test took 184756ms.
[07:47:31.004] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 203 (-1/-1) hits flags = 528 (plus default)
[07:47:31.019] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[07:47:31.019] <TB3> INFO: run 1 of 1
[07:47:31.264] <TB3> INFO: Expecting 4243200 events.
[07:48:03.218] <TB3> INFO: 736590 events read in total (31363ms).
[07:48:34.008] <TB3> INFO: 1468545 events read in total (62153ms).
[07:49:05.160] <TB3> INFO: 2196975 events read in total (93305ms).
[07:49:36.474] <TB3> INFO: 2919125 events read in total (124619ms).
[07:50:07.739] <TB3> INFO: 3638105 events read in total (155884ms).
[07:50:33.665] <TB3> INFO: 4243200 events read in total (181810ms).
[07:50:33.769] <TB3> INFO: Test took 182749ms.
[07:50:59.920] <TB3> INFO: PixTestTrim::trimBitTest() done
[07:50:59.921] <TB3> INFO: PixTestTrim::doTest() done, duration: 2521 seconds
[07:50:59.921] <TB3> INFO: Decoding statistics:
[07:50:59.921] <TB3> INFO: General information:
[07:50:59.921] <TB3> INFO: 16bit words read: 0
[07:50:59.921] <TB3> INFO: valid events total: 0
[07:50:59.921] <TB3> INFO: empty events: 0
[07:50:59.921] <TB3> INFO: valid events with pixels: 0
[07:50:59.922] <TB3> INFO: valid pixel hits: 0
[07:50:59.922] <TB3> INFO: Event errors: 0
[07:50:59.922] <TB3> INFO: start marker: 0
[07:50:59.922] <TB3> INFO: stop marker: 0
[07:50:59.922] <TB3> INFO: overflow: 0
[07:50:59.922] <TB3> INFO: invalid 5bit words: 0
[07:50:59.922] <TB3> INFO: invalid XOR eye diagram: 0
[07:50:59.922] <TB3> INFO: frame (failed synchr.): 0
[07:50:59.922] <TB3> INFO: idle data (no TBM trl): 0
[07:50:59.922] <TB3> INFO: no data (only TBM hdr): 0
[07:50:59.922] <TB3> INFO: TBM errors: 0
[07:50:59.922] <TB3> INFO: flawed TBM headers: 0
[07:50:59.922] <TB3> INFO: flawed TBM trailers: 0
[07:50:59.922] <TB3> INFO: event ID mismatches: 0
[07:50:59.922] <TB3> INFO: ROC errors: 0
[07:50:59.922] <TB3> INFO: missing ROC header(s): 0
[07:50:59.922] <TB3> INFO: misplaced readback start: 0
[07:50:59.922] <TB3> INFO: Pixel decoding errors: 0
[07:50:59.922] <TB3> INFO: pixel data incomplete: 0
[07:50:59.922] <TB3> INFO: pixel address: 0
[07:50:59.922] <TB3> INFO: pulse height fill bit: 0
[07:50:59.922] <TB3> INFO: buffer corruption: 0
[07:51:00.530] <TB3> INFO: ######################################################################
[07:51:00.530] <TB3> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[07:51:00.530] <TB3> INFO: ######################################################################
[07:51:00.771] <TB3> INFO: Expecting 41600 events.
[07:51:04.284] <TB3> INFO: 41600 events read in total (2921ms).
[07:51:04.286] <TB3> INFO: Test took 3754ms.
[07:51:04.725] <TB3> INFO: Expecting 41600 events.
[07:51:08.258] <TB3> INFO: 41600 events read in total (2941ms).
[07:51:08.259] <TB3> INFO: Test took 3769ms.
[07:51:08.548] <TB3> INFO: Expecting 41600 events.
[07:51:12.093] <TB3> INFO: 41600 events read in total (2954ms).
[07:51:12.094] <TB3> INFO: Test took 3811ms.
[07:51:12.383] <TB3> INFO: Expecting 41600 events.
[07:51:15.869] <TB3> INFO: 41600 events read in total (2894ms).
[07:51:15.870] <TB3> INFO: Test took 3751ms.
[07:51:16.159] <TB3> INFO: Expecting 41600 events.
[07:51:19.700] <TB3> INFO: 41600 events read in total (2949ms).
[07:51:19.701] <TB3> INFO: Test took 3806ms.
[07:51:19.990] <TB3> INFO: Expecting 41600 events.
[07:51:23.466] <TB3> INFO: 41600 events read in total (2884ms).
[07:51:23.467] <TB3> INFO: Test took 3742ms.
[07:51:23.756] <TB3> INFO: Expecting 41600 events.
[07:51:27.222] <TB3> INFO: 41600 events read in total (2874ms).
[07:51:27.222] <TB3> INFO: Test took 3730ms.
[07:51:27.512] <TB3> INFO: Expecting 41600 events.
[07:51:30.997] <TB3> INFO: 41600 events read in total (2894ms).
[07:51:30.999] <TB3> INFO: Test took 3752ms.
[07:51:31.288] <TB3> INFO: Expecting 41600 events.
[07:51:34.761] <TB3> INFO: 41600 events read in total (2882ms).
[07:51:34.762] <TB3> INFO: Test took 3739ms.
[07:51:35.054] <TB3> INFO: Expecting 41600 events.
[07:51:38.578] <TB3> INFO: 41600 events read in total (2932ms).
[07:51:38.579] <TB3> INFO: Test took 3790ms.
[07:51:38.868] <TB3> INFO: Expecting 41600 events.
[07:51:42.447] <TB3> INFO: 41600 events read in total (2987ms).
[07:51:42.448] <TB3> INFO: Test took 3845ms.
[07:51:42.737] <TB3> INFO: Expecting 41600 events.
[07:51:46.324] <TB3> INFO: 41600 events read in total (2995ms).
[07:51:46.325] <TB3> INFO: Test took 3853ms.
[07:51:46.619] <TB3> INFO: Expecting 41600 events.
[07:51:50.127] <TB3> INFO: 41600 events read in total (2916ms).
[07:51:50.128] <TB3> INFO: Test took 3774ms.
[07:51:50.421] <TB3> INFO: Expecting 41600 events.
[07:51:54.058] <TB3> INFO: 41600 events read in total (3045ms).
[07:51:54.060] <TB3> INFO: Test took 3905ms.
[07:51:54.350] <TB3> INFO: Expecting 41600 events.
[07:51:58.003] <TB3> INFO: 41600 events read in total (3062ms).
[07:51:58.004] <TB3> INFO: Test took 3920ms.
[07:51:58.294] <TB3> INFO: Expecting 41600 events.
[07:52:01.786] <TB3> INFO: 41600 events read in total (2900ms).
[07:52:01.787] <TB3> INFO: Test took 3759ms.
[07:52:02.077] <TB3> INFO: Expecting 41600 events.
[07:52:05.719] <TB3> INFO: 41600 events read in total (3051ms).
[07:52:05.720] <TB3> INFO: Test took 3909ms.
[07:52:06.024] <TB3> INFO: Expecting 41600 events.
[07:52:09.538] <TB3> INFO: 41600 events read in total (2922ms).
[07:52:09.539] <TB3> INFO: Test took 3794ms.
[07:52:09.828] <TB3> INFO: Expecting 41600 events.
[07:52:13.355] <TB3> INFO: 41600 events read in total (2935ms).
[07:52:13.357] <TB3> INFO: Test took 3794ms.
[07:52:13.647] <TB3> INFO: Expecting 41600 events.
[07:52:17.157] <TB3> INFO: 41600 events read in total (2917ms).
[07:52:17.158] <TB3> INFO: Test took 3776ms.
[07:52:17.447] <TB3> INFO: Expecting 41600 events.
[07:52:20.915] <TB3> INFO: 41600 events read in total (2876ms).
[07:52:20.916] <TB3> INFO: Test took 3734ms.
[07:52:21.209] <TB3> INFO: Expecting 41600 events.
[07:52:24.907] <TB3> INFO: 41600 events read in total (3107ms).
[07:52:24.908] <TB3> INFO: Test took 3964ms.
[07:52:25.197] <TB3> INFO: Expecting 41600 events.
[07:52:28.703] <TB3> INFO: 41600 events read in total (2914ms).
[07:52:28.704] <TB3> INFO: Test took 3771ms.
[07:52:28.993] <TB3> INFO: Expecting 41600 events.
[07:52:32.518] <TB3> INFO: 41600 events read in total (2933ms).
[07:52:32.519] <TB3> INFO: Test took 3791ms.
[07:52:32.808] <TB3> INFO: Expecting 41600 events.
[07:52:36.326] <TB3> INFO: 41600 events read in total (2926ms).
[07:52:36.327] <TB3> INFO: Test took 3783ms.
[07:52:36.617] <TB3> INFO: Expecting 41600 events.
[07:52:40.108] <TB3> INFO: 41600 events read in total (2900ms).
[07:52:40.109] <TB3> INFO: Test took 3757ms.
[07:52:40.398] <TB3> INFO: Expecting 41600 events.
[07:52:43.931] <TB3> INFO: 41600 events read in total (2941ms).
[07:52:43.932] <TB3> INFO: Test took 3798ms.
[07:52:44.223] <TB3> INFO: Expecting 41600 events.
[07:52:47.719] <TB3> INFO: 41600 events read in total (2904ms).
[07:52:47.720] <TB3> INFO: Test took 3762ms.
[07:52:48.009] <TB3> INFO: Expecting 41600 events.
[07:52:51.605] <TB3> INFO: 41600 events read in total (3004ms).
[07:52:51.606] <TB3> INFO: Test took 3862ms.
[07:52:51.895] <TB3> INFO: Expecting 41600 events.
[07:52:55.387] <TB3> INFO: 41600 events read in total (2900ms).
[07:52:55.388] <TB3> INFO: Test took 3758ms.
[07:52:55.677] <TB3> INFO: Expecting 41600 events.
[07:52:59.343] <TB3> INFO: 41600 events read in total (3074ms).
[07:52:59.343] <TB3> INFO: Test took 3930ms.
[07:52:59.633] <TB3> INFO: Expecting 41600 events.
[07:53:03.146] <TB3> INFO: 41600 events read in total (2921ms).
[07:53:03.147] <TB3> INFO: Test took 3779ms.
[07:53:03.435] <TB3> INFO: Expecting 41600 events.
[07:53:07.004] <TB3> INFO: 41600 events read in total (2977ms).
[07:53:07.005] <TB3> INFO: Test took 3835ms.
[07:53:07.294] <TB3> INFO: Expecting 41600 events.
[07:53:10.838] <TB3> INFO: 41600 events read in total (2952ms).
[07:53:10.838] <TB3> INFO: Test took 3809ms.
[07:53:11.128] <TB3> INFO: Expecting 41600 events.
[07:53:14.605] <TB3> INFO: 41600 events read in total (2885ms).
[07:53:14.606] <TB3> INFO: Test took 3743ms.
[07:53:14.896] <TB3> INFO: Expecting 41600 events.
[07:53:18.450] <TB3> INFO: 41600 events read in total (2963ms).
[07:53:18.452] <TB3> INFO: Test took 3822ms.
[07:53:18.742] <TB3> INFO: Expecting 41600 events.
[07:53:22.298] <TB3> INFO: 41600 events read in total (2963ms).
[07:53:22.299] <TB3> INFO: Test took 3821ms.
[07:53:22.591] <TB3> INFO: Expecting 41600 events.
[07:53:26.100] <TB3> INFO: 41600 events read in total (2917ms).
[07:53:26.101] <TB3> INFO: Test took 3775ms.
[07:53:26.391] <TB3> INFO: Expecting 41600 events.
[07:53:30.066] <TB3> INFO: 41600 events read in total (3083ms).
[07:53:30.067] <TB3> INFO: Test took 3941ms.
[07:53:30.357] <TB3> INFO: Expecting 41600 events.
[07:53:33.943] <TB3> INFO: 41600 events read in total (2994ms).
[07:53:33.944] <TB3> INFO: Test took 3852ms.
[07:53:34.295] <TB3> INFO: Expecting 41600 events.
[07:53:37.822] <TB3> INFO: 41600 events read in total (2935ms).
[07:53:37.823] <TB3> INFO: Test took 3854ms.
[07:53:38.112] <TB3> INFO: Expecting 41600 events.
[07:53:41.659] <TB3> INFO: 41600 events read in total (2955ms).
[07:53:41.660] <TB3> INFO: Test took 3813ms.
[07:53:41.950] <TB3> INFO: Expecting 41600 events.
[07:53:45.516] <TB3> INFO: 41600 events read in total (2975ms).
[07:53:45.517] <TB3> INFO: Test took 3832ms.
[07:53:45.809] <TB3> INFO: Expecting 41600 events.
[07:53:49.476] <TB3> INFO: 41600 events read in total (3075ms).
[07:53:49.477] <TB3> INFO: Test took 3933ms.
[07:53:49.768] <TB3> INFO: Expecting 41600 events.
[07:53:53.264] <TB3> INFO: 41600 events read in total (2905ms).
[07:53:53.264] <TB3> INFO: Test took 3762ms.
[07:53:53.555] <TB3> INFO: Expecting 41600 events.
[07:53:57.109] <TB3> INFO: 41600 events read in total (2962ms).
[07:53:57.110] <TB3> INFO: Test took 3820ms.
[07:53:57.400] <TB3> INFO: Expecting 41600 events.
[07:54:00.905] <TB3> INFO: 41600 events read in total (2913ms).
[07:54:00.906] <TB3> INFO: Test took 3771ms.
[07:54:01.207] <TB3> INFO: Expecting 41600 events.
[07:54:04.700] <TB3> INFO: 41600 events read in total (2901ms).
[07:54:04.701] <TB3> INFO: Test took 3770ms.
[07:54:04.991] <TB3> INFO: Expecting 41600 events.
[07:54:08.544] <TB3> INFO: 41600 events read in total (2962ms).
[07:54:08.546] <TB3> INFO: Test took 3820ms.
[07:54:08.839] <TB3> INFO: Expecting 41600 events.
[07:54:12.379] <TB3> INFO: 41600 events read in total (2949ms).
[07:54:12.381] <TB3> INFO: Test took 3808ms.
[07:54:12.673] <TB3> INFO: Expecting 41600 events.
[07:54:16.190] <TB3> INFO: 41600 events read in total (2925ms).
[07:54:16.191] <TB3> INFO: Test took 3783ms.
[07:54:16.482] <TB3> INFO: Expecting 41600 events.
[07:54:19.993] <TB3> INFO: 41600 events read in total (2919ms).
[07:54:19.994] <TB3> INFO: Test took 3777ms.
[07:54:20.288] <TB3> INFO: Expecting 41600 events.
[07:54:23.899] <TB3> INFO: 41600 events read in total (3019ms).
[07:54:23.900] <TB3> INFO: Test took 3880ms.
[07:54:24.196] <TB3> INFO: Expecting 41600 events.
[07:54:27.748] <TB3> INFO: 41600 events read in total (2961ms).
[07:54:27.749] <TB3> INFO: Test took 3819ms.
[07:54:28.040] <TB3> INFO: Expecting 2560 events.
[07:54:28.934] <TB3> INFO: 2560 events read in total (302ms).
[07:54:28.934] <TB3> INFO: Test took 1171ms.
[07:54:29.241] <TB3> INFO: Expecting 2560 events.
[07:54:30.131] <TB3> INFO: 2560 events read in total (298ms).
[07:54:30.131] <TB3> INFO: Test took 1196ms.
[07:54:30.438] <TB3> INFO: Expecting 2560 events.
[07:54:31.325] <TB3> INFO: 2560 events read in total (295ms).
[07:54:31.325] <TB3> INFO: Test took 1193ms.
[07:54:31.633] <TB3> INFO: Expecting 2560 events.
[07:54:32.525] <TB3> INFO: 2560 events read in total (301ms).
[07:54:32.525] <TB3> INFO: Test took 1199ms.
[07:54:32.832] <TB3> INFO: Expecting 2560 events.
[07:54:33.718] <TB3> INFO: 2560 events read in total (295ms).
[07:54:33.719] <TB3> INFO: Test took 1193ms.
[07:54:34.026] <TB3> INFO: Expecting 2560 events.
[07:54:34.915] <TB3> INFO: 2560 events read in total (297ms).
[07:54:34.915] <TB3> INFO: Test took 1195ms.
[07:54:35.222] <TB3> INFO: Expecting 2560 events.
[07:54:36.111] <TB3> INFO: 2560 events read in total (297ms).
[07:54:36.111] <TB3> INFO: Test took 1195ms.
[07:54:36.419] <TB3> INFO: Expecting 2560 events.
[07:54:37.302] <TB3> INFO: 2560 events read in total (291ms).
[07:54:37.302] <TB3> INFO: Test took 1190ms.
[07:54:37.609] <TB3> INFO: Expecting 2560 events.
[07:54:38.494] <TB3> INFO: 2560 events read in total (293ms).
[07:54:38.494] <TB3> INFO: Test took 1191ms.
[07:54:38.801] <TB3> INFO: Expecting 2560 events.
[07:54:39.690] <TB3> INFO: 2560 events read in total (297ms).
[07:54:39.691] <TB3> INFO: Test took 1196ms.
[07:54:39.998] <TB3> INFO: Expecting 2560 events.
[07:54:40.888] <TB3> INFO: 2560 events read in total (298ms).
[07:54:40.889] <TB3> INFO: Test took 1197ms.
[07:54:41.196] <TB3> INFO: Expecting 2560 events.
[07:54:42.087] <TB3> INFO: 2560 events read in total (299ms).
[07:54:42.087] <TB3> INFO: Test took 1198ms.
[07:54:42.395] <TB3> INFO: Expecting 2560 events.
[07:54:43.290] <TB3> INFO: 2560 events read in total (303ms).
[07:54:43.290] <TB3> INFO: Test took 1202ms.
[07:54:43.598] <TB3> INFO: Expecting 2560 events.
[07:54:44.484] <TB3> INFO: 2560 events read in total (294ms).
[07:54:44.484] <TB3> INFO: Test took 1194ms.
[07:54:44.792] <TB3> INFO: Expecting 2560 events.
[07:54:45.679] <TB3> INFO: 2560 events read in total (295ms).
[07:54:45.680] <TB3> INFO: Test took 1195ms.
[07:54:45.988] <TB3> INFO: Expecting 2560 events.
[07:54:46.875] <TB3> INFO: 2560 events read in total (296ms).
[07:54:46.876] <TB3> INFO: Test took 1196ms.




[07:54:46.881] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:54:47.184] <TB3> INFO: Expecting 655360 events.
[07:55:02.066] <TB3> INFO: 655360 events read in total (14290ms).
[07:55:02.079] <TB3> INFO: Expecting 655360 events.
[07:55:16.369] <TB3> INFO: 655360 events read in total (13887ms).
[07:55:16.388] <TB3> INFO: Expecting 655360 events.
[07:55:30.728] <TB3> INFO: 655360 events read in total (13936ms).
[07:55:30.746] <TB3> INFO: Expecting 655360 events.
[07:55:45.654] <TB3> INFO: 655360 events read in total (14505ms).
[07:55:45.684] <TB3> INFO: Expecting 655360 events.
[07:56:00.402] <TB3> INFO: 655360 events read in total (14315ms).
[07:56:00.430] <TB3> INFO: Expecting 655360 events.
[07:56:14.563] <TB3> INFO: 655360 events read in total (13730ms).
[07:56:14.593] <TB3> INFO: Expecting 655360 events.
[07:56:29.423] <TB3> INFO: 655360 events read in total (14427ms).
[07:56:29.468] <TB3> INFO: Expecting 655360 events.
[07:56:44.235] <TB3> INFO: 655360 events read in total (14364ms).
[07:56:44.275] <TB3> INFO: Expecting 655360 events.
[07:56:58.491] <TB3> INFO: 655360 events read in total (13813ms).
[07:56:58.545] <TB3> INFO: Expecting 655360 events.
[07:57:13.010] <TB3> INFO: 655360 events read in total (14061ms).
[07:57:13.055] <TB3> INFO: Expecting 655360 events.
[07:57:27.745] <TB3> INFO: 655360 events read in total (14287ms).
[07:57:27.835] <TB3> INFO: Expecting 655360 events.
[07:57:42.705] <TB3> INFO: 655360 events read in total (14467ms).
[07:57:42.785] <TB3> INFO: Expecting 655360 events.
[07:57:57.187] <TB3> INFO: 655360 events read in total (13999ms).
[07:57:57.267] <TB3> INFO: Expecting 655360 events.
[07:58:12.104] <TB3> INFO: 655360 events read in total (14434ms).
[07:58:12.204] <TB3> INFO: Test took 205323ms.
[07:58:12.298] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[07:58:12.553] <TB3> INFO: Expecting 655360 events.
[07:58:27.351] <TB3> INFO: 655360 events read in total (14206ms).
[07:58:27.370] <TB3> INFO: Expecting 655360 events.
[07:58:41.944] <TB3> INFO: 655360 events read in total (14171ms).
[07:58:41.960] <TB3> INFO: Expecting 655360 events.
[07:58:56.684] <TB3> INFO: 655360 events read in total (14321ms).
[07:58:56.711] <TB3> INFO: Expecting 655360 events.
[07:59:11.229] <TB3> INFO: 655360 events read in total (14114ms).
[07:59:11.255] <TB3> INFO: Expecting 655360 events.
[07:59:25.812] <TB3> INFO: 655360 events read in total (14154ms).
[07:59:25.843] <TB3> INFO: Expecting 655360 events.
[07:59:40.306] <TB3> INFO: 655360 events read in total (14060ms).
[07:59:40.341] <TB3> INFO: Expecting 655360 events.
[07:59:54.979] <TB3> INFO: 655360 events read in total (14235ms).
[07:59:55.017] <TB3> INFO: Expecting 655360 events.
[08:00:09.570] <TB3> INFO: 655360 events read in total (14150ms).
[08:00:09.613] <TB3> INFO: Expecting 655360 events.
[08:00:24.184] <TB3> INFO: 655360 events read in total (14168ms).
[08:00:24.246] <TB3> INFO: Expecting 655360 events.
[08:00:38.864] <TB3> INFO: 655360 events read in total (14214ms).
[08:00:38.921] <TB3> INFO: Expecting 655360 events.
[08:00:53.277] <TB3> INFO: 655360 events read in total (13953ms).
[08:00:53.386] <TB3> INFO: Expecting 655360 events.
[08:01:08.054] <TB3> INFO: 655360 events read in total (14265ms).
[08:01:08.147] <TB3> INFO: Expecting 655360 events.
[08:01:22.578] <TB3> INFO: 655360 events read in total (14028ms).
[08:01:22.678] <TB3> INFO: Expecting 655360 events.
[08:01:37.200] <TB3> INFO: 655360 events read in total (14119ms).
[08:01:37.301] <TB3> INFO: Expecting 655360 events.
[08:01:51.733] <TB3> INFO: 655360 events read in total (14029ms).
[08:01:51.861] <TB3> INFO: Expecting 655360 events.
[08:02:06.600] <TB3> INFO: 655360 events read in total (14336ms).
[08:02:06.743] <TB3> INFO: Test took 234445ms.
[08:02:06.904] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:06.910] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:06.915] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:06.921] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:06.926] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:06.932] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:06.938] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:06.943] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:06.949] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:06.955] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:06.960] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:06.966] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:06.972] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:06.977] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:06.983] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:06.989] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:06.994] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:06.000] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:07.006] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:07.012] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:07.018] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:07.023] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:07.029] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:07.035] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:07.041] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:07.046] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:07.053] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[08:02:07.061] <TB3> INFO: safety margin for low PH: adding 8, margin is now 28
[08:02:07.070] <TB3> INFO: safety margin for low PH: adding 9, margin is now 29
[08:02:07.078] <TB3> INFO: safety margin for low PH: adding 10, margin is now 30
[08:02:07.086] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:07.094] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:07.102] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:07.110] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:07.119] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:07.127] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:07.135] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:07.143] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:07.151] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:07.159] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:07.167] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:07.175] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:07.183] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:07.191] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[08:02:07.199] <TB3> INFO: safety margin for low PH: adding 8, margin is now 28
[08:02:07.207] <TB3> INFO: safety margin for low PH: adding 9, margin is now 29
[08:02:07.213] <TB3> INFO: safety margin for low PH: adding 10, margin is now 30
[08:02:07.219] <TB3> INFO: safety margin for low PH: adding 11, margin is now 31
[08:02:07.225] <TB3> INFO: safety margin for low PH: adding 12, margin is now 32
[08:02:07.230] <TB3> INFO: safety margin for low PH: adding 13, margin is now 33
[08:02:07.236] <TB3> INFO: safety margin for low PH: adding 14, margin is now 34
[08:02:07.241] <TB3> INFO: safety margin for low PH: adding 15, margin is now 35
[08:02:07.247] <TB3> INFO: safety margin for low PH: adding 16, margin is now 36
[08:02:07.253] <TB3> INFO: safety margin for low PH: adding 17, margin is now 37
[08:02:07.258] <TB3> INFO: safety margin for low PH: adding 18, margin is now 38
[08:02:07.263] <TB3> INFO: safety margin for low PH: adding 19, margin is now 39
[08:02:07.269] <TB3> INFO: safety margin for low PH: adding 20, margin is now 40
[08:02:07.275] <TB3> INFO: safety margin for low PH: adding 21, margin is now 41
[08:02:07.280] <TB3> INFO: safety margin for low PH: adding 22, margin is now 42
[08:02:07.286] <TB3> INFO: safety margin for low PH: adding 23, margin is now 43
[08:02:07.291] <TB3> INFO: safety margin for low PH: adding 24, margin is now 44
[08:02:07.297] <TB3> INFO: safety margin for low PH: adding 25, margin is now 45
[08:02:07.303] <TB3> INFO: safety margin for low PH: adding 26, margin is now 46
[08:02:07.308] <TB3> INFO: safety margin for low PH: adding 27, margin is now 47
[08:02:07.314] <TB3> INFO: safety margin for low PH: adding 28, margin is now 48
[08:02:07.319] <TB3> INFO: safety margin for low PH: adding 29, margin is now 49
[08:02:07.325] <TB3> INFO: safety margin for low PH: adding 30, margin is now 50
[08:02:07.330] <TB3> INFO: safety margin for low PH: adding 31, margin is now 51
[08:02:07.336] <TB3> INFO: safety margin for low PH: adding 32, margin is now 52
[08:02:07.341] <TB3> INFO: safety margin for low PH: adding 33, margin is now 53
[08:02:07.347] <TB3> INFO: safety margin for low PH: adding 34, margin is now 54
[08:02:07.353] <TB3> INFO: safety margin for low PH: adding 35, margin is now 55
[08:02:07.358] <TB3> INFO: safety margin for low PH: adding 36, margin is now 56
[08:02:07.364] <TB3> INFO: safety margin for low PH: adding 37, margin is now 57
[08:02:07.369] <TB3> INFO: safety margin for low PH: adding 38, margin is now 58
[08:02:07.375] <TB3> INFO: safety margin for low PH: adding 39, margin is now 59
[08:02:07.381] <TB3> INFO: safety margin for low PH: adding 40, margin is now 60
[08:02:07.387] <TB3> INFO: safety margin for low PH: adding 41, margin is now 61
[08:02:07.392] <TB3> INFO: safety margin for low PH: adding 42, margin is now 62
[08:02:07.398] <TB3> INFO: safety margin for low PH: adding 43, margin is now 63
[08:02:07.404] <TB3> INFO: safety margin for low PH: adding 44, margin is now 64
[08:02:07.409] <TB3> INFO: safety margin for low PH: adding 45, margin is now 65
[08:02:07.415] <TB3> INFO: safety margin for low PH: adding 46, margin is now 66
[08:02:07.421] <TB3> INFO: safety margin for low PH: adding 47, margin is now 67
[08:02:07.426] <TB3> INFO: safety margin for low PH: adding 48, margin is now 68
[08:02:07.432] <TB3> INFO: safety margin for low PH: adding 49, margin is now 69
[08:02:07.438] <TB3> INFO: safety margin for low PH: adding 50, margin is now 70
[08:02:07.443] <TB3> INFO: safety margin for low PH: adding 51, margin is now 71
[08:02:07.449] <TB3> INFO: safety margin for low PH: adding 52, margin is now 72
[08:02:07.455] <TB3> INFO: safety margin for low PH: adding 53, margin is now 73
[08:02:07.461] <TB3> INFO: safety margin for low PH: adding 54, margin is now 74
[08:02:07.467] <TB3> INFO: safety margin for low PH: adding 55, margin is now 75
[08:02:07.473] <TB3> INFO: safety margin for low PH: adding 56, margin is now 76
[08:02:07.479] <TB3> INFO: safety margin for low PH: adding 57, margin is now 77
[08:02:07.484] <TB3> INFO: safety margin for low PH: adding 58, margin is now 78
[08:02:07.490] <TB3> INFO: safety margin for low PH: adding 59, margin is now 79
[08:02:07.496] <TB3> INFO: safety margin for low PH: adding 60, margin is now 80
[08:02:07.502] <TB3> INFO: safety margin for low PH: adding 61, margin is now 81
[08:02:07.507] <TB3> INFO: safety margin for low PH: adding 62, margin is now 82
[08:02:07.513] <TB3> INFO: safety margin for low PH: adding 63, margin is now 83
[08:02:07.518] <TB3> INFO: safety margin for low PH: adding 64, margin is now 84
[08:02:07.524] <TB3> INFO: safety margin for low PH: adding 65, margin is now 85
[08:02:07.529] <TB3> INFO: safety margin for low PH: adding 66, margin is now 86
[08:02:07.535] <TB3> INFO: safety margin for low PH: adding 67, margin is now 87
[08:02:07.541] <TB3> INFO: safety margin for low PH: adding 68, margin is now 88
[08:02:07.547] <TB3> INFO: safety margin for low PH: adding 69, margin is now 89
[08:02:07.552] <TB3> INFO: safety margin for low PH: adding 70, margin is now 90
[08:02:07.558] <TB3> INFO: safety margin for low PH: adding 71, margin is now 91
[08:02:07.564] <TB3> INFO: safety margin for low PH: adding 72, margin is now 92
[08:02:07.569] <TB3> INFO: safety margin for low PH: adding 73, margin is now 93
[08:02:07.575] <TB3> INFO: safety margin for low PH: adding 74, margin is now 94
[08:02:07.581] <TB3> INFO: safety margin for low PH: adding 75, margin is now 95
[08:02:07.587] <TB3> INFO: safety margin for low PH: adding 76, margin is now 96
[08:02:07.592] <TB3> INFO: safety margin for low PH: adding 77, margin is now 97
[08:02:07.598] <TB3> INFO: safety margin for low PH: adding 78, margin is now 98
[08:02:07.604] <TB3> INFO: safety margin for low PH: adding 79, margin is now 99
[08:02:07.609] <TB3> INFO: safety margin for low PH: adding 80, margin is now 100
[08:02:07.615] <TB3> INFO: safety margin for low PH: adding 81, margin is now 101
[08:02:07.621] <TB3> INFO: safety margin for low PH: adding 82, margin is now 102
[08:02:07.626] <TB3> INFO: safety margin for low PH: adding 83, margin is now 103
[08:02:07.632] <TB3> INFO: safety margin for low PH: adding 84, margin is now 104
[08:02:07.638] <TB3> INFO: safety margin for low PH: adding 85, margin is now 105
[08:02:07.643] <TB3> INFO: safety margin for low PH: adding 86, margin is now 106
[08:02:07.649] <TB3> INFO: safety margin for low PH: adding 87, margin is now 107
[08:02:07.654] <TB3> INFO: safety margin for low PH: adding 88, margin is now 108
[08:02:07.660] <TB3> INFO: safety margin for low PH: adding 89, margin is now 109
[08:02:07.666] <TB3> INFO: safety margin for low PH: adding 90, margin is now 110
[08:02:07.671] <TB3> INFO: safety margin for low PH: adding 91, margin is now 111
[08:02:07.677] <TB3> INFO: safety margin for low PH: adding 92, margin is now 112
[08:02:07.683] <TB3> INFO: safety margin for low PH: adding 93, margin is now 113
[08:02:07.689] <TB3> INFO: safety margin for low PH: adding 94, margin is now 114
[08:02:07.694] <TB3> INFO: safety margin for low PH: adding 95, margin is now 115
[08:02:07.700] <TB3> INFO: safety margin for low PH: adding 96, margin is now 116
[08:02:07.706] <TB3> INFO: safety margin for low PH: adding 97, margin is now 117
[08:02:07.711] <TB3> INFO: safety margin for low PH: adding 98, margin is now 118
[08:02:07.717] <TB3> INFO: safety margin for low PH: adding 99, margin is now 119
[08:02:07.723] <TB3> INFO: safety margin for low PH: adding 100, margin is now 120
[08:02:07.729] <TB3> INFO: safety margin for low PH: adding 101, margin is now 121
[08:02:07.735] <TB3> INFO: safety margin for low PH: adding 102, margin is now 122
[08:02:07.740] <TB3> INFO: safety margin for low PH: adding 103, margin is now 123
[08:02:07.746] <TB3> INFO: safety margin for low PH: adding 104, margin is now 124
[08:02:07.752] <TB3> INFO: safety margin for low PH: adding 105, margin is now 125
[08:02:07.757] <TB3> INFO: safety margin for low PH: adding 106, margin is now 126
[08:02:07.763] <TB3> INFO: safety margin for low PH: adding 107, margin is now 127
[08:02:07.768] <TB3> INFO: safety margin for low PH: adding 108, margin is now 128
[08:02:07.774] <TB3> INFO: safety margin for low PH: adding 109, margin is now 129
[08:02:07.780] <TB3> INFO: safety margin for low PH: adding 110, margin is now 130
[08:02:07.785] <TB3> INFO: safety margin for low PH: adding 111, margin is now 131
[08:02:07.791] <TB3> INFO: safety margin for low PH: adding 112, margin is now 132
[08:02:07.796] <TB3> INFO: safety margin for low PH: adding 113, margin is now 133
[08:02:07.802] <TB3> INFO: safety margin for low PH: adding 114, margin is now 134
[08:02:07.808] <TB3> INFO: safety margin for low PH: adding 115, margin is now 135
[08:02:07.813] <TB3> INFO: safety margin for low PH: adding 116, margin is now 136
[08:02:07.819] <TB3> INFO: safety margin for low PH: adding 117, margin is now 137
[08:02:07.824] <TB3> INFO: safety margin for low PH: adding 118, margin is now 138
[08:02:07.830] <TB3> INFO: safety margin for low PH: adding 119, margin is now 139
[08:02:07.836] <TB3> INFO: safety margin for low PH: adding 120, margin is now 140
[08:02:07.842] <TB3> INFO: safety margin for low PH: adding 121, margin is now 141
[08:02:07.848] <TB3> INFO: safety margin for low PH: adding 122, margin is now 142
[08:02:07.854] <TB3> INFO: safety margin for low PH: adding 123, margin is now 143
[08:02:07.859] <TB3> INFO: safety margin for low PH: adding 124, margin is now 144
[08:02:07.865] <TB3> INFO: safety margin for low PH: adding 125, margin is now 145
[08:02:07.871] <TB3> INFO: safety margin for low PH: adding 126, margin is now 146
[08:02:07.877] <TB3> INFO: safety margin for low PH: adding 127, margin is now 147
[08:02:07.883] <TB3> INFO: safety margin for low PH: adding 128, margin is now 148
[08:02:07.889] <TB3> INFO: safety margin for low PH: adding 129, margin is now 149
[08:02:07.895] <TB3> INFO: safety margin for low PH: adding 130, margin is now 150
[08:02:07.901] <TB3> INFO: safety margin for low PH: adding 131, margin is now 151
[08:02:07.907] <TB3> INFO: safety margin for low PH: adding 132, margin is now 152
[08:02:07.913] <TB3> INFO: safety margin for low PH: adding 133, margin is now 153
[08:02:07.919] <TB3> INFO: safety margin for low PH: adding 134, margin is now 154
[08:02:07.925] <TB3> INFO: safety margin for low PH: adding 135, margin is now 155
[08:02:07.931] <TB3> INFO: safety margin for low PH: adding 136, margin is now 156
[08:02:07.937] <TB3> INFO: safety margin for low PH: adding 137, margin is now 157
[08:02:07.943] <TB3> INFO: safety margin for low PH: adding 138, margin is now 158
[08:02:07.949] <TB3> INFO: safety margin for low PH: adding 139, margin is now 159
[08:02:07.955] <TB3> INFO: safety margin for low PH: adding 140, margin is now 160
[08:02:07.961] <TB3> INFO: safety margin for low PH: adding 141, margin is now 161
[08:02:07.967] <TB3> INFO: safety margin for low PH: adding 142, margin is now 162
[08:02:07.973] <TB3> INFO: safety margin for low PH: adding 143, margin is now 163
[08:02:07.980] <TB3> INFO: safety margin for low PH: adding 144, margin is now 164
[08:02:07.986] <TB3> INFO: safety margin for low PH: adding 145, margin is now 165
[08:02:07.991] <TB3> INFO: safety margin for low PH: adding 146, margin is now 166
[08:02:07.997] <TB3> INFO: safety margin for low PH: adding 147, margin is now 167
[08:02:07.003] <TB3> INFO: safety margin for low PH: adding 148, margin is now 168
[08:02:08.008] <TB3> INFO: safety margin for low PH: adding 149, margin is now 169
[08:02:08.014] <TB3> INFO: safety margin for low PH: adding 150, margin is now 170
[08:02:08.020] <TB3> INFO: safety margin for low PH: adding 151, margin is now 171
[08:02:08.026] <TB3> INFO: safety margin for low PH: adding 152, margin is now 172
[08:02:08.031] <TB3> INFO: safety margin for low PH: adding 153, margin is now 173
[08:02:08.037] <TB3> INFO: safety margin for low PH: adding 154, margin is now 174
[08:02:08.043] <TB3> INFO: safety margin for low PH: adding 155, margin is now 175
[08:02:08.048] <TB3> INFO: safety margin for low PH: adding 156, margin is now 176
[08:02:08.054] <TB3> INFO: safety margin for low PH: adding 157, margin is now 177
[08:02:08.060] <TB3> INFO: safety margin for low PH: adding 158, margin is now 178
[08:02:08.065] <TB3> INFO: safety margin for low PH: adding 159, margin is now 179
[08:02:08.071] <TB3> INFO: safety margin for low PH: adding 160, margin is now 180
[08:02:08.077] <TB3> INFO: safety margin for low PH: adding 161, margin is now 181
[08:02:08.082] <TB3> INFO: safety margin for low PH: adding 162, margin is now 182
[08:02:08.088] <TB3> INFO: safety margin for low PH: adding 163, margin is now 183
[08:02:08.093] <TB3> INFO: safety margin for low PH: adding 164, margin is now 184
[08:02:08.099] <TB3> INFO: safety margin for low PH: adding 165, margin is now 185
[08:02:08.105] <TB3> INFO: safety margin for low PH: adding 166, margin is now 186
[08:02:08.110] <TB3> INFO: safety margin for low PH: adding 167, margin is now 187
[08:02:08.117] <TB3> INFO: safety margin for low PH: adding 168, margin is now 188
[08:02:08.122] <TB3> INFO: safety margin for low PH: adding 169, margin is now 189
[08:02:08.128] <TB3> INFO: safety margin for low PH: adding 170, margin is now 190
[08:02:08.134] <TB3> INFO: safety margin for low PH: adding 171, margin is now 191
[08:02:08.139] <TB3> INFO: safety margin for low PH: adding 172, margin is now 192
[08:02:08.145] <TB3> INFO: safety margin for low PH: adding 173, margin is now 193
[08:02:08.150] <TB3> INFO: safety margin for low PH: adding 174, margin is now 194
[08:02:08.156] <TB3> INFO: safety margin for low PH: adding 175, margin is now 195
[08:02:08.161] <TB3> INFO: safety margin for low PH: adding 176, margin is now 196
[08:02:08.167] <TB3> INFO: safety margin for low PH: adding 177, margin is now 197
[08:02:08.173] <TB3> INFO: safety margin for low PH: adding 178, margin is now 198
[08:02:08.178] <TB3> INFO: safety margin for low PH: adding 179, margin is now 199
[08:02:08.184] <TB3> INFO: safety margin for low PH: adding 180, margin is now 200
[08:02:08.190] <TB3> INFO: safety margin for low PH: adding 181, margin is now 201
[08:02:08.195] <TB3> INFO: safety margin for low PH: adding 182, margin is now 202
[08:02:08.201] <TB3> INFO: safety margin for low PH: adding 183, margin is now 203
[08:02:08.207] <TB3> INFO: safety margin for low PH: adding 184, margin is now 204
[08:02:08.213] <TB3> INFO: safety margin for low PH: adding 185, margin is now 205
[08:02:08.219] <TB3> INFO: safety margin for low PH: adding 186, margin is now 206
[08:02:08.225] <TB3> INFO: safety margin for low PH: adding 187, margin is now 207
[08:02:08.231] <TB3> INFO: safety margin for low PH: adding 188, margin is now 208
[08:02:08.237] <TB3> INFO: safety margin for low PH: adding 189, margin is now 209
[08:02:08.243] <TB3> INFO: safety margin for low PH: adding 190, margin is now 210
[08:02:08.249] <TB3> INFO: safety margin for low PH: adding 191, margin is now 211
[08:02:08.255] <TB3> INFO: safety margin for low PH: adding 192, margin is now 212
[08:02:08.261] <TB3> INFO: safety margin for low PH: adding 193, margin is now 213
[08:02:08.268] <TB3> INFO: safety margin for low PH: adding 194, margin is now 214
[08:02:08.274] <TB3> INFO: safety margin for low PH: adding 195, margin is now 215
[08:02:08.280] <TB3> INFO: safety margin for low PH: adding 196, margin is now 216
[08:02:08.287] <TB3> INFO: safety margin for low PH: adding 197, margin is now 217
[08:02:08.293] <TB3> INFO: safety margin for low PH: adding 198, margin is now 218
[08:02:08.299] <TB3> INFO: safety margin for low PH: adding 199, margin is now 219
[08:02:08.306] <TB3> INFO: safety margin for low PH: adding 200, margin is now 220
[08:02:08.312] <TB3> INFO: safety margin for low PH: adding 201, margin is now 221
[08:02:08.318] <TB3> INFO: safety margin for low PH: adding 202, margin is now 222
[08:02:08.325] <TB3> INFO: safety margin for low PH: adding 203, margin is now 223
[08:02:08.332] <TB3> INFO: safety margin for low PH: adding 204, margin is now 224
[08:02:08.338] <TB3> INFO: safety margin for low PH: adding 205, margin is now 225
[08:02:08.344] <TB3> INFO: safety margin for low PH: adding 206, margin is now 226
[08:02:08.351] <TB3> INFO: safety margin for low PH: adding 207, margin is now 227
[08:02:08.357] <TB3> INFO: safety margin for low PH: adding 208, margin is now 228
[08:02:08.363] <TB3> INFO: safety margin for low PH: adding 209, margin is now 229
[08:02:08.369] <TB3> INFO: safety margin for low PH: adding 210, margin is now 230
[08:02:08.375] <TB3> INFO: safety margin for low PH: adding 211, margin is now 231
[08:02:08.381] <TB3> INFO: safety margin for low PH: adding 212, margin is now 232
[08:02:08.387] <TB3> INFO: safety margin for low PH: adding 213, margin is now 233
[08:02:08.393] <TB3> INFO: safety margin for low PH: adding 214, margin is now 234
[08:02:08.400] <TB3> INFO: safety margin for low PH: adding 215, margin is now 235
[08:02:08.406] <TB3> INFO: safety margin for low PH: adding 216, margin is now 236
[08:02:08.413] <TB3> INFO: safety margin for low PH: adding 217, margin is now 237
[08:02:08.420] <TB3> INFO: safety margin for low PH: adding 218, margin is now 238
[08:02:08.427] <TB3> INFO: safety margin for low PH: adding 219, margin is now 239
[08:02:08.434] <TB3> INFO: safety margin for low PH: adding 220, margin is now 240
[08:02:08.441] <TB3> INFO: safety margin for low PH: adding 221, margin is now 241
[08:02:08.448] <TB3> INFO: safety margin for low PH: adding 222, margin is now 242
[08:02:08.455] <TB3> INFO: safety margin for low PH: adding 223, margin is now 243
[08:02:08.461] <TB3> INFO: safety margin for low PH: adding 224, margin is now 244
[08:02:08.468] <TB3> INFO: safety margin for low PH: adding 225, margin is now 245
[08:02:08.474] <TB3> INFO: safety margin for low PH: adding 226, margin is now 246
[08:02:08.481] <TB3> INFO: safety margin for low PH: adding 227, margin is now 247
[08:02:08.487] <TB3> INFO: safety margin for low PH: adding 228, margin is now 248
[08:02:08.494] <TB3> INFO: safety margin for low PH: adding 229, margin is now 249
[08:02:08.501] <TB3> INFO: safety margin for low PH: adding 230, margin is now 250
[08:02:08.507] <TB3> INFO: safety margin for low PH: adding 231, margin is now 251
[08:02:08.513] <TB3> INFO: safety margin for low PH: adding 232, margin is now 252
[08:02:08.519] <TB3> INFO: safety margin for low PH: adding 233, margin is now 253
[08:02:08.525] <TB3> INFO: safety margin for low PH: adding 234, margin is now 254
[08:02:08.532] <TB3> INFO: safety margin for low PH: adding 235, margin is now 255
[08:02:08.538] <TB3> INFO: For ROC 8: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[08:02:08.538] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:08.544] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:08.551] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:08.558] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:08.565] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:08.571] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:08.578] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:08.585] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[08:02:08.591] <TB3> INFO: safety margin for low PH: adding 8, margin is now 28
[08:02:08.598] <TB3> INFO: safety margin for low PH: adding 9, margin is now 29
[08:02:08.604] <TB3> INFO: safety margin for low PH: adding 10, margin is now 30
[08:02:08.610] <TB3> INFO: safety margin for low PH: adding 11, margin is now 31
[08:02:08.616] <TB3> INFO: safety margin for low PH: adding 12, margin is now 32
[08:02:08.622] <TB3> INFO: safety margin for low PH: adding 13, margin is now 33
[08:02:08.627] <TB3> INFO: safety margin for low PH: adding 14, margin is now 34
[08:02:08.634] <TB3> INFO: safety margin for low PH: adding 15, margin is now 35
[08:02:08.640] <TB3> INFO: safety margin for low PH: adding 16, margin is now 36
[08:02:08.645] <TB3> INFO: safety margin for low PH: adding 17, margin is now 37
[08:02:08.651] <TB3> INFO: safety margin for low PH: adding 18, margin is now 38
[08:02:08.657] <TB3> INFO: safety margin for low PH: adding 19, margin is now 39
[08:02:08.663] <TB3> INFO: safety margin for low PH: adding 20, margin is now 40
[08:02:08.669] <TB3> INFO: safety margin for low PH: adding 21, margin is now 41
[08:02:08.676] <TB3> INFO: safety margin for low PH: adding 22, margin is now 42
[08:02:08.682] <TB3> INFO: safety margin for low PH: adding 23, margin is now 43
[08:02:08.688] <TB3> INFO: safety margin for low PH: adding 24, margin is now 44
[08:02:08.694] <TB3> INFO: safety margin for low PH: adding 25, margin is now 45
[08:02:08.700] <TB3> INFO: safety margin for low PH: adding 26, margin is now 46
[08:02:08.706] <TB3> INFO: safety margin for low PH: adding 27, margin is now 47
[08:02:08.711] <TB3> INFO: safety margin for low PH: adding 28, margin is now 48
[08:02:08.718] <TB3> INFO: safety margin for low PH: adding 29, margin is now 49
[08:02:08.723] <TB3> INFO: safety margin for low PH: adding 30, margin is now 50
[08:02:08.729] <TB3> INFO: safety margin for low PH: adding 31, margin is now 51
[08:02:08.735] <TB3> INFO: safety margin for low PH: adding 32, margin is now 52
[08:02:08.741] <TB3> INFO: safety margin for low PH: adding 33, margin is now 53
[08:02:08.746] <TB3> INFO: safety margin for low PH: adding 34, margin is now 54
[08:02:08.752] <TB3> INFO: safety margin for low PH: adding 35, margin is now 55
[08:02:08.758] <TB3> INFO: safety margin for low PH: adding 36, margin is now 56
[08:02:08.764] <TB3> INFO: safety margin for low PH: adding 37, margin is now 57
[08:02:08.770] <TB3> INFO: safety margin for low PH: adding 38, margin is now 58
[08:02:08.775] <TB3> INFO: safety margin for low PH: adding 39, margin is now 59
[08:02:08.781] <TB3> INFO: safety margin for low PH: adding 40, margin is now 60
[08:02:08.787] <TB3> INFO: safety margin for low PH: adding 41, margin is now 61
[08:02:08.793] <TB3> INFO: safety margin for low PH: adding 42, margin is now 62
[08:02:08.799] <TB3> INFO: safety margin for low PH: adding 43, margin is now 63
[08:02:08.804] <TB3> INFO: safety margin for low PH: adding 44, margin is now 64
[08:02:08.810] <TB3> INFO: safety margin for low PH: adding 45, margin is now 65
[08:02:08.816] <TB3> INFO: safety margin for low PH: adding 46, margin is now 66
[08:02:08.822] <TB3> INFO: safety margin for low PH: adding 47, margin is now 67
[08:02:08.827] <TB3> INFO: safety margin for low PH: adding 48, margin is now 68
[08:02:08.833] <TB3> INFO: safety margin for low PH: adding 49, margin is now 69
[08:02:08.839] <TB3> INFO: safety margin for low PH: adding 50, margin is now 70
[08:02:08.845] <TB3> INFO: safety margin for low PH: adding 51, margin is now 71
[08:02:08.851] <TB3> INFO: safety margin for low PH: adding 52, margin is now 72
[08:02:08.856] <TB3> INFO: safety margin for low PH: adding 53, margin is now 73
[08:02:08.862] <TB3> INFO: safety margin for low PH: adding 54, margin is now 74
[08:02:08.868] <TB3> INFO: safety margin for low PH: adding 55, margin is now 75
[08:02:08.874] <TB3> INFO: safety margin for low PH: adding 56, margin is now 76
[08:02:08.879] <TB3> INFO: safety margin for low PH: adding 57, margin is now 77
[08:02:08.885] <TB3> INFO: safety margin for low PH: adding 58, margin is now 78
[08:02:08.891] <TB3> INFO: safety margin for low PH: adding 59, margin is now 79
[08:02:08.897] <TB3> INFO: safety margin for low PH: adding 60, margin is now 80
[08:02:08.903] <TB3> INFO: safety margin for low PH: adding 61, margin is now 81
[08:02:08.908] <TB3> INFO: safety margin for low PH: adding 62, margin is now 82
[08:02:08.914] <TB3> INFO: safety margin for low PH: adding 63, margin is now 83
[08:02:08.920] <TB3> INFO: safety margin for low PH: adding 64, margin is now 84
[08:02:08.926] <TB3> INFO: safety margin for low PH: adding 65, margin is now 85
[08:02:08.932] <TB3> INFO: safety margin for low PH: adding 66, margin is now 86
[08:02:08.937] <TB3> INFO: safety margin for low PH: adding 67, margin is now 87
[08:02:08.943] <TB3> INFO: safety margin for low PH: adding 68, margin is now 88
[08:02:08.949] <TB3> INFO: safety margin for low PH: adding 69, margin is now 89
[08:02:08.955] <TB3> INFO: safety margin for low PH: adding 70, margin is now 90
[08:02:08.960] <TB3> INFO: safety margin for low PH: adding 71, margin is now 91
[08:02:08.966] <TB3> INFO: safety margin for low PH: adding 72, margin is now 92
[08:02:08.972] <TB3> INFO: safety margin for low PH: adding 73, margin is now 93
[08:02:08.978] <TB3> INFO: safety margin for low PH: adding 74, margin is now 94
[08:02:08.984] <TB3> INFO: safety margin for low PH: adding 75, margin is now 95
[08:02:08.989] <TB3> INFO: safety margin for low PH: adding 76, margin is now 96
[08:02:08.995] <TB3> INFO: safety margin for low PH: adding 77, margin is now 97
[08:02:08.001] <TB3> INFO: safety margin for low PH: adding 78, margin is now 98
[08:02:09.007] <TB3> INFO: safety margin for low PH: adding 79, margin is now 99
[08:02:09.012] <TB3> INFO: safety margin for low PH: adding 80, margin is now 100
[08:02:09.018] <TB3> INFO: safety margin for low PH: adding 81, margin is now 101
[08:02:09.024] <TB3> INFO: safety margin for low PH: adding 82, margin is now 102
[08:02:09.030] <TB3> INFO: safety margin for low PH: adding 83, margin is now 103
[08:02:09.036] <TB3> INFO: safety margin for low PH: adding 84, margin is now 104
[08:02:09.041] <TB3> INFO: safety margin for low PH: adding 85, margin is now 105
[08:02:09.047] <TB3> INFO: safety margin for low PH: adding 86, margin is now 106
[08:02:09.053] <TB3> INFO: safety margin for low PH: adding 87, margin is now 107
[08:02:09.058] <TB3> INFO: safety margin for low PH: adding 88, margin is now 108
[08:02:09.064] <TB3> INFO: safety margin for low PH: adding 89, margin is now 109
[08:02:09.070] <TB3> INFO: safety margin for low PH: adding 90, margin is now 110
[08:02:09.076] <TB3> INFO: safety margin for low PH: adding 91, margin is now 111
[08:02:09.082] <TB3> INFO: safety margin for low PH: adding 92, margin is now 112
[08:02:09.088] <TB3> INFO: safety margin for low PH: adding 93, margin is now 113
[08:02:09.093] <TB3> INFO: safety margin for low PH: adding 94, margin is now 114
[08:02:09.099] <TB3> INFO: safety margin for low PH: adding 95, margin is now 115
[08:02:09.105] <TB3> INFO: safety margin for low PH: adding 96, margin is now 116
[08:02:09.111] <TB3> INFO: safety margin for low PH: adding 97, margin is now 117
[08:02:09.117] <TB3> INFO: safety margin for low PH: adding 98, margin is now 118
[08:02:09.122] <TB3> INFO: safety margin for low PH: adding 99, margin is now 119
[08:02:09.128] <TB3> INFO: safety margin for low PH: adding 100, margin is now 120
[08:02:09.134] <TB3> INFO: safety margin for low PH: adding 101, margin is now 121
[08:02:09.140] <TB3> INFO: safety margin for low PH: adding 102, margin is now 122
[08:02:09.146] <TB3> INFO: safety margin for low PH: adding 103, margin is now 123
[08:02:09.152] <TB3> INFO: safety margin for low PH: adding 104, margin is now 124
[08:02:09.157] <TB3> INFO: safety margin for low PH: adding 105, margin is now 125
[08:02:09.163] <TB3> INFO: safety margin for low PH: adding 106, margin is now 126
[08:02:09.169] <TB3> INFO: safety margin for low PH: adding 107, margin is now 127
[08:02:09.175] <TB3> INFO: safety margin for low PH: adding 108, margin is now 128
[08:02:09.181] <TB3> INFO: safety margin for low PH: adding 109, margin is now 129
[08:02:09.187] <TB3> INFO: safety margin for low PH: adding 110, margin is now 130
[08:02:09.193] <TB3> INFO: safety margin for low PH: adding 111, margin is now 131
[08:02:09.198] <TB3> INFO: safety margin for low PH: adding 112, margin is now 132
[08:02:09.204] <TB3> INFO: safety margin for low PH: adding 113, margin is now 133
[08:02:09.210] <TB3> INFO: safety margin for low PH: adding 114, margin is now 134
[08:02:09.216] <TB3> INFO: safety margin for low PH: adding 115, margin is now 135
[08:02:09.222] <TB3> INFO: safety margin for low PH: adding 116, margin is now 136
[08:02:09.227] <TB3> INFO: safety margin for low PH: adding 117, margin is now 137
[08:02:09.233] <TB3> INFO: safety margin for low PH: adding 118, margin is now 138
[08:02:09.239] <TB3> INFO: safety margin for low PH: adding 119, margin is now 139
[08:02:09.244] <TB3> INFO: safety margin for low PH: adding 120, margin is now 140
[08:02:09.250] <TB3> INFO: safety margin for low PH: adding 121, margin is now 141
[08:02:09.256] <TB3> INFO: safety margin for low PH: adding 122, margin is now 142
[08:02:09.262] <TB3> INFO: safety margin for low PH: adding 123, margin is now 143
[08:02:09.268] <TB3> INFO: safety margin for low PH: adding 124, margin is now 144
[08:02:09.274] <TB3> INFO: safety margin for low PH: adding 125, margin is now 145
[08:02:09.279] <TB3> INFO: safety margin for low PH: adding 126, margin is now 146
[08:02:09.285] <TB3> INFO: safety margin for low PH: adding 127, margin is now 147
[08:02:09.291] <TB3> INFO: safety margin for low PH: adding 128, margin is now 148
[08:02:09.297] <TB3> INFO: safety margin for low PH: adding 129, margin is now 149
[08:02:09.302] <TB3> INFO: safety margin for low PH: adding 130, margin is now 150
[08:02:09.308] <TB3> INFO: safety margin for low PH: adding 131, margin is now 151
[08:02:09.314] <TB3> INFO: safety margin for low PH: adding 132, margin is now 152
[08:02:09.320] <TB3> INFO: safety margin for low PH: adding 133, margin is now 153
[08:02:09.325] <TB3> INFO: safety margin for low PH: adding 134, margin is now 154
[08:02:09.331] <TB3> INFO: safety margin for low PH: adding 135, margin is now 155
[08:02:09.337] <TB3> INFO: safety margin for low PH: adding 136, margin is now 156
[08:02:09.342] <TB3> INFO: safety margin for low PH: adding 137, margin is now 157
[08:02:09.348] <TB3> INFO: safety margin for low PH: adding 138, margin is now 158
[08:02:09.354] <TB3> INFO: safety margin for low PH: adding 139, margin is now 159
[08:02:09.360] <TB3> INFO: safety margin for low PH: adding 140, margin is now 160
[08:02:09.366] <TB3> INFO: safety margin for low PH: adding 141, margin is now 161
[08:02:09.372] <TB3> INFO: safety margin for low PH: adding 142, margin is now 162
[08:02:09.378] <TB3> INFO: safety margin for low PH: adding 143, margin is now 163
[08:02:09.385] <TB3> INFO: safety margin for low PH: adding 144, margin is now 164
[08:02:09.391] <TB3> INFO: safety margin for low PH: adding 145, margin is now 165
[08:02:09.397] <TB3> INFO: safety margin for low PH: adding 146, margin is now 166
[08:02:09.403] <TB3> INFO: safety margin for low PH: adding 147, margin is now 167
[08:02:09.408] <TB3> INFO: safety margin for low PH: adding 148, margin is now 168
[08:02:09.414] <TB3> INFO: safety margin for low PH: adding 149, margin is now 169
[08:02:09.420] <TB3> INFO: safety margin for low PH: adding 150, margin is now 170
[08:02:09.426] <TB3> INFO: safety margin for low PH: adding 151, margin is now 171
[08:02:09.432] <TB3> INFO: safety margin for low PH: adding 152, margin is now 172
[08:02:09.438] <TB3> INFO: safety margin for low PH: adding 153, margin is now 173
[08:02:09.443] <TB3> INFO: safety margin for low PH: adding 154, margin is now 174
[08:02:09.449] <TB3> INFO: safety margin for low PH: adding 155, margin is now 175
[08:02:09.455] <TB3> INFO: safety margin for low PH: adding 156, margin is now 176
[08:02:09.460] <TB3> INFO: safety margin for low PH: adding 157, margin is now 177
[08:02:09.466] <TB3> INFO: safety margin for low PH: adding 158, margin is now 178
[08:02:09.472] <TB3> INFO: safety margin for low PH: adding 159, margin is now 179
[08:02:09.478] <TB3> INFO: safety margin for low PH: adding 160, margin is now 180
[08:02:09.484] <TB3> INFO: safety margin for low PH: adding 161, margin is now 181
[08:02:09.489] <TB3> INFO: safety margin for low PH: adding 162, margin is now 182
[08:02:09.495] <TB3> INFO: safety margin for low PH: adding 163, margin is now 183
[08:02:09.501] <TB3> INFO: safety margin for low PH: adding 164, margin is now 184
[08:02:09.507] <TB3> INFO: safety margin for low PH: adding 165, margin is now 185
[08:02:09.513] <TB3> INFO: safety margin for low PH: adding 166, margin is now 186
[08:02:09.519] <TB3> INFO: safety margin for low PH: adding 167, margin is now 187
[08:02:09.525] <TB3> INFO: safety margin for low PH: adding 168, margin is now 188
[08:02:09.532] <TB3> INFO: safety margin for low PH: adding 169, margin is now 189
[08:02:09.538] <TB3> INFO: safety margin for low PH: adding 170, margin is now 190
[08:02:09.544] <TB3> INFO: safety margin for low PH: adding 171, margin is now 191
[08:02:09.550] <TB3> INFO: safety margin for low PH: adding 172, margin is now 192
[08:02:09.556] <TB3> INFO: safety margin for low PH: adding 173, margin is now 193
[08:02:09.562] <TB3> INFO: safety margin for low PH: adding 174, margin is now 194
[08:02:09.568] <TB3> INFO: safety margin for low PH: adding 175, margin is now 195
[08:02:09.574] <TB3> INFO: safety margin for low PH: adding 176, margin is now 196
[08:02:09.581] <TB3> INFO: safety margin for low PH: adding 177, margin is now 197
[08:02:09.586] <TB3> INFO: safety margin for low PH: adding 178, margin is now 198
[08:02:09.592] <TB3> INFO: safety margin for low PH: adding 179, margin is now 199
[08:02:09.599] <TB3> INFO: safety margin for low PH: adding 180, margin is now 200
[08:02:09.604] <TB3> INFO: safety margin for low PH: adding 181, margin is now 201
[08:02:09.610] <TB3> INFO: safety margin for low PH: adding 182, margin is now 202
[08:02:09.617] <TB3> INFO: safety margin for low PH: adding 183, margin is now 203
[08:02:09.622] <TB3> INFO: safety margin for low PH: adding 184, margin is now 204
[08:02:09.629] <TB3> INFO: safety margin for low PH: adding 185, margin is now 205
[08:02:09.635] <TB3> INFO: safety margin for low PH: adding 186, margin is now 206
[08:02:09.640] <TB3> INFO: safety margin for low PH: adding 187, margin is now 207
[08:02:09.646] <TB3> INFO: safety margin for low PH: adding 188, margin is now 208
[08:02:09.652] <TB3> INFO: safety margin for low PH: adding 189, margin is now 209
[08:02:09.657] <TB3> INFO: safety margin for low PH: adding 190, margin is now 210
[08:02:09.663] <TB3> INFO: safety margin for low PH: adding 191, margin is now 211
[08:02:09.669] <TB3> INFO: safety margin for low PH: adding 192, margin is now 212
[08:02:09.674] <TB3> INFO: safety margin for low PH: adding 193, margin is now 213
[08:02:09.680] <TB3> INFO: safety margin for low PH: adding 194, margin is now 214
[08:02:09.686] <TB3> INFO: safety margin for low PH: adding 195, margin is now 215
[08:02:09.691] <TB3> INFO: safety margin for low PH: adding 196, margin is now 216
[08:02:09.697] <TB3> INFO: safety margin for low PH: adding 197, margin is now 217
[08:02:09.703] <TB3> INFO: safety margin for low PH: adding 198, margin is now 218
[08:02:09.708] <TB3> INFO: safety margin for low PH: adding 199, margin is now 219
[08:02:09.714] <TB3> INFO: safety margin for low PH: adding 200, margin is now 220
[08:02:09.720] <TB3> INFO: safety margin for low PH: adding 201, margin is now 221
[08:02:09.725] <TB3> INFO: safety margin for low PH: adding 202, margin is now 222
[08:02:09.731] <TB3> INFO: safety margin for low PH: adding 203, margin is now 223
[08:02:09.737] <TB3> INFO: safety margin for low PH: adding 204, margin is now 224
[08:02:09.742] <TB3> INFO: safety margin for low PH: adding 205, margin is now 225
[08:02:09.748] <TB3> INFO: safety margin for low PH: adding 206, margin is now 226
[08:02:09.754] <TB3> INFO: safety margin for low PH: adding 207, margin is now 227
[08:02:09.759] <TB3> INFO: safety margin for low PH: adding 208, margin is now 228
[08:02:09.765] <TB3> INFO: safety margin for low PH: adding 209, margin is now 229
[08:02:09.771] <TB3> INFO: safety margin for low PH: adding 210, margin is now 230
[08:02:09.776] <TB3> INFO: safety margin for low PH: adding 211, margin is now 231
[08:02:09.782] <TB3> INFO: safety margin for low PH: adding 212, margin is now 232
[08:02:09.788] <TB3> INFO: safety margin for low PH: adding 213, margin is now 233
[08:02:09.794] <TB3> INFO: safety margin for low PH: adding 214, margin is now 234
[08:02:09.800] <TB3> INFO: safety margin for low PH: adding 215, margin is now 235
[08:02:09.805] <TB3> INFO: safety margin for low PH: adding 216, margin is now 236
[08:02:09.811] <TB3> INFO: safety margin for low PH: adding 217, margin is now 237
[08:02:09.817] <TB3> INFO: safety margin for low PH: adding 218, margin is now 238
[08:02:09.822] <TB3> INFO: safety margin for low PH: adding 219, margin is now 239
[08:02:09.828] <TB3> INFO: safety margin for low PH: adding 220, margin is now 240
[08:02:09.834] <TB3> INFO: safety margin for low PH: adding 221, margin is now 241
[08:02:09.839] <TB3> INFO: safety margin for low PH: adding 222, margin is now 242
[08:02:09.845] <TB3> INFO: safety margin for low PH: adding 223, margin is now 243
[08:02:09.851] <TB3> INFO: safety margin for low PH: adding 224, margin is now 244
[08:02:09.856] <TB3> INFO: safety margin for low PH: adding 225, margin is now 245
[08:02:09.862] <TB3> INFO: safety margin for low PH: adding 226, margin is now 246
[08:02:09.869] <TB3> INFO: safety margin for low PH: adding 227, margin is now 247
[08:02:09.875] <TB3> INFO: safety margin for low PH: adding 228, margin is now 248
[08:02:09.881] <TB3> INFO: safety margin for low PH: adding 229, margin is now 249
[08:02:09.887] <TB3> INFO: safety margin for low PH: adding 230, margin is now 250
[08:02:09.893] <TB3> INFO: safety margin for low PH: adding 231, margin is now 251
[08:02:09.899] <TB3> INFO: safety margin for low PH: adding 232, margin is now 252
[08:02:09.905] <TB3> INFO: safety margin for low PH: adding 233, margin is now 253
[08:02:09.911] <TB3> INFO: safety margin for low PH: adding 234, margin is now 254
[08:02:09.917] <TB3> INFO: safety margin for low PH: adding 235, margin is now 255
[08:02:09.923] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:09.929] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:09.935] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:09.941] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:09.947] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:09.953] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:09.959] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:09.965] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[08:02:09.971] <TB3> INFO: safety margin for low PH: adding 8, margin is now 28
[08:02:09.978] <TB3> INFO: safety margin for low PH: adding 9, margin is now 29
[08:02:09.984] <TB3> INFO: safety margin for low PH: adding 10, margin is now 30
[08:02:09.990] <TB3> INFO: safety margin for low PH: adding 11, margin is now 31
[08:02:09.996] <TB3> INFO: safety margin for low PH: adding 12, margin is now 32
[08:02:09.002] <TB3> INFO: safety margin for low PH: adding 13, margin is now 33
[08:02:10.008] <TB3> INFO: safety margin for low PH: adding 14, margin is now 34
[08:02:10.014] <TB3> INFO: safety margin for low PH: adding 15, margin is now 35
[08:02:10.021] <TB3> INFO: safety margin for low PH: adding 16, margin is now 36
[08:02:10.027] <TB3> INFO: safety margin for low PH: adding 17, margin is now 37
[08:02:10.033] <TB3> INFO: safety margin for low PH: adding 18, margin is now 38
[08:02:10.040] <TB3> INFO: safety margin for low PH: adding 19, margin is now 39
[08:02:10.046] <TB3> INFO: safety margin for low PH: adding 20, margin is now 40
[08:02:10.052] <TB3> INFO: safety margin for low PH: adding 21, margin is now 41
[08:02:10.058] <TB3> INFO: safety margin for low PH: adding 22, margin is now 42
[08:02:10.064] <TB3> INFO: safety margin for low PH: adding 23, margin is now 43
[08:02:10.070] <TB3> INFO: safety margin for low PH: adding 24, margin is now 44
[08:02:10.076] <TB3> INFO: safety margin for low PH: adding 25, margin is now 45
[08:02:10.084] <TB3> INFO: safety margin for low PH: adding 26, margin is now 46
[08:02:10.093] <TB3> INFO: safety margin for low PH: adding 27, margin is now 47
[08:02:10.101] <TB3> INFO: safety margin for low PH: adding 28, margin is now 48
[08:02:10.110] <TB3> INFO: safety margin for low PH: adding 29, margin is now 49
[08:02:10.118] <TB3> INFO: safety margin for low PH: adding 30, margin is now 50
[08:02:10.127] <TB3> INFO: safety margin for low PH: adding 31, margin is now 51
[08:02:10.135] <TB3> INFO: safety margin for low PH: adding 32, margin is now 52
[08:02:10.143] <TB3> INFO: safety margin for low PH: adding 33, margin is now 53
[08:02:10.151] <TB3> INFO: safety margin for low PH: adding 34, margin is now 54
[08:02:10.156] <TB3> INFO: safety margin for low PH: adding 35, margin is now 55
[08:02:10.162] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:10.168] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:10.174] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:10.180] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:10.186] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:10.192] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:10.197] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:10.203] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[08:02:10.209] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:10.215] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:10.221] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:10.226] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:10.232] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:10.238] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:10.244] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:10.250] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:10.256] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:10.261] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[08:02:10.267] <TB3> INFO: safety margin for low PH: adding 8, margin is now 28
[08:02:10.273] <TB3> INFO: safety margin for low PH: adding 9, margin is now 29
[08:02:10.279] <TB3> INFO: safety margin for low PH: adding 10, margin is now 30
[08:02:10.285] <TB3> INFO: safety margin for low PH: adding 11, margin is now 31
[08:02:10.291] <TB3> INFO: safety margin for low PH: adding 12, margin is now 32
[08:02:10.297] <TB3> INFO: safety margin for low PH: adding 13, margin is now 33
[08:02:10.303] <TB3> INFO: safety margin for low PH: adding 14, margin is now 34
[08:02:10.308] <TB3> INFO: safety margin for low PH: adding 15, margin is now 35
[08:02:10.314] <TB3> INFO: safety margin for low PH: adding 16, margin is now 36
[08:02:10.320] <TB3> INFO: safety margin for low PH: adding 17, margin is now 37
[08:02:10.326] <TB3> INFO: safety margin for low PH: adding 18, margin is now 38
[08:02:10.331] <TB3> INFO: safety margin for low PH: adding 19, margin is now 39
[08:02:10.337] <TB3> INFO: safety margin for low PH: adding 20, margin is now 40
[08:02:10.343] <TB3> INFO: safety margin for low PH: adding 21, margin is now 41
[08:02:10.349] <TB3> INFO: safety margin for low PH: adding 22, margin is now 42
[08:02:10.354] <TB3> INFO: safety margin for low PH: adding 23, margin is now 43
[08:02:10.360] <TB3> INFO: safety margin for low PH: adding 24, margin is now 44
[08:02:10.367] <TB3> INFO: safety margin for low PH: adding 25, margin is now 45
[08:02:10.373] <TB3> INFO: safety margin for low PH: adding 26, margin is now 46
[08:02:10.379] <TB3> INFO: safety margin for low PH: adding 27, margin is now 47
[08:02:10.385] <TB3> INFO: safety margin for low PH: adding 28, margin is now 48
[08:02:10.391] <TB3> INFO: safety margin for low PH: adding 29, margin is now 49
[08:02:10.397] <TB3> INFO: safety margin for low PH: adding 30, margin is now 50
[08:02:10.403] <TB3> INFO: safety margin for low PH: adding 31, margin is now 51
[08:02:10.409] <TB3> INFO: safety margin for low PH: adding 32, margin is now 52
[08:02:10.415] <TB3> INFO: safety margin for low PH: adding 33, margin is now 53
[08:02:10.421] <TB3> INFO: safety margin for low PH: adding 34, margin is now 54
[08:02:10.427] <TB3> INFO: safety margin for low PH: adding 35, margin is now 55
[08:02:10.436] <TB3> INFO: safety margin for low PH: adding 36, margin is now 56
[08:02:10.443] <TB3> INFO: safety margin for low PH: adding 37, margin is now 57
[08:02:10.452] <TB3> INFO: safety margin for low PH: adding 38, margin is now 58
[08:02:10.460] <TB3> INFO: safety margin for low PH: adding 39, margin is now 59
[08:02:10.469] <TB3> INFO: safety margin for low PH: adding 40, margin is now 60
[08:02:10.477] <TB3> INFO: safety margin for low PH: adding 41, margin is now 61
[08:02:10.485] <TB3> INFO: safety margin for low PH: adding 42, margin is now 62
[08:02:10.494] <TB3> INFO: safety margin for low PH: adding 43, margin is now 63
[08:02:10.503] <TB3> INFO: safety margin for low PH: adding 44, margin is now 64
[08:02:10.511] <TB3> INFO: safety margin for low PH: adding 45, margin is now 65
[08:02:10.520] <TB3> INFO: safety margin for low PH: adding 46, margin is now 66
[08:02:10.528] <TB3> INFO: safety margin for low PH: adding 47, margin is now 67
[08:02:10.536] <TB3> INFO: safety margin for low PH: adding 48, margin is now 68
[08:02:10.544] <TB3> INFO: safety margin for low PH: adding 49, margin is now 69
[08:02:10.553] <TB3> INFO: safety margin for low PH: adding 50, margin is now 70
[08:02:10.561] <TB3> INFO: safety margin for low PH: adding 51, margin is now 71
[08:02:10.569] <TB3> INFO: safety margin for low PH: adding 52, margin is now 72
[08:02:10.577] <TB3> INFO: safety margin for low PH: adding 53, margin is now 73
[08:02:10.585] <TB3> INFO: safety margin for low PH: adding 54, margin is now 74
[08:02:10.593] <TB3> INFO: safety margin for low PH: adding 55, margin is now 75
[08:02:10.602] <TB3> INFO: safety margin for low PH: adding 56, margin is now 76
[08:02:10.610] <TB3> INFO: safety margin for low PH: adding 57, margin is now 77
[08:02:10.619] <TB3> INFO: safety margin for low PH: adding 58, margin is now 78
[08:02:10.627] <TB3> INFO: safety margin for low PH: adding 59, margin is now 79
[08:02:10.635] <TB3> INFO: safety margin for low PH: adding 60, margin is now 80
[08:02:10.643] <TB3> INFO: safety margin for low PH: adding 61, margin is now 81
[08:02:10.652] <TB3> INFO: safety margin for low PH: adding 62, margin is now 82
[08:02:10.660] <TB3> INFO: safety margin for low PH: adding 63, margin is now 83
[08:02:10.669] <TB3> INFO: safety margin for low PH: adding 64, margin is now 84
[08:02:10.677] <TB3> INFO: safety margin for low PH: adding 65, margin is now 85
[08:02:10.685] <TB3> INFO: safety margin for low PH: adding 66, margin is now 86
[08:02:10.693] <TB3> INFO: safety margin for low PH: adding 67, margin is now 87
[08:02:10.702] <TB3> INFO: safety margin for low PH: adding 68, margin is now 88
[08:02:10.710] <TB3> INFO: safety margin for low PH: adding 69, margin is now 89
[08:02:10.719] <TB3> INFO: safety margin for low PH: adding 70, margin is now 90
[08:02:10.727] <TB3> INFO: safety margin for low PH: adding 71, margin is now 91
[08:02:10.736] <TB3> INFO: safety margin for low PH: adding 72, margin is now 92
[08:02:10.744] <TB3> INFO: safety margin for low PH: adding 73, margin is now 93
[08:02:10.752] <TB3> INFO: safety margin for low PH: adding 74, margin is now 94
[08:02:10.760] <TB3> INFO: safety margin for low PH: adding 75, margin is now 95
[08:02:10.769] <TB3> INFO: safety margin for low PH: adding 76, margin is now 96
[08:02:10.777] <TB3> INFO: safety margin for low PH: adding 77, margin is now 97
[08:02:10.785] <TB3> INFO: safety margin for low PH: adding 78, margin is now 98
[08:02:10.793] <TB3> INFO: safety margin for low PH: adding 79, margin is now 99
[08:02:10.802] <TB3> INFO: safety margin for low PH: adding 80, margin is now 100
[08:02:10.810] <TB3> INFO: safety margin for low PH: adding 81, margin is now 101
[08:02:10.818] <TB3> INFO: safety margin for low PH: adding 82, margin is now 102
[08:02:10.826] <TB3> INFO: safety margin for low PH: adding 83, margin is now 103
[08:02:10.835] <TB3> INFO: safety margin for low PH: adding 84, margin is now 104
[08:02:10.843] <TB3> INFO: safety margin for low PH: adding 85, margin is now 105
[08:02:10.851] <TB3> INFO: safety margin for low PH: adding 86, margin is now 106
[08:02:10.859] <TB3> INFO: safety margin for low PH: adding 87, margin is now 107
[08:02:10.868] <TB3> INFO: safety margin for low PH: adding 88, margin is now 108
[08:02:10.876] <TB3> INFO: safety margin for low PH: adding 89, margin is now 109
[08:02:10.885] <TB3> INFO: safety margin for low PH: adding 90, margin is now 110
[08:02:10.893] <TB3> INFO: safety margin for low PH: adding 91, margin is now 111
[08:02:10.901] <TB3> INFO: safety margin for low PH: adding 92, margin is now 112
[08:02:10.909] <TB3> INFO: safety margin for low PH: adding 93, margin is now 113
[08:02:10.918] <TB3> INFO: safety margin for low PH: adding 94, margin is now 114
[08:02:10.926] <TB3> INFO: safety margin for low PH: adding 95, margin is now 115
[08:02:10.935] <TB3> INFO: safety margin for low PH: adding 96, margin is now 116
[08:02:10.943] <TB3> INFO: safety margin for low PH: adding 97, margin is now 117
[08:02:10.951] <TB3> INFO: safety margin for low PH: adding 98, margin is now 118
[08:02:10.959] <TB3> INFO: safety margin for low PH: adding 99, margin is now 119
[08:02:10.968] <TB3> INFO: safety margin for low PH: adding 100, margin is now 120
[08:02:10.976] <TB3> INFO: safety margin for low PH: adding 101, margin is now 121
[08:02:10.984] <TB3> INFO: safety margin for low PH: adding 102, margin is now 122
[08:02:10.993] <TB3> INFO: safety margin for low PH: adding 103, margin is now 123
[08:02:10.001] <TB3> INFO: safety margin for low PH: adding 104, margin is now 124
[08:02:11.009] <TB3> INFO: safety margin for low PH: adding 105, margin is now 125
[08:02:11.017] <TB3> INFO: safety margin for low PH: adding 106, margin is now 126
[08:02:11.026] <TB3> INFO: safety margin for low PH: adding 107, margin is now 127
[08:02:11.034] <TB3> INFO: safety margin for low PH: adding 108, margin is now 128
[08:02:11.042] <TB3> INFO: safety margin for low PH: adding 109, margin is now 129
[08:02:11.050] <TB3> INFO: safety margin for low PH: adding 110, margin is now 130
[08:02:11.058] <TB3> INFO: safety margin for low PH: adding 111, margin is now 131
[08:02:11.067] <TB3> INFO: safety margin for low PH: adding 112, margin is now 132
[08:02:11.075] <TB3> INFO: safety margin for low PH: adding 113, margin is now 133
[08:02:11.083] <TB3> INFO: safety margin for low PH: adding 114, margin is now 134
[08:02:11.091] <TB3> INFO: safety margin for low PH: adding 115, margin is now 135
[08:02:11.100] <TB3> INFO: safety margin for low PH: adding 116, margin is now 136
[08:02:11.108] <TB3> INFO: safety margin for low PH: adding 117, margin is now 137
[08:02:11.116] <TB3> INFO: safety margin for low PH: adding 118, margin is now 138
[08:02:11.124] <TB3> INFO: safety margin for low PH: adding 119, margin is now 139
[08:02:11.133] <TB3> INFO: safety margin for low PH: adding 120, margin is now 140
[08:02:11.141] <TB3> INFO: safety margin for low PH: adding 121, margin is now 141
[08:02:11.149] <TB3> INFO: safety margin for low PH: adding 122, margin is now 142
[08:02:11.158] <TB3> INFO: safety margin for low PH: adding 123, margin is now 143
[08:02:11.166] <TB3> INFO: safety margin for low PH: adding 124, margin is now 144
[08:02:11.174] <TB3> INFO: safety margin for low PH: adding 125, margin is now 145
[08:02:11.183] <TB3> INFO: safety margin for low PH: adding 126, margin is now 146
[08:02:11.191] <TB3> INFO: safety margin for low PH: adding 127, margin is now 147
[08:02:11.199] <TB3> INFO: safety margin for low PH: adding 128, margin is now 148
[08:02:11.207] <TB3> INFO: safety margin for low PH: adding 129, margin is now 149
[08:02:11.216] <TB3> INFO: safety margin for low PH: adding 130, margin is now 150
[08:02:11.224] <TB3> INFO: safety margin for low PH: adding 131, margin is now 151
[08:02:11.232] <TB3> INFO: safety margin for low PH: adding 132, margin is now 152
[08:02:11.241] <TB3> INFO: safety margin for low PH: adding 133, margin is now 153
[08:02:11.249] <TB3> INFO: safety margin for low PH: adding 134, margin is now 154
[08:02:11.257] <TB3> INFO: safety margin for low PH: adding 135, margin is now 155
[08:02:11.265] <TB3> INFO: safety margin for low PH: adding 136, margin is now 156
[08:02:11.273] <TB3> INFO: safety margin for low PH: adding 137, margin is now 157
[08:02:11.281] <TB3> INFO: safety margin for low PH: adding 138, margin is now 158
[08:02:11.286] <TB3> INFO: safety margin for low PH: adding 139, margin is now 159
[08:02:11.292] <TB3> INFO: safety margin for low PH: adding 140, margin is now 160
[08:02:11.298] <TB3> INFO: safety margin for low PH: adding 141, margin is now 161
[08:02:11.303] <TB3> INFO: safety margin for low PH: adding 142, margin is now 162
[08:02:11.309] <TB3> INFO: safety margin for low PH: adding 143, margin is now 163
[08:02:11.315] <TB3> INFO: safety margin for low PH: adding 144, margin is now 164
[08:02:11.321] <TB3> INFO: safety margin for low PH: adding 145, margin is now 165
[08:02:11.326] <TB3> INFO: safety margin for low PH: adding 146, margin is now 166
[08:02:11.332] <TB3> INFO: safety margin for low PH: adding 147, margin is now 167
[08:02:11.338] <TB3> INFO: safety margin for low PH: adding 148, margin is now 168
[08:02:11.343] <TB3> INFO: safety margin for low PH: adding 149, margin is now 169
[08:02:11.349] <TB3> INFO: safety margin for low PH: adding 150, margin is now 170
[08:02:11.355] <TB3> INFO: safety margin for low PH: adding 151, margin is now 171
[08:02:11.361] <TB3> INFO: safety margin for low PH: adding 152, margin is now 172
[08:02:11.367] <TB3> INFO: safety margin for low PH: adding 153, margin is now 173
[08:02:11.373] <TB3> INFO: safety margin for low PH: adding 154, margin is now 174
[08:02:11.378] <TB3> INFO: safety margin for low PH: adding 155, margin is now 175
[08:02:11.384] <TB3> INFO: safety margin for low PH: adding 156, margin is now 176
[08:02:11.390] <TB3> INFO: safety margin for low PH: adding 157, margin is now 177
[08:02:11.396] <TB3> INFO: safety margin for low PH: adding 158, margin is now 178
[08:02:11.402] <TB3> INFO: safety margin for low PH: adding 159, margin is now 179
[08:02:11.407] <TB3> INFO: safety margin for low PH: adding 160, margin is now 180
[08:02:11.413] <TB3> INFO: safety margin for low PH: adding 161, margin is now 181
[08:02:11.419] <TB3> INFO: safety margin for low PH: adding 162, margin is now 182
[08:02:11.425] <TB3> INFO: safety margin for low PH: adding 163, margin is now 183
[08:02:11.430] <TB3> INFO: safety margin for low PH: adding 164, margin is now 184
[08:02:11.436] <TB3> INFO: safety margin for low PH: adding 165, margin is now 185
[08:02:11.442] <TB3> INFO: safety margin for low PH: adding 166, margin is now 186
[08:02:11.448] <TB3> INFO: safety margin for low PH: adding 167, margin is now 187
[08:02:11.454] <TB3> INFO: safety margin for low PH: adding 168, margin is now 188
[08:02:11.460] <TB3> INFO: safety margin for low PH: adding 169, margin is now 189
[08:02:11.470] <TB3> INFO: safety margin for low PH: adding 170, margin is now 190
[08:02:11.485] <TB3> INFO: safety margin for low PH: adding 171, margin is now 191
[08:02:11.492] <TB3> INFO: safety margin for low PH: adding 172, margin is now 192
[08:02:11.499] <TB3> INFO: safety margin for low PH: adding 173, margin is now 193
[08:02:11.506] <TB3> INFO: safety margin for low PH: adding 174, margin is now 194
[08:02:11.512] <TB3> INFO: safety margin for low PH: adding 175, margin is now 195
[08:02:11.519] <TB3> INFO: safety margin for low PH: adding 176, margin is now 196
[08:02:11.525] <TB3> INFO: safety margin for low PH: adding 177, margin is now 197
[08:02:11.531] <TB3> INFO: safety margin for low PH: adding 178, margin is now 198
[08:02:11.537] <TB3> INFO: safety margin for low PH: adding 179, margin is now 199
[08:02:11.543] <TB3> INFO: safety margin for low PH: adding 180, margin is now 200
[08:02:11.550] <TB3> INFO: safety margin for low PH: adding 181, margin is now 201
[08:02:11.556] <TB3> INFO: safety margin for low PH: adding 182, margin is now 202
[08:02:11.563] <TB3> INFO: safety margin for low PH: adding 183, margin is now 203
[08:02:11.570] <TB3> INFO: safety margin for low PH: adding 184, margin is now 204
[08:02:11.576] <TB3> INFO: safety margin for low PH: adding 185, margin is now 205
[08:02:11.583] <TB3> INFO: safety margin for low PH: adding 186, margin is now 206
[08:02:11.589] <TB3> INFO: safety margin for low PH: adding 187, margin is now 207
[08:02:11.594] <TB3> INFO: safety margin for low PH: adding 188, margin is now 208
[08:02:11.600] <TB3> INFO: safety margin for low PH: adding 189, margin is now 209
[08:02:11.606] <TB3> INFO: safety margin for low PH: adding 190, margin is now 210
[08:02:11.612] <TB3> INFO: safety margin for low PH: adding 191, margin is now 211
[08:02:11.618] <TB3> INFO: safety margin for low PH: adding 192, margin is now 212
[08:02:11.624] <TB3> INFO: safety margin for low PH: adding 193, margin is now 213
[08:02:11.630] <TB3> INFO: safety margin for low PH: adding 194, margin is now 214
[08:02:11.636] <TB3> INFO: safety margin for low PH: adding 195, margin is now 215
[08:02:11.641] <TB3> INFO: safety margin for low PH: adding 196, margin is now 216
[08:02:11.647] <TB3> INFO: safety margin for low PH: adding 197, margin is now 217
[08:02:11.653] <TB3> INFO: safety margin for low PH: adding 198, margin is now 218
[08:02:11.659] <TB3> INFO: safety margin for low PH: adding 199, margin is now 219
[08:02:11.665] <TB3> INFO: safety margin for low PH: adding 200, margin is now 220
[08:02:11.670] <TB3> INFO: safety margin for low PH: adding 201, margin is now 221
[08:02:11.676] <TB3> INFO: safety margin for low PH: adding 202, margin is now 222
[08:02:11.682] <TB3> INFO: safety margin for low PH: adding 203, margin is now 223
[08:02:11.688] <TB3> INFO: safety margin for low PH: adding 204, margin is now 224
[08:02:11.694] <TB3> INFO: safety margin for low PH: adding 205, margin is now 225
[08:02:11.700] <TB3> INFO: safety margin for low PH: adding 206, margin is now 226
[08:02:11.706] <TB3> INFO: safety margin for low PH: adding 207, margin is now 227
[08:02:11.712] <TB3> INFO: safety margin for low PH: adding 208, margin is now 228
[08:02:11.718] <TB3> INFO: safety margin for low PH: adding 209, margin is now 229
[08:02:11.724] <TB3> INFO: safety margin for low PH: adding 210, margin is now 230
[08:02:11.729] <TB3> INFO: safety margin for low PH: adding 211, margin is now 231
[08:02:11.735] <TB3> INFO: safety margin for low PH: adding 212, margin is now 232
[08:02:11.741] <TB3> INFO: safety margin for low PH: adding 213, margin is now 233
[08:02:11.747] <TB3> INFO: safety margin for low PH: adding 214, margin is now 234
[08:02:11.752] <TB3> INFO: safety margin for low PH: adding 215, margin is now 235
[08:02:11.758] <TB3> INFO: safety margin for low PH: adding 216, margin is now 236
[08:02:11.764] <TB3> INFO: safety margin for low PH: adding 217, margin is now 237
[08:02:11.770] <TB3> INFO: safety margin for low PH: adding 218, margin is now 238
[08:02:11.775] <TB3> INFO: safety margin for low PH: adding 219, margin is now 239
[08:02:11.781] <TB3> INFO: safety margin for low PH: adding 220, margin is now 240
[08:02:11.787] <TB3> INFO: safety margin for low PH: adding 221, margin is now 241
[08:02:11.793] <TB3> INFO: safety margin for low PH: adding 222, margin is now 242
[08:02:11.799] <TB3> INFO: safety margin for low PH: adding 223, margin is now 243
[08:02:11.804] <TB3> INFO: safety margin for low PH: adding 224, margin is now 244
[08:02:11.810] <TB3> INFO: safety margin for low PH: adding 225, margin is now 245
[08:02:11.816] <TB3> INFO: safety margin for low PH: adding 226, margin is now 246
[08:02:11.822] <TB3> INFO: safety margin for low PH: adding 227, margin is now 247
[08:02:11.828] <TB3> INFO: safety margin for low PH: adding 228, margin is now 248
[08:02:11.834] <TB3> INFO: safety margin for low PH: adding 229, margin is now 249
[08:02:11.839] <TB3> INFO: safety margin for low PH: adding 230, margin is now 250
[08:02:11.845] <TB3> INFO: safety margin for low PH: adding 231, margin is now 251
[08:02:11.851] <TB3> INFO: safety margin for low PH: adding 232, margin is now 252
[08:02:11.857] <TB3> INFO: safety margin for low PH: adding 233, margin is now 253
[08:02:11.863] <TB3> INFO: safety margin for low PH: adding 234, margin is now 254
[08:02:11.869] <TB3> INFO: safety margin for low PH: adding 235, margin is now 255
[08:02:11.874] <TB3> INFO: For ROC 13: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[08:02:11.874] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:11.880] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:11.886] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:11.892] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:11.898] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:11.904] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:11.911] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:11.918] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[08:02:11.924] <TB3> INFO: safety margin for low PH: adding 8, margin is now 28
[08:02:11.931] <TB3> INFO: safety margin for low PH: adding 9, margin is now 29
[08:02:11.938] <TB3> INFO: safety margin for low PH: adding 10, margin is now 30
[08:02:11.944] <TB3> INFO: safety margin for low PH: adding 11, margin is now 31
[08:02:11.951] <TB3> INFO: safety margin for low PH: adding 12, margin is now 32
[08:02:11.958] <TB3> INFO: safety margin for low PH: adding 13, margin is now 33
[08:02:11.965] <TB3> INFO: safety margin for low PH: adding 14, margin is now 34
[08:02:11.971] <TB3> INFO: safety margin for low PH: adding 15, margin is now 35
[08:02:11.977] <TB3> INFO: safety margin for low PH: adding 16, margin is now 36
[08:02:11.984] <TB3> INFO: safety margin for low PH: adding 17, margin is now 37
[08:02:11.991] <TB3> INFO: safety margin for low PH: adding 18, margin is now 38
[08:02:11.998] <TB3> INFO: safety margin for low PH: adding 19, margin is now 39
[08:02:12.005] <TB3> INFO: safety margin for low PH: adding 20, margin is now 40
[08:02:12.011] <TB3> INFO: safety margin for low PH: adding 21, margin is now 41
[08:02:12.019] <TB3> INFO: safety margin for low PH: adding 22, margin is now 42
[08:02:12.025] <TB3> INFO: safety margin for low PH: adding 23, margin is now 43
[08:02:12.032] <TB3> INFO: safety margin for low PH: adding 24, margin is now 44
[08:02:12.039] <TB3> INFO: safety margin for low PH: adding 25, margin is now 45
[08:02:12.046] <TB3> INFO: safety margin for low PH: adding 26, margin is now 46
[08:02:12.053] <TB3> INFO: safety margin for low PH: adding 27, margin is now 47
[08:02:12.059] <TB3> INFO: safety margin for low PH: adding 28, margin is now 48
[08:02:12.066] <TB3> INFO: safety margin for low PH: adding 29, margin is now 49
[08:02:12.072] <TB3> INFO: safety margin for low PH: adding 30, margin is now 50
[08:02:12.078] <TB3> INFO: safety margin for low PH: adding 31, margin is now 51
[08:02:12.084] <TB3> INFO: safety margin for low PH: adding 32, margin is now 52
[08:02:12.090] <TB3> INFO: safety margin for low PH: adding 33, margin is now 53
[08:02:12.096] <TB3> INFO: safety margin for low PH: adding 34, margin is now 54
[08:02:12.102] <TB3> INFO: safety margin for low PH: adding 35, margin is now 55
[08:02:12.108] <TB3> INFO: safety margin for low PH: adding 36, margin is now 56
[08:02:12.114] <TB3> INFO: safety margin for low PH: adding 37, margin is now 57
[08:02:12.119] <TB3> INFO: safety margin for low PH: adding 38, margin is now 58
[08:02:12.125] <TB3> INFO: safety margin for low PH: adding 39, margin is now 59
[08:02:12.131] <TB3> INFO: safety margin for low PH: adding 40, margin is now 60
[08:02:12.137] <TB3> INFO: safety margin for low PH: adding 41, margin is now 61
[08:02:12.143] <TB3> INFO: safety margin for low PH: adding 42, margin is now 62
[08:02:12.149] <TB3> INFO: safety margin for low PH: adding 43, margin is now 63
[08:02:12.155] <TB3> INFO: safety margin for low PH: adding 44, margin is now 64
[08:02:12.160] <TB3> INFO: safety margin for low PH: adding 45, margin is now 65
[08:02:12.166] <TB3> INFO: safety margin for low PH: adding 46, margin is now 66
[08:02:12.172] <TB3> INFO: safety margin for low PH: adding 47, margin is now 67
[08:02:12.178] <TB3> INFO: safety margin for low PH: adding 48, margin is now 68
[08:02:12.184] <TB3> INFO: safety margin for low PH: adding 49, margin is now 69
[08:02:12.190] <TB3> INFO: safety margin for low PH: adding 50, margin is now 70
[08:02:12.196] <TB3> INFO: safety margin for low PH: adding 51, margin is now 71
[08:02:12.202] <TB3> INFO: safety margin for low PH: adding 52, margin is now 72
[08:02:12.207] <TB3> INFO: safety margin for low PH: adding 53, margin is now 73
[08:02:12.213] <TB3> INFO: safety margin for low PH: adding 54, margin is now 74
[08:02:12.219] <TB3> INFO: safety margin for low PH: adding 55, margin is now 75
[08:02:12.225] <TB3> INFO: safety margin for low PH: adding 56, margin is now 76
[08:02:12.230] <TB3> INFO: safety margin for low PH: adding 57, margin is now 77
[08:02:12.236] <TB3> INFO: safety margin for low PH: adding 58, margin is now 78
[08:02:12.242] <TB3> INFO: safety margin for low PH: adding 59, margin is now 79
[08:02:12.248] <TB3> INFO: safety margin for low PH: adding 60, margin is now 80
[08:02:12.254] <TB3> INFO: safety margin for low PH: adding 61, margin is now 81
[08:02:12.260] <TB3> INFO: safety margin for low PH: adding 62, margin is now 82
[08:02:12.266] <TB3> INFO: safety margin for low PH: adding 63, margin is now 83
[08:02:12.271] <TB3> INFO: safety margin for low PH: adding 64, margin is now 84
[08:02:12.277] <TB3> INFO: safety margin for low PH: adding 65, margin is now 85
[08:02:12.283] <TB3> INFO: safety margin for low PH: adding 66, margin is now 86
[08:02:12.289] <TB3> INFO: safety margin for low PH: adding 67, margin is now 87
[08:02:12.295] <TB3> INFO: safety margin for low PH: adding 68, margin is now 88
[08:02:12.301] <TB3> INFO: safety margin for low PH: adding 69, margin is now 89
[08:02:12.307] <TB3> INFO: safety margin for low PH: adding 70, margin is now 90
[08:02:12.312] <TB3> INFO: safety margin for low PH: adding 71, margin is now 91
[08:02:12.319] <TB3> INFO: safety margin for low PH: adding 72, margin is now 92
[08:02:12.324] <TB3> INFO: safety margin for low PH: adding 73, margin is now 93
[08:02:12.330] <TB3> INFO: safety margin for low PH: adding 74, margin is now 94
[08:02:12.336] <TB3> INFO: safety margin for low PH: adding 75, margin is now 95
[08:02:12.342] <TB3> INFO: safety margin for low PH: adding 76, margin is now 96
[08:02:12.348] <TB3> INFO: safety margin for low PH: adding 77, margin is now 97
[08:02:12.354] <TB3> INFO: safety margin for low PH: adding 78, margin is now 98
[08:02:12.359] <TB3> INFO: safety margin for low PH: adding 79, margin is now 99
[08:02:12.365] <TB3> INFO: safety margin for low PH: adding 80, margin is now 100
[08:02:12.372] <TB3> INFO: safety margin for low PH: adding 81, margin is now 101
[08:02:12.379] <TB3> INFO: safety margin for low PH: adding 82, margin is now 102
[08:02:12.385] <TB3> INFO: safety margin for low PH: adding 83, margin is now 103
[08:02:12.392] <TB3> INFO: safety margin for low PH: adding 84, margin is now 104
[08:02:12.398] <TB3> INFO: safety margin for low PH: adding 85, margin is now 105
[08:02:12.404] <TB3> INFO: safety margin for low PH: adding 86, margin is now 106
[08:02:12.409] <TB3> INFO: safety margin for low PH: adding 87, margin is now 107
[08:02:12.416] <TB3> INFO: safety margin for low PH: adding 88, margin is now 108
[08:02:12.422] <TB3> INFO: safety margin for low PH: adding 89, margin is now 109
[08:02:12.427] <TB3> INFO: safety margin for low PH: adding 90, margin is now 110
[08:02:12.433] <TB3> INFO: safety margin for low PH: adding 91, margin is now 111
[08:02:12.439] <TB3> INFO: safety margin for low PH: adding 92, margin is now 112
[08:02:12.445] <TB3> INFO: safety margin for low PH: adding 93, margin is now 113
[08:02:12.451] <TB3> INFO: safety margin for low PH: adding 94, margin is now 114
[08:02:12.457] <TB3> INFO: safety margin for low PH: adding 95, margin is now 115
[08:02:12.463] <TB3> INFO: safety margin for low PH: adding 96, margin is now 116
[08:02:12.469] <TB3> INFO: safety margin for low PH: adding 97, margin is now 117
[08:02:12.474] <TB3> INFO: safety margin for low PH: adding 98, margin is now 118
[08:02:12.480] <TB3> INFO: safety margin for low PH: adding 99, margin is now 119
[08:02:12.486] <TB3> INFO: safety margin for low PH: adding 100, margin is now 120
[08:02:12.492] <TB3> INFO: safety margin for low PH: adding 101, margin is now 121
[08:02:12.498] <TB3> INFO: safety margin for low PH: adding 102, margin is now 122
[08:02:12.504] <TB3> INFO: safety margin for low PH: adding 103, margin is now 123
[08:02:12.509] <TB3> INFO: safety margin for low PH: adding 104, margin is now 124
[08:02:12.515] <TB3> INFO: safety margin for low PH: adding 105, margin is now 125
[08:02:12.521] <TB3> INFO: safety margin for low PH: adding 106, margin is now 126
[08:02:12.527] <TB3> INFO: safety margin for low PH: adding 107, margin is now 127
[08:02:12.533] <TB3> INFO: safety margin for low PH: adding 108, margin is now 128
[08:02:12.539] <TB3> INFO: safety margin for low PH: adding 109, margin is now 129
[08:02:12.545] <TB3> INFO: safety margin for low PH: adding 110, margin is now 130
[08:02:12.551] <TB3> INFO: safety margin for low PH: adding 111, margin is now 131
[08:02:12.557] <TB3> INFO: safety margin for low PH: adding 112, margin is now 132
[08:02:12.563] <TB3> INFO: safety margin for low PH: adding 113, margin is now 133
[08:02:12.569] <TB3> INFO: safety margin for low PH: adding 114, margin is now 134
[08:02:12.574] <TB3> INFO: safety margin for low PH: adding 115, margin is now 135
[08:02:12.580] <TB3> INFO: safety margin for low PH: adding 116, margin is now 136
[08:02:12.587] <TB3> INFO: safety margin for low PH: adding 117, margin is now 137
[08:02:12.593] <TB3> INFO: safety margin for low PH: adding 118, margin is now 138
[08:02:12.599] <TB3> INFO: safety margin for low PH: adding 119, margin is now 139
[08:02:12.606] <TB3> INFO: safety margin for low PH: adding 120, margin is now 140
[08:02:12.615] <TB3> INFO: safety margin for low PH: adding 121, margin is now 141
[08:02:12.624] <TB3> INFO: safety margin for low PH: adding 122, margin is now 142
[08:02:12.633] <TB3> INFO: safety margin for low PH: adding 123, margin is now 143
[08:02:12.642] <TB3> INFO: safety margin for low PH: adding 124, margin is now 144
[08:02:12.651] <TB3> INFO: safety margin for low PH: adding 125, margin is now 145
[08:02:12.660] <TB3> INFO: safety margin for low PH: adding 126, margin is now 146
[08:02:12.669] <TB3> INFO: safety margin for low PH: adding 127, margin is now 147
[08:02:12.678] <TB3> INFO: safety margin for low PH: adding 128, margin is now 148
[08:02:12.687] <TB3> INFO: safety margin for low PH: adding 129, margin is now 149
[08:02:12.696] <TB3> INFO: safety margin for low PH: adding 130, margin is now 150
[08:02:12.705] <TB3> INFO: safety margin for low PH: adding 131, margin is now 151
[08:02:12.714] <TB3> INFO: safety margin for low PH: adding 132, margin is now 152
[08:02:12.723] <TB3> INFO: safety margin for low PH: adding 133, margin is now 153
[08:02:12.732] <TB3> INFO: safety margin for low PH: adding 134, margin is now 154
[08:02:12.740] <TB3> INFO: safety margin for low PH: adding 135, margin is now 155
[08:02:12.749] <TB3> INFO: safety margin for low PH: adding 136, margin is now 156
[08:02:12.758] <TB3> INFO: safety margin for low PH: adding 137, margin is now 157
[08:02:12.767] <TB3> INFO: safety margin for low PH: adding 138, margin is now 158
[08:02:12.776] <TB3> INFO: safety margin for low PH: adding 139, margin is now 159
[08:02:12.785] <TB3> INFO: safety margin for low PH: adding 140, margin is now 160
[08:02:12.793] <TB3> INFO: safety margin for low PH: adding 141, margin is now 161
[08:02:12.802] <TB3> INFO: safety margin for low PH: adding 142, margin is now 162
[08:02:12.810] <TB3> INFO: safety margin for low PH: adding 143, margin is now 163
[08:02:12.819] <TB3> INFO: safety margin for low PH: adding 144, margin is now 164
[08:02:12.828] <TB3> INFO: safety margin for low PH: adding 145, margin is now 165
[08:02:12.836] <TB3> INFO: safety margin for low PH: adding 146, margin is now 166
[08:02:12.844] <TB3> INFO: safety margin for low PH: adding 147, margin is now 167
[08:02:12.853] <TB3> INFO: safety margin for low PH: adding 148, margin is now 168
[08:02:12.861] <TB3> INFO: safety margin for low PH: adding 149, margin is now 169
[08:02:12.870] <TB3> INFO: safety margin for low PH: adding 150, margin is now 170
[08:02:12.878] <TB3> INFO: safety margin for low PH: adding 151, margin is now 171
[08:02:12.888] <TB3> INFO: safety margin for low PH: adding 152, margin is now 172
[08:02:12.900] <TB3> INFO: safety margin for low PH: adding 153, margin is now 173
[08:02:12.909] <TB3> INFO: safety margin for low PH: adding 154, margin is now 174
[08:02:12.918] <TB3> INFO: safety margin for low PH: adding 155, margin is now 175
[08:02:12.927] <TB3> INFO: safety margin for low PH: adding 156, margin is now 176
[08:02:12.935] <TB3> INFO: safety margin for low PH: adding 157, margin is now 177
[08:02:12.943] <TB3> INFO: safety margin for low PH: adding 158, margin is now 178
[08:02:12.952] <TB3> INFO: safety margin for low PH: adding 159, margin is now 179
[08:02:12.960] <TB3> INFO: safety margin for low PH: adding 160, margin is now 180
[08:02:12.969] <TB3> INFO: safety margin for low PH: adding 161, margin is now 181
[08:02:12.976] <TB3> INFO: safety margin for low PH: adding 162, margin is now 182
[08:02:12.985] <TB3> INFO: safety margin for low PH: adding 163, margin is now 183
[08:02:12.994] <TB3> INFO: safety margin for low PH: adding 164, margin is now 184
[08:02:12.002] <TB3> INFO: safety margin for low PH: adding 165, margin is now 185
[08:02:13.011] <TB3> INFO: safety margin for low PH: adding 166, margin is now 186
[08:02:13.019] <TB3> INFO: safety margin for low PH: adding 167, margin is now 187
[08:02:13.028] <TB3> INFO: safety margin for low PH: adding 168, margin is now 188
[08:02:13.036] <TB3> INFO: safety margin for low PH: adding 169, margin is now 189
[08:02:13.044] <TB3> INFO: safety margin for low PH: adding 170, margin is now 190
[08:02:13.053] <TB3> INFO: safety margin for low PH: adding 171, margin is now 191
[08:02:13.061] <TB3> INFO: safety margin for low PH: adding 172, margin is now 192
[08:02:13.069] <TB3> INFO: safety margin for low PH: adding 173, margin is now 193
[08:02:13.077] <TB3> INFO: safety margin for low PH: adding 174, margin is now 194
[08:02:13.085] <TB3> INFO: safety margin for low PH: adding 175, margin is now 195
[08:02:13.093] <TB3> INFO: safety margin for low PH: adding 176, margin is now 196
[08:02:13.102] <TB3> INFO: safety margin for low PH: adding 177, margin is now 197
[08:02:13.110] <TB3> INFO: safety margin for low PH: adding 178, margin is now 198
[08:02:13.119] <TB3> INFO: safety margin for low PH: adding 179, margin is now 199
[08:02:13.127] <TB3> INFO: safety margin for low PH: adding 180, margin is now 200
[08:02:13.135] <TB3> INFO: safety margin for low PH: adding 181, margin is now 201
[08:02:13.143] <TB3> INFO: safety margin for low PH: adding 182, margin is now 202
[08:02:13.152] <TB3> INFO: safety margin for low PH: adding 183, margin is now 203
[08:02:13.160] <TB3> INFO: safety margin for low PH: adding 184, margin is now 204
[08:02:13.168] <TB3> INFO: safety margin for low PH: adding 185, margin is now 205
[08:02:13.176] <TB3> INFO: safety margin for low PH: adding 186, margin is now 206
[08:02:13.185] <TB3> INFO: safety margin for low PH: adding 187, margin is now 207
[08:02:13.193] <TB3> INFO: safety margin for low PH: adding 188, margin is now 208
[08:02:13.202] <TB3> INFO: safety margin for low PH: adding 189, margin is now 209
[08:02:13.210] <TB3> INFO: safety margin for low PH: adding 190, margin is now 210
[08:02:13.218] <TB3> INFO: safety margin for low PH: adding 191, margin is now 211
[08:02:13.224] <TB3> INFO: safety margin for low PH: adding 192, margin is now 212
[08:02:13.229] <TB3> INFO: safety margin for low PH: adding 193, margin is now 213
[08:02:13.235] <TB3> INFO: safety margin for low PH: adding 194, margin is now 214
[08:02:13.241] <TB3> INFO: safety margin for low PH: adding 195, margin is now 215
[08:02:13.247] <TB3> INFO: safety margin for low PH: adding 196, margin is now 216
[08:02:13.252] <TB3> INFO: safety margin for low PH: adding 197, margin is now 217
[08:02:13.258] <TB3> INFO: safety margin for low PH: adding 198, margin is now 218
[08:02:13.264] <TB3> INFO: safety margin for low PH: adding 199, margin is now 219
[08:02:13.270] <TB3> INFO: safety margin for low PH: adding 200, margin is now 220
[08:02:13.275] <TB3> INFO: safety margin for low PH: adding 201, margin is now 221
[08:02:13.281] <TB3> INFO: safety margin for low PH: adding 202, margin is now 222
[08:02:13.287] <TB3> INFO: safety margin for low PH: adding 203, margin is now 223
[08:02:13.293] <TB3> INFO: safety margin for low PH: adding 204, margin is now 224
[08:02:13.299] <TB3> INFO: safety margin for low PH: adding 205, margin is now 225
[08:02:13.305] <TB3> INFO: safety margin for low PH: adding 206, margin is now 226
[08:02:13.311] <TB3> INFO: safety margin for low PH: adding 207, margin is now 227
[08:02:13.317] <TB3> INFO: safety margin for low PH: adding 208, margin is now 228
[08:02:13.323] <TB3> INFO: safety margin for low PH: adding 209, margin is now 229
[08:02:13.330] <TB3> INFO: safety margin for low PH: adding 210, margin is now 230
[08:02:13.336] <TB3> INFO: safety margin for low PH: adding 211, margin is now 231
[08:02:13.342] <TB3> INFO: safety margin for low PH: adding 212, margin is now 232
[08:02:13.349] <TB3> INFO: safety margin for low PH: adding 213, margin is now 233
[08:02:13.355] <TB3> INFO: safety margin for low PH: adding 214, margin is now 234
[08:02:13.361] <TB3> INFO: safety margin for low PH: adding 215, margin is now 235
[08:02:13.367] <TB3> INFO: safety margin for low PH: adding 216, margin is now 236
[08:02:13.373] <TB3> INFO: safety margin for low PH: adding 217, margin is now 237
[08:02:13.379] <TB3> INFO: safety margin for low PH: adding 218, margin is now 238
[08:02:13.385] <TB3> INFO: safety margin for low PH: adding 219, margin is now 239
[08:02:13.392] <TB3> INFO: safety margin for low PH: adding 220, margin is now 240
[08:02:13.398] <TB3> INFO: safety margin for low PH: adding 221, margin is now 241
[08:02:13.404] <TB3> INFO: safety margin for low PH: adding 222, margin is now 242
[08:02:13.410] <TB3> INFO: safety margin for low PH: adding 223, margin is now 243
[08:02:13.416] <TB3> INFO: safety margin for low PH: adding 224, margin is now 244
[08:02:13.422] <TB3> INFO: safety margin for low PH: adding 225, margin is now 245
[08:02:13.429] <TB3> INFO: safety margin for low PH: adding 226, margin is now 246
[08:02:13.435] <TB3> INFO: safety margin for low PH: adding 227, margin is now 247
[08:02:13.441] <TB3> INFO: safety margin for low PH: adding 228, margin is now 248
[08:02:13.450] <TB3> INFO: safety margin for low PH: adding 229, margin is now 249
[08:02:13.456] <TB3> INFO: safety margin for low PH: adding 230, margin is now 250
[08:02:13.462] <TB3> INFO: safety margin for low PH: adding 231, margin is now 251
[08:02:13.468] <TB3> INFO: safety margin for low PH: adding 232, margin is now 252
[08:02:13.474] <TB3> INFO: safety margin for low PH: adding 233, margin is now 253
[08:02:13.481] <TB3> INFO: safety margin for low PH: adding 234, margin is now 254
[08:02:13.488] <TB3> INFO: safety margin for low PH: adding 235, margin is now 255
[08:02:13.495] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:13.504] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:13.513] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:13.521] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:13.530] <TB3> INFO: safety margin for low PH: adding 4, margin is now 24
[08:02:13.538] <TB3> INFO: safety margin for low PH: adding 5, margin is now 25
[08:02:13.546] <TB3> INFO: safety margin for low PH: adding 6, margin is now 26
[08:02:13.554] <TB3> INFO: safety margin for low PH: adding 7, margin is now 27
[08:02:13.562] <TB3> INFO: safety margin for low PH: adding 8, margin is now 28
[08:02:13.571] <TB3> INFO: safety margin for low PH: adding 9, margin is now 29
[08:02:13.579] <TB3> INFO: safety margin for low PH: adding 10, margin is now 30
[08:02:13.587] <TB3> INFO: safety margin for low PH: adding 11, margin is now 31
[08:02:13.595] <TB3> INFO: safety margin for low PH: adding 12, margin is now 32
[08:02:13.603] <TB3> INFO: safety margin for low PH: adding 0, margin is now 20
[08:02:13.612] <TB3> INFO: safety margin for low PH: adding 1, margin is now 21
[08:02:13.620] <TB3> INFO: safety margin for low PH: adding 2, margin is now 22
[08:02:13.628] <TB3> INFO: safety margin for low PH: adding 3, margin is now 23
[08:02:13.672] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C0.dat
[08:02:13.672] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C1.dat
[08:02:13.672] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C2.dat
[08:02:13.672] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C3.dat
[08:02:13.672] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C4.dat
[08:02:13.673] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C5.dat
[08:02:13.673] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C6.dat
[08:02:13.673] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C7.dat
[08:02:13.673] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C8.dat
[08:02:13.674] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C9.dat
[08:02:13.674] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C10.dat
[08:02:13.674] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C11.dat
[08:02:13.674] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C12.dat
[08:02:13.674] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C13.dat
[08:02:13.675] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C14.dat
[08:02:13.675] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters35_C15.dat
[08:02:13.922] <TB3> INFO: Expecting 41600 events.
[08:02:17.097] <TB3> INFO: 41600 events read in total (2583ms).
[08:02:17.098] <TB3> INFO: Test took 3418ms.
[08:02:17.560] <TB3> INFO: Expecting 41600 events.
[08:02:20.633] <TB3> INFO: 41600 events read in total (2482ms).
[08:02:20.634] <TB3> INFO: Test took 3318ms.
[08:02:21.091] <TB3> INFO: Expecting 41600 events.
[08:02:24.284] <TB3> INFO: 41600 events read in total (2602ms).
[08:02:24.285] <TB3> INFO: Test took 3436ms.
[08:02:24.506] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:24.595] <TB3> INFO: Expecting 2560 events.
[08:02:25.491] <TB3> INFO: 2560 events read in total (304ms).
[08:02:25.493] <TB3> INFO: Test took 987ms.
[08:02:25.496] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:25.800] <TB3> INFO: Expecting 2560 events.
[08:02:26.694] <TB3> INFO: 2560 events read in total (303ms).
[08:02:26.695] <TB3> INFO: Test took 1199ms.
[08:02:26.697] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:26.002] <TB3> INFO: Expecting 2560 events.
[08:02:27.889] <TB3> INFO: 2560 events read in total (295ms).
[08:02:27.890] <TB3> INFO: Test took 1193ms.
[08:02:27.894] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:28.198] <TB3> INFO: Expecting 2560 events.
[08:02:29.091] <TB3> INFO: 2560 events read in total (301ms).
[08:02:29.091] <TB3> INFO: Test took 1197ms.
[08:02:29.094] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:29.399] <TB3> INFO: Expecting 2560 events.
[08:02:30.283] <TB3> INFO: 2560 events read in total (292ms).
[08:02:30.283] <TB3> INFO: Test took 1189ms.
[08:02:30.285] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:30.592] <TB3> INFO: Expecting 2560 events.
[08:02:31.477] <TB3> INFO: 2560 events read in total (294ms).
[08:02:31.477] <TB3> INFO: Test took 1192ms.
[08:02:31.480] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:31.786] <TB3> INFO: Expecting 2560 events.
[08:02:32.681] <TB3> INFO: 2560 events read in total (303ms).
[08:02:32.681] <TB3> INFO: Test took 1201ms.
[08:02:32.686] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:32.988] <TB3> INFO: Expecting 2560 events.
[08:02:33.874] <TB3> INFO: 2560 events read in total (294ms).
[08:02:33.875] <TB3> INFO: Test took 1189ms.
[08:02:33.879] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:34.182] <TB3> INFO: Expecting 2560 events.
[08:02:35.070] <TB3> INFO: 2560 events read in total (296ms).
[08:02:35.070] <TB3> INFO: Test took 1191ms.
[08:02:35.073] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:35.377] <TB3> INFO: Expecting 2560 events.
[08:02:36.259] <TB3> INFO: 2560 events read in total (290ms).
[08:02:36.259] <TB3> INFO: Test took 1186ms.
[08:02:36.262] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:36.568] <TB3> INFO: Expecting 2560 events.
[08:02:37.455] <TB3> INFO: 2560 events read in total (295ms).
[08:02:37.456] <TB3> INFO: Test took 1194ms.
[08:02:37.459] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:37.765] <TB3> INFO: Expecting 2560 events.
[08:02:38.647] <TB3> INFO: 2560 events read in total (290ms).
[08:02:38.647] <TB3> INFO: Test took 1188ms.
[08:02:38.650] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:38.956] <TB3> INFO: Expecting 2560 events.
[08:02:39.844] <TB3> INFO: 2560 events read in total (296ms).
[08:02:39.845] <TB3> INFO: Test took 1195ms.
[08:02:39.848] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:40.153] <TB3> INFO: Expecting 2560 events.
[08:02:41.043] <TB3> INFO: 2560 events read in total (299ms).
[08:02:41.043] <TB3> INFO: Test took 1195ms.
[08:02:41.047] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:41.352] <TB3> INFO: Expecting 2560 events.
[08:02:42.239] <TB3> INFO: 2560 events read in total (296ms).
[08:02:42.240] <TB3> INFO: Test took 1193ms.
[08:02:42.243] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:42.547] <TB3> INFO: Expecting 2560 events.
[08:02:43.439] <TB3> INFO: 2560 events read in total (300ms).
[08:02:43.440] <TB3> INFO: Test took 1197ms.



[08:02:43.747] <TB3> INFO: Test took 304ms.
[08:02:43.750] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:44.216] <TB3> INFO: Expecting 2560 events.
[08:02:45.104] <TB3> INFO: 2560 events read in total (297ms).
[08:02:45.105] <TB3> INFO: Test took 1355ms.
[08:02:45.108] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:45.413] <TB3> INFO: Expecting 2560 events.
[08:02:46.292] <TB3> INFO: 2560 events read in total (287ms).
[08:02:46.292] <TB3> INFO: Test took 1184ms.
[08:02:46.295] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:46.601] <TB3> INFO: Expecting 2560 events.
[08:02:47.491] <TB3> INFO: 2560 events read in total (298ms).
[08:02:47.491] <TB3> INFO: Test took 1197ms.
[08:02:47.494] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:47.801] <TB3> INFO: Expecting 2560 events.
[08:02:48.687] <TB3> INFO: 2560 events read in total (294ms).
[08:02:48.687] <TB3> INFO: Test took 1193ms.
[08:02:48.689] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:48.996] <TB3> INFO: Expecting 2560 events.
[08:02:49.879] <TB3> INFO: 2560 events read in total (291ms).
[08:02:49.881] <TB3> INFO: Test took 1192ms.
[08:02:49.883] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:50.187] <TB3> INFO: Expecting 2560 events.
[08:02:51.076] <TB3> INFO: 2560 events read in total (297ms).
[08:02:51.076] <TB3> INFO: Test took 1194ms.
[08:02:51.079] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:51.386] <TB3> INFO: Expecting 2560 events.
[08:02:52.277] <TB3> INFO: 2560 events read in total (299ms).
[08:02:52.278] <TB3> INFO: Test took 1199ms.
[08:02:52.283] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:52.586] <TB3> INFO: Expecting 2560 events.
[08:02:53.477] <TB3> INFO: 2560 events read in total (299ms).
[08:02:53.478] <TB3> INFO: Test took 1195ms.
[08:02:53.482] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:53.785] <TB3> INFO: Expecting 2560 events.
[08:02:54.679] <TB3> INFO: 2560 events read in total (303ms).
[08:02:54.679] <TB3> INFO: Test took 1198ms.



[08:02:54.987] <TB3> INFO: Test took 305ms.
[08:02:54.990] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:55.455] <TB3> INFO: Expecting 2560 events.
[08:02:56.346] <TB3> INFO: 2560 events read in total (299ms).
[08:02:56.346] <TB3> INFO: Test took 1356ms.
[08:02:56.349] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:56.655] <TB3> INFO: Expecting 2560 events.
[08:02:57.546] <TB3> INFO: 2560 events read in total (300ms).
[08:02:57.547] <TB3> INFO: Test took 1198ms.
[08:02:57.551] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:57.855] <TB3> INFO: Expecting 2560 events.
[08:02:58.749] <TB3> INFO: 2560 events read in total (302ms).
[08:02:58.750] <TB3> INFO: Test took 1199ms.
[08:02:58.753] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:02:59.058] <TB3> INFO: Expecting 2560 events.
[08:02:59.946] <TB3> INFO: 2560 events read in total (296ms).
[08:02:59.946] <TB3> INFO: Test took 1193ms.
[08:02:59.950] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:03:00.254] <TB3> INFO: Expecting 2560 events.
[08:03:01.152] <TB3> INFO: 2560 events read in total (307ms).
[08:03:01.153] <TB3> INFO: Test took 1203ms.
[08:03:01.634] <TB3> INFO: PixTestPhOptimization::doTest() done, duration: 721 seconds
[08:03:01.634] <TB3> INFO: PH scale (per ROC): 33 24 44 28 31 37 48 23 0 21 25 29 30 0 37 28
[08:03:01.634] <TB3> INFO: PH offset (per ROC): 91 115 90 105 96 106 130 86 0 117 114 92 92 0 90 105
[08:03:01.644] <TB3> INFO: Decoding statistics:
[08:03:01.644] <TB3> INFO: General information:
[08:03:01.644] <TB3> INFO: 16bit words read: 127886
[08:03:01.645] <TB3> INFO: valid events total: 20480
[08:03:01.645] <TB3> INFO: empty events: 17977
[08:03:01.645] <TB3> INFO: valid events with pixels: 2503
[08:03:01.645] <TB3> INFO: valid pixel hits: 2503
[08:03:01.645] <TB3> INFO: Event errors: 0
[08:03:01.645] <TB3> INFO: start marker: 0
[08:03:01.645] <TB3> INFO: stop marker: 0
[08:03:01.645] <TB3> INFO: overflow: 0
[08:03:01.645] <TB3> INFO: invalid 5bit words: 0
[08:03:01.645] <TB3> INFO: invalid XOR eye diagram: 0
[08:03:01.645] <TB3> INFO: frame (failed synchr.): 0
[08:03:01.645] <TB3> INFO: idle data (no TBM trl): 0
[08:03:01.645] <TB3> INFO: no data (only TBM hdr): 0
[08:03:01.645] <TB3> INFO: TBM errors: 0
[08:03:01.645] <TB3> INFO: flawed TBM headers: 0
[08:03:01.645] <TB3> INFO: flawed TBM trailers: 0
[08:03:01.645] <TB3> INFO: event ID mismatches: 0
[08:03:01.645] <TB3> INFO: ROC errors: 0
[08:03:01.645] <TB3> INFO: missing ROC header(s): 0
[08:03:01.645] <TB3> INFO: misplaced readback start: 0
[08:03:01.645] <TB3> INFO: Pixel decoding errors: 0
[08:03:01.645] <TB3> INFO: pixel data incomplete: 0
[08:03:01.645] <TB3> INFO: pixel address: 0
[08:03:01.645] <TB3> INFO: pulse height fill bit: 0
[08:03:01.645] <TB3> INFO: buffer corruption: 0
[08:03:01.837] <TB3> INFO: ######################################################################
[08:03:01.837] <TB3> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[08:03:01.837] <TB3> INFO: ######################################################################
[08:03:01.854] <TB3> INFO: scanning low vcal = 10
[08:03:02.095] <TB3> INFO: Expecting 41600 events.
[08:03:05.736] <TB3> INFO: 41600 events read in total (3050ms).
[08:03:05.736] <TB3> INFO: Test took 3882ms.
[08:03:05.738] <TB3> INFO: scanning low vcal = 20
[08:03:06.033] <TB3> INFO: Expecting 41600 events.
[08:03:09.657] <TB3> INFO: 41600 events read in total (3032ms).
[08:03:09.658] <TB3> INFO: Test took 3919ms.
[08:03:09.659] <TB3> INFO: scanning low vcal = 30
[08:03:09.952] <TB3> INFO: Expecting 41600 events.
[08:03:13.648] <TB3> INFO: 41600 events read in total (3105ms).
[08:03:13.649] <TB3> INFO: Test took 3990ms.
[08:03:13.651] <TB3> INFO: scanning low vcal = 40
[08:03:13.929] <TB3> INFO: Expecting 41600 events.
[08:03:17.914] <TB3> INFO: 41600 events read in total (3393ms).
[08:03:17.915] <TB3> INFO: Test took 4264ms.
[08:03:17.918] <TB3> INFO: scanning low vcal = 50
[08:03:18.196] <TB3> INFO: Expecting 41600 events.
[08:03:22.249] <TB3> INFO: 41600 events read in total (3461ms).
[08:03:22.249] <TB3> INFO: Test took 4331ms.
[08:03:22.253] <TB3> INFO: scanning low vcal = 60
[08:03:22.530] <TB3> INFO: Expecting 41600 events.
[08:03:26.574] <TB3> INFO: 41600 events read in total (3452ms).
[08:03:26.574] <TB3> INFO: Test took 4321ms.
[08:03:26.578] <TB3> INFO: scanning low vcal = 70
[08:03:26.855] <TB3> INFO: Expecting 41600 events.
[08:03:30.866] <TB3> INFO: 41600 events read in total (3419ms).
[08:03:30.867] <TB3> INFO: Test took 4289ms.
[08:03:30.870] <TB3> INFO: scanning low vcal = 80
[08:03:31.148] <TB3> INFO: Expecting 41600 events.
[08:03:35.155] <TB3> INFO: 41600 events read in total (3416ms).
[08:03:35.156] <TB3> INFO: Test took 4285ms.
[08:03:35.159] <TB3> INFO: scanning low vcal = 90
[08:03:35.436] <TB3> INFO: Expecting 41600 events.
[08:03:39.458] <TB3> INFO: 41600 events read in total (3430ms).
[08:03:39.458] <TB3> INFO: Test took 4299ms.
[08:03:39.463] <TB3> INFO: scanning low vcal = 100
[08:03:39.739] <TB3> INFO: Expecting 41600 events.
[08:03:43.748] <TB3> INFO: 41600 events read in total (3417ms).
[08:03:43.749] <TB3> INFO: Test took 4286ms.
[08:03:43.752] <TB3> INFO: scanning low vcal = 110
[08:03:44.030] <TB3> INFO: Expecting 41600 events.
[08:03:48.053] <TB3> INFO: 41600 events read in total (3432ms).
[08:03:48.054] <TB3> INFO: Test took 4302ms.
[08:03:48.057] <TB3> INFO: scanning low vcal = 120
[08:03:48.334] <TB3> INFO: Expecting 41600 events.
[08:03:52.351] <TB3> INFO: 41600 events read in total (3425ms).
[08:03:52.352] <TB3> INFO: Test took 4295ms.
[08:03:52.355] <TB3> INFO: scanning low vcal = 130
[08:03:52.633] <TB3> INFO: Expecting 41600 events.
[08:03:56.640] <TB3> INFO: 41600 events read in total (3417ms).
[08:03:56.641] <TB3> INFO: Test took 4285ms.
[08:03:56.644] <TB3> INFO: scanning low vcal = 140
[08:03:56.922] <TB3> INFO: Expecting 41600 events.
[08:04:00.925] <TB3> INFO: 41600 events read in total (3412ms).
[08:04:00.925] <TB3> INFO: Test took 4281ms.
[08:04:00.928] <TB3> INFO: scanning low vcal = 150
[08:04:01.206] <TB3> INFO: Expecting 41600 events.
[08:04:05.163] <TB3> INFO: 41600 events read in total (3366ms).
[08:04:05.164] <TB3> INFO: Test took 4236ms.
[08:04:05.169] <TB3> INFO: scanning low vcal = 160
[08:04:05.444] <TB3> INFO: Expecting 41600 events.
[08:04:09.390] <TB3> INFO: 41600 events read in total (3355ms).
[08:04:09.391] <TB3> INFO: Test took 4222ms.
[08:04:09.395] <TB3> INFO: scanning low vcal = 170
[08:04:09.670] <TB3> INFO: Expecting 41600 events.
[08:04:13.652] <TB3> INFO: 41600 events read in total (3390ms).
[08:04:13.653] <TB3> INFO: Test took 4258ms.
[08:04:13.658] <TB3> INFO: scanning low vcal = 180
[08:04:13.932] <TB3> INFO: Expecting 41600 events.
[08:04:17.871] <TB3> INFO: 41600 events read in total (3347ms).
[08:04:17.872] <TB3> INFO: Test took 4213ms.
[08:04:17.876] <TB3> INFO: scanning low vcal = 190
[08:04:18.151] <TB3> INFO: Expecting 41600 events.
[08:04:22.109] <TB3> INFO: 41600 events read in total (3366ms).
[08:04:22.110] <TB3> INFO: Test took 4234ms.
[08:04:22.113] <TB3> INFO: scanning low vcal = 200
[08:04:22.389] <TB3> INFO: Expecting 41600 events.
[08:04:26.365] <TB3> INFO: 41600 events read in total (3384ms).
[08:04:26.366] <TB3> INFO: Test took 4253ms.
[08:04:26.369] <TB3> INFO: scanning low vcal = 210
[08:04:26.646] <TB3> INFO: Expecting 41600 events.
[08:04:30.592] <TB3> INFO: 41600 events read in total (3355ms).
[08:04:30.593] <TB3> INFO: Test took 4224ms.
[08:04:30.596] <TB3> INFO: scanning low vcal = 220
[08:04:30.873] <TB3> INFO: Expecting 41600 events.
[08:04:34.871] <TB3> INFO: 41600 events read in total (3407ms).
[08:04:34.872] <TB3> INFO: Test took 4276ms.
[08:04:34.875] <TB3> INFO: scanning low vcal = 230
[08:04:35.153] <TB3> INFO: Expecting 41600 events.
[08:04:39.150] <TB3> INFO: 41600 events read in total (3405ms).
[08:04:39.151] <TB3> INFO: Test took 4276ms.
[08:04:39.155] <TB3> INFO: scanning low vcal = 240
[08:04:39.431] <TB3> INFO: Expecting 41600 events.
[08:04:43.392] <TB3> INFO: 41600 events read in total (3369ms).
[08:04:43.393] <TB3> INFO: Test took 4238ms.
[08:04:43.396] <TB3> INFO: scanning low vcal = 250
[08:04:43.672] <TB3> INFO: Expecting 41600 events.
[08:04:47.623] <TB3> INFO: 41600 events read in total (3359ms).
[08:04:47.623] <TB3> INFO: Test took 4228ms.
[08:04:47.628] <TB3> INFO: scanning high vcal = 30 (= 210 in low range)
[08:04:47.903] <TB3> INFO: Expecting 41600 events.
[08:04:51.896] <TB3> INFO: 41600 events read in total (3401ms).
[08:04:51.897] <TB3> INFO: Test took 4269ms.
[08:04:51.901] <TB3> INFO: scanning high vcal = 50 (= 350 in low range)
[08:04:52.176] <TB3> INFO: Expecting 41600 events.
[08:04:56.125] <TB3> INFO: 41600 events read in total (3357ms).
[08:04:56.126] <TB3> INFO: Test took 4225ms.
[08:04:56.129] <TB3> INFO: scanning high vcal = 70 (= 490 in low range)
[08:04:56.405] <TB3> INFO: Expecting 41600 events.
[08:05:00.364] <TB3> INFO: 41600 events read in total (3367ms).
[08:05:00.365] <TB3> INFO: Test took 4236ms.
[08:05:00.369] <TB3> INFO: scanning high vcal = 90 (= 630 in low range)
[08:05:00.644] <TB3> INFO: Expecting 41600 events.
[08:05:04.580] <TB3> INFO: 41600 events read in total (3344ms).
[08:05:04.581] <TB3> INFO: Test took 4213ms.
[08:05:04.585] <TB3> INFO: scanning high vcal = 200 (= 1400 in low range)
[08:05:04.861] <TB3> INFO: Expecting 41600 events.
[08:05:08.791] <TB3> INFO: 41600 events read in total (3338ms).
[08:05:08.792] <TB3> INFO: Test took 4207ms.
[08:05:09.433] <TB3> INFO: PixTestGainPedestal::measure() done
[08:05:44.256] <TB3> INFO: PixTestGainPedestal::fit() done
[08:05:44.256] <TB3> INFO: non-linearity mean: 0.926 0.907 0.961 0.945 0.923 0.948 0.984 0.956 0.000 0.914 0.967 0.934 0.946 0.000 0.948 0.919
[08:05:44.256] <TB3> INFO: non-linearity RMS: 0.072 0.132 0.040 0.048 0.100 0.041 0.002 0.148 0.000 0.149 0.199 0.165 0.137 0.000 0.041 0.091
[08:05:44.256] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C0.dat
[08:05:44.273] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C1.dat
[08:05:44.292] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C2.dat
[08:05:44.310] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C3.dat
[08:05:44.329] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C4.dat
[08:05:44.348] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C5.dat
[08:05:44.366] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C6.dat
[08:05:44.384] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C7.dat
[08:05:44.403] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C8.dat
[08:05:44.418] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C9.dat
[08:05:44.437] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C10.dat
[08:05:44.456] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C11.dat
[08:05:44.474] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C12.dat
[08:05:44.493] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C13.dat
[08:05:44.507] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C14.dat
[08:05:44.526] <TB3> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//phCalibrationFitErr35_C15.dat
[08:05:44.545] <TB3> INFO: PixTestGainPedestal::fullTest() done, duration: 162 seconds
[08:05:44.545] <TB3> INFO: Decoding statistics:
[08:05:44.545] <TB3> INFO: General information:
[08:05:44.545] <TB3> INFO: 16bit words read: 3268248
[08:05:44.545] <TB3> INFO: valid events total: 332800
[08:05:44.545] <TB3> INFO: empty events: 450
[08:05:44.545] <TB3> INFO: valid events with pixels: 332350
[08:05:44.545] <TB3> INFO: valid pixel hits: 635724
[08:05:44.545] <TB3> INFO: Event errors: 0
[08:05:44.545] <TB3> INFO: start marker: 0
[08:05:44.545] <TB3> INFO: stop marker: 0
[08:05:44.545] <TB3> INFO: overflow: 0
[08:05:44.545] <TB3> INFO: invalid 5bit words: 0
[08:05:44.545] <TB3> INFO: invalid XOR eye diagram: 0
[08:05:44.545] <TB3> INFO: frame (failed synchr.): 0
[08:05:44.545] <TB3> INFO: idle data (no TBM trl): 0
[08:05:44.545] <TB3> INFO: no data (only TBM hdr): 0
[08:05:44.545] <TB3> INFO: TBM errors: 0
[08:05:44.545] <TB3> INFO: flawed TBM headers: 0
[08:05:44.545] <TB3> INFO: flawed TBM trailers: 0
[08:05:44.545] <TB3> INFO: event ID mismatches: 0
[08:05:44.545] <TB3> INFO: ROC errors: 0
[08:05:44.545] <TB3> INFO: missing ROC header(s): 0
[08:05:44.545] <TB3> INFO: misplaced readback start: 0
[08:05:44.545] <TB3> INFO: Pixel decoding errors: 0
[08:05:44.545] <TB3> INFO: pixel data incomplete: 0
[08:05:44.545] <TB3> INFO: pixel address: 0
[08:05:44.545] <TB3> INFO: pulse height fill bit: 0
[08:05:44.545] <TB3> INFO: buffer corruption: 0
[08:05:44.580] <TB3> INFO: Decoding statistics:
[08:05:44.580] <TB3> INFO: General information:
[08:05:44.580] <TB3> INFO: 16bit words read: 3397670
[08:05:44.580] <TB3> INFO: valid events total: 353536
[08:05:44.580] <TB3> INFO: empty events: 18683
[08:05:44.580] <TB3> INFO: valid events with pixels: 334853
[08:05:44.580] <TB3> INFO: valid pixel hits: 638227
[08:05:44.580] <TB3> INFO: Event errors: 0
[08:05:44.580] <TB3> INFO: start marker: 0
[08:05:44.580] <TB3> INFO: stop marker: 0
[08:05:44.580] <TB3> INFO: overflow: 0
[08:05:44.580] <TB3> INFO: invalid 5bit words: 0
[08:05:44.580] <TB3> INFO: invalid XOR eye diagram: 0
[08:05:44.580] <TB3> INFO: frame (failed synchr.): 0
[08:05:44.580] <TB3> INFO: idle data (no TBM trl): 0
[08:05:44.580] <TB3> INFO: no data (only TBM hdr): 0
[08:05:44.580] <TB3> INFO: TBM errors: 0
[08:05:44.580] <TB3> INFO: flawed TBM headers: 0
[08:05:44.580] <TB3> INFO: flawed TBM trailers: 0
[08:05:44.580] <TB3> INFO: event ID mismatches: 0
[08:05:44.580] <TB3> INFO: ROC errors: 0
[08:05:44.580] <TB3> INFO: missing ROC header(s): 0
[08:05:44.580] <TB3> INFO: misplaced readback start: 0
[08:05:44.580] <TB3> INFO: Pixel decoding errors: 0
[08:05:44.580] <TB3> INFO: pixel data incomplete: 0
[08:05:44.580] <TB3> INFO: pixel address: 0
[08:05:44.580] <TB3> INFO: pulse height fill bit: 0
[08:05:44.580] <TB3> INFO: buffer corruption: 0
[08:05:44.580] <TB3> INFO: enter test to run
[08:05:44.580] <TB3> INFO: test: trim80 no parameter change
[08:05:44.580] <TB3> INFO: running: trim80
[08:05:44.581] <TB3> INFO: ######################################################################
[08:05:44.581] <TB3> INFO: PixTestTrim80::doTest()
[08:05:44.581] <TB3> INFO: ######################################################################
[08:05:44.583] <TB3> INFO: ----------------------------------------------------------------------
[08:05:44.583] <TB3> INFO: PixTestTrim80::trimTest() ntrig = 8, vcal = 80
[08:05:44.583] <TB3> INFO: ----------------------------------------------------------------------
[08:05:44.624] <TB3> INFO: ---> VthrComp thr map (minimal VthrComp)
[08:05:44.624] <TB3> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[08:05:44.638] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:05:44.638] <TB3> INFO: run 1 of 1
[08:05:44.963] <TB3> INFO: Expecting 5025280 events.
[08:06:13.114] <TB3> INFO: 691856 events read in total (27559ms).
[08:06:40.704] <TB3> INFO: 1380592 events read in total (55149ms).
[08:07:08.304] <TB3> INFO: 2067208 events read in total (82749ms).
[08:07:35.612] <TB3> INFO: 2753192 events read in total (110057ms).
[08:08:03.689] <TB3> INFO: 3437880 events read in total (138134ms).
[08:08:31.520] <TB3> INFO: 4121808 events read in total (165965ms).
[08:08:59.960] <TB3> INFO: 4805432 events read in total (194405ms).
[08:09:08.957] <TB3> INFO: 5025280 events read in total (203402ms).
[08:09:09.042] <TB3> INFO: Test took 204404ms.
[08:09:29.779] <TB3> INFO: ROC 0 VthrComp = 78
[08:09:29.779] <TB3> INFO: ROC 1 VthrComp = 84
[08:09:29.779] <TB3> INFO: ROC 2 VthrComp = 81
[08:09:29.779] <TB3> INFO: ROC 3 VthrComp = 73
[08:09:29.780] <TB3> INFO: ROC 4 VthrComp = 71
[08:09:29.780] <TB3> INFO: ROC 5 VthrComp = 71
[08:09:29.780] <TB3> INFO: ROC 6 VthrComp = 76
[08:09:29.780] <TB3> INFO: ROC 7 VthrComp = 71
[08:09:29.780] <TB3> INFO: ROC 8 VthrComp = 71
[08:09:29.780] <TB3> INFO: ROC 9 VthrComp = 81
[08:09:29.780] <TB3> INFO: ROC 10 VthrComp = 74
[08:09:29.780] <TB3> INFO: ROC 11 VthrComp = 66
[08:09:29.780] <TB3> INFO: ROC 12 VthrComp = 78
[08:09:29.780] <TB3> INFO: ROC 13 VthrComp = 75
[08:09:29.781] <TB3> INFO: ROC 14 VthrComp = 74
[08:09:29.781] <TB3> INFO: ROC 15 VthrComp = 71
[08:09:30.063] <TB3> INFO: Expecting 41600 events.
[08:09:33.612] <TB3> INFO: 41600 events read in total (2957ms).
[08:09:33.613] <TB3> INFO: Test took 3830ms.
[08:09:33.622] <TB3> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[08:09:33.622] <TB3> INFO: ---> dac: vcal name: TrimThr1 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[08:09:33.635] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:09:33.635] <TB3> INFO: run 1 of 1
[08:09:33.913] <TB3> INFO: Expecting 5025280 events.
[08:10:02.782] <TB3> INFO: 691312 events read in total (28278ms).
[08:10:30.215] <TB3> INFO: 1372504 events read in total (55711ms).
[08:10:58.259] <TB3> INFO: 2058160 events read in total (83755ms).
[08:11:25.811] <TB3> INFO: 2739600 events read in total (111307ms).
[08:11:53.820] <TB3> INFO: 3415888 events read in total (139316ms).
[08:12:20.947] <TB3> INFO: 4090616 events read in total (166443ms).
[08:12:48.707] <TB3> INFO: 4765520 events read in total (194203ms).
[08:12:59.618] <TB3> INFO: 5025280 events read in total (205114ms).
[08:12:59.710] <TB3> INFO: Test took 206075ms.
[08:13:20.547] <TB3> INFO: roc 0 with ID = 0 has maximal Vcal 112.695 for pixel 0/10 mean/min/max = 95.4997/77.4178/113.582
[08:13:20.548] <TB3> INFO: roc 1 with ID = 1 has maximal Vcal 107.894 for pixel 0/0 mean/min/max = 91.4043/74.752/108.057
[08:13:20.548] <TB3> INFO: roc 2 with ID = 2 has maximal Vcal 110.628 for pixel 0/78 mean/min/max = 92.7627/74.514/111.011
[08:13:20.549] <TB3> INFO: roc 3 with ID = 3 has maximal Vcal 114.409 for pixel 1/5 mean/min/max = 95.3987/76.259/114.538
[08:13:20.549] <TB3> INFO: roc 4 with ID = 4 has maximal Vcal 109.761 for pixel 51/14 mean/min/max = 92.2308/74.549/109.913
[08:13:20.550] <TB3> INFO: roc 5 with ID = 5 has maximal Vcal 110.284 for pixel 0/42 mean/min/max = 92.3139/74.1954/110.432
[08:13:20.550] <TB3> INFO: roc 6 with ID = 6 has maximal Vcal 112.326 for pixel 0/31 mean/min/max = 95.0779/77.1398/113.016
[08:13:20.551] <TB3> INFO: roc 7 with ID = 7 has maximal Vcal 113.166 for pixel 51/22 mean/min/max = 94.0141/74.1082/113.92
[08:13:20.552] <TB3> INFO: roc 8 with ID = 8 has maximal Vcal 111.248 for pixel 2/1 mean/min/max = 92.541/73.7417/111.34
[08:13:20.553] <TB3> INFO: roc 9 with ID = 9 has maximal Vcal 110.852 for pixel 51/17 mean/min/max = 93.1208/74.9577/111.284
[08:13:20.553] <TB3> INFO: roc 10 with ID = 10 has maximal Vcal 110.437 for pixel 0/18 mean/min/max = 93.2486/75.8145/110.683
[08:13:20.554] <TB3> INFO: roc 11 with ID = 11 has maximal Vcal 109.006 for pixel 0/70 mean/min/max = 91.7904/74.5484/109.032
[08:13:20.555] <TB3> INFO: roc 12 with ID = 12 has maximal Vcal 112.232 for pixel 5/6 mean/min/max = 94.8259/77.1852/112.467
[08:13:20.556] <TB3> INFO: roc 13 with ID = 13 has maximal Vcal 112.79 for pixel 51/5 mean/min/max = 94.9771/76.5315/113.423
[08:13:20.556] <TB3> INFO: roc 14 with ID = 14 has maximal Vcal 112.565 for pixel 51/8 mean/min/max = 94.5596/76.3603/112.759
[08:13:20.557] <TB3> INFO: roc 15 with ID = 15 has maximal Vcal 108.733 for pixel 12/75 mean/min/max = 90.8561/72.9502/108.762
[08:13:20.558] <TB3> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[08:13:20.646] <TB3> INFO: Expecting 411648 events.
[08:13:30.303] <TB3> INFO: 411648 events read in total (9065ms).
[08:13:30.312] <TB3> INFO: Expecting 411648 events.
[08:13:39.501] <TB3> INFO: 411648 events read in total (8786ms).
[08:13:39.515] <TB3> INFO: Expecting 411648 events.
[08:13:48.668] <TB3> INFO: 411648 events read in total (8750ms).
[08:13:48.682] <TB3> INFO: Expecting 411648 events.
[08:13:57.975] <TB3> INFO: 411648 events read in total (8890ms).
[08:13:57.995] <TB3> INFO: Expecting 411648 events.
[08:14:07.427] <TB3> INFO: 411648 events read in total (9028ms).
[08:14:07.447] <TB3> INFO: Expecting 411648 events.
[08:14:16.969] <TB3> INFO: 411648 events read in total (9119ms).
[08:14:16.994] <TB3> INFO: Expecting 411648 events.
[08:14:26.500] <TB3> INFO: 411648 events read in total (9103ms).
[08:14:26.526] <TB3> INFO: Expecting 411648 events.
[08:14:35.856] <TB3> INFO: 411648 events read in total (8927ms).
[08:14:35.885] <TB3> INFO: Expecting 411648 events.
[08:14:45.446] <TB3> INFO: 411648 events read in total (9158ms).
[08:14:45.477] <TB3> INFO: Expecting 411648 events.
[08:14:54.749] <TB3> INFO: 411648 events read in total (8869ms).
[08:14:54.795] <TB3> INFO: Expecting 411648 events.
[08:15:04.081] <TB3> INFO: 411648 events read in total (8883ms).
[08:15:04.129] <TB3> INFO: Expecting 411648 events.
[08:15:13.568] <TB3> INFO: 411648 events read in total (9036ms).
[08:15:13.619] <TB3> INFO: Expecting 411648 events.
[08:15:22.995] <TB3> INFO: 411648 events read in total (8973ms).
[08:15:23.077] <TB3> INFO: Expecting 411648 events.
[08:15:32.713] <TB3> INFO: 411648 events read in total (9232ms).
[08:15:32.773] <TB3> INFO: Expecting 411648 events.
[08:15:42.177] <TB3> INFO: 411648 events read in total (9001ms).
[08:15:42.289] <TB3> INFO: Expecting 411648 events.
[08:15:51.604] <TB3> INFO: 411648 events read in total (8912ms).
[08:15:51.709] <TB3> INFO: Test took 151151ms.
[08:15:53.368] <TB3> INFO: ---> dac: vcal name: TrimThr2 ntrig: 8 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[08:15:53.382] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:15:53.382] <TB3> INFO: run 1 of 1
[08:15:53.620] <TB3> INFO: Expecting 5025280 events.
[08:16:21.311] <TB3> INFO: 669136 events read in total (27099ms).
[08:16:48.208] <TB3> INFO: 1329992 events read in total (53996ms).
[08:17:15.715] <TB3> INFO: 1995504 events read in total (81503ms).
[08:17:43.169] <TB3> INFO: 2658048 events read in total (108957ms).
[08:18:10.691] <TB3> INFO: 3315504 events read in total (136479ms).
[08:18:37.469] <TB3> INFO: 3972432 events read in total (163257ms).
[08:19:04.471] <TB3> INFO: 4628312 events read in total (190259ms).
[08:19:20.850] <TB3> INFO: 5025280 events read in total (206638ms).
[08:19:20.957] <TB3> INFO: Test took 207575ms.
[08:19:42.419] <TB3> INFO: ---> TrimStepCorr4 extremal thresholds: 51.014521 .. 100.603352
[08:19:42.668] <TB3> INFO: Expecting 208000 events.
[08:19:52.455] <TB3> INFO: 208000 events read in total (9196ms).
[08:19:52.455] <TB3> INFO: Test took 10034ms.
[08:19:52.507] <TB3> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 8 dacrange: 41 .. 110 (-1/-1) hits flags = 528 (plus default)
[08:19:52.520] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:19:52.520] <TB3> INFO: run 1 of 1
[08:19:52.798] <TB3> INFO: Expecting 2329600 events.
[08:20:22.181] <TB3> INFO: 692608 events read in total (28791ms).
[08:20:50.091] <TB3> INFO: 1385336 events read in total (56701ms).
[08:21:17.832] <TB3> INFO: 2069240 events read in total (84442ms).
[08:21:28.470] <TB3> INFO: 2329600 events read in total (95080ms).
[08:21:28.514] <TB3> INFO: Test took 95994ms.
[08:21:45.708] <TB3> INFO: ---> TrimStepCorr2 extremal thresholds: 60.957509 .. 93.373621
[08:21:45.947] <TB3> INFO: Expecting 208000 events.
[08:21:56.396] <TB3> INFO: 208000 events read in total (9857ms).
[08:21:56.397] <TB3> INFO: Test took 10687ms.
[08:21:56.449] <TB3> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 8 dacrange: 50 .. 103 (-1/-1) hits flags = 528 (plus default)
[08:21:56.462] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:21:56.462] <TB3> INFO: run 1 of 1
[08:21:56.740] <TB3> INFO: Expecting 1797120 events.
[08:22:25.467] <TB3> INFO: 689384 events read in total (28135ms).
[08:22:53.745] <TB3> INFO: 1379288 events read in total (56413ms).
[08:23:11.283] <TB3> INFO: 1797120 events read in total (73951ms).
[08:23:11.332] <TB3> INFO: Test took 74871ms.
[08:23:27.502] <TB3> INFO: ---> TrimStepCorr1a extremal thresholds: 66.700422 .. 89.573003
[08:23:27.741] <TB3> INFO: Expecting 208000 events.
[08:23:37.442] <TB3> INFO: 208000 events read in total (9109ms).
[08:23:37.443] <TB3> INFO: Test took 9939ms.
[08:23:37.493] <TB3> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 8 dacrange: 56 .. 99 (-1/-1) hits flags = 528 (plus default)
[08:23:37.507] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:23:37.507] <TB3> INFO: run 1 of 1
[08:23:37.787] <TB3> INFO: Expecting 1464320 events.
[08:24:05.999] <TB3> INFO: 687528 events read in total (27621ms).
[08:24:34.004] <TB3> INFO: 1375208 events read in total (55627ms).
[08:24:38.786] <TB3> INFO: 1464320 events read in total (60408ms).
[08:24:38.833] <TB3> INFO: Test took 61326ms.
[08:24:57.974] <TB3> INFO: ---> TrimStepCorr1b extremal thresholds: 69.300367 .. 89.573003
[08:24:58.300] <TB3> INFO: Expecting 208000 events.
[08:25:08.027] <TB3> INFO: 208000 events read in total (9135ms).
[08:25:08.028] <TB3> INFO: Test took 10052ms.
[08:25:08.075] <TB3> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 8 dacrange: 59 .. 99 (-1/-1) hits flags = 528 (plus default)
[08:25:08.089] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:25:08.089] <TB3> INFO: run 1 of 1
[08:25:08.368] <TB3> INFO: Expecting 1364480 events.
[08:25:36.908] <TB3> INFO: 677792 events read in total (27948ms).
[08:26:05.634] <TB3> INFO: 1355896 events read in total (56674ms).
[08:26:06.433] <TB3> INFO: 1364480 events read in total (57474ms).
[08:26:06.462] <TB3> INFO: Test took 58373ms.
[08:26:24.587] <TB3> INFO: ---> TrimThrFinal extremal thresholds: 60 .. 100
[08:26:24.587] <TB3> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 8 dacrange: 60 .. 100 (-1/-1) hits flags = 528 (plus default)
[08:26:24.601] <TB3> INFO: dacScan split into 1 runs with ntrig = 8
[08:26:24.601] <TB3> INFO: run 1 of 1
[08:26:24.837] <TB3> INFO: Expecting 1364480 events.
[08:26:52.795] <TB3> INFO: 667128 events read in total (27366ms).
[08:27:20.344] <TB3> INFO: 1335112 events read in total (54915ms).
[08:27:22.004] <TB3> INFO: 1364480 events read in total (56575ms).
[08:27:22.039] <TB3> INFO: Test took 57439ms.
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C0.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C1.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C2.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C3.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C4.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C5.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C6.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C7.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C8.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C9.dat
[08:27:38.766] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C10.dat
[08:27:38.767] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C11.dat
[08:27:38.767] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C12.dat
[08:27:38.767] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C13.dat
[08:27:38.767] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C14.dat
[08:27:38.767] <TB3> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//dacParameters80_C15.dat
[08:27:38.767] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C0.dat
[08:27:38.772] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C1.dat
[08:27:38.776] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C2.dat
[08:27:38.781] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C3.dat
[08:27:38.786] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C4.dat
[08:27:38.791] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C5.dat
[08:27:38.796] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C6.dat
[08:27:38.800] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C7.dat
[08:27:38.805] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C8.dat
[08:27:38.810] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C9.dat
[08:27:38.815] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C10.dat
[08:27:38.819] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C11.dat
[08:27:38.824] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C12.dat
[08:27:38.829] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C13.dat
[08:27:38.834] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C14.dat
[08:27:38.838] <TB3> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1078_FullQualification_2016-11-03_14h08m_1478178483//003_FulltestTrim80_p17//trimParameters80_C15.dat
[08:27:38.843] <TB3> INFO: PixTestTrim80::trimTest() done
[08:27:38.843] <TB3> INFO: vtrim: 111 95 102 114 98 98 101 101 102 101 93 85 106 103 104 92
[08:27:38.843] <TB3> INFO: vthrcomp: 78 84 81 73 71 71 76 71 71 81 74 66 78 75 74 71
[08:27:38.843] <TB3> INFO: vcal mean: 79.96 79.95 80.03 79.94 80.00 79.97 79.94 79.97 79.94 79.99 79.92 79.95 79.96 79.97 79.97 79.99
[08:27:38.843] <TB3> INFO: vcal RMS: 0.84 0.80 0.84 0.87 0.83 0.84 0.79 0.87 1.51 0.80 0.72 0.78 0.80 0.80 0.84 0.82
[08:27:38.843] <TB3> INFO: bits mean: 9.53 9.58 9.64 9.90 10.35 10.09 9.05 9.83 10.28 9.34 9.23 10.06 9.91 9.33 9.47 10.46
[08:27:38.843] <TB3> INFO: bits RMS: 2.23 2.68 2.62 2.17 2.28 2.45 2.42 2.53 2.36 2.64 2.52 2.42 2.10 2.39 2.35 2.45
[08:27:38.850] <TB3> INFO: ----------------------------------------------------------------------
[08:27:38.850] <TB3> INFO: PixTestTrim80::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[08:27:38.850] <TB3> INFO: ----------------------------------------------------------------------
[08:27:38.853] <TB3> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[08:27:38.867] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:27:38.867] <TB3> INFO: run 1 of 1
[08:27:39.105] <TB3> INFO: Expecting 4160000 events.
[08:28:11.651] <TB3> INFO: 768900 events read in total (31954ms).
[08:28:43.586] <TB3> INFO: 1532045 events read in total (63889ms).
[08:29:15.856] <TB3> INFO: 2289825 events read in total (96159ms).
[08:29:48.065] <TB3> INFO: 3040220 events read in total (128368ms).
[08:30:20.118] <TB3> INFO: 3788615 events read in total (160421ms).
[08:30:36.218] <TB3> INFO: 4160000 events read in total (176521ms).
[08:30:36.303] <TB3> INFO: Test took 177435ms.
[08:31:01.223] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 210 (-1/-1) hits flags = 528 (plus default)
[08:31:01.237] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:31:01.237] <TB3> INFO: run 1 of 1
[08:31:01.490] <TB3> INFO: Expecting 4388800 events.
[08:31:33.022] <TB3> INFO: 726615 events read in total (30940ms).
[08:32:03.882] <TB3> INFO: 1449315 events read in total (61800ms).
[08:32:35.092] <TB3> INFO: 2168175 events read in total (93011ms).
[08:33:05.958] <TB3> INFO: 2882230 events read in total (123876ms).
[08:33:37.105] <TB3> INFO: 3592590 events read in total (155023ms).
[08:34:08.105] <TB3> INFO: 4304150 events read in total (186023ms).
[08:34:12.012] <TB3> INFO: 4388800 events read in total (189930ms).
[08:34:12.103] <TB3> INFO: Test took 190866ms.
[08:34:40.390] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 206 (-1/-1) hits flags = 528 (plus default)
[08:34:40.404] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:34:40.404] <TB3> INFO: run 1 of 1
[08:34:40.640] <TB3> INFO: Expecting 4305600 events.
[08:35:12.843] <TB3> INFO: 732190 events read in total (31612ms).
[08:35:43.882] <TB3> INFO: 1460005 events read in total (62651ms).
[08:36:15.168] <TB3> INFO: 2184185 events read in total (93937ms).
[08:36:46.753] <TB3> INFO: 2902820 events read in total (125522ms).
[08:37:17.800] <TB3> INFO: 3617670 events read in total (156569ms).
[08:37:47.700] <TB3> INFO: 4305600 events read in total (186469ms).
[08:37:47.815] <TB3> INFO: Test took 187411ms.
[08:38:16.010] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 205 (-1/-1) hits flags = 528 (plus default)
[08:38:16.024] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:38:16.024] <TB3> INFO: run 1 of 1
[08:38:16.261] <TB3> INFO: Expecting 4284800 events.
[08:38:48.247] <TB3> INFO: 733855 events read in total (31395ms).
[08:39:19.572] <TB3> INFO: 1462960 events read in total (62720ms).
[08:39:50.391] <TB3> INFO: 2188760 events read in total (93539ms).
[08:40:21.328] <TB3> INFO: 2908710 events read in total (124476ms).
[08:40:51.541] <TB3> INFO: 3624820 events read in total (154689ms).
[08:41:20.218] <TB3> INFO: 4284800 events read in total (183366ms).
[08:41:20.304] <TB3> INFO: Test took 184281ms.
[08:41:44.354] <TB3> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 204 (-1/-1) hits flags = 528 (plus default)
[08:41:44.369] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:41:44.369] <TB3> INFO: run 1 of 1
[08:41:44.609] <TB3> INFO: Expecting 4264000 events.
[08:42:16.376] <TB3> INFO: 735100 events read in total (31175ms).
[08:42:47.683] <TB3> INFO: 1465620 events read in total (62482ms).
[08:43:20.294] <TB3> INFO: 2192635 events read in total (95093ms).
[08:43:52.421] <TB3> INFO: 2913700 events read in total (127220ms).
[08:44:24.511] <TB3> INFO: 3631310 events read in total (159310ms).
[08:44:52.327] <TB3> INFO: 4264000 events read in total (187126ms).
[08:44:52.392] <TB3> INFO: Test took 188023ms.
[08:45:16.576] <TB3> INFO: PixTestTrim80::trimBitTest() done
[08:45:16.579] <TB3> INFO: PixTestTrim80::doTest() done, duration: 2371 seconds
[08:45:17.261] <TB3> INFO: enter test to run
[08:45:17.261] <TB3> INFO: test: exit no parameter change
[08:45:17.625] <TB3> QUIET: Connection to board 126 closed.
[08:45:17.626] <TB3> INFO: pXar: this is the end, my friend