Test Date: 1973-11-29 16:33
Analysis date: 2016-07-22 12:42
Logfile
hrData_40.log
[10:45:42.672] INFO: *** Welcome to pxar ***
[10:45:42.672] INFO: *** Today: 2016/07/22
[10:45:42.697] INFO: *** Version: v1.9.0-816-gf0c0
[10:45:42.697] INFO: readRocDacs: data/mp107/dacParameters35_C0.dat .. data/mp107/dacParameters35_C15.dat
[10:45:42.698] INFO: readTbmDacs: data/mp107/tbmParameters_C0a.dat .. data/mp107/tbmParameters_C0b.dat
[10:45:42.698] INFO: readMaskFile: data/mp107/defaultMaskFile.dat
[10:45:42.698] INFO: readTrimFile: data/mp107/trimParameters35_C0.dat .. data/mp107/trimParameters35_C15.dat
[10:45:42.848] INFO: clk: 4
[10:45:42.848] INFO: ctr: 4
[10:45:42.848] INFO: sda: 19
[10:45:42.848] INFO: tin: 9
[10:45:42.848] INFO: level: 15
[10:45:42.848] INFO: triggerdelay: 0
[10:45:42.848] QUIET: Instanciating API for pxar v1.9.0+816~gf0c098f
[10:45:42.848] INFO: Log level: DEBUG
[10:45:42.859] QUIET: Connection to board DTB_WRPRHI opened.
[10:45:42.862] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:45:42.865] INFO: RPC call hashes of host and DTB match: 398089610
[10:45:44.468] INFO: DUT info:
[10:45:44.468] INFO: The DUT currently contains the following objects:
[10:45:44.468] INFO: 2 TBM Cores tbm08c (2 ON)
[10:45:44.468] INFO: TBM Core alpha (0): 7 registers set
[10:45:44.468] INFO: TBM Core beta (1): 7 registers set
[10:45:44.468] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:45:44.468] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.468] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:45:44.469] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:45:44.470] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:45:44.471] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:45:44.472] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:45:44.474] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 32718848
[10:45:44.474] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x17180e0
[10:45:44.474] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x14ba370
[10:45:44.474] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f5511d94010
[10:45:44.474] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f5517fff510
[10:45:44.474] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 32727040 fPxarMemory = 0x7f5511d94010
[10:45:44.475] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 376.2mA
[10:45:44.476] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 476.7mA
[10:45:44.476] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[10:45:44.972] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x1b06f80
[10:45:45.032] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:45:45.032] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:45:45.032] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:45:45.038] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:45:45.038] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:45:45.038] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:45:45.059] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:45:45.060] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:45:45.069] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:45:45.069] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:45:45.087] INFO: PixTestCmd::init()
[10:45:45.104] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:45:45.104] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:45:45.104] INFO: readGainPedestalParameters data/mp107/phCalibrationFitErr35_C0.dat .. data/mp107/phCalibrationFitErr35_C15.dat
[10:45:45.351] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:45:45.351] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:45:45.364] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:45:45.370] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:45:45.370] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[10:45:45.370] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:45:45.391] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:45:45.391] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:45:45.391] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:45:45.391] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:45:45.391] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:45:45.397] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:45:45.397] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:45:45.412] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:45:45.412] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:45:45.412] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:45:45.412] INFO: readReadbackCal: data/mp107/readbackCal_C0.dat .. data/mp107/readbackCal_C15.dat
[10:45:45.422] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:45:45.429] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:45:45.429] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:45:45.429] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:45:45.429] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:45:45.441] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:45:45.441] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:46:03.038] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 02ma
[10:46:05.134] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[10:46:10.411] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[10:46:10.411] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[10:46:10.411] INFO: ----------------------------------------------------------------------
[10:46:10.411] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[10:46:10.411] INFO: ----------------------------------------------------------------------
[10:46:11.385] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[10:46:24.815] INFO: run duration 13 seconds, buffer almost full (81%), pausing triggers.
[10:46:24.819] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:46:52.651] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1323268 events.
[10:46:57.471] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1323268, pixels seen in all events: 4372530
[10:46:57.627] INFO: Resuming triggers.
[10:47:11.064] INFO: run duration 26 seconds, buffer almost full (81%), pausing triggers.
[10:47:11.153] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:47:39.048] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1323771 events.
[10:47:43.843] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1323771, pixels seen in all events: 4365772
[10:47:44.049] INFO: Resuming triggers.
[10:47:57.486] INFO: run duration 40 seconds, buffer almost full (81%), pausing triggers.
[10:47:57.522] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:48:25.406] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1323771 events.
[10:48:30.221] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1323771, pixels seen in all events: 4365690
[10:48:30.429] INFO: Resuming triggers.
[10:48:43.865] INFO: run duration 53 seconds, buffer almost full (81%), pausing triggers.
[10:48:43.897] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:49:11.812] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 1323635 events.
[10:49:16.631] DEBUG: <PixTestXray.cc/processData:L823> # events read: 1323635, pixels seen in all events: 4367619
[10:49:16.839] INFO: Resuming triggers.
[10:49:23.171] INFO: data taking finished, elapsed time: 60 seconds.
[10:49:23.368] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:49:36.619] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 623830 events.
[10:49:38.891] DEBUG: <PixTestXray.cc/processData:L823> # events read: 623830, pixels seen in all events: 2059694
[10:49:38.983] INFO: PixTest:: pg_setup set to default.
[10:49:39.021] INFO: PixTestXray::doPhRun() done
[10:50:29.507] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:50:29.508] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 381mA
[10:50:29.509] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 476.7mA
[10:50:29.509] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[10:50:29.509] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:50:29.509] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:50:29.509] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:50:29.509] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:50:29.509] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:50:29.509] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:50:29.509] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:50:29.509] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:50:29.510] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:50:29.510] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[10:50:29.510] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:50:29.510] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:50:29.510] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:50:29.510] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:50:29.510] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:50:29.510] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:50:29.510] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:50:29.510] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:50:29.779] QUIET: Connection to board 58 closed.
[10:50:29.859] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrData_120.log
[10:50:34.101] INFO: *** Welcome to pxar ***
[10:50:34.101] INFO: *** Today: 2016/07/22
[10:50:34.125] INFO: *** Version: v1.9.0-816-gf0c0
[10:50:34.125] INFO: readRocDacs: data/mp107/dacParameters35_C0.dat .. data/mp107/dacParameters35_C15.dat
[10:50:34.126] INFO: readTbmDacs: data/mp107/tbmParameters_C0a.dat .. data/mp107/tbmParameters_C0b.dat
[10:50:34.127] INFO: readMaskFile: data/mp107/defaultMaskFile.dat
[10:50:34.127] INFO: readTrimFile: data/mp107/trimParameters35_C0.dat .. data/mp107/trimParameters35_C15.dat
[10:50:34.277] INFO: clk: 4
[10:50:34.277] INFO: ctr: 4
[10:50:34.277] INFO: sda: 19
[10:50:34.277] INFO: tin: 9
[10:50:34.277] INFO: level: 15
[10:50:34.277] INFO: triggerdelay: 0
[10:50:34.277] QUIET: Instanciating API for pxar v1.9.0+816~gf0c098f
[10:50:34.277] INFO: Log level: DEBUG
[10:50:34.290] QUIET: Connection to board DTB_WRPRHI opened.
[10:50:34.294] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:50:34.296] INFO: RPC call hashes of host and DTB match: 398089610
[10:50:35.899] INFO: DUT info:
[10:50:35.899] INFO: The DUT currently contains the following objects:
[10:50:35.899] INFO: 2 TBM Cores tbm08c (2 ON)
[10:50:35.899] INFO: TBM Core alpha (0): 7 registers set
[10:50:35.899] INFO: TBM Core beta (1): 7 registers set
[10:50:35.899] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:50:35.899] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.899] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:50:35.900] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:50:35.901] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:50:35.902] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:50:35.903] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:50:35.905] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 36904960
[10:50:35.905] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x1edd0e0
[10:50:35.905] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x1c7f370
[10:50:35.905] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7ffbc9393010
[10:50:35.905] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7ffbcf5fe510
[10:50:35.905] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 36913152 fPxarMemory = 0x7ffbc9393010
[10:50:35.907] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 376.2mA
[10:50:35.908] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 476.7mA
[10:50:35.908] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.4 C
[10:50:36.406] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x22cbfc0
[10:50:36.466] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:50:36.466] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:50:36.467] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:50:36.472] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:50:36.472] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:50:36.472] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:50:36.494] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:50:36.494] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:50:36.506] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:50:36.506] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:50:36.529] INFO: PixTestCmd::init()
[10:50:36.539] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:50:36.539] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:50:36.539] INFO: readGainPedestalParameters data/mp107/phCalibrationFitErr35_C0.dat .. data/mp107/phCalibrationFitErr35_C15.dat
[10:50:36.788] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:50:36.788] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:50:36.802] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:50:36.809] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:50:36.809] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[10:50:36.809] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:50:36.829] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:50:36.829] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:50:36.829] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:50:36.829] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:50:36.829] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:50:36.837] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:50:36.837] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:50:36.854] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:50:36.854] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:50:36.854] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:50:36.854] INFO: readReadbackCal: data/mp107/readbackCal_C0.dat .. data/mp107/readbackCal_C15.dat
[10:50:36.863] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:50:36.870] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:50:36.870] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:50:36.870] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:50:36.870] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:50:36.885] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:50:36.885] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:50:48.718] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 1 -> source to value 06ma
[10:50:50.574] DEBUG: <PixTab.cc/setParameter:L391> xxxPressed(): ID = 2 -> runseconds to value 60
[10:50:55.251] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): phrun
[10:50:55.252] DEBUG: <PixTestXray.cc/runCommand:L109> running command: phrun
[10:50:55.252] INFO: ----------------------------------------------------------------------
[10:50:55.252] INFO: PixTestXray::doPhRun() fParRunSeconds = 60
[10:50:55.252] INFO: ----------------------------------------------------------------------
[10:50:56.225] INFO: PixTestXray::doPhRun start TriggerLoop with trigger frequency 100 kHz, period 405 and duration 60 seconds, fEventsMax = 6000000
[10:51:04.746] INFO: run duration 8 seconds, buffer almost full (81%), pausing triggers.
[10:51:04.750] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:51:30.222] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 839580 events.
[10:51:41.273] DEBUG: <PixTestXray.cc/processData:L823> # events read: 839580, pixels seen in all events: 10178250
[10:51:41.469] INFO: Resuming triggers.
[10:51:49.992] INFO: run duration 17 seconds, buffer almost full (81%), pausing triggers.
[10:51:50.028] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:52:15.391] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 839640 events.
[10:52:26.476] DEBUG: <PixTestXray.cc/processData:L823> # events read: 839640, pixels seen in all events: 10175722
[10:52:26.743] INFO: Resuming triggers.
[10:52:35.268] INFO: run duration 25 seconds, buffer almost full (81%), pausing triggers.
[10:52:35.300] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:53:00.706] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 839873 events.
[10:53:11.774] DEBUG: <PixTestXray.cc/processData:L823> # events read: 839873, pixels seen in all events: 10173521
[10:53:12.037] INFO: Resuming triggers.
[10:53:20.568] INFO: run duration 34 seconds, buffer almost full (81%), pausing triggers.
[10:53:20.603] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:53:45.997] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 840427 events.
[10:53:57.074] DEBUG: <PixTestXray.cc/processData:L823> # events read: 840427, pixels seen in all events: 10166499
[10:53:57.259] INFO: Resuming triggers.
[10:54:05.796] INFO: run duration 42 seconds, buffer almost full (81%), pausing triggers.
[10:54:05.832] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:54:31.255] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 840981 events.
[10:54:42.325] DEBUG: <PixTestXray.cc/processData:L823> # events read: 840981, pixels seen in all events: 10160218
[10:54:42.505] INFO: Resuming triggers.
[10:54:51.037] INFO: run duration 51 seconds, buffer almost full (81%), pausing triggers.
[10:54:51.148] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:55:16.601] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 840515 events.
[10:55:27.682] DEBUG: <PixTestXray.cc/processData:L823> # events read: 840515, pixels seen in all events: 10165744
[10:55:27.949] INFO: Resuming triggers.
[10:55:36.482] INFO: run duration 59 seconds, buffer almost full (81%), pausing triggers.
[10:55:36.516] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:56:02.003] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 840576 events.
[10:56:13.089] DEBUG: <PixTestXray.cc/processData:L823> # events read: 840576, pixels seen in all events: 10164215
[10:56:13.358] INFO: Resuming triggers.
[10:56:13.737] INFO: data taking finished, elapsed time: 60 seconds.
[10:56:13.933] DEBUG: <PixTestXray.cc/processData:L754> Getting Event Buffer
[10:56:15.246] DEBUG: <PixTestXray.cc/processData:L772> Processing Data: 37237 events.
[10:56:15.739] DEBUG: <PixTestXray.cc/processData:L823> # events read: 37237, pixels seen in all events: 450398
[10:56:15.780] INFO: PixTest:: pg_setup set to default.
[10:56:15.817] INFO: PixTestXray::doPhRun() done
[10:57:26.979] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:57:26.980] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 380.2mA
[10:57:26.981] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 476.7mA
[10:57:26.981] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[10:57:26.981] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:57:26.981] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:57:26.981] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:57:26.981] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:57:26.981] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:57:26.981] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:57:26.982] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:57:26.982] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:57:26.982] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:57:26.982] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[10:57:26.982] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:57:26.982] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:57:26.982] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:57:26.982] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:57:26.982] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:57:26.982] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:57:26.982] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:57:26.982] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:57:27.282] QUIET: Connection to board 58 closed.
[10:57:27.361] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_40.log
[10:38:02.748] INFO: *** Welcome to pxar ***
[10:38:02.748] INFO: *** Today: 2016/07/22
[10:38:02.772] INFO: *** Version: v1.9.0-816-gf0c0
[10:38:02.772] INFO: readRocDacs: data/mp107/dacParameters35_C0.dat .. data/mp107/dacParameters35_C15.dat
[10:38:02.773] INFO: readTbmDacs: data/mp107/tbmParameters_C0a.dat .. data/mp107/tbmParameters_C0b.dat
[10:38:02.773] INFO: readMaskFile: data/mp107/defaultMaskFile.dat
[10:38:02.773] INFO: readTrimFile: data/mp107/trimParameters35_C0.dat .. data/mp107/trimParameters35_C15.dat
[10:38:02.923] INFO: clk: 4
[10:38:02.923] INFO: ctr: 4
[10:38:02.923] INFO: sda: 19
[10:38:02.923] INFO: tin: 9
[10:38:02.923] INFO: level: 15
[10:38:02.923] INFO: triggerdelay: 0
[10:38:02.923] QUIET: Instanciating API for pxar v1.9.0+816~gf0c098f
[10:38:02.923] INFO: Log level: DEBUG
[10:38:02.933] QUIET: Connection to board DTB_WRPRHI opened.
[10:38:02.937] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:38:02.940] INFO: RPC call hashes of host and DTB match: 398089610
[10:38:04.541] INFO: DUT info:
[10:38:04.541] INFO: The DUT currently contains the following objects:
[10:38:04.541] INFO: 2 TBM Cores tbm08c (2 ON)
[10:38:04.542] INFO: TBM Core alpha (0): 7 registers set
[10:38:04.542] INFO: TBM Core beta (1): 7 registers set
[10:38:04.542] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:38:04.542] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:38:04.542] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:38:04.542] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:38:04.542] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:38:04.542] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:38:04.542] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:38:04.543] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:38:04.544] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:38:04.545] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:38:04.547] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 31371264
[10:38:04.547] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x255c0e0
[10:38:04.547] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x22fe370
[10:38:04.547] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f5b01d94010
[10:38:04.547] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f5b07fff510
[10:38:04.547] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 31379456 fPxarMemory = 0x7f5b01d94010
[10:38:04.548] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 375.4mA
[10:38:04.550] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 476.7mA
[10:38:04.550] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.2 C
[10:38:05.064] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x294b030
[10:38:05.132] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:38:05.132] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:38:05.132] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:38:05.138] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:38:05.138] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:38:05.138] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:38:05.159] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:38:05.159] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:38:05.169] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:38:05.170] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:38:05.191] INFO: PixTestCmd::init()
[10:38:05.205] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:38:05.205] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:38:05.205] INFO: readGainPedestalParameters data/mp107/phCalibrationFitErr35_C0.dat .. data/mp107/phCalibrationFitErr35_C15.dat
[10:38:05.456] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:38:05.456] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:38:05.469] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:38:05.476] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:38:05.476] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[10:38:05.476] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:38:05.498] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:38:05.498] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:38:05.498] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:38:05.498] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:38:05.498] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:38:05.504] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:38:05.504] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:38:05.519] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:38:05.519] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:38:05.519] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:38:05.519] INFO: readReadbackCal: data/mp107/readbackCal_C0.dat .. data/mp107/readbackCal_C15.dat
[10:38:05.531] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:38:05.538] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:38:05.538] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:38:05.538] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:38:05.538] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:38:05.555] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:38:05.555] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:38:09.246] INFO: ######################################################################
[10:38:09.246] INFO: PixTestAlive::doTest()
[10:38:09.246] INFO: ######################################################################
[10:38:09.250] INFO: ----------------------------------------------------------------------
[10:38:09.250] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:38:09.250] INFO: ----------------------------------------------------------------------
[10:38:09.252] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:09.631] INFO: Expecting 41600 events.
[10:38:14.031] INFO: 41600 events read in total (3682ms).
[10:38:14.179] INFO: Test took 4927ms.
[10:38:14.190] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:14.190] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[10:38:14.190] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[10:38:14.465] INFO: PixTestAlive::aliveTest() done
[10:38:14.465] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:38:14.465] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 6 13 13 32 39 33 34 40 38 34 33 35 19 20 13 12
[10:38:14.493] INFO: ----------------------------------------------------------------------
[10:38:14.493] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:38:14.493] INFO: ----------------------------------------------------------------------
[10:38:14.495] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:14.871] INFO: Expecting 41600 events.
[10:38:17.998] INFO: 41600 events read in total (2411ms).
[10:38:17.998] INFO: Test took 3503ms.
[10:38:17.998] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:17.998] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[10:38:17.998] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[10:38:17.999] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:38:18.421] INFO: PixTestAlive::maskTest() done
[10:38:18.421] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:38:18.440] INFO: ----------------------------------------------------------------------
[10:38:18.440] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:38:18.440] INFO: ----------------------------------------------------------------------
[10:38:18.443] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:18.819] INFO: Expecting 41600 events.
[10:38:23.216] INFO: 41600 events read in total (3681ms).
[10:38:23.217] INFO: Test took 4774ms.
[10:38:23.228] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:23.228] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[10:38:23.228] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[10:38:23.598] INFO: PixTestAlive::addressDecodingTest() done
[10:38:23.598] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:38:23.598] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[10:38:29.459] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[10:38:29.459] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C3_V0 -> PixelAlive_mod
[10:38:32.171] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[10:38:32.171] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[10:38:32.171] INFO: ----------------------------------------------------------------------
[10:38:32.171] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:38:32.171] INFO: ----------------------------------------------------------------------
[10:38:32.310] INFO: Expecting 768 events.
[10:38:33.444] INFO: 768 events read in total (419ms).
[10:38:33.444] INFO: Test took 1267ms.
[10:38:33.450] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:34.248] INFO: Expecting 41600 events.
[10:38:37.487] INFO: 41600 events read in total (2713ms).
[10:38:37.490] INFO: Test took 4040ms.
[10:38:37.556] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:37.556] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 375707
[10:38:37.556] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[10:38:37.557] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:38:37.588] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:38.254] INFO: Expecting 41600 events.
[10:38:41.611] INFO: 41600 events read in total (2831ms).
[10:38:41.614] INFO: Test took 4026ms.
[10:38:41.679] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:41.679] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 385782
[10:38:41.679] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[10:38:41.680] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:38:41.713] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:42.378] INFO: Expecting 41600 events.
[10:38:45.784] INFO: 41600 events read in total (2879ms).
[10:38:45.787] INFO: Test took 4074ms.
[10:38:45.852] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:45.852] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387507
[10:38:45.852] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[10:38:45.852] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:38:45.886] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:46.551] INFO: Expecting 41600 events.
[10:38:49.969] INFO: 41600 events read in total (2891ms).
[10:38:49.972] INFO: Test took 4086ms.
[10:38:50.035] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:50.036] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387615
[10:38:50.036] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[10:38:50.036] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:38:50.069] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:50.734] INFO: Expecting 41600 events.
[10:38:54.149] INFO: 41600 events read in total (2888ms).
[10:38:54.153] INFO: Test took 4084ms.
[10:38:54.217] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:54.217] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 386850
[10:38:54.217] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[10:38:54.217] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:38:54.251] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:54.916] INFO: Expecting 41600 events.
[10:38:58.337] INFO: 41600 events read in total (2895ms).
[10:38:58.340] INFO: Test took 4089ms.
[10:38:58.405] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:38:58.405] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 388982
[10:38:58.405] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[10:38:58.406] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:38:58.439] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:38:59.104] INFO: Expecting 41600 events.
[10:39:02.527] INFO: 41600 events read in total (2896ms).
[10:39:02.531] INFO: Test took 4092ms.
[10:39:02.597] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:02.597] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387498
[10:39:02.597] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[10:39:02.597] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:02.631] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:03.296] INFO: Expecting 41600 events.
[10:39:06.718] INFO: 41600 events read in total (2895ms).
[10:39:06.721] INFO: Test took 4090ms.
[10:39:06.784] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:06.784] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387097
[10:39:06.785] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[10:39:06.785] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:06.818] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:07.483] INFO: Expecting 41600 events.
[10:39:10.902] INFO: 41600 events read in total (2892ms).
[10:39:10.906] INFO: Test took 4088ms.
[10:39:10.970] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:10.970] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387787
[10:39:10.970] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[10:39:10.970] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:11.004] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:11.669] INFO: Expecting 41600 events.
[10:39:15.077] INFO: 41600 events read in total (2882ms).
[10:39:15.080] INFO: Test took 4076ms.
[10:39:15.145] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:15.145] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 388711
[10:39:15.145] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[10:39:15.145] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:15.180] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:15.845] INFO: Expecting 41600 events.
[10:39:19.266] INFO: 41600 events read in total (2894ms).
[10:39:19.269] INFO: Test took 4089ms.
[10:39:19.333] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:19.333] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387725
[10:39:19.333] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[10:39:19.333] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:19.367] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:20.032] INFO: Expecting 41600 events.
[10:39:23.443] INFO: 41600 events read in total (2885ms).
[10:39:23.446] INFO: Test took 4079ms.
[10:39:23.510] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:23.510] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387180
[10:39:23.510] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[10:39:23.510] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:23.544] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:24.209] INFO: Expecting 41600 events.
[10:39:27.618] INFO: 41600 events read in total (2882ms).
[10:39:27.622] INFO: Test took 4078ms.
[10:39:27.685] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:27.685] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387663
[10:39:27.685] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[10:39:27.686] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:27.720] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:28.385] INFO: Expecting 41600 events.
[10:39:31.806] INFO: 41600 events read in total (2895ms).
[10:39:31.809] INFO: Test took 4089ms.
[10:39:31.873] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:31.873] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 386471
[10:39:31.873] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[10:39:31.874] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:31.908] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:32.573] INFO: Expecting 41600 events.
[10:39:35.999] INFO: 41600 events read in total (2899ms).
[10:39:36.002] INFO: Test took 4094ms.
[10:39:36.066] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:36.066] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 386981
[10:39:36.066] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[10:39:36.066] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:36.100] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:36.765] INFO: Expecting 41600 events.
[10:39:40.205] INFO: 41600 events read in total (2913ms).
[10:39:40.208] INFO: Test took 4108ms.
[10:39:40.272] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:40.272] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 387457
[10:39:40.273] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[10:39:40.273] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:40.307] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:40.972] INFO: Expecting 41600 events.
[10:39:44.397] INFO: 41600 events read in total (2899ms).
[10:39:44.401] INFO: Test took 4094ms.
[10:39:44.464] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:44.464] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 386687
[10:39:44.464] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[10:39:44.465] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:44.499] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:45.164] INFO: Expecting 41600 events.
[10:39:48.564] INFO: 41600 events read in total (2873ms).
[10:39:48.567] INFO: Test took 4068ms.
[10:39:48.631] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:48.631] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 386512
[10:39:48.631] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[10:39:48.632] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:48.666] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:49.331] INFO: Expecting 41600 events.
[10:39:52.723] INFO: 41600 events read in total (2865ms).
[10:39:52.727] INFO: Test took 4061ms.
[10:39:52.790] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:52.790] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 386420
[10:39:52.790] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[10:39:52.791] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:52.824] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:39:53.490] INFO: Expecting 41600 events.
[10:39:56.724] INFO: 41600 events read in total (2707ms).
[10:39:56.727] INFO: Test took 3903ms.
[10:39:56.791] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:39:56.791] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 378721
[10:39:56.791] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[10:39:56.792] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:39:57.053] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 143 eff = 0.999856
[10:39:57.053] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 155 eff = 0.999832
[10:39:57.054] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 169 eff = 0.999519
[10:39:57.054] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 152 eff = 0.999303
[10:39:57.054] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 161 eff = 0.999327
[10:39:57.054] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 185 eff = 0.999183
[10:39:57.054] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 150 eff = 0.999327
[10:39:57.054] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 151 eff = 0.999255
[10:39:57.054] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 164 eff = 0.999087
[10:39:57.055] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 128 eff = 0.999111
[10:39:57.055] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 143 eff = 0.999231
[10:39:57.055] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 149 eff = 0.999255
[10:39:57.055] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 153 eff = 0.999399
[10:39:57.055] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 150 eff = 0.999688
[10:39:57.055] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 124 eff = 0.999784
[10:39:57.055] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 147 eff = 0.99988
[10:40:03.011] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[10:40:03.011] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[10:40:03.011] INFO: ----------------------------------------------------------------------
[10:40:03.011] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:40:03.011] INFO: ----------------------------------------------------------------------
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[10:40:03.012] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[10:40:03.030] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:40:03.699] INFO: Expecting 208000 events.
[10:40:16.572] INFO: 208000 events read in total (12346ms).
[10:40:16.580] INFO: Test took 13550ms.
[10:40:16.859] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:40:16.860] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 1660279
[10:40:16.860] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[10:40:16.860] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:40:17.203] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:40:17.203] INFO: number of red-efficiency pixels: 54 50 121 194 168 199 192 166 197 228 159 199 163 131 59 43
[10:40:17.203] INFO: number of X-ray hits detected: 38558 45051 78703 119226 124781 132883 129121 123826 137507 132767 128331 120926 121371 78863 46224 35581
[10:40:17.203] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:40:17.203] INFO: number of Vcal hits detected: 207946 207949 207878 207799 207826 207792 207801 207832 207794 207766 207834 207798 207837 207867 207938 207957
[10:40:17.203] INFO: Vcal hit fiducial efficiency (%): 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[10:40:17.203] INFO: Vcal hit overall efficiency (%): 100.0 100.0 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 99.9 100.0 100.0
[10:40:17.203] INFO: X-ray hit rate [MHz/cm2]: 11.3 13.2 23.1 34.9 36.6 38.9 37.8 36.3 40.3 38.9 37.6 35.4 35.6 23.1 13.5 10.4
[10:40:17.204] INFO: PixTestHighRate::doXPixelAlive() done
[10:40:17.248] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[10:40:17.248] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[10:40:17.248] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[10:40:17.248] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[10:40:17.248] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[10:40:17.248] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[10:40:17.248] INFO: PixTest:: pg_setup set to default.
[10:40:29.923] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[10:40:29.923] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C11_V0 -> highRate_xraymap_mod
[10:40:32.739] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:40:32.740] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 380.2mA
[10:40:32.741] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 475.9mA
[10:40:32.741] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[10:40:32.741] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:40:32.741] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:40:32.741] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:40:32.741] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:40:32.741] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:40:32.741] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:40:32.741] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:40:32.741] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:40:32.741] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:40:32.741] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[10:40:32.829] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:40:32.829] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:40:32.842] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:40:32.843] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:40:32.843] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:40:32.843] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:40:32.843] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:40:32.843] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:40:32.845] QUIET: Connection to board 58 closed.
[10:40:32.925] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_80.log
[10:34:42.498] INFO: *** Welcome to pxar ***
[10:34:42.498] INFO: *** Today: 2016/07/22
[10:34:42.522] INFO: *** Version: v1.9.0-816-gf0c0
[10:34:42.522] INFO: readRocDacs: data/mp107/dacParameters35_C0.dat .. data/mp107/dacParameters35_C15.dat
[10:34:42.523] INFO: readTbmDacs: data/mp107/tbmParameters_C0a.dat .. data/mp107/tbmParameters_C0b.dat
[10:34:42.523] INFO: readMaskFile: data/mp107/defaultMaskFile.dat
[10:34:42.523] INFO: readTrimFile: data/mp107/trimParameters35_C0.dat .. data/mp107/trimParameters35_C15.dat
[10:34:42.674] INFO: clk: 4
[10:34:42.675] INFO: ctr: 4
[10:34:42.675] INFO: sda: 19
[10:34:42.675] INFO: tin: 9
[10:34:42.675] INFO: level: 15
[10:34:42.675] INFO: triggerdelay: 0
[10:34:42.675] QUIET: Instanciating API for pxar v1.9.0+816~gf0c098f
[10:34:42.675] INFO: Log level: DEBUG
[10:34:42.685] QUIET: Connection to board DTB_WRPRHI opened.
[10:34:42.689] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:34:42.692] INFO: RPC call hashes of host and DTB match: 398089610
[10:34:44.293] INFO: DUT info:
[10:34:44.293] INFO: The DUT currently contains the following objects:
[10:34:44.293] INFO: 2 TBM Cores tbm08c (2 ON)
[10:34:44.293] INFO: TBM Core alpha (0): 7 registers set
[10:34:44.293] INFO: TBM Core beta (1): 7 registers set
[10:34:44.293] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:34:44.293] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.293] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:34:44.294] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:34:44.295] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:34:44.296] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:34:44.297] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:34:44.300] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33107968
[10:34:44.300] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x1d3f170
[10:34:44.300] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x1ccd370
[10:34:44.300] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f24c5d94010
[10:34:44.300] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f24cbfff510
[10:34:44.300] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33116160 fPxarMemory = 0x7f24c5d94010
[10:34:44.301] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 375.4mA
[10:34:44.302] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 475.9mA
[10:34:44.302] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.1 C
[10:34:44.797] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x231a0b0
[10:34:44.917] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:34:44.917] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:34:44.917] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:34:44.922] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:34:44.922] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:34:44.923] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:34:44.943] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:34:44.944] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:34:44.984] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:34:44.984] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:34:44.999] INFO: PixTestCmd::init()
[10:34:45.003] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:34:45.003] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:34:45.004] INFO: readGainPedestalParameters data/mp107/phCalibrationFitErr35_C0.dat .. data/mp107/phCalibrationFitErr35_C15.dat
[10:34:45.254] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:34:45.254] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:34:45.268] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:34:45.333] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:34:45.333] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[10:34:45.333] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:34:45.352] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:34:45.353] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:34:45.353] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:34:45.353] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:34:45.353] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:34:45.359] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:34:45.359] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:34:45.377] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:34:45.377] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:34:45.377] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:34:45.378] INFO: readReadbackCal: data/mp107/readbackCal_C0.dat .. data/mp107/readbackCal_C15.dat
[10:34:45.388] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:34:45.396] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:34:45.396] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:34:45.396] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:34:45.396] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:34:45.411] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:34:45.411] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:34:51.046] INFO: ######################################################################
[10:34:51.046] INFO: PixTestAlive::doTest()
[10:34:51.046] INFO: ######################################################################
[10:34:51.050] INFO: ----------------------------------------------------------------------
[10:34:51.050] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:34:51.050] INFO: ----------------------------------------------------------------------
[10:34:51.052] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:34:51.430] INFO: Expecting 41600 events.
[10:34:55.831] INFO: 41600 events read in total (3682ms).
[10:34:55.979] INFO: Test took 4927ms.
[10:34:55.991] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:55.991] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[10:34:55.991] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[10:34:56.264] INFO: PixTestAlive::aliveTest() done
[10:34:56.264] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:34:56.264] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 16 18 36 48 52 77 59 67 59 58 49 72 55 46 15 22
[10:34:56.291] INFO: ----------------------------------------------------------------------
[10:34:56.291] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:34:56.291] INFO: ----------------------------------------------------------------------
[10:34:56.293] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:34:56.669] INFO: Expecting 41600 events.
[10:34:59.799] INFO: 41600 events read in total (2414ms).
[10:34:59.800] INFO: Test took 3507ms.
[10:34:59.800] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:34:59.800] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[10:34:59.800] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[10:34:59.800] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:35:00.222] INFO: PixTestAlive::maskTest() done
[10:35:00.222] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:35:00.241] INFO: ----------------------------------------------------------------------
[10:35:00.242] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:35:00.242] INFO: ----------------------------------------------------------------------
[10:35:00.244] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:00.620] INFO: Expecting 41600 events.
[10:35:04.978] INFO: 41600 events read in total (3644ms).
[10:35:04.980] INFO: Test took 4736ms.
[10:35:04.991] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:04.991] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[10:35:04.992] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[10:35:05.361] INFO: PixTestAlive::addressDecodingTest() done
[10:35:05.361] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:35:05.362] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[10:35:13.931] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[10:35:13.931] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C4_V0 -> PixelAlive_mod
[10:35:17.427] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[10:35:17.427] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[10:35:17.427] INFO: ----------------------------------------------------------------------
[10:35:17.427] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:35:17.427] INFO: ----------------------------------------------------------------------
[10:35:17.566] INFO: Expecting 768 events.
[10:35:18.699] INFO: 768 events read in total (417ms).
[10:35:18.699] INFO: Test took 1266ms.
[10:35:18.705] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:19.503] INFO: Expecting 41600 events.
[10:35:23.026] INFO: 41600 events read in total (2996ms).
[10:35:23.031] INFO: Test took 4326ms.
[10:35:23.140] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:23.140] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 630231
[10:35:23.140] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[10:35:23.141] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:23.189] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:23.855] INFO: Expecting 41600 events.
[10:35:27.500] INFO: 41600 events read in total (3118ms).
[10:35:27.506] INFO: Test took 4317ms.
[10:35:27.616] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:27.616] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 639792
[10:35:27.616] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[10:35:27.617] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:27.667] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:28.332] INFO: Expecting 41600 events.
[10:35:32.015] INFO: 41600 events read in total (3156ms).
[10:35:32.019] INFO: Test took 4352ms.
[10:35:32.125] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:32.125] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 642499
[10:35:32.125] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[10:35:32.126] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:32.177] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:32.843] INFO: Expecting 41600 events.
[10:35:36.538] INFO: 41600 events read in total (3168ms).
[10:35:36.542] INFO: Test took 4365ms.
[10:35:36.652] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:36.652] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 641608
[10:35:36.652] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[10:35:36.653] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:36.703] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:37.369] INFO: Expecting 41600 events.
[10:35:41.074] INFO: 41600 events read in total (3179ms).
[10:35:41.078] INFO: Test took 4375ms.
[10:35:41.187] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:41.187] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 643427
[10:35:41.187] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[10:35:41.187] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:41.238] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:41.903] INFO: Expecting 41600 events.
[10:35:45.613] INFO: 41600 events read in total (3183ms).
[10:35:45.617] INFO: Test took 4379ms.
[10:35:45.726] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:45.726] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 642587
[10:35:45.726] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[10:35:45.727] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:45.777] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:46.443] INFO: Expecting 41600 events.
[10:35:50.158] INFO: 41600 events read in total (3189ms).
[10:35:50.162] INFO: Test took 4385ms.
[10:35:50.272] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:50.272] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 643660
[10:35:50.272] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[10:35:50.273] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:50.323] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:50.988] INFO: Expecting 41600 events.
[10:35:54.705] INFO: 41600 events read in total (3190ms).
[10:35:54.709] INFO: Test took 4386ms.
[10:35:54.817] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:54.817] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 643513
[10:35:54.817] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[10:35:54.818] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:54.869] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:35:55.534] INFO: Expecting 41600 events.
[10:35:59.269] INFO: 41600 events read in total (3208ms).
[10:35:59.273] INFO: Test took 4404ms.
[10:35:59.383] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:35:59.383] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 644841
[10:35:59.383] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[10:35:59.384] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:35:59.434] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:00.099] INFO: Expecting 41600 events.
[10:36:03.822] INFO: 41600 events read in total (3196ms).
[10:36:03.827] INFO: Test took 4393ms.
[10:36:03.936] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:03.936] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 642830
[10:36:03.936] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[10:36:03.936] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:03.987] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:04.653] INFO: Expecting 41600 events.
[10:36:08.378] INFO: 41600 events read in total (3198ms).
[10:36:08.382] INFO: Test took 4395ms.
[10:36:08.491] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:08.491] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 644284
[10:36:08.492] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[10:36:08.492] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:08.542] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:09.208] INFO: Expecting 41600 events.
[10:36:12.932] INFO: 41600 events read in total (3198ms).
[10:36:12.937] INFO: Test took 4394ms.
[10:36:13.045] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:13.045] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 642867
[10:36:13.045] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[10:36:13.045] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:13.096] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:13.762] INFO: Expecting 41600 events.
[10:36:17.481] INFO: 41600 events read in total (3192ms).
[10:36:17.485] INFO: Test took 4389ms.
[10:36:17.593] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:17.593] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 642301
[10:36:17.593] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[10:36:17.593] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:17.644] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:18.310] INFO: Expecting 41600 events.
[10:36:22.032] INFO: 41600 events read in total (3196ms).
[10:36:22.036] INFO: Test took 4392ms.
[10:36:22.145] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:22.145] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 644475
[10:36:22.145] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[10:36:22.145] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:22.196] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:22.861] INFO: Expecting 41600 events.
[10:36:26.580] INFO: 41600 events read in total (3192ms).
[10:36:26.584] INFO: Test took 4388ms.
[10:36:26.693] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:26.693] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 642658
[10:36:26.693] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[10:36:26.693] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:26.744] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:27.409] INFO: Expecting 41600 events.
[10:36:31.132] INFO: 41600 events read in total (3196ms).
[10:36:31.136] INFO: Test took 4392ms.
[10:36:31.244] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:31.244] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 642496
[10:36:31.244] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[10:36:31.245] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:31.295] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:31.960] INFO: Expecting 41600 events.
[10:36:35.680] INFO: 41600 events read in total (3194ms).
[10:36:35.685] INFO: Test took 4390ms.
[10:36:35.793] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:35.793] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 642358
[10:36:35.793] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[10:36:35.793] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:35.844] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:36.508] INFO: Expecting 41600 events.
[10:36:40.228] INFO: 41600 events read in total (3193ms).
[10:36:40.232] INFO: Test took 4388ms.
[10:36:40.339] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:40.339] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 643016
[10:36:40.339] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[10:36:40.339] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:40.390] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:41.054] INFO: Expecting 41600 events.
[10:36:44.736] INFO: 41600 events read in total (3155ms).
[10:36:44.740] INFO: Test took 4350ms.
[10:36:44.849] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:44.849] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 641737
[10:36:44.849] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[10:36:44.849] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:44.900] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:45.565] INFO: Expecting 41600 events.
[10:36:49.136] INFO: 41600 events read in total (3045ms).
[10:36:49.140] INFO: Test took 4240ms.
[10:36:49.249] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:36:49.249] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 636144
[10:36:49.249] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[10:36:49.249] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:36:49.521] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 152 eff = 0.99976
[10:36:49.521] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 167 eff = 0.999591
[10:36:49.522] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 180 eff = 0.998702
[10:36:49.522] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 175 eff = 0.998053
[10:36:49.522] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 164 eff = 0.998221
[10:36:49.522] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 192 eff = 0.997428
[10:36:49.522] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 155 eff = 0.997813
[10:36:49.522] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 158 eff = 0.998365
[10:36:49.523] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 166 eff = 0.997933
[10:36:49.523] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 137 eff = 0.997861
[10:36:49.523] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 141 eff = 0.997716
[10:36:49.524] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 161 eff = 0.998149
[10:36:49.524] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 154 eff = 0.998173
[10:36:49.524] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 162 eff = 0.99887
[10:36:49.524] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 147 eff = 0.999663
[10:36:49.524] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 149 eff = 0.999688
[10:36:53.459] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[10:36:53.459] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[10:36:53.459] INFO: ----------------------------------------------------------------------
[10:36:53.459] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:36:53.459] INFO: ----------------------------------------------------------------------
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[10:36:53.460] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[10:36:53.483] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:36:54.153] INFO: Expecting 208000 events.
[10:37:09.104] INFO: 208000 events read in total (14424ms).
[10:37:09.120] INFO: Test took 15637ms.
[10:37:09.650] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:37:09.650] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 2922562
[10:37:09.650] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[10:37:09.651] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:37:10.073] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:37:10.073] INFO: number of red-efficiency pixels: 94 125 242 349 411 428 436 395 523 466 505 398 435 265 109 84
[10:37:10.073] INFO: number of X-ray hits detected: 69385 80756 140916 213368 221719 238996 231487 221359 245728 238566 231601 216650 217569 141816 82847 63239
[10:37:10.073] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:37:10.073] INFO: number of Vcal hits detected: 207901 207868 207712 207626 207560 207532 207523 207574 207401 207487 207457 207573 207526 207721 207888 207915
[10:37:10.073] INFO: Vcal hit fiducial efficiency (%): 100.0 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.8 99.8 99.8 99.9 99.9 100.0
[10:37:10.073] INFO: Vcal hit overall efficiency (%): 100.0 99.9 99.9 99.8 99.8 99.8 99.8 99.8 99.7 99.8 99.7 99.8 99.8 99.9 99.9 100.0
[10:37:10.073] INFO: X-ray hit rate [MHz/cm2]: 20.3 23.7 41.3 62.5 65.0 70.1 67.9 64.9 72.0 69.9 67.9 63.5 63.8 41.6 24.3 18.5
[10:37:10.073] INFO: PixTestHighRate::doXPixelAlive() done
[10:37:10.117] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[10:37:10.117] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[10:37:10.117] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[10:37:10.117] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[10:37:10.117] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[10:37:10.117] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[10:37:10.117] INFO: PixTest:: pg_setup set to default.
[10:37:49.507] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[10:37:49.507] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C11_V0 -> highRate_xraymap_mod
[10:37:57.955] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:37:57.956] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 380.2mA
[10:37:57.957] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 476.7mA
[10:37:57.957] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.1 C
[10:37:57.957] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:37:57.957] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:37:57.957] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:37:57.957] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:37:57.957] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:37:57.957] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:37:57.957] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:37:57.957] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:37:57.957] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:37:57.958] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[10:37:58.061] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:37:58.061] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:37:58.075] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:37:58.075] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:37:58.075] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:37:58.075] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:37:58.075] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:37:58.075] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:37:58.078] QUIET: Connection to board 58 closed.
[10:37:58.157] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
hrEff_120.log
[10:28:08.210] INFO: *** Welcome to pxar ***
[10:28:08.210] INFO: *** Today: 2016/07/22
[10:28:08.237] INFO: *** Version: v1.9.0-816-gf0c0
[10:28:08.238] INFO: readRocDacs: data/mp107/dacParameters35_C0.dat .. data/mp107/dacParameters35_C15.dat
[10:28:08.239] INFO: readTbmDacs: data/mp107/tbmParameters_C0a.dat .. data/mp107/tbmParameters_C0b.dat
[10:28:08.239] INFO: readMaskFile: data/mp107/defaultMaskFile.dat
[10:28:08.239] INFO: readTrimFile: data/mp107/trimParameters35_C0.dat .. data/mp107/trimParameters35_C15.dat
[10:28:08.388] INFO: clk: 4
[10:28:08.388] INFO: ctr: 4
[10:28:08.388] INFO: sda: 19
[10:28:08.388] INFO: tin: 9
[10:28:08.388] INFO: level: 15
[10:28:08.388] INFO: triggerdelay: 0
[10:28:08.388] QUIET: Instanciating API for pxar v1.9.0+816~gf0c098f
[10:28:08.388] INFO: Log level: DEBUG
[10:28:08.400] QUIET: Connection to board DTB_WRPRHI opened.
[10:28:08.403] INFO: DTB startup information
--- DTB info------------------------------------------
Board id: 58
HW version: DTB1.2
FW version: 4.2
SW version: 4.5
USB id: DTB_WRPRHI
MAC address: 40D85511803A
Hostname: pixelDTB058
Comment:
------------------------------------------------------
[10:28:08.406] INFO: RPC call hashes of host and DTB match: 398089610
[10:28:10.008] INFO: DUT info:
[10:28:10.008] INFO: The DUT currently contains the following objects:
[10:28:10.008] INFO: 2 TBM Cores tbm08c (2 ON)
[10:28:10.008] INFO: TBM Core alpha (0): 7 registers set
[10:28:10.009] INFO: TBM Core beta (1): 7 registers set
[10:28:10.009] INFO: 16 ROCs psi46digv21respin (16 ON) with 4160 pixelConfigs
[10:28:10.009] INFO: ROC 0: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 1: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 2: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 3: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 4: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 5: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 6: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 7: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 8: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 9: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 10: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 11: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 12: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 13: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 14: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] INFO: ROC 15: 19 DACs set, Pixels: 0 masked, 0 active.
[10:28:10.009] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB<-
[10:28:10.009] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:28:10.009] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:28:10.009] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:28:10.009] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB2<-
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 222
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> plwidth: 35
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB3<-
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> vcals: 250
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->BB4<-
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> savecaldelscan: checkbox(0)
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 100
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> cals: 1
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> caldello: 80
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> caldelhi: 200
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> caldelstep: 10
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomplo: 70
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> vthrcomphi: 130
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompstep: 5
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> noisypixels: 10
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 255
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> cut: 0.5
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Cmd<-
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DAQ<-
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> trgnumber: 5
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 10
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> rundaqtrg: button
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> daqseconds: 5
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> rundaqseconds: button
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacDacScan<-
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dac1: caldel
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dac1lo: 0
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dac1hi: 255
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dac2: vthrcomp
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dac2lo: 0
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dac2hi: 255
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->DacScan<-
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> phmap: checkbox(1)
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> allpixels: checkbox(0)
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> unmasked: checkbox(0)
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dac: vcal
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 255
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->GainPedestal<-
[10:28:10.010] DEBUG: <PixTestParameters.cc/dump:L107> showfits: checkbox(0)
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> extended: checkbox(0)
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> dumphists: checkbox(0)
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> vcalstep: 10
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> measure: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> fit: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> save: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->HighRate<-
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixels: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> trimhotpixelthr: 200
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> runsecondshotpixels: 10
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> savetrimbits: checkbox(1)
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> maskuntrimmable: checkbox(1)
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> caldelscan: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> xpixelalive: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> xnoisemaps: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 100
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: 20
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> rundaq: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 20
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 2
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> triggerdelay: 20
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->IV<-
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> port: /dev/FIXME
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> voltagestart: 0
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> voltagestop: 600
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> voltagestep: 5
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> delay: 1
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> compliance(ua): 100
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PhOptimization<-
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> safetymarginlow: 20
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> saturationvcal: 100
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> quantilesaturation: 0.98
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->PixelAlive<-
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 200
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> alivetest: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> masktest: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> addressdecodingtest: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Pretest<-
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> programroc: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> targetia: 24
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> iterations: 100
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> settimings: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> findtiming: button
[10:28:10.011] DEBUG: <PixTestParameters.cc/dump:L107> findworkingpixel: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> setvthrcompcaldel: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> pix: 11,20
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 250
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> deltavthrcomp: 50
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> fraccaldel: 0.5
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 5
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> savedacs: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Readback<-
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> calibratevd: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> calibrateva: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> calibrateia: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> readbackvbg: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> getcalibratedvbg: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> usecalvd: checkbox(1)
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> usecalva: checkbox(0)
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> setvana: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Scurves<-
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> adjustvcal: checkbox(0)
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> dumpall: checkbox(0)
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> dumpproblematic: checkbox(0)
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> dumpoutputfile: checkbox(0)
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 50
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> dac: Vcal
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> daclo: 0
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> dachi: 200
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> dacs/step: -1
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> ntrig/step: -1
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> scurves: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Timing<-
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> targetclk: 4
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 10
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> clocksdascan: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> notokenpass: checkbox(0)
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> phasescan: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> levelscan: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> tbmphasescan: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> rocdelayscan: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> timingtest: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> saveparameters: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Trim<-
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> trim: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> ntrig: 8
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> vcal: 35
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> trimbits: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L104> PixTestParameters: ->Xray<-
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> maskhotpixels: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> savemaskfile: checkbox(0)
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> maskfilename: default
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> source: Ag
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> phrun: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> runseconds: 100
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> trgfrequency(khz): 100
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> ratescan: button
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmin: 10
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> vthrcompmax: 80
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> stepseconds: 5
[10:28:10.012] DEBUG: <PixTestParameters.cc/dump:L107> delaytbm: checkbox
[10:28:10.013] DEBUG: <PixTestParameters.cc/dump:L107> filltree: checkbox
[10:28:10.015] DEBUG: <PixSetup.cc/init:L81> PixSetup init start; getCurrentRSS() = 33488896
[10:28:10.015] DEBUG: <PixSetup.cc/init:L87> fPixTestParameters = 0x2ae70e0
[10:28:10.015] DEBUG: <PixSetup.cc/init:L88> fConfigParameters = 0x2889370
[10:28:10.015] DEBUG: <PixSetup.cc/init:L89> fPxarMemory = 0x7f3249d94010
[10:28:10.015] DEBUG: <PixSetup.cc/init:L90> fPxarMemHi = 0x7f324ffff510
[10:28:10.015] DEBUG: <PixSetup.cc/init:L106> PixSetup init done; getCurrentRSS() = 33497088 fPxarMemory = 0x7f3249d94010
[10:28:10.016] DEBUG: <pXar.cc/main:L223> Initial Analog Current: 376.2mA
[10:28:10.017] DEBUG: <pXar.cc/main:L224> Initial Digital Current: 476.7mA
[10:28:10.017] DEBUG: <pXar.cc/main:L225> Initial Module Temperature: -0.1 C
[10:28:10.515] DEBUG: <PixGui.cc/hvOn:L460> HV set On: 0x2ed5fd0
[10:28:10.583] DEBUG: <PixTestFactory.cc/PixTestFactory:L53> PixTestFactory::PixTestFactory()
[10:28:10.583] DEBUG: <PixTestBBMap.cc/init:L79> PixTestBBMap::init()
[10:28:10.583] DEBUG: <PixTestBBMap.cc/PixTestBBMap:L27> PixTestBBMap ctor(PixSetup &a, string, TGTab *)
[10:28:10.589] DEBUG: <PixTestBB2Map.cc/setParameter:L58> setting fTargetIa = 24 mA/ROC
[10:28:10.589] DEBUG: <PixTestBB2Map.cc/init:L97> PixTestBB2Map::init()
[10:28:10.589] DEBUG: <PixTestBB2Map.cc/PixTestBB2Map:L29> PixTestBB2Map ctor(PixSetup &a, string, TGTab *)
[10:28:10.611] DEBUG: <PixTestBB3Map.cc/init:L81> PixTestBB3Map::init()
[10:28:10.611] DEBUG: <PixTestBB3Map.cc/PixTestBB3Map:L29> PixTestBB3Map ctor(PixSetup &a, string, TGTab *)
[10:28:10.627] DEBUG: <PixTestBB4Map.cc/init:L93> PixTestBB4Map::init()
[10:28:10.627] DEBUG: <PixTestBB4Map.cc/PixTestBB4Map:L26> PixTestMapeff ctor(PixSetup &a, string, TGTab *)
[10:28:10.638] INFO: PixTestCmd::init()
[10:28:10.652] DEBUG: <PixTestDaq.cc/init:L44> PixTestDaq::init()
[10:28:10.653] DEBUG: <PixTestDaq.cc/PixTestDaq:L22> PixTestDaq ctor(PixSetup &a, string, TGTab *)
[10:28:10.653] INFO: readGainPedestalParameters data/mp107/phCalibrationFitErr35_C0.dat .. data/mp107/phCalibrationFitErr35_C15.dat
[10:28:10.902] DEBUG: <PixTestDacDacScan.cc/init:L103> PixTestDacDacScan::init()
[10:28:10.902] DEBUG: <PixTestDacDacScan.cc/PixTestDacDacScan:L22> PixTestDacDacScan ctor(PixSetup &a, string, TGTab *)
[10:28:10.917] DEBUG: <PixTestGainPedestal.cc/setParameter:L83> PixTestGainPedestal::PixTest() fVcalStep = 10
[10:28:10.924] DEBUG: <PixTestHighRate.cc/setParameter:L68> setting fParTriggerFrequency -> 20
[10:28:10.924] DEBUG: <PixTestHighRate.cc/init:L211> PixTestHighRate::init()
[10:28:10.924] DEBUG: <PixTestHighRate.cc/PixTestHighRate:L31> PixTestHighRate ctor(PixSetup &a, string, TGTab *)
[10:28:10.946] DEBUG: <PixTest.cc/setTestParameter:L637> setting ntrig to new value 10
[10:28:10.946] DEBUG: <PixTestPhOptimization.cc/setParameter:L37> setting fParNtrig ->10<- from sval = 10
[10:28:10.946] DEBUG: <PixTestPhOptimization.cc/setParameter:L42> setting fSafetyMarginLow ->20<- from sval = 20
[10:28:10.946] DEBUG: <PixTestPhOptimization.cc/setParameter:L48> setting fVcalMax ->100<- from sval = 100
[10:28:10.946] DEBUG: <PixTestPhOptimization.cc/setParameter:L53> setting fQuantMax ->0.98<- from sval = 0.98
[10:28:10.952] DEBUG: <PixTestAlive.cc/init:L83> PixTestAlive::init()
[10:28:10.952] DEBUG: <PixTestAlive.cc/PixTestAlive:L21> PixTestAlive ctor(PixSetup &a, string, TGTab *)
[10:28:10.966] DEBUG: <PixTestReadback.cc/setParameter:L172> fCalwVd set to 1
[10:28:10.967] DEBUG: <PixTestReadback.cc/init:L95> PixTestReadback::init()
[10:28:10.967] DEBUG: <PixTestReadback.cc/PixTestReadback:L22> PixTestReadback ctor(PixSetup &a, string, TGTab *)
[10:28:10.967] INFO: readReadbackCal: data/mp107/readbackCal_C0.dat .. data/mp107/readbackCal_C15.dat
[10:28:10.976] DEBUG: <PixTestScurves.cc/setParameter:L93> set fOutputFilename =
[10:28:10.984] DEBUG: <PixTestTiming.cc/setParameter:L61> PixTestTiming::PixTest() targetclk = 4
[10:28:10.984] DEBUG: <PixTestTiming.cc/setParameter:L65> PixTestTiming::PixTest() ntrig = 10
[10:28:10.984] DEBUG: <PixTestTiming.cc/setParameter:L49> fNoTokenPass: 0
[10:28:10.984] DEBUG: <PixTestTiming.cc/init:L75> PixTestTiming::init()
[10:28:10.996] DEBUG: <PixTestXray.cc/init:L135> PixTestXray::init()
[10:28:10.996] DEBUG: <PixTestXray.cc/PixTestXray:L28> PixTestXray ctor(PixSetup &a, string, TGTab *)
[10:28:13.366] INFO: ######################################################################
[10:28:13.368] INFO: PixTestAlive::doTest()
[10:28:13.368] INFO: ######################################################################
[10:28:13.371] INFO: ----------------------------------------------------------------------
[10:28:13.371] INFO: PixTestAlive::aliveTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:28:13.371] INFO: ----------------------------------------------------------------------
[10:28:13.374] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:13.750] INFO: Expecting 41600 events.
[10:28:18.148] INFO: 41600 events read in total (3680ms).
[10:28:18.296] INFO: Test took 4922ms.
[10:28:18.308] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:18.308] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[10:28:18.308] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists PixelAlive_C0 .. PixelAlive_C15
[10:28:18.584] INFO: PixTestAlive::aliveTest() done
[10:28:18.584] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:28:18.584] DEBUG: <PixTestAlive.cc/aliveTest:L199> number of red-efficiency pixels: 31 37 51 58 54 82 71 72 81 85 63 59 73 50 27 16
[10:28:18.609] INFO: ----------------------------------------------------------------------
[10:28:18.609] INFO: PixTestAlive::maskTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:28:18.609] INFO: ----------------------------------------------------------------------
[10:28:18.611] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:18.988] INFO: Expecting 41600 events.
[10:28:22.109] INFO: 41600 events read in total (2406ms).
[10:28:22.109] INFO: Test took 3498ms.
[10:28:22.109] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:22.109] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 0
[10:28:22.109] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists MaskTest_C0 .. MaskTest_C15
[10:28:22.110] INFO: mask vs. old pixelAlive PixelAlive_C0_V0 .. PixelAlive_C15_V0
[10:28:22.532] INFO: PixTestAlive::maskTest() done
[10:28:22.532] INFO: number of mask-defect pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:28:22.551] INFO: ----------------------------------------------------------------------
[10:28:22.551] INFO: PixTestAlive::addressDecodingTest() ntrig = 10, vcal = 200 (ctrlreg = 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0)
[10:28:22.552] INFO: ----------------------------------------------------------------------
[10:28:22.554] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:22.930] INFO: Expecting 41600 events.
[10:28:27.326] INFO: 41600 events read in total (3680ms).
[10:28:27.328] INFO: Test took 4774ms.
[10:28:27.339] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:27.339] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 66560
[10:28:27.339] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists AddressDecodingTest_C0 .. AddressDecodingTest_C15
[10:28:27.709] INFO: PixTestAlive::addressDecodingTest() done
[10:28:27.709] INFO: number of address-decoding pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:28:27.709] INFO: PixTestAlive::doTest() done, duration: 14 seconds
[10:28:31.259] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[10:28:31.259] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = PixelAlive_C3_V0 -> PixelAlive_mod
[10:28:33.803] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): caldelscan
[10:28:33.803] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: caldelscan
[10:28:33.803] INFO: ----------------------------------------------------------------------
[10:28:33.803] INFO: PixTestHighRate::calDelScan() ntrig = 10, vcal = 200
[10:28:33.803] INFO: ----------------------------------------------------------------------
[10:28:33.942] INFO: Expecting 768 events.
[10:28:35.076] INFO: 768 events read in total (419ms).
[10:28:35.077] INFO: Test took 1268ms.
[10:28:35.083] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:35.880] INFO: Expecting 41600 events.
[10:28:39.587] INFO: 41600 events read in total (3180ms).
[10:28:39.592] INFO: Test took 4509ms.
[10:28:39.729] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:39.729] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 798331
[10:28:39.729] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step0_C0 .. HR_xeff_CalDelScan_step0_C15
[10:28:39.730] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:39.788] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:40.454] INFO: Expecting 41600 events.
[10:28:44.319] INFO: 41600 events read in total (3339ms).
[10:28:44.324] INFO: Test took 4536ms.
[10:28:44.457] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:44.458] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 808401
[10:28:44.458] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step1_C0 .. HR_xeff_CalDelScan_step1_C15
[10:28:44.458] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:44.519] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:45.185] INFO: Expecting 41600 events.
[10:28:49.076] INFO: 41600 events read in total (3365ms).
[10:28:49.081] INFO: Test took 4562ms.
[10:28:49.213] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:49.213] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 811049
[10:28:49.213] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step2_C0 .. HR_xeff_CalDelScan_step2_C15
[10:28:49.214] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:49.275] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:49.941] INFO: Expecting 41600 events.
[10:28:53.833] INFO: 41600 events read in total (3366ms).
[10:28:53.838] INFO: Test took 4563ms.
[10:28:53.970] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:53.970] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 810426
[10:28:53.970] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step3_C0 .. HR_xeff_CalDelScan_step3_C15
[10:28:53.971] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:54.033] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:54.698] INFO: Expecting 41600 events.
[10:28:58.610] INFO: 41600 events read in total (3385ms).
[10:28:58.615] INFO: Test took 4582ms.
[10:28:58.749] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:28:58.749] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 811251
[10:28:58.749] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step4_C0 .. HR_xeff_CalDelScan_step4_C15
[10:28:58.749] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:28:58.812] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:28:59.478] INFO: Expecting 41600 events.
[10:29:03.384] INFO: 41600 events read in total (3380ms).
[10:29:03.389] INFO: Test took 4577ms.
[10:29:03.521] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:03.521] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 811855
[10:29:03.521] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step5_C0 .. HR_xeff_CalDelScan_step5_C15
[10:29:03.522] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:03.584] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:04.249] INFO: Expecting 41600 events.
[10:29:08.168] INFO: 41600 events read in total (3392ms).
[10:29:08.173] INFO: Test took 4589ms.
[10:29:08.307] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:08.307] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 810364
[10:29:08.307] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step6_C0 .. HR_xeff_CalDelScan_step6_C15
[10:29:08.308] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:08.368] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:09.033] INFO: Expecting 41600 events.
[10:29:12.953] INFO: 41600 events read in total (3393ms).
[10:29:12.958] INFO: Test took 4590ms.
[10:29:13.090] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:13.090] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 810330
[10:29:13.090] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step7_C0 .. HR_xeff_CalDelScan_step7_C15
[10:29:13.090] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:13.154] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:13.821] INFO: Expecting 41600 events.
[10:29:17.747] INFO: 41600 events read in total (3400ms).
[10:29:17.752] INFO: Test took 4598ms.
[10:29:17.887] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:17.887] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 811389
[10:29:17.887] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step8_C0 .. HR_xeff_CalDelScan_step8_C15
[10:29:17.887] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:17.948] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:18.613] INFO: Expecting 41600 events.
[10:29:22.534] INFO: 41600 events read in total (3394ms).
[10:29:22.539] INFO: Test took 4591ms.
[10:29:22.673] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:22.673] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 809751
[10:29:22.673] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step9_C0 .. HR_xeff_CalDelScan_step9_C15
[10:29:22.673] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:22.734] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:23.400] INFO: Expecting 41600 events.
[10:29:27.326] INFO: 41600 events read in total (3399ms).
[10:29:27.331] INFO: Test took 4597ms.
[10:29:27.463] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:27.463] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 811898
[10:29:27.463] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step10_C0 .. HR_xeff_CalDelScan_step10_C15
[10:29:27.464] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:27.526] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:28.191] INFO: Expecting 41600 events.
[10:29:32.112] INFO: 41600 events read in total (3395ms).
[10:29:32.117] INFO: Test took 4591ms.
[10:29:32.250] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:32.250] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 810915
[10:29:32.250] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step11_C0 .. HR_xeff_CalDelScan_step11_C15
[10:29:32.250] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:32.313] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:32.978] INFO: Expecting 41600 events.
[10:29:36.903] INFO: 41600 events read in total (3398ms).
[10:29:36.908] INFO: Test took 4595ms.
[10:29:37.040] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:37.040] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 811948
[10:29:37.040] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step12_C0 .. HR_xeff_CalDelScan_step12_C15
[10:29:37.040] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:37.102] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:37.768] INFO: Expecting 41600 events.
[10:29:41.690] INFO: 41600 events read in total (3396ms).
[10:29:41.695] INFO: Test took 4593ms.
[10:29:41.828] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:41.828] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 810054
[10:29:41.828] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step13_C0 .. HR_xeff_CalDelScan_step13_C15
[10:29:41.828] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:41.891] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:42.557] INFO: Expecting 41600 events.
[10:29:46.485] INFO: 41600 events read in total (3402ms).
[10:29:46.490] INFO: Test took 4599ms.
[10:29:46.623] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:46.623] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 810652
[10:29:46.623] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step14_C0 .. HR_xeff_CalDelScan_step14_C15
[10:29:46.623] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:46.684] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:47.349] INFO: Expecting 41600 events.
[10:29:51.261] INFO: 41600 events read in total (3386ms).
[10:29:51.266] INFO: Test took 4582ms.
[10:29:51.399] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:51.399] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 810275
[10:29:51.399] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step15_C0 .. HR_xeff_CalDelScan_step15_C15
[10:29:51.399] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:51.462] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:52.127] INFO: Expecting 41600 events.
[10:29:56.054] INFO: 41600 events read in total (3401ms).
[10:29:56.059] INFO: Test took 4597ms.
[10:29:56.192] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:29:56.192] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 809495
[10:29:56.192] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step16_C0 .. HR_xeff_CalDelScan_step16_C15
[10:29:56.192] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:29:56.254] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:29:56.919] INFO: Expecting 41600 events.
[10:30:00.848] INFO: 41600 events read in total (3402ms).
[10:30:00.853] INFO: Test took 4599ms.
[10:30:00.984] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:00.984] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 809422
[10:30:00.984] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step17_C0 .. HR_xeff_CalDelScan_step17_C15
[10:30:00.984] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:30:01.046] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:01.712] INFO: Expecting 41600 events.
[10:30:05.606] INFO: 41600 events read in total (3368ms).
[10:30:05.611] INFO: Test took 4565ms.
[10:30:05.741] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:05.741] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 809353
[10:30:05.741] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step18_C0 .. HR_xeff_CalDelScan_step18_C15
[10:30:05.742] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:30:05.804] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:06.469] INFO: Expecting 41600 events.
[10:30:10.233] INFO: 41600 events read in total (3238ms).
[10:30:10.238] INFO: Test took 4434ms.
[10:30:10.370] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:10.370] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 802437
[10:30:10.370] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists HR_xeff_CalDelScan_step19_C0 .. HR_xeff_CalDelScan_step19_C15
[10:30:10.371] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:30:10.653] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 0: caldel = 155 eff = 0.999543
[10:30:10.653] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 1: caldel = 164 eff = 0.999327
[10:30:10.653] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 2: caldel = 177 eff = 0.998558
[10:30:10.653] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 3: caldel = 175 eff = 0.996466
[10:30:10.654] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 4: caldel = 167 eff = 0.996563
[10:30:10.654] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 5: caldel = 191 eff = 0.996106
[10:30:10.654] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 6: caldel = 155 eff = 0.995865
[10:30:10.654] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 7: caldel = 157 eff = 0.996563
[10:30:10.654] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 8: caldel = 164 eff = 0.99601
[10:30:10.654] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 9: caldel = 133 eff = 0.996611
[10:30:10.654] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 10: caldel = 143 eff = 0.99649
[10:30:10.655] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 11: caldel = 161 eff = 0.996707
[10:30:10.655] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 12: caldel = 154 eff = 0.996611
[10:30:10.655] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 13: caldel = 171 eff = 0.998438
[10:30:10.655] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 14: caldel = 135 eff = 0.999447
[10:30:10.655] DEBUG: <PixTestHighRate.cc/doCalDelScan:L435> roc 15: caldel = 155 eff = 0.999495
[10:30:12.659] DEBUG: <PixTab.cc/buttonClicked:L308> xxxPressed(): xpixelalive
[10:30:12.659] DEBUG: <PixTestHighRate.cc/runCommand:L165> running command: xpixelalive
[10:30:12.659] INFO: ----------------------------------------------------------------------
[10:30:12.659] INFO: PixTestHighRate::xPixelAlive() ntrig = 50, vcal = 200
[10:30:12.659] INFO: ----------------------------------------------------------------------
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: clk: 4
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: ctr: 4
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: sda: 19
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: tin: 9
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: level: 15
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L464> old set: triggerdelay: 0
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: clk: 4
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: ctr: 4
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: sda: 19
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: tin: 9
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: level: 15
[10:30:12.660] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L480> setting: triggerdelay: 20
[10:30:12.677] DEBUG: <PixTest.cc/efficiencyMaps:L396> attempt #0
[10:30:13.344] INFO: Expecting 208000 events.
[10:30:29.627] INFO: 208000 events read in total (15756ms).
[10:30:29.646] INFO: Test took 16969ms.
[10:30:30.285] INFO: Fetched DAQ statistics. Counters are being reset now.
[10:30:30.285] DEBUG: <PixTest.cc/efficiencyMaps:L407> eff result size = 3741562
[10:30:30.285] DEBUG: <PixTest.cc/efficiencyMaps:L412> Create hists highRate_C0 .. highRate_C15
[10:30:30.286] DEBUG: <PixTest.cc/efficiencyMaps:L426> booking xray maps for unmasked detector
[10:30:30.762] INFO: number of dead pixels (per ROC): 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0
[10:30:30.763] INFO: number of red-efficiency pixels: 127 192 357 578 632 749 705 673 793 760 697 600 640 343 151 122
[10:30:30.763] INFO: number of X-ray hits detected: 88833 103614 181563 275747 284572 306129 298984 284963 316558 306390 298030 278284 279633 182996 107098 81608
[10:30:30.763] INFO: number of triggers sent (total per ROC): 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000 208000
[10:30:30.763] INFO: number of Vcal hits detected: 207871 207803 207596 207357 207302 207133 207173 207258 207122 207145 207178 207334 207260 207621 207836 207874
[10:30:30.763] INFO: Vcal hit fiducial efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.6 99.6 99.7 99.6 99.6 99.6 99.7 99.7 99.8 99.9 99.9
[10:30:30.763] INFO: Vcal hit overall efficiency (%): 99.9 99.9 99.8 99.7 99.7 99.6 99.6 99.6 99.6 99.6 99.6 99.7 99.6 99.8 99.9 99.9
[10:30:30.763] INFO: X-ray hit rate [MHz/cm2]: 26.0 30.4 53.2 80.8 83.4 89.7 87.6 83.5 92.8 89.8 87.4 81.6 82.0 53.6 31.4 23.9
[10:30:30.763] INFO: PixTestHighRate::doXPixelAlive() done
[10:30:30.808] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: clk: 4
[10:30:30.808] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: ctr: 4
[10:30:30.808] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: sda: 19
[10:30:30.808] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: tin: 9
[10:30:30.808] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: level: 15
[10:30:30.808] DEBUG: <PixTestHighRate.cc/doXPixelAlive:L599> resetting: triggerdelay: 0
[10:30:30.808] INFO: PixTest:: pg_setup set to default.
[10:30:51.987] DEBUG: <PixTest.cc/moduleMap:L1029> moduleMap histname: what
[10:30:51.987] DEBUG: <PixTest.cc/moduleMap:L1039> h1->GetName() = highRate_xraymap_C11_V0 -> highRate_xraymap_mod
[10:31:06.099] DEBUG: <PixGui.cc/handleButtons:L396> PixGui::exit called
[10:31:06.100] DEBUG: <PixGui.cc/CloseWindow:L335> Final Analog Current: 380.2mA
[10:31:06.101] DEBUG: <PixGui.cc/CloseWindow:L336> Final Digital Current: 476.7mA
[10:31:06.101] DEBUG: <PixGui.cc/CloseWindow:L337> Final Module Temperature: -0.2 C
[10:31:06.101] DEBUG: <PixTestBBMap.cc/~PixTestBBMap:L97> PixTestBBMap dtor
[10:31:06.101] DEBUG: <PixTestBB2Map.cc/~PixTestBB2Map:L115> PixTestBB2Map dtor
[10:31:06.101] DEBUG: <PixTestBB3Map.cc/~PixTestBB3Map:L99> PixTestBB3Map dtor
[10:31:06.101] DEBUG: <PixTestBB4Map.cc/~PixTestBB4Map:L118> PixTestBB4Map dtor
[10:31:06.101] DEBUG: <PixTestCmd.cc/~PixTestCmd:L78> PixTestCmd dtor
[10:31:06.101] DEBUG: <PixTestDaq.cc/~PixTestDaq:L37> PixTestDaq dtor
[10:31:06.101] DEBUG: <PixTestDacDacScan.cc/~PixTestDacDacScan:L136> PixTestDacDacScan dtor
[10:31:06.101] DEBUG: <PixTestDacScan.cc/~PixTestDacScan:L129> PixTestDacScan dtor
[10:31:06.101] DEBUG: <PixTestGainPedestal.cc/~PixTestGainPedestal:L125> PixTestGainPedestal dtor
[10:31:06.101] DEBUG: <PixTestHighRate.cc/~PixTestHighRate:L258> PixTestHighRate dtor
[10:31:06.194] DEBUG: <PixTestIV.cc/~PixTestIV:L96> PixTestIV dtor
[10:31:06.194] DEBUG: <PixTestAlive.cc/~PixTestAlive:L115> PixTestAlive dtor
[10:31:06.208] DEBUG: <PixTestPretest.cc/~PixTestPretest:L136> PixTestPretest dtor
[10:31:06.208] DEBUG: <PixTestReadback.cc/~PixTestReadback:L89> PixTestReadback dtor, saving tree ...
[10:31:06.208] DEBUG: <PixTestScurves.cc/~PixTestScurves:L142> PixTestScurves dtor
[10:31:06.208] DEBUG: <PixTestTiming.cc/~PixTestTiming:L98> PixTestTiming dtor
[10:31:06.208] DEBUG: <PixTestTrim.cc/~PixTestTrim:L103> PixTestTrim dtor
[10:31:06.208] DEBUG: <PixTestXray.cc/~PixTestXray:L218> PixTestXray dtor
[10:31:06.211] QUIET: Connection to board 58 closed.
[10:31:06.290] DEBUG: <PixMonitor.cc/dumpSummaries:L39> PixMonitor::dumpSummaries
MoReWeb-v0.5.1-901-g16ebcc5 on branch master