[16:18:51.188] <TB3> INFO: *** Welcome to pxar ***
[16:18:51.188] <TB3> INFO: *** Today: 2016/07/14
[16:18:51.241] <TB3> INFO: *** Version: f5d3-dirty
[16:18:51.241] <TB3> INFO: readRocDacs: /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C0.dat .. /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C15.dat
[16:18:51.260] <TB3> INFO: readTbmDacs: /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//tbmParameters_C0a.dat .. /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//tbmParameters_C0b.dat
[16:18:51.263] <TB3> INFO: readMaskFile: /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//defaultMaskFile.dat
[16:18:51.264] <TB3> INFO: readTrimFile: /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//trimParameters_C0.dat .. /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//trimParameters_C15.dat
[16:18:51.383] <TB3> INFO: clk: 4
[16:18:51.383] <TB3> INFO: ctr: 4
[16:18:51.383] <TB3> INFO: sda: 19
[16:18:51.383] <TB3> INFO: tin: 9
[16:18:51.383] <TB3> INFO: level: 15
[16:18:51.383] <TB3> INFO: triggerdelay: 0
[16:18:51.383] <TB3> QUIET: Instanciating API for pxar v2.7.5+40~g4fce89b
[16:18:51.383] <TB3> INFO: Log level: INFO
[16:18:51.390] <TB3> INFO: Found DTB DTB_WWVASW
[16:18:51.398] <TB3> QUIET: Connection to board DTB_WWVASW opened.
[16:18:51.400] <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:
------------------------------------------------------
[16:18:51.402] <TB3> INFO: RPC call hashes of host and DTB match: 484264910
[16:18:52.929] <TB3> INFO: DUT info:
[16:18:52.929] <TB3> INFO: The DUT currently contains the following objects:
[16:18:52.929] <TB3> INFO: 2 TBM Cores tbm08c (2 ON)
[16:18:52.929] <TB3> INFO: TBM Core alpha (0): 7 registers set
[16:18:52.929] <TB3> INFO: TBM Core beta (1): 7 registers set
[16:18:52.929] <TB3> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[16:18:52.929] <TB3> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.929] <TB3> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.930] <TB3> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.930] <TB3> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.930] <TB3> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.930] <TB3> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:52.930] <TB3> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[16:18:53.332] <TB3> INFO: enter 'restricted' command line mode
[16:18:53.332] <TB3> INFO: enter test to run
[16:18:53.332] <TB3> INFO: test: pretest no parameter change
[16:18:53.332] <TB3> INFO: running: pretest
[16:18:53.339] <TB3> INFO: ----------------------------------------------------------------------
[16:18:53.339] <TB3> INFO: PixTestPretest::programROC()
[16:18:53.339] <TB3> INFO: ----------------------------------------------------------------------
[16:19:11.357] <TB3> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[16:19:11.357] <TB3> INFO: IA differences per ROC: 18.5 19.3 19.3 20.9 19.3 18.5 20.1 19.3 19.3 20.1 20.1 17.7 20.1 20.1 17.7 17.7
[16:19:11.477] <TB3> INFO: enter test to run
[16:19:11.477] <TB3> INFO: test: pretest no parameter change
[16:19:11.477] <TB3> INFO: running: pretest
[16:19:11.478] <TB3> INFO: ----------------------------------------------------------------------
[16:19:11.478] <TB3> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[16:19:11.478] <TB3> INFO: ----------------------------------------------------------------------
[16:19:32.790] <TB3> INFO: PixTestPretest::setVana() done, Module Ia 396.3 mA = 24.7688 mA/ROC
[16:19:32.790] <TB3> INFO: i(loss) [mA/ROC]: 20.9 20.9 20.9 20.1 20.1 20.1 20.1 20.9 20.1 20.9 20.9 20.1 20.1 20.9 20.1 20.1
[16:19:32.838] <TB3> INFO: enter test to run
[16:19:32.838] <TB3> INFO: test: pretest no parameter change
[16:19:32.838] <TB3> INFO: running: pretest
[16:19:32.839] <TB3> INFO: ----------------------------------------------------------------------
[16:19:32.839] <TB3> INFO: PixTestPretest::findTiming()
[16:19:32.839] <TB3> INFO: ----------------------------------------------------------------------
[16:19:32.839] <TB3> INFO: PixTestCmd::init()
[16:19:33.640] <TB3> WARNING: Not unmasking DUT, not setting Calibrate bits!
[16:20:32.928] <TB3> INFO: TBM phases: 160MHz: 7, 400MHz: 2, TBM delays: ROC(0/1):4, header/trailer: 1, token: 1
[16:20:32.928] <TB3> INFO: (success/tries = 100/100), width = 4
[16:20:32.929] <TB3> INFO: enter test to run
[16:20:32.930] <TB3> INFO: test: pretest no parameter change
[16:20:32.930] <TB3> INFO: running: pretest
[16:20:32.931] <TB3> INFO: ----------------------------------------------------------------------
[16:20:32.931] <TB3> INFO: PixTestPretest::findWorkingPixel()
[16:20:32.931] <TB3> INFO: ----------------------------------------------------------------------
[16:20:33.026] <TB3> INFO: Expecting 231680 events.
[16:20:38.705] <TB3> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"
[16:20:42.034] <TB3> INFO: 231680 events read in total (8452ms).
[16:20:42.039] <TB3> INFO: Test took 9102ms.
[16:20:42.336] <TB3> INFO: Found working pixel in all ROCs: col/row = 12/22
[16:20:42.417] <TB3> INFO: enter test to run
[16:20:42.417] <TB3> INFO: test: pretest no parameter change
[16:20:42.417] <TB3> INFO: running: pretest
[16:20:42.419] <TB3> INFO: ----------------------------------------------------------------------
[16:20:42.419] <TB3> INFO: PixTestPretest::setVthrCompCalDel()
[16:20:42.419] <TB3> INFO: ----------------------------------------------------------------------
[16:20:42.515] <TB3> INFO: Expecting 231680 events.
[16:20:51.580] <TB3> INFO: 231680 events read in total (8509ms).
[16:20:51.584] <TB3> INFO: Test took 9159ms.
[16:20:51.908] <TB3> INFO: PixTestPretest::setVthrCompCalDel() done
[16:20:51.908] <TB3> INFO: CalDel: 138 128 143 143 123 114 116 112 133 116 114 109 123 112 100 107
[16:20:51.908] <TB3> INFO: VthrComp: 51 51 51 51 51 51 51 52 51 51 51 51 51 52 51 51
[16:20:51.942] <TB3> INFO: enter test to run
[16:20:51.942] <TB3> INFO: test: pretest no parameter change
[16:20:51.942] <TB3> INFO: running: pretest
[16:20:51.947] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C0.dat
[16:20:51.952] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C1.dat
[16:20:51.957] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C2.dat
[16:20:51.962] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C3.dat
[16:20:51.967] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C4.dat
[16:20:51.972] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C5.dat
[16:20:51.977] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C6.dat
[16:20:51.982] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C7.dat
[16:20:51.987] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C8.dat
[16:20:51.992] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C9.dat
[16:20:51.997] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C10.dat
[16:20:52.002] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C11.dat
[16:20:52.007] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C12.dat
[16:20:52.012] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C13.dat
[16:20:52.017] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C14.dat
[16:20:52.022] <TB3> INFO: write dac parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//dacParameters_C15.dat
[16:20:52.025] <TB3> INFO: enter test to run
[16:20:52.025] <TB3> INFO: test: PixelAlive no parameter change
[16:20:52.025] <TB3> INFO: running: pixelalive
[16:20:52.026] <TB3> INFO: ######################################################################
[16:20:52.026] <TB3> INFO: PixTestAlive::doTest()
[16:20:52.026] <TB3> INFO: ######################################################################
[16:20:52.027] <TB3> INFO: ----------------------------------------------------------------------
[16:20:52.027] <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)
[16:20:52.027] <TB3> INFO: ----------------------------------------------------------------------
[16:20:52.294] <TB3> INFO: Expecting 41600 events.
[16:20:55.716] <TB3> INFO: 41600 events read in total (2866ms).
[16:20:55.717] <TB3> INFO: Test took 3688ms.
[16:20:56.026] <TB3> INFO: PixTestAlive::aliveTest() done
[16:20:56.026] <TB3> INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 1 1 0 0 0 0 0 0 0
[16:20:56.028] <TB3> INFO: ----------------------------------------------------------------------
[16:20:56.028] <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)
[16:20:56.028] <TB3> INFO: ----------------------------------------------------------------------
[16:20:56.295] <TB3> INFO: Expecting 41600 events.
[16:20:58.896] <TB3> INFO: 41600 events read in total (2045ms).
[16:20:58.896] <TB3> INFO: Test took 2866ms.
[16:20:58.897] <TB3> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[16:20:59.221] <TB3> INFO: PixTestAlive::maskTest() done
[16:20:59.221] <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
[16:20:59.222] <TB3> INFO: ----------------------------------------------------------------------
[16:20:59.222] <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)
[16:20:59.222] <TB3> INFO: ----------------------------------------------------------------------
[16:20:59.490] <TB3> INFO: Expecting 41600 events.
[16:21:02.902] <TB3> INFO: 41600 events read in total (2857ms).
[16:21:02.902] <TB3> INFO: Test took 3677ms.
[16:21:03.213] <TB3> INFO: PixTestAlive::addressDecodingTest() done
[16:21:03.213] <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
[16:21:03.213] <TB3> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[16:21:03.220] <TB3> INFO: enter test to run
[16:21:03.220] <TB3> INFO: test: BB no parameter change
[16:21:03.220] <TB3> INFO: running: bb
[16:21:03.221] <TB3> INFO: ######################################################################
[16:21:03.221] <TB3> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[16:21:03.221] <TB3> INFO: ######################################################################
[16:21:03.225] <TB3> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[16:21:03.241] <TB3> INFO: dacScan split into 1 runs with ntrig = 5
[16:21:03.241] <TB3> INFO: run 1 of 1
[16:21:03.509] <TB3> INFO: Expecting 3120000 events.
[16:21:47.709] <TB3> INFO: 1125125 events read in total (43644ms).
[16:22:30.532] <TB3> INFO: 2225595 events read in total (86467ms).
[16:23:05.606] <TB3> INFO: 3120000 events read in total (121542ms).
[16:23:05.652] <TB3> INFO: Test took 122411ms.
[16:23:28.545] <TB3> INFO: PixTestBBMap::doTest() done, duration: 145 seconds
[16:23:28.545] <TB3> INFO: number of dead bumps (per ROC): 0 0 0 0 0 0 0 1 0 0 0 0 0 0 0 0
[16:23:28.545] <TB3> INFO: separation cut (per ROC): 123 117 110 105 107 109 111 111 131 115 117 103 108 126 119 126
[16:23:28.614] <TB3> INFO: enter test to run
[16:23:28.614] <TB3> INFO: test: Readback no parameter change
[16:23:28.614] <TB3> INFO: running: readback
[16:23:28.614] <TB3> INFO: readReadbackCal: /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C0.dat .. /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C15.dat
[16:23:28.630] <TB3> INFO: readGainPedestalParameters /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//phCalibrationFitErr_C0.dat .. /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//phCalibrationFitErr_C15.dat
[16:23:28.631] <TB3> ERROR: <ConfigParameters.cc/readGainPedestalParameters:L996> cannot open /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//phCalibrationFitErr_C0.dat for reading PH calibration constants
[16:23:28.631] <TB3> INFO: ######################################################################
[16:23:28.631] <TB3> INFO: PixTestReadback::doTest()
[16:23:28.631] <TB3> INFO: ######################################################################
[16:23:28.631] <TB3> INFO: ----------------------------------------------------------------------
[16:23:28.631] <TB3> INFO: PixTestReadback::CalibrateVd()
[16:23:28.631] <TB3> INFO: ----------------------------------------------------------------------
[16:23:37.963] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C0.dat
[16:23:37.968] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C1.dat
[16:23:37.973] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C2.dat
[16:23:37.978] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C3.dat
[16:23:37.983] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C4.dat
[16:23:37.988] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C5.dat
[16:23:37.993] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C6.dat
[16:23:37.998] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C7.dat
[16:23:38.003] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C8.dat
[16:23:38.009] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C9.dat
[16:23:38.014] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C10.dat
[16:23:38.019] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C11.dat
[16:23:38.024] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C12.dat
[16:23:38.030] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C13.dat
[16:23:38.035] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C14.dat
[16:23:38.040] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C15.dat
[16:23:38.089] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[16:23:38.090] <TB3> INFO: ----------------------------------------------------------------------
[16:23:38.090] <TB3> INFO: PixTestReadback::CalibrateVa()
[16:23:38.090] <TB3> INFO: ----------------------------------------------------------------------
[16:23:47.457] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C0.dat
[16:23:47.465] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C1.dat
[16:23:47.470] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C2.dat
[16:23:47.477] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C3.dat
[16:23:47.482] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C4.dat
[16:23:47.487] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C5.dat
[16:23:47.495] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C6.dat
[16:23:47.500] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C7.dat
[16:23:47.507] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C8.dat
[16:23:47.515] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C9.dat
[16:23:47.520] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C10.dat
[16:23:47.527] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C11.dat
[16:23:47.532] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C12.dat
[16:23:47.537] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C13.dat
[16:23:47.542] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C14.dat
[16:23:47.548] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C15.dat
[16:23:47.599] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[16:23:47.599] <TB3> INFO: ----------------------------------------------------------------------
[16:23:47.599] <TB3> INFO: PixTestReadback::readbackVbg()
[16:23:47.599] <TB3> INFO: ----------------------------------------------------------------------
[16:23:54.778] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[16:23:54.779] <TB3> INFO: ----------------------------------------------------------------------
[16:23:54.779] <TB3> INFO: PixTestReadback::getCalibratedVbg()
[16:23:54.779] <TB3> INFO: ----------------------------------------------------------------------
[16:23:54.779] <TB3> INFO: Vbg will be calibrated using Vd calibration
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 155.3calibrated Vbg = 1.24927 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 143.2calibrated Vbg = 1.23867 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 150.3calibrated Vbg = 1.24879 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 153.5calibrated Vbg = 1.25588 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 155.3calibrated Vbg = 1.26103 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 145.5calibrated Vbg = 1.25503 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 157.9calibrated Vbg = 1.25038 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 144.4calibrated Vbg = 1.2546 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 157.8calibrated Vbg = 1.26435 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 154.1calibrated Vbg = 1.25883 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 150.2calibrated Vbg = 1.25463 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 146calibrated Vbg = 1.24747 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 143calibrated Vbg = 1.24212 :::*/*/*/*/
[16:23:54.779] <TB3> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 145.9calibrated Vbg = 1.23949 :::*/*/*/*/
[16:23:54.780] <TB3> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 155.4calibrated Vbg = 1.24406 :::*/*/*/*/
[16:23:54.780] <TB3> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 154.1calibrated Vbg = 1.24518 :::*/*/*/*/
[16:23:54.783] <TB3> INFO: ----------------------------------------------------------------------
[16:23:54.783] <TB3> INFO: PixTestReadback::CalibrateIa()
[16:23:54.783] <TB3> INFO: ----------------------------------------------------------------------
[16:26:27.951] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C0.dat
[16:26:27.957] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C1.dat
[16:26:27.962] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C2.dat
[16:26:27.967] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C3.dat
[16:26:27.972] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C4.dat
[16:26:27.977] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C5.dat
[16:26:27.983] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C6.dat
[16:26:27.988] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C7.dat
[16:26:27.993] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C8.dat
[16:26:27.998] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C9.dat
[16:26:28.003] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C10.dat
[16:26:28.008] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C11.dat
[16:26:28.013] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C12.dat
[16:26:28.019] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C13.dat
[16:26:28.024] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C14.dat
[16:26:28.029] <TB3> INFO: write readback calibration parameters into /home/Reception/DATA/KITAACHEN/M4807_Reception_2016-07-14_18h13m_1468512816//000_ReceptionTestBB4_p17//readbackCal_C15.dat
[16:26:28.077] <TB3> INFO: PixTestPattern:: pg_setup set to default.
[16:26:28.079] <TB3> INFO: PixTestReadback::doTest() done
[16:26:28.100] <TB3> INFO: enter test to run
[16:26:28.100] <TB3> INFO: test: BB4 no parameter change
[16:26:28.100] <TB3> INFO: running: bb4
[16:26:28.100] <TB3> INFO: PixTestBB4Map::doTest() ntrig = 100
[16:26:28.100] <TB3> INFO: VthrComp (min,max,step) = 70 130 5
[16:26:28.100] <TB3> INFO: CalDel (min,max,step) = 80 200 10
[16:26:28.100] <TB3> INFO: Vcal = 255
[16:26:28.100] <TB3> INFO: Cut = 0.5
[16:26:28.100] <TB3> INFO: flag 2
[16:26:28.102] <TB3> INFO: CtrlReg 4 (large Vcal)
[16:26:28.102] <TB3> INFO: saving VthrComp and CalDel before running tests)
[16:26:28.102] <TB3> INFO: 0 130 0
[16:26:28.102] <TB3> INFO: 1 130 0
[16:26:28.102] <TB3> INFO: 2 130 0
[16:26:28.102] <TB3> INFO: 3 130 0
[16:26:28.102] <TB3> INFO: 4 130 0
[16:26:28.102] <TB3> INFO: 5 130 0
[16:26:28.102] <TB3> INFO: 6 130 0
[16:26:28.102] <TB3> INFO: 7 130 0
[16:26:28.102] <TB3> INFO: 8 130 0
[16:26:28.102] <TB3> INFO: 9 130 0
[16:26:28.102] <TB3> INFO: 10 130 0
[16:26:28.102] <TB3> INFO: 11 130 0
[16:26:28.102] <TB3> INFO: 12 130 0
[16:26:28.102] <TB3> INFO: 13 130 0
[16:26:28.102] <TB3> INFO: 14 130 0
[16:26:28.102] <TB3> INFO: 15 130 0
[16:26:28.366] <TB3> INFO: Expecting 416000 events.
[16:26:33.016] <TB3> ERROR: <datapipe.cc/CheckEventValidity:L507> Channel 0 Number of ROCs (0) != Token Chain Length (8)
[16:26:33.044] <TB3> ERROR: <datapipe.cc/CheckEventID:L469> Channel 0 Event ID mismatch: local ID (16) != TBM ID (2)
[16:26:37.668] <TB3> INFO: 416000 events read in total (8746ms).
[16:26:37.669] <TB3> INFO: Test took 9561ms.
[16:26:37.669] <TB3> INFO: starting loop over VthrComp
[16:26:38.208] <TB3> INFO: Expecting 416000 events.
[16:26:47.562] <TB3> INFO: 416000 events read in total (8798ms).
[16:26:47.563] <TB3> INFO: Test took 9619ms.
[16:26:47.563] <TB3> INFO: got noisemap
[16:26:47.838] <TB3> INFO: ROC 0, integral 0
[16:26:47.838] <TB3> INFO: ROC 1, integral 0
[16:26:47.838] <TB3> INFO: ROC 2, integral 0
[16:26:47.838] <TB3> INFO: ROC 3, integral 0
[16:26:47.838] <TB3> INFO: ROC 4, integral 0
[16:26:47.838] <TB3> INFO: ROC 5, integral 0
[16:26:47.838] <TB3> INFO: ROC 6, integral 0
[16:26:47.838] <TB3> INFO: ROC 7, integral 0
[16:26:47.838] <TB3> INFO: ROC 8, integral 0
[16:26:47.838] <TB3> INFO: ROC 9, integral 0
[16:26:47.838] <TB3> INFO: ROC 10, integral 0
[16:26:47.839] <TB3> INFO: ROC 11, integral 0
[16:26:47.839] <TB3> INFO: ROC 12, integral 0
[16:26:47.839] <TB3> INFO: ROC 13, integral 0
[16:26:47.839] <TB3> INFO: ROC 14, integral 0
[16:26:47.839] <TB3> INFO: ROC 15, integral 0
[16:26:47.839] <TB3> INFO: VthrComp = 70 done
[16:26:48.131] <TB3> INFO: Expecting 416000 events.
[16:26:57.443] <TB3> INFO: 416000 events read in total (8756ms).
[16:26:57.444] <TB3> INFO: Test took 9601ms.
[16:26:57.444] <TB3> INFO: got noisemap
[16:26:57.719] <TB3> INFO: ROC 0, integral 0
[16:26:57.719] <TB3> INFO: ROC 1, integral 0
[16:26:57.719] <TB3> INFO: ROC 2, integral 0
[16:26:57.719] <TB3> INFO: ROC 3, integral 0
[16:26:57.719] <TB3> INFO: ROC 4, integral 0
[16:26:57.719] <TB3> INFO: ROC 5, integral 0
[16:26:57.719] <TB3> INFO: ROC 6, integral 0
[16:26:57.719] <TB3> INFO: ROC 7, integral 0
[16:26:57.719] <TB3> INFO: ROC 8, integral 0
[16:26:57.719] <TB3> INFO: ROC 9, integral 0
[16:26:57.719] <TB3> INFO: ROC 10, integral 0
[16:26:57.719] <TB3> INFO: ROC 11, integral 0
[16:26:57.719] <TB3> INFO: ROC 12, integral 0
[16:26:57.720] <TB3> INFO: ROC 13, integral 0
[16:26:57.720] <TB3> INFO: ROC 14, integral 0
[16:26:57.720] <TB3> INFO: ROC 15, integral 0
[16:26:57.720] <TB3> INFO: VthrComp = 75 done
[16:26:57.985] <TB3> INFO: Expecting 416000 events.
[16:27:07.364] <TB3> INFO: 416000 events read in total (8823ms).
[16:27:07.365] <TB3> INFO: Test took 9641ms.
[16:27:07.365] <TB3> INFO: got noisemap
[16:27:07.641] <TB3> INFO: ROC 0, integral 0
[16:27:07.641] <TB3> INFO: ROC 1, integral 0
[16:27:07.641] <TB3> INFO: ROC 2, integral 0
[16:27:07.641] <TB3> INFO: ROC 3, integral 0
[16:27:07.641] <TB3> INFO: ROC 4, integral 0
[16:27:07.641] <TB3> INFO: ROC 5, integral 0
[16:27:07.641] <TB3> INFO: ROC 6, integral 0
[16:27:07.641] <TB3> INFO: ROC 7, integral 0
[16:27:07.641] <TB3> INFO: ROC 8, integral 0
[16:27:07.641] <TB3> INFO: ROC 9, integral 0
[16:27:07.641] <TB3> INFO: ROC 10, integral 0
[16:27:07.641] <TB3> INFO: ROC 11, integral 0
[16:27:07.641] <TB3> INFO: ROC 12, integral 0
[16:27:07.641] <TB3> INFO: ROC 13, integral 0
[16:27:07.641] <TB3> INFO: ROC 14, integral 0
[16:27:07.641] <TB3> INFO: ROC 15, integral 0
[16:27:07.641] <TB3> INFO: VthrComp = 80 done
[16:27:07.910] <TB3> INFO: Expecting 416000 events.
[16:27:17.359] <TB3> INFO: 416000 events read in total (8893ms).
[16:27:17.360] <TB3> INFO: Test took 9715ms.
[16:27:17.360] <TB3> INFO: got noisemap
[16:27:17.632] <TB3> INFO: ROC 0, integral 0
[16:27:17.632] <TB3> INFO: ROC 1, integral 0
[16:27:17.632] <TB3> INFO: ROC 2, integral 0
[16:27:17.632] <TB3> INFO: ROC 3, integral 0
[16:27:17.633] <TB3> INFO: ROC 4, integral 0
[16:27:17.633] <TB3> INFO: ROC 5, integral 0
[16:27:17.633] <TB3> INFO: ROC 6, integral 0
[16:27:17.633] <TB3> INFO: ROC 7, integral 0
[16:27:17.633] <TB3> INFO: ROC 8, integral 0
[16:27:17.633] <TB3> INFO: ROC 9, integral 0
[16:27:17.633] <TB3> INFO: ROC 10, integral 0
[16:27:17.634] <TB3> INFO: ROC 11, integral 0
[16:27:17.634] <TB3> INFO: ROC 12, integral 0
[16:27:17.634] <TB3> INFO: ROC 13, integral 0
[16:27:17.634] <TB3> INFO: ROC 14, integral 0
[16:27:17.634] <TB3> INFO: ROC 15, integral 0
[16:27:17.634] <TB3> INFO: VthrComp = 85 done
[16:27:17.908] <TB3> INFO: Expecting 416000 events.
[16:27:27.269] <TB3> INFO: 416000 events read in total (8805ms).
[16:27:27.269] <TB3> INFO: Test took 9630ms.
[16:27:27.270] <TB3> INFO: got noisemap
[16:27:27.541] <TB3> INFO: ROC 0, integral 0
[16:27:27.541] <TB3> INFO: ROC 1, integral 0
[16:27:27.541] <TB3> INFO: ROC 2, integral 0
[16:27:27.541] <TB3> INFO: ROC 3, integral 0
[16:27:27.541] <TB3> INFO: ROC 4, integral 0
[16:27:27.542] <TB3> INFO: ROC 5, integral 0
[16:27:27.542] <TB3> INFO: ROC 6, integral 0
[16:27:27.542] <TB3> INFO: ROC 7, integral 0
[16:27:27.542] <TB3> INFO: ROC 8, integral 0
[16:27:27.542] <TB3> INFO: ROC 9, integral 0
[16:27:27.542] <TB3> INFO: ROC 10, integral 0
[16:27:27.543] <TB3> INFO: ROC 11, integral 0
[16:27:27.543] <TB3> INFO: ROC 12, integral 0
[16:27:27.543] <TB3> INFO: ROC 13, integral 0
[16:27:27.543] <TB3> INFO: ROC 14, integral 0
[16:27:27.543] <TB3> INFO: ROC 15, integral 0
[16:27:27.543] <TB3> INFO: VthrComp = 90 done
[16:27:27.841] <TB3> INFO: Expecting 416000 events.
[16:27:37.378] <TB3> INFO: 416000 events read in total (8981ms).
[16:27:37.380] <TB3> INFO: Test took 9832ms.
[16:27:37.381] <TB3> INFO: got noisemap
[16:27:37.651] <TB3> INFO: ROC 0, integral 0
[16:27:37.651] <TB3> INFO: ROC 1, integral 0
[16:27:37.651] <TB3> INFO: ROC 2, integral 0
[16:27:37.651] <TB3> INFO: ROC 3, integral 0
[16:27:37.651] <TB3> INFO: ROC 4, integral 0
[16:27:37.651] <TB3> INFO: ROC 5, integral 0
[16:27:37.652] <TB3> INFO: ROC 6, integral 0
[16:27:37.652] <TB3> INFO: ROC 7, integral 0
[16:27:37.652] <TB3> INFO: ROC 8, integral 0
[16:27:37.652] <TB3> INFO: ROC 9, integral 0
[16:27:37.652] <TB3> INFO: ROC 10, integral 0
[16:27:37.653] <TB3> INFO: ROC 11, integral 0
[16:27:37.653] <TB3> INFO: ROC 12, integral 0
[16:27:37.653] <TB3> INFO: ROC 13, integral 0
[16:27:37.653] <TB3> INFO: ROC 14, integral 0
[16:27:37.653] <TB3> INFO: ROC 15, integral 0
[16:27:37.653] <TB3> INFO: VthrComp = 95 done
[16:27:37.937] <TB3> INFO: Expecting 416000 events.
[16:27:47.538] <TB3> INFO: 416000 events read in total (9045ms).
[16:27:47.540] <TB3> INFO: Test took 9882ms.
[16:27:47.540] <TB3> INFO: got noisemap
[16:27:47.810] <TB3> INFO: ROC 0, integral 0
[16:27:47.810] <TB3> INFO: ROC 1, integral 0
[16:27:47.810] <TB3> INFO: ROC 2, integral 0
[16:27:47.810] <TB3> INFO: ROC 3, integral 0
[16:27:47.810] <TB3> INFO: ROC 4, integral 0
[16:27:47.810] <TB3> INFO: ROC 5, integral 0
[16:27:47.811] <TB3> INFO: ROC 6, integral 0
[16:27:47.811] <TB3> INFO: ROC 7, integral 0
[16:27:47.811] <TB3> INFO: ROC 8, integral 0
[16:27:47.811] <TB3> INFO: ROC 9, integral 0
[16:27:47.811] <TB3> INFO: ROC 10, integral 0
[16:27:47.811] <TB3> INFO: ROC 11, integral 0
[16:27:47.811] <TB3> INFO: ROC 12, integral 0
[16:27:47.812] <TB3> INFO: ROC 13, integral 0
[16:27:47.812] <TB3> INFO: ROC 14, integral 0
[16:27:47.812] <TB3> INFO: ROC 15, integral 0
[16:27:47.812] <TB3> INFO: VthrComp = 100 done
[16:27:48.090] <TB3> INFO: Expecting 416000 events.
[16:27:57.608] <TB3> INFO: 416000 events read in total (8962ms).
[16:27:57.610] <TB3> INFO: Test took 9793ms.
[16:27:57.610] <TB3> INFO: got noisemap
[16:27:57.881] <TB3> INFO: ROC 0, integral 0
[16:27:57.881] <TB3> INFO: ROC 1, integral 0
[16:27:57.881] <TB3> INFO: ROC 2, integral 0
[16:27:57.882] <TB3> INFO: ROC 3, integral 0
[16:27:57.882] <TB3> INFO: ROC 4, integral 0
[16:27:57.882] <TB3> INFO: ROC 5, integral 0
[16:27:57.882] <TB3> INFO: ROC 6, integral 0
[16:27:57.882] <TB3> INFO: ROC 7, integral 0
[16:27:57.882] <TB3> INFO: ROC 8, integral 0
[16:27:57.882] <TB3> INFO: ROC 9, integral 0
[16:27:57.883] <TB3> INFO: ROC 10, integral 0
[16:27:57.883] <TB3> INFO: ROC 11, integral 0
[16:27:57.883] <TB3> INFO: ROC 12, integral 0
[16:27:57.883] <TB3> INFO: ROC 13, integral 0
[16:27:57.883] <TB3> INFO: ROC 14, integral 0
[16:27:57.883] <TB3> INFO: ROC 15, integral 0
[16:27:57.883] <TB3> INFO: VthrComp = 105 done
[16:27:58.161] <TB3> INFO: Expecting 416000 events.
[16:28:07.585] <TB3> INFO: 416000 events read in total (8868ms).
[16:28:07.586] <TB3> INFO: Test took 9698ms.
[16:28:07.586] <TB3> INFO: got noisemap
[16:28:07.861] <TB3> INFO: ROC 0, integral 1
[16:28:07.861] <TB3> INFO: ROC 1, integral 0
[16:28:07.862] <TB3> INFO: ROC 2, integral 0
[16:28:07.862] <TB3> INFO: ROC 3, integral 0
[16:28:07.862] <TB3> INFO: ROC 4, integral 0
[16:28:07.862] <TB3> INFO: ROC 5, integral 1
[16:28:07.862] <TB3> INFO: ROC 6, integral 0
[16:28:07.862] <TB3> INFO: ROC 7, integral 0
[16:28:07.863] <TB3> INFO: ROC 8, integral 0
[16:28:07.863] <TB3> INFO: ROC 9, integral 0
[16:28:07.863] <TB3> INFO: ROC 10, integral 0
[16:28:07.863] <TB3> INFO: ROC 11, integral 0
[16:28:07.863] <TB3> INFO: ROC 12, integral 0
[16:28:07.863] <TB3> INFO: ROC 13, integral 0
[16:28:07.863] <TB3> INFO: ROC 14, integral 0
[16:28:07.864] <TB3> INFO: ROC 15, integral 0
[16:28:07.864] <TB3> INFO: VthrComp = 110 done
[16:28:08.134] <TB3> INFO: Expecting 416000 events.
[16:28:17.640] <TB3> INFO: 416000 events read in total (8950ms).
[16:28:17.642] <TB3> INFO: Test took 9773ms.
[16:28:17.643] <TB3> INFO: got noisemap
[16:28:17.911] <TB3> INFO: ROC 0, integral 11
[16:28:17.912] <TB3> INFO: ROC #0: threshold found
[16:28:17.912] <TB3> INFO: ROC 1, integral 0
[16:28:17.912] <TB3> INFO: ROC 2, integral 0
[16:28:17.912] <TB3> INFO: ROC 3, integral 1
[16:28:17.912] <TB3> INFO: ROC 4, integral 1
[16:28:17.912] <TB3> INFO: ROC 5, integral 19
[16:28:17.912] <TB3> INFO: ROC #5: threshold found
[16:28:17.913] <TB3> INFO: ROC 6, integral 6
[16:28:17.913] <TB3> INFO: ROC 7, integral 1
[16:28:17.913] <TB3> INFO: ROC 8, integral 0
[16:28:17.913] <TB3> INFO: ROC 9, integral 0
[16:28:17.913] <TB3> INFO: ROC 10, integral 0
[16:28:17.914] <TB3> INFO: ROC 11, integral 0
[16:28:17.914] <TB3> INFO: ROC 12, integral 1
[16:28:17.914] <TB3> INFO: ROC 13, integral 0
[16:28:17.914] <TB3> INFO: ROC 14, integral 0
[16:28:17.914] <TB3> INFO: ROC 15, integral 0
[16:28:17.915] <TB3> INFO: VthrComp = 115 done
[16:28:18.202] <TB3> INFO: Expecting 416000 events.
[16:28:27.605] <TB3> INFO: 416000 events read in total (8847ms).
[16:28:27.606] <TB3> INFO: Test took 9686ms.
[16:28:27.606] <TB3> INFO: got noisemap
[16:28:27.881] <TB3> INFO: ROC 1, integral 3
[16:28:27.881] <TB3> INFO: ROC 2, integral 1
[16:28:27.881] <TB3> INFO: ROC 3, integral 7
[16:28:27.881] <TB3> INFO: ROC 4, integral 10
[16:28:27.881] <TB3> INFO: ROC #4: threshold found
[16:28:27.881] <TB3> INFO: ROC 6, integral 49
[16:28:27.881] <TB3> INFO: ROC #6: threshold found
[16:28:27.881] <TB3> INFO: ROC 7, integral 0
[16:28:27.881] <TB3> INFO: ROC 8, integral 9
[16:28:27.881] <TB3> INFO: ROC 9, integral 0
[16:28:27.881] <TB3> INFO: ROC 10, integral 0
[16:28:27.882] <TB3> INFO: ROC 11, integral 21
[16:28:27.882] <TB3> INFO: ROC #11: threshold found
[16:28:27.882] <TB3> INFO: ROC 12, integral 8
[16:28:27.882] <TB3> INFO: ROC 13, integral 0
[16:28:27.882] <TB3> INFO: ROC 14, integral 0
[16:28:27.882] <TB3> INFO: ROC 15, integral 2
[16:28:27.882] <TB3> INFO: VthrComp = 120 done
[16:28:28.156] <TB3> INFO: Expecting 416000 events.
[16:28:37.602] <TB3> INFO: 416000 events read in total (8890ms).
[16:28:37.603] <TB3> INFO: Test took 9717ms.
[16:28:37.604] <TB3> INFO: got noisemap
[16:28:37.875] <TB3> INFO: ROC 1, integral 52
[16:28:37.875] <TB3> INFO: ROC #1: threshold found
[16:28:37.875] <TB3> INFO: ROC 2, integral 23
[16:28:37.875] <TB3> INFO: ROC #2: threshold found
[16:28:37.875] <TB3> INFO: ROC 3, integral 92
[16:28:37.875] <TB3> INFO: ROC #3: threshold found
[16:28:37.875] <TB3> INFO: ROC 7, integral 1
[16:28:37.875] <TB3> INFO: ROC 8, integral 87
[16:28:37.875] <TB3> INFO: ROC #8: threshold found
[16:28:37.875] <TB3> INFO: ROC 9, integral 19
[16:28:37.875] <TB3> INFO: ROC #9: threshold found
[16:28:37.875] <TB3> INFO: ROC 10, integral 3
[16:28:37.875] <TB3> INFO: ROC 12, integral 114
[16:28:37.875] <TB3> INFO: ROC #12: threshold found
[16:28:37.875] <TB3> INFO: ROC 13, integral 0
[16:28:37.875] <TB3> INFO: ROC 14, integral 11
[16:28:37.875] <TB3> INFO: ROC #14: threshold found
[16:28:37.875] <TB3> INFO: ROC 15, integral 22
[16:28:37.875] <TB3> INFO: ROC #15: threshold found
[16:28:37.875] <TB3> INFO: VthrComp = 125 done
[16:28:38.141] <TB3> INFO: Expecting 416000 events.
[16:28:47.491] <TB3> INFO: 416000 events read in total (8794ms).
[16:28:47.493] <TB3> INFO: Test took 9614ms.
[16:28:47.495] <TB3> INFO: got noisemap
[16:28:47.760] <TB3> INFO: ROC 7, integral 21
[16:28:47.760] <TB3> INFO: ROC #7: threshold found
[16:28:47.760] <TB3> INFO: ROC 10, integral 53
[16:28:47.761] <TB3> INFO: ROC #10: threshold found
[16:28:47.761] <TB3> INFO: ROC 13, integral 0
[16:28:47.761] <TB3> INFO: VthrComp = 130 done
[16:28:47.763] <TB3> INFO: resulting noise thresholds per ROC = 110 120 120 120 115 110 115 125 120 120 125 115 120 130 120 120
[16:28:47.763] <TB3> INFO: threshold scan done
[16:28:48.056] <TB3> INFO: Expecting 416000 events.
[16:28:58.585] <TB3> INFO: 416000 events read in total (9973ms).
[16:28:58.586] <TB3> INFO: Test took 10815ms.
[16:28:58.812] <TB3> INFO: ROC 0, missing bumps = 4160, total number of good bumps = 0
[16:28:58.813] <TB3> INFO: ROC 1, missing bumps = 4160, total number of good bumps = 0
[16:28:58.814] <TB3> INFO: ROC 2, missing bumps = 4160, total number of good bumps = 0
[16:28:58.815] <TB3> INFO: ROC 3, missing bumps = 4160, total number of good bumps = 0
[16:28:58.817] <TB3> INFO: ROC 4, missing bumps = 4160, total number of good bumps = 0
[16:28:58.818] <TB3> INFO: ROC 5, missing bumps = 3731, total number of good bumps = 429
[16:28:58.819] <TB3> INFO: ROC 6, missing bumps = 3885, total number of good bumps = 275
[16:28:58.821] <TB3> INFO: ROC 7, missing bumps = 4157, total number of good bumps = 3
[16:28:58.822] <TB3> INFO: ROC 8, missing bumps = 4160, total number of good bumps = 0
[16:28:58.824] <TB3> INFO: ROC 9, missing bumps = 4157, total number of good bumps = 3
[16:28:58.825] <TB3> INFO: ROC 10, missing bumps = 4157, total number of good bumps = 3
[16:28:58.826] <TB3> INFO: ROC 11, missing bumps = 1972, total number of good bumps = 2188
[16:28:58.827] <TB3> INFO: ROC 12, missing bumps = 4160, total number of good bumps = 0
[16:28:58.829] <TB3> INFO: ROC 13, missing bumps = 3909, total number of good bumps = 251
[16:28:58.830] <TB3> INFO: ROC 14, missing bumps = 4, total number of good bumps = 4156
[16:28:58.831] <TB3> INFO: ROC 15, missing bumps = 479, total number of good bumps = 3681
[16:28:58.831] <TB3> INFO: CalDel = 80 done
[16:28:59.107] <TB3> INFO: Expecting 416000 events.
[16:29:11.450] <TB3> INFO: 416000 events read in total (11787ms).
[16:29:11.451] <TB3> INFO: Test took 12615ms.
[16:29:11.641] <TB3> INFO: ROC 0, missing bumps = 4156, total number of good bumps = 4
[16:29:11.642] <TB3> INFO: ROC 1, missing bumps = 4156, total number of good bumps = 4
[16:29:11.644] <TB3> INFO: ROC 2, missing bumps = 4160, total number of good bumps = 0
[16:29:11.645] <TB3> INFO: ROC 3, missing bumps = 4160, total number of good bumps = 0
[16:29:11.646] <TB3> INFO: ROC 4, missing bumps = 3422, total number of good bumps = 738
[16:29:11.647] <TB3> INFO: ROC 5, missing bumps = 143, total number of good bumps = 4017
[16:29:11.649] <TB3> INFO: ROC 6, missing bumps = 646, total number of good bumps = 3514
[16:29:11.650] <TB3> INFO: ROC 7, missing bumps = 1906, total number of good bumps = 2254
[16:29:11.652] <TB3> INFO: ROC 8, missing bumps = 4160, total number of good bumps = 0
[16:29:11.653] <TB3> INFO: ROC 9, missing bumps = 2914, total number of good bumps = 1246
[16:29:11.655] <TB3> INFO: ROC 10, missing bumps = 2544, total number of good bumps = 1616
[16:29:11.656] <TB3> INFO: ROC 11, missing bumps = 9, total number of good bumps = 4151
[16:29:11.657] <TB3> INFO: ROC 12, missing bumps = 4008, total number of good bumps = 152
[16:29:11.658] <TB3> INFO: ROC 13, missing bumps = 394, total number of good bumps = 3766
[16:29:11.660] <TB3> INFO: ROC 14, missing bumps = 0, total number of good bumps = 4160
[16:29:11.661] <TB3> INFO: ROC 15, missing bumps = 2, total number of good bumps = 4158
[16:29:11.661] <TB3> INFO: CalDel = 90 done
[16:29:11.937] <TB3> INFO: Expecting 416000 events.
[16:29:26.020] <TB3> INFO: 416000 events read in total (13527ms).
[16:29:26.022] <TB3> INFO: Test took 14357ms.
[16:29:26.188] <TB3> INFO: ROC 0, missing bumps = 3559, total number of good bumps = 601
[16:29:26.190] <TB3> INFO: ROC 1, missing bumps = 3076, total number of good bumps = 1084
[16:29:26.191] <TB3> INFO: ROC 2, missing bumps = 4160, total number of good bumps = 0
[16:29:26.193] <TB3> INFO: ROC 3, missing bumps = 4160, total number of good bumps = 0
[16:29:26.194] <TB3> INFO: ROC 4, missing bumps = 50, total number of good bumps = 4110
[16:29:26.195] <TB3> INFO: ROC 5, missing bumps = 0, total number of good bumps = 4160
[16:29:26.197] <TB3> INFO: ROC 6, missing bumps = 8, total number of good bumps = 4152
[16:29:26.198] <TB3> INFO: ROC 7, missing bumps = 3, total number of good bumps = 4157
[16:29:26.199] <TB3> INFO: ROC 8, missing bumps = 3837, total number of good bumps = 323
[16:29:26.200] <TB3> INFO: ROC 9, missing bumps = 8, total number of good bumps = 4152
[16:29:26.202] <TB3> INFO: ROC 10, missing bumps = 20, total number of good bumps = 4140
[16:29:26.203] <TB3> INFO: ROC 11, missing bumps = 0, total number of good bumps = 4160
[16:29:26.205] <TB3> INFO: ROC 12, missing bumps = 224, total number of good bumps = 3936
[16:29:26.206] <TB3> INFO: ROC 13, missing bumps = 0, total number of good bumps = 4160
[16:29:26.207] <TB3> INFO: ROC 15, missing bumps = 2, total number of good bumps = 4158
[16:29:26.207] <TB3> INFO: CalDel = 100 done
[16:29:26.502] <TB3> INFO: Expecting 416000 events.
[16:29:41.488] <TB3> INFO: 416000 events read in total (14429ms).
[16:29:41.489] <TB3> INFO: Test took 15278ms.
[16:29:41.658] <TB3> INFO: ROC 0, missing bumps = 490, total number of good bumps = 3670
[16:29:41.659] <TB3> INFO: ROC 1, missing bumps = 129, total number of good bumps = 4031
[16:29:41.660] <TB3> INFO: ROC 2, missing bumps = 4043, total number of good bumps = 117
[16:29:41.661] <TB3> INFO: ROC 3, missing bumps = 4028, total number of good bumps = 132
[16:29:41.663] <TB3> INFO: ROC 4, missing bumps = 0, total number of good bumps = 4160
[16:29:41.664] <TB3> INFO: ROC 6, missing bumps = 1, total number of good bumps = 4159
[16:29:41.665] <TB3> INFO: ROC 7, missing bumps = 1, total number of good bumps = 4159
[16:29:41.667] <TB3> INFO: ROC 8, missing bumps = 1204, total number of good bumps = 2956
[16:29:41.668] <TB3> INFO: ROC 9, missing bumps = 0, total number of good bumps = 4160
[16:29:41.669] <TB3> INFO: ROC 10, missing bumps = 3, total number of good bumps = 4157
[16:29:41.671] <TB3> INFO: ROC 12, missing bumps = 7, total number of good bumps = 4153
[16:29:41.672] <TB3> INFO: ROC 15, missing bumps = 0, total number of good bumps = 4160
[16:29:41.672] <TB3> INFO: CalDel = 110 done
[16:29:41.950] <TB3> INFO: Expecting 416000 events.
[16:29:57.775] <TB3> INFO: 416000 events read in total (15269ms).
[16:29:57.776] <TB3> INFO: Test took 16100ms.
[16:29:57.947] <TB3> INFO: ROC 0, missing bumps = 1, total number of good bumps = 4159
[16:29:57.949] <TB3> INFO: ROC 1, missing bumps = 2, total number of good bumps = 4158
[16:29:57.951] <TB3> INFO: ROC 2, missing bumps = 524, total number of good bumps = 3636
[16:29:57.952] <TB3> INFO: ROC 3, missing bumps = 522, total number of good bumps = 3638
[16:29:57.954] <TB3> INFO: ROC 6, missing bumps = 1, total number of good bumps = 4159
[16:29:57.956] <TB3> INFO: ROC 7, missing bumps = 1, total number of good bumps = 4159
[16:29:57.958] <TB3> INFO: ROC 8, missing bumps = 10, total number of good bumps = 4150
[16:29:57.963] <TB3> INFO: ROC 10, missing bumps = 1, total number of good bumps = 4159
[16:29:57.965] <TB3> INFO: ROC 12, missing bumps = 5, total number of good bumps = 4155
[16:29:57.965] <TB3> INFO: CalDel = 120 done
[16:29:58.244] <TB3> INFO: Expecting 416000 events.
[16:30:13.681] <TB3> INFO: 416000 events read in total (14881ms).
[16:30:13.683] <TB3> INFO: Test took 15713ms.
[16:30:13.851] <TB3> INFO: ROC 0, missing bumps = 1, total number of good bumps = 4159
[16:30:13.853] <TB3> INFO: ROC 1, missing bumps = 2, total number of good bumps = 4158
[16:30:13.855] <TB3> INFO: ROC 2, missing bumps = 1, total number of good bumps = 4159
[16:30:13.856] <TB3> INFO: ROC 3, missing bumps = 6, total number of good bumps = 4154
[16:30:13.858] <TB3> INFO: ROC 6, missing bumps = 0, total number of good bumps = 4160
[16:30:13.859] <TB3> INFO: ROC 7, missing bumps = 1, total number of good bumps = 4159
[16:30:13.860] <TB3> INFO: ROC 8, missing bumps = 5, total number of good bumps = 4155
[16:30:13.861] <TB3> INFO: ROC 10, missing bumps = 1, total number of good bumps = 4159
[16:30:13.863] <TB3> INFO: ROC 12, missing bumps = 2, total number of good bumps = 4158
[16:30:13.863] <TB3> INFO: CalDel = 130 done
[16:30:14.137] <TB3> INFO: Expecting 416000 events.
[16:30:28.990] <TB3> INFO: 416000 events read in total (14297ms).
[16:30:28.991] <TB3> INFO: Test took 15124ms.
[16:30:29.159] <TB3> INFO: ROC 0, missing bumps = 0, total number of good bumps = 4160
[16:30:29.160] <TB3> INFO: ROC 1, missing bumps = 2, total number of good bumps = 4158
[16:30:29.161] <TB3> INFO: ROC 2, missing bumps = 0, total number of good bumps = 4160
[16:30:29.163] <TB3> INFO: ROC 3, missing bumps = 3, total number of good bumps = 4157
[16:30:29.164] <TB3> INFO: ROC 7, missing bumps = 2, total number of good bumps = 4159
[16:30:29.165] <TB3> INFO: ROC 8, missing bumps = 4, total number of good bumps = 4156
[16:30:29.166] <TB3> INFO: ROC 10, missing bumps = 1, total number of good bumps = 4159
[16:30:29.168] <TB3> INFO: ROC 12, missing bumps = 1, total number of good bumps = 4159
[16:30:29.168] <TB3> INFO: CalDel = 140 done
[16:30:29.442] <TB3> INFO: Expecting 416000 events.
[16:30:42.301] <TB3> INFO: 416000 events read in total (12303ms).
[16:30:42.302] <TB3> INFO: Test took 13130ms.
[16:30:42.468] <TB3> INFO: ROC 1, missing bumps = 2, total number of good bumps = 4160
[16:30:42.470] <TB3> INFO: ROC 3, missing bumps = 0, total number of good bumps = 4160
[16:30:42.472] <TB3> INFO: ROC 7, missing bumps = 2399, total number of good bumps = 4159
[16:30:42.474] <TB3> INFO: ROC 8, missing bumps = 1, total number of good bumps = 4159
[16:30:42.475] <TB3> INFO: ROC 10, missing bumps = 2174, total number of good bumps = 4159
[16:30:42.477] <TB3> INFO: ROC 12, missing bumps = 352, total number of good bumps = 4159
[16:30:42.477] <TB3> INFO: CalDel = 150 done
[16:30:42.752] <TB3> INFO: Expecting 416000 events.
[16:30:54.142] <TB3> INFO: 416000 events read in total (10834ms).
[16:30:54.144] <TB3> INFO: Test took 11662ms.
[16:30:54.364] <TB3> INFO: ROC 1, missing bumps = 360, total number of good bumps = 4160
[16:30:54.365] <TB3> INFO: ROC 7, missing bumps = 4154, total number of good bumps = 4159
[16:30:54.367] <TB3> INFO: ROC 8, missing bumps = 22, total number of good bumps = 4159
[16:30:54.368] <TB3> INFO: ROC 10, missing bumps = 4139, total number of good bumps = 4159
[16:30:54.370] <TB3> INFO: ROC 12, missing bumps = 3946, total number of good bumps = 4159
[16:30:54.370] <TB3> INFO: CalDel = 160 done
[16:30:54.643] <TB3> INFO: Expecting 416000 events.
[16:31:05.305] <TB3> INFO: 416000 events read in total (10106ms).
[16:31:05.306] <TB3> INFO: Test took 10931ms.
[16:31:05.535] <TB3> INFO: ROC 1, missing bumps = 3574, total number of good bumps = 4160
[16:31:05.536] <TB3> INFO: ROC 7, missing bumps = 4160, total number of good bumps = 4159
[16:31:05.538] <TB3> INFO: ROC 8, missing bumps = 960, total number of good bumps = 4159
[16:31:05.540] <TB3> INFO: ROC 10, missing bumps = 4158, total number of good bumps = 4159
[16:31:05.541] <TB3> INFO: ROC 12, missing bumps = 4154, total number of good bumps = 4159
[16:31:05.541] <TB3> INFO: CalDel = 170 done
[16:31:05.812] <TB3> INFO: Expecting 416000 events.
[16:31:15.597] <TB3> INFO: 416000 events read in total (9229ms).
[16:31:15.598] <TB3> INFO: Test took 10053ms.
[16:31:15.847] <TB3> INFO: ROC 1, missing bumps = 4157, total number of good bumps = 4160
[16:31:15.848] <TB3> INFO: ROC 7, missing bumps = 4160, total number of good bumps = 4159
[16:31:15.850] <TB3> INFO: ROC 8, missing bumps = 4080, total number of good bumps = 4159
[16:31:15.851] <TB3> INFO: ROC 10, missing bumps = 4159, total number of good bumps = 4160
[16:31:15.852] <TB3> INFO: ROC 12, missing bumps = 4160, total number of good bumps = 4159
[16:31:15.852] <TB3> INFO: CalDel = 180 done
[16:31:16.118] <TB3> INFO: Expecting 416000 events.
[16:31:25.443] <TB3> INFO: 416000 events read in total (8769ms).
[16:31:25.445] <TB3> INFO: Test took 9589ms.
[16:31:25.716] <TB3> INFO: ROC 1, missing bumps = 4158, total number of good bumps = 4160
[16:31:25.718] <TB3> INFO: ROC 7, missing bumps = 4160, total number of good bumps = 4159
[16:31:25.719] <TB3> INFO: ROC 8, missing bumps = 4155, total number of good bumps = 4159
[16:31:25.720] <TB3> INFO: ROC 10, missing bumps = 4160, total number of good bumps = 4160
[16:31:25.721] <TB3> INFO: ROC 12, missing bumps = 4160, total number of good bumps = 4159
[16:31:25.721] <TB3> INFO: CalDel = 190 done
[16:31:25.991] <TB3> INFO: Expecting 416000 events.
[16:31:35.216] <TB3> INFO: 416000 events read in total (8669ms).
[16:31:35.218] <TB3> INFO: Test took 9493ms.
[16:31:35.490] <TB3> INFO: ROC 1, missing bumps = 4158, total number of good bumps = 4160
[16:31:35.491] <TB3> INFO: ROC 7, missing bumps = 4160, total number of good bumps = 4159
[16:31:35.493] <TB3> INFO: ROC 8, missing bumps = 4157, total number of good bumps = 4159
[16:31:35.494] <TB3> INFO: ROC 10, missing bumps = 4160, total number of good bumps = 4160
[16:31:35.496] <TB3> INFO: ROC 12, missing bumps = 4160, total number of good bumps = 4159
[16:31:35.496] <TB3> INFO: CalDel = 200 done
[16:31:35.496] <TB3> INFO: CalDel scan done
[16:31:35.498] <TB3> INFO: resulting values: CalDel = 140 120 140 150 110 100 130 110 150 110 120 100 140 100 90 110
[16:31:35.760] <TB3> INFO: Expecting 416000 events.
[16:31:50.946] <TB3> INFO: 416000 events read in total (14630ms).
[16:31:50.952] <TB3> INFO: Test took 15452ms.
[16:31:50.959] <TB3> INFO: maps.size() = 16
[16:31:51.138] <TB3> INFO: 3 broken Bump Bonds found
[16:31:51.140] <TB3> INFO: back to CtrlReg 0
[16:31:51.144] <TB3> INFO: PixTestBB4Map::doTest() done
[16:31:51.144] <TB3> INFO: Write out MinimumThreshold
[16:31:51.144] <TB3> INFO: Write out CalDel Scan_C0_V0
[16:31:51.144] <TB3> INFO: Write out PixelHit_C0_V0
[16:31:51.144] <TB3> INFO: Write out BB4MapBest_C0_V0
[16:31:51.145] <TB3> INFO: Write out NoiseScan_C0_V0
[16:31:51.145] <TB3> INFO: Write out BB4Map_C0_V14
[16:31:51.145] <TB3> INFO: Write out Hit Distr_C0_V0
[16:31:51.145] <TB3> INFO: Write out Hit Distr_C0_V0
[16:31:51.145] <TB3> INFO: Write out CalDel Scan_C1_V0
[16:31:51.145] <TB3> INFO: Write out PixelHit_C1_V0
[16:31:51.145] <TB3> INFO: Write out BB4MapBest_C1_V0
[16:31:51.145] <TB3> INFO: Write out NoiseScan_C1_V0
[16:31:51.145] <TB3> INFO: Write out BB4Map_C1_V14
[16:31:51.145] <TB3> INFO: Write out Hit Distr_C1_V0
[16:31:51.145] <TB3> INFO: Write out Hit Distr_C1_V0
[16:31:51.146] <TB3> INFO: Write out CalDel Scan_C2_V0
[16:31:51.146] <TB3> INFO: Write out PixelHit_C2_V0
[16:31:51.146] <TB3> INFO: Write out BB4MapBest_C2_V0
[16:31:51.146] <TB3> INFO: Write out NoiseScan_C2_V0
[16:31:51.146] <TB3> INFO: Write out BB4Map_C2_V14
[16:31:51.146] <TB3> INFO: Write out Hit Distr_C2_V0
[16:31:51.146] <TB3> INFO: Write out Hit Distr_C2_V0
[16:31:51.146] <TB3> INFO: Write out CalDel Scan_C3_V0
[16:31:51.146] <TB3> INFO: Write out PixelHit_C3_V0
[16:31:51.146] <TB3> INFO: Write out BB4MapBest_C3_V0
[16:31:51.147] <TB3> INFO: Write out NoiseScan_C3_V0
[16:31:51.147] <TB3> INFO: Write out BB4Map_C3_V14
[16:31:51.147] <TB3> INFO: Write out Hit Distr_C3_V0
[16:31:51.147] <TB3> INFO: Write out Hit Distr_C3_V0
[16:31:51.147] <TB3> INFO: Write out CalDel Scan_C4_V0
[16:31:51.147] <TB3> INFO: Write out PixelHit_C4_V0
[16:31:51.147] <TB3> INFO: Write out BB4MapBest_C4_V0
[16:31:51.147] <TB3> INFO: Write out NoiseScan_C4_V0
[16:31:51.147] <TB3> INFO: Write out BB4Map_C4_V14
[16:31:51.147] <TB3> INFO: Write out Hit Distr_C4_V0
[16:31:51.147] <TB3> INFO: Write out Hit Distr_C4_V0
[16:31:51.147] <TB3> INFO: Write out CalDel Scan_C5_V0
[16:31:51.148] <TB3> INFO: Write out PixelHit_C5_V0
[16:31:51.148] <TB3> INFO: Write out BB4MapBest_C5_V0
[16:31:51.148] <TB3> INFO: Write out NoiseScan_C5_V0
[16:31:51.148] <TB3> INFO: Write out BB4Map_C5_V14
[16:31:51.148] <TB3> INFO: Write out Hit Distr_C5_V0
[16:31:51.148] <TB3> INFO: Write out Hit Distr_C5_V0
[16:31:51.148] <TB3> INFO: Write out CalDel Scan_C6_V0
[16:31:51.148] <TB3> INFO: Write out PixelHit_C6_V0
[16:31:51.148] <TB3> INFO: Write out BB4MapBest_C6_V0
[16:31:51.148] <TB3> INFO: Write out NoiseScan_C6_V0
[16:31:51.148] <TB3> INFO: Write out BB4Map_C6_V14
[16:31:51.149] <TB3> INFO: Write out Hit Distr_C6_V0
[16:31:51.149] <TB3> INFO: Write out Hit Distr_C6_V0
[16:31:51.149] <TB3> INFO: Write out CalDel Scan_C7_V0
[16:31:51.149] <TB3> INFO: Write out PixelHit_C7_V0
[16:31:51.149] <TB3> INFO: Write out BB4MapBest_C7_V0
[16:31:51.149] <TB3> INFO: Write out NoiseScan_C7_V0
[16:31:51.149] <TB3> INFO: Write out BB4Map_C7_V14
[16:31:51.149] <TB3> INFO: Write out Hit Distr_C7_V0
[16:31:51.149] <TB3> INFO: Write out Hit Distr_C7_V0
[16:31:51.149] <TB3> INFO: Write out CalDel Scan_C8_V0
[16:31:51.149] <TB3> INFO: Write out PixelHit_C8_V0
[16:31:51.150] <TB3> INFO: Write out BB4MapBest_C8_V0
[16:31:51.150] <TB3> INFO: Write out NoiseScan_C8_V0
[16:31:51.150] <TB3> INFO: Write out BB4Map_C8_V14
[16:31:51.150] <TB3> INFO: Write out Hit Distr_C8_V0
[16:31:51.150] <TB3> INFO: Write out Hit Distr_C8_V0
[16:31:51.150] <TB3> INFO: Write out CalDel Scan_C9_V0
[16:31:51.150] <TB3> INFO: Write out PixelHit_C9_V0
[16:31:51.150] <TB3> INFO: Write out BB4MapBest_C9_V0
[16:31:51.150] <TB3> INFO: Write out NoiseScan_C9_V0
[16:31:51.150] <TB3> INFO: Write out BB4Map_C9_V14
[16:31:51.150] <TB3> INFO: Write out Hit Distr_C9_V0
[16:31:51.151] <TB3> INFO: Write out Hit Distr_C9_V0
[16:31:51.151] <TB3> INFO: Write out CalDel Scan_C10_V0
[16:31:51.151] <TB3> INFO: Write out PixelHit_C10_V0
[16:31:51.151] <TB3> INFO: Write out BB4MapBest_C10_V0
[16:31:51.151] <TB3> INFO: Write out NoiseScan_C10_V0
[16:31:51.151] <TB3> INFO: Write out BB4Map_C10_V14
[16:31:51.151] <TB3> INFO: Write out Hit Distr_C10_V0
[16:31:51.151] <TB3> INFO: Write out Hit Distr_C10_V0
[16:31:51.151] <TB3> INFO: Write out CalDel Scan_C11_V0
[16:31:51.151] <TB3> INFO: Write out PixelHit_C11_V0
[16:31:51.151] <TB3> INFO: Write out BB4MapBest_C11_V0
[16:31:51.151] <TB3> INFO: Write out NoiseScan_C11_V0
[16:31:51.151] <TB3> INFO: Write out BB4Map_C11_V14
[16:31:51.152] <TB3> INFO: Write out Hit Distr_C11_V0
[16:31:51.152] <TB3> INFO: Write out Hit Distr_C11_V0
[16:31:51.152] <TB3> INFO: Write out CalDel Scan_C12_V0
[16:31:51.152] <TB3> INFO: Write out PixelHit_C12_V0
[16:31:51.152] <TB3> INFO: Write out BB4MapBest_C12_V0
[16:31:51.152] <TB3> INFO: Write out NoiseScan_C12_V0
[16:31:51.152] <TB3> INFO: Write out BB4Map_C12_V14
[16:31:51.152] <TB3> INFO: Write out Hit Distr_C12_V0
[16:31:51.152] <TB3> INFO: Write out Hit Distr_C12_V0
[16:31:51.152] <TB3> INFO: Write out CalDel Scan_C13_V0
[16:31:51.152] <TB3> INFO: Write out PixelHit_C13_V0
[16:31:51.152] <TB3> INFO: Write out BB4MapBest_C13_V0
[16:31:51.153] <TB3> INFO: Write out NoiseScan_C13_V0
[16:31:51.153] <TB3> INFO: Write out BB4Map_C13_V14
[16:31:51.153] <TB3> INFO: Write out Hit Distr_C13_V0
[16:31:51.153] <TB3> INFO: Write out Hit Distr_C13_V0
[16:31:51.153] <TB3> INFO: Write out CalDel Scan_C14_V0
[16:31:51.153] <TB3> INFO: Write out PixelHit_C14_V0
[16:31:51.153] <TB3> INFO: Write out BB4MapBest_C14_V0
[16:31:51.153] <TB3> INFO: Write out NoiseScan_C14_V0
[16:31:51.153] <TB3> INFO: Write out BB4Map_C14_V14
[16:31:51.153] <TB3> INFO: Write out Hit Distr_C14_V0
[16:31:51.153] <TB3> INFO: Write out Hit Distr_C14_V0
[16:31:51.153] <TB3> INFO: Write out CalDel Scan_C15_V0
[16:31:51.153] <TB3> INFO: Write out PixelHit_C15_V0
[16:31:51.154] <TB3> INFO: Write out BB4MapBest_C15_V0
[16:31:51.154] <TB3> INFO: Write out NoiseScan_C15_V0
[16:31:51.154] <TB3> INFO: Write out BB4Map_C15_V14
[16:31:51.154] <TB3> INFO: Write out Hit Distr_C15_V0
[16:31:51.154] <TB3> INFO: Write out Hit Distr_C15_V0
[16:31:51.154] <TB3> INFO: enter test to run
[16:31:51.154] <TB3> INFO: test: no parameter change
[16:31:51.182] <TB3> QUIET: Connection to board 126 closed.
[16:31:51.230] <TB3> INFO: pXar: this is the end, my friend