[08:16:35.694] <TB3> INFO: *** Welcome to pxar ***
[08:16:35.694] <TB3> INFO: *** Today: 2016/08/18
[08:16:35.746] <TB3> INFO: *** Version: f5d3-dirty
[08:16:35.746] <TB3> INFO: readRocDacs: /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C0.dat .. /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C15.dat
[08:16:35.761] <TB3> INFO: readTbmDacs: /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//tbmParameters_C0a.dat .. /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//tbmParameters_C0b.dat
[08:16:35.763] <TB3> INFO: readMaskFile: /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//defaultMaskFile.dat
[08:16:35.764] <TB3> INFO: readTrimFile: /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//trimParameters_C0.dat .. /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//trimParameters_C15.dat
[08:16:35.871] <TB3> INFO: clk: 4
[08:16:35.871] <TB3> INFO: ctr: 4
[08:16:35.871] <TB3> INFO: sda: 19
[08:16:35.871] <TB3> INFO: tin: 9
[08:16:35.871] <TB3> INFO: level: 15
[08:16:35.871] <TB3> INFO: triggerdelay: 0
[08:16:35.871] <TB3> QUIET: Instanciating API for pxar v2.7.5+40~g4fce89b
[08:16:35.871] <TB3> INFO: Log level: INFO
[08:16:35.878] <TB3> INFO: Found DTB DTB_WWVASW
[08:16:35.890] <TB3> QUIET: Connection to board DTB_WWVASW opened.
[08:16:35.892] <TB3> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 126
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWVASW
MAC address: 40D85511807E
Hostname: pixelDTB126
Comment:
------------------------------------------------------
[08:16:35.894] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[08:16:37.410] <TB3> INFO: DUT info:
[08:16:37.410] <TB3> INFO: The DUT currently contains the following objects:
[08:16:37.410] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[08:16:37.410] <TB3> INFO: TBM Core alpha (0): 7 registers set
[08:16:37.410] <TB3> INFO: TBM Core beta (1): 7 registers set
[08:16:37.410] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:16:37.410] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.410] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:16:37.812] <TB3> INFO: enter 'restricted' command line mode
[08:16:37.812] <TB3> INFO: enter test to run
[08:16:37.812] <TB3> INFO: test: pretest no parameter change
[08:16:37.812] <TB3> INFO: running: pretest
[08:16:37.818] <TB3> INFO: ----------------------------------------------------------------------
[08:16:37.818] <TB3> INFO: PixTestPretest::programROC()
[08:16:37.818] <TB3> INFO: ----------------------------------------------------------------------
[08:16:55.833] <TB3> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[08:16:55.834] <TB3> INFO: IA differences per ROC: 17.7 20.1 17.7 20.1 18.5 19.3 20.1 18.5 19.3 19.3 21.7 20.9 21.7 20.1 20.1 20.9
[08:16:55.955] <TB3> INFO: enter test to run
[08:16:55.955] <TB3> INFO: test: pretest no parameter change
[08:16:55.955] <TB3> INFO: running: pretest
[08:16:55.956] <TB3> INFO: ----------------------------------------------------------------------
[08:16:55.956] <TB3> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[08:16:55.956] <TB3> INFO: ----------------------------------------------------------------------
[08:17:17.239] <TB3> INFO: PixTestPretest::setVana() done, Module Ia 382.7 mA = 23.9187 mA/ROC
[08:17:17.240] <TB3> INFO: i(loss) [mA/ROC]: 19.3 20.1 19.3 18.5 18.5 19.3 19.3 18.5 19.3 19.3 18.5 17.7 17.7 19.3 19.3 19.3
[08:17:17.285] <TB3> INFO: enter test to run
[08:17:17.285] <TB3> INFO: test: pretest no parameter change
[08:17:17.285] <TB3> INFO: running: pretest
[08:17:17.286] <TB3> INFO: ----------------------------------------------------------------------
[08:17:17.286] <TB3> INFO: PixTestPretest::findWorkingPixel()
[08:17:17.286] <TB3> INFO: ----------------------------------------------------------------------
[08:17:17.378] <TB3> INFO: Expecting 231680 events.
[08:17:26.333] <TB3> INFO: 231680 events read in total (8396ms).
[08:17:26.434] <TB3> INFO: Test took 9146ms.
[08:17:26.642] <TB3> INFO: Found working pixel in all ROCs: col/row = 12/22
[08:17:26.720] <TB3> INFO: enter test to run
[08:17:26.720] <TB3> INFO: test: pretest no parameter change
[08:17:26.720] <TB3> INFO: running: pretest
[08:17:26.722] <TB3> INFO: ----------------------------------------------------------------------
[08:17:26.722] <TB3> INFO: PixTestPretest::setVthrCompCalDel()
[08:17:26.722] <TB3> INFO: ----------------------------------------------------------------------
[08:17:26.817] <TB3> INFO: Expecting 231680 events.
[08:17:35.800] <TB3> INFO: 231680 events read in total (8427ms).
[08:17:35.805] <TB3> INFO: Test took 9078ms.
[08:17:36.130] <TB3> INFO: PixTestPretest::setVthrCompCalDel() done
[08:17:36.130] <TB3> INFO: CalDel: 118 127 115 106 122 132 116 121 134 126 141 132 115 110 112 106
[08:17:36.130] <TB3> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[08:17:36.164] <TB3> INFO: enter test to run
[08:17:36.164] <TB3> INFO: test: pretest no parameter change
[08:17:36.164] <TB3> INFO: running: pretest
[08:17:36.168] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C0.dat
[08:17:36.172] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C1.dat
[08:17:36.180] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C2.dat
[08:17:36.184] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C3.dat
[08:17:36.190] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C4.dat
[08:17:36.194] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C5.dat
[08:17:36.199] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C6.dat
[08:17:36.204] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C7.dat
[08:17:36.211] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C8.dat
[08:17:36.216] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C9.dat
[08:17:36.221] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C10.dat
[08:17:36.226] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C11.dat
[08:17:36.230] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C12.dat
[08:17:36.235] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C13.dat
[08:17:36.241] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C14.dat
[08:17:36.247] <TB3> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//dacParameters_C15.dat
[08:17:36.250] <TB3> INFO: enter test to run
[08:17:36.250] <TB3> INFO: test: PixelAlive no parameter change
[08:17:36.250] <TB3> INFO: running: pixelalive
[08:17:36.251] <TB3> INFO: ######################################################################
[08:17:36.251] <TB3> INFO: PixTestAlive::doTest()
[08:17:36.251] <TB3> INFO: ######################################################################
[08:17:36.252] <TB3> INFO: ----------------------------------------------------------------------
[08:17:36.252] <TB3> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:17:36.252] <TB3> INFO: ----------------------------------------------------------------------
[08:17:36.528] <TB3> INFO: Expecting 41600 events.
[08:17:39.974] <TB3> INFO: 41600 events read in total (2890ms).
[08:17:39.975] <TB3> INFO: Test took 3720ms.
[08:17:40.285] <TB3> INFO: PixTestAlive::aliveTest() done
[08:17:40.285] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 1 1 1 1 0 0 0 0 0 0 0 0
[08:17:40.286] <TB3> INFO: ----------------------------------------------------------------------
[08:17:40.286] <TB3> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:17:40.286] <TB3> INFO: ----------------------------------------------------------------------
[08:17:40.549] <TB3> INFO: Expecting 41600 events.
[08:17:43.190] <TB3> INFO: 41600 events read in total (2085ms).
[08:17:43.190] <TB3> INFO: Test took 2902ms.
[08:17:43.191] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:17:43.515] <TB3> INFO: PixTestAlive::maskTest() done
[08:17:43.515] <TB3> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:17:43.516] <TB3> INFO: ----------------------------------------------------------------------
[08:17:43.516] <TB3> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:17:43.516] <TB3> INFO: ----------------------------------------------------------------------
[08:17:43.807] <TB3> INFO: Expecting 41600 events.
[08:17:47.275] <TB3> INFO: 41600 events read in total (2912ms).
[08:17:47.276] <TB3> INFO: Test took 3757ms.
[08:17:47.576] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[08:17:47.576] <TB3> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:17:47.576] <TB3> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[08:17:47.582] <TB3> INFO: enter test to run
[08:17:47.582] <TB3> INFO: test: BB no parameter change
[08:17:47.582] <TB3> INFO: running: bb
[08:17:47.583] <TB3> INFO: ######################################################################
[08:17:47.583] <TB3> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[08:17:47.583] <TB3> INFO: ######################################################################
[08:17:47.587] <TB3> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[08:17:47.599] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[08:17:47.599] <TB3> INFO: run 1 of 1
[08:17:47.887] <TB3> INFO: Expecting 3120000 events.
[08:18:34.564] <TB3> INFO: 1195770 events read in total (46121ms).
[08:19:21.875] <TB3> INFO: 2387920 events read in total (93432ms).
[08:19:51.227] <TB3> INFO: 3120000 events read in total (122785ms).
[08:19:51.286] <TB3> INFO: Test took 123688ms.
[08:20:14.333] <TB3> INFO: PixTestBBMap::doTest() done, duration: 146 seconds
[08:20:14.334] <TB3> INFO: number of dead bumps (per ROC): 1 0 1 0 1 3 3 1 0 0 0 0 0 0 0 1
[08:20:14.334] <TB3> INFO: separation cut (per ROC): 137 139 112 123 107 105 120 107 132 108 125 110 116 140 128 129
[08:20:14.408] <TB3> INFO: enter test to run
[08:20:14.408] <TB3> INFO: test: Readback no parameter change
[08:20:14.408] <TB3> INFO: running: readback
[08:20:14.408] <TB3> INFO: readReadbackCal: /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C0.dat .. /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C15.dat
[08:20:14.497] <TB3> INFO: readGainPedestalParameters /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//phCalibrationFitErr_C0.dat .. /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//phCalibrationFitErr_C15.dat

[08:20:14.497] <TB3> INFO: ######################################################################
[08:20:14.497] <TB3> INFO: PixTestReadback::doTest()
[08:20:14.497] <TB3> INFO: ######################################################################
[08:20:14.497] <TB3> INFO: ----------------------------------------------------------------------
[08:20:14.498] <TB3> INFO: PixTestReadback::CalibrateVd()
[08:20:14.498] <TB3> INFO: ----------------------------------------------------------------------
[08:20:30.728] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C0.dat
[08:20:30.733] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C1.dat
[08:20:30.738] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C2.dat
[08:20:30.743] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C3.dat
[08:20:30.748] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C4.dat
[08:20:30.754] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C5.dat
[08:20:30.760] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C6.dat
[08:20:30.765] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C7.dat
[08:20:30.771] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C8.dat
[08:20:30.784] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C9.dat
[08:20:30.791] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C10.dat
[08:20:30.796] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C11.dat
[08:20:30.801] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C12.dat
[08:20:30.807] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C13.dat
[08:20:30.813] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C14.dat
[08:20:30.818] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C15.dat
[08:20:30.867] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[08:20:30.867] <TB3> INFO: ----------------------------------------------------------------------
[08:20:30.867] <TB3> INFO: PixTestReadback::CalibrateVa()
[08:20:30.867] <TB3> INFO: ----------------------------------------------------------------------
[08:20:47.576] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C0.dat
[08:20:47.581] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C1.dat
[08:20:47.588] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C2.dat
[08:20:47.593] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C3.dat
[08:20:47.630] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C4.dat
[08:20:47.637] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C5.dat
[08:20:47.642] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C6.dat
[08:20:47.649] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C7.dat
[08:20:47.655] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C8.dat
[08:20:47.662] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C9.dat
[08:20:47.693] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C10.dat
[08:20:47.706] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C11.dat
[08:20:47.725] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C12.dat
[08:20:47.733] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C13.dat
[08:20:47.750] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C14.dat
[08:20:47.758] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C15.dat
[08:20:47.807] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[08:20:47.807] <TB3> INFO: ----------------------------------------------------------------------
[08:20:47.807] <TB3> INFO: PixTestReadback::readbackVbg()
[08:20:47.807] <TB3> INFO: ----------------------------------------------------------------------
[08:21:00.405] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[08:21:00.405] <TB3> INFO: ----------------------------------------------------------------------
[08:21:00.405] <TB3> INFO: PixTestReadback::getCalibratedVbg()
[08:21:00.405] <TB3> INFO: ----------------------------------------------------------------------
[08:21:00.406] <TB3> INFO: Vbg will be calibrated using Vd calibration
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 158calibrated Vbg = 1.24148 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 161.3calibrated Vbg = 1.2378 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 155.6calibrated Vbg = 1.24586 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 148.9calibrated Vbg = 1.24838 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 160.2calibrated Vbg = 1.25558 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 152.7calibrated Vbg = 1.24845 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 155.3calibrated Vbg = 1.2586 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 154.1calibrated Vbg = 1.24968 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 151.7calibrated Vbg = 1.25337 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 152.4calibrated Vbg = 1.25328 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 144.6calibrated Vbg = 1.25083 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 150.1calibrated Vbg = 1.24877 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 157.3calibrated Vbg = 1.2387 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 155.6calibrated Vbg = 1.23757 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 156.1calibrated Vbg = 1.24195 :::*/*/*/*/
[08:21:00.406] <TB3> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 157.1calibrated Vbg = 1.24084 :::*/*/*/*/
[08:21:00.407] <TB3> INFO: ----------------------------------------------------------------------
[08:21:00.407] <TB3> INFO: PixTestReadback::CalibrateIa()
[08:21:00.408] <TB3> INFO: ----------------------------------------------------------------------
[08:24:33.421] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C0.dat
[08:24:33.513] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C1.dat
[08:24:33.580] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C2.dat
[08:24:33.689] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C3.dat
[08:24:33.765] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C4.dat
[08:24:33.840] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C5.dat
[08:24:33.915] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C6.dat
[08:24:33.999] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C7.dat
[08:24:34.067] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C8.dat
[08:24:34.134] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C9.dat
[08:24:34.201] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C10.dat
[08:24:34.268] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C11.dat
[08:24:34.402] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C12.dat
[08:24:34.486] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C13.dat
[08:24:34.553] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C14.dat
[08:24:34.629] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4420_Reception_2016-08-18_10h14m_1471508059//000_ReceptionTestBB2_p17//readbackCal_C15.dat
[08:24:34.733] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[08:24:34.735] <TB3> INFO: PixTestReadback::doTest() done
[08:24:34.757] <TB3> INFO: enter test to run
[08:24:34.757] <TB3> INFO: test: BB2 no parameter change
[08:24:34.757] <TB3> INFO: running: bb2
[08:24:34.759] <TB3> INFO: ######################################################################
[08:24:34.759] <TB3> INFO: PixTestBB2Map::doTest() Ntrig = 10, VcalS = 222, PlWidth = 35
[08:24:34.759] <TB3> INFO: ######################################################################
[08:24:34.760] <TB3> INFO: ----------------------------------------------------------------------
[08:24:34.760] <TB3> INFO: PixTestBB2Map::setVana() target Ia = 24 mA/ROC
[08:24:34.760] <TB3> INFO: ----------------------------------------------------------------------
[08:24:54.338] <TB3> INFO: PixTestBB2Map::setVana() done, Module Ia 373 mA = 23.3125 mA/ROC
[08:24:54.340] <TB3> INFO: ----------------------------------------------------------------------
[08:24:54.340] <TB3> INFO: PixTestBB2Map::setVthrCompCalDel()
[08:24:54.340] <TB3> INFO: ----------------------------------------------------------------------
[08:24:54.437] <TB3> INFO: Expecting 655360 events.
[08:25:12.319] <TB3> INFO: 655360 events read in total (17326ms).
[08:25:12.323] <TB3> INFO: Test took 17974ms.
[08:25:12.633] <TB3> INFO: PixTestBB2Map::setVthrCompCalDel() done
[08:25:12.633] <TB3> INFO: CalDel: 114 121 113 100 114 125 114 114 131 120 132 127 113 107 110 101
[08:25:12.633] <TB3> INFO: VthrComp: 98 95 95 100 90 91 96 89 103 91 89 92 95 102 99 92
[08:25:12.908] <TB3> INFO: Expecting 5324800 events.
[08:25:49.257] <TB3> INFO: 1380810 events read in total (35793ms).
[08:26:25.063] <TB3> INFO: 2743930 events read in total (71599ms).
[08:27:01.106] <TB3> INFO: 4127710 events read in total (107643ms).
[08:27:31.444] <TB3> INFO: 5324800 events read in total (137980ms).
[08:27:31.471] <TB3> INFO: Test took 138824ms.
[08:27:31.982] <TB3> INFO: Missing Bumps: 46 7 1 1 1 3 3 1 0 0 0 0 0 0 0 6
[08:27:31.982] <TB3> INFO: Separation Cut: 32.38 29.72 26.18 31.21 16.76 19.96 22.52 18.09 27.11 23.21 28.71 24.25 23.54 27.28 19.72 28.95
[08:27:31.982] <TB3> INFO: PixTestBB2Map::doTest() done,177 seconds
[08:27:32.303] <TB3> INFO: enter test to run
[08:27:32.303] <TB3> INFO: test: no parameter change
[08:27:32.360] <TB3> QUIET: Connection to board 126 closed.
[08:27:32.441] <TB3> INFO: pXar: this is the end, my friend