[15:53:46.397] <TB2> INFO: *** Welcome to pxar ***
[15:53:46.397] <TB2> INFO: *** Today: 2016/07/12
[15:53:46.435] <TB2> INFO: *** Version: f5d3-dirty
[15:53:46.435] <TB2> INFO: readRocDacs: /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C0.dat .. /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C15.dat
[15:53:46.451] <TB2> INFO: readTbmDacs: /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//tbmParameters_C0a.dat .. /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//tbmParameters_C0b.dat
[15:53:46.453] <TB2> INFO: readMaskFile: /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//defaultMaskFile.dat
[15:53:46.454] <TB2> INFO: readTrimFile: /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//trimParameters_C0.dat .. /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//trimParameters_C15.dat
[15:53:46.571] <TB2> INFO: clk: 4
[15:53:46.571] <TB2> INFO: ctr: 4
[15:53:46.571] <TB2> INFO: sda: 19
[15:53:46.571] <TB2> INFO: tin: 9
[15:53:46.571] <TB2> INFO: level: 15
[15:53:46.571] <TB2> INFO: triggerdelay: 0
[15:53:46.571] <TB2> QUIET: Instanciating API for pxar v2.7.5+40~g4fce89b
[15:53:46.571] <TB2> INFO: Log level: INFO
[15:53:46.578] <TB2> INFO: Found DTB DTB_WWXUD2
[15:53:46.588] <TB2> QUIET: Connection to board DTB_WWXUD2 opened.
[15:53:46.590] <TB2> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 149
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WWXUD2
MAC address: 40D855118095
Hostname: pixelDTB149
Comment:
------------------------------------------------------
[15:53:46.592] <TB2> INFO: RPC call hashes of host and DTB match: 484264910
[15:53:48.105] <TB2> INFO: DUT info:
[15:53:48.105] <TB2> INFO: The DUT currently contains the following objects:
[15:53:48.105] <TB2> INFO: 2 TBM Cores tbm08c (2 ON)
[15:53:48.105] <TB2> INFO: TBM Core alpha (0): 7 registers set
[15:53:48.105] <TB2> INFO: TBM Core beta (1): 7 registers set
[15:53:48.106] <TB2> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[15:53:48.106] <TB2> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.106] <TB2> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[15:53:48.509] <TB2> INFO: enter 'restricted' command line mode
[15:53:48.509] <TB2> INFO: enter test to run
[15:53:48.509] <TB2> INFO: test: pretest no parameter change
[15:53:48.509] <TB2> INFO: running: pretest
[15:53:48.515] <TB2> INFO: ----------------------------------------------------------------------
[15:53:48.515] <TB2> INFO: PixTestPretest::programROC()
[15:53:48.515] <TB2> INFO: ----------------------------------------------------------------------
[15:54:06.535] <TB2> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[15:54:06.535] <TB2> INFO: IA differences per ROC: 20.9 16.9 19.3 20.1 22.5 18.5 22.5 20.1 18.5 20.1 20.1 18.5 19.3 20.9 18.5 20.9
[15:54:06.654] <TB2> INFO: enter test to run
[15:54:06.654] <TB2> INFO: test: pretest no parameter change
[15:54:06.654] <TB2> INFO: running: pretest
[15:54:06.655] <TB2> INFO: ----------------------------------------------------------------------
[15:54:06.655] <TB2> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[15:54:06.655] <TB2> INFO: ----------------------------------------------------------------------
[15:54:27.987] <TB2> INFO: PixTestPretest::setVana() done, Module Ia 376.2 mA = 23.5125 mA/ROC
[15:54:27.988] <TB2> INFO: i(loss) [mA/ROC]: 20.1 19.3 18.5 18.5 19.3 19.3 19.3 18.5 19.3 18.5 20.1 19.3 18.5 18.5 18.5 17.7
[15:54:28.041] <TB2> INFO: enter test to run
[15:54:28.041] <TB2> INFO: test: pretest no parameter change
[15:54:28.041] <TB2> INFO: running: pretest
[15:54:28.041] <TB2> INFO: ----------------------------------------------------------------------
[15:54:28.041] <TB2> INFO: PixTestPretest::findTiming()
[15:54:28.041] <TB2> INFO: ----------------------------------------------------------------------
[15:54:28.041] <TB2> INFO: PixTestCmd::init()
[15:54:28.845] <TB2> WARNING: Not unmasking DUT, not setting Calibrate bits!
[15:55:29.226] <TB2> INFO: TBM phases: 160MHz: 7, 400MHz: 2, TBM delays: ROC(0/1):4, header/trailer: 1, token: 1
[15:55:29.226] <TB2> INFO: (success/tries = 100/100), width = 4
[15:55:29.228] <TB2> INFO: enter test to run
[15:55:29.228] <TB2> INFO: test: pretest no parameter change
[15:55:29.228] <TB2> INFO: running: pretest
[15:55:29.229] <TB2> INFO: ----------------------------------------------------------------------
[15:55:29.229] <TB2> INFO: PixTestPretest::findWorkingPixel()
[15:55:29.229] <TB2> INFO: ----------------------------------------------------------------------
[15:55:29.325] <TB2> INFO: Expecting 231680 events.
[15:55:35.000] <TB2> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"
[15:55:38.249] <TB2> INFO: 231680 events read in total (8368ms).
[15:55:38.253] <TB2> INFO: Test took 9018ms.
[15:55:38.555] <TB2> INFO: Found working pixel in all ROCs: col/row = 12/22
[15:55:38.632] <TB2> INFO: enter test to run
[15:55:38.632] <TB2> INFO: test: pretest no parameter change
[15:55:38.632] <TB2> INFO: running: pretest
[15:55:38.634] <TB2> INFO: ----------------------------------------------------------------------
[15:55:38.634] <TB2> INFO: PixTestPretest::setVthrCompCalDel()
[15:55:38.634] <TB2> INFO: ----------------------------------------------------------------------
[15:55:38.729] <TB2> INFO: Expecting 231680 events.
[15:55:47.712] <TB2> INFO: 231680 events read in total (8427ms).
[15:55:47.717] <TB2> INFO: Test took 9078ms.
[15:55:48.044] <TB2> INFO: PixTestPretest::setVthrCompCalDel() done
[15:55:48.044] <TB2> INFO: CalDel: 113 109 132 106 143 120 120 124 123 116 128 113 127 107 110 119
[15:55:48.044] <TB2> INFO: VthrComp: 51 51 51 51 51 52 51 51 51 51 51 51 51 51 51 51
[15:55:48.078] <TB2> INFO: enter test to run
[15:55:48.078] <TB2> INFO: test: pretest no parameter change
[15:55:48.078] <TB2> INFO: running: pretest
[15:55:48.095] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C0.dat
[15:55:48.101] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C1.dat
[15:55:48.106] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C2.dat
[15:55:48.113] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C3.dat
[15:55:48.121] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C4.dat
[15:55:48.126] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C5.dat
[15:55:48.131] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C6.dat
[15:55:48.137] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C7.dat
[15:55:48.143] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C8.dat
[15:55:48.148] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C9.dat
[15:55:48.153] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C10.dat
[15:55:48.160] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C11.dat
[15:55:48.167] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C12.dat
[15:55:48.172] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C13.dat
[15:55:48.179] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C14.dat
[15:55:48.184] <TB2> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//dacParameters_C15.dat
[15:55:48.187] <TB2> INFO: enter test to run
[15:55:48.187] <TB2> INFO: test: PixelAlive no parameter change
[15:55:48.187] <TB2> INFO: running: pixelalive
[15:55:48.188] <TB2> INFO: ######################################################################
[15:55:48.188] <TB2> INFO: PixTestAlive::doTest()
[15:55:48.188] <TB2> INFO: ######################################################################
[15:55:48.189] <TB2> INFO: ----------------------------------------------------------------------
[15:55:48.189] <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)
[15:55:48.189] <TB2> INFO: ----------------------------------------------------------------------
[15:55:48.454] <TB2> INFO: Expecting 41600 events.
[15:55:51.823] <TB2> INFO: 41600 events read in total (2813ms).
[15:55:51.824] <TB2> INFO: Test took 3632ms.
[15:55:52.135] <TB2> INFO: PixTestAlive::aliveTest() done
[15:55:52.135] <TB2> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 4 0 0 0
[15:55:52.136] <TB2> INFO: ----------------------------------------------------------------------
[15:55:52.136] <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)
[15:55:52.136] <TB2> INFO: ----------------------------------------------------------------------
[15:55:52.400] <TB2> INFO: Expecting 41600 events.
[15:55:55.000] <TB2> INFO: 41600 events read in total (2044ms).
[15:55:55.000] <TB2> INFO: Test took 2861ms.
[15:55:55.000] <TB2> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[15:55:55.325] <TB2> INFO: PixTestAlive::maskTest() done
[15:55:55.325] <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
[15:55:55.326] <TB2> INFO: ----------------------------------------------------------------------
[15:55:55.326] <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)
[15:55:55.326] <TB2> INFO: ----------------------------------------------------------------------
[15:55:55.590] <TB2> INFO: Expecting 41600 events.
[15:55:59.022] <TB2> INFO: 41600 events read in total (2876ms).
[15:55:59.022] <TB2> INFO: Test took 3694ms.
[15:55:59.333] <TB2> INFO: PixTestAlive::addressDecodingTest() done
[15:55:59.333] <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
[15:55:59.333] <TB2> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[15:55:59.338] <TB2> INFO: enter test to run
[15:55:59.338] <TB2> INFO: test: BB no parameter change
[15:55:59.338] <TB2> INFO: running: bb
[15:55:59.340] <TB2> INFO: ######################################################################
[15:55:59.340] <TB2> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[15:55:59.340] <TB2> INFO: ######################################################################
[15:55:59.344] <TB2> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[15:55:59.388] <TB2> INFO: dacScan split into 1 runs with ntrig = 5
[15:55:59.388] <TB2> INFO: run 1 of 1
[15:55:59.651] <TB2> INFO: Expecting 3120000 events.
[15:56:44.460] <TB2> INFO: 1165540 events read in total (44253ms).
[15:57:28.257] <TB2> INFO: 2306170 events read in total (88050ms).
[15:57:59.105] <TB2> INFO: 3120000 events read in total (118898ms).
[15:57:59.192] <TB2> INFO: Test took 119805ms.
[15:58:21.840] <TB2> INFO: PixTestBBMap::doTest() done, duration: 142 seconds
[15:58:21.841] <TB2> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 0 0 0 0 3 2 0 0 0
[15:58:21.841] <TB2> INFO: separation cut (per ROC): 121 111 117 109 122 126 116 103 112 100 107 115 104 104 101 97
[15:58:21.909] <TB2> INFO: enter test to run
[15:58:21.909] <TB2> INFO: test: Readback no parameter change
[15:58:21.909] <TB2> INFO: running: readback
[15:58:21.909] <TB2> INFO: readReadbackCal: /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C0.dat .. /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C15.dat
[15:58:21.924] <TB2> INFO: readGainPedestalParameters /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//phCalibrationFitErr_C0.dat .. /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//phCalibrationFitErr_C15.dat
[15:58:21.924] <TB2> ERROR: <ConfigParameters.cc/readGainPedestalParameters:L996> cannot open /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//phCalibrationFitErr_C0.dat for reading PH calibration constants
[15:58:21.924] <TB2> INFO: ######################################################################
[15:58:21.924] <TB2> INFO: PixTestReadback::doTest()
[15:58:21.924] <TB2> INFO: ######################################################################
[15:58:21.924] <TB2> INFO: ----------------------------------------------------------------------
[15:58:21.924] <TB2> INFO: PixTestReadback::CalibrateVd()
[15:58:21.924] <TB2> INFO: ----------------------------------------------------------------------
[15:58:31.281] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C0.dat
[15:58:31.286] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C1.dat
[15:58:31.293] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C2.dat
[15:58:31.298] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C3.dat
[15:58:31.303] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C4.dat
[15:58:31.308] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C5.dat
[15:58:31.313] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C6.dat
[15:58:31.318] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C7.dat
[15:58:31.323] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C8.dat
[15:58:31.328] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C9.dat
[15:58:31.333] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C10.dat
[15:58:31.338] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C11.dat
[15:58:31.343] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C12.dat
[15:58:31.348] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C13.dat
[15:58:31.353] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C14.dat
[15:58:31.358] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C15.dat
[15:58:31.407] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[15:58:31.407] <TB2> INFO: ----------------------------------------------------------------------
[15:58:31.407] <TB2> INFO: PixTestReadback::CalibrateVa()
[15:58:31.407] <TB2> INFO: ----------------------------------------------------------------------
[15:58:40.852] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C0.dat
[15:58:40.857] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C1.dat
[15:58:40.863] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C2.dat
[15:58:40.868] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C3.dat
[15:58:40.874] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C4.dat
[15:58:40.879] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C5.dat
[15:58:40.885] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C6.dat
[15:58:40.892] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C7.dat
[15:58:40.897] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C8.dat
[15:58:40.902] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C9.dat
[15:58:40.908] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C10.dat
[15:58:40.914] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C11.dat
[15:58:40.921] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C12.dat
[15:58:40.926] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C13.dat
[15:58:40.932] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C14.dat
[15:58:40.938] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C15.dat
[15:58:40.990] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[15:58:40.990] <TB2> INFO: ----------------------------------------------------------------------
[15:58:40.990] <TB2> INFO: PixTestReadback::readbackVbg()
[15:58:40.990] <TB2> INFO: ----------------------------------------------------------------------
[15:58:48.173] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[15:58:48.173] <TB2> INFO: ----------------------------------------------------------------------
[15:58:48.173] <TB2> INFO: PixTestReadback::getCalibratedVbg()
[15:58:48.173] <TB2> INFO: ----------------------------------------------------------------------
[15:58:48.173] <TB2> INFO: Vbg will be calibrated using Vd calibration
[15:58:48.173] <TB2> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 149.5calibrated Vbg = 1.23466 :::*/*/*/*/
[15:58:48.173] <TB2> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 165calibrated Vbg = 1.2303 :::*/*/*/*/
[15:58:48.173] <TB2> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 156.3calibrated Vbg = 1.22989 :::*/*/*/*/
[15:58:48.173] <TB2> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 158.4calibrated Vbg = 1.24027 :::*/*/*/*/
[15:58:48.173] <TB2> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 150.8calibrated Vbg = 1.2516 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 157.2calibrated Vbg = 1.2453 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 154.8calibrated Vbg = 1.24102 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 150.2calibrated Vbg = 1.24925 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 152.3calibrated Vbg = 1.24621 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 160.7calibrated Vbg = 1.25029 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 156.5calibrated Vbg = 1.24312 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 152calibrated Vbg = 1.2332 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 148.2calibrated Vbg = 1.23621 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 144.7calibrated Vbg = 1.2334 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 150.1calibrated Vbg = 1.23717 :::*/*/*/*/
[15:58:48.174] <TB2> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 152.8calibrated Vbg = 1.23583 :::*/*/*/*/
[15:58:48.177] <TB2> INFO: ----------------------------------------------------------------------
[15:58:48.177] <TB2> INFO: PixTestReadback::CalibrateIa()
[15:58:48.177] <TB2> INFO: ----------------------------------------------------------------------
[16:01:21.651] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C0.dat
[16:01:21.658] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C1.dat
[16:01:21.664] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C2.dat
[16:01:21.669] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C3.dat
[16:01:21.674] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C4.dat
[16:01:21.679] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C5.dat
[16:01:21.685] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C6.dat
[16:01:21.690] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C7.dat
[16:01:21.699] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C8.dat
[16:01:21.704] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C9.dat
[16:01:21.711] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C10.dat
[16:01:21.716] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C11.dat
[16:01:21.721] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C12.dat
[16:01:21.727] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C13.dat
[16:01:21.732] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C14.dat
[16:01:21.737] <TB2> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4790_Reception_2016-07-12_17h48m_1468338495//000_ReceptionTestBB4_p17//readbackCal_C15.dat
[16:01:21.788] <TB2> INFO: PixTestPattern:: pg_setup set to default.
[16:01:21.791] <TB2> INFO: PixTestReadback::doTest() done
[16:01:21.815] <TB2> INFO: enter test to run
[16:01:21.815] <TB2> INFO: test: BB4 no parameter change
[16:01:21.815] <TB2> INFO: running: bb4
[16:01:21.815] <TB2> INFO: PixTestBB4Map::doTest() ntrig = 100
[16:01:21.815] <TB2> INFO: VthrComp (min,max,step) = 70 130 5
[16:01:21.815] <TB2> INFO: CalDel (min,max,step) = 80 200 10
[16:01:21.815] <TB2> INFO: Vcal = 255
[16:01:21.815] <TB2> INFO: Cut = 0.5
[16:01:21.815] <TB2> INFO: flag 2
[16:01:21.817] <TB2> INFO: CtrlReg 4 (large Vcal)
[16:01:21.817] <TB2> INFO: saving VthrComp and CalDel before running tests)
[16:01:21.817] <TB2> INFO: 0 130 0
[16:01:21.817] <TB2> INFO: 1 130 0
[16:01:21.817] <TB2> INFO: 2 130 0
[16:01:21.817] <TB2> INFO: 3 130 0
[16:01:21.817] <TB2> INFO: 4 130 0
[16:01:21.817] <TB2> INFO: 5 130 0
[16:01:21.817] <TB2> INFO: 6 130 0
[16:01:21.817] <TB2> INFO: 7 130 0
[16:01:21.817] <TB2> INFO: 8 130 0
[16:01:21.817] <TB2> INFO: 9 130 0
[16:01:21.817] <TB2> INFO: 10 130 0
[16:01:21.817] <TB2> INFO: 11 130 0
[16:01:21.817] <TB2> INFO: 12 130 0
[16:01:21.817] <TB2> INFO: 13 130 0
[16:01:21.817] <TB2> INFO: 14 130 0
[16:01:21.817] <TB2> INFO: 15 130 0
[16:01:22.111] <TB2> INFO: Expecting 416000 events.
[16:01:26.761] <TB2> ERROR: <datapipe.cc/CheckEventValidity:L507> Channel 0 Number of ROCs (0) != Token Chain Length (8)
[16:01:26.789] <TB2> ERROR: <datapipe.cc/CheckEventID:L469> Channel 0 Event ID mismatch: local ID (16) != TBM ID (2)
[16:01:31.626] <TB2> INFO: 416000 events read in total (8959ms).
[16:01:31.630] <TB2> INFO: Test took 9807ms.
[16:01:31.630] <TB2> INFO: starting loop over VthrComp
[16:01:32.184] <TB2> INFO: Expecting 416000 events.
[16:01:41.722] <TB2> INFO: 416000 events read in total (8982ms).
[16:01:41.725] <TB2> INFO: Test took 9828ms.
[16:01:41.725] <TB2> INFO: got noisemap
[16:01:41.997] <TB2> INFO: ROC 0, integral 0
[16:01:41.997] <TB2> INFO: ROC 1, integral 0
[16:01:41.997] <TB2> INFO: ROC 2, integral 0
[16:01:41.997] <TB2> INFO: ROC 3, integral 0
[16:01:41.998] <TB2> INFO: ROC 4, integral 0
[16:01:41.998] <TB2> INFO: ROC 5, integral 0
[16:01:41.998] <TB2> INFO: ROC 6, integral 0
[16:01:41.998] <TB2> INFO: ROC 7, integral 0
[16:01:41.998] <TB2> INFO: ROC 8, integral 0
[16:01:41.998] <TB2> INFO: ROC 9, integral 0
[16:01:41.998] <TB2> INFO: ROC 10, integral 0
[16:01:41.999] <TB2> INFO: ROC 11, integral 0
[16:01:41.999] <TB2> INFO: ROC 12, integral 0
[16:01:41.999] <TB2> INFO: ROC 13, integral 0
[16:01:41.999] <TB2> INFO: ROC 14, integral 0
[16:01:41.999] <TB2> INFO: ROC 15, integral 0
[16:01:41.999] <TB2> INFO: VthrComp = 70 done
[16:01:42.274] <TB2> INFO: Expecting 416000 events.
[16:01:51.730] <TB2> INFO: 416000 events read in total (8900ms).
[16:01:51.732] <TB2> INFO: Test took 9728ms.
[16:01:51.732] <TB2> INFO: got noisemap
[16:01:52.004] <TB2> INFO: ROC 0, integral 0
[16:01:52.004] <TB2> INFO: ROC 1, integral 0
[16:01:52.004] <TB2> INFO: ROC 2, integral 0
[16:01:52.004] <TB2> INFO: ROC 3, integral 0
[16:01:52.004] <TB2> INFO: ROC 4, integral 0
[16:01:52.004] <TB2> INFO: ROC 5, integral 0
[16:01:52.005] <TB2> INFO: ROC 6, integral 0
[16:01:52.005] <TB2> INFO: ROC 7, integral 0
[16:01:52.005] <TB2> INFO: ROC 8, integral 0
[16:01:52.005] <TB2> INFO: ROC 9, integral 0
[16:01:52.005] <TB2> INFO: ROC 10, integral 0
[16:01:52.005] <TB2> INFO: ROC 11, integral 0
[16:01:52.005] <TB2> INFO: ROC 12, integral 0
[16:01:52.005] <TB2> INFO: ROC 13, integral 0
[16:01:52.005] <TB2> INFO: ROC 14, integral 0
[16:01:52.005] <TB2> INFO: ROC 15, integral 0
[16:01:52.005] <TB2> INFO: VthrComp = 75 done
[16:01:52.275] <TB2> INFO: Expecting 416000 events.
[16:02:01.766] <TB2> INFO: 416000 events read in total (8936ms).
[16:02:01.769] <TB2> INFO: Test took 9760ms.
[16:02:01.769] <TB2> INFO: got noisemap
[16:02:02.036] <TB2> INFO: ROC 0, integral 0
[16:02:02.036] <TB2> INFO: ROC 1, integral 0
[16:02:02.036] <TB2> INFO: ROC 2, integral 0
[16:02:02.036] <TB2> INFO: ROC 3, integral 0
[16:02:02.036] <TB2> INFO: ROC 4, integral 0
[16:02:02.036] <TB2> INFO: ROC 5, integral 0
[16:02:02.036] <TB2> INFO: ROC 6, integral 0
[16:02:02.037] <TB2> INFO: ROC 7, integral 0
[16:02:02.037] <TB2> INFO: ROC 8, integral 0
[16:02:02.037] <TB2> INFO: ROC 9, integral 0
[16:02:02.037] <TB2> INFO: ROC 10, integral 0
[16:02:02.037] <TB2> INFO: ROC 11, integral 0
[16:02:02.037] <TB2> INFO: ROC 12, integral 0
[16:02:02.037] <TB2> INFO: ROC 13, integral 0
[16:02:02.038] <TB2> INFO: ROC 14, integral 0
[16:02:02.038] <TB2> INFO: ROC 15, integral 0
[16:02:02.038] <TB2> INFO: VthrComp = 80 done
[16:02:02.314] <TB2> INFO: Expecting 416000 events.
[16:02:11.750] <TB2> INFO: 416000 events read in total (8881ms).
[16:02:11.753] <TB2> INFO: Test took 9710ms.
[16:02:11.753] <TB2> INFO: got noisemap
[16:02:12.024] <TB2> INFO: ROC 0, integral 0
[16:02:12.025] <TB2> INFO: ROC 1, integral 0
[16:02:12.025] <TB2> INFO: ROC 2, integral 0
[16:02:12.025] <TB2> INFO: ROC 3, integral 0
[16:02:12.025] <TB2> INFO: ROC 4, integral 0
[16:02:12.025] <TB2> INFO: ROC 5, integral 0
[16:02:12.025] <TB2> INFO: ROC 6, integral 0
[16:02:12.025] <TB2> INFO: ROC 7, integral 0
[16:02:12.025] <TB2> INFO: ROC 8, integral 0
[16:02:12.025] <TB2> INFO: ROC 9, integral 0
[16:02:12.025] <TB2> INFO: ROC 10, integral 0
[16:02:12.025] <TB2> INFO: ROC 11, integral 0
[16:02:12.025] <TB2> INFO: ROC 12, integral 0
[16:02:12.025] <TB2> INFO: ROC 13, integral 0
[16:02:12.025] <TB2> INFO: ROC 14, integral 0
[16:02:12.025] <TB2> INFO: ROC 15, integral 0
[16:02:12.025] <TB2> INFO: VthrComp = 85 done
[16:02:12.313] <TB2> INFO: Expecting 416000 events.
[16:02:21.721] <TB2> INFO: 416000 events read in total (8852ms).
[16:02:21.723] <TB2> INFO: Test took 9693ms.
[16:02:21.723] <TB2> INFO: got noisemap
[16:02:21.988] <TB2> INFO: ROC 0, integral 0
[16:02:21.988] <TB2> INFO: ROC 1, integral 0
[16:02:21.988] <TB2> INFO: ROC 2, integral 0
[16:02:21.988] <TB2> INFO: ROC 3, integral 0
[16:02:21.988] <TB2> INFO: ROC 4, integral 0
[16:02:21.988] <TB2> INFO: ROC 5, integral 0
[16:02:21.988] <TB2> INFO: ROC 6, integral 0
[16:02:21.988] <TB2> INFO: ROC 7, integral 0
[16:02:21.988] <TB2> INFO: ROC 8, integral 0
[16:02:21.988] <TB2> INFO: ROC 9, integral 0
[16:02:21.988] <TB2> INFO: ROC 10, integral 0
[16:02:21.988] <TB2> INFO: ROC 11, integral 0
[16:02:21.988] <TB2> INFO: ROC 12, integral 0
[16:02:21.988] <TB2> INFO: ROC 13, integral 0
[16:02:21.988] <TB2> INFO: ROC 14, integral 0
[16:02:21.988] <TB2> INFO: ROC 15, integral 0
[16:02:21.989] <TB2> INFO: VthrComp = 90 done
[16:02:22.255] <TB2> INFO: Expecting 416000 events.
[16:02:31.775] <TB2> INFO: 416000 events read in total (8965ms).
[16:02:31.777] <TB2> INFO: Test took 9784ms.
[16:02:31.778] <TB2> INFO: got noisemap
[16:02:32.047] <TB2> INFO: ROC 0, integral 0
[16:02:32.047] <TB2> INFO: ROC 1, integral 0
[16:02:32.047] <TB2> INFO: ROC 2, integral 0
[16:02:32.047] <TB2> INFO: ROC 3, integral 0
[16:02:32.047] <TB2> INFO: ROC 4, integral 0
[16:02:32.047] <TB2> INFO: ROC 5, integral 0
[16:02:32.047] <TB2> INFO: ROC 6, integral 0
[16:02:32.047] <TB2> INFO: ROC 7, integral 0
[16:02:32.048] <TB2> INFO: ROC 8, integral 0
[16:02:32.048] <TB2> INFO: ROC 9, integral 0
[16:02:32.048] <TB2> INFO: ROC 10, integral 0
[16:02:32.048] <TB2> INFO: ROC 11, integral 0
[16:02:32.048] <TB2> INFO: ROC 12, integral 0
[16:02:32.049] <TB2> INFO: ROC 13, integral 0
[16:02:32.049] <TB2> INFO: ROC 14, integral 0
[16:02:32.049] <TB2> INFO: ROC 15, integral 0
[16:02:32.049] <TB2> INFO: VthrComp = 95 done
[16:02:32.344] <TB2> INFO: Expecting 416000 events.
[16:02:41.861] <TB2> INFO: 416000 events read in total (8962ms).
[16:02:41.864] <TB2> INFO: Test took 9809ms.
[16:02:41.864] <TB2> INFO: got noisemap
[16:02:42.133] <TB2> INFO: ROC 0, integral 0
[16:02:42.134] <TB2> INFO: ROC 1, integral 0
[16:02:42.134] <TB2> INFO: ROC 2, integral 0
[16:02:42.134] <TB2> INFO: ROC 3, integral 0
[16:02:42.134] <TB2> INFO: ROC 4, integral 0
[16:02:42.134] <TB2> INFO: ROC 5, integral 0
[16:02:42.134] <TB2> INFO: ROC 6, integral 0
[16:02:42.134] <TB2> INFO: ROC 7, integral 0
[16:02:42.135] <TB2> INFO: ROC 8, integral 0
[16:02:42.135] <TB2> INFO: ROC 9, integral 0
[16:02:42.135] <TB2> INFO: ROC 10, integral 0
[16:02:42.135] <TB2> INFO: ROC 11, integral 0
[16:02:42.135] <TB2> INFO: ROC 12, integral 0
[16:02:42.135] <TB2> INFO: ROC 13, integral 0
[16:02:42.136] <TB2> INFO: ROC 14, integral 0
[16:02:42.136] <TB2> INFO: ROC 15, integral 0
[16:02:42.136] <TB2> INFO: VthrComp = 100 done
[16:02:42.435] <TB2> INFO: Expecting 416000 events.
[16:02:51.958] <TB2> INFO: 416000 events read in total (8967ms).
[16:02:51.961] <TB2> INFO: Test took 9819ms.
[16:02:51.961] <TB2> INFO: got noisemap
[16:02:52.232] <TB2> INFO: ROC 0, integral 0
[16:02:52.232] <TB2> INFO: ROC 1, integral 0
[16:02:52.233] <TB2> INFO: ROC 2, integral 0
[16:02:52.233] <TB2> INFO: ROC 3, integral 0
[16:02:52.233] <TB2> INFO: ROC 4, integral 0
[16:02:52.233] <TB2> INFO: ROC 5, integral 0
[16:02:52.233] <TB2> INFO: ROC 6, integral 0
[16:02:52.233] <TB2> INFO: ROC 7, integral 0
[16:02:52.233] <TB2> INFO: ROC 8, integral 0
[16:02:52.233] <TB2> INFO: ROC 9, integral 1
[16:02:52.233] <TB2> INFO: ROC 10, integral 0
[16:02:52.233] <TB2> INFO: ROC 11, integral 0
[16:02:52.233] <TB2> INFO: ROC 12, integral 1
[16:02:52.233] <TB2> INFO: ROC 13, integral 1
[16:02:52.233] <TB2> INFO: ROC 14, integral 1
[16:02:52.233] <TB2> INFO: ROC 15, integral 7
[16:02:52.233] <TB2> INFO: VthrComp = 105 done
[16:02:52.514] <TB2> INFO: Expecting 416000 events.
[16:03:02.107] <TB2> INFO: 416000 events read in total (9037ms).
[16:03:02.109] <TB2> INFO: Test took 9870ms.
[16:03:02.110] <TB2> INFO: got noisemap
[16:03:02.377] <TB2> INFO: ROC 0, integral 0
[16:03:02.377] <TB2> INFO: ROC 1, integral 5
[16:03:02.377] <TB2> INFO: ROC 2, integral 1
[16:03:02.377] <TB2> INFO: ROC 3, integral 0
[16:03:02.377] <TB2> INFO: ROC 4, integral 0
[16:03:02.377] <TB2> INFO: ROC 5, integral 0
[16:03:02.378] <TB2> INFO: ROC 6, integral 0
[16:03:02.378] <TB2> INFO: ROC 7, integral 0
[16:03:02.378] <TB2> INFO: ROC 8, integral 0
[16:03:02.378] <TB2> INFO: ROC 9, integral 16
[16:03:02.378] <TB2> INFO: ROC #9: threshold found
[16:03:02.378] <TB2> INFO: ROC 10, integral 0
[16:03:02.378] <TB2> INFO: ROC 11, integral 0
[16:03:02.378] <TB2> INFO: ROC 12, integral 3
[16:03:02.379] <TB2> INFO: ROC 13, integral 10
[16:03:02.379] <TB2> INFO: ROC #13: threshold found
[16:03:02.379] <TB2> INFO: ROC 14, integral 32
[16:03:02.379] <TB2> INFO: ROC #14: threshold found
[16:03:02.379] <TB2> INFO: ROC 15, integral 138
[16:03:02.379] <TB2> INFO: ROC #15: threshold found
[16:03:02.379] <TB2> INFO: VthrComp = 110 done
[16:03:02.662] <TB2> INFO: Expecting 416000 events.
[16:03:12.196] <TB2> INFO: 416000 events read in total (8978ms).
[16:03:12.199] <TB2> INFO: Test took 9815ms.
[16:03:12.199] <TB2> INFO: got noisemap
[16:03:12.466] <TB2> INFO: ROC 0, integral 1
[16:03:12.466] <TB2> INFO: ROC 1, integral 155
[16:03:12.466] <TB2> INFO: ROC #1: threshold found
[16:03:12.466] <TB2> INFO: ROC 2, integral 53
[16:03:12.466] <TB2> INFO: ROC #2: threshold found
[16:03:12.466] <TB2> INFO: ROC 3, integral 0
[16:03:12.466] <TB2> INFO: ROC 4, integral 20
[16:03:12.466] <TB2> INFO: ROC #4: threshold found
[16:03:12.467] <TB2> INFO: ROC 5, integral 5
[16:03:12.467] <TB2> INFO: ROC 6, integral 34
[16:03:12.467] <TB2> INFO: ROC #6: threshold found
[16:03:12.467] <TB2> INFO: ROC 7, integral 14
[16:03:12.467] <TB2> INFO: ROC #7: threshold found
[16:03:12.467] <TB2> INFO: ROC 8, integral 13
[16:03:12.467] <TB2> INFO: ROC #8: threshold found
[16:03:12.467] <TB2> INFO: ROC 10, integral 2
[16:03:12.468] <TB2> INFO: ROC 11, integral 6
[16:03:12.468] <TB2> INFO: ROC 12, integral 128
[16:03:12.468] <TB2> INFO: ROC #12: threshold found
[16:03:12.468] <TB2> INFO: VthrComp = 115 done
[16:03:12.748] <TB2> INFO: Expecting 416000 events.
[16:03:22.264] <TB2> INFO: 416000 events read in total (8960ms).
[16:03:22.267] <TB2> INFO: Test took 9794ms.
[16:03:22.267] <TB2> INFO: got noisemap
[16:03:22.536] <TB2> INFO: ROC 0, integral 48
[16:03:22.536] <TB2> INFO: ROC #0: threshold found
[16:03:22.536] <TB2> INFO: ROC 3, integral 4
[16:03:22.536] <TB2> INFO: ROC 5, integral 18
[16:03:22.536] <TB2> INFO: ROC #5: threshold found
[16:03:22.536] <TB2> INFO: ROC 10, integral 15
[16:03:22.536] <TB2> INFO: ROC #10: threshold found
[16:03:22.537] <TB2> INFO: ROC 11, integral 25
[16:03:22.537] <TB2> INFO: ROC #11: threshold found
[16:03:22.537] <TB2> INFO: VthrComp = 120 done
[16:03:22.807] <TB2> INFO: Expecting 416000 events.
[16:03:32.330] <TB2> INFO: 416000 events read in total (8967ms).
[16:03:32.344] <TB2> INFO: Test took 9803ms.
[16:03:32.346] <TB2> INFO: got noisemap
[16:03:32.591] <TB2> INFO: ROC 3, integral 59
[16:03:32.591] <TB2> INFO: ROC #3: threshold found
[16:03:32.591] <TB2> INFO: VthrComp = 125 done
[16:03:32.591] <TB2> INFO: Minimal threshold for all ROCs found
[16:03:32.593] <TB2> INFO: resulting noise thresholds per ROC = 115 110 110 120 110 115 110 110 110 105 115 115 110 105 105 105
[16:03:32.593] <TB2> INFO: threshold scan done
[16:03:32.889] <TB2> INFO: Expecting 416000 events.
[16:03:43.502] <TB2> INFO: 416000 events read in total (10057ms).
[16:03:43.503] <TB2> INFO: Test took 10902ms.
[16:03:43.708] <TB2> INFO: ROC 0, missing bumps = 4063, total number of good bumps = 97
[16:03:43.709] <TB2> INFO: ROC 1, missing bumps = 2701, total number of good bumps = 1459
[16:03:43.711] <TB2> INFO: ROC 2, missing bumps = 4160, total number of good bumps = 0
[16:03:43.712] <TB2> INFO: ROC 3, missing bumps = 1230, total number of good bumps = 2930
[16:03:43.713] <TB2> INFO: ROC 4, missing bumps = 4160, total number of good bumps = 0
[16:03:43.715] <TB2> INFO: ROC 5, missing bumps = 4139, total number of good bumps = 21
[16:03:43.716] <TB2> INFO: ROC 6, missing bumps = 4144, total number of good bumps = 16
[16:03:43.718] <TB2> INFO: ROC 7, missing bumps = 4157, total number of good bumps = 3
[16:03:43.719] <TB2> INFO: ROC 8, missing bumps = 4140, total number of good bumps = 20
[16:03:43.721] <TB2> INFO: ROC 9, missing bumps = 4005, total number of good bumps = 155
[16:03:43.722] <TB2> INFO: ROC 10, missing bumps = 4160, total number of good bumps = 0
[16:03:43.724] <TB2> INFO: ROC 11, missing bumps = 3385, total number of good bumps = 775
[16:03:43.725] <TB2> INFO: ROC 12, missing bumps = 4160, total number of good bumps = 0
[16:03:43.727] <TB2> INFO: ROC 13, missing bumps = 105, total number of good bumps = 4055
[16:03:43.728] <TB2> INFO: ROC 14, missing bumps = 2949, total number of good bumps = 1211
[16:03:43.730] <TB2> INFO: ROC 15, missing bumps = 4155, total number of good bumps = 5
[16:03:43.730] <TB2> INFO: CalDel = 80 done
[16:03:44.023] <TB2> INFO: Expecting 416000 events.
[16:03:56.581] <TB2> INFO: 416000 events read in total (12002ms).
[16:03:56.582] <TB2> INFO: Test took 12848ms.
[16:03:56.750] <TB2> INFO: ROC 0, missing bumps = 1860, total number of good bumps = 2300
[16:03:56.752] <TB2> INFO: ROC 1, missing bumps = 82, total number of good bumps = 4078
[16:03:56.753] <TB2> INFO: ROC 2, missing bumps = 4102, total number of good bumps = 58
[16:03:56.755] <TB2> INFO: ROC 3, missing bumps = 10, total number of good bumps = 4150
[16:03:56.756] <TB2> INFO: ROC 4, missing bumps = 4149, total number of good bumps = 11
[16:03:56.758] <TB2> INFO: ROC 5, missing bumps = 3145, total number of good bumps = 1015
[16:03:56.759] <TB2> INFO: ROC 6, missing bumps = 2828, total number of good bumps = 1332
[16:03:56.761] <TB2> INFO: ROC 7, missing bumps = 3328, total number of good bumps = 832
[16:03:56.762] <TB2> INFO: ROC 8, missing bumps = 3006, total number of good bumps = 1154
[16:03:56.764] <TB2> INFO: ROC 9, missing bumps = 1046, total number of good bumps = 3114
[16:03:56.765] <TB2> INFO: ROC 10, missing bumps = 4151, total number of good bumps = 9
[16:03:56.767] <TB2> INFO: ROC 11, missing bumps = 429, total number of good bumps = 3731
[16:03:56.768] <TB2> INFO: ROC 12, missing bumps = 3820, total number of good bumps = 340
[16:03:56.770] <TB2> INFO: ROC 13, missing bumps = 1, total number of good bumps = 4159
[16:03:56.771] <TB2> INFO: ROC 14, missing bumps = 48, total number of good bumps = 4112
[16:03:56.773] <TB2> INFO: ROC 15, missing bumps = 1934, total number of good bumps = 2226
[16:03:56.773] <TB2> INFO: CalDel = 90 done
[16:03:57.062] <TB2> INFO: Expecting 416000 events.
[16:04:12.130] <TB2> INFO: 416000 events read in total (14512ms).
[16:04:12.131] <TB2> INFO: Test took 15354ms.
[16:04:12.301] <TB2> INFO: ROC 0, missing bumps = 21, total number of good bumps = 4139
[16:04:12.303] <TB2> INFO: ROC 1, missing bumps = 4, total number of good bumps = 4156
[16:04:12.305] <TB2> INFO: ROC 2, missing bumps = 1419, total number of good bumps = 2741
[16:04:12.307] <TB2> INFO: ROC 3, missing bumps = 4, total number of good bumps = 4156
[16:04:12.309] <TB2> INFO: ROC 4, missing bumps = 3712, total number of good bumps = 448
[16:04:12.311] <TB2> INFO: ROC 5, missing bumps = 102, total number of good bumps = 4058
[16:04:12.312] <TB2> INFO: ROC 6, missing bumps = 36, total number of good bumps = 4124
[16:04:12.313] <TB2> INFO: ROC 7, missing bumps = 38, total number of good bumps = 4122
[16:04:12.315] <TB2> INFO: ROC 8, missing bumps = 52, total number of good bumps = 4108
[16:04:12.316] <TB2> INFO: ROC 9, missing bumps = 1, total number of good bumps = 4159
[16:04:12.318] <TB2> INFO: ROC 10, missing bumps = 1700, total number of good bumps = 2460
[16:04:12.319] <TB2> INFO: ROC 11, missing bumps = 14, total number of good bumps = 4146
[16:04:12.321] <TB2> INFO: ROC 12, missing bumps = 136, total number of good bumps = 4024
[16:04:12.322] <TB2> INFO: ROC 13, missing bumps = 0, total number of good bumps = 4160
[16:04:12.324] <TB2> INFO: ROC 14, missing bumps = 1, total number of good bumps = 4159
[16:04:12.325] <TB2> INFO: ROC 15, missing bumps = 14, total number of good bumps = 4146
[16:04:12.325] <TB2> INFO: CalDel = 100 done
[16:04:12.605] <TB2> INFO: Expecting 416000 events.
[16:04:28.247] <TB2> INFO: 416000 events read in total (15086ms).
[16:04:28.248] <TB2> INFO: Test took 15918ms.
[16:04:28.419] <TB2> INFO: ROC 0, missing bumps = 2, total number of good bumps = 4158
[16:04:28.421] <TB2> INFO: ROC 1, missing bumps = 4, total number of good bumps = 4156
[16:04:28.423] <TB2> INFO: ROC 2, missing bumps = 16, total number of good bumps = 4144
[16:04:28.424] <TB2> INFO: ROC 3, missing bumps = 1, total number of good bumps = 4159
[16:04:28.426] <TB2> INFO: ROC 4, missing bumps = 1379, total number of good bumps = 2781
[16:04:28.427] <TB2> INFO: ROC 5, missing bumps = 2, total number of good bumps = 4158
[16:04:28.429] <TB2> INFO: ROC 6, missing bumps = 0, total number of good bumps = 4160
[16:04:28.431] <TB2> INFO: ROC 7, missing bumps = 0, total number of good bumps = 4160
[16:04:28.432] <TB2> INFO: ROC 8, missing bumps = 0, total number of good bumps = 4160
[16:04:28.433] <TB2> INFO: ROC 9, missing bumps = 0, total number of good bumps = 4160
[16:04:28.435] <TB2> INFO: ROC 10, missing bumps = 16, total number of good bumps = 4144
[16:04:28.436] <TB2> INFO: ROC 11, missing bumps = 8, total number of good bumps = 4152
[16:04:28.438] <TB2> INFO: ROC 12, missing bumps = 8, total number of good bumps = 4152
[16:04:28.439] <TB2> INFO: ROC 14, missing bumps = 0, total number of good bumps = 4160
[16:04:28.441] <TB2> INFO: ROC 15, missing bumps = 6, total number of good bumps = 4154
[16:04:28.441] <TB2> INFO: CalDel = 110 done
[16:04:28.710] <TB2> INFO: Expecting 416000 events.
[16:04:44.505] <TB2> INFO: 416000 events read in total (15239ms).
[16:04:44.506] <TB2> INFO: Test took 16061ms.
[16:04:44.676] <TB2> INFO: ROC 0, missing bumps = 1, total number of good bumps = 4159
[16:04:44.677] <TB2> INFO: ROC 1, missing bumps = 3, total number of good bumps = 4157
[16:04:44.679] <TB2> INFO: ROC 2, missing bumps = 0, total number of good bumps = 4160
[16:04:44.680] <TB2> INFO: ROC 3, missing bumps = 0, total number of good bumps = 4160
[16:04:44.682] <TB2> INFO: ROC 4, missing bumps = 6, total number of good bumps = 4154
[16:04:44.683] <TB2> INFO: ROC 5, missing bumps = 1, total number of good bumps = 4159
[16:04:44.685] <TB2> INFO: ROC 10, missing bumps = 3, total number of good bumps = 4157
[16:04:44.686] <TB2> INFO: ROC 11, missing bumps = 4, total number of good bumps = 4156
[16:04:44.688] <TB2> INFO: ROC 12, missing bumps = 5, total number of good bumps = 4155
[16:04:44.689] <TB2> INFO: ROC 15, missing bumps = 2, total number of good bumps = 4158
[16:04:44.689] <TB2> INFO: CalDel = 120 done
[16:04:44.974] <TB2> INFO: Expecting 416000 events.
[16:05:00.645] <TB2> INFO: 416000 events read in total (15115ms).
[16:05:00.646] <TB2> INFO: Test took 15953ms.
[16:05:00.816] <TB2> INFO: ROC 0, missing bumps = 1, total number of good bumps = 4159
[16:05:00.818] <TB2> INFO: ROC 1, missing bumps = 3, total number of good bumps = 4159
[16:05:00.820] <TB2> INFO: ROC 4, missing bumps = 0, total number of good bumps = 4160
[16:05:00.822] <TB2> INFO: ROC 5, missing bumps = 1, total number of good bumps = 4159
[16:05:00.824] <TB2> INFO: ROC 10, missing bumps = 0, total number of good bumps = 4160
[16:05:00.826] <TB2> INFO: ROC 11, missing bumps = 3, total number of good bumps = 4157
[16:05:00.828] <TB2> INFO: ROC 12, missing bumps = 5, total number of good bumps = 4155
[16:05:00.829] <TB2> INFO: ROC 15, missing bumps = 1, total number of good bumps = 4159
[16:05:00.829] <TB2> INFO: CalDel = 130 done
[16:05:01.110] <TB2> INFO: Expecting 416000 events.
[16:05:16.245] <TB2> INFO: 416000 events read in total (14579ms).
[16:05:16.246] <TB2> INFO: Test took 15411ms.
[16:05:16.418] <TB2> INFO: ROC 0, missing bumps = 11, total number of good bumps = 4159
[16:05:16.419] <TB2> INFO: ROC 1, missing bumps = 933, total number of good bumps = 4159
[16:05:16.421] <TB2> INFO: ROC 5, missing bumps = 1, total number of good bumps = 4160
[16:05:16.423] <TB2> INFO: ROC 11, missing bumps = 139, total number of good bumps = 4157
[16:05:16.425] <TB2> INFO: ROC 12, missing bumps = 5, total number of good bumps = 4155
[16:05:16.426] <TB2> INFO: ROC 15, missing bumps = 0, total number of good bumps = 4160
[16:05:16.427] <TB2> INFO: CalDel = 140 done
[16:05:16.730] <TB2> INFO: Expecting 416000 events.
[16:05:29.269] <TB2> INFO: 416000 events read in total (11983ms).
[16:05:29.270] <TB2> INFO: Test took 12838ms.
[16:05:29.454] <TB2> INFO: ROC 0, missing bumps = 2424, total number of good bumps = 4159
[16:05:29.456] <TB2> INFO: ROC 1, missing bumps = 4128, total number of good bumps = 4159
[16:05:29.458] <TB2> INFO: ROC 5, missing bumps = 956, total number of good bumps = 4160
[16:05:29.459] <TB2> INFO: ROC 11, missing bumps = 3671, total number of good bumps = 4157
[16:05:29.461] <TB2> INFO: ROC 12, missing bumps = 474, total number of good bumps = 4155
[16:05:29.461] <TB2> INFO: CalDel = 150 done
[16:05:29.738] <TB2> INFO: Expecting 416000 events.
[16:05:40.474] <TB2> INFO: 416000 events read in total (10180ms).
[16:05:40.475] <TB2> INFO: Test took 11008ms.
[16:05:40.696] <TB2> INFO: ROC 0, missing bumps = 4113, total number of good bumps = 4159
[16:05:40.697] <TB2> INFO: ROC 1, missing bumps = 4153, total number of good bumps = 4160
[16:05:40.699] <TB2> INFO: ROC 5, missing bumps = 3904, total number of good bumps = 4160
[16:05:40.700] <TB2> INFO: ROC 11, missing bumps = 4148, total number of good bumps = 4157
[16:05:40.701] <TB2> INFO: ROC 12, missing bumps = 3900, total number of good bumps = 4155
[16:05:40.701] <TB2> INFO: CalDel = 160 done
[16:05:40.981] <TB2> INFO: Expecting 416000 events.
[16:05:50.864] <TB2> INFO: 416000 events read in total (9327ms).
[16:05:50.866] <TB2> INFO: Test took 10160ms.
[16:05:51.114] <TB2> INFO: ROC 0, missing bumps = 4158, total number of good bumps = 4159
[16:05:51.116] <TB2> INFO: ROC 1, missing bumps = 4158, total number of good bumps = 4160
[16:05:51.118] <TB2> INFO: ROC 5, missing bumps = 4157, total number of good bumps = 4160
[16:05:51.119] <TB2> INFO: ROC 11, missing bumps = 4154, total number of good bumps = 4157
[16:05:51.121] <TB2> INFO: ROC 12, missing bumps = 4157, total number of good bumps = 4155
[16:05:51.121] <TB2> INFO: CalDel = 170 done
[16:05:51.421] <TB2> INFO: Expecting 416000 events.
[16:06:00.910] <TB2> INFO: 416000 events read in total (8933ms).
[16:06:00.912] <TB2> INFO: Test took 9785ms.
[16:06:01.183] <TB2> INFO: ROC 0, missing bumps = 4160, total number of good bumps = 4159
[16:06:01.184] <TB2> INFO: ROC 1, missing bumps = 4160, total number of good bumps = 4160
[16:06:01.186] <TB2> INFO: ROC 5, missing bumps = 4159, total number of good bumps = 4160
[16:06:01.187] <TB2> INFO: ROC 11, missing bumps = 4160, total number of good bumps = 4157
[16:06:01.189] <TB2> INFO: ROC 12, missing bumps = 4160, total number of good bumps = 4155
[16:06:01.189] <TB2> INFO: CalDel = 180 done
[16:06:01.546] <TB2> INFO: Expecting 416000 events.
[16:06:10.944] <TB2> INFO: 416000 events read in total (8842ms).
[16:06:10.946] <TB2> INFO: Test took 9752ms.
[16:06:11.218] <TB2> INFO: ROC 0, missing bumps = 4160, total number of good bumps = 4159
[16:06:11.220] <TB2> INFO: ROC 1, missing bumps = 4160, total number of good bumps = 4160
[16:06:11.221] <TB2> INFO: ROC 5, missing bumps = 4160, total number of good bumps = 4160
[16:06:11.222] <TB2> INFO: ROC 11, missing bumps = 4160, total number of good bumps = 4157
[16:06:11.224] <TB2> INFO: ROC 12, missing bumps = 4160, total number of good bumps = 4155
[16:06:11.224] <TB2> INFO: CalDel = 190 done
[16:06:11.502] <TB2> INFO: Expecting 416000 events.
[16:06:20.910] <TB2> INFO: 416000 events read in total (8852ms).
[16:06:20.911] <TB2> INFO: Test took 9682ms.
[16:06:21.185] <TB2> INFO: ROC 0, missing bumps = 4160, total number of good bumps = 4159
[16:06:21.186] <TB2> INFO: ROC 1, missing bumps = 4160, total number of good bumps = 4160
[16:06:21.188] <TB2> INFO: ROC 5, missing bumps = 4160, total number of good bumps = 4160
[16:06:21.190] <TB2> INFO: ROC 11, missing bumps = 4160, total number of good bumps = 4157
[16:06:21.192] <TB2> INFO: ROC 12, missing bumps = 4160, total number of good bumps = 4155
[16:06:21.192] <TB2> INFO: CalDel = 200 done
[16:06:21.192] <TB2> INFO: CalDel scan done
[16:06:21.194] <TB2> INFO: resulting values: CalDel = 120 120 120 120 130 120 110 110 110 110 130 130 120 100 110 140
[16:06:21.493] <TB2> INFO: Expecting 416000 events.
[16:06:37.197] <TB2> INFO: 416000 events read in total (15148ms).
[16:06:37.198] <TB2> INFO: Test took 16000ms.
[16:06:37.212] <TB2> INFO: maps.size() = 16
[16:06:37.461] <TB2> INFO: 9 broken Bump Bonds found
[16:06:37.465] <TB2> INFO: back to CtrlReg 0
[16:06:37.469] <TB2> INFO: PixTestBB4Map::doTest() done
[16:06:37.469] <TB2> INFO: Write out MinimumThreshold
[16:06:37.469] <TB2> INFO: Write out CalDel Scan_C0_V0
[16:06:37.469] <TB2> INFO: Write out PixelHit_C0_V0
[16:06:37.469] <TB2> INFO: Write out BB4MapBest_C0_V0
[16:06:37.469] <TB2> INFO: Write out NoiseScan_C0_V0
[16:06:37.469] <TB2> INFO: Write out BB4Map_C0_V13
[16:06:37.469] <TB2> INFO: Write out Hit Distr_C0_V0
[16:06:37.469] <TB2> INFO: Write out Hit Distr_C0_V0
[16:06:37.469] <TB2> INFO: Write out CalDel Scan_C1_V0
[16:06:37.470] <TB2> INFO: Write out PixelHit_C1_V0
[16:06:37.470] <TB2> INFO: Write out BB4MapBest_C1_V0
[16:06:37.470] <TB2> INFO: Write out NoiseScan_C1_V0
[16:06:37.470] <TB2> INFO: Write out BB4Map_C1_V13
[16:06:37.470] <TB2> INFO: Write out Hit Distr_C1_V0
[16:06:37.470] <TB2> INFO: Write out Hit Distr_C1_V0
[16:06:37.470] <TB2> INFO: Write out CalDel Scan_C2_V0
[16:06:37.470] <TB2> INFO: Write out PixelHit_C2_V0
[16:06:37.470] <TB2> INFO: Write out BB4MapBest_C2_V0
[16:06:37.470] <TB2> INFO: Write out NoiseScan_C2_V0
[16:06:37.471] <TB2> INFO: Write out BB4Map_C2_V13
[16:06:37.471] <TB2> INFO: Write out Hit Distr_C2_V0
[16:06:37.471] <TB2> INFO: Write out Hit Distr_C2_V0
[16:06:37.471] <TB2> INFO: Write out CalDel Scan_C3_V0
[16:06:37.471] <TB2> INFO: Write out PixelHit_C3_V0
[16:06:37.471] <TB2> INFO: Write out BB4MapBest_C3_V0
[16:06:37.471] <TB2> INFO: Write out NoiseScan_C3_V0
[16:06:37.471] <TB2> INFO: Write out BB4Map_C3_V13
[16:06:37.471] <TB2> INFO: Write out Hit Distr_C3_V0
[16:06:37.471] <TB2> INFO: Write out Hit Distr_C3_V0
[16:06:37.471] <TB2> INFO: Write out CalDel Scan_C4_V0
[16:06:37.472] <TB2> INFO: Write out PixelHit_C4_V0
[16:06:37.472] <TB2> INFO: Write out BB4MapBest_C4_V0
[16:06:37.472] <TB2> INFO: Write out NoiseScan_C4_V0
[16:06:37.472] <TB2> INFO: Write out BB4Map_C4_V13
[16:06:37.472] <TB2> INFO: Write out Hit Distr_C4_V0
[16:06:37.472] <TB2> INFO: Write out Hit Distr_C4_V0
[16:06:37.472] <TB2> INFO: Write out CalDel Scan_C5_V0
[16:06:37.472] <TB2> INFO: Write out PixelHit_C5_V0
[16:06:37.472] <TB2> INFO: Write out BB4MapBest_C5_V0
[16:06:37.472] <TB2> INFO: Write out NoiseScan_C5_V0
[16:06:37.472] <TB2> INFO: Write out BB4Map_C5_V13
[16:06:37.473] <TB2> INFO: Write out Hit Distr_C5_V0
[16:06:37.473] <TB2> INFO: Write out Hit Distr_C5_V0
[16:06:37.473] <TB2> INFO: Write out CalDel Scan_C6_V0
[16:06:37.473] <TB2> INFO: Write out PixelHit_C6_V0
[16:06:37.473] <TB2> INFO: Write out BB4MapBest_C6_V0
[16:06:37.473] <TB2> INFO: Write out NoiseScan_C6_V0
[16:06:37.473] <TB2> INFO: Write out BB4Map_C6_V13
[16:06:37.473] <TB2> INFO: Write out Hit Distr_C6_V0
[16:06:37.473] <TB2> INFO: Write out Hit Distr_C6_V0
[16:06:37.473] <TB2> INFO: Write out CalDel Scan_C7_V0
[16:06:37.473] <TB2> INFO: Write out PixelHit_C7_V0
[16:06:37.474] <TB2> INFO: Write out BB4MapBest_C7_V0
[16:06:37.474] <TB2> INFO: Write out NoiseScan_C7_V0
[16:06:37.474] <TB2> INFO: Write out BB4Map_C7_V13
[16:06:37.474] <TB2> INFO: Write out Hit Distr_C7_V0
[16:06:37.474] <TB2> INFO: Write out Hit Distr_C7_V0
[16:06:37.474] <TB2> INFO: Write out CalDel Scan_C8_V0
[16:06:37.474] <TB2> INFO: Write out PixelHit_C8_V0
[16:06:37.474] <TB2> INFO: Write out BB4MapBest_C8_V0
[16:06:37.474] <TB2> INFO: Write out NoiseScan_C8_V0
[16:06:37.474] <TB2> INFO: Write out BB4Map_C8_V13
[16:06:37.475] <TB2> INFO: Write out Hit Distr_C8_V0
[16:06:37.475] <TB2> INFO: Write out Hit Distr_C8_V0
[16:06:37.475] <TB2> INFO: Write out CalDel Scan_C9_V0
[16:06:37.475] <TB2> INFO: Write out PixelHit_C9_V0
[16:06:37.475] <TB2> INFO: Write out BB4MapBest_C9_V0
[16:06:37.475] <TB2> INFO: Write out NoiseScan_C9_V0
[16:06:37.475] <TB2> INFO: Write out BB4Map_C9_V13
[16:06:37.475] <TB2> INFO: Write out Hit Distr_C9_V0
[16:06:37.475] <TB2> INFO: Write out Hit Distr_C9_V0
[16:06:37.475] <TB2> INFO: Write out CalDel Scan_C10_V0
[16:06:37.475] <TB2> INFO: Write out PixelHit_C10_V0
[16:06:37.476] <TB2> INFO: Write out BB4MapBest_C10_V0
[16:06:37.476] <TB2> INFO: Write out NoiseScan_C10_V0
[16:06:37.476] <TB2> INFO: Write out BB4Map_C10_V13
[16:06:37.476] <TB2> INFO: Write out Hit Distr_C10_V0
[16:06:37.476] <TB2> INFO: Write out Hit Distr_C10_V0
[16:06:37.476] <TB2> INFO: Write out CalDel Scan_C11_V0
[16:06:37.476] <TB2> INFO: Write out PixelHit_C11_V0
[16:06:37.476] <TB2> INFO: Write out BB4MapBest_C11_V0
[16:06:37.476] <TB2> INFO: Write out NoiseScan_C11_V0
[16:06:37.476] <TB2> INFO: Write out BB4Map_C11_V13
[16:06:37.477] <TB2> INFO: Write out Hit Distr_C11_V0
[16:06:37.477] <TB2> INFO: Write out Hit Distr_C11_V0
[16:06:37.477] <TB2> INFO: Write out CalDel Scan_C12_V0
[16:06:37.477] <TB2> INFO: Write out PixelHit_C12_V0
[16:06:37.477] <TB2> INFO: Write out BB4MapBest_C12_V0
[16:06:37.477] <TB2> INFO: Write out NoiseScan_C12_V0
[16:06:37.477] <TB2> INFO: Write out BB4Map_C12_V13
[16:06:37.477] <TB2> INFO: Write out Hit Distr_C12_V0
[16:06:37.477] <TB2> INFO: Write out Hit Distr_C12_V0
[16:06:37.477] <TB2> INFO: Write out CalDel Scan_C13_V0
[16:06:37.477] <TB2> INFO: Write out PixelHit_C13_V0
[16:06:37.478] <TB2> INFO: Write out BB4MapBest_C13_V0
[16:06:37.478] <TB2> INFO: Write out NoiseScan_C13_V0
[16:06:37.478] <TB2> INFO: Write out BB4Map_C13_V13
[16:06:37.478] <TB2> INFO: Write out Hit Distr_C13_V0
[16:06:37.478] <TB2> INFO: Write out Hit Distr_C13_V0
[16:06:37.478] <TB2> INFO: Write out CalDel Scan_C14_V0
[16:06:37.478] <TB2> INFO: Write out PixelHit_C14_V0
[16:06:37.478] <TB2> INFO: Write out BB4MapBest_C14_V0
[16:06:37.478] <TB2> INFO: Write out NoiseScan_C14_V0
[16:06:37.478] <TB2> INFO: Write out BB4Map_C14_V13
[16:06:37.479] <TB2> INFO: Write out Hit Distr_C14_V0
[16:06:37.479] <TB2> INFO: Write out Hit Distr_C14_V0
[16:06:37.479] <TB2> INFO: Write out CalDel Scan_C15_V0
[16:06:37.479] <TB2> INFO: Write out PixelHit_C15_V0
[16:06:37.479] <TB2> INFO: Write out BB4MapBest_C15_V0
[16:06:37.479] <TB2> INFO: Write out NoiseScan_C15_V0
[16:06:37.479] <TB2> INFO: Write out BB4Map_C15_V13
[16:06:37.479] <TB2> INFO: Write out Hit Distr_C15_V0
[16:06:37.479] <TB2> INFO: Write out Hit Distr_C15_V0
[16:06:37.479] <TB2> INFO: enter test to run
[16:06:37.479] <TB2> INFO: test: no parameter change
[16:06:37.507] <TB2> QUIET: Connection to board 149 closed.
[16:06:37.587] <TB2> INFO: pXar: this is the end, my friend