[08:29:23.976] <TB1> INFO: *** Welcome to pxar ***
[08:29:23.976] <TB1> INFO: *** Today: 2016/08/16
[08:29:24.017] <TB1> INFO: *** Version: f5d3-dirty
[08:29:24.017] <TB1> INFO: readRocDacs: /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C0.dat .. /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C15.dat
[08:29:24.033] <TB1> INFO: readTbmDacs: /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//tbmParameters_C0a.dat .. /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//tbmParameters_C0b.dat
[08:29:24.035] <TB1> INFO: readMaskFile: /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//defaultMaskFile.dat
[08:29:24.036] <TB1> INFO: readTrimFile: /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//trimParameters_C0.dat .. /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//trimParameters_C15.dat
[08:29:24.141] <TB1> INFO: clk: 4
[08:29:24.141] <TB1> INFO: ctr: 4
[08:29:24.141] <TB1> INFO: sda: 19
[08:29:24.141] <TB1> INFO: tin: 9
[08:29:24.141] <TB1> INFO: level: 15
[08:29:24.142] <TB1> INFO: triggerdelay: 0
[08:29:24.142] <TB1> QUIET: Instanciating API for pxar v2.7.5+40~g4fce89b
[08:29:24.142] <TB1> INFO: Log level: INFO
[08:29:24.148] <TB1> INFO: Found DTB DTB_WXC03A
[08:29:24.160] <TB1> QUIET: Connection to board DTB_WXC03A opened.
[08:29:24.162] <TB1> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 154
HW version: DTB1.2
FW version: 4.4
SW version: 4.6
Options:
USB id: DTB_WXC03A
MAC address: 40D85511809A
Hostname: pixelDTB154
Comment:
------------------------------------------------------
[08:29:24.164] <TB1> INFO: RPC call hashes of host and DTB match: 484264910
[08:29:25.717] <TB1> INFO: DUT info:
[08:29:25.717] <TB1> INFO: The DUT currently contains the following objects:
[08:29:25.717] <TB1> INFO: 2 TBM Cores tbm08c (2 ON)
[08:29:25.717] <TB1> INFO: TBM Core alpha (0): 7 registers set
[08:29:25.717] <TB1> INFO: TBM Core beta (1): 7 registers set
[08:29:25.717] <TB1> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[08:29:25.717] <TB1> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.717] <TB1> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:25.718] <TB1> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[08:29:26.120] <TB1> INFO: enter 'restricted' command line mode
[08:29:26.120] <TB1> INFO: enter test to run
[08:29:26.120] <TB1> INFO: test: pretest no parameter change
[08:29:26.120] <TB1> INFO: running: pretest
[08:29:26.127] <TB1> INFO: ----------------------------------------------------------------------
[08:29:26.127] <TB1> INFO: PixTestPretest::programROC()
[08:29:26.127] <TB1> INFO: ----------------------------------------------------------------------
[08:29:44.146] <TB1> INFO: PixTestPretest::programROC() done: ROCs are all programmable
[08:29:44.146] <TB1> INFO: IA differences per ROC: 19.3 16.1 20.1 19.3 20.1 20.9 20.9 20.1 19.3 20.1 19.3 20.1 20.1 20.1 19.3 19.3
[08:29:44.253] <TB1> INFO: enter test to run
[08:29:44.253] <TB1> INFO: test: pretest no parameter change
[08:29:44.253] <TB1> INFO: running: pretest
[08:29:44.255] <TB1> INFO: ----------------------------------------------------------------------
[08:29:44.255] <TB1> INFO: PixTestPretest::setVana() target Ia = 24 mA/ROC
[08:29:44.255] <TB1> INFO: ----------------------------------------------------------------------
[08:30:05.587] <TB1> INFO: PixTestPretest::setVana() done, Module Ia 386.7 mA = 24.1687 mA/ROC
[08:30:05.588] <TB1> INFO: i(loss) [mA/ROC]: 19.3 19.3 19.3 19.3 19.3 18.5 19.3 18.5 19.3 19.3 19.3 18.5 19.3 19.3 19.3 18.5
[08:30:05.633] <TB1> INFO: enter test to run
[08:30:05.633] <TB1> INFO: test: pretest no parameter change
[08:30:05.633] <TB1> INFO: running: pretest
[08:30:05.633] <TB1> INFO: ----------------------------------------------------------------------
[08:30:05.633] <TB1> INFO: PixTestPretest::findTiming()
[08:30:05.633] <TB1> INFO: ----------------------------------------------------------------------
[08:30:05.633] <TB1> INFO: PixTestCmd::init()
[08:30:06.451] <TB1> WARNING: Not unmasking DUT, not setting Calibrate bits!
[08:31:06.832] <TB1> INFO: TBM phases: 160MHz: 7, 400MHz: 2, TBM delays: ROC(0/1):4, header/trailer: 1, token: 1
[08:31:06.832] <TB1> INFO: (success/tries = 100/100), width = 4
[08:31:06.833] <TB1> INFO: enter test to run
[08:31:06.833] <TB1> INFO: test: pretest no parameter change
[08:31:06.834] <TB1> INFO: running: pretest
[08:31:06.835] <TB1> INFO: ----------------------------------------------------------------------
[08:31:06.835] <TB1> INFO: PixTestPretest::findWorkingPixel()
[08:31:06.835] <TB1> INFO: ----------------------------------------------------------------------
[08:31:06.931] <TB1> INFO: Expecting 231680 events.
[08:31:12.616] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"
[08:31:16.105] <TB1> INFO: 231680 events read in total (8617ms).
[08:31:16.109] <TB1> INFO: Test took 9267ms.
[08:31:16.413] <TB1> INFO: Found working pixel in all ROCs: col/row = 12/22
[08:31:16.501] <TB1> INFO: enter test to run
[08:31:16.501] <TB1> INFO: test: pretest no parameter change
[08:31:16.501] <TB1> INFO: running: pretest
[08:31:16.503] <TB1> INFO: ----------------------------------------------------------------------
[08:31:16.503] <TB1> INFO: PixTestPretest::setVthrCompCalDel()
[08:31:16.503] <TB1> INFO: ----------------------------------------------------------------------
[08:31:16.598] <TB1> INFO: Expecting 231680 events.
[08:31:25.706] <TB1> INFO: 231680 events read in total (8551ms).
[08:31:25.710] <TB1> INFO: Test took 9202ms.
[08:31:26.040] <TB1> INFO: PixTestPretest::setVthrCompCalDel() done
[08:31:26.040] <TB1> INFO: CalDel: 144 126 131 110 129 129 143 128 129 123 130 140 141 123 131 131
[08:31:26.040] <TB1> INFO: VthrComp: 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51 51
[08:31:26.075] <TB1> INFO: enter test to run
[08:31:26.075] <TB1> INFO: test: pretest no parameter change
[08:31:26.075] <TB1> INFO: running: pretest
[08:31:26.093] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C0.dat
[08:31:26.118] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C1.dat
[08:31:26.123] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C2.dat
[08:31:26.133] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C3.dat
[08:31:26.141] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C4.dat
[08:31:26.149] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C5.dat
[08:31:26.154] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C6.dat
[08:31:26.161] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C7.dat
[08:31:26.169] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C8.dat
[08:31:26.176] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C9.dat
[08:31:26.182] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C10.dat
[08:31:26.187] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C11.dat
[08:31:26.195] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C12.dat
[08:31:26.203] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C13.dat
[08:31:26.211] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C14.dat
[08:31:26.216] <TB1> INFO: write dac parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//dacParameters_C15.dat
[08:31:26.219] <TB1> INFO: enter test to run
[08:31:26.219] <TB1> INFO: test: PixelAlive no parameter change
[08:31:26.219] <TB1> INFO: running: pixelalive
[08:31:26.221] <TB1> INFO: ######################################################################
[08:31:26.221] <TB1> INFO: PixTestAlive::doTest()
[08:31:26.221] <TB1> INFO: ######################################################################
[08:31:26.223] <TB1> INFO: ----------------------------------------------------------------------
[08:31:26.223] <TB1> INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:31:26.223] <TB1> INFO: ----------------------------------------------------------------------
[08:31:26.515] <TB1> INFO: Expecting 41600 events.
[08:31:30.006] <TB1> INFO: 41600 events read in total (2935ms).
[08:31:30.007] <TB1> INFO: Test took 3782ms.
[08:31:30.317] <TB1> INFO: PixTestAlive::aliveTest() done
[08:31:30.317] <TB1> INFO: number of dead pixels (per ROC): 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:31:30.318] <TB1> INFO: ----------------------------------------------------------------------
[08:31:30.318] <TB1> INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:31:30.318] <TB1> INFO: ----------------------------------------------------------------------
[08:31:30.587] <TB1> INFO: Expecting 41600 events.
[08:31:33.221] <TB1> INFO: 41600 events read in total (2078ms).
[08:31:33.221] <TB1> INFO: Test took 2900ms.
[08:31:33.221] <TB1> INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[08:31:33.546] <TB1> INFO: PixTestAlive::maskTest() done
[08:31:33.546] <TB1> INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:31:33.548] <TB1> INFO: ----------------------------------------------------------------------
[08:31:33.548] <TB1> INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[08:31:33.548] <TB1> INFO: ----------------------------------------------------------------------
[08:31:33.840] <TB1> INFO: Expecting 41600 events.
[08:31:37.329] <TB1> INFO: 41600 events read in total (2933ms).
[08:31:37.330] <TB1> INFO: Test took 3779ms.
[08:31:37.635] <TB1> INFO: PixTestAlive::addressDecodingTest() done
[08:31:37.635] <TB1> INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[08:31:37.635] <TB1> INFO: PixTestAlive::doTest() done, duration: 11 seconds
[08:31:37.641] <TB1> INFO: enter test to run
[08:31:37.641] <TB1> INFO: test: BB no parameter change
[08:31:37.641] <TB1> INFO: running: bb
[08:31:37.642] <TB1> INFO: ######################################################################
[08:31:37.642] <TB1> INFO: PixTestBBMap::doTest() Ntrig = 5, VcalS = 250 (high range)
[08:31:37.642] <TB1> INFO: ######################################################################
[08:31:37.646] <TB1> INFO: ---> dac: VthrComp name: calSMap ntrig: 5 dacrange: 0 .. 149 (-1/-1) hits flags = 514 (plus default)
[08:31:37.659] <TB1> INFO: dacScan split into 1 runs with ntrig = 5
[08:31:37.659] <TB1> INFO: run 1 of 1
[08:31:37.949] <TB1> INFO: Expecting 3120000 events.
[08:32:23.246] <TB1> INFO: 1213270 events read in total (44740ms).
[08:33:08.572] <TB1> INFO: 2428115 events read in total (90066ms).
[08:33:34.571] <TB1> INFO: 3120000 events read in total (116065ms).
[08:33:34.613] <TB1> INFO: Test took 116955ms.
[08:34:00.302] <TB1> INFO: PixTestBBMap::doTest() done, duration: 142 seconds
[08:34:00.302] <TB1> INFO: number of dead bumps (per ROC): 0 1 0 0 0 0 0 1 0 1 0 0 1 1 0 0
[08:34:00.302] <TB1> INFO: separation cut (per ROC): 114 107 125 124 122 107 115 116 111 114 125 102 124 106 105 103
[08:34:00.394] <TB1> INFO: enter test to run
[08:34:00.394] <TB1> INFO: test: Readback no parameter change
[08:34:00.394] <TB1> INFO: running: readback
[08:34:00.394] <TB1> INFO: readReadbackCal: /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C0.dat .. /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C15.dat
[08:34:00.415] <TB1> INFO: readGainPedestalParameters /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//phCalibrationFitErr_C0.dat .. /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//phCalibrationFitErr_C15.dat
[08:34:00.423] <TB1> ERROR: <ConfigParameters.cc/readGainPedestalParameters:L996> cannot open /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//phCalibrationFitErr_C0.dat for reading PH calibration constants
[08:34:00.423] <TB1> INFO: ######################################################################
[08:34:00.423] <TB1> INFO: PixTestReadback::doTest()
[08:34:00.423] <TB1> INFO: ######################################################################
[08:34:00.423] <TB1> INFO: ----------------------------------------------------------------------
[08:34:00.423] <TB1> INFO: PixTestReadback::CalibrateVd()
[08:34:00.423] <TB1> INFO: ----------------------------------------------------------------------
[08:34:09.787] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C0.dat
[08:34:09.792] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C1.dat
[08:34:09.797] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C2.dat
[08:34:09.802] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C3.dat
[08:34:09.808] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C4.dat
[08:34:09.813] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C5.dat
[08:34:09.818] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C6.dat
[08:34:09.823] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C7.dat
[08:34:09.828] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C8.dat
[08:34:09.833] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C9.dat
[08:34:09.838] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C10.dat
[08:34:09.843] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C11.dat
[08:34:09.852] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C12.dat
[08:34:09.857] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C13.dat
[08:34:09.864] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C14.dat
[08:34:09.869] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C15.dat
[08:34:09.918] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[08:34:09.918] <TB1> INFO: ----------------------------------------------------------------------
[08:34:09.918] <TB1> INFO: PixTestReadback::CalibrateVa()
[08:34:09.918] <TB1> INFO: ----------------------------------------------------------------------
[08:34:19.398] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C0.dat
[08:34:19.405] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C1.dat
[08:34:19.410] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C2.dat
[08:34:19.416] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C3.dat
[08:34:19.423] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C4.dat
[08:34:19.428] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C5.dat
[08:34:19.433] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C6.dat
[08:34:19.438] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C7.dat
[08:34:19.443] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C8.dat
[08:34:19.448] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C9.dat
[08:34:19.453] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C10.dat
[08:34:19.459] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C11.dat
[08:34:19.464] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C12.dat
[08:34:19.469] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C13.dat
[08:34:19.475] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C14.dat
[08:34:19.483] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C15.dat
[08:34:19.533] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[08:34:19.533] <TB1> INFO: ----------------------------------------------------------------------
[08:34:19.533] <TB1> INFO: PixTestReadback::readbackVbg()
[08:34:19.533] <TB1> INFO: ----------------------------------------------------------------------
[08:34:26.706] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[08:34:26.706] <TB1> INFO: ----------------------------------------------------------------------
[08:34:26.706] <TB1> INFO: PixTestReadback::getCalibratedVbg()
[08:34:26.706] <TB1> INFO: ----------------------------------------------------------------------
[08:34:26.706] <TB1> INFO: Vbg will be calibrated using Vd calibration
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 0: uncalibrated Vbg = 137.8calibrated Vbg = 1.23849 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 1: uncalibrated Vbg = 154.1calibrated Vbg = 1.23827 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 2: uncalibrated Vbg = 152calibrated Vbg = 1.23754 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 3: uncalibrated Vbg = 162.1calibrated Vbg = 1.23987 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 4: uncalibrated Vbg = 149calibrated Vbg = 1.24622 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 5: uncalibrated Vbg = 149.3calibrated Vbg = 1.24821 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 6: uncalibrated Vbg = 152.5calibrated Vbg = 1.24149 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 7: uncalibrated Vbg = 154calibrated Vbg = 1.24889 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 8: uncalibrated Vbg = 149.6calibrated Vbg = 1.23912 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 9: uncalibrated Vbg = 151.3calibrated Vbg = 1.24684 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 10: uncalibrated Vbg = 154.5calibrated Vbg = 1.2413 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 11: uncalibrated Vbg = 146.3calibrated Vbg = 1.24278 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 12: uncalibrated Vbg = 149.2calibrated Vbg = 1.23728 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 13: uncalibrated Vbg = 138.7calibrated Vbg = 1.23183 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 14: uncalibrated Vbg = 146.2calibrated Vbg = 1.23522 :::*/*/*/*/
[08:34:26.706] <TB1> INFO: /*/*/*/*::: ROC 15: uncalibrated Vbg = 146.2calibrated Vbg = 1.23597 :::*/*/*/*/
[08:34:26.709] <TB1> INFO: ----------------------------------------------------------------------
[08:34:26.709] <TB1> INFO: PixTestReadback::CalibrateIa()
[08:34:26.709] <TB1> INFO: ----------------------------------------------------------------------
[08:37:00.076] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C0.dat
[08:37:00.081] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C1.dat
[08:37:00.086] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C2.dat
[08:37:00.092] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C3.dat
[08:37:00.098] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C4.dat
[08:37:00.104] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C5.dat
[08:37:00.111] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C6.dat
[08:37:00.116] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C7.dat
[08:37:00.121] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C8.dat
[08:37:00.126] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C9.dat
[08:37:00.133] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C10.dat
[08:37:00.138] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C11.dat
[08:37:00.144] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C12.dat
[08:37:00.150] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C13.dat
[08:37:00.155] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C14.dat
[08:37:00.162] <TB1> INFO: write readback calibration parameters into /home/Reception/DATA/DESYUHH/M4105_Reception_2016-08-16_10h27m_1471336044//000_ReceptionTestBB2_p17//readbackCal_C15.dat
[08:37:00.210] <TB1> INFO: PixTestPattern:: pg_setup set to default.
[08:37:00.211] <TB1> INFO: PixTestReadback::doTest() done
[08:37:00.232] <TB1> INFO: enter test to run
[08:37:00.232] <TB1> INFO: test: BB2 no parameter change
[08:37:00.232] <TB1> INFO: running: bb2
[08:37:00.234] <TB1> INFO: ######################################################################
[08:37:00.234] <TB1> INFO: PixTestBB2Map::doTest() Ntrig = 10, VcalS = 222, PlWidth = 35
[08:37:00.234] <TB1> INFO: ######################################################################
[08:37:00.235] <TB1> INFO: ----------------------------------------------------------------------
[08:37:00.235] <TB1> INFO: PixTestBB2Map::setVana() target Ia = 24 mA/ROC
[08:37:00.235] <TB1> INFO: ----------------------------------------------------------------------
[08:37:05.028] <TB1> INFO: PixTestBB2Map::setVana() done, Module Ia 389.1 mA = 24.3188 mA/ROC
[08:37:05.029] <TB1> INFO: ----------------------------------------------------------------------
[08:37:05.029] <TB1> INFO: PixTestBB2Map::setVthrCompCalDel()
[08:37:05.029] <TB1> INFO: ----------------------------------------------------------------------
[08:37:05.124] <TB1> INFO: Expecting 655360 events.
[08:37:15.059] <TB1> WARNING: Detected DESER400 trailer error bits: "CODE ERROR"
[08:37:23.307] <TB1> INFO: 655360 events read in total (17627ms).
[08:37:23.310] <TB1> INFO: Test took 18274ms.
[08:37:23.635] <TB1> INFO: PixTestBB2Map::setVthrCompCalDel() done
[08:37:23.635] <TB1> INFO: CalDel: 131 120 125 107 125 125 139 123 124 118 125 136 136 119 123 124
[08:37:23.635] <TB1> INFO: VthrComp: 82 88 99 107 101 102 101 101 103 104 97 95 97 98 80 91
[08:37:23.935] <TB1> INFO: Expecting 5324800 events.
[08:38:00.593] <TB1> INFO: 1394410 events read in total (36102ms).
[08:38:36.505] <TB1> INFO: 2774200 events read in total (72014ms).
[08:39:12.685] <TB1> INFO: 4175300 events read in total (108195ms).
[08:39:42.199] <TB1> INFO: 5324800 events read in total (137708ms).
[08:39:42.220] <TB1> INFO: Test took 138559ms.
[08:39:42.680] <TB1> INFO: Missing Bumps: 1 1 1 0 0 0 0 2 0 3 1 0 1 1 0 0
[08:39:42.680] <TB1> INFO: Separation Cut: 22.73 29.74 30.98 30.01 29.01 24.74 27.56 23.45 28.30 30.70 28.53 31.92 30.90 31.51 23.10 24.47
[08:39:42.680] <TB1> INFO: PixTestBB2Map::doTest() done,162 seconds
[08:39:43.003] <TB1> INFO: enter test to run
[08:39:43.003] <TB1> INFO: test: no parameter change
[08:39:43.061] <TB1> QUIET: Connection to board 154 closed.
[08:39:43.143] <TB1> INFO: pXar: this is the end, my friend