[12:07:09.093] <TB0> INFO: *** Welcome to pxar ***
[12:07:09.093] <TB0> INFO: *** Today: 2016/11/17
[12:07:09.125] <TB0> INFO: *** Version: c8ba-dirty
[12:07:09.125] <TB0> INFO: readRocDacs: /Users/danek_kotlinski/danek/public/PHASE1/OnShellTest/results_L3plus/M3086_OnShellQuickTest_2016-11-17_12h06m_1479380808//000_OnShellQuickTest_p17//dacParameters_C0.dat .. /Users/danek_kotlinski/danek/public/PHASE1/OnShellTest/results_L3plus/M3086_OnShellQuickTest_2016-11-17_12h06m_1479380808//000_OnShellQuickTest_p17//dacParameters_C15.dat
[12:07:09.134] <TB0> INFO: readTbmDacs: /Users/danek_kotlinski/danek/public/PHASE1/OnShellTest/results_L3plus/M3086_OnShellQuickTest_2016-11-17_12h06m_1479380808//000_OnShellQuickTest_p17//tbmParameters_C0a.dat .. /Users/danek_kotlinski/danek/public/PHASE1/OnShellTest/results_L3plus/M3086_OnShellQuickTest_2016-11-17_12h06m_1479380808//000_OnShellQuickTest_p17//tbmParameters_C0b.dat
[12:07:09.135] <TB0> INFO: readMaskFile: /Users/danek_kotlinski/danek/public/PHASE1/OnShellTest/results_L3plus/M3086_OnShellQuickTest_2016-11-17_12h06m_1479380808//000_OnShellQuickTest_p17//defaultMaskFile.dat
[12:07:09.136] <TB0> INFO: readTrimFile: /Users/danek_kotlinski/danek/public/PHASE1/OnShellTest/results_L3plus/M3086_OnShellQuickTest_2016-11-17_12h06m_1479380808//000_OnShellQuickTest_p17//trimParameters_C0.dat .. /Users/danek_kotlinski/danek/public/PHASE1/OnShellTest/results_L3plus/M3086_OnShellQuickTest_2016-11-17_12h06m_1479380808//000_OnShellQuickTest_p17//trimParameters_C15.dat
[12:07:09.179] <TB0> INFO: clk: 4
[12:07:09.180] <TB0> INFO: ctr: 4
[12:07:09.180] <TB0> INFO: sda: 19
[12:07:09.180] <TB0> INFO: tin: 9
[12:07:09.180] <TB0> INFO: level: 15
[12:07:09.180] <TB0> INFO: triggerdelay: 0
[12:07:09.180] <TB0> QUIET: Instanciating API for pxar v1.8.0+1259~g87a54fa
[12:07:09.180] <TB0> INFO: Log level: INFO
[12:07:09.283] <TB0> QUIET: Connection to board DTB_WS6THK opened.
[12:07:09.285] <TB0> INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 81
HW version: DTB1.2
FW version: 4.6
SW version: 4.7
Options: LCDS2
USB id: DTB_WS6THK
MAC address: 40D855118051
Hostname: pixelDTB081
Comment:
------------------------------------------------------
[12:07:09.287] <TB0> INFO: RPC call hashes of host and DTB match: 486171790
[12:07:10.883] <TB0> INFO: DUT info:
[12:07:10.883] <TB0> INFO: The DUT currently contains the following objects:
[12:07:10.884] <TB0> INFO: 2 TBM Cores tbm08c (2 ON)
[12:07:10.884] <TB0> INFO: TBM Core alpha (0): 7 registers set
[12:07:10.884] <TB0> INFO: TBM Core beta (1): 7 registers set
[12:07:10.884] <TB0> INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[12:07:10.884] <TB0> INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:10.884] <TB0> INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[12:07:11.286] <TB0> INFO: enter 'restricted' command line mode
[12:07:11.286] <TB0> INFO: enter test to run
[12:07:11.286] <TB0> INFO: test: OnShellQuickTest no parameter change
[12:07:11.286] <TB0> INFO: running: onshellquicktest
[12:07:11.879] <TB0> INFO: ######################################################################
[12:07:11.879] <TB0> INFO: PixTestOnShellQuickTest::doTest()
[12:07:11.879] <TB0> INFO: ######################################################################
[12:07:11.879] <TB0> INFO: ----------------------------------------------------------------------
[12:07:11.879] <TB0> INFO: PixTestOnShellQuickTest::signalTest()
[12:07:11.879] <TB0> INFO: ----------------------------------------------------------------------
[12:07:11.879] <TB0> INFO: PixTestCmd::init()
[12:07:12.363] <TB0> WARNING: Pattern generator does not contain a trigger signal. No data is expected from the DUT!
[12:07:13.885] <TB0> WARNING: Pattern generator does not contain a trigger signal. No data is expected from the DUT!
[12:07:14.265] <TB0> WARNING: Pattern generator does not contain a trigger signal. No data is expected from the DUT!
[12:07:14.656] <TB0> INFO: clk low = -202.0 mV high= 191.0 mV amplitude = 393.0 mVpp (differential)
[12:07:14.656] <TB0> INFO: ctr low = -238.0 mV high= 226.0 mV amplitude = 464.0 mVpp (differential)
[12:07:14.656] <TB0> INFO: sda low = -241.0 mV high= 225.0 mV amplitude = 466.0 mVpp (differential)
[12:07:14.656] <TB0> INFO: rda low = -71.0 mV high= 57.0 mV amplitude = 128.0 mVpp (differential)
[12:07:14.656] <TB0> INFO: sdata1 low = -111.0 mV high= 97.0 mV amplitude = 208.0 mVpp (differential)
[12:07:14.656] <TB0> INFO: sdata2 low = -12.0 mV high= -6.0 mV amplitude = 6.0 mVpp (differential)
[12:07:16.117] <TB0> INFO: ----------------------------------------------------------------------
[12:07:16.117] <TB0> INFO: PixTestOnShellQuickTest::programROC()
[12:07:16.117] <TB0> INFO: ----------------------------------------------------------------------
[12:07:34.231] <TB0> INFO: PixTestOnShellQuickTest::programROC() done: ROCs are all programmable
[12:07:34.231] <TB0> INFO: IA differences per ROC: 16.1 17.7 16.1 17.7 16.9 16.9 17.7 16.1 16.9 16.1 16.9 16.9 17.7 17.7 17.7 16.9
[12:07:34.282] <TB0> INFO: ----------------------------------------------------------------------
[12:07:34.282] <TB0> INFO: PixTestOnShellQuickTest::setVana() target Ia = 24 mA/ROC
[12:07:34.282] <TB0> INFO: ----------------------------------------------------------------------
[12:07:42.016] <TB0> INFO: PixTestOnShellQuickTest::setVana() done, Module Ia 447.8 mA = 27.9875 mA/ROC
[12:07:42.016] <TB0> INFO: i(loss) [mA/ROC]: 24.1 23.3 23.3 23.3 23.3 23.3 23.3 23.3 23.3 22.5 23.3 23.3 23.3 22.5 22.5 22.5
[12:07:42.055] <TB0> INFO: ----------------------------------------------------------------------
[12:07:42.055] <TB0> INFO: PixTestOnShellQuickTest::findTiming()
[12:07:42.055] <TB0> INFO: ----------------------------------------------------------------------
[12:07:42.055] <TB0> INFO: Testing Timing: Attempt #1
[12:07:43.669] <TB0> INFO: NErrors = 0
[12:07:43.669] <TB0> INFO: NEvents = 10000
[12:07:43.794] <TB0> INFO: Timings are already good, no scan needed!
[12:07:43.950] <TB0> INFO: ----------------------------------------------------------------------
[12:07:43.950] <TB0> INFO: PixTestOnShellQuickTest::findWorkingPixel()
[12:07:43.950] <TB0> INFO: ----------------------------------------------------------------------
[12:07:44.044] <TB0> INFO: Expecting 231680 events.
[12:07:51.638] <TB0> INFO: 231680 events read in total (7037ms).
[12:07:51.654] <TB0> INFO: Test took 7699ms.
[12:07:51.871] <TB0> INFO: Found working pixel in all ROCs: col/row = 12/22
[12:07:51.913] <TB0> INFO: ----------------------------------------------------------------------
[12:07:51.913] <TB0> INFO: PixTestOnShellQuickTest::setVthrCompCalDel()
[12:07:51.913] <TB0> INFO: ----------------------------------------------------------------------
[12:07:51.917] <TB0> INFO: /1
[12:07:51.921] <TB0> INFO: /2
[12:07:52.009] <TB0> INFO: Expecting 463360 events.
[12:08:02.849] <TB0> INFO: 463360 events read in total (10284ms).
[12:08:02.865] <TB0> INFO: Test took 10943ms.
[12:08:02.881] <TB0> INFO: /3
[12:08:03.108] <TB0> INFO: PixTestOnShellQuickTest::setVthrCompCalDel() done
[12:08:03.108] <TB0> INFO: CalDel: 123 138 120 131 132 129 143 139 128 121 125 117 124 131 144 129
[12:08:03.108] <TB0> INFO: VthrComp: 52 53 51 51 51 51 51 51 52 53 51 52 51 51 51 51
[12:08:03.112] <TB0> INFO: ----------------------------------------------------------------------
[12:08:03.112] <TB0> INFO: PixTestOnShellQuickTest::hvQuickTest()
[12:08:03.112] <TB0> INFO: ----------------------------------------------------------------------
[12:08:03.845] <TB0> INFO: Expecting 41600 events.
[12:08:07.159] <TB0> INFO: 41600 events read in total (2758ms).
[12:08:07.160] <TB0> INFO: Test took 3642ms.
[12:08:07.718] <TB0> INFO: Expecting 41600 events.
[12:08:10.876] <TB0> INFO: 41600 events read in total (2602ms).
[12:08:10.878] <TB0> INFO: Test took 3485ms.
[12:08:11.294] <TB0> INFO: Inefficient pixels per ROC: 0 0 0 1 0 0 0 1 3 0 0 0 0 2 0 0
[12:08:11.294] <TB0> INFO: Delta Pixel Alive with HV per ROC: 341 380 139 85 188 119 54 127 1069 422 111 439 31 624 20 151
[12:08:11.295] <TB0> INFO: Database: Dead Pixels
[12:08:11.295] <TB0> INFO: Dead pixels per ROC: 2 0 0 0 0 0 1 0 1 0 0 0 0 0 0 0
[12:08:11.295] <TB0> INFO: Quicktest: Dead Pixels
[12:08:11.295] <TB0> INFO: Dead pixels per ROC: 0 0 0 1 0 0 0 1 3 0 0 0 0 2 0 0
[12:08:11.332] <TB0> INFO: ----------------------------------------------------------------------
[12:08:11.332] <TB0> INFO: PixTestOnShellQuickTest::bbQuickTest()
[12:08:11.332] <TB0> INFO: ----------------------------------------------------------------------
[12:08:11.332] <TB0> INFO: using Ntrig = 10, Vthrcomp = 105, fParVcalS = 250
[12:08:11.664] <TB0> INFO: Expecting 41600 events.
[12:08:14.818] <TB0> INFO: 41600 events read in total (2598ms).
[12:08:14.820] <TB0> INFO: Test took 3485ms.
[12:08:14.836] <TB0> INFO: using Vana from file:
[12:08:14.836] <TB0> INFO: Vana:79 78 78 79 78 88 88 84 80 74 80 83 75 78 84 88
[12:08:14.839] <TB0> INFO: using Vthrcomps from file:
[12:08:14.839] <TB0> INFO: Vthrcomp:100 83 89 94 88 81 81 94 85 84 80 98 85 82 83 82
[12:08:15.233] <TB0> INFO: Expecting 41600 events.
[12:08:18.645] <TB0> INFO: 41600 events read in total (2855ms).
[12:08:18.647] <TB0> INFO: Test took 3741ms.
[12:08:18.882] <TB0> INFO: results from database:
[12:08:18.882] <TB0> INFO: Dead bumps per ROC: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2 0
[12:08:18.882] <TB0> INFO: quicktest:
[12:08:18.882] <TB0> INFO: Dead bumps per ROC: 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[12:08:18.924] <TB0> INFO: ######################################################################
[12:08:18.924] <TB0> INFO: PixTestBB2Map::doTest() Ntrig = 2, VcalS = 222, PlWidth = 35
[12:08:18.924] <TB0> INFO: ######################################################################
[12:08:18.925] <TB0> INFO: ----------------------------------------------------------------------
[12:08:18.926] <TB0> INFO: PixTestBB2Map::setVana() target Ia = 24 mA/ROC
[12:08:18.926] <TB0> INFO: ----------------------------------------------------------------------
[12:08:23.111] <TB0> INFO: PixTestBB2Map::setVana() done, Module Ia 434.9 mA = 27.1813 mA/ROC
[12:08:23.112] <TB0> INFO: ----------------------------------------------------------------------
[12:08:23.112] <TB0> INFO: PixTestBB2Map::setVthrCompCalDel()
[12:08:23.112] <TB0> INFO: ----------------------------------------------------------------------
[12:08:23.206] <TB0> INFO: Expecting 131072 events.
[12:08:30.598] <TB0> INFO: 131072 events read in total (6836ms).
[12:08:30.613] <TB0> INFO: Test took 7493ms.
[12:08:30.845] <TB0> INFO: PixTestBB2Map::setVthrCompCalDel() done
[12:08:30.845] <TB0> INFO: CalDel: 123 140 116 125 135 126 140 135 131 125 124 117 119 131 141 133
[12:08:30.845] <TB0> INFO: VthrComp: 89 90 79 72 77 76 90 75 90 93 88 87 88 89 71 90
[12:08:31.210] <TB0> INFO: Expecting 1064960 events.
[12:09:14.531] <TB0> INFO: 1064960 events read in total (42765ms).
[12:09:14.646] <TB0> INFO: Test took 43763ms.
[12:09:15.539] <TB0> INFO: Missing Bumps: 0 0 0 1 0 0 0 0 0 0 0 0 0 0 0 0
[12:09:15.539] <TB0> INFO: Separation Cut: 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00 45.00
[12:09:15.539] <TB0> INFO: PixTestBB2Map::doTest() done,56 seconds
[12:09:16.270] <TB0> INFO: PixTestOnShellQuickTest::doTest() done, duration: 124 seconds
[12:09:16.415] <TB0> INFO: enter test to run
[12:09:16.415] <TB0> INFO: test: no parameter change
[12:09:16.453] <TB0> QUIET: Connection to board 81 closed.
[12:09:17.072] <TB0> INFO: pXar: this is the end, my friend