[18:11:43.840] <TB2> INFO: *** Welcome to pxar ***
[18:11:43.840] <TB2> INFO: *** Today: 2016/11/04
[18:11:43.846] <TB2> INFO: *** Version: c8ba-dirty
[18:11:43.846] <TB2> INFO: readRocDacs: /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C0.dat .. /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C15.dat
[18:11:43.846] <TB2> INFO: readTbmDacs: /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//tbmParameters_C0a.dat .. /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//tbmParameters_C1b.dat
[18:11:43.846] <TB2> INFO: readMaskFile: /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//defaultMaskFile.dat
[18:11:43.846] <TB2> INFO: readTrimFile: /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters_C0.dat .. /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters_C15.dat
[18:11:43.909] <TB2> INFO: clk: 4
[18:11:43.909] <TB2> INFO: ctr: 4
[18:11:43.909] <TB2> INFO: sda: 19
[18:11:43.909] <TB2> INFO: tin: 9
[18:11:43.909] <TB2> INFO: level: 15
[18:11:43.909] <TB2> INFO: triggerdelay: 0
[18:11:43.909] <TB2> QUIET: Instanciating API for pxar v2.7.6+61~g7f4a123
[18:11:43.909] <TB2> INFO: Log level: INFO
[18:11:43.917] <TB2> INFO: Found DTB DTB_WWXUD2
[18:11:43.928] <TB2> QUIET: Connection to board DTB_WWXUD2 opened.
[18:11:43.930] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 149
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options:
USB id: DTB_WWXUD2
MAC address: 40D855118095
Hostname: pixelDTB149
Comment:
------------------------------------------------------
[18:11:43.932] <TB2> INFO: RPC call hashes of host and DTB match: 486171790
[18:11:45.451] <TB2> INFO: DUT info:
[18:11:45.451] <TB2> INFO: The DUT currently contains the following objects:
[18:11:45.451] <TB2> INFO: 4 TBM Cores tbm10c (4 ON)
[18:11:45.451] <TB2> INFO: TBM Core alpha (0): 7 registers set
[18:11:45.451] <TB2> INFO: TBM Core beta (1): 7 registers set
[18:11:45.451] <TB2> INFO: TBM Core alpha (2): 7 registers set
[18:11:45.451] <TB2> INFO: TBM Core beta (3): 7 registers set
[18:11:45.451] <TB2> INFO: 16 ROCs proc600 (16 ON) with 4160 pixelConfigs
[18:11:45.451] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.451] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.452] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.452] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.452] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[18:11:45.852] <TB2> INFO: enter 'restricted' command line mode
[18:11:45.852] <TB2> INFO: enter test to run
[18:11:45.853] <TB2> INFO: test: pretest no parameter change
[18:11:45.853] <TB2> INFO: running: pretest
[18:11:45.859] <TB2> INFO: ######################################################################
[18:11:45.859] <TB2> INFO: PixTestPretest::doTest()
[18:11:45.859] <TB2> INFO: ######################################################################
[18:11:45.860] <TB2> INFO: ----------------------------------------------------------------------
[18:11:45.860] <TB2> INFO: PixTestPretest::programROC()
[18:11:45.860] <TB2> INFO: ----------------------------------------------------------------------
[18:12:03.876] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[18:12:03.876] <TB2> INFO: IA differences per ROC: 21.7 18.5 21.7 20.1 17.7 21.7 17.7 20.1 16.9 19.3 18.5 20.1 17.7 21.7 20.9 16.9
[18:12:03.935] <TB2> INFO: ----------------------------------------------------------------------
[18:12:03.935] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[18:12:03.935] <TB2> INFO: ----------------------------------------------------------------------
[18:12:25.242] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 377 mA = 23.5625 mA/ROC
[18:12:25.242] <TB2> INFO: i(loss) [mA/ROC]: 19.3 18.5 19.3 19.3 18.5 19.3 19.3 19.3 19.3 18.5 19.3 19.3 18.5 18.5 18.5 19.3
[18:12:25.279] <TB2> INFO: ----------------------------------------------------------------------
[18:12:25.279] <TB2> INFO: PixTestPretest::findTiming()
[18:12:25.279] <TB2> INFO: ----------------------------------------------------------------------
[18:12:25.279] <TB2> INFO: PixTestCmd::init()

[18:12:57.371] <TB2> INFO: TBM phases: 160MHz: 0, 400MHz: 2, TBM delays: ROC(0/1):5, header/trailer: 1, token: 1
[18:12:57.371] <TB2> INFO: (success/tries = 100/100), width = 3
[18:12:58.871] <TB2> INFO: ----------------------------------------------------------------------
[18:12:58.871] <TB2> INFO: PixTestPretest::findWorkingPixel()
[18:12:58.871] <TB2> INFO: ----------------------------------------------------------------------
[18:12:58.967] <TB2> INFO: Expecting 231680 events.
[18:13:08.893] <TB2> INFO: 231680 events read in total (9334ms).
[18:13:08.900] <TB2> INFO: Test took 10024ms.
[18:13:09.149] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[18:13:09.187] <TB2> INFO: ----------------------------------------------------------------------
[18:13:09.187] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[18:13:09.187] <TB2> INFO: ----------------------------------------------------------------------
[18:13:09.282] <TB2> INFO: Expecting 231680 events.
[18:13:19.272] <TB2> INFO: 231680 events read in total (9399ms).
[18:13:19.283] <TB2> INFO: Test took 10091ms.
[18:13:19.554] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[18:13:19.554] <TB2> INFO: CalDel: 107 107 96 102 82 107 85 90 87 111 87 108 95 108 101 94
[18:13:19.555] <TB2> INFO: VthrComp: 51 51 51 51 55 55 51 51 51 51 51 51 51 51 51 53
[18:13:19.558] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C0.dat
[18:13:19.559] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C1.dat
[18:13:19.559] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C2.dat
[18:13:19.559] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C3.dat
[18:13:19.559] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C4.dat
[18:13:19.559] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C5.dat
[18:13:19.559] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C6.dat
[18:13:19.560] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C7.dat
[18:13:19.560] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C8.dat
[18:13:19.560] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C9.dat
[18:13:19.560] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C10.dat
[18:13:19.560] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C11.dat
[18:13:19.560] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C12.dat
[18:13:19.561] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C13.dat
[18:13:19.561] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C14.dat
[18:13:19.561] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters_C15.dat
[18:13:19.561] <TB2> INFO: write tbm parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//tbmParameters_C0a.dat
[18:13:19.561] <TB2> INFO: write tbm parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//tbmParameters_C0b.dat
[18:13:19.561] <TB2> INFO: write tbm parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//tbmParameters_C1a.dat
[18:13:19.561] <TB2> INFO: write tbm parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//tbmParameters_C1b.dat
[18:13:19.561] <TB2> INFO: PixTestPretest::doTest() done, duration: 93 seconds
[18:13:19.618] <TB2> INFO: enter test to run
[18:13:19.618] <TB2> INFO: test: FullTest no parameter change
[18:13:19.618] <TB2> INFO: running: fulltest
[18:13:19.618] <TB2> INFO: ######################################################################
[18:13:19.618] <TB2> INFO: PixTestFullTest::doTest()
[18:13:19.618] <TB2> INFO: ######################################################################
[18:13:19.620] <TB2> INFO: ######################################################################
[18:13:19.620] <TB2> INFO: PixTestAlive::doTest()
[18:13:19.620] <TB2> INFO: ######################################################################
[18:13:19.621] <TB2> INFO: ----------------------------------------------------------------------
[18:13:19.621] <TB2> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[18:13:19.621] <TB2> INFO: ----------------------------------------------------------------------
[18:13:19.905] <TB2> INFO: Expecting 41600 events.
[18:13:23.412] <TB2> INFO: 41600 events read in total (2915ms).
[18:13:23.412] <TB2> INFO: Test took 3789ms.
[18:13:23.644] <TB2> INFO: PixTestAlive::aliveTest() done
[18:13:23.644] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[18:13:23.646] <TB2> INFO: ----------------------------------------------------------------------
[18:13:23.646] <TB2> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[18:13:23.646] <TB2> INFO: ----------------------------------------------------------------------
[18:13:23.891] <TB2> INFO: Expecting 41600 events.
[18:13:26.856] <TB2> INFO: 41600 events read in total (2373ms).
[18:13:26.857] <TB2> INFO: Test took 3209ms.
[18:13:26.857] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[18:13:27.103] <TB2> INFO: PixTestAlive::maskTest() done
[18:13:27.103] <TB2> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[18:13:27.105] <TB2> INFO: ----------------------------------------------------------------------
[18:13:27.105] <TB2> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[18:13:27.105] <TB2> INFO: ----------------------------------------------------------------------
[18:13:27.436] <TB2> INFO: Expecting 41600 events.
[18:13:31.007] <TB2> INFO: 41600 events read in total (2979ms).
[18:13:31.008] <TB2> INFO: Test took 3901ms.
[18:13:31.242] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[18:13:31.242] <TB2> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[18:13:31.242] <TB2> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[18:13:31.242] <TB2> INFO: Decoding statistics:
[18:13:31.242] <TB2> INFO: General information:
[18:13:31.242] <TB2> INFO: 16bit words read: 0
[18:13:31.242] <TB2> INFO: valid events total: 0
[18:13:31.242] <TB2> INFO: empty events: 0
[18:13:31.242] <TB2> INFO: valid events with pixels: 0
[18:13:31.242] <TB2> INFO: valid pixel hits: 0
[18:13:31.242] <TB2> INFO: Event errors: 0
[18:13:31.242] <TB2> INFO: start marker: 0
[18:13:31.242] <TB2> INFO: stop marker: 0
[18:13:31.242] <TB2> INFO: overflow: 0
[18:13:31.242] <TB2> INFO: invalid 5bit words: 0
[18:13:31.243] <TB2> INFO: invalid XOR eye diagram: 0
[18:13:31.243] <TB2> INFO: frame (failed synchr.): 0
[18:13:31.243] <TB2> INFO: idle data (no TBM trl): 0
[18:13:31.243] <TB2> INFO: no data (only TBM hdr): 0
[18:13:31.243] <TB2> INFO: TBM errors: 0
[18:13:31.243] <TB2> INFO: flawed TBM headers: 0
[18:13:31.243] <TB2> INFO: flawed TBM trailers: 0
[18:13:31.243] <TB2> INFO: event ID mismatches: 0
[18:13:31.243] <TB2> INFO: ROC errors: 0
[18:13:31.243] <TB2> INFO: missing ROC header(s): 0
[18:13:31.243] <TB2> INFO: misplaced readback start: 0
[18:13:31.243] <TB2> INFO: Pixel decoding errors: 0
[18:13:31.243] <TB2> INFO: pixel data incomplete: 0
[18:13:31.243] <TB2> INFO: pixel address: 0
[18:13:31.243] <TB2> INFO: pulse height fill bit: 0
[18:13:31.243] <TB2> INFO: buffer corruption: 0
[18:13:31.252] <TB2> INFO: readReadbackCal: /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C0.dat .. /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C15.dat
[18:13:31.252] <TB2> INFO: readGainPedestalParameters /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr_C0.dat .. /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr_C15.dat

[18:13:31.252] <TB2> INFO: ######################################################################
[18:13:31.252] <TB2> INFO: PixTestReadback::doTest()
[18:13:31.252] <TB2> INFO: ######################################################################
[18:13:31.252] <TB2> INFO: ----------------------------------------------------------------------
[18:13:31.253] <TB2> INFO: PixTestReadback::CalibrateVd()
[18:13:31.253] <TB2> INFO: ----------------------------------------------------------------------
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C0.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C1.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C2.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C3.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C4.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C5.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C6.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C7.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C8.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C9.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C10.dat
[18:13:41.238] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C11.dat
[18:13:41.239] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C12.dat
[18:13:41.239] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C13.dat
[18:13:41.239] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C14.dat
[18:13:41.239] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C15.dat
[18:13:41.273] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[18:13:41.274] <TB2> INFO: ----------------------------------------------------------------------
[18:13:41.274] <TB2> INFO: PixTestReadback::CalibrateVa()
[18:13:41.274] <TB2> INFO: ----------------------------------------------------------------------
[18:13:51.215] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C0.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C1.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C2.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C3.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C4.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C5.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C6.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C7.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C8.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C9.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C10.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C11.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C12.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C13.dat
[18:13:51.216] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C14.dat
[18:13:51.217] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C15.dat
[18:13:51.249] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[18:13:51.249] <TB2> INFO: ----------------------------------------------------------------------
[18:13:51.249] <TB2> INFO: PixTestReadback::readbackVbg()
[18:13:51.249] <TB2> INFO: ----------------------------------------------------------------------
[18:13:58.925] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[18:13:58.925] <TB2> INFO: ----------------------------------------------------------------------
[18:13:58.925] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[18:13:58.925] <TB2> INFO: ----------------------------------------------------------------------
[18:13:58.925] <TB2> INFO: Vbg will be calibrated using Vd calibration
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 162.6calibrated Vbg = 1.18423 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 147.6calibrated Vbg = 1.17401 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 158calibrated Vbg = 1.17301 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 150.4calibrated Vbg = 1.1703 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 164.2calibrated Vbg = 1.17538 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 164.7calibrated Vbg = 1.18005 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 157.4calibrated Vbg = 1.18142 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 160.9calibrated Vbg = 1.18326 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 166calibrated Vbg = 1.1784 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 158.7calibrated Vbg = 1.17251 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 156.9calibrated Vbg = 1.17116 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 151.3calibrated Vbg = 1.16132 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 149.2calibrated Vbg = 1.17348 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 159calibrated Vbg = 1.17259 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 148.5calibrated Vbg = 1.17762 :::*/*/*/*/
[18:13:58.925] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 158.5calibrated Vbg = 1.17137 :::*/*/*/*/
[18:13:58.928] <TB2> INFO: ----------------------------------------------------------------------
[18:13:58.928] <TB2> INFO: PixTestReadback::CalibrateIa()
[18:13:58.928] <TB2> INFO: ----------------------------------------------------------------------
[18:16:39.738] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C0.dat
[18:16:39.738] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C1.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C2.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C3.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C4.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C5.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C6.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C7.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C8.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C9.dat
[18:16:39.739] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C10.dat
[18:16:39.740] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C11.dat
[18:16:39.740] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C12.dat
[18:16:39.740] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C13.dat
[18:16:39.740] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C14.dat
[18:16:39.740] <TB2> INFO: write readback calibration parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//readbackCal_C15.dat
[18:16:39.767] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[18:16:39.768] <TB2> INFO: PixTestReadback::doTest() done
[18:16:39.769] <TB2> INFO: Decoding statistics:
[18:16:39.769] <TB2> INFO: General information:
[18:16:39.769] <TB2> INFO: 16bit words read: 1536
[18:16:39.769] <TB2> INFO: valid events total: 256
[18:16:39.769] <TB2> INFO: empty events: 256
[18:16:39.769] <TB2> INFO: valid events with pixels: 0
[18:16:39.769] <TB2> INFO: valid pixel hits: 0
[18:16:39.769] <TB2> INFO: Event errors: 0
[18:16:39.769] <TB2> INFO: start marker: 0
[18:16:39.769] <TB2> INFO: stop marker: 0
[18:16:39.769] <TB2> INFO: overflow: 0
[18:16:39.769] <TB2> INFO: invalid 5bit words: 0
[18:16:39.769] <TB2> INFO: invalid XOR eye diagram: 0
[18:16:39.769] <TB2> INFO: frame (failed synchr.): 0
[18:16:39.769] <TB2> INFO: idle data (no TBM trl): 0
[18:16:39.769] <TB2> INFO: no data (only TBM hdr): 0
[18:16:39.769] <TB2> INFO: TBM errors: 0
[18:16:39.769] <TB2> INFO: flawed TBM headers: 0
[18:16:39.769] <TB2> INFO: flawed TBM trailers: 0
[18:16:39.769] <TB2> INFO: event ID mismatches: 0
[18:16:39.769] <TB2> INFO: ROC errors: 0
[18:16:39.769] <TB2> INFO: missing ROC header(s): 0
[18:16:39.769] <TB2> INFO: misplaced readback start: 0
[18:16:39.769] <TB2> INFO: Pixel decoding errors: 0
[18:16:39.769] <TB2> INFO: pixel data incomplete: 0
[18:16:39.769] <TB2> INFO: pixel address: 0
[18:16:39.769] <TB2> INFO: pulse height fill bit: 0
[18:16:39.769] <TB2> INFO: buffer corruption: 0
[18:16:39.820] <TB2> INFO: ######################################################################
[18:16:39.820] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[18:16:39.820] <TB2> INFO: ######################################################################
[18:16:39.823] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[18:16:39.993] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[18:16:39.993] <TB2> INFO: run 1 of 1
[18:16:40.236] <TB2> INFO: Expecting 3120000 events.
[18:17:10.958] <TB2> INFO: 669490 events read in total (30130ms).











[18:17:41.266] <TB2> INFO: 1332620 events read in total (60438ms).











[18:18:11.668] <TB2> INFO: 1993175 events read in total (90840ms).











[18:18:41.903] <TB2> INFO: 2652600 events read in total (121075ms).











[18:19:03.260] <TB2> INFO: 3120000 events read in total (142432ms).
[18:19:03.358] <TB2> INFO: Test took 143365ms.
[18:19:28.065] <TB2> INFO: PixTestBBMap::doTest() done with 4 decoding errors: , duration: 168 seconds
[18:19:28.065] <TB2> INFO: number of dead bumps (per ROC): 1 0 1 0 3 0 1 0 1 1 0 0 1 0 0 0
[18:19:28.065] <TB2> INFO: separation cut (per ROC): 103 94 110 107 104 112 106 98 103 88 108 104 94 89 105 107
[18:19:28.065] <TB2> INFO: Decoding statistics:
[18:19:28.065] <TB2> INFO: General information:
[18:19:28.065] <TB2> INFO: 16bit words read: 0
[18:19:28.065] <TB2> INFO: valid events total: 0
[18:19:28.065] <TB2> INFO: empty events: 0
[18:19:28.065] <TB2> INFO: valid events with pixels: 0
[18:19:28.065] <TB2> INFO: valid pixel hits: 0
[18:19:28.065] <TB2> INFO: Event errors: 0
[18:19:28.065] <TB2> INFO: start marker: 0
[18:19:28.065] <TB2> INFO: stop marker: 0
[18:19:28.066] <TB2> INFO: overflow: 0
[18:19:28.066] <TB2> INFO: invalid 5bit words: 0
[18:19:28.066] <TB2> INFO: invalid XOR eye diagram: 0
[18:19:28.066] <TB2> INFO: frame (failed synchr.): 0
[18:19:28.066] <TB2> INFO: idle data (no TBM trl): 0
[18:19:28.066] <TB2> INFO: no data (only TBM hdr): 0
[18:19:28.066] <TB2> INFO: TBM errors: 0
[18:19:28.066] <TB2> INFO: flawed TBM headers: 0
[18:19:28.066] <TB2> INFO: flawed TBM trailers: 0
[18:19:28.066] <TB2> INFO: event ID mismatches: 0
[18:19:28.066] <TB2> INFO: ROC errors: 0
[18:19:28.066] <TB2> INFO: missing ROC header(s): 0
[18:19:28.066] <TB2> INFO: misplaced readback start: 0
[18:19:28.066] <TB2> INFO: Pixel decoding errors: 0
[18:19:28.066] <TB2> INFO: pixel data incomplete: 0
[18:19:28.066] <TB2> INFO: pixel address: 0
[18:19:28.066] <TB2> INFO: pulse height fill bit: 0
[18:19:28.066] <TB2> INFO: buffer corruption: 0
[18:19:28.103] <TB2> INFO: ######################################################################
[18:19:28.103] <TB2> INFO: PixTestScurves::fullTest() ntrig = 50, dacs/step = -1, ntrig/step = -1
[18:19:28.103] <TB2> INFO: ######################################################################
[18:19:28.103] <TB2> INFO: ----------------------------------------------------------------------
[18:19:28.103] <TB2> INFO: PixTestScurves::scurves(Vcal), ntrig = 50, dacs/step = -1, ntrig/step = -1
[18:19:28.103] <TB2> INFO: ----------------------------------------------------------------------
[18:19:28.103] <TB2> INFO: ---> dac: Vcal name: scurveVcal ntrig: 50 dacrange: 25 .. 200 (-1/-1) hits flags = 528 (plus default)
[18:19:28.117] <TB2> INFO: dacScan split into 1 runs with ntrig = 50
[18:19:28.117] <TB2> INFO: run 1 of 1
[18:19:28.394] <TB2> INFO: Expecting 36608000 events.
[18:19:51.935] <TB2> INFO: 675250 events read in total (22950ms).
[18:20:15.273] <TB2> INFO: 1338600 events read in total (46288ms).
[18:20:38.049] <TB2> INFO: 1999800 events read in total (69064ms).
[18:21:00.916] <TB2> INFO: 2661350 events read in total (91931ms).
[18:21:23.865] <TB2> INFO: 3321100 events read in total (114880ms).
[18:21:46.588] <TB2> INFO: 3981900 events read in total (137603ms).
[18:22:09.445] <TB2> INFO: 4643000 events read in total (160460ms).
[18:22:31.951] <TB2> INFO: 5303050 events read in total (182966ms).
[18:22:54.505] <TB2> INFO: 5962750 events read in total (205520ms).
[18:23:17.177] <TB2> INFO: 6622700 events read in total (228192ms).
[18:23:39.813] <TB2> INFO: 7281150 events read in total (250828ms).
[18:24:02.397] <TB2> INFO: 7938400 events read in total (273412ms).
[18:24:25.217] <TB2> INFO: 8597500 events read in total (296232ms).
[18:24:47.915] <TB2> INFO: 9257650 events read in total (318930ms).
[18:25:10.469] <TB2> INFO: 9916350 events read in total (341484ms).
[18:25:33.227] <TB2> INFO: 10574450 events read in total (364242ms).
[18:25:56.061] <TB2> INFO: 11233550 events read in total (387076ms).
[18:26:18.657] <TB2> INFO: 11891050 events read in total (409672ms).
[18:26:41.371] <TB2> INFO: 12549600 events read in total (432386ms).
[18:27:04.186] <TB2> INFO: 13208000 events read in total (455201ms).
[18:27:26.850] <TB2> INFO: 13866250 events read in total (477865ms).
[18:27:49.750] <TB2> INFO: 14524400 events read in total (500765ms).
[18:28:12.912] <TB2> INFO: 15181850 events read in total (523927ms).
[18:28:35.966] <TB2> INFO: 15839200 events read in total (546981ms).
[18:28:58.528] <TB2> INFO: 16497200 events read in total (569543ms).
[18:29:21.434] <TB2> INFO: 17155350 events read in total (592449ms).
[18:29:43.966] <TB2> INFO: 17810950 events read in total (614981ms).
[18:30:06.630] <TB2> INFO: 18468350 events read in total (637645ms).
[18:30:29.447] <TB2> INFO: 19123700 events read in total (660462ms).
[18:30:52.316] <TB2> INFO: 19779800 events read in total (683331ms).
[18:31:15.223] <TB2> INFO: 20433550 events read in total (706238ms).
[18:31:38.160] <TB2> INFO: 21088750 events read in total (729175ms).
[18:32:00.923] <TB2> INFO: 21742300 events read in total (751938ms).
[18:32:23.002] <TB2> INFO: 22394450 events read in total (775017ms).
[18:32:46.677] <TB2> INFO: 23046850 events read in total (797692ms).
[18:33:09.513] <TB2> INFO: 23701850 events read in total (820528ms).
[18:33:32.197] <TB2> INFO: 24354650 events read in total (843212ms).
[18:33:54.894] <TB2> INFO: 25006700 events read in total (865909ms).
[18:34:17.586] <TB2> INFO: 25660700 events read in total (888601ms).
[18:34:40.352] <TB2> INFO: 26315550 events read in total (911367ms).
[18:35:03.022] <TB2> INFO: 26968450 events read in total (934037ms).
[18:35:25.606] <TB2> INFO: 27620100 events read in total (956621ms).
[18:35:48.100] <TB2> INFO: 28272350 events read in total (979115ms).
[18:36:10.938] <TB2> INFO: 28925200 events read in total (1001953ms).
[18:36:33.520] <TB2> INFO: 29577800 events read in total (1024535ms).
[18:36:56.217] <TB2> INFO: 30227700 events read in total (1047232ms).
[18:37:19.045] <TB2> INFO: 30878150 events read in total (1070060ms).
[18:37:41.449] <TB2> INFO: 31529300 events read in total (1092464ms).
[18:38:04.183] <TB2> INFO: 32182200 events read in total (1115198ms).
[18:38:26.900] <TB2> INFO: 32834700 events read in total (1137915ms).
[18:38:49.678] <TB2> INFO: 33488400 events read in total (1160693ms).
[18:39:12.375] <TB2> INFO: 34141400 events read in total (1183390ms).
[18:39:35.075] <TB2> INFO: 34794800 events read in total (1206090ms).
[18:39:57.931] <TB2> INFO: 35450000 events read in total (1228946ms).
[18:40:20.460] <TB2> INFO: 36108600 events read in total (1251475ms).
[18:40:38.293] <TB2> INFO: 36608000 events read in total (1269308ms).
[18:40:38.462] <TB2> INFO: Test took 1270345ms.
[18:40:38.926] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:41.344] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:43.578] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:45.129] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:46.596] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:48.137] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:49.604] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:51.223] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:52.858] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:54.979] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:56.632] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:40:58.511] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:41:00.554] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:41:02.689] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:41:04.503] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:41:06.321] <TB2> INFO: dumping ASCII scurve output file: SCurveData
[18:41:08.179] <TB2> INFO: PixTestScurves::scurves() done
[18:41:08.179] <TB2> INFO: Vcal mean: 110.42 106.92 121.55 113.28 109.18 129.23 116.68 107.74 117.99 105.26 116.46 109.41 109.15 107.14 117.38 117.16
[18:41:08.179] <TB2> INFO: Vcal RMS: 4.71 5.43 6.57 5.25 6.36 8.29 5.75 5.53 5.78 6.22 5.94 5.29 5.16 5.40 6.85 5.64
[18:41:08.179] <TB2> INFO: PixTestScurves::fullTest() done, duration: 1300 seconds
[18:41:08.179] <TB2> INFO: Decoding statistics:
[18:41:08.179] <TB2> INFO: General information:
[18:41:08.179] <TB2> INFO: 16bit words read: 0
[18:41:08.179] <TB2> INFO: valid events total: 0
[18:41:08.179] <TB2> INFO: empty events: 0
[18:41:08.179] <TB2> INFO: valid events with pixels: 0
[18:41:08.179] <TB2> INFO: valid pixel hits: 0
[18:41:08.179] <TB2> INFO: Event errors: 0
[18:41:08.179] <TB2> INFO: start marker: 0
[18:41:08.179] <TB2> INFO: stop marker: 0
[18:41:08.179] <TB2> INFO: overflow: 0
[18:41:08.179] <TB2> INFO: invalid 5bit words: 0
[18:41:08.179] <TB2> INFO: invalid XOR eye diagram: 0
[18:41:08.179] <TB2> INFO: frame (failed synchr.): 0
[18:41:08.179] <TB2> INFO: idle data (no TBM trl): 0
[18:41:08.179] <TB2> INFO: no data (only TBM hdr): 0
[18:41:08.179] <TB2> INFO: TBM errors: 0
[18:41:08.179] <TB2> INFO: flawed TBM headers: 0
[18:41:08.179] <TB2> INFO: flawed TBM trailers: 0
[18:41:08.179] <TB2> INFO: event ID mismatches: 0
[18:41:08.179] <TB2> INFO: ROC errors: 0
[18:41:08.179] <TB2> INFO: missing ROC header(s): 0
[18:41:08.179] <TB2> INFO: misplaced readback start: 0
[18:41:08.179] <TB2> INFO: Pixel decoding errors: 0
[18:41:08.179] <TB2> INFO: pixel data incomplete: 0
[18:41:08.179] <TB2> INFO: pixel address: 0
[18:41:08.179] <TB2> INFO: pulse height fill bit: 0
[18:41:08.179] <TB2> INFO: buffer corruption: 0
[18:41:08.246] <TB2> INFO: ######################################################################
[18:41:08.246] <TB2> INFO: PixTestTrim::doTest()
[18:41:08.246] <TB2> INFO: ######################################################################
[18:41:08.247] <TB2> INFO: ----------------------------------------------------------------------
[18:41:08.247] <TB2> INFO: PixTestTrim::trimTest() ntrig = 8, vcal = 35
[18:41:08.247] <TB2> INFO: ----------------------------------------------------------------------
[18:41:08.289] <TB2> INFO: ---> VthrComp thr map (minimal VthrComp)
[18:41:08.289] <TB2> INFO: ---> dac: vthrcomp name: TrimThr0 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[18:41:08.302] <TB2> INFO: dacScan split into 1 runs with ntrig = 8
[18:41:08.302] <TB2> INFO: run 1 of 1
[18:41:08.575] <TB2> INFO: Expecting 5025280 events.
[18:41:39.852] <TB2> INFO: 827640 events read in total (30663ms).
[18:42:10.012] <TB2> INFO: 1651248 events read in total (60824ms).
[18:42:40.343] <TB2> INFO: 2472560 events read in total (91154ms).
[18:43:10.769] <TB2> INFO: 3291648 events read in total (121580ms).
[18:43:41.053] <TB2> INFO: 4108304 events read in total (151865ms).
[18:44:11.309] <TB2> INFO: 4924304 events read in total (182120ms).
[18:44:15.404] <TB2> INFO: 5025280 events read in total (186215ms).
[18:44:15.482] <TB2> INFO: Test took 187180ms.
[18:44:34.076] <TB2> INFO: ROC 0 VthrComp = 112
[18:44:34.076] <TB2> INFO: ROC 1 VthrComp = 104
[18:44:34.076] <TB2> INFO: ROC 2 VthrComp = 123
[18:44:34.076] <TB2> INFO: ROC 3 VthrComp = 116
[18:44:34.076] <TB2> INFO: ROC 4 VthrComp = 108
[18:44:34.076] <TB2> INFO: ROC 5 VthrComp = 128
[18:44:34.076] <TB2> INFO: ROC 6 VthrComp = 118
[18:44:34.076] <TB2> INFO: ROC 7 VthrComp = 105
[18:44:34.077] <TB2> INFO: ROC 8 VthrComp = 115
[18:44:34.077] <TB2> INFO: ROC 9 VthrComp = 97
[18:44:34.077] <TB2> INFO: ROC 10 VthrComp = 117
[18:44:34.077] <TB2> INFO: ROC 11 VthrComp = 110
[18:44:34.077] <TB2> INFO: ROC 12 VthrComp = 106
[18:44:34.077] <TB2> INFO: ROC 13 VthrComp = 103
[18:44:34.077] <TB2> INFO: ROC 14 VthrComp = 114
[18:44:34.077] <TB2> INFO: ROC 15 VthrComp = 117
[18:44:34.315] <TB2> INFO: Expecting 41600 events.
[18:44:37.873] <TB2> INFO: 41600 events read in total (2967ms).
[18:44:37.874] <TB2> INFO: Test took 3795ms.
[18:44:37.884] <TB2> INFO: ---> Vcal thr map (pixel with maximum Vcal thr)
[18:44:37.884] <TB2> INFO: ---> dac: vcal name: TrimThr1 ntrig: 8 dacrange: 10 .. 160 (-1/-1) hits flags = 528 (plus default)
[18:44:37.895] <TB2> INFO: dacScan split into 1 runs with ntrig = 8
[18:44:37.895] <TB2> INFO: run 1 of 1
[18:44:38.174] <TB2> INFO: Expecting 5025280 events.
[18:45:04.774] <TB2> INFO: 592472 events read in total (26008ms).
[18:45:30.420] <TB2> INFO: 1185024 events read in total (51654ms).
[18:45:56.787] <TB2> INFO: 1776928 events read in total (78022ms).
[18:46:22.659] <TB2> INFO: 2367504 events read in total (103893ms).
[18:46:48.365] <TB2> INFO: 2955808 events read in total (129599ms).
[18:47:14.467] <TB2> INFO: 3542576 events read in total (155701ms).
[18:47:40.371] <TB2> INFO: 4128088 events read in total (181605ms).
[18:48:06.078] <TB2> INFO: 4712600 events read in total (207312ms).
[18:48:20.710] <TB2> INFO: 5025280 events read in total (221944ms).
[18:48:20.858] <TB2> INFO: Test took 222964ms.
[18:48:44.533] <TB2> INFO: roc 0 with ID = 0 has maximal Vcal 59.8016 for pixel 38/10 mean/min/max = 46.4507/32.8503/60.0511
[18:48:44.533] <TB2> INFO: roc 1 with ID = 1 has maximal Vcal 64.501 for pixel 0/8 mean/min/max = 48.8865/33.1807/64.5924
[18:48:44.533] <TB2> INFO: roc 2 with ID = 2 has maximal Vcal 62.3562 for pixel 8/16 mean/min/max = 46.2595/30.143/62.376
[18:48:44.534] <TB2> INFO: roc 3 with ID = 3 has maximal Vcal 59.8319 for pixel 8/61 mean/min/max = 46.1722/32.2821/60.0623
[18:48:44.534] <TB2> INFO: roc 4 with ID = 4 has maximal Vcal 66.1392 for pixel 0/23 mean/min/max = 50.0247/33.3739/66.6756
[18:48:44.534] <TB2> INFO: roc 5 with ID = 5 has maximal Vcal 65.2389 for pixel 14/77 mean/min/max = 47.887/29.7436/66.0303
[18:48:44.535] <TB2> INFO: roc 6 with ID = 6 has maximal Vcal 60.0776 for pixel 22/26 mean/min/max = 45.9656/31.6396/60.2917
[18:48:44.535] <TB2> INFO: roc 7 with ID = 7 has maximal Vcal 65.0327 for pixel 13/11 mean/min/max = 49.5935/34.1531/65.034
[18:48:44.535] <TB2> INFO: roc 8 with ID = 8 has maximal Vcal 62.2669 for pixel 9/4 mean/min/max = 46.9103/31.3143/62.5063
[18:48:44.536] <TB2> INFO: roc 9 with ID = 9 has maximal Vcal 65.9253 for pixel 50/68 mean/min/max = 48.8041/31.5377/66.0705
[18:48:44.536] <TB2> INFO: roc 10 with ID = 10 has maximal Vcal 62.1763 for pixel 1/4 mean/min/max = 46.4488/30.6888/62.2087
[18:48:44.536] <TB2> INFO: roc 11 with ID = 11 has maximal Vcal 63.513 for pixel 15/70 mean/min/max = 48.5681/33.6079/63.5284
[18:48:44.537] <TB2> INFO: roc 12 with ID = 12 has maximal Vcal 64.2121 for pixel 0/14 mean/min/max = 49.2544/34.1926/64.3162
[18:48:44.537] <TB2> INFO: roc 13 with ID = 13 has maximal Vcal 61.3474 for pixel 7/29 mean/min/max = 47.2715/33.097/61.4459
[18:48:44.537] <TB2> INFO: roc 14 with ID = 14 has maximal Vcal 63.2001 for pixel 0/78 mean/min/max = 47.1498/31.0696/63.23
[18:48:44.537] <TB2> INFO: roc 15 with ID = 15 has maximal Vcal 62.387 for pixel 2/6 mean/min/max = 46.8902/31.3028/62.4776
[18:48:44.538] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[18:48:44.627] <TB2> INFO: Expecting 411648 events.
[18:48:54.184] <TB2> INFO: 411648 events read in total (8966ms).
[18:48:54.192] <TB2> INFO: Expecting 411648 events.
[18:49:03.488] <TB2> INFO: 411648 events read in total (8893ms).
[18:49:03.501] <TB2> INFO: Expecting 411648 events.
[18:49:12.791] <TB2> INFO: 411648 events read in total (8887ms).
[18:49:12.805] <TB2> INFO: Expecting 411648 events.
[18:49:22.113] <TB2> INFO: 411648 events read in total (8905ms).
[18:49:22.129] <TB2> INFO: Expecting 411648 events.
[18:49:31.439] <TB2> INFO: 411648 events read in total (8907ms).
[18:49:31.461] <TB2> INFO: Expecting 411648 events.
[18:49:40.761] <TB2> INFO: 411648 events read in total (8896ms).
[18:49:40.782] <TB2> INFO: Expecting 411648 events.
[18:49:50.060] <TB2> INFO: 411648 events read in total (8874ms).
[18:49:50.083] <TB2> INFO: Expecting 411648 events.
[18:49:59.393] <TB2> INFO: 411648 events read in total (8907ms).
[18:49:59.420] <TB2> INFO: Expecting 411648 events.
[18:50:08.764] <TB2> INFO: 411648 events read in total (8940ms).
[18:50:08.903] <TB2> INFO: Expecting 411648 events.
[18:50:18.175] <TB2> INFO: 411648 events read in total (8869ms).
[18:50:18.209] <TB2> INFO: Expecting 411648 events.
[18:50:27.569] <TB2> INFO: 411648 events read in total (8956ms).
[18:50:27.670] <TB2> INFO: Expecting 411648 events.
[18:50:36.998] <TB2> INFO: 411648 events read in total (8925ms).
[18:50:37.038] <TB2> INFO: Expecting 411648 events.
[18:50:46.462] <TB2> INFO: 411648 events read in total (9021ms).
[18:50:46.514] <TB2> INFO: Expecting 411648 events.
[18:50:55.952] <TB2> INFO: 411648 events read in total (9035ms).
[18:50:56.010] <TB2> INFO: Expecting 411648 events.
[18:51:05.176] <TB2> INFO: 411648 events read in total (8762ms).
[18:51:05.248] <TB2> INFO: Expecting 411648 events.
[18:51:14.476] <TB2> INFO: 411648 events read in total (8825ms).
[18:51:14.533] <TB2> INFO: Test took 149995ms.
[18:51:15.197] <TB2> INFO: ---> dac: vcal name: TrimThr2 ntrig: 8 dacrange: 0 .. 150 (-1/-1) hits flags = 528 (plus default)
[18:51:15.210] <TB2> INFO: dacScan split into 1 runs with ntrig = 8
[18:51:15.210] <TB2> INFO: run 1 of 1
[18:51:15.451] <TB2> INFO: Expecting 5025280 events.
[18:51:41.977] <TB2> INFO: 592272 events read in total (25934ms).
[18:52:08.334] <TB2> INFO: 1183600 events read in total (52291ms).
[18:52:34.600] <TB2> INFO: 1775672 events read in total (78557ms).
[18:53:01.005] <TB2> INFO: 2365056 events read in total (104962ms).
[18:53:27.532] <TB2> INFO: 2954032 events read in total (131489ms).
[18:53:53.932] <TB2> INFO: 3544728 events read in total (157889ms).
[18:54:20.477] <TB2> INFO: 4136504 events read in total (184434ms).
[18:54:47.050] <TB2> INFO: 4728472 events read in total (211007ms).
[18:55:01.065] <TB2> INFO: 5025280 events read in total (225022ms).
[18:55:01.259] <TB2> INFO: Test took 226050ms.
[18:55:25.999] <TB2> INFO: ---> TrimStepCorr4 extremal thresholds: 2.752954 .. 146.554082
[18:55:26.242] <TB2> INFO: Expecting 208000 events.
[18:55:35.805] <TB2> INFO: 208000 events read in total (8972ms).
[18:55:35.805] <TB2> INFO: Test took 9804ms.
[18:55:35.852] <TB2> INFO: ---> dac: vcal name: trimStepCorr4 ntrig: 8 dacrange: 2 .. 156 (-1/-1) hits flags = 528 (plus default)
[18:55:35.865] <TB2> INFO: dacScan split into 1 runs with ntrig = 8
[18:55:35.865] <TB2> INFO: run 1 of 1
[18:55:36.144] <TB2> INFO: Expecting 5158400 events.
[18:56:02.678] <TB2> INFO: 583360 events read in total (25942ms).
[18:56:28.798] <TB2> INFO: 1166704 events read in total (52063ms).
[18:56:54.839] <TB2> INFO: 1750160 events read in total (78103ms).
[18:57:20.789] <TB2> INFO: 2333544 events read in total (104054ms).
[18:57:46.570] <TB2> INFO: 2916688 events read in total (129834ms).
[18:58:12.746] <TB2> INFO: 3499600 events read in total (156010ms).
[18:58:39.138] <TB2> INFO: 4082768 events read in total (182402ms).
[18:59:04.720] <TB2> INFO: 4664888 events read in total (207984ms).
[18:59:26.869] <TB2> INFO: 5158400 events read in total (230133ms).
[18:59:27.036] <TB2> INFO: Test took 231171ms.
[18:59:54.869] <TB2> INFO: ---> TrimStepCorr2 extremal thresholds: 27.317543 .. 46.802976
[18:59:55.112] <TB2> INFO: Expecting 208000 events.
[19:00:04.959] <TB2> INFO: 208000 events read in total (9255ms).
[19:00:04.960] <TB2> INFO: Test took 10090ms.
[19:00:05.007] <TB2> INFO: ---> dac: vcal name: trimStepCorr2 ntrig: 8 dacrange: 17 .. 56 (-1/-1) hits flags = 528 (plus default)
[19:00:05.020] <TB2> INFO: dacScan split into 1 runs with ntrig = 8
[19:00:05.020] <TB2> INFO: run 1 of 1
[19:00:05.299] <TB2> INFO: Expecting 1331200 events.
[19:00:34.092] <TB2> INFO: 657456 events read in total (28201ms).
[19:01:01.895] <TB2> INFO: 1311312 events read in total (56004ms).
[19:01:03.169] <TB2> INFO: 1331200 events read in total (57279ms).
[19:01:03.215] <TB2> INFO: Test took 58196ms.
[19:01:17.792] <TB2> INFO: ---> TrimStepCorr1a extremal thresholds: 27.592148 .. 47.341219
[19:01:18.110] <TB2> INFO: Expecting 208000 events.
[19:01:28.060] <TB2> INFO: 208000 events read in total (9358ms).
[19:01:28.061] <TB2> INFO: Test took 10268ms.
[19:01:28.108] <TB2> INFO: ---> dac: vcal name: trimStepCorr1a ntrig: 8 dacrange: 17 .. 57 (-1/-1) hits flags = 528 (plus default)
[19:01:28.121] <TB2> INFO: dacScan split into 1 runs with ntrig = 8
[19:01:28.121] <TB2> INFO: run 1 of 1
[19:01:28.400] <TB2> INFO: Expecting 1364480 events.
[19:01:57.048] <TB2> INFO: 652664 events read in total (28056ms).
[19:02:24.397] <TB2> INFO: 1303592 events read in total (55405ms).
[19:02:27.372] <TB2> INFO: 1364480 events read in total (58380ms).
[19:02:27.405] <TB2> INFO: Test took 59284ms.
[19:02:42.515] <TB2> INFO: ---> TrimStepCorr1b extremal thresholds: 25.867133 .. 48.725511
[19:02:42.790] <TB2> INFO: Expecting 208000 events.
[19:02:52.533] <TB2> INFO: 208000 events read in total (9151ms).
[19:02:52.534] <TB2> INFO: Test took 10017ms.
[19:02:52.581] <TB2> INFO: ---> dac: vcal name: trimStepCorr1b ntrig: 8 dacrange: 15 .. 58 (-1/-1) hits flags = 528 (plus default)
[19:02:52.594] <TB2> INFO: dacScan split into 1 runs with ntrig = 8
[19:02:52.594] <TB2> INFO: run 1 of 1
[19:02:52.873] <TB2> INFO: Expecting 1464320 events.
[19:03:21.050] <TB2> INFO: 656112 events read in total (27583ms).
[19:03:48.257] <TB2> INFO: 1311376 events read in total (54791ms).
[19:03:55.406] <TB2> INFO: 1464320 events read in total (61939ms).
[19:03:55.449] <TB2> INFO: Test took 62855ms.
[19:04:09.808] <TB2> INFO: ---> TrimThrFinal extremal thresholds: 15 .. 55
[19:04:09.808] <TB2> INFO: ---> dac: vcal name: TrimThrFinal ntrig: 8 dacrange: 15 .. 55 (-1/-1) hits flags = 528 (plus default)
[19:04:09.821] <TB2> INFO: dacScan split into 1 runs with ntrig = 8
[19:04:09.821] <TB2> INFO: run 1 of 1
[19:04:10.061] <TB2> INFO: Expecting 1364480 events.
[19:04:38.960] <TB2> INFO: 668000 events read in total (28307ms).
[19:05:07.226] <TB2> INFO: 1335232 events read in total (56573ms).
[19:05:08.837] <TB2> INFO: 1364480 events read in total (58184ms).
[19:05:08.868] <TB2> INFO: Test took 59048ms.
[19:05:32.227] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C0.dat
[19:05:32.227] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C1.dat
[19:05:32.227] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C2.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C3.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C4.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C5.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C6.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C7.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C8.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C9.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C10.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C11.dat
[19:05:32.228] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C12.dat
[19:05:32.229] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C13.dat
[19:05:32.229] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C14.dat
[19:05:32.229] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C15.dat
[19:05:32.229] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C0.dat
[19:05:32.237] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C1.dat
[19:05:32.244] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C2.dat
[19:05:32.251] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C3.dat
[19:05:32.258] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C4.dat
[19:05:32.265] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C5.dat
[19:05:32.272] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C6.dat
[19:05:32.279] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C7.dat
[19:05:32.286] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C8.dat
[19:05:32.293] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C9.dat
[19:05:32.302] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C10.dat
[19:05:32.310] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C11.dat
[19:05:32.317] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C12.dat
[19:05:32.324] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C13.dat
[19:05:32.331] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C14.dat
[19:05:32.338] <TB2> INFO: write trim parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//trimParameters35_C15.dat
[19:05:32.345] <TB2> INFO: PixTestTrim::trimTest() done
[19:05:32.345] <TB2> INFO: vtrim: 130 134 139 113 132 143 116 147 140 127 113 122 154 121 118 127
[19:05:32.345] <TB2> INFO: vthrcomp: 112 104 123 116 108 128 118 105 115 97 117 110 106 103 114 117
[19:05:32.345] <TB2> INFO: vcal mean: 34.95 35.18 35.00 35.07 35.01 35.11 34.97 35.08 34.93 35.26 34.97 35.00 35.03 34.99 34.99 35.00
[19:05:32.345] <TB2> INFO: vcal RMS: 1.07 1.41 1.34 1.04 1.11 1.33 1.10 1.14 1.12 1.54 1.32 1.07 1.10 1.06 1.13 1.22
[19:05:32.345] <TB2> INFO: bits mean: 9.57 8.83 10.05 9.53 8.28 9.62 9.82 9.12 9.68 9.64 9.68 8.67 8.21 9.31 9.58 9.38
[19:05:32.345] <TB2> INFO: bits RMS: 2.58 2.78 2.63 2.65 2.71 2.76 2.61 2.39 2.68 2.55 2.70 2.67 2.77 2.56 2.67 2.86
[19:05:32.354] <TB2> INFO: ----------------------------------------------------------------------
[19:05:32.354] <TB2> INFO: PixTestTrim::trimBitTest() ntrig = 5, vtrims = 254 126 63 32
[19:05:32.354] <TB2> INFO: ----------------------------------------------------------------------
[19:05:32.357] <TB2> INFO: ---> dac: Vcal name: TrimBitsThr0 ntrig: 5 dacrange: 0 .. 199 (-1/-1) hits flags = 528 (plus default)
[19:05:32.371] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[19:05:32.371] <TB2> INFO: run 1 of 1
[19:05:32.679] <TB2> INFO: Expecting 4160000 events.
[19:06:30.743] <TB2> INFO: 746150 events read in total (57404ms).
[19:07:46.723] <TB2> INFO: 1487485 events read in total (133384ms).
[19:08:18.547] <TB2> INFO: 2225945 events read in total (165208ms).
[19:08:50.449] <TB2> INFO: 2961235 events read in total (197110ms).
[19:09:22.411] <TB2> INFO: 3692695 events read in total (229072ms).
[19:09:42.542] <TB2> INFO: 4160000 events read in total (249203ms).
[19:09:42.612] <TB2> INFO: Test took 250242ms.
[19:10:12.097] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim14 ntrig: 5 dacrange: 0 .. 228 (-1/-1) hits flags = 528 (plus default)
[19:10:12.111] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[19:10:12.112] <TB2> INFO: run 1 of 1
[19:10:12.364] <TB2> INFO: Expecting 4763200 events.
[19:10:43.619] <TB2> INFO: 692030 events read in total (30664ms).
[19:11:14.167] <TB2> INFO: 1380795 events read in total (61212ms).
[19:11:45.157] <TB2> INFO: 2066825 events read in total (92202ms).
[19:12:16.064] <TB2> INFO: 2752515 events read in total (123109ms).
[19:12:47.048] <TB2> INFO: 3434875 events read in total (154093ms).
[19:13:17.752] <TB2> INFO: 4115175 events read in total (184797ms).
[19:13:47.230] <TB2> INFO: 4763200 events read in total (214275ms).
[19:13:47.386] <TB2> INFO: Test took 215275ms.
[19:14:17.504] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim13 ntrig: 5 dacrange: 0 .. 209 (-1/-1) hits flags = 528 (plus default)
[19:14:17.522] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[19:14:17.522] <TB2> INFO: run 1 of 1
[19:14:17.800] <TB2> INFO: Expecting 4368000 events.
[19:14:49.519] <TB2> INFO: 711325 events read in total (31128ms).
[19:15:20.667] <TB2> INFO: 1419270 events read in total (62276ms).
[19:15:51.947] <TB2> INFO: 2124405 events read in total (93556ms).
[19:16:23.040] <TB2> INFO: 2827005 events read in total (124649ms).
[19:16:55.047] <TB2> INFO: 3526745 events read in total (156656ms).
[19:17:59.151] <TB2> INFO: 4226120 events read in total (220760ms).
[19:18:23.681] <TB2> INFO: 4368000 events read in total (245290ms).
[19:18:23.798] <TB2> INFO: Test took 246276ms.
[19:18:57.951] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim11 ntrig: 5 dacrange: 0 .. 209 (-1/-1) hits flags = 528 (plus default)
[19:18:57.980] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[19:18:57.980] <TB2> INFO: run 1 of 1
[19:18:59.059] <TB2> INFO: Expecting 4368000 events.
[19:20:05.188] <TB2> INFO: 711670 events read in total (65505ms).
[19:21:09.271] <TB2> INFO: 1419725 events read in total (129588ms).
[19:21:46.848] <TB2> INFO: 2124985 events read in total (167165ms).
[19:23:10.032] <TB2> INFO: 2827700 events read in total (250349ms).
[19:24:33.357] <TB2> INFO: 3527760 events read in total (333674ms).
[19:25:09.231] <TB2> INFO: 4227465 events read in total (369548ms).
[19:25:38.387] <TB2> INFO: 4368000 events read in total (398704ms).
[19:25:38.619] <TB2> INFO: Test took 400628ms.
[19:26:23.349] <TB2> INFO: ---> dac: Vcal name: TrimThr_trim7 ntrig: 5 dacrange: 0 .. 210 (-1/-1) hits flags = 528 (plus default)
[19:26:23.363] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[19:26:23.363] <TB2> INFO: run 1 of 1
[19:26:23.609] <TB2> INFO: Expecting 4388800 events.
[19:27:35.645] <TB2> INFO: 710355 events read in total (71444ms).
[19:28:22.194] <TB2> INFO: 1417270 events read in total (117993ms).
[19:29:16.080] <TB2> INFO: 2121425 events read in total (171879ms).
[19:30:42.198] <TB2> INFO: 2823085 events read in total (257997ms).
[19:31:44.605] <TB2> INFO: 3521950 events read in total (320404ms).
[19:32:23.009] <TB2> INFO: 4220695 events read in total (358808ms).
[19:32:30.731] <TB2> INFO: 4388800 events read in total (366530ms).
[19:32:30.844] <TB2> INFO: Test took 367481ms.
[19:33:40.074] <TB2> INFO: PixTestTrim::trimBitTest() done
[19:33:40.075] <TB2> INFO: PixTestTrim::doTest() done, duration: 3151 seconds
[19:33:40.075] <TB2> INFO: Decoding statistics:
[19:33:40.075] <TB2> INFO: General information:
[19:33:40.075] <TB2> INFO: 16bit words read: 0
[19:33:40.075] <TB2> INFO: valid events total: 0
[19:33:40.075] <TB2> INFO: empty events: 0
[19:33:40.075] <TB2> INFO: valid events with pixels: 0
[19:33:40.075] <TB2> INFO: valid pixel hits: 0
[19:33:40.075] <TB2> INFO: Event errors: 0
[19:33:40.075] <TB2> INFO: start marker: 0
[19:33:40.075] <TB2> INFO: stop marker: 0
[19:33:40.075] <TB2> INFO: overflow: 0
[19:33:40.075] <TB2> INFO: invalid 5bit words: 0
[19:33:40.075] <TB2> INFO: invalid XOR eye diagram: 0
[19:33:40.075] <TB2> INFO: frame (failed synchr.): 0
[19:33:40.075] <TB2> INFO: idle data (no TBM trl): 0
[19:33:40.075] <TB2> INFO: no data (only TBM hdr): 0
[19:33:40.076] <TB2> INFO: TBM errors: 0
[19:33:40.076] <TB2> INFO: flawed TBM headers: 0
[19:33:40.076] <TB2> INFO: flawed TBM trailers: 0
[19:33:40.076] <TB2> INFO: event ID mismatches: 0
[19:33:40.076] <TB2> INFO: ROC errors: 0
[19:33:40.076] <TB2> INFO: missing ROC header(s): 0
[19:33:40.076] <TB2> INFO: misplaced readback start: 0
[19:33:40.076] <TB2> INFO: Pixel decoding errors: 0
[19:33:40.076] <TB2> INFO: pixel data incomplete: 0
[19:33:40.076] <TB2> INFO: pixel address: 0
[19:33:40.076] <TB2> INFO: pulse height fill bit: 0
[19:33:40.076] <TB2> INFO: buffer corruption: 0
[19:33:40.780] <TB2> INFO: ######################################################################
[19:33:40.780] <TB2> INFO: PixTestPhOptimization::doTest() Ntrig = 10
[19:33:40.780] <TB2> INFO: ######################################################################
[19:33:41.065] <TB2> INFO: Expecting 41600 events.
[19:33:44.547] <TB2> INFO: 41600 events read in total (2890ms).
[19:33:44.548] <TB2> INFO: Test took 3767ms.
[19:33:44.999] <TB2> INFO: Expecting 41600 events.
[19:33:48.580] <TB2> INFO: 41600 events read in total (2990ms).
[19:33:48.581] <TB2> INFO: Test took 3828ms.
[19:33:48.888] <TB2> INFO: Expecting 41600 events.
[19:33:52.426] <TB2> INFO: 41600 events read in total (2946ms).
[19:33:52.427] <TB2> INFO: Test took 3822ms.
[19:33:52.717] <TB2> INFO: Expecting 41600 events.
[19:33:56.302] <TB2> INFO: 41600 events read in total (2993ms).
[19:33:56.303] <TB2> INFO: Test took 3852ms.
[19:33:56.592] <TB2> INFO: Expecting 41600 events.
[19:34:00.083] <TB2> INFO: 41600 events read in total (2900ms).
[19:34:00.084] <TB2> INFO: Test took 3757ms.
[19:34:00.373] <TB2> INFO: Expecting 41600 events.
[19:34:03.898] <TB2> INFO: 41600 events read in total (2934ms).
[19:34:03.899] <TB2> INFO: Test took 3791ms.
[19:34:04.193] <TB2> INFO: Expecting 41600 events.
[19:34:12.548] <TB2> INFO: 41600 events read in total (7749ms).
[19:34:12.560] <TB2> INFO: Test took 8634ms.
[19:34:13.667] <TB2> INFO: Expecting 41600 events.
[19:34:20.689] <TB2> INFO: 41600 events read in total (6425ms).
[19:34:20.692] <TB2> INFO: Test took 7609ms.
[19:34:21.719] <TB2> INFO: Expecting 41600 events.
[19:34:41.763] <TB2> INFO: 41600 events read in total (19360ms).
[19:34:41.770] <TB2> INFO: Test took 21041ms.
[19:34:42.173] <TB2> INFO: Expecting 41600 events.
[19:35:00.496] <TB2> INFO: 41600 events read in total (17731ms).
[19:35:00.511] <TB2> INFO: Test took 18696ms.
[19:35:02.139] <TB2> INFO: Expecting 41600 events.
[19:35:05.867] <TB2> INFO: 41600 events read in total (3028ms).
[19:35:05.868] <TB2> INFO: Test took 4769ms.
[19:35:06.158] <TB2> INFO: Expecting 41600 events.
[19:35:09.691] <TB2> INFO: 41600 events read in total (2941ms).
[19:35:09.692] <TB2> INFO: Test took 3798ms.
[19:35:09.981] <TB2> INFO: Expecting 41600 events.
[19:35:13.543] <TB2> INFO: 41600 events read in total (2971ms).
[19:35:13.544] <TB2> INFO: Test took 3828ms.
[19:35:13.833] <TB2> INFO: Expecting 41600 events.
[19:35:17.457] <TB2> INFO: 41600 events read in total (3032ms).
[19:35:17.458] <TB2> INFO: Test took 3890ms.
[19:35:17.747] <TB2> INFO: Expecting 41600 events.
[19:35:21.440] <TB2> INFO: 41600 events read in total (3102ms).
[19:35:21.441] <TB2> INFO: Test took 3959ms.
[19:35:21.733] <TB2> INFO: Expecting 41600 events.
[19:35:25.274] <TB2> INFO: 41600 events read in total (2949ms).
[19:35:25.275] <TB2> INFO: Test took 3807ms.
[19:35:25.565] <TB2> INFO: Expecting 41600 events.
[19:35:29.082] <TB2> INFO: 41600 events read in total (2925ms).
[19:35:29.083] <TB2> INFO: Test took 3784ms.
[19:35:29.372] <TB2> INFO: Expecting 41600 events.
[19:35:33.031] <TB2> INFO: 41600 events read in total (3068ms).
[19:35:33.032] <TB2> INFO: Test took 3925ms.
[19:35:33.411] <TB2> INFO: Expecting 41600 events.
[19:35:42.275] <TB2> INFO: 41600 events read in total (8212ms).
[19:35:42.277] <TB2> INFO: Test took 9215ms.
[19:35:42.570] <TB2> INFO: Expecting 41600 events.
[19:35:50.531] <TB2> INFO: 41600 events read in total (7351ms).
[19:35:50.532] <TB2> INFO: Test took 8227ms.
[19:35:51.083] <TB2> INFO: Expecting 41600 events.
[19:36:08.996] <TB2> INFO: 41600 events read in total (17257ms).
[19:36:08.997] <TB2> INFO: Test took 18434ms.
[19:36:09.362] <TB2> INFO: Expecting 41600 events.
[19:36:27.981] <TB2> INFO: 41600 events read in total (18028ms).
[19:36:27.996] <TB2> INFO: Test took 18971ms.
[19:36:28.652] <TB2> INFO: Expecting 41600 events.
[19:36:33.511] <TB2> INFO: 41600 events read in total (4156ms).
[19:36:33.512] <TB2> INFO: Test took 5207ms.
[19:36:33.821] <TB2> INFO: Expecting 41600 events.
[19:36:37.394] <TB2> INFO: 41600 events read in total (2981ms).
[19:36:37.395] <TB2> INFO: Test took 3856ms.
[19:36:37.713] <TB2> INFO: Expecting 41600 events.
[19:36:41.278] <TB2> INFO: 41600 events read in total (2973ms).
[19:36:41.279] <TB2> INFO: Test took 3857ms.
[19:36:41.572] <TB2> INFO: Expecting 41600 events.
[19:36:45.069] <TB2> INFO: 41600 events read in total (2906ms).
[19:36:45.070] <TB2> INFO: Test took 3767ms.
[19:36:45.359] <TB2> INFO: Expecting 41600 events.
[19:36:48.934] <TB2> INFO: 41600 events read in total (2984ms).
[19:36:48.934] <TB2> INFO: Test took 3840ms.
[19:36:49.231] <TB2> INFO: Expecting 41600 events.
[19:36:52.734] <TB2> INFO: 41600 events read in total (2911ms).
[19:36:52.735] <TB2> INFO: Test took 3776ms.
[19:36:53.025] <TB2> INFO: Expecting 41600 events.
[19:36:56.613] <TB2> INFO: 41600 events read in total (2996ms).
[19:36:56.614] <TB2> INFO: Test took 3853ms.
[19:36:56.911] <TB2> INFO: Expecting 41600 events.
[19:37:00.512] <TB2> INFO: 41600 events read in total (3009ms).
[19:37:00.512] <TB2> INFO: Test took 3874ms.
[19:37:00.801] <TB2> INFO: Expecting 41600 events.
[19:37:06.485] <TB2> INFO: 41600 events read in total (5086ms).
[19:37:06.486] <TB2> INFO: Test took 5950ms.
[19:37:06.949] <TB2> INFO: Expecting 41600 events.
[19:37:12.215] <TB2> INFO: 41600 events read in total (4640ms).
[19:37:12.220] <TB2> INFO: Test took 5704ms.
[19:37:13.115] <TB2> INFO: Expecting 41600 events.
[19:37:36.466] <TB2> INFO: 41600 events read in total (22695ms).
[19:37:36.468] <TB2> INFO: Test took 24214ms.
[19:37:37.015] <TB2> INFO: Expecting 41600 events.
[19:37:40.620] <TB2> INFO: 41600 events read in total (2999ms).
[19:37:40.622] <TB2> INFO: Test took 4107ms.
[19:37:40.913] <TB2> INFO: Expecting 41600 events.
[19:38:03.052] <TB2> INFO: 41600 events read in total (21545ms).
[19:38:03.053] <TB2> INFO: Test took 22405ms.
[19:38:03.396] <TB2> INFO: Expecting 41600 events.
[19:38:06.980] <TB2> INFO: 41600 events read in total (2992ms).
[19:38:06.981] <TB2> INFO: Test took 3902ms.
[19:38:07.274] <TB2> INFO: Expecting 41600 events.
[19:38:10.802] <TB2> INFO: 41600 events read in total (2936ms).
[19:38:10.802] <TB2> INFO: Test took 3792ms.
[19:38:11.094] <TB2> INFO: Expecting 41600 events.
[19:38:14.583] <TB2> INFO: 41600 events read in total (2897ms).
[19:38:14.583] <TB2> INFO: Test took 3754ms.
[19:38:14.873] <TB2> INFO: Expecting 41600 events.
[19:38:18.469] <TB2> INFO: 41600 events read in total (3005ms).
[19:38:18.470] <TB2> INFO: Test took 3862ms.
[19:38:18.764] <TB2> INFO: Expecting 41600 events.
[19:38:22.381] <TB2> INFO: 41600 events read in total (3026ms).
[19:38:22.383] <TB2> INFO: Test took 3884ms.
[19:38:22.676] <TB2> INFO: Expecting 41600 events.
[19:38:26.192] <TB2> INFO: 41600 events read in total (2924ms).
[19:38:26.193] <TB2> INFO: Test took 3781ms.
[19:38:26.482] <TB2> INFO: Expecting 41600 events.
[19:38:33.381] <TB2> INFO: 41600 events read in total (6307ms).
[19:38:33.382] <TB2> INFO: Test took 7165ms.
[19:38:33.861] <TB2> INFO: Expecting 41600 events.
[19:38:40.198] <TB2> INFO: 41600 events read in total (5739ms).
[19:38:40.199] <TB2> INFO: Test took 6780ms.
[19:38:40.879] <TB2> INFO: Expecting 41600 events.
[19:38:45.679] <TB2> INFO: 41600 events read in total (4084ms).
[19:38:45.680] <TB2> INFO: Test took 5457ms.
[19:38:46.223] <TB2> INFO: Expecting 41600 events.
[19:38:52.915] <TB2> INFO: 41600 events read in total (6036ms).
[19:38:52.922] <TB2> INFO: Test took 7125ms.
[19:38:53.386] <TB2> INFO: Expecting 41600 events.
[19:39:00.035] <TB2> INFO: 41600 events read in total (5984ms).
[19:39:00.043] <TB2> INFO: Test took 7073ms.
[19:39:00.422] <TB2> INFO: Expecting 41600 events.
[19:39:08.344] <TB2> INFO: 41600 events read in total (7321ms).
[19:39:08.353] <TB2> INFO: Test took 8272ms.
[19:39:09.758] <TB2> INFO: Expecting 41600 events.
[19:39:23.620] <TB2> INFO: 41600 events read in total (13141ms).
[19:39:23.624] <TB2> INFO: Test took 14857ms.
[19:39:23.979] <TB2> INFO: Expecting 41600 events.
[19:39:27.529] <TB2> INFO: 41600 events read in total (2959ms).
[19:39:27.530] <TB2> INFO: Test took 3865ms.
[19:39:27.820] <TB2> INFO: Expecting 41600 events.
[19:39:31.436] <TB2> INFO: 41600 events read in total (3025ms).
[19:39:31.437] <TB2> INFO: Test took 3882ms.
[19:39:31.731] <TB2> INFO: Expecting 41600 events.
[19:39:35.248] <TB2> INFO: 41600 events read in total (2926ms).
[19:39:35.248] <TB2> INFO: Test took 3783ms.
[19:39:35.538] <TB2> INFO: Expecting 41600 events.
[19:39:39.110] <TB2> INFO: 41600 events read in total (2981ms).
[19:39:39.111] <TB2> INFO: Test took 3838ms.
[19:39:39.408] <TB2> INFO: Expecting 41600 events.
[19:39:42.920] <TB2> INFO: 41600 events read in total (2921ms).
[19:39:42.921] <TB2> INFO: Test took 3784ms.
[19:39:43.212] <TB2> INFO: Expecting 41600 events.
[19:39:46.828] <TB2> INFO: 41600 events read in total (3025ms).
[19:39:46.829] <TB2> INFO: Test took 3882ms.
[19:39:47.119] <TB2> INFO: Expecting 2560 events.
[19:39:48.007] <TB2> INFO: 2560 events read in total (296ms).
[19:39:48.007] <TB2> INFO: Test took 1165ms.
[19:39:48.315] <TB2> INFO: Expecting 2560 events.
[19:39:49.198] <TB2> INFO: 2560 events read in total (291ms).
[19:39:49.198] <TB2> INFO: Test took 1190ms.
[19:39:49.507] <TB2> INFO: Expecting 2560 events.
[19:39:50.395] <TB2> INFO: 2560 events read in total (297ms).
[19:39:50.396] <TB2> INFO: Test took 1197ms.
[19:39:50.704] <TB2> INFO: Expecting 2560 events.
[19:39:51.605] <TB2> INFO: 2560 events read in total (308ms).
[19:39:51.605] <TB2> INFO: Test took 1209ms.
[19:39:51.914] <TB2> INFO: Expecting 2560 events.
[19:39:52.809] <TB2> INFO: 2560 events read in total (304ms).
[19:39:52.810] <TB2> INFO: Test took 1204ms.
[19:39:53.149] <TB2> INFO: Expecting 2560 events.
[19:39:55.658] <TB2> INFO: 2560 events read in total (1847ms).
[19:39:55.663] <TB2> INFO: Test took 2836ms.
[19:39:56.148] <TB2> INFO: Expecting 2560 events.
[19:39:57.172] <TB2> INFO: 2560 events read in total (361ms).
[19:39:57.179] <TB2> INFO: Test took 1509ms.
[19:39:57.473] <TB2> INFO: Expecting 2560 events.
[19:40:00.116] <TB2> INFO: 2560 events read in total (2045ms).
[19:40:00.122] <TB2> INFO: Test took 2935ms.
[19:40:00.729] <TB2> INFO: Expecting 2560 events.
[19:40:02.142] <TB2> INFO: 2560 events read in total (793ms).
[19:40:02.142] <TB2> INFO: Test took 2003ms.
[19:40:02.464] <TB2> INFO: Expecting 2560 events.
[19:40:03.355] <TB2> INFO: 2560 events read in total (300ms).
[19:40:03.359] <TB2> INFO: Test took 1216ms.
[19:40:03.895] <TB2> INFO: Expecting 2560 events.
[19:40:05.686] <TB2> INFO: 2560 events read in total (1099ms).
[19:40:05.686] <TB2> INFO: Test took 2326ms.
[19:40:05.000] <TB2> INFO: Expecting 2560 events.
[19:40:08.524] <TB2> INFO: 2560 events read in total (1889ms).
[19:40:08.524] <TB2> INFO: Test took 2837ms.
[19:40:08.836] <TB2> INFO: Expecting 2560 events.
[19:40:11.349] <TB2> INFO: 2560 events read in total (1906ms).
[19:40:11.360] <TB2> INFO: Test took 2835ms.
[19:40:11.859] <TB2> INFO: Expecting 2560 events.
[19:40:14.588] <TB2> INFO: 2560 events read in total (2041ms).
[19:40:14.599] <TB2> INFO: Test took 3222ms.
[19:40:15.143] <TB2> INFO: Expecting 2560 events.
[19:40:17.889] <TB2> INFO: 2560 events read in total (2054ms).
[19:40:17.899] <TB2> INFO: Test took 3280ms.
[19:40:18.503] <TB2> INFO: Expecting 2560 events.
[19:40:21.196] <TB2> INFO: 2560 events read in total (1981ms).
[19:40:21.196] <TB2> INFO: Test took 3281ms.


[19:40:21.198] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:40:21.639] <TB2> INFO: Expecting 655360 events.
[19:40:58.568] <TB2> INFO: 655360 events read in total (36229ms).
[19:40:58.584] <TB2> INFO: Expecting 655360 events.
[19:41:12.616] <TB2> INFO: 655360 events read in total (13629ms).
[19:41:12.633] <TB2> INFO: Expecting 655360 events.
[19:41:57.550] <TB2> INFO: 655360 events read in total (44514ms).
[19:41:57.576] <TB2> INFO: Expecting 655360 events.
[19:42:26.316] <TB2> INFO: 655360 events read in total (28337ms).
[19:42:26.348] <TB2> INFO: Expecting 655360 events.
[19:42:40.711] <TB2> INFO: 655360 events read in total (13960ms).
[19:42:40.741] <TB2> INFO: Expecting 655360 events.
[19:43:24.055] <TB2> INFO: 655360 events read in total (42911ms).
[19:43:24.100] <TB2> INFO: Expecting 655360 events.
[19:43:53.999] <TB2> INFO: 655360 events read in total (29493ms).
[19:43:54.038] <TB2> INFO: Expecting 655360 events.
[19:44:08.325] <TB2> INFO: 655360 events read in total (13884ms).
[19:44:08.381] <TB2> INFO: Expecting 655360 events.
[19:44:52.105] <TB2> INFO: 655360 events read in total (43321ms).
[19:44:52.174] <TB2> INFO: Expecting 655360 events.
[19:45:21.829] <TB2> INFO: 655360 events read in total (29251ms).
[19:45:21.904] <TB2> INFO: Expecting 655360 events.
[19:45:36.393] <TB2> INFO: 655360 events read in total (14074ms).
[19:45:36.514] <TB2> INFO: Expecting 655360 events.
[19:46:22.267] <TB2> INFO: 655360 events read in total (45350ms).
[19:46:22.344] <TB2> INFO: Expecting 655360 events.
[19:46:52.157] <TB2> INFO: 655360 events read in total (29410ms).
[19:46:52.244] <TB2> INFO: Expecting 655360 events.
[19:47:06.623] <TB2> INFO: 655360 events read in total (13976ms).
[19:47:06.735] <TB2> INFO: Expecting 655360 events.
[19:48:08.111] <TB2> INFO: 655360 events read in total (60973ms).
[19:48:08.268] <TB2> INFO: Test took 467070ms.
[19:48:08.383] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:48:08.631] <TB2> INFO: Expecting 655360 events.
[19:48:23.142] <TB2> INFO: 655360 events read in total (13914ms).
[19:48:23.155] <TB2> INFO: Expecting 655360 events.
[19:48:37.274] <TB2> INFO: 655360 events read in total (13716ms).
[19:48:37.294] <TB2> INFO: Expecting 655360 events.
[19:49:24.272] <TB2> INFO: 655360 events read in total (46575ms).
[19:49:24.353] <TB2> INFO: Expecting 655360 events.
[19:49:50.197] <TB2> INFO: 655360 events read in total (25338ms).
[19:49:50.240] <TB2> INFO: Expecting 655360 events.
[19:50:04.684] <TB2> INFO: 655360 events read in total (14038ms).
[19:50:04.739] <TB2> INFO: Expecting 655360 events.
[19:50:33.413] <TB2> INFO: 655360 events read in total (28267ms).
[19:50:33.490] <TB2> INFO: Expecting 655360 events.
[19:51:10.259] <TB2> INFO: 655360 events read in total (36344ms).
[19:51:10.297] <TB2> INFO: Expecting 655360 events.
[19:51:24.154] <TB2> INFO: 655360 events read in total (13453ms).
[19:51:24.208] <TB2> INFO: Expecting 655360 events.
[19:51:42.616] <TB2> INFO: 655360 events read in total (18005ms).
[19:51:42.789] <TB2> INFO: Expecting 655360 events.
[19:52:19.124] <TB2> INFO: 655360 events read in total (35805ms).
[19:52:19.186] <TB2> INFO: Expecting 655360 events.
[19:52:48.861] <TB2> INFO: 655360 events read in total (29272ms).
[19:52:48.957] <TB2> INFO: Expecting 655360 events.
[19:53:03.326] <TB2> INFO: 655360 events read in total (13965ms).
[19:53:03.406] <TB2> INFO: Expecting 655360 events.
[19:53:46.524] <TB2> INFO: 655360 events read in total (42715ms).
[19:53:46.611] <TB2> INFO: Expecting 655360 events.
[19:54:15.787] <TB2> INFO: 655360 events read in total (28773ms).
[19:54:15.897] <TB2> INFO: Expecting 655360 events.
[19:54:30.086] <TB2> INFO: 655360 events read in total (13786ms).
[19:54:30.204] <TB2> INFO: Expecting 655360 events.
[19:54:58.058] <TB2> INFO: 655360 events read in total (27451ms).
[19:54:58.397] <TB2> INFO: Test took 410014ms.
[19:54:59.228] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:54:59.256] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:54:59.277] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:54:59.301] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:54:59.326] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:54:59.367] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:54:59.404] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:54:59.438] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:54:59.469] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[19:54:59.488] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[19:54:59.509] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[19:54:59.532] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[19:54:59.555] <TB2> INFO: safety margin for low PH: adding 7, margin is now 27
[19:54:59.577] <TB2> INFO: safety margin for low PH: adding 8, margin is now 28
[19:54:59.600] <TB2> INFO: safety margin for low PH: adding 9, margin is now 29
[19:54:59.622] <TB2> INFO: safety margin for low PH: adding 10, margin is now 30
[19:54:59.643] <TB2> INFO: safety margin for low PH: adding 11, margin is now 31
[19:54:59.667] <TB2> INFO: safety margin for low PH: adding 12, margin is now 32
[19:54:59.689] <TB2> INFO: safety margin for low PH: adding 13, margin is now 33
[19:54:59.712] <TB2> INFO: safety margin for low PH: adding 14, margin is now 34
[19:54:59.731] <TB2> INFO: safety margin for low PH: adding 15, margin is now 35
[19:54:59.756] <TB2> INFO: safety margin for low PH: adding 16, margin is now 36
[19:54:59.774] <TB2> INFO: safety margin for low PH: adding 17, margin is now 37
[19:54:59.797] <TB2> INFO: safety margin for low PH: adding 18, margin is now 38
[19:54:59.817] <TB2> INFO: safety margin for low PH: adding 19, margin is now 39
[19:54:59.837] <TB2> INFO: safety margin for low PH: adding 20, margin is now 40
[19:54:59.860] <TB2> INFO: safety margin for low PH: adding 21, margin is now 41
[19:54:59.882] <TB2> INFO: safety margin for low PH: adding 22, margin is now 42
[19:54:59.905] <TB2> INFO: safety margin for low PH: adding 23, margin is now 43
[19:54:59.920] <TB2> INFO: safety margin for low PH: adding 24, margin is now 44
[19:54:59.932] <TB2> INFO: safety margin for low PH: adding 25, margin is now 45
[19:54:59.944] <TB2> INFO: safety margin for low PH: adding 26, margin is now 46
[19:54:59.955] <TB2> INFO: safety margin for low PH: adding 27, margin is now 47
[19:54:59.966] <TB2> INFO: safety margin for low PH: adding 28, margin is now 48
[19:54:59.977] <TB2> INFO: safety margin for low PH: adding 29, margin is now 49
[19:54:59.998] <TB2> INFO: safety margin for low PH: adding 30, margin is now 50
[19:55:00.021] <TB2> INFO: safety margin for low PH: adding 31, margin is now 51
[19:55:00.045] <TB2> INFO: safety margin for low PH: adding 32, margin is now 52
[19:55:00.068] <TB2> INFO: safety margin for low PH: adding 33, margin is now 53
[19:55:00.093] <TB2> INFO: safety margin for low PH: adding 34, margin is now 54
[19:55:00.117] <TB2> INFO: safety margin for low PH: adding 35, margin is now 55
[19:55:00.141] <TB2> INFO: safety margin for low PH: adding 36, margin is now 56
[19:55:00.166] <TB2> INFO: safety margin for low PH: adding 37, margin is now 57
[19:55:00.190] <TB2> INFO: safety margin for low PH: adding 38, margin is now 58
[19:55:00.214] <TB2> INFO: safety margin for low PH: adding 39, margin is now 59
[19:55:00.241] <TB2> INFO: safety margin for low PH: adding 40, margin is now 60
[19:55:00.263] <TB2> INFO: safety margin for low PH: adding 41, margin is now 61
[19:55:00.287] <TB2> INFO: safety margin for low PH: adding 42, margin is now 62
[19:55:00.312] <TB2> INFO: safety margin for low PH: adding 43, margin is now 63
[19:55:00.335] <TB2> INFO: safety margin for low PH: adding 44, margin is now 64
[19:55:00.360] <TB2> INFO: safety margin for low PH: adding 45, margin is now 65
[19:55:00.405] <TB2> INFO: safety margin for low PH: adding 46, margin is now 66
[19:55:00.436] <TB2> INFO: safety margin for low PH: adding 47, margin is now 67
[19:55:00.471] <TB2> INFO: safety margin for low PH: adding 48, margin is now 68
[19:55:00.504] <TB2> INFO: safety margin for low PH: adding 49, margin is now 69
[19:55:00.535] <TB2> INFO: safety margin for low PH: adding 50, margin is now 70
[19:55:00.563] <TB2> INFO: safety margin for low PH: adding 51, margin is now 71
[19:55:00.587] <TB2> INFO: safety margin for low PH: adding 52, margin is now 72
[19:55:00.612] <TB2> INFO: safety margin for low PH: adding 53, margin is now 73
[19:55:00.637] <TB2> INFO: safety margin for low PH: adding 54, margin is now 74
[19:55:00.661] <TB2> INFO: safety margin for low PH: adding 55, margin is now 75
[19:55:00.686] <TB2> INFO: safety margin for low PH: adding 56, margin is now 76
[19:55:00.710] <TB2> INFO: safety margin for low PH: adding 57, margin is now 77
[19:55:00.735] <TB2> INFO: safety margin for low PH: adding 58, margin is now 78
[19:55:00.760] <TB2> INFO: safety margin for low PH: adding 59, margin is now 79
[19:55:00.785] <TB2> INFO: safety margin for low PH: adding 60, margin is now 80
[19:55:00.811] <TB2> INFO: safety margin for low PH: adding 61, margin is now 81
[19:55:00.836] <TB2> INFO: safety margin for low PH: adding 62, margin is now 82
[19:55:00.880] <TB2> INFO: safety margin for low PH: adding 63, margin is now 83
[19:55:00.915] <TB2> INFO: safety margin for low PH: adding 64, margin is now 84
[19:55:00.953] <TB2> INFO: safety margin for low PH: adding 65, margin is now 85
[19:55:00.991] <TB2> INFO: safety margin for low PH: adding 66, margin is now 86
[19:55:01.023] <TB2> INFO: safety margin for low PH: adding 67, margin is now 87
[19:55:01.054] <TB2> INFO: safety margin for low PH: adding 68, margin is now 88
[19:55:01.080] <TB2> INFO: safety margin for low PH: adding 69, margin is now 89
[19:55:01.115] <TB2> INFO: safety margin for low PH: adding 70, margin is now 90
[19:55:01.140] <TB2> INFO: safety margin for low PH: adding 71, margin is now 91
[19:55:01.164] <TB2> INFO: safety margin for low PH: adding 72, margin is now 92
[19:55:01.187] <TB2> INFO: safety margin for low PH: adding 73, margin is now 93
[19:55:01.211] <TB2> INFO: safety margin for low PH: adding 74, margin is now 94
[19:55:01.234] <TB2> INFO: safety margin for low PH: adding 75, margin is now 95
[19:55:01.258] <TB2> INFO: safety margin for low PH: adding 76, margin is now 96
[19:55:01.281] <TB2> INFO: safety margin for low PH: adding 77, margin is now 97
[19:55:01.305] <TB2> INFO: safety margin for low PH: adding 78, margin is now 98
[19:55:01.343] <TB2> INFO: safety margin for low PH: adding 79, margin is now 99
[19:55:01.376] <TB2> INFO: safety margin for low PH: adding 80, margin is now 100
[19:55:01.410] <TB2> INFO: safety margin for low PH: adding 81, margin is now 101
[19:55:01.443] <TB2> INFO: safety margin for low PH: adding 82, margin is now 102
[19:55:01.477] <TB2> INFO: safety margin for low PH: adding 83, margin is now 103
[19:55:01.512] <TB2> INFO: safety margin for low PH: adding 84, margin is now 104
[19:55:01.535] <TB2> INFO: safety margin for low PH: adding 85, margin is now 105
[19:55:01.570] <TB2> INFO: safety margin for low PH: adding 86, margin is now 106
[19:55:01.606] <TB2> INFO: safety margin for low PH: adding 87, margin is now 107
[19:55:01.635] <TB2> INFO: safety margin for low PH: adding 88, margin is now 108
[19:55:01.668] <TB2> INFO: safety margin for low PH: adding 89, margin is now 109
[19:55:01.687] <TB2> INFO: safety margin for low PH: adding 90, margin is now 110
[19:55:01.709] <TB2> INFO: safety margin for low PH: adding 91, margin is now 111
[19:55:01.749] <TB2> INFO: safety margin for low PH: adding 92, margin is now 112
[19:55:01.777] <TB2> INFO: safety margin for low PH: adding 93, margin is now 113
[19:55:01.799] <TB2> INFO: safety margin for low PH: adding 94, margin is now 114
[19:55:01.818] <TB2> INFO: safety margin for low PH: adding 95, margin is now 115
[19:55:01.839] <TB2> INFO: safety margin for low PH: adding 96, margin is now 116
[19:55:01.860] <TB2> INFO: safety margin for low PH: adding 97, margin is now 117
[19:55:01.881] <TB2> INFO: safety margin for low PH: adding 98, margin is now 118
[19:55:01.902] <TB2> INFO: safety margin for low PH: adding 99, margin is now 119
[19:55:01.937] <TB2> INFO: safety margin for low PH: adding 100, margin is now 120
[19:55:01.971] <TB2> INFO: safety margin for low PH: adding 101, margin is now 121
[19:55:02.004] <TB2> INFO: safety margin for low PH: adding 102, margin is now 122
[19:55:02.036] <TB2> INFO: safety margin for low PH: adding 103, margin is now 123
[19:55:02.070] <TB2> INFO: safety margin for low PH: adding 104, margin is now 124
[19:55:02.101] <TB2> INFO: safety margin for low PH: adding 105, margin is now 125
[19:55:02.144] <TB2> INFO: safety margin for low PH: adding 106, margin is now 126
[19:55:02.162] <TB2> INFO: safety margin for low PH: adding 107, margin is now 127
[19:55:02.206] <TB2> INFO: safety margin for low PH: adding 108, margin is now 128
[19:55:02.243] <TB2> INFO: safety margin for low PH: adding 109, margin is now 129
[19:55:02.278] <TB2> INFO: safety margin for low PH: adding 110, margin is now 130
[19:55:02.302] <TB2> INFO: safety margin for low PH: adding 111, margin is now 131
[19:55:02.323] <TB2> INFO: safety margin for low PH: adding 112, margin is now 132
[19:55:02.344] <TB2> INFO: safety margin for low PH: adding 113, margin is now 133
[19:55:02.366] <TB2> INFO: safety margin for low PH: adding 114, margin is now 134
[19:55:02.388] <TB2> INFO: safety margin for low PH: adding 115, margin is now 135
[19:55:02.410] <TB2> INFO: safety margin for low PH: adding 116, margin is now 136
[19:55:02.432] <TB2> INFO: safety margin for low PH: adding 117, margin is now 137
[19:55:02.453] <TB2> INFO: safety margin for low PH: adding 118, margin is now 138
[19:55:02.474] <TB2> INFO: safety margin for low PH: adding 119, margin is now 139
[19:55:02.500] <TB2> INFO: safety margin for low PH: adding 120, margin is now 140
[19:55:02.523] <TB2> INFO: safety margin for low PH: adding 121, margin is now 141
[19:55:02.549] <TB2> INFO: safety margin for low PH: adding 122, margin is now 142
[19:55:02.566] <TB2> INFO: safety margin for low PH: adding 123, margin is now 143
[19:55:02.584] <TB2> INFO: safety margin for low PH: adding 124, margin is now 144
[19:55:02.632] <TB2> INFO: safety margin for low PH: adding 125, margin is now 145
[19:55:02.642] <TB2> INFO: safety margin for low PH: adding 126, margin is now 146
[19:55:02.652] <TB2> INFO: safety margin for low PH: adding 127, margin is now 147
[19:55:02.663] <TB2> INFO: safety margin for low PH: adding 128, margin is now 148
[19:55:02.674] <TB2> INFO: safety margin for low PH: adding 129, margin is now 149
[19:55:02.684] <TB2> INFO: safety margin for low PH: adding 130, margin is now 150
[19:55:02.694] <TB2> INFO: safety margin for low PH: adding 131, margin is now 151
[19:55:02.705] <TB2> INFO: safety margin for low PH: adding 132, margin is now 152
[19:55:02.715] <TB2> INFO: safety margin for low PH: adding 133, margin is now 153
[19:55:02.726] <TB2> INFO: safety margin for low PH: adding 134, margin is now 154
[19:55:02.736] <TB2> INFO: safety margin for low PH: adding 135, margin is now 155
[19:55:02.747] <TB2> INFO: safety margin for low PH: adding 136, margin is now 156
[19:55:02.757] <TB2> INFO: safety margin for low PH: adding 137, margin is now 157
[19:55:02.768] <TB2> INFO: safety margin for low PH: adding 138, margin is now 158
[19:55:02.778] <TB2> INFO: safety margin for low PH: adding 139, margin is now 159
[19:55:02.789] <TB2> INFO: safety margin for low PH: adding 140, margin is now 160
[19:55:02.799] <TB2> INFO: safety margin for low PH: adding 141, margin is now 161
[19:55:02.811] <TB2> INFO: safety margin for low PH: adding 142, margin is now 162
[19:55:02.823] <TB2> INFO: safety margin for low PH: adding 143, margin is now 163
[19:55:02.836] <TB2> INFO: safety margin for low PH: adding 144, margin is now 164
[19:55:02.849] <TB2> INFO: safety margin for low PH: adding 145, margin is now 165
[19:55:02.862] <TB2> INFO: safety margin for low PH: adding 146, margin is now 166
[19:55:02.875] <TB2> INFO: safety margin for low PH: adding 147, margin is now 167
[19:55:02.888] <TB2> INFO: safety margin for low PH: adding 148, margin is now 168
[19:55:02.901] <TB2> INFO: safety margin for low PH: adding 149, margin is now 169
[19:55:02.913] <TB2> INFO: safety margin for low PH: adding 150, margin is now 170
[19:55:02.926] <TB2> INFO: safety margin for low PH: adding 151, margin is now 171
[19:55:02.940] <TB2> INFO: safety margin for low PH: adding 152, margin is now 172
[19:55:02.952] <TB2> INFO: safety margin for low PH: adding 153, margin is now 173
[19:55:02.965] <TB2> INFO: safety margin for low PH: adding 154, margin is now 174
[19:55:02.978] <TB2> INFO: safety margin for low PH: adding 155, margin is now 175
[19:55:02.991] <TB2> INFO: safety margin for low PH: adding 156, margin is now 176
[19:55:03.003] <TB2> INFO: safety margin for low PH: adding 157, margin is now 177
[19:55:03.016] <TB2> INFO: safety margin for low PH: adding 158, margin is now 178
[19:55:03.029] <TB2> INFO: safety margin for low PH: adding 159, margin is now 179
[19:55:03.042] <TB2> INFO: safety margin for low PH: adding 160, margin is now 180
[19:55:03.055] <TB2> INFO: safety margin for low PH: adding 161, margin is now 181
[19:55:03.070] <TB2> INFO: safety margin for low PH: adding 162, margin is now 182
[19:55:03.086] <TB2> INFO: safety margin for low PH: adding 163, margin is now 183
[19:55:03.103] <TB2> INFO: safety margin for low PH: adding 164, margin is now 184
[19:55:03.119] <TB2> INFO: safety margin for low PH: adding 165, margin is now 185
[19:55:03.132] <TB2> INFO: safety margin for low PH: adding 166, margin is now 186
[19:55:03.140] <TB2> INFO: safety margin for low PH: adding 167, margin is now 187
[19:55:03.150] <TB2> INFO: safety margin for low PH: adding 168, margin is now 188
[19:55:03.160] <TB2> INFO: safety margin for low PH: adding 169, margin is now 189
[19:55:03.169] <TB2> INFO: safety margin for low PH: adding 170, margin is now 190
[19:55:03.179] <TB2> INFO: safety margin for low PH: adding 171, margin is now 191
[19:55:03.189] <TB2> INFO: safety margin for low PH: adding 172, margin is now 192
[19:55:03.199] <TB2> INFO: safety margin for low PH: adding 173, margin is now 193
[19:55:03.209] <TB2> INFO: safety margin for low PH: adding 174, margin is now 194
[19:55:03.218] <TB2> INFO: safety margin for low PH: adding 175, margin is now 195
[19:55:03.228] <TB2> INFO: safety margin for low PH: adding 176, margin is now 196
[19:55:03.238] <TB2> INFO: safety margin for low PH: adding 177, margin is now 197
[19:55:03.247] <TB2> INFO: safety margin for low PH: adding 178, margin is now 198
[19:55:03.257] <TB2> INFO: safety margin for low PH: adding 179, margin is now 199
[19:55:03.267] <TB2> INFO: safety margin for low PH: adding 180, margin is now 200
[19:55:03.277] <TB2> INFO: safety margin for low PH: adding 181, margin is now 201
[19:55:03.286] <TB2> INFO: safety margin for low PH: adding 182, margin is now 202
[19:55:03.296] <TB2> INFO: safety margin for low PH: adding 183, margin is now 203
[19:55:03.305] <TB2> INFO: safety margin for low PH: adding 184, margin is now 204
[19:55:03.316] <TB2> INFO: safety margin for low PH: adding 185, margin is now 205
[19:55:03.326] <TB2> INFO: safety margin for low PH: adding 186, margin is now 206
[19:55:03.335] <TB2> INFO: safety margin for low PH: adding 187, margin is now 207
[19:55:03.345] <TB2> INFO: safety margin for low PH: adding 188, margin is now 208
[19:55:03.355] <TB2> INFO: safety margin for low PH: adding 189, margin is now 209
[19:55:03.365] <TB2> INFO: safety margin for low PH: adding 190, margin is now 210
[19:55:03.375] <TB2> INFO: safety margin for low PH: adding 191, margin is now 211
[19:55:03.384] <TB2> INFO: safety margin for low PH: adding 192, margin is now 212
[19:55:03.396] <TB2> INFO: safety margin for low PH: adding 193, margin is now 213
[19:55:03.406] <TB2> INFO: safety margin for low PH: adding 194, margin is now 214
[19:55:03.416] <TB2> INFO: safety margin for low PH: adding 195, margin is now 215
[19:55:03.426] <TB2> INFO: safety margin for low PH: adding 196, margin is now 216
[19:55:03.435] <TB2> INFO: safety margin for low PH: adding 197, margin is now 217
[19:55:03.445] <TB2> INFO: safety margin for low PH: adding 198, margin is now 218
[19:55:03.459] <TB2> INFO: safety margin for low PH: adding 199, margin is now 219
[19:55:03.475] <TB2> INFO: safety margin for low PH: adding 200, margin is now 220
[19:55:03.493] <TB2> INFO: safety margin for low PH: adding 201, margin is now 221
[19:55:03.508] <TB2> INFO: safety margin for low PH: adding 202, margin is now 222
[19:55:03.524] <TB2> INFO: safety margin for low PH: adding 203, margin is now 223
[19:55:03.540] <TB2> INFO: safety margin for low PH: adding 204, margin is now 224
[19:55:03.556] <TB2> INFO: safety margin for low PH: adding 205, margin is now 225
[19:55:03.572] <TB2> INFO: safety margin for low PH: adding 206, margin is now 226
[19:55:03.588] <TB2> INFO: safety margin for low PH: adding 207, margin is now 227
[19:55:03.604] <TB2> INFO: safety margin for low PH: adding 208, margin is now 228
[19:55:03.620] <TB2> INFO: safety margin for low PH: adding 209, margin is now 229
[19:55:03.636] <TB2> INFO: safety margin for low PH: adding 210, margin is now 230
[19:55:03.652] <TB2> INFO: safety margin for low PH: adding 211, margin is now 231
[19:55:03.669] <TB2> INFO: safety margin for low PH: adding 212, margin is now 232
[19:55:03.686] <TB2> INFO: safety margin for low PH: adding 213, margin is now 233
[19:55:03.703] <TB2> INFO: safety margin for low PH: adding 214, margin is now 234
[19:55:03.720] <TB2> INFO: safety margin for low PH: adding 215, margin is now 235
[19:55:03.736] <TB2> INFO: safety margin for low PH: adding 216, margin is now 236
[19:55:03.753] <TB2> INFO: safety margin for low PH: adding 217, margin is now 237
[19:55:03.769] <TB2> INFO: safety margin for low PH: adding 218, margin is now 238
[19:55:03.786] <TB2> INFO: safety margin for low PH: adding 219, margin is now 239
[19:55:03.802] <TB2> INFO: safety margin for low PH: adding 220, margin is now 240
[19:55:03.819] <TB2> INFO: safety margin for low PH: adding 221, margin is now 241
[19:55:03.836] <TB2> INFO: safety margin for low PH: adding 222, margin is now 242
[19:55:03.852] <TB2> INFO: safety margin for low PH: adding 223, margin is now 243
[19:55:03.869] <TB2> INFO: safety margin for low PH: adding 224, margin is now 244
[19:55:03.886] <TB2> INFO: safety margin for low PH: adding 225, margin is now 245
[19:55:03.902] <TB2> INFO: safety margin for low PH: adding 226, margin is now 246
[19:55:03.919] <TB2> INFO: safety margin for low PH: adding 227, margin is now 247
[19:55:03.936] <TB2> INFO: safety margin for low PH: adding 228, margin is now 248
[19:55:03.952] <TB2> INFO: safety margin for low PH: adding 229, margin is now 249
[19:55:03.969] <TB2> INFO: safety margin for low PH: adding 230, margin is now 250
[19:55:03.985] <TB2> INFO: safety margin for low PH: adding 231, margin is now 251
[19:55:04.003] <TB2> INFO: safety margin for low PH: adding 232, margin is now 252
[19:55:04.018] <TB2> INFO: safety margin for low PH: adding 233, margin is now 253
[19:55:04.035] <TB2> INFO: safety margin for low PH: adding 234, margin is now 254
[19:55:04.052] <TB2> INFO: safety margin for low PH: adding 235, margin is now 255
[19:55:04.068] <TB2> INFO: For ROC 2: No solutions with PhScale > 20 could be found. Looking for a solution with PhScale < 20.
[19:55:04.073] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:04.089] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:04.106] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:55:04.118] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[19:55:04.130] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[19:55:04.142] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[19:55:04.154] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[19:55:04.166] <TB2> INFO: safety margin for low PH: adding 7, margin is now 27
[19:55:04.188] <TB2> INFO: safety margin for low PH: adding 8, margin is now 28
[19:55:04.201] <TB2> INFO: safety margin for low PH: adding 9, margin is now 29
[19:55:04.213] <TB2> INFO: safety margin for low PH: adding 10, margin is now 30
[19:55:04.226] <TB2> INFO: safety margin for low PH: adding 11, margin is now 31
[19:55:04.239] <TB2> INFO: safety margin for low PH: adding 12, margin is now 32
[19:55:04.251] <TB2> INFO: safety margin for low PH: adding 13, margin is now 33
[19:55:04.263] <TB2> INFO: safety margin for low PH: adding 14, margin is now 34
[19:55:04.276] <TB2> INFO: safety margin for low PH: adding 15, margin is now 35
[19:55:04.288] <TB2> INFO: safety margin for low PH: adding 16, margin is now 36
[19:55:04.300] <TB2> INFO: safety margin for low PH: adding 17, margin is now 37
[19:55:04.313] <TB2> INFO: safety margin for low PH: adding 18, margin is now 38
[19:55:04.326] <TB2> INFO: safety margin for low PH: adding 19, margin is now 39
[19:55:04.338] <TB2> INFO: safety margin for low PH: adding 20, margin is now 40
[19:55:04.350] <TB2> INFO: safety margin for low PH: adding 21, margin is now 41
[19:55:04.362] <TB2> INFO: safety margin for low PH: adding 22, margin is now 42
[19:55:04.375] <TB2> INFO: safety margin for low PH: adding 23, margin is now 43
[19:55:04.387] <TB2> INFO: safety margin for low PH: adding 24, margin is now 44
[19:55:04.399] <TB2> INFO: safety margin for low PH: adding 25, margin is now 45
[19:55:04.412] <TB2> INFO: safety margin for low PH: adding 26, margin is now 46
[19:55:04.425] <TB2> INFO: safety margin for low PH: adding 27, margin is now 47
[19:55:04.437] <TB2> INFO: safety margin for low PH: adding 28, margin is now 48
[19:55:04.449] <TB2> INFO: safety margin for low PH: adding 29, margin is now 49
[19:55:04.462] <TB2> INFO: safety margin for low PH: adding 30, margin is now 50
[19:55:04.475] <TB2> INFO: safety margin for low PH: adding 31, margin is now 51
[19:55:04.487] <TB2> INFO: safety margin for low PH: adding 32, margin is now 52
[19:55:04.499] <TB2> INFO: safety margin for low PH: adding 33, margin is now 53
[19:55:04.512] <TB2> INFO: safety margin for low PH: adding 34, margin is now 54
[19:55:04.524] <TB2> INFO: safety margin for low PH: adding 35, margin is now 55
[19:55:04.536] <TB2> INFO: safety margin for low PH: adding 36, margin is now 56
[19:55:04.549] <TB2> INFO: safety margin for low PH: adding 37, margin is now 57
[19:55:04.562] <TB2> INFO: safety margin for low PH: adding 38, margin is now 58
[19:55:04.574] <TB2> INFO: safety margin for low PH: adding 39, margin is now 59
[19:55:04.587] <TB2> INFO: safety margin for low PH: adding 40, margin is now 60
[19:55:04.599] <TB2> INFO: safety margin for low PH: adding 41, margin is now 61
[19:55:04.612] <TB2> INFO: safety margin for low PH: adding 42, margin is now 62
[19:55:04.624] <TB2> INFO: safety margin for low PH: adding 43, margin is now 63
[19:55:04.636] <TB2> INFO: safety margin for low PH: adding 44, margin is now 64
[19:55:04.649] <TB2> INFO: safety margin for low PH: adding 45, margin is now 65
[19:55:04.661] <TB2> INFO: safety margin for low PH: adding 46, margin is now 66
[19:55:04.674] <TB2> INFO: safety margin for low PH: adding 47, margin is now 67
[19:55:04.686] <TB2> INFO: safety margin for low PH: adding 48, margin is now 68
[19:55:04.698] <TB2> INFO: safety margin for low PH: adding 49, margin is now 69
[19:55:04.714] <TB2> INFO: safety margin for low PH: adding 50, margin is now 70
[19:55:04.726] <TB2> INFO: safety margin for low PH: adding 51, margin is now 71
[19:55:04.739] <TB2> INFO: safety margin for low PH: adding 52, margin is now 72
[19:55:04.751] <TB2> INFO: safety margin for low PH: adding 53, margin is now 73
[19:55:04.763] <TB2> INFO: safety margin for low PH: adding 54, margin is now 74
[19:55:04.776] <TB2> INFO: safety margin for low PH: adding 55, margin is now 75
[19:55:04.788] <TB2> INFO: safety margin for low PH: adding 56, margin is now 76
[19:55:04.800] <TB2> INFO: safety margin for low PH: adding 57, margin is now 77
[19:55:04.813] <TB2> INFO: safety margin for low PH: adding 58, margin is now 78
[19:55:04.825] <TB2> INFO: safety margin for low PH: adding 59, margin is now 79
[19:55:04.838] <TB2> INFO: safety margin for low PH: adding 60, margin is now 80
[19:55:04.852] <TB2> INFO: safety margin for low PH: adding 61, margin is now 81
[19:55:04.865] <TB2> INFO: safety margin for low PH: adding 62, margin is now 82
[19:55:04.880] <TB2> INFO: safety margin for low PH: adding 63, margin is now 83
[19:55:04.894] <TB2> INFO: safety margin for low PH: adding 64, margin is now 84
[19:55:04.909] <TB2> INFO: safety margin for low PH: adding 65, margin is now 85
[19:55:04.923] <TB2> INFO: safety margin for low PH: adding 66, margin is now 86
[19:55:04.936] <TB2> INFO: safety margin for low PH: adding 67, margin is now 87
[19:55:04.950] <TB2> INFO: safety margin for low PH: adding 68, margin is now 88
[19:55:04.964] <TB2> INFO: safety margin for low PH: adding 69, margin is now 89
[19:55:04.979] <TB2> INFO: safety margin for low PH: adding 70, margin is now 90
[19:55:04.994] <TB2> INFO: safety margin for low PH: adding 71, margin is now 91
[19:55:05.008] <TB2> INFO: safety margin for low PH: adding 72, margin is now 92
[19:55:05.022] <TB2> INFO: safety margin for low PH: adding 73, margin is now 93
[19:55:05.036] <TB2> INFO: safety margin for low PH: adding 74, margin is now 94
[19:55:05.050] <TB2> INFO: safety margin for low PH: adding 75, margin is now 95
[19:55:05.064] <TB2> INFO: safety margin for low PH: adding 76, margin is now 96
[19:55:05.079] <TB2> INFO: safety margin for low PH: adding 77, margin is now 97
[19:55:05.097] <TB2> INFO: safety margin for low PH: adding 78, margin is now 98
[19:55:05.111] <TB2> INFO: safety margin for low PH: adding 79, margin is now 99
[19:55:05.129] <TB2> INFO: safety margin for low PH: adding 80, margin is now 100
[19:55:05.147] <TB2> INFO: safety margin for low PH: adding 81, margin is now 101
[19:55:05.165] <TB2> INFO: safety margin for low PH: adding 82, margin is now 102
[19:55:05.184] <TB2> INFO: safety margin for low PH: adding 83, margin is now 103
[19:55:05.199] <TB2> INFO: safety margin for low PH: adding 84, margin is now 104
[19:55:05.215] <TB2> INFO: safety margin for low PH: adding 85, margin is now 105
[19:55:05.234] <TB2> INFO: safety margin for low PH: adding 86, margin is now 106
[19:55:05.252] <TB2> INFO: safety margin for low PH: adding 87, margin is now 107
[19:55:05.270] <TB2> INFO: safety margin for low PH: adding 88, margin is now 108
[19:55:05.287] <TB2> INFO: safety margin for low PH: adding 89, margin is now 109
[19:55:05.304] <TB2> INFO: safety margin for low PH: adding 90, margin is now 110
[19:55:05.321] <TB2> INFO: safety margin for low PH: adding 91, margin is now 111
[19:55:05.338] <TB2> INFO: safety margin for low PH: adding 92, margin is now 112
[19:55:05.354] <TB2> INFO: safety margin for low PH: adding 93, margin is now 113
[19:55:05.371] <TB2> INFO: safety margin for low PH: adding 94, margin is now 114
[19:55:05.387] <TB2> INFO: safety margin for low PH: adding 95, margin is now 115
[19:55:05.403] <TB2> INFO: safety margin for low PH: adding 96, margin is now 116
[19:55:05.420] <TB2> INFO: safety margin for low PH: adding 97, margin is now 117
[19:55:05.437] <TB2> INFO: safety margin for low PH: adding 98, margin is now 118
[19:55:05.457] <TB2> INFO: safety margin for low PH: adding 99, margin is now 119
[19:55:05.476] <TB2> INFO: safety margin for low PH: adding 100, margin is now 120
[19:55:05.496] <TB2> INFO: safety margin for low PH: adding 101, margin is now 121
[19:55:05.517] <TB2> INFO: safety margin for low PH: adding 102, margin is now 122
[19:55:05.537] <TB2> INFO: safety margin for low PH: adding 103, margin is now 123
[19:55:05.557] <TB2> INFO: safety margin for low PH: adding 104, margin is now 124
[19:55:05.576] <TB2> INFO: safety margin for low PH: adding 105, margin is now 125
[19:55:05.595] <TB2> INFO: safety margin for low PH: adding 106, margin is now 126
[19:55:05.613] <TB2> INFO: safety margin for low PH: adding 107, margin is now 127
[19:55:05.634] <TB2> INFO: safety margin for low PH: adding 108, margin is now 128
[19:55:05.652] <TB2> INFO: safety margin for low PH: adding 109, margin is now 129
[19:55:05.669] <TB2> INFO: safety margin for low PH: adding 110, margin is now 130
[19:55:05.686] <TB2> INFO: safety margin for low PH: adding 111, margin is now 131
[19:55:05.702] <TB2> INFO: safety margin for low PH: adding 112, margin is now 132
[19:55:05.719] <TB2> INFO: safety margin for low PH: adding 113, margin is now 133
[19:55:05.736] <TB2> INFO: safety margin for low PH: adding 114, margin is now 134
[19:55:05.752] <TB2> INFO: safety margin for low PH: adding 115, margin is now 135
[19:55:05.769] <TB2> INFO: safety margin for low PH: adding 116, margin is now 136
[19:55:05.785] <TB2> INFO: safety margin for low PH: adding 117, margin is now 137
[19:55:05.801] <TB2> INFO: safety margin for low PH: adding 118, margin is now 138
[19:55:05.815] <TB2> INFO: safety margin for low PH: adding 119, margin is now 139
[19:55:05.829] <TB2> INFO: safety margin for low PH: adding 120, margin is now 140
[19:55:05.840] <TB2> INFO: safety margin for low PH: adding 121, margin is now 141
[19:55:05.850] <TB2> INFO: safety margin for low PH: adding 122, margin is now 142
[19:55:05.862] <TB2> INFO: safety margin for low PH: adding 123, margin is now 143
[19:55:05.875] <TB2> INFO: safety margin for low PH: adding 124, margin is now 144
[19:55:05.886] <TB2> INFO: safety margin for low PH: adding 125, margin is now 145
[19:55:05.898] <TB2> INFO: safety margin for low PH: adding 126, margin is now 146
[19:55:05.909] <TB2> INFO: safety margin for low PH: adding 127, margin is now 147
[19:55:05.921] <TB2> INFO: safety margin for low PH: adding 128, margin is now 148
[19:55:05.932] <TB2> INFO: safety margin for low PH: adding 129, margin is now 149
[19:55:05.944] <TB2> INFO: safety margin for low PH: adding 130, margin is now 150
[19:55:05.955] <TB2> INFO: safety margin for low PH: adding 131, margin is now 151
[19:55:05.967] <TB2> INFO: safety margin for low PH: adding 132, margin is now 152
[19:55:05.978] <TB2> INFO: safety margin for low PH: adding 133, margin is now 153
[19:55:05.990] <TB2> INFO: safety margin for low PH: adding 134, margin is now 154
[19:55:05.002] <TB2> INFO: safety margin for low PH: adding 135, margin is now 155
[19:55:06.013] <TB2> INFO: safety margin for low PH: adding 136, margin is now 156
[19:55:06.025] <TB2> INFO: safety margin for low PH: adding 137, margin is now 157
[19:55:06.038] <TB2> INFO: safety margin for low PH: adding 138, margin is now 158
[19:55:06.050] <TB2> INFO: safety margin for low PH: adding 139, margin is now 159
[19:55:06.064] <TB2> INFO: safety margin for low PH: adding 140, margin is now 160
[19:55:06.077] <TB2> INFO: safety margin for low PH: adding 141, margin is now 161
[19:55:06.107] <TB2> INFO: safety margin for low PH: adding 142, margin is now 162
[19:55:06.133] <TB2> INFO: safety margin for low PH: adding 143, margin is now 163
[19:55:06.156] <TB2> INFO: safety margin for low PH: adding 144, margin is now 164
[19:55:06.180] <TB2> INFO: safety margin for low PH: adding 145, margin is now 165
[19:55:06.203] <TB2> INFO: safety margin for low PH: adding 146, margin is now 166
[19:55:06.223] <TB2> INFO: safety margin for low PH: adding 147, margin is now 167
[19:55:06.235] <TB2> INFO: safety margin for low PH: adding 148, margin is now 168
[19:55:06.248] <TB2> INFO: safety margin for low PH: adding 149, margin is now 169
[19:55:06.261] <TB2> INFO: safety margin for low PH: adding 150, margin is now 170
[19:55:06.273] <TB2> INFO: safety margin for low PH: adding 151, margin is now 171
[19:55:06.286] <TB2> INFO: safety margin for low PH: adding 152, margin is now 172
[19:55:06.299] <TB2> INFO: safety margin for low PH: adding 153, margin is now 173
[19:55:06.311] <TB2> INFO: safety margin for low PH: adding 154, margin is now 174
[19:55:06.324] <TB2> INFO: safety margin for low PH: adding 155, margin is now 175
[19:55:06.337] <TB2> INFO: safety margin for low PH: adding 156, margin is now 176
[19:55:06.350] <TB2> INFO: safety margin for low PH: adding 157, margin is now 177
[19:55:06.363] <TB2> INFO: safety margin for low PH: adding 158, margin is now 178
[19:55:06.376] <TB2> INFO: safety margin for low PH: adding 159, margin is now 179
[19:55:06.388] <TB2> INFO: safety margin for low PH: adding 160, margin is now 180
[19:55:06.401] <TB2> INFO: safety margin for low PH: adding 161, margin is now 181
[19:55:06.414] <TB2> INFO: safety margin for low PH: adding 162, margin is now 182
[19:55:06.427] <TB2> INFO: safety margin for low PH: adding 163, margin is now 183
[19:55:06.440] <TB2> INFO: safety margin for low PH: adding 164, margin is now 184
[19:55:06.452] <TB2> INFO: safety margin for low PH: adding 165, margin is now 185
[19:55:06.465] <TB2> INFO: safety margin for low PH: adding 166, margin is now 186
[19:55:06.478] <TB2> INFO: safety margin for low PH: adding 167, margin is now 187
[19:55:06.491] <TB2> INFO: safety margin for low PH: adding 168, margin is now 188
[19:55:06.504] <TB2> INFO: safety margin for low PH: adding 169, margin is now 189
[19:55:06.517] <TB2> INFO: safety margin for low PH: adding 170, margin is now 190
[19:55:06.530] <TB2> INFO: safety margin for low PH: adding 171, margin is now 191
[19:55:06.559] <TB2> INFO: safety margin for low PH: adding 172, margin is now 192
[19:55:06.583] <TB2> INFO: safety margin for low PH: adding 173, margin is now 193
[19:55:06.606] <TB2> INFO: safety margin for low PH: adding 174, margin is now 194
[19:55:06.629] <TB2> INFO: safety margin for low PH: adding 175, margin is now 195
[19:55:06.653] <TB2> INFO: safety margin for low PH: adding 176, margin is now 196
[19:55:06.675] <TB2> INFO: safety margin for low PH: adding 177, margin is now 197
[19:55:06.688] <TB2> INFO: safety margin for low PH: adding 178, margin is now 198
[19:55:06.701] <TB2> INFO: safety margin for low PH: adding 179, margin is now 199
[19:55:06.713] <TB2> INFO: safety margin for low PH: adding 180, margin is now 200
[19:55:06.726] <TB2> INFO: safety margin for low PH: adding 181, margin is now 201
[19:55:06.739] <TB2> INFO: safety margin for low PH: adding 182, margin is now 202
[19:55:06.752] <TB2> INFO: safety margin for low PH: adding 183, margin is now 203
[19:55:06.766] <TB2> INFO: safety margin for low PH: adding 184, margin is now 204
[19:55:06.779] <TB2> INFO: safety margin for low PH: adding 185, margin is now 205
[19:55:06.793] <TB2> INFO: safety margin for low PH: adding 186, margin is now 206
[19:55:06.806] <TB2> INFO: safety margin for low PH: adding 187, margin is now 207
[19:55:06.819] <TB2> INFO: safety margin for low PH: adding 188, margin is now 208
[19:55:06.833] <TB2> INFO: safety margin for low PH: adding 189, margin is now 209
[19:55:06.847] <TB2> INFO: safety margin for low PH: adding 190, margin is now 210
[19:55:06.860] <TB2> INFO: safety margin for low PH: adding 191, margin is now 211
[19:55:06.874] <TB2> INFO: safety margin for low PH: adding 192, margin is now 212
[19:55:06.887] <TB2> INFO: safety margin for low PH: adding 193, margin is now 213
[19:55:06.900] <TB2> INFO: safety margin for low PH: adding 194, margin is now 214
[19:55:06.914] <TB2> INFO: safety margin for low PH: adding 195, margin is now 215
[19:55:06.927] <TB2> INFO: safety margin for low PH: adding 196, margin is now 216
[19:55:06.968] <TB2> INFO: safety margin for low PH: adding 197, margin is now 217
[19:55:07.004] <TB2> INFO: safety margin for low PH: adding 198, margin is now 218
[19:55:07.026] <TB2> INFO: safety margin for low PH: adding 199, margin is now 219
[19:55:07.041] <TB2> INFO: safety margin for low PH: adding 200, margin is now 220
[19:55:07.054] <TB2> INFO: safety margin for low PH: adding 201, margin is now 221
[19:55:07.079] <TB2> INFO: safety margin for low PH: adding 202, margin is now 222
[19:55:07.092] <TB2> INFO: safety margin for low PH: adding 203, margin is now 223
[19:55:07.105] <TB2> INFO: safety margin for low PH: adding 204, margin is now 224
[19:55:07.117] <TB2> INFO: safety margin for low PH: adding 205, margin is now 225
[19:55:07.130] <TB2> INFO: safety margin for low PH: adding 206, margin is now 226
[19:55:07.143] <TB2> INFO: safety margin for low PH: adding 207, margin is now 227
[19:55:07.155] <TB2> INFO: safety margin for low PH: adding 208, margin is now 228
[19:55:07.167] <TB2> INFO: safety margin for low PH: adding 209, margin is now 229
[19:55:07.180] <TB2> INFO: safety margin for low PH: adding 210, margin is now 230
[19:55:07.193] <TB2> INFO: safety margin for low PH: adding 211, margin is now 231
[19:55:07.206] <TB2> INFO: safety margin for low PH: adding 212, margin is now 232
[19:55:07.224] <TB2> INFO: safety margin for low PH: adding 213, margin is now 233
[19:55:07.249] <TB2> INFO: safety margin for low PH: adding 214, margin is now 234
[19:55:07.267] <TB2> INFO: safety margin for low PH: adding 215, margin is now 235
[19:55:07.280] <TB2> INFO: safety margin for low PH: adding 216, margin is now 236
[19:55:07.294] <TB2> INFO: safety margin for low PH: adding 217, margin is now 237
[19:55:07.328] <TB2> INFO: safety margin for low PH: adding 218, margin is now 238
[19:55:07.351] <TB2> INFO: safety margin for low PH: adding 219, margin is now 239
[19:55:07.375] <TB2> INFO: safety margin for low PH: adding 220, margin is now 240
[19:55:07.399] <TB2> INFO: safety margin for low PH: adding 221, margin is now 241
[19:55:07.424] <TB2> INFO: safety margin for low PH: adding 222, margin is now 242
[19:55:07.450] <TB2> INFO: safety margin for low PH: adding 223, margin is now 243
[19:55:07.475] <TB2> INFO: safety margin for low PH: adding 224, margin is now 244
[19:55:07.498] <TB2> INFO: safety margin for low PH: adding 225, margin is now 245
[19:55:07.521] <TB2> INFO: safety margin for low PH: adding 226, margin is now 246
[19:55:07.533] <TB2> INFO: safety margin for low PH: adding 227, margin is now 247
[19:55:07.546] <TB2> INFO: safety margin for low PH: adding 228, margin is now 248
[19:55:07.557] <TB2> INFO: safety margin for low PH: adding 229, margin is now 249
[19:55:07.569] <TB2> INFO: safety margin for low PH: adding 230, margin is now 250
[19:55:07.581] <TB2> INFO: safety margin for low PH: adding 231, margin is now 251
[19:55:07.594] <TB2> INFO: safety margin for low PH: adding 232, margin is now 252
[19:55:07.608] <TB2> INFO: safety margin for low PH: adding 233, margin is now 253
[19:55:07.621] <TB2> INFO: safety margin for low PH: adding 234, margin is now 254
[19:55:07.635] <TB2> INFO: safety margin for low PH: adding 235, margin is now 255
[19:55:07.649] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:07.663] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:07.687] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:07.715] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:55:07.744] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[19:55:07.791] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:07.827] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:07.856] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:55:07.880] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[19:55:07.904] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[19:55:07.929] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[19:55:07.955] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[19:55:07.980] <TB2> INFO: safety margin for low PH: adding 7, margin is now 27
[19:55:08.004] <TB2> INFO: safety margin for low PH: adding 8, margin is now 28
[19:55:08.028] <TB2> INFO: safety margin for low PH: adding 9, margin is now 29
[19:55:08.053] <TB2> INFO: safety margin for low PH: adding 10, margin is now 30
[19:55:08.076] <TB2> INFO: safety margin for low PH: adding 11, margin is now 31
[19:55:08.100] <TB2> INFO: safety margin for low PH: adding 12, margin is now 32
[19:55:08.124] <TB2> INFO: safety margin for low PH: adding 13, margin is now 33
[19:55:08.143] <TB2> INFO: safety margin for low PH: adding 14, margin is now 34
[19:55:08.155] <TB2> INFO: safety margin for low PH: adding 15, margin is now 35
[19:55:08.167] <TB2> INFO: safety margin for low PH: adding 16, margin is now 36
[19:55:08.179] <TB2> INFO: safety margin for low PH: adding 17, margin is now 37
[19:55:08.192] <TB2> INFO: safety margin for low PH: adding 18, margin is now 38
[19:55:08.205] <TB2> INFO: safety margin for low PH: adding 19, margin is now 39
[19:55:08.216] <TB2> INFO: safety margin for low PH: adding 20, margin is now 40
[19:55:08.228] <TB2> INFO: safety margin for low PH: adding 21, margin is now 41
[19:55:08.240] <TB2> INFO: safety margin for low PH: adding 22, margin is now 42
[19:55:08.252] <TB2> INFO: safety margin for low PH: adding 23, margin is now 43
[19:55:08.263] <TB2> INFO: safety margin for low PH: adding 24, margin is now 44
[19:55:08.275] <TB2> INFO: safety margin for low PH: adding 25, margin is now 45
[19:55:08.287] <TB2> INFO: safety margin for low PH: adding 26, margin is now 46
[19:55:08.299] <TB2> INFO: safety margin for low PH: adding 27, margin is now 47
[19:55:08.311] <TB2> INFO: safety margin for low PH: adding 28, margin is now 48
[19:55:08.323] <TB2> INFO: safety margin for low PH: adding 29, margin is now 49
[19:55:08.334] <TB2> INFO: safety margin for low PH: adding 30, margin is now 50
[19:55:08.346] <TB2> INFO: safety margin for low PH: adding 31, margin is now 51
[19:55:08.358] <TB2> INFO: safety margin for low PH: adding 32, margin is now 52
[19:55:08.369] <TB2> INFO: safety margin for low PH: adding 33, margin is now 53
[19:55:08.390] <TB2> INFO: safety margin for low PH: adding 34, margin is now 54
[19:55:08.402] <TB2> INFO: safety margin for low PH: adding 35, margin is now 55
[19:55:08.413] <TB2> INFO: safety margin for low PH: adding 36, margin is now 56
[19:55:08.424] <TB2> INFO: safety margin for low PH: adding 37, margin is now 57
[19:55:08.435] <TB2> INFO: safety margin for low PH: adding 38, margin is now 58
[19:55:08.447] <TB2> INFO: safety margin for low PH: adding 39, margin is now 59
[19:55:08.458] <TB2> INFO: safety margin for low PH: adding 40, margin is now 60
[19:55:08.469] <TB2> INFO: safety margin for low PH: adding 41, margin is now 61
[19:55:08.480] <TB2> INFO: safety margin for low PH: adding 42, margin is now 62
[19:55:08.492] <TB2> INFO: safety margin for low PH: adding 43, margin is now 63
[19:55:08.503] <TB2> INFO: safety margin for low PH: adding 44, margin is now 64
[19:55:08.514] <TB2> INFO: safety margin for low PH: adding 45, margin is now 65
[19:55:08.527] <TB2> INFO: safety margin for low PH: adding 46, margin is now 66
[19:55:08.539] <TB2> INFO: safety margin for low PH: adding 47, margin is now 67
[19:55:08.551] <TB2> INFO: safety margin for low PH: adding 48, margin is now 68
[19:55:08.563] <TB2> INFO: safety margin for low PH: adding 49, margin is now 69
[19:55:08.576] <TB2> INFO: safety margin for low PH: adding 50, margin is now 70
[19:55:08.588] <TB2> INFO: safety margin for low PH: adding 51, margin is now 71
[19:55:08.600] <TB2> INFO: safety margin for low PH: adding 52, margin is now 72
[19:55:08.612] <TB2> INFO: safety margin for low PH: adding 53, margin is now 73
[19:55:08.625] <TB2> INFO: safety margin for low PH: adding 54, margin is now 74
[19:55:08.637] <TB2> INFO: safety margin for low PH: adding 55, margin is now 75
[19:55:08.649] <TB2> INFO: safety margin for low PH: adding 56, margin is now 76
[19:55:08.662] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:08.674] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:08.687] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:55:08.699] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[19:55:08.712] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[19:55:08.724] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[19:55:08.737] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[19:55:08.749] <TB2> INFO: safety margin for low PH: adding 7, margin is now 27
[19:55:08.762] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:08.774] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:08.786] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:08.799] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:08.811] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:08.824] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:55:08.836] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[19:55:08.848] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:08.861] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:08.873] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:08.885] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:55:08.898] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:08.910] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:08.923] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:08.935] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:08.947] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:55:08.964] <TB2> INFO: safety margin for low PH: adding 3, margin is now 23
[19:55:08.976] <TB2> INFO: safety margin for low PH: adding 4, margin is now 24
[19:55:08.989] <TB2> INFO: safety margin for low PH: adding 5, margin is now 25
[19:55:08.002] <TB2> INFO: safety margin for low PH: adding 6, margin is now 26
[19:55:09.015] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:09.028] <TB2> INFO: safety margin for low PH: adding 1, margin is now 21
[19:55:09.041] <TB2> INFO: safety margin for low PH: adding 2, margin is now 22
[19:55:09.054] <TB2> INFO: safety margin for low PH: adding 0, margin is now 20
[19:55:09.315] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C0.dat
[19:55:09.315] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C1.dat
[19:55:09.315] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C2.dat
[19:55:09.315] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C3.dat
[19:55:09.315] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C4.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C5.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C6.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C7.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C8.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C9.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C10.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C11.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C12.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C13.dat
[19:55:09.316] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C14.dat
[19:55:09.317] <TB2> INFO: write dac parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//dacParameters35_C15.dat
[19:55:10.035] <TB2> INFO: Expecting 41600 events.
[19:55:13.874] <TB2> INFO: 41600 events read in total (3247ms).
[19:55:13.875] <TB2> INFO: Test took 4304ms.
[19:55:14.418] <TB2> INFO: Expecting 41600 events.
[19:55:17.678] <TB2> INFO: 41600 events read in total (2668ms).
[19:55:17.703] <TB2> INFO: Test took 3617ms.
[19:55:18.492] <TB2> INFO: Expecting 41600 events.
[19:55:24.255] <TB2> INFO: 41600 events read in total (5169ms).
[19:55:24.264] <TB2> INFO: Test took 6327ms.
[19:55:24.627] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:24.716] <TB2> INFO: Expecting 2560 events.
[19:55:25.624] <TB2> INFO: 2560 events read in total (307ms).
[19:55:25.625] <TB2> INFO: Test took 998ms.
[19:55:25.634] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:25.938] <TB2> INFO: Expecting 2560 events.
[19:55:26.851] <TB2> INFO: 2560 events read in total (318ms).
[19:55:26.852] <TB2> INFO: Test took 1218ms.
[19:55:26.853] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:27.171] <TB2> INFO: Expecting 2560 events.
[19:55:28.064] <TB2> INFO: 2560 events read in total (299ms).
[19:55:28.064] <TB2> INFO: Test took 1211ms.
[19:55:28.066] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:28.373] <TB2> INFO: Expecting 2560 events.
[19:55:29.276] <TB2> INFO: 2560 events read in total (312ms).
[19:55:29.277] <TB2> INFO: Test took 1211ms.



[19:55:29.590] <TB2> INFO: Test took 311ms.
[19:55:29.592] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:30.091] <TB2> INFO: Expecting 2560 events.
[19:55:30.989] <TB2> INFO: 2560 events read in total (299ms).
[19:55:30.990] <TB2> INFO: Test took 1398ms.
[19:55:30.992] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:31.297] <TB2> INFO: Expecting 2560 events.
[19:55:32.189] <TB2> INFO: 2560 events read in total (300ms).
[19:55:32.189] <TB2> INFO: Test took 1197ms.
[19:55:32.191] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:32.497] <TB2> INFO: Expecting 2560 events.
[19:55:33.429] <TB2> INFO: 2560 events read in total (314ms).
[19:55:33.431] <TB2> INFO: Test took 1240ms.
[19:55:33.499] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:33.740] <TB2> INFO: Expecting 2560 events.
[19:55:34.628] <TB2> INFO: 2560 events read in total (297ms).
[19:55:34.629] <TB2> INFO: Test took 1130ms.
[19:55:34.630] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:34.937] <TB2> INFO: Expecting 2560 events.
[19:55:35.864] <TB2> INFO: 2560 events read in total (295ms).
[19:55:35.865] <TB2> INFO: Test took 1235ms.
[19:55:35.867] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:36.173] <TB2> INFO: Expecting 2560 events.
[19:55:39.093] <TB2> INFO: 2560 events read in total (2294ms).
[19:55:39.103] <TB2> INFO: Test took 3236ms.
[19:55:39.116] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:39.393] <TB2> INFO: Expecting 2560 events.
[19:55:40.290] <TB2> INFO: 2560 events read in total (299ms).
[19:55:40.292] <TB2> INFO: Test took 1176ms.
[19:55:40.299] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:40.598] <TB2> INFO: Expecting 2560 events.
[19:55:41.484] <TB2> INFO: 2560 events read in total (294ms).
[19:55:41.484] <TB2> INFO: Test took 1185ms.
[19:55:41.488] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:41.791] <TB2> INFO: Expecting 2560 events.
[19:55:42.672] <TB2> INFO: 2560 events read in total (289ms).
[19:55:42.672] <TB2> INFO: Test took 1184ms.
[19:55:42.677] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:42.980] <TB2> INFO: Expecting 2560 events.
[19:55:43.864] <TB2> INFO: 2560 events read in total (293ms).
[19:55:43.865] <TB2> INFO: Test took 1188ms.
[19:55:43.867] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:44.173] <TB2> INFO: Expecting 2560 events.
[19:55:45.052] <TB2> INFO: 2560 events read in total (288ms).
[19:55:45.053] <TB2> INFO: Test took 1186ms.
[19:55:45.055] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:45.360] <TB2> INFO: Expecting 2560 events.
[19:55:46.244] <TB2> INFO: 2560 events read in total (292ms).
[19:55:46.245] <TB2> INFO: Test took 1190ms.
[19:55:46.248] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:46.553] <TB2> INFO: Expecting 2560 events.
[19:55:47.441] <TB2> INFO: 2560 events read in total (297ms).
[19:55:47.441] <TB2> INFO: Test took 1193ms.
[19:55:47.443] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:47.749] <TB2> INFO: Expecting 2560 events.
[19:55:48.638] <TB2> INFO: 2560 events read in total (297ms).
[19:55:48.638] <TB2> INFO: Test took 1195ms.
[19:55:48.641] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:48.947] <TB2> INFO: Expecting 2560 events.
[19:55:49.833] <TB2> INFO: 2560 events read in total (295ms).
[19:55:49.833] <TB2> INFO: Test took 1192ms.
[19:55:49.836] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:50.141] <TB2> INFO: Expecting 2560 events.
[19:55:51.022] <TB2> INFO: 2560 events read in total (289ms).
[19:55:51.022] <TB2> INFO: Test took 1187ms.
[19:55:51.024] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:51.330] <TB2> INFO: Expecting 2560 events.
[19:55:52.215] <TB2> INFO: 2560 events read in total (294ms).
[19:55:52.215] <TB2> INFO: Test took 1191ms.
[19:55:52.217] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:52.523] <TB2> INFO: Expecting 2560 events.
[19:55:53.404] <TB2> INFO: 2560 events read in total (289ms).
[19:55:53.404] <TB2> INFO: Test took 1187ms.
[19:55:53.407] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:53.712] <TB2> INFO: Expecting 2560 events.
[19:55:54.595] <TB2> INFO: 2560 events read in total (291ms).
[19:55:54.595] <TB2> INFO: Test took 1188ms.
[19:55:54.598] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:54.904] <TB2> INFO: Expecting 2560 events.
[19:55:55.788] <TB2> INFO: 2560 events read in total (292ms).
[19:55:55.789] <TB2> INFO: Test took 1191ms.
[19:55:55.794] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:56.097] <TB2> INFO: Expecting 2560 events.
[19:55:56.986] <TB2> INFO: 2560 events read in total (297ms).
[19:55:56.986] <TB2> INFO: Test took 1192ms.
[19:55:56.990] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:57.294] <TB2> INFO: Expecting 2560 events.
[19:55:58.179] <TB2> INFO: 2560 events read in total (293ms).
[19:55:58.179] <TB2> INFO: Test took 1189ms.
[19:55:58.181] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:58.488] <TB2> INFO: Expecting 2560 events.
[19:55:59.381] <TB2> INFO: 2560 events read in total (301ms).
[19:55:59.381] <TB2> INFO: Test took 1200ms.
[19:55:59.383] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:55:59.689] <TB2> INFO: Expecting 2560 events.
[19:56:00.578] <TB2> INFO: 2560 events read in total (298ms).
[19:56:00.578] <TB2> INFO: Test took 1195ms.
[19:56:00.582] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:56:00.886] <TB2> INFO: Expecting 2560 events.
[19:56:01.771] <TB2> INFO: 2560 events read in total (293ms).
[19:56:01.771] <TB2> INFO: Test took 1189ms.
[19:56:01.774] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:56:02.079] <TB2> INFO: Expecting 2560 events.
[19:56:02.963] <TB2> INFO: 2560 events read in total (292ms).
[19:56:02.963] <TB2> INFO: Test took 1191ms.
[19:56:02.966] <TB2> INFO: Not all ROCs have their pixels configured the same way. Running in FLAG_FORCE_SERIAL mode.
[19:56:03.271] <TB2> INFO: Expecting 2560 events.
[19:56:04.156] <TB2> INFO: 2560 events read in total (293ms).
[19:56:04.156] <TB2> INFO: Test took 1191ms.
[19:56:04.629] <TB2> INFO: PixTestPhOptimization::doTest() done, duration: 1343 seconds
[19:56:04.629] <TB2> INFO: PH scale (per ROC): 35 32 0 38 37 20 31 35 52 22 33 59 48 35 53 42
[19:56:04.629] <TB2> INFO: PH offset (per ROC): 102 147 0 90 85 114 108 118 125 128 118 131 132 109 129 96
[19:56:04.640] <TB2> INFO: Decoding statistics:
[19:56:04.640] <TB2> INFO: General information:
[19:56:04.640] <TB2> INFO: 16bit words read: 127886
[19:56:04.640] <TB2> INFO: valid events total: 20480
[19:56:04.640] <TB2> INFO: empty events: 17977
[19:56:04.640] <TB2> INFO: valid events with pixels: 2503
[19:56:04.640] <TB2> INFO: valid pixel hits: 2503
[19:56:04.640] <TB2> INFO: Event errors: 0
[19:56:04.640] <TB2> INFO: start marker: 0
[19:56:04.640] <TB2> INFO: stop marker: 0
[19:56:04.640] <TB2> INFO: overflow: 0
[19:56:04.640] <TB2> INFO: invalid 5bit words: 0
[19:56:04.640] <TB2> INFO: invalid XOR eye diagram: 0
[19:56:04.640] <TB2> INFO: frame (failed synchr.): 0
[19:56:04.640] <TB2> INFO: idle data (no TBM trl): 0
[19:56:04.640] <TB2> INFO: no data (only TBM hdr): 0
[19:56:04.640] <TB2> INFO: TBM errors: 0
[19:56:04.640] <TB2> INFO: flawed TBM headers: 0
[19:56:04.640] <TB2> INFO: flawed TBM trailers: 0
[19:56:04.640] <TB2> INFO: event ID mismatches: 0
[19:56:04.640] <TB2> INFO: ROC errors: 0
[19:56:04.640] <TB2> INFO: missing ROC header(s): 0
[19:56:04.640] <TB2> INFO: misplaced readback start: 0
[19:56:04.640] <TB2> INFO: Pixel decoding errors: 0
[19:56:04.640] <TB2> INFO: pixel data incomplete: 0
[19:56:04.640] <TB2> INFO: pixel address: 0
[19:56:04.640] <TB2> INFO: pulse height fill bit: 0
[19:56:04.640] <TB2> INFO: buffer corruption: 0
[19:56:04.838] <TB2> INFO: ######################################################################
[19:56:04.838] <TB2> INFO: PixTestGainPedestal::fullTest() ntrig = 10
[19:56:04.838] <TB2> INFO: ######################################################################
[19:56:04.853] <TB2> INFO: scanning low vcal = 10
[19:56:05.140] <TB2> INFO: Expecting 41600 events.
[19:56:09.519] <TB2> INFO: 41600 events read in total (3735ms).
[19:56:09.520] <TB2> INFO: Test took 4666ms.
[19:56:09.521] <TB2> INFO: scanning low vcal = 20
[19:56:09.813] <TB2> INFO: Expecting 41600 events.
[19:56:14.603] <TB2> INFO: 41600 events read in total (4088ms).
[19:56:14.610] <TB2> INFO: Test took 5088ms.
[19:56:14.680] <TB2> INFO: scanning low vcal = 30
[19:56:15.091] <TB2> INFO: Expecting 41600 events.
[19:56:19.769] <TB2> INFO: 41600 events read in total (3978ms).
[19:56:19.773] <TB2> INFO: Test took 5083ms.
[19:56:19.784] <TB2> INFO: scanning low vcal = 40
[19:56:20.711] <TB2> INFO: Expecting 41600 events.
[19:56:33.745] <TB2> INFO: 41600 events read in total (12326ms).
[19:56:33.748] <TB2> INFO: Test took 13963ms.
[19:56:33.776] <TB2> INFO: scanning low vcal = 50
[19:56:34.207] <TB2> INFO: Expecting 41600 events.
[19:56:38.535] <TB2> INFO: 41600 events read in total (3676ms).
[19:56:38.536] <TB2> INFO: Test took 4759ms.
[19:56:38.541] <TB2> INFO: scanning low vcal = 60
[19:56:38.864] <TB2> INFO: Expecting 41600 events.
[19:56:43.754] <TB2> INFO: 41600 events read in total (4296ms).
[19:56:43.764] <TB2> INFO: Test took 5222ms.
[19:56:43.840] <TB2> INFO: scanning low vcal = 70
[19:56:44.170] <TB2> INFO: Expecting 41600 events.
[19:56:51.569] <TB2> INFO: 41600 events read in total (6738ms).
[19:56:51.571] <TB2> INFO: Test took 7731ms.
[19:56:51.588] <TB2> INFO: scanning low vcal = 80
[19:56:52.129] <TB2> INFO: Expecting 41600 events.
[19:56:56.864] <TB2> INFO: 41600 events read in total (4143ms).
[19:56:56.866] <TB2> INFO: Test took 5277ms.
[19:56:56.885] <TB2> INFO: scanning low vcal = 90
[19:56:57.488] <TB2> INFO: Expecting 41600 events.
[19:57:01.474] <TB2> INFO: 41600 events read in total (3394ms).
[19:57:01.476] <TB2> INFO: Test took 4590ms.
[19:57:01.480] <TB2> INFO: scanning low vcal = 100
[19:57:01.755] <TB2> INFO: Expecting 41600 events.
[19:57:05.769] <TB2> INFO: 41600 events read in total (3422ms).
[19:57:05.770] <TB2> INFO: Test took 4290ms.
[19:57:05.774] <TB2> INFO: scanning low vcal = 110
[19:57:06.050] <TB2> INFO: Expecting 41600 events.
[19:57:10.059] <TB2> INFO: 41600 events read in total (3417ms).
[19:57:10.060] <TB2> INFO: Test took 4286ms.
[19:57:10.063] <TB2> INFO: scanning low vcal = 120
[19:57:10.342] <TB2> INFO: Expecting 41600 events.
[19:57:14.342] <TB2> INFO: 41600 events read in total (3408ms).
[19:57:14.343] <TB2> INFO: Test took 4280ms.
[19:57:14.346] <TB2> INFO: scanning low vcal = 130
[19:57:14.623] <TB2> INFO: Expecting 41600 events.
[19:57:18.712] <TB2> INFO: 41600 events read in total (3496ms).
[19:57:18.713] <TB2> INFO: Test took 4367ms.
[19:57:18.716] <TB2> INFO: scanning low vcal = 140
[19:57:19.042] <TB2> INFO: Expecting 41600 events.
[19:57:23.096] <TB2> INFO: 41600 events read in total (3463ms).
[19:57:23.097] <TB2> INFO: Test took 4381ms.
[19:57:23.104] <TB2> INFO: scanning low vcal = 150
[19:57:23.377] <TB2> INFO: Expecting 41600 events.
[19:57:27.461] <TB2> INFO: 41600 events read in total (3493ms).
[19:57:27.463] <TB2> INFO: Test took 4359ms.
[19:57:27.468] <TB2> INFO: scanning low vcal = 160
[19:57:27.743] <TB2> INFO: Expecting 41600 events.
[19:57:31.799] <TB2> INFO: 41600 events read in total (3465ms).
[19:57:31.801] <TB2> INFO: Test took 4333ms.
[19:57:31.804] <TB2> INFO: scanning low vcal = 170
[19:57:32.080] <TB2> INFO: Expecting 41600 events.
[19:57:36.138] <TB2> INFO: 41600 events read in total (3466ms).
[19:57:36.139] <TB2> INFO: Test took 4335ms.
[19:57:36.145] <TB2> INFO: scanning low vcal = 180
[19:57:36.419] <TB2> INFO: Expecting 41600 events.
[19:57:40.422] <TB2> INFO: 41600 events read in total (3412ms).
[19:57:40.423] <TB2> INFO: Test took 4277ms.
[19:57:40.426] <TB2> INFO: scanning low vcal = 190
[19:57:40.702] <TB2> INFO: Expecting 41600 events.
[19:57:44.709] <TB2> INFO: 41600 events read in total (3415ms).
[19:57:44.710] <TB2> INFO: Test took 4284ms.
[19:57:44.713] <TB2> INFO: scanning low vcal = 200
[19:57:44.990] <TB2> INFO: Expecting 41600 events.
[19:57:49.035] <TB2> INFO: 41600 events read in total (3453ms).
[19:57:49.038] <TB2> INFO: Test took 4324ms.
[19:57:49.042] <TB2> INFO: scanning low vcal = 210
[19:57:49.319] <TB2> INFO: Expecting 41600 events.
[19:57:53.322] <TB2> INFO: 41600 events read in total (3412ms).
[19:57:53.324] <TB2> INFO: Test took 4282ms.
[19:57:53.327] <TB2> INFO: scanning low vcal = 220
[19:57:53.604] <TB2> INFO: Expecting 41600 events.
[19:57:57.557] <TB2> INFO: 41600 events read in total (3362ms).
[19:57:57.557] <TB2> INFO: Test took 4231ms.
[19:57:57.561] <TB2> INFO: scanning low vcal = 230
[19:57:57.838] <TB2> INFO: Expecting 41600 events.
[19:58:01.801] <TB2> INFO: 41600 events read in total (3371ms).
[19:58:01.802] <TB2> INFO: Test took 4241ms.
[19:58:01.805] <TB2> INFO: scanning low vcal = 240
[19:58:02.082] <TB2> INFO: Expecting 41600 events.
[19:58:06.039] <TB2> INFO: 41600 events read in total (3365ms).
[19:58:06.040] <TB2> INFO: Test took 4234ms.
[19:58:06.043] <TB2> INFO: scanning low vcal = 250
[19:58:06.320] <TB2> INFO: Expecting 41600 events.
[19:58:10.281] <TB2> INFO: 41600 events read in total (3369ms).
[19:58:10.282] <TB2> INFO: Test took 4239ms.
[19:58:10.286] <TB2> INFO: scanning high vcal = 30 (= 210 in low range)
[19:58:10.562] <TB2> INFO: Expecting 41600 events.
[19:58:14.534] <TB2> INFO: 41600 events read in total (3380ms).
[19:58:14.535] <TB2> INFO: Test took 4248ms.
[19:58:14.539] <TB2> INFO: scanning high vcal = 50 (= 350 in low range)
[19:58:14.815] <TB2> INFO: Expecting 41600 events.
[19:58:18.778] <TB2> INFO: 41600 events read in total (3371ms).
[19:58:18.780] <TB2> INFO: Test took 4241ms.
[19:58:18.783] <TB2> INFO: scanning high vcal = 70 (= 490 in low range)
[19:58:19.060] <TB2> INFO: Expecting 41600 events.
[19:58:23.022] <TB2> INFO: 41600 events read in total (3370ms).
[19:58:23.024] <TB2> INFO: Test took 4241ms.
[19:58:23.028] <TB2> INFO: scanning high vcal = 90 (= 630 in low range)
[19:58:23.304] <TB2> INFO: Expecting 41600 events.
[19:58:27.268] <TB2> INFO: 41600 events read in total (3372ms).
[19:58:27.269] <TB2> INFO: Test took 4241ms.
[19:58:27.273] <TB2> INFO: scanning high vcal = 200 (= 1400 in low range)
[19:58:27.550] <TB2> INFO: Expecting 41600 events.
[19:58:31.517] <TB2> INFO: 41600 events read in total (3375ms).
[19:58:31.518] <TB2> INFO: Test took 4245ms.
[19:58:31.910] <TB2> INFO: PixTestGainPedestal::measure() done
[19:59:04.042] <TB2> INFO: PixTestGainPedestal::fit() done
[19:59:04.042] <TB2> INFO: non-linearity mean: 0.930 0.961 0.000 1.014 0.922 1.004 0.933 0.946 0.977 0.913 0.951 0.980 0.974 0.928 0.978 0.938
[19:59:04.042] <TB2> INFO: non-linearity RMS: 0.157 0.010 0.000 0.154 0.074 0.223 0.154 0.052 0.003 0.138 0.034 0.003 0.003 0.075 0.003 0.059
[19:59:04.042] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C0.dat
[19:59:04.056] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C1.dat
[19:59:04.069] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C2.dat
[19:59:04.079] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C3.dat
[19:59:04.093] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C4.dat
[19:59:04.107] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C5.dat
[19:59:04.121] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C6.dat
[19:59:04.134] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C7.dat
[19:59:04.148] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C8.dat
[19:59:04.162] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C9.dat
[19:59:04.175] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C10.dat
[19:59:04.189] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C11.dat
[19:59:04.203] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C12.dat
[19:59:04.216] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C13.dat
[19:59:04.230] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C14.dat
[19:59:04.244] <TB2> INFO: write gain/ped parameters into /home/l_tester/david/FullQualification/data/M1049_FullQualification_2016-11-04_17h17m_1478276226//001_Fulltest_m20//phCalibrationFitErr35_C15.dat
[19:59:04.258] <TB2> INFO: PixTestGainPedestal::fullTest() done, duration: 179 seconds
[19:59:04.258] <TB2> INFO: Decoding statistics:
[19:59:04.258] <TB2> INFO: General information:
[19:59:04.258] <TB2> INFO: 16bit words read: 3328966
[19:59:04.258] <TB2> INFO: valid events total: 332800
[19:59:04.258] <TB2> INFO: empty events: 0
[19:59:04.258] <TB2> INFO: valid events with pixels: 332800
[19:59:04.258] <TB2> INFO: valid pixel hits: 666082
[19:59:04.258] <TB2> INFO: Event errors: 0
[19:59:04.258] <TB2> INFO: start marker: 0
[19:59:04.258] <TB2> INFO: stop marker: 0
[19:59:04.258] <TB2> INFO: overflow: 0
[19:59:04.258] <TB2> INFO: invalid 5bit words: 0
[19:59:04.258] <TB2> INFO: invalid XOR eye diagram: 0
[19:59:04.258] <TB2> INFO: frame (failed synchr.): 0
[19:59:04.258] <TB2> INFO: idle data (no TBM trl): 0
[19:59:04.258] <TB2> INFO: no data (only TBM hdr): 0
[19:59:04.258] <TB2> INFO: TBM errors: 0
[19:59:04.258] <TB2> INFO: flawed TBM headers: 0
[19:59:04.258] <TB2> INFO: flawed TBM trailers: 0
[19:59:04.258] <TB2> INFO: event ID mismatches: 0
[19:59:04.258] <TB2> INFO: ROC errors: 0
[19:59:04.258] <TB2> INFO: missing ROC header(s): 0
[19:59:04.258] <TB2> INFO: misplaced readback start: 0
[19:59:04.258] <TB2> INFO: Pixel decoding errors: 1
[19:59:04.258] <TB2> INFO: pixel data incomplete: 0
[19:59:04.258] <TB2> INFO: pixel address: 0
[19:59:04.258] <TB2> INFO: pulse height fill bit: 0
[19:59:04.258] <TB2> INFO: buffer corruption: 1
[19:59:04.284] <TB2> INFO: Decoding statistics:
[19:59:04.284] <TB2> INFO: General information:
[19:59:04.284] <TB2> INFO: 16bit words read: 3458388
[19:59:04.284] <TB2> INFO: valid events total: 353536
[19:59:04.284] <TB2> INFO: empty events: 18233
[19:59:04.284] <TB2> INFO: valid events with pixels: 335303
[19:59:04.284] <TB2> INFO: valid pixel hits: 668585
[19:59:04.284] <TB2> INFO: Event errors: 0
[19:59:04.284] <TB2> INFO: start marker: 0
[19:59:04.284] <TB2> INFO: stop marker: 0
[19:59:04.284] <TB2> INFO: overflow: 0
[19:59:04.284] <TB2> INFO: invalid 5bit words: 0
[19:59:04.284] <TB2> INFO: invalid XOR eye diagram: 0
[19:59:04.284] <TB2> INFO: frame (failed synchr.): 0
[19:59:04.284] <TB2> INFO: idle data (no TBM trl): 0
[19:59:04.284] <TB2> INFO: no data (only TBM hdr): 0
[19:59:04.284] <TB2> INFO: TBM errors: 0
[19:59:04.285] <TB2> INFO: flawed TBM headers: 0
[19:59:04.285] <TB2> INFO: flawed TBM trailers: 0
[19:59:04.285] <TB2> INFO: event ID mismatches: 0
[19:59:04.285] <TB2> INFO: ROC errors: 0
[19:59:04.285] <TB2> INFO: missing ROC header(s): 0
[19:59:04.285] <TB2> INFO: misplaced readback start: 0
[19:59:04.285] <TB2> INFO: Pixel decoding errors: 1
[19:59:04.285] <TB2> INFO: pixel data incomplete: 0
[19:59:04.285] <TB2> INFO: pixel address: 0
[19:59:04.285] <TB2> INFO: pulse height fill bit: 0
[19:59:04.285] <TB2> INFO: buffer corruption: 1
[19:59:04.285] <TB2> INFO: enter test to run
[19:59:04.285] <TB2> INFO: test: exit no parameter change
[19:59:04.518] <TB2> QUIET: Connection to board 149 closed.
[19:59:04.519] <TB2> INFO: pXar: this is the end, my friend